builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0100 starttime: 1484858856.93 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.931705) ========= 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.932123) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:36.932444) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:37.005238) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:37.005708) ========= 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.hO58RIyCgD/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.eXo1Ppu4fi/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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% 8.16M=0.001s 2017-01-19 12:47:37 (8.16 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.491085 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:37.527607) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:37.527959) ========= 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.hO58RIyCgD/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.eXo1Ppu4fi/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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.019077 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:37.576554) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-19 12:47:37.576915) ========= 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.hO58RIyCgD/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.eXo1Ppu4fi/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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,666 truncating revision to first 12 chars 2017-01-19 12:47:37,667 Setting DEBUG logging. 2017-01-19 12:47:37,667 attempt 1/10 2017-01-19 12:47:37,667 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,907 unpacking tar archive at: mozilla-central-a3978751f451/testing/mozharness/ program finished with exit code 0 elapsedTime=1.499815 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-19 12:47:39.101114) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:39.101488) ========= script_repo_revision: a3978751f45108ff1ae002ecebdc0fa23fc52b84 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:39.102025) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:39.102387) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:39.123113) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2017-01-19 12:47:39.123821) ========= /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.hO58RIyCgD/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.eXo1Ppu4fi/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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-0100', 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.337338Z] 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:39 INFO - Running post-action listener: _resource_record_post_action 12:47:39 INFO - [mozharness: 2017-01-19 20:47:39.967577Z] Finished clobber step (success) 12:47:39 INFO - [mozharness: 2017-01-19 20:47:39.967717Z] Running read-buildbot-config step. 12:47:39 INFO - Running pre-action listener: _resource_record_pre_action 12:47:39 INFO - Running main action method: read_buildbot_config 12:47:39 INFO - Using buildbot properties: 12:47:39 INFO - { 12:47:39 INFO - "project": "", 12:47:39 INFO - "product": "firefox", 12:47:39 INFO - "script_repo_revision": "production", 12:47:39 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 12:47:39 INFO - "repository": "", 12:47:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 12:47:39 INFO - "buildid": "20170119071129", 12:47:39 INFO - "pgo_build": "False", 12:47:39 INFO - "basedir": "/builds/slave/test", 12:47:39 INFO - "buildnumber": 62, 12:47:39 INFO - "slavename": "t-yosemite-r7-0100", 12:47:39 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 12:47:39 INFO - "platform": "yosemite_r7", 12:47:39 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 12:47:39 INFO - "branch": "mozilla-central", 12:47:39 INFO - "repo_path": "mozilla-central", 12:47:39 INFO - "revision": "a3978751f45108ff1ae002ecebdc0fa23fc52b84", 12:47:39 INFO - "stage_platform": "macosx64", 12:47:39 INFO - "builduid": "c70f3fdf1f924acab3275675a44e0caf", 12:47:39 INFO - "slavebuilddir": "test" 12:47:39 INFO - } 12:47:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 12:47:39 INFO - Running post-action listener: _resource_record_post_action 12:47:39 INFO - [mozharness: 2017-01-19 20:47:39.971056Z] Finished read-buildbot-config step (success) 12:47:39 INFO - [mozharness: 2017-01-19 20:47:39.971217Z] Running download-and-extract step. 12:47:39 INFO - Running pre-action listener: _resource_record_pre_action 12:47:39 INFO - Running main action method: download_and_extract 12:47:39 INFO - mkdir: /builds/slave/test/build/tests 12:47:39 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:39 INFO - trying https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 12:47:39 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:39 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:41 INFO - Downloaded 1199 bytes. 12:47:41 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 12:47:41 INFO - Using the following test package requirements: 12:47:41 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 12:47:41 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:47:41 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 12:47:41 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:47:41 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 12:47:41 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:47:41 INFO - u'jsshell-mac.zip'], 12:47:41 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:47:41 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 12:47:41 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 12:47:41 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:47:41 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 12:47:41 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:47:41 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 12:47:41 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:47:41 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 12:47:41 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:47:41 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 12:47:41 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:47:41 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:41 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:41 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:50 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:50 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:50 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:50 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:52 INFO - Expected file size: 16340629 12:47:52 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:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:02 INFO - trying https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:48:02 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:02 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:07 INFO - Downloaded 69915509 bytes. 12:48:07 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:07 INFO - mkdir: /builds/slave/test/properties 12:48:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:48:07 INFO - Writing to file /builds/slave/test/properties/build_url 12:48:07 INFO - Contents: 12:48:07 INFO - build_url:https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:48:08 INFO - Running post-action listener: _resource_record_post_action 12:48:08 INFO - Running post-action listener: set_extra_try_arguments 12:48:08 INFO - [mozharness: 2017-01-19 20:48:08.691446Z] Finished download-and-extract step (success) 12:48:08 INFO - [mozharness: 2017-01-19 20:48:08.691555Z] Running populate-webroot step. 12:48:08 INFO - Running pre-action listener: _resource_record_pre_action 12:48:08 INFO - Running main action method: populate_webroot 12:48:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:48:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:48:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:48:08 INFO - '--tppagecycles', 12:48:08 INFO - '7'], 12:48:08 INFO - 'tests': ['tsvgm']}}, 12:48:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:48:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:48:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:48:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:48:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:48:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:48:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:48:08 INFO - 'talos_options': ['--disable-e10s'], 12:48:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:48:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:48:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:48:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:48:08 INFO - 'talos_options': ['--disable-e10s'], 12:48:08 INFO - 'tests': ['damp', 'tps']}, 12:48:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:48:08 INFO - 'tests': ['damp', 'tps']}, 12:48:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:48:08 INFO - 'tests': ['dromaeo_dom']}, 12:48:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:48:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:48:08 INFO - 'tests': ['basic_compositor_video']}, 12:48:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:48:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:48:08 INFO - 'tests': ['a11yr', 12:48:08 INFO - 'ts_paint', 12:48:08 INFO - 'tpaint', 12:48:08 INFO - 'sessionrestore', 12:48:08 INFO - 'sessionrestore_no_auto_restore', 12:48:08 INFO - 'tabpaint']}, 12:48:08 INFO - 'other-e10s': {'tests': ['a11yr', 12:48:08 INFO - 'ts_paint', 12:48:08 INFO - 'tpaint', 12:48:08 INFO - 'sessionrestore', 12:48:08 INFO - 'sessionrestore_no_auto_restore', 12:48:08 INFO - 'tabpaint']}, 12:48:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:48:08 INFO - 'ts_paint', 12:48:08 INFO - 'tpaint', 12:48:08 INFO - 'sessionrestore', 12:48:08 INFO - 'sessionrestore_no_auto_restore', 12:48:08 INFO - 'tabpaint']}, 12:48:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:48:08 INFO - 'ts_paint', 12:48:08 INFO - 'tpaint', 12:48:08 INFO - 'sessionrestore', 12:48:08 INFO - 'sessionrestore_no_auto_restore', 12:48:08 INFO - 'tabpaint']}, 12:48:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:48:08 INFO - 'tests': ['a11yr', 12:48:08 INFO - 'ts_paint', 12:48:08 INFO - 'tpaint', 12:48:08 INFO - 'sessionrestore', 12:48:08 INFO - 'sessionrestore_no_auto_restore', 12:48:08 INFO - 'tabpaint']}, 12:48:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:48:08 INFO - 'tests': ['a11yr', 12:48:08 INFO - 'ts_paint', 12:48:08 INFO - 'tpaint', 12:48:08 INFO - 'sessionrestore', 12:48:08 INFO - 'sessionrestore_no_auto_restore', 12:48:08 INFO - 'tabpaint']}, 12:48:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:48:08 INFO - 'tests': ['tsvgx', 12:48:08 INFO - 'tsvgr_opacity', 12:48:08 INFO - 'tart', 12:48:08 INFO - 'tscrollx', 12:48:08 INFO - 'cart', 12:48:08 INFO - 'tsvg_static']}, 12:48:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:48:08 INFO - 'tsvgr_opacity', 12:48:08 INFO - 'tart', 12:48:08 INFO - 'tscrollx', 12:48:08 INFO - 'cart', 12:48:08 INFO - 'tsvg_static']}, 12:48:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:48:08 INFO - 'talos_options': ['--disable-e10s'], 12:48:08 INFO - 'tests': ['tp5o']}, 12:48:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:48:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:48:08 INFO - 'talos_options': ['--disable-e10s', 12:48:08 INFO - '--xperf_path', 12:48:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:48:08 INFO - 'tests': ['tp5n']}, 12:48:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:48:08 INFO - 'talos_options': ['--xperf_path', 12:48:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:48:08 INFO - 'tests': ['tp5n']}}, 12:48:08 INFO - 'talos.zip': {'path': '', 12:48:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:48:08 INFO - Running post-action listener: _resource_record_post_action 12:48:08 INFO - [mozharness: 2017-01-19 20:48:08.709600Z] Finished populate-webroot step (success) 12:48:08 INFO - [mozharness: 2017-01-19 20:48:08.709706Z] Running create-virtualenv step. 12:48:08 INFO - Running pre-action listener: _resource_record_pre_action 12:48:08 INFO - Running main action method: create_virtualenv 12:48:08 INFO - Creating virtualenv /builds/slave/test/build/venv 12:48:08 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:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:48:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:48:08 INFO - Using real prefix '/tools/python27' 12:48:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:48:09 INFO - Installing distribute.............................................................................................................................................................................................done. 12:48:12 INFO - Installing pip.................done. 12:48:12 INFO - Return code: 0 12:48:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:48:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:48:12 INFO - Reading from file tmpfile_stdout 12:48:12 INFO - Output received: 12:48:12 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:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c575b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c578768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4c8575080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c353d30>, '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 0x10c27adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c348be8>, '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.hO58RIyCgD/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.eXo1Ppu4fi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:48:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:48:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hO58RIyCgD/Render', 12:48:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:12 INFO - 'HOME': '/Users/cltbld', 12:48:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:12 INFO - 'LOGNAME': 'cltbld', 12:48:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:12 INFO - 'MOZ_NO_REMOTE': '1', 12:48:12 INFO - 'NO_EM_RESTART': '1', 12:48:12 INFO - 'PAGER': '/bin/cat', 12:48:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:12 INFO - 'PWD': '/builds/slave/test', 12:48:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:12 INFO - 'SHELL': '/bin/bash', 12:48:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eXo1Ppu4fi/Listeners', 12:48:12 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 12:48:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:12 INFO - 'USER': 'cltbld', 12:48:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:12 INFO - 'XPC_FLAGS': '0x0', 12:48:12 INFO - 'XPC_SERVICE_NAME': '0', 12:48:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:12 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:12 INFO - Cleaning up... 12:48:12 INFO - Return code: 0 12:48:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c575b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c578768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4c8575080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c353d30>, '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 0x10c27adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c348be8>, '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.hO58RIyCgD/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.eXo1Ppu4fi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:48:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:48:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hO58RIyCgD/Render', 12:48:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:12 INFO - 'HOME': '/Users/cltbld', 12:48:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:12 INFO - 'LOGNAME': 'cltbld', 12:48:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:12 INFO - 'MOZ_NO_REMOTE': '1', 12:48:12 INFO - 'NO_EM_RESTART': '1', 12:48:12 INFO - 'PAGER': '/bin/cat', 12:48:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:12 INFO - 'PWD': '/builds/slave/test', 12:48:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:12 INFO - 'SHELL': '/bin/bash', 12:48:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eXo1Ppu4fi/Listeners', 12:48:12 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 12:48:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:12 INFO - 'USER': 'cltbld', 12:48:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:12 INFO - 'XPC_FLAGS': '0x0', 12:48:12 INFO - 'XPC_SERVICE_NAME': '0', 12:48:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:13 INFO - Downloading/unpacking psutil>=3.1.1 12:48:13 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:13 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:13 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:13 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:13 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:13 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:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:48:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:48:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:48:17 INFO - Installing collected packages: psutil 12:48:17 INFO - Running setup.py install for psutil 12:48:17 INFO - building 'psutil._psutil_osx' extension 12:48:17 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:17 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:17 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:17 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:17 INFO - building 'psutil._psutil_posix' extension 12:48:17 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:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:48:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:48:17 INFO - ^ 12:48:17 INFO - 1 warning generated. 12:48:17 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:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:48:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:48:18 INFO - Successfully installed psutil 12:48:18 INFO - Cleaning up... 12:48:18 INFO - Return code: 0 12:48:18 INFO - Installing mozsystemmonitor==0.3 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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c575b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c578768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4c8575080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c353d30>, '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 0x10c27adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c348be8>, '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.hO58RIyCgD/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.eXo1Ppu4fi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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', 'mozsystemmonitor==0.3'] 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 mozsystemmonitor==0.3 12:48:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hO58RIyCgD/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.eXo1Ppu4fi/Listeners', 12:48:18 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 mozsystemmonitor==0.3 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:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:48:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:48:21 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:21 INFO - Installing collected packages: mozsystemmonitor 12:48:21 INFO - Running setup.py install for mozsystemmonitor 12:48:21 INFO - Successfully installed mozsystemmonitor 12:48:21 INFO - Cleaning up... 12:48:21 INFO - Return code: 0 12:48:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:48:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c575b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c578768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4c8575080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c353d30>, '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 0x10c27adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c348be8>, '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.hO58RIyCgD/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.eXo1Ppu4fi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:48:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hO58RIyCgD/Render', 12:48:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:21 INFO - 'HOME': '/Users/cltbld', 12:48:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:21 INFO - 'LOGNAME': 'cltbld', 12:48:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:21 INFO - 'MOZ_NO_REMOTE': '1', 12:48:21 INFO - 'NO_EM_RESTART': '1', 12:48:21 INFO - 'PAGER': '/bin/cat', 12:48:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:21 INFO - 'PWD': '/builds/slave/test', 12:48:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:21 INFO - 'SHELL': '/bin/bash', 12:48:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eXo1Ppu4fi/Listeners', 12:48:21 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 12:48:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:21 INFO - 'USER': 'cltbld', 12:48:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:21 INFO - 'XPC_FLAGS': '0x0', 12:48:21 INFO - 'XPC_SERVICE_NAME': '0', 12:48:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:21 INFO - Downloading/unpacking 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:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:48:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:48:24 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:24 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:24 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:24 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:24 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:24 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:24 INFO - Downloading functools32-3.2.3-2.tar.gz 12:48:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:48:24 INFO - warning: no files found matching '*.txt' 12:48:24 INFO - no previously-included directories found matching 'build' 12:48:24 INFO - no previously-included directories found matching 'dist' 12:48:24 INFO - no previously-included directories found matching '.git*' 12:48:24 INFO - Installing collected packages: jsonschema, functools32 12:48:24 INFO - Running setup.py install for functools32 12:48:24 INFO - warning: no files found matching '*.txt' 12:48:24 INFO - no previously-included directories found matching 'build' 12:48:24 INFO - no previously-included directories found matching 'dist' 12:48:24 INFO - no previously-included directories found matching '.git*' 12:48:24 INFO - Successfully installed jsonschema functools32 12:48:24 INFO - Cleaning up... 12:48:24 INFO - Return code: 0 12:48:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:48:24 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:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:24 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:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:24 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 0x10c575b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c578768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4c8575080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c353d30>, '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 0x10c27adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c348be8>, '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.hO58RIyCgD/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.eXo1Ppu4fi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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:24 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:24 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:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hO58RIyCgD/Render', 12:48:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:24 INFO - 'HOME': '/Users/cltbld', 12:48:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:24 INFO - 'LOGNAME': 'cltbld', 12:48:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:24 INFO - 'MOZ_NO_REMOTE': '1', 12:48:24 INFO - 'NO_EM_RESTART': '1', 12:48:24 INFO - 'PAGER': '/bin/cat', 12:48:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:24 INFO - 'PWD': '/builds/slave/test', 12:48:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:24 INFO - 'SHELL': '/bin/bash', 12:48:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eXo1Ppu4fi/Listeners', 12:48:24 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 12:48:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:24 INFO - 'USER': 'cltbld', 12:48:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:24 INFO - 'XPC_FLAGS': '0x0', 12:48:24 INFO - 'XPC_SERVICE_NAME': '0', 12:48:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:48:25 INFO - Cleaning up... 12:48:25 INFO - Return code: 0 12:48:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:48:25 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:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:25 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:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:25 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 0x10c575b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c578768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4c8575080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c353d30>, '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 0x10c27adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c348be8>, '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.hO58RIyCgD/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.eXo1Ppu4fi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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:25 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:25 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:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hO58RIyCgD/Render', 12:48:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:25 INFO - 'HOME': '/Users/cltbld', 12:48:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:25 INFO - 'LOGNAME': 'cltbld', 12:48:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:25 INFO - 'MOZ_NO_REMOTE': '1', 12:48:25 INFO - 'NO_EM_RESTART': '1', 12:48:25 INFO - 'PAGER': '/bin/cat', 12:48:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:25 INFO - 'PWD': '/builds/slave/test', 12:48:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:25 INFO - 'SHELL': '/bin/bash', 12:48:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eXo1Ppu4fi/Listeners', 12:48:25 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 12:48:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:25 INFO - 'USER': 'cltbld', 12:48:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:25 INFO - 'XPC_FLAGS': '0x0', 12:48:25 INFO - 'XPC_SERVICE_NAME': '0', 12:48:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:25 INFO - Downloading/unpacking 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:28 INFO - Downloading blobuploader-1.2.4.tar.gz 12:48:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:48:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:48:28 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:28 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:28 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:28 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:28 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:28 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:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:48:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:48:28 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:28 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:28 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:28 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:28 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:28 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:29 INFO - Downloading docopt-0.6.1.tar.gz 12:48:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:48:29 INFO - Installing collected packages: blobuploader, requests, docopt 12:48:29 INFO - Running setup.py install for blobuploader 12:48:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:48:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:48:29 INFO - Running setup.py install for requests 12:48:29 INFO - Running setup.py install for docopt 12:48:30 INFO - Successfully installed blobuploader requests docopt 12:48:30 INFO - Cleaning up... 12:48:30 INFO - Return code: 0 12:48:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48:30 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:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:30 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:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:30 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 0x10c575b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c578768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4c8575080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c353d30>, '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 0x10c27adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c348be8>, '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.hO58RIyCgD/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.eXo1Ppu4fi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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:30 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:30 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:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hO58RIyCgD/Render', 12:48:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:30 INFO - 'HOME': '/Users/cltbld', 12:48:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:30 INFO - 'LOGNAME': 'cltbld', 12:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:30 INFO - 'MOZ_NO_REMOTE': '1', 12:48:30 INFO - 'NO_EM_RESTART': '1', 12:48:30 INFO - 'PAGER': '/bin/cat', 12:48:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:30 INFO - 'PWD': '/builds/slave/test', 12:48:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:30 INFO - 'SHELL': '/bin/bash', 12:48:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eXo1Ppu4fi/Listeners', 12:48:30 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 12:48:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:30 INFO - 'USER': 'cltbld', 12:48:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:30 INFO - 'XPC_FLAGS': '0x0', 12:48:30 INFO - 'XPC_SERVICE_NAME': '0', 12:48:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:48:30 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-16ibd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:48:30 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-IsddUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:48:30 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-ajKZft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:48:30 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-0aaz0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:48:30 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-mLItiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:48:30 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-YscfM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:48:31 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-_pwmN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:48:31 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-HbLegH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:48:31 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-9j9jMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:48:31 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-PPWRqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:48:31 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-9UAMlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:48:31 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-5M2FPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:48:31 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-mijaoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:48:31 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-71tOBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:31 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-rhOeyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:48:32 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-DEmDtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:48:32 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-W8Yq6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:48:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:48:32 INFO - Running setup.py install for manifestparser 12:48:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:48:32 INFO - Running setup.py install for mozcrash 12:48:32 INFO - Running setup.py install for mozdebug 12:48:32 INFO - Running setup.py install for mozdevice 12:48:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:48:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:48:32 INFO - Running setup.py install for mozfile 12:48:33 INFO - Running setup.py install for mozhttpd 12:48:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:48:33 INFO - Running setup.py install for mozinfo 12:48:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:48:33 INFO - Running setup.py install for mozInstall 12:48:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:48:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:48:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:48:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:48:33 INFO - Running setup.py install for mozleak 12:48:33 INFO - Running setup.py install for mozlog 12:48:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:48:33 INFO - Running setup.py install for moznetwork 12:48:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:48:33 INFO - Running setup.py install for mozprocess 12:48:34 INFO - Running setup.py install for mozprofile 12:48:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:48:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:48:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:48:34 INFO - Running setup.py install for mozrunner 12:48:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:48:34 INFO - Running setup.py install for mozscreenshot 12:48:34 INFO - Running setup.py install for moztest 12:48:34 INFO - Running setup.py install for mozversion 12:48:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:48:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:48:34 INFO - Cleaning up... 12:48:34 INFO - Return code: 0 12:48:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:34 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 0x10c575b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c578768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4c8575080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c353d30>, '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 0x10c27adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c348be8>, '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.hO58RIyCgD/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.eXo1Ppu4fi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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:34 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:34 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:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hO58RIyCgD/Render', 12:48:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:34 INFO - 'HOME': '/Users/cltbld', 12:48:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:34 INFO - 'LOGNAME': 'cltbld', 12:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:34 INFO - 'MOZ_NO_REMOTE': '1', 12:48:34 INFO - 'NO_EM_RESTART': '1', 12:48:34 INFO - 'PAGER': '/bin/cat', 12:48:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:34 INFO - 'PWD': '/builds/slave/test', 12:48:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:34 INFO - 'SHELL': '/bin/bash', 12:48:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eXo1Ppu4fi/Listeners', 12:48:34 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 12:48:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:34 INFO - 'USER': 'cltbld', 12:48:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:34 INFO - 'XPC_FLAGS': '0x0', 12:48:34 INFO - 'XPC_SERVICE_NAME': '0', 12:48:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:48:35 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-1QH0Qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:48:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:48:35 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-Qnm7cf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:48:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:48:35 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-n9osgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:48:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:48:35 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-vuG8lH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:48:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:48:35 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-JywOtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:48:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:48:35 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-0GMBW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:48:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:48:35 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-XBNqIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:48:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:48:35 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-OGlI5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:48:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:48:35 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-zAY4E3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:48:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:48:36 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-4ObUxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:48:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:48:36 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-jFd563-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:48:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:48:36 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-6y1Xk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:48:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:48:36 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-J4PZL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:48:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:48:36 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-yZQa1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:48:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:36 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-kl65uA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:48:36 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-mltVil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:48:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:48:36 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-0n91V7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:48:36 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:36 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:36 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:36 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:36 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:36 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:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:48:36 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:36 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:36 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:36 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:36 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:36 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:39 INFO - Downloading blessings-1.6.tar.gz 12:48:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:48:39 INFO - Installing collected packages: blessings 12:48:39 INFO - Running setup.py install for blessings 12:48:39 INFO - Successfully installed blessings 12:48:39 INFO - Cleaning up... 12:48:39 INFO - Return code: 0 12:48:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:48:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:48:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:48:40 INFO - Reading from file tmpfile_stdout 12:48:40 INFO - Current package versions: 12:48:40 INFO - blessings == 1.6 12:48:40 INFO - blobuploader == 1.2.4 12:48:40 INFO - docopt == 0.6.1 12:48:40 INFO - functools32 == 3.2.3-2 12:48:40 INFO - jsonschema == 2.5.1 12:48:40 INFO - manifestparser == 1.1 12:48:40 INFO - mozInstall == 1.12 12:48:40 INFO - mozcrash == 1.0 12:48:40 INFO - mozdebug == 0.1 12:48:40 INFO - mozdevice == 0.49 12:48:40 INFO - mozfile == 1.2 12:48:40 INFO - mozhttpd == 0.7 12:48:40 INFO - mozinfo == 0.9 12:48:40 INFO - mozleak == 0.1 12:48:40 INFO - mozlog == 3.4 12:48:40 INFO - moznetwork == 0.27 12:48:40 INFO - mozprocess == 0.24 12:48:40 INFO - mozprofile == 0.28 12:48:40 INFO - mozrunner == 6.13 12:48:40 INFO - mozscreenshot == 0.1 12:48:40 INFO - mozsystemmonitor == 0.3 12:48:40 INFO - moztest == 0.8 12:48:40 INFO - mozversion == 1.4 12:48:40 INFO - psutil == 3.1.1 12:48:40 INFO - requests == 1.2.3 12:48:40 INFO - wsgiref == 0.1.2 12:48:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:40 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 0x10c575b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c578768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4c8575080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c353d30>, '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 0x10c27adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c348be8>, '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.hO58RIyCgD/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.eXo1Ppu4fi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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:40 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:40 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:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hO58RIyCgD/Render', 12:48:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:40 INFO - 'HOME': '/Users/cltbld', 12:48:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:40 INFO - 'LOGNAME': 'cltbld', 12:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:40 INFO - 'MOZ_NO_REMOTE': '1', 12:48:40 INFO - 'NO_EM_RESTART': '1', 12:48:40 INFO - 'PAGER': '/bin/cat', 12:48:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:40 INFO - 'PWD': '/builds/slave/test', 12:48:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:40 INFO - 'SHELL': '/bin/bash', 12:48:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eXo1Ppu4fi/Listeners', 12:48:40 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 12:48:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:40 INFO - 'USER': 'cltbld', 12:48:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:40 INFO - 'XPC_FLAGS': '0x0', 12:48:40 INFO - 'XPC_SERVICE_NAME': '0', 12:48:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:40 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:40 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:40 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:40 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:40 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:40 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:40 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:40 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:40 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:40 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:40 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:40 INFO - Cleaning up... 12:48:40 INFO - Return code: 0 12:48:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:40 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 0x10c575b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c578768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4c8575080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c353d30>, '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 0x10c27adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c348be8>, '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.hO58RIyCgD/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.eXo1Ppu4fi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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:40 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:40 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:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hO58RIyCgD/Render', 12:48:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:40 INFO - 'HOME': '/Users/cltbld', 12:48:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:40 INFO - 'LOGNAME': 'cltbld', 12:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:40 INFO - 'MOZ_NO_REMOTE': '1', 12:48:40 INFO - 'NO_EM_RESTART': '1', 12:48:40 INFO - 'PAGER': '/bin/cat', 12:48:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:40 INFO - 'PWD': '/builds/slave/test', 12:48:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:40 INFO - 'SHELL': '/bin/bash', 12:48:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eXo1Ppu4fi/Listeners', 12:48:40 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 12:48:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:40 INFO - 'USER': 'cltbld', 12:48:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:40 INFO - 'XPC_FLAGS': '0x0', 12:48:40 INFO - 'XPC_SERVICE_NAME': '0', 12:48:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:48:40 INFO - Cleaning up... 12:48:40 INFO - Return code: 0 12:48:40 INFO - Running post-action listener: _resource_record_post_action 12:48:40 INFO - Running post-action listener: _start_resource_monitoring 12:48:40 INFO - Starting resource monitoring. 12:48:40 INFO - [mozharness: 2017-01-19 20:48:40.825371Z] Finished create-virtualenv step (success) 12:48:40 INFO - [mozharness: 2017-01-19 20:48:40.826327Z] Running install step. 12:48:40 INFO - Running pre-action listener: _resource_record_pre_action 12:48:40 INFO - Running main action method: install 12:48:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:48:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:48:41 INFO - Reading from file tmpfile_stdout 12:48:41 INFO - Detecting whether we're running mozinstall >=1.0... 12:48:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:48:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:48:41 INFO - Reading from file tmpfile_stdout 12:48:41 INFO - Output received: 12:48:41 INFO - Usage: mozinstall [options] installer 12:48:41 INFO - Options: 12:48:41 INFO - -h, --help show this help message and exit 12:48:41 INFO - -d DEST, --destination=DEST 12:48:41 INFO - Directory to install application into. [default: 12:48:41 INFO - "/builds/slave/test"] 12:48:41 INFO - --app=APP Application being installed. [default: firefox] 12:48:41 INFO - mkdir: /builds/slave/test/build/application 12:48:41 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:41 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:03 INFO - Reading from file tmpfile_stdout 12:49:03 INFO - Output received: 12:49:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:49:03 INFO - Running post-action listener: _resource_record_post_action 12:49:03 INFO - [mozharness: 2017-01-19 20:49:03.006211Z] Finished install step (success) 12:49:03 INFO - [mozharness: 2017-01-19 20:49:03.006351Z] Running run-tests step. 12:49:03 INFO - Running pre-action listener: _resource_record_pre_action 12:49:03 INFO - Running main action method: run_tests 12:49:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:49:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:49:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:49:03 INFO - 2017-01-19 12:49:03.020 screenresolution[6412:113115] starting screenresolution argv=screenresolution get 12:49:03 INFO - 2017-01-19 12:49:03.022 screenresolution[6412:113115] Display 0: 1600x1200x32@60 12:49:03 INFO - 2017-01-19 12:49:03.028 screenresolution[6413:113117] starting screenresolution argv=screenresolution list 12:49:03 INFO - Available Modes on Display 0 12:49:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:49:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:49:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:49:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:49:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:49:03 INFO - Intel Iris: 12:49:03 INFO - Chipset Model: Intel Iris 12:49:03 INFO - Type: GPU 12:49:03 INFO - Bus: Built-In 12:49:03 INFO - VRAM (Dynamic, Max): 1536 MB 12:49:03 INFO - Vendor: Intel (0x8086) 12:49:03 INFO - Device ID: 0x0a2e 12:49:03 INFO - Revision ID: 0x0009 12:49:03 INFO - Displays: 12:49:03 INFO - Display: 12:49:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:49:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:49:03 INFO - Display Serial Number: 1600x1200 60 12:49:03 INFO - Main Display: Yes 12:49:03 INFO - Mirror: Off 12:49:03 INFO - Online: Yes 12:49:03 INFO - Rotation: Supported 12:49:03 INFO - Return code: 0 12:49:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:49:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:49:03 INFO - Python 2.7.3 12:49:03 INFO - Return code: 0 12:49:03 INFO - grabbing minidump binary from tooltool 12:49:03 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:03 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 0x10c353d30>, '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 0x10c27adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c348be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:49:03 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:03 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:03 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:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:49:03 INFO - Return code: 0 12:49:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:49:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:49:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:49:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:49:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:49:03 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-0100', '--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:03 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-0100 --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:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hO58RIyCgD/Render', 12:49:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:49:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:49:03 INFO - 'HOME': '/Users/cltbld', 12:49:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:49:03 INFO - 'LOGNAME': 'cltbld', 12:49:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:49:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:49:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:03 INFO - 'MOZ_NO_REMOTE': '1', 12:49:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:49:03 INFO - 'NO_EM_RESTART': '1', 12:49:03 INFO - 'PAGER': '/bin/cat', 12:49:03 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:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:03 INFO - 'PWD': '/builds/slave/test', 12:49:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:49:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:49:03 INFO - 'SHELL': '/bin/bash', 12:49:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eXo1Ppu4fi/Listeners', 12:49:03 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 12:49:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:49:03 INFO - 'USER': 'cltbld', 12:49:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:49:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:49:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:03 INFO - 'XPC_FLAGS': '0x0', 12:49:03 INFO - 'XPC_SERVICE_NAME': '0', 12:49:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:49:03 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-0100', '--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:03 INFO - mozversion application_buildid: 20170119071129 12:49:03 INFO - mozversion application_changeset: a3978751f45108ff1ae002ecebdc0fa23fc52b84 12:49:03 INFO - mozversion application_display_name: Nightly 12:49:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:49:03 INFO - mozversion application_name: Firefox 12:49:03 INFO - mozversion application_remotingname: firefox 12:49:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:49:03 INFO - mozversion application_vendor: Mozilla 12:49:03 INFO - mozversion application_version: 53.0a1 12:49:03 INFO - mozversion platform_buildid: 20170119071129 12:49:03 INFO - mozversion platform_changeset: a3978751f45108ff1ae002ecebdc0fa23fc52b84 12:49:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:49:03 INFO - mozversion platform_version: 53.0a1 12:49:03 INFO - using testdate: 1484858943 12:49:03 INFO - actual date: 1484858943 12:49:03 INFO - starting webserver on 'localhost:57586' 12:49:03 INFO - SUITE-START | Running 2 tests 12:49:03 INFO - TEST-START | dromaeo_css 12:49:03 INFO - operating with platform_type : mac_ 12:49:03 INFO - Initialising browser for dromaeo_css test... 12:49:03 INFO - TEST-INFO | started process 6423 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpV9xuwE/profile http://localhost:57586/getInfo.html) 12:49:06 INFO - PROCESS | 6423 | 2017-01-19 12:49:06.669 plugin-container[6425:113283] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x914b, name = 'com.apple.tsm.portname' 12:49:06 INFO - PROCESS | 6423 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:49:06 INFO - PROCESS | 6423 | 2017-01-19 12:49:06.672 plugin-container[6425:113283] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9603, name = 'com.apple.CFPasteboardClient' 12:49:06 INFO - PROCESS | 6423 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:49:06 INFO - PROCESS | 6423 | 2017-01-19 12:49:06.672 plugin-container[6425:113283] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:49:06 INFO - PROCESS | 6423 | __metrics Screen width/height:1600/1200 12:49:06 INFO - PROCESS | 6423 | colorDepth:24 12:49:06 INFO - PROCESS | 6423 | Browser inner width/height: 1024/663 12:49:06 INFO - PROCESS | 6423 | __metrics 12:49:06 ERROR - PROCESS | 6423 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3269: TypeError: this.tabs is undefined 12:49:07 INFO - TEST-INFO | 6423: exit 0 12:49:07 INFO - Browser initialized. 12:49:07 INFO - Running cycle 1/1 for dromaeo_css test... 12:49:07 INFO - TEST-INFO | started process 6427 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpV9xuwE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:49:10 INFO - PROCESS | 6427 | 2017-01-19 12:49:10.219 plugin-container[6428:113409] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 12:49:10 INFO - PROCESS | 6427 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:49:10 INFO - PROCESS | 6427 | 2017-01-19 12:49:10.220 plugin-container[6428:113409] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 12:49:10 INFO - PROCESS | 6427 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:49:10 INFO - PROCESS | 6427 | 2017-01-19 12:49:10.220 plugin-container[6428:113409] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:49:19 INFO - PROCESS | 6427 | RSS: Main: 241344512 12:49:19 INFO - PROCESS | 6427 | 12:52:21 INFO - PROCESS | 6427 | Cycle 1(1): loaded http://localhost:57586/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57586/tests/dromaeo/cssquery-ext.html) 12:52:23 INFO - PROCESS | 6427 | RSS: Main: 268558336 12:52:23 INFO - PROCESS | 6427 | 12:54:08 INFO - PROCESS | 6427 | ************************* 12:54:08 INFO - PROCESS | 6427 | A coding exception was thrown and uncaught in a Task. 12:54:08 INFO - PROCESS | 6427 | 12:54:08 ERROR - PROCESS | 6427 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:54:08 INFO - PROCESS | 6427 | Full stack: 12:54:08 INFO - PROCESS | 6427 | ************************* 12:55:26 INFO - PROCESS | 6427 | Cycle 1(1): loaded http://localhost:57586/tests/dromaeo/cssquery-ext.html (next: http://localhost:57586/tests/dromaeo/cssquery-jquery.html) 12:55:27 INFO - PROCESS | 6427 | RSS: Main: 267796480 12:55:27 INFO - PROCESS | 6427 | 12:58:29 INFO - PROCESS | 6427 | Cycle 1(1): loaded http://localhost:57586/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57586/tests/dromaeo/cssquery-mootools.html) 12:58:29 INFO - PROCESS | 6427 | RSS: Main: 275402752 12:58:29 INFO - PROCESS | 6427 | 13:01:31 INFO - PROCESS | 6427 | Cycle 1(1): loaded http://localhost:57586/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57586/tests/dromaeo/cssquery-prototype.html) 13:01:32 INFO - PROCESS | 6427 | RSS: Main: 271474688 13:01:32 INFO - PROCESS | 6427 | 13:04:35 INFO - PROCESS | 6427 | Cycle 1(1): loaded http://localhost:57586/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57586/tests/dromaeo/cssquery-yui.html) 13:04:35 INFO - PROCESS | 6427 | RSS: Main: 276414464 13:04:35 INFO - PROCESS | 6427 | 13:07:38 INFO - PROCESS | 6427 | Cycle 1(1): loaded http://localhost:57586/tests/dromaeo/cssquery-yui.html (next: http://localhost:57586/tests/dromaeo/cssquery-dojo.html) 13:07:39 INFO - PROCESS | 6427 | RSS: Main: 278401024 13:07:39 INFO - PROCESS | 6427 | 13:07:39 INFO - PROCESS | 6427 | __start_tp_report 13:07:39 INFO - PROCESS | 6427 | _x_x_mozilla_page_load 13:07:39 INFO - PROCESS | 6427 | _x_x_mozilla_page_load_details 13:07:39 INFO - PROCESS | 6427 | |i|pagename|runs| 13:07:39 INFO - PROCESS | 6427 | |0;dojo.html;2557.8465292082474;2734.7812175026;3293.720033797127;3323.9335213295735;3343.247769251918;5596.664200147994;5636.09822428411;5640.182173584828;5682.666374737515;5697.971510142444;5544.667319960805;5639.041362968295;5651.1523271509295;5682.17608446776;5740;5115.897682046348;5143.897122057557;5196.038732834419;5196.58427325813;5236.528712415882;4760.690555113906;4986.675866068694;5167.354080739908;5221.869453263661;5236.397814251352;359.3380421589274;5225.764840582164;5249.685018898859;5256.707338252291;5281.656692315007;4432.667549933735;5078.085944529983;5093.79624815007;5108.029474399852;5146.6911985281;5014;5044.697318160922;5046.419661738911;5051.848444546633;5066.822661206877;5520.779168833242;5536.861578460571;5538.723063846792;5565.387807341189;5588.804391846306;6087.3303936566945;6117.113018612321;6128.136482154514;6139.201903752528;6159.1993040904845;6170.2904166021035;6197.504199664016;6212.223472065992;6214.937850621526;6217.751289948396;5822.330432000332;5824.446677565625;5851.970740146315;5858.47273745365;5870.618409803349;6112.381899552462;6130.979101202072;6167.444929956326;6175.073738939105;6214.564980451325;5710.914336284959;6069.3627169147485;6131.50947924165;6138.38839838597;6171.814845554641;4831.323614693945;6166.229221347332;6168.537359698041;6205.069239614094;6233.812985610439;6037.879242415127;6106.206193194945;6193.84515387119;6197.25632924043;6227.346128656516;6114.724837382329;6132.938670613326;6136.938630613637;6144.477719393902;6162.7226774795245;3944.74359166659;4026.59734026595;4827.131116399082;4898.90202195954;4901.215805471107;4278.080212754273;4357.782110894443;4374.4531933508315;4380.014496738208;4428.955710442919;4805.879853003633;5744.827655170351;5764.279465066867;5781.190633311256;5827.854303642443;6001.549883758736;6035.215421995113;6130.448259656563;6130.673316708229;6170.81487555374;5750.913736293959;5770.336411312753;5773.913391299134;5783.566232532577;5796.594238403271;5370.677759334452;5371.919421208685;5377.78488860449;5388.865278367994;5390.137577987503;6129.022607377628;6169.259688837368;6186.783462578788;6209.720562574605;6283.120363149163;6178.443940045418;6184.969075154595;6190.907136393048;6200.131981522681;6214.1921550198185;6266.060090986206;6286.402791734778;6291.056341548804;6292.653904035139;6319.747210111544;6069.36271691466;6098.878022439615;6100.176476175659;6129.662868542273;6139.079138129317;5303.655262407931;5996;6136.641621527207;6137.097499775084;6151.26184857802;6063.181470501426;6072.696365181635;6076.149339092619;6082.635041897501;6102.572819902564;6036.245469316335;6055.6063855849225;6069.51443884497;6076.605020673642;6106.389361064036;5624.100143977108;5745;5813.24427824397;5856.443637854397;5877.823665289877;6012.518998480198;6105.587591966488;6109.252844142398;6115.788007244199;6150.7539698411565;5748.223989761496;5813;5834.862201870595;5934.673592952429;5957.821265362046 13:07:39 INFO - PROCESS | 6427 | |1;ext.html;445.4654414702357;474.38093288258807;500.0024950224303;525.4587774592171;526.1555203897746;34547.48178777317;41040.79479602598;41146.58853411465;41173.58826411735;41221;41947;42373;42387.364189537104;42581.7870910645;42590.57409425905;8320.209580089911;8530.530820804854;9057.81884362314;9329.11373419524;11019.559217631286;11143.832842507369;11395.772084558344;11397.943010284936;11430.37132957687;11435.970762631361;11334.659960201207;11397.601083962063;11414.885851141507;11453.770924581504;11466.484008219608;11342.092632589372;11429.971302582724;11435.771284574263;11442.427878606037;11450.656480305604;11354.772904541864;11393.487293071748;11426.25729327591;11429.371384573846;11434.885651143466;40389;40705.38941915874;40733.18533629311;40812.591874081176;40852.59147408547;3939.5863434339267;3943.2902077626018;3968.31324281396;4003.319435695939;4188.141431006637;29332.853335733183;30675.386492270252;30733.69266307353;30762.384752304828;30779.84610076935;3127.354935945752;3159.557661927332;3166.667499912499;3211.2935154266256;3221.484562470017;417614;423392.8830355859;424016;424234;425945;59758.701206493686;59766;59927.4079851216;60080.39919600835;60157;61120;61323.69338153281;62305;62445.37554624487;62463;15669.686606268038;15704.371825127095;15921.203939802963;15933.840661593236;15965.44120955761;11091.112710983263;11155.330680159217;11288.98399144081;11302.152338574475;11320.716982075513;13134.802977955338;15913;16139.677206455804;16174.59563510898;16205.837941620668;5272.919051594414;5966.582339236299;6264.780732674426;6320.71556779946;6331.525135614847;722.6134018300185;796.7131832540397;863.6243234193146;880.3089574683843;895.7581453007651;26070;26785.732142678324;28734.281642958675;30362.392752145275;30373.088807335815;931.5249222896372;1063.9042486176281;1087.7933192693363;1102.6802227354137;1105.3367979212408;13430.791228789456;14853.405863765329;15170.772438413433;15347.616309592126;15445.459408920633;612755;618401;623095;624004;624197;59798.70100649469;60054;60069.699651502335;60214;60219;1406.374163497234;1442.5744405400433;1446.2190417174818;1451.8257809062768;1452.8619781120776;25096.74903251017;28956.420871582028;29759.39946423222;29919;29957.360325177924;50048.74975625099;50318;50474.74762626163;50592.74703626458;50815.74592127016;521286;522353;524472;525479;527276;37989;39337.80331098326;39429;39480.40779388369;39713.60286397099;43911.34132987944;45483.77258113688;45742.313865291384;46167.76916115398;46491.76754116343;33476;37181.81409092937;37380;37890;39367.40948885826;37254.8137259312;37474.8126259367;37782.60263330885;38626;39120.80439597784;37140.628593713715;37528.24943501169;37945.81027094847;37958.62041379661;38041.048973775876;30250.428713559595;31767.72929082811;33583.49624755582;33737.83131084329;33998.49002264919;22377;24407;24463.51072978566;24940.12709555157;25066.965178107646 13:07:39 INFO - PROCESS | 6427 | |2;jquery.html;382.55050315878833;387.6704800919217;393.92121575684854;397.0391652201672;416.5875782974854;19998.000099994995;20480.69278960817;20714.378568642926;21392.35822925313;21398.89300553499;17201.56996075099;20408.081636326362;21166.788332116674;21319.147234110656;21481.67777483339;5372.650777699447;5700.458456446631;5757.222774925373;5792.420757924216;5795.072788353864;5487.42382049885;5696.6866822324755;5728.713564321788;5737.942620573804;5779.62432441892;5683.2895888014;5750.597458177929;5765.1352297155345;5765.769369225247;5774.884502309951;4784.641151913585;5546.140348246028;5729.140628905656;5740.684262365568;5746.827595172131;4077.2864748668862;5025.648204625678;5026.220935754927;5037.521435463662;5048.419431765321;24618.384540386633;24712.3821904452;24869.129580464596;24999;25253.36866578332;2619.410632607667;2663.933401664974;2753.2841461220028;2761.5443451830424;2801.145650576573;14685.045472044283;15066.397344106223;15142.242887855564;15222;15462.381504739797;1757.3497805811803;1796.2455768577229;1836.9265229390808;1837.4303965770655;1853.6848735714962;121276;125446;125720.114198288;126693.36653316766;128216.35891820575;11072.778544429066;11274.267172633752;11375.658730238107;11379.658610241706;11483.598074067535;13970.790438143436;14042.929785351213;14065.015448918683;14066.507672231422;14074.2962851857;8183.468074575134;8367.246947774729;8408.784149909896;8596.312295016383;8621.482711037357;8284.378671599654;8331.916680833114;8376.874346884802;8488.74533763988;8508.234258916604;5929.940700593025;6981.476389270825;6988.37104660583;6999.195092564319;7005.509614326948;1892.5930924851223;1936.8353689936514;1937.6221636780692;1939.679952807799;1940.233607724969;1041.8228901086834;1060.9628662996759;1071.887451817548;1079.983800242997;1113.0817075912405;17034;19823;21427.57144857094;21578.352649420543;22074.33776986693;896.4128495835238;1019.2610357490908;1036.7304500829687;1045.0959919669583;1059.3908502610875;10411.11505522024;10985.956334148243;11011;11181.944090279496;11191.776164476665;646551.3553310377;692823;722733;757284;763136;124182;131703.36593268273;148445;150720;159959;1044.6448207609296;1057.6404022632341;1067.0503252105632;1073.3077165228383;1075.419273592267;14507.854921450651;17003.91498042502;17568.38510652121;17948.37180698669;18147.637047258715;50195;57251.42748572628;57572;58310.4168958305;58935;82100.76848847391;84605;85873;86269;86465.56767216124;7025.910983797519;7843.137254902052;7874.0157480314965;8016.95991520062;8157.75526734199;8755.168259015383;10275.280730348804;11945.641630751092;12002.275312855545;12469.937650311691;10241.129503992244;10520.421376824348;10603.41681207541;10677.039066484054;10734.785304293715;7816.296533312029;10332.793344132924;10478.79042419132;10849.67450976472;10939.56241750321;10387.272890897564;10652.84020739705;10770.24608277413;11030.007299343097;11129.554817807197;6046.909296360646;7957.602119894098;8074.232947869943;8124.268815806606;8124.512529248264;7689.730859419893;10638.255322127377;10963.945180274048;11032.44837758125;11080.279781814157 13:07:39 INFO - PROCESS | 6427 | |3;mootools.html;1427.2364285107467;1438.431819431324;1445.0895935560595;1457.8337330135896;1467.4717101843337;7482.4762266641355;7755.806104847382;7921.801954951129;8452.112528184536;8452.661893524268;7567.091948966132;7740.838874168878;8010.319122874548;8314.043884953233;8368;2225.3324002799177;2291.8968646410867;2325.976740232593;2332.323626148415;2336.5677349690277;2321.1759825262043;2322.1872344679396;2352.4589344450787;2363.7872591466767;2364.4561750797325;2300.3559003479054;2324.6861673674093;2326.7789559991857;2327.406511339606;2338.5206032763326;1879.9060046997731;2300.470891694911;2306.5041016181603;2314.722233331994;2329.5573840970246;2298.1152256381247;2350.0482304666466;2361.114582031738;2362.61016932206;2364.160722943365;8374.623141958566;8382.994040715092;8390;8400.663973441055;8422.368322375785;5012.27322038306;5136.8202112925865;5167;5170.534651881311;5172.991266702995;2898.2899189698446;3068.55505951638;3153;3313.2710803623163;3373.8650453981813;1212.1999480342931;1215.1008253892055;1646.1357787161717;1717.2529949471896;1778.2442461953617;10707.089897358734;10755.193360497993;10868.728281792939;10905.236633435663;10934.507947142398;3832.5784163741964;4428.22506061438;4444.333349997526;4479.776011199427;4515.390422293014;8383.455075420079;8769.956150219208;8774.034856165817;8788.16512431318;8974.326925480615;5131.820386286462;5139.408967968731;5145.742712864417;5152.433232344439;5167.22491626259;4277.679174061957;4361.560684974014;4534.682572219979;4593.885152871205;4711.646626503026;3634.7455678102806;3703.148275896559;3717.1636381813873;3742.5029988005017;3796.962030379716;1144.2390810111349;1158.0677554568654;1160.4487868262677;1162.5524173193382;1165.12033414773;820.7483587529066;856.9785755356166;878.446578655443;897.2866571076011;902.1159263921263;5435;5458;5630.436956304418;5747.568932330092;5866.794662186803;947;967.6226271754022;976.8339382304883;993.1111655068673;1014.5181039006413;3624.565052193701;3639.3449179148006;3696.6672999429643;3777.187904600469;3792.715546333981;9721.270904682036;9988.300818942604;10034.397936123856;10040.899591004143;10079.042490963348;9437.480938548446;9863.309568330147;10043.397396156253;10096.495175241209;10112.494375281207;7690.2694244046725;7844.4116691247245;7895.407844411692;7904.051513818378;7925.365970722329;4646.953530464787;4950.628702847373;5284.41871394154;5743;5904;7859.703148980354;8940.195382415613;8983.281337493116;9083.818323633623;9121.315901307296;9073.410228335137;9219.953900230725;9295.395799273025;9351.579178936829;9406.012368701187;6016.706408122274;6623;6786.966065169642;6945.652717364011;7281.19906810261;7950.602469876368;8015.599220038858;8018.599070046591;8026.83946321082;8044.034715834137;6089.756409743561;6113.694315284307;7095.787126386217;7286.417086633162;7439.330460258603;7145.678444469907;7156.570605763671;7167.534110282815;7168.032315637322;7225.674844632109;6335.524835637438;6390.329015453311;6428.903566446601;6462.289148193601;6466.256380516301;4939.259111133359;5009.423916249678;5017.8243761468175;5057.064443078042;5102.36220472441;4268.893277668083;4830.589399901048;4925.113479573568;5026.346574945233;5065.696058236517 13:07:39 INFO - PROCESS | 6427 | |4;prototype.html;309.670201235684;325.6108949804983;351.9476764474221;364.48607463476503;373.5554689918998;4414.381986521889;4593.448786145659;5330.520253177213;5360.391882435273;5409.56723462123;4801.711897286165;4932.4081110266725;5032.622553308507;5182.663126896749;5267.157254839227;3821.331267028273;4104.988555607753;4216.957830421703;4250.936235956463;4254.765987870666;4129.2154490646835;4129.648979836717;4264.573542645741;4278.122984788127;4284.293091639891;3456.792592444449;3695.6119607441233;3916.2167566486673;4162.687798415131;4199.73214464189;4102.3026085565525;4111.712180147376;4171.874843754692;4204.432401625772;4220.9155816883795;3587.8385472653795;3733.8879833605033;3743.794091324976;3746.6253374662315;3752.924941501182;4612.1698094343;5024.723640199788;5048.763053051989;5110.591152707774;5226.895462090737;4388.319810429389;4763.642726795504;4820.276958456225;4841.2496063110275;4877.609791216694;5442.047641662693;5444.346678398578;5617.859553511154;5696.417510839359;5740.397258287903;3594.6405359464106;3783.8297276622343;4112.280350938574;4113.4035564843225;4132.586741325874;4833.589144922686;5264.52619264268;5853.678047707374;5929.555283353766;5974.8506287342725;4151.4395556599475;4162.188373267184;4176.58234176586;4183.163367326547;4216.229183742836;3441.397755392796;3707.4994875691436;3919;4167.2082304362075;4273.376117075553;4343.782810859444;4767.498238055002;4852.902941941142;4867.415910090812;4879.853604391874;5668.987509434174;5676.744546495418;5692.430756924275;5727.5990680652785;5741.85645358861;1246.9189502682298;1289.9226046437057;1339.8325209348832;1353.2151352215692;1358.9388477518535;942.7595963029383;949.852772820214;955.9952200239094;959.3764053365229;970.9174720148867;4107.815148318333;4473.3542163136935;4754.667173297905;4900.382873651758;4929.580985616263;4790;5055.9494405055475;5176.2494438306985;5419.918701219485;5475.014497390428;3996.2606917720314;4265.445492086009;4389.978050109729;4492.3935268738305;4919.163742163841;2543.465872166829;2761.295869553251;2800.6919238883706;2802.8178168419395;2822.520171570838;5634.23937768396;5648.841987392575;5659.773609055674;5661.886762264731;5703.7148142592705;4524.6380289576755;4984.551390374883;5149.588032957355;5408.729563521808;5607.971960140173;5386.784528618811;5583.35791383996;5758.429773540432;5785.392533783892;5788.710564471759;4895.73073480962;4920.803167873245;5440.510354068153;5475.780968761205;5506.972465137809;4540.750258735801;4657.0918670858855;4792.472827988988;5160.638755287094;5304.336957880265;4593.839215627437;5055.974720126376;5267.631265811357;5337;5635.88728225425;3734.842198918235;3743.128435782109;3789.6778773804535;3824.8278827453387;3861.979426745276;4656.627469802475;5318.042752304467;5429.945700542944;5634.718264086861;5727.8854422912145;5665.5750818689585;5682.77268909239;5694.231278777312;5700.030994730822;5707.857303567278;4927.802887884444;5553.500184983371;5583.860403489783;5595.293435502048;5688.345840228427;4846.539578740014;5181.715005674724;5442.23808666779;5511.255980442589;5523.536262890418;4472.709273897186;4962.429320628174;4975.402951645826;5526.281583394133;5663.461971112738;5465.426130256265;5527.613067085426;5528.364238112507;5549.197655184267;5558.471945165203 13:07:39 INFO - PROCESS | 6427 | |5;yui.html;668.2415458454656;676.4013847744744;713.8037039814051;783.4085265624452;802.7431222008958;14832.703345933074;15728.37086516538;15740.606484837856;15745.52763417098;15788.921055394736;14283.151800217245;14386.352614132364;14538.491152809655;14577.781333279983;14579.343929523171;857.5369300577696;863.8013256950906;866.3069544364515;873.6636394987912;877.0352612126674;870.3863776037878;871.1593312453481;871.2072014466836;872.4111224923183;873.5894129759004;901.1394118616738;922.3727865051762;923.9743884288469;933.7572231219898;942.9198518125968;906.5784410249199;922.8661844032578;922.9261659067292;923.64901337492;924.58393722825;567.7785663591203;625.1060982794602;697.6163110289372;697.9685914133826;702.5257950883184;14635.780463293058;14840.10959342443;15693.979891307028;15753.054816711034;15766.921165394215;14006.579802605938;14057.578272651837;14322.14067155974;14473.565793026226;14482.637934051627;9500.952495237549;11374.69131183111;11525.423728813526;11985.28088314704;12235.388230588434;3589.0351051564594;3598.1004748812798;3654.6162652921594;3716.1638631307737;3730.850765969358;70883;87889;101788.99999999926;108276;108809;10577;10634.20243481742;10765.623203187852;10833.681779264569;10993.285436446606;22337.664935025987;22631;22732.886335568215;22851.542969140522;23026;7585.772426827204;7681.462297639224;7734.303912647776;7741.92258077412;7885.763427097197;3913.295606790805;3941.8620348287673;3989.4414781930554;3997.8600748973645;4003.3794761811964;3050.344176002126;3127.921801954924;3572.4641303804638;3658.926821463609;3660.6888414484533;660.072597999811;660.389140045456;665.4709505942787;670.7149461478851;689.3451221339748;562.3392513796273;654.2182092399537;665.3280187011056;669.3440428380214;690.6960937187621;8484.27883629886;9507.070304720066;9989.950050249847;10475.528601212964;10570.365778053188;519.7759276902915;545.7762317449826;595.5265563876728;638.4700698420393;674.699758607415;4509.301058335963;4798.712077275305;4799.904001919942;4857.562819346276;4923.163062279421;82578;84302;91817.54091229501;92202.53898730464;93597;65428.672856635414;80438;81295;82658.58670706728;83301.58349208215;72772.2722772776;73548.16129596804;73897.52204955979;74537.62731186309;74644.25355746482;9651.806963860823;9655.613775448903;9674.419534827934;9709.6601618943;9726.659566915125;44656.33015504835;48893.755531222116;48909.75545122252;49142;49206.261906072155;63067.369326307984;63692;64974;65463.34536654573;66390;11526.308421494738;11539.653810385365;11763.882361176278;11772.352520611106;11815.113866459878;11501.734809171152;12295.692607684521;12786.360681965678;12954.90753272427;13048.151870128411;11417.543298268309;11603.825942611036;11725.76548469043;11943.940280298542;12372.1958072725;9852.753681157741;11581.50851581495;11667.299962002307;11839.822402663794;12322.260664360167;11620.535178592761;12957.22256664603;13093.869061309266;13235.81841229625;13248.80126798118;8853.931020081449;10320.845187322046;10538.164399728046;10709.892901071202;11395.259308144945;7773.317966855954;8715.977302453355;9568.904310956801;10778.877134105487;10830.51262693165 13:07:39 INFO - PROCESS | 6427 | __end_tp_report 13:07:39 INFO - PROCESS | 6427 | __start_cc_report 13:07:39 INFO - PROCESS | 6427 | _x_x_mozilla_cycle_collect,390 13:07:39 INFO - PROCESS | 6427 | __end_cc_report 13:07:39 INFO - PROCESS | 6427 | __startTimestamp1484860059232__endTimestamp 13:07:39 INFO - PROCESS | 6427 | 13:07:39 INFO - PROCESS | 6427 | ------- Summary: start ------- 13:07:39 INFO - PROCESS | 6427 | Number of tests: 6 13:07:39 INFO - PROCESS | 6427 | 13:07:39 INFO - PROCESS | 6427 | [#0] dojo.html Cycles:165 Average:5617.43 Median:5856.44 stddev:810.92 (13.8%) stddev-sans-first:777.07 13:07:39 INFO - PROCESS | 6427 | Values: 2557.8 2734.8 3293.7 3323.9 3343.2 5596.7 5636.1 5640.2 5682.7 5698.0 5544.7 5639.0 5651.2 5682.2 5740.0 5115.9 5143.9 5196.0 5196.6 5236.5 4760.7 4986.7 5167.4 5221.9 5236.4 359.3 5225.8 5249.7 5256.7 5281.7 4432.7 5078.1 5093.8 5108.0 5146.7 5014.0 5044.7 5046.4 5051.8 5066.8 5520.8 5536.9 5538.7 5565.4 5588.8 6087.3 6117.1 6128.1 6139.2 6159.2 6170.3 6197.5 6212.2 6214.9 6217.8 5822.3 5824.4 5852.0 5858.5 5870.6 6112.4 6131.0 6167.4 6175.1 6214.6 5710.9 6069.4 6131.5 6138.4 6171.8 4831.3 6166.2 6168.5 6205.1 6233.8 6037.9 6106.2 6193.8 6197.3 6227.3 6114.7 6132.9 6136.9 6144.5 6162.7 3944.7 4026.6 4827.1 4898.9 4901.2 4278.1 4357.8 4374.5 4380.0 4429.0 4805.9 5744.8 5764.3 5781.2 5827.9 6001.5 6035.2 6130.4 6130.7 6170.8 5750.9 5770.3 5773.9 5783.6 5796.6 5370.7 5371.9 5377.8 5388.9 5390.1 6129.0 6169.3 6186.8 6209.7 6283.1 6178.4 6185.0 6190.9 6200.1 6214.2 6266.1 6286.4 6291.1 6292.7 6319.7 6069.4 6098.9 6100.2 6129.7 6139.1 5303.7 5996.0 6136.6 6137.1 6151.3 6063.2 6072.7 6076.1 6082.6 6102.6 6036.2 6055.6 6069.5 6076.6 6106.4 5624.1 5745.0 5813.2 5856.4 5877.8 6012.5 6105.6 6109.3 6115.8 6150.8 5748.2 5813.0 5834.9 5934.7 5957.8 13:07:39 INFO - PROCESS | 6427 | 13:07:39 INFO - PROCESS | 6427 | [#1] ext.html Cycles:180 Average:66513.47 Median:37952.22 stddev:140998.73 (371.5%) stddev-sans-first:141307.01 13:07:39 INFO - PROCESS | 6427 | Values: 445.5 474.4 500.0 525.5 526.2 34547.5 41040.8 41146.6 41173.6 41221.0 41947.0 42373.0 42387.4 42581.8 42590.6 8320.2 8530.5 9057.8 9329.1 11019.6 11143.8 11395.8 11397.9 11430.4 11436.0 11334.7 11397.6 11414.9 11453.8 11466.5 11342.1 11430.0 11435.8 11442.4 11450.7 11354.8 11393.5 11426.3 11429.4 11434.9 40389.0 40705.4 40733.2 40812.6 40852.6 3939.6 3943.3 3968.3 4003.3 4188.1 29332.9 30675.4 30733.7 30762.4 30779.8 3127.4 3159.6 3166.7 3211.3 3221.5 417614.0 423392.9 424016.0 424234.0 425945.0 59758.7 59766.0 59927.4 60080.4 60157.0 61120.0 61323.7 62305.0 62445.4 62463.0 15669.7 15704.4 15921.2 15933.8 15965.4 11091.1 11155.3 11289.0 11302.2 11320.7 13134.8 15913.0 16139.7 16174.6 16205.8 5272.9 5966.6 6264.8 6320.7 6331.5 722.6 796.7 863.6 880.3 895.8 26070.0 26785.7 28734.3 30362.4 30373.1 931.5 1063.9 1087.8 1102.7 1105.3 13430.8 14853.4 15170.8 15347.6 15445.5 612755.0 618401.0 623095.0 624004.0 624197.0 59798.7 60054.0 60069.7 60214.0 60219.0 1406.4 1442.6 1446.2 1451.8 1452.9 25096.7 28956.4 29759.4 29919.0 29957.4 50048.7 50318.0 50474.7 50592.7 50815.7 521286.0 522353.0 524472.0 525479.0 527276.0 37989.0 39337.8 39429.0 39480.4 39713.6 43911.3 45483.8 45742.3 46167.8 46491.8 33476.0 37181.8 37380.0 37890.0 39367.4 37254.8 37474.8 37782.6 38626.0 39120.8 37140.6 37528.2 37945.8 37958.6 38041.0 30250.4 31767.7 33583.5 33737.8 33998.5 22377.0 24407.0 24463.5 24940.1 25067.0 13:07:39 INFO - PROCESS | 6427 | 13:07:39 INFO - PROCESS | 6427 | [#2] jquery.html Cycles:180 Average:39186.06 Median:21395.63 stddev:119433.59 (558.2%) stddev-sans-first:119733.09 13:07:39 INFO - PROCESS | 6427 | Values: 382.6 387.7 393.9 397.0 416.6 19998.0 20480.7 20714.4 21392.4 21398.9 17201.6 20408.1 21166.8 21319.1 21481.7 5372.7 5700.5 5757.2 5792.4 5795.1 5487.4 5696.7 5728.7 5737.9 5779.6 5683.3 5750.6 5765.1 5765.8 5774.9 4784.6 5546.1 5729.1 5740.7 5746.8 4077.3 5025.6 5026.2 5037.5 5048.4 24618.4 24712.4 24869.1 24999.0 25253.4 2619.4 2663.9 2753.3 2761.5 2801.1 14685.0 15066.4 15142.2 15222.0 15462.4 1757.3 1796.2 1836.9 1837.4 1853.7 121276.0 125446.0 125720.1 126693.4 128216.4 11072.8 11274.3 11375.7 11379.7 11483.6 13970.8 14042.9 14065.0 14066.5 14074.3 8183.5 8367.2 8408.8 8596.3 8621.5 8284.4 8331.9 8376.9 8488.7 8508.2 5929.9 6981.5 6988.4 6999.2 7005.5 1892.6 1936.8 1937.6 1939.7 1940.2 1041.8 1061.0 1071.9 1080.0 1113.1 17034.0 19823.0 21427.6 21578.4 22074.3 896.4 1019.3 1036.7 1045.1 1059.4 10411.1 10986.0 11011.0 11181.9 11191.8 646551.4 692823.0 722733.0 757284.0 763136.0 124182.0 131703.4 148445.0 150720.0 159959.0 1044.6 1057.6 1067.1 1073.3 1075.4 14507.9 17003.9 17568.4 17948.4 18147.6 50195.0 57251.4 57572.0 58310.4 58935.0 82100.8 84605.0 85873.0 86269.0 86465.6 7025.9 7843.1 7874.0 8017.0 8157.8 8755.2 10275.3 11945.6 12002.3 12469.9 10241.1 10520.4 10603.4 10677.0 10734.8 7816.3 10332.8 10478.8 10849.7 10939.6 10387.3 10652.8 10770.2 11030.0 11129.6 6046.9 7957.6 8074.2 8124.3 8124.5 7689.7 10638.3 10963.9 11032.4 11080.3 13:07:39 INFO - PROCESS | 6427 | 13:07:39 INFO - PROCESS | 6427 | [#3] mootools.html Cycles:180 Average:5358.76 Median:5134.32 stddev:2910.49 (56.7%) stddev-sans-first:2903.65 13:07:39 INFO - PROCESS | 6427 | Values: 1427.2 1438.4 1445.1 1457.8 1467.5 7482.5 7755.8 7921.8 8452.1 8452.7 7567.1 7740.8 8010.3 8314.0 8368.0 2225.3 2291.9 2326.0 2332.3 2336.6 2321.2 2322.2 2352.5 2363.8 2364.5 2300.4 2324.7 2326.8 2327.4 2338.5 1879.9 2300.5 2306.5 2314.7 2329.6 2298.1 2350.0 2361.1 2362.6 2364.2 8374.6 8383.0 8390.0 8400.7 8422.4 5012.3 5136.8 5167.0 5170.5 5173.0 2898.3 3068.6 3153.0 3313.3 3373.9 1212.2 1215.1 1646.1 1717.3 1778.2 10707.1 10755.2 10868.7 10905.2 10934.5 3832.6 4428.2 4444.3 4479.8 4515.4 8383.5 8770.0 8774.0 8788.2 8974.3 5131.8 5139.4 5145.7 5152.4 5167.2 4277.7 4361.6 4534.7 4593.9 4711.6 3634.7 3703.1 3717.2 3742.5 3797.0 1144.2 1158.1 1160.4 1162.6 1165.1 820.7 857.0 878.4 897.3 902.1 5435.0 5458.0 5630.4 5747.6 5866.8 947.0 967.6 976.8 993.1 1014.5 3624.6 3639.3 3696.7 3777.2 3792.7 9721.3 9988.3 10034.4 10040.9 10079.0 9437.5 9863.3 10043.4 10096.5 10112.5 7690.3 7844.4 7895.4 7904.1 7925.4 4647.0 4950.6 5284.4 5743.0 5904.0 7859.7 8940.2 8983.3 9083.8 9121.3 9073.4 9220.0 9295.4 9351.6 9406.0 6016.7 6623.0 6787.0 6945.7 7281.2 7950.6 8015.6 8018.6 8026.8 8044.0 6089.8 6113.7 7095.8 7286.4 7439.3 7145.7 7156.6 7167.5 7168.0 7225.7 6335.5 6390.3 6428.9 6462.3 6466.3 4939.3 5009.4 5017.8 5057.1 5102.4 4268.9 4830.6 4925.1 5026.3 5065.7 13:07:39 INFO - PROCESS | 6427 | 13:07:39 INFO - PROCESS | 6427 | [#4] prototype.html Cycles:180 Average:4476.83 Median:4887.79 stddev:1318.46 (27.0%) stddev-sans-first:1284.52 13:07:39 INFO - PROCESS | 6427 | Values: 309.7 325.6 351.9 364.5 373.6 4414.4 4593.4 5330.5 5360.4 5409.6 4801.7 4932.4 5032.6 5182.7 5267.2 3821.3 4105.0 4217.0 4250.9 4254.8 4129.2 4129.6 4264.6 4278.1 4284.3 3456.8 3695.6 3916.2 4162.7 4199.7 4102.3 4111.7 4171.9 4204.4 4220.9 3587.8 3733.9 3743.8 3746.6 3752.9 4612.2 5024.7 5048.8 5110.6 5226.9 4388.3 4763.6 4820.3 4841.2 4877.6 5442.0 5444.3 5617.9 5696.4 5740.4 3594.6 3783.8 4112.3 4113.4 4132.6 4833.6 5264.5 5853.7 5929.6 5974.9 4151.4 4162.2 4176.6 4183.2 4216.2 3441.4 3707.5 3919.0 4167.2 4273.4 4343.8 4767.5 4852.9 4867.4 4879.9 5669.0 5676.7 5692.4 5727.6 5741.9 1246.9 1289.9 1339.8 1353.2 1358.9 942.8 949.9 956.0 959.4 970.9 4107.8 4473.4 4754.7 4900.4 4929.6 4790.0 5055.9 5176.2 5419.9 5475.0 3996.3 4265.4 4390.0 4492.4 4919.2 2543.5 2761.3 2800.7 2802.8 2822.5 5634.2 5648.8 5659.8 5661.9 5703.7 4524.6 4984.6 5149.6 5408.7 5608.0 5386.8 5583.4 5758.4 5785.4 5788.7 4895.7 4920.8 5440.5 5475.8 5507.0 4540.8 4657.1 4792.5 5160.6 5304.3 4593.8 5056.0 5267.6 5337.0 5635.9 3734.8 3743.1 3789.7 3824.8 3862.0 4656.6 5318.0 5429.9 5634.7 5727.9 5665.6 5682.8 5694.2 5700.0 5707.9 4927.8 5553.5 5583.9 5595.3 5688.3 4846.5 5181.7 5442.2 5511.3 5523.5 4472.7 4962.4 4975.4 5526.3 5663.5 5465.4 5527.6 5528.4 5549.2 5558.5 13:07:39 INFO - PROCESS | 6427 | 13:07:39 INFO - PROCESS | 6427 | [#5] yui.html Cycles:180 Average:19010.33 Median:49025.88 stddev:26608.82 (54.3%) stddev-sans-first:26647.82 13:07:39 INFO - PROCESS | 6427 | Values: 668.2 676.4 713.8 783.4 802.7 14832.7 15728.4 15740.6 15745.5 15788.9 14283.2 14386.4 14538.5 14577.8 14579.3 857.5 863.8 866.3 873.7 877.0 870.4 871.2 871.2 872.4 873.6 901.1 922.4 924.0 933.8 942.9 906.6 922.9 922.9 923.6 924.6 567.8 625.1 697.6 698.0 702.5 14635.8 14840.1 15694.0 15753.1 15766.9 14006.6 14057.6 14322.1 14473.6 14482.6 9501.0 11374.7 11525.4 11985.3 12235.4 3589.0 3598.1 3654.6 3716.2 3730.9 70883.0 87889.0 101789.0 108276.0 108809.0 10577.0 10634.2 10765.6 10833.7 10993.3 22337.7 22631.0 22732.9 22851.5 23026.0 7585.8 7681.5 7734.3 7741.9 7885.8 3913.3 3941.9 3989.4 3997.9 4003.4 3050.3 3127.9 3572.5 3658.9 3660.7 660.1 660.4 665.5 670.7 689.3 562.3 654.2 665.3 669.3 690.7 8484.3 9507.1 9990.0 10475.5 10570.4 519.8 545.8 595.5 638.5 674.7 4509.3 4798.7 4799.9 4857.6 4923.2 82578.0 84302.0 91817.5 92202.5 93597.0 65428.7 80438.0 81295.0 82658.6 83301.6 72772.3 73548.2 73897.5 74537.6 74644.3 9651.8 9655.6 9674.4 9709.7 9726.7 44656.3 48893.8 48909.8 49142.0 49206.3 63067.4 63692.0 64974.0 65463.3 66390.0 11526.3 11539.7 11763.9 11772.4 11815.1 11501.7 12295.7 12786.4 12954.9 13048.2 11417.5 11603.8 11725.8 11943.9 12372.2 9852.8 11581.5 11667.3 11839.8 12322.3 11620.5 12957.2 13093.9 13235.8 13248.8 8853.9 10320.8 10538.2 10709.9 11395.3 7773.3 8716.0 9568.9 10778.9 10830.5 13:07:39 INFO - PROCESS | 6427 | -------- Summary: end -------- 13:07:39 INFO - PROCESS | 6427 | 13:07:39 INFO - TEST-INFO | 6427: exit 0 13:07:39 INFO - TEST-OK | dromaeo_css | took 1116262ms 13:07:39 INFO - TEST-START | kraken 13:07:39 INFO - operating with platform_type : mac_ 13:07:39 INFO - Initialising browser for kraken test... 13:07:39 INFO - TEST-INFO | started process 6432 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpslfLwZ/profile http://localhost:57586/getInfo.html) 13:07:42 INFO - PROCESS | 6432 | 2017-01-19 13:07:42.553 plugin-container[6433:115739] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 13:07:42 INFO - PROCESS | 6432 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:07:42 INFO - PROCESS | 6432 | 2017-01-19 13:07:42.556 plugin-container[6433:115739] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 13:07:42 INFO - PROCESS | 6432 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:07:42 INFO - PROCESS | 6432 | 2017-01-19 13:07:42.556 plugin-container[6433:115739] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:07:42 INFO - PROCESS | 6432 | __metrics Screen width/height:1600/1200 13:07:42 INFO - PROCESS | 6432 | colorDepth:24 13:07:42 INFO - PROCESS | 6432 | Browser inner width/height: 1024/663 13:07:42 INFO - PROCESS | 6432 | __metrics 13:07:42 ERROR - PROCESS | 6432 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3269: TypeError: this.tabs is undefined 13:07:43 INFO - TEST-INFO | 6432: exit 0 13:07:43 INFO - Browser initialized. 13:07:43 INFO - Running cycle 1/1 for kraken test... 13:07:43 INFO - TEST-INFO | started process 6434 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpslfLwZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:07:45 INFO - PROCESS | 6434 | 2017-01-19 13:07:45.871 plugin-container[6435:115853] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8743, name = 'com.apple.tsm.portname' 13:07:45 INFO - PROCESS | 6434 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:07:45 INFO - PROCESS | 6434 | 2017-01-19 13:07:45.872 plugin-container[6435:115853] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4607, name = 'com.apple.CFPasteboardClient' 13:07:45 INFO - PROCESS | 6434 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:07:45 INFO - PROCESS | 6434 | 2017-01-19 13:07:45.872 plugin-container[6435:115853] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:07:55 INFO - PROCESS | 6434 | RSS: Main: 241569792 13:07:55 INFO - PROCESS | 6434 | 13:07:58 INFO - PROCESS | 6434 | Cycle 1(1): loaded http://localhost:57586/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57586/tests/kraken/driver.html?testName=audio-beat-detection) 13:07:59 INFO - PROCESS | 6434 | RSS: Main: 252719104 13:07:59 INFO - PROCESS | 6434 | 13:08:02 INFO - PROCESS | 6434 | Cycle 1(1): loaded http://localhost:57586/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57586/tests/kraken/driver.html?testName=audio-dft) 13:08:02 INFO - PROCESS | 6434 | RSS: Main: 260358144 13:08:02 INFO - PROCESS | 6434 | 13:08:06 INFO - PROCESS | 6434 | Cycle 1(1): loaded http://localhost:57586/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57586/tests/kraken/driver.html?testName=audio-fft) 13:08:06 INFO - PROCESS | 6434 | RSS: Main: 261529600 13:08:06 INFO - PROCESS | 6434 | 13:08:08 INFO - PROCESS | 6434 | Cycle 1(1): loaded http://localhost:57586/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57586/tests/kraken/driver.html?testName=audio-oscillator) 13:08:09 INFO - PROCESS | 6434 | RSS: Main: 262090752 13:08:09 INFO - PROCESS | 6434 | 13:08:11 INFO - PROCESS | 6434 | Cycle 1(1): loaded http://localhost:57586/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57586/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:08:11 INFO - PROCESS | 6434 | RSS: Main: 262356992 13:08:11 INFO - PROCESS | 6434 | 13:08:14 INFO - PROCESS | 6434 | Cycle 1(1): loaded http://localhost:57586/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57586/tests/kraken/driver.html?testName=imaging-darkroom) 13:08:15 INFO - PROCESS | 6434 | RSS: Main: 267821056 13:08:15 INFO - PROCESS | 6434 | 13:08:18 INFO - PROCESS | 6434 | Cycle 1(1): loaded http://localhost:57586/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57586/tests/kraken/driver.html?testName=imaging-desaturate) 13:08:19 INFO - PROCESS | 6434 | RSS: Main: 267100160 13:08:19 INFO - PROCESS | 6434 | 13:08:21 INFO - PROCESS | 6434 | Cycle 1(1): loaded http://localhost:57586/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57586/tests/kraken/driver.html?testName=json-parse-financial) 13:08:22 INFO - PROCESS | 6434 | RSS: Main: 266924032 13:08:22 INFO - PROCESS | 6434 | 13:08:24 INFO - PROCESS | 6434 | Cycle 1(1): loaded http://localhost:57586/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57586/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:08:24 INFO - PROCESS | 6434 | RSS: Main: 266416128 13:08:24 INFO - PROCESS | 6434 | 13:08:27 INFO - PROCESS | 6434 | Cycle 1(1): loaded http://localhost:57586/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57586/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:08:27 INFO - PROCESS | 6434 | RSS: Main: 266502144 13:08:27 INFO - PROCESS | 6434 | 13:08:29 INFO - PROCESS | 6434 | Cycle 1(1): loaded http://localhost:57586/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57586/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:08:30 INFO - PROCESS | 6434 | RSS: Main: 266391552 13:08:30 INFO - PROCESS | 6434 | 13:08:33 INFO - PROCESS | 6434 | Cycle 1(1): loaded http://localhost:57586/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57586/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:08:34 INFO - PROCESS | 6434 | RSS: Main: 266752000 13:08:34 INFO - PROCESS | 6434 | 13:08:37 INFO - PROCESS | 6434 | Cycle 1(1): loaded http://localhost:57586/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57586/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:08:38 INFO - PROCESS | 6434 | RSS: Main: 267079680 13:08:38 INFO - PROCESS | 6434 | 13:08:39 INFO - PROCESS | 6434 | Cycle 1(1): loaded http://localhost:57586/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57586/tests/kraken/driver.html?testName=ai-astar) 13:08:40 INFO - PROCESS | 6434 | RSS: Main: 268963840 13:08:40 INFO - PROCESS | 6434 | 13:08:40 INFO - PROCESS | 6434 | __start_tp_report 13:08:40 INFO - PROCESS | 6434 | _x_x_mozilla_page_load 13:08:40 INFO - PROCESS | 6434 | _x_x_mozilla_page_load_details 13:08:40 INFO - PROCESS | 6434 | |i|pagename|runs| 13:08:40 INFO - PROCESS | 6434 | |0;ai-astar;106;118;114;121;119;117;120;120;118;129 13:08:40 INFO - PROCESS | 6434 | |1;audio-beat-detection;141;116;116;150;111;115;115;116;133;111 13:08:40 INFO - PROCESS | 6434 | |2;audio-dft;201;212;217;250;202;198;201;200;206;199 13:08:40 INFO - PROCESS | 6434 | |3;audio-fft;89;60;60;87;63;63;86;79;71;60 13:08:40 INFO - PROCESS | 6434 | |4;audio-oscillator;90;73;83;71;69;77;96;68;70;84 13:08:40 INFO - PROCESS | 6434 | |5;imaging-gaussian-blur;89;90;99;112;90;85;91;106;84;128 13:08:40 INFO - PROCESS | 6434 | |6;imaging-darkroom;99;100;99;99;150;150;101;99;100;99 13:08:40 INFO - PROCESS | 6434 | |7;imaging-desaturate;93;97;92;92;96;95;91;95;92;107 13:08:40 INFO - PROCESS | 6434 | |8;json-parse-financial;60;63;62;61;63;67;79;84;63;63 13:08:40 INFO - PROCESS | 6434 | |9;json-stringify-tinderbox;72;70;127;112;115;103;73;73;96;95 13:08:40 INFO - PROCESS | 6434 | |10;stanford-crypto-aes;89;87;92;113;107;91;95;88;88;91 13:08:40 INFO - PROCESS | 6434 | |11;stanford-crypto-ccm;168;153;155;140;143;144;144;143;209;156 13:08:40 INFO - PROCESS | 6434 | |12;stanford-crypto-pbkdf2;184;181;179;181;176;174;175;175;178;180 13:08:40 INFO - PROCESS | 6434 | |13;stanford-crypto-sha256-iterative;70;71;70;66;72;69;68;75;81;92 13:08:40 INFO - PROCESS | 6434 | __end_tp_report 13:08:40 INFO - PROCESS | 6434 | __start_cc_report 13:08:40 INFO - PROCESS | 6434 | _x_x_mozilla_cycle_collect,958 13:08:40 INFO - PROCESS | 6434 | __end_cc_report 13:08:40 INFO - PROCESS | 6434 | __startTimestamp1484860120115__endTimestamp 13:08:40 INFO - PROCESS | 6434 | 13:08:40 INFO - PROCESS | 6434 | ------- Summary: start ------- 13:08:40 INFO - PROCESS | 6434 | Number of tests: 14 13:08:40 INFO - PROCESS | 6434 | 13:08:40 INFO - PROCESS | 6434 | [#0] ai-astar Cycles:10 Average:118.20 Median:119.50 stddev:5.77 (4.8%) stddev-sans-first:4.10 13:08:40 INFO - PROCESS | 6434 | Values: 106.0 118.0 114.0 121.0 119.0 117.0 120.0 120.0 118.0 129.0 13:08:40 INFO - PROCESS | 6434 | 13:08:40 INFO - PROCESS | 6434 | [#1] audio-beat-detection Cycles:10 Average:122.40 Median:116.00 stddev:13.79 (11.9%) stddev-sans-first:12.88 13:08:40 INFO - PROCESS | 6434 | Values: 141.0 116.0 116.0 150.0 111.0 115.0 115.0 116.0 133.0 111.0 13:08:40 INFO - PROCESS | 6434 | 13:08:40 INFO - PROCESS | 6434 | [#2] audio-dft Cycles:10 Average:208.60 Median:204.00 stddev:15.78 (7.7%) stddev-sans-first:16.49 13:08:40 INFO - PROCESS | 6434 | Values: 201.0 212.0 217.0 250.0 202.0 198.0 201.0 200.0 206.0 199.0 13:08:40 INFO - PROCESS | 6434 | 13:08:40 INFO - PROCESS | 6434 | [#3] audio-fft Cycles:10 Average:71.80 Median:75.00 stddev:12.26 (16.4%) stddev-sans-first:11.32 13:08:40 INFO - PROCESS | 6434 | Values: 89.0 60.0 60.0 87.0 63.0 63.0 86.0 79.0 71.0 60.0 13:08:40 INFO - PROCESS | 6434 | 13:08:40 INFO - PROCESS | 6434 | [#4] audio-oscillator Cycles:10 Average:78.10 Median:80.00 stddev:9.71 (12.1%) stddev-sans-first:9.30 13:08:40 INFO - PROCESS | 6434 | Values: 90.0 73.0 83.0 71.0 69.0 77.0 96.0 68.0 70.0 84.0 13:08:40 INFO - PROCESS | 6434 | 13:08:40 INFO - PROCESS | 6434 | [#5] imaging-gaussian-blur Cycles:10 Average:97.40 Median:89.50 stddev:14.06 (15.7%) stddev-sans-first:14.59 13:08:40 INFO - PROCESS | 6434 | Values: 89.0 90.0 99.0 112.0 90.0 85.0 91.0 106.0 84.0 128.0 13:08:40 INFO - PROCESS | 6434 | 13:08:40 INFO - PROCESS | 6434 | [#6] imaging-darkroom Cycles:10 Average:109.60 Median:99.00 stddev:21.30 (21.5%) stddev-sans-first:22.25 13:08:40 INFO - PROCESS | 6434 | Values: 99.0 100.0 99.0 99.0 150.0 150.0 101.0 99.0 100.0 99.0 13:08:40 INFO - PROCESS | 6434 | 13:08:40 INFO - PROCESS | 6434 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:94.00 stddev:4.67 (5.0%) stddev-sans-first:4.89 13:08:40 INFO - PROCESS | 6434 | Values: 93.0 97.0 92.0 92.0 96.0 95.0 91.0 95.0 92.0 107.0 13:08:40 INFO - PROCESS | 6434 | 13:08:40 INFO - PROCESS | 6434 | [#8] json-parse-financial Cycles:10 Average:66.50 Median:63.00 stddev:8.20 (13.0%) stddev-sans-first:8.35 13:08:40 INFO - PROCESS | 6434 | Values: 60.0 63.0 62.0 61.0 63.0 67.0 79.0 84.0 63.0 63.0 13:08:40 INFO - PROCESS | 6434 | 13:08:40 INFO - PROCESS | 6434 | [#9] json-stringify-tinderbox Cycles:10 Average:93.60 Median:72.50 stddev:20.76 (28.6%) stddev-sans-first:20.50 13:08:40 INFO - PROCESS | 6434 | Values: 72.0 70.0 127.0 112.0 115.0 103.0 73.0 73.0 96.0 95.0 13:08:40 INFO - PROCESS | 6434 | 13:08:40 INFO - PROCESS | 6434 | [#10] stanford-crypto-aes Cycles:10 Average:94.10 Median:90.00 stddev:8.81 (9.8%) stddev-sans-first:9.15 13:08:40 INFO - PROCESS | 6434 | Values: 89.0 87.0 92.0 113.0 107.0 91.0 95.0 88.0 88.0 91.0 13:08:40 INFO - PROCESS | 6434 | 13:08:40 INFO - PROCESS | 6434 | [#11] stanford-crypto-ccm Cycles:10 Average:155.50 Median:154.00 stddev:20.66 (13.4%) stddev-sans-first:21.42 13:08:40 INFO - PROCESS | 6434 | Values: 168.0 153.0 155.0 140.0 143.0 144.0 144.0 143.0 209.0 156.0 13:08:40 INFO - PROCESS | 6434 | 13:08:40 INFO - PROCESS | 6434 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.30 Median:179.50 stddev:3.27 (1.8%) stddev-sans-first:2.74 13:08:40 INFO - PROCESS | 6434 | Values: 184.0 181.0 179.0 181.0 176.0 174.0 175.0 175.0 178.0 180.0 13:08:40 INFO - PROCESS | 6434 | 13:08:40 INFO - PROCESS | 6434 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:71.50 stddev:7.75 (10.8%) stddev-sans-first:8.12 13:08:40 INFO - PROCESS | 6434 | Values: 70.0 71.0 70.0 66.0 72.0 69.0 68.0 75.0 81.0 92.0 13:08:40 INFO - PROCESS | 6434 | -------- Summary: end -------- 13:08:40 INFO - PROCESS | 6434 | 13:08:40 INFO - TEST-INFO | 6434: exit 0 13:08:40 INFO - TEST-OK | kraken | took 61080ms 13:08:40 INFO - SUITE-END | took 1177s 13:08:41 INFO - Completed test suite (00:19:37) 13:08:41 INFO - javascript benchmark 13:08:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7203.165247572063, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2557.8465292082474, 2734.7812175026, 3293.720033797127, 3323.9335213295735, 3343.247769251918, 5596.664200147994, 5636.09822428411, 5640.182173584828, 5682.666374737515, 5697.971510142444, 5544.667319960805, 5639.041362968295, 5651.1523271509295, 5682.17608446776, 5740.0, 5115.897682046348, 5143.897122057557, 5196.038732834419, 5196.58427325813, 5236.528712415882, 4760.690555113906, 4986.675866068694, 5167.354080739908, 5221.869453263661, 5236.397814251352, 359.3380421589274, 5225.764840582164, 5249.685018898859, 5256.707338252291, 5281.656692315007, 4432.667549933735, 5078.085944529983, 5093.79624815007, 5108.029474399852, 5146.6911985281, 5014.0, 5044.697318160922, 5046.419661738911, 5051.848444546633, 5066.822661206877, 5520.779168833242, 5536.861578460571, 5538.723063846792, 5565.387807341189, 5588.804391846306, 6087.3303936566945, 6117.113018612321, 6128.136482154514, 6139.201903752528, 6159.1993040904845, 6170.2904166021035, 6197.504199664016, 6212.223472065992, 6214.937850621526, 6217.751289948396, 5822.330432000332, 5824.446677565625, 5851.970740146315, 5858.47273745365, 5870.618409803349, 6112.381899552462, 6130.979101202072, 6167.444929956326, 6175.073738939105, 6214.564980451325, 5710.914336284959, 6069.3627169147485, 6131.50947924165, 6138.38839838597, 6171.814845554641, 4831.323614693945, 6166.229221347332, 6168.537359698041, 6205.069239614094, 6233.812985610439, 6037.879242415127, 6106.206193194945, 6193.84515387119, 6197.25632924043, 6227.346128656516, 6114.724837382329, 6132.938670613326, 6136.938630613637, 6144.477719393902, 6162.7226774795245, 3944.74359166659, 4026.59734026595, 4827.131116399082, 4898.90202195954, 4901.215805471107, 4278.080212754273, 4357.782110894443, 4374.4531933508315, 4380.014496738208, 4428.955710442919, 4805.879853003633, 5744.827655170351, 5764.279465066867, 5781.190633311256, 5827.854303642443, 6001.549883758736, 6035.215421995113, 6130.448259656563, 6130.673316708229, 6170.81487555374, 5750.913736293959, 5770.336411312753, 5773.913391299134, 5783.566232532577, 5796.594238403271, 5370.677759334452, 5371.919421208685, 5377.78488860449, 5388.865278367994, 5390.137577987503, 6129.022607377628, 6169.259688837368, 6186.783462578788, 6209.720562574605, 6283.120363149163, 6178.443940045418, 6184.969075154595, 6190.907136393048, 6200.131981522681, 6214.1921550198185, 6266.060090986206, 6286.402791734778, 6291.056341548804, 6292.653904035139, 6319.747210111544, 6069.36271691466, 6098.878022439615, 6100.176476175659, 6129.662868542273, 6139.079138129317, 5303.655262407931, 5996.0, 6136.641621527207, 6137.097499775084, 6151.26184857802, 6063.181470501426, 6072.696365181635, 6076.149339092619, 6082.635041897501, 6102.572819902564, 6036.245469316335, 6055.6063855849225, 6069.51443884497, 6076.605020673642, 6106.389361064036, 5624.100143977108, 5745.0, 5813.24427824397, 5856.443637854397, 5877.823665289877, 6012.518998480198, 6105.587591966488, 6109.252844142398, 6115.788007244199, 6150.7539698411565, 5748.223989761496, 5813.0, 5834.862201870595, 5934.673592952429, 5957.821265362046], "value": 5562.503505653849, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [445.4654414702357, 474.38093288258807, 500.0024950224303, 525.4587774592171, 526.1555203897746, 34547.48178777317, 41040.79479602598, 41146.58853411465, 41173.58826411735, 41221.0, 41947.0, 42373.0, 42387.364189537104, 42581.7870910645, 42590.57409425905, 8320.209580089911, 8530.530820804854, 9057.81884362314, 9329.11373419524, 11019.559217631286, 11143.832842507369, 11395.772084558344, 11397.943010284936, 11430.37132957687, 11435.970762631361, 11334.659960201207, 11397.601083962063, 11414.885851141507, 11453.770924581504, 11466.484008219608, 11342.092632589372, 11429.971302582724, 11435.771284574263, 11442.427878606037, 11450.656480305604, 11354.772904541864, 11393.487293071748, 11426.25729327591, 11429.371384573846, 11434.885651143466, 40389.0, 40705.38941915874, 40733.18533629311, 40812.591874081176, 40852.59147408547, 3939.5863434339267, 3943.2902077626018, 3968.31324281396, 4003.319435695939, 4188.141431006637, 29332.853335733183, 30675.386492270252, 30733.69266307353, 30762.384752304828, 30779.84610076935, 3127.354935945752, 3159.557661927332, 3166.667499912499, 3211.2935154266256, 3221.484562470017, 417614.0, 423392.8830355859, 424016.0, 424234.0, 425945.0, 59758.701206493686, 59766.0, 59927.4079851216, 60080.39919600835, 60157.0, 61120.0, 61323.69338153281, 62305.0, 62445.37554624487, 62463.0, 15669.686606268038, 15704.371825127095, 15921.203939802963, 15933.840661593236, 15965.44120955761, 11091.112710983263, 11155.330680159217, 11288.98399144081, 11302.152338574475, 11320.716982075513, 13134.802977955338, 15913.0, 16139.677206455804, 16174.59563510898, 16205.837941620668, 5272.919051594414, 5966.582339236299, 6264.780732674426, 6320.71556779946, 6331.525135614847, 722.6134018300185, 796.7131832540397, 863.6243234193146, 880.3089574683843, 895.7581453007651, 26070.0, 26785.732142678324, 28734.281642958675, 30362.392752145275, 30373.088807335815, 931.5249222896372, 1063.9042486176281, 1087.7933192693363, 1102.6802227354137, 1105.3367979212408, 13430.791228789456, 14853.405863765329, 15170.772438413433, 15347.616309592126, 15445.459408920633, 612755.0, 618401.0, 623095.0, 624004.0, 624197.0, 59798.70100649469, 60054.0, 60069.699651502335, 60214.0, 60219.0, 1406.374163497234, 1442.5744405400433, 1446.2190417174818, 1451.8257809062768, 1452.8619781120776, 25096.74903251017, 28956.420871582028, 29759.39946423222, 29919.0, 29957.360325177924, 50048.74975625099, 50318.0, 50474.74762626163, 50592.74703626458, 50815.74592127016, 521286.0, 522353.0, 524472.0, 525479.0, 527276.0, 37989.0, 39337.80331098326, 39429.0, 39480.40779388369, 39713.60286397099, 43911.34132987944, 45483.77258113688, 45742.313865291384, 46167.76916115398, 46491.76754116343, 33476.0, 37181.81409092937, 37380.0, 37890.0, 39367.40948885826, 37254.8137259312, 37474.8126259367, 37782.60263330885, 38626.0, 39120.80439597784, 37140.628593713715, 37528.24943501169, 37945.81027094847, 37958.62041379661, 38041.048973775876, 30250.428713559595, 31767.72929082811, 33583.49624755582, 33737.83131084329, 33998.49002264919, 22377.0, 24407.0, 24463.51072978566, 24940.12709555157, 25066.965178107646], "value": 19940.60829071706, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.55050315878833, 387.6704800919217, 393.92121575684854, 397.0391652201672, 416.5875782974854, 19998.000099994995, 20480.69278960817, 20714.378568642926, 21392.35822925313, 21398.89300553499, 17201.56996075099, 20408.081636326362, 21166.788332116674, 21319.147234110656, 21481.67777483339, 5372.650777699447, 5700.458456446631, 5757.222774925373, 5792.420757924216, 5795.072788353864, 5487.42382049885, 5696.6866822324755, 5728.713564321788, 5737.942620573804, 5779.62432441892, 5683.2895888014, 5750.597458177929, 5765.1352297155345, 5765.769369225247, 5774.884502309951, 4784.641151913585, 5546.140348246028, 5729.140628905656, 5740.684262365568, 5746.827595172131, 4077.2864748668862, 5025.648204625678, 5026.220935754927, 5037.521435463662, 5048.419431765321, 24618.384540386633, 24712.3821904452, 24869.129580464596, 24999.0, 25253.36866578332, 2619.410632607667, 2663.933401664974, 2753.2841461220028, 2761.5443451830424, 2801.145650576573, 14685.045472044283, 15066.397344106223, 15142.242887855564, 15222.0, 15462.381504739797, 1757.3497805811803, 1796.2455768577229, 1836.9265229390808, 1837.4303965770655, 1853.6848735714962, 121276.0, 125446.0, 125720.114198288, 126693.36653316766, 128216.35891820575, 11072.778544429066, 11274.267172633752, 11375.658730238107, 11379.658610241706, 11483.598074067535, 13970.790438143436, 14042.929785351213, 14065.015448918683, 14066.507672231422, 14074.2962851857, 8183.468074575134, 8367.246947774729, 8408.784149909896, 8596.312295016383, 8621.482711037357, 8284.378671599654, 8331.916680833114, 8376.874346884802, 8488.74533763988, 8508.234258916604, 5929.940700593025, 6981.476389270825, 6988.37104660583, 6999.195092564319, 7005.509614326948, 1892.5930924851223, 1936.8353689936514, 1937.6221636780692, 1939.679952807799, 1940.233607724969, 1041.8228901086834, 1060.9628662996759, 1071.887451817548, 1079.983800242997, 1113.0817075912405, 17034.0, 19823.0, 21427.57144857094, 21578.352649420543, 22074.33776986693, 896.4128495835238, 1019.2610357490908, 1036.7304500829687, 1045.0959919669583, 1059.3908502610875, 10411.11505522024, 10985.956334148243, 11011.0, 11181.944090279496, 11191.776164476665, 646551.3553310377, 692823.0, 722733.0, 757284.0, 763136.0, 124182.0, 131703.36593268273, 148445.0, 150720.0, 159959.0, 1044.6448207609296, 1057.6404022632341, 1067.0503252105632, 1073.3077165228383, 1075.419273592267, 14507.854921450651, 17003.91498042502, 17568.38510652121, 17948.37180698669, 18147.637047258715, 50195.0, 57251.42748572628, 57572.0, 58310.4168958305, 58935.0, 82100.76848847391, 84605.0, 85873.0, 86269.0, 86465.56767216124, 7025.910983797519, 7843.137254902052, 7874.0157480314965, 8016.95991520062, 8157.75526734199, 8755.168259015383, 10275.280730348804, 11945.641630751092, 12002.275312855545, 12469.937650311691, 10241.129503992244, 10520.421376824348, 10603.41681207541, 10677.039066484054, 10734.785304293715, 7816.296533312029, 10332.793344132924, 10478.79042419132, 10849.67450976472, 10939.56241750321, 10387.272890897564, 10652.84020739705, 10770.24608277413, 11030.007299343097, 11129.554817807197, 6046.909296360646, 7957.602119894098, 8074.232947869943, 8124.268815806606, 8124.512529248264, 7689.730859419893, 10638.255322127377, 10963.945180274048, 11032.44837758125, 11080.279781814157], "value": 9800.220883820146, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1427.2364285107467, 1438.431819431324, 1445.0895935560595, 1457.8337330135896, 1467.4717101843337, 7482.4762266641355, 7755.806104847382, 7921.801954951129, 8452.112528184536, 8452.661893524268, 7567.091948966132, 7740.838874168878, 8010.319122874548, 8314.043884953233, 8368.0, 2225.3324002799177, 2291.8968646410867, 2325.976740232593, 2332.323626148415, 2336.5677349690277, 2321.1759825262043, 2322.1872344679396, 2352.4589344450787, 2363.7872591466767, 2364.4561750797325, 2300.3559003479054, 2324.6861673674093, 2326.7789559991857, 2327.406511339606, 2338.5206032763326, 1879.9060046997731, 2300.470891694911, 2306.5041016181603, 2314.722233331994, 2329.5573840970246, 2298.1152256381247, 2350.0482304666466, 2361.114582031738, 2362.61016932206, 2364.160722943365, 8374.623141958566, 8382.994040715092, 8390.0, 8400.663973441055, 8422.368322375785, 5012.27322038306, 5136.8202112925865, 5167.0, 5170.534651881311, 5172.991266702995, 2898.2899189698446, 3068.55505951638, 3153.0, 3313.2710803623163, 3373.8650453981813, 1212.1999480342931, 1215.1008253892055, 1646.1357787161717, 1717.2529949471896, 1778.2442461953617, 10707.089897358734, 10755.193360497993, 10868.728281792939, 10905.236633435663, 10934.507947142398, 3832.5784163741964, 4428.22506061438, 4444.333349997526, 4479.776011199427, 4515.390422293014, 8383.455075420079, 8769.956150219208, 8774.034856165817, 8788.16512431318, 8974.326925480615, 5131.820386286462, 5139.408967968731, 5145.742712864417, 5152.433232344439, 5167.22491626259, 4277.679174061957, 4361.560684974014, 4534.682572219979, 4593.885152871205, 4711.646626503026, 3634.7455678102806, 3703.148275896559, 3717.1636381813873, 3742.5029988005017, 3796.962030379716, 1144.2390810111349, 1158.0677554568654, 1160.4487868262677, 1162.5524173193382, 1165.12033414773, 820.7483587529066, 856.9785755356166, 878.446578655443, 897.2866571076011, 902.1159263921263, 5435.0, 5458.0, 5630.436956304418, 5747.568932330092, 5866.794662186803, 947.0, 967.6226271754022, 976.8339382304883, 993.1111655068673, 1014.5181039006413, 3624.565052193701, 3639.3449179148006, 3696.6672999429643, 3777.187904600469, 3792.715546333981, 9721.270904682036, 9988.300818942604, 10034.397936123856, 10040.899591004143, 10079.042490963348, 9437.480938548446, 9863.309568330147, 10043.397396156253, 10096.495175241209, 10112.494375281207, 7690.2694244046725, 7844.4116691247245, 7895.407844411692, 7904.051513818378, 7925.365970722329, 4646.953530464787, 4950.628702847373, 5284.41871394154, 5743.0, 5904.0, 7859.703148980354, 8940.195382415613, 8983.281337493116, 9083.818323633623, 9121.315901307296, 9073.410228335137, 9219.953900230725, 9295.395799273025, 9351.579178936829, 9406.012368701187, 6016.706408122274, 6623.0, 6786.966065169642, 6945.652717364011, 7281.19906810261, 7950.602469876368, 8015.599220038858, 8018.599070046591, 8026.83946321082, 8044.034715834137, 6089.756409743561, 6113.694315284307, 7095.787126386217, 7286.417086633162, 7439.330460258603, 7145.678444469907, 7156.570605763671, 7167.534110282815, 7168.032315637322, 7225.674844632109, 6335.524835637438, 6390.329015453311, 6428.903566446601, 6462.289148193601, 6466.256380516301, 4939.259111133359, 5009.423916249678, 5017.8243761468175, 5057.064443078042, 5102.36220472441, 4268.893277668083, 4830.589399901048, 4925.113479573568, 5026.346574945233, 5065.696058236517], "value": 4381.991756019633, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.670201235684, 325.6108949804983, 351.9476764474221, 364.48607463476503, 373.5554689918998, 4414.381986521889, 4593.448786145659, 5330.520253177213, 5360.391882435273, 5409.56723462123, 4801.711897286165, 4932.4081110266725, 5032.622553308507, 5182.663126896749, 5267.157254839227, 3821.331267028273, 4104.988555607753, 4216.957830421703, 4250.936235956463, 4254.765987870666, 4129.2154490646835, 4129.648979836717, 4264.573542645741, 4278.122984788127, 4284.293091639891, 3456.792592444449, 3695.6119607441233, 3916.2167566486673, 4162.687798415131, 4199.73214464189, 4102.3026085565525, 4111.712180147376, 4171.874843754692, 4204.432401625772, 4220.9155816883795, 3587.8385472653795, 3733.8879833605033, 3743.794091324976, 3746.6253374662315, 3752.924941501182, 4612.1698094343, 5024.723640199788, 5048.763053051989, 5110.591152707774, 5226.895462090737, 4388.319810429389, 4763.642726795504, 4820.276958456225, 4841.2496063110275, 4877.609791216694, 5442.047641662693, 5444.346678398578, 5617.859553511154, 5696.417510839359, 5740.397258287903, 3594.6405359464106, 3783.8297276622343, 4112.280350938574, 4113.4035564843225, 4132.586741325874, 4833.589144922686, 5264.52619264268, 5853.678047707374, 5929.555283353766, 5974.8506287342725, 4151.4395556599475, 4162.188373267184, 4176.58234176586, 4183.163367326547, 4216.229183742836, 3441.397755392796, 3707.4994875691436, 3919.0, 4167.2082304362075, 4273.376117075553, 4343.782810859444, 4767.498238055002, 4852.902941941142, 4867.415910090812, 4879.853604391874, 5668.987509434174, 5676.744546495418, 5692.430756924275, 5727.5990680652785, 5741.85645358861, 1246.9189502682298, 1289.9226046437057, 1339.8325209348832, 1353.2151352215692, 1358.9388477518535, 942.7595963029383, 949.852772820214, 955.9952200239094, 959.3764053365229, 970.9174720148867, 4107.815148318333, 4473.3542163136935, 4754.667173297905, 4900.382873651758, 4929.580985616263, 4790.0, 5055.9494405055475, 5176.2494438306985, 5419.918701219485, 5475.014497390428, 3996.2606917720314, 4265.445492086009, 4389.978050109729, 4492.3935268738305, 4919.163742163841, 2543.465872166829, 2761.295869553251, 2800.6919238883706, 2802.8178168419395, 2822.520171570838, 5634.23937768396, 5648.841987392575, 5659.773609055674, 5661.886762264731, 5703.7148142592705, 4524.6380289576755, 4984.551390374883, 5149.588032957355, 5408.729563521808, 5607.971960140173, 5386.784528618811, 5583.35791383996, 5758.429773540432, 5785.392533783892, 5788.710564471759, 4895.73073480962, 4920.803167873245, 5440.510354068153, 5475.780968761205, 5506.972465137809, 4540.750258735801, 4657.0918670858855, 4792.472827988988, 5160.638755287094, 5304.336957880265, 4593.839215627437, 5055.974720126376, 5267.631265811357, 5337.0, 5635.88728225425, 3734.842198918235, 3743.128435782109, 3789.6778773804535, 3824.8278827453387, 3861.979426745276, 4656.627469802475, 5318.042752304467, 5429.945700542944, 5634.718264086861, 5727.8854422912145, 5665.5750818689585, 5682.77268909239, 5694.231278777312, 5700.030994730822, 5707.857303567278, 4927.802887884444, 5553.500184983371, 5583.860403489783, 5595.293435502048, 5688.345840228427, 4846.539578740014, 5181.715005674724, 5442.23808666779, 5511.255980442589, 5523.536262890418, 4472.709273897186, 4962.429320628174, 4975.402951645826, 5526.281583394133, 5663.461971112738, 5465.426130256265, 5527.613067085426, 5528.364238112507, 5549.197655184267, 5558.471945165203], "value": 4071.5836912655723, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.2415458454656, 676.4013847744744, 713.8037039814051, 783.4085265624452, 802.7431222008958, 14832.703345933074, 15728.37086516538, 15740.606484837856, 15745.52763417098, 15788.921055394736, 14283.151800217245, 14386.352614132364, 14538.491152809655, 14577.781333279983, 14579.343929523171, 857.5369300577696, 863.8013256950906, 866.3069544364515, 873.6636394987912, 877.0352612126674, 870.3863776037878, 871.1593312453481, 871.2072014466836, 872.4111224923183, 873.5894129759004, 901.1394118616738, 922.3727865051762, 923.9743884288469, 933.7572231219898, 942.9198518125968, 906.5784410249199, 922.8661844032578, 922.9261659067292, 923.64901337492, 924.58393722825, 567.7785663591203, 625.1060982794602, 697.6163110289372, 697.9685914133826, 702.5257950883184, 14635.780463293058, 14840.10959342443, 15693.979891307028, 15753.054816711034, 15766.921165394215, 14006.579802605938, 14057.578272651837, 14322.14067155974, 14473.565793026226, 14482.637934051627, 9500.952495237549, 11374.69131183111, 11525.423728813526, 11985.28088314704, 12235.388230588434, 3589.0351051564594, 3598.1004748812798, 3654.6162652921594, 3716.1638631307737, 3730.850765969358, 70883.0, 87889.0, 101788.99999999926, 108276.0, 108809.0, 10577.0, 10634.20243481742, 10765.623203187852, 10833.681779264569, 10993.285436446606, 22337.664935025987, 22631.0, 22732.886335568215, 22851.542969140522, 23026.0, 7585.772426827204, 7681.462297639224, 7734.303912647776, 7741.92258077412, 7885.763427097197, 3913.295606790805, 3941.8620348287673, 3989.4414781930554, 3997.8600748973645, 4003.3794761811964, 3050.344176002126, 3127.921801954924, 3572.4641303804638, 3658.926821463609, 3660.6888414484533, 660.072597999811, 660.389140045456, 665.4709505942787, 670.7149461478851, 689.3451221339748, 562.3392513796273, 654.2182092399537, 665.3280187011056, 669.3440428380214, 690.6960937187621, 8484.27883629886, 9507.070304720066, 9989.950050249847, 10475.528601212964, 10570.365778053188, 519.7759276902915, 545.7762317449826, 595.5265563876728, 638.4700698420393, 674.699758607415, 4509.301058335963, 4798.712077275305, 4799.904001919942, 4857.562819346276, 4923.163062279421, 82578.0, 84302.0, 91817.54091229501, 92202.53898730464, 93597.0, 65428.672856635414, 80438.0, 81295.0, 82658.58670706728, 83301.58349208215, 72772.2722772776, 73548.16129596804, 73897.52204955979, 74537.62731186309, 74644.25355746482, 9651.806963860823, 9655.613775448903, 9674.419534827934, 9709.6601618943, 9726.659566915125, 44656.33015504835, 48893.755531222116, 48909.75545122252, 49142.0, 49206.261906072155, 63067.369326307984, 63692.0, 64974.0, 65463.34536654573, 66390.0, 11526.308421494738, 11539.653810385365, 11763.882361176278, 11772.352520611106, 11815.113866459878, 11501.734809171152, 12295.692607684521, 12786.360681965678, 12954.90753272427, 13048.151870128411, 11417.543298268309, 11603.825942611036, 11725.76548469043, 11943.940280298542, 12372.1958072725, 9852.753681157741, 11581.50851581495, 11667.299962002307, 11839.822402663794, 12322.260664360167, 11620.535178592761, 12957.22256664603, 13093.869061309266, 13235.81841229625, 13248.80126798118, 8853.931020081449, 10320.845187322046, 10538.164399728046, 10709.892901071202, 11395.259308144945, 7773.317966855954, 8715.977302453355, 9568.904310956801, 10778.877134105487, 10830.51262693165], "value": 7201.323105882177, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1562.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 114.0, 121.0, 119.0, 117.0, 120.0, 120.0, 118.0, 129.0], "value": 118.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 116.0, 116.0, 150.0, 111.0, 115.0, 115.0, 116.0, 133.0, 111.0], "value": 122.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 212.0, 217.0, 250.0, 202.0, 198.0, 201.0, 200.0, 206.0, 199.0], "value": 208.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 60.0, 60.0, 87.0, 63.0, 63.0, 86.0, 79.0, 71.0, 60.0], "value": 71.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 73.0, 83.0, 71.0, 69.0, 77.0, 96.0, 68.0, 70.0, 84.0], "value": 78.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 99.0, 112.0, 90.0, 85.0, 91.0, 106.0, 84.0, 128.0], "value": 97.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 100.0, 99.0, 99.0, 150.0, 150.0, 101.0, 99.0, 100.0, 99.0], "value": 109.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 97.0, 92.0, 92.0, 96.0, 95.0, 91.0, 95.0, 92.0, 107.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 62.0, 61.0, 63.0, 67.0, 79.0, 84.0, 63.0, 63.0], "value": 66.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 127.0, 112.0, 115.0, 103.0, 73.0, 73.0, 96.0, 95.0], "value": 93.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 92.0, 113.0, 107.0, 91.0, 95.0, 88.0, 88.0, 91.0], "value": 94.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 153.0, 155.0, 140.0, 143.0, 144.0, 144.0, 143.0, 209.0, 156.0], "value": 155.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 181.0, 179.0, 181.0, 176.0, 174.0, 175.0, 175.0, 178.0, 180.0], "value": 178.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 70.0, 66.0, 72.0, 69.0, 68.0, 75.0, 81.0, 92.0], "value": 73.4, "unit": "score"}]}]} 13:08:41 INFO - Return code: 0 13:08:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:08:41 ERROR - # TBPL SUCCESS # 13:08:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:08:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:08:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:08:41 INFO - 2017-01-19 13:08:41.423 screenresolution[6439:116235] starting screenresolution argv=screenresolution get 13:08:41 INFO - 2017-01-19 13:08:41.425 screenresolution[6439:116235] Display 0: 1600x1200x32@60 13:08:41 INFO - 2017-01-19 13:08:41.432 screenresolution[6440:116238] starting screenresolution argv=screenresolution list 13:08:41 INFO - Available Modes on Display 0 13:08:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:08:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:08:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:08:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:08:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:08:41 INFO - Intel Iris: 13:08:41 INFO - Chipset Model: Intel Iris 13:08:41 INFO - Type: GPU 13:08:41 INFO - Bus: Built-In 13:08:41 INFO - VRAM (Dynamic, Max): 1536 MB 13:08:41 INFO - Vendor: Intel (0x8086) 13:08:41 INFO - Device ID: 0x0a2e 13:08:41 INFO - Revision ID: 0x0009 13:08:41 INFO - Displays: 13:08:41 INFO - Display: 13:08:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:08:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:08:41 INFO - Display Serial Number: 1600x1200 60 13:08:41 INFO - Main Display: Yes 13:08:41 INFO - Mirror: Off 13:08:41 INFO - Online: Yes 13:08:41 INFO - Rotation: Supported 13:08:41 INFO - Return code: 0 13:08:41 INFO - Running post-action listener: _resource_record_post_action 13:08:41 INFO - [mozharness: 2017-01-19 21:08:41.673538Z] Finished run-tests step (success) 13:08:41 INFO - Running post-run listener: _resource_record_post_run 13:08:41 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 1534976; Write bytes: 556700160; Read time: 21; Write time: 2201 13:08:41 INFO - TinderboxPrint: CPU usage
54.6% 13:08:41 INFO - TinderboxPrint: I/O read bytes / time
1,534,976 / 21 13:08:41 INFO - TinderboxPrint: I/O write bytes / time
556,700,160 / 2,201 13:08:41 INFO - TinderboxPrint: CPU idle
2,178.3 (45.4%) 13:08:41 INFO - TinderboxPrint: CPU system
971.7 (20.2%) 13:08:41 INFO - TinderboxPrint: CPU user
1,651.7 (34.4%) 13:08:41 INFO - TinderboxPrint: Swap in / out
253,485,056 / 0 13:08:41 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 251132416; Write bytes: 246092800; Read time: 18021; Write time: 743 13:08:41 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 1305600; Write bytes: 301178368; Read time: 16; Write time: 1427 13:08:42 INFO - Running post-run listener: _upload_blobber_files 13:08:42 INFO - Blob upload gear active. 13:08:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:08:42 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:42 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:42 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:42 INFO - (blobuploader) - INFO - Open directory for files ... 13:08:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 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: dromaeojs-e10s_errorsummary.log: 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/dromaeojs-e10s_raw.log ... 13:08:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:08:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:08:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:08:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:08:44 INFO - (blobuploader) - INFO - Done attempting. 13:08:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:08:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:08:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:08:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.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 - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:08:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:08:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:08:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:08:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:08:48 INFO - (blobuploader) - INFO - Done attempting. 13:08:48 INFO - (blobuploader) - INFO - Iteration through files over. 13:08:48 INFO - Return code: 0 13:08:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:08:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:08:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02ccc2a7873c38538a8317fee5d811dfae3ea4bde8175bedb771c4bb0dab41088bb9eefa810087459169d2f7e91639f708488957e260bb52ce68c94c9037062b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/633834dad9065f8b408727b14dbffd6d2d2fde344af7386634287971dd837a97324fd747d78dbfab521ec6a8bf1c93f9eaca7ab9db2e3673ebb18ae19e9a3fe8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cc4ae2953c64d996eb49071d4bd3e2dc26876415717f6b809716ba32bd56921608fe3ff11af7c34c2b012de596a2f7278e18e12b854fd8da90b4ad92c2a7d1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c710182e06908f36c3ce134a52cc8e0e428aafe7cc30d98ffabc83aac9f3078a952aa106b541d42fd5b6447ce5497a59e562dadc5a4bf02f4ff7d572448d9221"} 13:08:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:08:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:08:48 INFO - Contents: 13:08:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02ccc2a7873c38538a8317fee5d811dfae3ea4bde8175bedb771c4bb0dab41088bb9eefa810087459169d2f7e91639f708488957e260bb52ce68c94c9037062b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/633834dad9065f8b408727b14dbffd6d2d2fde344af7386634287971dd837a97324fd747d78dbfab521ec6a8bf1c93f9eaca7ab9db2e3673ebb18ae19e9a3fe8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cc4ae2953c64d996eb49071d4bd3e2dc26876415717f6b809716ba32bd56921608fe3ff11af7c34c2b012de596a2f7278e18e12b854fd8da90b4ad92c2a7d1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c710182e06908f36c3ce134a52cc8e0e428aafe7cc30d98ffabc83aac9f3078a952aa106b541d42fd5b6447ce5497a59e562dadc5a4bf02f4ff7d572448d9221"} 13:08:48 INFO - Running post-run listener: copy_logs_to_upload_dir 13:08:48 INFO - Copying logs to upload dir... 13:08:48 INFO - mkdir: /builds/slave/test/build/upload/logs 13:08:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.059503 ========= master_lag: 3.81 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2017-01-19 13:08:51.989849) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 5 secs) (at 2017-01-19 13:08:51.993177) ========= 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.hO58RIyCgD/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.eXo1Ppu4fi/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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/02ccc2a7873c38538a8317fee5d811dfae3ea4bde8175bedb771c4bb0dab41088bb9eefa810087459169d2f7e91639f708488957e260bb52ce68c94c9037062b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/633834dad9065f8b408727b14dbffd6d2d2fde344af7386634287971dd837a97324fd747d78dbfab521ec6a8bf1c93f9eaca7ab9db2e3673ebb18ae19e9a3fe8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cc4ae2953c64d996eb49071d4bd3e2dc26876415717f6b809716ba32bd56921608fe3ff11af7c34c2b012de596a2f7278e18e12b854fd8da90b4ad92c2a7d1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c710182e06908f36c3ce134a52cc8e0e428aafe7cc30d98ffabc83aac9f3078a952aa106b541d42fd5b6447ce5497a59e562dadc5a4bf02f4ff7d572448d9221"} 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.011454 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/02ccc2a7873c38538a8317fee5d811dfae3ea4bde8175bedb771c4bb0dab41088bb9eefa810087459169d2f7e91639f708488957e260bb52ce68c94c9037062b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/633834dad9065f8b408727b14dbffd6d2d2fde344af7386634287971dd837a97324fd747d78dbfab521ec6a8bf1c93f9eaca7ab9db2e3673ebb18ae19e9a3fe8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cc4ae2953c64d996eb49071d4bd3e2dc26876415717f6b809716ba32bd56921608fe3ff11af7c34c2b012de596a2f7278e18e12b854fd8da90b4ad92c2a7d1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c710182e06908f36c3ce134a52cc8e0e428aafe7cc30d98ffabc83aac9f3078a952aa106b541d42fd5b6447ce5497a59e562dadc5a4bf02f4ff7d572448d9221"}' ========= master_lag: 5.41 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 5 secs) (at 2017-01-19 13:08:57.414816) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2017-01-19 13:08:57.415175) ========= 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.hO58RIyCgD/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.eXo1Ppu4fi/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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.005500 ========= master_lag: 4.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2017-01-19 13:09:01.430679) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-19 13:09:01.434393) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-19 13:09:02.148535) ========= ========= Total master_lag: 13.31 =========