builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0093 starttime: 1492055709.73 results: success (0) buildid: 20170412193249 builduid: 118422aa946441f0b2344ad69b1c98a2 revision: 4c78da5f6ddacce5332ead124aa734635fc83d8f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-12 20:55:09.731494) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-12 20:55:09.731934) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-12 20:55:09.732209) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-12 20:55:09.759282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 20:55:09.759703) ========= 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.nJjNw9eL2f/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.yCqkHnd5KH/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 20:55:09-- 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% 153M=0s 2017-04-12 20:55:09 (153 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.148173 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 20:55:09.932036) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 20:55:09.932342) ========= 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.nJjNw9eL2f/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.yCqkHnd5KH/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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.037572 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 20:55:10.017956) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-12 20:55:10.018295) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4c78da5f6ddacce5332ead124aa734635fc83d8f --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 4c78da5f6ddacce5332ead124aa734635fc83d8f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nJjNw9eL2f/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.yCqkHnd5KH/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 20:55:10,148 truncating revision to first 12 chars 2017-04-12 20:55:10,148 Setting DEBUG logging. 2017-04-12 20:55:10,148 attempt 1/10 2017-04-12 20:55:10,148 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4c78da5f6dda?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-12 20:55:10,895 unpacking tar archive at: mozilla-aurora-4c78da5f6dda/testing/mozharness/ program finished with exit code 0 elapsedTime=1.024534 ========= master_lag: 0.28 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-12 20:55:11.320481) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-12 20:55:11.320872) ========= script_repo_revision: 4c78da5f6ddacce5332ead124aa734635fc83d8f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-12 20:55:11.321320) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-12 20:55:11.321607) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-12 20:55:11.341467) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-12 20:55:11.341795) ========= /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.nJjNw9eL2f/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.yCqkHnd5KH/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 20:55:11 INFO - MultiFileLogger online at 20170412 20:55:11 in /builds/slave/test 20:55:11 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 20:55:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:55:11 INFO - {'append_to_log': False, 20:55:11 INFO - 'base_work_dir': '/builds/slave/test', 20:55:11 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:55:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:55:11 INFO - 'branch': 'Mozilla-Aurora', 20:55:11 INFO - 'buildbot_json_path': 'buildprops.json', 20:55:11 INFO - 'config_files': ('talos/mac_config.py',), 20:55:11 INFO - 'default_actions': ('clobber', 20:55:11 INFO - 'read-buildbot-config', 20:55:11 INFO - 'download-and-extract', 20:55:11 INFO - 'populate-webroot', 20:55:11 INFO - 'create-virtualenv', 20:55:11 INFO - 'install', 20:55:11 INFO - 'run-tests'), 20:55:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:55:11 INFO - 'download_minidump_stackwalk': True, 20:55:11 INFO - 'download_symbols': 'ondemand', 20:55:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:55:11 INFO - 'tooltool.py': '/tools/tooltool.py', 20:55:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:55:11 INFO - '/tools/misc-python/virtualenv.py')}, 20:55:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:55:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:55:11 INFO - 'gecko_profile': False, 20:55:11 INFO - 'gecko_profile_interval': 0, 20:55:11 INFO - 'installer_path': 'installer.exe', 20:55:11 INFO - 'log_level': 'info', 20:55:11 INFO - 'log_name': 'talos', 20:55:11 INFO - 'log_to_console': True, 20:55:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:55:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:55:11 INFO - 'opt_config_files': (), 20:55:11 INFO - 'pip_index': False, 20:55:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:55:11 INFO - 'cmd': ('bash', 20:55:11 INFO - '-c', 20:55:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:55:11 INFO - 'enabled': True, 20:55:11 INFO - 'halt_on_failure': False, 20:55:11 INFO - 'name': 'check_screen_resolution'},), 20:55:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:55:11 INFO - 'cmd': ('bash', 20:55:11 INFO - '-c', 20:55:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:55:11 INFO - 'enabled': True, 20:55:11 INFO - 'halt_on_failure': False, 20:55:11 INFO - 'name': 'check_screen_resolution'},), 20:55:11 INFO - 'run_cmd_checks_enabled': True, 20:55:11 INFO - 'suite': 'dromaeojs-e10s', 20:55:11 INFO - 'system_bits': '32', 20:55:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:55:11 INFO - 'title': 't-yosemite-r7-0093', 20:55:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:55:11 INFO - 'use_talos_json': True, 20:55:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:55:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:55:11 INFO - 'work_dir': 'build'} 20:55:11 INFO - [mozharness: 2017-04-13 03:55:11.553609Z] Running clobber step. 20:55:11 INFO - Running pre-action listener: _resource_record_pre_action 20:55:11 INFO - Running main action method: clobber 20:55:11 INFO - rmtree: /builds/slave/test/build 20:55:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:55:14 INFO - Running post-action listener: _resource_record_post_action 20:55:14 INFO - [mozharness: 2017-04-13 03:55:14.015540Z] Finished clobber step (success) 20:55:14 INFO - [mozharness: 2017-04-13 03:55:14.015663Z] Running read-buildbot-config step. 20:55:14 INFO - Running pre-action listener: _resource_record_pre_action 20:55:14 INFO - Running main action method: read_buildbot_config 20:55:14 INFO - Using buildbot properties: 20:55:14 INFO - { 20:55:14 INFO - "project": "", 20:55:14 INFO - "product": "firefox", 20:55:14 INFO - "script_repo_revision": "production", 20:55:14 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 20:55:14 INFO - "repository": "", 20:55:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 20:55:14 INFO - "buildid": "20170412193249", 20:55:14 INFO - "pgo_build": "False", 20:55:14 INFO - "basedir": "/builds/slave/test", 20:55:14 INFO - "buildnumber": 21, 20:55:14 INFO - "slavename": "t-yosemite-r7-0093", 20:55:14 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 20:55:14 INFO - "platform": "yosemite_r7", 20:55:14 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 20:55:14 INFO - "branch": "mozilla-aurora", 20:55:14 INFO - "repo_path": "releases/mozilla-aurora", 20:55:14 INFO - "revision": "4c78da5f6ddacce5332ead124aa734635fc83d8f", 20:55:14 INFO - "stage_platform": "macosx64", 20:55:14 INFO - "builduid": "118422aa946441f0b2344ad69b1c98a2", 20:55:14 INFO - "slavebuilddir": "test" 20:55:14 INFO - } 20:55:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/LwmUDZQ-TD6IrEaa6p3o3g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 20:55:14 INFO - Running post-action listener: _resource_record_post_action 20:55:14 INFO - [mozharness: 2017-04-13 03:55:14.019082Z] Finished read-buildbot-config step (success) 20:55:14 INFO - [mozharness: 2017-04-13 03:55:14.019208Z] Running download-and-extract step. 20:55:14 INFO - Running pre-action listener: _resource_record_pre_action 20:55:14 INFO - Running main action method: download_and_extract 20:55:14 INFO - mkdir: /builds/slave/test/build/tests 20:55: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')]} 20:55:14 INFO - trying https://queue.taskcluster.net/v1/task/LwmUDZQ-TD6IrEaa6p3o3g/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 20:55:14 INFO - Downloading https://queue.taskcluster.net/v1/task/LwmUDZQ-TD6IrEaa6p3o3g/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 20:55:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LwmUDZQ-TD6IrEaa6p3o3g/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 20:55:14 INFO - Downloaded 1199 bytes. 20:55:14 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 20:55:14 INFO - Using the following test package requirements: 20:55:14 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 20:55:14 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:55:14 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 20:55:14 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:55:14 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 20:55:14 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:55:14 INFO - u'jsshell-mac.zip'], 20:55:14 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:55:14 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 20:55:14 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 20:55:14 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:55:14 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 20:55:14 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:55:14 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 20:55:14 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:55:14 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 20:55:14 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:55:14 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 20:55:14 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 20:55:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LwmUDZQ-TD6IrEaa6p3o3g/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 20:55:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LwmUDZQ-TD6IrEaa6p3o3g/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 20:55:14 INFO - Fetch https://queue.taskcluster.net/v1/task/LwmUDZQ-TD6IrEaa6p3o3g/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 20:55:16 INFO - Expected file size: 51790466 20:55:16 INFO - Obtained file size: 51790466 20:55:32 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 20:55:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LwmUDZQ-TD6IrEaa6p3o3g/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 20:55:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LwmUDZQ-TD6IrEaa6p3o3g/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 20:55:32 INFO - Fetch https://queue.taskcluster.net/v1/task/LwmUDZQ-TD6IrEaa6p3o3g/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 20:55:34 INFO - Expected file size: 51790466 20:55:34 INFO - Obtained file size: 51790466 20:55:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LwmUDZQ-TD6IrEaa6p3o3g/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 20:55:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LwmUDZQ-TD6IrEaa6p3o3g/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 20:55:49 INFO - Fetch https://queue.taskcluster.net/v1/task/LwmUDZQ-TD6IrEaa6p3o3g/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 20:55:50 INFO - Expected file size: 14404424 20:55:50 INFO - Obtained file size: 14404424 20:55:51 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')]} 20:55:51 INFO - trying https://queue.taskcluster.net/v1/task/LwmUDZQ-TD6IrEaa6p3o3g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 20:55:51 INFO - Downloading https://queue.taskcluster.net/v1/task/LwmUDZQ-TD6IrEaa6p3o3g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 20:55:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LwmUDZQ-TD6IrEaa6p3o3g/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 20:55:53 INFO - Downloaded 74728711 bytes. 20:55:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LwmUDZQ-TD6IrEaa6p3o3g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 20:55:53 INFO - mkdir: /builds/slave/test/properties 20:55:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:55:53 INFO - Writing to file /builds/slave/test/properties/build_url 20:55:53 INFO - Contents: 20:55:53 INFO - build_url:https://queue.taskcluster.net/v1/task/LwmUDZQ-TD6IrEaa6p3o3g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 20:55:53 INFO - Running post-action listener: _resource_record_post_action 20:55:53 INFO - Running post-action listener: set_extra_try_arguments 20:55:53 INFO - [mozharness: 2017-04-13 03:55:53.810823Z] Finished download-and-extract step (success) 20:55:53 INFO - [mozharness: 2017-04-13 03:55:53.810970Z] Running populate-webroot step. 20:55:53 INFO - Running pre-action listener: _resource_record_pre_action 20:55:53 INFO - Running main action method: populate_webroot 20:55:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:55:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:55:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:55:53 INFO - '--tppagecycles', 20:55:53 INFO - '7'], 20:55:53 INFO - 'tests': ['tsvgm']}}, 20:55:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:55:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:55:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:55:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:55:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:55:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:55:53 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:55:53 INFO - 'talos_options': ['--disable-e10s'], 20:55:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:55:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:55:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:55:53 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:55:53 INFO - 'talos_options': ['--disable-e10s'], 20:55:53 INFO - 'tests': ['damp', 'tps']}, 20:55:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:55:53 INFO - 'tests': ['damp', 'tps']}, 20:55:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:55:53 INFO - 'tests': ['dromaeo_dom']}, 20:55:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:55:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:55:53 INFO - 'tests': ['basic_compositor_video']}, 20:55:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:55:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:55:53 INFO - 'tests': ['a11yr', 20:55:53 INFO - 'ts_paint', 20:55:53 INFO - 'tpaint', 20:55:53 INFO - 'sessionrestore', 20:55:53 INFO - 'sessionrestore_no_auto_restore', 20:55:53 INFO - 'tabpaint']}, 20:55:53 INFO - 'other-e10s': {'tests': ['a11yr', 20:55:53 INFO - 'ts_paint', 20:55:53 INFO - 'tpaint', 20:55:53 INFO - 'sessionrestore', 20:55:53 INFO - 'sessionrestore_no_auto_restore', 20:55:53 INFO - 'tabpaint']}, 20:55:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:55:53 INFO - 'ts_paint', 20:55:53 INFO - 'tpaint', 20:55:53 INFO - 'sessionrestore', 20:55:53 INFO - 'sessionrestore_no_auto_restore', 20:55:53 INFO - 'tabpaint']}, 20:55:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:55:53 INFO - 'ts_paint', 20:55:53 INFO - 'tpaint', 20:55:53 INFO - 'sessionrestore', 20:55:53 INFO - 'sessionrestore_no_auto_restore', 20:55:53 INFO - 'tabpaint']}, 20:55:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:55:53 INFO - 'tests': ['a11yr', 20:55:53 INFO - 'ts_paint', 20:55:53 INFO - 'tpaint', 20:55:53 INFO - 'sessionrestore', 20:55:53 INFO - 'sessionrestore_no_auto_restore', 20:55:53 INFO - 'tabpaint']}, 20:55:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:55:53 INFO - 'tests': ['a11yr', 20:55:53 INFO - 'ts_paint', 20:55:53 INFO - 'tpaint', 20:55:53 INFO - 'sessionrestore', 20:55:53 INFO - 'sessionrestore_no_auto_restore', 20:55:53 INFO - 'tabpaint']}, 20:55:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:55:53 INFO - 'tests': ['tsvgx', 20:55:53 INFO - 'tsvgr_opacity', 20:55:53 INFO - 'tart', 20:55:53 INFO - 'tscrollx', 20:55:53 INFO - 'cart', 20:55:53 INFO - 'tsvg_static']}, 20:55:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:55:53 INFO - 'tsvgr_opacity', 20:55:53 INFO - 'tart', 20:55:53 INFO - 'tscrollx', 20:55:53 INFO - 'cart', 20:55:53 INFO - 'tsvg_static']}, 20:55:53 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:55:53 INFO - 'talos_options': ['--disable-e10s'], 20:55:53 INFO - 'tests': ['tp5o']}, 20:55:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:55:53 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:55:53 INFO - 'talos_options': ['--disable-e10s', 20:55:53 INFO - '--xperf_path', 20:55:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:55:53 INFO - 'tests': ['tp5n']}, 20:55:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:55:53 INFO - 'talos_options': ['--xperf_path', 20:55:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:55:53 INFO - 'tests': ['tp5n']}}, 20:55:53 INFO - 'talos.zip': {'path': '', 20:55:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:55:53 INFO - Running post-action listener: _resource_record_post_action 20:55:53 INFO - [mozharness: 2017-04-13 03:55:53.829765Z] Finished populate-webroot step (success) 20:55:53 INFO - [mozharness: 2017-04-13 03:55:53.829898Z] Running create-virtualenv step. 20:55:53 INFO - Running pre-action listener: _resource_record_pre_action 20:55:53 INFO - Running main action method: create_virtualenv 20:55:53 INFO - Creating virtualenv /builds/slave/test/build/venv 20:55:53 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 20:55:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:55:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:55:53 INFO - Using real prefix '/tools/python27' 20:55:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:55:54 INFO - Installing distribute.............................................................................................................................................................................................done. 20:55:57 INFO - Installing pip.................done. 20:55:57 INFO - Return code: 0 20:55:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:55:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:55:57 INFO - Reading from file tmpfile_stdout 20:55:57 INFO - Output received: 20:55:57 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) 20:55:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:55:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:55:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100f1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f2c78500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cfad30>, '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 0x100c21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cefbe8>, '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.nJjNw9eL2f/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.yCqkHnd5KH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 20:55:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:55:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:55:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nJjNw9eL2f/Render', 20:55:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:55:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:55:57 INFO - 'HOME': '/Users/cltbld', 20:55:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:55:57 INFO - 'LOGNAME': 'cltbld', 20:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:55:57 INFO - 'MOZ_NO_REMOTE': '1', 20:55:57 INFO - 'NO_EM_RESTART': '1', 20:55:57 INFO - 'PAGER': '/bin/cat', 20:55:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:55:57 INFO - 'PWD': '/builds/slave/test', 20:55:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:55:57 INFO - 'SHELL': '/bin/bash', 20:55:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yCqkHnd5KH/Listeners', 20:55:57 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 20:55:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:55:57 INFO - 'USER': 'cltbld', 20:55:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:55:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:55:57 INFO - 'XPC_FLAGS': '0x0', 20:55:57 INFO - 'XPC_SERVICE_NAME': '0', 20:55:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:55:58 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 20:55:58 INFO - Cleaning up... 20:55:58 INFO - Return code: 0 20:55:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:55:58 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')]} 20:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:55:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55:58 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')]} 20:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:55:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55:58 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 0x100f1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f2c78500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cfad30>, '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 0x100c21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cefbe8>, '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.nJjNw9eL2f/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.yCqkHnd5KH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 20:55:58 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 20:55:58 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 20:55:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nJjNw9eL2f/Render', 20:55:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:55:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:55:58 INFO - 'HOME': '/Users/cltbld', 20:55:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:55:58 INFO - 'LOGNAME': 'cltbld', 20:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:55:58 INFO - 'MOZ_NO_REMOTE': '1', 20:55:58 INFO - 'NO_EM_RESTART': '1', 20:55:58 INFO - 'PAGER': '/bin/cat', 20:55:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:55:58 INFO - 'PWD': '/builds/slave/test', 20:55:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:55:58 INFO - 'SHELL': '/bin/bash', 20:55:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yCqkHnd5KH/Listeners', 20:55:58 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 20:55:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:55:58 INFO - 'USER': 'cltbld', 20:55:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:55:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:55:58 INFO - 'XPC_FLAGS': '0x0', 20:55:58 INFO - 'XPC_SERVICE_NAME': '0', 20:55:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:55:58 INFO - Downloading/unpacking psutil>=3.1.1 20:55:58 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 20:55:58 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 20:55:58 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 20:55:58 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 20:55:58 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 20:55:58 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 20:56:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:56:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:56:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:56:01 INFO - Installing collected packages: psutil 20:56:01 INFO - Running setup.py install for psutil 20:56:01 INFO - building 'psutil._psutil_osx' extension 20:56:01 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 20:56:02 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 20:56:02 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 20:56:02 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 20:56:02 INFO - building 'psutil._psutil_posix' extension 20:56:02 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 20:56:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:56:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:56:02 INFO - ^ 20:56:02 INFO - 1 warning generated. 20:56:02 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 20:56:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:56:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:56:03 INFO - Successfully installed psutil 20:56:03 INFO - Cleaning up... 20:56:03 INFO - Return code: 0 20:56:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:56:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:03 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 0x100f1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f2c78500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cfad30>, '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 0x100c21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cefbe8>, '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.nJjNw9eL2f/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.yCqkHnd5KH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 20:56:03 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 20:56:03 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 20:56:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nJjNw9eL2f/Render', 20:56:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:56:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:56:03 INFO - 'HOME': '/Users/cltbld', 20:56:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:56:03 INFO - 'LOGNAME': 'cltbld', 20:56:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:03 INFO - 'MOZ_NO_REMOTE': '1', 20:56:03 INFO - 'NO_EM_RESTART': '1', 20:56:03 INFO - 'PAGER': '/bin/cat', 20:56:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:56:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:03 INFO - 'PWD': '/builds/slave/test', 20:56:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:56:03 INFO - 'SHELL': '/bin/bash', 20:56:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yCqkHnd5KH/Listeners', 20:56:03 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 20:56:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:56:03 INFO - 'USER': 'cltbld', 20:56:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:56:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:56:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:03 INFO - 'XPC_FLAGS': '0x0', 20:56:03 INFO - 'XPC_SERVICE_NAME': '0', 20:56:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:56:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:56:03 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 20:56:03 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 20:56:03 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 20:56:03 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 20:56:03 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 20:56:03 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 20:56:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:56:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:56:06 INFO - Installing collected packages: mozsystemmonitor 20:56:06 INFO - Running setup.py install for mozsystemmonitor 20:56:06 INFO - Successfully installed mozsystemmonitor 20:56:06 INFO - Cleaning up... 20:56:06 INFO - Return code: 0 20:56:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:56:06 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')]} 20:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:06 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')]} 20:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:07 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 0x100f1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f2c78500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cfad30>, '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 0x100c21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cefbe8>, '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.nJjNw9eL2f/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.yCqkHnd5KH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 20:56:07 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 20:56:07 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 20:56:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nJjNw9eL2f/Render', 20:56:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:56:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:56:07 INFO - 'HOME': '/Users/cltbld', 20:56:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:56:07 INFO - 'LOGNAME': 'cltbld', 20:56:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:07 INFO - 'MOZ_NO_REMOTE': '1', 20:56:07 INFO - 'NO_EM_RESTART': '1', 20:56:07 INFO - 'PAGER': '/bin/cat', 20:56:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:56:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:07 INFO - 'PWD': '/builds/slave/test', 20:56:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:56:07 INFO - 'SHELL': '/bin/bash', 20:56:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yCqkHnd5KH/Listeners', 20:56:07 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 20:56:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:56:07 INFO - 'USER': 'cltbld', 20:56:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:56:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:56:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:07 INFO - 'XPC_FLAGS': '0x0', 20:56:07 INFO - 'XPC_SERVICE_NAME': '0', 20:56:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:07 INFO - Downloading/unpacking jsonschema==2.5.1 20:56:07 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 20:56:07 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 20:56:07 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 20:56:07 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 20:56:07 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 20:56:07 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 20:56:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:56:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:10 INFO - Downloading functools32-3.2.3-2.tar.gz 20:56:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:56:10 INFO - warning: no files found matching '*.txt' 20:56:10 INFO - no previously-included directories found matching 'build' 20:56:10 INFO - no previously-included directories found matching 'dist' 20:56:10 INFO - no previously-included directories found matching '.git*' 20:56:10 INFO - Installing collected packages: jsonschema, functools32 20:56:10 INFO - Running setup.py install for functools32 20:56:11 INFO - warning: no files found matching '*.txt' 20:56:11 INFO - no previously-included directories found matching 'build' 20:56:11 INFO - no previously-included directories found matching 'dist' 20:56:11 INFO - no previously-included directories found matching '.git*' 20:56:11 INFO - Successfully installed jsonschema functools32 20:56:11 INFO - Cleaning up... 20:56:11 INFO - Return code: 0 20:56:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:56:11 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')]} 20:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:11 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')]} 20:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:11 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 0x100f1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f2c78500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cfad30>, '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 0x100c21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cefbe8>, '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.nJjNw9eL2f/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.yCqkHnd5KH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 20:56:11 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 20:56:11 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 20:56:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nJjNw9eL2f/Render', 20:56:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:56:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:56:11 INFO - 'HOME': '/Users/cltbld', 20:56:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:56:11 INFO - 'LOGNAME': 'cltbld', 20:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:11 INFO - 'MOZ_NO_REMOTE': '1', 20:56:11 INFO - 'NO_EM_RESTART': '1', 20:56:11 INFO - 'PAGER': '/bin/cat', 20:56:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:11 INFO - 'PWD': '/builds/slave/test', 20:56:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:56:11 INFO - 'SHELL': '/bin/bash', 20:56:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yCqkHnd5KH/Listeners', 20:56:11 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 20:56:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:56:11 INFO - 'USER': 'cltbld', 20:56:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:56:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:11 INFO - 'XPC_FLAGS': '0x0', 20:56:11 INFO - 'XPC_SERVICE_NAME': '0', 20:56:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:56:11 INFO - Cleaning up... 20:56:11 INFO - Return code: 0 20:56:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:56:11 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')]} 20:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:11 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')]} 20:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:11 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 0x100f1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f2c78500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cfad30>, '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 0x100c21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cefbe8>, '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.nJjNw9eL2f/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.yCqkHnd5KH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 20:56:11 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 20:56:11 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 20:56:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nJjNw9eL2f/Render', 20:56:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:56:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:56:11 INFO - 'HOME': '/Users/cltbld', 20:56:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:56:11 INFO - 'LOGNAME': 'cltbld', 20:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:11 INFO - 'MOZ_NO_REMOTE': '1', 20:56:11 INFO - 'NO_EM_RESTART': '1', 20:56:11 INFO - 'PAGER': '/bin/cat', 20:56:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:11 INFO - 'PWD': '/builds/slave/test', 20:56:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:56:11 INFO - 'SHELL': '/bin/bash', 20:56:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yCqkHnd5KH/Listeners', 20:56:11 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 20:56:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:56:11 INFO - 'USER': 'cltbld', 20:56:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:56:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:11 INFO - 'XPC_FLAGS': '0x0', 20:56:11 INFO - 'XPC_SERVICE_NAME': '0', 20:56:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:11 INFO - Downloading/unpacking blobuploader==1.2.4 20:56:11 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 20:56:11 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 20:56:11 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 20:56:11 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 20:56:11 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 20:56:11 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 20:56:14 INFO - Downloading blobuploader-1.2.4.tar.gz 20:56:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:56:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:56:14 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 20:56:14 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 20:56:14 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 20:56:14 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 20:56:14 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 20:56:14 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 20:56:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:56:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:56:14 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 20:56:14 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 20:56:14 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 20:56:14 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 20:56:14 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 20:56:14 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 20:56:15 INFO - Downloading docopt-0.6.1.tar.gz 20:56:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:56:15 INFO - Installing collected packages: blobuploader, requests, docopt 20:56:15 INFO - Running setup.py install for blobuploader 20:56:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:56:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:56:15 INFO - Running setup.py install for requests 20:56:16 INFO - Running setup.py install for docopt 20:56:16 INFO - Successfully installed blobuploader requests docopt 20:56:16 INFO - Cleaning up... 20:56:16 INFO - Return code: 0 20:56:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:56:16 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')]} 20:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:16 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')]} 20:56:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:16 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 0x100f1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f2c78500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cfad30>, '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 0x100c21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cefbe8>, '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.nJjNw9eL2f/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.yCqkHnd5KH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 20:56:16 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 20:56:16 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 20:56:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nJjNw9eL2f/Render', 20:56:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:56:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:56:16 INFO - 'HOME': '/Users/cltbld', 20:56:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:56:16 INFO - 'LOGNAME': 'cltbld', 20:56:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:16 INFO - 'MOZ_NO_REMOTE': '1', 20:56:16 INFO - 'NO_EM_RESTART': '1', 20:56:16 INFO - 'PAGER': '/bin/cat', 20:56:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:56:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:16 INFO - 'PWD': '/builds/slave/test', 20:56:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:56:16 INFO - 'SHELL': '/bin/bash', 20:56:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yCqkHnd5KH/Listeners', 20:56:16 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 20:56:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:56:16 INFO - 'USER': 'cltbld', 20:56:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:56:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:56:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:16 INFO - 'XPC_FLAGS': '0x0', 20:56:16 INFO - 'XPC_SERVICE_NAME': '0', 20:56:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:56:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:56:16 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-vSuOJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:56:16 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-R3DmwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:56:16 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-AV4JuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:56:17 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-gFjnRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:56:17 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-NJWgDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:56:17 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-ozzDA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:56:17 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-GilvwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:56:17 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-2oCMpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:56:17 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-D3UJwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:56:17 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-qJmvjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:56:17 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-RM0XO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:56:17 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-zvABaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:56:17 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-Zxq5CZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:56:18 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-kvPvil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:56:18 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-yMbBIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:56:18 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-1yPHyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:56:18 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-9g1sam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:56:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:56:18 INFO - Running setup.py install for manifestparser 20:56:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:56:18 INFO - Running setup.py install for mozcrash 20:56:18 INFO - Running setup.py install for mozdebug 20:56:18 INFO - Running setup.py install for mozdevice 20:56:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:56:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:56:19 INFO - Running setup.py install for mozfile 20:56:19 INFO - Running setup.py install for mozhttpd 20:56:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:56:19 INFO - Running setup.py install for mozinfo 20:56:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:56:19 INFO - Running setup.py install for mozInstall 20:56:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:56:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:56:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:56:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:56:19 INFO - Running setup.py install for mozleak 20:56:19 INFO - Running setup.py install for mozlog 20:56:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:56:19 INFO - Running setup.py install for moznetwork 20:56:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:56:20 INFO - Running setup.py install for mozprocess 20:56:20 INFO - Running setup.py install for mozprofile 20:56:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:56:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:56:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:56:20 INFO - Running setup.py install for mozrunner 20:56:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:56:20 INFO - Running setup.py install for mozscreenshot 20:56:20 INFO - Running setup.py install for moztest 20:56:20 INFO - Running setup.py install for mozversion 20:56:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:56:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:56:21 INFO - Cleaning up... 20:56:21 INFO - Return code: 0 20:56:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:21 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 0x100f1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f2c78500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cfad30>, '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 0x100c21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cefbe8>, '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.nJjNw9eL2f/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.yCqkHnd5KH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 20:56:21 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 20:56:21 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 20:56:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nJjNw9eL2f/Render', 20:56:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:56:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:56:21 INFO - 'HOME': '/Users/cltbld', 20:56:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:56:21 INFO - 'LOGNAME': 'cltbld', 20:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:21 INFO - 'MOZ_NO_REMOTE': '1', 20:56:21 INFO - 'NO_EM_RESTART': '1', 20:56:21 INFO - 'PAGER': '/bin/cat', 20:56:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:21 INFO - 'PWD': '/builds/slave/test', 20:56:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:56:21 INFO - 'SHELL': '/bin/bash', 20:56:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yCqkHnd5KH/Listeners', 20:56:21 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 20:56:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:56:21 INFO - 'USER': 'cltbld', 20:56:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:56:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:21 INFO - 'XPC_FLAGS': '0x0', 20:56:21 INFO - 'XPC_SERVICE_NAME': '0', 20:56:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:56:21 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-pAeJdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:56:21 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)) 20:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:56:21 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-410Ezl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:56:21 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)) 20:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:56:21 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-9WNFDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:56:21 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)) 20:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:56:21 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-JPSSgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:56:21 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)) 20:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:56:21 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-_RcqRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:56:21 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)) 20:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:56:21 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-Bv3FzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:56:21 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)) 20:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:56:21 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-_J1GgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:56:22 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)) 20:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:56:22 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-H1pvYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:56:22 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)) 20:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:56:22 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-C86Ypm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:56:22 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)) 20:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:56:22 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-qA5mY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:56:22 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)) 20:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:56:22 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-BlJVP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:56:22 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)) 20:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:56:22 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-vXvMoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:56:22 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)) 20:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:56:22 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-XSlXEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:56:22 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)) 20:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:56:22 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-4r1QJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:56:22 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)) 20:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:56:22 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-hfQlF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:56:22 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)) 20:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:56:22 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-C7suD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:56:23 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)) 20:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:56:23 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-4eDgZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:56:23 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)) 20:56:23 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)) 20:56:23 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)) 20:56:23 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)) 20:56:23 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)) 20:56:23 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)) 20:56:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:56:23 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 20:56:23 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 20:56:23 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 20:56:23 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 20:56:23 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 20:56:23 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 20:56:25 INFO - Downloading blessings-1.6.tar.gz 20:56:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:56:25 INFO - Installing collected packages: blessings 20:56:25 INFO - Running setup.py install for blessings 20:56:26 INFO - Successfully installed blessings 20:56:26 INFO - Cleaning up... 20:56:26 INFO - Return code: 0 20:56:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:56:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:56:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:56:26 INFO - Reading from file tmpfile_stdout 20:56:26 INFO - Current package versions: 20:56:26 INFO - blessings == 1.6 20:56:26 INFO - blobuploader == 1.2.4 20:56:26 INFO - docopt == 0.6.1 20:56:26 INFO - functools32 == 3.2.3-2 20:56:26 INFO - jsonschema == 2.5.1 20:56:26 INFO - manifestparser == 1.1 20:56:26 INFO - mozInstall == 1.12 20:56:26 INFO - mozcrash == 1.0 20:56:26 INFO - mozdebug == 0.1 20:56:26 INFO - mozdevice == 0.49 20:56:26 INFO - mozfile == 1.2 20:56:26 INFO - mozhttpd == 0.7 20:56:26 INFO - mozinfo == 0.9 20:56:26 INFO - mozleak == 0.1 20:56:26 INFO - mozlog == 3.4 20:56:26 INFO - moznetwork == 0.27 20:56:26 INFO - mozprocess == 0.25 20:56:26 INFO - mozprofile == 0.28 20:56:26 INFO - mozrunner == 6.13 20:56:26 INFO - mozscreenshot == 0.1 20:56:26 INFO - mozsystemmonitor == 0.3 20:56:26 INFO - moztest == 0.8 20:56:26 INFO - mozversion == 1.4 20:56:26 INFO - psutil == 3.1.1 20:56:26 INFO - requests == 1.2.3 20:56:26 INFO - wsgiref == 0.1.2 20:56:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:56:26 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')]} 20:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:26 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')]} 20:56:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:26 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 0x100f1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f2c78500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cfad30>, '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 0x100c21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cefbe8>, '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.nJjNw9eL2f/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.yCqkHnd5KH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 20:56:26 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 20:56:26 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 20:56:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nJjNw9eL2f/Render', 20:56:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:56:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:56:26 INFO - 'HOME': '/Users/cltbld', 20:56:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:56:26 INFO - 'LOGNAME': 'cltbld', 20:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:26 INFO - 'MOZ_NO_REMOTE': '1', 20:56:26 INFO - 'NO_EM_RESTART': '1', 20:56:26 INFO - 'PAGER': '/bin/cat', 20:56:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:26 INFO - 'PWD': '/builds/slave/test', 20:56:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:56:26 INFO - 'SHELL': '/bin/bash', 20:56:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yCqkHnd5KH/Listeners', 20:56:26 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 20:56:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:56:26 INFO - 'USER': 'cltbld', 20:56:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:56:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:26 INFO - 'XPC_FLAGS': '0x0', 20:56:26 INFO - 'XPC_SERVICE_NAME': '0', 20:56:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:56:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:26 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)) 20:56:26 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)) 20:56:26 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)) 20:56:26 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)) 20:56:26 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)) 20:56:26 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)) 20:56:26 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)) 20:56:26 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)) 20:56:26 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)) 20:56:26 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)) 20:56:26 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)) 20:56:26 INFO - Cleaning up... 20:56:26 INFO - Return code: 0 20:56:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:56:26 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')]} 20:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:26 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')]} 20:56:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:26 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 0x100f1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f2c78500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cfad30>, '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 0x100c21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cefbe8>, '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.nJjNw9eL2f/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.yCqkHnd5KH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 20:56:26 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 20:56:26 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 20:56:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nJjNw9eL2f/Render', 20:56:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:56:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:56:26 INFO - 'HOME': '/Users/cltbld', 20:56:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:56:26 INFO - 'LOGNAME': 'cltbld', 20:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:26 INFO - 'MOZ_NO_REMOTE': '1', 20:56:26 INFO - 'NO_EM_RESTART': '1', 20:56:26 INFO - 'PAGER': '/bin/cat', 20:56:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:26 INFO - 'PWD': '/builds/slave/test', 20:56:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:56:26 INFO - 'SHELL': '/bin/bash', 20:56:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yCqkHnd5KH/Listeners', 20:56:26 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 20:56:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:56:26 INFO - 'USER': 'cltbld', 20:56:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:56:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:26 INFO - 'XPC_FLAGS': '0x0', 20:56:26 INFO - 'XPC_SERVICE_NAME': '0', 20:56:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:56:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:56:26 INFO - Cleaning up... 20:56:26 INFO - Return code: 0 20:56:26 INFO - Running post-action listener: _resource_record_post_action 20:56:26 INFO - Running post-action listener: _start_resource_monitoring 20:56:26 INFO - Starting resource monitoring. 20:56:26 INFO - [mozharness: 2017-04-13 03:56:26.956667Z] Finished create-virtualenv step (success) 20:56:26 INFO - [mozharness: 2017-04-13 03:56:26.957633Z] Running install step. 20:56:26 INFO - Running pre-action listener: _resource_record_pre_action 20:56:26 INFO - Running main action method: install 20:56:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:56:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:56:27 INFO - Reading from file tmpfile_stdout 20:56:27 INFO - Detecting whether we're running mozinstall >=1.0... 20:56:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:56:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:56:27 INFO - Reading from file tmpfile_stdout 20:56:27 INFO - Output received: 20:56:27 INFO - Usage: mozinstall [options] installer 20:56:27 INFO - Options: 20:56:27 INFO - -h, --help show this help message and exit 20:56:27 INFO - -d DEST, --destination=DEST 20:56:27 INFO - Directory to install application into. [default: 20:56:27 INFO - "/builds/slave/test"] 20:56:27 INFO - --app=APP Application being installed. [default: firefox] 20:56:27 INFO - mkdir: /builds/slave/test/build/application 20:56:27 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'] 20:56:27 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 20:56:47 INFO - Reading from file tmpfile_stdout 20:56:47 INFO - Output received: 20:56:47 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 20:56:47 INFO - Running post-action listener: _resource_record_post_action 20:56:47 INFO - [mozharness: 2017-04-13 03:56:47.611013Z] Finished install step (success) 20:56:47 INFO - [mozharness: 2017-04-13 03:56:47.611193Z] Running run-tests step. 20:56:47 INFO - Running pre-action listener: _resource_record_pre_action 20:56:47 INFO - Running main action method: run_tests 20:56:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:56:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:56:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:56:47 INFO - 2017-04-12 20:56:47.625 screenresolution[1626:7751] starting screenresolution argv=screenresolution get 20:56:47 INFO - 2017-04-12 20:56:47.628 screenresolution[1626:7751] Display 0: 1600x1200x32@60 20:56:47 INFO - 2017-04-12 20:56:47.634 screenresolution[1627:7754] starting screenresolution argv=screenresolution list 20:56:47 INFO - Available Modes on Display 0 20:56:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:56:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:56:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:56:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:56:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:56:47 INFO - Intel Iris: 20:56:47 INFO - Chipset Model: Intel Iris 20:56:47 INFO - Type: GPU 20:56:47 INFO - Bus: Built-In 20:56:47 INFO - VRAM (Dynamic, Max): 1536 MB 20:56:47 INFO - Vendor: Intel (0x8086) 20:56:47 INFO - Device ID: 0x0a2e 20:56:47 INFO - Revision ID: 0x0009 20:56:47 INFO - Displays: 20:56:47 INFO - Display: 20:56:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:56:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:56:47 INFO - Display Serial Number: 1600x1200 60 20:56:47 INFO - Main Display: Yes 20:56:47 INFO - Mirror: Off 20:56:47 INFO - Online: Yes 20:56:47 INFO - Rotation: Supported 20:56:47 INFO - Return code: 0 20:56:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:56:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:56:47 INFO - Python 2.7.3 20:56:47 INFO - Return code: 0 20:56:47 INFO - grabbing minidump binary from tooltool 20:56:47 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')]} 20:56:47 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 0x100cfad30>, '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 0x100c21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cefbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:56:47 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 20:56:47 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 20:56:47 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 20:56:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:56:47 INFO - Return code: 0 20:56:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:56:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:56:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:56:47 INFO - ENV: RUST_BACKTRACE is now 1 20:56:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:56:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:56:47 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/LwmUDZQ-TD6IrEaa6p3o3g/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0093', '--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 20:56:47 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/LwmUDZQ-TD6IrEaa6p3o3g/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0093 --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 20:56:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nJjNw9eL2f/Render', 20:56:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:56:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:56:47 INFO - 'HOME': '/Users/cltbld', 20:56:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:56:47 INFO - 'LOGNAME': 'cltbld', 20:56:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:56:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:47 INFO - 'MOZ_NO_REMOTE': '1', 20:56:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:56:47 INFO - 'NO_EM_RESTART': '1', 20:56:47 INFO - 'PAGER': '/bin/cat', 20:56:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:47 INFO - 'PWD': '/builds/slave/test', 20:56:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:56:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:56:47 INFO - 'RUST_BACKTRACE': '1', 20:56:47 INFO - 'SHELL': '/bin/bash', 20:56:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yCqkHnd5KH/Listeners', 20:56:47 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 20:56:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:56:47 INFO - 'USER': 'cltbld', 20:56:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:56:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:47 INFO - 'XPC_FLAGS': '0x0', 20:56:47 INFO - 'XPC_SERVICE_NAME': '0', 20:56:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:56:47 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/LwmUDZQ-TD6IrEaa6p3o3g/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0093', '--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 20:56:48 INFO - mozversion application_buildid: 20170412193249 20:56:48 INFO - mozversion application_changeset: 4c78da5f6ddacce5332ead124aa734635fc83d8f 20:56:48 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:56:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:56:48 INFO - mozversion application_name: Firefox 20:56:48 INFO - mozversion application_remotingname: firefox-dev 20:56:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:56:48 INFO - mozversion application_vendor: Mozilla 20:56:48 INFO - mozversion application_version: 54.0a2 20:56:48 INFO - mozversion platform_buildid: 20170412193249 20:56:48 INFO - mozversion platform_changeset: 4c78da5f6ddacce5332ead124aa734635fc83d8f 20:56:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:56:48 INFO - mozversion platform_version: 54.0a2 20:56:48 INFO - using testdate: 1492055808 20:56:48 INFO - actual date: 1492055808 20:56:48 INFO - starting webserver on 'localhost:49251' 20:56:48 INFO - SUITE-START | Running 2 tests 20:56:48 INFO - TEST-START | dromaeo_css 20:56:48 INFO - operating with platform_type : mac_ 20:56:48 INFO - Initialising browser for dromaeo_css test... 20:56:48 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/tmpCQXpBo/profile http://localhost:49251/getInfo.html) 20:56:51 INFO - PROCESS | 1637 | 2017-04-12 20:56:51.206 plugin-container[1639:7927] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f43, name = 'com.apple.tsm.portname' 20:56:51 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:56:51 INFO - PROCESS | 1637 | 2017-04-12 20:56:51.209 plugin-container[1639:7927] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9227, name = 'com.apple.CFPasteboardClient' 20:56:51 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:56:51 INFO - PROCESS | 1637 | 2017-04-12 20:56:51.209 plugin-container[1639:7927] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:56:51 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 20:56:51 INFO - PROCESS | 1637 | colorDepth:24 20:56:51 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 20:56:51 INFO - PROCESS | 1637 | __metrics 20:56:51 ERROR - PROCESS | 1637 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 20:56:52 INFO - TEST-INFO | 1637: exit 0 20:56:52 INFO - Browser initialized. 20:56:52 INFO - Running cycle 1/1 for dromaeo_css test... 20:56:52 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/tmpCQXpBo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:56:54 INFO - PROCESS | 1640 | 2017-04-12 20:56:54.566 plugin-container[1641:8060] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883b, name = 'com.apple.tsm.portname' 20:56:54 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:56:54 INFO - PROCESS | 1640 | 2017-04-12 20:56:54.569 plugin-container[1641:8060] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4723, name = 'com.apple.CFPasteboardClient' 20:56:54 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:56:54 INFO - PROCESS | 1640 | 2017-04-12 20:56:54.569 plugin-container[1641:8060] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:57:04 INFO - PROCESS | 1640 | RSS: Main: 220692480 20:57:04 INFO - PROCESS | 1640 | 21:00:07 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49251/tests/dromaeo/cssquery-ext.html) 21:00:08 INFO - PROCESS | 1640 | RSS: Main: 238211072 21:00:08 INFO - PROCESS | 1640 | 21:01:52 INFO - PROCESS | 1640 | ************************* 21:01:52 INFO - PROCESS | 1640 | A coding exception was thrown and uncaught in a Task. 21:01:52 INFO - PROCESS | 1640 | 21:01:52 ERROR - PROCESS | 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:01:52 INFO - PROCESS | 1640 | Full stack: 21:01:52 INFO - PROCESS | 1640 | ************************* 21:01:52 INFO - PROCESS | 1640 | ************************* 21:01:52 INFO - PROCESS | 1640 | A coding exception was thrown and uncaught in a Task. 21:01:52 INFO - PROCESS | 1640 | 21:01:52 ERROR - PROCESS | 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:01:52 INFO - PROCESS | 1640 | Full stack: 21:01:52 INFO - PROCESS | 1640 | ************************* 21:01:52 INFO - PROCESS | 1640 | ************************* 21:01:52 INFO - PROCESS | 1640 | A coding exception was thrown and uncaught in a Task. 21:01:52 INFO - PROCESS | 1640 | 21:01:52 ERROR - PROCESS | 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:01:52 INFO - PROCESS | 1640 | Full stack: 21:01:52 INFO - PROCESS | 1640 | ************************* 21:01:52 INFO - PROCESS | 1640 | ************************* 21:01:52 INFO - PROCESS | 1640 | A coding exception was thrown and uncaught in a Task. 21:01:52 INFO - PROCESS | 1640 | 21:01:52 ERROR - PROCESS | 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:01:52 INFO - PROCESS | 1640 | Full stack: 21:01:52 INFO - PROCESS | 1640 | ************************* 21:03:11 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-ext.html (next: http://localhost:49251/tests/dromaeo/cssquery-jquery.html) 21:03:11 INFO - PROCESS | 1640 | RSS: Main: 245608448 21:03:11 INFO - PROCESS | 1640 | 21:06:13 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49251/tests/dromaeo/cssquery-mootools.html) 21:06:14 INFO - PROCESS | 1640 | RSS: Main: 255066112 21:06:14 INFO - PROCESS | 1640 | 21:09:16 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49251/tests/dromaeo/cssquery-prototype.html) 21:09:17 INFO - PROCESS | 1640 | RSS: Main: 251543552 21:09:17 INFO - PROCESS | 1640 | 21:12:20 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49251/tests/dromaeo/cssquery-yui.html) 21:12:20 INFO - PROCESS | 1640 | RSS: Main: 257212416 21:12:20 INFO - PROCESS | 1640 | 21:15:23 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-yui.html (next: http://localhost:49251/tests/dromaeo/cssquery-dojo.html) 21:15:24 INFO - PROCESS | 1640 | RSS: Main: 254312448 21:15:24 INFO - PROCESS | 1640 | 21:15:24 INFO - PROCESS | 1640 | __start_tp_report 21:15:24 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 21:15:24 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 21:15:24 INFO - PROCESS | 1640 | |i|pagename|runs| 21:15:24 INFO - PROCESS | 1640 | |0;dojo.html;3390.9321813563743;3399.2351720862807;3406.5230867678547;3422.9559984204816;3435.519027336173;4726.527347265272;5078.568321692656;5486.423925487826;5770.913436298459;5785.103308987103;5678.716064196794;5750.33871104822;5765.567582431314;5780.364159942414;5821.67980761058;5190.9740451297785;5240.659357141773;5242.711650859202;5254.553362964152;5302;5307.814226502073;5323.866903327409;5330.946690533084;5349.786008559653;5383.67697938123;5123.641345105825;5149.665271757323;5234.973825130869;5271.4464981177;5310.283111779918;4099.97950010248;4498.955010449903;5212.6611770235195;5230.372355317386;5390.811321603745;5136.4606716295;5254.868628284324;5266.657667251617;5300.125479295912;5305.336832895888;4720.858374248778;5469.781208751645;5516.9448305516835;5580.581456390787;5658.74535645897;6262.185915830958;6304.968475157641;6317.399847014526;6324.241091069055;6337.081123237105;5745.339285982082;6295.150154729099;6303.0545418187185;6326.2092238470195;6334.904976425358;5669.234653321749;5678.943210567924;5884.70576471179;5898.14476900847;5903.645781253182;6278.672303679057;6289.119523266746;6354.205724284465;6355.968220158869;6370.968145159337;6239.844003899939;6249.9062514062325;6274.968625156845;6277.654728989858;6295.968520157461;6289.182406287154;6294.213223347082;6341.143945567289;6352.872942541123;6361.522885783492;6077.3314935357075;6093.238345206849;6176.7838125665385;6197.163382943335;6320.747170113236;6009.45914867664;6248.375162483806;6298.433141017239;6308.27454842699;6309.053641953744;4229.894252643647;4949.505049495094;5009.874753131201;5018.3476148101245;5034.974825125924;4347.695661303678;4348.28253338202;4389.780510974439;4410.80151393188;4459.286514157784;5861.17943487912;5861.941380586225;5891.027980383275;5900.527957763368;5901;6110.5587591967305;6123.404636889863;6331.810045698637;6333.714982825784;6344.333844946306;5805.912911306334;5825.533957283407;5833.912491312633;5872.970635146797;5890.970545147246;5309.495597918191;5356.491133342326;5367.221752845816;5436.483534064258;5531.1426728857095;6369.87260254783;6387.329330420332;6389.904151437825;6423.197100362455;6434.324395938359;6313.021481670348;6314.431701146918;6323.778667746791;6325.209348831396;6338.746450141943;6263.342349053284;6488.124103246001;6507.934920650733;6511.088447617432;6511.967440162769;6103.7253323601435;6204.3795620439405;6207.906881396692;6233.065040243819;6234.532410069353;6107.053406721965;6286.717097730521;6302.3067462578165;6304.873902521832;6316.399942005502;6095.207623008981;6138.9386106140155;6179.3202747698615;6187.597806142587;6234.501239900887;5912.113183022581;5949;6091.0558863376245;6093.512518998381;6132.04958718918;5854.765809367748;5893.2044174035955;5963.761449541969;5981.401859813984;5999.130126131774;6171.321154672893;6176.197094377702;6182.690865456799;6192.8761424770355;6195.380461953769;4688.789004494738;5292.20616907467;5773.191753154646;5929.16991621182;5941.58408911372 21:15:24 INFO - PROCESS | 1640 | |1;ext.html;706.7208452661198;737.2185483387609;800.9799755006125;823.6622984576318;965.1120968708788;37975.480980760774;38387.42418863719;40611.39082913751;40638.796806015926;40666.7966660167;38953;39187.02032449183;39220.60779392205;39236.60763392365;39342.0164495887;7803.531788092732;10325.948370258177;10606.522706478188;10781.5687372505;10791.62229321974;10454.372737635766;10562.841557376645;10583.153347732163;10592.576296948113;10635.734106647318;10561.841572376421;10563.207759418035;10589.894101058968;10597.523111459965;10604.310719803227;10524;10553.41956192409;10572.577096916115;10573.418461984587;10610;10394.480275986247;10412.895871041268;10445;10460.68617941463;10465.68602941913;29226.561601575995;32251.83874080638;33680.49479257813;33689.32621347584;33725;3711.3876210425246;3767.416050512175;3768.6042965488505;3768.7173461990187;3811.7331786774935;24455.87772061146;24750.876245618656;24887.902374735528;25253;25894;3050.176452357873;3070.370574032318;3074.13924101252;3077.6306843178736;3115.9532607010915;353980;355773;356222.9999999974;357549;357709;43943.340849887274;43970.78014609907;44079.67760967176;44103.77948110239;44138.11723765507;37765.81117094397;39873.60126398699;42675.57324426778;45948.54051459509;46042;13481.258530780706;13822.447102116004;13825.446982120804;13868.514601988882;13870.514531991332;11779.941100294443;11849.170558061025;11891.989180919545;11893.762124757457;11953.641390758292;11474.655760327203;11965.940170299267;11994.220375675553;12042.458089385998;12099.818502722466;5661.320641523043;5708.600397972185;5712.457316554921;5713.714314284269;5715.742791574306;1076.445630500293;1102.0412241350077;1131.1742428027421;1131.8568246071363;1165.9125565582615;21498.78501214999;22523.43691407728;26543.93824247047;26661.866690666422;26690.332741681614;1123.2642619084513;1220.4020030185145;1245.7446223524337;1248.1637303007008;1264.1151194164122;10528.631497897537;13537.526186583422;13652.931735341459;13712.902967762555;13739.96950228737;487714;488003;491353;492376;493118.5344073257;48257.5174248253;49543.50456495461;55387.72306138444;56045.159322609376;56314.43685563174;1400.59382778995;1423.6725553122633;1430.2705620133806;1432.3983926750789;1435.777454494555;23833.404164896016;26201.344966375993;26245.08142215013;26398.736012639627;27185.456290874467;40703.1859362817;40777.98055048529;41040.1791964165;41048.38427423651;41075.178496430504;464009;465558;466323;468582;468818.6559067183;24462.877685611456;29428.705712943454;29463.410731785672;29612.555811663275;29813.10560683183;27767.861160694876;34392.65607343894;37348.81325593355;37960.67137650169;38015.809920951324;25979.350516237246;26793.33016674599;27505.31236719098;27725.722742772316;27868.721312786613;22957.88521057451;23367.065317387114;26112.477750445265;26838.32904177333;27722.8910843564;31165.53251701181;31696.5245521322;31715.682843171275;31768.682313177498;31823;21520.354389368345;25189.622155668047;25320.240392788244;27397.45205095927;27930.603469826834;16119.355225791307;20220.89889550543;20246.59506809885;22635.75503347266;23953.880230598734 21:15:24 INFO - PROCESS | 1640 | |2;jquery.html;414.3101735610209;427.7230011897251;429.5897417965843;435.0472465300991;439.3344083713175;19114.90442547787;20206.89896550517;21367.893160534175;21489.57020859586;21529.46176345592;18835.43493695188;20354.08406621702;21926.342209733735;22054.669179962275;22182.667259991114;6532.281449040614;6890.965545172267;6914.135733033371;6927.238003819576;6935.479839012069;6372.076048972896;6677.632730199837;6735.595864248136;6758.763443279487;6778.627175505345;6423.357664233586;6699.363560461748;6703.865922681543;6734.8316292092595;6763.729450821986;6648.368405001517;6681.5656982296;6707.396334329934;6710.899336509932;6764.763233286836;6238.937610623926;6436.452901503331;6531.791618550584;6578.835529111762;6584.539082264243;21357.359279221648;25673.74326256732;25692.871535642204;25784.74215257861;25968.350791230372;2898.68114507404;2904.4796472420912;3005.443992861328;3022.199117233935;3040.8783648654025;15719.214039298104;16483.34066637333;16619.919705219123;16897.408590699266;17056.317747290093;2009.3067891577382;2040.2043203150783;2057.506198512361;2063.9793602063937;2075.0869617368307;133249.3337533306;135081;138638;155616;159708.20145899314;17768.9111554444;20552;20771.896140519504;21313.25403610866;21354.572908542053;26306.86846565793;31401.214969625486;31621;31956.881509147068;32014.359712805614;10021.498925053718;10086.848697269546;10237.129843963347;10283.971602839656;10428.739281517872;7473.850522989618;8112.22933821286;8488.193621605938;8678.95660521706;8682.348823838238;8124.837503249902;9092.81793366858;9179.403338782959;9495.287853411022;9524.333296669305;4032.193561287754;4032.5564187939303;4155.522114956819;4162.292410290258;4170.874873753793;1002.2282842211456;1005.070309963281;1009.8586197932295;1017.3285631483186;1053.6996955867542;20545.48636284105;20892.58214835695;20925.26761563338;21090.17879891489;21111.68332475014;1000.1948431512702;1006.6108769897495;1033.6330602636106;1036.233187441288;1041.068243921701;10022.3485473444;10613.5223914924;10786.73033174177;10871.130309575216;10876.02115809581;737791;748772.2561387158;756319;771279;776515;145239;147861.52138478693;166320;166673.33326666578;172941;1202.8255902894032;1236.5486597391887;1256.2901960392348;1261.369315342329;1265.0322503284995;17570.121493925;18104.90947545254;18164.36424725181;18285.908570457064;18584.535386615444;56825.431745683665;63457.365426346994;63773.6811315959;63919;63950;70424;89066.55466722885;90740.09259907581;91047.17905641718;92781;11672.88327116718;11681.591144309908;11717.296962182296;11921.165518413627;12077.456514457046;13022;13116.737665246832;13274.004449666121;13438.260895650443;13495.865041349462;9305.348625596143;10850.94574527154;10862.94568527184;11200.495977680861;11383.658490245305;9638.361478548522;9754.365966212457;10287.331323463952;10362.481875906024;10511.26421150512;10162.085412312927;10245;10346.689599312032;11304.208705390543;11683.824742628698;10761.441477216134;11464.770704585695;11627.418629068343;11669.241499302518;11689.357085360387;11212.49543770516;11326.603568875049;11375.20373573842;11476.827847582126;11550.480228389575 21:15:24 INFO - PROCESS | 1640 | |3;mootools.html;1326.2307861440365;1374.7800351943686;1475.911445313282;1548.388386587298;1552.3324970262786;9223.677171299007;9489.952550237256;10495.160387169019;11113.777724445506;11143.1642626803;9790.559424825882;10499.42253176075;11062.889371106286;11085.889141108586;11088.501017454213;2371.6205407134817;2422.818288628351;2425.223928342931;2429.465517586128;2432.2946345559767;2384.6303822907475;2409.0363854458183;2411.770881766229;2413.9275821725378;2428.7085549734056;2065.845061620377;2379.8929048192786;2399.172285561487;2405.386626410263;2409.0363854458183;1925.7592800899888;2359.2922123362923;2384.451576137481;2407.374082738483;2408.0849277274697;2188.4419473034272;2292.5529521743265;2388.7133543974833;2391.844530105555;2413.5172965406987;10861.511231994578;11100.056495197918;11110.61112861054;11118.110551155889;11127.221094523387;5101.0308041472;5693.629914055573;5823.09741989988;5887;5894.8821023579285;3512.613612502623;3624.27514497099;3648.2521083177885;3662.249238906018;3689.631036896316;1194.110387761115;1198.1553005131361;1235.7466719322608;1254.3853511779162;1257.930758854966;15353.385864565404;15499.302531386002;15512.069275843485;15519.689606207925;15520.456784012506;4826.420829500412;4938.827141050046;4959.330490383824;4979.975100124476;5012.749362531858;12978;12987;13014.414351354022;13017.21896686202;13045.478180872658;5933.554983376264;5948.196993405922;5973.014452615356;5976.804639072203;5996.880062398727;4092.9386059209137;4986.60375094974;5103.897922041612;5196.9740151299;5290.92063619046;3286.8356582170795;4016.859409920639;4026.6577340925764;4035.9192816143513;4085.22380747657;1137.5734099712608;1141.7887690777234;1154.3881742676394;1166.2594252649628;1172.1443346357207;929.5723966975132;930.2046750028763;931.5435436636;940.5532372123187;993.438707130469;6524;6652.268250492442;6694.129763130762;6791.3548212919695;6865.313468653195;946.4983558713893;967.3325405470204;978.5351957819978;1000.9849852252222;1020.9132223760915;4254.212970600449;4262.339337402707;4282.229198744194;4295.548967358445;4396.406485124531;13250.801237981437;13698.863011369958;13723.862761372458;13726.725465490634;13736.862631373759;13246.271455069871;13474.244357188534;13556.45774169042;13579.388927498287;13588.660283492794;9932.304738668225;10038.347507412142;10061.79876402468;10075.042870927397;10076.69769906904;6362.268339141058;6465.61206327603;6562;6676.732930682912;6722.596644201363;12058;12170.269783812999;12292.81560776607;12347.506099756269;12371.319577423328;12284;12428.502859885502;12475.376231188222;12488.25070495773;12507.499700011898;7983.640736166771;8234.752957411287;8834.204921557091;9181.081891810765;9299.163075323253;10182.439965801655;10440.37357758537;10522;10534.683959481228;10560.841587376042;8719.433236839584;8751.824963500821;8755.474671519729;8800.867986980329;8824;7836.568988705676;8483.44857584255;8671.219590236657;8789.077146899483;8875.334349923653;7857.192845645419;7928.801779955547;7948.801279968047;7987.800304992422;7990.84018319642;5828.970855145697;5859.472647461749;5865.296164460292;5961.225040744675;6114.48026917717;5934.584579079596;5949.762009519571;6179.474744646575;6204.720787564661;6281.842953926189 21:15:24 INFO - PROCESS | 1640 | |4;prototype.html;339.7638641144404;364.98357573909175;374.87066961898137;377.61483287047196;391.7140487444166;4399.736015839052;4618.983823558816;4983.401991760985;5087.6693014954;5229.843104706855;4783.976080119594;5044.344235249412;5049.722265275417;5090.847274581768;5092.4028745339865;3591.7844929304197;3832.2143960488174;4068.41008053832;4270.338097594878;4280.935785963213;4059.234233108607;4231.4710661167355;4243.575642435762;4248.300679728102;4313.309870420733;3796.6393192646656;4264.040590867061;4268.570029040276;4277.272863613193;4287.892802679927;3557.7687450315907;3750.887473375803;3939.936217221334;4079.775612341305;4084.775337356444;3137.2784259620416;3724.6089160638285;3822.3310920588788;3915.060385507486;3967.682585393162;4685.554872287127;4936.185529387647;4946.3817022872145;4981.850544483635;4984.6261530385;4151.205357811732;4444;4537.9773101134615;4660.347551342815;4908.4846091160625;5352.598555108343;5460.208269800896;5504.80733174341;5524.917126243109;5542.168674698787;3904.4533765272886;4347.673924455678;4376.606105450524;4400.691951563392;4456.777161141962;4694.929576056362;5447.918281225785;5480.671159730429;5513.255710479114;5921.674307913063;3832.7508711933633;4024.5774193709826;4285.292926667127;4433.911321773547;4541.933420293758;4151.941254979961;4227.32362821947;4555.817767289338;4668.346431499593;4706.976465117653;4430.579094985971;4457.509673935864;4724.71651700899;4853.95146048542;4955.776990035457;4917.434495033045;5159.25190847325;5305.814296499604;5416.7020813855615;5491.32514583048;1521.9315130819139;1531.318563239348;1565.9765103523457;1586.1672621873608;1591.6737068900848;1090.4438736244572;1105.1987309200765;1169.584797396929;1172.9882701172878;1175.4122938530734;4442.666799990014;4875.026233997259;5080.974595127074;5124.92312615311;5132.153194722903;5049.31834202378;5050.873728156752;5421.403645598981;5542.3626282977975;5621.325440947113;4166.458659903922;4492.169932942225;4845.297431872359;5094.5160209780015;5112.795488180505;2514.7485251475073;2905.6754596322858;2922.1087568291873;2927;2948.9115326540236;5248.506959194352;5262.657927234717;5519.777370311715;5541.168824676331;5599.356074051455;5060.949390506122;5367.302250707383;5643.661380317194;5796.565257605696;5819.621724587888;5411.485908838654;5457.863553411196;5792.304923409218;5824.3593204748295;5840.94159058404;4979.0788704089855;5619.634723742944;5639.3232812062815;5651.6043876928225;5700.629459085146;4616.468401672656;5070.847874563769;5256.816011439581;5473.658953556245;5568.805091821767;4930.630202734881;5789.1605717171615;5841.94158058414;5858.422294190543;5884.852878678067;3996.9024006395275;4503.617192538671;4509.210888094636;4542.046170304273;4563.247064234364;4809.735464549483;5039.697618142924;5688.402717714746;5704.828855134353;5707.486326230659;4907.852764416931;5410.349843297832;5420.783168673367;5472.753726082416;5495.120780675233;4895.926561101657;5218.921716174336;5284.392294886137;5442.673074905539;5448.855740294583;5146.856780291901;5247.344081989751;5327.07011143877;5336.384027815989;5353.759080841293;5193.714345711022;5489.286392768914;5507.476789704971;5527.364353099445;5583.35791383996;4882.389701287339;4884.340614017062;5022.459166287831;5349.705766182741;5595.04884169684 21:15:24 INFO - PROCESS | 1640 | |5;yui.html;712.1063065852354;731.3016069653478;753.1038064703004;831.1895901496042;841.2722994609661;14913.478028269014;15765.132917689523;15818.60453488662;15861.84138158618;15876.444324448647;15467.613309667237;16450.506484805475;16548.420805271788;16720.41478548251;16809.15954202288;655.8032590222938;741.8850078237882;913.0048247410322;941.0495399646338;945.7399215215802;908.8954770201445;922.7324076017946;936.3024546712709;936.9390989585655;941.4774799986005;984.8375018122001;987.121461898907;987.8320685483485;989.4310771306491;989.8812142542905;983.5573991703726;985.4924713772413;985.7929834734714;985.960561577536;989.5052473763119;728.7595093619093;729.5659082845698;730.1821959405447;730.4156674660251;730.9305615966475;15992.600184995352;16380.918095409566;16481.34074637025;16640.16799160037;16861.325546978107;13017.893479054292;13175.34123293841;13652;13924.860751392458;14074.22591757453;10730.356178629307;11583.710407239801;11757;11869.584564540286;12430.12989090764;3319.3527262183884;3591.982040089809;3678.282734866702;3682.2819550187724;3824.349860523718;114069.85930140676;115159;115312;116695.41652291769;116764;10846.349219046724;10926.617568385069;10944.343339399662;10987.340759554452;11099.83350249747;19814.90092549528;21076.840773757285;21141.942902854797;22263.220787272367;22607.20874769408;7198.460115491359;7676.276138527953;7680.4623676343235;7743.186965368668;7795;4178.310578754532;4200.516940551875;4272.829086836554;4273.337632666941;4348.695591308578;2892.537194048942;3381.306832099414;3397.76215664906;3406.8126253055825;3430.27964127531;631.766246488802;632.6552029144127;639.4500729372736;640.5804198250154;648.0117820324043;658.9308122647149;660.94712423007;678.8981652752127;700.7932659865352;722.151472020374;9957.402555846673;10054.296199266128;10099.545520451597;10198.592056317813;10303.278770485995;694.187800273681;696.6133795743411;706.0997228533558;706.5195666946526;713.2403989750899;4768.856934291976;4896.632752543574;4901.142300097468;4902.607791376681;4917.877053073702;81258;83229.16770832335;92525.53737231271;93557.5322123385;97015.51492242493;67970.66014669895;69902;71706.28293717101;81143.18856811474;82602.3479530406;71829.2817071833;74387.62806185934;74768.87846682304;75881.86177207346;77043.61478192573;10624.309419887682;10790.716167188635;11131.888681113085;11134;11139.443027848738;47401.28898066463;48119.518804812906;48233.75883120562;48615;49990;59174.70412647909;59604;62312.688436557524;62737.11788646348;63354.36645633669;11947.940260298643;12427.565035223724;12482.375881206084;12725.80911286313;12912.289824059391;12067.698307542381;13587.932060339635;13828.723425531634;14032.438702452197;14232;12843.871561284268;13539.390727417487;13622;13929.930350348588;14382.454714006732;13550.322483875963;13667.726645466835;13697.863021370058;14023.018388712691;14139.222342771247;12978.545750898673;13231.27228002469;13676.521321753691;13743.518976835763;13798.17210967345;7778.88331675014;8123.593820308843;8312.6674933002;9183.77040573991;9223.123803238681;10818.188635852186;11059.336439813636;11076.889231107585;11254.493547790205;11258.831117533407 21:15:24 INFO - PROCESS | 1640 | __end_tp_report 21:15:24 INFO - PROCESS | 1640 | __start_cc_report 21:15:24 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,417 21:15:24 INFO - PROCESS | 1640 | __end_cc_report 21:15:24 INFO - PROCESS | 1640 | __startTimestamp1492056924191__endTimestamp 21:15:24 INFO - PROCESS | 1640 | 21:15:24 INFO - PROCESS | 1640 | ------- Summary: start ------- 21:15:24 INFO - PROCESS | 1640 | Number of tests: 6 21:15:24 INFO - PROCESS | 1640 | 21:15:24 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5746.36 Median:5929.17 stddev:690.33 (11.6%) stddev-sans-first:667.26 21:15:24 INFO - PROCESS | 1640 | Values: 3390.9 3399.2 3406.5 3423.0 3435.5 4726.5 5078.6 5486.4 5770.9 5785.1 5678.7 5750.3 5765.6 5780.4 5821.7 5191.0 5240.7 5242.7 5254.6 5302.0 5307.8 5323.9 5330.9 5349.8 5383.7 5123.6 5149.7 5235.0 5271.4 5310.3 4100.0 4499.0 5212.7 5230.4 5390.8 5136.5 5254.9 5266.7 5300.1 5305.3 4720.9 5469.8 5516.9 5580.6 5658.7 6262.2 6305.0 6317.4 6324.2 6337.1 5745.3 6295.2 6303.1 6326.2 6334.9 5669.2 5678.9 5884.7 5898.1 5903.6 6278.7 6289.1 6354.2 6356.0 6371.0 6239.8 6249.9 6275.0 6277.7 6296.0 6289.2 6294.2 6341.1 6352.9 6361.5 6077.3 6093.2 6176.8 6197.2 6320.7 6009.5 6248.4 6298.4 6308.3 6309.1 4229.9 4949.5 5009.9 5018.3 5035.0 4347.7 4348.3 4389.8 4410.8 4459.3 5861.2 5861.9 5891.0 5900.5 5901.0 6110.6 6123.4 6331.8 6333.7 6344.3 5805.9 5825.5 5833.9 5873.0 5891.0 5309.5 5356.5 5367.2 5436.5 5531.1 6369.9 6387.3 6389.9 6423.2 6434.3 6313.0 6314.4 6323.8 6325.2 6338.7 6263.3 6488.1 6507.9 6511.1 6512.0 6103.7 6204.4 6207.9 6233.1 6234.5 6107.1 6286.7 6302.3 6304.9 6316.4 6095.2 6138.9 6179.3 6187.6 6234.5 5912.1 5949.0 6091.1 6093.5 6132.0 5854.8 5893.2 5963.8 5981.4 5999.1 6171.3 6176.2 6182.7 6192.9 6195.4 4688.8 5292.2 5773.2 5929.2 5941.6 21:15:24 INFO - PROCESS | 1640 | 21:15:24 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:55417.38 Median:27614.10 stddev:117692.54 (426.2%) stddev-sans-first:117951.02 21:15:24 INFO - PROCESS | 1640 | Values: 706.7 737.2 801.0 823.7 965.1 37975.5 38387.4 40611.4 40638.8 40666.8 38953.0 39187.0 39220.6 39236.6 39342.0 7803.5 10325.9 10606.5 10781.6 10791.6 10454.4 10562.8 10583.2 10592.6 10635.7 10561.8 10563.2 10589.9 10597.5 10604.3 10524.0 10553.4 10572.6 10573.4 10610.0 10394.5 10412.9 10445.0 10460.7 10465.7 29226.6 32251.8 33680.5 33689.3 33725.0 3711.4 3767.4 3768.6 3768.7 3811.7 24455.9 24750.9 24887.9 25253.0 25894.0 3050.2 3070.4 3074.1 3077.6 3116.0 353980.0 355773.0 356223.0 357549.0 357709.0 43943.3 43970.8 44079.7 44103.8 44138.1 37765.8 39873.6 42675.6 45948.5 46042.0 13481.3 13822.4 13825.4 13868.5 13870.5 11779.9 11849.2 11892.0 11893.8 11953.6 11474.7 11965.9 11994.2 12042.5 12099.8 5661.3 5708.6 5712.5 5713.7 5715.7 1076.4 1102.0 1131.2 1131.9 1165.9 21498.8 22523.4 26543.9 26661.9 26690.3 1123.3 1220.4 1245.7 1248.2 1264.1 10528.6 13537.5 13652.9 13712.9 13740.0 487714.0 488003.0 491353.0 492376.0 493118.5 48257.5 49543.5 55387.7 56045.2 56314.4 1400.6 1423.7 1430.3 1432.4 1435.8 23833.4 26201.3 26245.1 26398.7 27185.5 40703.2 40778.0 41040.2 41048.4 41075.2 464009.0 465558.0 466323.0 468582.0 468818.7 24462.9 29428.7 29463.4 29612.6 29813.1 27767.9 34392.7 37348.8 37960.7 38015.8 25979.4 26793.3 27505.3 27725.7 27868.7 22957.9 23367.1 26112.5 26838.3 27722.9 31165.5 31696.5 31715.7 31768.7 31823.0 21520.4 25189.6 25320.2 27397.5 27930.6 16119.4 20220.9 20246.6 22635.8 23953.9 21:15:24 INFO - PROCESS | 1640 | 21:15:24 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:43023.15 Median:20908.92 stddev:126394.88 (604.5%) stddev-sans-first:126708.96 21:15:24 INFO - PROCESS | 1640 | Values: 414.3 427.7 429.6 435.0 439.3 19114.9 20206.9 21367.9 21489.6 21529.5 18835.4 20354.1 21926.3 22054.7 22182.7 6532.3 6891.0 6914.1 6927.2 6935.5 6372.1 6677.6 6735.6 6758.8 6778.6 6423.4 6699.4 6703.9 6734.8 6763.7 6648.4 6681.6 6707.4 6710.9 6764.8 6238.9 6436.5 6531.8 6578.8 6584.5 21357.4 25673.7 25692.9 25784.7 25968.4 2898.7 2904.5 3005.4 3022.2 3040.9 15719.2 16483.3 16619.9 16897.4 17056.3 2009.3 2040.2 2057.5 2064.0 2075.1 133249.3 135081.0 138638.0 155616.0 159708.2 17768.9 20552.0 20771.9 21313.3 21354.6 26306.9 31401.2 31621.0 31956.9 32014.4 10021.5 10086.8 10237.1 10284.0 10428.7 7473.9 8112.2 8488.2 8679.0 8682.3 8124.8 9092.8 9179.4 9495.3 9524.3 4032.2 4032.6 4155.5 4162.3 4170.9 1002.2 1005.1 1009.9 1017.3 1053.7 20545.5 20892.6 20925.3 21090.2 21111.7 1000.2 1006.6 1033.6 1036.2 1041.1 10022.3 10613.5 10786.7 10871.1 10876.0 737791.0 748772.3 756319.0 771279.0 776515.0 145239.0 147861.5 166320.0 166673.3 172941.0 1202.8 1236.5 1256.3 1261.4 1265.0 17570.1 18104.9 18164.4 18285.9 18584.5 56825.4 63457.4 63773.7 63919.0 63950.0 70424.0 89066.6 90740.1 91047.2 92781.0 11672.9 11681.6 11717.3 11921.2 12077.5 13022.0 13116.7 13274.0 13438.3 13495.9 9305.3 10850.9 10862.9 11200.5 11383.7 9638.4 9754.4 10287.3 10362.5 10511.3 10162.1 10245.0 10346.7 11304.2 11683.8 10761.4 11464.8 11627.4 11669.2 11689.4 11212.5 11326.6 11375.2 11476.8 11550.5 21:15:24 INFO - PROCESS | 1640 | 21:15:24 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:6749.51 Median:2429.09 stddev:4238.17 (174.5%) stddev-sans-first:4230.47 21:15:24 INFO - PROCESS | 1640 | Values: 1326.2 1374.8 1475.9 1548.4 1552.3 9223.7 9490.0 10495.2 11113.8 11143.2 9790.6 10499.4 11062.9 11085.9 11088.5 2371.6 2422.8 2425.2 2429.5 2432.3 2384.6 2409.0 2411.8 2413.9 2428.7 2065.8 2379.9 2399.2 2405.4 2409.0 1925.8 2359.3 2384.5 2407.4 2408.1 2188.4 2292.6 2388.7 2391.8 2413.5 10861.5 11100.1 11110.6 11118.1 11127.2 5101.0 5693.6 5823.1 5887.0 5894.9 3512.6 3624.3 3648.3 3662.2 3689.6 1194.1 1198.2 1235.7 1254.4 1257.9 15353.4 15499.3 15512.1 15519.7 15520.5 4826.4 4938.8 4959.3 4980.0 5012.7 12978.0 12987.0 13014.4 13017.2 13045.5 5933.6 5948.2 5973.0 5976.8 5996.9 4092.9 4986.6 5103.9 5197.0 5290.9 3286.8 4016.9 4026.7 4035.9 4085.2 1137.6 1141.8 1154.4 1166.3 1172.1 929.6 930.2 931.5 940.6 993.4 6524.0 6652.3 6694.1 6791.4 6865.3 946.5 967.3 978.5 1001.0 1020.9 4254.2 4262.3 4282.2 4295.5 4396.4 13250.8 13698.9 13723.9 13726.7 13736.9 13246.3 13474.2 13556.5 13579.4 13588.7 9932.3 10038.3 10061.8 10075.0 10076.7 6362.3 6465.6 6562.0 6676.7 6722.6 12058.0 12170.3 12292.8 12347.5 12371.3 12284.0 12428.5 12475.4 12488.3 12507.5 7983.6 8234.8 8834.2 9181.1 9299.2 10182.4 10440.4 10522.0 10534.7 10560.8 8719.4 8751.8 8755.5 8800.9 8824.0 7836.6 8483.4 8671.2 8789.1 8875.3 7857.2 7928.8 7948.8 7987.8 7990.8 5829.0 5859.5 5865.3 5961.2 6114.5 5934.6 5949.8 6179.5 6204.7 6281.8 21:15:24 INFO - PROCESS | 1640 | 21:15:24 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4538.39 Median:4924.03 stddev:1265.14 (25.7%) stddev-sans-first:1228.81 21:15:24 INFO - PROCESS | 1640 | Values: 339.8 365.0 374.9 377.6 391.7 4399.7 4619.0 4983.4 5087.7 5229.8 4784.0 5044.3 5049.7 5090.8 5092.4 3591.8 3832.2 4068.4 4270.3 4280.9 4059.2 4231.5 4243.6 4248.3 4313.3 3796.6 4264.0 4268.6 4277.3 4287.9 3557.8 3750.9 3939.9 4079.8 4084.8 3137.3 3724.6 3822.3 3915.1 3967.7 4685.6 4936.2 4946.4 4981.9 4984.6 4151.2 4444.0 4538.0 4660.3 4908.5 5352.6 5460.2 5504.8 5524.9 5542.2 3904.5 4347.7 4376.6 4400.7 4456.8 4694.9 5447.9 5480.7 5513.3 5921.7 3832.8 4024.6 4285.3 4433.9 4541.9 4151.9 4227.3 4555.8 4668.3 4707.0 4430.6 4457.5 4724.7 4854.0 4955.8 4917.4 5159.3 5305.8 5416.7 5491.3 1521.9 1531.3 1566.0 1586.2 1591.7 1090.4 1105.2 1169.6 1173.0 1175.4 4442.7 4875.0 5081.0 5124.9 5132.2 5049.3 5050.9 5421.4 5542.4 5621.3 4166.5 4492.2 4845.3 5094.5 5112.8 2514.7 2905.7 2922.1 2927.0 2948.9 5248.5 5262.7 5519.8 5541.2 5599.4 5060.9 5367.3 5643.7 5796.6 5819.6 5411.5 5457.9 5792.3 5824.4 5840.9 4979.1 5619.6 5639.3 5651.6 5700.6 4616.5 5070.8 5256.8 5473.7 5568.8 4930.6 5789.2 5841.9 5858.4 5884.9 3996.9 4503.6 4509.2 4542.0 4563.2 4809.7 5039.7 5688.4 5704.8 5707.5 4907.9 5410.3 5420.8 5472.8 5495.1 4895.9 5218.9 5284.4 5442.7 5448.9 5146.9 5247.3 5327.1 5336.4 5353.8 5193.7 5489.3 5507.5 5527.4 5583.4 4882.4 4884.3 5022.5 5349.7 5595.0 21:15:24 INFO - PROCESS | 1640 | 21:15:24 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:19701.05 Median:4236.67 stddev:27921.96 (659.1%) stddev-sans-first:27963.88 21:15:24 INFO - PROCESS | 1640 | Values: 712.1 731.3 753.1 831.2 841.3 14913.5 15765.1 15818.6 15861.8 15876.4 15467.6 16450.5 16548.4 16720.4 16809.2 655.8 741.9 913.0 941.0 945.7 908.9 922.7 936.3 936.9 941.5 984.8 987.1 987.8 989.4 989.9 983.6 985.5 985.8 986.0 989.5 728.8 729.6 730.2 730.4 730.9 15992.6 16380.9 16481.3 16640.2 16861.3 13017.9 13175.3 13652.0 13924.9 14074.2 10730.4 11583.7 11757.0 11869.6 12430.1 3319.4 3592.0 3678.3 3682.3 3824.3 114069.9 115159.0 115312.0 116695.4 116764.0 10846.3 10926.6 10944.3 10987.3 11099.8 19814.9 21076.8 21141.9 22263.2 22607.2 7198.5 7676.3 7680.5 7743.2 7795.0 4178.3 4200.5 4272.8 4273.3 4348.7 2892.5 3381.3 3397.8 3406.8 3430.3 631.8 632.7 639.5 640.6 648.0 658.9 660.9 678.9 700.8 722.2 9957.4 10054.3 10099.5 10198.6 10303.3 694.2 696.6 706.1 706.5 713.2 4768.9 4896.6 4901.1 4902.6 4917.9 81258.0 83229.2 92525.5 93557.5 97015.5 67970.7 69902.0 71706.3 81143.2 82602.3 71829.3 74387.6 74768.9 75881.9 77043.6 10624.3 10790.7 11131.9 11134.0 11139.4 47401.3 48119.5 48233.8 48615.0 49990.0 59174.7 59604.0 62312.7 62737.1 63354.4 11947.9 12427.6 12482.4 12725.8 12912.3 12067.7 13587.9 13828.7 14032.4 14232.0 12843.9 13539.4 13622.0 13929.9 14382.5 13550.3 13667.7 13697.9 14023.0 14139.2 12978.5 13231.3 13676.5 13743.5 13798.2 7778.9 8123.6 8312.7 9183.8 9223.1 10818.2 11059.3 11076.9 11254.5 11258.8 21:15:24 INFO - PROCESS | 1640 | -------- Summary: end -------- 21:15:24 INFO - PROCESS | 1640 | 21:15:24 INFO - TEST-INFO | 1640: exit 0 21:15:24 INFO - TEST-OK | dromaeo_css | took 1116619ms 21:15:24 INFO - TEST-START | kraken 21:15:24 INFO - operating with platform_type : mac_ 21:15:24 INFO - Initialising browser for kraken test... 21:15:24 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/tmpoUbVFE/profile http://localhost:49251/getInfo.html) 21:15:27 INFO - PROCESS | 1652 | 2017-04-12 21:15:27.604 plugin-container[1653:10511] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d4b, name = 'com.apple.tsm.portname' 21:15:27 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:15:27 INFO - PROCESS | 1652 | 2017-04-12 21:15:27.608 plugin-container[1653:10511] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4413, name = 'com.apple.CFPasteboardClient' 21:15:27 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:15:27 INFO - PROCESS | 1652 | 2017-04-12 21:15:27.608 plugin-container[1653:10511] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:15:27 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 21:15:27 INFO - PROCESS | 1652 | colorDepth:24 21:15:27 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 21:15:27 INFO - PROCESS | 1652 | __metrics 21:15:27 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 21:15:28 INFO - TEST-INFO | 1652: exit 0 21:15:28 INFO - Browser initialized. 21:15:28 INFO - Running cycle 1/1 for kraken test... 21:15:28 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/tmpoUbVFE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:15:30 INFO - PROCESS | 1654 | 2017-04-12 21:15:30.909 plugin-container[1655:10642] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a47, name = 'com.apple.tsm.portname' 21:15:30 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:15:30 INFO - PROCESS | 1654 | 2017-04-12 21:15:30.909 plugin-container[1655:10642] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4713, name = 'com.apple.CFPasteboardClient' 21:15:30 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:15:30 INFO - PROCESS | 1654 | 2017-04-12 21:15:30.909 plugin-container[1655:10642] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:15:40 INFO - PROCESS | 1654 | RSS: Main: 221073408 21:15:40 INFO - PROCESS | 1654 | 21:15:43 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-beat-detection) 21:15:44 INFO - PROCESS | 1654 | RSS: Main: 235700224 21:15:44 INFO - PROCESS | 1654 | 21:15:47 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-dft) 21:15:48 INFO - PROCESS | 1654 | RSS: Main: 243441664 21:15:48 INFO - PROCESS | 1654 | 21:15:51 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-fft) 21:15:52 INFO - PROCESS | 1654 | RSS: Main: 245059584 21:15:52 INFO - PROCESS | 1654 | 21:15:54 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-oscillator) 21:15:54 INFO - PROCESS | 1654 | RSS: Main: 247832576 21:15:54 INFO - PROCESS | 1654 | 21:15:56 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:15:57 INFO - PROCESS | 1654 | RSS: Main: 248184832 21:15:57 INFO - PROCESS | 1654 | 21:16:00 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-darkroom) 21:16:01 INFO - PROCESS | 1654 | RSS: Main: 252493824 21:16:01 INFO - PROCESS | 1654 | 21:16:04 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-desaturate) 21:16:05 INFO - PROCESS | 1654 | RSS: Main: 252289024 21:16:05 INFO - PROCESS | 1654 | 21:16:08 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49251/tests/kraken/driver.html?testName=json-parse-financial) 21:16:08 INFO - PROCESS | 1654 | RSS: Main: 251953152 21:16:08 INFO - PROCESS | 1654 | 21:16:10 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49251/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:16:11 INFO - PROCESS | 1654 | RSS: Main: 251297792 21:16:11 INFO - PROCESS | 1654 | 21:16:13 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:16:13 INFO - PROCESS | 1654 | RSS: Main: 251318272 21:16:13 INFO - PROCESS | 1654 | 21:16:15 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:16:16 INFO - PROCESS | 1654 | RSS: Main: 251400192 21:16:16 INFO - PROCESS | 1654 | 21:16:19 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:16:20 INFO - PROCESS | 1654 | RSS: Main: 251764736 21:16:20 INFO - PROCESS | 1654 | 21:16:23 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:16:24 INFO - PROCESS | 1654 | RSS: Main: 251756544 21:16:24 INFO - PROCESS | 1654 | 21:16:25 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49251/tests/kraken/driver.html?testName=ai-astar) 21:16:26 INFO - PROCESS | 1654 | RSS: Main: 254820352 21:16:26 INFO - PROCESS | 1654 | 21:16:26 INFO - PROCESS | 1654 | __start_tp_report 21:16:26 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 21:16:26 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 21:16:26 INFO - PROCESS | 1654 | |i|pagename|runs| 21:16:26 INFO - PROCESS | 1654 | |0;ai-astar;108;133;170;160;122;126;122;121;122;121 21:16:26 INFO - PROCESS | 1654 | |1;audio-beat-detection;143;112;110;148;110;115;131;116;151;131 21:16:26 INFO - PROCESS | 1654 | |2;audio-dft;198;197;197;238;280;205;210;269;235;173 21:16:26 INFO - PROCESS | 1654 | |3;audio-fft;87;60;75;73;83;52;61;63;71;79 21:16:26 INFO - PROCESS | 1654 | |4;audio-oscillator;88;68;84;74;71;69;82;97;96;108 21:16:26 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;90;93;86;127;127;108;91;90;79;83 21:16:26 INFO - PROCESS | 1654 | |6;imaging-darkroom;97;106;110;144;114;145;145;98;97;99 21:16:26 INFO - PROCESS | 1654 | |7;imaging-desaturate;146;125;93;93;92;90;88;91;91;93 21:16:26 INFO - PROCESS | 1654 | |8;json-parse-financial;67;65;68;70;69;68;69;70;71;75 21:16:26 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;58;62;83;54;58;66;79;79;70;59 21:16:26 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;83;81;84;87;83;87;84;84;87;86 21:16:26 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;147;142;135;146;136;146;155;148;196;158 21:16:26 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;174;229;213;177;181;207;216;209;169;169 21:16:26 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;69;71;86;79;63;78;80;66;58;85 21:16:26 INFO - PROCESS | 1654 | __end_tp_report 21:16:26 INFO - PROCESS | 1654 | __start_cc_report 21:16:26 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1006 21:16:26 INFO - PROCESS | 1654 | __end_cc_report 21:16:26 INFO - PROCESS | 1654 | __startTimestamp1492056986122__endTimestamp 21:16:26 INFO - PROCESS | 1654 | 21:16:26 INFO - PROCESS | 1654 | ------- Summary: start ------- 21:16:26 INFO - PROCESS | 1654 | Number of tests: 14 21:16:26 INFO - PROCESS | 1654 | 21:16:26 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:130.50 Median:124.00 stddev:19.32 (15.6%) stddev-sans-first:18.70 21:16:26 INFO - PROCESS | 1654 | Values: 108.0 133.0 170.0 160.0 122.0 126.0 122.0 121.0 122.0 121.0 21:16:26 INFO - PROCESS | 1654 | 21:16:26 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:126.70 Median:131.00 stddev:16.23 (12.4%) stddev-sans-first:16.11 21:16:26 INFO - PROCESS | 1654 | Values: 143.0 112.0 110.0 148.0 110.0 115.0 131.0 116.0 151.0 131.0 21:16:26 INFO - PROCESS | 1654 | 21:16:26 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:220.20 Median:222.50 stddev:34.36 (15.4%) stddev-sans-first:35.49 21:16:26 INFO - PROCESS | 1654 | Values: 198.0 197.0 197.0 238.0 280.0 205.0 210.0 269.0 235.0 173.0 21:16:26 INFO - PROCESS | 1654 | 21:16:26 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:70.40 Median:74.00 stddev:11.19 (15.1%) stddev-sans-first:10.13 21:16:26 INFO - PROCESS | 1654 | Values: 87.0 60.0 75.0 73.0 83.0 52.0 61.0 63.0 71.0 79.0 21:16:26 INFO - PROCESS | 1654 | 21:16:26 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:83.70 Median:83.00 stddev:13.57 (16.4%) stddev-sans-first:14.31 21:16:26 INFO - PROCESS | 1654 | Values: 88.0 68.0 84.0 74.0 71.0 69.0 82.0 97.0 96.0 108.0 21:16:26 INFO - PROCESS | 1654 | 21:16:26 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:97.40 Median:88.00 stddev:17.35 (19.7%) stddev-sans-first:18.20 21:16:26 INFO - PROCESS | 1654 | Values: 90.0 93.0 86.0 127.0 127.0 108.0 91.0 90.0 79.0 83.0 21:16:26 INFO - PROCESS | 1654 | 21:16:26 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:115.50 Median:121.00 stddev:20.92 (17.3%) stddev-sans-first:21.09 21:16:26 INFO - PROCESS | 1654 | Values: 97.0 106.0 110.0 144.0 114.0 145.0 145.0 98.0 97.0 99.0 21:16:26 INFO - PROCESS | 1654 | 21:16:26 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:100.20 Median:91.50 stddev:19.31 (21.1%) stddev-sans-first:11.33 21:16:26 INFO - PROCESS | 1654 | Values: 146.0 125.0 93.0 93.0 92.0 90.0 88.0 91.0 91.0 93.0 21:16:26 INFO - PROCESS | 1654 | 21:16:26 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:69.20 Median:69.50 stddev:2.66 (3.8%) stddev-sans-first:2.70 21:16:26 INFO - PROCESS | 1654 | Values: 67.0 65.0 68.0 70.0 69.0 68.0 69.0 70.0 71.0 75.0 21:16:26 INFO - PROCESS | 1654 | 21:16:26 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:68.00 stddev:10.40 (15.3%) stddev-sans-first:10.53 21:16:26 INFO - PROCESS | 1654 | Values: 58.0 62.0 83.0 54.0 58.0 66.0 79.0 79.0 70.0 59.0 21:16:26 INFO - PROCESS | 1654 | 21:16:26 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:85.00 stddev:2.07 (2.4%) stddev-sans-first:2.11 21:16:26 INFO - PROCESS | 1654 | Values: 83.0 81.0 84.0 87.0 83.0 87.0 84.0 84.0 87.0 86.0 21:16:26 INFO - PROCESS | 1654 | 21:16:26 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:150.90 Median:147.50 stddev:17.41 (11.8%) stddev-sans-first:18.41 21:16:26 INFO - PROCESS | 1654 | Values: 147.0 142.0 135.0 146.0 136.0 146.0 155.0 148.0 196.0 158.0 21:16:26 INFO - PROCESS | 1654 | 21:16:26 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.40 Median:208.00 stddev:22.53 (10.8%) stddev-sans-first:22.66 21:16:26 INFO - PROCESS | 1654 | Values: 174.0 229.0 213.0 177.0 181.0 207.0 216.0 209.0 169.0 169.0 21:16:26 INFO - PROCESS | 1654 | 21:16:26 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.50 Median:78.50 stddev:9.51 (12.1%) stddev-sans-first:9.95 21:16:26 INFO - PROCESS | 1654 | Values: 69.0 71.0 86.0 79.0 63.0 78.0 80.0 66.0 58.0 85.0 21:16:26 INFO - PROCESS | 1654 | -------- Summary: end -------- 21:16:26 INFO - PROCESS | 1654 | 21:16:26 INFO - TEST-INFO | 1654: exit 0 21:16:27 INFO - TEST-OK | kraken | took 62201ms 21:16:27 INFO - SUITE-END | took 1178s 21:16:27 INFO - Completed test suite (00:19:39) 21:16:27 INFO - javascript benchmark 21:16:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7564.791316509969, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3390.9321813563743, 3399.2351720862807, 3406.5230867678547, 3422.9559984204816, 3435.519027336173, 4726.527347265272, 5078.568321692656, 5486.423925487826, 5770.913436298459, 5785.103308987103, 5678.716064196794, 5750.33871104822, 5765.567582431314, 5780.364159942414, 5821.67980761058, 5190.9740451297785, 5240.659357141773, 5242.711650859202, 5254.553362964152, 5302.0, 5307.814226502073, 5323.866903327409, 5330.946690533084, 5349.786008559653, 5383.67697938123, 5123.641345105825, 5149.665271757323, 5234.973825130869, 5271.4464981177, 5310.283111779918, 4099.97950010248, 4498.955010449903, 5212.6611770235195, 5230.372355317386, 5390.811321603745, 5136.4606716295, 5254.868628284324, 5266.657667251617, 5300.125479295912, 5305.336832895888, 4720.858374248778, 5469.781208751645, 5516.9448305516835, 5580.581456390787, 5658.74535645897, 6262.185915830958, 6304.968475157641, 6317.399847014526, 6324.241091069055, 6337.081123237105, 5745.339285982082, 6295.150154729099, 6303.0545418187185, 6326.2092238470195, 6334.904976425358, 5669.234653321749, 5678.943210567924, 5884.70576471179, 5898.14476900847, 5903.645781253182, 6278.672303679057, 6289.119523266746, 6354.205724284465, 6355.968220158869, 6370.968145159337, 6239.844003899939, 6249.9062514062325, 6274.968625156845, 6277.654728989858, 6295.968520157461, 6289.182406287154, 6294.213223347082, 6341.143945567289, 6352.872942541123, 6361.522885783492, 6077.3314935357075, 6093.238345206849, 6176.7838125665385, 6197.163382943335, 6320.747170113236, 6009.45914867664, 6248.375162483806, 6298.433141017239, 6308.27454842699, 6309.053641953744, 4229.894252643647, 4949.505049495094, 5009.874753131201, 5018.3476148101245, 5034.974825125924, 4347.695661303678, 4348.28253338202, 4389.780510974439, 4410.80151393188, 4459.286514157784, 5861.17943487912, 5861.941380586225, 5891.027980383275, 5900.527957763368, 5901.0, 6110.5587591967305, 6123.404636889863, 6331.810045698637, 6333.714982825784, 6344.333844946306, 5805.912911306334, 5825.533957283407, 5833.912491312633, 5872.970635146797, 5890.970545147246, 5309.495597918191, 5356.491133342326, 5367.221752845816, 5436.483534064258, 5531.1426728857095, 6369.87260254783, 6387.329330420332, 6389.904151437825, 6423.197100362455, 6434.324395938359, 6313.021481670348, 6314.431701146918, 6323.778667746791, 6325.209348831396, 6338.746450141943, 6263.342349053284, 6488.124103246001, 6507.934920650733, 6511.088447617432, 6511.967440162769, 6103.7253323601435, 6204.3795620439405, 6207.906881396692, 6233.065040243819, 6234.532410069353, 6107.053406721965, 6286.717097730521, 6302.3067462578165, 6304.873902521832, 6316.399942005502, 6095.207623008981, 6138.9386106140155, 6179.3202747698615, 6187.597806142587, 6234.501239900887, 5912.113183022581, 5949.0, 6091.0558863376245, 6093.512518998381, 6132.04958718918, 5854.765809367748, 5893.2044174035955, 5963.761449541969, 5981.401859813984, 5999.130126131774, 6171.321154672893, 6176.197094377702, 6182.690865456799, 6192.8761424770355, 6195.380461953769, 4688.789004494738, 5292.20616907467, 5773.191753154646, 5929.16991621182, 5941.58408911372], "value": 5701.422481336712, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.7208452661198, 737.2185483387609, 800.9799755006125, 823.6622984576318, 965.1120968708788, 37975.480980760774, 38387.42418863719, 40611.39082913751, 40638.796806015926, 40666.7966660167, 38953.0, 39187.02032449183, 39220.60779392205, 39236.60763392365, 39342.0164495887, 7803.531788092732, 10325.948370258177, 10606.522706478188, 10781.5687372505, 10791.62229321974, 10454.372737635766, 10562.841557376645, 10583.153347732163, 10592.576296948113, 10635.734106647318, 10561.841572376421, 10563.207759418035, 10589.894101058968, 10597.523111459965, 10604.310719803227, 10524.0, 10553.41956192409, 10572.577096916115, 10573.418461984587, 10610.0, 10394.480275986247, 10412.895871041268, 10445.0, 10460.68617941463, 10465.68602941913, 29226.561601575995, 32251.83874080638, 33680.49479257813, 33689.32621347584, 33725.0, 3711.3876210425246, 3767.416050512175, 3768.6042965488505, 3768.7173461990187, 3811.7331786774935, 24455.87772061146, 24750.876245618656, 24887.902374735528, 25253.0, 25894.0, 3050.176452357873, 3070.370574032318, 3074.13924101252, 3077.6306843178736, 3115.9532607010915, 353980.0, 355773.0, 356222.9999999974, 357549.0, 357709.0, 43943.340849887274, 43970.78014609907, 44079.67760967176, 44103.77948110239, 44138.11723765507, 37765.81117094397, 39873.60126398699, 42675.57324426778, 45948.54051459509, 46042.0, 13481.258530780706, 13822.447102116004, 13825.446982120804, 13868.514601988882, 13870.514531991332, 11779.941100294443, 11849.170558061025, 11891.989180919545, 11893.762124757457, 11953.641390758292, 11474.655760327203, 11965.940170299267, 11994.220375675553, 12042.458089385998, 12099.818502722466, 5661.320641523043, 5708.600397972185, 5712.457316554921, 5713.714314284269, 5715.742791574306, 1076.445630500293, 1102.0412241350077, 1131.1742428027421, 1131.8568246071363, 1165.9125565582615, 21498.78501214999, 22523.43691407728, 26543.93824247047, 26661.866690666422, 26690.332741681614, 1123.2642619084513, 1220.4020030185145, 1245.7446223524337, 1248.1637303007008, 1264.1151194164122, 10528.631497897537, 13537.526186583422, 13652.931735341459, 13712.902967762555, 13739.96950228737, 487714.0, 488003.0, 491353.0, 492376.0, 493118.5344073257, 48257.5174248253, 49543.50456495461, 55387.72306138444, 56045.159322609376, 56314.43685563174, 1400.59382778995, 1423.6725553122633, 1430.2705620133806, 1432.3983926750789, 1435.777454494555, 23833.404164896016, 26201.344966375993, 26245.08142215013, 26398.736012639627, 27185.456290874467, 40703.1859362817, 40777.98055048529, 41040.1791964165, 41048.38427423651, 41075.178496430504, 464009.0, 465558.0, 466323.0, 468582.0, 468818.6559067183, 24462.877685611456, 29428.705712943454, 29463.410731785672, 29612.555811663275, 29813.10560683183, 27767.861160694876, 34392.65607343894, 37348.81325593355, 37960.67137650169, 38015.809920951324, 25979.350516237246, 26793.33016674599, 27505.31236719098, 27725.722742772316, 27868.721312786613, 22957.88521057451, 23367.065317387114, 26112.477750445265, 26838.32904177333, 27722.8910843564, 31165.53251701181, 31696.5245521322, 31715.682843171275, 31768.682313177498, 31823.0, 21520.354389368345, 25189.622155668047, 25320.240392788244, 27397.45205095927, 27930.603469826834, 16119.355225791307, 20220.89889550543, 20246.59506809885, 22635.75503347266, 23953.880230598734], "value": 17793.273783454842, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.3101735610209, 427.7230011897251, 429.5897417965843, 435.0472465300991, 439.3344083713175, 19114.90442547787, 20206.89896550517, 21367.893160534175, 21489.57020859586, 21529.46176345592, 18835.43493695188, 20354.08406621702, 21926.342209733735, 22054.669179962275, 22182.667259991114, 6532.281449040614, 6890.965545172267, 6914.135733033371, 6927.238003819576, 6935.479839012069, 6372.076048972896, 6677.632730199837, 6735.595864248136, 6758.763443279487, 6778.627175505345, 6423.357664233586, 6699.363560461748, 6703.865922681543, 6734.8316292092595, 6763.729450821986, 6648.368405001517, 6681.5656982296, 6707.396334329934, 6710.899336509932, 6764.763233286836, 6238.937610623926, 6436.452901503331, 6531.791618550584, 6578.835529111762, 6584.539082264243, 21357.359279221648, 25673.74326256732, 25692.871535642204, 25784.74215257861, 25968.350791230372, 2898.68114507404, 2904.4796472420912, 3005.443992861328, 3022.199117233935, 3040.8783648654025, 15719.214039298104, 16483.34066637333, 16619.919705219123, 16897.408590699266, 17056.317747290093, 2009.3067891577382, 2040.2043203150783, 2057.506198512361, 2063.9793602063937, 2075.0869617368307, 133249.3337533306, 135081.0, 138638.0, 155616.0, 159708.20145899314, 17768.9111554444, 20552.0, 20771.896140519504, 21313.25403610866, 21354.572908542053, 26306.86846565793, 31401.214969625486, 31621.0, 31956.881509147068, 32014.359712805614, 10021.498925053718, 10086.848697269546, 10237.129843963347, 10283.971602839656, 10428.739281517872, 7473.850522989618, 8112.22933821286, 8488.193621605938, 8678.95660521706, 8682.348823838238, 8124.837503249902, 9092.81793366858, 9179.403338782959, 9495.287853411022, 9524.333296669305, 4032.193561287754, 4032.5564187939303, 4155.522114956819, 4162.292410290258, 4170.874873753793, 1002.2282842211456, 1005.070309963281, 1009.8586197932295, 1017.3285631483186, 1053.6996955867542, 20545.48636284105, 20892.58214835695, 20925.26761563338, 21090.17879891489, 21111.68332475014, 1000.1948431512702, 1006.6108769897495, 1033.6330602636106, 1036.233187441288, 1041.068243921701, 10022.3485473444, 10613.5223914924, 10786.73033174177, 10871.130309575216, 10876.02115809581, 737791.0, 748772.2561387158, 756319.0, 771279.0, 776515.0, 145239.0, 147861.52138478693, 166320.0, 166673.33326666578, 172941.0, 1202.8255902894032, 1236.5486597391887, 1256.2901960392348, 1261.369315342329, 1265.0322503284995, 17570.121493925, 18104.90947545254, 18164.36424725181, 18285.908570457064, 18584.535386615444, 56825.431745683665, 63457.365426346994, 63773.6811315959, 63919.0, 63950.0, 70424.0, 89066.55466722885, 90740.09259907581, 91047.17905641718, 92781.0, 11672.88327116718, 11681.591144309908, 11717.296962182296, 11921.165518413627, 12077.456514457046, 13022.0, 13116.737665246832, 13274.004449666121, 13438.260895650443, 13495.865041349462, 9305.348625596143, 10850.94574527154, 10862.94568527184, 11200.495977680861, 11383.658490245305, 9638.361478548522, 9754.365966212457, 10287.331323463952, 10362.481875906024, 10511.26421150512, 10162.085412312927, 10245.0, 10346.689599312032, 11304.208705390543, 11683.824742628698, 10761.441477216134, 11464.770704585695, 11627.418629068343, 11669.241499302518, 11689.357085360387, 11212.49543770516, 11326.603568875049, 11375.20373573842, 11476.827847582126, 11550.480228389575], "value": 11483.129775449053, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1326.2307861440365, 1374.7800351943686, 1475.911445313282, 1548.388386587298, 1552.3324970262786, 9223.677171299007, 9489.952550237256, 10495.160387169019, 11113.777724445506, 11143.1642626803, 9790.559424825882, 10499.42253176075, 11062.889371106286, 11085.889141108586, 11088.501017454213, 2371.6205407134817, 2422.818288628351, 2425.223928342931, 2429.465517586128, 2432.2946345559767, 2384.6303822907475, 2409.0363854458183, 2411.770881766229, 2413.9275821725378, 2428.7085549734056, 2065.845061620377, 2379.8929048192786, 2399.172285561487, 2405.386626410263, 2409.0363854458183, 1925.7592800899888, 2359.2922123362923, 2384.451576137481, 2407.374082738483, 2408.0849277274697, 2188.4419473034272, 2292.5529521743265, 2388.7133543974833, 2391.844530105555, 2413.5172965406987, 10861.511231994578, 11100.056495197918, 11110.61112861054, 11118.110551155889, 11127.221094523387, 5101.0308041472, 5693.629914055573, 5823.09741989988, 5887.0, 5894.8821023579285, 3512.613612502623, 3624.27514497099, 3648.2521083177885, 3662.249238906018, 3689.631036896316, 1194.110387761115, 1198.1553005131361, 1235.7466719322608, 1254.3853511779162, 1257.930758854966, 15353.385864565404, 15499.302531386002, 15512.069275843485, 15519.689606207925, 15520.456784012506, 4826.420829500412, 4938.827141050046, 4959.330490383824, 4979.975100124476, 5012.749362531858, 12978.0, 12987.0, 13014.414351354022, 13017.21896686202, 13045.478180872658, 5933.554983376264, 5948.196993405922, 5973.014452615356, 5976.804639072203, 5996.880062398727, 4092.9386059209137, 4986.60375094974, 5103.897922041612, 5196.9740151299, 5290.92063619046, 3286.8356582170795, 4016.859409920639, 4026.6577340925764, 4035.9192816143513, 4085.22380747657, 1137.5734099712608, 1141.7887690777234, 1154.3881742676394, 1166.2594252649628, 1172.1443346357207, 929.5723966975132, 930.2046750028763, 931.5435436636, 940.5532372123187, 993.438707130469, 6524.0, 6652.268250492442, 6694.129763130762, 6791.3548212919695, 6865.313468653195, 946.4983558713893, 967.3325405470204, 978.5351957819978, 1000.9849852252222, 1020.9132223760915, 4254.212970600449, 4262.339337402707, 4282.229198744194, 4295.548967358445, 4396.406485124531, 13250.801237981437, 13698.863011369958, 13723.862761372458, 13726.725465490634, 13736.862631373759, 13246.271455069871, 13474.244357188534, 13556.45774169042, 13579.388927498287, 13588.660283492794, 9932.304738668225, 10038.347507412142, 10061.79876402468, 10075.042870927397, 10076.69769906904, 6362.268339141058, 6465.61206327603, 6562.0, 6676.732930682912, 6722.596644201363, 12058.0, 12170.269783812999, 12292.81560776607, 12347.506099756269, 12371.319577423328, 12284.0, 12428.502859885502, 12475.376231188222, 12488.25070495773, 12507.499700011898, 7983.640736166771, 8234.752957411287, 8834.204921557091, 9181.081891810765, 9299.163075323253, 10182.439965801655, 10440.37357758537, 10522.0, 10534.683959481228, 10560.841587376042, 8719.433236839584, 8751.824963500821, 8755.474671519729, 8800.867986980329, 8824.0, 7836.568988705676, 8483.44857584255, 8671.219590236657, 8789.077146899483, 8875.334349923653, 7857.192845645419, 7928.801779955547, 7948.801279968047, 7987.800304992422, 7990.84018319642, 5828.970855145697, 5859.472647461749, 5865.296164460292, 5961.225040744675, 6114.48026917717, 5934.584579079596, 5949.762009519571, 6179.474744646575, 6204.720787564661, 6281.842953926189], "value": 5148.322998333754, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.7638641144404, 364.98357573909175, 374.87066961898137, 377.61483287047196, 391.7140487444166, 4399.736015839052, 4618.983823558816, 4983.401991760985, 5087.6693014954, 5229.843104706855, 4783.976080119594, 5044.344235249412, 5049.722265275417, 5090.847274581768, 5092.4028745339865, 3591.7844929304197, 3832.2143960488174, 4068.41008053832, 4270.338097594878, 4280.935785963213, 4059.234233108607, 4231.4710661167355, 4243.575642435762, 4248.300679728102, 4313.309870420733, 3796.6393192646656, 4264.040590867061, 4268.570029040276, 4277.272863613193, 4287.892802679927, 3557.7687450315907, 3750.887473375803, 3939.936217221334, 4079.775612341305, 4084.775337356444, 3137.2784259620416, 3724.6089160638285, 3822.3310920588788, 3915.060385507486, 3967.682585393162, 4685.554872287127, 4936.185529387647, 4946.3817022872145, 4981.850544483635, 4984.6261530385, 4151.205357811732, 4444.0, 4537.9773101134615, 4660.347551342815, 4908.4846091160625, 5352.598555108343, 5460.208269800896, 5504.80733174341, 5524.917126243109, 5542.168674698787, 3904.4533765272886, 4347.673924455678, 4376.606105450524, 4400.691951563392, 4456.777161141962, 4694.929576056362, 5447.918281225785, 5480.671159730429, 5513.255710479114, 5921.674307913063, 3832.7508711933633, 4024.5774193709826, 4285.292926667127, 4433.911321773547, 4541.933420293758, 4151.941254979961, 4227.32362821947, 4555.817767289338, 4668.346431499593, 4706.976465117653, 4430.579094985971, 4457.509673935864, 4724.71651700899, 4853.95146048542, 4955.776990035457, 4917.434495033045, 5159.25190847325, 5305.814296499604, 5416.7020813855615, 5491.32514583048, 1521.9315130819139, 1531.318563239348, 1565.9765103523457, 1586.1672621873608, 1591.6737068900848, 1090.4438736244572, 1105.1987309200765, 1169.584797396929, 1172.9882701172878, 1175.4122938530734, 4442.666799990014, 4875.026233997259, 5080.974595127074, 5124.92312615311, 5132.153194722903, 5049.31834202378, 5050.873728156752, 5421.403645598981, 5542.3626282977975, 5621.325440947113, 4166.458659903922, 4492.169932942225, 4845.297431872359, 5094.5160209780015, 5112.795488180505, 2514.7485251475073, 2905.6754596322858, 2922.1087568291873, 2927.0, 2948.9115326540236, 5248.506959194352, 5262.657927234717, 5519.777370311715, 5541.168824676331, 5599.356074051455, 5060.949390506122, 5367.302250707383, 5643.661380317194, 5796.565257605696, 5819.621724587888, 5411.485908838654, 5457.863553411196, 5792.304923409218, 5824.3593204748295, 5840.94159058404, 4979.0788704089855, 5619.634723742944, 5639.3232812062815, 5651.6043876928225, 5700.629459085146, 4616.468401672656, 5070.847874563769, 5256.816011439581, 5473.658953556245, 5568.805091821767, 4930.630202734881, 5789.1605717171615, 5841.94158058414, 5858.422294190543, 5884.852878678067, 3996.9024006395275, 4503.617192538671, 4509.210888094636, 4542.046170304273, 4563.247064234364, 4809.735464549483, 5039.697618142924, 5688.402717714746, 5704.828855134353, 5707.486326230659, 4907.852764416931, 5410.349843297832, 5420.783168673367, 5472.753726082416, 5495.120780675233, 4895.926561101657, 5218.921716174336, 5284.392294886137, 5442.673074905539, 5448.855740294583, 5146.856780291901, 5247.344081989751, 5327.07011143877, 5336.384027815989, 5353.759080841293, 5193.714345711022, 5489.286392768914, 5507.476789704971, 5527.364353099445, 5583.35791383996, 4882.389701287339, 4884.340614017062, 5022.459166287831, 5349.705766182741, 5595.04884169684], "value": 4169.891558257481, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.1063065852354, 731.3016069653478, 753.1038064703004, 831.1895901496042, 841.2722994609661, 14913.478028269014, 15765.132917689523, 15818.60453488662, 15861.84138158618, 15876.444324448647, 15467.613309667237, 16450.506484805475, 16548.420805271788, 16720.41478548251, 16809.15954202288, 655.8032590222938, 741.8850078237882, 913.0048247410322, 941.0495399646338, 945.7399215215802, 908.8954770201445, 922.7324076017946, 936.3024546712709, 936.9390989585655, 941.4774799986005, 984.8375018122001, 987.121461898907, 987.8320685483485, 989.4310771306491, 989.8812142542905, 983.5573991703726, 985.4924713772413, 985.7929834734714, 985.960561577536, 989.5052473763119, 728.7595093619093, 729.5659082845698, 730.1821959405447, 730.4156674660251, 730.9305615966475, 15992.600184995352, 16380.918095409566, 16481.34074637025, 16640.16799160037, 16861.325546978107, 13017.893479054292, 13175.34123293841, 13652.0, 13924.860751392458, 14074.22591757453, 10730.356178629307, 11583.710407239801, 11757.0, 11869.584564540286, 12430.12989090764, 3319.3527262183884, 3591.982040089809, 3678.282734866702, 3682.2819550187724, 3824.349860523718, 114069.85930140676, 115159.0, 115312.0, 116695.41652291769, 116764.0, 10846.349219046724, 10926.617568385069, 10944.343339399662, 10987.340759554452, 11099.83350249747, 19814.90092549528, 21076.840773757285, 21141.942902854797, 22263.220787272367, 22607.20874769408, 7198.460115491359, 7676.276138527953, 7680.4623676343235, 7743.186965368668, 7795.0, 4178.310578754532, 4200.516940551875, 4272.829086836554, 4273.337632666941, 4348.695591308578, 2892.537194048942, 3381.306832099414, 3397.76215664906, 3406.8126253055825, 3430.27964127531, 631.766246488802, 632.6552029144127, 639.4500729372736, 640.5804198250154, 648.0117820324043, 658.9308122647149, 660.94712423007, 678.8981652752127, 700.7932659865352, 722.151472020374, 9957.402555846673, 10054.296199266128, 10099.545520451597, 10198.592056317813, 10303.278770485995, 694.187800273681, 696.6133795743411, 706.0997228533558, 706.5195666946526, 713.2403989750899, 4768.856934291976, 4896.632752543574, 4901.142300097468, 4902.607791376681, 4917.877053073702, 81258.0, 83229.16770832335, 92525.53737231271, 93557.5322123385, 97015.51492242493, 67970.66014669895, 69902.0, 71706.28293717101, 81143.18856811474, 82602.3479530406, 71829.2817071833, 74387.62806185934, 74768.87846682304, 75881.86177207346, 77043.61478192573, 10624.309419887682, 10790.716167188635, 11131.888681113085, 11134.0, 11139.443027848738, 47401.28898066463, 48119.518804812906, 48233.75883120562, 48615.0, 49990.0, 59174.70412647909, 59604.0, 62312.688436557524, 62737.11788646348, 63354.36645633669, 11947.940260298643, 12427.565035223724, 12482.375881206084, 12725.80911286313, 12912.289824059391, 12067.698307542381, 13587.932060339635, 13828.723425531634, 14032.438702452197, 14232.0, 12843.871561284268, 13539.390727417487, 13622.0, 13929.930350348588, 14382.454714006732, 13550.322483875963, 13667.726645466835, 13697.863021370058, 14023.018388712691, 14139.222342771247, 12978.545750898673, 13231.27228002469, 13676.521321753691, 13743.518976835763, 13798.17210967345, 7778.88331675014, 8123.593820308843, 8312.6674933002, 9183.77040573991, 9223.123803238681, 10818.188635852186, 11059.336439813636, 11076.889231107585, 11254.493547790205, 11258.831117533407], "value": 7492.925411346588, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1584.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 133.0, 170.0, 160.0, 122.0, 126.0, 122.0, 121.0, 122.0, 121.0], "value": 130.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 112.0, 110.0, 148.0, 110.0, 115.0, 131.0, 116.0, 151.0, 131.0], "value": 126.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 197.0, 197.0, 238.0, 280.0, 205.0, 210.0, 269.0, 235.0, 173.0], "value": 220.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 60.0, 75.0, 73.0, 83.0, 52.0, 61.0, 63.0, 71.0, 79.0], "value": 70.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 68.0, 84.0, 74.0, 71.0, 69.0, 82.0, 97.0, 96.0, 108.0], "value": 83.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 93.0, 86.0, 127.0, 127.0, 108.0, 91.0, 90.0, 79.0, 83.0], "value": 97.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 106.0, 110.0, 144.0, 114.0, 145.0, 145.0, 98.0, 97.0, 99.0], "value": 115.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 125.0, 93.0, 93.0, 92.0, 90.0, 88.0, 91.0, 91.0, 93.0], "value": 100.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 68.0, 70.0, 69.0, 68.0, 69.0, 70.0, 71.0, 75.0], "value": 69.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 62.0, 83.0, 54.0, 58.0, 66.0, 79.0, 79.0, 70.0, 59.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 84.0, 87.0, 83.0, 87.0, 84.0, 84.0, 87.0, 86.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 142.0, 135.0, 146.0, 136.0, 146.0, 155.0, 148.0, 196.0, 158.0], "value": 150.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 229.0, 213.0, 177.0, 181.0, 207.0, 216.0, 209.0, 169.0, 169.0], "value": 194.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 86.0, 79.0, 63.0, 78.0, 80.0, 66.0, 58.0, 85.0], "value": 73.5, "unit": "score"}]}]} 21:16:27 INFO - Return code: 0 21:16:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:16:27 ERROR - # TBPL SUCCESS # 21:16:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:16:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:16:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:16:27 INFO - 2017-04-12 21:16:27.440 screenresolution[1659:11034] starting screenresolution argv=screenresolution get 21:16:27 INFO - 2017-04-12 21:16:27.443 screenresolution[1659:11034] Display 0: 1600x1200x32@60 21:16:27 INFO - 2017-04-12 21:16:27.449 screenresolution[1660:11037] starting screenresolution argv=screenresolution list 21:16:27 INFO - Available Modes on Display 0 21:16:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:16:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:16:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:16:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:16:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:16:27 INFO - Intel Iris: 21:16:27 INFO - Chipset Model: Intel Iris 21:16:27 INFO - Type: GPU 21:16:27 INFO - Bus: Built-In 21:16:27 INFO - VRAM (Dynamic, Max): 1536 MB 21:16:27 INFO - Vendor: Intel (0x8086) 21:16:27 INFO - Device ID: 0x0a2e 21:16:27 INFO - Revision ID: 0x0009 21:16:27 INFO - Displays: 21:16:27 INFO - Display: 21:16:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:16:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:16:27 INFO - Display Serial Number: 1600x1200 60 21:16:27 INFO - Main Display: Yes 21:16:27 INFO - Mirror: Off 21:16:27 INFO - Online: Yes 21:16:27 INFO - Rotation: Supported 21:16:27 INFO - Return code: 0 21:16:27 INFO - Running post-action listener: _resource_record_post_action 21:16:27 INFO - [mozharness: 2017-04-13 04:16:27.689061Z] Finished run-tests step (success) 21:16:27 INFO - Running post-run listener: _resource_record_post_run 21:16:27 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 43796992; Write bytes: 512925696; Read time: 454; Write time: 1693 21:16:27 INFO - TinderboxPrint: CPU usage
55.0% 21:16:27 INFO - TinderboxPrint: I/O read bytes / time
43,796,992 / 454 21:16:27 INFO - TinderboxPrint: I/O write bytes / time
512,925,696 / 1,693 21:16:27 INFO - TinderboxPrint: CPU idle
2,160.9 (45.0%) 21:16:27 INFO - TinderboxPrint: CPU system
970.1 (20.2%) 21:16:27 INFO - TinderboxPrint: CPU user
1,670.7 (34.8%) 21:16:27 INFO - TinderboxPrint: Swap in / out
248,299,520 / 0 21:16:27 INFO - install - Wall time: 21s; CPU: 55.0%; Read bytes: 201873920; Write bytes: 200849408; Read time: 15669; Write time: 420 21:16:27 INFO - run-tests - Wall time: 1180s; CPU: 55.0%; Read bytes: 41900544; Write bytes: 301291520; Read time: 433; Write time: 1242 21:16:28 INFO - Running post-run listener: _upload_blobber_files 21:16:28 INFO - Blob upload gear active. 21:16:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:16:28 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 21:16:28 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'] 21:16:28 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 21:16:28 INFO - (blobuploader) - INFO - Open directory for files ... 21:16:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:16:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:16:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:16:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:16:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:16:29 INFO - (blobuploader) - INFO - Done attempting. 21:16:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:16:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:16:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:16:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:16:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:16:30 INFO - (blobuploader) - INFO - Done attempting. 21:16:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:16:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:16:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:16:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:16:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:16:31 INFO - (blobuploader) - INFO - Done attempting. 21:16:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:16:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:16:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:16:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:16:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:16:34 INFO - (blobuploader) - INFO - Done attempting. 21:16:34 INFO - (blobuploader) - INFO - Iteration through files over. 21:16:34 INFO - Return code: 0 21:16:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:16:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:16:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9fe6ae4fd9bb756466ef51e96b97befa7334ecf003e98a339cb298cb75329b1098dbf028737fbb5f7a1aa1f593b3075ab20d6219afeed4318e2eec6b539deb9b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ae64809803e4175f5bc3a00d365a7dfbd200969622235f399e4100ab4e364803a41cb9cdd56132a79d4e3d04c6f8faa1caeb9f3fe8d1bcea47946b37064a667", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22331b1aba2274c68ba406c7fb5d931d60dc06de7eef36c7bda9b9086ee99ce1304c518824ea14068de95f29990e185bac815774a17b9eba3d6713530785fc60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36d0dab10d703d9d5806f135285c37b7298707fe5968a2eabdf402d86fce8ba87b5527a8ee872ec91e40fd5d92d5116905f704b18e118812927fc699bbf72d76"} 21:16:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:16:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:16:34 INFO - Contents: 21:16:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9fe6ae4fd9bb756466ef51e96b97befa7334ecf003e98a339cb298cb75329b1098dbf028737fbb5f7a1aa1f593b3075ab20d6219afeed4318e2eec6b539deb9b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ae64809803e4175f5bc3a00d365a7dfbd200969622235f399e4100ab4e364803a41cb9cdd56132a79d4e3d04c6f8faa1caeb9f3fe8d1bcea47946b37064a667", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22331b1aba2274c68ba406c7fb5d931d60dc06de7eef36c7bda9b9086ee99ce1304c518824ea14068de95f29990e185bac815774a17b9eba3d6713530785fc60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36d0dab10d703d9d5806f135285c37b7298707fe5968a2eabdf402d86fce8ba87b5527a8ee872ec91e40fd5d92d5116905f704b18e118812927fc699bbf72d76"} 21:16:34 INFO - Running post-run listener: copy_logs_to_upload_dir 21:16:34 INFO - Copying logs to upload dir... 21:16:34 INFO - mkdir: /builds/slave/test/build/upload/logs 21:16:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.860040 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-12 21:16:34.244734) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-12 21:16:34.247906) ========= 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.nJjNw9eL2f/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.yCqkHnd5KH/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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/9fe6ae4fd9bb756466ef51e96b97befa7334ecf003e98a339cb298cb75329b1098dbf028737fbb5f7a1aa1f593b3075ab20d6219afeed4318e2eec6b539deb9b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ae64809803e4175f5bc3a00d365a7dfbd200969622235f399e4100ab4e364803a41cb9cdd56132a79d4e3d04c6f8faa1caeb9f3fe8d1bcea47946b37064a667", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22331b1aba2274c68ba406c7fb5d931d60dc06de7eef36c7bda9b9086ee99ce1304c518824ea14068de95f29990e185bac815774a17b9eba3d6713530785fc60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36d0dab10d703d9d5806f135285c37b7298707fe5968a2eabdf402d86fce8ba87b5527a8ee872ec91e40fd5d92d5116905f704b18e118812927fc699bbf72d76"} build_url:https://queue.taskcluster.net/v1/task/LwmUDZQ-TD6IrEaa6p3o3g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010965 build_url: 'https://queue.taskcluster.net/v1/task/LwmUDZQ-TD6IrEaa6p3o3g/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/9fe6ae4fd9bb756466ef51e96b97befa7334ecf003e98a339cb298cb75329b1098dbf028737fbb5f7a1aa1f593b3075ab20d6219afeed4318e2eec6b539deb9b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ae64809803e4175f5bc3a00d365a7dfbd200969622235f399e4100ab4e364803a41cb9cdd56132a79d4e3d04c6f8faa1caeb9f3fe8d1bcea47946b37064a667", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22331b1aba2274c68ba406c7fb5d931d60dc06de7eef36c7bda9b9086ee99ce1304c518824ea14068de95f29990e185bac815774a17b9eba3d6713530785fc60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36d0dab10d703d9d5806f135285c37b7298707fe5968a2eabdf402d86fce8ba87b5527a8ee872ec91e40fd5d92d5116905f704b18e118812927fc699bbf72d76"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-12 21:16:34.283916) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 21:16:34.284459) ========= 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.nJjNw9eL2f/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.yCqkHnd5KH/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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.005206 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 21:16:34.333629) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-12 21:16:34.333941) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-12 21:16:34.334289) ========= ========= Total master_lag: 0.46 =========