builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0022 starttime: 1489618765.46 results: success (0) buildid: 20170315142540 builduid: 2bbc3e66a3ba4d4eabc75e49b2d8d370 revision: ff04d410e74b69acfab17ef7e73e7397602d5a68 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-15 15:59:25.465260) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-15 15:59:25.465754) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-15 15:59:25.466090) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-15 15:59:25.492237) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 15:59:25.492647) ========= 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.QF4NzQeRw1/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.Lh2mXNdPaY/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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-03-15 15:59:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 166M=0s 2017-03-15 15:59:25 (166 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.200452 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 15:59:25.719331) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 15:59:25.719853) ========= 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.QF4NzQeRw1/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.Lh2mXNdPaY/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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.028321 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 15:59:25.774164) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-15 15:59:25.774648) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ff04d410e74b69acfab17ef7e73e7397602d5a68 --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 ff04d410e74b69acfab17ef7e73e7397602d5a68 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QF4NzQeRw1/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.Lh2mXNdPaY/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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-03-15 15:59:25,884 truncating revision to first 12 chars 2017-03-15 15:59:25,884 Setting DEBUG logging. 2017-03-15 15:59:25,884 attempt 1/10 2017-03-15 15:59:25,884 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ff04d410e74b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-15 15:59:27,834 unpacking tar archive at: mozilla-central-ff04d410e74b/testing/mozharness/ program finished with exit code 0 elapsedTime=2.222150 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-15 15:59:28.021726) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-15 15:59:28.022131) ========= script_repo_revision: ff04d410e74b69acfab17ef7e73e7397602d5a68 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-15 15:59:28.022580) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-15 15:59:28.022877) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-15 15:59:28.043099) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-15 15:59:28.043539) ========= /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.QF4NzQeRw1/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.Lh2mXNdPaY/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 15:59:28 INFO - MultiFileLogger online at 20170315 15:59:28 in /builds/slave/test 15:59:28 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 15:59:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:59:28 INFO - {'append_to_log': False, 15:59:28 INFO - 'base_work_dir': '/builds/slave/test', 15:59:28 INFO - 'blob_upload_branch': 'Firefox', 15:59:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:59:28 INFO - 'branch': 'Firefox', 15:59:28 INFO - 'buildbot_json_path': 'buildprops.json', 15:59:28 INFO - 'config_files': ('talos/mac_config.py',), 15:59:28 INFO - 'default_actions': ('clobber', 15:59:28 INFO - 'read-buildbot-config', 15:59:28 INFO - 'download-and-extract', 15:59:28 INFO - 'populate-webroot', 15:59:28 INFO - 'create-virtualenv', 15:59:28 INFO - 'install', 15:59:28 INFO - 'run-tests'), 15:59:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:59:28 INFO - 'download_minidump_stackwalk': True, 15:59:28 INFO - 'download_symbols': 'ondemand', 15:59:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:59:28 INFO - 'tooltool.py': '/tools/tooltool.py', 15:59:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:59:28 INFO - '/tools/misc-python/virtualenv.py')}, 15:59:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:59:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:59:28 INFO - 'gecko_profile': False, 15:59:28 INFO - 'gecko_profile_interval': 0, 15:59:28 INFO - 'installer_path': 'installer.exe', 15:59:28 INFO - 'log_level': 'info', 15:59:28 INFO - 'log_name': 'talos', 15:59:28 INFO - 'log_to_console': True, 15:59:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:59:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:59:28 INFO - 'opt_config_files': (), 15:59:28 INFO - 'pip_index': False, 15:59:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:59:28 INFO - 'cmd': ('bash', 15:59:28 INFO - '-c', 15:59:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:59:28 INFO - 'enabled': True, 15:59:28 INFO - 'halt_on_failure': False, 15:59:28 INFO - 'name': 'check_screen_resolution'},), 15:59:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:59:28 INFO - 'cmd': ('bash', 15:59:28 INFO - '-c', 15:59:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:59:28 INFO - 'enabled': True, 15:59:28 INFO - 'halt_on_failure': False, 15:59:28 INFO - 'name': 'check_screen_resolution'},), 15:59:28 INFO - 'run_cmd_checks_enabled': True, 15:59:28 INFO - 'suite': 'dromaeojs-e10s', 15:59:28 INFO - 'system_bits': '32', 15:59:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:59:28 INFO - 'title': 't-yosemite-r7-0022', 15:59:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:59:28 INFO - 'use_talos_json': True, 15:59:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:59:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:59:28 INFO - 'work_dir': 'build'} 15:59:28 INFO - [mozharness: 2017-03-15 22:59:28.260277Z] Running clobber step. 15:59:28 INFO - Running pre-action listener: _resource_record_pre_action 15:59:28 INFO - Running main action method: clobber 15:59:28 INFO - rmtree: /builds/slave/test/build 15:59:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:59:30 INFO - Running post-action listener: _resource_record_post_action 15:59:30 INFO - [mozharness: 2017-03-15 22:59:30.778558Z] Finished clobber step (success) 15:59:30 INFO - [mozharness: 2017-03-15 22:59:30.778686Z] Running read-buildbot-config step. 15:59:30 INFO - Running pre-action listener: _resource_record_pre_action 15:59:30 INFO - Running main action method: read_buildbot_config 15:59:30 INFO - Using buildbot properties: 15:59:30 INFO - { 15:59:30 INFO - "project": "", 15:59:30 INFO - "product": "firefox", 15:59:30 INFO - "script_repo_revision": "production", 15:59:30 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 15:59:30 INFO - "repository": "", 15:59:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 15:59:30 INFO - "buildid": "20170315142540", 15:59:30 INFO - "pgo_build": "False", 15:59:30 INFO - "basedir": "/builds/slave/test", 15:59:30 INFO - "buildnumber": 176, 15:59:30 INFO - "slavename": "t-yosemite-r7-0022", 15:59:30 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 15:59:30 INFO - "platform": "yosemite_r7", 15:59:30 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:59:30 INFO - "branch": "mozilla-central", 15:59:30 INFO - "repo_path": "mozilla-central", 15:59:30 INFO - "revision": "ff04d410e74b69acfab17ef7e73e7397602d5a68", 15:59:30 INFO - "stage_platform": "macosx64", 15:59:30 INFO - "builduid": "2bbc3e66a3ba4d4eabc75e49b2d8d370", 15:59:30 INFO - "slavebuilddir": "test" 15:59:30 INFO - } 15:59:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/FexCcSDiTeiLFAxIJoTGqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 15:59:30 INFO - Running post-action listener: _resource_record_post_action 15:59:30 INFO - [mozharness: 2017-03-15 22:59:30.782082Z] Finished read-buildbot-config step (success) 15:59:30 INFO - [mozharness: 2017-03-15 22:59:30.782192Z] Running download-and-extract step. 15:59:30 INFO - Running pre-action listener: _resource_record_pre_action 15:59:30 INFO - Running main action method: download_and_extract 15:59:30 INFO - mkdir: /builds/slave/test/build/tests 15:59: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')]} 15:59:30 INFO - trying https://queue.taskcluster.net/v1/task/FexCcSDiTeiLFAxIJoTGqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 15:59:30 INFO - Downloading https://queue.taskcluster.net/v1/task/FexCcSDiTeiLFAxIJoTGqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 15:59:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FexCcSDiTeiLFAxIJoTGqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 15:59:31 INFO - Downloaded 1199 bytes. 15:59:31 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 15:59:31 INFO - Using the following test package requirements: 15:59:31 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 15:59:31 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:59:31 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 15:59:31 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:59:31 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 15:59:31 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:59:31 INFO - u'jsshell-mac.zip'], 15:59:31 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:59:31 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 15:59:31 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 15:59:31 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:59:31 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 15:59:31 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:59:31 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 15:59:31 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:59:31 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 15:59:31 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:59:31 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 15:59:31 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:59:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FexCcSDiTeiLFAxIJoTGqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 15:59:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FexCcSDiTeiLFAxIJoTGqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:59:31 INFO - Fetch https://queue.taskcluster.net/v1/task/FexCcSDiTeiLFAxIJoTGqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 15:59:33 INFO - Expected file size: 52476367 15:59:33 INFO - Obtained file size: 52476367 15:59:49 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:59:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FexCcSDiTeiLFAxIJoTGqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 15:59:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FexCcSDiTeiLFAxIJoTGqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:59:49 INFO - Fetch https://queue.taskcluster.net/v1/task/FexCcSDiTeiLFAxIJoTGqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 15:59:51 INFO - Expected file size: 52476367 15:59:51 INFO - Obtained file size: 52476367 16:00:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FexCcSDiTeiLFAxIJoTGqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 16:00:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FexCcSDiTeiLFAxIJoTGqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:00:06 INFO - Fetch https://queue.taskcluster.net/v1/task/FexCcSDiTeiLFAxIJoTGqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 16:00:07 INFO - Expected file size: 14404452 16:00:07 INFO - Obtained file size: 14404452 16:00:07 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')]} 16:00:07 INFO - trying https://queue.taskcluster.net/v1/task/FexCcSDiTeiLFAxIJoTGqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:00:07 INFO - Downloading https://queue.taskcluster.net/v1/task/FexCcSDiTeiLFAxIJoTGqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 16:00:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FexCcSDiTeiLFAxIJoTGqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 16:00:10 INFO - Downloaded 75095025 bytes. 16:00:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FexCcSDiTeiLFAxIJoTGqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:00:10 INFO - mkdir: /builds/slave/test/properties 16:00:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:00:10 INFO - Writing to file /builds/slave/test/properties/build_url 16:00:10 INFO - Contents: 16:00:10 INFO - build_url:https://queue.taskcluster.net/v1/task/FexCcSDiTeiLFAxIJoTGqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:00:10 INFO - Running post-action listener: _resource_record_post_action 16:00:10 INFO - Running post-action listener: set_extra_try_arguments 16:00:10 INFO - [mozharness: 2017-03-15 23:00:10.659233Z] Finished download-and-extract step (success) 16:00:10 INFO - [mozharness: 2017-03-15 23:00:10.659334Z] Running populate-webroot step. 16:00:10 INFO - Running pre-action listener: _resource_record_pre_action 16:00:10 INFO - Running main action method: populate_webroot 16:00:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:00:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:00:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:00:10 INFO - '--tppagecycles', 16:00:10 INFO - '7'], 16:00:10 INFO - 'tests': ['tsvgm']}}, 16:00:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:00:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:00:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:00:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:00:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:00:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:00:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:00:10 INFO - 'talos_options': ['--disable-e10s'], 16:00:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:00:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:00:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:00:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:00:10 INFO - 'talos_options': ['--disable-e10s'], 16:00:10 INFO - 'tests': ['damp', 'tps']}, 16:00:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:00:10 INFO - 'tests': ['damp', 'tps']}, 16:00:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:00:10 INFO - 'tests': ['dromaeo_dom']}, 16:00:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:00:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:00:10 INFO - 'tests': ['basic_compositor_video']}, 16:00:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:00:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:00:10 INFO - 'tests': ['a11yr', 16:00:10 INFO - 'ts_paint', 16:00:10 INFO - 'tpaint', 16:00:10 INFO - 'sessionrestore', 16:00:10 INFO - 'sessionrestore_no_auto_restore', 16:00:10 INFO - 'tabpaint']}, 16:00:10 INFO - 'other-e10s': {'tests': ['a11yr', 16:00:10 INFO - 'ts_paint', 16:00:10 INFO - 'tpaint', 16:00:10 INFO - 'sessionrestore', 16:00:10 INFO - 'sessionrestore_no_auto_restore', 16:00:10 INFO - 'tabpaint']}, 16:00:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:00:10 INFO - 'ts_paint', 16:00:10 INFO - 'tpaint', 16:00:10 INFO - 'sessionrestore', 16:00:10 INFO - 'sessionrestore_no_auto_restore', 16:00:10 INFO - 'tabpaint']}, 16:00:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:00:10 INFO - 'ts_paint', 16:00:10 INFO - 'tpaint', 16:00:10 INFO - 'sessionrestore', 16:00:10 INFO - 'sessionrestore_no_auto_restore', 16:00:10 INFO - 'tabpaint']}, 16:00:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:00:10 INFO - 'tests': ['a11yr', 16:00:10 INFO - 'ts_paint', 16:00:10 INFO - 'tpaint', 16:00:10 INFO - 'sessionrestore', 16:00:10 INFO - 'sessionrestore_no_auto_restore', 16:00:10 INFO - 'tabpaint']}, 16:00:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:00:10 INFO - 'tests': ['a11yr', 16:00:10 INFO - 'ts_paint', 16:00:10 INFO - 'tpaint', 16:00:10 INFO - 'sessionrestore', 16:00:10 INFO - 'sessionrestore_no_auto_restore', 16:00:10 INFO - 'tabpaint']}, 16:00:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:00:10 INFO - 'tests': ['tsvgx', 16:00:10 INFO - 'tsvgr_opacity', 16:00:10 INFO - 'tart', 16:00:10 INFO - 'tscrollx', 16:00:10 INFO - 'cart', 16:00:10 INFO - 'tsvg_static']}, 16:00:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:00:10 INFO - 'tsvgr_opacity', 16:00:10 INFO - 'tart', 16:00:10 INFO - 'tscrollx', 16:00:10 INFO - 'cart', 16:00:10 INFO - 'tsvg_static']}, 16:00:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:00:10 INFO - 'talos_options': ['--disable-e10s'], 16:00:10 INFO - 'tests': ['tp5o']}, 16:00:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:00:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:00:10 INFO - 'talos_options': ['--disable-e10s', 16:00:10 INFO - '--xperf_path', 16:00:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:00:10 INFO - 'tests': ['tp5n']}, 16:00:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:00:10 INFO - 'talos_options': ['--xperf_path', 16:00:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:00:10 INFO - 'tests': ['tp5n']}}, 16:00:10 INFO - 'talos.zip': {'path': '', 16:00:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:00:10 INFO - Running post-action listener: _resource_record_post_action 16:00:10 INFO - [mozharness: 2017-03-15 23:00:10.677480Z] Finished populate-webroot step (success) 16:00:10 INFO - [mozharness: 2017-03-15 23:00:10.677609Z] Running create-virtualenv step. 16:00:10 INFO - Running pre-action listener: _resource_record_pre_action 16:00:10 INFO - Running main action method: create_virtualenv 16:00:10 INFO - Creating virtualenv /builds/slave/test/build/venv 16:00:10 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 16:00:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:00:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:00:10 INFO - Using real prefix '/tools/python27' 16:00:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:00:11 INFO - Installing distribute.............................................................................................................................................................................................done. 16:00:14 INFO - Installing pip.................done. 16:00:14 INFO - Return code: 0 16:00:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:00:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:00:14 INFO - Reading from file tmpfile_stdout 16:00:14 INFO - Output received: 16:00:14 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) 16:00:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:14 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 0x109fb2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fb5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a8ccc690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d90d30>, '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 0x109cb7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d85be8>, '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.QF4NzQeRw1/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.Lh2mXNdPaY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 16:00:14 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 16:00:14 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 16:00:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QF4NzQeRw1/Render', 16:00:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:00:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:00:14 INFO - 'HOME': '/Users/cltbld', 16:00:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:00:14 INFO - 'LOGNAME': 'cltbld', 16:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:14 INFO - 'MOZ_NO_REMOTE': '1', 16:00:14 INFO - 'NO_EM_RESTART': '1', 16:00:14 INFO - 'PAGER': '/bin/cat', 16:00:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:00:14 INFO - 'PWD': '/builds/slave/test', 16:00:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:00:14 INFO - 'SHELL': '/bin/bash', 16:00:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lh2mXNdPaY/Listeners', 16:00:14 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 16:00:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:00:14 INFO - 'USER': 'cltbld', 16:00:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:00:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:14 INFO - 'XPC_FLAGS': '0x0', 16:00:14 INFO - 'XPC_SERVICE_NAME': '0', 16:00:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:14 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 16:00:14 INFO - Cleaning up... 16:00:14 INFO - Return code: 0 16:00:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:14 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 0x109fb2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fb5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a8ccc690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d90d30>, '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 0x109cb7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d85be8>, '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.QF4NzQeRw1/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.Lh2mXNdPaY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 16:00:14 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 16:00:14 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 16:00:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QF4NzQeRw1/Render', 16:00:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:00:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:00:14 INFO - 'HOME': '/Users/cltbld', 16:00:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:00:14 INFO - 'LOGNAME': 'cltbld', 16:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:14 INFO - 'MOZ_NO_REMOTE': '1', 16:00:14 INFO - 'NO_EM_RESTART': '1', 16:00:14 INFO - 'PAGER': '/bin/cat', 16:00:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:00:14 INFO - 'PWD': '/builds/slave/test', 16:00:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:00:14 INFO - 'SHELL': '/bin/bash', 16:00:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lh2mXNdPaY/Listeners', 16:00:14 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 16:00:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:00:14 INFO - 'USER': 'cltbld', 16:00:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:00:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:14 INFO - 'XPC_FLAGS': '0x0', 16:00:14 INFO - 'XPC_SERVICE_NAME': '0', 16:00:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:15 INFO - Downloading/unpacking psutil>=3.1.1 16:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:00:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:00:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:00:18 INFO - Installing collected packages: psutil 16:00:18 INFO - Running setup.py install for psutil 16:00:18 INFO - building 'psutil._psutil_osx' extension 16:00:18 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 16:00:19 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 16:00:19 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 16:00:19 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 16:00:19 INFO - building 'psutil._psutil_posix' extension 16:00:19 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 16:00:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:00:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:00:19 INFO - ^ 16:00:19 INFO - 1 warning generated. 16:00:19 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 16:00:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:00:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:00:19 INFO - Successfully installed psutil 16:00:19 INFO - Cleaning up... 16:00:19 INFO - Return code: 0 16:00:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:00:19 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')]} 16:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:20 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')]} 16:00:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109fb2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fb5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a8ccc690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d90d30>, '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 0x109cb7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d85be8>, '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.QF4NzQeRw1/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.Lh2mXNdPaY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 16:00: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:00: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 mozsystemmonitor==0.3 16:00:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QF4NzQeRw1/Render', 16:00:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:00:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:00:21 INFO - 'HOME': '/Users/cltbld', 16:00:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:00:21 INFO - 'LOGNAME': 'cltbld', 16:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:21 INFO - 'MOZ_NO_REMOTE': '1', 16:00:21 INFO - 'NO_EM_RESTART': '1', 16:00:21 INFO - 'PAGER': '/bin/cat', 16:00:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:00:21 INFO - 'PWD': '/builds/slave/test', 16:00:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:00:21 INFO - 'SHELL': '/bin/bash', 16:00:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lh2mXNdPaY/Listeners', 16:00:21 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 16:00:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:00:21 INFO - 'USER': 'cltbld', 16:00:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:00:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:21 INFO - 'XPC_FLAGS': '0x0', 16:00:21 INFO - 'XPC_SERVICE_NAME': '0', 16:00:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:00:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:00: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 16:00: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 16:00: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 16:00: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 16:00: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 16:00: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 16:00:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:00:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:00:24 INFO - Installing collected packages: mozsystemmonitor 16:00:24 INFO - Running setup.py install for mozsystemmonitor 16:00:24 INFO - Successfully installed mozsystemmonitor 16:00:24 INFO - Cleaning up... 16:00:24 INFO - Return code: 0 16:00:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:00: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')]} 16:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00: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')]} 16:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00: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', '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 0x109fb2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fb5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a8ccc690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d90d30>, '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 0x109cb7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d85be8>, '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.QF4NzQeRw1/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.Lh2mXNdPaY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 16:00: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:00: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 jsonschema==2.5.1 16:00:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QF4NzQeRw1/Render', 16:00:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:00:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:00:24 INFO - 'HOME': '/Users/cltbld', 16:00:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:00:24 INFO - 'LOGNAME': 'cltbld', 16:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:24 INFO - 'MOZ_NO_REMOTE': '1', 16:00:24 INFO - 'NO_EM_RESTART': '1', 16:00:24 INFO - 'PAGER': '/bin/cat', 16:00:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:00:24 INFO - 'PWD': '/builds/slave/test', 16:00:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:00:24 INFO - 'SHELL': '/bin/bash', 16:00:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lh2mXNdPaY/Listeners', 16:00:24 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 16:00:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:00:24 INFO - 'USER': 'cltbld', 16:00:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:00:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:24 INFO - 'XPC_FLAGS': '0x0', 16:00:24 INFO - 'XPC_SERVICE_NAME': '0', 16:00:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:24 INFO - Downloading/unpacking jsonschema==2.5.1 16:00: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 16:00: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 16:00: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 16:00: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 16:00: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 16:00: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 16:00:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:00:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:27 INFO - Downloading functools32-3.2.3-2.tar.gz 16:00:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:00:28 INFO - warning: no files found matching '*.txt' 16:00:28 INFO - no previously-included directories found matching 'build' 16:00:28 INFO - no previously-included directories found matching 'dist' 16:00:28 INFO - no previously-included directories found matching '.git*' 16:00:28 INFO - Installing collected packages: jsonschema, functools32 16:00:28 INFO - Running setup.py install for functools32 16:00:28 INFO - warning: no files found matching '*.txt' 16:00:28 INFO - no previously-included directories found matching 'build' 16:00:28 INFO - no previously-included directories found matching 'dist' 16:00:28 INFO - no previously-included directories found matching '.git*' 16:00:28 INFO - Successfully installed jsonschema functools32 16:00:28 INFO - Cleaning up... 16:00:28 INFO - Return code: 0 16:00:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:00:28 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')]} 16:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:28 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')]} 16:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:28 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 0x109fb2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fb5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a8ccc690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d90d30>, '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 0x109cb7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d85be8>, '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.QF4NzQeRw1/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.Lh2mXNdPaY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 16:00:28 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 16:00:28 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 16:00:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QF4NzQeRw1/Render', 16:00:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:00:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:00:28 INFO - 'HOME': '/Users/cltbld', 16:00:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:00:28 INFO - 'LOGNAME': 'cltbld', 16:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:28 INFO - 'MOZ_NO_REMOTE': '1', 16:00:28 INFO - 'NO_EM_RESTART': '1', 16:00:28 INFO - 'PAGER': '/bin/cat', 16:00:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:00:28 INFO - 'PWD': '/builds/slave/test', 16:00:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:00:28 INFO - 'SHELL': '/bin/bash', 16:00:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lh2mXNdPaY/Listeners', 16:00:28 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 16:00:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:00:28 INFO - 'USER': 'cltbld', 16:00:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:00:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:28 INFO - 'XPC_FLAGS': '0x0', 16:00:28 INFO - 'XPC_SERVICE_NAME': '0', 16:00:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:00:28 INFO - Cleaning up... 16:00:28 INFO - Return code: 0 16:00:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:00:28 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')]} 16:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:28 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')]} 16:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:28 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 0x109fb2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fb5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a8ccc690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d90d30>, '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 0x109cb7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d85be8>, '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.QF4NzQeRw1/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.Lh2mXNdPaY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 16:00:28 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 16:00:28 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 16:00:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QF4NzQeRw1/Render', 16:00:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:00:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:00:28 INFO - 'HOME': '/Users/cltbld', 16:00:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:00:28 INFO - 'LOGNAME': 'cltbld', 16:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:28 INFO - 'MOZ_NO_REMOTE': '1', 16:00:28 INFO - 'NO_EM_RESTART': '1', 16:00:28 INFO - 'PAGER': '/bin/cat', 16:00:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:00:28 INFO - 'PWD': '/builds/slave/test', 16:00:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:00:28 INFO - 'SHELL': '/bin/bash', 16:00:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lh2mXNdPaY/Listeners', 16:00:28 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 16:00:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:00:28 INFO - 'USER': 'cltbld', 16:00:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:00:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:28 INFO - 'XPC_FLAGS': '0x0', 16:00:28 INFO - 'XPC_SERVICE_NAME': '0', 16:00:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:28 INFO - Downloading/unpacking blobuploader==1.2.4 16:00: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 16:00: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 16:00: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 16:00: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 16:00: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 16:00: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 16:00:31 INFO - Downloading blobuploader-1.2.4.tar.gz 16:00:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:00:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:00:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:00:32 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 16:00:32 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 16:00:32 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 16:00:32 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 16:00:32 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 16:00:32 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 16:00:32 INFO - Downloading docopt-0.6.1.tar.gz 16:00:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:00:32 INFO - Installing collected packages: blobuploader, requests, docopt 16:00:32 INFO - Running setup.py install for blobuploader 16:00:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:00:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:00:32 INFO - Running setup.py install for requests 16:00:33 INFO - Running setup.py install for docopt 16:00:33 INFO - Successfully installed blobuploader requests docopt 16:00:33 INFO - Cleaning up... 16:00:33 INFO - Return code: 0 16:00:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:00:33 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')]} 16:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:33 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')]} 16:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:33 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 0x109fb2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fb5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a8ccc690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d90d30>, '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 0x109cb7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d85be8>, '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.QF4NzQeRw1/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.Lh2mXNdPaY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 16:00:33 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 16:00:33 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 16:00:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QF4NzQeRw1/Render', 16:00:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:00:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:00:33 INFO - 'HOME': '/Users/cltbld', 16:00:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:00:33 INFO - 'LOGNAME': 'cltbld', 16:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:33 INFO - 'MOZ_NO_REMOTE': '1', 16:00:33 INFO - 'NO_EM_RESTART': '1', 16:00:33 INFO - 'PAGER': '/bin/cat', 16:00:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:00:33 INFO - 'PWD': '/builds/slave/test', 16:00:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:00:33 INFO - 'SHELL': '/bin/bash', 16:00:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lh2mXNdPaY/Listeners', 16:00:33 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 16:00:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:00:33 INFO - 'USER': 'cltbld', 16:00:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:00:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:33 INFO - 'XPC_FLAGS': '0x0', 16:00:33 INFO - 'XPC_SERVICE_NAME': '0', 16:00:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:00:34 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-KVQ97O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:00:34 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-ZqPTyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:00:34 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-9G_FCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:00:34 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-XH_UsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:00:34 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-j_vLni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:00:34 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-37dw1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:00:34 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-jyCZfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:00:34 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-_aiBn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:00:34 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-sOChZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:00:34 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-b8LXAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:00:35 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-FGa9bG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:00:35 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-pwXGZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:00:35 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-CfjgUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:00:35 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-yCi7gU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:00:35 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-pVqjrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:00:35 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-TK0XPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:00:35 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-tIOuUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:00:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:00:35 INFO - Running setup.py install for manifestparser 16:00:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:00:35 INFO - Running setup.py install for mozcrash 16:00:36 INFO - Running setup.py install for mozdebug 16:00:36 INFO - Running setup.py install for mozdevice 16:00:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:00:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:00:36 INFO - Running setup.py install for mozfile 16:00:36 INFO - Running setup.py install for mozhttpd 16:00:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:00:36 INFO - Running setup.py install for mozinfo 16:00:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:00:36 INFO - Running setup.py install for mozInstall 16:00:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:00:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:00:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:00:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:00:36 INFO - Running setup.py install for mozleak 16:00:37 INFO - Running setup.py install for mozlog 16:00:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:00:37 INFO - Running setup.py install for moznetwork 16:00:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:00:37 INFO - Running setup.py install for mozprocess 16:00:37 INFO - Running setup.py install for mozprofile 16:00:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:00:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:00:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:00:37 INFO - Running setup.py install for mozrunner 16:00:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:00:37 INFO - Running setup.py install for mozscreenshot 16:00:38 INFO - Running setup.py install for moztest 16:00:38 INFO - Running setup.py install for mozversion 16:00:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:00:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:00:38 INFO - Cleaning up... 16:00:38 INFO - Return code: 0 16:00:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:38 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 0x109fb2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fb5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a8ccc690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d90d30>, '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 0x109cb7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d85be8>, '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.QF4NzQeRw1/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.Lh2mXNdPaY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 16:00:38 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 16:00:38 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 16:00:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QF4NzQeRw1/Render', 16:00:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:00:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:00:38 INFO - 'HOME': '/Users/cltbld', 16:00:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:00:38 INFO - 'LOGNAME': 'cltbld', 16:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:38 INFO - 'MOZ_NO_REMOTE': '1', 16:00:38 INFO - 'NO_EM_RESTART': '1', 16:00:38 INFO - 'PAGER': '/bin/cat', 16:00:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:00:38 INFO - 'PWD': '/builds/slave/test', 16:00:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:00:38 INFO - 'SHELL': '/bin/bash', 16:00:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lh2mXNdPaY/Listeners', 16:00:38 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 16:00:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:00:38 INFO - 'USER': 'cltbld', 16:00:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:00:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:38 INFO - 'XPC_FLAGS': '0x0', 16:00:38 INFO - 'XPC_SERVICE_NAME': '0', 16:00:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:00:38 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-WndmFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:00:38 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)) 16:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:00:38 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-MI_WVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:00:38 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)) 16:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:00:38 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-Xp8WZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:00:38 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)) 16:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:00:38 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-rOrx4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:00:39 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)) 16:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:00:39 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-tOECmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:00:39 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)) 16:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:00:39 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-aG9bOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:00:39 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)) 16:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:00:39 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-aB6Aea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:00:39 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)) 16:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:00:39 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-Kbj4Od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:00:39 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)) 16:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:00:39 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-GuqtGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:00:39 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)) 16:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:00:39 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-5bniqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:00:39 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)) 16:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:00:39 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-cfEqKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:00:39 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)) 16:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:00:39 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-Lsc2Sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:00:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:00:39 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-XNJTuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:00:39 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)) 16:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:00:39 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-nGDlzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:00:40 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)) 16:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:00:40 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-5mkIGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:00:40 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)) 16:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:00:40 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-jXsAEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:00:40 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)) 16:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:00:40 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-G3RTP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:00:40 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)) 16:00:40 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)) 16:00:40 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)) 16:00:40 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)) 16:00:40 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)) 16:00:40 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)) 16:00:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:00:40 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 16:00:40 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 16:00:40 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 16:00:40 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 16:00:40 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 16:00:40 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 16:00:43 INFO - Downloading blessings-1.6.tar.gz 16:00:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:00:43 INFO - Installing collected packages: blessings 16:00:43 INFO - Running setup.py install for blessings 16:00:43 INFO - Successfully installed blessings 16:00:43 INFO - Cleaning up... 16:00:43 INFO - Return code: 0 16:00:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:00:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:00:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:00:43 INFO - Reading from file tmpfile_stdout 16:00:43 INFO - Current package versions: 16:00:43 INFO - blessings == 1.6 16:00:43 INFO - blobuploader == 1.2.4 16:00:43 INFO - docopt == 0.6.1 16:00:43 INFO - functools32 == 3.2.3-2 16:00:43 INFO - jsonschema == 2.5.1 16:00:43 INFO - manifestparser == 1.1 16:00:43 INFO - mozInstall == 1.12 16:00:43 INFO - mozcrash == 1.0 16:00:43 INFO - mozdebug == 0.1 16:00:43 INFO - mozdevice == 0.49 16:00:43 INFO - mozfile == 1.2 16:00:43 INFO - mozhttpd == 0.7 16:00:43 INFO - mozinfo == 0.9 16:00:43 INFO - mozleak == 0.1 16:00:43 INFO - mozlog == 3.4 16:00:43 INFO - moznetwork == 0.27 16:00:43 INFO - mozprocess == 0.25 16:00:43 INFO - mozprofile == 0.28 16:00:43 INFO - mozrunner == 6.13 16:00:43 INFO - mozscreenshot == 0.1 16:00:43 INFO - mozsystemmonitor == 0.3 16:00:43 INFO - moztest == 0.8 16:00:43 INFO - mozversion == 1.4 16:00:43 INFO - psutil == 3.1.1 16:00:43 INFO - requests == 1.2.3 16:00:43 INFO - wsgiref == 0.1.2 16:00:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:00:43 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')]} 16:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:43 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')]} 16:00:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:43 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 0x109fb2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fb5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a8ccc690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d90d30>, '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 0x109cb7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d85be8>, '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.QF4NzQeRw1/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.Lh2mXNdPaY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 16:00:43 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 16:00:43 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 16:00:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QF4NzQeRw1/Render', 16:00:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:00:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:00:43 INFO - 'HOME': '/Users/cltbld', 16:00:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:00:43 INFO - 'LOGNAME': 'cltbld', 16:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:43 INFO - 'MOZ_NO_REMOTE': '1', 16:00:43 INFO - 'NO_EM_RESTART': '1', 16:00:43 INFO - 'PAGER': '/bin/cat', 16:00:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:00:43 INFO - 'PWD': '/builds/slave/test', 16:00:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:00:43 INFO - 'SHELL': '/bin/bash', 16:00:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lh2mXNdPaY/Listeners', 16:00:43 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 16:00:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:00:43 INFO - 'USER': 'cltbld', 16:00:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:00:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:43 INFO - 'XPC_FLAGS': '0x0', 16:00:43 INFO - 'XPC_SERVICE_NAME': '0', 16:00:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:43 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)) 16:00:43 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)) 16:00:43 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)) 16:00:43 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)) 16:00:43 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)) 16:00:43 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)) 16:00:43 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)) 16:00:43 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)) 16:00:43 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)) 16:00:43 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)) 16:00:43 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)) 16:00:43 INFO - Cleaning up... 16:00:43 INFO - Return code: 0 16:00:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:00:43 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')]} 16:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:43 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')]} 16:00:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:43 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 0x109fb2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fb5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a8ccc690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d90d30>, '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 0x109cb7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d85be8>, '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.QF4NzQeRw1/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.Lh2mXNdPaY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 16:00:43 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 16:00:43 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 16:00:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QF4NzQeRw1/Render', 16:00:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:00:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:00:43 INFO - 'HOME': '/Users/cltbld', 16:00:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:00:43 INFO - 'LOGNAME': 'cltbld', 16:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:43 INFO - 'MOZ_NO_REMOTE': '1', 16:00:43 INFO - 'NO_EM_RESTART': '1', 16:00:43 INFO - 'PAGER': '/bin/cat', 16:00:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:00:43 INFO - 'PWD': '/builds/slave/test', 16:00:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:00:43 INFO - 'SHELL': '/bin/bash', 16:00:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lh2mXNdPaY/Listeners', 16:00:43 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 16:00:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:00:43 INFO - 'USER': 'cltbld', 16:00:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:00:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:43 INFO - 'XPC_FLAGS': '0x0', 16:00:43 INFO - 'XPC_SERVICE_NAME': '0', 16:00:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:00:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:00:44 INFO - Cleaning up... 16:00:44 INFO - Return code: 0 16:00:44 INFO - Running post-action listener: _resource_record_post_action 16:00:44 INFO - Running post-action listener: _start_resource_monitoring 16:00:44 INFO - Starting resource monitoring. 16:00:44 INFO - [mozharness: 2017-03-15 23:00:44.253487Z] Finished create-virtualenv step (success) 16:00:44 INFO - [mozharness: 2017-03-15 23:00:44.254437Z] Running install step. 16:00:44 INFO - Running pre-action listener: _resource_record_pre_action 16:00:44 INFO - Running main action method: install 16:00:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:00:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:00:44 INFO - Reading from file tmpfile_stdout 16:00:44 INFO - Detecting whether we're running mozinstall >=1.0... 16:00:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:00:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:00:44 INFO - Reading from file tmpfile_stdout 16:00:44 INFO - Output received: 16:00:44 INFO - Usage: mozinstall [options] installer 16:00:44 INFO - Options: 16:00:44 INFO - -h, --help show this help message and exit 16:00:44 INFO - -d DEST, --destination=DEST 16:00:44 INFO - Directory to install application into. [default: 16:00:44 INFO - "/builds/slave/test"] 16:00:44 INFO - --app=APP Application being installed. [default: firefox] 16:00:44 INFO - mkdir: /builds/slave/test/build/application 16:00:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:00:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:01:04 INFO - Reading from file tmpfile_stdout 16:01:04 INFO - Output received: 16:01:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:01:04 INFO - Running post-action listener: _resource_record_post_action 16:01:04 INFO - [mozharness: 2017-03-15 23:01:04.704429Z] Finished install step (success) 16:01:04 INFO - [mozharness: 2017-03-15 23:01:04.704597Z] Running run-tests step. 16:01:04 INFO - Running pre-action listener: _resource_record_pre_action 16:01:04 INFO - Running main action method: run_tests 16:01:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:01:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:01:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:01:04 INFO - 2017-03-15 16:01:04.718 screenresolution[1622:7653] starting screenresolution argv=screenresolution get 16:01:04 INFO - 2017-03-15 16:01:04.721 screenresolution[1622:7653] Display 0: 1600x1200x32@60 16:01:04 INFO - 2017-03-15 16:01:04.727 screenresolution[1623:7655] starting screenresolution argv=screenresolution list 16:01:04 INFO - Available Modes on Display 0 16:01:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:01:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:01:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:01:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:01:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:01:04 INFO - Intel Iris: 16:01:04 INFO - Chipset Model: Intel Iris 16:01:04 INFO - Type: GPU 16:01:04 INFO - Bus: Built-In 16:01:04 INFO - VRAM (Dynamic, Max): 1536 MB 16:01:04 INFO - Vendor: Intel (0x8086) 16:01:04 INFO - Device ID: 0x0a2e 16:01:04 INFO - Revision ID: 0x0009 16:01:04 INFO - Displays: 16:01:04 INFO - Display: 16:01:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:01:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:01:04 INFO - Display Serial Number: 1600x1200 60 16:01:04 INFO - Main Display: Yes 16:01:04 INFO - Mirror: Off 16:01:04 INFO - Online: Yes 16:01:04 INFO - Rotation: Supported 16:01:04 INFO - Return code: 0 16:01:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:01:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:01:04 INFO - Python 2.7.3 16:01:04 INFO - Return code: 0 16:01:04 INFO - grabbing minidump binary from tooltool 16:01:04 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')]} 16:01:04 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 0x109d90d30>, '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 0x109cb7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d85be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:01:04 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 16:01:04 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 16:01:04 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 16:01:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:01:05 INFO - Return code: 0 16:01:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:01:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:01:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:01:05 INFO - ENV: RUST_BACKTRACE is now 1 16:01:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:01:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:01:05 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/FexCcSDiTeiLFAxIJoTGqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0022', '--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 16:01:05 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/FexCcSDiTeiLFAxIJoTGqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0022 --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 16:01:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QF4NzQeRw1/Render', 16:01:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:01:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:01:05 INFO - 'HOME': '/Users/cltbld', 16:01:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:01:05 INFO - 'LOGNAME': 'cltbld', 16:01:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:01:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:01:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:05 INFO - 'MOZ_NO_REMOTE': '1', 16:01:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:01:05 INFO - 'NO_EM_RESTART': '1', 16:01:05 INFO - 'PAGER': '/bin/cat', 16:01:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:01:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:05 INFO - 'PWD': '/builds/slave/test', 16:01:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:01:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:01:05 INFO - 'RUST_BACKTRACE': '1', 16:01:05 INFO - 'SHELL': '/bin/bash', 16:01:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lh2mXNdPaY/Listeners', 16:01:05 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 16:01:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:01:05 INFO - 'USER': 'cltbld', 16:01:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:01:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:01:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:05 INFO - 'XPC_FLAGS': '0x0', 16:01:05 INFO - 'XPC_SERVICE_NAME': '0', 16:01:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:01:05 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/FexCcSDiTeiLFAxIJoTGqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0022', '--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 16:01:05 INFO - mozversion application_buildid: 20170315142540 16:01:05 INFO - mozversion application_changeset: ff04d410e74b69acfab17ef7e73e7397602d5a68 16:01:05 INFO - mozversion application_display_name: Nightly 16:01:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:01:05 INFO - mozversion application_name: Firefox 16:01:05 INFO - mozversion application_remotingname: firefox 16:01:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:01:05 INFO - mozversion application_vendor: Mozilla 16:01:05 INFO - mozversion application_version: 55.0a1 16:01:05 INFO - mozversion platform_buildid: 20170315142540 16:01:05 INFO - mozversion platform_changeset: ff04d410e74b69acfab17ef7e73e7397602d5a68 16:01:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:01:05 INFO - mozversion platform_version: 55.0a1 16:01:05 INFO - using testdate: 1489618865 16:01:05 INFO - actual date: 1489618865 16:01:05 INFO - starting webserver on 'localhost:49241' 16:01:05 INFO - SUITE-START | Running 2 tests 16:01:05 INFO - TEST-START | dromaeo_css 16:01:05 INFO - operating with platform_type : mac_ 16:01:05 INFO - Initialising browser for dromaeo_css test... 16:01:05 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmpZUUMSV/profile http://localhost:49241/getInfo.html) 16:01:08 INFO - PID 1633 | 2017-03-15 16:01:08.265 plugin-container[1635:7837] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 16:01:08 INFO - PID 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:01:08 INFO - PID 1633 | 2017-03-15 16:01:08.268 plugin-container[1635:7837] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4923, name = 'com.apple.CFPasteboardClient' 16:01:08 INFO - PID 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:01:08 INFO - PID 1633 | 2017-03-15 16:01:08.268 plugin-container[1635:7837] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:01:08 INFO - PID 1633 | __metrics Screen width/height:1600/1200 16:01:08 INFO - PID 1633 | colorDepth:24 16:01:08 INFO - PID 1633 | Browser inner width/height: 1024/689 16:01:08 INFO - PID 1633 | __metrics 16:01:08 ERROR - PID 1633 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 16:01:09 INFO - TEST-INFO | 1633: exit 0 16:01:09 INFO - Browser initialized. 16:01:09 INFO - Running cycle 1/1 for dromaeo_css test... 16:01:09 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmpZUUMSV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:01:11 INFO - PID 1636 | 2017-03-15 16:01:11.645 plugin-container[1637:7965] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 16:01:11 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:01:11 INFO - PID 1636 | 2017-03-15 16:01:11.645 plugin-container[1637:7965] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c23, name = 'com.apple.CFPasteboardClient' 16:01:11 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:01:11 INFO - PID 1636 | 2017-03-15 16:01:11.645 plugin-container[1637:7965] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:01:21 INFO - PID 1636 | RSS: Main: 227454976 16:01:21 INFO - PID 1636 | 16:04:23 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 16:04:25 INFO - PID 1636 | RSS: Main: 250232832 16:04:25 INFO - PID 1636 | 16:06:09 INFO - PID 1636 | ************************* 16:06:09 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 16:06:09 INFO - PID 1636 | 16:06:09 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:06:09 INFO - PID 1636 | Full stack: 16:06:09 INFO - PID 1636 | ************************* 16:07:28 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 16:07:28 INFO - PID 1636 | RSS: Main: 258600960 16:07:28 INFO - PID 1636 | 16:10:30 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 16:10:31 INFO - PID 1636 | RSS: Main: 270323712 16:10:31 INFO - PID 1636 | 16:13:33 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 16:13:33 INFO - PID 1636 | RSS: Main: 263073792 16:13:33 INFO - PID 1636 | 16:16:37 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 16:16:37 INFO - PID 1636 | RSS: Main: 272785408 16:16:37 INFO - PID 1636 | 16:19:40 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 16:19:41 INFO - PID 1636 | RSS: Main: 266838016 16:19:41 INFO - PID 1636 | 16:19:41 INFO - PID 1636 | __start_tp_report 16:19:41 INFO - PID 1636 | _x_x_mozilla_page_load 16:19:41 INFO - PID 1636 | _x_x_mozilla_page_load_details 16:19:41 INFO - PID 1636 | |i|pagename|runs| 16:19:41 INFO - PID 1636 | |0;dojo.html;3216.8230747308917;3261.695321871251;3319.1038419626702;3432;3462.5498685170933;4600.447946246451;4699.342092107104;5668.234788303578;6000.879982400349;6035.758569657214;4969.875753106174;6008.429199226078;6024.728887200075;6070.301915279744;6082;5239.10935141025;5239.895202095956;5329.147336426163;5387.218853266274;5458.235846981426;5397.433269506684;5431.83704488866;5444.8366549003595;5460.726963651821;5469.617126801126;5217.34783152106;5312.548433383167;5313.654612450178;5317.388500322474;5421.620486565942;4479.8352428368535;4609.400777898885;5031.723255220962;5130.153524668425;5342.519173274385;5248.947510524884;5331.2269720890645;5332.2801421808335;5336.252924590522;5383.057964856134;5712.171735098387;5851.356350801409;5902.380250073767;5914.497267732248;5932.080527518242;6169.5064394848305;6288.874222515524;6311.558190926637;6313.179286692746;6327.936720632781;6261.624302541862;6340.841478963017;6389.393007664265;6393.680315984182;6408.359164083601;6116.26604807426;6130.478909292716;6156.199694039746;6162.506999440034;6181.103739957681;6506.316836732075;6520.47836173105;6533.085368048477;6542.443892269211;6548.410643042149;6145;6273.937260627426;6275.6862156892885;6284.277308109535;6305.590136641195;6320.146780184708;6334.398232167937;6341.112244285804;6352.968235158794;6388.456981156561;6274.466670332981;6309.873802523924;6316.084167795736;6316.589421687576;6330.0821380899515;6179.876402471926;6237.064440333987;6246.437820596168;6308.779192728232;6314.71583778731;5164.992826398816;5177.948220517746;5186.766595503212;5203.947960520422;5210.426853046162;4612.262038073892;4621.468531118897;4642.744649044267;4654.115718013567;4662.160811053975;4896.3389942358035;5915.438033386821;6076.422739839708;6081.118237855486;6132.294786099566;6310.905336419957;6357.872842543124;6387.169667943138;6412.67936603168;6431.935680643227;6036.547258955508;6097.085437184458;6121.234845644294;6123.295820980644;6140.723667434976;5497.945020549823;5594.776208951596;5645.23789288449;5680.943190568124;5729.942700572941;6420.6147631142285;6426.068220108058;6591.736330546724;6599.340065993362;6628.07206991012;6387.712552935222;6390.648514331757;6409.807705768834;6428.067930150009;6437.935620643733;6289.213848268966;6355.5551111421755;6380.266269379081;6503.6097834130105;6609.570377925419;6312.684365781601;6315.179026726496;6322.146510221245;6337.809865704036;6338.936610633835;5013.373328333958;5862.560307977004;6304.306526282014;6353.0152826312;6390.4248617624635;5244.501772331622;6229.688515574294;6263.718132684131;6276.843078923063;6298.370162983665;6251.280897752972;6272.717727702173;6281.59169653971;6295.9370406297185;6308.968455157695;5071.39143302806;5619.494245517923;6137.131844484855;6202.5658203925295;6287;6249.187605611241;6265;6276.403741644536;6277.937220627735;6283.088952102011;6241.531885108544;6270.529710271657;6279.340669229665;6293.37066293367;6325.209348831396 16:19:41 INFO - PID 1636 | |1;ext.html;794.9443538952273;943.1181844974947;943.7027336389037;954.9188318992885;970.3304719743377;30174;36861.078473038186;37655.81172094143;37698.86903392899;37827.24345513088;37957.24085518288;38223.80888095563;38356.232875342546;38388.80805595968;38455.615443845556;8790.428622139572;9117.68088116916;9129.041450647686;9132.223760980325;9141.862872056925;9089.54552272387;9183.678571250008;9211.217046551052;9217.44695318283;9247.213986811095;8059.556724380157;9274.211692006187;9311.906880931205;9332.393394429375;9368.625254989825;9274.907250927505;9306.534673266377;9312.767180820467;9314.86027709585;9345.01877302887;9087.136722011399;9168.862467063;9177.265818734486;9182.540872956326;9189.816203675957;38128.809355953046;38378.23243535141;38380.61619383798;38391.04022399434;38436;3356.412627790127;3832.4059770735303;3855.9036024099623;3863.38185890259;3996.9600303997167;27389.726102738918;27629.447411051868;27998.5800212997;28148.718512814816;28253;2521.445282037949;2897.9277667263036;3245.432049391347;3273.6562660920736;3298.2578919742864;230212;235044.82477587502;298078;298184.5090774554;298273.5431614227;50094.49905500971;50151.498485015414;50290.497095029314;50330;50440;52020.739896301035;52150.478495214564;52203.21695174575;52269;52375;14402.639934001525;14442.638934026523;14467.565973020826;14473.421063157566;14496.782548261785;11627.883721162849;11754;11774.764504709858;11793.997510211728;11815.468303926344;12643.304618246084;13945.233012184428;13956.581302560939;13990.930045349709;14095.097161883219;5171.689698618095;5209.869753256123;6179.81460556184;6201.875962480725;6227.906581401283;1079.8974097460728;1111.183280288987;1114.4984756859283;1115.5330740076772;1166.78414493319;20108.798912010985;26274.737252627612;26293.73706262913;26526.867365663435;26896.193114206606;1189.1556994533805;1212.5513559982862;1219.5973931355215;1261.5269274022241;1266.069438962362;13223.47106115764;13477.326133693276;13554.525591604246;13633.659158521117;13822.170669759847;343851;347866;348945;349609;349984;55319;55928;55949.160762588595;55959;56119.43880561142;1256.5162412471082;1266.6257111034631;1373;1416.4334266293565;1434.4405681784112;21573.568528629025;28056.438871222053;28169.295767605974;28738.425231495672;28836.42327153487;45453.54546454493;52052.739736301075;52269;52595.21107183472;52715.472845271055;417009;417011;419266;419580;420486;33745.15637109092;34219.631214752124;34224.486632701024;34397.82801085978;34426.48360274548;43000.56999429966;43168;43265.567344326155;43291.35062974121;43394.349084763126;33937.15157120993;34751.826240868635;35657.08739210354;36085.81957090198;36299;34245;34441.82779086089;34670.82664586661;35685.821570893015;35763;34951.82524087465;35456.64543354533;35517;35712;35766.64233357633;22983.540329192987;25079.749202508472;30917;31345;31363.372732544765;23440.413989650395;23871.246382279332;23964.52070958606;24014.87992560026;24317.878410607835 16:19:41 INFO - PID 1636 | |2;jquery.html;387.11544121681965;405.4647864818439;413.153036275635;417.96029377209163;426.41793951256545;17795.37716179934;20707.689384659225;21112.4721881953;21116.15535378585;21889.781102188972;22178.88910555449;22367;22379.32862014138;22469.438264043365;22788.265408151005;6326.114343991845;6686.531942764009;6718.563293385939;6726.024726414667;6746.325367463263;5116.334876466054;6710.060591517192;6735.629540375277;6745.527813053088;6765.5602385845;6444.742210311582;6613.6693165341785;6720.428763555079;6721.596704197764;6728.529002969794;6552.868942621145;6574.737010519598;6626.6686665667;6627.933720662828;6634.701438435258;5889.293284805851;6305.180326557518;6563.442107420875;6570.408663220333;6621.437177839889;26003.869980649975;26243;27221.047263345885;27349.589756153673;27769.722302776914;3119.407312610597;3238.3847069056806;3244.983775081133;3359.328134373135;3369.629340772513;15736.685266294724;16154.596135096717;16739;17165.88421752582;17296.654066918716;1661.7092008898514;1926.7591551056119;1989.6518109330955;1991.4324417541077;2034.0033383642058;141790;142939.57060429367;143382.28308858493;143630;145192;22862.31413057611;22869;23003;23147;23222.187223447097;37174;37299.81350093286;37398.06504837401;37420.625793742256;37486.812565937544;8766.21104100634;10256.179505639531;10511.369317840954;10696.358218506915;10772.946135269274;8527.872081918777;8543.060263371024;8568.014678312074;8699.652013919373;8732.738017859474;10679.276784419922;11005;11065.889341106647;11260.155488338407;11271.38007409584;3863.439801228806;3915.9622699984525;4531.45622525299;4537.8411755588395;4597.724136551751;752.8744526932271;864.2912811494514;865.7229686500385;885.8892638420198;901.396064636695;17604.91197544004;22485.88757056204;22517.32448026562;22548.774512254997;22595;889.7419748273057;902.9097090290918;904.4166512599468;905.0858632780808;907.4555266839975;10466.842997355046;10888.836667449994;11206.655201375725;11370.03354714842;11844.585439509576;504719;620188;630331;664256;678769;129353.62995327273;130399;133766;134050;134098;1157.8726340102583;1210.7033776724759;1235.3390935849457;1250.6748245456247;1263.886250237483;16791;17069.146542673065;19961.900190498956;20847.37457876266;21039.474013149793;50655;61200.693996529735;62563.748725026155;63826.08521744355;64679.353206467335;66228;78563.21436785787;85160;85201.20186178421;85626.14373856182;9786.853197201905;11357.716057098638;11751.294922304689;12092.455839487067;12248.448819803309;12427.254364738144;13450;13768.793468097787;13903.860961390661;13945.930270348583;11539.711507212387;11590.884091159318;11910.821337680116;11997.820032699341;12044.51821927113;11112.722181945193;11367.317960922372;11659.825102623638;11794.941025294818;11809.996150327319;11595.478203481032;11754.529818807152;11969.760604788029;12048.337341446304;12128.818067728815;11470.541178353105;11810.527578897092;11856.466459009538;12038.976686981705;12174.634760957186;11569.6529104127;11659;11919.940400297943;12015.819762703391;12029.819552706542 16:19:41 INFO - PID 1636 | |3;mootools.html;1537.2237020304744;1568.5686436230042;1572.3725943648326;1596.1221328269453;1598.6962477129346;10390.948045259773;10839.18706097043;10868.402237876913;10882.6735197944;11211.327320360784;10244.565760793495;10828.729281767959;10978;11021.338719676825;11059.281146725478;1929.24759343856;2195.4730864592543;2199.08737873783;2203.9449013774624;2204.2946257197705;2265.3883451468096;2303.585354636165;2306;2306.1582522379376;2310.976890231093;2266.1162146762695;2285.7942785149335;2296.1274715608047;2301.355620426283;2304.412374844412;2257.525919556895;2259.6045692004;2263.581237471073;2272.931812045633;2275.6245219538837;2242.2040175737543;2292.2321022457495;2309.711286089239;2313.398516385752;2316.293530473205;10863.348199107999;10890.237683362167;10973;10976.780464390748;10980.176486763445;5643.717814109278;5736.311642602915;5772.942270577282;5856.619319744245;5864.38423965486;3015.7888947773663;3284.4088064148445;3432.2277487565348;3640.7451478396524;3652.7625704329134;1196.8683444821063;1235.14774805384;1740.225599608175;1788.5439213000732;1912.1013123831776;14581.416743330254;14690.869823875479;14750.114993100447;14791.186484743335;14947.02844315116;4499.492669955602;4561.908761824811;4579.679422440464;4717.551832575899;4730.290456431494;9116.316276279305;10655.041046305869;11267.985881270724;11297.152713546517;11297.378644174485;4671.649626278043;5555.2222688823595;5694.402087780806;5708.771649134072;5722.198892155102;5080.644354895196;5210.583153347723;5227.111391063529;5246.711430871339;5282.075636763628;3793.525809273841;3837.76973381598;3841.539015318124;3923.0780766519847;3930.4890364252465;1043.1081425381342;1046.2310202001674;1046.6912260883057;1058.915286777056;1060.7878424315013;776.6737970052592;901.3014913442134;912.9957047247974;920.5075284722641;937.2267878999852;6287.1512345832725;6398.392152745481;6513;6579.144711187515;6614.437772789271;827.755812035451;994.9850752238722;995.6166875752888;1030.0523518363125;1048.0567489259727;3415.8591320063147;4052.9392059119136;4081.6938729594804;4101.323281658552;4160.625543701081;12125.514979400901;13058.934705326412;13449.125806822525;13476.326183690777;13503.729925401634;11176.776464470666;12878.484860605471;13402.396892139877;13408.195508269535;13425.328733563283;8371.83256334882;8630.611622477003;9535.52322383878;9888.505574721235;9908.306418550776;6341.175647165839;6542.476601871934;6674.098996635586;6765.661716914036;6797.72809087631;9747.463889486145;11854.348010859485;12186.817197742219;12197.268163910194;12207.267563946192;11863.525458981545;11897.345645989553;12169.20900141488;12181;12235.816462752888;9059.411138275991;9288.860667090134;9317.34778565494;9354.76613084651;9397.436153830791;9272.907270927204;9290.303227257848;9333.066693330884;9334.346595738505;9396.389234699722;8219.424640275123;8260.752177434686;8298.83402331938;8349.37379696513;8450.323974082181;8096.919030809617;8116.959415202886;8145.714899978472;8185.30424913889;8301;5868.354481007001;6531.771388001397;7213;7335.853282934205;7342.963285183753;4484.372187893763;4807.87450260783;5443.482869127427;5494.230807686847;5663.518600918968;5508.283923089973;5531.004419204421;5686.459786320458;5750.482456578928;5756.424357564378 16:19:41 INFO - PID 1636 | |4;prototype.html;328.17627754336615;358.25125487730645;372.23691432563237;393.75193628014347;398.9825943843199;4817.783199756011;5279.4192638809745;5938.317093534234;6087.299960504538;6158.261008678965;4528.75091869947;6014.248218972629;6051.27384713835;6082.482988945934;6120.296165940907;5277.973610131944;5285;5308.097623404011;5323.441038690939;5499.230107784913;4047.4738284023038;4676.251799712047;4946.901061978776;4949.282354058677;5308.177232528945;4919.827806026789;4926.778294976734;4949.950500495003;4952.959878425535;4987.802927297441;3884.611538846121;4962.627802914778;4964.982178653404;4984.22744474607;4990.30135780991;3690.7231957603285;4062.73592216505;4364.668776023312;4405.515393306734;4469.664775141878;4901.485344038861;5067.873303167414;5538.723063846792;5660.528262651699;5887.499562537189;5801.593888427812;5820.272465941757;5834.52032886026;5837.357890632027;5840.678762668052;5223.529882310572;6096.603720758137;6177.413145751147;6259.436650701458;6566.70449829754;4435.866923992286;4553.339765733983;4618.1687296286655;5102.183510797694;5106.795728170869;5101.744912754384;6012.969935150296;6464.45052170566;6613.537052406334;6819.761308354184;4547.272436410159;5102.428300189882;5279.762410691528;5289.100852855024;5319.202119682079;4998.425181104147;5060.2662613920775;5283.709395983258;5350.063738845764;5353.357597088374;4227.239096962577;4853.757312134379;5703.201551782754;5743.195952566644;5786;6455.419012288917;6484.773032943919;6488.870222595521;6494.285628580852;6517.152770139852;1762.8237176282269;1809.3576780243088;1813.6949422938117;1815.1287382056687;1831.276645724931;1154.4054811771944;1303.244118411319;1350.9324533773272;1352.905296629246;1370.2258224103548;5064.733247055628;5594;6064.66644334557;6095.939040609537;6110.297315808739;6560.851850926068;6724.49566282521;6756.324367563205;6773.525853190328;6785.626790526569;5583.302087239095;5701.344345400332;5753.338366087954;6026.246719160105;6081.604695694766;3020.4412183746076;3034.0746072448114;3322.767406281537;3469.924323459685;3541.451075083366;6737.6968036438475;6974.38561957629;7017.298270173044;7034.472414568928;7034.753783617549;5269;6316.810010944444;6953.200381956039;6975.9302406975285;6996.65612019979;6573.638449885207;6851.177858656993;6985.371316581431;6998.860022799618;7001.334873187243;6316.968415157895;6719.865602688016;6722.361375669304;6742.9662851685425;6745.2446025552845;5635.8591035224445;6367.821952938722;6639.734410623521;6655.700493477902;6688.331166883273;5726.455986681259;6884.932835410519;7005.789826305219;7046.295370462913;7072.929270707227;4917.270914642408;5223.164293712987;5314.388845282842;5336.973315133399;5338.57291416678;5403.378611459732;6476.579022363531;6817.488688348294;6847.417969472651;6848.931510685029;5232.9738351308;6318.810435686937;6548.919428294278;6571.57284776488;6601.636909969998;5300.867478313073;6510;6524.347565243438;6561.376669216417;6581.868362632817;6255.218097737783;6390.265119511129;6412.9679351602945;6421.789105447277;6458.770614692654;5238.738063096754;6505.674716264262;6525.249596296297;6549.443297319781;6561.3438656134;6407.743690252338;6424;6433.549651524536;6445.581037232565;6468.223813142453 16:19:41 INFO - PID 1636 | |5;yui.html;619.7551966973049;695.0165515795151;739.6080077558894;754.6415452659987;849.5837039850471;14753.631159221011;15040.849591504082;15314.923425382858;15528.844711552894;15601.687966240668;11412.486438110283;13348.466061357558;14265.714685706305;14515.274236288169;14532;931.8555623878293;955.3599088610648;963.3064193780502;965.0879918477007;967.2262190247809;901.8737376767258;929.4562680831722;966.2801213096218;971.8153550825356;972.6936015155203;1025.3489034463096;1025.825609646358;1034.1623285139062;1036.507658862042;1038.5586125896502;1003.8644782954281;1028.0798685176762;1028.7428142964259;1034.0125180452687;1037.6005237983354;773.8065483629093;774.0943096577018;775.3215936055951;777.296546625305;777.9922200777976;15427.614309642237;16295.592610184722;16467.917660411742;16485.258163382678;16540.421085261958;14415.927920360436;14765.704685906328;14801.555953321418;14832.555023349316;14851.777223341658;10045.949770251174;10418.27072104953;11141.108711303077;11198.552057917674;11612.6516204514;3760.4547340635727;3808.2901554403925;3830.5211848518934;3926.725129240954;3941.940870886939;95076;95286.09427811475;95936;100375;106955.93044069537;11353.772924541463;11375.715607109889;11559.826602600968;11752.529898804123;11913.08129508276;23692.052317907437;23755.524889502114;23940.40148996289;23985.760142398703;23993.640095398583;7735.806604834812;7746;7820.217978202248;7854.646540905673;7937.5237485749885;3564.625714300013;4125.773082480492;4217.768022758778;4222.366645003212;4227.471566054243;3445.9655403446145;3496.3356962177104;3509.192885636318;3529.2764983178386;3530.91172720684;627.9262461191414;631.823089534931;631.9905201421982;632.1245075570276;637.1144109687538;633.4647223096476;633.7813454358239;636.8503401700597;695.9164900212007;696.7491702986921;9612.327137100336;9720.75698107553;10047.748806279755;10054.447005414626;10260.692179234635;619.7211254935297;649.0353649956882;671;672.8561445542597;692.3976140757472;4620.306953956933;4825.710457372569;4827.468978412372;4842.5157484251995;4849.854504364875;87070;93081.5345923266;98332.50833745785;102347;105064;70757.2924270761;72006.63996680088;79068.90707568704;81611.18388816036;89017.55491222502;59895.40104598898;68464.3153568468;70505;70777.93833092508;71309;9084.954575227082;10887.346759194474;11107.777844443228;11136.888631113585;11221;41864.74405767832;42685.57314426816;44166.558334416244;45354.09291814211;47694;53826;61450.692746535984;66420.66789666214;68591.31408686048;68813.77455367114;11402.372869492257;13262.403191856196;13382.243592921308;13834.792478112635;14056.367463464374;11555.595554155565;12182.93869607518;14446.494372697325;14670.706585868436;14799.704005920037;13387;13470.461181552628;13560.254186019863;13584.45662173502;13761.31193440344;11768.411579421167;13657.975651826351;13743.450261989808;13836.723265534834;14033.1580105194;13076.542321018718;13456.932715336361;13474.730505390033;13932.860671393157;14027.158370497802;10885.727856803644;10977.231593788358;11053;11062.668119956092;11901.880981190077;9394.76513087151;10391.688249352532;10483.423411712429;10537.367757934548;11011.608953206427 16:19:41 INFO - PID 1636 | __end_tp_report 16:19:41 INFO - PID 1636 | __start_cc_report 16:19:41 INFO - PID 1636 | _x_x_mozilla_cycle_collect,424 16:19:41 INFO - PID 1636 | __end_cc_report 16:19:41 INFO - PID 1636 | __startTimestamp1489619981250__endTimestamp 16:19:41 INFO - PID 1636 | 16:19:41 INFO - PID 1636 | ------- Summary: start ------- 16:19:41 INFO - PID 1636 | Number of tests: 6 16:19:41 INFO - PID 1636 | 16:19:41 INFO - PID 1636 | [#0] dojo.html Cycles:165 Average:5862.46 Median:6179.88 stddev:699.32 (11.3%) stddev-sans-first:669.96 16:19:41 INFO - PID 1636 | Values: 3216.8 3261.7 3319.1 3432.0 3462.5 4600.4 4699.3 5668.2 6000.9 6035.8 4969.9 6008.4 6024.7 6070.3 6082.0 5239.1 5239.9 5329.1 5387.2 5458.2 5397.4 5431.8 5444.8 5460.7 5469.6 5217.3 5312.5 5313.7 5317.4 5421.6 4479.8 4609.4 5031.7 5130.2 5342.5 5248.9 5331.2 5332.3 5336.3 5383.1 5712.2 5851.4 5902.4 5914.5 5932.1 6169.5 6288.9 6311.6 6313.2 6327.9 6261.6 6340.8 6389.4 6393.7 6408.4 6116.3 6130.5 6156.2 6162.5 6181.1 6506.3 6520.5 6533.1 6542.4 6548.4 6145.0 6273.9 6275.7 6284.3 6305.6 6320.1 6334.4 6341.1 6353.0 6388.5 6274.5 6309.9 6316.1 6316.6 6330.1 6179.9 6237.1 6246.4 6308.8 6314.7 5165.0 5177.9 5186.8 5203.9 5210.4 4612.3 4621.5 4642.7 4654.1 4662.2 4896.3 5915.4 6076.4 6081.1 6132.3 6310.9 6357.9 6387.2 6412.7 6431.9 6036.5 6097.1 6121.2 6123.3 6140.7 5497.9 5594.8 5645.2 5680.9 5729.9 6420.6 6426.1 6591.7 6599.3 6628.1 6387.7 6390.6 6409.8 6428.1 6437.9 6289.2 6355.6 6380.3 6503.6 6609.6 6312.7 6315.2 6322.1 6337.8 6338.9 5013.4 5862.6 6304.3 6353.0 6390.4 5244.5 6229.7 6263.7 6276.8 6298.4 6251.3 6272.7 6281.6 6295.9 6309.0 5071.4 5619.5 6137.1 6202.6 6287.0 6249.2 6265.0 6276.4 6277.9 6283.1 6241.5 6270.5 6279.3 6293.4 6325.2 16:19:41 INFO - PID 1636 | 16:19:41 INFO - PID 1636 | [#1] ext.html Cycles:180 Average:49801.37 Median:35671.45 stddev:92887.60 (260.4%) stddev-sans-first:93075.30 16:19:41 INFO - PID 1636 | Values: 794.9 943.1 943.7 954.9 970.3 30174.0 36861.1 37655.8 37698.9 37827.2 37957.2 38223.8 38356.2 38388.8 38455.6 8790.4 9117.7 9129.0 9132.2 9141.9 9089.5 9183.7 9211.2 9217.4 9247.2 8059.6 9274.2 9311.9 9332.4 9368.6 9274.9 9306.5 9312.8 9314.9 9345.0 9087.1 9168.9 9177.3 9182.5 9189.8 38128.8 38378.2 38380.6 38391.0 38436.0 3356.4 3832.4 3855.9 3863.4 3997.0 27389.7 27629.4 27998.6 28148.7 28253.0 2521.4 2897.9 3245.4 3273.7 3298.3 230212.0 235044.8 298078.0 298184.5 298273.5 50094.5 50151.5 50290.5 50330.0 50440.0 52020.7 52150.5 52203.2 52269.0 52375.0 14402.6 14442.6 14467.6 14473.4 14496.8 11627.9 11754.0 11774.8 11794.0 11815.5 12643.3 13945.2 13956.6 13990.9 14095.1 5171.7 5209.9 6179.8 6201.9 6227.9 1079.9 1111.2 1114.5 1115.5 1166.8 20108.8 26274.7 26293.7 26526.9 26896.2 1189.2 1212.6 1219.6 1261.5 1266.1 13223.5 13477.3 13554.5 13633.7 13822.2 343851.0 347866.0 348945.0 349609.0 349984.0 55319.0 55928.0 55949.2 55959.0 56119.4 1256.5 1266.6 1373.0 1416.4 1434.4 21573.6 28056.4 28169.3 28738.4 28836.4 45453.5 52052.7 52269.0 52595.2 52715.5 417009.0 417011.0 419266.0 419580.0 420486.0 33745.2 34219.6 34224.5 34397.8 34426.5 43000.6 43168.0 43265.6 43291.4 43394.3 33937.2 34751.8 35657.1 36085.8 36299.0 34245.0 34441.8 34670.8 35685.8 35763.0 34951.8 35456.6 35517.0 35712.0 35766.6 22983.5 25079.7 30917.0 31345.0 31363.4 23440.4 23871.2 23964.5 24014.9 24317.9 16:19:41 INFO - PID 1636 | 16:19:41 INFO - PID 1636 | [#2] jquery.html Cycles:180 Average:38727.41 Median:22571.89 stddev:104155.32 (461.4%) stddev-sans-first:104407.72 16:19:41 INFO - PID 1636 | Values: 387.1 405.5 413.2 418.0 426.4 17795.4 20707.7 21112.5 21116.2 21889.8 22178.9 22367.0 22379.3 22469.4 22788.3 6326.1 6686.5 6718.6 6726.0 6746.3 5116.3 6710.1 6735.6 6745.5 6765.6 6444.7 6613.7 6720.4 6721.6 6728.5 6552.9 6574.7 6626.7 6627.9 6634.7 5889.3 6305.2 6563.4 6570.4 6621.4 26003.9 26243.0 27221.0 27349.6 27769.7 3119.4 3238.4 3245.0 3359.3 3369.6 15736.7 16154.6 16739.0 17165.9 17296.7 1661.7 1926.8 1989.7 1991.4 2034.0 141790.0 142939.6 143382.3 143630.0 145192.0 22862.3 22869.0 23003.0 23147.0 23222.2 37174.0 37299.8 37398.1 37420.6 37486.8 8766.2 10256.2 10511.4 10696.4 10772.9 8527.9 8543.1 8568.0 8699.7 8732.7 10679.3 11005.0 11065.9 11260.2 11271.4 3863.4 3916.0 4531.5 4537.8 4597.7 752.9 864.3 865.7 885.9 901.4 17604.9 22485.9 22517.3 22548.8 22595.0 889.7 902.9 904.4 905.1 907.5 10466.8 10888.8 11206.7 11370.0 11844.6 504719.0 620188.0 630331.0 664256.0 678769.0 129353.6 130399.0 133766.0 134050.0 134098.0 1157.9 1210.7 1235.3 1250.7 1263.9 16791.0 17069.1 19961.9 20847.4 21039.5 50655.0 61200.7 62563.7 63826.1 64679.4 66228.0 78563.2 85160.0 85201.2 85626.1 9786.9 11357.7 11751.3 12092.5 12248.4 12427.3 13450.0 13768.8 13903.9 13945.9 11539.7 11590.9 11910.8 11997.8 12044.5 11112.7 11367.3 11659.8 11794.9 11810.0 11595.5 11754.5 11969.8 12048.3 12128.8 11470.5 11810.5 11856.5 12039.0 12174.6 11569.7 11659.0 11919.9 12015.8 12029.8 16:19:41 INFO - PID 1636 | 16:19:41 INFO - PID 1636 | [#3] mootools.html Cycles:180 Average:6460.77 Median:3723.14 stddev:4028.86 (108.2%) stddev-sans-first:4023.18 16:19:41 INFO - PID 1636 | Values: 1537.2 1568.6 1572.4 1596.1 1598.7 10390.9 10839.2 10868.4 10882.7 11211.3 10244.6 10828.7 10978.0 11021.3 11059.3 1929.2 2195.5 2199.1 2203.9 2204.3 2265.4 2303.6 2306.0 2306.2 2311.0 2266.1 2285.8 2296.1 2301.4 2304.4 2257.5 2259.6 2263.6 2272.9 2275.6 2242.2 2292.2 2309.7 2313.4 2316.3 10863.3 10890.2 10973.0 10976.8 10980.2 5643.7 5736.3 5772.9 5856.6 5864.4 3015.8 3284.4 3432.2 3640.7 3652.8 1196.9 1235.1 1740.2 1788.5 1912.1 14581.4 14690.9 14750.1 14791.2 14947.0 4499.5 4561.9 4579.7 4717.6 4730.3 9116.3 10655.0 11268.0 11297.2 11297.4 4671.6 5555.2 5694.4 5708.8 5722.2 5080.6 5210.6 5227.1 5246.7 5282.1 3793.5 3837.8 3841.5 3923.1 3930.5 1043.1 1046.2 1046.7 1058.9 1060.8 776.7 901.3 913.0 920.5 937.2 6287.2 6398.4 6513.0 6579.1 6614.4 827.8 995.0 995.6 1030.1 1048.1 3415.9 4052.9 4081.7 4101.3 4160.6 12125.5 13058.9 13449.1 13476.3 13503.7 11176.8 12878.5 13402.4 13408.2 13425.3 8371.8 8630.6 9535.5 9888.5 9908.3 6341.2 6542.5 6674.1 6765.7 6797.7 9747.5 11854.3 12186.8 12197.3 12207.3 11863.5 11897.3 12169.2 12181.0 12235.8 9059.4 9288.9 9317.3 9354.8 9397.4 9272.9 9290.3 9333.1 9334.3 9396.4 8219.4 8260.8 8298.8 8349.4 8450.3 8096.9 8117.0 8145.7 8185.3 8301.0 5868.4 6531.8 7213.0 7335.9 7343.0 4484.4 4807.9 5443.5 5494.2 5663.5 5508.3 5531.0 5686.5 5750.5 5756.4 16:19:41 INFO - PID 1636 | 16:19:41 INFO - PID 1636 | [#4] prototype.html Cycles:180 Average:5399.14 Median:5793.80 stddev:1564.91 (27.0%) stddev-sans-first:1522.31 16:19:41 INFO - PID 1636 | Values: 328.2 358.3 372.2 393.8 399.0 4817.8 5279.4 5938.3 6087.3 6158.3 4528.8 6014.2 6051.3 6082.5 6120.3 5278.0 5285.0 5308.1 5323.4 5499.2 4047.5 4676.3 4946.9 4949.3 5308.2 4919.8 4926.8 4950.0 4953.0 4987.8 3884.6 4962.6 4965.0 4984.2 4990.3 3690.7 4062.7 4364.7 4405.5 4469.7 4901.5 5067.9 5538.7 5660.5 5887.5 5801.6 5820.3 5834.5 5837.4 5840.7 5223.5 6096.6 6177.4 6259.4 6566.7 4435.9 4553.3 4618.2 5102.2 5106.8 5101.7 6013.0 6464.5 6613.5 6819.8 4547.3 5102.4 5279.8 5289.1 5319.2 4998.4 5060.3 5283.7 5350.1 5353.4 4227.2 4853.8 5703.2 5743.2 5786.0 6455.4 6484.8 6488.9 6494.3 6517.2 1762.8 1809.4 1813.7 1815.1 1831.3 1154.4 1303.2 1350.9 1352.9 1370.2 5064.7 5594.0 6064.7 6095.9 6110.3 6560.9 6724.5 6756.3 6773.5 6785.6 5583.3 5701.3 5753.3 6026.2 6081.6 3020.4 3034.1 3322.8 3469.9 3541.5 6737.7 6974.4 7017.3 7034.5 7034.8 5269.0 6316.8 6953.2 6975.9 6996.7 6573.6 6851.2 6985.4 6998.9 7001.3 6317.0 6719.9 6722.4 6743.0 6745.2 5635.9 6367.8 6639.7 6655.7 6688.3 5726.5 6884.9 7005.8 7046.3 7072.9 4917.3 5223.2 5314.4 5337.0 5338.6 5403.4 6476.6 6817.5 6847.4 6848.9 5233.0 6318.8 6548.9 6571.6 6601.6 5300.9 6510.0 6524.3 6561.4 6581.9 6255.2 6390.3 6413.0 6421.8 6458.8 5238.7 6505.7 6525.2 6549.4 6561.3 6407.7 6424.0 6433.5 6445.6 6468.2 16:19:41 INFO - PID 1636 | 16:19:41 INFO - PID 1636 | [#5] yui.html Cycles:180 Average:19384.75 Median:3471.15 stddev:26891.38 (774.7%) stddev-sans-first:26929.90 16:19:41 INFO - PID 1636 | Values: 619.8 695.0 739.6 754.6 849.6 14753.6 15040.8 15314.9 15528.8 15601.7 11412.5 13348.5 14265.7 14515.3 14532.0 931.9 955.4 963.3 965.1 967.2 901.9 929.5 966.3 971.8 972.7 1025.3 1025.8 1034.2 1036.5 1038.6 1003.9 1028.1 1028.7 1034.0 1037.6 773.8 774.1 775.3 777.3 778.0 15427.6 16295.6 16467.9 16485.3 16540.4 14415.9 14765.7 14801.6 14832.6 14851.8 10045.9 10418.3 11141.1 11198.6 11612.7 3760.5 3808.3 3830.5 3926.7 3941.9 95076.0 95286.1 95936.0 100375.0 106955.9 11353.8 11375.7 11559.8 11752.5 11913.1 23692.1 23755.5 23940.4 23985.8 23993.6 7735.8 7746.0 7820.2 7854.6 7937.5 3564.6 4125.8 4217.8 4222.4 4227.5 3446.0 3496.3 3509.2 3529.3 3530.9 627.9 631.8 632.0 632.1 637.1 633.5 633.8 636.9 695.9 696.7 9612.3 9720.8 10047.7 10054.4 10260.7 619.7 649.0 671.0 672.9 692.4 4620.3 4825.7 4827.5 4842.5 4849.9 87070.0 93081.5 98332.5 102347.0 105064.0 70757.3 72006.6 79068.9 81611.2 89017.6 59895.4 68464.3 70505.0 70777.9 71309.0 9085.0 10887.3 11107.8 11136.9 11221.0 41864.7 42685.6 44166.6 45354.1 47694.0 53826.0 61450.7 66420.7 68591.3 68813.8 11402.4 13262.4 13382.2 13834.8 14056.4 11555.6 12182.9 14446.5 14670.7 14799.7 13387.0 13470.5 13560.3 13584.5 13761.3 11768.4 13658.0 13743.5 13836.7 14033.2 13076.5 13456.9 13474.7 13932.9 14027.2 10885.7 10977.2 11053.0 11062.7 11901.9 9394.8 10391.7 10483.4 10537.4 11011.6 16:19:41 INFO - PID 1636 | -------- Summary: end -------- 16:19:41 INFO - PID 1636 | 16:19:41 INFO - TEST-INFO | 1636: exit 0 16:19:41 INFO - TEST-OK | dromaeo_css | took 1116608ms 16:19:41 INFO - TEST-START | kraken 16:19:41 INFO - operating with platform_type : mac_ 16:19:41 INFO - Initialising browser for kraken test... 16:19:41 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmpO9kWhs/profile http://localhost:49241/getInfo.html) 16:19:44 INFO - PID 1648 | 2017-03-15 16:19:44.779 plugin-container[1649:10271] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a37, name = 'com.apple.tsm.portname' 16:19:44 INFO - PID 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:19:44 INFO - PID 1648 | 2017-03-15 16:19:44.782 plugin-container[1649:10271] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 16:19:44 INFO - PID 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:19:44 INFO - PID 1648 | 2017-03-15 16:19:44.782 plugin-container[1649:10271] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:19:44 INFO - PID 1648 | __metrics Screen width/height:1600/1200 16:19:44 INFO - PID 1648 | colorDepth:24 16:19:44 INFO - PID 1648 | Browser inner width/height: 1024/689 16:19:44 INFO - PID 1648 | __metrics 16:19:44 ERROR - PID 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 16:19:45 INFO - TEST-INFO | 1648: exit 0 16:19:45 INFO - Browser initialized. 16:19:45 INFO - Running cycle 1/1 for kraken test... 16:19:45 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmpO9kWhs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:19:48 INFO - PID 1650 | 2017-03-15 16:19:48.162 plugin-container[1651:10396] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9053, name = 'com.apple.tsm.portname' 16:19:48 INFO - PID 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:19:48 INFO - PID 1650 | 2017-03-15 16:19:48.163 plugin-container[1651:10396] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9057, name = 'com.apple.CFPasteboardClient' 16:19:48 INFO - PID 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:19:48 INFO - PID 1650 | 2017-03-15 16:19:48.163 plugin-container[1651:10396] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:19:57 INFO - PID 1650 | RSS: Main: 227934208 16:19:57 INFO - PID 1650 | 16:20:00 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 16:20:01 INFO - PID 1650 | RSS: Main: 241963008 16:20:01 INFO - PID 1650 | 16:20:04 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 16:20:04 INFO - PID 1650 | RSS: Main: 250384384 16:20:04 INFO - PID 1650 | 16:20:08 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 16:20:08 INFO - PID 1650 | RSS: Main: 252674048 16:20:08 INFO - PID 1650 | 16:20:10 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 16:20:11 INFO - PID 1650 | RSS: Main: 255410176 16:20:11 INFO - PID 1650 | 16:20:13 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:20:13 INFO - PID 1650 | RSS: Main: 255889408 16:20:13 INFO - PID 1650 | 16:20:16 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 16:20:17 INFO - PID 1650 | RSS: Main: 261455872 16:20:17 INFO - PID 1650 | 16:20:20 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 16:20:21 INFO - PID 1650 | RSS: Main: 262627328 16:20:21 INFO - PID 1650 | 16:20:24 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 16:20:24 INFO - PID 1650 | RSS: Main: 261672960 16:20:24 INFO - PID 1650 | 16:20:26 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:20:27 INFO - PID 1650 | RSS: Main: 261566464 16:20:27 INFO - PID 1650 | 16:20:28 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:20:29 INFO - PID 1650 | RSS: Main: 261476352 16:20:29 INFO - PID 1650 | 16:20:31 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:20:32 INFO - PID 1650 | RSS: Main: 261525504 16:20:32 INFO - PID 1650 | 16:20:35 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:20:36 INFO - PID 1650 | RSS: Main: 262098944 16:20:36 INFO - PID 1650 | 16:20:39 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:20:40 INFO - PID 1650 | RSS: Main: 262176768 16:20:40 INFO - PID 1650 | 16:20:41 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 16:20:42 INFO - PID 1650 | RSS: Main: 263680000 16:20:42 INFO - PID 1650 | 16:20:42 INFO - PID 1650 | __start_tp_report 16:20:42 INFO - PID 1650 | _x_x_mozilla_page_load 16:20:42 INFO - PID 1650 | _x_x_mozilla_page_load_details 16:20:42 INFO - PID 1650 | |i|pagename|runs| 16:20:42 INFO - PID 1650 | |0;ai-astar;109;141;119;113;118;119;119;120;121;121 16:20:42 INFO - PID 1650 | |1;audio-beat-detection;145;109;128;154;116;114;113;115;135;114 16:20:42 INFO - PID 1650 | |2;audio-dft;192;200;197;217;206;227;194;198;230;218 16:20:42 INFO - PID 1650 | |3;audio-fft;87;61;60;87;59;65;57;58;74;60 16:20:42 INFO - PID 1650 | |4;audio-oscillator;90;70;85;71;72;72;85;70;88;116 16:20:42 INFO - PID 1650 | |5;imaging-gaussian-blur;87;88;87;118;117;137;88;87;89;89 16:20:42 INFO - PID 1650 | |6;imaging-darkroom;95;96;97;95;96;94;95;155;96;97 16:20:42 INFO - PID 1650 | |7;imaging-desaturate;88;93;92;93;119;143;94;92;92;94 16:20:42 INFO - PID 1650 | |8;json-parse-financial;66;66;68;67;66;68;67;68;66;67 16:20:42 INFO - PID 1650 | |9;json-stringify-tinderbox;60;61;61;71;65;54;58;58;58;59 16:20:42 INFO - PID 1650 | |10;stanford-crypto-aes;98;73;106;108;94;75;84;110;104;108 16:20:42 INFO - PID 1650 | |11;stanford-crypto-ccm;152;160;155;149;161;158;153;139;187;141 16:20:42 INFO - PID 1650 | |12;stanford-crypto-pbkdf2;182;187;213;190;186;184;243;234;216;189 16:20:42 INFO - PID 1650 | |13;stanford-crypto-sha256-iterative;65;99;68;70;69;67;69;83;94;103 16:20:42 INFO - PID 1650 | __end_tp_report 16:20:42 INFO - PID 1650 | __start_cc_report 16:20:42 INFO - PID 1650 | _x_x_mozilla_cycle_collect,996 16:20:42 INFO - PID 1650 | __end_cc_report 16:20:42 INFO - PID 1650 | __startTimestamp1489620042216__endTimestamp 16:20:42 INFO - PID 1650 | 16:20:42 INFO - PID 1650 | ------- Summary: start ------- 16:20:42 INFO - PID 1650 | Number of tests: 14 16:20:42 INFO - PID 1650 | 16:20:42 INFO - PID 1650 | [#0] ai-astar Cycles:10 Average:120.00 Median:119.50 stddev:8.30 (6.9%) stddev-sans-first:7.79 16:20:42 INFO - PID 1650 | Values: 109.0 141.0 119.0 113.0 118.0 119.0 119.0 120.0 121.0 121.0 16:20:42 INFO - PID 1650 | 16:20:42 INFO - PID 1650 | [#1] audio-beat-detection Cycles:10 Average:124.30 Median:122.00 stddev:15.52 (12.7%) stddev-sans-first:14.54 16:20:42 INFO - PID 1650 | Values: 145.0 109.0 128.0 154.0 116.0 114.0 113.0 115.0 135.0 114.0 16:20:42 INFO - PID 1650 | 16:20:42 INFO - PID 1650 | [#2] audio-dft Cycles:10 Average:207.90 Median:211.50 stddev:14.01 (6.6%) stddev-sans-first:13.63 16:20:42 INFO - PID 1650 | Values: 192.0 200.0 197.0 217.0 206.0 227.0 194.0 198.0 230.0 218.0 16:20:42 INFO - PID 1650 | 16:20:42 INFO - PID 1650 | [#3] audio-fft Cycles:10 Average:66.80 Median:63.00 stddev:11.70 (18.6%) stddev-sans-first:9.86 16:20:42 INFO - PID 1650 | Values: 87.0 61.0 60.0 87.0 59.0 65.0 57.0 58.0 74.0 60.0 16:20:42 INFO - PID 1650 | 16:20:42 INFO - PID 1650 | [#4] audio-oscillator Cycles:10 Average:81.90 Median:78.50 stddev:14.46 (18.4%) stddev-sans-first:15.04 16:20:42 INFO - PID 1650 | Values: 90.0 70.0 85.0 71.0 72.0 72.0 85.0 70.0 88.0 116.0 16:20:42 INFO - PID 1650 | 16:20:42 INFO - PID 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:98.70 Median:87.50 stddev:18.26 (20.9%) stddev-sans-first:18.87 16:20:42 INFO - PID 1650 | Values: 87.0 88.0 87.0 118.0 117.0 137.0 88.0 87.0 89.0 89.0 16:20:42 INFO - PID 1650 | 16:20:42 INFO - PID 1650 | [#6] imaging-darkroom Cycles:10 Average:101.60 Median:96.00 stddev:18.79 (19.6%) stddev-sans-first:19.77 16:20:42 INFO - PID 1650 | Values: 95.0 96.0 97.0 95.0 96.0 94.0 95.0 155.0 96.0 97.0 16:20:42 INFO - PID 1650 | 16:20:42 INFO - PID 1650 | [#7] imaging-desaturate Cycles:10 Average:100.00 Median:92.50 stddev:17.37 (18.8%) stddev-sans-first:17.87 16:20:42 INFO - PID 1650 | Values: 88.0 93.0 92.0 93.0 119.0 143.0 94.0 92.0 92.0 94.0 16:20:42 INFO - PID 1650 | 16:20:42 INFO - PID 1650 | [#8] json-parse-financial Cycles:10 Average:66.90 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.87 16:20:42 INFO - PID 1650 | Values: 66.0 66.0 68.0 67.0 66.0 68.0 67.0 68.0 66.0 67.0 16:20:42 INFO - PID 1650 | 16:20:42 INFO - PID 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:60.50 stddev:4.65 (7.7%) stddev-sans-first:4.93 16:20:42 INFO - PID 1650 | Values: 60.0 61.0 61.0 71.0 65.0 54.0 58.0 58.0 58.0 59.0 16:20:42 INFO - PID 1650 | 16:20:42 INFO - PID 1650 | [#10] stanford-crypto-aes Cycles:10 Average:96.00 Median:74.00 stddev:14.02 (19.0%) stddev-sans-first:14.86 16:20:42 INFO - PID 1650 | Values: 98.0 73.0 106.0 108.0 94.0 75.0 84.0 110.0 104.0 108.0 16:20:42 INFO - PID 1650 | 16:20:42 INFO - PID 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:155.50 Median:156.50 stddev:13.30 (8.5%) stddev-sans-first:14.05 16:20:42 INFO - PID 1650 | Values: 152.0 160.0 155.0 149.0 161.0 158.0 153.0 139.0 187.0 141.0 16:20:42 INFO - PID 1650 | 16:20:42 INFO - PID 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:202.40 Median:201.50 stddev:22.46 (11.1%) stddev-sans-first:22.57 16:20:42 INFO - PID 1650 | Values: 182.0 187.0 213.0 190.0 186.0 184.0 243.0 234.0 216.0 189.0 16:20:42 INFO - PID 1650 | 16:20:42 INFO - PID 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.70 Median:69.50 stddev:14.75 (21.2%) stddev-sans-first:14.79 16:20:42 INFO - PID 1650 | Values: 65.0 99.0 68.0 70.0 69.0 67.0 69.0 83.0 94.0 103.0 16:20:42 INFO - PID 1650 | -------- Summary: end -------- 16:20:42 INFO - PID 1650 | 16:20:43 INFO - TEST-INFO | 1650: exit 0 16:20:43 INFO - TEST-OK | kraken | took 61354ms 16:20:43 INFO - SUITE-END | took 1177s 16:20:43 INFO - Completed test suite (00:19:38) 16:20:43 INFO - javascript benchmark 16:20:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7816.307673171051, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3216.8230747308917, 3261.695321871251, 3319.1038419626702, 3432.0, 3462.5498685170933, 4600.447946246451, 4699.342092107104, 5668.234788303578, 6000.879982400349, 6035.758569657214, 4969.875753106174, 6008.429199226078, 6024.728887200075, 6070.301915279744, 6082.0, 5239.10935141025, 5239.895202095956, 5329.147336426163, 5387.218853266274, 5458.235846981426, 5397.433269506684, 5431.83704488866, 5444.8366549003595, 5460.726963651821, 5469.617126801126, 5217.34783152106, 5312.548433383167, 5313.654612450178, 5317.388500322474, 5421.620486565942, 4479.8352428368535, 4609.400777898885, 5031.723255220962, 5130.153524668425, 5342.519173274385, 5248.947510524884, 5331.2269720890645, 5332.2801421808335, 5336.252924590522, 5383.057964856134, 5712.171735098387, 5851.356350801409, 5902.380250073767, 5914.497267732248, 5932.080527518242, 6169.5064394848305, 6288.874222515524, 6311.558190926637, 6313.179286692746, 6327.936720632781, 6261.624302541862, 6340.841478963017, 6389.393007664265, 6393.680315984182, 6408.359164083601, 6116.26604807426, 6130.478909292716, 6156.199694039746, 6162.506999440034, 6181.103739957681, 6506.316836732075, 6520.47836173105, 6533.085368048477, 6542.443892269211, 6548.410643042149, 6145.0, 6273.937260627426, 6275.6862156892885, 6284.277308109535, 6305.590136641195, 6320.146780184708, 6334.398232167937, 6341.112244285804, 6352.968235158794, 6388.456981156561, 6274.466670332981, 6309.873802523924, 6316.084167795736, 6316.589421687576, 6330.0821380899515, 6179.876402471926, 6237.064440333987, 6246.437820596168, 6308.779192728232, 6314.71583778731, 5164.992826398816, 5177.948220517746, 5186.766595503212, 5203.947960520422, 5210.426853046162, 4612.262038073892, 4621.468531118897, 4642.744649044267, 4654.115718013567, 4662.160811053975, 4896.3389942358035, 5915.438033386821, 6076.422739839708, 6081.118237855486, 6132.294786099566, 6310.905336419957, 6357.872842543124, 6387.169667943138, 6412.67936603168, 6431.935680643227, 6036.547258955508, 6097.085437184458, 6121.234845644294, 6123.295820980644, 6140.723667434976, 5497.945020549823, 5594.776208951596, 5645.23789288449, 5680.943190568124, 5729.942700572941, 6420.6147631142285, 6426.068220108058, 6591.736330546724, 6599.340065993362, 6628.07206991012, 6387.712552935222, 6390.648514331757, 6409.807705768834, 6428.067930150009, 6437.935620643733, 6289.213848268966, 6355.5551111421755, 6380.266269379081, 6503.6097834130105, 6609.570377925419, 6312.684365781601, 6315.179026726496, 6322.146510221245, 6337.809865704036, 6338.936610633835, 5013.373328333958, 5862.560307977004, 6304.306526282014, 6353.0152826312, 6390.4248617624635, 5244.501772331622, 6229.688515574294, 6263.718132684131, 6276.843078923063, 6298.370162983665, 6251.280897752972, 6272.717727702173, 6281.59169653971, 6295.9370406297185, 6308.968455157695, 5071.39143302806, 5619.494245517923, 6137.131844484855, 6202.5658203925295, 6287.0, 6249.187605611241, 6265.0, 6276.403741644536, 6277.937220627735, 6283.088952102011, 6241.531885108544, 6270.529710271657, 6279.340669229665, 6293.37066293367, 6325.209348831396], "value": 5817.641988755379, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [794.9443538952273, 943.1181844974947, 943.7027336389037, 954.9188318992885, 970.3304719743377, 30174.0, 36861.078473038186, 37655.81172094143, 37698.86903392899, 37827.24345513088, 37957.24085518288, 38223.80888095563, 38356.232875342546, 38388.80805595968, 38455.615443845556, 8790.428622139572, 9117.68088116916, 9129.041450647686, 9132.223760980325, 9141.862872056925, 9089.54552272387, 9183.678571250008, 9211.217046551052, 9217.44695318283, 9247.213986811095, 8059.556724380157, 9274.211692006187, 9311.906880931205, 9332.393394429375, 9368.625254989825, 9274.907250927505, 9306.534673266377, 9312.767180820467, 9314.86027709585, 9345.01877302887, 9087.136722011399, 9168.862467063, 9177.265818734486, 9182.540872956326, 9189.816203675957, 38128.809355953046, 38378.23243535141, 38380.61619383798, 38391.04022399434, 38436.0, 3356.412627790127, 3832.4059770735303, 3855.9036024099623, 3863.38185890259, 3996.9600303997167, 27389.726102738918, 27629.447411051868, 27998.5800212997, 28148.718512814816, 28253.0, 2521.445282037949, 2897.9277667263036, 3245.432049391347, 3273.6562660920736, 3298.2578919742864, 230212.0, 235044.82477587502, 298078.0, 298184.5090774554, 298273.5431614227, 50094.49905500971, 50151.498485015414, 50290.497095029314, 50330.0, 50440.0, 52020.739896301035, 52150.478495214564, 52203.21695174575, 52269.0, 52375.0, 14402.639934001525, 14442.638934026523, 14467.565973020826, 14473.421063157566, 14496.782548261785, 11627.883721162849, 11754.0, 11774.764504709858, 11793.997510211728, 11815.468303926344, 12643.304618246084, 13945.233012184428, 13956.581302560939, 13990.930045349709, 14095.097161883219, 5171.689698618095, 5209.869753256123, 6179.81460556184, 6201.875962480725, 6227.906581401283, 1079.8974097460728, 1111.183280288987, 1114.4984756859283, 1115.5330740076772, 1166.78414493319, 20108.798912010985, 26274.737252627612, 26293.73706262913, 26526.867365663435, 26896.193114206606, 1189.1556994533805, 1212.5513559982862, 1219.5973931355215, 1261.5269274022241, 1266.069438962362, 13223.47106115764, 13477.326133693276, 13554.525591604246, 13633.659158521117, 13822.170669759847, 343851.0, 347866.0, 348945.0, 349609.0, 349984.0, 55319.0, 55928.0, 55949.160762588595, 55959.0, 56119.43880561142, 1256.5162412471082, 1266.6257111034631, 1373.0, 1416.4334266293565, 1434.4405681784112, 21573.568528629025, 28056.438871222053, 28169.295767605974, 28738.425231495672, 28836.42327153487, 45453.54546454493, 52052.739736301075, 52269.0, 52595.21107183472, 52715.472845271055, 417009.0, 417011.0, 419266.0, 419580.0, 420486.0, 33745.15637109092, 34219.631214752124, 34224.486632701024, 34397.82801085978, 34426.48360274548, 43000.56999429966, 43168.0, 43265.567344326155, 43291.35062974121, 43394.349084763126, 33937.15157120993, 34751.826240868635, 35657.08739210354, 36085.81957090198, 36299.0, 34245.0, 34441.82779086089, 34670.82664586661, 35685.821570893015, 35763.0, 34951.82524087465, 35456.64543354533, 35517.0, 35712.0, 35766.64233357633, 22983.540329192987, 25079.749202508472, 30917.0, 31345.0, 31363.372732544765, 23440.413989650395, 23871.246382279332, 23964.52070958606, 24014.87992560026, 24317.878410607835], "value": 18343.481465895416, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.11544121681965, 405.4647864818439, 413.153036275635, 417.96029377209163, 426.41793951256545, 17795.37716179934, 20707.689384659225, 21112.4721881953, 21116.15535378585, 21889.781102188972, 22178.88910555449, 22367.0, 22379.32862014138, 22469.438264043365, 22788.265408151005, 6326.114343991845, 6686.531942764009, 6718.563293385939, 6726.024726414667, 6746.325367463263, 5116.334876466054, 6710.060591517192, 6735.629540375277, 6745.527813053088, 6765.5602385845, 6444.742210311582, 6613.6693165341785, 6720.428763555079, 6721.596704197764, 6728.529002969794, 6552.868942621145, 6574.737010519598, 6626.6686665667, 6627.933720662828, 6634.701438435258, 5889.293284805851, 6305.180326557518, 6563.442107420875, 6570.408663220333, 6621.437177839889, 26003.869980649975, 26243.0, 27221.047263345885, 27349.589756153673, 27769.722302776914, 3119.407312610597, 3238.3847069056806, 3244.983775081133, 3359.328134373135, 3369.629340772513, 15736.685266294724, 16154.596135096717, 16739.0, 17165.88421752582, 17296.654066918716, 1661.7092008898514, 1926.7591551056119, 1989.6518109330955, 1991.4324417541077, 2034.0033383642058, 141790.0, 142939.57060429367, 143382.28308858493, 143630.0, 145192.0, 22862.31413057611, 22869.0, 23003.0, 23147.0, 23222.187223447097, 37174.0, 37299.81350093286, 37398.06504837401, 37420.625793742256, 37486.812565937544, 8766.21104100634, 10256.179505639531, 10511.369317840954, 10696.358218506915, 10772.946135269274, 8527.872081918777, 8543.060263371024, 8568.014678312074, 8699.652013919373, 8732.738017859474, 10679.276784419922, 11005.0, 11065.889341106647, 11260.155488338407, 11271.38007409584, 3863.439801228806, 3915.9622699984525, 4531.45622525299, 4537.8411755588395, 4597.724136551751, 752.8744526932271, 864.2912811494514, 865.7229686500385, 885.8892638420198, 901.396064636695, 17604.91197544004, 22485.88757056204, 22517.32448026562, 22548.774512254997, 22595.0, 889.7419748273057, 902.9097090290918, 904.4166512599468, 905.0858632780808, 907.4555266839975, 10466.842997355046, 10888.836667449994, 11206.655201375725, 11370.03354714842, 11844.585439509576, 504719.0, 620188.0, 630331.0, 664256.0, 678769.0, 129353.62995327273, 130399.0, 133766.0, 134050.0, 134098.0, 1157.8726340102583, 1210.7033776724759, 1235.3390935849457, 1250.6748245456247, 1263.886250237483, 16791.0, 17069.146542673065, 19961.900190498956, 20847.37457876266, 21039.474013149793, 50655.0, 61200.693996529735, 62563.748725026155, 63826.08521744355, 64679.353206467335, 66228.0, 78563.21436785787, 85160.0, 85201.20186178421, 85626.14373856182, 9786.853197201905, 11357.716057098638, 11751.294922304689, 12092.455839487067, 12248.448819803309, 12427.254364738144, 13450.0, 13768.793468097787, 13903.860961390661, 13945.930270348583, 11539.711507212387, 11590.884091159318, 11910.821337680116, 11997.820032699341, 12044.51821927113, 11112.722181945193, 11367.317960922372, 11659.825102623638, 11794.941025294818, 11809.996150327319, 11595.478203481032, 11754.529818807152, 11969.760604788029, 12048.337341446304, 12128.818067728815, 11470.541178353105, 11810.527578897092, 11856.466459009538, 12038.976686981705, 12174.634760957186, 11569.6529104127, 11659.0, 11919.940400297943, 12015.819762703391, 12029.819552706542], "value": 11584.332820854517, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1537.2237020304744, 1568.5686436230042, 1572.3725943648326, 1596.1221328269453, 1598.6962477129346, 10390.948045259773, 10839.18706097043, 10868.402237876913, 10882.6735197944, 11211.327320360784, 10244.565760793495, 10828.729281767959, 10978.0, 11021.338719676825, 11059.281146725478, 1929.24759343856, 2195.4730864592543, 2199.08737873783, 2203.9449013774624, 2204.2946257197705, 2265.3883451468096, 2303.585354636165, 2306.0, 2306.1582522379376, 2310.976890231093, 2266.1162146762695, 2285.7942785149335, 2296.1274715608047, 2301.355620426283, 2304.412374844412, 2257.525919556895, 2259.6045692004, 2263.581237471073, 2272.931812045633, 2275.6245219538837, 2242.2040175737543, 2292.2321022457495, 2309.711286089239, 2313.398516385752, 2316.293530473205, 10863.348199107999, 10890.237683362167, 10973.0, 10976.780464390748, 10980.176486763445, 5643.717814109278, 5736.311642602915, 5772.942270577282, 5856.619319744245, 5864.38423965486, 3015.7888947773663, 3284.4088064148445, 3432.2277487565348, 3640.7451478396524, 3652.7625704329134, 1196.8683444821063, 1235.14774805384, 1740.225599608175, 1788.5439213000732, 1912.1013123831776, 14581.416743330254, 14690.869823875479, 14750.114993100447, 14791.186484743335, 14947.02844315116, 4499.492669955602, 4561.908761824811, 4579.679422440464, 4717.551832575899, 4730.290456431494, 9116.316276279305, 10655.041046305869, 11267.985881270724, 11297.152713546517, 11297.378644174485, 4671.649626278043, 5555.2222688823595, 5694.402087780806, 5708.771649134072, 5722.198892155102, 5080.644354895196, 5210.583153347723, 5227.111391063529, 5246.711430871339, 5282.075636763628, 3793.525809273841, 3837.76973381598, 3841.539015318124, 3923.0780766519847, 3930.4890364252465, 1043.1081425381342, 1046.2310202001674, 1046.6912260883057, 1058.915286777056, 1060.7878424315013, 776.6737970052592, 901.3014913442134, 912.9957047247974, 920.5075284722641, 937.2267878999852, 6287.1512345832725, 6398.392152745481, 6513.0, 6579.144711187515, 6614.437772789271, 827.755812035451, 994.9850752238722, 995.6166875752888, 1030.0523518363125, 1048.0567489259727, 3415.8591320063147, 4052.9392059119136, 4081.6938729594804, 4101.323281658552, 4160.625543701081, 12125.514979400901, 13058.934705326412, 13449.125806822525, 13476.326183690777, 13503.729925401634, 11176.776464470666, 12878.484860605471, 13402.396892139877, 13408.195508269535, 13425.328733563283, 8371.83256334882, 8630.611622477003, 9535.52322383878, 9888.505574721235, 9908.306418550776, 6341.175647165839, 6542.476601871934, 6674.098996635586, 6765.661716914036, 6797.72809087631, 9747.463889486145, 11854.348010859485, 12186.817197742219, 12197.268163910194, 12207.267563946192, 11863.525458981545, 11897.345645989553, 12169.20900141488, 12181.0, 12235.816462752888, 9059.411138275991, 9288.860667090134, 9317.34778565494, 9354.76613084651, 9397.436153830791, 9272.907270927204, 9290.303227257848, 9333.066693330884, 9334.346595738505, 9396.389234699722, 8219.424640275123, 8260.752177434686, 8298.83402331938, 8349.37379696513, 8450.323974082181, 8096.919030809617, 8116.959415202886, 8145.714899978472, 8185.30424913889, 8301.0, 5868.354481007001, 6531.771388001397, 7213.0, 7335.853282934205, 7342.963285183753, 4484.372187893763, 4807.87450260783, 5443.482869127427, 5494.230807686847, 5663.518600918968, 5508.283923089973, 5531.004419204421, 5686.459786320458, 5750.482456578928, 5756.424357564378], "value": 4973.026983423262, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.17627754336615, 358.25125487730645, 372.23691432563237, 393.75193628014347, 398.9825943843199, 4817.783199756011, 5279.4192638809745, 5938.317093534234, 6087.299960504538, 6158.261008678965, 4528.75091869947, 6014.248218972629, 6051.27384713835, 6082.482988945934, 6120.296165940907, 5277.973610131944, 5285.0, 5308.097623404011, 5323.441038690939, 5499.230107784913, 4047.4738284023038, 4676.251799712047, 4946.901061978776, 4949.282354058677, 5308.177232528945, 4919.827806026789, 4926.778294976734, 4949.950500495003, 4952.959878425535, 4987.802927297441, 3884.611538846121, 4962.627802914778, 4964.982178653404, 4984.22744474607, 4990.30135780991, 3690.7231957603285, 4062.73592216505, 4364.668776023312, 4405.515393306734, 4469.664775141878, 4901.485344038861, 5067.873303167414, 5538.723063846792, 5660.528262651699, 5887.499562537189, 5801.593888427812, 5820.272465941757, 5834.52032886026, 5837.357890632027, 5840.678762668052, 5223.529882310572, 6096.603720758137, 6177.413145751147, 6259.436650701458, 6566.70449829754, 4435.866923992286, 4553.339765733983, 4618.1687296286655, 5102.183510797694, 5106.795728170869, 5101.744912754384, 6012.969935150296, 6464.45052170566, 6613.537052406334, 6819.761308354184, 4547.272436410159, 5102.428300189882, 5279.762410691528, 5289.100852855024, 5319.202119682079, 4998.425181104147, 5060.2662613920775, 5283.709395983258, 5350.063738845764, 5353.357597088374, 4227.239096962577, 4853.757312134379, 5703.201551782754, 5743.195952566644, 5786.0, 6455.419012288917, 6484.773032943919, 6488.870222595521, 6494.285628580852, 6517.152770139852, 1762.8237176282269, 1809.3576780243088, 1813.6949422938117, 1815.1287382056687, 1831.276645724931, 1154.4054811771944, 1303.244118411319, 1350.9324533773272, 1352.905296629246, 1370.2258224103548, 5064.733247055628, 5594.0, 6064.66644334557, 6095.939040609537, 6110.297315808739, 6560.851850926068, 6724.49566282521, 6756.324367563205, 6773.525853190328, 6785.626790526569, 5583.302087239095, 5701.344345400332, 5753.338366087954, 6026.246719160105, 6081.604695694766, 3020.4412183746076, 3034.0746072448114, 3322.767406281537, 3469.924323459685, 3541.451075083366, 6737.6968036438475, 6974.38561957629, 7017.298270173044, 7034.472414568928, 7034.753783617549, 5269.0, 6316.810010944444, 6953.200381956039, 6975.9302406975285, 6996.65612019979, 6573.638449885207, 6851.177858656993, 6985.371316581431, 6998.860022799618, 7001.334873187243, 6316.968415157895, 6719.865602688016, 6722.361375669304, 6742.9662851685425, 6745.2446025552845, 5635.8591035224445, 6367.821952938722, 6639.734410623521, 6655.700493477902, 6688.331166883273, 5726.455986681259, 6884.932835410519, 7005.789826305219, 7046.295370462913, 7072.929270707227, 4917.270914642408, 5223.164293712987, 5314.388845282842, 5336.973315133399, 5338.57291416678, 5403.378611459732, 6476.579022363531, 6817.488688348294, 6847.417969472651, 6848.931510685029, 5232.9738351308, 6318.810435686937, 6548.919428294278, 6571.57284776488, 6601.636909969998, 5300.867478313073, 6510.0, 6524.347565243438, 6561.376669216417, 6581.868362632817, 6255.218097737783, 6390.265119511129, 6412.9679351602945, 6421.789105447277, 6458.770614692654, 5238.738063096754, 6505.674716264262, 6525.249596296297, 6549.443297319781, 6561.3438656134, 6407.743690252338, 6424.0, 6433.549651524536, 6445.581037232565, 6468.223813142453], "value": 4925.053118308344, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.7551966973049, 695.0165515795151, 739.6080077558894, 754.6415452659987, 849.5837039850471, 14753.631159221011, 15040.849591504082, 15314.923425382858, 15528.844711552894, 15601.687966240668, 11412.486438110283, 13348.466061357558, 14265.714685706305, 14515.274236288169, 14532.0, 931.8555623878293, 955.3599088610648, 963.3064193780502, 965.0879918477007, 967.2262190247809, 901.8737376767258, 929.4562680831722, 966.2801213096218, 971.8153550825356, 972.6936015155203, 1025.3489034463096, 1025.825609646358, 1034.1623285139062, 1036.507658862042, 1038.5586125896502, 1003.8644782954281, 1028.0798685176762, 1028.7428142964259, 1034.0125180452687, 1037.6005237983354, 773.8065483629093, 774.0943096577018, 775.3215936055951, 777.296546625305, 777.9922200777976, 15427.614309642237, 16295.592610184722, 16467.917660411742, 16485.258163382678, 16540.421085261958, 14415.927920360436, 14765.704685906328, 14801.555953321418, 14832.555023349316, 14851.777223341658, 10045.949770251174, 10418.27072104953, 11141.108711303077, 11198.552057917674, 11612.6516204514, 3760.4547340635727, 3808.2901554403925, 3830.5211848518934, 3926.725129240954, 3941.940870886939, 95076.0, 95286.09427811475, 95936.0, 100375.0, 106955.93044069537, 11353.772924541463, 11375.715607109889, 11559.826602600968, 11752.529898804123, 11913.08129508276, 23692.052317907437, 23755.524889502114, 23940.40148996289, 23985.760142398703, 23993.640095398583, 7735.806604834812, 7746.0, 7820.217978202248, 7854.646540905673, 7937.5237485749885, 3564.625714300013, 4125.773082480492, 4217.768022758778, 4222.366645003212, 4227.471566054243, 3445.9655403446145, 3496.3356962177104, 3509.192885636318, 3529.2764983178386, 3530.91172720684, 627.9262461191414, 631.823089534931, 631.9905201421982, 632.1245075570276, 637.1144109687538, 633.4647223096476, 633.7813454358239, 636.8503401700597, 695.9164900212007, 696.7491702986921, 9612.327137100336, 9720.75698107553, 10047.748806279755, 10054.447005414626, 10260.692179234635, 619.7211254935297, 649.0353649956882, 671.0, 672.8561445542597, 692.3976140757472, 4620.306953956933, 4825.710457372569, 4827.468978412372, 4842.5157484251995, 4849.854504364875, 87070.0, 93081.5345923266, 98332.50833745785, 102347.0, 105064.0, 70757.2924270761, 72006.63996680088, 79068.90707568704, 81611.18388816036, 89017.55491222502, 59895.40104598898, 68464.3153568468, 70505.0, 70777.93833092508, 71309.0, 9084.954575227082, 10887.346759194474, 11107.777844443228, 11136.888631113585, 11221.0, 41864.74405767832, 42685.57314426816, 44166.558334416244, 45354.09291814211, 47694.0, 53826.0, 61450.692746535984, 66420.66789666214, 68591.31408686048, 68813.77455367114, 11402.372869492257, 13262.403191856196, 13382.243592921308, 13834.792478112635, 14056.367463464374, 11555.595554155565, 12182.93869607518, 14446.494372697325, 14670.706585868436, 14799.704005920037, 13387.0, 13470.461181552628, 13560.254186019863, 13584.45662173502, 13761.31193440344, 11768.411579421167, 13657.975651826351, 13743.450261989808, 13836.723265534834, 14033.1580105194, 13076.542321018718, 13456.932715336361, 13474.730505390033, 13932.860671393157, 14027.158370497802, 10885.727856803644, 10977.231593788358, 11053.0, 11062.668119956092, 11901.880981190077, 9394.76513087151, 10391.688249352532, 10483.423411712429, 10537.367757934548, 11011.608953206427], "value": 7530.828323271658, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1561.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 141.0, 119.0, 113.0, 118.0, 119.0, 119.0, 120.0, 121.0, 121.0], "value": 120.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 109.0, 128.0, 154.0, 116.0, 114.0, 113.0, 115.0, 135.0, 114.0], "value": 124.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 200.0, 197.0, 217.0, 206.0, 227.0, 194.0, 198.0, 230.0, 218.0], "value": 207.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 61.0, 60.0, 87.0, 59.0, 65.0, 57.0, 58.0, 74.0, 60.0], "value": 66.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 85.0, 71.0, 72.0, 72.0, 85.0, 70.0, 88.0, 116.0], "value": 81.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 87.0, 118.0, 117.0, 137.0, 88.0, 87.0, 89.0, 89.0], "value": 98.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 95.0, 96.0, 94.0, 95.0, 155.0, 96.0, 97.0], "value": 101.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 93.0, 92.0, 93.0, 119.0, 143.0, 94.0, 92.0, 92.0, 94.0], "value": 100.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 68.0, 67.0, 66.0, 68.0, 67.0, 68.0, 66.0, 67.0], "value": 66.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 71.0, 65.0, 54.0, 58.0, 58.0, 58.0, 59.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 73.0, 106.0, 108.0, 94.0, 75.0, 84.0, 110.0, 104.0, 108.0], "value": 96.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 160.0, 155.0, 149.0, 161.0, 158.0, 153.0, 139.0, 187.0, 141.0], "value": 155.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 187.0, 213.0, 190.0, 186.0, 184.0, 243.0, 234.0, 216.0, 189.0], "value": 202.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 99.0, 68.0, 70.0, 69.0, 67.0, 69.0, 83.0, 94.0, 103.0], "value": 78.7, "unit": "score"}]}]} 16:20:43 INFO - Return code: 0 16:20:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:20:43 ERROR - # TBPL SUCCESS # 16:20:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:20:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:20:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:20:43 INFO - 2017-03-15 16:20:43.496 screenresolution[1655:10777] starting screenresolution argv=screenresolution get 16:20:43 INFO - 2017-03-15 16:20:43.498 screenresolution[1655:10777] Display 0: 1600x1200x32@60 16:20:43 INFO - 2017-03-15 16:20:43.505 screenresolution[1656:10780] starting screenresolution argv=screenresolution list 16:20:43 INFO - Available Modes on Display 0 16:20:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:20:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:20:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:20:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:20:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:20:43 INFO - Intel Iris: 16:20:43 INFO - Chipset Model: Intel Iris 16:20:43 INFO - Type: GPU 16:20:43 INFO - Bus: Built-In 16:20:43 INFO - VRAM (Dynamic, Max): 1536 MB 16:20:43 INFO - Vendor: Intel (0x8086) 16:20:43 INFO - Device ID: 0x0a2e 16:20:43 INFO - Revision ID: 0x0009 16:20:43 INFO - Displays: 16:20:43 INFO - Display: 16:20:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:20:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:20:43 INFO - Display Serial Number: 1600x1200 60 16:20:43 INFO - Main Display: Yes 16:20:43 INFO - Mirror: Off 16:20:43 INFO - Online: Yes 16:20:43 INFO - Rotation: Supported 16:20:43 INFO - Return code: 0 16:20:43 INFO - Running post-action listener: _resource_record_post_action 16:20:43 INFO - [mozharness: 2017-03-15 23:20:43.746107Z] Finished run-tests step (success) 16:20:43 INFO - Running post-run listener: _resource_record_post_run 16:20:43 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 38857216; Write bytes: 515031040; Read time: 459; Write time: 1960 16:20:43 INFO - TinderboxPrint: CPU usage
54.2% 16:20:43 INFO - TinderboxPrint: I/O read bytes / time
38,857,216 / 459 16:20:43 INFO - TinderboxPrint: I/O write bytes / time
515,031,040 / 1,960 16:20:43 INFO - TinderboxPrint: CPU idle
2,199.7 (45.8%) 16:20:43 INFO - TinderboxPrint: CPU system
963.9 (20.1%) 16:20:43 INFO - TinderboxPrint: CPU user
1,634.1 (34.1%) 16:20:43 INFO - TinderboxPrint: Swap in / out
249,303,040 / 0 16:20:43 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205908480; Write bytes: 202900992; Read time: 15689; Write time: 395 16:20:43 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 36846080; Write bytes: 301263360; Read time: 438; Write time: 1531 16:20:44 INFO - Running post-run listener: _upload_blobber_files 16:20:44 INFO - Blob upload gear active. 16:20:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:20:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:20:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:20:44 INFO - (blobuploader) - INFO - Open directory for files ... 16:20:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:20:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:20:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:20:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:20:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:20:45 INFO - (blobuploader) - INFO - Done attempting. 16:20:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:20:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:20:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:20:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:20:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:20:46 INFO - (blobuploader) - INFO - Done attempting. 16:20:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:20:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:20:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:20:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:20:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:20:48 INFO - (blobuploader) - INFO - Done attempting. 16:20:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:20:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:20:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:20:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:20:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:20:50 INFO - (blobuploader) - INFO - Done attempting. 16:20:50 INFO - (blobuploader) - INFO - Iteration through files over. 16:20:50 INFO - Return code: 0 16:20:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:20:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:20:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/271961bef68f1ea101de6d8feb8abd890cdd1db899199fae5847dd26ea87671dfb8b2e904fccedc928816812b5fac1977c2cbca28239537a8b04d3a729d39334", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9748d4cec79e52cfa3fade1f1bc047c66de56296fda8473b1c2a8d723652c005c0305cafe4c091b9a66cd8ebc53a58a9dda10eef9ba280618a194cf9e5b750e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/847a66e647fd0b956b71d4d0797b8053ad702f15248f7f4ef406fff0a839d9a4224c66b5a19d15e650b1feb126e79c37275fba78280507443809495cd26d2722", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ceded566f9e6899e53bf3a7abd4bb8acf186f13059bd2d922df86b232f999924f1c54e74faa066e68f0f9b4c86fdce1c4d9a833a15e1ca3f50622cdf886d64ff"} 16:20:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:20:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:20:50 INFO - Contents: 16:20:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/271961bef68f1ea101de6d8feb8abd890cdd1db899199fae5847dd26ea87671dfb8b2e904fccedc928816812b5fac1977c2cbca28239537a8b04d3a729d39334", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9748d4cec79e52cfa3fade1f1bc047c66de56296fda8473b1c2a8d723652c005c0305cafe4c091b9a66cd8ebc53a58a9dda10eef9ba280618a194cf9e5b750e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/847a66e647fd0b956b71d4d0797b8053ad702f15248f7f4ef406fff0a839d9a4224c66b5a19d15e650b1feb126e79c37275fba78280507443809495cd26d2722", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ceded566f9e6899e53bf3a7abd4bb8acf186f13059bd2d922df86b232f999924f1c54e74faa066e68f0f9b4c86fdce1c4d9a833a15e1ca3f50622cdf886d64ff"} 16:20:50 INFO - Running post-run listener: copy_logs_to_upload_dir 16:20:50 INFO - Copying logs to upload dir... 16:20:50 INFO - mkdir: /builds/slave/test/build/upload/logs 16:20:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.714809 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-15 16:20:50.796863) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-15 16:20:50.802334) ========= 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.QF4NzQeRw1/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.Lh2mXNdPaY/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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/271961bef68f1ea101de6d8feb8abd890cdd1db899199fae5847dd26ea87671dfb8b2e904fccedc928816812b5fac1977c2cbca28239537a8b04d3a729d39334", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9748d4cec79e52cfa3fade1f1bc047c66de56296fda8473b1c2a8d723652c005c0305cafe4c091b9a66cd8ebc53a58a9dda10eef9ba280618a194cf9e5b750e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/847a66e647fd0b956b71d4d0797b8053ad702f15248f7f4ef406fff0a839d9a4224c66b5a19d15e650b1feb126e79c37275fba78280507443809495cd26d2722", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ceded566f9e6899e53bf3a7abd4bb8acf186f13059bd2d922df86b232f999924f1c54e74faa066e68f0f9b4c86fdce1c4d9a833a15e1ca3f50622cdf886d64ff"} build_url:https://queue.taskcluster.net/v1/task/FexCcSDiTeiLFAxIJoTGqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011081 build_url: 'https://queue.taskcluster.net/v1/task/FexCcSDiTeiLFAxIJoTGqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/271961bef68f1ea101de6d8feb8abd890cdd1db899199fae5847dd26ea87671dfb8b2e904fccedc928816812b5fac1977c2cbca28239537a8b04d3a729d39334", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9748d4cec79e52cfa3fade1f1bc047c66de56296fda8473b1c2a8d723652c005c0305cafe4c091b9a66cd8ebc53a58a9dda10eef9ba280618a194cf9e5b750e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/847a66e647fd0b956b71d4d0797b8053ad702f15248f7f4ef406fff0a839d9a4224c66b5a19d15e650b1feb126e79c37275fba78280507443809495cd26d2722", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ceded566f9e6899e53bf3a7abd4bb8acf186f13059bd2d922df86b232f999924f1c54e74faa066e68f0f9b4c86fdce1c4d9a833a15e1ca3f50622cdf886d64ff"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-15 16:20:50.836612) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 16:20:50.836924) ========= 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.QF4NzQeRw1/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.Lh2mXNdPaY/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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.005010 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 16:20:50.884629) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-15 16:20:50.884937) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-15 16:20:50.885235) ========= ========= Total master_lag: 0.18 =========