builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0274 starttime: 1491997406.18 results: success (0) buildid: 20170412024510 builduid: 73ec3e6ce1724308b27af787bba100d2 revision: 65875bd4b7df1e5e29f1b07927d88d37b9ddded0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-12 04:43:26.183163) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-12 04:43:26.184189) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-12 04:43:26.184876) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-12 04:43:26.213433) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 04:43:26.214149) ========= 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.x9A1ZJB3aP/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.njkY2zFP6w/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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-04-12 04:43:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 11.1M=0.001s 2017-04-12 04:43:26 (11.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136421 ========= master_lag: 0.24 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 04:43:26.589280) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 04:43:26.589629) ========= 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.x9A1ZJB3aP/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.njkY2zFP6w/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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.026282 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 04:43:26.638082) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-12 04:43:26.638444) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 65875bd4b7df1e5e29f1b07927d88d37b9ddded0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 65875bd4b7df1e5e29f1b07927d88d37b9ddded0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.x9A1ZJB3aP/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.njkY2zFP6w/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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-04-12 04:43:26,771 truncating revision to first 12 chars 2017-04-12 04:43:26,771 Setting DEBUG logging. 2017-04-12 04:43:26,771 attempt 1/10 2017-04-12 04:43:26,771 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/65875bd4b7df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-12 04:43:27,883 unpacking tar archive at: mozilla-aurora-65875bd4b7df/testing/mozharness/ program finished with exit code 0 elapsedTime=1.412669 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-12 04:43:28.075193) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-12 04:43:28.075557) ========= script_repo_revision: 65875bd4b7df1e5e29f1b07927d88d37b9ddded0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-12 04:43:28.076050) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-12 04:43:28.076352) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-12 04:43:28.095920) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-12 04:43:28.096312) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.x9A1ZJB3aP/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.njkY2zFP6w/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 04:43:28 INFO - MultiFileLogger online at 20170412 04:43:28 in /builds/slave/test 04:43:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:43:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:43:28 INFO - {'append_to_log': False, 04:43:28 INFO - 'base_work_dir': '/builds/slave/test', 04:43:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:43:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:43:28 INFO - 'branch': 'Mozilla-Aurora', 04:43:28 INFO - 'buildbot_json_path': 'buildprops.json', 04:43:28 INFO - 'config_files': ('talos/mac_config.py',), 04:43:28 INFO - 'default_actions': ('clobber', 04:43:28 INFO - 'read-buildbot-config', 04:43:28 INFO - 'download-and-extract', 04:43:28 INFO - 'populate-webroot', 04:43:28 INFO - 'create-virtualenv', 04:43:28 INFO - 'install', 04:43:28 INFO - 'run-tests'), 04:43:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:43:28 INFO - 'download_minidump_stackwalk': True, 04:43:28 INFO - 'download_symbols': 'ondemand', 04:43:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:43:28 INFO - 'tooltool.py': '/tools/tooltool.py', 04:43:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:43:28 INFO - '/tools/misc-python/virtualenv.py')}, 04:43:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:43:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:43:28 INFO - 'gecko_profile': False, 04:43:28 INFO - 'gecko_profile_interval': 0, 04:43:28 INFO - 'installer_path': 'installer.exe', 04:43:28 INFO - 'log_level': 'info', 04:43:28 INFO - 'log_name': 'talos', 04:43:28 INFO - 'log_to_console': True, 04:43:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:43:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:43:28 INFO - 'opt_config_files': (), 04:43:28 INFO - 'pip_index': False, 04:43:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:43:28 INFO - 'cmd': ('bash', 04:43:28 INFO - '-c', 04:43:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:43:28 INFO - 'enabled': True, 04:43:28 INFO - 'halt_on_failure': False, 04:43:28 INFO - 'name': 'check_screen_resolution'},), 04:43:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:43:28 INFO - 'cmd': ('bash', 04:43:28 INFO - '-c', 04:43:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:43:28 INFO - 'enabled': True, 04:43:28 INFO - 'halt_on_failure': False, 04:43:28 INFO - 'name': 'check_screen_resolution'},), 04:43:28 INFO - 'run_cmd_checks_enabled': True, 04:43:28 INFO - 'suite': 'dromaeojs-e10s', 04:43:28 INFO - 'system_bits': '32', 04:43:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:43:28 INFO - 'title': 't-yosemite-r7-0274', 04:43:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:43:28 INFO - 'use_talos_json': True, 04:43:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:43:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:43:28 INFO - 'work_dir': 'build'} 04:43:28 INFO - [mozharness: 2017-04-12 11:43:28.338727Z] Running clobber step. 04:43:28 INFO - Running pre-action listener: _resource_record_pre_action 04:43:28 INFO - Running main action method: clobber 04:43:28 INFO - rmtree: /builds/slave/test/build 04:43:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:43:30 INFO - Running post-action listener: _resource_record_post_action 04:43:30 INFO - [mozharness: 2017-04-12 11:43:30.839553Z] Finished clobber step (success) 04:43:30 INFO - [mozharness: 2017-04-12 11:43:30.839732Z] Running read-buildbot-config step. 04:43:30 INFO - Running pre-action listener: _resource_record_pre_action 04:43:30 INFO - Running main action method: read_buildbot_config 04:43:30 INFO - Using buildbot properties: 04:43:30 INFO - { 04:43:30 INFO - "project": "", 04:43:30 INFO - "product": "firefox", 04:43:30 INFO - "script_repo_revision": "production", 04:43:30 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 04:43:30 INFO - "repository": "", 04:43:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 04:43:30 INFO - "buildid": "20170412024510", 04:43:30 INFO - "pgo_build": "False", 04:43:30 INFO - "basedir": "/builds/slave/test", 04:43:30 INFO - "buildnumber": 105, 04:43:30 INFO - "slavename": "t-yosemite-r7-0274", 04:43:30 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 04:43:30 INFO - "platform": "yosemite_r7", 04:43:30 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 04:43:30 INFO - "branch": "mozilla-aurora", 04:43:30 INFO - "repo_path": "releases/mozilla-aurora", 04:43:30 INFO - "revision": "65875bd4b7df1e5e29f1b07927d88d37b9ddded0", 04:43:30 INFO - "stage_platform": "macosx64", 04:43:30 INFO - "builduid": "73ec3e6ce1724308b27af787bba100d2", 04:43:30 INFO - "slavebuilddir": "test" 04:43:30 INFO - } 04:43:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/a_3f6jyFTMyk9hDUQyFzVw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 04:43:30 INFO - Running post-action listener: _resource_record_post_action 04:43:30 INFO - [mozharness: 2017-04-12 11:43:30.843148Z] Finished read-buildbot-config step (success) 04:43:30 INFO - [mozharness: 2017-04-12 11:43:30.843287Z] Running download-and-extract step. 04:43:30 INFO - Running pre-action listener: _resource_record_pre_action 04:43:30 INFO - Running main action method: download_and_extract 04:43:30 INFO - mkdir: /builds/slave/test/build/tests 04:43:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:30 INFO - trying https://queue.taskcluster.net/v1/task/a_3f6jyFTMyk9hDUQyFzVw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 04:43:30 INFO - Downloading https://queue.taskcluster.net/v1/task/a_3f6jyFTMyk9hDUQyFzVw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 04:43:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a_3f6jyFTMyk9hDUQyFzVw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 04:43:32 INFO - Downloaded 1199 bytes. 04:43:32 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 04:43:32 INFO - Using the following test package requirements: 04:43:32 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 04:43:32 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:43:32 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 04:43:32 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:43:32 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 04:43:32 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:43:32 INFO - u'jsshell-mac.zip'], 04:43:32 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:43:32 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 04:43:32 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 04:43:32 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:43:32 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 04:43:32 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:43:32 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 04:43:32 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:43:32 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 04:43:32 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:43:32 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 04:43:32 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 04:43:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a_3f6jyFTMyk9hDUQyFzVw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 04:43:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a_3f6jyFTMyk9hDUQyFzVw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:43:32 INFO - Fetch https://queue.taskcluster.net/v1/task/a_3f6jyFTMyk9hDUQyFzVw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 04:43:33 INFO - Expected file size: 51790296 04:43:33 INFO - Obtained file size: 51790296 04:43:49 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 04:43:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a_3f6jyFTMyk9hDUQyFzVw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 04:43:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a_3f6jyFTMyk9hDUQyFzVw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:43:49 INFO - Fetch https://queue.taskcluster.net/v1/task/a_3f6jyFTMyk9hDUQyFzVw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 04:43:51 INFO - Expected file size: 51790296 04:43:51 INFO - Obtained file size: 51790296 04:44:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a_3f6jyFTMyk9hDUQyFzVw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 04:44:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a_3f6jyFTMyk9hDUQyFzVw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 04:44:06 INFO - Fetch https://queue.taskcluster.net/v1/task/a_3f6jyFTMyk9hDUQyFzVw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 04:44:07 INFO - Expected file size: 14404424 04:44:07 INFO - Obtained file size: 14404424 04:44: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')]} 04:44:07 INFO - trying https://queue.taskcluster.net/v1/task/a_3f6jyFTMyk9hDUQyFzVw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 04:44:07 INFO - Downloading https://queue.taskcluster.net/v1/task/a_3f6jyFTMyk9hDUQyFzVw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 04:44:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a_3f6jyFTMyk9hDUQyFzVw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 04:44:09 INFO - Downloaded 74726214 bytes. 04:44:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a_3f6jyFTMyk9hDUQyFzVw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 04:44:09 INFO - mkdir: /builds/slave/test/properties 04:44:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:44:09 INFO - Writing to file /builds/slave/test/properties/build_url 04:44:09 INFO - Contents: 04:44:09 INFO - build_url:https://queue.taskcluster.net/v1/task/a_3f6jyFTMyk9hDUQyFzVw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 04:44:10 INFO - Running post-action listener: _resource_record_post_action 04:44:10 INFO - Running post-action listener: set_extra_try_arguments 04:44:10 INFO - [mozharness: 2017-04-12 11:44:10.488586Z] Finished download-and-extract step (success) 04:44:10 INFO - [mozharness: 2017-04-12 11:44:10.488722Z] Running populate-webroot step. 04:44:10 INFO - Running pre-action listener: _resource_record_pre_action 04:44:10 INFO - Running main action method: populate_webroot 04:44:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:44:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:44:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:44:10 INFO - '--tppagecycles', 04:44:10 INFO - '7'], 04:44:10 INFO - 'tests': ['tsvgm']}}, 04:44:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:44:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:44:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:44:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:44:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:44:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:44:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:44:10 INFO - 'talos_options': ['--disable-e10s'], 04:44:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:44:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:44:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:44:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:44:10 INFO - 'talos_options': ['--disable-e10s'], 04:44:10 INFO - 'tests': ['damp', 'tps']}, 04:44:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:44:10 INFO - 'tests': ['damp', 'tps']}, 04:44:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:44:10 INFO - 'tests': ['dromaeo_dom']}, 04:44:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:44:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:44:10 INFO - 'tests': ['basic_compositor_video']}, 04:44:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:44:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:44:10 INFO - 'tests': ['a11yr', 04:44:10 INFO - 'ts_paint', 04:44:10 INFO - 'tpaint', 04:44:10 INFO - 'sessionrestore', 04:44:10 INFO - 'sessionrestore_no_auto_restore', 04:44:10 INFO - 'tabpaint']}, 04:44:10 INFO - 'other-e10s': {'tests': ['a11yr', 04:44:10 INFO - 'ts_paint', 04:44:10 INFO - 'tpaint', 04:44:10 INFO - 'sessionrestore', 04:44:10 INFO - 'sessionrestore_no_auto_restore', 04:44:10 INFO - 'tabpaint']}, 04:44:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:44:10 INFO - 'ts_paint', 04:44:10 INFO - 'tpaint', 04:44:10 INFO - 'sessionrestore', 04:44:10 INFO - 'sessionrestore_no_auto_restore', 04:44:10 INFO - 'tabpaint']}, 04:44:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:44:10 INFO - 'ts_paint', 04:44:10 INFO - 'tpaint', 04:44:10 INFO - 'sessionrestore', 04:44:10 INFO - 'sessionrestore_no_auto_restore', 04:44:10 INFO - 'tabpaint']}, 04:44:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:44:10 INFO - 'tests': ['a11yr', 04:44:10 INFO - 'ts_paint', 04:44:10 INFO - 'tpaint', 04:44:10 INFO - 'sessionrestore', 04:44:10 INFO - 'sessionrestore_no_auto_restore', 04:44:10 INFO - 'tabpaint']}, 04:44:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:44:10 INFO - 'tests': ['a11yr', 04:44:10 INFO - 'ts_paint', 04:44:10 INFO - 'tpaint', 04:44:10 INFO - 'sessionrestore', 04:44:10 INFO - 'sessionrestore_no_auto_restore', 04:44:10 INFO - 'tabpaint']}, 04:44:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:44:10 INFO - 'tests': ['tsvgx', 04:44:10 INFO - 'tsvgr_opacity', 04:44:10 INFO - 'tart', 04:44:10 INFO - 'tscrollx', 04:44:10 INFO - 'cart', 04:44:10 INFO - 'tsvg_static']}, 04:44:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:44:10 INFO - 'tsvgr_opacity', 04:44:10 INFO - 'tart', 04:44:10 INFO - 'tscrollx', 04:44:10 INFO - 'cart', 04:44:10 INFO - 'tsvg_static']}, 04:44:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:44:10 INFO - 'talos_options': ['--disable-e10s'], 04:44:10 INFO - 'tests': ['tp5o']}, 04:44:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:44:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:44:10 INFO - 'talos_options': ['--disable-e10s', 04:44:10 INFO - '--xperf_path', 04:44:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:44:10 INFO - 'tests': ['tp5n']}, 04:44:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:44:10 INFO - 'talos_options': ['--xperf_path', 04:44:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:44:10 INFO - 'tests': ['tp5n']}}, 04:44:10 INFO - 'talos.zip': {'path': '', 04:44:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:44:10 INFO - Running post-action listener: _resource_record_post_action 04:44:10 INFO - [mozharness: 2017-04-12 11:44:10.507358Z] Finished populate-webroot step (success) 04:44:10 INFO - [mozharness: 2017-04-12 11:44:10.507471Z] Running create-virtualenv step. 04:44:10 INFO - Running pre-action listener: _resource_record_pre_action 04:44:10 INFO - Running main action method: create_virtualenv 04:44:10 INFO - Creating virtualenv /builds/slave/test/build/venv 04:44:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:44:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:44:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:44:10 INFO - Using real prefix '/tools/python27' 04:44:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:44:11 INFO - Installing distribute.............................................................................................................................................................................................done. 04:44:14 INFO - Installing pip.................done. 04:44:14 INFO - Return code: 0 04:44:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:44:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:44:14 INFO - Reading from file tmpfile_stdout 04:44:14 INFO - Output received: 04:44:14 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:44:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:44: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')]} 04:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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')]} 04:44:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104319b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10431c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8689469880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f7d30>, '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 0x10401edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ecbe8>, '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.x9A1ZJB3aP/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.njkY2zFP6w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 04:44:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:44:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:44:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x9A1ZJB3aP/Render', 04:44:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:14 INFO - 'HOME': '/Users/cltbld', 04:44:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:14 INFO - 'LOGNAME': 'cltbld', 04:44:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:14 INFO - 'MOZ_NO_REMOTE': '1', 04:44:14 INFO - 'NO_EM_RESTART': '1', 04:44:14 INFO - 'PAGER': '/bin/cat', 04:44:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:14 INFO - 'PWD': '/builds/slave/test', 04:44:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:14 INFO - 'SHELL': '/bin/bash', 04:44:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.njkY2zFP6w/Listeners', 04:44:14 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 04:44:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:14 INFO - 'USER': 'cltbld', 04:44:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:14 INFO - 'XPC_FLAGS': '0x0', 04:44:14 INFO - 'XPC_SERVICE_NAME': '0', 04:44:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:44:14 INFO - Cleaning up... 04:44:14 INFO - Return code: 0 04:44:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:44: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')]} 04:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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')]} 04:44:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104319b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10431c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8689469880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f7d30>, '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 0x10401edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ecbe8>, '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.x9A1ZJB3aP/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.njkY2zFP6w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 04:44:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:44:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:44:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x9A1ZJB3aP/Render', 04:44:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:14 INFO - 'HOME': '/Users/cltbld', 04:44:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:14 INFO - 'LOGNAME': 'cltbld', 04:44:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:14 INFO - 'MOZ_NO_REMOTE': '1', 04:44:14 INFO - 'NO_EM_RESTART': '1', 04:44:14 INFO - 'PAGER': '/bin/cat', 04:44:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:14 INFO - 'PWD': '/builds/slave/test', 04:44:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:14 INFO - 'SHELL': '/bin/bash', 04:44:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.njkY2zFP6w/Listeners', 04:44:14 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 04:44:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:14 INFO - 'USER': 'cltbld', 04:44:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:14 INFO - 'XPC_FLAGS': '0x0', 04:44:14 INFO - 'XPC_SERVICE_NAME': '0', 04:44:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:15 INFO - Downloading/unpacking psutil>=3.1.1 04:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:44:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:44:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:44:18 INFO - Installing collected packages: psutil 04:44:18 INFO - Running setup.py install for psutil 04:44:18 INFO - building 'psutil._psutil_osx' extension 04:44:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:44:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:44:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:44:19 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:44:19 INFO - building 'psutil._psutil_posix' extension 04:44:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:44:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:44:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:44:19 INFO - ^ 04:44:19 INFO - 1 warning generated. 04:44:19 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:44:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:44:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:44:19 INFO - Successfully installed psutil 04:44:19 INFO - Cleaning up... 04:44:19 INFO - Return code: 0 04:44:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:19 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 0x104319b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10431c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8689469880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f7d30>, '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 0x10401edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ecbe8>, '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.x9A1ZJB3aP/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.njkY2zFP6w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 04:44:19 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 04:44:19 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 04:44:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x9A1ZJB3aP/Render', 04:44:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:19 INFO - 'HOME': '/Users/cltbld', 04:44:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:19 INFO - 'LOGNAME': 'cltbld', 04:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:19 INFO - 'MOZ_NO_REMOTE': '1', 04:44:19 INFO - 'NO_EM_RESTART': '1', 04:44:19 INFO - 'PAGER': '/bin/cat', 04:44:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:19 INFO - 'PWD': '/builds/slave/test', 04:44:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:19 INFO - 'SHELL': '/bin/bash', 04:44:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.njkY2zFP6w/Listeners', 04:44:19 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 04:44:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:19 INFO - 'USER': 'cltbld', 04:44:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:19 INFO - 'XPC_FLAGS': '0x0', 04:44:19 INFO - 'XPC_SERVICE_NAME': '0', 04:44:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:44:20 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 04:44:20 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 04:44:20 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 04:44:20 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 04:44:20 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 04:44:20 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 04:44:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:44:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:44:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:44:22 INFO - Installing collected packages: mozsystemmonitor 04:44:22 INFO - Running setup.py install for mozsystemmonitor 04:44:22 INFO - Successfully installed mozsystemmonitor 04:44:22 INFO - Cleaning up... 04:44:23 INFO - Return code: 0 04:44:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:44:23 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')]} 04:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:23 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')]} 04:44:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:23 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 0x104319b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10431c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8689469880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f7d30>, '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 0x10401edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ecbe8>, '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.x9A1ZJB3aP/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.njkY2zFP6w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 04:44:23 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 04:44:23 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 04:44:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x9A1ZJB3aP/Render', 04:44:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:23 INFO - 'HOME': '/Users/cltbld', 04:44:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:23 INFO - 'LOGNAME': 'cltbld', 04:44:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:23 INFO - 'MOZ_NO_REMOTE': '1', 04:44:23 INFO - 'NO_EM_RESTART': '1', 04:44:23 INFO - 'PAGER': '/bin/cat', 04:44:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:23 INFO - 'PWD': '/builds/slave/test', 04:44:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:23 INFO - 'SHELL': '/bin/bash', 04:44:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.njkY2zFP6w/Listeners', 04:44:23 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 04:44:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:23 INFO - 'USER': 'cltbld', 04:44:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:23 INFO - 'XPC_FLAGS': '0x0', 04:44:23 INFO - 'XPC_SERVICE_NAME': '0', 04:44:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:24 INFO - Downloading/unpacking jsonschema==2.5.1 04:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:44:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:27 INFO - Downloading functools32-3.2.3-2.tar.gz 04:44:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:44:27 INFO - warning: no files found matching '*.txt' 04:44:27 INFO - no previously-included directories found matching 'build' 04:44:27 INFO - no previously-included directories found matching 'dist' 04:44:27 INFO - no previously-included directories found matching '.git*' 04:44:27 INFO - Installing collected packages: jsonschema, functools32 04:44:27 INFO - Running setup.py install for functools32 04:44:27 INFO - warning: no files found matching '*.txt' 04:44:27 INFO - no previously-included directories found matching 'build' 04:44:27 INFO - no previously-included directories found matching 'dist' 04:44:27 INFO - no previously-included directories found matching '.git*' 04:44:27 INFO - Successfully installed jsonschema functools32 04:44:27 INFO - Cleaning up... 04:44:27 INFO - Return code: 0 04:44:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:44:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104319b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10431c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8689469880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f7d30>, '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 0x10401edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ecbe8>, '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.x9A1ZJB3aP/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.njkY2zFP6w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 04:44:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:44:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:44:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x9A1ZJB3aP/Render', 04:44:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:27 INFO - 'HOME': '/Users/cltbld', 04:44:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:27 INFO - 'LOGNAME': 'cltbld', 04:44:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:27 INFO - 'MOZ_NO_REMOTE': '1', 04:44:27 INFO - 'NO_EM_RESTART': '1', 04:44:27 INFO - 'PAGER': '/bin/cat', 04:44:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:27 INFO - 'PWD': '/builds/slave/test', 04:44:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:27 INFO - 'SHELL': '/bin/bash', 04:44:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.njkY2zFP6w/Listeners', 04:44:27 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 04:44:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:27 INFO - 'USER': 'cltbld', 04:44:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:27 INFO - 'XPC_FLAGS': '0x0', 04:44:27 INFO - 'XPC_SERVICE_NAME': '0', 04:44:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:44:28 INFO - Cleaning up... 04:44:28 INFO - Return code: 0 04:44:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104319b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10431c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8689469880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f7d30>, '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 0x10401edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ecbe8>, '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.x9A1ZJB3aP/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.njkY2zFP6w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 04:44:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:44:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:44:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x9A1ZJB3aP/Render', 04:44:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:28 INFO - 'HOME': '/Users/cltbld', 04:44:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:28 INFO - 'LOGNAME': 'cltbld', 04:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:28 INFO - 'MOZ_NO_REMOTE': '1', 04:44:28 INFO - 'NO_EM_RESTART': '1', 04:44:28 INFO - 'PAGER': '/bin/cat', 04:44:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:28 INFO - 'PWD': '/builds/slave/test', 04:44:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:28 INFO - 'SHELL': '/bin/bash', 04:44:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.njkY2zFP6w/Listeners', 04:44:28 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 04:44:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:28 INFO - 'USER': 'cltbld', 04:44:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:28 INFO - 'XPC_FLAGS': '0x0', 04:44:28 INFO - 'XPC_SERVICE_NAME': '0', 04:44:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:28 INFO - Downloading/unpacking blobuploader==1.2.4 04:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:30 INFO - Downloading blobuploader-1.2.4.tar.gz 04:44:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:44:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:44:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:32 INFO - Downloading docopt-0.6.1.tar.gz 04:44:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:44:32 INFO - Installing collected packages: blobuploader, requests, docopt 04:44:32 INFO - Running setup.py install for blobuploader 04:44:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:44:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:44:32 INFO - Running setup.py install for requests 04:44:33 INFO - Running setup.py install for docopt 04:44:33 INFO - Successfully installed blobuploader requests docopt 04:44:33 INFO - Cleaning up... 04:44:33 INFO - Return code: 0 04:44:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104319b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10431c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8689469880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f7d30>, '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 0x10401edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ecbe8>, '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.x9A1ZJB3aP/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.njkY2zFP6w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 04:44:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:44:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:44:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x9A1ZJB3aP/Render', 04:44:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:33 INFO - 'HOME': '/Users/cltbld', 04:44:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:33 INFO - 'LOGNAME': 'cltbld', 04:44:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:33 INFO - 'MOZ_NO_REMOTE': '1', 04:44:33 INFO - 'NO_EM_RESTART': '1', 04:44:33 INFO - 'PAGER': '/bin/cat', 04:44:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:33 INFO - 'PWD': '/builds/slave/test', 04:44:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:33 INFO - 'SHELL': '/bin/bash', 04:44:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.njkY2zFP6w/Listeners', 04:44:33 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 04:44:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:33 INFO - 'USER': 'cltbld', 04:44:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:33 INFO - 'XPC_FLAGS': '0x0', 04:44:33 INFO - 'XPC_SERVICE_NAME': '0', 04:44:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:44:33 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-MENRJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:44:33 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-JLNz2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:44:33 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-mYnA0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:44:33 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-lUCgmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:44:33 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-JPbXNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:44:34 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-2i5K3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:44:34 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-SX7S07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:44:34 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-CYSI8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:44:34 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-ijVaNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:44:34 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-RJiT3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:44:34 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-i4Uaim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:44:34 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-oDiEoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:44:34 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-6Ew3mZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:44:34 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-Rz6Mop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:34 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-C4JCMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:44:35 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-JhbGL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:44:35 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-HJOFDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:44:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:44:35 INFO - Running setup.py install for manifestparser 04:44:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:44:35 INFO - Running setup.py install for mozcrash 04:44:35 INFO - Running setup.py install for mozdebug 04:44:35 INFO - Running setup.py install for mozdevice 04:44:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:44:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:44:35 INFO - Running setup.py install for mozfile 04:44:36 INFO - Running setup.py install for mozhttpd 04:44:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:44:36 INFO - Running setup.py install for mozinfo 04:44:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:44:36 INFO - Running setup.py install for mozInstall 04:44:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:44:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:44:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:44:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:44:36 INFO - Running setup.py install for mozleak 04:44:36 INFO - Running setup.py install for mozlog 04:44:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:44:36 INFO - Running setup.py install for moznetwork 04:44:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:44:36 INFO - Running setup.py install for mozprocess 04:44:37 INFO - Running setup.py install for mozprofile 04:44:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:44:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:44:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:44:37 INFO - Running setup.py install for mozrunner 04:44:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:44:37 INFO - Running setup.py install for mozscreenshot 04:44:37 INFO - Running setup.py install for moztest 04:44:37 INFO - Running setup.py install for mozversion 04:44:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:44:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:44:37 INFO - Cleaning up... 04:44:37 INFO - Return code: 0 04:44:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44: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')]} 04:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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')]} 04:44:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:37 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 0x104319b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10431c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8689469880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f7d30>, '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 0x10401edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ecbe8>, '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.x9A1ZJB3aP/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.njkY2zFP6w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 04:44:37 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 04:44:37 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 04:44:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x9A1ZJB3aP/Render', 04:44:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:37 INFO - 'HOME': '/Users/cltbld', 04:44:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:37 INFO - 'LOGNAME': 'cltbld', 04:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:37 INFO - 'MOZ_NO_REMOTE': '1', 04:44:37 INFO - 'NO_EM_RESTART': '1', 04:44:37 INFO - 'PAGER': '/bin/cat', 04:44:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:37 INFO - 'PWD': '/builds/slave/test', 04:44:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:37 INFO - 'SHELL': '/bin/bash', 04:44:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.njkY2zFP6w/Listeners', 04:44:37 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 04:44:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:37 INFO - 'USER': 'cltbld', 04:44:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:37 INFO - 'XPC_FLAGS': '0x0', 04:44:37 INFO - 'XPC_SERVICE_NAME': '0', 04:44:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:44:38 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-w34Eit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:44:38 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:44:38 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-4a1lj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:44:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:44:38 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-ekqshg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:44:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:44:38 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-oP_kYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:44:38 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)) 04:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:44:38 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-CgPQX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:44:38 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)) 04:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:44:38 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-XrvUar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:44:38 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)) 04:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:44:38 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-uIy6KK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:44:38 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)) 04:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:44:38 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-9jwi9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:44:39 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-GqNcCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:44:39 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-s295No-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:44:39 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-pG4jam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:44:39 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-14vuP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:44:39 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-MufJjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:44:39 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-F1bEzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:44:39 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)) 04:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:39 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-ghcvT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:39 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)) 04:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:44:39 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-rrpSqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:44:39 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)) 04:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:44:39 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-UkaX6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:44:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:42 INFO - Downloading blessings-1.6.tar.gz 04:44:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:44:42 INFO - Installing collected packages: blessings 04:44:42 INFO - Running setup.py install for blessings 04:44:42 INFO - Successfully installed blessings 04:44:42 INFO - Cleaning up... 04:44:42 INFO - Return code: 0 04:44:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:44:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:44:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:44:43 INFO - Reading from file tmpfile_stdout 04:44:43 INFO - Current package versions: 04:44:43 INFO - blessings == 1.6 04:44:43 INFO - blobuploader == 1.2.4 04:44:43 INFO - docopt == 0.6.1 04:44:43 INFO - functools32 == 3.2.3-2 04:44:43 INFO - jsonschema == 2.5.1 04:44:43 INFO - manifestparser == 1.1 04:44:43 INFO - mozInstall == 1.12 04:44:43 INFO - mozcrash == 1.0 04:44:43 INFO - mozdebug == 0.1 04:44:43 INFO - mozdevice == 0.49 04:44:43 INFO - mozfile == 1.2 04:44:43 INFO - mozhttpd == 0.7 04:44:43 INFO - mozinfo == 0.9 04:44:43 INFO - mozleak == 0.1 04:44:43 INFO - mozlog == 3.4 04:44:43 INFO - moznetwork == 0.27 04:44:43 INFO - mozprocess == 0.25 04:44:43 INFO - mozprofile == 0.28 04:44:43 INFO - mozrunner == 6.13 04:44:43 INFO - mozscreenshot == 0.1 04:44:43 INFO - mozsystemmonitor == 0.3 04:44:43 INFO - moztest == 0.8 04:44:43 INFO - mozversion == 1.4 04:44:43 INFO - psutil == 3.1.1 04:44:43 INFO - requests == 1.2.3 04:44:43 INFO - wsgiref == 0.1.2 04:44:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104319b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10431c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8689469880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f7d30>, '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 0x10401edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ecbe8>, '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.x9A1ZJB3aP/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.njkY2zFP6w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 04:44:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:44:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:44:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x9A1ZJB3aP/Render', 04:44:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:43 INFO - 'HOME': '/Users/cltbld', 04:44:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:43 INFO - 'LOGNAME': 'cltbld', 04:44:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:43 INFO - 'MOZ_NO_REMOTE': '1', 04:44:43 INFO - 'NO_EM_RESTART': '1', 04:44:43 INFO - 'PAGER': '/bin/cat', 04:44:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:43 INFO - 'PWD': '/builds/slave/test', 04:44:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:43 INFO - 'SHELL': '/bin/bash', 04:44:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.njkY2zFP6w/Listeners', 04:44:43 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 04:44:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:43 INFO - 'USER': 'cltbld', 04:44:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:43 INFO - 'XPC_FLAGS': '0x0', 04:44:43 INFO - 'XPC_SERVICE_NAME': '0', 04:44:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:44:43 INFO - Cleaning up... 04:44:43 INFO - Return code: 0 04:44:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:44:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104319b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10431c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8689469880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f7d30>, '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 0x10401edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ecbe8>, '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.x9A1ZJB3aP/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.njkY2zFP6w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 04:44:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:44:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:44:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x9A1ZJB3aP/Render', 04:44:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:43 INFO - 'HOME': '/Users/cltbld', 04:44:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:43 INFO - 'LOGNAME': 'cltbld', 04:44:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:43 INFO - 'MOZ_NO_REMOTE': '1', 04:44:43 INFO - 'NO_EM_RESTART': '1', 04:44:43 INFO - 'PAGER': '/bin/cat', 04:44:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:43 INFO - 'PWD': '/builds/slave/test', 04:44:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:43 INFO - 'SHELL': '/bin/bash', 04:44:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.njkY2zFP6w/Listeners', 04:44:43 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 04:44:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:43 INFO - 'USER': 'cltbld', 04:44:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:43 INFO - 'XPC_FLAGS': '0x0', 04:44:43 INFO - 'XPC_SERVICE_NAME': '0', 04:44:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:44:43 INFO - Cleaning up... 04:44:43 INFO - Return code: 0 04:44:43 INFO - Running post-action listener: _resource_record_post_action 04:44:43 INFO - Running post-action listener: _start_resource_monitoring 04:44:43 INFO - Starting resource monitoring. 04:44:43 INFO - [mozharness: 2017-04-12 11:44:43.783997Z] Finished create-virtualenv step (success) 04:44:43 INFO - [mozharness: 2017-04-12 11:44:43.784927Z] Running install step. 04:44:43 INFO - Running pre-action listener: _resource_record_pre_action 04:44:43 INFO - Running main action method: install 04:44:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:44:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:44:44 INFO - Reading from file tmpfile_stdout 04:44:44 INFO - Detecting whether we're running mozinstall >=1.0... 04:44:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:44:44 INFO - Reading from file tmpfile_stdout 04:44:44 INFO - Output received: 04:44:44 INFO - Usage: mozinstall [options] installer 04:44:44 INFO - Options: 04:44:44 INFO - -h, --help show this help message and exit 04:44:44 INFO - -d DEST, --destination=DEST 04:44:44 INFO - Directory to install application into. [default: 04:44:44 INFO - "/builds/slave/test"] 04:44:44 INFO - --app=APP Application being installed. [default: firefox] 04:44:44 INFO - mkdir: /builds/slave/test/build/application 04:44:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 04:45:04 INFO - Reading from file tmpfile_stdout 04:45:04 INFO - Output received: 04:45:04 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 04:45:04 INFO - Running post-action listener: _resource_record_post_action 04:45:04 INFO - [mozharness: 2017-04-12 11:45:04.276922Z] Finished install step (success) 04:45:04 INFO - [mozharness: 2017-04-12 11:45:04.277077Z] Running run-tests step. 04:45:04 INFO - Running pre-action listener: _resource_record_pre_action 04:45:04 INFO - Running main action method: run_tests 04:45:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:45:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:45:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:45:04 INFO - 2017-04-12 04:45:04.291 screenresolution[1623:7420] starting screenresolution argv=screenresolution get 04:45:04 INFO - 2017-04-12 04:45:04.294 screenresolution[1623:7420] Display 0: 1600x1200x32@60 04:45:04 INFO - 2017-04-12 04:45:04.300 screenresolution[1624:7422] starting screenresolution argv=screenresolution list 04:45:04 INFO - Available Modes on Display 0 04:45:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:45:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:45:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:45:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:45:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:45:04 INFO - Intel Iris: 04:45:04 INFO - Chipset Model: Intel Iris 04:45:04 INFO - Type: GPU 04:45:04 INFO - Bus: Built-In 04:45:04 INFO - VRAM (Dynamic, Max): 1536 MB 04:45:04 INFO - Vendor: Intel (0x8086) 04:45:04 INFO - Device ID: 0x0a2e 04:45:04 INFO - Revision ID: 0x0009 04:45:04 INFO - Displays: 04:45:04 INFO - Display: 04:45:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:45:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:45:04 INFO - Display Serial Number: 1600x1200 60 04:45:04 INFO - Main Display: Yes 04:45:04 INFO - Mirror: Off 04:45:04 INFO - Online: Yes 04:45:04 INFO - Rotation: Supported 04:45:04 INFO - Return code: 0 04:45:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:45:04 INFO - Python 2.7.3 04:45:04 INFO - Return code: 0 04:45:04 INFO - grabbing minidump binary from tooltool 04:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:04 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f7d30>, '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 0x10401edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ecbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:45:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:45:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:45:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:45:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:45:04 INFO - Return code: 0 04:45:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:45:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:45:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:45:04 INFO - ENV: RUST_BACKTRACE is now 1 04:45:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:45:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:45:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a_3f6jyFTMyk9hDUQyFzVw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0274', '--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 04:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a_3f6jyFTMyk9hDUQyFzVw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0274 --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 04:45:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x9A1ZJB3aP/Render', 04:45:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:04 INFO - 'HOME': '/Users/cltbld', 04:45:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:04 INFO - 'LOGNAME': 'cltbld', 04:45:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:45:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:04 INFO - 'MOZ_NO_REMOTE': '1', 04:45:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:45:04 INFO - 'NO_EM_RESTART': '1', 04:45:04 INFO - 'PAGER': '/bin/cat', 04:45:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:04 INFO - 'PWD': '/builds/slave/test', 04:45:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:45:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:04 INFO - 'RUST_BACKTRACE': '1', 04:45:04 INFO - 'SHELL': '/bin/bash', 04:45:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.njkY2zFP6w/Listeners', 04:45:04 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 04:45:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:04 INFO - 'USER': 'cltbld', 04:45:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:04 INFO - 'XPC_FLAGS': '0x0', 04:45:04 INFO - 'XPC_SERVICE_NAME': '0', 04:45:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a_3f6jyFTMyk9hDUQyFzVw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0274', '--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 04:45:04 INFO - mozversion application_buildid: 20170412024510 04:45:04 INFO - mozversion application_changeset: 65875bd4b7df1e5e29f1b07927d88d37b9ddded0 04:45:04 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:45:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:45:04 INFO - mozversion application_name: Firefox 04:45:04 INFO - mozversion application_remotingname: firefox-dev 04:45:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:45:04 INFO - mozversion application_vendor: Mozilla 04:45:04 INFO - mozversion application_version: 54.0a2 04:45:04 INFO - mozversion platform_buildid: 20170412024510 04:45:04 INFO - mozversion platform_changeset: 65875bd4b7df1e5e29f1b07927d88d37b9ddded0 04:45:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:45:04 INFO - mozversion platform_version: 54.0a2 04:45:04 INFO - using testdate: 1491997504 04:45:04 INFO - actual date: 1491997504 04:45:04 INFO - starting webserver on 'localhost:49241' 04:45:04 INFO - SUITE-START | Running 2 tests 04:45:04 INFO - TEST-START | dromaeo_css 04:45:04 INFO - operating with platform_type : mac_ 04:45:04 INFO - Initialising browser for dromaeo_css test... 04:45:04 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpUvTQy9/profile http://localhost:49241/getInfo.html) 04:45:07 INFO - PROCESS | 1634 | 2017-04-12 04:45:07.780 plugin-container[1636:7604] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x494f, name = 'com.apple.tsm.portname' 04:45:07 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:45:07 INFO - PROCESS | 1634 | 2017-04-12 04:45:07.782 plugin-container[1636:7604] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f43, name = 'com.apple.CFPasteboardClient' 04:45:07 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:45:07 INFO - PROCESS | 1634 | 2017-04-12 04:45:07.782 plugin-container[1636:7604] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:45:07 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 04:45:07 INFO - PROCESS | 1634 | colorDepth:24 04:45:07 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 04:45:07 INFO - PROCESS | 1634 | __metrics 04:45:07 ERROR - PROCESS | 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 04:45:08 INFO - TEST-INFO | 1634: exit 0 04:45:08 INFO - Browser initialized. 04:45:08 INFO - Running cycle 1/1 for dromaeo_css test... 04:45:08 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpUvTQy9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:45:11 INFO - PROCESS | 1637 | 2017-04-12 04:45:11.160 plugin-container[1638:7732] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 04:45:11 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:45:11 INFO - PROCESS | 1637 | 2017-04-12 04:45:11.161 plugin-container[1638:7732] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 04:45:11 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:45:11 INFO - PROCESS | 1637 | 2017-04-12 04:45:11.161 plugin-container[1638:7732] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:45:20 INFO - PROCESS | 1637 | RSS: Main: 220569600 04:45:20 INFO - PROCESS | 1637 | 04:48:24 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 04:48:26 INFO - PROCESS | 1637 | RSS: Main: 244051968 04:48:26 INFO - PROCESS | 1637 | 04:50:09 INFO - PROCESS | 1637 | ************************* 04:50:09 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 04:50:09 INFO - PROCESS | 1637 | 04:50:09 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:50:09 INFO - PROCESS | 1637 | Full stack: 04:50:09 INFO - PROCESS | 1637 | ************************* 04:50:09 INFO - PROCESS | 1637 | ************************* 04:50:09 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 04:50:09 INFO - PROCESS | 1637 | 04:50:09 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:50:09 INFO - PROCESS | 1637 | Full stack: 04:50:09 INFO - PROCESS | 1637 | ************************* 04:50:09 INFO - PROCESS | 1637 | ************************* 04:50:09 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 04:50:09 INFO - PROCESS | 1637 | 04:50:09 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:50:09 INFO - PROCESS | 1637 | Full stack: 04:50:09 INFO - PROCESS | 1637 | ************************* 04:50:09 INFO - PROCESS | 1637 | ************************* 04:50:09 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 04:50:09 INFO - PROCESS | 1637 | 04:50:09 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:50:09 INFO - PROCESS | 1637 | Full stack: 04:50:09 INFO - PROCESS | 1637 | ************************* 04:51:28 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 04:51:28 INFO - PROCESS | 1637 | RSS: Main: 251199488 04:51:28 INFO - PROCESS | 1637 | 04:54:30 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 04:54:31 INFO - PROCESS | 1637 | RSS: Main: 258674688 04:54:31 INFO - PROCESS | 1637 | 04:57:33 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 04:57:34 INFO - PROCESS | 1637 | RSS: Main: 254898176 04:57:34 INFO - PROCESS | 1637 | 05:00:37 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 05:00:37 INFO - PROCESS | 1637 | RSS: Main: 259870720 05:00:37 INFO - PROCESS | 1637 | 05:03:40 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 05:03:41 INFO - PROCESS | 1637 | RSS: Main: 256180224 05:03:41 INFO - PROCESS | 1637 | 05:03:41 INFO - PROCESS | 1637 | __start_tp_report 05:03:41 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 05:03:41 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 05:03:41 INFO - PROCESS | 1637 | |i|pagename|runs| 05:03:41 INFO - PROCESS | 1637 | |0;dojo.html;3424.4863270509436;3458.948115778263;3479.965200347996;3496.091016335752;3519.87680431185;5975.312839023508;5975.701214939252;6006.489448396892;6056.939430605704;6095.177151084602;6006.699665016754;6044;6076.969615151918;6094.421030002154;6110.908336374947;4417.646588272931;5388.488093631099;5448.564114870801;5453.918191227135;5559.58303127265;5523.6685798852195;5540.63985840919;5541.445855414467;5552.694601796899;5561.277033985576;5288.127458969266;5293.444188360225;5327.653702509325;5546.77812887486;5553.916691249635;4615.907681846378;5453.672779633234;5470.152126420391;5513.145462453286;5547;4910.877228069291;5037.11850426174;5455.836324910219;5479.506844384025;5533.335999680024;5712.343080545749;6102.115193296947;6136.417040381157;6151.507879369639;6191.87616247677;4760.785764640565;6276.215473065867;6357.459615932651;6357.904631430532;6473.902891456632;6535.411812936811;6540.509461790385;6556.967215163893;6559.639219842907;6566.934330656728;6181.876362472725;6201.9689901550655;6212.751489940442;6218.098375735583;6229.065640154013;6283.2460104787715;6344.6827658616885;6373.107764912916;6615.966920165369;6738.764143254963;4737.952620473751;6261.968690156611;6288.9056664150075;6376.7130479128555;6411.743530258831;6492.805215843532;6497.864703221114;6517.478601711851;6526.804195874131;6547.836304092436;6201.627902325875;6429.099926010363;6445.806625801233;6461.64460954652;6479.384458476437;6277.591956522811;6279.0895320178315;6280.434760871543;6281.371862813773;6301.495880329563;5186.688798672092;5198.584113270929;5200.193969934666;5203.427622961547;5218.399884013387;4602.309653551927;4617.676762626584;4626.930596041062;4637.3275874997935;4645.210314246586;5854.941450585525;5913.319968203626;5963.463288304073;5963.4931030862;6144.41628045335;5349.812756553502;6303.495720342362;6527.314631963671;6540.509461790385;6556.672166391661;5961.910571341434;5962.552808539377;6098.573099882966;6139.907901381483;6178.443940045418;5653.293338332708;5720.628159169641;5747.741351639186;5766.365699773021;5786.276715410574;6412.551121421456;6457.773977910751;6751.291114432914;6763.425108865703;6789.083473730983;6329.873402531832;6351.428371446592;6397.232332120176;6444.226692796894;6445.742170313135;6722.462203023649;6732.259451460433;6734.3265673434225;6748.7300507979135;6754.290799465985;6179.412955769195;6368.904466432915;6384.712687929147;6387.808365749035;6396.776112836028;6275.3724627536885;6352.968235158794;6363.045543168377;6391.3289104643345;6414.069959855888;6112.235970503687;6185.319614842274;6227.813165605039;6230.906536401867;6232.75068997235;6315.3053164152825;6316.084167795736;6321.0834429008455;6321.936780632135;6332.176817013758;5145.151050076845;5951.404859514014;5994.130851026664;6124.930239974474;6153.154053783936;6211.254649442096;6295.842603934938;6296.496280297473;6343.619382837044;6344.841378965562;6226.283977342664;6259.6870156492905;6261.029540421242;6267.905981410374;6268.498520118471 05:03:41 INFO - PROCESS | 1637 | |1;ext.html;753.6947536247818;807.430761313274;829.3903980574277;948.3456415073603;952.200151872427;38034.80982595087;38865.80567097168;40038.599614003884;40559.18881622366;40742.79628601853;37169.81415092928;37310.44034339487;37329.62670373295;37347.81326093366;37394.25211495775;7743.535387876731;7889.684412623516;10401.895981040168;10684.03843654071;10884.401357925311;10641.627543035995;10730.463476826166;10742.677719668383;10747.140228781678;10766.24636275461;10702.839457408145;10735.946320268387;10780.51487683056;10788.406637634927;10792.676219713421;10690.839637405406;10708.625198118107;10730.087942524895;10737.24839261252;10770.299930504492;9438.292128090421;10102.595896164145;10507.579696812118;10514.474276286155;10524.31591946521;34060.48909266363;34205.31589368199;34263.4860477093;34368.31263374744;34422.48366274508;3134.294783673678;3156.7948083374736;3674;3735.6451137141926;3905.082305658168;24874.25377238686;25065.62401563978;25468.872655636602;26842;26854.5971810423;2603.2580714496276;3044.512877939519;3136.9372612547622;3174.492081266986;3181.538676891861;318767;324087;382605;384486;390384;42820.571794281655;43209.35185972213;43226.56773432288;43330.35004474936;43400.78299608482;44585.55414445879;44943;44980.3252951206;44989.77505112519;45119;13380.531681391105;13381.665458363424;13474.124181928144;13487.393067311994;13496.19022858612;11541.942290288494;11794.587189448328;11798.587049453228;11805.114616403633;11813.527458901719;11743.706407339885;11744.70638234051;11769.293842369485;11806.350650714294;11842.230255033395;4632.97683511587;5487.670739755627;5539.335279766454;5550.944490555124;5555.833325000256;1112.2547892911768;1133.40190331632;1142.9028532574823;1162.5177898179888;1187.1986409173774;21453.356399308046;26230.819613117073;26304.21087367382;26342;26608.334791630365;998.9350692204983;1218.6100447856777;1220.341015851448;1267.3473161321926;1302.6287508060157;10775.407352595683;11279.063978093105;13445.193288402726;13732;13748.587542373745;365091;435869.8206508947;437081;437537.8123109428;438110.618893807;51861.48138518642;52035.73982130141;52264.73867630638;52306.47693523092;52316.73841630767;1282.5062350994933;1380.8481067082612;1415.591486470968;1440.063958427031;1446.2262689461088;18547.19616842924;20342;24820;25377.49245015126;25636.743632564183;36222;45225.54774452213;45299.54700452953;45309.546904530536;45361.639150825526;382458.17541824223;389178;389958;390586;395424;24400.389990250387;25603.6159457612;26342.20973370802;30690.693093069676;30907.69092309138;43239;43603.34594981141;43917.902052448946;44386.556134438244;45114.77442612766;29739.959101431345;29845.403091938475;30221.395572088873;30546.541801872547;30776;29625.407491850474;29755.55366669545;29817.701822981493;30402.391952161277;30445;35544.82227588846;35557.82221088878;36324.818375907955;36328.81835590805;36408.453873192455;28707;28994.565081524215;31063.884955222078;31203;31472.52791208088;17725.645487090445;17826.643467130845;22963.88518057399;23194;23305.650415244123 05:03:41 INFO - PROCESS | 1637 | |2;jquery.html;405.6288496026136;425.71477110336065;426.8353682645998;430.5952404739547;435.82131326156275;20232.29186978456;20758.89620551897;21136.682949755766;21268.89365553172;21288.36134915955;21034.894825525887;21955;22301.665475017886;22364.329070127922;22604.660930086062;5384.869177472736;6481.643509606958;6756.594604323732;6773.559718618299;6778.5593936394225;6597.175353080865;6624.834379140512;6648.767293144717;6650.6009639421545;6662.833429164285;6361.459275961549;6535.24844642865;6629.303923088079;6635.170603674541;6665.40011398974;6514.315996820361;6588.176477940257;6656.966715166393;6681.098051762999;6681.732730690791;6225.221847269091;6415.5829871058695;6463.224413070461;6474.967625161891;6475.514336424787;24288.878555607287;25056.874715626487;25554.36114097144;25756.87121564399;26962.46075078507;2861.527847905093;2876.8130071545283;2933.296008957856;2966.8664910079096;2968.4063187362613;15177.772333415007;15244.46644367453;15385.615359616098;16317.184140792913;16696.916515417346;1985.463924740312;2044.2027609232412;2045.0490521907236;2050.333641566482;2050.5181282398776;162539;170481.14759426125;177787;178894;181687.18312816834;21713.348599542038;21778.89110554437;21817;21873.453163671034;21906;31912.840435797672;31928.680713193036;32511.512327315108;32523.34953300921;32557.51163732546;8092;8503.362247831437;8885.644574217089;9033.87076615423;9865.112139907444;8020.959895200486;8034;8070.47541909774;8192.713255036164;8219.794505137419;9610.279229057849;9675.90324096764;9686.07982241686;9711.902880971242;9730.151271258439;3481.3559491494157;4051.6498138633274;4132.442120313779;4148.091877736215;4148.543660197376;997.640849294268;1007.2898606482412;1009.7273736091214;1013.5996281468779;1045.5033858917106;20733.170673172903;21177.894110529658;21204.25785097514;21315.68026479604;21405.78594214069;916.9134575527887;1005.3816902604846;1012.8784545854397;1037.9325343852624;1046.7487802927242;9931.304808663468;10572.947135264429;10843.98774433369;10985.670429887115;11041.944790276159;676754;691571;747968;768416;790965.0451747704;114062.28906566408;142363;148719;154771.90456190813;165646;1316.1708123881892;1340.5241139395375;1372.629390064677;1378.076688618628;1378.9241591712353;19090.713639295143;20416.897915510326;20494.487637809176;20541.691874621592;20542.79457205409;64357;65431.67284163549;65586.68826623536;65686;67155;62734;89341.55329223312;89486.55256723675;91721.08278917125;91843;11560.768784624428;11692.883071169179;11806.232594881305;12024;12070.094742894493;13034.283114428417;13062.54281100157;13085.280309583064;13137;13426.798598020841;9571.234301256021;11229.887701122883;11288.830667540158;11411;11438.256513326607;10556.102731267621;10625.468726563795;10666.466676665981;10922.29005114665;10924.836127458253;11224.045956093823;11534.59628912984;11752.23610465317;11837.526498939946;11880.940595296968;9841.753956151153;11555.711107222387;11587.957083862493;11691.707707307045;11863.34751588671;10069.496525173565;10794.838077428687;10976.890231097907;11110.777784444428;11424 05:03:41 INFO - PROCESS | 1637 | |3;mootools.html;1517.4537166620007;1546.7602521609153;1548.388386587298;1563.1324614838768;1570.4110958390604;8849.336299777518;9341.579628916697;10941.83587246192;11185.32888026718;11208.719782005433;10993.285436446626;11122.833157502624;11176.608818691348;11194.328340299568;11219.38293393865;2406.1698713943706;2457.410221546834;2468.308873515419;2472.5673007223663;2473.2209354053507;2395.9520809583796;2413.1915808204185;2428.113738485458;2435.0990133650575;2439.609662454008;2022.383173132194;2216.8115710164657;2246.382244882654;2340.9648855267183;2420.346506443268;2142.3144593730012;2336.0188720737333;2383.642453631952;2387.3554140382084;2390.95218095638;2350.623900175981;2376.0614557249964;2388.1163969331283;2391.0794344177443;2391.940201494959;10934.179936504794;11151.665450036431;11159.888401115966;11185.272957257834;11198.272112312674;5830.4169583041785;5906.704664766788;6029.54778391618;6029.969850150765;6038.667873266969;3579.677828995377;3611.981940090309;3661.3226553087766;3667.15655399257;3742.8315725792404;1190.8987736042448;1197.1679682620581;1215.9635210943686;1234.2224398628896;1244.1104610203747;13696.93151534246;13870.4451821927;15087.24563771818;15531.767023494656;15623.375064997386;4698.553637404441;4710.719989060774;4733.242681170997;4835.661503694778;4853.757312134379;11768.529258829722;11848.407579620984;11848.644540663794;11859.525618975144;11880.287182768889;5814.302283725895;5905.498032667271;5910.261217347832;5913.201717768046;5946.048632218824;5237.790488380422;5288.524032837063;5314.97342513285;5355.062863998784;5369.838904832861;3862.8261728222296;3915.197384536163;3963.8216280267457;3989.202159568098;4011.3782363733667;1054.2778196935124;1058.1217589400778;1058.730023843915;1068.58859339155;1069.6363236499628;921.3185935667434;932.0958670090001;939.5020639061308;945.8202941441104;992.7468495533593;5177.689338639693;6396.744130234739;6501.577397469149;6514.250861151028;6589.637569933604;834.6160766047686;885.3625389719392;935.4808081514689;992.5731935267904;1017.353980222564;4096.7102024988035;4164.687648426319;4233.322668373045;4271.380649805761;4308.784560771949;11782.823257651142;13471.730565388832;14077.296135193199;14088;14102.929485352508;12450.377481125908;13471.932640336736;13692.452301908012;13720.725585488235;13931.233782142079;10166.034226748447;10274.229432792421;10295.845562316421;10320.690379288633;10321.277510574339;6478.4169424752;6531.738730450918;6551.377619126175;6666.633335166418;6804.11546498952;11653.30080195191;12188.878111219128;12352.691182720504;12454.501819927102;12688.365581721062;12563.497460101493;12658.87341126577;12767.361631918182;12891.548795792101;13053.216806991612;10043.497825108861;10322.277440579388;10445.582176712845;10490.580376784843;10511.001454861776;10682.145428365868;10693.304935179189;10720.035196832323;10813.080888124598;10933.289336193122;9003.234725048444;9032.45805251687;9057.95471022667;9129.178373946112;9180.311476639145;7778.766637000899;8763.298936085226;8829.646814127364;8941.329400295133;8963.910360896307;7978.962734844433;7986.281234688906;8061.758147255592;8078.7172448964;8102.189781022086;5452.5365343946205;6028.57799953999;6057.757689692363;6071.241094863142;6198.318184999556;6014.218151640259;6047.213862197887;6084.756609735561;6143.6006659568775;6174.228221472316 05:03:41 INFO - PROCESS | 1637 | |4;prototype.html;318.76411455522907;346.9236767911062;380.9904752381191;384.60385802623307;390.8866428735667;4254.446921900157;4832.685875418099;4838.96763359389;5028.472010438902;5225.372955245376;4186.906546726636;4832.782524786384;5063.898722025567;5068.9608630230805;5124.385073791141;4129.772862492562;4235.6187943085115;4287.249731297011;4300.354946757988;4308.633766129883;4243.957560424387;4292.65658747301;4307.267764480031;4338.587834155766;4368.3884256204;3849.9807500962597;4293.806778694966;4309.676774241929;4334.371516130159;4349.1301739652035;3870.438786375988;4103.733257338294;4289.056407590325;4306.6554675626185;4308.741475511463;3600.3159399713973;3919;3923.920322229223;3926.0577461409057;3927.8036098194975;4991.550760431579;4992.326035985132;4992.477294425199;5006.5744411725045;5024.924626130611;4741.193997020515;4746.881327966794;4769.80588929093;4918.147474464802;4975.203967365204;4677.579017888406;5051.570616497602;5498.972505137449;5521.337439507245;5554.583406244507;4371.125774845043;4411.757353345564;4423.606563932383;4461.397711308964;4500.662450316239;4831.492693267227;4927.728974906378;5093.536395251264;5200.957439897665;5850.771338019021;4041.515018197835;4328.740275583412;4428.31361139024;4463.732176069446;4468.285074388147;4525.7780399292005;4592.288195329729;4606.838760643362;4608.147492713859;4608.28571571407;4086.40747091676;4530.818767249273;4815.927761083586;4900.917110228139;4933.6793108448555;4429.557044295545;5158.839261166283;5465.480779325958;5478.411640375561;5543.143047079193;1362.8569000254831;1497.288787825796;1525.4660868695867;1534.910213748229;1548.821885483184;1044.8955104489642;1064.8136576099307;1149.0175899605883;1170.6195486466931;1184.6919800851667;4651.2557990721325;4670.439547254351;4670.893855585998;4691.929621055687;5118.97440512795;4846.927296090491;5016.423111342242;5624.943750562442;5628.690422026746;5670.7731690732735;4577.977110114428;4686.109639168547;4842.612590992712;4906.533879281463;5043.2255067947;2562.3209849389928;2953.8523073846222;2954.1137658702305;2958.9408211835644;2960.955585666217;4949.747864721543;5491.7254137292975;5664.943350566524;5757.740901659436;5950.702464876739;4803.855884323476;5416.51251387377;5699.943000570024;5890.318550905684;5912.379200184005;4972.328735620645;5071.54356107952;5079.8984020319385;5484.012877681976;5934.406559344031;5238.580913526985;5683.89164112994;5740.741666624928;5743.62666426681;5744.827655170351;5313.442088580643;5631.267935168402;5637.8590535236945;5651.4348565143155;5677.772889084556;4388.51726310112;5109.540141387293;5726.599138060295;5882.970585147047;5999.730012149551;4645.907081858276;4816.735079570657;4948.208286674115;4972.726500042532;4982.800687972441;5146.279520867007;5240;5449.564034877121;5460.6996615186545;5728.598998070095;4666.953330466652;5256;5304.336957880265;5432.728363581726;5478.835634930959;4953.925691114564;5465.945340546544;5470.206820010996;5514.779408823602;5598.776048958159;4229.450171477688;4931.7040977541465;5058.431886115316;5309.309789727311;5428.321459817523;4538.704984176018;4671;5202.921956170585;5468.753906074316;5480.150576660464;4956.900861982812;5164.584280440169;5375.5162035417;5421.810236641856;5470.53500452466 05:03:41 INFO - PROCESS | 1637 | |5;yui.html;645.048553383759;698.4656737595737;730.6858051038055;789.2502122983163;822.646262107294;13416.993725470604;14989.925050374746;16167.83832161678;16355.672886542277;16405.015699058065;15021.849781502182;15242.314095865684;15322.15728134952;15325.310361033753;15344.923275383635;905.0316161706976;920.4201353147507;940.2149205413488;940.4028441939349;942.3356533643764;908.0919080919081;922.912323329286;923.6213152607432;925.8240934222476;936.929730270229;977.2963466304285;979.485769970764;979.8726165598463;981.0336818234034;981.3866333541537;968.9612415503407;973.250597040275;977.5649835823061;979.2998006425404;980.8921018687938;716.5736386849816;719.8272414620506;726.2084328082362;726.426123362543;728.8032231297573;15783.210839457981;16275.755863662054;16352.427665031786;16631.6673666526;16725.247363868533;13967.37146828395;14203.147811131365;14292;14326.856731432656;14372.005212849695;11543.53825846965;11813.822792658117;11838.348890811001;11861.703457413547;11895.643130706007;2859;3268.2809781847955;3381.915452113717;3399.8780402467373;3682.521272234619;55322.96729639982;70905.64547177283;73607;80503.5974820128;112687;10651.680449586369;11036.668899933014;11101;11211.60759373418;11355.772884542263;21760.238391656534;22052.669209961863;22061.33815985523;22095.116195352326;22358;7637.5035622684345;7781.182975787574;7860.528368297806;8103.837923241502;8105.432619716681;4185.707000509935;4233.576642335742;4276.358546218092;4395.033092719596;4473.4408198975125;3474.3398754236614;3479.1128262292955;3502.6847583717586;3529.6293889141784;3565.698520040167;591.1635036423498;611.0894766797439;628.2461046743925;636.8153235561728;657.4641667041346;670.6143967218869;697.4211404534225;703.39859420195;722.1226210154688;723.4393345157545;9660.420374777535;10301.587936482456;10411.5835366586;10478.37129772216;10548.630797922036;679.7043286170532;687.2200052939949;705.6789160931763;706.3925024478943;712.0636363182399;4513.390692256503;4962.801487940442;4966.453690094087;4976.62675299354;4978.452370239271;110268;110588.4470577658;112565;112812.43593782143;113793.43103284431;75980;93496.53251733698;93815;93964.53017734867;96144;58630.413695863346;62284.75430491274;74714.6264268686;74857;80901.59549202333;10072.01410400708;10837.729056773644;11009.954054364822;11074.889251107386;11083.501242443948;47188;48827;49410.01179976452;49544;50003;60785.696071519356;61803.690981546606;63289.36710632835;63496.36503635089;63799;12576.685582860502;12605.747885042065;12720.173188742701;12765.680857978254;13029.022823288102;14475.710485790436;14549.484848635677;14717;14787.408503660163;14968.550943471713;11263.943680281545;13327.501018997917;13660.385282662503;13696.93151534236;13739.24434156131;11109.277896936674;12957.639447858217;13714.24571648569;13721.794173087612;14348.282585870456;12760.808587871004;12946.611601651966;13473.797893031808;13561.321933903067;13689.315534223448;9003.954980225057;9176.403533770284;9324.580393882155;9513.476758778334;9695.806083878142;10617.628383006559;11011.28176570312;11358.94320528392;11375.43122843871;11387.601433949772 05:03:41 INFO - PROCESS | 1637 | __end_tp_report 05:03:41 INFO - PROCESS | 1637 | __start_cc_report 05:03:41 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,420 05:03:41 INFO - PROCESS | 1637 | __end_cc_report 05:03:41 INFO - PROCESS | 1637 | __startTimestamp1491998621111__endTimestamp 05:03:41 INFO - PROCESS | 1637 | 05:03:41 INFO - PROCESS | 1637 | ------- Summary: start ------- 05:03:41 INFO - PROCESS | 1637 | Number of tests: 6 05:03:41 INFO - PROCESS | 1637 | 05:03:41 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5945.29 Median:6201.63 stddev:687.37 (11.1%) stddev-sans-first:660.42 05:03:41 INFO - PROCESS | 1637 | Values: 3424.5 3458.9 3480.0 3496.1 3519.9 5975.3 5975.7 6006.5 6056.9 6095.2 6006.7 6044.0 6077.0 6094.4 6110.9 4417.6 5388.5 5448.6 5453.9 5559.6 5523.7 5540.6 5541.4 5552.7 5561.3 5288.1 5293.4 5327.7 5546.8 5553.9 4615.9 5453.7 5470.2 5513.1 5547.0 4910.9 5037.1 5455.8 5479.5 5533.3 5712.3 6102.1 6136.4 6151.5 6191.9 4760.8 6276.2 6357.5 6357.9 6473.9 6535.4 6540.5 6557.0 6559.6 6566.9 6181.9 6202.0 6212.8 6218.1 6229.1 6283.2 6344.7 6373.1 6616.0 6738.8 4738.0 6262.0 6288.9 6376.7 6411.7 6492.8 6497.9 6517.5 6526.8 6547.8 6201.6 6429.1 6445.8 6461.6 6479.4 6277.6 6279.1 6280.4 6281.4 6301.5 5186.7 5198.6 5200.2 5203.4 5218.4 4602.3 4617.7 4626.9 4637.3 4645.2 5854.9 5913.3 5963.5 5963.5 6144.4 5349.8 6303.5 6527.3 6540.5 6556.7 5961.9 5962.6 6098.6 6139.9 6178.4 5653.3 5720.6 5747.7 5766.4 5786.3 6412.6 6457.8 6751.3 6763.4 6789.1 6329.9 6351.4 6397.2 6444.2 6445.7 6722.5 6732.3 6734.3 6748.7 6754.3 6179.4 6368.9 6384.7 6387.8 6396.8 6275.4 6353.0 6363.0 6391.3 6414.1 6112.2 6185.3 6227.8 6230.9 6232.8 6315.3 6316.1 6321.1 6321.9 6332.2 5145.2 5951.4 5994.1 6124.9 6153.2 6211.3 6295.8 6296.5 6343.6 6344.8 6226.3 6259.7 6261.0 6267.9 6268.5 05:03:41 INFO - PROCESS | 1637 | 05:03:41 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:52185.82 Median:30495.77 stddev:103944.37 (340.8%) stddev-sans-first:104164.23 05:03:41 INFO - PROCESS | 1637 | Values: 753.7 807.4 829.4 948.3 952.2 38034.8 38865.8 40038.6 40559.2 40742.8 37169.8 37310.4 37329.6 37347.8 37394.3 7743.5 7889.7 10401.9 10684.0 10884.4 10641.6 10730.5 10742.7 10747.1 10766.2 10702.8 10735.9 10780.5 10788.4 10792.7 10690.8 10708.6 10730.1 10737.2 10770.3 9438.3 10102.6 10507.6 10514.5 10524.3 34060.5 34205.3 34263.5 34368.3 34422.5 3134.3 3156.8 3674.0 3735.6 3905.1 24874.3 25065.6 25468.9 26842.0 26854.6 2603.3 3044.5 3136.9 3174.5 3181.5 318767.0 324087.0 382605.0 384486.0 390384.0 42820.6 43209.4 43226.6 43330.4 43400.8 44585.6 44943.0 44980.3 44989.8 45119.0 13380.5 13381.7 13474.1 13487.4 13496.2 11541.9 11794.6 11798.6 11805.1 11813.5 11743.7 11744.7 11769.3 11806.4 11842.2 4633.0 5487.7 5539.3 5550.9 5555.8 1112.3 1133.4 1142.9 1162.5 1187.2 21453.4 26230.8 26304.2 26342.0 26608.3 998.9 1218.6 1220.3 1267.3 1302.6 10775.4 11279.1 13445.2 13732.0 13748.6 365091.0 435869.8 437081.0 437537.8 438110.6 51861.5 52035.7 52264.7 52306.5 52316.7 1282.5 1380.8 1415.6 1440.1 1446.2 18547.2 20342.0 24820.0 25377.5 25636.7 36222.0 45225.5 45299.5 45309.5 45361.6 382458.2 389178.0 389958.0 390586.0 395424.0 24400.4 25603.6 26342.2 30690.7 30907.7 43239.0 43603.3 43917.9 44386.6 45114.8 29740.0 29845.4 30221.4 30546.5 30776.0 29625.4 29755.6 29817.7 30402.4 30445.0 35544.8 35557.8 36324.8 36328.8 36408.5 28707.0 28994.6 31063.9 31203.0 31472.5 17725.6 17826.6 22963.9 23194.0 23305.7 05:03:41 INFO - PROCESS | 1637 | 05:03:41 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:43007.22 Median:21930.50 stddev:123377.99 (562.6%) stddev-sans-first:123682.63 05:03:41 INFO - PROCESS | 1637 | Values: 405.6 425.7 426.8 430.6 435.8 20232.3 20758.9 21136.7 21268.9 21288.4 21034.9 21955.0 22301.7 22364.3 22604.7 5384.9 6481.6 6756.6 6773.6 6778.6 6597.2 6624.8 6648.8 6650.6 6662.8 6361.5 6535.2 6629.3 6635.2 6665.4 6514.3 6588.2 6657.0 6681.1 6681.7 6225.2 6415.6 6463.2 6475.0 6475.5 24288.9 25056.9 25554.4 25756.9 26962.5 2861.5 2876.8 2933.3 2966.9 2968.4 15177.8 15244.5 15385.6 16317.2 16696.9 1985.5 2044.2 2045.0 2050.3 2050.5 162539.0 170481.1 177787.0 178894.0 181687.2 21713.3 21778.9 21817.0 21873.5 21906.0 31912.8 31928.7 32511.5 32523.3 32557.5 8092.0 8503.4 8885.6 9033.9 9865.1 8021.0 8034.0 8070.5 8192.7 8219.8 9610.3 9675.9 9686.1 9711.9 9730.2 3481.4 4051.6 4132.4 4148.1 4148.5 997.6 1007.3 1009.7 1013.6 1045.5 20733.2 21177.9 21204.3 21315.7 21405.8 916.9 1005.4 1012.9 1037.9 1046.7 9931.3 10572.9 10844.0 10985.7 11041.9 676754.0 691571.0 747968.0 768416.0 790965.0 114062.3 142363.0 148719.0 154771.9 165646.0 1316.2 1340.5 1372.6 1378.1 1378.9 19090.7 20416.9 20494.5 20541.7 20542.8 64357.0 65431.7 65586.7 65686.0 67155.0 62734.0 89341.6 89486.6 91721.1 91843.0 11560.8 11692.9 11806.2 12024.0 12070.1 13034.3 13062.5 13085.3 13137.0 13426.8 9571.2 11229.9 11288.8 11411.0 11438.3 10556.1 10625.5 10666.5 10922.3 10924.8 11224.0 11534.6 11752.2 11837.5 11880.9 9841.8 11555.7 11588.0 11691.7 11863.3 10069.5 10794.8 10976.9 11110.8 11424.0 05:03:41 INFO - PROCESS | 1637 | 05:03:41 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:6793.65 Median:2416.77 stddev:4230.39 (175.0%) stddev-sans-first:4223.68 05:03:41 INFO - PROCESS | 1637 | Values: 1517.5 1546.8 1548.4 1563.1 1570.4 8849.3 9341.6 10941.8 11185.3 11208.7 10993.3 11122.8 11176.6 11194.3 11219.4 2406.2 2457.4 2468.3 2472.6 2473.2 2396.0 2413.2 2428.1 2435.1 2439.6 2022.4 2216.8 2246.4 2341.0 2420.3 2142.3 2336.0 2383.6 2387.4 2391.0 2350.6 2376.1 2388.1 2391.1 2391.9 10934.2 11151.7 11159.9 11185.3 11198.3 5830.4 5906.7 6029.5 6030.0 6038.7 3579.7 3612.0 3661.3 3667.2 3742.8 1190.9 1197.2 1216.0 1234.2 1244.1 13696.9 13870.4 15087.2 15531.8 15623.4 4698.6 4710.7 4733.2 4835.7 4853.8 11768.5 11848.4 11848.6 11859.5 11880.3 5814.3 5905.5 5910.3 5913.2 5946.0 5237.8 5288.5 5315.0 5355.1 5369.8 3862.8 3915.2 3963.8 3989.2 4011.4 1054.3 1058.1 1058.7 1068.6 1069.6 921.3 932.1 939.5 945.8 992.7 5177.7 6396.7 6501.6 6514.3 6589.6 834.6 885.4 935.5 992.6 1017.4 4096.7 4164.7 4233.3 4271.4 4308.8 11782.8 13471.7 14077.3 14088.0 14102.9 12450.4 13471.9 13692.5 13720.7 13931.2 10166.0 10274.2 10295.8 10320.7 10321.3 6478.4 6531.7 6551.4 6666.6 6804.1 11653.3 12188.9 12352.7 12454.5 12688.4 12563.5 12658.9 12767.4 12891.5 13053.2 10043.5 10322.3 10445.6 10490.6 10511.0 10682.1 10693.3 10720.0 10813.1 10933.3 9003.2 9032.5 9058.0 9129.2 9180.3 7778.8 8763.3 8829.6 8941.3 8963.9 7979.0 7986.3 8061.8 8078.7 8102.2 5452.5 6028.6 6057.8 6071.2 6198.3 6014.2 6047.2 6084.8 6143.6 6174.2 05:03:41 INFO - PROCESS | 1637 | 05:03:41 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4558.72 Median:4903.73 stddev:1250.54 (25.5%) stddev-sans-first:1212.88 05:03:41 INFO - PROCESS | 1637 | Values: 318.8 346.9 381.0 384.6 390.9 4254.4 4832.7 4839.0 5028.5 5225.4 4186.9 4832.8 5063.9 5069.0 5124.4 4129.8 4235.6 4287.2 4300.4 4308.6 4244.0 4292.7 4307.3 4338.6 4368.4 3850.0 4293.8 4309.7 4334.4 4349.1 3870.4 4103.7 4289.1 4306.7 4308.7 3600.3 3919.0 3923.9 3926.1 3927.8 4991.6 4992.3 4992.5 5006.6 5024.9 4741.2 4746.9 4769.8 4918.1 4975.2 4677.6 5051.6 5499.0 5521.3 5554.6 4371.1 4411.8 4423.6 4461.4 4500.7 4831.5 4927.7 5093.5 5201.0 5850.8 4041.5 4328.7 4428.3 4463.7 4468.3 4525.8 4592.3 4606.8 4608.1 4608.3 4086.4 4530.8 4815.9 4900.9 4933.7 4429.6 5158.8 5465.5 5478.4 5543.1 1362.9 1497.3 1525.5 1534.9 1548.8 1044.9 1064.8 1149.0 1170.6 1184.7 4651.3 4670.4 4670.9 4691.9 5119.0 4846.9 5016.4 5624.9 5628.7 5670.8 4578.0 4686.1 4842.6 4906.5 5043.2 2562.3 2953.9 2954.1 2958.9 2961.0 4949.7 5491.7 5664.9 5757.7 5950.7 4803.9 5416.5 5699.9 5890.3 5912.4 4972.3 5071.5 5079.9 5484.0 5934.4 5238.6 5683.9 5740.7 5743.6 5744.8 5313.4 5631.3 5637.9 5651.4 5677.8 4388.5 5109.5 5726.6 5883.0 5999.7 4645.9 4816.7 4948.2 4972.7 4982.8 5146.3 5240.0 5449.6 5460.7 5728.6 4667.0 5256.0 5304.3 5432.7 5478.8 4953.9 5465.9 5470.2 5514.8 5598.8 4229.5 4931.7 5058.4 5309.3 5428.3 4538.7 4671.0 5202.9 5468.8 5480.2 4956.9 5164.6 5375.5 5421.8 5470.5 05:03:41 INFO - PROCESS | 1637 | 05:03:41 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:19701.85 Median:4209.64 stddev:27910.31 (663.0%) stddev-sans-first:27951.92 05:03:41 INFO - PROCESS | 1637 | Values: 645.0 698.5 730.7 789.3 822.6 13417.0 14989.9 16167.8 16355.7 16405.0 15021.8 15242.3 15322.2 15325.3 15344.9 905.0 920.4 940.2 940.4 942.3 908.1 922.9 923.6 925.8 936.9 977.3 979.5 979.9 981.0 981.4 969.0 973.3 977.6 979.3 980.9 716.6 719.8 726.2 726.4 728.8 15783.2 16275.8 16352.4 16631.7 16725.2 13967.4 14203.1 14292.0 14326.9 14372.0 11543.5 11813.8 11838.3 11861.7 11895.6 2859.0 3268.3 3381.9 3399.9 3682.5 55323.0 70905.6 73607.0 80503.6 112687.0 10651.7 11036.7 11101.0 11211.6 11355.8 21760.2 22052.7 22061.3 22095.1 22358.0 7637.5 7781.2 7860.5 8103.8 8105.4 4185.7 4233.6 4276.4 4395.0 4473.4 3474.3 3479.1 3502.7 3529.6 3565.7 591.2 611.1 628.2 636.8 657.5 670.6 697.4 703.4 722.1 723.4 9660.4 10301.6 10411.6 10478.4 10548.6 679.7 687.2 705.7 706.4 712.1 4513.4 4962.8 4966.5 4976.6 4978.5 110268.0 110588.4 112565.0 112812.4 113793.4 75980.0 93496.5 93815.0 93964.5 96144.0 58630.4 62284.8 74714.6 74857.0 80901.6 10072.0 10837.7 11010.0 11074.9 11083.5 47188.0 48827.0 49410.0 49544.0 50003.0 60785.7 61803.7 63289.4 63496.4 63799.0 12576.7 12605.7 12720.2 12765.7 13029.0 14475.7 14549.5 14717.0 14787.4 14968.6 11263.9 13327.5 13660.4 13696.9 13739.2 11109.3 12957.6 13714.2 13721.8 14348.3 12760.8 12946.6 13473.8 13561.3 13689.3 9004.0 9176.4 9324.6 9513.5 9695.8 10617.6 11011.3 11358.9 11375.4 11387.6 05:03:41 INFO - PROCESS | 1637 | -------- Summary: end -------- 05:03:41 INFO - PROCESS | 1637 | 05:03:41 INFO - TEST-INFO | 1637: exit 0 05:03:41 INFO - TEST-OK | dromaeo_css | took 1116862ms 05:03:41 INFO - TEST-START | kraken 05:03:41 INFO - operating with platform_type : mac_ 05:03:41 INFO - Initialising browser for kraken test... 05:03:41 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpV3e_Gl/profile http://localhost:49241/getInfo.html) 05:03:44 INFO - PROCESS | 1649 | 2017-04-12 05:03:44.521 plugin-container[1650:10158] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 05:03:44 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:03:44 INFO - PROCESS | 1649 | 2017-04-12 05:03:44.524 plugin-container[1650:10158] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4617, name = 'com.apple.CFPasteboardClient' 05:03:44 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:03:44 INFO - PROCESS | 1649 | 2017-04-12 05:03:44.524 plugin-container[1650:10158] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:03:44 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 05:03:44 INFO - PROCESS | 1649 | colorDepth:24 05:03:44 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 05:03:44 INFO - PROCESS | 1649 | __metrics 05:03:44 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 05:03:45 INFO - TEST-INFO | 1649: exit 0 05:03:45 INFO - Browser initialized. 05:03:45 INFO - Running cycle 1/1 for kraken test... 05:03:45 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpV3e_Gl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:03:47 INFO - PROCESS | 1651 | 2017-04-12 05:03:47.870 plugin-container[1652:10282] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c4b, name = 'com.apple.tsm.portname' 05:03:47 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:03:47 INFO - PROCESS | 1651 | 2017-04-12 05:03:47.870 plugin-container[1652:10282] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c4f, name = 'com.apple.CFPasteboardClient' 05:03:47 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:03:47 INFO - PROCESS | 1651 | 2017-04-12 05:03:47.870 plugin-container[1652:10282] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:03:57 INFO - PROCESS | 1651 | RSS: Main: 220475392 05:03:57 INFO - PROCESS | 1651 | 05:04:00 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 05:04:01 INFO - PROCESS | 1651 | RSS: Main: 235081728 05:04:01 INFO - PROCESS | 1651 | 05:04:04 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 05:04:05 INFO - PROCESS | 1651 | RSS: Main: 243040256 05:04:05 INFO - PROCESS | 1651 | 05:04:08 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 05:04:09 INFO - PROCESS | 1651 | RSS: Main: 246718464 05:04:09 INFO - PROCESS | 1651 | 05:04:11 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 05:04:11 INFO - PROCESS | 1651 | RSS: Main: 247205888 05:04:11 INFO - PROCESS | 1651 | 05:04:13 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:04:14 INFO - PROCESS | 1651 | RSS: Main: 248492032 05:04:14 INFO - PROCESS | 1651 | 05:04:17 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 05:04:18 INFO - PROCESS | 1651 | RSS: Main: 252375040 05:04:18 INFO - PROCESS | 1651 | 05:04:21 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 05:04:22 INFO - PROCESS | 1651 | RSS: Main: 251879424 05:04:22 INFO - PROCESS | 1651 | 05:04:24 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 05:04:25 INFO - PROCESS | 1651 | RSS: Main: 251748352 05:04:25 INFO - PROCESS | 1651 | 05:04:27 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:04:28 INFO - PROCESS | 1651 | RSS: Main: 251404288 05:04:28 INFO - PROCESS | 1651 | 05:04:30 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:04:30 INFO - PROCESS | 1651 | RSS: Main: 251404288 05:04:30 INFO - PROCESS | 1651 | 05:04:33 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:04:33 INFO - PROCESS | 1651 | RSS: Main: 251928576 05:04:33 INFO - PROCESS | 1651 | 05:04:36 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:04:37 INFO - PROCESS | 1651 | RSS: Main: 251875328 05:04:37 INFO - PROCESS | 1651 | 05:04:40 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:04:41 INFO - PROCESS | 1651 | RSS: Main: 251506688 05:04:41 INFO - PROCESS | 1651 | 05:04:42 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 05:04:43 INFO - PROCESS | 1651 | RSS: Main: 255098880 05:04:43 INFO - PROCESS | 1651 | 05:04:43 INFO - PROCESS | 1651 | __start_tp_report 05:04:43 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 05:04:43 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 05:04:43 INFO - PROCESS | 1651 | |i|pagename|runs| 05:04:43 INFO - PROCESS | 1651 | |0;ai-astar;108;118;113;120;121;123;157;116;177;98 05:04:43 INFO - PROCESS | 1651 | |1;audio-beat-detection;148;116;143;165;139;113;104;141;121;130 05:04:43 INFO - PROCESS | 1651 | |2;audio-dft;194;199;196;201;197;201;206;201;204;202 05:04:43 INFO - PROCESS | 1651 | |3;audio-fft;85;59;62;88;54;62;74;85;97;86 05:04:43 INFO - PROCESS | 1651 | |4;audio-oscillator;82;72;86;70;71;70;82;74;103;117 05:04:43 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;110;89;103;87;89;112;91;90;96;89 05:04:43 INFO - PROCESS | 1651 | |6;imaging-darkroom;96;99;104;155;102;151;112;153;153;98 05:04:43 INFO - PROCESS | 1651 | |7;imaging-desaturate;90;95;100;90;90;97;90;91;90;118 05:04:43 INFO - PROCESS | 1651 | |8;json-parse-financial;71;79;58;91;101;82;65;101;105;112 05:04:43 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;58;64;59;67;62;53;63;82;83;63 05:04:43 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;94;97;84;85;80;78;91;101;104;105 05:04:43 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;148;158;141;139;147;147;176;153;212;173 05:04:43 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;164;167;167;168;169;170;167;176;163;168 05:04:43 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;66;67;66;67;65;66;76;85;83;71 05:04:43 INFO - PROCESS | 1651 | __end_tp_report 05:04:43 INFO - PROCESS | 1651 | __start_cc_report 05:04:43 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1005 05:04:43 INFO - PROCESS | 1651 | __end_cc_report 05:04:43 INFO - PROCESS | 1651 | __startTimestamp1491998683103__endTimestamp 05:04:43 INFO - PROCESS | 1651 | 05:04:43 INFO - PROCESS | 1651 | ------- Summary: start ------- 05:04:43 INFO - PROCESS | 1651 | Number of tests: 14 05:04:43 INFO - PROCESS | 1651 | 05:04:43 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:125.10 Median:122.00 stddev:23.72 (19.4%) stddev-sans-first:24.34 05:04:43 INFO - PROCESS | 1651 | Values: 108.0 118.0 113.0 120.0 121.0 123.0 157.0 116.0 177.0 98.0 05:04:43 INFO - PROCESS | 1651 | 05:04:43 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:132.00 Median:140.00 stddev:18.62 (13.3%) stddev-sans-first:18.83 05:04:43 INFO - PROCESS | 1651 | Values: 148.0 116.0 143.0 165.0 139.0 113.0 104.0 141.0 121.0 130.0 05:04:43 INFO - PROCESS | 1651 | 05:04:43 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:200.10 Median:201.00 stddev:3.67 (1.8%) stddev-sans-first:3.15 05:04:43 INFO - PROCESS | 1651 | Values: 194.0 199.0 196.0 201.0 197.0 201.0 206.0 201.0 204.0 202.0 05:04:43 INFO - PROCESS | 1651 | 05:04:43 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:75.20 Median:85.00 stddev:14.94 (17.6%) stddev-sans-first:15.42 05:04:43 INFO - PROCESS | 1651 | Values: 85.0 59.0 62.0 88.0 54.0 62.0 74.0 85.0 97.0 86.0 05:04:43 INFO - PROCESS | 1651 | 05:04:43 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:82.70 Median:73.00 stddev:15.81 (21.7%) stddev-sans-first:16.77 05:04:43 INFO - PROCESS | 1651 | Values: 82.0 72.0 86.0 70.0 71.0 70.0 82.0 74.0 103.0 117.0 05:04:43 INFO - PROCESS | 1651 | 05:04:43 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:95.60 Median:89.00 stddev:9.36 (10.5%) stddev-sans-first:8.35 05:04:43 INFO - PROCESS | 1651 | Values: 110.0 89.0 103.0 87.0 89.0 112.0 91.0 90.0 96.0 89.0 05:04:43 INFO - PROCESS | 1651 | 05:04:43 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:122.30 Median:154.00 stddev:26.78 (17.4%) stddev-sans-first:26.66 05:04:43 INFO - PROCESS | 1651 | Values: 96.0 99.0 104.0 155.0 102.0 151.0 112.0 153.0 153.0 98.0 05:04:43 INFO - PROCESS | 1651 | 05:04:43 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:90.00 stddev:8.81 (9.8%) stddev-sans-first:9.15 05:04:43 INFO - PROCESS | 1651 | Values: 90.0 95.0 100.0 90.0 90.0 97.0 90.0 91.0 90.0 118.0 05:04:43 INFO - PROCESS | 1651 | 05:04:43 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:86.50 Median:68.00 stddev:18.33 (27.0%) stddev-sans-first:18.57 05:04:43 INFO - PROCESS | 1651 | Values: 71.0 79.0 58.0 91.0 101.0 82.0 65.0 101.0 105.0 112.0 05:04:43 INFO - PROCESS | 1651 | 05:04:43 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:63.50 stddev:9.79 (15.4%) stddev-sans-first:10.01 05:04:43 INFO - PROCESS | 1651 | Values: 58.0 64.0 59.0 67.0 62.0 53.0 63.0 82.0 83.0 63.0 05:04:43 INFO - PROCESS | 1651 | 05:04:43 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:91.90 Median:84.50 stddev:9.87 (11.7%) stddev-sans-first:10.44 05:04:43 INFO - PROCESS | 1651 | Values: 94.0 97.0 84.0 85.0 80.0 78.0 91.0 101.0 104.0 105.0 05:04:43 INFO - PROCESS | 1651 | 05:04:43 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:159.40 Median:155.50 stddev:22.27 (14.3%) stddev-sans-first:23.23 05:04:43 INFO - PROCESS | 1651 | Values: 148.0 158.0 141.0 139.0 147.0 147.0 176.0 153.0 212.0 173.0 05:04:43 INFO - PROCESS | 1651 | 05:04:43 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:168.00 stddev:3.54 (2.1%) stddev-sans-first:3.46 05:04:43 INFO - PROCESS | 1651 | Values: 164.0 167.0 167.0 168.0 169.0 170.0 167.0 176.0 163.0 168.0 05:04:43 INFO - PROCESS | 1651 | 05:04:43 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:69.00 stddev:7.51 (10.9%) stddev-sans-first:7.73 05:04:43 INFO - PROCESS | 1651 | Values: 66.0 67.0 66.0 67.0 65.0 66.0 76.0 85.0 83.0 71.0 05:04:43 INFO - PROCESS | 1651 | -------- Summary: end -------- 05:04:43 INFO - PROCESS | 1651 | 05:04:43 INFO - TEST-INFO | 1651: exit 0 05:04:44 INFO - TEST-OK | kraken | took 62256ms 05:04:44 INFO - SUITE-END | took 1179s 05:04:44 INFO - Completed test suite (00:19:39) 05:04:44 INFO - javascript benchmark 05:04:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7644.633355576619, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3424.4863270509436, 3458.948115778263, 3479.965200347996, 3496.091016335752, 3519.87680431185, 5975.312839023508, 5975.701214939252, 6006.489448396892, 6056.939430605704, 6095.177151084602, 6006.699665016754, 6044.0, 6076.969615151918, 6094.421030002154, 6110.908336374947, 4417.646588272931, 5388.488093631099, 5448.564114870801, 5453.918191227135, 5559.58303127265, 5523.6685798852195, 5540.63985840919, 5541.445855414467, 5552.694601796899, 5561.277033985576, 5288.127458969266, 5293.444188360225, 5327.653702509325, 5546.77812887486, 5553.916691249635, 4615.907681846378, 5453.672779633234, 5470.152126420391, 5513.145462453286, 5547.0, 4910.877228069291, 5037.11850426174, 5455.836324910219, 5479.506844384025, 5533.335999680024, 5712.343080545749, 6102.115193296947, 6136.417040381157, 6151.507879369639, 6191.87616247677, 4760.785764640565, 6276.215473065867, 6357.459615932651, 6357.904631430532, 6473.902891456632, 6535.411812936811, 6540.509461790385, 6556.967215163893, 6559.639219842907, 6566.934330656728, 6181.876362472725, 6201.9689901550655, 6212.751489940442, 6218.098375735583, 6229.065640154013, 6283.2460104787715, 6344.6827658616885, 6373.107764912916, 6615.966920165369, 6738.764143254963, 4737.952620473751, 6261.968690156611, 6288.9056664150075, 6376.7130479128555, 6411.743530258831, 6492.805215843532, 6497.864703221114, 6517.478601711851, 6526.804195874131, 6547.836304092436, 6201.627902325875, 6429.099926010363, 6445.806625801233, 6461.64460954652, 6479.384458476437, 6277.591956522811, 6279.0895320178315, 6280.434760871543, 6281.371862813773, 6301.495880329563, 5186.688798672092, 5198.584113270929, 5200.193969934666, 5203.427622961547, 5218.399884013387, 4602.309653551927, 4617.676762626584, 4626.930596041062, 4637.3275874997935, 4645.210314246586, 5854.941450585525, 5913.319968203626, 5963.463288304073, 5963.4931030862, 6144.41628045335, 5349.812756553502, 6303.495720342362, 6527.314631963671, 6540.509461790385, 6556.672166391661, 5961.910571341434, 5962.552808539377, 6098.573099882966, 6139.907901381483, 6178.443940045418, 5653.293338332708, 5720.628159169641, 5747.741351639186, 5766.365699773021, 5786.276715410574, 6412.551121421456, 6457.773977910751, 6751.291114432914, 6763.425108865703, 6789.083473730983, 6329.873402531832, 6351.428371446592, 6397.232332120176, 6444.226692796894, 6445.742170313135, 6722.462203023649, 6732.259451460433, 6734.3265673434225, 6748.7300507979135, 6754.290799465985, 6179.412955769195, 6368.904466432915, 6384.712687929147, 6387.808365749035, 6396.776112836028, 6275.3724627536885, 6352.968235158794, 6363.045543168377, 6391.3289104643345, 6414.069959855888, 6112.235970503687, 6185.319614842274, 6227.813165605039, 6230.906536401867, 6232.75068997235, 6315.3053164152825, 6316.084167795736, 6321.0834429008455, 6321.936780632135, 6332.176817013758, 5145.151050076845, 5951.404859514014, 5994.130851026664, 6124.930239974474, 6153.154053783936, 6211.254649442096, 6295.842603934938, 6296.496280297473, 6343.619382837044, 6344.841378965562, 6226.283977342664, 6259.6870156492905, 6261.029540421242, 6267.905981410374, 6268.498520118471], "value": 5903.218782852511, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.6947536247818, 807.430761313274, 829.3903980574277, 948.3456415073603, 952.200151872427, 38034.80982595087, 38865.80567097168, 40038.599614003884, 40559.18881622366, 40742.79628601853, 37169.81415092928, 37310.44034339487, 37329.62670373295, 37347.81326093366, 37394.25211495775, 7743.535387876731, 7889.684412623516, 10401.895981040168, 10684.03843654071, 10884.401357925311, 10641.627543035995, 10730.463476826166, 10742.677719668383, 10747.140228781678, 10766.24636275461, 10702.839457408145, 10735.946320268387, 10780.51487683056, 10788.406637634927, 10792.676219713421, 10690.839637405406, 10708.625198118107, 10730.087942524895, 10737.24839261252, 10770.299930504492, 9438.292128090421, 10102.595896164145, 10507.579696812118, 10514.474276286155, 10524.31591946521, 34060.48909266363, 34205.31589368199, 34263.4860477093, 34368.31263374744, 34422.48366274508, 3134.294783673678, 3156.7948083374736, 3674.0, 3735.6451137141926, 3905.082305658168, 24874.25377238686, 25065.62401563978, 25468.872655636602, 26842.0, 26854.5971810423, 2603.2580714496276, 3044.512877939519, 3136.9372612547622, 3174.492081266986, 3181.538676891861, 318767.0, 324087.0, 382605.0, 384486.0, 390384.0, 42820.571794281655, 43209.35185972213, 43226.56773432288, 43330.35004474936, 43400.78299608482, 44585.55414445879, 44943.0, 44980.3252951206, 44989.77505112519, 45119.0, 13380.531681391105, 13381.665458363424, 13474.124181928144, 13487.393067311994, 13496.19022858612, 11541.942290288494, 11794.587189448328, 11798.587049453228, 11805.114616403633, 11813.527458901719, 11743.706407339885, 11744.70638234051, 11769.293842369485, 11806.350650714294, 11842.230255033395, 4632.97683511587, 5487.670739755627, 5539.335279766454, 5550.944490555124, 5555.833325000256, 1112.2547892911768, 1133.40190331632, 1142.9028532574823, 1162.5177898179888, 1187.1986409173774, 21453.356399308046, 26230.819613117073, 26304.21087367382, 26342.0, 26608.334791630365, 998.9350692204983, 1218.6100447856777, 1220.341015851448, 1267.3473161321926, 1302.6287508060157, 10775.407352595683, 11279.063978093105, 13445.193288402726, 13732.0, 13748.587542373745, 365091.0, 435869.8206508947, 437081.0, 437537.8123109428, 438110.618893807, 51861.48138518642, 52035.73982130141, 52264.73867630638, 52306.47693523092, 52316.73841630767, 1282.5062350994933, 1380.8481067082612, 1415.591486470968, 1440.063958427031, 1446.2262689461088, 18547.19616842924, 20342.0, 24820.0, 25377.49245015126, 25636.743632564183, 36222.0, 45225.54774452213, 45299.54700452953, 45309.546904530536, 45361.639150825526, 382458.17541824223, 389178.0, 389958.0, 390586.0, 395424.0, 24400.389990250387, 25603.6159457612, 26342.20973370802, 30690.693093069676, 30907.69092309138, 43239.0, 43603.34594981141, 43917.902052448946, 44386.556134438244, 45114.77442612766, 29739.959101431345, 29845.403091938475, 30221.395572088873, 30546.541801872547, 30776.0, 29625.407491850474, 29755.55366669545, 29817.701822981493, 30402.391952161277, 30445.0, 35544.82227588846, 35557.82221088878, 36324.818375907955, 36328.81835590805, 36408.453873192455, 28707.0, 28994.565081524215, 31063.884955222078, 31203.0, 31472.52791208088, 17725.645487090445, 17826.643467130845, 22963.88518057399, 23194.0, 23305.650415244123], "value": 17928.19056359932, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.6288496026136, 425.71477110336065, 426.8353682645998, 430.5952404739547, 435.82131326156275, 20232.29186978456, 20758.89620551897, 21136.682949755766, 21268.89365553172, 21288.36134915955, 21034.894825525887, 21955.0, 22301.665475017886, 22364.329070127922, 22604.660930086062, 5384.869177472736, 6481.643509606958, 6756.594604323732, 6773.559718618299, 6778.5593936394225, 6597.175353080865, 6624.834379140512, 6648.767293144717, 6650.6009639421545, 6662.833429164285, 6361.459275961549, 6535.24844642865, 6629.303923088079, 6635.170603674541, 6665.40011398974, 6514.315996820361, 6588.176477940257, 6656.966715166393, 6681.098051762999, 6681.732730690791, 6225.221847269091, 6415.5829871058695, 6463.224413070461, 6474.967625161891, 6475.514336424787, 24288.878555607287, 25056.874715626487, 25554.36114097144, 25756.87121564399, 26962.46075078507, 2861.527847905093, 2876.8130071545283, 2933.296008957856, 2966.8664910079096, 2968.4063187362613, 15177.772333415007, 15244.46644367453, 15385.615359616098, 16317.184140792913, 16696.916515417346, 1985.463924740312, 2044.2027609232412, 2045.0490521907236, 2050.333641566482, 2050.5181282398776, 162539.0, 170481.14759426125, 177787.0, 178894.0, 181687.18312816834, 21713.348599542038, 21778.89110554437, 21817.0, 21873.453163671034, 21906.0, 31912.840435797672, 31928.680713193036, 32511.512327315108, 32523.34953300921, 32557.51163732546, 8092.0, 8503.362247831437, 8885.644574217089, 9033.87076615423, 9865.112139907444, 8020.959895200486, 8034.0, 8070.47541909774, 8192.713255036164, 8219.794505137419, 9610.279229057849, 9675.90324096764, 9686.07982241686, 9711.902880971242, 9730.151271258439, 3481.3559491494157, 4051.6498138633274, 4132.442120313779, 4148.091877736215, 4148.543660197376, 997.640849294268, 1007.2898606482412, 1009.7273736091214, 1013.5996281468779, 1045.5033858917106, 20733.170673172903, 21177.894110529658, 21204.25785097514, 21315.68026479604, 21405.78594214069, 916.9134575527887, 1005.3816902604846, 1012.8784545854397, 1037.9325343852624, 1046.7487802927242, 9931.304808663468, 10572.947135264429, 10843.98774433369, 10985.670429887115, 11041.944790276159, 676754.0, 691571.0, 747968.0, 768416.0, 790965.0451747704, 114062.28906566408, 142363.0, 148719.0, 154771.90456190813, 165646.0, 1316.1708123881892, 1340.5241139395375, 1372.629390064677, 1378.076688618628, 1378.9241591712353, 19090.713639295143, 20416.897915510326, 20494.487637809176, 20541.691874621592, 20542.79457205409, 64357.0, 65431.67284163549, 65586.68826623536, 65686.0, 67155.0, 62734.0, 89341.55329223312, 89486.55256723675, 91721.08278917125, 91843.0, 11560.768784624428, 11692.883071169179, 11806.232594881305, 12024.0, 12070.094742894493, 13034.283114428417, 13062.54281100157, 13085.280309583064, 13137.0, 13426.798598020841, 9571.234301256021, 11229.887701122883, 11288.830667540158, 11411.0, 11438.256513326607, 10556.102731267621, 10625.468726563795, 10666.466676665981, 10922.29005114665, 10924.836127458253, 11224.045956093823, 11534.59628912984, 11752.23610465317, 11837.526498939946, 11880.940595296968, 9841.753956151153, 11555.711107222387, 11587.957083862493, 11691.707707307045, 11863.34751588671, 10069.496525173565, 10794.838077428687, 10976.890231097907, 11110.777784444428, 11424.0], "value": 11568.614743267439, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1517.4537166620007, 1546.7602521609153, 1548.388386587298, 1563.1324614838768, 1570.4110958390604, 8849.336299777518, 9341.579628916697, 10941.83587246192, 11185.32888026718, 11208.719782005433, 10993.285436446626, 11122.833157502624, 11176.608818691348, 11194.328340299568, 11219.38293393865, 2406.1698713943706, 2457.410221546834, 2468.308873515419, 2472.5673007223663, 2473.2209354053507, 2395.9520809583796, 2413.1915808204185, 2428.113738485458, 2435.0990133650575, 2439.609662454008, 2022.383173132194, 2216.8115710164657, 2246.382244882654, 2340.9648855267183, 2420.346506443268, 2142.3144593730012, 2336.0188720737333, 2383.642453631952, 2387.3554140382084, 2390.95218095638, 2350.623900175981, 2376.0614557249964, 2388.1163969331283, 2391.0794344177443, 2391.940201494959, 10934.179936504794, 11151.665450036431, 11159.888401115966, 11185.272957257834, 11198.272112312674, 5830.4169583041785, 5906.704664766788, 6029.54778391618, 6029.969850150765, 6038.667873266969, 3579.677828995377, 3611.981940090309, 3661.3226553087766, 3667.15655399257, 3742.8315725792404, 1190.8987736042448, 1197.1679682620581, 1215.9635210943686, 1234.2224398628896, 1244.1104610203747, 13696.93151534246, 13870.4451821927, 15087.24563771818, 15531.767023494656, 15623.375064997386, 4698.553637404441, 4710.719989060774, 4733.242681170997, 4835.661503694778, 4853.757312134379, 11768.529258829722, 11848.407579620984, 11848.644540663794, 11859.525618975144, 11880.287182768889, 5814.302283725895, 5905.498032667271, 5910.261217347832, 5913.201717768046, 5946.048632218824, 5237.790488380422, 5288.524032837063, 5314.97342513285, 5355.062863998784, 5369.838904832861, 3862.8261728222296, 3915.197384536163, 3963.8216280267457, 3989.202159568098, 4011.3782363733667, 1054.2778196935124, 1058.1217589400778, 1058.730023843915, 1068.58859339155, 1069.6363236499628, 921.3185935667434, 932.0958670090001, 939.5020639061308, 945.8202941441104, 992.7468495533593, 5177.689338639693, 6396.744130234739, 6501.577397469149, 6514.250861151028, 6589.637569933604, 834.6160766047686, 885.3625389719392, 935.4808081514689, 992.5731935267904, 1017.353980222564, 4096.7102024988035, 4164.687648426319, 4233.322668373045, 4271.380649805761, 4308.784560771949, 11782.823257651142, 13471.730565388832, 14077.296135193199, 14088.0, 14102.929485352508, 12450.377481125908, 13471.932640336736, 13692.452301908012, 13720.725585488235, 13931.233782142079, 10166.034226748447, 10274.229432792421, 10295.845562316421, 10320.690379288633, 10321.277510574339, 6478.4169424752, 6531.738730450918, 6551.377619126175, 6666.633335166418, 6804.11546498952, 11653.30080195191, 12188.878111219128, 12352.691182720504, 12454.501819927102, 12688.365581721062, 12563.497460101493, 12658.87341126577, 12767.361631918182, 12891.548795792101, 13053.216806991612, 10043.497825108861, 10322.277440579388, 10445.582176712845, 10490.580376784843, 10511.001454861776, 10682.145428365868, 10693.304935179189, 10720.035196832323, 10813.080888124598, 10933.289336193122, 9003.234725048444, 9032.45805251687, 9057.95471022667, 9129.178373946112, 9180.311476639145, 7778.766637000899, 8763.298936085226, 8829.646814127364, 8941.329400295133, 8963.910360896307, 7978.962734844433, 7986.281234688906, 8061.758147255592, 8078.7172448964, 8102.189781022086, 5452.5365343946205, 6028.57799953999, 6057.757689692363, 6071.241094863142, 6198.318184999556, 6014.218151640259, 6047.213862197887, 6084.756609735561, 6143.6006659568775, 6174.228221472316], "value": 5171.876224189524, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.76411455522907, 346.9236767911062, 380.9904752381191, 384.60385802623307, 390.8866428735667, 4254.446921900157, 4832.685875418099, 4838.96763359389, 5028.472010438902, 5225.372955245376, 4186.906546726636, 4832.782524786384, 5063.898722025567, 5068.9608630230805, 5124.385073791141, 4129.772862492562, 4235.6187943085115, 4287.249731297011, 4300.354946757988, 4308.633766129883, 4243.957560424387, 4292.65658747301, 4307.267764480031, 4338.587834155766, 4368.3884256204, 3849.9807500962597, 4293.806778694966, 4309.676774241929, 4334.371516130159, 4349.1301739652035, 3870.438786375988, 4103.733257338294, 4289.056407590325, 4306.6554675626185, 4308.741475511463, 3600.3159399713973, 3919.0, 3923.920322229223, 3926.0577461409057, 3927.8036098194975, 4991.550760431579, 4992.326035985132, 4992.477294425199, 5006.5744411725045, 5024.924626130611, 4741.193997020515, 4746.881327966794, 4769.80588929093, 4918.147474464802, 4975.203967365204, 4677.579017888406, 5051.570616497602, 5498.972505137449, 5521.337439507245, 5554.583406244507, 4371.125774845043, 4411.757353345564, 4423.606563932383, 4461.397711308964, 4500.662450316239, 4831.492693267227, 4927.728974906378, 5093.536395251264, 5200.957439897665, 5850.771338019021, 4041.515018197835, 4328.740275583412, 4428.31361139024, 4463.732176069446, 4468.285074388147, 4525.7780399292005, 4592.288195329729, 4606.838760643362, 4608.147492713859, 4608.28571571407, 4086.40747091676, 4530.818767249273, 4815.927761083586, 4900.917110228139, 4933.6793108448555, 4429.557044295545, 5158.839261166283, 5465.480779325958, 5478.411640375561, 5543.143047079193, 1362.8569000254831, 1497.288787825796, 1525.4660868695867, 1534.910213748229, 1548.821885483184, 1044.8955104489642, 1064.8136576099307, 1149.0175899605883, 1170.6195486466931, 1184.6919800851667, 4651.2557990721325, 4670.439547254351, 4670.893855585998, 4691.929621055687, 5118.97440512795, 4846.927296090491, 5016.423111342242, 5624.943750562442, 5628.690422026746, 5670.7731690732735, 4577.977110114428, 4686.109639168547, 4842.612590992712, 4906.533879281463, 5043.2255067947, 2562.3209849389928, 2953.8523073846222, 2954.1137658702305, 2958.9408211835644, 2960.955585666217, 4949.747864721543, 5491.7254137292975, 5664.943350566524, 5757.740901659436, 5950.702464876739, 4803.855884323476, 5416.51251387377, 5699.943000570024, 5890.318550905684, 5912.379200184005, 4972.328735620645, 5071.54356107952, 5079.8984020319385, 5484.012877681976, 5934.406559344031, 5238.580913526985, 5683.89164112994, 5740.741666624928, 5743.62666426681, 5744.827655170351, 5313.442088580643, 5631.267935168402, 5637.8590535236945, 5651.4348565143155, 5677.772889084556, 4388.51726310112, 5109.540141387293, 5726.599138060295, 5882.970585147047, 5999.730012149551, 4645.907081858276, 4816.735079570657, 4948.208286674115, 4972.726500042532, 4982.800687972441, 5146.279520867007, 5240.0, 5449.564034877121, 5460.6996615186545, 5728.598998070095, 4666.953330466652, 5256.0, 5304.336957880265, 5432.728363581726, 5478.835634930959, 4953.925691114564, 5465.945340546544, 5470.206820010996, 5514.779408823602, 5598.776048958159, 4229.450171477688, 4931.7040977541465, 5058.431886115316, 5309.309789727311, 5428.321459817523, 4538.704984176018, 4671.0, 5202.921956170585, 5468.753906074316, 5480.150576660464, 4956.900861982812, 5164.584280440169, 5375.5162035417, 5421.810236641856, 5470.53500452466], "value": 4188.872957581096, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.048553383759, 698.4656737595737, 730.6858051038055, 789.2502122983163, 822.646262107294, 13416.993725470604, 14989.925050374746, 16167.83832161678, 16355.672886542277, 16405.015699058065, 15021.849781502182, 15242.314095865684, 15322.15728134952, 15325.310361033753, 15344.923275383635, 905.0316161706976, 920.4201353147507, 940.2149205413488, 940.4028441939349, 942.3356533643764, 908.0919080919081, 922.912323329286, 923.6213152607432, 925.8240934222476, 936.929730270229, 977.2963466304285, 979.485769970764, 979.8726165598463, 981.0336818234034, 981.3866333541537, 968.9612415503407, 973.250597040275, 977.5649835823061, 979.2998006425404, 980.8921018687938, 716.5736386849816, 719.8272414620506, 726.2084328082362, 726.426123362543, 728.8032231297573, 15783.210839457981, 16275.755863662054, 16352.427665031786, 16631.6673666526, 16725.247363868533, 13967.37146828395, 14203.147811131365, 14292.0, 14326.856731432656, 14372.005212849695, 11543.53825846965, 11813.822792658117, 11838.348890811001, 11861.703457413547, 11895.643130706007, 2859.0, 3268.2809781847955, 3381.915452113717, 3399.8780402467373, 3682.521272234619, 55322.96729639982, 70905.64547177283, 73607.0, 80503.5974820128, 112687.0, 10651.680449586369, 11036.668899933014, 11101.0, 11211.60759373418, 11355.772884542263, 21760.238391656534, 22052.669209961863, 22061.33815985523, 22095.116195352326, 22358.0, 7637.5035622684345, 7781.182975787574, 7860.528368297806, 8103.837923241502, 8105.432619716681, 4185.707000509935, 4233.576642335742, 4276.358546218092, 4395.033092719596, 4473.4408198975125, 3474.3398754236614, 3479.1128262292955, 3502.6847583717586, 3529.6293889141784, 3565.698520040167, 591.1635036423498, 611.0894766797439, 628.2461046743925, 636.8153235561728, 657.4641667041346, 670.6143967218869, 697.4211404534225, 703.39859420195, 722.1226210154688, 723.4393345157545, 9660.420374777535, 10301.587936482456, 10411.5835366586, 10478.37129772216, 10548.630797922036, 679.7043286170532, 687.2200052939949, 705.6789160931763, 706.3925024478943, 712.0636363182399, 4513.390692256503, 4962.801487940442, 4966.453690094087, 4976.62675299354, 4978.452370239271, 110268.0, 110588.4470577658, 112565.0, 112812.43593782143, 113793.43103284431, 75980.0, 93496.53251733698, 93815.0, 93964.53017734867, 96144.0, 58630.413695863346, 62284.75430491274, 74714.6264268686, 74857.0, 80901.59549202333, 10072.01410400708, 10837.729056773644, 11009.954054364822, 11074.889251107386, 11083.501242443948, 47188.0, 48827.0, 49410.01179976452, 49544.0, 50003.0, 60785.696071519356, 61803.690981546606, 63289.36710632835, 63496.36503635089, 63799.0, 12576.685582860502, 12605.747885042065, 12720.173188742701, 12765.680857978254, 13029.022823288102, 14475.710485790436, 14549.484848635677, 14717.0, 14787.408503660163, 14968.550943471713, 11263.943680281545, 13327.501018997917, 13660.385282662503, 13696.93151534236, 13739.24434156131, 11109.277896936674, 12957.639447858217, 13714.24571648569, 13721.794173087612, 14348.282585870456, 12760.808587871004, 12946.611601651966, 13473.797893031808, 13561.321933903067, 13689.315534223448, 9003.954980225057, 9176.403533770284, 9324.580393882155, 9513.476758778334, 9695.806083878142, 10617.628383006559, 11011.28176570312, 11358.94320528392, 11375.43122843871, 11387.601433949772], "value": 7523.988520243261, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1570.4000000000005, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 118.0, 113.0, 120.0, 121.0, 123.0, 157.0, 116.0, 177.0, 98.0], "value": 125.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 116.0, 143.0, 165.0, 139.0, 113.0, 104.0, 141.0, 121.0, 130.0], "value": 132.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 199.0, 196.0, 201.0, 197.0, 201.0, 206.0, 201.0, 204.0, 202.0], "value": 200.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 59.0, 62.0, 88.0, 54.0, 62.0, 74.0, 85.0, 97.0, 86.0], "value": 75.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 72.0, 86.0, 70.0, 71.0, 70.0, 82.0, 74.0, 103.0, 117.0], "value": 82.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 89.0, 103.0, 87.0, 89.0, 112.0, 91.0, 90.0, 96.0, 89.0], "value": 95.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 99.0, 104.0, 155.0, 102.0, 151.0, 112.0, 153.0, 153.0, 98.0], "value": 122.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 95.0, 100.0, 90.0, 90.0, 97.0, 90.0, 91.0, 90.0, 118.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 79.0, 58.0, 91.0, 101.0, 82.0, 65.0, 101.0, 105.0, 112.0], "value": 86.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 64.0, 59.0, 67.0, 62.0, 53.0, 63.0, 82.0, 83.0, 63.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 97.0, 84.0, 85.0, 80.0, 78.0, 91.0, 101.0, 104.0, 105.0], "value": 91.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 158.0, 141.0, 139.0, 147.0, 147.0, 176.0, 153.0, 212.0, 173.0], "value": 159.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 167.0, 168.0, 169.0, 170.0, 167.0, 176.0, 163.0, 168.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 67.0, 65.0, 66.0, 76.0, 85.0, 83.0, 71.0], "value": 71.2, "unit": "score"}]}]} 05:04:44 INFO - Return code: 0 05:04:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:04:44 ERROR - # TBPL SUCCESS # 05:04:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:04:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:04:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:04:44 INFO - 2017-04-12 05:04:44.465 screenresolution[1656:10671] starting screenresolution argv=screenresolution get 05:04:44 INFO - 2017-04-12 05:04:44.468 screenresolution[1656:10671] Display 0: 1600x1200x32@60 05:04:44 INFO - 2017-04-12 05:04:44.474 screenresolution[1657:10675] starting screenresolution argv=screenresolution list 05:04:44 INFO - Available Modes on Display 0 05:04:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:04:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:04:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:04:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:04:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:04:44 INFO - Intel Iris: 05:04:44 INFO - Chipset Model: Intel Iris 05:04:44 INFO - Type: GPU 05:04:44 INFO - Bus: Built-In 05:04:44 INFO - VRAM (Dynamic, Max): 1536 MB 05:04:44 INFO - Vendor: Intel (0x8086) 05:04:44 INFO - Device ID: 0x0a2e 05:04:44 INFO - Revision ID: 0x0009 05:04:44 INFO - Displays: 05:04:44 INFO - Display: 05:04:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:04:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:04:44 INFO - Display Serial Number: 1600x1200 60 05:04:44 INFO - Main Display: Yes 05:04:44 INFO - Mirror: Off 05:04:44 INFO - Online: Yes 05:04:44 INFO - Rotation: Supported 05:04:44 INFO - Return code: 0 05:04:44 INFO - Running post-action listener: _resource_record_post_action 05:04:44 INFO - [mozharness: 2017-04-12 12:04:44.710599Z] Finished run-tests step (success) 05:04:44 INFO - Running post-run listener: _resource_record_post_run 05:04:44 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 39143936; Write bytes: 513973248; Read time: 243; Write time: 1663 05:04:44 INFO - TinderboxPrint: CPU usage
54.4% 05:04:44 INFO - TinderboxPrint: I/O read bytes / time
39,143,936 / 243 05:04:44 INFO - TinderboxPrint: I/O write bytes / time
513,973,248 / 1,663 05:04:44 INFO - TinderboxPrint: CPU idle
2,189.5 (45.6%) 05:04:44 INFO - TinderboxPrint: CPU system
959.4 (20.0%) 05:04:44 INFO - TinderboxPrint: CPU user
1,652.8 (34.4%) 05:04:44 INFO - TinderboxPrint: Swap in / out
247,922,688 / 0 05:04:44 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 203911680; Write bytes: 202593792; Read time: 15778; Write time: 470 05:04:44 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 37132800; Write bytes: 300586496; Read time: 223; Write time: 1157 05:04:45 INFO - Running post-run listener: _upload_blobber_files 05:04:45 INFO - Blob upload gear active. 05:04:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:04:45 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 05:04:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:04:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:04:45 INFO - (blobuploader) - INFO - Open directory for files ... 05:04:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:04:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:04:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:04:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:04:46 INFO - (blobuploader) - INFO - Done attempting. 05:04:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:04:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:04:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:04:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:04:47 INFO - (blobuploader) - INFO - Done attempting. 05:04:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:04:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:04:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:04:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:04:48 INFO - (blobuploader) - INFO - Done attempting. 05:04:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:04:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:04:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:04:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:04:50 INFO - (blobuploader) - INFO - Done attempting. 05:04:50 INFO - (blobuploader) - INFO - Iteration through files over. 05:04:50 INFO - Return code: 0 05:04:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:04:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:04:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eeb91c6ec290477e74433b72e7c79774fe57067e504f96f4e8e8f454dc7ff4f4f0a7a6aff8a0d999eb6e3e08ee6551842407529e8e05e0287fad07e92047ce29", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d799e6ff4f4253fcc6bc4e93cefcfe9ad58f7654a940dc21d4bfbe56c42f1a160acbde263219f13359277b7bf35fd390a6c8170949e82fecf77dfa6e41df2778", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf06ae6c626aa3ec2a9368ced90e649f48397665a6a60db434486bc04739f9db21976bdb1068ecdf7221eeaa78e71d632f9051b53c928b87b493eef8d62bc68f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/651dbfb9c395afc81ec86c23e91a106a01ce99eb0974fac9c442bb7eef19fbeb7cb3b010978a7a0ecc2d8048e285c54171c6200abc6645a3f362705fb10eafa4"} 05:04:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:04:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:04:50 INFO - Contents: 05:04:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eeb91c6ec290477e74433b72e7c79774fe57067e504f96f4e8e8f454dc7ff4f4f0a7a6aff8a0d999eb6e3e08ee6551842407529e8e05e0287fad07e92047ce29", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d799e6ff4f4253fcc6bc4e93cefcfe9ad58f7654a940dc21d4bfbe56c42f1a160acbde263219f13359277b7bf35fd390a6c8170949e82fecf77dfa6e41df2778", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf06ae6c626aa3ec2a9368ced90e649f48397665a6a60db434486bc04739f9db21976bdb1068ecdf7221eeaa78e71d632f9051b53c928b87b493eef8d62bc68f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/651dbfb9c395afc81ec86c23e91a106a01ce99eb0974fac9c442bb7eef19fbeb7cb3b010978a7a0ecc2d8048e285c54171c6200abc6645a3f362705fb10eafa4"} 05:04:50 INFO - Running post-run listener: copy_logs_to_upload_dir 05:04:50 INFO - Copying logs to upload dir... 05:04:50 INFO - mkdir: /builds/slave/test/build/upload/logs 05:04:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.161747 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-12 05:04:50.290269) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-12 05:04:50.294537) ========= 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.x9A1ZJB3aP/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.njkY2zFP6w/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eeb91c6ec290477e74433b72e7c79774fe57067e504f96f4e8e8f454dc7ff4f4f0a7a6aff8a0d999eb6e3e08ee6551842407529e8e05e0287fad07e92047ce29", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d799e6ff4f4253fcc6bc4e93cefcfe9ad58f7654a940dc21d4bfbe56c42f1a160acbde263219f13359277b7bf35fd390a6c8170949e82fecf77dfa6e41df2778", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf06ae6c626aa3ec2a9368ced90e649f48397665a6a60db434486bc04739f9db21976bdb1068ecdf7221eeaa78e71d632f9051b53c928b87b493eef8d62bc68f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/651dbfb9c395afc81ec86c23e91a106a01ce99eb0974fac9c442bb7eef19fbeb7cb3b010978a7a0ecc2d8048e285c54171c6200abc6645a3f362705fb10eafa4"} build_url:https://queue.taskcluster.net/v1/task/a_3f6jyFTMyk9hDUQyFzVw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011047 build_url: 'https://queue.taskcluster.net/v1/task/a_3f6jyFTMyk9hDUQyFzVw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eeb91c6ec290477e74433b72e7c79774fe57067e504f96f4e8e8f454dc7ff4f4f0a7a6aff8a0d999eb6e3e08ee6551842407529e8e05e0287fad07e92047ce29", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d799e6ff4f4253fcc6bc4e93cefcfe9ad58f7654a940dc21d4bfbe56c42f1a160acbde263219f13359277b7bf35fd390a6c8170949e82fecf77dfa6e41df2778", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf06ae6c626aa3ec2a9368ced90e649f48397665a6a60db434486bc04739f9db21976bdb1068ecdf7221eeaa78e71d632f9051b53c928b87b493eef8d62bc68f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/651dbfb9c395afc81ec86c23e91a106a01ce99eb0974fac9c442bb7eef19fbeb7cb3b010978a7a0ecc2d8048e285c54171c6200abc6645a3f362705fb10eafa4"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-12 05:04:50.333025) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 05:04:50.333341) ========= 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.x9A1ZJB3aP/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.njkY2zFP6w/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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.004443 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 05:04:50.381692) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-12 05:04:50.382014) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-12 05:04:50.382334) ========= ========= Total master_lag: 0.39 =========