builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0034 starttime: 1484090055.15 results: success (0) buildid: 20170110135305 builduid: f6379935fddb4424b063583578133854 revision: 20094311ab5ec56d5be7afc6d5c2e2b09e656fb2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 15:14:15.153686) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 15:14:15.154222) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 15:14:15.154545) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 15:14:15.181367) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 15:14:15.181793) ========= 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.Cd889FpU3Q/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.B5CrLjHGUU/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-10 15:14:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.14M=0.001s 2017-01-10 15:14:15 (8.14 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120164 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 15:14:15.328615) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 15:14:15.329078) ========= 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.Cd889FpU3Q/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.B5CrLjHGUU/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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.020828 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 15:14:15.379137) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-10 15:14:15.379536) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 20094311ab5ec56d5be7afc6d5c2e2b09e656fb2 --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 20094311ab5ec56d5be7afc6d5c2e2b09e656fb2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Cd889FpU3Q/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.B5CrLjHGUU/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-10 15:14:15,464 truncating revision to first 12 chars 2017-01-10 15:14:15,464 Setting DEBUG logging. 2017-01-10 15:14:15,464 attempt 1/10 2017-01-10 15:14:15,464 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/20094311ab5e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-10 15:14:16,762 unpacking tar archive at: mozilla-central-20094311ab5e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.568078 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-10 15:14:16.971968) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 15:14:16.972341) ========= script_repo_revision: 20094311ab5ec56d5be7afc6d5c2e2b09e656fb2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 15:14:16.972818) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 15:14:16.973139) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 15:14:16.993706) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2017-01-10 15:14:16.994051) ========= /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.Cd889FpU3Q/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.B5CrLjHGUU/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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:14:17 INFO - MultiFileLogger online at 20170110 15:14:17 in /builds/slave/test 15:14:17 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:14:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:14:17 INFO - {'append_to_log': False, 15:14:17 INFO - 'base_work_dir': '/builds/slave/test', 15:14:17 INFO - 'blob_upload_branch': 'Firefox', 15:14:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:14:17 INFO - 'branch': 'Firefox', 15:14:17 INFO - 'buildbot_json_path': 'buildprops.json', 15:14:17 INFO - 'config_files': ('talos/mac_config.py',), 15:14:17 INFO - 'default_actions': ('clobber', 15:14:17 INFO - 'read-buildbot-config', 15:14:17 INFO - 'download-and-extract', 15:14:17 INFO - 'populate-webroot', 15:14:17 INFO - 'create-virtualenv', 15:14:17 INFO - 'install', 15:14:17 INFO - 'run-tests'), 15:14:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:14:17 INFO - 'download_minidump_stackwalk': True, 15:14:17 INFO - 'download_symbols': 'ondemand', 15:14:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:14:17 INFO - 'tooltool.py': '/tools/tooltool.py', 15:14:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:14:17 INFO - '/tools/misc-python/virtualenv.py')}, 15:14:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:14:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:14:17 INFO - 'installer_path': 'installer.exe', 15:14:17 INFO - 'log_level': 'info', 15:14:17 INFO - 'log_name': 'talos', 15:14:17 INFO - 'log_to_console': True, 15:14:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:14:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:14:17 INFO - 'opt_config_files': (), 15:14:17 INFO - 'pip_index': False, 15:14:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:14:17 INFO - 'cmd': ('bash', 15:14:17 INFO - '-c', 15:14:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:14:17 INFO - 'enabled': True, 15:14:17 INFO - 'halt_on_failure': False, 15:14:17 INFO - 'name': 'check_screen_resolution'},), 15:14:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:14:17 INFO - 'cmd': ('bash', 15:14:17 INFO - '-c', 15:14:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:14:17 INFO - 'enabled': True, 15:14:17 INFO - 'halt_on_failure': False, 15:14:17 INFO - 'name': 'check_screen_resolution'},), 15:14:17 INFO - 'run_cmd_checks_enabled': True, 15:14:17 INFO - 'sps_profile': False, 15:14:17 INFO - 'sps_profile_interval': 0, 15:14:17 INFO - 'suite': 'dromaeojs-e10s', 15:14:17 INFO - 'system_bits': '32', 15:14:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:14:17 INFO - 'title': 't-yosemite-r7-0034', 15:14:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:14:17 INFO - 'use_talos_json': True, 15:14:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:14:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:14:17 INFO - 'work_dir': 'build'} 15:14:17 INFO - [mozharness: 2017-01-10 23:14:17.211496Z] Running clobber step. 15:14:17 INFO - Running pre-action listener: _resource_record_pre_action 15:14:17 INFO - Running main action method: clobber 15:14:17 INFO - rmtree: /builds/slave/test/build 15:14:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:14:18 INFO - Running post-action listener: _resource_record_post_action 15:14:18 INFO - [mozharness: 2017-01-10 23:14:18.888104Z] Finished clobber step (success) 15:14:18 INFO - [mozharness: 2017-01-10 23:14:18.888280Z] Running read-buildbot-config step. 15:14:18 INFO - Running pre-action listener: _resource_record_pre_action 15:14:18 INFO - Running main action method: read_buildbot_config 15:14:18 INFO - Using buildbot properties: 15:14:18 INFO - { 15:14:18 INFO - "project": "", 15:14:18 INFO - "product": "firefox", 15:14:18 INFO - "script_repo_revision": "production", 15:14:18 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 15:14:18 INFO - "repository": "", 15:14:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 15:14:18 INFO - "buildid": "20170110135305", 15:14:18 INFO - "pgo_build": "False", 15:14:18 INFO - "basedir": "/builds/slave/test", 15:14:18 INFO - "buildnumber": 43, 15:14:18 INFO - "slavename": "t-yosemite-r7-0034", 15:14:18 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 15:14:18 INFO - "platform": "yosemite_r7", 15:14:18 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:14:18 INFO - "branch": "mozilla-central", 15:14:18 INFO - "repo_path": "mozilla-central", 15:14:18 INFO - "revision": "20094311ab5ec56d5be7afc6d5c2e2b09e656fb2", 15:14:18 INFO - "stage_platform": "macosx64", 15:14:18 INFO - "builduid": "f6379935fddb4424b063583578133854", 15:14:18 INFO - "slavebuilddir": "test" 15:14:18 INFO - } 15:14:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q2hg10i3R7WjSq_Li1M6aA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 15:14:18 INFO - Running post-action listener: _resource_record_post_action 15:14:18 INFO - [mozharness: 2017-01-10 23:14:18.891801Z] Finished read-buildbot-config step (success) 15:14:18 INFO - [mozharness: 2017-01-10 23:14:18.891954Z] Running download-and-extract step. 15:14:18 INFO - Running pre-action listener: _resource_record_pre_action 15:14:18 INFO - Running main action method: download_and_extract 15:14:18 INFO - mkdir: /builds/slave/test/build/tests 15:14:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:14:18 INFO - trying https://queue.taskcluster.net/v1/task/Q2hg10i3R7WjSq_Li1M6aA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 15:14:18 INFO - Downloading https://queue.taskcluster.net/v1/task/Q2hg10i3R7WjSq_Li1M6aA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 15:14:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q2hg10i3R7WjSq_Li1M6aA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 15:14:19 INFO - Downloaded 1199 bytes. 15:14:19 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 15:14:19 INFO - Using the following test package requirements: 15:14:19 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 15:14:19 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:14:19 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 15:14:19 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:14:19 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 15:14:19 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:14:19 INFO - u'jsshell-mac.zip'], 15:14:19 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:14:19 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 15:14:19 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 15:14:19 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:14:19 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 15:14:19 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:14:19 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 15:14:19 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:14:19 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 15:14:19 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:14:19 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 15:14:19 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:14:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q2hg10i3R7WjSq_Li1M6aA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 15:14:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q2hg10i3R7WjSq_Li1M6aA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:14:19 INFO - Fetch https://queue.taskcluster.net/v1/task/Q2hg10i3R7WjSq_Li1M6aA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 15:14:20 INFO - Expected file size: 16309981 15:14:20 INFO - Obtained file size: 16309981 15:14:27 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:14:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q2hg10i3R7WjSq_Li1M6aA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 15:14:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q2hg10i3R7WjSq_Li1M6aA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:14:27 INFO - Fetch https://queue.taskcluster.net/v1/task/Q2hg10i3R7WjSq_Li1M6aA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 15:14:28 INFO - Expected file size: 16309981 15:14:28 INFO - Obtained file size: 16309981 15:14:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q2hg10i3R7WjSq_Li1M6aA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 15:14:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q2hg10i3R7WjSq_Li1M6aA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:14:35 INFO - Fetch https://queue.taskcluster.net/v1/task/Q2hg10i3R7WjSq_Li1M6aA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 15:14:37 INFO - Expected file size: 14403529 15:14:37 INFO - Obtained file size: 14403529 15:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:14:37 INFO - trying https://queue.taskcluster.net/v1/task/Q2hg10i3R7WjSq_Li1M6aA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 15:14:37 INFO - Downloading https://queue.taskcluster.net/v1/task/Q2hg10i3R7WjSq_Li1M6aA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 15:14:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q2hg10i3R7WjSq_Li1M6aA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 15:14:39 INFO - Downloaded 69712218 bytes. 15:14:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q2hg10i3R7WjSq_Li1M6aA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 15:14:39 INFO - mkdir: /builds/slave/test/properties 15:14:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:14:39 INFO - Writing to file /builds/slave/test/properties/build_url 15:14:39 INFO - Contents: 15:14:39 INFO - build_url:https://queue.taskcluster.net/v1/task/Q2hg10i3R7WjSq_Li1M6aA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 15:14:41 INFO - Running post-action listener: _resource_record_post_action 15:14:41 INFO - Running post-action listener: set_extra_try_arguments 15:14:41 INFO - [mozharness: 2017-01-10 23:14:41.003561Z] Finished download-and-extract step (success) 15:14:41 INFO - [mozharness: 2017-01-10 23:14:41.003733Z] Running populate-webroot step. 15:14:41 INFO - Running pre-action listener: _resource_record_pre_action 15:14:41 INFO - Running main action method: populate_webroot 15:14:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:14:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:14:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:14:41 INFO - '--tppagecycles', 15:14:41 INFO - '7'], 15:14:41 INFO - 'tests': ['tsvgm']}}, 15:14:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:14:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:14:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:14:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:14:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:14:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:14:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:14:41 INFO - 'talos_options': ['--disable-e10s'], 15:14:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:14:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:14:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:14:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:14:41 INFO - 'talos_options': ['--disable-e10s'], 15:14:41 INFO - 'tests': ['damp', 'tps']}, 15:14:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:14:41 INFO - 'tests': ['damp', 'tps']}, 15:14:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:14:41 INFO - 'tests': ['dromaeo_dom']}, 15:14:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:14:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:14:41 INFO - 'tests': ['basic_compositor_video']}, 15:14:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:14:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:14:41 INFO - 'tests': ['a11yr', 15:14:41 INFO - 'ts_paint', 15:14:41 INFO - 'tpaint', 15:14:41 INFO - 'sessionrestore', 15:14:41 INFO - 'sessionrestore_no_auto_restore', 15:14:41 INFO - 'tabpaint']}, 15:14:41 INFO - 'other-e10s': {'tests': ['a11yr', 15:14:41 INFO - 'ts_paint', 15:14:41 INFO - 'tpaint', 15:14:41 INFO - 'sessionrestore', 15:14:41 INFO - 'sessionrestore_no_auto_restore', 15:14:41 INFO - 'tabpaint']}, 15:14:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:14:41 INFO - 'ts_paint', 15:14:41 INFO - 'tpaint', 15:14:41 INFO - 'sessionrestore', 15:14:41 INFO - 'sessionrestore_no_auto_restore', 15:14:41 INFO - 'tabpaint']}, 15:14:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:14:41 INFO - 'ts_paint', 15:14:41 INFO - 'tpaint', 15:14:41 INFO - 'sessionrestore', 15:14:41 INFO - 'sessionrestore_no_auto_restore', 15:14:41 INFO - 'tabpaint']}, 15:14:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:14:41 INFO - 'tests': ['a11yr', 15:14:41 INFO - 'ts_paint', 15:14:41 INFO - 'tpaint', 15:14:41 INFO - 'sessionrestore', 15:14:41 INFO - 'sessionrestore_no_auto_restore', 15:14:41 INFO - 'tabpaint']}, 15:14:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:14:41 INFO - 'tests': ['a11yr', 15:14:41 INFO - 'ts_paint', 15:14:41 INFO - 'tpaint', 15:14:41 INFO - 'sessionrestore', 15:14:41 INFO - 'sessionrestore_no_auto_restore', 15:14:41 INFO - 'tabpaint']}, 15:14:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:14:41 INFO - 'tests': ['tsvgx', 15:14:41 INFO - 'tsvgr_opacity', 15:14:41 INFO - 'tart', 15:14:41 INFO - 'tscrollx', 15:14:41 INFO - 'cart', 15:14:41 INFO - 'tsvg_static']}, 15:14:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:14:41 INFO - 'tsvgr_opacity', 15:14:41 INFO - 'tart', 15:14:41 INFO - 'tscrollx', 15:14:41 INFO - 'cart', 15:14:41 INFO - 'tsvg_static']}, 15:14:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:14:41 INFO - 'talos_options': ['--disable-e10s'], 15:14:41 INFO - 'tests': ['tp5o']}, 15:14:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:14:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:14:41 INFO - 'talos_options': ['--disable-e10s', 15:14:41 INFO - '--xperf_path', 15:14:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:14:41 INFO - 'tests': ['tp5n']}, 15:14:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:14:41 INFO - 'talos_options': ['--xperf_path', 15:14:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:14:41 INFO - 'tests': ['tp5n']}}, 15:14:41 INFO - 'talos.zip': {'path': '', 15:14:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:14:41 INFO - Running post-action listener: _resource_record_post_action 15:14:41 INFO - [mozharness: 2017-01-10 23:14:41.023191Z] Finished populate-webroot step (success) 15:14:41 INFO - [mozharness: 2017-01-10 23:14:41.023341Z] Running create-virtualenv step. 15:14:41 INFO - Running pre-action listener: _resource_record_pre_action 15:14:41 INFO - Running main action method: create_virtualenv 15:14:41 INFO - Creating virtualenv /builds/slave/test/build/venv 15:14:41 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 15:14:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:14:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:14:41 INFO - Using real prefix '/tools/python27' 15:14:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:14:41 INFO - Installing distribute.............................................................................................................................................................................................done. 15:14:44 INFO - Installing pip.................done. 15:14:44 INFO - Return code: 0 15:14:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:14:45 INFO - Reading from file tmpfile_stdout 15:14:45 INFO - Output received: 15:14:45 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) 15:14:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:14:45 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:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:45 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:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:45 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 0x10bcf3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcf6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fe35737e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bad1d30>, '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 0x10b9f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bac6be8>, '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.Cd889FpU3Q/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.B5CrLjHGUU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 15:14:45 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 15:14:45 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 15:14:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cd889FpU3Q/Render', 15:14:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:14:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:14:45 INFO - 'HOME': '/Users/cltbld', 15:14:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:14:45 INFO - 'LOGNAME': 'cltbld', 15:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:45 INFO - 'MOZ_NO_REMOTE': '1', 15:14:45 INFO - 'NO_EM_RESTART': '1', 15:14:45 INFO - 'PAGER': '/bin/cat', 15:14:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:45 INFO - 'PWD': '/builds/slave/test', 15:14:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:14:45 INFO - 'SHELL': '/bin/bash', 15:14:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B5CrLjHGUU/Listeners', 15:14:45 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 15:14:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:14:45 INFO - 'USER': 'cltbld', 15:14:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:14:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:45 INFO - 'XPC_FLAGS': '0x0', 15:14:45 INFO - 'XPC_SERVICE_NAME': '0', 15:14:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:14:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:45 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 15:14:45 INFO - Cleaning up... 15:14:45 INFO - Return code: 0 15:14:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:14:45 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:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:45 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:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:45 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 0x10bcf3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcf6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fe35737e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bad1d30>, '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 0x10b9f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bac6be8>, '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.Cd889FpU3Q/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.B5CrLjHGUU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 15:14:45 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 15:14:45 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 15:14:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cd889FpU3Q/Render', 15:14:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:14:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:14:45 INFO - 'HOME': '/Users/cltbld', 15:14:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:14:45 INFO - 'LOGNAME': 'cltbld', 15:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:45 INFO - 'MOZ_NO_REMOTE': '1', 15:14:45 INFO - 'NO_EM_RESTART': '1', 15:14:45 INFO - 'PAGER': '/bin/cat', 15:14:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:45 INFO - 'PWD': '/builds/slave/test', 15:14:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:14:45 INFO - 'SHELL': '/bin/bash', 15:14:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B5CrLjHGUU/Listeners', 15:14:45 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 15:14:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:14:45 INFO - 'USER': 'cltbld', 15:14:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:14:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:45 INFO - 'XPC_FLAGS': '0x0', 15:14:45 INFO - 'XPC_SERVICE_NAME': '0', 15:14:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:14:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:45 INFO - Downloading/unpacking psutil>=3.1.1 15:14:45 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 15:14:45 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 15:14:45 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 15:14:45 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 15:14:45 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 15:14:45 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 15:14:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:14:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:14:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:14:49 INFO - Installing collected packages: psutil 15:14:49 INFO - Running setup.py install for psutil 15:14:49 INFO - building 'psutil._psutil_osx' extension 15:14:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 15:14:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:14:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:14:49 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 15:14:49 INFO - building 'psutil._psutil_posix' extension 15:14:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 15:14:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:14:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:14:50 INFO - ^ 15:14:50 INFO - 1 warning generated. 15:14:50 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 15:14:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:14:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:14:50 INFO - Successfully installed psutil 15:14:50 INFO - Cleaning up... 15:14:50 INFO - Return code: 0 15:14:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bcf3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcf6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fe35737e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bad1d30>, '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 0x10b9f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bac6be8>, '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.Cd889FpU3Q/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.B5CrLjHGUU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 15:14:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:14:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cd889FpU3Q/Render', 15:14:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:14:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:14:50 INFO - 'HOME': '/Users/cltbld', 15:14:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:14:50 INFO - 'LOGNAME': 'cltbld', 15:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:50 INFO - 'MOZ_NO_REMOTE': '1', 15:14:50 INFO - 'NO_EM_RESTART': '1', 15:14:50 INFO - 'PAGER': '/bin/cat', 15:14:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:50 INFO - 'PWD': '/builds/slave/test', 15:14:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:14:50 INFO - 'SHELL': '/bin/bash', 15:14:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B5CrLjHGUU/Listeners', 15:14:50 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 15:14:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:14:50 INFO - 'USER': 'cltbld', 15:14:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:14:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:50 INFO - 'XPC_FLAGS': '0x0', 15:14:50 INFO - 'XPC_SERVICE_NAME': '0', 15:14:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:14:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:14:50 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 15:14:50 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 15:14:50 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 15:14:50 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 15:14:50 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 15:14:50 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 15:14:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:14:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:14:53 INFO - Installing collected packages: mozsystemmonitor 15:14:53 INFO - Running setup.py install for mozsystemmonitor 15:14:53 INFO - Successfully installed mozsystemmonitor 15:14:53 INFO - Cleaning up... 15:14:53 INFO - Return code: 0 15:14:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:14:53 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:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:53 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:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:53 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 0x10bcf3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcf6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fe35737e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bad1d30>, '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 0x10b9f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bac6be8>, '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.Cd889FpU3Q/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.B5CrLjHGUU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 15:14:53 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 15:14:53 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 15:14:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cd889FpU3Q/Render', 15:14:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:14:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:14:53 INFO - 'HOME': '/Users/cltbld', 15:14:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:14:53 INFO - 'LOGNAME': 'cltbld', 15:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:53 INFO - 'MOZ_NO_REMOTE': '1', 15:14:53 INFO - 'NO_EM_RESTART': '1', 15:14:53 INFO - 'PAGER': '/bin/cat', 15:14:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:53 INFO - 'PWD': '/builds/slave/test', 15:14:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:14:53 INFO - 'SHELL': '/bin/bash', 15:14:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B5CrLjHGUU/Listeners', 15:14:53 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 15:14:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:14:53 INFO - 'USER': 'cltbld', 15:14:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:14:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:53 INFO - 'XPC_FLAGS': '0x0', 15:14:53 INFO - 'XPC_SERVICE_NAME': '0', 15:14:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:53 INFO - Downloading/unpacking jsonschema==2.5.1 15:14:53 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 15:14:53 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 15:14:53 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 15:14:53 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 15:14:53 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 15:14:53 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 15:14:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:14:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:56 INFO - Downloading functools32-3.2.3-2.tar.gz 15:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:14:57 INFO - warning: no files found matching '*.txt' 15:14:57 INFO - no previously-included directories found matching 'build' 15:14:57 INFO - no previously-included directories found matching 'dist' 15:14:57 INFO - no previously-included directories found matching '.git*' 15:14:57 INFO - Installing collected packages: jsonschema, functools32 15:14:57 INFO - Running setup.py install for functools32 15:14:57 INFO - warning: no files found matching '*.txt' 15:14:57 INFO - no previously-included directories found matching 'build' 15:14:57 INFO - no previously-included directories found matching 'dist' 15:14:57 INFO - no previously-included directories found matching '.git*' 15:14:57 INFO - Successfully installed jsonschema functools32 15:14:57 INFO - Cleaning up... 15:14:57 INFO - Return code: 0 15:14:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:14:57 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:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:57 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:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:57 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 0x10bcf3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcf6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fe35737e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bad1d30>, '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 0x10b9f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bac6be8>, '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.Cd889FpU3Q/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.B5CrLjHGUU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 15:14:57 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 15:14:57 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 15:14:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cd889FpU3Q/Render', 15:14:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:14:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:14:57 INFO - 'HOME': '/Users/cltbld', 15:14:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:14:57 INFO - 'LOGNAME': 'cltbld', 15:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:57 INFO - 'MOZ_NO_REMOTE': '1', 15:14:57 INFO - 'NO_EM_RESTART': '1', 15:14:57 INFO - 'PAGER': '/bin/cat', 15:14:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:57 INFO - 'PWD': '/builds/slave/test', 15:14:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:14:57 INFO - 'SHELL': '/bin/bash', 15:14:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B5CrLjHGUU/Listeners', 15:14:57 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 15:14:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:14:57 INFO - 'USER': 'cltbld', 15:14:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:14:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:57 INFO - 'XPC_FLAGS': '0x0', 15:14:57 INFO - 'XPC_SERVICE_NAME': '0', 15:14:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:14:57 INFO - Cleaning up... 15:14:57 INFO - Return code: 0 15:14:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:14:57 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:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:57 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:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:57 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 0x10bcf3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcf6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fe35737e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bad1d30>, '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 0x10b9f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bac6be8>, '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.Cd889FpU3Q/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.B5CrLjHGUU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 15:14:57 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 15:14:57 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 15:14:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cd889FpU3Q/Render', 15:14:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:14:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:14:57 INFO - 'HOME': '/Users/cltbld', 15:14:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:14:57 INFO - 'LOGNAME': 'cltbld', 15:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:57 INFO - 'MOZ_NO_REMOTE': '1', 15:14:57 INFO - 'NO_EM_RESTART': '1', 15:14:57 INFO - 'PAGER': '/bin/cat', 15:14:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:57 INFO - 'PWD': '/builds/slave/test', 15:14:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:14:57 INFO - 'SHELL': '/bin/bash', 15:14:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B5CrLjHGUU/Listeners', 15:14:57 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 15:14:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:14:57 INFO - 'USER': 'cltbld', 15:14:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:14:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:57 INFO - 'XPC_FLAGS': '0x0', 15:14:57 INFO - 'XPC_SERVICE_NAME': '0', 15:14:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:57 INFO - Downloading/unpacking blobuploader==1.2.4 15:14:57 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 15:14:57 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 15:14:57 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 15:14:57 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 15:14:57 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 15:14:57 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 15:15:00 INFO - Downloading blobuploader-1.2.4.tar.gz 15:15:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:15:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:15:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:15:01 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 15:15:01 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 15:15:01 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 15:15:01 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 15:15:01 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 15:15:01 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 15:15:01 INFO - Downloading docopt-0.6.1.tar.gz 15:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:15:01 INFO - Installing collected packages: blobuploader, requests, docopt 15:15:01 INFO - Running setup.py install for blobuploader 15:15:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:15:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:15:02 INFO - Running setup.py install for requests 15:15:02 INFO - Running setup.py install for docopt 15:15:02 INFO - Successfully installed blobuploader requests docopt 15:15:02 INFO - Cleaning up... 15:15:02 INFO - Return code: 0 15:15:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:02 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 0x10bcf3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcf6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fe35737e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bad1d30>, '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 0x10b9f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bac6be8>, '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.Cd889FpU3Q/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.B5CrLjHGUU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 15:15:02 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 15:15:02 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 15:15:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cd889FpU3Q/Render', 15:15:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:02 INFO - 'HOME': '/Users/cltbld', 15:15:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:02 INFO - 'LOGNAME': 'cltbld', 15:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:02 INFO - 'MOZ_NO_REMOTE': '1', 15:15:02 INFO - 'NO_EM_RESTART': '1', 15:15:02 INFO - 'PAGER': '/bin/cat', 15:15:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:02 INFO - 'PWD': '/builds/slave/test', 15:15:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:02 INFO - 'SHELL': '/bin/bash', 15:15:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B5CrLjHGUU/Listeners', 15:15:02 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 15:15:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:02 INFO - 'USER': 'cltbld', 15:15:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:02 INFO - 'XPC_FLAGS': '0x0', 15:15:02 INFO - 'XPC_SERVICE_NAME': '0', 15:15:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:15:03 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-IJonlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:15:03 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-o1Dhmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:15:03 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-6EXHRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:15:03 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-Gsehrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:15:03 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-_omu3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:15:03 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-1j0g04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:15:03 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-ljYtSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:15:03 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-TPvSf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:15:04 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-JAVAVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:15:04 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-YnwMrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:15:04 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-aMt6WZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:15:04 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-XtO3E2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:15:04 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-8QFd6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:15:04 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-Tymmsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:04 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-iiZ677-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:15:04 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-Ak3tYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:15:04 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-81Pv2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:15:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:15:05 INFO - Running setup.py install for manifestparser 15:15:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:15:05 INFO - Running setup.py install for mozcrash 15:15:05 INFO - Running setup.py install for mozdebug 15:15:05 INFO - Running setup.py install for mozdevice 15:15:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:15:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:15:05 INFO - Running setup.py install for mozfile 15:15:05 INFO - Running setup.py install for mozhttpd 15:15:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:15:05 INFO - Running setup.py install for mozinfo 15:15:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:15:06 INFO - Running setup.py install for mozInstall 15:15:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:15:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:15:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:15:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:15:06 INFO - Running setup.py install for mozleak 15:15:06 INFO - Running setup.py install for mozlog 15:15:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:15:06 INFO - Running setup.py install for moznetwork 15:15:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:15:06 INFO - Running setup.py install for mozprocess 15:15:06 INFO - Running setup.py install for mozprofile 15:15:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:15:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:15:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:15:07 INFO - Running setup.py install for mozrunner 15:15:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:15:07 INFO - Running setup.py install for mozscreenshot 15:15:07 INFO - Running setup.py install for moztest 15:15:07 INFO - Running setup.py install for mozversion 15:15:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:15:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:15:07 INFO - Cleaning up... 15:15:07 INFO - Return code: 0 15:15:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:15: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')]} 15:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15: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')]} 15:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:07 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 0x10bcf3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcf6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fe35737e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bad1d30>, '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 0x10b9f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bac6be8>, '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.Cd889FpU3Q/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.B5CrLjHGUU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 15:15:07 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 15:15:07 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 15:15:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cd889FpU3Q/Render', 15:15:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:07 INFO - 'HOME': '/Users/cltbld', 15:15:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:07 INFO - 'LOGNAME': 'cltbld', 15:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:07 INFO - 'MOZ_NO_REMOTE': '1', 15:15:07 INFO - 'NO_EM_RESTART': '1', 15:15:07 INFO - 'PAGER': '/bin/cat', 15:15:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:07 INFO - 'PWD': '/builds/slave/test', 15:15:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:07 INFO - 'SHELL': '/bin/bash', 15:15:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B5CrLjHGUU/Listeners', 15:15:07 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 15:15:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:07 INFO - 'USER': 'cltbld', 15:15:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:07 INFO - 'XPC_FLAGS': '0x0', 15:15:07 INFO - 'XPC_SERVICE_NAME': '0', 15:15:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:15:08 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-T7WdN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:15:08 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)) 15:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:15:08 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-V8qHrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:15:08 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)) 15:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:15:08 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-2f8MPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:15:08 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)) 15:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:15:08 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-MaViPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:15:08 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)) 15:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:15:08 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-isPTWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:15:08 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)) 15:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:15:08 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-o3Y6q_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:15:08 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)) 15:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:15:08 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-fVh2hb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:15:08 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)) 15:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:15:08 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-a5Os63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:15:08 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)) 15:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:15:08 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-PFFjDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:15:09 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)) 15:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:15:09 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-KVYc1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:15:09 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)) 15:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:15:09 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-gwqOA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:15:09 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)) 15:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:15:09 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-_oGS6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:15:09 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-9Sh1Ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:15:09 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)) 15:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:15:09 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-3a068x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:15:09 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)) 15:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:09 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-J72bTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:09 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)) 15:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:15:09 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-cWoDR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:15:09 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)) 15:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:15:09 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-p7cYjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:15:09 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)) 15:15:09 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)) 15:15:09 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)) 15:15:09 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)) 15:15:09 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)) 15:15:09 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)) 15:15:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:15:09 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 15:15:09 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 15:15:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:12 INFO - Downloading blessings-1.6.tar.gz 15:15:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:15:12 INFO - Installing collected packages: blessings 15:15:12 INFO - Running setup.py install for blessings 15:15:12 INFO - Successfully installed blessings 15:15:12 INFO - Cleaning up... 15:15:13 INFO - Return code: 0 15:15:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:15:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:15:13 INFO - Reading from file tmpfile_stdout 15:15:13 INFO - Current package versions: 15:15:13 INFO - blessings == 1.6 15:15:13 INFO - blobuploader == 1.2.4 15:15:13 INFO - docopt == 0.6.1 15:15:13 INFO - functools32 == 3.2.3-2 15:15:13 INFO - jsonschema == 2.5.1 15:15:13 INFO - manifestparser == 1.1 15:15:13 INFO - mozInstall == 1.12 15:15:13 INFO - mozcrash == 1.0 15:15:13 INFO - mozdebug == 0.1 15:15:13 INFO - mozdevice == 0.49 15:15:13 INFO - mozfile == 1.2 15:15:13 INFO - mozhttpd == 0.7 15:15:13 INFO - mozinfo == 0.9 15:15:13 INFO - mozleak == 0.1 15:15:13 INFO - mozlog == 3.4 15:15:13 INFO - moznetwork == 0.27 15:15:13 INFO - mozprocess == 0.24 15:15:13 INFO - mozprofile == 0.28 15:15:13 INFO - mozrunner == 6.13 15:15:13 INFO - mozscreenshot == 0.1 15:15:13 INFO - mozsystemmonitor == 0.3 15:15:13 INFO - moztest == 0.8 15:15:13 INFO - mozversion == 1.4 15:15:13 INFO - psutil == 3.1.1 15:15:13 INFO - requests == 1.2.3 15:15:13 INFO - wsgiref == 0.1.2 15:15:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:15:13 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:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:13 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:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:14 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 0x10bcf3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcf6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fe35737e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bad1d30>, '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 0x10b9f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bac6be8>, '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.Cd889FpU3Q/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.B5CrLjHGUU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 15:15:14 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 15:15:14 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 15:15:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cd889FpU3Q/Render', 15:15:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:14 INFO - 'HOME': '/Users/cltbld', 15:15:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:14 INFO - 'LOGNAME': 'cltbld', 15:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:14 INFO - 'MOZ_NO_REMOTE': '1', 15:15:14 INFO - 'NO_EM_RESTART': '1', 15:15:14 INFO - 'PAGER': '/bin/cat', 15:15:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:14 INFO - 'PWD': '/builds/slave/test', 15:15:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:14 INFO - 'SHELL': '/bin/bash', 15:15:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B5CrLjHGUU/Listeners', 15:15:14 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 15:15:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:14 INFO - 'USER': 'cltbld', 15:15:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:14 INFO - 'XPC_FLAGS': '0x0', 15:15:14 INFO - 'XPC_SERVICE_NAME': '0', 15:15:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:14 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)) 15:15:14 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)) 15:15:14 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)) 15:15:14 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)) 15:15:14 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)) 15:15:14 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)) 15:15:14 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)) 15:15:14 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)) 15:15:14 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)) 15:15:14 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)) 15:15:14 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)) 15:15:14 INFO - Cleaning up... 15:15:14 INFO - Return code: 0 15:15:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:15: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')]} 15:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15: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')]} 15:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bcf3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcf6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fe35737e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bad1d30>, '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 0x10b9f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bac6be8>, '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.Cd889FpU3Q/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.B5CrLjHGUU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 15:15: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', 'jsonschema'] in /builds/slave/test/build 15:15: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 jsonschema 15:15:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cd889FpU3Q/Render', 15:15:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:14 INFO - 'HOME': '/Users/cltbld', 15:15:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:14 INFO - 'LOGNAME': 'cltbld', 15:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:14 INFO - 'MOZ_NO_REMOTE': '1', 15:15:14 INFO - 'NO_EM_RESTART': '1', 15:15:14 INFO - 'PAGER': '/bin/cat', 15:15:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:14 INFO - 'PWD': '/builds/slave/test', 15:15:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:14 INFO - 'SHELL': '/bin/bash', 15:15:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B5CrLjHGUU/Listeners', 15:15:14 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 15:15:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:14 INFO - 'USER': 'cltbld', 15:15:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:14 INFO - 'XPC_FLAGS': '0x0', 15:15:14 INFO - 'XPC_SERVICE_NAME': '0', 15:15:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:15:15 INFO - Cleaning up... 15:15:15 INFO - Return code: 0 15:15:15 INFO - Running post-action listener: _resource_record_post_action 15:15:15 INFO - Running post-action listener: _start_resource_monitoring 15:15:15 INFO - Starting resource monitoring. 15:15:15 INFO - [mozharness: 2017-01-10 23:15:15.095642Z] Finished create-virtualenv step (success) 15:15:15 INFO - [mozharness: 2017-01-10 23:15:15.096682Z] Running install step. 15:15:15 INFO - Running pre-action listener: _resource_record_pre_action 15:15:15 INFO - Running main action method: install 15:15:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:15:15 INFO - Reading from file tmpfile_stdout 15:15:15 INFO - Detecting whether we're running mozinstall >=1.0... 15:15:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:15:15 INFO - Reading from file tmpfile_stdout 15:15:15 INFO - Output received: 15:15:15 INFO - Usage: mozinstall [options] installer 15:15:15 INFO - Options: 15:15:15 INFO - -h, --help show this help message and exit 15:15:15 INFO - -d DEST, --destination=DEST 15:15:15 INFO - Directory to install application into. [default: 15:15:15 INFO - "/builds/slave/test"] 15:15:15 INFO - --app=APP Application being installed. [default: firefox] 15:15:15 INFO - mkdir: /builds/slave/test/build/application 15:15:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:15:38 INFO - Reading from file tmpfile_stdout 15:15:38 INFO - Output received: 15:15:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:15:38 INFO - Running post-action listener: _resource_record_post_action 15:15:38 INFO - [mozharness: 2017-01-10 23:15:38.205345Z] Finished install step (success) 15:15:38 INFO - [mozharness: 2017-01-10 23:15:38.205482Z] Running run-tests step. 15:15:38 INFO - Running pre-action listener: _resource_record_pre_action 15:15:38 INFO - Running main action method: run_tests 15:15:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:15:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:15:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:15:38 INFO - 2017-01-10 15:15:38.221 screenresolution[1892:14414] starting screenresolution argv=screenresolution get 15:15:38 INFO - 2017-01-10 15:15:38.224 screenresolution[1892:14414] Display 0: 1600x1200x32@60 15:15:38 INFO - 2017-01-10 15:15:38.230 screenresolution[1893:14416] starting screenresolution argv=screenresolution list 15:15:38 INFO - Available Modes on Display 0 15:15:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:15:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:15:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:15:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:15:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:15:38 INFO - Intel Iris: 15:15:38 INFO - Chipset Model: Intel Iris 15:15:38 INFO - Type: GPU 15:15:38 INFO - Bus: Built-In 15:15:38 INFO - VRAM (Dynamic, Max): 1536 MB 15:15:38 INFO - Vendor: Intel (0x8086) 15:15:38 INFO - Device ID: 0x0a2e 15:15:38 INFO - Revision ID: 0x0009 15:15:38 INFO - Displays: 15:15:38 INFO - Display: 15:15:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:15:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:15:38 INFO - Display Serial Number: 1600x1200 60 15:15:38 INFO - Main Display: Yes 15:15:38 INFO - Mirror: Off 15:15:38 INFO - Online: Yes 15:15:38 INFO - Rotation: Supported 15:15:38 INFO - Return code: 0 15:15:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:15:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:15:38 INFO - Python 2.7.3 15:15:38 INFO - Return code: 0 15:15:38 INFO - grabbing minidump binary from tooltool 15:15: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')]} 15:15:38 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 0x10bad1d30>, '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 0x10b9f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bac6be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:15:38 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 15:15:38 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 15:15:38 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 15:15:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:15:38 INFO - Return code: 0 15:15:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:15:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:15:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:15:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:15:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:15:38 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/Q2hg10i3R7WjSq_Li1M6aA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0034', '--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 15:15:38 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/Q2hg10i3R7WjSq_Li1M6aA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0034 --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 15:15:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cd889FpU3Q/Render', 15:15:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:38 INFO - 'HOME': '/Users/cltbld', 15:15:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:38 INFO - 'LOGNAME': 'cltbld', 15:15:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:15:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:38 INFO - 'MOZ_NO_REMOTE': '1', 15:15:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:15:38 INFO - 'NO_EM_RESTART': '1', 15:15:38 INFO - 'PAGER': '/bin/cat', 15:15:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:38 INFO - 'PWD': '/builds/slave/test', 15:15:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:15:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:38 INFO - 'SHELL': '/bin/bash', 15:15:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B5CrLjHGUU/Listeners', 15:15:38 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 15:15:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:38 INFO - 'USER': 'cltbld', 15:15:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:38 INFO - 'XPC_FLAGS': '0x0', 15:15:38 INFO - 'XPC_SERVICE_NAME': '0', 15:15:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:38 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/Q2hg10i3R7WjSq_Li1M6aA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0034', '--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 15:15:38 INFO - mozversion application_buildid: 20170110135305 15:15:38 INFO - mozversion application_changeset: 20094311ab5ec56d5be7afc6d5c2e2b09e656fb2 15:15:38 INFO - mozversion application_display_name: Nightly 15:15:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:15:38 INFO - mozversion application_name: Firefox 15:15:38 INFO - mozversion application_remotingname: firefox 15:15:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:15:38 INFO - mozversion application_vendor: Mozilla 15:15:38 INFO - mozversion application_version: 53.0a1 15:15:38 INFO - mozversion platform_buildid: 20170110135305 15:15:38 INFO - mozversion platform_changeset: 20094311ab5ec56d5be7afc6d5c2e2b09e656fb2 15:15:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:15:38 INFO - mozversion platform_version: 53.0a1 15:15:38 INFO - using testdate: 1484090138 15:15:38 INFO - actual date: 1484090138 15:15:38 INFO - starting webserver on 'localhost:51757' 15:15:38 INFO - SUITE-START | Running 2 tests 15:15:38 INFO - TEST-START | dromaeo_css 15:15:38 INFO - operating with platform_type : mac_ 15:15:38 INFO - Initialising browser for dromaeo_css test... 15:15:38 INFO - TEST-INFO | started process 1903 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmpKZ_EvS/profile http://localhost:51757/getInfo.html) 15:15:41 INFO - PROCESS | 1903 | 2017-01-10 15:15:41.909 plugin-container[1905:14573] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x484b, name = 'com.apple.tsm.portname' 15:15:41 INFO - PROCESS | 1903 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:15:41 INFO - PROCESS | 1903 | 2017-01-10 15:15:41.912 plugin-container[1905:14573] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b0b, name = 'com.apple.CFPasteboardClient' 15:15:41 INFO - PROCESS | 1903 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:15:41 INFO - PROCESS | 1903 | 2017-01-10 15:15:41.912 plugin-container[1905:14573] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:15:41 INFO - PROCESS | 1903 | __metrics Screen width/height:1600/1200 15:15:41 INFO - PROCESS | 1903 | colorDepth:24 15:15:41 INFO - PROCESS | 1903 | Browser inner width/height: 1024/689 15:15:41 INFO - PROCESS | 1903 | __metrics 15:15:42 ERROR - PROCESS | 1903 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 15:15:42 INFO - TEST-INFO | 1903: exit 0 15:15:42 INFO - Browser initialized. 15:15:42 INFO - Running cycle 1/1 for dromaeo_css test... 15:15:42 INFO - TEST-INFO | started process 1906 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmpKZ_EvS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:15:45 INFO - PROCESS | 1906 | 2017-01-10 15:15:45.537 plugin-container[1907:14686] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e4f, name = 'com.apple.tsm.portname' 15:15:45 INFO - PROCESS | 1906 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:15:45 INFO - PROCESS | 1906 | 2017-01-10 15:15:45.539 plugin-container[1907:14686] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f07, name = 'com.apple.CFPasteboardClient' 15:15:45 INFO - PROCESS | 1906 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:15:45 INFO - PROCESS | 1906 | 2017-01-10 15:15:45.539 plugin-container[1907:14686] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:15:55 INFO - PROCESS | 1906 | RSS: Main: 233074688 15:15:55 INFO - PROCESS | 1906 | 15:18:56 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:51757/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51757/tests/dromaeo/cssquery-ext.html) 15:18:58 INFO - PROCESS | 1906 | RSS: Main: 254750720 15:18:58 INFO - PROCESS | 1906 | 15:20:43 INFO - PROCESS | 1906 | ************************* 15:20:43 INFO - PROCESS | 1906 | A coding exception was thrown and uncaught in a Task. 15:20:43 INFO - PROCESS | 1906 | 15:20:43 INFO - PROCESS | 1906 | Full message: ReferenceError: fetch is not defined 15:20:43 INFO - PROCESS | 1906 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 15:20:43 INFO - PROCESS | 1906 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 15:20:43 INFO - PROCESS | 1906 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 15:20:43 INFO - PROCESS | 1906 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 15:20:43 INFO - PROCESS | 1906 | TaskImpl@resource://gre/modules/Task.jsm:277:3 15:20:43 INFO - PROCESS | 1906 | asyncFunction@resource://gre/modules/Task.jsm:252:14 15:20:43 INFO - PROCESS | 1906 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 15:20:43 INFO - PROCESS | 1906 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 15:20:43 INFO - PROCESS | 1906 | TaskImpl@resource://gre/modules/Task.jsm:277:3 15:20:43 INFO - PROCESS | 1906 | asyncFunction@resource://gre/modules/Task.jsm:252:14 15:20:43 INFO - PROCESS | 1906 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 15:20:43 INFO - PROCESS | 1906 | 15:20:43 INFO - PROCESS | 1906 | ************************* 15:22:00 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:51757/tests/dromaeo/cssquery-ext.html (next: http://localhost:51757/tests/dromaeo/cssquery-jquery.html) 15:22:01 INFO - PROCESS | 1906 | RSS: Main: 261976064 15:22:01 INFO - PROCESS | 1906 | 15:25:03 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:51757/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51757/tests/dromaeo/cssquery-mootools.html) 15:25:04 INFO - PROCESS | 1906 | RSS: Main: 269598720 15:25:04 INFO - PROCESS | 1906 | 15:28:06 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:51757/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51757/tests/dromaeo/cssquery-prototype.html) 15:28:06 INFO - PROCESS | 1906 | RSS: Main: 265928704 15:28:06 INFO - PROCESS | 1906 | 15:31:09 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:51757/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51757/tests/dromaeo/cssquery-yui.html) 15:31:10 INFO - PROCESS | 1906 | RSS: Main: 270577664 15:31:10 INFO - PROCESS | 1906 | 15:34:13 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:51757/tests/dromaeo/cssquery-yui.html (next: http://localhost:51757/tests/dromaeo/cssquery-dojo.html) 15:34:13 INFO - PROCESS | 1906 | RSS: Main: 274198528 15:34:13 INFO - PROCESS | 1906 | 15:34:13 INFO - PROCESS | 1906 | __start_tp_report 15:34:13 INFO - PROCESS | 1906 | _x_x_mozilla_page_load 15:34:13 INFO - PROCESS | 1906 | _x_x_mozilla_page_load_details 15:34:13 INFO - PROCESS | 1906 | |i|pagename|runs| 15:34:13 INFO - PROCESS | 1906 | |0;dojo.html;2759.9862000689996;2858.385447128867;2858.499762541555;2868.0392068656997;2933.3253351729104;4680.227762419197;4735.484644913629;4769.379980602521;4813.2780082987565;4883.804647814092;4119.01143725506;4750.762461876901;4772.475027746945;4809;4837.951620483794;3025.44029354569;3258.3646188993157;3360.663933606632;4485.035717320776;4539.827073224297;4448.799804008828;4483.843065492709;4510.954890451087;4539.72761634303;4576.153411618861;4512.548745125494;4535.115652447774;4564.475085365176;4572.748498832563;4589.35748995141;3832.0419895026243;4113.835446582133;4276.935845962313;4308.569143085698;4384.583464570893;3642.470162531743;4335.761533115678;4376.146651402978;4400.11997600478;4418.381426600278;4503.1218912312115;4642.280446530793;4720.740359280238;4752.762361881927;4768.833090841838;4211.43145675336;5093.312402825608;5163.251328557338;5241.947580524184;5251.842444726664;5283.07546179417;5319;5340.359156901158;5434.619576629638;5478.972605136949;5030.170021946375;5057.9494205057845;5060.544550990428;5081.085404627165;5096.541311282002;5243.318368612056;5492.176173573996;5502.2296878437055;5526.392096869341;5564.610477266633;5089.745512724349;5117.334746482933;5130.666506677054;5193.298904647824;5215.087359712035;5267.157254839208;5302.549283310885;5305.283786688748;5353.812616558402;5397.812481254118;5000.39995200571;5121.28302037715;5273.1035723927025;5286.656367336111;5300.31095957523;5211;5291.259223708684;5294.523492885659;5297.8145764898045;5347.064263753828;4221.472315960505;4302.698811083194;4345.304751239786;4406.889827754268;4415.558444155623;3801.2967600993907;3823.1589050408866;3921.941170882439;3966.2464131814863;3981.7212795104065;4864.8783780405065;4875.146849301429;4886.242632391985;4899.265110233422;4915.606751459874;5368.355797304271;5401.108817045222;5403.486668766461;5425.9186112208345;5468.26178465902;3844.6539811417106;4387.849953522815;4704.200285951397;4853.757312134449;4904.901901961941;4651.976740116278;4700.694454860423;4722.905541889143;4725.5510726480925;4772.570468657768;5568.582356323292;5583.972080139573;5590.413006634326;5611.691356975324;5629.155626655953;5100.617453690914;5359.517643412111;5391.622586418913;5395.055865223491;5412.079946409199;5214.139666955061;5428.4842939920645;5476.205950137288;5513;5515.751791169327;3969.9678083699023;5161.819336323361;5212.166053431432;5221.817236396708;5239.345081864767;4549.203889319289;4641.814327426865;5286.20706893969;5298.125809241432;5305.230741542532;4402.5597440255715;5226.425093239664;5251.6323857331145;5337.733113344395;5363.329583802025;5101.8724531887;5195.350581177353;5228.37259528859;5266.552343050884;5277.683338999673;4241.427407299975;4949.82675606352;5063.316452278895;5149.02168587982;5184.948150518447;5146.614003949793;5158.3552055993005;5190.039842629126;5207.3751149862255;5232.843014709565;5107.38711354625;5115.3094332266155;5145.9965306764825;5147.562457191031;5183.5593974512585 15:34:13 INFO - PROCESS | 1906 | |1;ext.html;408.9366148247021;434.04510077828775;437.39202508513154;441.4966937691035;458.2027272545769;29941.70058299419;30931.690683093162;31483.21291967702;40859.79570102145;40989.51589114929;41487.792561037226;41836.16327673445;41904.37143442851;41912.37131443031;41989.7900510497;8879.86680199796;9144.451332920013;9149.496777677225;9152.816943661122;9179;8186.877196842052;8380.413371064027;8851.601677924476;10710.41092739899;11015.83476247857;10507.054365107138;10918;10986.615468458605;10989.780204395907;11032.28290161141;9554.856677149814;11077.944610276978;11084.833727494093;11106.500207490642;11109.72225694356;10883.891161088366;10964.122870170368;10967.451627418597;10971.83542246867;10996.28524145928;39278.21443571141;39292.80353598242;39547;39567.60432395668;39635.801820991;3736.57029441615;3900.7854567998747;3925.430812532167;3926.666233370167;3948.4077388391684;28952.986645467518;29840.70159298401;30077.248068798453;30088.548671769942;30091.849540752373;3107.6892310768967;3131.8434078295995;3137.62348518177;3161.1780936956325;3210.983945080283;419111;419423;422071;423149.9999999969;423922;56902;57005.71497142488;57172;57195.71402143046;57340.99999999916;60928.390716093156;61036.16891493263;61049.08426373608;61496.69251653802;61656;11192.496337664825;14428.927855360866;14662.926685366718;14692.559223223321;15138.697226055638;9716.833979922314;10179.592816287413;10561.577536898592;10684.732881678021;11155.163362747664;13906.30468476572;14238.43046278158;16628.734480357445;20961;21005.264815731374;7434.516756410816;8389.119142490074;8563.700270490503;8583.399162058597;8590.570471476402;628.2617923939445;680.6766785776716;686.6174374919023;750.598429840033;761.7600455856387;26719.866400667874;26838.5974210387;27130.05044823461;27450.862745686143;27484.58773118405;949.6496171974309;959.2421986630484;988.5551501824065;994.3636072913341;1101.4052411697594;12069;13307.46770129184;14243.64390890236;15233.6191595211;15680.607984800472;577506;580175;584766.0761696164;584777;586313;58656.41343586509;59243;59460.70269648624;59523;59550.70224648936;1125.1673761416494;1294.7410517896458;1304.6020963606002;1317.426919290112;1321.3327269728725;23032.539349213257;27395.04117355883;28084;28316;29134;49146.75426622844;49306;49334.76663083308;49451.50548494469;49744.50255497399;476134;476326;476336;477374;477460;33684.67347356996;40301.79849100736;41512.584874150874;41614.16771664489;41774.58225417707;45929.08141837078;47885.76057119692;48659;48971.51028489812;49559.75220123876;37857.81071094627;37869.24261514809;38021.61978380291;39405;39491;32910;34369.31261374809;38006.80996594999;38062.429063564625;39378.60621393749;35914.28171436609;36708.71519496805;37171.44242836306;37275.6272437283;37294.62705372911;25603.23190304294;26678.866605666848;31357.686423135478;33946.49080263847;34114.82942585271;23896.641550377106;24549.64976926286;24837.379065523506;24858.50282994366;25326.240212793644 15:34:13 INFO - PROCESS | 1906 | |2;jquery.html;326.9051974927271;347.942589472737;351.47805508819397;364.60258318432903;373.07477455909344;18660.160292786823;19296.324628637984;20392.59214815703;20432.08055637496;20434.69347959778;10707.982741639551;16986;18287.90272583646;19084.95032773197;19675.31136410226;5157.097507936115;5370.624056316059;5384.865378365533;5407.270018547505;5407.675539467625;5075.517825806561;5210.192420174879;5269.868253293679;5280.577553795706;5339.946600534003;5321.467853214667;5323.707196104213;5325.254464374991;5340.412554618989;5352.946470535303;4234.640055595278;4284.8859296582805;4856;5252.789888404459;5302.257683924254;5141.897162056738;5143.537081662668;5151.098557752416;5151.484851514856;5156.458571849977;13159.94720422364;16721.414750483797;24468.632970505456;24552.754472455224;24832.627510587357;2166.739991201066;2306.4925716342545;2801.7618502427317;2876.6979467156066;2905.026816016637;9710.465924374157;9774.120329170337;10063.496825158785;10277;12043.397830108459;1753.114677088075;1800.5858652509996;1824.3705921457076;1825.9269629214816;1830.2404502131733;109083.45458272737;121607.05536501757;123652.38173809163;133062.00406993806;139854.3007284957;10530.31552949056;11077.667669969915;11439.714007149887;11495.080393568494;11503.942480287546;13825.239611821446;15000.69998600022;15090.320935557926;15101.622459438382;15110.54668359951;7905.446618736748;8110.594470276463;8118.35053195743;8218.712345067894;8231.135730748305;7688.577128258;7692.923070769332;7694.961525192451;7835;7838.490498117604;4668.626509879269;4670.369500117441;4688.132695451352;4711.670183087151;4760.785764640599;1908.6946088625753;1958.6474434601623;1965.4005528313717;1972.7435433393566;1978.366922584759;819.4100247821559;831.7421599304236;861.4185424838334;861.9741407757778;885.4587334350327;20434.154558222865;20722.067506962223;21684.241051563436;21886.343409697736;21916.23293184731;901.8827552418144;927.4342650982895;943.2501161576563;950.2825366847985;958.3818437108026;11051.502682379152;11157;11171.050460710769;11189.664310070712;11280.379579123228;625425;652559;660567;671446;692562;106434;138997;141808;147536;156065;710.5488015110442;895.6372669068908;911.9452832830051;915.1671978499534;915.3638221436038;13500.987425942898;14541.127532348093;15430.996985195927;19218.903905480944;19830.909299988638;44863.065062843714;54760.63098422571;55946;55999;57517.13724294055;70001.59996800138;78198.21801781909;87621.68567471621;89606;90448.54775726079;5949.8215053548465;7628.656710448154;8245.711400100967;8268.131846156308;8381.58092095405;12223.511059557519;12558.811617825922;12664.87335126637;12866;12940.41768120418;10356.844647330447;10667.199960003187;10856.2400631955;11047.834282485608;11291.830622540832;8511.489310641382;9433.962264150801;9716.659916902874;10786.676399708022;11246.325220486797;10988;11251.943740281245;11263.718407039889;11307.830382544103;11426.828597570877;6294.34835979675;7926.603669816602;8176.141505141874;8179.468334558234;8238.50568965864;7918.81217817332;9278.768030799283;11009.889901100887;11087.833682494931;11244.156688248579 15:34:13 INFO - PROCESS | 1906 | |3;mootools.html;1208.7099096216912;1214.4656351205472;1336.204958049961;1352.053562506246;1383.8201033865598;7189.1013623297085;7451.143118541369;7667.654955527;8146.470479418841;8160.510369377834;7561.962190189041;7873;7928.6035698215;7931.167227441122;8008.519488830674;2113.577284543094;2191.802737753602;2192.506685995654;2200.713907192063;2208.2271205078255;1509.6527798606328;1832.25793553611;2176.46676564242;2213.1700612270397;2222.7888350606668;1720.9655806883854;2156.676498525218;2157.9568408631817;2173.652215645497;2173.8586991845477;2195.4182141732454;2200.548887478063;2225.4881377283236;2225.5882661707637;2230.130249202812;2176.7279090113734;2224.2326397393035;2241.618924782791;2245.6631505274177;2247.78646028627;7959.602019898982;7961.800954976172;8054.43618946674;8067.596620169027;8075;4820.25286080658;4977.104121258172;4979.800807967713;4993.5019494151975;4998.700077995296;3235.4499735045097;3300.933981320384;3338.8998330050135;3362.4451965425674;3367.9158021049425;1127.7988941776982;1167.2471256039892;1198.568515334479;1205.1555537834367;1220.371508673034;7719.3052625264;8086.353091752704;9964.25268104895;10132.138768204712;10279.126274266697;3834.213986132836;4427.048184640318;4493.932591011072;4505.166544189336;4506.098780243964;9039.77400564978;9120.635174593075;9150.130737579919;9151.130642588943;9246.4914429707;4926.45808961014;5025.949740502549;5026.195808670595;5029.823956161516;5061;4317.870463886088;4462.48681401643;4513.458384993822;4591.1965406053805;4610.469795973506;3331.783434076777;3381.5773028371455;3392.1858753898887;3397.1167496450607;3422.57217847769;1004.542932965499;1017.9796404071877;1066.5733706517456;1075.510642657589;1076.9537878031647;683.6820878291519;698.7135274537517;704.9048378468943;733.5598640815468;750.0212223048865;5218.139007063868;5316.3354580677415;5589.245451864028;5628.549716022709;5671.489565939003;871.5380848150363;886.6985225023394;886.9533949939133;897.7441429192648;908.3868388837508;3665.1203711109674;3728.5898551159353;3796.9050773730323;3856.787876666754;3877.427759946919;9060.637574496946;9487.478188699688;9514.90485095154;9516.048395160567;9527.999560046095;9478.715638530855;9480.194183494481;9484.05159484046;9507;9647.035296470438;7346.96326518364;7506.549607023596;7510.84978300431;7516.887246691304;7548.207438219018;5074.314967479343;5368.677879327252;5389.461053894579;5415.1335786274;5471.945280547303;8050.033995920527;8535.445196062235;8631.741047768577;8656.091110433566;8705.521196334263;8112.43212975086;8807.603657835285;8892.110788921056;8940.955295223483;8941.37410381267;6314.147590075281;6514.153160089348;6517.641529715722;6524.5432819704065;6543.869122617426;7435.219301973431;7447.5531468112085;7472.813179670552;7502.099748030271;7534.849303014019;6072.939270607414;6822.317768223138;6866.553674011373;6917.896231556631;6934.410575100971;6572.967135164294;6694.4644428444635;6747.932520674731;6817.181938167451;6834.726610935507;6019.217501724747;6116.816495505142;6138.1713468681155;6151.138840562236;6171.413715697002;3935.586763389803;4521.796519156712;4557.860534866283;4672.112298663243;4792.928106078341;3869.709771767072;4466.4640243171025;4552.476465206543;4928.236123400879;4997.800087996439 15:34:13 INFO - PROCESS | 1906 | |4;prototype.html;270.5292790544453;316.48729058924533;329.2443841384023;333.2136158665549;338.7239399889092;3683.410654295313;4212.536620971695;4213.8314467421305;4278.4010238566625;4367.541408152142;3421.9315613687713;4168.812403441845;4209.084866385795;4223.978880105603;4234.216669916068;3034.453798316313;3141.6387115481725;3284.425225585525;3349.145967778213;3366.73066154707;2758.3655759175404;3336.498575640959;3360.54632624595;3388.695017448429;3430.708389786871;3302.455094909349;3394;3399.5750531183603;3410.7380269300393;3416.7437442191813;2970.212893583202;3292.094673964667;3434.708049815769;3437.9312413751586;3446.6036405813275;2893.291143669793;2893.755685055425;2982.3438843454405;3003.3843062172423;3033.226527235563;3496.6503349665086;3514.38498262803;3777.471154038437;4060.654844338235;4065.4105154752397;3188.3942051010467;3827.67945058957;3933.5476420211758;3936.9606303937167;4015.8393664253394;4238.452964667874;4498.910021799546;4523.773811309421;4531.682782205247;4555.74943378114;2951.95205701977;3290.4735242361107;3293.2096296888813;3347.3640008398324;3442.707369873564;3797.1331644608144;4096.877093687164;4209.3896385024;4541.932645828228;4702.153612349775;3488.5464889564196;3516.3143187078786;3518.683318501347;3527.6648718372226;3536.7091011780517;3273.558069660613;3568.054465566575;3574.285142971416;3596.3346780845627;3596.98201508996;3269.7901776342906;3605.2068544920076;3830.559485659129;3962.2075584882564;3973.0861901762755;4012.3256406286932;4567.337736028324;4614.077184563101;4618.145643056046;4631.907361852812;1006.8137394582026;1115.4422788605698;1156.8142653779944;1160.182071639492;1163.5694792926502;786.8701664225339;842.7935155886724;844.2401838345415;852.9488230706054;852.9658813647509;3367.040393487844;3540.2211513466996;3806.2006978534264;3895;3920.196359746245;3978.8116535905715;4504.48198457175;4552.975580494429;4565.876867256741;4634.768261586974;4078.6737061035046;4081.163361510883;4114.979425102855;4134.720564216022;4197.349410841324;2010.0150926046424;2091.4980404703065;2337.6026075567192;2338.801201897858;2348.2602980061224;4435.3125265583885;4543.45478542577;4582.312653102062;4630.351750754897;4676.438827340741;3617.819109044537;3667.7184853810427;4301.548337424588;4456.398386217819;4585.816567337336;4552.726836389827;4625.560571745679;4654.4181977252165;4654.557817007379;4670.416197975253;3842.2507611015585;3953.822078006439;4173.561776013475;4222.811777108263;4283.785810709514;4416.315471101984;4429.247028005182;4453.75504347264;4460.888477788081;4468.329750537446;3832.712546559075;4121.855735049379;4574.153781550423;4638.6752927294765;4684.009296049234;2956.645202575705;3105.378924215211;3206.342699746593;3314.6188188358647;3322.8172450515453;3718.4608231805696;3912.5304963404574;4370.519242883217;4394.209042372404;4404.603585677304;3545.15651861036;4112.848402447319;4344.153734662819;4346.130773845181;4398.516163221979;3698.2973235085246;4016.718829681894;4020.819063142107;4055.3105971985424;4332.545082766264;4095.0171958730284;4247.320428731388;4262.188569857736;4271.060366719316;4438.9334159988275;3715.7213209009974;4507.4365704286965;4556.33933079695;4564.520725323926;4568.327528395926;3930.567637559809;4034.0519977804606;4138.6482149017675;4419.403380543586;4486.663500237561 15:34:13 INFO - PROCESS | 1906 | |5;yui.html;629.540435482098;679.6397909108168;743.0897150990038;775.1589525364978;808.6401551309666;14526.273686315682;15505.379784808621;15554.922225388871;15617.687646247097;15629.218539073043;14136.646583835409;14253.501127460515;14288.71422571548;15209.4676686316;15807.446739364095;665.3911670821204;688.7348370877198;830.2071521696765;850.3154960256991;862.9989212513485;854.2952064546743;854.9230569248766;856.7429771068686;859.5530324231396;859.7334826203897;901.0989010989011;901.9819603607924;903.327021369081;908.8091500784843;909.9317551183688;895.5835536475505;897.5557099235855;898.290350623007;899.9235065019482;901.8647202919549;662.2549631664377;670.3196255800367;670.3531092495716;671.5467059734708;672.1732269308777;14992.700145997129;15335.846641533553;15349.462768803038;15362.385504579803;15428.305726242346;11131;13634.181949083088;13874.514391996332;13925.791113133311;13958.651033724136;10125.89874101257;10804.891951080468;10816.567337306498;11404.429778511041;11925.821112683318;3082.568440418343;3240.5301231321564;3256.560364350806;3617.222297206113;3756.69946404287;55107.72446137784;82512.18299353555;87118;114168.42915785451;114391;10625.415602141802;10731.409772462433;10734.7017834882;10865.402402867918;10904.945475272572;21554.03006864695;21868.45328866791;21881.67177492339;21885;22273.66358018524;7364.189939106694;7398;7495.400367970549;7515.661795219228;7718.228177182349;4038.6567141793275;4164.292070348048;4171.687123465752;4174.91650166995;4199.622034016953;2646.9602955955293;3458.9654103459147;3481.234128491728;3488.1977145256224;3514.9297014059575;597.3518732175552;607.6688204928324;621.273110460762;624.3444383397415;625.3777491395999;531.8431062836472;562.5780664501624;580.8615114375787;594.9851253718605;616.6893415029004;9826.606935722633;10064.899351006396;10081.546330415149;10367.585296588051;10401.791964160826;573.5612256623687;594.6877889108252;597.1073245497921;601.5278006764669;607.5686262753494;4326.286162783168;4594.609458196091;4908.9263661045115;4912.4350699669285;4918.926216106761;99252;107445.8510829779;108699.45650271697;109450;114475;72192;94600;96800.54799178019;96824;98162.5091874536;81379.59310203411;85120.57439712886;85294;85778.57110714406;86943.13056869477;8180.263776260165;9602.519874006412;9605.951970240105;9625.807483850143;9698.418094914328;44065.339019915365;52886.73556632192;54572.727136365655;54833.62915927134;55179.44820551743;73200.6339968318;73950;74536;75397;78512.60743696245;9870.851937220803;11284.32294062359;11319.660410187707;11369.2609980351;11962.34207118582;12697;12762.48950042025;12866.485340586272;13091.149075310075;13101.672458188621;11300.152488563226;11511.079113671054;11770.646880593597;12005.459754311252;12139.150259481752;10390.948045259725;11224.7755044897;11921.582744603897;12086.516539338329;12307.138500304893;11609.76780464369;11760.70598235051;12145.392730363623;12145.45345459474;12176.756464870476;10005.249606279413;10254.436006019741;10521.368717876952;10534.789652053763;10558.8416173759;9077.700474563642;9121.635134594542;9302.255819534286;9906.541130322343;9913.071059700216 15:34:13 INFO - PROCESS | 1906 | __end_tp_report 15:34:13 INFO - PROCESS | 1906 | __start_cc_report 15:34:13 INFO - PROCESS | 1906 | _x_x_mozilla_cycle_collect,396 15:34:13 INFO - PROCESS | 1906 | __end_cc_report 15:34:13 INFO - PROCESS | 1906 | __startTimestamp1484091253935__endTimestamp 15:34:13 INFO - PROCESS | 1906 | 15:34:13 INFO - PROCESS | 1906 | ------- Summary: start ------- 15:34:13 INFO - PROCESS | 1906 | Number of tests: 6 15:34:13 INFO - PROCESS | 1906 | 15:34:13 INFO - PROCESS | 1906 | [#0] dojo.html Cycles:165 Average:4840.68 Median:5081.09 stddev:616.84 (12.1%) stddev-sans-first:596.74 15:34:13 INFO - PROCESS | 1906 | Values: 2760.0 2858.4 2858.5 2868.0 2933.3 4680.2 4735.5 4769.4 4813.3 4883.8 4119.0 4750.8 4772.5 4809.0 4838.0 3025.4 3258.4 3360.7 4485.0 4539.8 4448.8 4483.8 4511.0 4539.7 4576.2 4512.5 4535.1 4564.5 4572.7 4589.4 3832.0 4113.8 4276.9 4308.6 4384.6 3642.5 4335.8 4376.1 4400.1 4418.4 4503.1 4642.3 4720.7 4752.8 4768.8 4211.4 5093.3 5163.3 5241.9 5251.8 5283.1 5319.0 5340.4 5434.6 5479.0 5030.2 5057.9 5060.5 5081.1 5096.5 5243.3 5492.2 5502.2 5526.4 5564.6 5089.7 5117.3 5130.7 5193.3 5215.1 5267.2 5302.5 5305.3 5353.8 5397.8 5000.4 5121.3 5273.1 5286.7 5300.3 5211.0 5291.3 5294.5 5297.8 5347.1 4221.5 4302.7 4345.3 4406.9 4415.6 3801.3 3823.2 3921.9 3966.2 3981.7 4864.9 4875.1 4886.2 4899.3 4915.6 5368.4 5401.1 5403.5 5425.9 5468.3 3844.7 4387.8 4704.2 4853.8 4904.9 4652.0 4700.7 4722.9 4725.6 4772.6 5568.6 5584.0 5590.4 5611.7 5629.2 5100.6 5359.5 5391.6 5395.1 5412.1 5214.1 5428.5 5476.2 5513.0 5515.8 3970.0 5161.8 5212.2 5221.8 5239.3 4549.2 4641.8 5286.2 5298.1 5305.2 4402.6 5226.4 5251.6 5337.7 5363.3 5101.9 5195.4 5228.4 5266.6 5277.7 4241.4 4949.8 5063.3 5149.0 5184.9 5146.6 5158.4 5190.0 5207.4 5232.8 5107.4 5115.3 5146.0 5147.6 5183.6 15:34:13 INFO - PROCESS | 1906 | 15:34:13 INFO - PROCESS | 1906 | [#1] ext.html Cycles:180 Average:63585.67 Median:21602.44 stddev:132650.75 (614.1%) stddev-sans-first:132938.06 15:34:13 INFO - PROCESS | 1906 | Values: 408.9 434.0 437.4 441.5 458.2 29941.7 30931.7 31483.2 40859.8 40989.5 41487.8 41836.2 41904.4 41912.4 41989.8 8879.9 9144.5 9149.5 9152.8 9179.0 8186.9 8380.4 8851.6 10710.4 11015.8 10507.1 10918.0 10986.6 10989.8 11032.3 9554.9 11077.9 11084.8 11106.5 11109.7 10883.9 10964.1 10967.5 10971.8 10996.3 39278.2 39292.8 39547.0 39567.6 39635.8 3736.6 3900.8 3925.4 3926.7 3948.4 28953.0 29840.7 30077.2 30088.5 30091.8 3107.7 3131.8 3137.6 3161.2 3211.0 419111.0 419423.0 422071.0 423150.0 423922.0 56902.0 57005.7 57172.0 57195.7 57341.0 60928.4 61036.2 61049.1 61496.7 61656.0 11192.5 14428.9 14662.9 14692.6 15138.7 9716.8 10179.6 10561.6 10684.7 11155.2 13906.3 14238.4 16628.7 20961.0 21005.3 7434.5 8389.1 8563.7 8583.4 8590.6 628.3 680.7 686.6 750.6 761.8 26719.9 26838.6 27130.1 27450.9 27484.6 949.6 959.2 988.6 994.4 1101.4 12069.0 13307.5 14243.6 15233.6 15680.6 577506.0 580175.0 584766.1 584777.0 586313.0 58656.4 59243.0 59460.7 59523.0 59550.7 1125.2 1294.7 1304.6 1317.4 1321.3 23032.5 27395.0 28084.0 28316.0 29134.0 49146.8 49306.0 49334.8 49451.5 49744.5 476134.0 476326.0 476336.0 477374.0 477460.0 33684.7 40301.8 41512.6 41614.2 41774.6 45929.1 47885.8 48659.0 48971.5 49559.8 37857.8 37869.2 38021.6 39405.0 39491.0 32910.0 34369.3 38006.8 38062.4 39378.6 35914.3 36708.7 37171.4 37275.6 37294.6 25603.2 26678.9 31357.7 33946.5 34114.8 23896.6 24549.6 24837.4 24858.5 25326.2 15:34:13 INFO - PROCESS | 1906 | 15:34:13 INFO - PROCESS | 1906 | [#2] jquery.html Cycles:180 Average:36947.85 Median:358.04 stddev:110386.33 (30830.7%) stddev-sans-first:110661.74 15:34:13 INFO - PROCESS | 1906 | Values: 326.9 347.9 351.5 364.6 373.1 18660.2 19296.3 20392.6 20432.1 20434.7 10708.0 16986.0 18287.9 19085.0 19675.3 5157.1 5370.6 5384.9 5407.3 5407.7 5075.5 5210.2 5269.9 5280.6 5339.9 5321.5 5323.7 5325.3 5340.4 5352.9 4234.6 4284.9 4856.0 5252.8 5302.3 5141.9 5143.5 5151.1 5151.5 5156.5 13159.9 16721.4 24468.6 24552.8 24832.6 2166.7 2306.5 2801.8 2876.7 2905.0 9710.5 9774.1 10063.5 10277.0 12043.4 1753.1 1800.6 1824.4 1825.9 1830.2 109083.5 121607.1 123652.4 133062.0 139854.3 10530.3 11077.7 11439.7 11495.1 11503.9 13825.2 15000.7 15090.3 15101.6 15110.5 7905.4 8110.6 8118.4 8218.7 8231.1 7688.6 7692.9 7695.0 7835.0 7838.5 4668.6 4670.4 4688.1 4711.7 4760.8 1908.7 1958.6 1965.4 1972.7 1978.4 819.4 831.7 861.4 862.0 885.5 20434.2 20722.1 21684.2 21886.3 21916.2 901.9 927.4 943.3 950.3 958.4 11051.5 11157.0 11171.1 11189.7 11280.4 625425.0 652559.0 660567.0 671446.0 692562.0 106434.0 138997.0 141808.0 147536.0 156065.0 710.5 895.6 911.9 915.2 915.4 13501.0 14541.1 15431.0 19218.9 19830.9 44863.1 54760.6 55946.0 55999.0 57517.1 70001.6 78198.2 87621.7 89606.0 90448.5 5949.8 7628.7 8245.7 8268.1 8381.6 12223.5 12558.8 12664.9 12866.0 12940.4 10356.8 10667.2 10856.2 11047.8 11291.8 8511.5 9434.0 9716.7 10786.7 11246.3 10988.0 11251.9 11263.7 11307.8 11426.8 6294.3 7926.6 8176.1 8179.5 8238.5 7918.8 9278.8 11009.9 11087.8 11244.2 15:34:13 INFO - PROCESS | 1906 | 15:34:13 INFO - PROCESS | 1906 | [#3] mootools.html Cycles:180 Average:5117.49 Median:5379.07 stddev:2787.30 (51.8%) stddev-sans-first:2779.63 15:34:13 INFO - PROCESS | 1906 | Values: 1208.7 1214.5 1336.2 1352.1 1383.8 7189.1 7451.1 7667.7 8146.5 8160.5 7562.0 7873.0 7928.6 7931.2 8008.5 2113.6 2191.8 2192.5 2200.7 2208.2 1509.7 1832.3 2176.5 2213.2 2222.8 1721.0 2156.7 2158.0 2173.7 2173.9 2195.4 2200.5 2225.5 2225.6 2230.1 2176.7 2224.2 2241.6 2245.7 2247.8 7959.6 7961.8 8054.4 8067.6 8075.0 4820.3 4977.1 4979.8 4993.5 4998.7 3235.4 3300.9 3338.9 3362.4 3367.9 1127.8 1167.2 1198.6 1205.2 1220.4 7719.3 8086.4 9964.3 10132.1 10279.1 3834.2 4427.0 4493.9 4505.2 4506.1 9039.8 9120.6 9150.1 9151.1 9246.5 4926.5 5025.9 5026.2 5029.8 5061.0 4317.9 4462.5 4513.5 4591.2 4610.5 3331.8 3381.6 3392.2 3397.1 3422.6 1004.5 1018.0 1066.6 1075.5 1077.0 683.7 698.7 704.9 733.6 750.0 5218.1 5316.3 5589.2 5628.5 5671.5 871.5 886.7 887.0 897.7 908.4 3665.1 3728.6 3796.9 3856.8 3877.4 9060.6 9487.5 9514.9 9516.0 9528.0 9478.7 9480.2 9484.1 9507.0 9647.0 7347.0 7506.5 7510.8 7516.9 7548.2 5074.3 5368.7 5389.5 5415.1 5471.9 8050.0 8535.4 8631.7 8656.1 8705.5 8112.4 8807.6 8892.1 8941.0 8941.4 6314.1 6514.2 6517.6 6524.5 6543.9 7435.2 7447.6 7472.8 7502.1 7534.8 6072.9 6822.3 6866.6 6917.9 6934.4 6573.0 6694.5 6747.9 6817.2 6834.7 6019.2 6116.8 6138.2 6151.1 6171.4 3935.6 4521.8 4557.9 4672.1 4792.9 3869.7 4466.5 4552.5 4928.2 4997.8 15:34:13 INFO - PROCESS | 1906 | 15:34:13 INFO - PROCESS | 1906 | [#4] prototype.html Cycles:180 Average:3626.61 Median:3975.95 stddev:1040.06 (26.2%) stddev-sans-first:1012.02 15:34:13 INFO - PROCESS | 1906 | Values: 270.5 316.5 329.2 333.2 338.7 3683.4 4212.5 4213.8 4278.4 4367.5 3421.9 4168.8 4209.1 4224.0 4234.2 3034.5 3141.6 3284.4 3349.1 3366.7 2758.4 3336.5 3360.5 3388.7 3430.7 3302.5 3394.0 3399.6 3410.7 3416.7 2970.2 3292.1 3434.7 3437.9 3446.6 2893.3 2893.8 2982.3 3003.4 3033.2 3496.7 3514.4 3777.5 4060.7 4065.4 3188.4 3827.7 3933.5 3937.0 4015.8 4238.5 4498.9 4523.8 4531.7 4555.7 2952.0 3290.5 3293.2 3347.4 3442.7 3797.1 4096.9 4209.4 4541.9 4702.2 3488.5 3516.3 3518.7 3527.7 3536.7 3273.6 3568.1 3574.3 3596.3 3597.0 3269.8 3605.2 3830.6 3962.2 3973.1 4012.3 4567.3 4614.1 4618.1 4631.9 1006.8 1115.4 1156.8 1160.2 1163.6 786.9 842.8 844.2 852.9 853.0 3367.0 3540.2 3806.2 3895.0 3920.2 3978.8 4504.5 4553.0 4565.9 4634.8 4078.7 4081.2 4115.0 4134.7 4197.3 2010.0 2091.5 2337.6 2338.8 2348.3 4435.3 4543.5 4582.3 4630.4 4676.4 3617.8 3667.7 4301.5 4456.4 4585.8 4552.7 4625.6 4654.4 4654.6 4670.4 3842.3 3953.8 4173.6 4222.8 4283.8 4416.3 4429.2 4453.8 4460.9 4468.3 3832.7 4121.9 4574.2 4638.7 4684.0 2956.6 3105.4 3206.3 3314.6 3322.8 3718.5 3912.5 4370.5 4394.2 4404.6 3545.2 4112.8 4344.2 4346.1 4398.5 3698.3 4016.7 4020.8 4055.3 4332.5 4095.0 4247.3 4262.2 4271.1 4438.9 3715.7 4507.4 4556.3 4564.5 4568.3 3930.6 4034.1 4138.6 4419.4 4486.7 15:34:13 INFO - PROCESS | 1906 | 15:34:13 INFO - PROCESS | 1906 | [#5] yui.html Cycles:180 Average:20371.18 Median:24329.97 stddev:30062.04 (123.6%) stddev-sans-first:30109.83 15:34:13 INFO - PROCESS | 1906 | Values: 629.5 679.6 743.1 775.2 808.6 14526.3 15505.4 15554.9 15617.7 15629.2 14136.6 14253.5 14288.7 15209.5 15807.4 665.4 688.7 830.2 850.3 863.0 854.3 854.9 856.7 859.6 859.7 901.1 902.0 903.3 908.8 909.9 895.6 897.6 898.3 899.9 901.9 662.3 670.3 670.4 671.5 672.2 14992.7 15335.8 15349.5 15362.4 15428.3 11131.0 13634.2 13874.5 13925.8 13958.7 10125.9 10804.9 10816.6 11404.4 11925.8 3082.6 3240.5 3256.6 3617.2 3756.7 55107.7 82512.2 87118.0 114168.4 114391.0 10625.4 10731.4 10734.7 10865.4 10904.9 21554.0 21868.5 21881.7 21885.0 22273.7 7364.2 7398.0 7495.4 7515.7 7718.2 4038.7 4164.3 4171.7 4174.9 4199.6 2647.0 3459.0 3481.2 3488.2 3514.9 597.4 607.7 621.3 624.3 625.4 531.8 562.6 580.9 595.0 616.7 9826.6 10064.9 10081.5 10367.6 10401.8 573.6 594.7 597.1 601.5 607.6 4326.3 4594.6 4908.9 4912.4 4918.9 99252.0 107445.9 108699.5 109450.0 114475.0 72192.0 94600.0 96800.5 96824.0 98162.5 81379.6 85120.6 85294.0 85778.6 86943.1 8180.3 9602.5 9606.0 9625.8 9698.4 44065.3 52886.7 54572.7 54833.6 55179.4 73200.6 73950.0 74536.0 75397.0 78512.6 9870.9 11284.3 11319.7 11369.3 11962.3 12697.0 12762.5 12866.5 13091.1 13101.7 11300.2 11511.1 11770.6 12005.5 12139.2 10390.9 11224.8 11921.6 12086.5 12307.1 11609.8 11760.7 12145.4 12145.5 12176.8 10005.2 10254.4 10521.4 10534.8 10558.8 9077.7 9121.6 9302.3 9906.5 9913.1 15:34:13 INFO - PROCESS | 1906 | -------- Summary: end -------- 15:34:13 INFO - PROCESS | 1906 | 15:34:14 INFO - TEST-INFO | 1906: exit 0 15:34:14 INFO - TEST-OK | dromaeo_css | took 1115794ms 15:34:14 INFO - TEST-START | kraken 15:34:14 INFO - operating with platform_type : mac_ 15:34:14 INFO - Initialising browser for kraken test... 15:34:14 INFO - TEST-INFO | started process 1914 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmpdNDHYj/profile http://localhost:51757/getInfo.html) 15:34:17 INFO - PROCESS | 1914 | 2017-01-10 15:34:17.422 plugin-container[1915:16804] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893b, name = 'com.apple.tsm.portname' 15:34:17 INFO - PROCESS | 1914 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:34:17 INFO - PROCESS | 1914 | 2017-01-10 15:34:17.425 plugin-container[1915:16804] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 15:34:17 INFO - PROCESS | 1914 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:34:17 INFO - PROCESS | 1914 | 2017-01-10 15:34:17.425 plugin-container[1915:16804] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:34:17 INFO - PROCESS | 1914 | __metrics Screen width/height:1600/1200 15:34:17 INFO - PROCESS | 1914 | colorDepth:24 15:34:17 INFO - PROCESS | 1914 | Browser inner width/height: 1024/689 15:34:17 INFO - PROCESS | 1914 | __metrics 15:34:17 ERROR - PROCESS | 1914 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 15:34:18 INFO - TEST-INFO | 1914: exit 0 15:34:18 INFO - Browser initialized. 15:34:18 INFO - Running cycle 1/1 for kraken test... 15:34:18 INFO - TEST-INFO | started process 1916 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmpdNDHYj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:34:20 INFO - PROCESS | 1916 | 2017-01-10 15:34:20.847 plugin-container[1917:16922] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 15:34:20 INFO - PROCESS | 1916 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:34:20 INFO - PROCESS | 1916 | 2017-01-10 15:34:20.848 plugin-container[1917:16922] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x470b, name = 'com.apple.CFPasteboardClient' 15:34:20 INFO - PROCESS | 1916 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:34:20 INFO - PROCESS | 1916 | 2017-01-10 15:34:20.848 plugin-container[1917:16922] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:34:30 INFO - PROCESS | 1916 | RSS: Main: 232751104 15:34:30 INFO - PROCESS | 1916 | 15:34:33 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:51757/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51757/tests/kraken/driver.html?testName=audio-beat-detection) 15:34:34 INFO - PROCESS | 1916 | RSS: Main: 245579776 15:34:34 INFO - PROCESS | 1916 | 15:34:37 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:51757/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51757/tests/kraken/driver.html?testName=audio-dft) 15:34:38 INFO - PROCESS | 1916 | RSS: Main: 253665280 15:34:38 INFO - PROCESS | 1916 | 15:34:41 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:51757/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51757/tests/kraken/driver.html?testName=audio-fft) 15:34:42 INFO - PROCESS | 1916 | RSS: Main: 256458752 15:34:42 INFO - PROCESS | 1916 | 15:34:44 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:51757/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51757/tests/kraken/driver.html?testName=audio-oscillator) 15:34:45 INFO - PROCESS | 1916 | RSS: Main: 257568768 15:34:45 INFO - PROCESS | 1916 | 15:34:47 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:51757/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51757/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:34:47 INFO - PROCESS | 1916 | RSS: Main: 259272704 15:34:47 INFO - PROCESS | 1916 | 15:34:50 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:51757/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51757/tests/kraken/driver.html?testName=imaging-darkroom) 15:34:51 INFO - PROCESS | 1916 | RSS: Main: 264794112 15:34:51 INFO - PROCESS | 1916 | 15:34:54 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:51757/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51757/tests/kraken/driver.html?testName=imaging-desaturate) 15:34:55 INFO - PROCESS | 1916 | RSS: Main: 264376320 15:34:55 INFO - PROCESS | 1916 | 15:34:58 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:51757/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51757/tests/kraken/driver.html?testName=json-parse-financial) 15:34:59 INFO - PROCESS | 1916 | RSS: Main: 263892992 15:34:59 INFO - PROCESS | 1916 | 15:35:00 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:51757/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51757/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:35:01 INFO - PROCESS | 1916 | RSS: Main: 263446528 15:35:01 INFO - PROCESS | 1916 | 15:35:03 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:51757/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51757/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:35:04 INFO - PROCESS | 1916 | RSS: Main: 263434240 15:35:04 INFO - PROCESS | 1916 | 15:35:06 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:51757/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51757/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:35:07 INFO - PROCESS | 1916 | RSS: Main: 263495680 15:35:07 INFO - PROCESS | 1916 | 15:35:10 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:51757/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51757/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:35:11 INFO - PROCESS | 1916 | RSS: Main: 263766016 15:35:11 INFO - PROCESS | 1916 | 15:35:14 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:51757/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51757/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:35:15 INFO - PROCESS | 1916 | RSS: Main: 263610368 15:35:15 INFO - PROCESS | 1916 | 15:35:16 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:51757/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51757/tests/kraken/driver.html?testName=ai-astar) 15:35:17 INFO - PROCESS | 1916 | RSS: Main: 266792960 15:35:17 INFO - PROCESS | 1916 | 15:35:17 INFO - PROCESS | 1916 | __start_tp_report 15:35:17 INFO - PROCESS | 1916 | _x_x_mozilla_page_load 15:35:17 INFO - PROCESS | 1916 | _x_x_mozilla_page_load_details 15:35:17 INFO - PROCESS | 1916 | |i|pagename|runs| 15:35:17 INFO - PROCESS | 1916 | |0;ai-astar;112;121;126;108;164;183;162;122;123;121 15:35:17 INFO - PROCESS | 1916 | |1;audio-beat-detection;161;117;119;156;120;119;119;117;141;120 15:35:17 INFO - PROCESS | 1916 | |2;audio-dft;237;278;233;229;231;231;228;225;225;229 15:35:17 INFO - PROCESS | 1916 | |3;audio-fft;84;61;60;89;63;75;89;91;92;61 15:35:17 INFO - PROCESS | 1916 | |4;audio-oscillator;92;73;86;75;72;74;86;75;74;88 15:35:17 INFO - PROCESS | 1916 | |5;imaging-gaussian-blur;95;113;80;120;138;119;93;88;94;106 15:35:17 INFO - PROCESS | 1916 | |6;imaging-darkroom;100;101;99;99;99;99;100;117;156;138 15:35:17 INFO - PROCESS | 1916 | |7;imaging-desaturate;165;126;124;101;164;163;145;111;112;108 15:35:17 INFO - PROCESS | 1916 | |8;json-parse-financial;66;65;65;65;66;65;66;66;63;65 15:35:17 INFO - PROCESS | 1916 | |9;json-stringify-tinderbox;78;77;77;90;85;81;76;80;79;77 15:35:17 INFO - PROCESS | 1916 | |10;stanford-crypto-aes;94;92;97;97;96;93;94;98;81;106 15:35:17 INFO - PROCESS | 1916 | |11;stanford-crypto-ccm;160;161;142;178;169;162;159;165;213;177 15:35:17 INFO - PROCESS | 1916 | |12;stanford-crypto-pbkdf2;186;189;183;183;187;216;248;188;184;182 15:35:17 INFO - PROCESS | 1916 | |13;stanford-crypto-sha256-iterative;78;70;72;71;71;73;74;73;71;75 15:35:17 INFO - PROCESS | 1916 | __end_tp_report 15:35:17 INFO - PROCESS | 1916 | __start_cc_report 15:35:17 INFO - PROCESS | 1916 | _x_x_mozilla_cycle_collect,972 15:35:17 INFO - PROCESS | 1916 | __end_cc_report 15:35:17 INFO - PROCESS | 1916 | __startTimestamp1484091317090__endTimestamp 15:35:17 INFO - PROCESS | 1916 | 15:35:17 INFO - PROCESS | 1916 | ------- Summary: start ------- 15:35:17 INFO - PROCESS | 1916 | Number of tests: 14 15:35:17 INFO - PROCESS | 1916 | 15:35:17 INFO - PROCESS | 1916 | [#0] ai-astar Cycles:10 Average:134.20 Median:124.50 stddev:25.63 (20.6%) stddev-sans-first:25.89 15:35:17 INFO - PROCESS | 1916 | Values: 112.0 121.0 126.0 108.0 164.0 183.0 162.0 122.0 123.0 121.0 15:35:17 INFO - PROCESS | 1916 | 15:35:17 INFO - PROCESS | 1916 | [#1] audio-beat-detection Cycles:10 Average:128.90 Median:120.00 stddev:17.15 (14.3%) stddev-sans-first:13.70 15:35:17 INFO - PROCESS | 1916 | Values: 161.0 117.0 119.0 156.0 120.0 119.0 119.0 117.0 141.0 120.0 15:35:17 INFO - PROCESS | 1916 | 15:35:17 INFO - PROCESS | 1916 | [#2] audio-dft Cycles:10 Average:234.60 Median:231.00 stddev:15.66 (6.8%) stddev-sans-first:16.59 15:35:17 INFO - PROCESS | 1916 | Values: 237.0 278.0 233.0 229.0 231.0 231.0 228.0 225.0 225.0 229.0 15:35:17 INFO - PROCESS | 1916 | 15:35:17 INFO - PROCESS | 1916 | [#3] audio-fft Cycles:10 Average:76.50 Median:86.50 stddev:13.97 (16.2%) stddev-sans-first:14.55 15:35:17 INFO - PROCESS | 1916 | Values: 84.0 61.0 60.0 89.0 63.0 75.0 89.0 91.0 92.0 61.0 15:35:17 INFO - PROCESS | 1916 | 15:35:17 INFO - PROCESS | 1916 | [#4] audio-oscillator Cycles:10 Average:79.50 Median:80.50 stddev:7.55 (9.4%) stddev-sans-first:6.51 15:35:17 INFO - PROCESS | 1916 | Values: 92.0 73.0 86.0 75.0 72.0 74.0 86.0 75.0 74.0 88.0 15:35:17 INFO - PROCESS | 1916 | 15:35:17 INFO - PROCESS | 1916 | [#5] imaging-gaussian-blur Cycles:10 Average:104.60 Median:84.00 stddev:17.80 (21.2%) stddev-sans-first:18.54 15:35:17 INFO - PROCESS | 1916 | Values: 95.0 113.0 80.0 120.0 138.0 119.0 93.0 88.0 94.0 106.0 15:35:17 INFO - PROCESS | 1916 | 15:35:17 INFO - PROCESS | 1916 | [#6] imaging-darkroom Cycles:10 Average:110.80 Median:127.50 stddev:20.30 (15.9%) stddev-sans-first:21.15 15:35:17 INFO - PROCESS | 1916 | Values: 100.0 101.0 99.0 99.0 99.0 99.0 100.0 117.0 156.0 138.0 15:35:17 INFO - PROCESS | 1916 | 15:35:17 INFO - PROCESS | 1916 | [#7] imaging-desaturate Cycles:10 Average:131.90 Median:135.50 stddev:25.21 (18.6%) stddev-sans-first:23.73 15:35:17 INFO - PROCESS | 1916 | Values: 165.0 126.0 124.0 101.0 164.0 163.0 145.0 111.0 112.0 108.0 15:35:17 INFO - PROCESS | 1916 | 15:35:17 INFO - PROCESS | 1916 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:65.50 stddev:0.92 (1.4%) stddev-sans-first:0.93 15:35:17 INFO - PROCESS | 1916 | Values: 66.0 65.0 65.0 65.0 66.0 65.0 66.0 66.0 63.0 65.0 15:35:17 INFO - PROCESS | 1916 | 15:35:17 INFO - PROCESS | 1916 | [#9] json-stringify-tinderbox Cycles:10 Average:80.00 Median:79.50 stddev:4.40 (5.5%) stddev-sans-first:4.60 15:35:17 INFO - PROCESS | 1916 | Values: 78.0 77.0 77.0 90.0 85.0 81.0 76.0 80.0 79.0 77.0 15:35:17 INFO - PROCESS | 1916 | 15:35:17 INFO - PROCESS | 1916 | [#10] stanford-crypto-aes Cycles:10 Average:94.80 Median:95.00 stddev:6.23 (6.6%) stddev-sans-first:6.60 15:35:17 INFO - PROCESS | 1916 | Values: 94.0 92.0 97.0 97.0 96.0 93.0 94.0 98.0 81.0 106.0 15:35:17 INFO - PROCESS | 1916 | 15:35:17 INFO - PROCESS | 1916 | [#11] stanford-crypto-ccm Cycles:10 Average:168.60 Median:167.00 stddev:18.61 (11.1%) stddev-sans-first:19.48 15:35:17 INFO - PROCESS | 1916 | Values: 160.0 161.0 142.0 178.0 169.0 162.0 159.0 165.0 213.0 177.0 15:35:17 INFO - PROCESS | 1916 | 15:35:17 INFO - PROCESS | 1916 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.60 Median:187.50 stddev:21.23 (11.3%) stddev-sans-first:22.29 15:35:17 INFO - PROCESS | 1916 | Values: 186.0 189.0 183.0 183.0 187.0 216.0 248.0 188.0 184.0 182.0 15:35:17 INFO - PROCESS | 1916 | 15:35:17 INFO - PROCESS | 1916 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:73.00 stddev:2.39 (3.3%) stddev-sans-first:1.64 15:35:17 INFO - PROCESS | 1916 | Values: 78.0 70.0 72.0 71.0 71.0 73.0 74.0 73.0 71.0 75.0 15:35:17 INFO - PROCESS | 1916 | -------- Summary: end -------- 15:35:17 INFO - PROCESS | 1916 | 15:35:17 INFO - TEST-INFO | 1916: exit 0 15:35:17 INFO - TEST-OK | kraken | took 63364ms 15:35:17 INFO - SUITE-END | took 1179s 15:35:18 INFO - Completed test suite (00:19:39) 15:35:18 INFO - javascript benchmark 15:35:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6623.844927235776, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2759.9862000689996, 2858.385447128867, 2858.499762541555, 2868.0392068656997, 2933.3253351729104, 4680.227762419197, 4735.484644913629, 4769.379980602521, 4813.2780082987565, 4883.804647814092, 4119.01143725506, 4750.762461876901, 4772.475027746945, 4809.0, 4837.951620483794, 3025.44029354569, 3258.3646188993157, 3360.663933606632, 4485.035717320776, 4539.827073224297, 4448.799804008828, 4483.843065492709, 4510.954890451087, 4539.72761634303, 4576.153411618861, 4512.548745125494, 4535.115652447774, 4564.475085365176, 4572.748498832563, 4589.35748995141, 3832.0419895026243, 4113.835446582133, 4276.935845962313, 4308.569143085698, 4384.583464570893, 3642.470162531743, 4335.761533115678, 4376.146651402978, 4400.11997600478, 4418.381426600278, 4503.1218912312115, 4642.280446530793, 4720.740359280238, 4752.762361881927, 4768.833090841838, 4211.43145675336, 5093.312402825608, 5163.251328557338, 5241.947580524184, 5251.842444726664, 5283.07546179417, 5319.0, 5340.359156901158, 5434.619576629638, 5478.972605136949, 5030.170021946375, 5057.9494205057845, 5060.544550990428, 5081.085404627165, 5096.541311282002, 5243.318368612056, 5492.176173573996, 5502.2296878437055, 5526.392096869341, 5564.610477266633, 5089.745512724349, 5117.334746482933, 5130.666506677054, 5193.298904647824, 5215.087359712035, 5267.157254839208, 5302.549283310885, 5305.283786688748, 5353.812616558402, 5397.812481254118, 5000.39995200571, 5121.28302037715, 5273.1035723927025, 5286.656367336111, 5300.31095957523, 5211.0, 5291.259223708684, 5294.523492885659, 5297.8145764898045, 5347.064263753828, 4221.472315960505, 4302.698811083194, 4345.304751239786, 4406.889827754268, 4415.558444155623, 3801.2967600993907, 3823.1589050408866, 3921.941170882439, 3966.2464131814863, 3981.7212795104065, 4864.8783780405065, 4875.146849301429, 4886.242632391985, 4899.265110233422, 4915.606751459874, 5368.355797304271, 5401.108817045222, 5403.486668766461, 5425.9186112208345, 5468.26178465902, 3844.6539811417106, 4387.849953522815, 4704.200285951397, 4853.757312134449, 4904.901901961941, 4651.976740116278, 4700.694454860423, 4722.905541889143, 4725.5510726480925, 4772.570468657768, 5568.582356323292, 5583.972080139573, 5590.413006634326, 5611.691356975324, 5629.155626655953, 5100.617453690914, 5359.517643412111, 5391.622586418913, 5395.055865223491, 5412.079946409199, 5214.139666955061, 5428.4842939920645, 5476.205950137288, 5513.0, 5515.751791169327, 3969.9678083699023, 5161.819336323361, 5212.166053431432, 5221.817236396708, 5239.345081864767, 4549.203889319289, 4641.814327426865, 5286.20706893969, 5298.125809241432, 5305.230741542532, 4402.5597440255715, 5226.425093239664, 5251.6323857331145, 5337.733113344395, 5363.329583802025, 5101.8724531887, 5195.350581177353, 5228.37259528859, 5266.552343050884, 5277.683338999673, 4241.427407299975, 4949.82675606352, 5063.316452278895, 5149.02168587982, 5184.948150518447, 5146.614003949793, 5158.3552055993005, 5190.039842629126, 5207.3751149862255, 5232.843014709565, 5107.38711354625, 5115.3094332266155, 5145.9965306764825, 5147.562457191031, 5183.5593974512585], "value": 4801.245264195219, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.9366148247021, 434.04510077828775, 437.39202508513154, 441.4966937691035, 458.2027272545769, 29941.70058299419, 30931.690683093162, 31483.21291967702, 40859.79570102145, 40989.51589114929, 41487.792561037226, 41836.16327673445, 41904.37143442851, 41912.37131443031, 41989.7900510497, 8879.86680199796, 9144.451332920013, 9149.496777677225, 9152.816943661122, 9179.0, 8186.877196842052, 8380.413371064027, 8851.601677924476, 10710.41092739899, 11015.83476247857, 10507.054365107138, 10918.0, 10986.615468458605, 10989.780204395907, 11032.28290161141, 9554.856677149814, 11077.944610276978, 11084.833727494093, 11106.500207490642, 11109.72225694356, 10883.891161088366, 10964.122870170368, 10967.451627418597, 10971.83542246867, 10996.28524145928, 39278.21443571141, 39292.80353598242, 39547.0, 39567.60432395668, 39635.801820991, 3736.57029441615, 3900.7854567998747, 3925.430812532167, 3926.666233370167, 3948.4077388391684, 28952.986645467518, 29840.70159298401, 30077.248068798453, 30088.548671769942, 30091.849540752373, 3107.6892310768967, 3131.8434078295995, 3137.62348518177, 3161.1780936956325, 3210.983945080283, 419111.0, 419423.0, 422071.0, 423149.9999999969, 423922.0, 56902.0, 57005.71497142488, 57172.0, 57195.71402143046, 57340.99999999916, 60928.390716093156, 61036.16891493263, 61049.08426373608, 61496.69251653802, 61656.0, 11192.496337664825, 14428.927855360866, 14662.926685366718, 14692.559223223321, 15138.697226055638, 9716.833979922314, 10179.592816287413, 10561.577536898592, 10684.732881678021, 11155.163362747664, 13906.30468476572, 14238.43046278158, 16628.734480357445, 20961.0, 21005.264815731374, 7434.516756410816, 8389.119142490074, 8563.700270490503, 8583.399162058597, 8590.570471476402, 628.2617923939445, 680.6766785776716, 686.6174374919023, 750.598429840033, 761.7600455856387, 26719.866400667874, 26838.5974210387, 27130.05044823461, 27450.862745686143, 27484.58773118405, 949.6496171974309, 959.2421986630484, 988.5551501824065, 994.3636072913341, 1101.4052411697594, 12069.0, 13307.46770129184, 14243.64390890236, 15233.6191595211, 15680.607984800472, 577506.0, 580175.0, 584766.0761696164, 584777.0, 586313.0, 58656.41343586509, 59243.0, 59460.70269648624, 59523.0, 59550.70224648936, 1125.1673761416494, 1294.7410517896458, 1304.6020963606002, 1317.426919290112, 1321.3327269728725, 23032.539349213257, 27395.04117355883, 28084.0, 28316.0, 29134.0, 49146.75426622844, 49306.0, 49334.76663083308, 49451.50548494469, 49744.50255497399, 476134.0, 476326.0, 476336.0, 477374.0, 477460.0, 33684.67347356996, 40301.79849100736, 41512.584874150874, 41614.16771664489, 41774.58225417707, 45929.08141837078, 47885.76057119692, 48659.0, 48971.51028489812, 49559.75220123876, 37857.81071094627, 37869.24261514809, 38021.61978380291, 39405.0, 39491.0, 32910.0, 34369.31261374809, 38006.80996594999, 38062.429063564625, 39378.60621393749, 35914.28171436609, 36708.71519496805, 37171.44242836306, 37275.6272437283, 37294.62705372911, 25603.23190304294, 26678.866605666848, 31357.686423135478, 33946.49080263847, 34114.82942585271, 23896.641550377106, 24549.64976926286, 24837.379065523506, 24858.50282994366, 25326.240212793644], "value": 19264.700609629843, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.9051974927271, 347.942589472737, 351.47805508819397, 364.60258318432903, 373.07477455909344, 18660.160292786823, 19296.324628637984, 20392.59214815703, 20432.08055637496, 20434.69347959778, 10707.982741639551, 16986.0, 18287.90272583646, 19084.95032773197, 19675.31136410226, 5157.097507936115, 5370.624056316059, 5384.865378365533, 5407.270018547505, 5407.675539467625, 5075.517825806561, 5210.192420174879, 5269.868253293679, 5280.577553795706, 5339.946600534003, 5321.467853214667, 5323.707196104213, 5325.254464374991, 5340.412554618989, 5352.946470535303, 4234.640055595278, 4284.8859296582805, 4856.0, 5252.789888404459, 5302.257683924254, 5141.897162056738, 5143.537081662668, 5151.098557752416, 5151.484851514856, 5156.458571849977, 13159.94720422364, 16721.414750483797, 24468.632970505456, 24552.754472455224, 24832.627510587357, 2166.739991201066, 2306.4925716342545, 2801.7618502427317, 2876.6979467156066, 2905.026816016637, 9710.465924374157, 9774.120329170337, 10063.496825158785, 10277.0, 12043.397830108459, 1753.114677088075, 1800.5858652509996, 1824.3705921457076, 1825.9269629214816, 1830.2404502131733, 109083.45458272737, 121607.05536501757, 123652.38173809163, 133062.00406993806, 139854.3007284957, 10530.31552949056, 11077.667669969915, 11439.714007149887, 11495.080393568494, 11503.942480287546, 13825.239611821446, 15000.69998600022, 15090.320935557926, 15101.622459438382, 15110.54668359951, 7905.446618736748, 8110.594470276463, 8118.35053195743, 8218.712345067894, 8231.135730748305, 7688.577128258, 7692.923070769332, 7694.961525192451, 7835.0, 7838.490498117604, 4668.626509879269, 4670.369500117441, 4688.132695451352, 4711.670183087151, 4760.785764640599, 1908.6946088625753, 1958.6474434601623, 1965.4005528313717, 1972.7435433393566, 1978.366922584759, 819.4100247821559, 831.7421599304236, 861.4185424838334, 861.9741407757778, 885.4587334350327, 20434.154558222865, 20722.067506962223, 21684.241051563436, 21886.343409697736, 21916.23293184731, 901.8827552418144, 927.4342650982895, 943.2501161576563, 950.2825366847985, 958.3818437108026, 11051.502682379152, 11157.0, 11171.050460710769, 11189.664310070712, 11280.379579123228, 625425.0, 652559.0, 660567.0, 671446.0, 692562.0, 106434.0, 138997.0, 141808.0, 147536.0, 156065.0, 710.5488015110442, 895.6372669068908, 911.9452832830051, 915.1671978499534, 915.3638221436038, 13500.987425942898, 14541.127532348093, 15430.996985195927, 19218.903905480944, 19830.909299988638, 44863.065062843714, 54760.63098422571, 55946.0, 55999.0, 57517.13724294055, 70001.59996800138, 78198.21801781909, 87621.68567471621, 89606.0, 90448.54775726079, 5949.8215053548465, 7628.656710448154, 8245.711400100967, 8268.131846156308, 8381.58092095405, 12223.511059557519, 12558.811617825922, 12664.87335126637, 12866.0, 12940.41768120418, 10356.844647330447, 10667.199960003187, 10856.2400631955, 11047.834282485608, 11291.830622540832, 8511.489310641382, 9433.962264150801, 9716.659916902874, 10786.676399708022, 11246.325220486797, 10988.0, 11251.943740281245, 11263.718407039889, 11307.830382544103, 11426.828597570877, 6294.34835979675, 7926.603669816602, 8176.141505141874, 8179.468334558234, 8238.50568965864, 7918.81217817332, 9278.768030799283, 11009.889901100887, 11087.833682494931, 11244.156688248579], "value": 9228.309590353063, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1208.7099096216912, 1214.4656351205472, 1336.204958049961, 1352.053562506246, 1383.8201033865598, 7189.1013623297085, 7451.143118541369, 7667.654955527, 8146.470479418841, 8160.510369377834, 7561.962190189041, 7873.0, 7928.6035698215, 7931.167227441122, 8008.519488830674, 2113.577284543094, 2191.802737753602, 2192.506685995654, 2200.713907192063, 2208.2271205078255, 1509.6527798606328, 1832.25793553611, 2176.46676564242, 2213.1700612270397, 2222.7888350606668, 1720.9655806883854, 2156.676498525218, 2157.9568408631817, 2173.652215645497, 2173.8586991845477, 2195.4182141732454, 2200.548887478063, 2225.4881377283236, 2225.5882661707637, 2230.130249202812, 2176.7279090113734, 2224.2326397393035, 2241.618924782791, 2245.6631505274177, 2247.78646028627, 7959.602019898982, 7961.800954976172, 8054.43618946674, 8067.596620169027, 8075.0, 4820.25286080658, 4977.104121258172, 4979.800807967713, 4993.5019494151975, 4998.700077995296, 3235.4499735045097, 3300.933981320384, 3338.8998330050135, 3362.4451965425674, 3367.9158021049425, 1127.7988941776982, 1167.2471256039892, 1198.568515334479, 1205.1555537834367, 1220.371508673034, 7719.3052625264, 8086.353091752704, 9964.25268104895, 10132.138768204712, 10279.126274266697, 3834.213986132836, 4427.048184640318, 4493.932591011072, 4505.166544189336, 4506.098780243964, 9039.77400564978, 9120.635174593075, 9150.130737579919, 9151.130642588943, 9246.4914429707, 4926.45808961014, 5025.949740502549, 5026.195808670595, 5029.823956161516, 5061.0, 4317.870463886088, 4462.48681401643, 4513.458384993822, 4591.1965406053805, 4610.469795973506, 3331.783434076777, 3381.5773028371455, 3392.1858753898887, 3397.1167496450607, 3422.57217847769, 1004.542932965499, 1017.9796404071877, 1066.5733706517456, 1075.510642657589, 1076.9537878031647, 683.6820878291519, 698.7135274537517, 704.9048378468943, 733.5598640815468, 750.0212223048865, 5218.139007063868, 5316.3354580677415, 5589.245451864028, 5628.549716022709, 5671.489565939003, 871.5380848150363, 886.6985225023394, 886.9533949939133, 897.7441429192648, 908.3868388837508, 3665.1203711109674, 3728.5898551159353, 3796.9050773730323, 3856.787876666754, 3877.427759946919, 9060.637574496946, 9487.478188699688, 9514.90485095154, 9516.048395160567, 9527.999560046095, 9478.715638530855, 9480.194183494481, 9484.05159484046, 9507.0, 9647.035296470438, 7346.96326518364, 7506.549607023596, 7510.84978300431, 7516.887246691304, 7548.207438219018, 5074.314967479343, 5368.677879327252, 5389.461053894579, 5415.1335786274, 5471.945280547303, 8050.033995920527, 8535.445196062235, 8631.741047768577, 8656.091110433566, 8705.521196334263, 8112.43212975086, 8807.603657835285, 8892.110788921056, 8940.955295223483, 8941.37410381267, 6314.147590075281, 6514.153160089348, 6517.641529715722, 6524.5432819704065, 6543.869122617426, 7435.219301973431, 7447.5531468112085, 7472.813179670552, 7502.099748030271, 7534.849303014019, 6072.939270607414, 6822.317768223138, 6866.553674011373, 6917.896231556631, 6934.410575100971, 6572.967135164294, 6694.4644428444635, 6747.932520674731, 6817.181938167451, 6834.726610935507, 6019.217501724747, 6116.816495505142, 6138.1713468681155, 6151.138840562236, 6171.413715697002, 3935.586763389803, 4521.796519156712, 4557.860534866283, 4672.112298663243, 4792.928106078341, 3869.709771767072, 4466.4640243171025, 4552.476465206543, 4928.236123400879, 4997.800087996439], "value": 4135.864415451958, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [270.5292790544453, 316.48729058924533, 329.2443841384023, 333.2136158665549, 338.7239399889092, 3683.410654295313, 4212.536620971695, 4213.8314467421305, 4278.4010238566625, 4367.541408152142, 3421.9315613687713, 4168.812403441845, 4209.084866385795, 4223.978880105603, 4234.216669916068, 3034.453798316313, 3141.6387115481725, 3284.425225585525, 3349.145967778213, 3366.73066154707, 2758.3655759175404, 3336.498575640959, 3360.54632624595, 3388.695017448429, 3430.708389786871, 3302.455094909349, 3394.0, 3399.5750531183603, 3410.7380269300393, 3416.7437442191813, 2970.212893583202, 3292.094673964667, 3434.708049815769, 3437.9312413751586, 3446.6036405813275, 2893.291143669793, 2893.755685055425, 2982.3438843454405, 3003.3843062172423, 3033.226527235563, 3496.6503349665086, 3514.38498262803, 3777.471154038437, 4060.654844338235, 4065.4105154752397, 3188.3942051010467, 3827.67945058957, 3933.5476420211758, 3936.9606303937167, 4015.8393664253394, 4238.452964667874, 4498.910021799546, 4523.773811309421, 4531.682782205247, 4555.74943378114, 2951.95205701977, 3290.4735242361107, 3293.2096296888813, 3347.3640008398324, 3442.707369873564, 3797.1331644608144, 4096.877093687164, 4209.3896385024, 4541.932645828228, 4702.153612349775, 3488.5464889564196, 3516.3143187078786, 3518.683318501347, 3527.6648718372226, 3536.7091011780517, 3273.558069660613, 3568.054465566575, 3574.285142971416, 3596.3346780845627, 3596.98201508996, 3269.7901776342906, 3605.2068544920076, 3830.559485659129, 3962.2075584882564, 3973.0861901762755, 4012.3256406286932, 4567.337736028324, 4614.077184563101, 4618.145643056046, 4631.907361852812, 1006.8137394582026, 1115.4422788605698, 1156.8142653779944, 1160.182071639492, 1163.5694792926502, 786.8701664225339, 842.7935155886724, 844.2401838345415, 852.9488230706054, 852.9658813647509, 3367.040393487844, 3540.2211513466996, 3806.2006978534264, 3895.0, 3920.196359746245, 3978.8116535905715, 4504.48198457175, 4552.975580494429, 4565.876867256741, 4634.768261586974, 4078.6737061035046, 4081.163361510883, 4114.979425102855, 4134.720564216022, 4197.349410841324, 2010.0150926046424, 2091.4980404703065, 2337.6026075567192, 2338.801201897858, 2348.2602980061224, 4435.3125265583885, 4543.45478542577, 4582.312653102062, 4630.351750754897, 4676.438827340741, 3617.819109044537, 3667.7184853810427, 4301.548337424588, 4456.398386217819, 4585.816567337336, 4552.726836389827, 4625.560571745679, 4654.4181977252165, 4654.557817007379, 4670.416197975253, 3842.2507611015585, 3953.822078006439, 4173.561776013475, 4222.811777108263, 4283.785810709514, 4416.315471101984, 4429.247028005182, 4453.75504347264, 4460.888477788081, 4468.329750537446, 3832.712546559075, 4121.855735049379, 4574.153781550423, 4638.6752927294765, 4684.009296049234, 2956.645202575705, 3105.378924215211, 3206.342699746593, 3314.6188188358647, 3322.8172450515453, 3718.4608231805696, 3912.5304963404574, 4370.519242883217, 4394.209042372404, 4404.603585677304, 3545.15651861036, 4112.848402447319, 4344.153734662819, 4346.130773845181, 4398.516163221979, 3698.2973235085246, 4016.718829681894, 4020.819063142107, 4055.3105971985424, 4332.545082766264, 4095.0171958730284, 4247.320428731388, 4262.188569857736, 4271.060366719316, 4438.9334159988275, 3715.7213209009974, 4507.4365704286965, 4556.33933079695, 4564.520725323926, 4568.327528395926, 3930.567637559809, 4034.0519977804606, 4138.6482149017675, 4419.403380543586, 4486.663500237561], "value": 3322.3982610770486, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.540435482098, 679.6397909108168, 743.0897150990038, 775.1589525364978, 808.6401551309666, 14526.273686315682, 15505.379784808621, 15554.922225388871, 15617.687646247097, 15629.218539073043, 14136.646583835409, 14253.501127460515, 14288.71422571548, 15209.4676686316, 15807.446739364095, 665.3911670821204, 688.7348370877198, 830.2071521696765, 850.3154960256991, 862.9989212513485, 854.2952064546743, 854.9230569248766, 856.7429771068686, 859.5530324231396, 859.7334826203897, 901.0989010989011, 901.9819603607924, 903.327021369081, 908.8091500784843, 909.9317551183688, 895.5835536475505, 897.5557099235855, 898.290350623007, 899.9235065019482, 901.8647202919549, 662.2549631664377, 670.3196255800367, 670.3531092495716, 671.5467059734708, 672.1732269308777, 14992.700145997129, 15335.846641533553, 15349.462768803038, 15362.385504579803, 15428.305726242346, 11131.0, 13634.181949083088, 13874.514391996332, 13925.791113133311, 13958.651033724136, 10125.89874101257, 10804.891951080468, 10816.567337306498, 11404.429778511041, 11925.821112683318, 3082.568440418343, 3240.5301231321564, 3256.560364350806, 3617.222297206113, 3756.69946404287, 55107.72446137784, 82512.18299353555, 87118.0, 114168.42915785451, 114391.0, 10625.415602141802, 10731.409772462433, 10734.7017834882, 10865.402402867918, 10904.945475272572, 21554.03006864695, 21868.45328866791, 21881.67177492339, 21885.0, 22273.66358018524, 7364.189939106694, 7398.0, 7495.400367970549, 7515.661795219228, 7718.228177182349, 4038.6567141793275, 4164.292070348048, 4171.687123465752, 4174.91650166995, 4199.622034016953, 2646.9602955955293, 3458.9654103459147, 3481.234128491728, 3488.1977145256224, 3514.9297014059575, 597.3518732175552, 607.6688204928324, 621.273110460762, 624.3444383397415, 625.3777491395999, 531.8431062836472, 562.5780664501624, 580.8615114375787, 594.9851253718605, 616.6893415029004, 9826.606935722633, 10064.899351006396, 10081.546330415149, 10367.585296588051, 10401.791964160826, 573.5612256623687, 594.6877889108252, 597.1073245497921, 601.5278006764669, 607.5686262753494, 4326.286162783168, 4594.609458196091, 4908.9263661045115, 4912.4350699669285, 4918.926216106761, 99252.0, 107445.8510829779, 108699.45650271697, 109450.0, 114475.0, 72192.0, 94600.0, 96800.54799178019, 96824.0, 98162.5091874536, 81379.59310203411, 85120.57439712886, 85294.0, 85778.57110714406, 86943.13056869477, 8180.263776260165, 9602.519874006412, 9605.951970240105, 9625.807483850143, 9698.418094914328, 44065.339019915365, 52886.73556632192, 54572.727136365655, 54833.62915927134, 55179.44820551743, 73200.6339968318, 73950.0, 74536.0, 75397.0, 78512.60743696245, 9870.851937220803, 11284.32294062359, 11319.660410187707, 11369.2609980351, 11962.34207118582, 12697.0, 12762.48950042025, 12866.485340586272, 13091.149075310075, 13101.672458188621, 11300.152488563226, 11511.079113671054, 11770.646880593597, 12005.459754311252, 12139.150259481752, 10390.948045259725, 11224.7755044897, 11921.582744603897, 12086.516539338329, 12307.138500304893, 11609.76780464369, 11760.70598235051, 12145.392730363623, 12145.45345459474, 12176.756464870476, 10005.249606279413, 10254.436006019741, 10521.368717876952, 10534.789652053763, 10558.8416173759, 9077.700474563642, 9121.635134594542, 9302.255819534286, 9906.541130322343, 9913.071059700216], "value": 7200.156798468086, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1676.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 121.0, 126.0, 108.0, 164.0, 183.0, 162.0, 122.0, 123.0, 121.0], "value": 134.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 117.0, 119.0, 156.0, 120.0, 119.0, 119.0, 117.0, 141.0, 120.0], "value": 128.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [237.0, 278.0, 233.0, 229.0, 231.0, 231.0, 228.0, 225.0, 225.0, 229.0], "value": 234.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 61.0, 60.0, 89.0, 63.0, 75.0, 89.0, 91.0, 92.0, 61.0], "value": 76.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 73.0, 86.0, 75.0, 72.0, 74.0, 86.0, 75.0, 74.0, 88.0], "value": 79.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 113.0, 80.0, 120.0, 138.0, 119.0, 93.0, 88.0, 94.0, 106.0], "value": 104.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 101.0, 99.0, 99.0, 99.0, 99.0, 100.0, 117.0, 156.0, 138.0], "value": 110.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 126.0, 124.0, 101.0, 164.0, 163.0, 145.0, 111.0, 112.0, 108.0], "value": 131.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0, 66.0, 63.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 90.0, 85.0, 81.0, 76.0, 80.0, 79.0, 77.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 97.0, 97.0, 96.0, 93.0, 94.0, 98.0, 81.0, 106.0], "value": 94.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 142.0, 178.0, 169.0, 162.0, 159.0, 165.0, 213.0, 177.0], "value": 168.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 189.0, 183.0, 183.0, 187.0, 216.0, 248.0, 188.0, 184.0, 182.0], "value": 194.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 70.0, 72.0, 71.0, 71.0, 73.0, 74.0, 73.0, 71.0, 75.0], "value": 72.8, "unit": "score"}]}]} 15:35:18 INFO - Return code: 0 15:35:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:35:18 ERROR - # TBPL SUCCESS # 15:35:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:35:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:35:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:35:18 INFO - 2017-01-10 15:35:18.425 screenresolution[1921:17320] starting screenresolution argv=screenresolution get 15:35:18 INFO - 2017-01-10 15:35:18.428 screenresolution[1921:17320] Display 0: 1600x1200x32@60 15:35:18 INFO - 2017-01-10 15:35:18.434 screenresolution[1922:17323] starting screenresolution argv=screenresolution list 15:35:18 INFO - Available Modes on Display 0 15:35:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:35:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:35:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:35:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:35:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:35:18 INFO - Intel Iris: 15:35:18 INFO - Chipset Model: Intel Iris 15:35:18 INFO - Type: GPU 15:35:18 INFO - Bus: Built-In 15:35:18 INFO - VRAM (Dynamic, Max): 1536 MB 15:35:18 INFO - Vendor: Intel (0x8086) 15:35:18 INFO - Device ID: 0x0a2e 15:35:18 INFO - Revision ID: 0x0009 15:35:18 INFO - Displays: 15:35:18 INFO - Display: 15:35:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:35:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:35:18 INFO - Display Serial Number: 1600x1200 60 15:35:18 INFO - Main Display: Yes 15:35:18 INFO - Mirror: Off 15:35:18 INFO - Online: Yes 15:35:18 INFO - Rotation: Supported 15:35:18 INFO - Return code: 0 15:35:18 INFO - Running post-action listener: _resource_record_post_action 15:35:18 INFO - [mozharness: 2017-01-10 23:35:18.684634Z] Finished run-tests step (success) 15:35:18 INFO - Running post-run listener: _resource_record_post_run 15:35:18 INFO - Total resource usage - Wall time: 1203s; CPU: 55.0%; Read bytes: 1660416; Write bytes: 553229312; Read time: 20; Write time: 1669 15:35:18 INFO - TinderboxPrint: CPU usage
54.9% 15:35:18 INFO - TinderboxPrint: I/O read bytes / time
1,660,416 / 20 15:35:18 INFO - TinderboxPrint: I/O write bytes / time
553,229,312 / 1,669 15:35:18 INFO - TinderboxPrint: CPU idle
2,172.8 (45.1%) 15:35:18 INFO - TinderboxPrint: CPU system
975.2 (20.3%) 15:35:18 INFO - TinderboxPrint: CPU user
1,665.7 (34.6%) 15:35:18 INFO - TinderboxPrint: Swap in / out
252,067,840 / 0 15:35:18 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 250657280; Write bytes: 252700160; Read time: 19189; Write time: 567 15:35:18 INFO - run-tests - Wall time: 1180s; CPU: 55.0%; Read bytes: 1603072; Write bytes: 299116032; Read time: 19; Write time: 1095 15:35:19 INFO - Running post-run listener: _upload_blobber_files 15:35:19 INFO - Blob upload gear active. 15:35:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:35:19 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 15:35:19 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'] 15:35:19 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 15:35:19 INFO - (blobuploader) - INFO - Open directory for files ... 15:35:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:35:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:35:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:35:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:35:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:35:20 INFO - (blobuploader) - INFO - Done attempting. 15:35:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:35:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:35:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:35:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:35:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:35:21 INFO - (blobuploader) - INFO - Done attempting. 15:35:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:35:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:35:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:35:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:35:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:35:22 INFO - (blobuploader) - INFO - Done attempting. 15:35:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:35:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:35:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:35:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:35:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:35:25 INFO - (blobuploader) - INFO - Done attempting. 15:35:25 INFO - (blobuploader) - INFO - Iteration through files over. 15:35:25 INFO - Return code: 0 15:35:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:35:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:35:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05d2a7a7ed9bfdad4f631ff24c8f0d7e55b4518d97dc7fb1e5acacafabb60e38e99b334b452c60529519a57caf5e6f5ae97f17b6c026469ea7e08d6df063bff3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6ceabbd7718d495c4af39baaf07d883e36df9cca74c6909f7e9667e684ca4eb276ba2da5d695420b1bd2f48c6008329d85d333c08c4e1c1e463d57c2d0264d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d335cf8b0753d00380baa0b1157a8e16a0fddfff963225abb0acde35dfcff6604b8e02a16592bc5686537c5d3acefb4de85291ca0bf4658e37c18a52f5abf49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2b5b3333233e66eccb032b91b648da9f31c931c2662842cf31564541d4f0fcc3ede6c0e890b3165879baf259cb9d83d727a045fff6b62433778acb5f38f8cbc"} 15:35:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:35:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:35:25 INFO - Contents: 15:35:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05d2a7a7ed9bfdad4f631ff24c8f0d7e55b4518d97dc7fb1e5acacafabb60e38e99b334b452c60529519a57caf5e6f5ae97f17b6c026469ea7e08d6df063bff3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6ceabbd7718d495c4af39baaf07d883e36df9cca74c6909f7e9667e684ca4eb276ba2da5d695420b1bd2f48c6008329d85d333c08c4e1c1e463d57c2d0264d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d335cf8b0753d00380baa0b1157a8e16a0fddfff963225abb0acde35dfcff6604b8e02a16592bc5686537c5d3acefb4de85291ca0bf4658e37c18a52f5abf49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2b5b3333233e66eccb032b91b648da9f31c931c2662842cf31564541d4f0fcc3ede6c0e890b3165879baf259cb9d83d727a045fff6b62433778acb5f38f8cbc"} 15:35:25 INFO - Running post-run listener: copy_logs_to_upload_dir 15:35:25 INFO - Copying logs to upload dir... 15:35:25 INFO - mkdir: /builds/slave/test/build/upload/logs 15:35:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.114129 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2017-01-10 15:35:25.184584) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 15:35:25.188229) ========= 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.Cd889FpU3Q/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.B5CrLjHGUU/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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/05d2a7a7ed9bfdad4f631ff24c8f0d7e55b4518d97dc7fb1e5acacafabb60e38e99b334b452c60529519a57caf5e6f5ae97f17b6c026469ea7e08d6df063bff3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6ceabbd7718d495c4af39baaf07d883e36df9cca74c6909f7e9667e684ca4eb276ba2da5d695420b1bd2f48c6008329d85d333c08c4e1c1e463d57c2d0264d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d335cf8b0753d00380baa0b1157a8e16a0fddfff963225abb0acde35dfcff6604b8e02a16592bc5686537c5d3acefb4de85291ca0bf4658e37c18a52f5abf49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2b5b3333233e66eccb032b91b648da9f31c931c2662842cf31564541d4f0fcc3ede6c0e890b3165879baf259cb9d83d727a045fff6b62433778acb5f38f8cbc"} build_url:https://queue.taskcluster.net/v1/task/Q2hg10i3R7WjSq_Li1M6aA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.012389 build_url: 'https://queue.taskcluster.net/v1/task/Q2hg10i3R7WjSq_Li1M6aA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05d2a7a7ed9bfdad4f631ff24c8f0d7e55b4518d97dc7fb1e5acacafabb60e38e99b334b452c60529519a57caf5e6f5ae97f17b6c026469ea7e08d6df063bff3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6ceabbd7718d495c4af39baaf07d883e36df9cca74c6909f7e9667e684ca4eb276ba2da5d695420b1bd2f48c6008329d85d333c08c4e1c1e463d57c2d0264d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d335cf8b0753d00380baa0b1157a8e16a0fddfff963225abb0acde35dfcff6604b8e02a16592bc5686537c5d3acefb4de85291ca0bf4658e37c18a52f5abf49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2b5b3333233e66eccb032b91b648da9f31c931c2662842cf31564541d4f0fcc3ede6c0e890b3165879baf259cb9d83d727a045fff6b62433778acb5f38f8cbc"}' ========= master_lag: 0.10 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 15:35:25.300675) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 15:35:25.301059) ========= 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.Cd889FpU3Q/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.B5CrLjHGUU/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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.005656 ========= master_lag: 0.15 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 15:35:25.455343) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 15:35:25.455749) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 15:35:25.456314) ========= ========= Total master_lag: 0.41 =========