builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0272 starttime: 1491217081.74 results: success (0) buildid: 20170403022922 builduid: e11d517989514f19b01f71617b6ad914 revision: c53411a2c11f43f6ea567fbb38efcf79b08bcf28 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 03:58:01.744340) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 03:58:01.745073) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-03 03:58:01.745539) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-03 03:58:01.773936) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 03:58:01.774537) ========= 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.LCYKuVlWMI/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.j6NcSrKnWt/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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-03 03:58:01-- 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% 17.4M=0.001s 2017-04-03 03:58:01 (17.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089951 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 03:58:01.890727) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 03:58:01.891160) ========= 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.LCYKuVlWMI/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.j6NcSrKnWt/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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.036598 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 03:58:01.951505) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-03 03:58:01.951871) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c53411a2c11f43f6ea567fbb38efcf79b08bcf28 --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 c53411a2c11f43f6ea567fbb38efcf79b08bcf28 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LCYKuVlWMI/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.j6NcSrKnWt/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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-03 03:58:02,018 truncating revision to first 12 chars 2017-04-03 03:58:02,018 Setting DEBUG logging. 2017-04-03 03:58:02,018 attempt 1/10 2017-04-03 03:58:02,018 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c53411a2c11f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-03 03:58:02,862 unpacking tar archive at: mozilla-aurora-c53411a2c11f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.122265 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-03 03:58:03.098415) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 03:58:03.098807) ========= script_repo_revision: c53411a2c11f43f6ea567fbb38efcf79b08bcf28 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 03:58:03.099290) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 03:58:03.099573) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 03:58:03.119749) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-04-03 03:58:03.120214) ========= /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.LCYKuVlWMI/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.j6NcSrKnWt/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 03:58:03 INFO - MultiFileLogger online at 20170403 03:58:03 in /builds/slave/test 03:58:03 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 03:58:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:58:03 INFO - {'append_to_log': False, 03:58:03 INFO - 'base_work_dir': '/builds/slave/test', 03:58:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:58:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:58:03 INFO - 'branch': 'Mozilla-Aurora', 03:58:03 INFO - 'buildbot_json_path': 'buildprops.json', 03:58:03 INFO - 'config_files': ('talos/mac_config.py',), 03:58:03 INFO - 'default_actions': ('clobber', 03:58:03 INFO - 'read-buildbot-config', 03:58:03 INFO - 'download-and-extract', 03:58:03 INFO - 'populate-webroot', 03:58:03 INFO - 'create-virtualenv', 03:58:03 INFO - 'install', 03:58:03 INFO - 'run-tests'), 03:58:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:58:03 INFO - 'download_minidump_stackwalk': True, 03:58:03 INFO - 'download_symbols': 'ondemand', 03:58:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:58:03 INFO - 'tooltool.py': '/tools/tooltool.py', 03:58:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:58:03 INFO - '/tools/misc-python/virtualenv.py')}, 03:58:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:58:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:58:03 INFO - 'gecko_profile': False, 03:58:03 INFO - 'gecko_profile_interval': 0, 03:58:03 INFO - 'installer_path': 'installer.exe', 03:58:03 INFO - 'log_level': 'info', 03:58:03 INFO - 'log_name': 'talos', 03:58:03 INFO - 'log_to_console': True, 03:58:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:58:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:58:03 INFO - 'opt_config_files': (), 03:58:03 INFO - 'pip_index': False, 03:58:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:58:03 INFO - 'cmd': ('bash', 03:58:03 INFO - '-c', 03:58:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:58:03 INFO - 'enabled': True, 03:58:03 INFO - 'halt_on_failure': False, 03:58:03 INFO - 'name': 'check_screen_resolution'},), 03:58:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:58:03 INFO - 'cmd': ('bash', 03:58:03 INFO - '-c', 03:58:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:58:03 INFO - 'enabled': True, 03:58:03 INFO - 'halt_on_failure': False, 03:58:03 INFO - 'name': 'check_screen_resolution'},), 03:58:03 INFO - 'run_cmd_checks_enabled': True, 03:58:03 INFO - 'suite': 'dromaeojs-e10s', 03:58:03 INFO - 'system_bits': '32', 03:58:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:58:03 INFO - 'title': 't-yosemite-r7-0272', 03:58:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:58:03 INFO - 'use_talos_json': True, 03:58:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:58:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:58:03 INFO - 'work_dir': 'build'} 03:58:03 INFO - [mozharness: 2017-04-03 10:58:03.297153Z] Running clobber step. 03:58:03 INFO - Running pre-action listener: _resource_record_pre_action 03:58:03 INFO - Running main action method: clobber 03:58:03 INFO - rmtree: /builds/slave/test/build 03:58:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:58:05 INFO - Running post-action listener: _resource_record_post_action 03:58:05 INFO - [mozharness: 2017-04-03 10:58:05.672983Z] Finished clobber step (success) 03:58:05 INFO - [mozharness: 2017-04-03 10:58:05.673112Z] Running read-buildbot-config step. 03:58:05 INFO - Running pre-action listener: _resource_record_pre_action 03:58:05 INFO - Running main action method: read_buildbot_config 03:58:05 INFO - Using buildbot properties: 03:58:05 INFO - { 03:58:05 INFO - "project": "", 03:58:05 INFO - "product": "firefox", 03:58:05 INFO - "script_repo_revision": "production", 03:58:05 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 03:58:05 INFO - "repository": "", 03:58:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 03:58:05 INFO - "buildid": "20170403022922", 03:58:05 INFO - "pgo_build": "False", 03:58:05 INFO - "basedir": "/builds/slave/test", 03:58:05 INFO - "buildnumber": 16, 03:58:05 INFO - "slavename": "t-yosemite-r7-0272", 03:58:05 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 03:58:05 INFO - "platform": "yosemite_r7", 03:58:05 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:58:05 INFO - "branch": "mozilla-aurora", 03:58:05 INFO - "repo_path": "releases/mozilla-aurora", 03:58:05 INFO - "revision": "c53411a2c11f43f6ea567fbb38efcf79b08bcf28", 03:58:05 INFO - "stage_platform": "macosx64", 03:58:05 INFO - "builduid": "e11d517989514f19b01f71617b6ad914", 03:58:05 INFO - "slavebuilddir": "test" 03:58:05 INFO - } 03:58:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 03:58:05 INFO - Running post-action listener: _resource_record_post_action 03:58:05 INFO - [mozharness: 2017-04-03 10:58:05.676442Z] Finished read-buildbot-config step (success) 03:58:05 INFO - [mozharness: 2017-04-03 10:58:05.676578Z] Running download-and-extract step. 03:58:05 INFO - Running pre-action listener: _resource_record_pre_action 03:58:05 INFO - Running main action method: download_and_extract 03:58:05 INFO - mkdir: /builds/slave/test/build/tests 03:58:05 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')]} 03:58:05 INFO - trying https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 03:58:05 INFO - Downloading https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/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 03:58:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/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 03:58:06 INFO - Downloaded 1199 bytes. 03:58:06 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 03:58:06 INFO - Using the following test package requirements: 03:58:06 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 03:58:06 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:58:06 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 03:58:06 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:58:06 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 03:58:06 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:58:06 INFO - u'jsshell-mac.zip'], 03:58:06 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:58:06 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 03:58:06 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 03:58:06 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:58:06 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 03:58:06 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:58:06 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 03:58:06 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:58:06 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 03:58:06 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:58:06 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 03:58:06 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:58:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 03:58:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:58:06 INFO - Fetch https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 03:58:08 INFO - Expected file size: 51788822 03:58:08 INFO - Obtained file size: 51788822 03:58:24 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 03:58:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 03:58:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:58:24 INFO - Fetch https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 03:58:26 INFO - Expected file size: 51788822 03:58:26 INFO - Obtained file size: 51788822 03:58:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 03:58:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:58:41 INFO - Fetch https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 03:58:42 INFO - Expected file size: 14404438 03:58:42 INFO - Obtained file size: 14404438 03:58:42 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')]} 03:58:42 INFO - trying https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 03:58:42 INFO - Downloading https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 03:58:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/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 03:58:44 INFO - Downloaded 74661606 bytes. 03:58:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 03:58:44 INFO - mkdir: /builds/slave/test/properties 03:58:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:58:44 INFO - Writing to file /builds/slave/test/properties/build_url 03:58:44 INFO - Contents: 03:58:44 INFO - build_url:https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 03:58:45 INFO - Running post-action listener: _resource_record_post_action 03:58:45 INFO - Running post-action listener: set_extra_try_arguments 03:58:45 INFO - [mozharness: 2017-04-03 10:58:45.291430Z] Finished download-and-extract step (success) 03:58:45 INFO - [mozharness: 2017-04-03 10:58:45.291561Z] Running populate-webroot step. 03:58:45 INFO - Running pre-action listener: _resource_record_pre_action 03:58:45 INFO - Running main action method: populate_webroot 03:58:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:58:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:58:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:58:45 INFO - '--tppagecycles', 03:58:45 INFO - '7'], 03:58:45 INFO - 'tests': ['tsvgm']}}, 03:58:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:58:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:58:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:58:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:58:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:58:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:58:45 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:58:45 INFO - 'talos_options': ['--disable-e10s'], 03:58:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:58:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:58:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:58:45 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:58:45 INFO - 'talos_options': ['--disable-e10s'], 03:58:45 INFO - 'tests': ['damp', 'tps']}, 03:58:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:58:45 INFO - 'tests': ['damp', 'tps']}, 03:58:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:58:45 INFO - 'tests': ['dromaeo_dom']}, 03:58:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:58:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:58:45 INFO - 'tests': ['basic_compositor_video']}, 03:58:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:58:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:58:45 INFO - 'tests': ['a11yr', 03:58:45 INFO - 'ts_paint', 03:58:45 INFO - 'tpaint', 03:58:45 INFO - 'sessionrestore', 03:58:45 INFO - 'sessionrestore_no_auto_restore', 03:58:45 INFO - 'tabpaint']}, 03:58:45 INFO - 'other-e10s': {'tests': ['a11yr', 03:58:45 INFO - 'ts_paint', 03:58:45 INFO - 'tpaint', 03:58:45 INFO - 'sessionrestore', 03:58:45 INFO - 'sessionrestore_no_auto_restore', 03:58:45 INFO - 'tabpaint']}, 03:58:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:58:45 INFO - 'ts_paint', 03:58:45 INFO - 'tpaint', 03:58:45 INFO - 'sessionrestore', 03:58:45 INFO - 'sessionrestore_no_auto_restore', 03:58:45 INFO - 'tabpaint']}, 03:58:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:58:45 INFO - 'ts_paint', 03:58:45 INFO - 'tpaint', 03:58:45 INFO - 'sessionrestore', 03:58:45 INFO - 'sessionrestore_no_auto_restore', 03:58:45 INFO - 'tabpaint']}, 03:58:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:58:45 INFO - 'tests': ['a11yr', 03:58:45 INFO - 'ts_paint', 03:58:45 INFO - 'tpaint', 03:58:45 INFO - 'sessionrestore', 03:58:45 INFO - 'sessionrestore_no_auto_restore', 03:58:45 INFO - 'tabpaint']}, 03:58:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:58:45 INFO - 'tests': ['a11yr', 03:58:45 INFO - 'ts_paint', 03:58:45 INFO - 'tpaint', 03:58:45 INFO - 'sessionrestore', 03:58:45 INFO - 'sessionrestore_no_auto_restore', 03:58:45 INFO - 'tabpaint']}, 03:58:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:58:45 INFO - 'tests': ['tsvgx', 03:58:45 INFO - 'tsvgr_opacity', 03:58:45 INFO - 'tart', 03:58:45 INFO - 'tscrollx', 03:58:45 INFO - 'cart', 03:58:45 INFO - 'tsvg_static']}, 03:58:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:58:45 INFO - 'tsvgr_opacity', 03:58:45 INFO - 'tart', 03:58:45 INFO - 'tscrollx', 03:58:45 INFO - 'cart', 03:58:45 INFO - 'tsvg_static']}, 03:58:45 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:58:45 INFO - 'talos_options': ['--disable-e10s'], 03:58:45 INFO - 'tests': ['tp5o']}, 03:58:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:58:45 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:58:45 INFO - 'talos_options': ['--disable-e10s', 03:58:45 INFO - '--xperf_path', 03:58:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:58:45 INFO - 'tests': ['tp5n']}, 03:58:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:58:45 INFO - 'talos_options': ['--xperf_path', 03:58:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:58:45 INFO - 'tests': ['tp5n']}}, 03:58:45 INFO - 'talos.zip': {'path': '', 03:58:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:58:45 INFO - Running post-action listener: _resource_record_post_action 03:58:45 INFO - [mozharness: 2017-04-03 10:58:45.310299Z] Finished populate-webroot step (success) 03:58:45 INFO - [mozharness: 2017-04-03 10:58:45.310428Z] Running create-virtualenv step. 03:58:45 INFO - Running pre-action listener: _resource_record_pre_action 03:58:45 INFO - Running main action method: create_virtualenv 03:58:45 INFO - Creating virtualenv /builds/slave/test/build/venv 03:58:45 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 03:58:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:58:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:58:45 INFO - Using real prefix '/tools/python27' 03:58:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:58:46 INFO - Installing distribute.............................................................................................................................................................................................done. 03:58:49 INFO - Installing pip.................done. 03:58:49 INFO - Return code: 0 03:58:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:58:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:58:49 INFO - Reading from file tmpfile_stdout 03:58:49 INFO - Output received: 03:58:49 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) 03:58:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:58:49 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')]} 03:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:49 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')]} 03:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:49 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 0x1104ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97e0584bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102bbd30>, '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 0x1101e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102b0be8>, '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.LCYKuVlWMI/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.j6NcSrKnWt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 03:58:49 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 03:58:49 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 03:58:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LCYKuVlWMI/Render', 03:58:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:49 INFO - 'HOME': '/Users/cltbld', 03:58:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:49 INFO - 'LOGNAME': 'cltbld', 03:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:49 INFO - 'MOZ_NO_REMOTE': '1', 03:58:49 INFO - 'NO_EM_RESTART': '1', 03:58:49 INFO - 'PAGER': '/bin/cat', 03:58:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:49 INFO - 'PWD': '/builds/slave/test', 03:58:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:49 INFO - 'SHELL': '/bin/bash', 03:58:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j6NcSrKnWt/Listeners', 03:58:49 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 03:58:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:49 INFO - 'USER': 'cltbld', 03:58:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:49 INFO - 'XPC_FLAGS': '0x0', 03:58:49 INFO - 'XPC_SERVICE_NAME': '0', 03:58:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:49 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 03:58:49 INFO - Cleaning up... 03:58:49 INFO - Return code: 0 03:58:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:58:49 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')]} 03:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:49 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')]} 03:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:49 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 0x1104ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97e0584bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102bbd30>, '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 0x1101e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102b0be8>, '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.LCYKuVlWMI/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.j6NcSrKnWt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 03:58:49 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 03:58:49 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 03:58:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LCYKuVlWMI/Render', 03:58:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:49 INFO - 'HOME': '/Users/cltbld', 03:58:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:49 INFO - 'LOGNAME': 'cltbld', 03:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:49 INFO - 'MOZ_NO_REMOTE': '1', 03:58:49 INFO - 'NO_EM_RESTART': '1', 03:58:49 INFO - 'PAGER': '/bin/cat', 03:58:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:49 INFO - 'PWD': '/builds/slave/test', 03:58:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:49 INFO - 'SHELL': '/bin/bash', 03:58:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j6NcSrKnWt/Listeners', 03:58:49 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 03:58:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:49 INFO - 'USER': 'cltbld', 03:58:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:49 INFO - 'XPC_FLAGS': '0x0', 03:58:49 INFO - 'XPC_SERVICE_NAME': '0', 03:58:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:49 INFO - Downloading/unpacking psutil>=3.1.1 03:58:49 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 03:58:49 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 03:58:49 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 03:58:49 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 03:58:49 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 03:58:49 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 03:58:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:58:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:58:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:58:53 INFO - Installing collected packages: psutil 03:58:53 INFO - Running setup.py install for psutil 03:58:53 INFO - building 'psutil._psutil_osx' extension 03:58:53 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 03:58:54 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 03:58:54 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 03:58:54 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 03:58:54 INFO - building 'psutil._psutil_posix' extension 03:58:54 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 03:58:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:58:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:58:54 INFO - ^ 03:58:54 INFO - 1 warning generated. 03:58:54 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 03:58:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:58:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:58:54 INFO - Successfully installed psutil 03:58:54 INFO - Cleaning up... 03:58:54 INFO - Return code: 0 03:58:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:58:54 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')]} 03:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:54 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')]} 03:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:54 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 0x1104ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97e0584bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102bbd30>, '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 0x1101e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102b0be8>, '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.LCYKuVlWMI/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.j6NcSrKnWt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 03:58:54 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 03:58:54 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 03:58:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LCYKuVlWMI/Render', 03:58:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:54 INFO - 'HOME': '/Users/cltbld', 03:58:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:54 INFO - 'LOGNAME': 'cltbld', 03:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:54 INFO - 'MOZ_NO_REMOTE': '1', 03:58:54 INFO - 'NO_EM_RESTART': '1', 03:58:54 INFO - 'PAGER': '/bin/cat', 03:58:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:54 INFO - 'PWD': '/builds/slave/test', 03:58:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:54 INFO - 'SHELL': '/bin/bash', 03:58:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j6NcSrKnWt/Listeners', 03:58:54 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 03:58:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:54 INFO - 'USER': 'cltbld', 03:58:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:54 INFO - 'XPC_FLAGS': '0x0', 03:58:54 INFO - 'XPC_SERVICE_NAME': '0', 03:58:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:58:54 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 03:58:54 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 03:58:54 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 03:58:54 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 03:58:54 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 03:58:54 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 03:58:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:58:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:58:57 INFO - Installing collected packages: mozsystemmonitor 03:58:57 INFO - Running setup.py install for mozsystemmonitor 03:58:57 INFO - Successfully installed mozsystemmonitor 03:58:57 INFO - Cleaning up... 03:58:57 INFO - Return code: 0 03:58:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:58: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')]} 03:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58: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')]} 03:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58: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', '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 0x1104ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97e0584bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102bbd30>, '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 0x1101e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102b0be8>, '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.LCYKuVlWMI/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.j6NcSrKnWt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 03:58: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:58: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 jsonschema==2.5.1 03:58:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LCYKuVlWMI/Render', 03:58:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:58 INFO - 'HOME': '/Users/cltbld', 03:58:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:58 INFO - 'LOGNAME': 'cltbld', 03:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:58 INFO - 'MOZ_NO_REMOTE': '1', 03:58:58 INFO - 'NO_EM_RESTART': '1', 03:58:58 INFO - 'PAGER': '/bin/cat', 03:58:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:58 INFO - 'PWD': '/builds/slave/test', 03:58:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:58 INFO - 'SHELL': '/bin/bash', 03:58:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j6NcSrKnWt/Listeners', 03:58:58 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 03:58:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:58 INFO - 'USER': 'cltbld', 03:58:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:58 INFO - 'XPC_FLAGS': '0x0', 03:58:58 INFO - 'XPC_SERVICE_NAME': '0', 03:58:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:59 INFO - Downloading/unpacking jsonschema==2.5.1 03:58:59 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 03:58:59 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 03:58:59 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 03:58:59 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 03:58:59 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 03:58:59 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 03:59:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:59:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:02 INFO - Downloading functools32-3.2.3-2.tar.gz 03:59:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:59:02 INFO - warning: no files found matching '*.txt' 03:59:02 INFO - no previously-included directories found matching 'build' 03:59:02 INFO - no previously-included directories found matching 'dist' 03:59:02 INFO - no previously-included directories found matching '.git*' 03:59:02 INFO - Installing collected packages: jsonschema, functools32 03:59:02 INFO - Running setup.py install for functools32 03:59:02 INFO - warning: no files found matching '*.txt' 03:59:02 INFO - no previously-included directories found matching 'build' 03:59:02 INFO - no previously-included directories found matching 'dist' 03:59:02 INFO - no previously-included directories found matching '.git*' 03:59:02 INFO - Successfully installed jsonschema functools32 03:59:02 INFO - Cleaning up... 03:59:02 INFO - Return code: 0 03:59:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:02 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 0x1104ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97e0584bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102bbd30>, '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 0x1101e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102b0be8>, '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.LCYKuVlWMI/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.j6NcSrKnWt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 03:59:02 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 03:59:02 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 03:59:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LCYKuVlWMI/Render', 03:59:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:02 INFO - 'HOME': '/Users/cltbld', 03:59:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:02 INFO - 'LOGNAME': 'cltbld', 03:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:02 INFO - 'MOZ_NO_REMOTE': '1', 03:59:02 INFO - 'NO_EM_RESTART': '1', 03:59:02 INFO - 'PAGER': '/bin/cat', 03:59:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:02 INFO - 'PWD': '/builds/slave/test', 03:59:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:02 INFO - 'SHELL': '/bin/bash', 03:59:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j6NcSrKnWt/Listeners', 03:59:02 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 03:59:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:02 INFO - 'USER': 'cltbld', 03:59:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:02 INFO - 'XPC_FLAGS': '0x0', 03:59:02 INFO - 'XPC_SERVICE_NAME': '0', 03:59:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:59:02 INFO - Cleaning up... 03:59:02 INFO - Return code: 0 03:59:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:02 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 0x1104ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97e0584bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102bbd30>, '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 0x1101e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102b0be8>, '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.LCYKuVlWMI/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.j6NcSrKnWt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 03:59:02 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 03:59:02 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 03:59:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LCYKuVlWMI/Render', 03:59:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:02 INFO - 'HOME': '/Users/cltbld', 03:59:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:02 INFO - 'LOGNAME': 'cltbld', 03:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:02 INFO - 'MOZ_NO_REMOTE': '1', 03:59:02 INFO - 'NO_EM_RESTART': '1', 03:59:02 INFO - 'PAGER': '/bin/cat', 03:59:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:02 INFO - 'PWD': '/builds/slave/test', 03:59:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:02 INFO - 'SHELL': '/bin/bash', 03:59:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j6NcSrKnWt/Listeners', 03:59:02 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 03:59:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:02 INFO - 'USER': 'cltbld', 03:59:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:02 INFO - 'XPC_FLAGS': '0x0', 03:59:02 INFO - 'XPC_SERVICE_NAME': '0', 03:59:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:03 INFO - Downloading/unpacking blobuploader==1.2.4 03:59: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 03:59: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 03:59: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 03:59: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 03:59: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 03:59: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 03:59:05 INFO - Downloading blobuploader-1.2.4.tar.gz 03:59:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:59:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:59:05 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 03:59:05 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 03:59:05 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 03:59:05 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 03:59:05 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 03:59:05 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 03:59:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:59:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:59:06 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 03:59:06 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 03:59:06 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 03:59:06 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 03:59:06 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 03:59:06 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 03:59:07 INFO - Downloading docopt-0.6.1.tar.gz 03:59:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:59:07 INFO - Installing collected packages: blobuploader, requests, docopt 03:59:07 INFO - Running setup.py install for blobuploader 03:59:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:59:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:59:07 INFO - Running setup.py install for requests 03:59:07 INFO - Running setup.py install for docopt 03:59:07 INFO - Successfully installed blobuploader requests docopt 03:59:07 INFO - Cleaning up... 03:59:08 INFO - Return code: 0 03:59:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:59:08 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')]} 03:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:08 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')]} 03:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:08 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 0x1104ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97e0584bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102bbd30>, '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 0x1101e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102b0be8>, '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.LCYKuVlWMI/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.j6NcSrKnWt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 03:59:08 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 03:59:08 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 03:59:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LCYKuVlWMI/Render', 03:59:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:08 INFO - 'HOME': '/Users/cltbld', 03:59:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:08 INFO - 'LOGNAME': 'cltbld', 03:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:08 INFO - 'MOZ_NO_REMOTE': '1', 03:59:08 INFO - 'NO_EM_RESTART': '1', 03:59:08 INFO - 'PAGER': '/bin/cat', 03:59:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:08 INFO - 'PWD': '/builds/slave/test', 03:59:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:08 INFO - 'SHELL': '/bin/bash', 03:59:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j6NcSrKnWt/Listeners', 03:59:08 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 03:59:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:08 INFO - 'USER': 'cltbld', 03:59:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:08 INFO - 'XPC_FLAGS': '0x0', 03:59:08 INFO - 'XPC_SERVICE_NAME': '0', 03:59:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:59:08 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-VtJLkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:59:08 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-fy5gRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:59:08 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-9TlYpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:59:08 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-1moPLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:59:08 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-6nOgt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:59:08 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-z5PbxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:59:08 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-P6hN2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:59:09 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-D5Zzqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:59:09 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-F5NnoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:59:09 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-BnQLKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:59:09 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-FikzeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:59:09 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-SvF0hu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:59:09 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-sOut2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:59:09 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-k6MvF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:09 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-DDqqKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:59:09 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-4UzsUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:59:09 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-JEeiw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:59:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:59:10 INFO - Running setup.py install for manifestparser 03:59:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:59:10 INFO - Running setup.py install for mozcrash 03:59:10 INFO - Running setup.py install for mozdebug 03:59:10 INFO - Running setup.py install for mozdevice 03:59:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:59:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:59:10 INFO - Running setup.py install for mozfile 03:59:10 INFO - Running setup.py install for mozhttpd 03:59:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:59:10 INFO - Running setup.py install for mozinfo 03:59:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:59:11 INFO - Running setup.py install for mozInstall 03:59:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:59:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:59:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:59:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:59:11 INFO - Running setup.py install for mozleak 03:59:11 INFO - Running setup.py install for mozlog 03:59:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:59:11 INFO - Running setup.py install for moznetwork 03:59:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:59:11 INFO - Running setup.py install for mozprocess 03:59:11 INFO - Running setup.py install for mozprofile 03:59:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:59:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:59:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:59:12 INFO - Running setup.py install for mozrunner 03:59:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:59:12 INFO - Running setup.py install for mozscreenshot 03:59:12 INFO - Running setup.py install for moztest 03:59:12 INFO - Running setup.py install for mozversion 03:59:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:59:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:59:12 INFO - Cleaning up... 03:59:12 INFO - Return code: 0 03:59:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:12 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 0x1104ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97e0584bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102bbd30>, '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 0x1101e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102b0be8>, '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.LCYKuVlWMI/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.j6NcSrKnWt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 03:59:12 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 03:59:12 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 03:59:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LCYKuVlWMI/Render', 03:59:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:12 INFO - 'HOME': '/Users/cltbld', 03:59:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:12 INFO - 'LOGNAME': 'cltbld', 03:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:12 INFO - 'MOZ_NO_REMOTE': '1', 03:59:12 INFO - 'NO_EM_RESTART': '1', 03:59:12 INFO - 'PAGER': '/bin/cat', 03:59:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:12 INFO - 'PWD': '/builds/slave/test', 03:59:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:12 INFO - 'SHELL': '/bin/bash', 03:59:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j6NcSrKnWt/Listeners', 03:59:12 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 03:59:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:12 INFO - 'USER': 'cltbld', 03:59:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:12 INFO - 'XPC_FLAGS': '0x0', 03:59:12 INFO - 'XPC_SERVICE_NAME': '0', 03:59:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:59:12 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-6bR8jN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:59:13 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)) 03:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:59:13 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-kwjaZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:59:13 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)) 03:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:59:13 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-wK4St_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:59:13 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)) 03:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:59:13 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-F0SOPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:59:13 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)) 03:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:59:13 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-NkxOZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:59:13 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)) 03:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:59:13 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-l4Yq3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:59:13 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)) 03:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:59:13 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-d5xw2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:59:13 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)) 03:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:59:13 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-9YypXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:59:13 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)) 03:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:59:13 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-yTAYbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:59:13 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)) 03:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:59:13 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-7t2jGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:59:14 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)) 03:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:59:14 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-9gH9nd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:59:14 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)) 03:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:59:14 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-tQaJdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:59:14 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)) 03:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:59:14 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-n2eHBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:59:14 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)) 03:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:59:14 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-Inlc6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:59:14 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)) 03:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:14 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-aMO3z8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:14 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)) 03:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:59:14 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-LPBkHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:59:14 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)) 03:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:59:14 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-i2NJUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:59:14 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)) 03:59:14 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)) 03:59:14 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)) 03:59:14 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)) 03:59:14 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)) 03:59:14 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)) 03:59:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:59: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 03:59: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 03:59: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 03:59: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 03:59: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 03:59: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 03:59:17 INFO - Downloading blessings-1.6.tar.gz 03:59:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:59:17 INFO - Installing collected packages: blessings 03:59:17 INFO - Running setup.py install for blessings 03:59:17 INFO - Successfully installed blessings 03:59:17 INFO - Cleaning up... 03:59:17 INFO - Return code: 0 03:59:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:59:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:59:17 INFO - Reading from file tmpfile_stdout 03:59:17 INFO - Current package versions: 03:59:17 INFO - blessings == 1.6 03:59:17 INFO - blobuploader == 1.2.4 03:59:17 INFO - docopt == 0.6.1 03:59:17 INFO - functools32 == 3.2.3-2 03:59:17 INFO - jsonschema == 2.5.1 03:59:17 INFO - manifestparser == 1.1 03:59:17 INFO - mozInstall == 1.12 03:59:17 INFO - mozcrash == 1.0 03:59:17 INFO - mozdebug == 0.1 03:59:17 INFO - mozdevice == 0.49 03:59:17 INFO - mozfile == 1.2 03:59:17 INFO - mozhttpd == 0.7 03:59:17 INFO - mozinfo == 0.9 03:59:17 INFO - mozleak == 0.1 03:59:17 INFO - mozlog == 3.4 03:59:17 INFO - moznetwork == 0.27 03:59:17 INFO - mozprocess == 0.25 03:59:17 INFO - mozprofile == 0.28 03:59:17 INFO - mozrunner == 6.13 03:59:17 INFO - mozscreenshot == 0.1 03:59:17 INFO - mozsystemmonitor == 0.3 03:59:17 INFO - moztest == 0.8 03:59:17 INFO - mozversion == 1.4 03:59:17 INFO - psutil == 3.1.1 03:59:17 INFO - requests == 1.2.3 03:59:17 INFO - wsgiref == 0.1.2 03:59:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:59:17 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')]} 03:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:17 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')]} 03:59:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:17 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 0x1104ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97e0584bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102bbd30>, '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 0x1101e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102b0be8>, '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.LCYKuVlWMI/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.j6NcSrKnWt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 03:59:17 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 03:59:17 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 03:59:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LCYKuVlWMI/Render', 03:59:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:17 INFO - 'HOME': '/Users/cltbld', 03:59:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:17 INFO - 'LOGNAME': 'cltbld', 03:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:17 INFO - 'MOZ_NO_REMOTE': '1', 03:59:17 INFO - 'NO_EM_RESTART': '1', 03:59:17 INFO - 'PAGER': '/bin/cat', 03:59:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:17 INFO - 'PWD': '/builds/slave/test', 03:59:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:17 INFO - 'SHELL': '/bin/bash', 03:59:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j6NcSrKnWt/Listeners', 03:59:17 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 03:59:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:17 INFO - 'USER': 'cltbld', 03:59:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:17 INFO - 'XPC_FLAGS': '0x0', 03:59:17 INFO - 'XPC_SERVICE_NAME': '0', 03:59:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:18 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)) 03:59:18 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)) 03:59:18 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)) 03:59:18 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)) 03:59:18 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)) 03:59:18 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)) 03:59:18 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)) 03:59:18 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)) 03:59:18 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)) 03:59:18 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)) 03:59:18 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)) 03:59:18 INFO - Cleaning up... 03:59:18 INFO - Return code: 0 03:59:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1104ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97e0584bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102bbd30>, '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 0x1101e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102b0be8>, '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.LCYKuVlWMI/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.j6NcSrKnWt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 03:59:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:59:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LCYKuVlWMI/Render', 03:59:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:18 INFO - 'HOME': '/Users/cltbld', 03:59:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:18 INFO - 'LOGNAME': 'cltbld', 03:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:18 INFO - 'MOZ_NO_REMOTE': '1', 03:59:18 INFO - 'NO_EM_RESTART': '1', 03:59:18 INFO - 'PAGER': '/bin/cat', 03:59:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:18 INFO - 'PWD': '/builds/slave/test', 03:59:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:18 INFO - 'SHELL': '/bin/bash', 03:59:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j6NcSrKnWt/Listeners', 03:59:18 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 03:59:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:18 INFO - 'USER': 'cltbld', 03:59:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:18 INFO - 'XPC_FLAGS': '0x0', 03:59:18 INFO - 'XPC_SERVICE_NAME': '0', 03:59:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:59:18 INFO - Cleaning up... 03:59:18 INFO - Return code: 0 03:59:18 INFO - Running post-action listener: _resource_record_post_action 03:59:18 INFO - Running post-action listener: _start_resource_monitoring 03:59:18 INFO - Starting resource monitoring. 03:59:18 INFO - [mozharness: 2017-04-03 10:59:18.531320Z] Finished create-virtualenv step (success) 03:59:18 INFO - [mozharness: 2017-04-03 10:59:18.532267Z] Running install step. 03:59:18 INFO - Running pre-action listener: _resource_record_pre_action 03:59:18 INFO - Running main action method: install 03:59:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:59:18 INFO - Reading from file tmpfile_stdout 03:59:18 INFO - Detecting whether we're running mozinstall >=1.0... 03:59:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:59:18 INFO - Reading from file tmpfile_stdout 03:59:18 INFO - Output received: 03:59:18 INFO - Usage: mozinstall [options] installer 03:59:18 INFO - Options: 03:59:18 INFO - -h, --help show this help message and exit 03:59:18 INFO - -d DEST, --destination=DEST 03:59:18 INFO - Directory to install application into. [default: 03:59:18 INFO - "/builds/slave/test"] 03:59:18 INFO - --app=APP Application being installed. [default: firefox] 03:59:18 INFO - mkdir: /builds/slave/test/build/application 03:59:18 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'] 03:59:18 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 03:59:38 INFO - Reading from file tmpfile_stdout 03:59:38 INFO - Output received: 03:59:38 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:59:38 INFO - Running post-action listener: _resource_record_post_action 03:59:38 INFO - [mozharness: 2017-04-03 10:59:38.855229Z] Finished install step (success) 03:59:38 INFO - [mozharness: 2017-04-03 10:59:38.855365Z] Running run-tests step. 03:59:38 INFO - Running pre-action listener: _resource_record_pre_action 03:59:38 INFO - Running main action method: run_tests 03:59:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:59:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:59:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:59:38 INFO - 2017-04-03 03:59:38.870 screenresolution[1623:7614] starting screenresolution argv=screenresolution get 03:59:38 INFO - 2017-04-03 03:59:38.872 screenresolution[1623:7614] Display 0: 1600x1200x32@60 03:59:38 INFO - 2017-04-03 03:59:38.878 screenresolution[1624:7616] starting screenresolution argv=screenresolution list 03:59:38 INFO - Available Modes on Display 0 03:59:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:59:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:59:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:59:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:59:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:59:39 INFO - Intel Iris: 03:59:39 INFO - Chipset Model: Intel Iris 03:59:39 INFO - Type: GPU 03:59:39 INFO - Bus: Built-In 03:59:39 INFO - VRAM (Dynamic, Max): 1536 MB 03:59:39 INFO - Vendor: Intel (0x8086) 03:59:39 INFO - Device ID: 0x0a2e 03:59:39 INFO - Revision ID: 0x0009 03:59:39 INFO - Displays: 03:59:39 INFO - Display: 03:59:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:59:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:59:39 INFO - Display Serial Number: 1600x1200 60 03:59:39 INFO - Main Display: Yes 03:59:39 INFO - Mirror: Off 03:59:39 INFO - Online: Yes 03:59:39 INFO - Rotation: Supported 03:59:39 INFO - Return code: 0 03:59:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:59:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:59:39 INFO - Python 2.7.3 03:59:39 INFO - Return code: 0 03:59:39 INFO - grabbing minidump binary from tooltool 03:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:39 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 0x1102bbd30>, '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 0x1101e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102b0be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:59:39 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 03:59:39 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 03:59:39 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 03:59:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:59:39 INFO - Return code: 0 03:59:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:59:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:59:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:59:39 INFO - ENV: RUST_BACKTRACE is now 1 03:59:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:59:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:59:39 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/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0272', '--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 03:59:39 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/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0272 --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 03:59:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LCYKuVlWMI/Render', 03:59:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:39 INFO - 'HOME': '/Users/cltbld', 03:59:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:39 INFO - 'LOGNAME': 'cltbld', 03:59:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:59:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:39 INFO - 'MOZ_NO_REMOTE': '1', 03:59:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:59:39 INFO - 'NO_EM_RESTART': '1', 03:59:39 INFO - 'PAGER': '/bin/cat', 03:59:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:39 INFO - 'PWD': '/builds/slave/test', 03:59:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:59:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:39 INFO - 'RUST_BACKTRACE': '1', 03:59:39 INFO - 'SHELL': '/bin/bash', 03:59:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j6NcSrKnWt/Listeners', 03:59:39 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 03:59:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:39 INFO - 'USER': 'cltbld', 03:59:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:39 INFO - 'XPC_FLAGS': '0x0', 03:59:39 INFO - 'XPC_SERVICE_NAME': '0', 03:59:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:39 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/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0272', '--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 03:59:39 INFO - mozversion application_buildid: 20170403022922 03:59:39 INFO - mozversion application_changeset: c53411a2c11f43f6ea567fbb38efcf79b08bcf28 03:59:39 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:59:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:59:39 INFO - mozversion application_name: Firefox 03:59:39 INFO - mozversion application_remotingname: firefox-dev 03:59:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:59:39 INFO - mozversion application_vendor: Mozilla 03:59:39 INFO - mozversion application_version: 54.0a2 03:59:39 INFO - mozversion platform_buildid: 20170403022922 03:59:39 INFO - mozversion platform_changeset: c53411a2c11f43f6ea567fbb38efcf79b08bcf28 03:59:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:59:39 INFO - mozversion platform_version: 54.0a2 03:59:39 INFO - using testdate: 1491217179 03:59:39 INFO - actual date: 1491217179 03:59:39 INFO - starting webserver on 'localhost:49247' 03:59:39 INFO - SUITE-START | Running 2 tests 03:59:39 INFO - TEST-START | dromaeo_css 03:59:39 INFO - operating with platform_type : mac_ 03:59:39 INFO - Initialising browser for dromaeo_css test... 03:59:39 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/tmpbEOnEU/profile http://localhost:49247/getInfo.html) 03:59:42 INFO - PROCESS | 1634 | 2017-04-03 03:59:42.243 plugin-container[1635:7784] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b3b, name = 'com.apple.tsm.portname' 03:59:42 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:59:42 INFO - PROCESS | 1634 | 2017-04-03 03:59:42.246 plugin-container[1635:7784] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 03:59:42 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:59:42 INFO - PROCESS | 1634 | 2017-04-03 03:59:42.246 plugin-container[1635:7784] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:59:42 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 03:59:42 INFO - PROCESS | 1634 | colorDepth:24 03:59:42 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 03:59:42 INFO - PROCESS | 1634 | __metrics 03:59:42 ERROR - PROCESS | 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 03:59:43 INFO - TEST-INFO | 1634: exit 0 03:59:43 INFO - Browser initialized. 03:59:43 INFO - Running cycle 1/1 for dromaeo_css test... 03:59:43 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/tmpbEOnEU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:59:45 INFO - PROCESS | 1637 | 2017-04-03 03:59:45.673 plugin-container[1638:7922] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 03:59:45 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:59:45 INFO - PROCESS | 1637 | 2017-04-03 03:59:45.676 plugin-container[1638:7922] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 03:59:45 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:59:45 INFO - PROCESS | 1637 | 2017-04-03 03:59:45.676 plugin-container[1638:7922] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:59:55 INFO - PROCESS | 1637 | RSS: Main: 220794880 03:59:55 INFO - PROCESS | 1637 | 04:02:58 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49247/tests/dromaeo/cssquery-ext.html) 04:03:00 INFO - PROCESS | 1637 | RSS: Main: 238047232 04:03:00 INFO - PROCESS | 1637 | 04:04:43 INFO - PROCESS | 1637 | ************************* 04:04:43 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 04:04:43 INFO - PROCESS | 1637 | 04:04:43 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:04:43 INFO - PROCESS | 1637 | Full stack: 04:04:43 INFO - PROCESS | 1637 | ************************* 04:06:02 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-ext.html (next: http://localhost:49247/tests/dromaeo/cssquery-jquery.html) 04:06:02 INFO - PROCESS | 1637 | RSS: Main: 245415936 04:06:02 INFO - PROCESS | 1637 | 04:09:04 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49247/tests/dromaeo/cssquery-mootools.html) 04:09:05 INFO - PROCESS | 1637 | RSS: Main: 255344640 04:09:05 INFO - PROCESS | 1637 | 04:12:07 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49247/tests/dromaeo/cssquery-prototype.html) 04:12:08 INFO - PROCESS | 1637 | RSS: Main: 252248064 04:12:08 INFO - PROCESS | 1637 | 04:15:11 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49247/tests/dromaeo/cssquery-yui.html) 04:15:12 INFO - PROCESS | 1637 | RSS: Main: 257499136 04:15:12 INFO - PROCESS | 1637 | 04:18:14 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-yui.html (next: http://localhost:49247/tests/dromaeo/cssquery-dojo.html) 04:18:14 INFO - PROCESS | 1637 | RSS: Main: 253657088 04:18:14 INFO - PROCESS | 1637 | 04:18:14 INFO - PROCESS | 1637 | __start_tp_report 04:18:14 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 04:18:14 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 04:18:14 INFO - PROCESS | 1637 | |i|pagename|runs| 04:18:14 INFO - PROCESS | 1637 | |0;dojo.html;2410.4696966667334;2777.916662500125;3445.758796884219;3465.896023119306;3513.0865974846565;6024.915515207261;6073.301570319409;6120.663363515005;6128.662923539209;6137.539684523656;5976.252968378953;6003.369646187142;6099.3290738018895;6130.662813545253;6155.599886007406;4582.977085114587;5511.9724401377935;5512.972435137819;5561.388247292794;5608.2428872102155;5570.2480165177585;5574.331080270353;5576.442355764431;5578.107502799553;5583.5254003409755;4450.599446049855;5369.9463005370035;5374.91937620936;5566.109422492402;5569.443055694439;5557.805476808313;5589.077802162638;5589.776408943638;5619.550435965113;5641.069223578104;5435.2934118564335;5465.617406781527;5516.448355164492;5521.503064724194;5523.475269849358;4763.809447622091;5497.615166938316;5790.276215473066;5816.41835816415;6210.316865144876;6359;6374.776882809079;6451.225852897635;6463.418292353711;6501.382368674968;6536.954087346049;6555;6556;6561.835954101138;6580.473562115019;4885.218365061644;6200.658963756991;6224.688765561704;6240.968795156086;6241.875162496724;6389.840253993594;6587.571807832475;6644.700988455531;6644.900326495106;6652.36802503771;6379.5215358847345;6386.2975072741965;6399.712012959428;6402.519811014193;6405.807825765234;6493.837654058686;6522.804315870531;6555.672216389162;6577.967110164514;6589.967050164719;6278.686065696788;6323.336049714806;6388.712507937061;6429.196350456193;6441.61350318973;6300.936990630126;6469.51478639104;6471.546991710535;6474.902876456857;6494.6752662367635;5024.095662780662;5138.049460849755;5141.691498510101;5194.3766747990485;5212.4266330703595;4645.419322584677;4672.275797251432;4698.694584851974;4699.78850951708;4713.033828065307;4914.164592019365;5949.8215053548465;6113.476306051851;6210.037444196157;6231.189945307172;6476.158099447136;6503.382178693017;6555.115059466911;6562.606243625398;6575.178102737158;4720.716756994591;6185.195924529782;6224.688765561704;6233.252009758858;6268.059791031291;5538.667679939216;5571.860703482364;5697.4302569742695;5747.339056008529;5753.252077229933;5685.545156387562;6640.568363056483;6714.227863795726;6792.184937807495;6813.2846051163915;6501.187351581052;6561.081448597105;6577.572457790228;6579.407853293226;6592.373724496165;5060.544550990428;6392.520560957853;6789.762358317435;6792.01515780219;6817.420519255918;6321.209848768904;6343;6351.333110023381;6452.870942581216;6457.709403076967;6501.902471463027;6506.4469520091325;6518.250401203923;6520.869582608416;6529.575577587441;5481.342238931354;6323.399277068671;6354.23749150105;6359.109724638647;6368.968155159195;6245.094461302995;6281.96859015702;6284.08880712285;6285.842853928689;6359.395857393541;6162.876742465036;6354.205724284465;6364.331745166691;6383.96808015957;6407.006913928349;6215.9378406217165;6230.906536402048;6341.334159913143;6354.809355719336;6387.616742995435;6279.560430769802;6330.335314792064;6358.904616430665;6389.201349831271;6413.967930160319 04:18:14 INFO - PROCESS | 1637 | |1;ext.html;733.5855241788389;801.5911884938681;821.5253619752546;864.2394692670449;866.1381924984642;38283.80858095709;39511.604883951186;41226.58773412269;41264.38103428451;41487.17025659492;35469.581216751365;36144.81927590358;37719.81140094303;37776;37788.622113778925;8732.21410073095;8866.202041816236;8869.246114080312;8878.023417424078;8881.777955551099;7455.4781165318445;8753.518556479423;8807.64769409226;8862.0251772305;8869.866951995726;7258.927410725904;8838.160374764388;8902.020777714479;8902.510361930092;8918.73243802687;8849.469031858109;8855.95572022139;8869.290456763509;8872.689455869046;8878.112188781135;7459.44054195932;8633.65465381384;8649;8694.087120852282;8700.695475658385;33631.99104026883;33775.493367599505;33781.64873405061;33889.474973626246;33910.83044584786;3669.3028324618235;3726.124360775216;3749.1189570450924;3772.2078363543687;3794.867179648699;23004.769952300598;24686.876565617058;24918.252452426455;25130.24609261725;25727.742722572722;2857.18540432945;2884.394277201769;2921.9123426297247;3024.1683537027275;3061.3724186541926;329416.0587591188;330622;330779;331733.34133329423;331872;35668;44445.77777111094;44486.555134448245;44600.776996114815;44612.776936115115;45935;46114.308285375744;46132.07735845264;46138;46236.5376346239;13693.383797728928;14047.227402492961;14070.788938165935;14094.85905140956;14133.5053273137;12137.817932731015;12140.21088629254;12152.5138994441;12155.392230388445;12162.878371216351;9725.416475011521;10156.933521980234;10161.4919254037;10232.181425485944;10276.691699249035;4522.706024108423;4527.864164075083;4567.543245675406;4586.289125185602;4587.17430862448;1083.3229231730168;1108.7616162525096;1115.8772535021142;1144.9542018319341;1147.925384849982;26194.607080893802;26217.213483595522;26339.73660263411;26505;26704.465910681676;1190.5237904837961;1224.1430998301225;1233.8704436034266;1256.7109564799964;1261.7728808814318;13223.47106115764;13646.113002654796;13762.105463144864;13846.861531384557;15011;505346;507512;508291;509148;509343;49668.75165624149;49955.75022124866;50046.499535004914;50163.24755128676;50203.74898125486;1378.9655258618616;1391.0888368119101;1413.2156653057652;1423.985760142406;1424.33056463462;25980;27320.180394588195;27368.452630947668;27383.904643814025;27866.58200126959;42078;42235;42238.366424504275;42281.57718422776;42322;488051;488143;490328;490953;491337;30113.69886301109;30454.086377408712;30517.542236866022;30704.232394190323;30790.53814192744;37440.812795935846;38710.41934371043;38892;38953.610463895;39312;25364.11225607095;27659.723402765714;27924.30189245285;28165.859170704014;28499.715002849705;27345.589816152376;27358.5896211553;27616.585751213344;28147.57778633281;28277.43445131127;31281.374372511968;31851;32570.51144232791;32620.184495387806;32791.836040819646;27359.86320068387;27441.588376174772;27742;28366.14901552957;28471;17975.37086202029;18861.622767544297;22682.52563583362;22948.311550653507;23112.537749245257 04:18:14 INFO - PROCESS | 1637 | |2;jquery.html;404.53680535786526;413.6814652717406;417.1632896305124;431.48868590719997;436.9868903932882;18895.71656425153;20187.394378168643;21323.36029919103;21379.465513362175;21492.355229343146;20659.070341834617;21365.35903922885;21391.786082139173;21428;22006.779932200712;5661.547076233891;6153.353897840718;6465.385788350122;6474.902876456857;6518.967405162967;6180.660063696495;6302.747890084391;6341.239051313849;6399;6418.839529011765;6329.145565348688;6345.873082538346;6356.555041147121;6388.073729309247;6390.93609063908;6174.96912515439;7130.6078165700865;7436.3679087277105;7438.516496427715;7451.7019319227165;7042.225355210922;7207.783766487014;7243.7102515899305;7310.305520975498;7311.122665280201;26047.609285860726;26128.954841806306;26259.949602015895;26351.73648263512;26725.866370668216;2839.403725217707;2942.2938494761315;2952.9114126576237;2958.9408211835644;2966.1546459259225;15772.369105235777;15951.202439878076;16055.438059667855;16351.59121021972;16766.832331676647;2009.698545218229;2061.0596341173605;2078.366098340006;2103.779103194158;2134.3916983659738;146279;149578.50421495756;151341.2432937828;151522;155286.44713552832;21056.894715526632;21979.670304945437;22004.559908801733;22252;22332.776672233394;32413;32539.18652033718;33023;33050.504242436386;33094.50358244628;9941.552630131662;10122.645707400206;10198.439085850201;10400.791984160274;10404.427756473468;8430.114837941928;8492.40553161285;8513.40406171562;8619.310455163572;8639.784005399915;9486.430814151174;9739.366941148803;9840.852387214198;9859.556319965619;9891.60433582663;4138.586141385837;4218.915621687549;4219.303814870512;4220.472440944882;4251.193242871767;902.7923577577194;908.4367692030983;914.6067191107887;921.5852866210232;944.6740874398322;19958.900205498878;20272.695909561367;21652.891735541223;21715.674264886038;21732;776.9223077692186;909.1635695160336;913.712180663089;934.3412893909777;939.3987847777428;10843.67468975932;11166.05088567481;11271.887281127083;11297.435128243555;11300.378479183559;716544;732546;745070;750213;778266;122033.77966220402;150211.2489437546;156748.5138020164;158607;162041;1215.9756804863853;1238.9566365177175;1276.3681977421236;1282.666506708244;1284.3385656386968;18912;19268.362189214073;19655.60688786245;19694.704579431032;19718.40844774659;61226;62454.687726561075;63479.6826015867;63569.682151588946;64476.38809029812;88836;89408;89807.65288520546;90267;91202.54398727964;10393.896061039293;10660.680179594625;10789;10842.728931776768;10969.83545246806;11628;12108.636740897788;12222.266664000188;12297.938510307391;12351.320677362472;9378.812423751624;10459.43108533726;10504.054635082879;10562.207834412604;10800.876934524276;9085.591148398471;9696.981816909405;9785.119339259501;9837.311388203043;9953.452560109263;8853.822923541364;10621.344703441155;10630.52162652698;10770.784584308427;11158.051565617014;11062.446877656246;11217.2147949646;11238.325700457672;11471.885281147082;11501.482433290355;10502.842457362993;10535.4732263385;10649.680509584725;10704.946475267574;10914.56341746353 04:18:14 INFO - PROCESS | 1637 | |3;mootools.html;1315.7302752935648;1498.8426215247405;1536.33937406915;1567.4122204173434;1574.5906064423245;10600.628977985773;11024.834627480574;11205.991460768539;11208.943955280232;11249.437528123592;11173.21787474875;11309.264897781639;11326.377049262288;11332.886671133307;11413.657590272285;2373.537160253747;2419.7822196002357;2421.927342179729;2424.309071914505;2425.9393515162087;2325.6046472099697;2393.282015395383;2411.4212588978608;2413.4931664350506;2417.3956510872194;2325.0469605531352;2375.904963801446;2380.73811880693;2384.0582969726947;2386.4391867911027;2277.8974946127464;2286.8056215221727;2336.6027775278158;2340.566995105902;2349.694539709844;1972.901354932262;1984.682450807864;2363.988180059089;2368.988155059231;2375.3942744600017;11076.612318568812;11077.833832492519;11129.443527823576;11141.610043648514;11155.498002589822;5578.30271216098;5712.542996560265;5865.706714664249;5895.4399332063385;5950.285965684146;3423.24688568517;3613.421852503613;3618.1678214010662;3636.654517820803;3695.4087346024507;1134.9148813838995;1184.0586733546852;1208.5588760102498;1208.7582483503247;1222.541546919905;12780.872191277967;13770.104943178661;13904;15374.385024599003;15451.845481545153;4538.704984176018;4594.264917613166;4731.33761273422;4752.1921273383605;4759.309900064541;11109.83335249972;11219.326840389604;11230.550777968952;11232.045276151619;11255.549778008952;4915.410150781929;5628.183913332544;5720.399358067343;5721.199032135504;5722.799702010409;5176.404713457925;5208.479152084761;5211.166213405837;5267.3152490176035;5289.3652761668845;3831.080540670219;3880.049387899983;3901.43429202764;3963.583823698528;3972.08642012333;1043.1915265669168;1045.717656232813;1049.3179433368218;1053.0206907575875;1060.3372891942536;934.8083642853198;953.4041224234853;958.2382006305004;963.5086106085946;1011.6863772230485;5453.263809385682;6528.543001989815;6618.635975021324;6781.4574834013165;6978.755743548952;998.495759641391;1002.9068315535955;1024.2522958240377;1031.489412740683;1053.5259133390005;4181.456410666594;4274.829006839692;4299.570042995738;4388.4953230378915;4411.360352748833;13294.534691285759;13830.723385532234;13894.861051389558;13931.885449164043;13944.651383715489;13419.329033548283;13559.661008474866;13770.65573360654;13867;13867.583972480841;7835.981322428162;9777.071178238199;10062;10175.694729158136;10335.638252661121;6289.371062893674;6712.966435167793;6727.2263689674355;6800.9118541033195;7045;12268.631941041784;12292.754144917231;12302.507899683913;12438.751224975631;12511.249325040526;9590.328676992543;12376.443060062138;12620.11659183885;12666.113372063866;12905.161164524276;9309.44143351401;9370.906290937004;9469.337146399961;9469.952650236704;9478.146966773023;10200.948995254976;10305.74235644115;10402.427866467417;10404.58381664725;10411.84382234252;8588.957055214934;8708.085651006553;8757.47455152693;8797.428167169113;8802.25180859634;8594.699185528476;8647.610857511552;8667.696630617898;8689.044205137556;8798.692045778624;7051.471139664443;7608.16310205888;7778.805529861799;7848.80377990532;7932.920670793449;4837.95162048375;4994.975025124996;5752;5964.343922168645;6032.819015429369;5028.823991160292;5906.940930590639;5932.644041357532;5999.310079340931;6141.263048434216 04:18:14 INFO - PROCESS | 1637 | |4;prototype.html;359.55056179775283;370.35003568736863;378.07183364839324;379.4308537194209;392.90373858404683;5320.174409022115;5357.598180136491;5433.48381903719;5478.890422191559;5607.915881261774;4681.906361872769;5250.396204436491;5354.759035843386;5392.379876314225;5432.945670543293;3941.1132495188494;4212.957870421287;4305.55763819121;4414.602685758281;4440.644748420127;4400.735955842643;4402.075564131536;4439.245328294198;4451.221036318648;4457;4132.97933510332;4423.4028406165235;4426.313921342181;4445.266531022394;4449.243628583133;3882.7575175943425;3959.722819402643;3999.7600143991453;4423.739234318204;4487.6088412592035;3659.451082337644;3848.749831260959;3876.3216437123674;4023.24988629944;4111.280525907954;4469.793155847935;4611.792469338888;4816.662833601649;5201.271821944931;5235.319408476912;4702.31816386622;4811.583775519385;5002.124203423716;5165.69054787479;5193.428722840485;5428.371488553418;5465.22380226428;5671.404502527216;5708.657480551139;5719.427157531671;3775.848966041355;4120.608542188487;4189.790510474464;4545.454545454533;4572.7713614319155;5266.92099618506;5398.460153984609;5696.695916368496;5865.076272964294;5987.191729116601;3961.8217180226957;4180.24755544005;4419.779011049434;4558.316252562142;4638.907221855544;4083.141800739494;4131.338985762263;4628.421447319085;4698.295255711602;4738.881527961759;4492.607291739506;4638.026014536985;4719.504452032487;4772.8499190534085;5097.46476619957;5040.697558146523;5658.7170641467765;5669.716514174274;5671.319441667027;5712.314522257356;1384.9751184123877;1401.4863946937282;1491.076511300432;1506.2242944883394;1536.792533008052;1066.8851050652088;1095.3646884806792;1124.5670416889557;1130.9247530780945;1201.2432167734446;4691.5308469152815;4766.736814744096;5078.4413714491375;5279.39286982002;5318.494742999409;5352.545033672103;5500.58745594082;5893.2044174035955;5946.8810623787285;5995.760169593167;4654.765712458039;4868.756562171877;5003.974980125076;5126.410462796752;5303.761330740126;2840.2615320016944;2923.187623673336;3002.429538387743;3071.616047994001;3091.90724278272;5580.665160090326;5830.650160990269;5942.732577034044;6078.209832721718;6158.692065396713;5218.399884013311;5237.319148510745;5662.37713851476;5829.970850145807;5965;5219;5543.6396634218645;5746.655200687972;5773.39379365169;6098.420650038239;5629.887402252014;5645.717714114196;5651.463111004448;5786.119511158806;5952.285725712942;4893.437254715754;5476.233327334096;5627.915581266202;5801.245838041028;5803.65178089316;5545.584081193846;5774.364819869895;5909.645421274738;5910.911336329872;6161.6919154041225;3236.4983427568764;3726.7763934164036;4415.205263052681;4548.20406428867;4597.333386658983;5194.363775410734;5770.567207459541;5786.276715410574;5825.135956493881;5897.439743224387;5139;5371.072765342819;5593.412691667317;5775.826725198251;5827;5310.8937821244135;5463.945360546502;5557.555035690831;5643;5653.406392328746;4739.47865734762;4784.904301914012;5544.390117087198;5564.944350556442;5567.24842146305;5170.741462926914;5257.5005374489365;5307.097793375213;5475.972620137033;5679.290088738908;5059.3422855030085;5268.710220937885;5362.356517217959;5519.586031047607;5575.2473416088305 04:18:14 INFO - PROCESS | 1637 | |5;yui.html;694.6769752065288;702.5749421599928;772.3743767548286;821.1919213007839;822.1296550347956;14948.252587370629;15513.689726205497;15938.246792852806;16119.677606447878;16186.595335116614;14913.179775112365;14962.32669529871;15105.244737763123;15117.848821511781;15173.393064277443;925.949072800994;943.5659596585579;967.7483854197889;968.6754937096046;969.3166317745972;889.3774357949429;961.2886464016613;965.4255717847869;966.0194902174263;974.6150270643092;843.582426698785;1001.7295330260825;1007.0885848307294;1012.4735137728377;1018.6332920148741;1005.6580762540772;1007.5415685862952;1007.944563049032;1008.1178968402647;1009.0262896305064;735.91904890462;750.4034292737286;750.9436792240549;753.427395179662;754.0009487429178;16308.266128024268;16614.75077873821;16666.916665416717;16821.411250606292;16835.242414091274;11533.653990380302;13867.306634668226;14013.5095271665;14018.088824226495;14098.859011409857;11700.824487632692;11737.53049878004;11778.175527713063;11828.172027958046;12455.377231138407;3037.5139977603476;3114.937701245962;3138.7018233267804;3230.0632816483194;3230.3216324571868;102610;111363;114188.42905785501;114425;115157;10113.494325283853;10671.253012289066;10721.892781072245;10760.515776789907;10834.783304333869;16625.836191466722;17308.307667693152;21507.13971441156;22249.332520024425;22348;7647.885281720779;7685.23147685227;7741.961290193513;7837.568933708587;7975;4011.659008984269;4088.4276201331836;4292.356146577976;4304.440422745023;4577.130345234395;3496.2483066140903;3535.2399234164777;3549.0594992327055;3554.982225088858;3571.535700358989;609.2536642612853;620.9348018458087;626.4706323157017;627.1564745417406;630.0832289019465;673.6396028125027;686.7527690031585;694.5728377048079;700.5936556797147;718.9748358807417;9423;9641.903580964241;10317.638882639072;10542.367457952547;10611.416372099455;697.8569393274366;700.929907009295;703.7853454696265;707.7558242406361;721.4336745654635;4653.813847446132;5065.56942659878;5080.288759573663;5081.872953176126;5139.434662187156;74257.62871185718;90565;104618;106142.46928765462;109540;74634;77335.61332193416;78722;83483.5825820867;83563.16436835675;60409.69795151084;69483;70034;73605.63197184086;76380;9835.409875407498;10556.524956376828;10632.89367106319;10833.945830270799;11415.200935934405;45681.54318456773;45980.310295346266;47051.82370440629;48404.78988025327;50664.74667626638;67357.66321168363;68515.31484685288;70948;71706.64146679442;72575.27424725896;12593.93703031479;12649.367531623198;12825.159116435792;12842.67893302675;13026.218426894417;13761.105528140639;13874.791878121634;13916.860831391961;14107.788383174055;14122;13632.591022269347;13658.317084145952;13684.863151368758;13802.240876751875;13824.377902994189;13537.932310338385;13722.794158087836;13743.793843092162;14050.297485125908;14234.074785138933;12914.768706330435;13328.933685304959;13455.327233638083;13491.392887319898;13507.257100859548;9453.669121580711;9725.124738773262;9797.853032204664;9874.703758887244;10138.645147419806;8263.380246481418;10311.123554497952;10721.517531711248;11374;11406.543738250377 04:18:14 INFO - PROCESS | 1637 | __end_tp_report 04:18:14 INFO - PROCESS | 1637 | __start_cc_report 04:18:14 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,412 04:18:14 INFO - PROCESS | 1637 | __end_cc_report 04:18:14 INFO - PROCESS | 1637 | __startTimestamp1491218294935__endTimestamp 04:18:14 INFO - PROCESS | 1637 | 04:18:14 INFO - PROCESS | 1637 | ------- Summary: start ------- 04:18:14 INFO - PROCESS | 1637 | Number of tests: 6 04:18:14 INFO - PROCESS | 1637 | 04:18:14 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5974.15 Median:6278.69 stddev:752.15 (12.0%) stddev-sans-first:700.58 04:18:14 INFO - PROCESS | 1637 | Values: 2410.5 2777.9 3445.8 3465.9 3513.1 6024.9 6073.3 6120.7 6128.7 6137.5 5976.3 6003.4 6099.3 6130.7 6155.6 4583.0 5512.0 5513.0 5561.4 5608.2 5570.2 5574.3 5576.4 5578.1 5583.5 4450.6 5369.9 5374.9 5566.1 5569.4 5557.8 5589.1 5589.8 5619.6 5641.1 5435.3 5465.6 5516.4 5521.5 5523.5 4763.8 5497.6 5790.3 5816.4 6210.3 6359.0 6374.8 6451.2 6463.4 6501.4 6537.0 6555.0 6556.0 6561.8 6580.5 4885.2 6200.7 6224.7 6241.0 6241.9 6389.8 6587.6 6644.7 6644.9 6652.4 6379.5 6386.3 6399.7 6402.5 6405.8 6493.8 6522.8 6555.7 6578.0 6590.0 6278.7 6323.3 6388.7 6429.2 6441.6 6300.9 6469.5 6471.5 6474.9 6494.7 5024.1 5138.0 5141.7 5194.4 5212.4 4645.4 4672.3 4698.7 4699.8 4713.0 4914.2 5949.8 6113.5 6210.0 6231.2 6476.2 6503.4 6555.1 6562.6 6575.2 4720.7 6185.2 6224.7 6233.3 6268.1 5538.7 5571.9 5697.4 5747.3 5753.3 5685.5 6640.6 6714.2 6792.2 6813.3 6501.2 6561.1 6577.6 6579.4 6592.4 5060.5 6392.5 6789.8 6792.0 6817.4 6321.2 6343.0 6351.3 6452.9 6457.7 6501.9 6506.4 6518.3 6520.9 6529.6 5481.3 6323.4 6354.2 6359.1 6369.0 6245.1 6282.0 6284.1 6285.8 6359.4 6162.9 6354.2 6364.3 6384.0 6407.0 6215.9 6230.9 6341.3 6354.8 6387.6 6279.6 6330.3 6358.9 6389.2 6414.0 04:18:14 INFO - PROCESS | 1637 | 04:18:14 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:55944.44 Median:33778.57 stddev:120102.43 (355.6%) stddev-sans-first:120367.81 04:18:14 INFO - PROCESS | 1637 | Values: 733.6 801.6 821.5 864.2 866.1 38283.8 39511.6 41226.6 41264.4 41487.2 35469.6 36144.8 37719.8 37776.0 37788.6 8732.2 8866.2 8869.2 8878.0 8881.8 7455.5 8753.5 8807.6 8862.0 8869.9 7258.9 8838.2 8902.0 8902.5 8918.7 8849.5 8856.0 8869.3 8872.7 8878.1 7459.4 8633.7 8649.0 8694.1 8700.7 33632.0 33775.5 33781.6 33889.5 33910.8 3669.3 3726.1 3749.1 3772.2 3794.9 23004.8 24686.9 24918.3 25130.2 25727.7 2857.2 2884.4 2921.9 3024.2 3061.4 329416.1 330622.0 330779.0 331733.3 331872.0 35668.0 44445.8 44486.6 44600.8 44612.8 45935.0 46114.3 46132.1 46138.0 46236.5 13693.4 14047.2 14070.8 14094.9 14133.5 12137.8 12140.2 12152.5 12155.4 12162.9 9725.4 10156.9 10161.5 10232.2 10276.7 4522.7 4527.9 4567.5 4586.3 4587.2 1083.3 1108.8 1115.9 1145.0 1147.9 26194.6 26217.2 26339.7 26505.0 26704.5 1190.5 1224.1 1233.9 1256.7 1261.8 13223.5 13646.1 13762.1 13846.9 15011.0 505346.0 507512.0 508291.0 509148.0 509343.0 49668.8 49955.8 50046.5 50163.2 50203.7 1379.0 1391.1 1413.2 1424.0 1424.3 25980.0 27320.2 27368.5 27383.9 27866.6 42078.0 42235.0 42238.4 42281.6 42322.0 488051.0 488143.0 490328.0 490953.0 491337.0 30113.7 30454.1 30517.5 30704.2 30790.5 37440.8 38710.4 38892.0 38953.6 39312.0 25364.1 27659.7 27924.3 28165.9 28499.7 27345.6 27358.6 27616.6 28147.6 28277.4 31281.4 31851.0 32570.5 32620.2 32791.8 27359.9 27441.6 27742.0 28366.1 28471.0 17975.4 18861.6 22682.5 22948.3 23112.5 04:18:14 INFO - PROCESS | 1637 | 04:18:14 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:42747.46 Median:26538.80 stddev:124189.05 (468.0%) stddev-sans-first:124496.73 04:18:14 INFO - PROCESS | 1637 | Values: 404.5 413.7 417.2 431.5 437.0 18895.7 20187.4 21323.4 21379.5 21492.4 20659.1 21365.4 21391.8 21428.0 22006.8 5661.5 6153.4 6465.4 6474.9 6519.0 6180.7 6302.7 6341.2 6399.0 6418.8 6329.1 6345.9 6356.6 6388.1 6390.9 6175.0 7130.6 7436.4 7438.5 7451.7 7042.2 7207.8 7243.7 7310.3 7311.1 26047.6 26129.0 26259.9 26351.7 26725.9 2839.4 2942.3 2952.9 2958.9 2966.2 15772.4 15951.2 16055.4 16351.6 16766.8 2009.7 2061.1 2078.4 2103.8 2134.4 146279.0 149578.5 151341.2 151522.0 155286.4 21056.9 21979.7 22004.6 22252.0 22332.8 32413.0 32539.2 33023.0 33050.5 33094.5 9941.6 10122.6 10198.4 10400.8 10404.4 8430.1 8492.4 8513.4 8619.3 8639.8 9486.4 9739.4 9840.9 9859.6 9891.6 4138.6 4218.9 4219.3 4220.5 4251.2 902.8 908.4 914.6 921.6 944.7 19958.9 20272.7 21652.9 21715.7 21732.0 776.9 909.2 913.7 934.3 939.4 10843.7 11166.1 11271.9 11297.4 11300.4 716544.0 732546.0 745070.0 750213.0 778266.0 122033.8 150211.2 156748.5 158607.0 162041.0 1216.0 1239.0 1276.4 1282.7 1284.3 18912.0 19268.4 19655.6 19694.7 19718.4 61226.0 62454.7 63479.7 63569.7 64476.4 88836.0 89408.0 89807.7 90267.0 91202.5 10393.9 10660.7 10789.0 10842.7 10969.8 11628.0 12108.6 12222.3 12297.9 12351.3 9378.8 10459.4 10504.1 10562.2 10800.9 9085.6 9697.0 9785.1 9837.3 9953.5 8853.8 10621.3 10630.5 10770.8 11158.1 11062.4 11217.2 11238.3 11471.9 11501.5 10502.8 10535.5 10649.7 10704.9 10914.6 04:18:14 INFO - PROCESS | 1637 | 04:18:14 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:6674.55 Median:2412.46 stddev:4171.16 (172.9%) stddev-sans-first:4163.42 04:18:14 INFO - PROCESS | 1637 | Values: 1315.7 1498.8 1536.3 1567.4 1574.6 10600.6 11024.8 11206.0 11208.9 11249.4 11173.2 11309.3 11326.4 11332.9 11413.7 2373.5 2419.8 2421.9 2424.3 2425.9 2325.6 2393.3 2411.4 2413.5 2417.4 2325.0 2375.9 2380.7 2384.1 2386.4 2277.9 2286.8 2336.6 2340.6 2349.7 1972.9 1984.7 2364.0 2369.0 2375.4 11076.6 11077.8 11129.4 11141.6 11155.5 5578.3 5712.5 5865.7 5895.4 5950.3 3423.2 3613.4 3618.2 3636.7 3695.4 1134.9 1184.1 1208.6 1208.8 1222.5 12780.9 13770.1 13904.0 15374.4 15451.8 4538.7 4594.3 4731.3 4752.2 4759.3 11109.8 11219.3 11230.6 11232.0 11255.5 4915.4 5628.2 5720.4 5721.2 5722.8 5176.4 5208.5 5211.2 5267.3 5289.4 3831.1 3880.0 3901.4 3963.6 3972.1 1043.2 1045.7 1049.3 1053.0 1060.3 934.8 953.4 958.2 963.5 1011.7 5453.3 6528.5 6618.6 6781.5 6978.8 998.5 1002.9 1024.3 1031.5 1053.5 4181.5 4274.8 4299.6 4388.5 4411.4 13294.5 13830.7 13894.9 13931.9 13944.7 13419.3 13559.7 13770.7 13867.0 13867.6 7836.0 9777.1 10062.0 10175.7 10335.6 6289.4 6713.0 6727.2 6800.9 7045.0 12268.6 12292.8 12302.5 12438.8 12511.2 9590.3 12376.4 12620.1 12666.1 12905.2 9309.4 9370.9 9469.3 9470.0 9478.1 10200.9 10305.7 10402.4 10404.6 10411.8 8589.0 8708.1 8757.5 8797.4 8802.3 8594.7 8647.6 8667.7 8689.0 8798.7 7051.5 7608.2 7778.8 7848.8 7932.9 4838.0 4995.0 5752.0 5964.3 6032.8 5028.8 5906.9 5932.6 5999.3 6141.3 04:18:14 INFO - PROCESS | 1637 | 04:18:14 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4695.86 Median:5168.22 stddev:1331.23 (25.8%) stddev-sans-first:1294.57 04:18:14 INFO - PROCESS | 1637 | Values: 359.6 370.4 378.1 379.4 392.9 5320.2 5357.6 5433.5 5478.9 5607.9 4681.9 5250.4 5354.8 5392.4 5432.9 3941.1 4213.0 4305.6 4414.6 4440.6 4400.7 4402.1 4439.2 4451.2 4457.0 4133.0 4423.4 4426.3 4445.3 4449.2 3882.8 3959.7 3999.8 4423.7 4487.6 3659.5 3848.7 3876.3 4023.2 4111.3 4469.8 4611.8 4816.7 5201.3 5235.3 4702.3 4811.6 5002.1 5165.7 5193.4 5428.4 5465.2 5671.4 5708.7 5719.4 3775.8 4120.6 4189.8 4545.5 4572.8 5266.9 5398.5 5696.7 5865.1 5987.2 3961.8 4180.2 4419.8 4558.3 4638.9 4083.1 4131.3 4628.4 4698.3 4738.9 4492.6 4638.0 4719.5 4772.8 5097.5 5040.7 5658.7 5669.7 5671.3 5712.3 1385.0 1401.5 1491.1 1506.2 1536.8 1066.9 1095.4 1124.6 1130.9 1201.2 4691.5 4766.7 5078.4 5279.4 5318.5 5352.5 5500.6 5893.2 5946.9 5995.8 4654.8 4868.8 5004.0 5126.4 5303.8 2840.3 2923.2 3002.4 3071.6 3091.9 5580.7 5830.7 5942.7 6078.2 6158.7 5218.4 5237.3 5662.4 5830.0 5965.0 5219.0 5543.6 5746.7 5773.4 6098.4 5629.9 5645.7 5651.5 5786.1 5952.3 4893.4 5476.2 5627.9 5801.2 5803.7 5545.6 5774.4 5909.6 5910.9 6161.7 3236.5 3726.8 4415.2 4548.2 4597.3 5194.4 5770.6 5786.3 5825.1 5897.4 5139.0 5371.1 5593.4 5775.8 5827.0 5310.9 5463.9 5557.6 5643.0 5653.4 4739.5 4784.9 5544.4 5564.9 5567.2 5170.7 5257.5 5307.1 5476.0 5679.3 5059.3 5268.7 5362.4 5519.6 5575.2 04:18:14 INFO - PROCESS | 1637 | 04:18:14 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:19976.44 Median:3126.82 stddev:28568.35 (913.7%) stddev-sans-first:28611.81 04:18:14 INFO - PROCESS | 1637 | Values: 694.7 702.6 772.4 821.2 822.1 14948.3 15513.7 15938.2 16119.7 16186.6 14913.2 14962.3 15105.2 15117.8 15173.4 925.9 943.6 967.7 968.7 969.3 889.4 961.3 965.4 966.0 974.6 843.6 1001.7 1007.1 1012.5 1018.6 1005.7 1007.5 1007.9 1008.1 1009.0 735.9 750.4 750.9 753.4 754.0 16308.3 16614.8 16666.9 16821.4 16835.2 11533.7 13867.3 14013.5 14018.1 14098.9 11700.8 11737.5 11778.2 11828.2 12455.4 3037.5 3114.9 3138.7 3230.1 3230.3 102610.0 111363.0 114188.4 114425.0 115157.0 10113.5 10671.3 10721.9 10760.5 10834.8 16625.8 17308.3 21507.1 22249.3 22348.0 7647.9 7685.2 7742.0 7837.6 7975.0 4011.7 4088.4 4292.4 4304.4 4577.1 3496.2 3535.2 3549.1 3555.0 3571.5 609.3 620.9 626.5 627.2 630.1 673.6 686.8 694.6 700.6 719.0 9423.0 9641.9 10317.6 10542.4 10611.4 697.9 700.9 703.8 707.8 721.4 4653.8 5065.6 5080.3 5081.9 5139.4 74257.6 90565.0 104618.0 106142.5 109540.0 74634.0 77335.6 78722.0 83483.6 83563.2 60409.7 69483.0 70034.0 73605.6 76380.0 9835.4 10556.5 10632.9 10833.9 11415.2 45681.5 45980.3 47051.8 48404.8 50664.7 67357.7 68515.3 70948.0 71706.6 72575.3 12593.9 12649.4 12825.2 12842.7 13026.2 13761.1 13874.8 13916.9 14107.8 14122.0 13632.6 13658.3 13684.9 13802.2 13824.4 13537.9 13722.8 13743.8 14050.3 14234.1 12914.8 13328.9 13455.3 13491.4 13507.3 9453.7 9725.1 9797.9 9874.7 10138.6 8263.4 10311.1 10721.5 11374.0 11406.5 04:18:14 INFO - PROCESS | 1637 | -------- Summary: end -------- 04:18:14 INFO - PROCESS | 1637 | 04:18:15 INFO - TEST-INFO | 1637: exit 0 04:18:15 INFO - TEST-OK | dromaeo_css | took 1116125ms 04:18:15 INFO - TEST-START | kraken 04:18:15 INFO - operating with platform_type : mac_ 04:18:15 INFO - Initialising browser for kraken test... 04:18:15 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/tmp5EhVFP/profile http://localhost:49247/getInfo.html) 04:18:18 INFO - PROCESS | 1647 | 2017-04-03 04:18:18.351 plugin-container[1648:10385] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a37, name = 'com.apple.tsm.portname' 04:18:18 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:18:18 INFO - PROCESS | 1647 | 2017-04-03 04:18:18.355 plugin-container[1648:10385] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4607, name = 'com.apple.CFPasteboardClient' 04:18:18 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:18:18 INFO - PROCESS | 1647 | 2017-04-03 04:18:18.355 plugin-container[1648:10385] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:18:18 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 04:18:18 INFO - PROCESS | 1647 | colorDepth:24 04:18:18 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 04:18:18 INFO - PROCESS | 1647 | __metrics 04:18:18 ERROR - PROCESS | 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 04:18:19 INFO - TEST-INFO | 1647: exit 0 04:18:19 INFO - Browser initialized. 04:18:19 INFO - Running cycle 1/1 for kraken test... 04:18:19 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/tmp5EhVFP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:18:21 INFO - PROCESS | 1649 | 2017-04-03 04:18:21.707 plugin-container[1650:10511] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x433b, name = 'com.apple.tsm.portname' 04:18:21 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:18:21 INFO - PROCESS | 1649 | 2017-04-03 04:18:21.708 plugin-container[1650:10511] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 04:18:21 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:18:21 INFO - PROCESS | 1649 | 2017-04-03 04:18:21.708 plugin-container[1650:10511] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:18:31 INFO - PROCESS | 1649 | RSS: Main: 220839936 04:18:31 INFO - PROCESS | 1649 | 04:18:34 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection) 04:18:35 INFO - PROCESS | 1649 | RSS: Main: 235134976 04:18:35 INFO - PROCESS | 1649 | 04:18:37 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-dft) 04:18:38 INFO - PROCESS | 1649 | RSS: Main: 243068928 04:18:38 INFO - PROCESS | 1649 | 04:18:41 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-fft) 04:18:42 INFO - PROCESS | 1649 | RSS: Main: 244785152 04:18:42 INFO - PROCESS | 1649 | 04:18:44 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator) 04:18:45 INFO - PROCESS | 1649 | RSS: Main: 247508992 04:18:45 INFO - PROCESS | 1649 | 04:18:47 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:18:47 INFO - PROCESS | 1649 | RSS: Main: 248176640 04:18:47 INFO - PROCESS | 1649 | 04:18:50 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom) 04:18:51 INFO - PROCESS | 1649 | RSS: Main: 252018688 04:18:51 INFO - PROCESS | 1649 | 04:18:54 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate) 04:18:55 INFO - PROCESS | 1649 | RSS: Main: 251662336 04:18:55 INFO - PROCESS | 1649 | 04:18:58 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial) 04:18:59 INFO - PROCESS | 1649 | RSS: Main: 251691008 04:18:59 INFO - PROCESS | 1649 | 04:19:00 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:19:01 INFO - PROCESS | 1649 | RSS: Main: 251244544 04:19:01 INFO - PROCESS | 1649 | 04:19:03 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:19:03 INFO - PROCESS | 1649 | RSS: Main: 251035648 04:19:03 INFO - PROCESS | 1649 | 04:19:06 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:19:06 INFO - PROCESS | 1649 | RSS: Main: 251068416 04:19:06 INFO - PROCESS | 1649 | 04:19:09 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:19:10 INFO - PROCESS | 1649 | RSS: Main: 251527168 04:19:10 INFO - PROCESS | 1649 | 04:19:13 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:19:14 INFO - PROCESS | 1649 | RSS: Main: 251224064 04:19:14 INFO - PROCESS | 1649 | 04:19:15 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49247/tests/kraken/driver.html?testName=ai-astar) 04:19:16 INFO - PROCESS | 1649 | RSS: Main: 253128704 04:19:16 INFO - PROCESS | 1649 | 04:19:16 INFO - PROCESS | 1649 | __start_tp_report 04:19:16 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 04:19:16 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 04:19:16 INFO - PROCESS | 1649 | |i|pagename|runs| 04:19:16 INFO - PROCESS | 1649 | |0;ai-astar;114;121;123;122;123;123;122;123;122;122 04:19:16 INFO - PROCESS | 1649 | |1;audio-beat-detection;142;111;110;144;133;138;111;107;138;141 04:19:16 INFO - PROCESS | 1649 | |2;audio-dft;197;201;187;270;255;203;197;195;243;243 04:19:16 INFO - PROCESS | 1649 | |3;audio-fft;83;62;60;88;62;62;64;76;99;54 04:19:16 INFO - PROCESS | 1649 | |4;audio-oscillator;92;71;72;72;96;69;82;70;73;81 04:19:16 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;89;105;77;119;135;118;89;88;89;89 04:19:16 INFO - PROCESS | 1649 | |6;imaging-darkroom;105;156;114;152;144;98;106;113;101;97 04:19:16 INFO - PROCESS | 1649 | |7;imaging-desaturate;91;94;90;138;147;90;95;92;91;107 04:19:16 INFO - PROCESS | 1649 | |8;json-parse-financial;67;66;68;66;70;70;69;70;69;71 04:19:16 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;57;56;80;95;89;75;56;59;59;58 04:19:16 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;85;90;85;85;86;81;98;105;75;72 04:19:16 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;138;139;138;138;146;138;140;144;179;174 04:19:16 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;168;195;225;150;215;224;214;189;166;152 04:19:16 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;66;66;84;84;61;86;69;72;79;59 04:19:16 INFO - PROCESS | 1649 | __end_tp_report 04:19:16 INFO - PROCESS | 1649 | __start_cc_report 04:19:16 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,1003 04:19:16 INFO - PROCESS | 1649 | __end_cc_report 04:19:16 INFO - PROCESS | 1649 | __startTimestamp1491218356185__endTimestamp 04:19:16 INFO - PROCESS | 1649 | 04:19:16 INFO - PROCESS | 1649 | ------- Summary: start ------- 04:19:16 INFO - PROCESS | 1649 | Number of tests: 14 04:19:16 INFO - PROCESS | 1649 | 04:19:16 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:121.50 Median:122.50 stddev:2.72 (2.2%) stddev-sans-first:0.71 04:19:16 INFO - PROCESS | 1649 | Values: 114.0 121.0 123.0 122.0 123.0 123.0 122.0 123.0 122.0 122.0 04:19:16 INFO - PROCESS | 1649 | 04:19:16 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:127.50 Median:138.00 stddev:15.59 (11.3%) stddev-sans-first:15.62 04:19:16 INFO - PROCESS | 1649 | Values: 142.0 111.0 110.0 144.0 133.0 138.0 111.0 107.0 138.0 141.0 04:19:16 INFO - PROCESS | 1649 | 04:19:16 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:219.10 Median:223.00 stddev:30.18 (13.5%) stddev-sans-first:30.93 04:19:16 INFO - PROCESS | 1649 | Values: 197.0 201.0 187.0 270.0 255.0 203.0 197.0 195.0 243.0 243.0 04:19:16 INFO - PROCESS | 1649 | 04:19:16 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:71.00 Median:70.00 stddev:14.70 (21.0%) stddev-sans-first:14.93 04:19:16 INFO - PROCESS | 1649 | Values: 83.0 62.0 60.0 88.0 62.0 62.0 64.0 76.0 99.0 54.0 04:19:16 INFO - PROCESS | 1649 | 04:19:16 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:77.00 stddev:9.64 (12.5%) stddev-sans-first:8.74 04:19:16 INFO - PROCESS | 1649 | Values: 92.0 71.0 72.0 72.0 96.0 69.0 82.0 70.0 73.0 81.0 04:19:16 INFO - PROCESS | 1649 | 04:19:16 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:99.80 Median:88.50 stddev:18.53 (20.9%) stddev-sans-first:19.24 04:19:16 INFO - PROCESS | 1649 | Values: 89.0 105.0 77.0 119.0 135.0 118.0 89.0 88.0 89.0 89.0 04:19:16 INFO - PROCESS | 1649 | 04:19:16 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:118.60 Median:148.00 stddev:22.99 (15.5%) stddev-sans-first:23.85 04:19:16 INFO - PROCESS | 1649 | Values: 105.0 156.0 114.0 152.0 144.0 98.0 106.0 113.0 101.0 97.0 04:19:16 INFO - PROCESS | 1649 | 04:19:16 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:103.50 Median:91.00 stddev:21.26 (23.4%) stddev-sans-first:22.06 04:19:16 INFO - PROCESS | 1649 | Values: 91.0 94.0 90.0 138.0 147.0 90.0 95.0 92.0 91.0 107.0 04:19:16 INFO - PROCESS | 1649 | 04:19:16 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:68.60 Median:69.50 stddev:1.78 (2.6%) stddev-sans-first:1.79 04:19:16 INFO - PROCESS | 1649 | Values: 67.0 66.0 68.0 66.0 70.0 70.0 69.0 70.0 69.0 71.0 04:19:16 INFO - PROCESS | 1649 | 04:19:16 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:67.00 stddev:15.03 (22.4%) stddev-sans-first:15.36 04:19:16 INFO - PROCESS | 1649 | Values: 57.0 56.0 80.0 95.0 89.0 75.0 56.0 59.0 59.0 58.0 04:19:16 INFO - PROCESS | 1649 | 04:19:16 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:85.00 stddev:9.81 (11.5%) stddev-sans-first:10.39 04:19:16 INFO - PROCESS | 1649 | Values: 85.0 90.0 85.0 85.0 86.0 81.0 98.0 105.0 75.0 72.0 04:19:16 INFO - PROCESS | 1649 | 04:19:16 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:147.40 Median:142.00 stddev:15.63 (11.0%) stddev-sans-first:16.20 04:19:16 INFO - PROCESS | 1649 | Values: 138.0 139.0 138.0 138.0 146.0 138.0 140.0 144.0 179.0 174.0 04:19:16 INFO - PROCESS | 1649 | 04:19:16 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.80 Median:204.50 stddev:29.27 (14.3%) stddev-sans-first:29.97 04:19:16 INFO - PROCESS | 1649 | Values: 168.0 195.0 225.0 150.0 215.0 224.0 214.0 189.0 166.0 152.0 04:19:16 INFO - PROCESS | 1649 | 04:19:16 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:75.50 stddev:10.00 (13.2%) stddev-sans-first:10.32 04:19:16 INFO - PROCESS | 1649 | Values: 66.0 66.0 84.0 84.0 61.0 86.0 69.0 72.0 79.0 59.0 04:19:16 INFO - PROCESS | 1649 | -------- Summary: end -------- 04:19:16 INFO - PROCESS | 1649 | 04:19:17 INFO - TEST-INFO | 1649: exit 0 04:19:17 INFO - TEST-OK | kraken | took 61680ms 04:19:17 INFO - SUITE-END | took 1177s 04:19:17 INFO - Completed test suite (00:19:37) 04:19:17 INFO - javascript benchmark 04:19:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7614.643595279952, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2410.4696966667334, 2777.916662500125, 3445.758796884219, 3465.896023119306, 3513.0865974846565, 6024.915515207261, 6073.301570319409, 6120.663363515005, 6128.662923539209, 6137.539684523656, 5976.252968378953, 6003.369646187142, 6099.3290738018895, 6130.662813545253, 6155.599886007406, 4582.977085114587, 5511.9724401377935, 5512.972435137819, 5561.388247292794, 5608.2428872102155, 5570.2480165177585, 5574.331080270353, 5576.442355764431, 5578.107502799553, 5583.5254003409755, 4450.599446049855, 5369.9463005370035, 5374.91937620936, 5566.109422492402, 5569.443055694439, 5557.805476808313, 5589.077802162638, 5589.776408943638, 5619.550435965113, 5641.069223578104, 5435.2934118564335, 5465.617406781527, 5516.448355164492, 5521.503064724194, 5523.475269849358, 4763.809447622091, 5497.615166938316, 5790.276215473066, 5816.41835816415, 6210.316865144876, 6359.0, 6374.776882809079, 6451.225852897635, 6463.418292353711, 6501.382368674968, 6536.954087346049, 6555.0, 6556.0, 6561.835954101138, 6580.473562115019, 4885.218365061644, 6200.658963756991, 6224.688765561704, 6240.968795156086, 6241.875162496724, 6389.840253993594, 6587.571807832475, 6644.700988455531, 6644.900326495106, 6652.36802503771, 6379.5215358847345, 6386.2975072741965, 6399.712012959428, 6402.519811014193, 6405.807825765234, 6493.837654058686, 6522.804315870531, 6555.672216389162, 6577.967110164514, 6589.967050164719, 6278.686065696788, 6323.336049714806, 6388.712507937061, 6429.196350456193, 6441.61350318973, 6300.936990630126, 6469.51478639104, 6471.546991710535, 6474.902876456857, 6494.6752662367635, 5024.095662780662, 5138.049460849755, 5141.691498510101, 5194.3766747990485, 5212.4266330703595, 4645.419322584677, 4672.275797251432, 4698.694584851974, 4699.78850951708, 4713.033828065307, 4914.164592019365, 5949.8215053548465, 6113.476306051851, 6210.037444196157, 6231.189945307172, 6476.158099447136, 6503.382178693017, 6555.115059466911, 6562.606243625398, 6575.178102737158, 4720.716756994591, 6185.195924529782, 6224.688765561704, 6233.252009758858, 6268.059791031291, 5538.667679939216, 5571.860703482364, 5697.4302569742695, 5747.339056008529, 5753.252077229933, 5685.545156387562, 6640.568363056483, 6714.227863795726, 6792.184937807495, 6813.2846051163915, 6501.187351581052, 6561.081448597105, 6577.572457790228, 6579.407853293226, 6592.373724496165, 5060.544550990428, 6392.520560957853, 6789.762358317435, 6792.01515780219, 6817.420519255918, 6321.209848768904, 6343.0, 6351.333110023381, 6452.870942581216, 6457.709403076967, 6501.902471463027, 6506.4469520091325, 6518.250401203923, 6520.869582608416, 6529.575577587441, 5481.342238931354, 6323.399277068671, 6354.23749150105, 6359.109724638647, 6368.968155159195, 6245.094461302995, 6281.96859015702, 6284.08880712285, 6285.842853928689, 6359.395857393541, 6162.876742465036, 6354.205724284465, 6364.331745166691, 6383.96808015957, 6407.006913928349, 6215.9378406217165, 6230.906536402048, 6341.334159913143, 6354.809355719336, 6387.616742995435, 6279.560430769802, 6330.335314792064, 6358.904616430665, 6389.201349831271, 6413.967930160319], "value": 5922.542430451422, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.5855241788389, 801.5911884938681, 821.5253619752546, 864.2394692670449, 866.1381924984642, 38283.80858095709, 39511.604883951186, 41226.58773412269, 41264.38103428451, 41487.17025659492, 35469.581216751365, 36144.81927590358, 37719.81140094303, 37776.0, 37788.622113778925, 8732.21410073095, 8866.202041816236, 8869.246114080312, 8878.023417424078, 8881.777955551099, 7455.4781165318445, 8753.518556479423, 8807.64769409226, 8862.0251772305, 8869.866951995726, 7258.927410725904, 8838.160374764388, 8902.020777714479, 8902.510361930092, 8918.73243802687, 8849.469031858109, 8855.95572022139, 8869.290456763509, 8872.689455869046, 8878.112188781135, 7459.44054195932, 8633.65465381384, 8649.0, 8694.087120852282, 8700.695475658385, 33631.99104026883, 33775.493367599505, 33781.64873405061, 33889.474973626246, 33910.83044584786, 3669.3028324618235, 3726.124360775216, 3749.1189570450924, 3772.2078363543687, 3794.867179648699, 23004.769952300598, 24686.876565617058, 24918.252452426455, 25130.24609261725, 25727.742722572722, 2857.18540432945, 2884.394277201769, 2921.9123426297247, 3024.1683537027275, 3061.3724186541926, 329416.0587591188, 330622.0, 330779.0, 331733.34133329423, 331872.0, 35668.0, 44445.77777111094, 44486.555134448245, 44600.776996114815, 44612.776936115115, 45935.0, 46114.308285375744, 46132.07735845264, 46138.0, 46236.5376346239, 13693.383797728928, 14047.227402492961, 14070.788938165935, 14094.85905140956, 14133.5053273137, 12137.817932731015, 12140.21088629254, 12152.5138994441, 12155.392230388445, 12162.878371216351, 9725.416475011521, 10156.933521980234, 10161.4919254037, 10232.181425485944, 10276.691699249035, 4522.706024108423, 4527.864164075083, 4567.543245675406, 4586.289125185602, 4587.17430862448, 1083.3229231730168, 1108.7616162525096, 1115.8772535021142, 1144.9542018319341, 1147.925384849982, 26194.607080893802, 26217.213483595522, 26339.73660263411, 26505.0, 26704.465910681676, 1190.5237904837961, 1224.1430998301225, 1233.8704436034266, 1256.7109564799964, 1261.7728808814318, 13223.47106115764, 13646.113002654796, 13762.105463144864, 13846.861531384557, 15011.0, 505346.0, 507512.0, 508291.0, 509148.0, 509343.0, 49668.75165624149, 49955.75022124866, 50046.499535004914, 50163.24755128676, 50203.74898125486, 1378.9655258618616, 1391.0888368119101, 1413.2156653057652, 1423.985760142406, 1424.33056463462, 25980.0, 27320.180394588195, 27368.452630947668, 27383.904643814025, 27866.58200126959, 42078.0, 42235.0, 42238.366424504275, 42281.57718422776, 42322.0, 488051.0, 488143.0, 490328.0, 490953.0, 491337.0, 30113.69886301109, 30454.086377408712, 30517.542236866022, 30704.232394190323, 30790.53814192744, 37440.812795935846, 38710.41934371043, 38892.0, 38953.610463895, 39312.0, 25364.11225607095, 27659.723402765714, 27924.30189245285, 28165.859170704014, 28499.715002849705, 27345.589816152376, 27358.5896211553, 27616.585751213344, 28147.57778633281, 28277.43445131127, 31281.374372511968, 31851.0, 32570.51144232791, 32620.184495387806, 32791.836040819646, 27359.86320068387, 27441.588376174772, 27742.0, 28366.14901552957, 28471.0, 17975.37086202029, 18861.622767544297, 22682.52563583362, 22948.311550653507, 23112.537749245257], "value": 17429.88270133495, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.53680535786526, 413.6814652717406, 417.1632896305124, 431.48868590719997, 436.9868903932882, 18895.71656425153, 20187.394378168643, 21323.36029919103, 21379.465513362175, 21492.355229343146, 20659.070341834617, 21365.35903922885, 21391.786082139173, 21428.0, 22006.779932200712, 5661.547076233891, 6153.353897840718, 6465.385788350122, 6474.902876456857, 6518.967405162967, 6180.660063696495, 6302.747890084391, 6341.239051313849, 6399.0, 6418.839529011765, 6329.145565348688, 6345.873082538346, 6356.555041147121, 6388.073729309247, 6390.93609063908, 6174.96912515439, 7130.6078165700865, 7436.3679087277105, 7438.516496427715, 7451.7019319227165, 7042.225355210922, 7207.783766487014, 7243.7102515899305, 7310.305520975498, 7311.122665280201, 26047.609285860726, 26128.954841806306, 26259.949602015895, 26351.73648263512, 26725.866370668216, 2839.403725217707, 2942.2938494761315, 2952.9114126576237, 2958.9408211835644, 2966.1546459259225, 15772.369105235777, 15951.202439878076, 16055.438059667855, 16351.59121021972, 16766.832331676647, 2009.698545218229, 2061.0596341173605, 2078.366098340006, 2103.779103194158, 2134.3916983659738, 146279.0, 149578.50421495756, 151341.2432937828, 151522.0, 155286.44713552832, 21056.894715526632, 21979.670304945437, 22004.559908801733, 22252.0, 22332.776672233394, 32413.0, 32539.18652033718, 33023.0, 33050.504242436386, 33094.50358244628, 9941.552630131662, 10122.645707400206, 10198.439085850201, 10400.791984160274, 10404.427756473468, 8430.114837941928, 8492.40553161285, 8513.40406171562, 8619.310455163572, 8639.784005399915, 9486.430814151174, 9739.366941148803, 9840.852387214198, 9859.556319965619, 9891.60433582663, 4138.586141385837, 4218.915621687549, 4219.303814870512, 4220.472440944882, 4251.193242871767, 902.7923577577194, 908.4367692030983, 914.6067191107887, 921.5852866210232, 944.6740874398322, 19958.900205498878, 20272.695909561367, 21652.891735541223, 21715.674264886038, 21732.0, 776.9223077692186, 909.1635695160336, 913.712180663089, 934.3412893909777, 939.3987847777428, 10843.67468975932, 11166.05088567481, 11271.887281127083, 11297.435128243555, 11300.378479183559, 716544.0, 732546.0, 745070.0, 750213.0, 778266.0, 122033.77966220402, 150211.2489437546, 156748.5138020164, 158607.0, 162041.0, 1215.9756804863853, 1238.9566365177175, 1276.3681977421236, 1282.666506708244, 1284.3385656386968, 18912.0, 19268.362189214073, 19655.60688786245, 19694.704579431032, 19718.40844774659, 61226.0, 62454.687726561075, 63479.6826015867, 63569.682151588946, 64476.38809029812, 88836.0, 89408.0, 89807.65288520546, 90267.0, 91202.54398727964, 10393.896061039293, 10660.680179594625, 10789.0, 10842.728931776768, 10969.83545246806, 11628.0, 12108.636740897788, 12222.266664000188, 12297.938510307391, 12351.320677362472, 9378.812423751624, 10459.43108533726, 10504.054635082879, 10562.207834412604, 10800.876934524276, 9085.591148398471, 9696.981816909405, 9785.119339259501, 9837.311388203043, 9953.452560109263, 8853.822923541364, 10621.344703441155, 10630.52162652698, 10770.784584308427, 11158.051565617014, 11062.446877656246, 11217.2147949646, 11238.325700457672, 11471.885281147082, 11501.482433290355, 10502.842457362993, 10535.4732263385, 10649.680509584725, 10704.946475267574, 10914.56341746353], "value": 11420.74425610879, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1315.7302752935648, 1498.8426215247405, 1536.33937406915, 1567.4122204173434, 1574.5906064423245, 10600.628977985773, 11024.834627480574, 11205.991460768539, 11208.943955280232, 11249.437528123592, 11173.21787474875, 11309.264897781639, 11326.377049262288, 11332.886671133307, 11413.657590272285, 2373.537160253747, 2419.7822196002357, 2421.927342179729, 2424.309071914505, 2425.9393515162087, 2325.6046472099697, 2393.282015395383, 2411.4212588978608, 2413.4931664350506, 2417.3956510872194, 2325.0469605531352, 2375.904963801446, 2380.73811880693, 2384.0582969726947, 2386.4391867911027, 2277.8974946127464, 2286.8056215221727, 2336.6027775278158, 2340.566995105902, 2349.694539709844, 1972.901354932262, 1984.682450807864, 2363.988180059089, 2368.988155059231, 2375.3942744600017, 11076.612318568812, 11077.833832492519, 11129.443527823576, 11141.610043648514, 11155.498002589822, 5578.30271216098, 5712.542996560265, 5865.706714664249, 5895.4399332063385, 5950.285965684146, 3423.24688568517, 3613.421852503613, 3618.1678214010662, 3636.654517820803, 3695.4087346024507, 1134.9148813838995, 1184.0586733546852, 1208.5588760102498, 1208.7582483503247, 1222.541546919905, 12780.872191277967, 13770.104943178661, 13904.0, 15374.385024599003, 15451.845481545153, 4538.704984176018, 4594.264917613166, 4731.33761273422, 4752.1921273383605, 4759.309900064541, 11109.83335249972, 11219.326840389604, 11230.550777968952, 11232.045276151619, 11255.549778008952, 4915.410150781929, 5628.183913332544, 5720.399358067343, 5721.199032135504, 5722.799702010409, 5176.404713457925, 5208.479152084761, 5211.166213405837, 5267.3152490176035, 5289.3652761668845, 3831.080540670219, 3880.049387899983, 3901.43429202764, 3963.583823698528, 3972.08642012333, 1043.1915265669168, 1045.717656232813, 1049.3179433368218, 1053.0206907575875, 1060.3372891942536, 934.8083642853198, 953.4041224234853, 958.2382006305004, 963.5086106085946, 1011.6863772230485, 5453.263809385682, 6528.543001989815, 6618.635975021324, 6781.4574834013165, 6978.755743548952, 998.495759641391, 1002.9068315535955, 1024.2522958240377, 1031.489412740683, 1053.5259133390005, 4181.456410666594, 4274.829006839692, 4299.570042995738, 4388.4953230378915, 4411.360352748833, 13294.534691285759, 13830.723385532234, 13894.861051389558, 13931.885449164043, 13944.651383715489, 13419.329033548283, 13559.661008474866, 13770.65573360654, 13867.0, 13867.583972480841, 7835.981322428162, 9777.071178238199, 10062.0, 10175.694729158136, 10335.638252661121, 6289.371062893674, 6712.966435167793, 6727.2263689674355, 6800.9118541033195, 7045.0, 12268.631941041784, 12292.754144917231, 12302.507899683913, 12438.751224975631, 12511.249325040526, 9590.328676992543, 12376.443060062138, 12620.11659183885, 12666.113372063866, 12905.161164524276, 9309.44143351401, 9370.906290937004, 9469.337146399961, 9469.952650236704, 9478.146966773023, 10200.948995254976, 10305.74235644115, 10402.427866467417, 10404.58381664725, 10411.84382234252, 8588.957055214934, 8708.085651006553, 8757.47455152693, 8797.428167169113, 8802.25180859634, 8594.699185528476, 8647.610857511552, 8667.696630617898, 8689.044205137556, 8798.692045778624, 7051.471139664443, 7608.16310205888, 7778.805529861799, 7848.80377990532, 7932.920670793449, 4837.95162048375, 4994.975025124996, 5752.0, 5964.343922168645, 6032.819015429369, 5028.823991160292, 5906.940930590639, 5932.644041357532, 5999.310079340931, 6141.263048434216], "value": 5098.12338113969, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.55056179775283, 370.35003568736863, 378.07183364839324, 379.4308537194209, 392.90373858404683, 5320.174409022115, 5357.598180136491, 5433.48381903719, 5478.890422191559, 5607.915881261774, 4681.906361872769, 5250.396204436491, 5354.759035843386, 5392.379876314225, 5432.945670543293, 3941.1132495188494, 4212.957870421287, 4305.55763819121, 4414.602685758281, 4440.644748420127, 4400.735955842643, 4402.075564131536, 4439.245328294198, 4451.221036318648, 4457.0, 4132.97933510332, 4423.4028406165235, 4426.313921342181, 4445.266531022394, 4449.243628583133, 3882.7575175943425, 3959.722819402643, 3999.7600143991453, 4423.739234318204, 4487.6088412592035, 3659.451082337644, 3848.749831260959, 3876.3216437123674, 4023.24988629944, 4111.280525907954, 4469.793155847935, 4611.792469338888, 4816.662833601649, 5201.271821944931, 5235.319408476912, 4702.31816386622, 4811.583775519385, 5002.124203423716, 5165.69054787479, 5193.428722840485, 5428.371488553418, 5465.22380226428, 5671.404502527216, 5708.657480551139, 5719.427157531671, 3775.848966041355, 4120.608542188487, 4189.790510474464, 4545.454545454533, 4572.7713614319155, 5266.92099618506, 5398.460153984609, 5696.695916368496, 5865.076272964294, 5987.191729116601, 3961.8217180226957, 4180.24755544005, 4419.779011049434, 4558.316252562142, 4638.907221855544, 4083.141800739494, 4131.338985762263, 4628.421447319085, 4698.295255711602, 4738.881527961759, 4492.607291739506, 4638.026014536985, 4719.504452032487, 4772.8499190534085, 5097.46476619957, 5040.697558146523, 5658.7170641467765, 5669.716514174274, 5671.319441667027, 5712.314522257356, 1384.9751184123877, 1401.4863946937282, 1491.076511300432, 1506.2242944883394, 1536.792533008052, 1066.8851050652088, 1095.3646884806792, 1124.5670416889557, 1130.9247530780945, 1201.2432167734446, 4691.5308469152815, 4766.736814744096, 5078.4413714491375, 5279.39286982002, 5318.494742999409, 5352.545033672103, 5500.58745594082, 5893.2044174035955, 5946.8810623787285, 5995.760169593167, 4654.765712458039, 4868.756562171877, 5003.974980125076, 5126.410462796752, 5303.761330740126, 2840.2615320016944, 2923.187623673336, 3002.429538387743, 3071.616047994001, 3091.90724278272, 5580.665160090326, 5830.650160990269, 5942.732577034044, 6078.209832721718, 6158.692065396713, 5218.399884013311, 5237.319148510745, 5662.37713851476, 5829.970850145807, 5965.0, 5219.0, 5543.6396634218645, 5746.655200687972, 5773.39379365169, 6098.420650038239, 5629.887402252014, 5645.717714114196, 5651.463111004448, 5786.119511158806, 5952.285725712942, 4893.437254715754, 5476.233327334096, 5627.915581266202, 5801.245838041028, 5803.65178089316, 5545.584081193846, 5774.364819869895, 5909.645421274738, 5910.911336329872, 6161.6919154041225, 3236.4983427568764, 3726.7763934164036, 4415.205263052681, 4548.20406428867, 4597.333386658983, 5194.363775410734, 5770.567207459541, 5786.276715410574, 5825.135956493881, 5897.439743224387, 5139.0, 5371.072765342819, 5593.412691667317, 5775.826725198251, 5827.0, 5310.8937821244135, 5463.945360546502, 5557.555035690831, 5643.0, 5653.406392328746, 4739.47865734762, 4784.904301914012, 5544.390117087198, 5564.944350556442, 5567.24842146305, 5170.741462926914, 5257.5005374489365, 5307.097793375213, 5475.972620137033, 5679.290088738908, 5059.3422855030085, 5268.710220937885, 5362.356517217959, 5519.586031047607, 5575.2473416088305], "value": 4298.783393054064, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.6769752065288, 702.5749421599928, 772.3743767548286, 821.1919213007839, 822.1296550347956, 14948.252587370629, 15513.689726205497, 15938.246792852806, 16119.677606447878, 16186.595335116614, 14913.179775112365, 14962.32669529871, 15105.244737763123, 15117.848821511781, 15173.393064277443, 925.949072800994, 943.5659596585579, 967.7483854197889, 968.6754937096046, 969.3166317745972, 889.3774357949429, 961.2886464016613, 965.4255717847869, 966.0194902174263, 974.6150270643092, 843.582426698785, 1001.7295330260825, 1007.0885848307294, 1012.4735137728377, 1018.6332920148741, 1005.6580762540772, 1007.5415685862952, 1007.944563049032, 1008.1178968402647, 1009.0262896305064, 735.91904890462, 750.4034292737286, 750.9436792240549, 753.427395179662, 754.0009487429178, 16308.266128024268, 16614.75077873821, 16666.916665416717, 16821.411250606292, 16835.242414091274, 11533.653990380302, 13867.306634668226, 14013.5095271665, 14018.088824226495, 14098.859011409857, 11700.824487632692, 11737.53049878004, 11778.175527713063, 11828.172027958046, 12455.377231138407, 3037.5139977603476, 3114.937701245962, 3138.7018233267804, 3230.0632816483194, 3230.3216324571868, 102610.0, 111363.0, 114188.42905785501, 114425.0, 115157.0, 10113.494325283853, 10671.253012289066, 10721.892781072245, 10760.515776789907, 10834.783304333869, 16625.836191466722, 17308.307667693152, 21507.13971441156, 22249.332520024425, 22348.0, 7647.885281720779, 7685.23147685227, 7741.961290193513, 7837.568933708587, 7975.0, 4011.659008984269, 4088.4276201331836, 4292.356146577976, 4304.440422745023, 4577.130345234395, 3496.2483066140903, 3535.2399234164777, 3549.0594992327055, 3554.982225088858, 3571.535700358989, 609.2536642612853, 620.9348018458087, 626.4706323157017, 627.1564745417406, 630.0832289019465, 673.6396028125027, 686.7527690031585, 694.5728377048079, 700.5936556797147, 718.9748358807417, 9423.0, 9641.903580964241, 10317.638882639072, 10542.367457952547, 10611.416372099455, 697.8569393274366, 700.929907009295, 703.7853454696265, 707.7558242406361, 721.4336745654635, 4653.813847446132, 5065.56942659878, 5080.288759573663, 5081.872953176126, 5139.434662187156, 74257.62871185718, 90565.0, 104618.0, 106142.46928765462, 109540.0, 74634.0, 77335.61332193416, 78722.0, 83483.5825820867, 83563.16436835675, 60409.69795151084, 69483.0, 70034.0, 73605.63197184086, 76380.0, 9835.409875407498, 10556.524956376828, 10632.89367106319, 10833.945830270799, 11415.200935934405, 45681.54318456773, 45980.310295346266, 47051.82370440629, 48404.78988025327, 50664.74667626638, 67357.66321168363, 68515.31484685288, 70948.0, 71706.64146679442, 72575.27424725896, 12593.93703031479, 12649.367531623198, 12825.159116435792, 12842.67893302675, 13026.218426894417, 13761.105528140639, 13874.791878121634, 13916.860831391961, 14107.788383174055, 14122.0, 13632.591022269347, 13658.317084145952, 13684.863151368758, 13802.240876751875, 13824.377902994189, 13537.932310338385, 13722.794158087836, 13743.793843092162, 14050.297485125908, 14234.074785138933, 12914.768706330435, 13328.933685304959, 13455.327233638083, 13491.392887319898, 13507.257100859548, 9453.669121580711, 9725.124738773262, 9797.853032204664, 9874.703758887244, 10138.645147419806, 8263.380246481418, 10311.123554497952, 10721.517531711248, 11374.0, 11406.543738250377], "value": 7544.0870291041965, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1571.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 121.0, 123.0, 122.0, 123.0, 123.0, 122.0, 123.0, 122.0, 122.0], "value": 121.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 111.0, 110.0, 144.0, 133.0, 138.0, 111.0, 107.0, 138.0, 141.0], "value": 127.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 201.0, 187.0, 270.0, 255.0, 203.0, 197.0, 195.0, 243.0, 243.0], "value": 219.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 62.0, 60.0, 88.0, 62.0, 62.0, 64.0, 76.0, 99.0, 54.0], "value": 71.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 71.0, 72.0, 72.0, 96.0, 69.0, 82.0, 70.0, 73.0, 81.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 105.0, 77.0, 119.0, 135.0, 118.0, 89.0, 88.0, 89.0, 89.0], "value": 99.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 156.0, 114.0, 152.0, 144.0, 98.0, 106.0, 113.0, 101.0, 97.0], "value": 118.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 94.0, 90.0, 138.0, 147.0, 90.0, 95.0, 92.0, 91.0, 107.0], "value": 103.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 66.0, 70.0, 70.0, 69.0, 70.0, 69.0, 71.0], "value": 68.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 80.0, 95.0, 89.0, 75.0, 56.0, 59.0, 59.0, 58.0], "value": 68.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 90.0, 85.0, 85.0, 86.0, 81.0, 98.0, 105.0, 75.0, 72.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 139.0, 138.0, 138.0, 146.0, 138.0, 140.0, 144.0, 179.0, 174.0], "value": 147.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 195.0, 225.0, 150.0, 215.0, 224.0, 214.0, 189.0, 166.0, 152.0], "value": 189.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 84.0, 84.0, 61.0, 86.0, 69.0, 72.0, 79.0, 59.0], "value": 72.6, "unit": "score"}]}]} 04:19:17 INFO - Return code: 0 04:19:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:19:17 ERROR - # TBPL SUCCESS # 04:19:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:19:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:19:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:19:17 INFO - 2017-04-03 04:19:17.516 screenresolution[1654:10901] starting screenresolution argv=screenresolution get 04:19:17 INFO - 2017-04-03 04:19:17.518 screenresolution[1654:10901] Display 0: 1600x1200x32@60 04:19:17 INFO - 2017-04-03 04:19:17.525 screenresolution[1655:10904] starting screenresolution argv=screenresolution list 04:19:17 INFO - Available Modes on Display 0 04:19:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:19:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:19:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:19:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:19:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:19:17 INFO - Intel Iris: 04:19:17 INFO - Chipset Model: Intel Iris 04:19:17 INFO - Type: GPU 04:19:17 INFO - Bus: Built-In 04:19:17 INFO - VRAM (Dynamic, Max): 1536 MB 04:19:17 INFO - Vendor: Intel (0x8086) 04:19:17 INFO - Device ID: 0x0a2e 04:19:17 INFO - Revision ID: 0x0009 04:19:17 INFO - Displays: 04:19:17 INFO - Display: 04:19:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:19:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:19:17 INFO - Display Serial Number: 1600x1200 60 04:19:17 INFO - Main Display: Yes 04:19:17 INFO - Mirror: Off 04:19:17 INFO - Online: Yes 04:19:17 INFO - Rotation: Supported 04:19:17 INFO - Return code: 0 04:19:17 INFO - Running post-action listener: _resource_record_post_action 04:19:17 INFO - [mozharness: 2017-04-03 11:19:17.774619Z] Finished run-tests step (success) 04:19:17 INFO - Running post-run listener: _resource_record_post_run 04:19:17 INFO - Total resource usage - Wall time: 1198s; CPU: 55.0%; Read bytes: 37358080; Write bytes: 510197760; Read time: 240; Write time: 1591 04:19:17 INFO - TinderboxPrint: CPU usage
54.7% 04:19:17 INFO - TinderboxPrint: I/O read bytes / time
37,358,080 / 240 04:19:17 INFO - TinderboxPrint: I/O write bytes / time
510,197,760 / 1,591 04:19:17 INFO - TinderboxPrint: CPU idle
2,172.2 (45.3%) 04:19:17 INFO - TinderboxPrint: CPU system
963.6 (20.1%) 04:19:17 INFO - TinderboxPrint: CPU user
1,657.9 (34.6%) 04:19:17 INFO - TinderboxPrint: Swap in / out
245,547,008 / 0 04:19:17 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205888000; Write bytes: 202508288; Read time: 15705; Write time: 416 04:19:17 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 35252736; Write bytes: 296634368; Read time: 219; Write time: 1137 04:19:18 INFO - Running post-run listener: _upload_blobber_files 04:19:18 INFO - Blob upload gear active. 04:19:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:19:18 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 04:19:18 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'] 04:19:18 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 04:19:19 INFO - (blobuploader) - INFO - Open directory for files ... 04:19:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:19:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:19:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:22 INFO - (blobuploader) - INFO - Done attempting. 04:19:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:19:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:19:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:24 INFO - (blobuploader) - INFO - Done attempting. 04:19:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:19:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:19:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:27 INFO - (blobuploader) - INFO - Done attempting. 04:19:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:19:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:19:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:30 INFO - (blobuploader) - INFO - Done attempting. 04:19:30 INFO - (blobuploader) - INFO - Iteration through files over. 04:19:30 INFO - Return code: 0 04:19:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:19:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:19:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c62a39fe027cd08173d8d0ba92392ad3cade50d3122afa2fbee08fff5942ec0df2d33609587db3f8c6fcf3632ebb95c093e62dac2b31657a1ce3b2c7d52c9b5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f2a64bafe31fe2e4c94071008c70b979b7e5b04020a18e3f6d325cd1c5d7097e30bed2a01d2d15cbc0ca71631f597234f0072657dcf15673869b650d95032fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0932d60179160143b8bbd54b818b70dd33faa2a2620251c31d1cdb1b621b6f3083c3f33040b199804ae759f3fa9454473c9764f18e5bcd15e999de7d10e7f79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f4fe3bc9018e863ba37b2b1c9a1f51effcb114bd0f81850a4f8a079e020ddc6d3100abd575b8397b5174ea1f6604e765ea048f301c9a67a7a1c72612b64a53a"} 04:19:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:19:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:19:30 INFO - Contents: 04:19:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c62a39fe027cd08173d8d0ba92392ad3cade50d3122afa2fbee08fff5942ec0df2d33609587db3f8c6fcf3632ebb95c093e62dac2b31657a1ce3b2c7d52c9b5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f2a64bafe31fe2e4c94071008c70b979b7e5b04020a18e3f6d325cd1c5d7097e30bed2a01d2d15cbc0ca71631f597234f0072657dcf15673869b650d95032fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0932d60179160143b8bbd54b818b70dd33faa2a2620251c31d1cdb1b621b6f3083c3f33040b199804ae759f3fa9454473c9764f18e5bcd15e999de7d10e7f79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f4fe3bc9018e863ba37b2b1c9a1f51effcb114bd0f81850a4f8a079e020ddc6d3100abd575b8397b5174ea1f6604e765ea048f301c9a67a7a1c72612b64a53a"} 04:19:30 INFO - Running post-run listener: copy_logs_to_upload_dir 04:19:30 INFO - Copying logs to upload dir... 04:19:30 INFO - mkdir: /builds/slave/test/build/upload/logs 04:19:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.961228 ========= master_lag: 2.39 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-04-03 04:19:32.472369) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 04:19:32.475538) ========= 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.LCYKuVlWMI/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.j6NcSrKnWt/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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/0c62a39fe027cd08173d8d0ba92392ad3cade50d3122afa2fbee08fff5942ec0df2d33609587db3f8c6fcf3632ebb95c093e62dac2b31657a1ce3b2c7d52c9b5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f2a64bafe31fe2e4c94071008c70b979b7e5b04020a18e3f6d325cd1c5d7097e30bed2a01d2d15cbc0ca71631f597234f0072657dcf15673869b650d95032fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0932d60179160143b8bbd54b818b70dd33faa2a2620251c31d1cdb1b621b6f3083c3f33040b199804ae759f3fa9454473c9764f18e5bcd15e999de7d10e7f79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f4fe3bc9018e863ba37b2b1c9a1f51effcb114bd0f81850a4f8a079e020ddc6d3100abd575b8397b5174ea1f6604e765ea048f301c9a67a7a1c72612b64a53a"} build_url:https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011120 build_url: 'https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/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/0c62a39fe027cd08173d8d0ba92392ad3cade50d3122afa2fbee08fff5942ec0df2d33609587db3f8c6fcf3632ebb95c093e62dac2b31657a1ce3b2c7d52c9b5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f2a64bafe31fe2e4c94071008c70b979b7e5b04020a18e3f6d325cd1c5d7097e30bed2a01d2d15cbc0ca71631f597234f0072657dcf15673869b650d95032fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0932d60179160143b8bbd54b818b70dd33faa2a2620251c31d1cdb1b621b6f3083c3f33040b199804ae759f3fa9454473c9764f18e5bcd15e999de7d10e7f79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f4fe3bc9018e863ba37b2b1c9a1f51effcb114bd0f81850a4f8a079e020ddc6d3100abd575b8397b5174ea1f6604e765ea048f301c9a67a7a1c72612b64a53a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 04:19:32.511031) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 04:19:32.511344) ========= 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.LCYKuVlWMI/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.j6NcSrKnWt/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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.005054 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 04:19:32.559781) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 04:19:32.560112) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 04:19:32.560491) ========= ========= Total master_lag: 2.53 =========