builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0021 starttime: 1490269381.42 results: success (0) buildid: 20170323034859 builduid: e2f0cab6230747e3bc9709c06bdd94ad revision: 7861d97f9ec87b44da2d20757fdb2340c2f0c802 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 04:43:01.424685) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 04:43:01.425127) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 04:43:01.425421) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 04:43:01.452584) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 04:43:01.452902) ========= 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.b4uxfJi2VJ/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.L1t1glG4sS/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-23 04:43:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 74.9M=0s 2017-03-23 04:43:01 (74.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119913 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 04:43:01.600140) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 04:43:01.600464) ========= 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.b4uxfJi2VJ/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.L1t1glG4sS/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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.020645 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 04:43:01.650924) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-03-23 04:43:01.651432) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7861d97f9ec87b44da2d20757fdb2340c2f0c802 --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 7861d97f9ec87b44da2d20757fdb2340c2f0c802 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.b4uxfJi2VJ/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.L1t1glG4sS/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-23 04:43:01,766 truncating revision to first 12 chars 2017-03-23 04:43:01,766 Setting DEBUG logging. 2017-03-23 04:43:01,766 attempt 1/10 2017-03-23 04:43:01,766 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7861d97f9ec8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-23 04:43:02,761 unpacking tar archive at: mozilla-aurora-7861d97f9ec8/testing/mozharness/ program finished with exit code 0 elapsedTime=2.939205 ========= master_lag: 1.60 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-03-23 04:43:06.192393) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 04:43:06.192711) ========= script_repo_revision: 7861d97f9ec87b44da2d20757fdb2340c2f0c802 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 04:43:06.193091) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 04:43:06.193369) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 04:43:06.275959) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-23 04:43:06.276330) ========= /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.b4uxfJi2VJ/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.L1t1glG4sS/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:43:06 INFO - MultiFileLogger online at 20170323 04:43:06 in /builds/slave/test 04:43:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:43:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:43:06 INFO - {'append_to_log': False, 04:43:06 INFO - 'base_work_dir': '/builds/slave/test', 04:43:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:43:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:43:06 INFO - 'branch': 'Mozilla-Aurora', 04:43:06 INFO - 'buildbot_json_path': 'buildprops.json', 04:43:06 INFO - 'config_files': ('talos/mac_config.py',), 04:43:06 INFO - 'default_actions': ('clobber', 04:43:06 INFO - 'read-buildbot-config', 04:43:06 INFO - 'download-and-extract', 04:43:06 INFO - 'populate-webroot', 04:43:06 INFO - 'create-virtualenv', 04:43:06 INFO - 'install', 04:43:06 INFO - 'run-tests'), 04:43:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:43:06 INFO - 'download_minidump_stackwalk': True, 04:43:06 INFO - 'download_symbols': 'ondemand', 04:43:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:43:06 INFO - 'tooltool.py': '/tools/tooltool.py', 04:43:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:43:06 INFO - '/tools/misc-python/virtualenv.py')}, 04:43:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:43:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:43:06 INFO - 'gecko_profile': False, 04:43:06 INFO - 'gecko_profile_interval': 0, 04:43:06 INFO - 'installer_path': 'installer.exe', 04:43:06 INFO - 'log_level': 'info', 04:43:06 INFO - 'log_name': 'talos', 04:43:06 INFO - 'log_to_console': True, 04:43:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:43:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:43:06 INFO - 'opt_config_files': (), 04:43:06 INFO - 'pip_index': False, 04:43:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:43:06 INFO - 'cmd': ('bash', 04:43:06 INFO - '-c', 04:43:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:43:06 INFO - 'enabled': True, 04:43:06 INFO - 'halt_on_failure': False, 04:43:06 INFO - 'name': 'check_screen_resolution'},), 04:43:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:43:06 INFO - 'cmd': ('bash', 04:43:06 INFO - '-c', 04:43:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:43:06 INFO - 'enabled': True, 04:43:06 INFO - 'halt_on_failure': False, 04:43:06 INFO - 'name': 'check_screen_resolution'},), 04:43:06 INFO - 'run_cmd_checks_enabled': True, 04:43:06 INFO - 'suite': 'dromaeojs-e10s', 04:43:06 INFO - 'system_bits': '32', 04:43:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:43:06 INFO - 'title': 't-yosemite-r7-0021', 04:43:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:43:06 INFO - 'use_talos_json': True, 04:43:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:43:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:43:06 INFO - 'work_dir': 'build'} 04:43:06 INFO - [mozharness: 2017-03-23 11:43:06.523057Z] Running clobber step. 04:43:06 INFO - Running pre-action listener: _resource_record_pre_action 04:43:06 INFO - Running main action method: clobber 04:43:06 INFO - rmtree: /builds/slave/test/build 04:43:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:43:08 INFO - Running post-action listener: _resource_record_post_action 04:43:08 INFO - [mozharness: 2017-03-23 11:43:08.281509Z] Finished clobber step (success) 04:43:08 INFO - [mozharness: 2017-03-23 11:43:08.281755Z] Running read-buildbot-config step. 04:43:08 INFO - Running pre-action listener: _resource_record_pre_action 04:43:08 INFO - Running main action method: read_buildbot_config 04:43:08 INFO - Using buildbot properties: 04:43:08 INFO - { 04:43:08 INFO - "project": "", 04:43:08 INFO - "product": "firefox", 04:43:08 INFO - "script_repo_revision": "production", 04:43:08 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 04:43:08 INFO - "repository": "", 04:43:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 04:43:08 INFO - "buildid": "20170323034859", 04:43:08 INFO - "pgo_build": "False", 04:43:08 INFO - "basedir": "/builds/slave/test", 04:43:08 INFO - "buildnumber": 26, 04:43:08 INFO - "slavename": "t-yosemite-r7-0021", 04:43:08 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 04:43:08 INFO - "platform": "yosemite_r7", 04:43:08 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 04:43:08 INFO - "branch": "mozilla-aurora", 04:43:08 INFO - "repo_path": "releases/mozilla-aurora", 04:43:08 INFO - "revision": "7861d97f9ec87b44da2d20757fdb2340c2f0c802", 04:43:08 INFO - "stage_platform": "macosx64", 04:43:08 INFO - "builduid": "e2f0cab6230747e3bc9709c06bdd94ad", 04:43:08 INFO - "slavebuilddir": "test" 04:43:08 INFO - } 04:43:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/agp8B7bDSb-VNo_CO1evRw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 04:43:08 INFO - Running post-action listener: _resource_record_post_action 04:43:08 INFO - [mozharness: 2017-03-23 11:43:08.287545Z] Finished read-buildbot-config step (success) 04:43:08 INFO - [mozharness: 2017-03-23 11:43:08.287779Z] Running download-and-extract step. 04:43:08 INFO - Running pre-action listener: _resource_record_pre_action 04:43:08 INFO - Running main action method: download_and_extract 04:43:08 INFO - mkdir: /builds/slave/test/build/tests 04:43: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')]} 04:43:08 INFO - trying https://queue.taskcluster.net/v1/task/agp8B7bDSb-VNo_CO1evRw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 04:43:08 INFO - Downloading https://queue.taskcluster.net/v1/task/agp8B7bDSb-VNo_CO1evRw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 04:43:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/agp8B7bDSb-VNo_CO1evRw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 04:43:09 INFO - Downloaded 1199 bytes. 04:43:09 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 04:43:09 INFO - Using the following test package requirements: 04:43:09 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 04:43:09 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:43:09 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 04:43:09 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:43:09 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 04:43:09 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:43:09 INFO - u'jsshell-mac.zip'], 04:43:09 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:43:09 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 04:43:09 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 04:43:09 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:43:09 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 04:43:09 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:43:09 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 04:43:09 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:43:09 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 04:43:09 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:43:09 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 04:43:09 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 04:43:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/agp8B7bDSb-VNo_CO1evRw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 04:43:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/agp8B7bDSb-VNo_CO1evRw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:43:09 INFO - Fetch https://queue.taskcluster.net/v1/task/agp8B7bDSb-VNo_CO1evRw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 04:43:11 INFO - Expected file size: 51782002 04:43:11 INFO - Obtained file size: 51782002 04:43:27 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 04:43:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/agp8B7bDSb-VNo_CO1evRw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 04:43:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/agp8B7bDSb-VNo_CO1evRw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:43:27 INFO - Fetch https://queue.taskcluster.net/v1/task/agp8B7bDSb-VNo_CO1evRw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 04:43:29 INFO - Expected file size: 51782002 04:43:29 INFO - Obtained file size: 51782002 04:43:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/agp8B7bDSb-VNo_CO1evRw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 04:43:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/agp8B7bDSb-VNo_CO1evRw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 04:43:44 INFO - Fetch https://queue.taskcluster.net/v1/task/agp8B7bDSb-VNo_CO1evRw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 04:43:46 INFO - Expected file size: 14404438 04:43:46 INFO - Obtained file size: 14404438 04:43:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:46 INFO - trying https://queue.taskcluster.net/v1/task/agp8B7bDSb-VNo_CO1evRw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 04:43:46 INFO - Downloading https://queue.taskcluster.net/v1/task/agp8B7bDSb-VNo_CO1evRw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 04:43:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/agp8B7bDSb-VNo_CO1evRw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 04:43:48 INFO - Downloaded 74756792 bytes. 04:43:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/agp8B7bDSb-VNo_CO1evRw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 04:43:48 INFO - mkdir: /builds/slave/test/properties 04:43:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:43:48 INFO - Writing to file /builds/slave/test/properties/build_url 04:43:48 INFO - Contents: 04:43:48 INFO - build_url:https://queue.taskcluster.net/v1/task/agp8B7bDSb-VNo_CO1evRw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 04:43:49 INFO - Running post-action listener: _resource_record_post_action 04:43:49 INFO - Running post-action listener: set_extra_try_arguments 04:43:49 INFO - [mozharness: 2017-03-23 11:43:49.290053Z] Finished download-and-extract step (success) 04:43:49 INFO - [mozharness: 2017-03-23 11:43:49.290211Z] Running populate-webroot step. 04:43:49 INFO - Running pre-action listener: _resource_record_pre_action 04:43:49 INFO - Running main action method: populate_webroot 04:43:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:43:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:43:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:43:49 INFO - '--tppagecycles', 04:43:49 INFO - '7'], 04:43:49 INFO - 'tests': ['tsvgm']}}, 04:43:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:43:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:43:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:43:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:43:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:43:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:43:49 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:43:49 INFO - 'talos_options': ['--disable-e10s'], 04:43:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:43:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:43:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:43:49 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:43:49 INFO - 'talos_options': ['--disable-e10s'], 04:43:49 INFO - 'tests': ['damp', 'tps']}, 04:43:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:43:49 INFO - 'tests': ['damp', 'tps']}, 04:43:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:43:49 INFO - 'tests': ['dromaeo_dom']}, 04:43:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:43:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:43:49 INFO - 'tests': ['basic_compositor_video']}, 04:43:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:43:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:43:49 INFO - 'tests': ['a11yr', 04:43:49 INFO - 'ts_paint', 04:43:49 INFO - 'tpaint', 04:43:49 INFO - 'sessionrestore', 04:43:49 INFO - 'sessionrestore_no_auto_restore', 04:43:49 INFO - 'tabpaint']}, 04:43:49 INFO - 'other-e10s': {'tests': ['a11yr', 04:43:49 INFO - 'ts_paint', 04:43:49 INFO - 'tpaint', 04:43:49 INFO - 'sessionrestore', 04:43:49 INFO - 'sessionrestore_no_auto_restore', 04:43:49 INFO - 'tabpaint']}, 04:43:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:43:49 INFO - 'ts_paint', 04:43:49 INFO - 'tpaint', 04:43:49 INFO - 'sessionrestore', 04:43:49 INFO - 'sessionrestore_no_auto_restore', 04:43:49 INFO - 'tabpaint']}, 04:43:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:43:49 INFO - 'ts_paint', 04:43:49 INFO - 'tpaint', 04:43:49 INFO - 'sessionrestore', 04:43:49 INFO - 'sessionrestore_no_auto_restore', 04:43:49 INFO - 'tabpaint']}, 04:43:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:43:49 INFO - 'tests': ['a11yr', 04:43:49 INFO - 'ts_paint', 04:43:49 INFO - 'tpaint', 04:43:49 INFO - 'sessionrestore', 04:43:49 INFO - 'sessionrestore_no_auto_restore', 04:43:49 INFO - 'tabpaint']}, 04:43:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:43:49 INFO - 'tests': ['a11yr', 04:43:49 INFO - 'ts_paint', 04:43:49 INFO - 'tpaint', 04:43:49 INFO - 'sessionrestore', 04:43:49 INFO - 'sessionrestore_no_auto_restore', 04:43:49 INFO - 'tabpaint']}, 04:43:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:43:49 INFO - 'tests': ['tsvgx', 04:43:49 INFO - 'tsvgr_opacity', 04:43:49 INFO - 'tart', 04:43:49 INFO - 'tscrollx', 04:43:49 INFO - 'cart', 04:43:49 INFO - 'tsvg_static']}, 04:43:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:43:49 INFO - 'tsvgr_opacity', 04:43:49 INFO - 'tart', 04:43:49 INFO - 'tscrollx', 04:43:49 INFO - 'cart', 04:43:49 INFO - 'tsvg_static']}, 04:43:49 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:43:49 INFO - 'talos_options': ['--disable-e10s'], 04:43:49 INFO - 'tests': ['tp5o']}, 04:43:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:43:49 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:43:49 INFO - 'talos_options': ['--disable-e10s', 04:43:49 INFO - '--xperf_path', 04:43:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:43:49 INFO - 'tests': ['tp5n']}, 04:43:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:43:49 INFO - 'talos_options': ['--xperf_path', 04:43:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:43:49 INFO - 'tests': ['tp5n']}}, 04:43:49 INFO - 'talos.zip': {'path': '', 04:43:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:43:49 INFO - Running post-action listener: _resource_record_post_action 04:43:49 INFO - [mozharness: 2017-03-23 11:43:49.308615Z] Finished populate-webroot step (success) 04:43:49 INFO - [mozharness: 2017-03-23 11:43:49.308750Z] Running create-virtualenv step. 04:43:49 INFO - Running pre-action listener: _resource_record_pre_action 04:43:49 INFO - Running main action method: create_virtualenv 04:43:49 INFO - Creating virtualenv /builds/slave/test/build/venv 04:43:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:43:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:43:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:43:49 INFO - Using real prefix '/tools/python27' 04:43:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:43:50 INFO - Installing distribute.............................................................................................................................................................................................done. 04:43:53 INFO - Installing pip.................done. 04:43:53 INFO - Return code: 0 04:43:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:43:53 INFO - Reading from file tmpfile_stdout 04:43:53 INFO - Output received: 04:43:53 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:43:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108101b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108104768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe073557010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107edfd30>, '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 0x107e06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ed4be8>, '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.b4uxfJi2VJ/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.L1t1glG4sS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:43: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', 'pip>=1.5'] in /builds/slave/test/build 04:43: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 pip>=1.5 04:43:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4uxfJi2VJ/Render', 04:43:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:54 INFO - 'HOME': '/Users/cltbld', 04:43:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:54 INFO - 'LOGNAME': 'cltbld', 04:43:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:54 INFO - 'MOZ_NO_REMOTE': '1', 04:43:54 INFO - 'NO_EM_RESTART': '1', 04:43:54 INFO - 'PAGER': '/bin/cat', 04:43:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:54 INFO - 'PWD': '/builds/slave/test', 04:43:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:54 INFO - 'SHELL': '/bin/bash', 04:43:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1t1glG4sS/Listeners', 04:43:54 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:43:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:54 INFO - 'USER': 'cltbld', 04:43:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:54 INFO - 'XPC_FLAGS': '0x0', 04:43:54 INFO - 'XPC_SERVICE_NAME': '0', 04:43:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:43:54 INFO - Cleaning up... 04:43:54 INFO - Return code: 0 04:43:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:43: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')]} 04:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43: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')]} 04:43:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43: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', '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 0x108101b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108104768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe073557010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107edfd30>, '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 0x107e06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ed4be8>, '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.b4uxfJi2VJ/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.L1t1glG4sS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:43: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:43: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 psutil>=3.1.1 04:43:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4uxfJi2VJ/Render', 04:43:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:54 INFO - 'HOME': '/Users/cltbld', 04:43:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:54 INFO - 'LOGNAME': 'cltbld', 04:43:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:54 INFO - 'MOZ_NO_REMOTE': '1', 04:43:54 INFO - 'NO_EM_RESTART': '1', 04:43:54 INFO - 'PAGER': '/bin/cat', 04:43:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:54 INFO - 'PWD': '/builds/slave/test', 04:43:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:54 INFO - 'SHELL': '/bin/bash', 04:43:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1t1glG4sS/Listeners', 04:43:54 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:43:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:54 INFO - 'USER': 'cltbld', 04:43:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:54 INFO - 'XPC_FLAGS': '0x0', 04:43:54 INFO - 'XPC_SERVICE_NAME': '0', 04:43:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:55 INFO - Downloading/unpacking psutil>=3.1.1 04:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:43:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:43:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:43:58 INFO - Installing collected packages: psutil 04:43:58 INFO - Running setup.py install for psutil 04:43:58 INFO - building 'psutil._psutil_osx' extension 04:43:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:43:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:43:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:43:59 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:43:59 INFO - building 'psutil._psutil_posix' extension 04:43:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:43:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:43:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:43:59 INFO - ^ 04:43:59 INFO - 1 warning generated. 04:43:59 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:43:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:43:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:43:59 INFO - Successfully installed psutil 04:43:59 INFO - Cleaning up... 04:43:59 INFO - Return code: 0 04:43:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:59 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 0x108101b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108104768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe073557010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107edfd30>, '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 0x107e06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ed4be8>, '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.b4uxfJi2VJ/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.L1t1glG4sS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:43:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:43:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:43:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4uxfJi2VJ/Render', 04:43:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:59 INFO - 'HOME': '/Users/cltbld', 04:43:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:59 INFO - 'LOGNAME': 'cltbld', 04:43:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:59 INFO - 'MOZ_NO_REMOTE': '1', 04:43:59 INFO - 'NO_EM_RESTART': '1', 04:43:59 INFO - 'PAGER': '/bin/cat', 04:43:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:59 INFO - 'PWD': '/builds/slave/test', 04:43:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:59 INFO - 'SHELL': '/bin/bash', 04:43:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1t1glG4sS/Listeners', 04:43:59 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:43:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:59 INFO - 'USER': 'cltbld', 04:43:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:59 INFO - 'XPC_FLAGS': '0x0', 04:43:59 INFO - 'XPC_SERVICE_NAME': '0', 04:43:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:43: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 04:43: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 04:43: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 04:43: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 04:43: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 04:43: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 04:44:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:44:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:44:02 INFO - Installing collected packages: mozsystemmonitor 04:44:02 INFO - Running setup.py install for mozsystemmonitor 04:44:02 INFO - Successfully installed mozsystemmonitor 04:44:02 INFO - Cleaning up... 04:44:02 INFO - Return code: 0 04:44:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:44: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')]} 04:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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')]} 04:44:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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', '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 0x108101b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108104768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe073557010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107edfd30>, '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 0x107e06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ed4be8>, '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.b4uxfJi2VJ/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.L1t1glG4sS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:44: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:44: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 jsonschema==2.5.1 04:44:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4uxfJi2VJ/Render', 04:44:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:02 INFO - 'HOME': '/Users/cltbld', 04:44:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:02 INFO - 'LOGNAME': 'cltbld', 04:44:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:02 INFO - 'MOZ_NO_REMOTE': '1', 04:44:02 INFO - 'NO_EM_RESTART': '1', 04:44:02 INFO - 'PAGER': '/bin/cat', 04:44:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:02 INFO - 'PWD': '/builds/slave/test', 04:44:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:02 INFO - 'SHELL': '/bin/bash', 04:44:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1t1glG4sS/Listeners', 04:44:02 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:44:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:02 INFO - 'USER': 'cltbld', 04:44:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:02 INFO - 'XPC_FLAGS': '0x0', 04:44:02 INFO - 'XPC_SERVICE_NAME': '0', 04:44:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:03 INFO - Downloading/unpacking jsonschema==2.5.1 04:44: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 04:44: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 04:44: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 04:44: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 04:44: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 04:44: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 04:44:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:44:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:44: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 04:44: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 04:44: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 04:44: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 04:44: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 04:44: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 04:44:06 INFO - Downloading functools32-3.2.3-2.tar.gz 04:44:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:44:06 INFO - warning: no files found matching '*.txt' 04:44:06 INFO - no previously-included directories found matching 'build' 04:44:06 INFO - no previously-included directories found matching 'dist' 04:44:06 INFO - no previously-included directories found matching '.git*' 04:44:06 INFO - Installing collected packages: jsonschema, functools32 04:44:06 INFO - Running setup.py install for functools32 04:44:06 INFO - warning: no files found matching '*.txt' 04:44:06 INFO - no previously-included directories found matching 'build' 04:44:06 INFO - no previously-included directories found matching 'dist' 04:44:06 INFO - no previously-included directories found matching '.git*' 04:44:06 INFO - Successfully installed jsonschema functools32 04:44:06 INFO - Cleaning up... 04:44:06 INFO - Return code: 0 04:44:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:06 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 0x108101b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108104768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe073557010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107edfd30>, '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 0x107e06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ed4be8>, '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.b4uxfJi2VJ/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.L1t1glG4sS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:44:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:44:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:44:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4uxfJi2VJ/Render', 04:44:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:06 INFO - 'HOME': '/Users/cltbld', 04:44:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:06 INFO - 'LOGNAME': 'cltbld', 04:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:06 INFO - 'MOZ_NO_REMOTE': '1', 04:44:06 INFO - 'NO_EM_RESTART': '1', 04:44:06 INFO - 'PAGER': '/bin/cat', 04:44:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:06 INFO - 'PWD': '/builds/slave/test', 04:44:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:06 INFO - 'SHELL': '/bin/bash', 04:44:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1t1glG4sS/Listeners', 04:44:06 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:44:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:06 INFO - 'USER': 'cltbld', 04:44:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:06 INFO - 'XPC_FLAGS': '0x0', 04:44:06 INFO - 'XPC_SERVICE_NAME': '0', 04:44:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:44:06 INFO - Cleaning up... 04:44:06 INFO - Return code: 0 04:44:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:06 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 0x108101b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108104768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe073557010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107edfd30>, '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 0x107e06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ed4be8>, '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.b4uxfJi2VJ/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.L1t1glG4sS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:44:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:44:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:44:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4uxfJi2VJ/Render', 04:44:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:06 INFO - 'HOME': '/Users/cltbld', 04:44:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:06 INFO - 'LOGNAME': 'cltbld', 04:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:06 INFO - 'MOZ_NO_REMOTE': '1', 04:44:06 INFO - 'NO_EM_RESTART': '1', 04:44:06 INFO - 'PAGER': '/bin/cat', 04:44:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:06 INFO - 'PWD': '/builds/slave/test', 04:44:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:06 INFO - 'SHELL': '/bin/bash', 04:44:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1t1glG4sS/Listeners', 04:44:06 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:44:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:06 INFO - 'USER': 'cltbld', 04:44:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:06 INFO - 'XPC_FLAGS': '0x0', 04:44:06 INFO - 'XPC_SERVICE_NAME': '0', 04:44:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:06 INFO - Downloading/unpacking blobuploader==1.2.4 04:44: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 04:44: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 04:44: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 04:44: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 04:44: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 04:44: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 04:44:09 INFO - Downloading blobuploader-1.2.4.tar.gz 04:44:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:44:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:44:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:10 INFO - Downloading docopt-0.6.1.tar.gz 04:44:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:44:10 INFO - Installing collected packages: blobuploader, requests, docopt 04:44:10 INFO - Running setup.py install for blobuploader 04:44:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:44:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:44:11 INFO - Running setup.py install for requests 04:44:11 INFO - Running setup.py install for docopt 04:44:11 INFO - Successfully installed blobuploader requests docopt 04:44:11 INFO - Cleaning up... 04:44:11 INFO - Return code: 0 04:44:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:11 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 0x108101b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108104768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe073557010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107edfd30>, '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 0x107e06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ed4be8>, '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.b4uxfJi2VJ/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.L1t1glG4sS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:44:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:44:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:44:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4uxfJi2VJ/Render', 04:44:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:11 INFO - 'HOME': '/Users/cltbld', 04:44:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:11 INFO - 'LOGNAME': 'cltbld', 04:44:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:11 INFO - 'MOZ_NO_REMOTE': '1', 04:44:11 INFO - 'NO_EM_RESTART': '1', 04:44:11 INFO - 'PAGER': '/bin/cat', 04:44:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:11 INFO - 'PWD': '/builds/slave/test', 04:44:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:11 INFO - 'SHELL': '/bin/bash', 04:44:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1t1glG4sS/Listeners', 04:44:11 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:44:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:11 INFO - 'USER': 'cltbld', 04:44:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:11 INFO - 'XPC_FLAGS': '0x0', 04:44:11 INFO - 'XPC_SERVICE_NAME': '0', 04:44:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:44:11 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-lzAv5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:44:12 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-9VWrNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:44:12 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-QEPvsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:44:12 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-WR9cI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:44:12 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-I0UN4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:44:12 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-3TE09L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:44:12 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-qrQUdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:44:12 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-owjEIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:44:12 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-cEq3BQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:44:12 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-wl03mU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:44:13 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-Yv6Ch5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:44:13 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-iAuOBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:44:13 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-uuyCvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:44:13 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-AFFoPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:13 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-hk_xZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:44:13 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-2oXIfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:44:13 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-KkK2rU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:44:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:44:13 INFO - Running setup.py install for manifestparser 04:44:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:44:13 INFO - Running setup.py install for mozcrash 04:44:14 INFO - Running setup.py install for mozdebug 04:44:14 INFO - Running setup.py install for mozdevice 04:44:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:44:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:44:14 INFO - Running setup.py install for mozfile 04:44:14 INFO - Running setup.py install for mozhttpd 04:44:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:44:14 INFO - Running setup.py install for mozinfo 04:44:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:44:14 INFO - Running setup.py install for mozInstall 04:44:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:44:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:44:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:44:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:44:14 INFO - Running setup.py install for mozleak 04:44:15 INFO - Running setup.py install for mozlog 04:44:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:44:15 INFO - Running setup.py install for moznetwork 04:44:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:44:15 INFO - Running setup.py install for mozprocess 04:44:15 INFO - Running setup.py install for mozprofile 04:44:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:44:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:44:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:44:15 INFO - Running setup.py install for mozrunner 04:44:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:44:15 INFO - Running setup.py install for mozscreenshot 04:44:16 INFO - Running setup.py install for moztest 04:44:16 INFO - Running setup.py install for mozversion 04:44:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:44:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:44:16 INFO - Cleaning up... 04:44:16 INFO - Return code: 0 04:44:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:16 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 0x108101b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108104768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe073557010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107edfd30>, '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 0x107e06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ed4be8>, '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.b4uxfJi2VJ/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.L1t1glG4sS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:44:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:44:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:44:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4uxfJi2VJ/Render', 04:44:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:16 INFO - 'HOME': '/Users/cltbld', 04:44:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:16 INFO - 'LOGNAME': 'cltbld', 04:44:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:16 INFO - 'MOZ_NO_REMOTE': '1', 04:44:16 INFO - 'NO_EM_RESTART': '1', 04:44:16 INFO - 'PAGER': '/bin/cat', 04:44:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:16 INFO - 'PWD': '/builds/slave/test', 04:44:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:16 INFO - 'SHELL': '/bin/bash', 04:44:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1t1glG4sS/Listeners', 04:44:16 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:44:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:16 INFO - 'USER': 'cltbld', 04:44:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:16 INFO - 'XPC_FLAGS': '0x0', 04:44:16 INFO - 'XPC_SERVICE_NAME': '0', 04:44:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:44:16 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-aFm7JA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:44:16 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-QpGucX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:44:16 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-dndVrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:44:16 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-uV1nLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:44:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:44:17 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-ogqXOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:44:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:44:17 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-MhInDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:44:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:44:17 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-bwVMSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:44:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:44:17 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-OR4Lwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:44:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:44:17 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-WzKPl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:44:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:44:17 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-eORVdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:44:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:44:17 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-U66QQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:44:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:44:17 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-99ZXs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:44:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:44:17 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-jpN5o4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:44:18 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-ClAY3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:18 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-c5_UAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:44:18 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-iZyh14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:44:18 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-7hBHNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:44:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:20 INFO - Downloading blessings-1.6.tar.gz 04:44:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:44:21 INFO - Installing collected packages: blessings 04:44:21 INFO - Running setup.py install for blessings 04:44:21 INFO - Successfully installed blessings 04:44:21 INFO - Cleaning up... 04:44:21 INFO - Return code: 0 04:44:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:44:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:44:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:44:21 INFO - Reading from file tmpfile_stdout 04:44:21 INFO - Current package versions: 04:44:21 INFO - blessings == 1.6 04:44:21 INFO - blobuploader == 1.2.4 04:44:21 INFO - docopt == 0.6.1 04:44:21 INFO - functools32 == 3.2.3-2 04:44:21 INFO - jsonschema == 2.5.1 04:44:21 INFO - manifestparser == 1.1 04:44:21 INFO - mozInstall == 1.12 04:44:21 INFO - mozcrash == 1.0 04:44:21 INFO - mozdebug == 0.1 04:44:21 INFO - mozdevice == 0.49 04:44:21 INFO - mozfile == 1.2 04:44:21 INFO - mozhttpd == 0.7 04:44:21 INFO - mozinfo == 0.9 04:44:21 INFO - mozleak == 0.1 04:44:21 INFO - mozlog == 3.4 04:44:21 INFO - moznetwork == 0.27 04:44:21 INFO - mozprocess == 0.25 04:44:21 INFO - mozprofile == 0.28 04:44:21 INFO - mozrunner == 6.13 04:44:21 INFO - mozscreenshot == 0.1 04:44:21 INFO - mozsystemmonitor == 0.3 04:44:21 INFO - moztest == 0.8 04:44:21 INFO - mozversion == 1.4 04:44:21 INFO - psutil == 3.1.1 04:44:21 INFO - requests == 1.2.3 04:44:21 INFO - wsgiref == 0.1.2 04:44:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:21 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 0x108101b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108104768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe073557010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107edfd30>, '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 0x107e06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ed4be8>, '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.b4uxfJi2VJ/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.L1t1glG4sS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:44:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:44:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:44:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4uxfJi2VJ/Render', 04:44:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:21 INFO - 'HOME': '/Users/cltbld', 04:44:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:21 INFO - 'LOGNAME': 'cltbld', 04:44:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:21 INFO - 'MOZ_NO_REMOTE': '1', 04:44:21 INFO - 'NO_EM_RESTART': '1', 04:44:21 INFO - 'PAGER': '/bin/cat', 04:44:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:21 INFO - 'PWD': '/builds/slave/test', 04:44:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:21 INFO - 'SHELL': '/bin/bash', 04:44:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1t1glG4sS/Listeners', 04:44:21 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:44:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:21 INFO - 'USER': 'cltbld', 04:44:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:21 INFO - 'XPC_FLAGS': '0x0', 04:44:21 INFO - 'XPC_SERVICE_NAME': '0', 04:44:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:44:21 INFO - Cleaning up... 04:44:21 INFO - Return code: 0 04:44:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108101b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108104768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe073557010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107edfd30>, '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 0x107e06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ed4be8>, '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.b4uxfJi2VJ/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.L1t1glG4sS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:44:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:44:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:44:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4uxfJi2VJ/Render', 04:44:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:21 INFO - 'HOME': '/Users/cltbld', 04:44:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:21 INFO - 'LOGNAME': 'cltbld', 04:44:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:21 INFO - 'MOZ_NO_REMOTE': '1', 04:44:21 INFO - 'NO_EM_RESTART': '1', 04:44:21 INFO - 'PAGER': '/bin/cat', 04:44:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:21 INFO - 'PWD': '/builds/slave/test', 04:44:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:21 INFO - 'SHELL': '/bin/bash', 04:44:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1t1glG4sS/Listeners', 04:44:21 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:44:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:21 INFO - 'USER': 'cltbld', 04:44:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:21 INFO - 'XPC_FLAGS': '0x0', 04:44:21 INFO - 'XPC_SERVICE_NAME': '0', 04:44:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:44:22 INFO - Cleaning up... 04:44:22 INFO - Return code: 0 04:44:22 INFO - Running post-action listener: _resource_record_post_action 04:44:22 INFO - Running post-action listener: _start_resource_monitoring 04:44:22 INFO - Starting resource monitoring. 04:44:22 INFO - [mozharness: 2017-03-23 11:44:22.268137Z] Finished create-virtualenv step (success) 04:44:22 INFO - [mozharness: 2017-03-23 11:44:22.269123Z] Running install step. 04:44:22 INFO - Running pre-action listener: _resource_record_pre_action 04:44:22 INFO - Running main action method: install 04:44:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:44:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:44:22 INFO - Reading from file tmpfile_stdout 04:44:22 INFO - Detecting whether we're running mozinstall >=1.0... 04:44:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:44:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:44:22 INFO - Reading from file tmpfile_stdout 04:44:22 INFO - Output received: 04:44:22 INFO - Usage: mozinstall [options] installer 04:44:22 INFO - Options: 04:44:22 INFO - -h, --help show this help message and exit 04:44:22 INFO - -d DEST, --destination=DEST 04:44:22 INFO - Directory to install application into. [default: 04:44:22 INFO - "/builds/slave/test"] 04:44:22 INFO - --app=APP Application being installed. [default: firefox] 04:44:22 INFO - mkdir: /builds/slave/test/build/application 04:44:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:44:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 04:44:43 INFO - Reading from file tmpfile_stdout 04:44:43 INFO - Output received: 04:44:43 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 04:44:43 INFO - Running post-action listener: _resource_record_post_action 04:44:43 INFO - [mozharness: 2017-03-23 11:44:43.114120Z] Finished install step (success) 04:44:43 INFO - [mozharness: 2017-03-23 11:44:43.114250Z] Running run-tests step. 04:44:43 INFO - Running pre-action listener: _resource_record_pre_action 04:44:43 INFO - Running main action method: run_tests 04:44:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:44:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:44:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:44:43 INFO - 2017-03-23 04:44:43.129 screenresolution[2064:16323] starting screenresolution argv=screenresolution get 04:44:43 INFO - 2017-03-23 04:44:43.132 screenresolution[2064:16323] Display 0: 1600x1200x32@60 04:44:43 INFO - 2017-03-23 04:44:43.137 screenresolution[2065:16325] starting screenresolution argv=screenresolution list 04:44:43 INFO - Available Modes on Display 0 04:44:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:44:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:44:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:44:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:44:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:44:43 INFO - Intel Iris: 04:44:43 INFO - Chipset Model: Intel Iris 04:44:43 INFO - Type: GPU 04:44:43 INFO - Bus: Built-In 04:44:43 INFO - VRAM (Dynamic, Max): 1536 MB 04:44:43 INFO - Vendor: Intel (0x8086) 04:44:43 INFO - Device ID: 0x0a2e 04:44:43 INFO - Revision ID: 0x0009 04:44:43 INFO - Displays: 04:44:43 INFO - Display: 04:44:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:44:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:44:43 INFO - Display Serial Number: 1600x1200 60 04:44:43 INFO - Main Display: Yes 04:44:43 INFO - Mirror: Off 04:44:43 INFO - Online: Yes 04:44:43 INFO - Rotation: Supported 04:44:43 INFO - Return code: 0 04:44:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:44:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:44:43 INFO - Python 2.7.3 04:44:43 INFO - Return code: 0 04:44:43 INFO - grabbing minidump binary from tooltool 04:44:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:43 INFO - 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 0x107edfd30>, '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 0x107e06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ed4be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:44:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:44:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:44:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:44:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:44:43 INFO - Return code: 0 04:44:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:44:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:44:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:44:43 INFO - ENV: RUST_BACKTRACE is now 1 04:44:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:44:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:44:43 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/agp8B7bDSb-VNo_CO1evRw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:44:43 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/agp8B7bDSb-VNo_CO1evRw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:44:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4uxfJi2VJ/Render', 04:44:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:43 INFO - 'HOME': '/Users/cltbld', 04:44:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:43 INFO - 'LOGNAME': 'cltbld', 04:44:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:44:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:44:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:43 INFO - 'MOZ_NO_REMOTE': '1', 04:44:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:44:43 INFO - 'NO_EM_RESTART': '1', 04:44:43 INFO - 'PAGER': '/bin/cat', 04:44:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:43 INFO - 'PWD': '/builds/slave/test', 04:44:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:44:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:43 INFO - 'RUST_BACKTRACE': '1', 04:44:43 INFO - 'SHELL': '/bin/bash', 04:44:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1t1glG4sS/Listeners', 04:44:43 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:44:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:43 INFO - 'USER': 'cltbld', 04:44:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:43 INFO - 'XPC_FLAGS': '0x0', 04:44:43 INFO - 'XPC_SERVICE_NAME': '0', 04:44:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:43 INFO - 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/agp8B7bDSb-VNo_CO1evRw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:44:43 INFO - mozversion application_buildid: 20170323034859 04:44:43 INFO - mozversion application_changeset: 7861d97f9ec87b44da2d20757fdb2340c2f0c802 04:44:43 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:44:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:44:43 INFO - mozversion application_name: Firefox 04:44:43 INFO - mozversion application_remotingname: firefox-dev 04:44:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:44:43 INFO - mozversion application_vendor: Mozilla 04:44:43 INFO - mozversion application_version: 54.0a2 04:44:43 INFO - mozversion platform_buildid: 20170323034859 04:44:43 INFO - mozversion platform_changeset: 7861d97f9ec87b44da2d20757fdb2340c2f0c802 04:44:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:44:43 INFO - mozversion platform_version: 54.0a2 04:44:43 INFO - using testdate: 1490269483 04:44:43 INFO - actual date: 1490269483 04:44:43 INFO - starting webserver on 'localhost:53401' 04:44:43 INFO - SUITE-START | Running 2 tests 04:44:43 INFO - TEST-START | dromaeo_css 04:44:43 INFO - operating with platform_type : mac_ 04:44:43 INFO - Initialising browser for dromaeo_css test... 04:44:43 INFO - TEST-INFO | started process 2075 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/tmphU0ULO/profile http://localhost:53401/getInfo.html) 04:44:46 INFO - PROCESS | 2075 | 2017-03-23 04:44:46.580 plugin-container[2078:16488] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a47, name = 'com.apple.tsm.portname' 04:44:46 INFO - PROCESS | 2075 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:44:46 INFO - PROCESS | 2075 | 2017-03-23 04:44:46.583 plugin-container[2078:16488] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960f, name = 'com.apple.CFPasteboardClient' 04:44:46 INFO - PROCESS | 2075 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:44:46 INFO - PROCESS | 2075 | 2017-03-23 04:44:46.583 plugin-container[2078:16488] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:44:46 INFO - PROCESS | 2075 | __metrics Screen width/height:1600/1200 04:44:46 INFO - PROCESS | 2075 | colorDepth:24 04:44:46 INFO - PROCESS | 2075 | Browser inner width/height: 1024/689 04:44:46 INFO - PROCESS | 2075 | __metrics 04:44:46 ERROR - PROCESS | 2075 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 04:44:47 INFO - TEST-INFO | 2075: exit 0 04:44:47 INFO - Browser initialized. 04:44:47 INFO - Running cycle 1/1 for dromaeo_css test... 04:44:47 INFO - TEST-INFO | started process 2079 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/tmphU0ULO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:44:49 INFO - PROCESS | 2079 | 2017-03-23 04:44:49.764 plugin-container[2080:16621] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3b, name = 'com.apple.tsm.portname' 04:44:49 INFO - PROCESS | 2079 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:44:49 INFO - PROCESS | 2079 | 2017-03-23 04:44:49.765 plugin-container[2080:16621] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x461f, name = 'com.apple.CFPasteboardClient' 04:44:49 INFO - PROCESS | 2079 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:44:49 INFO - PROCESS | 2079 | 2017-03-23 04:44:49.765 plugin-container[2080:16621] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:44:59 INFO - PROCESS | 2079 | RSS: Main: 220848128 04:44:59 INFO - PROCESS | 2079 | 04:48:03 INFO - PROCESS | 2079 | Cycle 1(1): loaded http://localhost:53401/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53401/tests/dromaeo/cssquery-ext.html) 04:48:05 INFO - PROCESS | 2079 | RSS: Main: 238956544 04:48:05 INFO - PROCESS | 2079 | 04:49:47 INFO - PROCESS | 2079 | ************************* 04:49:47 INFO - PROCESS | 2079 | A coding exception was thrown and uncaught in a Task. 04:49:47 INFO - PROCESS | 2079 | 04:49:47 ERROR - PROCESS | 2079 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:49:47 INFO - PROCESS | 2079 | Full stack: 04:49:47 INFO - PROCESS | 2079 | ************************* 04:51:07 INFO - PROCESS | 2079 | Cycle 1(1): loaded http://localhost:53401/tests/dromaeo/cssquery-ext.html (next: http://localhost:53401/tests/dromaeo/cssquery-jquery.html) 04:51:08 INFO - PROCESS | 2079 | RSS: Main: 250126336 04:51:08 INFO - PROCESS | 2079 | 04:54:10 INFO - PROCESS | 2079 | Cycle 1(1): loaded http://localhost:53401/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53401/tests/dromaeo/cssquery-mootools.html) 04:54:10 INFO - PROCESS | 2079 | RSS: Main: 256675840 04:54:10 INFO - PROCESS | 2079 | 04:57:12 INFO - PROCESS | 2079 | Cycle 1(1): loaded http://localhost:53401/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53401/tests/dromaeo/cssquery-prototype.html) 04:57:13 INFO - PROCESS | 2079 | RSS: Main: 252887040 04:57:13 INFO - PROCESS | 2079 | 05:00:16 INFO - PROCESS | 2079 | Cycle 1(1): loaded http://localhost:53401/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53401/tests/dromaeo/cssquery-yui.html) 05:00:16 INFO - PROCESS | 2079 | RSS: Main: 258068480 05:00:16 INFO - PROCESS | 2079 | 05:03:19 INFO - PROCESS | 2079 | Cycle 1(1): loaded http://localhost:53401/tests/dromaeo/cssquery-yui.html (next: http://localhost:53401/tests/dromaeo/cssquery-dojo.html) 05:03:19 INFO - PROCESS | 2079 | RSS: Main: 254181376 05:03:19 INFO - PROCESS | 2079 | 05:03:19 INFO - PROCESS | 2079 | __start_tp_report 05:03:19 INFO - PROCESS | 2079 | _x_x_mozilla_page_load 05:03:19 INFO - PROCESS | 2079 | _x_x_mozilla_page_load_details 05:03:19 INFO - PROCESS | 2079 | |i|pagename|runs| 05:03:19 INFO - PROCESS | 2079 | |0;dojo.html;3519.9648003519965;3540.8052557109363;3547.130952916536;3560.875369362071;3595.9280814383715;4922.237053256742;6186.463549944524;6199.535034872386;6222.533310001745;6237.438630523252;6165.907511387333;6202.689865506729;6220.533459990496;6262.029385445252;6281.685915704208;4863.902721945577;5533.335999680044;5614.719264036802;5619.943800562003;5684.630499017571;5666.603337766337;5673.177389278552;5679.744411501471;5680.318361796591;5715.171300161474;5424.647397919142;5441.782328706847;5464.180372944051;5667.206591077253;5669.433056694339;5541.307336582927;5541.944580554204;5575.107982722745;5577.470140336662;5686.9715651421475;5508.421615730371;5586.720663966786;5607.523360514361;5631.042722737145;5652.63257888236;4517.909641807146;6287;6326.68366581669;6329.272133704637;6343.333949935237;4728.361671174382;5532.529734972532;5885.558583106242;6363.522735794788;6467.708953097075;6605.207375114969;6672.466202703772;6673.366030227169;6683.53215274931;6696.966515167393;6229.595076320024;6307.747690092345;6332.968335158294;6343.809685709436;6362.236531616236;5640.802571909963;6514.837129071811;6586.8353291168105;6832.624205668637;6845.828854278583;6361.522885783585;6403.839904002344;6408.10286559882;6422.100905873182;6432.549721519449;6662.933370666231;6674;6679.131712877392;6686.765963191265;6694.799156025327;6558.672066396661;6571.83570410734;6584.9012264816065;6598.505112116611;6617.371349721769;6327.936720632827;6374.617522948638;6386.8722625547225;6535.738570457223;6610;5299.4700529946695;5307.071262529042;5316.362036555638;5338.54622357104;5355.678659280456;4689.929651055237;4694.906101878011;4705.082508910729;4742.928856067162;4754.928676069792;6123.571350005457;6146.262448506208;6322.083297921868;6350.68246587678;6362.91830388835;6453.419192272718;6544.901826472606;6585.407313341726;6612.471002319803;6635.085299673216;6280.717367718372;6356;6359.459445947146;6359.554831161867;6366.299707032223;5829.387914268941;5829.4170582942215;5833.183354330397;5834.3290521589715;5837.09525023622;6526.738930442729;6596.175478065242;6714.630695311609;6745.561538500178;6870.175578930361;5614.775408983595;6672.096009432966;6678.599284042973;6709.664516774239;6716.261211266855;6732;6890.517663763489;6895.931040689529;6898.827529311808;6901.447884169354;5335.653182543122;6334.841628959129;6402.6158430494315;6424.100625912282;6588.40704336612;6456.2575303838785;6571.244306904767;6615.4376877965915;6620.867582648224;6637.203535575762;4611.907761844812;5379.811706590251;6293.527985401021;6316.368363163647;6339.714712837841;6166.753329866755;6444.355564443518;6496.642684652389;6508.837279068061;6522.934770652233;4133;5775.826725198251;6261.3112557617715;6319.3364696706185;6371.55399122057;6450.645214513247;6453.741850325934;6480.837979050561;6489.448396886318;6495.772647957488;6324.936750632435;6346.301906790157;6364.268109167505;6365.14070600463;6367.745290188341 05:03:19 INFO - PROCESS | 2079 | |1;ext.html;733.8495608400278;810.8378324335133;817.5544328341056;941.9952900235497;943.8018016216594;37233;38089.61910380895;39278;39359.21281574367;39580.2083958321;38205.66280180194;38245;38296.85109446714;38336.233275334474;38336.808315958384;7832.216778322165;10565.207609429284;10786.784264314709;10909.07272881806;10941.507632156572;8532.78668033301;9626.278029147807;10649.148068154567;10722.195835312345;10764.946175269113;9044.186023257906;10751.354918704903;10753.978372054642;10761.461926903663;10767.407792571405;8815.823683526325;10731.034206921375;10747.140228781756;10747.731306717356;10769.299995500267;8622.267107295887;10526.31578947366;10534.104601108915;10534.947325263325;10535;32875.342493150005;32892.17769555756;33159.502607460905;33169;33194.170145746306;3695.5565332160045;3711.7030637548933;3716.099940642174;3767.1335592813807;3770.872332459753;24516.754832451625;25393;25411.872940635363;25448.491030179477;25495.72521373924;3021.818690878554;3057.6636569977286;3088.1507585413965;3139.8587063581967;3239.271163988107;307480.46259768785;344822;346241.2687936544;346652;347562;34379;42967.57032429698;43070.35394469023;43274;43500;44879;44901.775491122986;45146.54853451424;45161.77419112883;45278;13670.931645341909;13687.726245475034;13783.379747911367;13793.931030344784;13797.931010344884;11888.227265227733;11891.940540297242;11896.583619573274;11911.702207444883;11911.880881191251;9380.577873995686;10341.4312212829;11764.941155296065;11868.465919033664;11876.762464750656;5583.720813959367;5603.327600687943;5634;5650.576206784508;5672.12082127271;949.9810003799886;1022.6318525330875;1098.0447011100393;1103.3324838472608;1107.3733522713178;22274.554508909732;24680.629790553157;24789.50420991606;25927;26914.192574222805;1061.4268295120548;1132.1056365471186;1174.8472698549133;1239.8822111899356;1256.7298030923396;10599.788004239872;13152.684731526771;13550.525731599346;13717.971152163627;13947.232902190273;398080;399109;401205;403374;405507;37217;55145.44854551483;55251;55755.44244557503;55815;1391.3460673483648;1409.5912185466304;1427.257825930531;1429.5997120806192;1430.9212993285469;23893;24989.750102498743;26218.21345359642;26291.342716432242;26990.32524186911;36836;38934;39034.2193156141;39134.804325978184;39139.2172156561;410013.94993024843;469104;474394;476023;476163;27502.587461187697;27778.722212777615;27787.44425111446;27813.304667383476;27854;36914.261714765016;38519.422208667456;38869;39579.60420395759;39893.0026749322;26619.60070598904;31288.530672039484;31697.366052678357;32208.55061522284;32479.18802029968;26576.601350980138;32023.839880800446;32309;32582.83708581442;32827;25612.847421866434;31465.056048318587;31522.527162092127;31595.84202078975;32122.678773212905;28931.276718082216;29111.708882910898;29136;29187.85406072956;29265.268368290963;22371.664425033312;22544.323670289916;22590.209342672926;22719.432014199778;22744.43138921474 05:03:19 INFO - PROCESS | 2079 | |2;jquery.html;402.8207447685781;409.72138945517077;414.6371924566005;414.906646004649;420.3610512021728;19972.601917865755;20694.86178260195;20741.274055408063;20986.790132098675;21234.681479777795;21598;21654.783452165473;21971.121155153774;22225.333240002827;22334.994925228362;6447.838804029901;6775.898361524581;6784.932150678479;6794.3545363190415;6800.285969973156;6374.904376434357;6629.370209830083;6668.099806526129;6668.333166683341;6717.932820671804;6657.234418041915;6690.531662783607;6714.429273511733;6717.1939367276;6732.663366831639;5311.389190243133;6598.538102332863;6623.966880165616;6636.435902948255;6650.634215118166;5327;6393.680315984182;6428.292887782341;6469.805905822833;6492.220933487964;25301.493970120493;25513.74486255151;25573.48853022948;25579.360515987064;25755.742442575523;2965.851707414642;3302.554155189043;3333.3666603345287;3428.862845486178;3473.808940508271;15190.164540950243;15718.37126514938;16682.58293542659;16803.495895123167;16860;2055.5683306505653;2147.14114354258;2151.4513798981316;2151.66649169379;2161.3948094533557;110477;120881.39559302235;123110.38444807718;123617.38191309077;123946.38026809899;21308.893455532623;22339.329820105424;22536.661950070764;22756.886215568815;22965.311040668807;35875.82062089673;36152.819235903655;36594.08514787152;36641.45037824435;36647.450288245695;10772.569097236179;10963.451827408599;11091.500882460146;11121.388323642277;11133.332000080021;9041.50271735061;9051.27589792815;9052.637894484147;9178.908210917938;9256.90743092574;10536.947315263527;10584.470776461147;10658.573657053787;10811.459427028618;10816.351018938889;3585.928281434357;4035.8094362162647;4238.533761286256;4436.600705936481;4440.845380201106;764.5603777827771;908.1599520443564;925.2967744514083;955.7371722776153;972.2270794718216;17067.829321706624;20130.993450327423;21334.35996920095;22038.787866667168;22195.556088878133;869.7434256894231;881.8192270584515;900.7297810656908;960.2078285414561;994.7811481474064;10601.787964240671;11617.658043472882;11830.763384732258;11837.526498940118;12137.635870923887;732967;751527;757623.211883937;772813;773879;119764.40117799355;122150;123298.38350808188;124583.377083114;125640;1212.8726483719083;1263.8925691316158;1269.8730126987411;1274.0635632809876;1310.2335133946558;16946.322147113977;17215.56961075983;18810.905945470186;19474.221031159163;19475.513112171742;52122;53007.93984120373;53923.73038134784;54264;54543;70990;72828;72897;74373.62813186116;74609.62695186489;8063.959680201561;10001.949990250003;11671.941640292083;11910.940445298065;12203.20679155852;13130.407650819878;13221.140625859673;13351.866481335452;13442.865571344162;13518.662033449242;11005.504752286006;11242.831357529807;11268.774624507629;11378.203525753117;11432.599859004895;11193.888061119285;11405.600803971822;11490.712732181762;11566.768664626828;11633.243839150427;11268.718282042686;11338.60314888975;11474.885251147381;11688.532458701897;11805.350705711267;11758.58844940423;11909.642710718692;12005.81991270149;12080.39598020113;12092.214006089576;11132.332060076422;11133.888661113286;11235.045021173291;11298;11460.713482163013 05:03:19 INFO - PROCESS | 2079 | |3;mootools.html;1274.4201388368294;1564.710528552218;1590.7671554545234;1611.7824093747345;1616.0949868073878;10892;11128.721781955455;11462.254953428032;11487.770244595104;11626.360550169748;9458.85811712825;11224.158188135902;11379.431028448565;11443.084553235742;11475.024622907042;2134.253011445989;2165.6859755335468;2166.306781829815;2169.609470295346;2171.81539569136;2018.818306352428;2310.445493081665;2354.1642716835536;2356.1164563288767;2364.9054037838464;2316.4672125411166;2333.346662934381;2336.4509340305017;2339.321596736953;2344.9882750586307;2285.6228722260807;2288.0504590594883;2299.632058870581;2304.124432715566;2311.075569772088;2294.552562250362;2342.3441436397834;2352.176738141654;2352.9764702352927;2355.599548076831;11480.655580332603;11538.653840384803;11563.30620162793;11569.768604627945;11587.826182607268;5532.806351777668;5645.887082258373;5673.177389278531;5704.429557044304;5713.257276554063;2920.153155584878;3235.2397186661115;3250.7886987345746;3311.8408557005096;3342.2647017656077;974.8537719342085;1120.4733775125678;1172.5309876049564;1186.1519013905013;1193.087288224509;13709.520166794215;13863.58409247714;14013.019088663797;14878.925605372013;14919.104853708921;4325.286327755885;4471.5081341052455;4583.564561366665;4597.632189424838;4607.539246075366;11935.403229838474;12010.879891200977;12041.759164816654;12056.819147712791;12065.758684826429;5468.070428027245;5514.200440936042;5516.089845175501;5536.889262214733;5545.334559852843;3959.6115658689305;5048.343715317059;5063.797448102035;5097.643164978416;5234.450382709837;3761.2101458693433;3779.225258821935;3782.7730336179916;3860.2665493556133;3867.361885288896;872.1845074854904;957.8036502517107;966.12083004467;967.883853937532;976.9560369783377;923.9907600924039;934.7102398256426;940.7836197674574;951.6716732727198;993.5727637115965;6658.933410665832;6682.465402767767;6695.330466953363;6914.343137401939;6942.93057069433;962.7785609309898;972.7324985628867;1013.1185868294483;1021.4126877045728;1044.5978298355187;4093.6315731583704;4198.160367926366;4236.957630423656;4308.46144231971;4339.891502712394;13679.384427700777;14037.368318425695;14122.85877141236;14174.787378189336;14240.928795355956;13540.59378218655;13812.240326781923;14063.015588908882;14081.577552673436;14179.432822687184;8852.468851869038;10189.184865210766;10249.231307651957;10386.688399348031;10419.06228439444;6369.649669268235;6806.115205023315;7033.894491582528;7061.869475939673;7079.929200707927;11941.82087268709;12220.388980551115;12251.87748122543;12286.631401057983;12353.938230308791;12461.314627695201;12608.684782880502;12731.61805145847;12921.741565168455;12923.870761292266;8487.575621219037;8514.74455766328;8526.61630226629;8563.186497282748;8572.657093716181;10366.896331036593;10414.635487757892;10497.160227181654;10517.368957862247;10553.841692374466;7720.8455830884195;9192.632294708137;9215.44707317563;9220.953895230748;9440.008799075998;8779.912200877909;8905.975812781613;9005.23455506263;9162.083791620784;9173.495457749888;7663.578503182379;7813.101493328113;7847.921520784719;7905.486143400661;7932.4447288691545;5785.132230165509;5861.0915308127305;5871.559633027455;5982.611130276518;6120.234970628671;6036.3661815510495;6047.0627052806885;6053.152558641706;6054.848628784315;6129.35641757609 05:03:19 INFO - PROCESS | 2079 | |4;prototype.html;296.9866356013979;330.34426663073793;381.1842656714631;383.96544311012013;385.62209035145537;5376.166694162406;5413.242146099539;5452.700101494426;5526.696031718254;5545.140503222002;4427.512973572912;4524.886877828056;4543.568361005708;5349.786008559663;5391.816314392678;3899.493065901429;4228.88555722139;4341.240282950487;4364.738115713051;4437.600615944564;4060.776657283848;4414.448193975753;4428.468583769952;4437.511873693891;4491.752953587551;3814.275287695329;4149.564295748948;4188.853390131346;4454.28731402974;4462.174497717916;3375.6455572164814;4011.916782468746;4119.822153026241;4385.736855788631;4440.777961101948;3461.7576769626135;3928.2681452620127;3948.2893079245723;4053.209624123297;4059.6346328830546;4357.455318085239;4426.645868330525;5168.198929165986;5259.921101183485;5312.415634280226;4273.55127711592;4933.506649335073;4953.926790092163;5076.44159142494;5120.132725673635;4645.699204222823;5030.698158110525;5415.212979716724;5645.887082258373;5768.384852241379;3725.5343082114737;4202.831886724527;4403.933940990888;4551.726896386227;4567.771611419449;4914.606831453475;5791.420857914217;6071.696415179267;6102.298235702907;6133.723982420757;4614.676972611952;4624.491305956342;4625.514320996314;4680.4149481314835;4703.330317737223;4399.076193999232;4413.757243351646;4701.741404222732;4737;4771.188897887368;4535.253927238037;4918.680285781413;5067.6452648315;5098.362704661918;5126.846194614168;5396.892062158813;5705.372409035002;5708.145927036482;5712.173582945373;5746.080627099727;1438.6331485471346;1589.8728101751833;1604.5186444066733;1616.744641225484;1642;1079.1366906474789;1150.3886178375042;1208.6917835951776;1208.8065909454444;1211.8727533608844;5089.643724939218;5240.9475905241225;5318.335208098988;5366.543843773245;5444.482774136451;4835.661503694778;5534.7509362078;5900.232969713996;5924.734191382198;5987.251593550806;4624.884377890512;4741.336212930192;5146.562542183881;5350.5987050971335;5392.64947778401;2653.893844246247;2656.72104429036;2780.88876444944;2838.7019362967003;2870.985645071761;4997.90004199914;5588.86027849307;6108.816735497942;6121.234845644294;6189;5133.743312834418;5172.043172013189;5887.76448942046;6092.75628974836;6125.693715314216;5155.236677225571;5194.4027986006995;5553.861458401018;5638.4925356718095;5944;5019.719971407268;5774;5808.751118509541;5829.912551311819;5898.528117750656;4975.502449754996;5209.192575150858;5385.75764090609;5435.83692489226;5787.884242315215;5132.409772876167;6014.939850601438;6066.878662426815;6083.756649733961;6091.837397723922;3960.66334361571;4519.887002824956;4598.815562607734;4622.260438329851;4718.882027949328;5257.106291930305;5637.577181711306;5727.59441034758;5830.804685039472;5946.851328716817;5652.576056795675;5671.517920976763;5677.716114194356;5677.886442271214;5799.333076696234;5317.760700768397;5693.6123006810885;5700.686462244616;5861.648301101947;5884.440623234932;4974.9502504975935;5110.872228194325;5492.752826122914;5524.364698059774;5526.253955715927;5446.836594902159;5667.404922483245;5701.600887937971;5779.7977070804;5784.5249461387075;5007.921712489276;5404.297441332602;5528.861778455571;5534.391216966211;5603.691796951207 05:03:19 INFO - PROCESS | 2079 | |5;yui.html;584.6579750845755;719.658162372873;760.2891296637641;820.5897051474263;829.2826704900261;15184.088954662728;16427.917860410696;16453.93049451785;16465.506034818944;16473.752893706605;15387.615309617266;16293.429729959424;16641.251143698533;16753.99476031439;16783.24475398607;637.289422294141;663.6615326183633;892.4645212872273;914.6295750221171;917.2661870503604;882.3250213586612;902.4044130873625;909.1454033208796;917.6283605139929;918.9494577798218;964.0889359555223;965.9130678238957;967.6661551764665;967.8741763570761;968;896.5338024227365;912.950107376519;960.2174228004154;960.6925783749203;962.1100482054107;569.0752527143392;697.2434908124691;715.2061212054615;716.7849645106447;718.195620904585;15571.844281557152;15732.29204685792;15754.291056902466;15997;16056.197190140447;13885;13954.232517211549;14044.223563130185;14080.647983800385;14094;11609.590401652651;11756.470958806789;11820.290782553075;11842.46708898093;12272.631821045383;3548.4499902514895;3600.4419315006216;3620.7646502977223;3651.8721844735574;3763.34141525232;95472;102065;120611.39694301473;121388.39305803503;122872;10588.576456941637;10641.574337026432;10713.142948564097;10714.839277410845;11205.04757095656;18405.723914141297;22318.776812231994;22392.216272430713;22523.887380562992;22579.548409032057;7080.150381954096;7347.8163045924275;7533.924660753322;7768.067831860213;7906.841863162705;4350.978245108754;4389.606242640752;4431.0694754102;4461.910761784811;4556.88607784808;2562.8718564072096;3217.083131307613;3219.9195020124216;3225.451673215559;3229.531717900938;627.1032423634156;662.5163630549725;663.6084710021111;664.2626684380334;664.4285914113858;654.9836254093591;655;669.3679736225332;678.9626570538668;710.8839122577504;8726.520041397784;9102.317326200562;10206.183505319557;10229.59081636741;10297.10887328513;623.5915475363644;676.8883134282887;707.3492387003865;715.5277516838966;737.2111840330901;3788.8105594720155;4827.720654026686;4938.703677779345;5041.294218809369;5050.065737838511;92371.53814230885;110349.44825275823;111191.44404277927;112083.87916120897;113774;67916.66041669859;84912.15087849043;94521;94722.52638736762;99286;77085;78156.8737250515;79560.6021969898;81341.18658813454;81671;10508.842367364343;10930.617428389969;10951.700142969747;11211.55153793839;11356.602518911799;50727.74636126796;50931.745341273054;51610;52714.73642631762;53159.73420132875;48142.55572332696;63818.68090659517;66665;66790;67795.98306025512;12437.502499899903;12618.43217055253;12814.67963300925;12842.165259258118;12863.742725145632;14300.427982880568;14317.427302908183;14458.349374278394;14895.62760930942;14950.850491494946;13553.322333883068;13577.932378873027;13895.444182233003;14014.313338516306;14354.497592584627;13489.123206991515;13608.523701670394;13669.985704394872;13767.931160344135;13816.861831381959;12733.61799146027;13361.599152025456;13583.932080339535;13700.24648644334;14087.718245635235;11050.447477626247;11233.49449274801;11235.831462527905;11263.549458021915;11632.275763358926;9038.960519540336;9725.805483890425;10679.252452328574;11140.345631764583;11496.48265828023 05:03:19 INFO - PROCESS | 2079 | __end_tp_report 05:03:19 INFO - PROCESS | 2079 | __start_cc_report 05:03:19 INFO - PROCESS | 2079 | _x_x_mozilla_cycle_collect,411 05:03:19 INFO - PROCESS | 2079 | __end_cc_report 05:03:19 INFO - PROCESS | 2079 | __startTimestamp1490270599870__endTimestamp 05:03:19 INFO - PROCESS | 2079 | 05:03:19 INFO - PROCESS | 2079 | ------- Summary: start ------- 05:03:19 INFO - PROCESS | 2079 | Number of tests: 6 05:03:19 INFO - PROCESS | 2079 | 05:03:19 INFO - PROCESS | 2079 | [#0] dojo.html Cycles:165 Average:6049.30 Median:6332.97 stddev:723.01 (11.4%) stddev-sans-first:697.47 05:03:19 INFO - PROCESS | 2079 | Values: 3520.0 3540.8 3547.1 3560.9 3595.9 4922.2 6186.5 6199.5 6222.5 6237.4 6165.9 6202.7 6220.5 6262.0 6281.7 4863.9 5533.3 5614.7 5619.9 5684.6 5666.6 5673.2 5679.7 5680.3 5715.2 5424.6 5441.8 5464.2 5667.2 5669.4 5541.3 5541.9 5575.1 5577.5 5687.0 5508.4 5586.7 5607.5 5631.0 5652.6 4517.9 6287.0 6326.7 6329.3 6343.3 4728.4 5532.5 5885.6 6363.5 6467.7 6605.2 6672.5 6673.4 6683.5 6697.0 6229.6 6307.7 6333.0 6343.8 6362.2 5640.8 6514.8 6586.8 6832.6 6845.8 6361.5 6403.8 6408.1 6422.1 6432.5 6662.9 6674.0 6679.1 6686.8 6694.8 6558.7 6571.8 6584.9 6598.5 6617.4 6327.9 6374.6 6386.9 6535.7 6610.0 5299.5 5307.1 5316.4 5338.5 5355.7 4689.9 4694.9 4705.1 4742.9 4754.9 6123.6 6146.3 6322.1 6350.7 6362.9 6453.4 6544.9 6585.4 6612.5 6635.1 6280.7 6356.0 6359.5 6359.6 6366.3 5829.4 5829.4 5833.2 5834.3 5837.1 6526.7 6596.2 6714.6 6745.6 6870.2 5614.8 6672.1 6678.6 6709.7 6716.3 6732.0 6890.5 6895.9 6898.8 6901.4 5335.7 6334.8 6402.6 6424.1 6588.4 6456.3 6571.2 6615.4 6620.9 6637.2 4611.9 5379.8 6293.5 6316.4 6339.7 6166.8 6444.4 6496.6 6508.8 6522.9 4133.0 5775.8 6261.3 6319.3 6371.6 6450.6 6453.7 6480.8 6489.4 6495.8 6324.9 6346.3 6364.3 6365.1 6367.7 05:03:19 INFO - PROCESS | 2079 | 05:03:19 INFO - PROCESS | 2079 | [#1] ext.html Cycles:180 Average:52574.02 Median:17302.46 stddev:107215.78 (619.7%) stddev-sans-first:107445.90 05:03:19 INFO - PROCESS | 2079 | Values: 733.8 810.8 817.6 942.0 943.8 37233.0 38089.6 39278.0 39359.2 39580.2 38205.7 38245.0 38296.9 38336.2 38336.8 7832.2 10565.2 10786.8 10909.1 10941.5 8532.8 9626.3 10649.1 10722.2 10764.9 9044.2 10751.4 10754.0 10761.5 10767.4 8815.8 10731.0 10747.1 10747.7 10769.3 8622.3 10526.3 10534.1 10534.9 10535.0 32875.3 32892.2 33159.5 33169.0 33194.2 3695.6 3711.7 3716.1 3767.1 3770.9 24516.8 25393.0 25411.9 25448.5 25495.7 3021.8 3057.7 3088.2 3139.9 3239.3 307480.5 344822.0 346241.3 346652.0 347562.0 34379.0 42967.6 43070.4 43274.0 43500.0 44879.0 44901.8 45146.5 45161.8 45278.0 13670.9 13687.7 13783.4 13793.9 13797.9 11888.2 11891.9 11896.6 11911.7 11911.9 9380.6 10341.4 11764.9 11868.5 11876.8 5583.7 5603.3 5634.0 5650.6 5672.1 950.0 1022.6 1098.0 1103.3 1107.4 22274.6 24680.6 24789.5 25927.0 26914.2 1061.4 1132.1 1174.8 1239.9 1256.7 10599.8 13152.7 13550.5 13718.0 13947.2 398080.0 399109.0 401205.0 403374.0 405507.0 37217.0 55145.4 55251.0 55755.4 55815.0 1391.3 1409.6 1427.3 1429.6 1430.9 23893.0 24989.8 26218.2 26291.3 26990.3 36836.0 38934.0 39034.2 39134.8 39139.2 410013.9 469104.0 474394.0 476023.0 476163.0 27502.6 27778.7 27787.4 27813.3 27854.0 36914.3 38519.4 38869.0 39579.6 39893.0 26619.6 31288.5 31697.4 32208.6 32479.2 26576.6 32023.8 32309.0 32582.8 32827.0 25612.8 31465.1 31522.5 31595.8 32122.7 28931.3 29111.7 29136.0 29187.9 29265.3 22371.7 22544.3 22590.2 22719.4 22744.4 05:03:19 INFO - PROCESS | 2079 | 05:03:19 INFO - PROCESS | 2079 | [#2] jquery.html Cycles:180 Average:41106.64 Median:22004.95 stddev:124799.21 (567.1%) stddev-sans-first:125111.88 05:03:19 INFO - PROCESS | 2079 | Values: 402.8 409.7 414.6 414.9 420.4 19972.6 20694.9 20741.3 20986.8 21234.7 21598.0 21654.8 21971.1 22225.3 22335.0 6447.8 6775.9 6784.9 6794.4 6800.3 6374.9 6629.4 6668.1 6668.3 6717.9 6657.2 6690.5 6714.4 6717.2 6732.7 5311.4 6598.5 6624.0 6636.4 6650.6 5327.0 6393.7 6428.3 6469.8 6492.2 25301.5 25513.7 25573.5 25579.4 25755.7 2965.9 3302.6 3333.4 3428.9 3473.8 15190.2 15718.4 16682.6 16803.5 16860.0 2055.6 2147.1 2151.5 2151.7 2161.4 110477.0 120881.4 123110.4 123617.4 123946.4 21308.9 22339.3 22536.7 22756.9 22965.3 35875.8 36152.8 36594.1 36641.5 36647.5 10772.6 10963.5 11091.5 11121.4 11133.3 9041.5 9051.3 9052.6 9178.9 9256.9 10536.9 10584.5 10658.6 10811.5 10816.4 3585.9 4035.8 4238.5 4436.6 4440.8 764.6 908.2 925.3 955.7 972.2 17067.8 20131.0 21334.4 22038.8 22195.6 869.7 881.8 900.7 960.2 994.8 10601.8 11617.7 11830.8 11837.5 12137.6 732967.0 751527.0 757623.2 772813.0 773879.0 119764.4 122150.0 123298.4 124583.4 125640.0 1212.9 1263.9 1269.9 1274.1 1310.2 16946.3 17215.6 18810.9 19474.2 19475.5 52122.0 53007.9 53923.7 54264.0 54543.0 70990.0 72828.0 72897.0 74373.6 74609.6 8064.0 10001.9 11671.9 11910.9 12203.2 13130.4 13221.1 13351.9 13442.9 13518.7 11005.5 11242.8 11268.8 11378.2 11432.6 11193.9 11405.6 11490.7 11566.8 11633.2 11268.7 11338.6 11474.9 11688.5 11805.4 11758.6 11909.6 12005.8 12080.4 12092.2 11132.3 11133.9 11235.0 11298.0 11460.7 05:03:19 INFO - PROCESS | 2079 | 05:03:19 INFO - PROCESS | 2079 | [#3] mootools.html Cycles:180 Average:6731.81 Median:3077.70 stddev:4283.31 (139.2%) stddev-sans-first:4275.69 05:03:19 INFO - PROCESS | 2079 | Values: 1274.4 1564.7 1590.8 1611.8 1616.1 10892.0 11128.7 11462.3 11487.8 11626.4 9458.9 11224.2 11379.4 11443.1 11475.0 2134.3 2165.7 2166.3 2169.6 2171.8 2018.8 2310.4 2354.2 2356.1 2364.9 2316.5 2333.3 2336.5 2339.3 2345.0 2285.6 2288.1 2299.6 2304.1 2311.1 2294.6 2342.3 2352.2 2353.0 2355.6 11480.7 11538.7 11563.3 11569.8 11587.8 5532.8 5645.9 5673.2 5704.4 5713.3 2920.2 3235.2 3250.8 3311.8 3342.3 974.9 1120.5 1172.5 1186.2 1193.1 13709.5 13863.6 14013.0 14878.9 14919.1 4325.3 4471.5 4583.6 4597.6 4607.5 11935.4 12010.9 12041.8 12056.8 12065.8 5468.1 5514.2 5516.1 5536.9 5545.3 3959.6 5048.3 5063.8 5097.6 5234.5 3761.2 3779.2 3782.8 3860.3 3867.4 872.2 957.8 966.1 967.9 977.0 924.0 934.7 940.8 951.7 993.6 6658.9 6682.5 6695.3 6914.3 6942.9 962.8 972.7 1013.1 1021.4 1044.6 4093.6 4198.2 4237.0 4308.5 4339.9 13679.4 14037.4 14122.9 14174.8 14240.9 13540.6 13812.2 14063.0 14081.6 14179.4 8852.5 10189.2 10249.2 10386.7 10419.1 6369.6 6806.1 7033.9 7061.9 7079.9 11941.8 12220.4 12251.9 12286.6 12353.9 12461.3 12608.7 12731.6 12921.7 12923.9 8487.6 8514.7 8526.6 8563.2 8572.7 10366.9 10414.6 10497.2 10517.4 10553.8 7720.8 9192.6 9215.4 9221.0 9440.0 8779.9 8906.0 9005.2 9162.1 9173.5 7663.6 7813.1 7847.9 7905.5 7932.4 5785.1 5861.1 5871.6 5982.6 6120.2 6036.4 6047.1 6053.2 6054.8 6129.4 05:03:19 INFO - PROCESS | 2079 | 05:03:19 INFO - PROCESS | 2079 | [#4] prototype.html Cycles:180 Average:4717.47 Median:5115.50 stddev:1340.56 (26.2%) stddev-sans-first:1302.61 05:03:19 INFO - PROCESS | 2079 | Values: 297.0 330.3 381.2 384.0 385.6 5376.2 5413.2 5452.7 5526.7 5545.1 4427.5 4524.9 4543.6 5349.8 5391.8 3899.5 4228.9 4341.2 4364.7 4437.6 4060.8 4414.4 4428.5 4437.5 4491.8 3814.3 4149.6 4188.9 4454.3 4462.2 3375.6 4011.9 4119.8 4385.7 4440.8 3461.8 3928.3 3948.3 4053.2 4059.6 4357.5 4426.6 5168.2 5259.9 5312.4 4273.6 4933.5 4953.9 5076.4 5120.1 4645.7 5030.7 5415.2 5645.9 5768.4 3725.5 4202.8 4403.9 4551.7 4567.8 4914.6 5791.4 6071.7 6102.3 6133.7 4614.7 4624.5 4625.5 4680.4 4703.3 4399.1 4413.8 4701.7 4737.0 4771.2 4535.3 4918.7 5067.6 5098.4 5126.8 5396.9 5705.4 5708.1 5712.2 5746.1 1438.6 1589.9 1604.5 1616.7 1642.0 1079.1 1150.4 1208.7 1208.8 1211.9 5089.6 5240.9 5318.3 5366.5 5444.5 4835.7 5534.8 5900.2 5924.7 5987.3 4624.9 4741.3 5146.6 5350.6 5392.6 2653.9 2656.7 2780.9 2838.7 2871.0 4997.9 5588.9 6108.8 6121.2 6189.0 5133.7 5172.0 5887.8 6092.8 6125.7 5155.2 5194.4 5553.9 5638.5 5944.0 5019.7 5774.0 5808.8 5829.9 5898.5 4975.5 5209.2 5385.8 5435.8 5787.9 5132.4 6014.9 6066.9 6083.8 6091.8 3960.7 4519.9 4598.8 4622.3 4718.9 5257.1 5637.6 5727.6 5830.8 5946.9 5652.6 5671.5 5677.7 5677.9 5799.3 5317.8 5693.6 5700.7 5861.6 5884.4 4975.0 5110.9 5492.8 5524.4 5526.3 5446.8 5667.4 5701.6 5779.8 5784.5 5007.9 5404.3 5528.9 5534.4 5603.7 05:03:19 INFO - PROCESS | 2079 | 05:03:19 INFO - PROCESS | 2079 | [#5] yui.html Cycles:180 Average:20851.65 Median:3610.60 stddev:30353.74 (840.7%) stddev-sans-first:30400.74 05:03:19 INFO - PROCESS | 2079 | Values: 584.7 719.7 760.3 820.6 829.3 15184.1 16427.9 16453.9 16465.5 16473.8 15387.6 16293.4 16641.3 16754.0 16783.2 637.3 663.7 892.5 914.6 917.3 882.3 902.4 909.1 917.6 918.9 964.1 965.9 967.7 967.9 968.0 896.5 913.0 960.2 960.7 962.1 569.1 697.2 715.2 716.8 718.2 15571.8 15732.3 15754.3 15997.0 16056.2 13885.0 13954.2 14044.2 14080.6 14094.0 11609.6 11756.5 11820.3 11842.5 12272.6 3548.4 3600.4 3620.8 3651.9 3763.3 95472.0 102065.0 120611.4 121388.4 122872.0 10588.6 10641.6 10713.1 10714.8 11205.0 18405.7 22318.8 22392.2 22523.9 22579.5 7080.2 7347.8 7533.9 7768.1 7906.8 4351.0 4389.6 4431.1 4461.9 4556.9 2562.9 3217.1 3219.9 3225.5 3229.5 627.1 662.5 663.6 664.3 664.4 655.0 655.0 669.4 679.0 710.9 8726.5 9102.3 10206.2 10229.6 10297.1 623.6 676.9 707.3 715.5 737.2 3788.8 4827.7 4938.7 5041.3 5050.1 92371.5 110349.4 111191.4 112083.9 113774.0 67916.7 84912.2 94521.0 94722.5 99286.0 77085.0 78156.9 79560.6 81341.2 81671.0 10508.8 10930.6 10951.7 11211.6 11356.6 50727.7 50931.7 51610.0 52714.7 53159.7 48142.6 63818.7 66665.0 66790.0 67796.0 12437.5 12618.4 12814.7 12842.2 12863.7 14300.4 14317.4 14458.3 14895.6 14950.9 13553.3 13577.9 13895.4 14014.3 14354.5 13489.1 13608.5 13670.0 13767.9 13816.9 12733.6 13361.6 13583.9 13700.2 14087.7 11050.4 11233.5 11235.8 11263.5 11632.3 9039.0 9725.8 10679.3 11140.3 11496.5 05:03:19 INFO - PROCESS | 2079 | -------- Summary: end -------- 05:03:19 INFO - PROCESS | 2079 | 05:03:20 INFO - TEST-INFO | 2079: exit 0 05:03:20 INFO - TEST-OK | dromaeo_css | took 1116806ms 05:03:20 INFO - TEST-START | kraken 05:03:20 INFO - operating with platform_type : mac_ 05:03:20 INFO - Initialising browser for kraken test... 05:03:20 INFO - TEST-INFO | started process 2198 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/tmpWY06CB/profile http://localhost:53401/getInfo.html) 05:03:23 INFO - PROCESS | 2198 | 2017-03-23 05:03:23.250 plugin-container[2199:19069] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4643, name = 'com.apple.tsm.portname' 05:03:23 INFO - PROCESS | 2198 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:03:23 INFO - PROCESS | 2198 | 2017-03-23 05:03:23.253 plugin-container[2199:19069] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b1b, name = 'com.apple.CFPasteboardClient' 05:03:23 INFO - PROCESS | 2198 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:03:23 INFO - PROCESS | 2198 | 2017-03-23 05:03:23.253 plugin-container[2199:19069] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:03:23 INFO - PROCESS | 2198 | __metrics Screen width/height:1600/1200 05:03:23 INFO - PROCESS | 2198 | colorDepth:24 05:03:23 INFO - PROCESS | 2198 | Browser inner width/height: 1024/689 05:03:23 INFO - PROCESS | 2198 | __metrics 05:03:23 ERROR - PROCESS | 2198 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 05:03:24 INFO - TEST-INFO | 2198: exit 0 05:03:24 INFO - Browser initialized. 05:03:24 INFO - Running cycle 1/1 for kraken test... 05:03:24 INFO - TEST-INFO | started process 2200 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/tmpWY06CB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:03:26 INFO - PROCESS | 2200 | 2017-03-23 05:03:26.481 plugin-container[2201:19196] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 05:03:26 INFO - PROCESS | 2200 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:03:26 INFO - PROCESS | 2200 | 2017-03-23 05:03:26.482 plugin-container[2201:19196] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x471b, name = 'com.apple.CFPasteboardClient' 05:03:26 INFO - PROCESS | 2200 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:03:26 INFO - PROCESS | 2200 | 2017-03-23 05:03:26.482 plugin-container[2201:19196] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:03:36 INFO - PROCESS | 2200 | RSS: Main: 221188096 05:03:36 INFO - PROCESS | 2200 | 05:03:39 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:53401/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53401/tests/kraken/driver.html?testName=audio-beat-detection) 05:03:40 INFO - PROCESS | 2200 | RSS: Main: 235552768 05:03:40 INFO - PROCESS | 2200 | 05:03:42 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:53401/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53401/tests/kraken/driver.html?testName=audio-dft) 05:03:43 INFO - PROCESS | 2200 | RSS: Main: 243675136 05:03:43 INFO - PROCESS | 2200 | 05:03:46 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:53401/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53401/tests/kraken/driver.html?testName=audio-fft) 05:03:47 INFO - PROCESS | 2200 | RSS: Main: 247308288 05:03:47 INFO - PROCESS | 2200 | 05:03:49 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:53401/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53401/tests/kraken/driver.html?testName=audio-oscillator) 05:03:50 INFO - PROCESS | 2200 | RSS: Main: 247799808 05:03:50 INFO - PROCESS | 2200 | 05:03:52 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:53401/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53401/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:03:52 INFO - PROCESS | 2200 | RSS: Main: 247721984 05:03:52 INFO - PROCESS | 2200 | 05:03:56 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:53401/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53401/tests/kraken/driver.html?testName=imaging-darkroom) 05:03:56 INFO - PROCESS | 2200 | RSS: Main: 251703296 05:03:56 INFO - PROCESS | 2200 | 05:03:59 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:53401/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53401/tests/kraken/driver.html?testName=imaging-desaturate) 05:04:00 INFO - PROCESS | 2200 | RSS: Main: 250920960 05:04:00 INFO - PROCESS | 2200 | 05:04:03 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:53401/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53401/tests/kraken/driver.html?testName=json-parse-financial) 05:04:04 INFO - PROCESS | 2200 | RSS: Main: 251158528 05:04:04 INFO - PROCESS | 2200 | 05:04:05 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:53401/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53401/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:04:06 INFO - PROCESS | 2200 | RSS: Main: 251760640 05:04:06 INFO - PROCESS | 2200 | 05:04:08 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:53401/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53401/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:04:09 INFO - PROCESS | 2200 | RSS: Main: 251842560 05:04:09 INFO - PROCESS | 2200 | 05:04:11 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:53401/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53401/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:04:11 INFO - PROCESS | 2200 | RSS: Main: 251985920 05:04:11 INFO - PROCESS | 2200 | 05:04:14 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:53401/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:04:15 INFO - PROCESS | 2200 | RSS: Main: 252162048 05:04:15 INFO - PROCESS | 2200 | 05:04:18 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:53401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:04:19 INFO - PROCESS | 2200 | RSS: Main: 252096512 05:04:19 INFO - PROCESS | 2200 | 05:04:21 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:53401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53401/tests/kraken/driver.html?testName=ai-astar) 05:04:21 INFO - PROCESS | 2200 | RSS: Main: 254050304 05:04:21 INFO - PROCESS | 2200 | 05:04:21 INFO - PROCESS | 2200 | __start_tp_report 05:04:21 INFO - PROCESS | 2200 | _x_x_mozilla_page_load 05:04:21 INFO - PROCESS | 2200 | _x_x_mozilla_page_load_details 05:04:21 INFO - PROCESS | 2200 | |i|pagename|runs| 05:04:21 INFO - PROCESS | 2200 | |0;ai-astar;106;119;118;116;118;119;123;118;119;119 05:04:21 INFO - PROCESS | 2200 | |1;audio-beat-detection;149;141;139;145;112;128;111;114;126;147 05:04:21 INFO - PROCESS | 2200 | |2;audio-dft;198;195;199;195;191;269;220;198;198;204 05:04:21 INFO - PROCESS | 2200 | |3;audio-fft;87;56;60;91;74;82;68;59;76;60 05:04:21 INFO - PROCESS | 2200 | |4;audio-oscillator;93;71;87;72;70;75;115;107;99;83 05:04:21 INFO - PROCESS | 2200 | |5;imaging-gaussian-blur;137;91;97;135;105;136;116;81;135;134 05:04:21 INFO - PROCESS | 2200 | |6;imaging-darkroom;97;125;98;98;98;98;99;99;98;98 05:04:21 INFO - PROCESS | 2200 | |7;imaging-desaturate;121;93;146;137;85;91;88;91;91;91 05:04:21 INFO - PROCESS | 2200 | |8;json-parse-financial;66;65;64;66;68;68;68;69;69;68 05:04:21 INFO - PROCESS | 2200 | |9;json-stringify-tinderbox;59;58;65;63;56;57;62;60;61;59 05:04:21 INFO - PROCESS | 2200 | |10;stanford-crypto-aes;87;88;87;87;83;85;83;85;87;93 05:04:21 INFO - PROCESS | 2200 | |11;stanford-crypto-ccm;142;147;142;149;158;150;149;147;171;177 05:04:21 INFO - PROCESS | 2200 | |12;stanford-crypto-pbkdf2;165;171;209;224;149;211;228;169;165;167 05:04:21 INFO - PROCESS | 2200 | |13;stanford-crypto-sha256-iterative;65;68;71;66;87;65;67;65;66;66 05:04:21 INFO - PROCESS | 2200 | __end_tp_report 05:04:21 INFO - PROCESS | 2200 | __start_cc_report 05:04:21 INFO - PROCESS | 2200 | _x_x_mozilla_cycle_collect,1018 05:04:21 INFO - PROCESS | 2200 | __end_cc_report 05:04:21 INFO - PROCESS | 2200 | __startTimestamp1490270661295__endTimestamp 05:04:21 INFO - PROCESS | 2200 | 05:04:21 INFO - PROCESS | 2200 | ------- Summary: start ------- 05:04:21 INFO - PROCESS | 2200 | Number of tests: 14 05:04:21 INFO - PROCESS | 2200 | 05:04:21 INFO - PROCESS | 2200 | [#0] ai-astar Cycles:10 Average:117.50 Median:119.00 stddev:4.40 (3.7%) stddev-sans-first:1.86 05:04:21 INFO - PROCESS | 2200 | Values: 106.0 119.0 118.0 116.0 118.0 119.0 123.0 118.0 119.0 119.0 05:04:21 INFO - PROCESS | 2200 | 05:04:21 INFO - PROCESS | 2200 | [#1] audio-beat-detection Cycles:10 Average:131.20 Median:140.00 stddev:14.99 (10.7%) stddev-sans-first:14.45 05:04:21 INFO - PROCESS | 2200 | Values: 149.0 141.0 139.0 145.0 112.0 128.0 111.0 114.0 126.0 147.0 05:04:21 INFO - PROCESS | 2200 | 05:04:21 INFO - PROCESS | 2200 | [#2] audio-dft Cycles:10 Average:206.70 Median:198.50 stddev:23.27 (11.7%) stddev-sans-first:24.46 05:04:21 INFO - PROCESS | 2200 | Values: 198.0 195.0 199.0 195.0 191.0 269.0 220.0 198.0 198.0 204.0 05:04:21 INFO - PROCESS | 2200 | 05:04:21 INFO - PROCESS | 2200 | [#3] audio-fft Cycles:10 Average:71.30 Median:75.00 stddev:12.61 (16.8%) stddev-sans-first:12.02 05:04:21 INFO - PROCESS | 2200 | Values: 87.0 56.0 60.0 91.0 74.0 82.0 68.0 59.0 76.0 60.0 05:04:21 INFO - PROCESS | 2200 | 05:04:21 INFO - PROCESS | 2200 | [#4] audio-oscillator Cycles:10 Average:87.20 Median:79.00 stddev:15.96 (20.2%) stddev-sans-first:16.79 05:04:21 INFO - PROCESS | 2200 | Values: 93.0 71.0 87.0 72.0 70.0 75.0 115.0 107.0 99.0 83.0 05:04:21 INFO - PROCESS | 2200 | 05:04:21 INFO - PROCESS | 2200 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:136.50 stddev:21.64 (15.9%) stddev-sans-first:21.67 05:04:21 INFO - PROCESS | 2200 | Values: 137.0 91.0 97.0 135.0 105.0 136.0 116.0 81.0 135.0 134.0 05:04:21 INFO - PROCESS | 2200 | 05:04:21 INFO - PROCESS | 2200 | [#6] imaging-darkroom Cycles:10 Average:100.80 Median:98.00 stddev:8.52 (8.7%) stddev-sans-first:8.93 05:04:21 INFO - PROCESS | 2200 | Values: 97.0 125.0 98.0 98.0 98.0 98.0 99.0 99.0 98.0 98.0 05:04:21 INFO - PROCESS | 2200 | 05:04:21 INFO - PROCESS | 2200 | [#7] imaging-desaturate Cycles:10 Average:103.40 Median:91.00 stddev:22.49 (24.7%) stddev-sans-first:22.94 05:04:21 INFO - PROCESS | 2200 | Values: 121.0 93.0 146.0 137.0 85.0 91.0 88.0 91.0 91.0 91.0 05:04:21 INFO - PROCESS | 2200 | 05:04:21 INFO - PROCESS | 2200 | [#8] json-parse-financial Cycles:10 Average:67.10 Median:68.00 stddev:1.73 (2.5%) stddev-sans-first:1.79 05:04:21 INFO - PROCESS | 2200 | Values: 66.0 65.0 64.0 66.0 68.0 68.0 68.0 69.0 69.0 68.0 05:04:21 INFO - PROCESS | 2200 | 05:04:21 INFO - PROCESS | 2200 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.50 stddev:2.79 (4.6%) stddev-sans-first:2.93 05:04:21 INFO - PROCESS | 2200 | Values: 59.0 58.0 65.0 63.0 56.0 57.0 62.0 60.0 61.0 59.0 05:04:21 INFO - PROCESS | 2200 | 05:04:21 INFO - PROCESS | 2200 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:87.00 stddev:2.88 (3.3%) stddev-sans-first:3.05 05:04:21 INFO - PROCESS | 2200 | Values: 87.0 88.0 87.0 87.0 83.0 85.0 83.0 85.0 87.0 93.0 05:04:21 INFO - PROCESS | 2200 | 05:04:21 INFO - PROCESS | 2200 | [#11] stanford-crypto-ccm Cycles:10 Average:153.20 Median:149.50 stddev:11.92 (8.0%) stddev-sans-first:11.94 05:04:21 INFO - PROCESS | 2200 | Values: 142.0 147.0 142.0 149.0 158.0 150.0 149.0 147.0 171.0 177.0 05:04:21 INFO - PROCESS | 2200 | 05:04:21 INFO - PROCESS | 2200 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.80 Median:190.00 stddev:28.84 (15.2%) stddev-sans-first:29.59 05:04:21 INFO - PROCESS | 2200 | Values: 165.0 171.0 209.0 224.0 149.0 211.0 228.0 169.0 165.0 167.0 05:04:21 INFO - PROCESS | 2200 | 05:04:21 INFO - PROCESS | 2200 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:66.50 stddev:6.72 (10.1%) stddev-sans-first:7.00 05:04:21 INFO - PROCESS | 2200 | Values: 65.0 68.0 71.0 66.0 87.0 65.0 67.0 65.0 66.0 66.0 05:04:21 INFO - PROCESS | 2200 | -------- Summary: end -------- 05:04:21 INFO - PROCESS | 2200 | 05:04:22 INFO - TEST-INFO | 2200: exit 0 05:04:22 INFO - TEST-OK | kraken | took 61824ms 05:04:22 INFO - SUITE-END | took 1178s 05:04:22 INFO - Completed test suite (00:19:38) 05:04:22 INFO - javascript benchmark 05:04:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7671.033595094492, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3519.9648003519965, 3540.8052557109363, 3547.130952916536, 3560.875369362071, 3595.9280814383715, 4922.237053256742, 6186.463549944524, 6199.535034872386, 6222.533310001745, 6237.438630523252, 6165.907511387333, 6202.689865506729, 6220.533459990496, 6262.029385445252, 6281.685915704208, 4863.902721945577, 5533.335999680044, 5614.719264036802, 5619.943800562003, 5684.630499017571, 5666.603337766337, 5673.177389278552, 5679.744411501471, 5680.318361796591, 5715.171300161474, 5424.647397919142, 5441.782328706847, 5464.180372944051, 5667.206591077253, 5669.433056694339, 5541.307336582927, 5541.944580554204, 5575.107982722745, 5577.470140336662, 5686.9715651421475, 5508.421615730371, 5586.720663966786, 5607.523360514361, 5631.042722737145, 5652.63257888236, 4517.909641807146, 6287.0, 6326.68366581669, 6329.272133704637, 6343.333949935237, 4728.361671174382, 5532.529734972532, 5885.558583106242, 6363.522735794788, 6467.708953097075, 6605.207375114969, 6672.466202703772, 6673.366030227169, 6683.53215274931, 6696.966515167393, 6229.595076320024, 6307.747690092345, 6332.968335158294, 6343.809685709436, 6362.236531616236, 5640.802571909963, 6514.837129071811, 6586.8353291168105, 6832.624205668637, 6845.828854278583, 6361.522885783585, 6403.839904002344, 6408.10286559882, 6422.100905873182, 6432.549721519449, 6662.933370666231, 6674.0, 6679.131712877392, 6686.765963191265, 6694.799156025327, 6558.672066396661, 6571.83570410734, 6584.9012264816065, 6598.505112116611, 6617.371349721769, 6327.936720632827, 6374.617522948638, 6386.8722625547225, 6535.738570457223, 6610.0, 5299.4700529946695, 5307.071262529042, 5316.362036555638, 5338.54622357104, 5355.678659280456, 4689.929651055237, 4694.906101878011, 4705.082508910729, 4742.928856067162, 4754.928676069792, 6123.571350005457, 6146.262448506208, 6322.083297921868, 6350.68246587678, 6362.91830388835, 6453.419192272718, 6544.901826472606, 6585.407313341726, 6612.471002319803, 6635.085299673216, 6280.717367718372, 6356.0, 6359.459445947146, 6359.554831161867, 6366.299707032223, 5829.387914268941, 5829.4170582942215, 5833.183354330397, 5834.3290521589715, 5837.09525023622, 6526.738930442729, 6596.175478065242, 6714.630695311609, 6745.561538500178, 6870.175578930361, 5614.775408983595, 6672.096009432966, 6678.599284042973, 6709.664516774239, 6716.261211266855, 6732.0, 6890.517663763489, 6895.931040689529, 6898.827529311808, 6901.447884169354, 5335.653182543122, 6334.841628959129, 6402.6158430494315, 6424.100625912282, 6588.40704336612, 6456.2575303838785, 6571.244306904767, 6615.4376877965915, 6620.867582648224, 6637.203535575762, 4611.907761844812, 5379.811706590251, 6293.527985401021, 6316.368363163647, 6339.714712837841, 6166.753329866755, 6444.355564443518, 6496.642684652389, 6508.837279068061, 6522.934770652233, 4133.0, 5775.826725198251, 6261.3112557617715, 6319.3364696706185, 6371.55399122057, 6450.645214513247, 6453.741850325934, 6480.837979050561, 6489.448396886318, 6495.772647957488, 6324.936750632435, 6346.301906790157, 6364.268109167505, 6365.14070600463, 6367.745290188341], "value": 6007.582688747029, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.8495608400278, 810.8378324335133, 817.5544328341056, 941.9952900235497, 943.8018016216594, 37233.0, 38089.61910380895, 39278.0, 39359.21281574367, 39580.2083958321, 38205.66280180194, 38245.0, 38296.85109446714, 38336.233275334474, 38336.808315958384, 7832.216778322165, 10565.207609429284, 10786.784264314709, 10909.07272881806, 10941.507632156572, 8532.78668033301, 9626.278029147807, 10649.148068154567, 10722.195835312345, 10764.946175269113, 9044.186023257906, 10751.354918704903, 10753.978372054642, 10761.461926903663, 10767.407792571405, 8815.823683526325, 10731.034206921375, 10747.140228781756, 10747.731306717356, 10769.299995500267, 8622.267107295887, 10526.31578947366, 10534.104601108915, 10534.947325263325, 10535.0, 32875.342493150005, 32892.17769555756, 33159.502607460905, 33169.0, 33194.170145746306, 3695.5565332160045, 3711.7030637548933, 3716.099940642174, 3767.1335592813807, 3770.872332459753, 24516.754832451625, 25393.0, 25411.872940635363, 25448.491030179477, 25495.72521373924, 3021.818690878554, 3057.6636569977286, 3088.1507585413965, 3139.8587063581967, 3239.271163988107, 307480.46259768785, 344822.0, 346241.2687936544, 346652.0, 347562.0, 34379.0, 42967.57032429698, 43070.35394469023, 43274.0, 43500.0, 44879.0, 44901.775491122986, 45146.54853451424, 45161.77419112883, 45278.0, 13670.931645341909, 13687.726245475034, 13783.379747911367, 13793.931030344784, 13797.931010344884, 11888.227265227733, 11891.940540297242, 11896.583619573274, 11911.702207444883, 11911.880881191251, 9380.577873995686, 10341.4312212829, 11764.941155296065, 11868.465919033664, 11876.762464750656, 5583.720813959367, 5603.327600687943, 5634.0, 5650.576206784508, 5672.12082127271, 949.9810003799886, 1022.6318525330875, 1098.0447011100393, 1103.3324838472608, 1107.3733522713178, 22274.554508909732, 24680.629790553157, 24789.50420991606, 25927.0, 26914.192574222805, 1061.4268295120548, 1132.1056365471186, 1174.8472698549133, 1239.8822111899356, 1256.7298030923396, 10599.788004239872, 13152.684731526771, 13550.525731599346, 13717.971152163627, 13947.232902190273, 398080.0, 399109.0, 401205.0, 403374.0, 405507.0, 37217.0, 55145.44854551483, 55251.0, 55755.44244557503, 55815.0, 1391.3460673483648, 1409.5912185466304, 1427.257825930531, 1429.5997120806192, 1430.9212993285469, 23893.0, 24989.750102498743, 26218.21345359642, 26291.342716432242, 26990.32524186911, 36836.0, 38934.0, 39034.2193156141, 39134.804325978184, 39139.2172156561, 410013.94993024843, 469104.0, 474394.0, 476023.0, 476163.0, 27502.587461187697, 27778.722212777615, 27787.44425111446, 27813.304667383476, 27854.0, 36914.261714765016, 38519.422208667456, 38869.0, 39579.60420395759, 39893.0026749322, 26619.60070598904, 31288.530672039484, 31697.366052678357, 32208.55061522284, 32479.18802029968, 26576.601350980138, 32023.839880800446, 32309.0, 32582.83708581442, 32827.0, 25612.847421866434, 31465.056048318587, 31522.527162092127, 31595.84202078975, 32122.678773212905, 28931.276718082216, 29111.708882910898, 29136.0, 29187.85406072956, 29265.268368290963, 22371.664425033312, 22544.323670289916, 22590.209342672926, 22719.432014199778, 22744.43138921474], "value": 17781.275578428857, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.8207447685781, 409.72138945517077, 414.6371924566005, 414.906646004649, 420.3610512021728, 19972.601917865755, 20694.86178260195, 20741.274055408063, 20986.790132098675, 21234.681479777795, 21598.0, 21654.783452165473, 21971.121155153774, 22225.333240002827, 22334.994925228362, 6447.838804029901, 6775.898361524581, 6784.932150678479, 6794.3545363190415, 6800.285969973156, 6374.904376434357, 6629.370209830083, 6668.099806526129, 6668.333166683341, 6717.932820671804, 6657.234418041915, 6690.531662783607, 6714.429273511733, 6717.1939367276, 6732.663366831639, 5311.389190243133, 6598.538102332863, 6623.966880165616, 6636.435902948255, 6650.634215118166, 5327.0, 6393.680315984182, 6428.292887782341, 6469.805905822833, 6492.220933487964, 25301.493970120493, 25513.74486255151, 25573.48853022948, 25579.360515987064, 25755.742442575523, 2965.851707414642, 3302.554155189043, 3333.3666603345287, 3428.862845486178, 3473.808940508271, 15190.164540950243, 15718.37126514938, 16682.58293542659, 16803.495895123167, 16860.0, 2055.5683306505653, 2147.14114354258, 2151.4513798981316, 2151.66649169379, 2161.3948094533557, 110477.0, 120881.39559302235, 123110.38444807718, 123617.38191309077, 123946.38026809899, 21308.893455532623, 22339.329820105424, 22536.661950070764, 22756.886215568815, 22965.311040668807, 35875.82062089673, 36152.819235903655, 36594.08514787152, 36641.45037824435, 36647.450288245695, 10772.569097236179, 10963.451827408599, 11091.500882460146, 11121.388323642277, 11133.332000080021, 9041.50271735061, 9051.27589792815, 9052.637894484147, 9178.908210917938, 9256.90743092574, 10536.947315263527, 10584.470776461147, 10658.573657053787, 10811.459427028618, 10816.351018938889, 3585.928281434357, 4035.8094362162647, 4238.533761286256, 4436.600705936481, 4440.845380201106, 764.5603777827771, 908.1599520443564, 925.2967744514083, 955.7371722776153, 972.2270794718216, 17067.829321706624, 20130.993450327423, 21334.35996920095, 22038.787866667168, 22195.556088878133, 869.7434256894231, 881.8192270584515, 900.7297810656908, 960.2078285414561, 994.7811481474064, 10601.787964240671, 11617.658043472882, 11830.763384732258, 11837.526498940118, 12137.635870923887, 732967.0, 751527.0, 757623.211883937, 772813.0, 773879.0, 119764.40117799355, 122150.0, 123298.38350808188, 124583.377083114, 125640.0, 1212.8726483719083, 1263.8925691316158, 1269.8730126987411, 1274.0635632809876, 1310.2335133946558, 16946.322147113977, 17215.56961075983, 18810.905945470186, 19474.221031159163, 19475.513112171742, 52122.0, 53007.93984120373, 53923.73038134784, 54264.0, 54543.0, 70990.0, 72828.0, 72897.0, 74373.62813186116, 74609.62695186489, 8063.959680201561, 10001.949990250003, 11671.941640292083, 11910.940445298065, 12203.20679155852, 13130.407650819878, 13221.140625859673, 13351.866481335452, 13442.865571344162, 13518.662033449242, 11005.504752286006, 11242.831357529807, 11268.774624507629, 11378.203525753117, 11432.599859004895, 11193.888061119285, 11405.600803971822, 11490.712732181762, 11566.768664626828, 11633.243839150427, 11268.718282042686, 11338.60314888975, 11474.885251147381, 11688.532458701897, 11805.350705711267, 11758.58844940423, 11909.642710718692, 12005.81991270149, 12080.39598020113, 12092.214006089576, 11132.332060076422, 11133.888661113286, 11235.045021173291, 11298.0, 11460.713482163013], "value": 11467.038464282481, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1274.4201388368294, 1564.710528552218, 1590.7671554545234, 1611.7824093747345, 1616.0949868073878, 10892.0, 11128.721781955455, 11462.254953428032, 11487.770244595104, 11626.360550169748, 9458.85811712825, 11224.158188135902, 11379.431028448565, 11443.084553235742, 11475.024622907042, 2134.253011445989, 2165.6859755335468, 2166.306781829815, 2169.609470295346, 2171.81539569136, 2018.818306352428, 2310.445493081665, 2354.1642716835536, 2356.1164563288767, 2364.9054037838464, 2316.4672125411166, 2333.346662934381, 2336.4509340305017, 2339.321596736953, 2344.9882750586307, 2285.6228722260807, 2288.0504590594883, 2299.632058870581, 2304.124432715566, 2311.075569772088, 2294.552562250362, 2342.3441436397834, 2352.176738141654, 2352.9764702352927, 2355.599548076831, 11480.655580332603, 11538.653840384803, 11563.30620162793, 11569.768604627945, 11587.826182607268, 5532.806351777668, 5645.887082258373, 5673.177389278531, 5704.429557044304, 5713.257276554063, 2920.153155584878, 3235.2397186661115, 3250.7886987345746, 3311.8408557005096, 3342.2647017656077, 974.8537719342085, 1120.4733775125678, 1172.5309876049564, 1186.1519013905013, 1193.087288224509, 13709.520166794215, 13863.58409247714, 14013.019088663797, 14878.925605372013, 14919.104853708921, 4325.286327755885, 4471.5081341052455, 4583.564561366665, 4597.632189424838, 4607.539246075366, 11935.403229838474, 12010.879891200977, 12041.759164816654, 12056.819147712791, 12065.758684826429, 5468.070428027245, 5514.200440936042, 5516.089845175501, 5536.889262214733, 5545.334559852843, 3959.6115658689305, 5048.343715317059, 5063.797448102035, 5097.643164978416, 5234.450382709837, 3761.2101458693433, 3779.225258821935, 3782.7730336179916, 3860.2665493556133, 3867.361885288896, 872.1845074854904, 957.8036502517107, 966.12083004467, 967.883853937532, 976.9560369783377, 923.9907600924039, 934.7102398256426, 940.7836197674574, 951.6716732727198, 993.5727637115965, 6658.933410665832, 6682.465402767767, 6695.330466953363, 6914.343137401939, 6942.93057069433, 962.7785609309898, 972.7324985628867, 1013.1185868294483, 1021.4126877045728, 1044.5978298355187, 4093.6315731583704, 4198.160367926366, 4236.957630423656, 4308.46144231971, 4339.891502712394, 13679.384427700777, 14037.368318425695, 14122.85877141236, 14174.787378189336, 14240.928795355956, 13540.59378218655, 13812.240326781923, 14063.015588908882, 14081.577552673436, 14179.432822687184, 8852.468851869038, 10189.184865210766, 10249.231307651957, 10386.688399348031, 10419.06228439444, 6369.649669268235, 6806.115205023315, 7033.894491582528, 7061.869475939673, 7079.929200707927, 11941.82087268709, 12220.388980551115, 12251.87748122543, 12286.631401057983, 12353.938230308791, 12461.314627695201, 12608.684782880502, 12731.61805145847, 12921.741565168455, 12923.870761292266, 8487.575621219037, 8514.74455766328, 8526.61630226629, 8563.186497282748, 8572.657093716181, 10366.896331036593, 10414.635487757892, 10497.160227181654, 10517.368957862247, 10553.841692374466, 7720.8455830884195, 9192.632294708137, 9215.44707317563, 9220.953895230748, 9440.008799075998, 8779.912200877909, 8905.975812781613, 9005.23455506263, 9162.083791620784, 9173.495457749888, 7663.578503182379, 7813.101493328113, 7847.921520784719, 7905.486143400661, 7932.4447288691545, 5785.132230165509, 5861.0915308127305, 5871.559633027455, 5982.611130276518, 6120.234970628671, 6036.3661815510495, 6047.0627052806885, 6053.152558641706, 6054.848628784315, 6129.35641757609], "value": 5073.086199572134, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.9866356013979, 330.34426663073793, 381.1842656714631, 383.96544311012013, 385.62209035145537, 5376.166694162406, 5413.242146099539, 5452.700101494426, 5526.696031718254, 5545.140503222002, 4427.512973572912, 4524.886877828056, 4543.568361005708, 5349.786008559663, 5391.816314392678, 3899.493065901429, 4228.88555722139, 4341.240282950487, 4364.738115713051, 4437.600615944564, 4060.776657283848, 4414.448193975753, 4428.468583769952, 4437.511873693891, 4491.752953587551, 3814.275287695329, 4149.564295748948, 4188.853390131346, 4454.28731402974, 4462.174497717916, 3375.6455572164814, 4011.916782468746, 4119.822153026241, 4385.736855788631, 4440.777961101948, 3461.7576769626135, 3928.2681452620127, 3948.2893079245723, 4053.209624123297, 4059.6346328830546, 4357.455318085239, 4426.645868330525, 5168.198929165986, 5259.921101183485, 5312.415634280226, 4273.55127711592, 4933.506649335073, 4953.926790092163, 5076.44159142494, 5120.132725673635, 4645.699204222823, 5030.698158110525, 5415.212979716724, 5645.887082258373, 5768.384852241379, 3725.5343082114737, 4202.831886724527, 4403.933940990888, 4551.726896386227, 4567.771611419449, 4914.606831453475, 5791.420857914217, 6071.696415179267, 6102.298235702907, 6133.723982420757, 4614.676972611952, 4624.491305956342, 4625.514320996314, 4680.4149481314835, 4703.330317737223, 4399.076193999232, 4413.757243351646, 4701.741404222732, 4737.0, 4771.188897887368, 4535.253927238037, 4918.680285781413, 5067.6452648315, 5098.362704661918, 5126.846194614168, 5396.892062158813, 5705.372409035002, 5708.145927036482, 5712.173582945373, 5746.080627099727, 1438.6331485471346, 1589.8728101751833, 1604.5186444066733, 1616.744641225484, 1642.0, 1079.1366906474789, 1150.3886178375042, 1208.6917835951776, 1208.8065909454444, 1211.8727533608844, 5089.643724939218, 5240.9475905241225, 5318.335208098988, 5366.543843773245, 5444.482774136451, 4835.661503694778, 5534.7509362078, 5900.232969713996, 5924.734191382198, 5987.251593550806, 4624.884377890512, 4741.336212930192, 5146.562542183881, 5350.5987050971335, 5392.64947778401, 2653.893844246247, 2656.72104429036, 2780.88876444944, 2838.7019362967003, 2870.985645071761, 4997.90004199914, 5588.86027849307, 6108.816735497942, 6121.234845644294, 6189.0, 5133.743312834418, 5172.043172013189, 5887.76448942046, 6092.75628974836, 6125.693715314216, 5155.236677225571, 5194.4027986006995, 5553.861458401018, 5638.4925356718095, 5944.0, 5019.719971407268, 5774.0, 5808.751118509541, 5829.912551311819, 5898.528117750656, 4975.502449754996, 5209.192575150858, 5385.75764090609, 5435.83692489226, 5787.884242315215, 5132.409772876167, 6014.939850601438, 6066.878662426815, 6083.756649733961, 6091.837397723922, 3960.66334361571, 4519.887002824956, 4598.815562607734, 4622.260438329851, 4718.882027949328, 5257.106291930305, 5637.577181711306, 5727.59441034758, 5830.804685039472, 5946.851328716817, 5652.576056795675, 5671.517920976763, 5677.716114194356, 5677.886442271214, 5799.333076696234, 5317.760700768397, 5693.6123006810885, 5700.686462244616, 5861.648301101947, 5884.440623234932, 4974.9502504975935, 5110.872228194325, 5492.752826122914, 5524.364698059774, 5526.253955715927, 5446.836594902159, 5667.404922483245, 5701.600887937971, 5779.7977070804, 5784.5249461387075, 5007.921712489276, 5404.297441332602, 5528.861778455571, 5534.391216966211, 5603.691796951207], "value": 4318.216643687015, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.6579750845755, 719.658162372873, 760.2891296637641, 820.5897051474263, 829.2826704900261, 15184.088954662728, 16427.917860410696, 16453.93049451785, 16465.506034818944, 16473.752893706605, 15387.615309617266, 16293.429729959424, 16641.251143698533, 16753.99476031439, 16783.24475398607, 637.289422294141, 663.6615326183633, 892.4645212872273, 914.6295750221171, 917.2661870503604, 882.3250213586612, 902.4044130873625, 909.1454033208796, 917.6283605139929, 918.9494577798218, 964.0889359555223, 965.9130678238957, 967.6661551764665, 967.8741763570761, 968.0, 896.5338024227365, 912.950107376519, 960.2174228004154, 960.6925783749203, 962.1100482054107, 569.0752527143392, 697.2434908124691, 715.2061212054615, 716.7849645106447, 718.195620904585, 15571.844281557152, 15732.29204685792, 15754.291056902466, 15997.0, 16056.197190140447, 13885.0, 13954.232517211549, 14044.223563130185, 14080.647983800385, 14094.0, 11609.590401652651, 11756.470958806789, 11820.290782553075, 11842.46708898093, 12272.631821045383, 3548.4499902514895, 3600.4419315006216, 3620.7646502977223, 3651.8721844735574, 3763.34141525232, 95472.0, 102065.0, 120611.39694301473, 121388.39305803503, 122872.0, 10588.576456941637, 10641.574337026432, 10713.142948564097, 10714.839277410845, 11205.04757095656, 18405.723914141297, 22318.776812231994, 22392.216272430713, 22523.887380562992, 22579.548409032057, 7080.150381954096, 7347.8163045924275, 7533.924660753322, 7768.067831860213, 7906.841863162705, 4350.978245108754, 4389.606242640752, 4431.0694754102, 4461.910761784811, 4556.88607784808, 2562.8718564072096, 3217.083131307613, 3219.9195020124216, 3225.451673215559, 3229.531717900938, 627.1032423634156, 662.5163630549725, 663.6084710021111, 664.2626684380334, 664.4285914113858, 654.9836254093591, 655.0, 669.3679736225332, 678.9626570538668, 710.8839122577504, 8726.520041397784, 9102.317326200562, 10206.183505319557, 10229.59081636741, 10297.10887328513, 623.5915475363644, 676.8883134282887, 707.3492387003865, 715.5277516838966, 737.2111840330901, 3788.8105594720155, 4827.720654026686, 4938.703677779345, 5041.294218809369, 5050.065737838511, 92371.53814230885, 110349.44825275823, 111191.44404277927, 112083.87916120897, 113774.0, 67916.66041669859, 84912.15087849043, 94521.0, 94722.52638736762, 99286.0, 77085.0, 78156.8737250515, 79560.6021969898, 81341.18658813454, 81671.0, 10508.842367364343, 10930.617428389969, 10951.700142969747, 11211.55153793839, 11356.602518911799, 50727.74636126796, 50931.745341273054, 51610.0, 52714.73642631762, 53159.73420132875, 48142.55572332696, 63818.68090659517, 66665.0, 66790.0, 67795.98306025512, 12437.502499899903, 12618.43217055253, 12814.67963300925, 12842.165259258118, 12863.742725145632, 14300.427982880568, 14317.427302908183, 14458.349374278394, 14895.62760930942, 14950.850491494946, 13553.322333883068, 13577.932378873027, 13895.444182233003, 14014.313338516306, 14354.497592584627, 13489.123206991515, 13608.523701670394, 13669.985704394872, 13767.931160344135, 13816.861831381959, 12733.61799146027, 13361.599152025456, 13583.932080339535, 13700.24648644334, 14087.718245635235, 11050.447477626247, 11233.49449274801, 11235.831462527905, 11263.549458021915, 11632.275763358926, 9038.960519540336, 9725.805483890425, 10679.252452328574, 11140.345631764583, 11496.48265828023], "value": 7592.668375853691, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1556.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 119.0, 118.0, 116.0, 118.0, 119.0, 123.0, 118.0, 119.0, 119.0], "value": 117.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 141.0, 139.0, 145.0, 112.0, 128.0, 111.0, 114.0, 126.0, 147.0], "value": 131.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 195.0, 199.0, 195.0, 191.0, 269.0, 220.0, 198.0, 198.0, 204.0], "value": 206.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 56.0, 60.0, 91.0, 74.0, 82.0, 68.0, 59.0, 76.0, 60.0], "value": 71.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 71.0, 87.0, 72.0, 70.0, 75.0, 115.0, 107.0, 99.0, 83.0], "value": 87.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 91.0, 97.0, 135.0, 105.0, 136.0, 116.0, 81.0, 135.0, 134.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 125.0, 98.0, 98.0, 98.0, 98.0, 99.0, 99.0, 98.0, 98.0], "value": 100.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 93.0, 146.0, 137.0, 85.0, 91.0, 88.0, 91.0, 91.0, 91.0], "value": 103.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 66.0, 68.0, 68.0, 68.0, 69.0, 69.0, 68.0], "value": 67.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 65.0, 63.0, 56.0, 57.0, 62.0, 60.0, 61.0, 59.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 87.0, 87.0, 83.0, 85.0, 83.0, 85.0, 87.0, 93.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 147.0, 142.0, 149.0, 158.0, 150.0, 149.0, 147.0, 171.0, 177.0], "value": 153.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 171.0, 209.0, 224.0, 149.0, 211.0, 228.0, 169.0, 165.0, 167.0], "value": 185.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 71.0, 66.0, 87.0, 65.0, 67.0, 65.0, 66.0, 66.0], "value": 68.6, "unit": "score"}]}]} 05:04:22 INFO - Return code: 0 05:04:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:04:22 ERROR - # TBPL SUCCESS # 05:04:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:04:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:04:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:04:22 INFO - 2017-03-23 05:04:22.641 screenresolution[2211:19581] starting screenresolution argv=screenresolution get 05:04:22 INFO - 2017-03-23 05:04:22.644 screenresolution[2211:19581] Display 0: 1600x1200x32@60 05:04:22 INFO - 2017-03-23 05:04:22.650 screenresolution[2212:19584] starting screenresolution argv=screenresolution list 05:04:22 INFO - Available Modes on Display 0 05:04:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:04:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:04:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:04:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:04:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:04:22 INFO - Intel Iris: 05:04:22 INFO - Chipset Model: Intel Iris 05:04:22 INFO - Type: GPU 05:04:22 INFO - Bus: Built-In 05:04:22 INFO - VRAM (Dynamic, Max): 1536 MB 05:04:22 INFO - Vendor: Intel (0x8086) 05:04:22 INFO - Device ID: 0x0a2e 05:04:22 INFO - Revision ID: 0x0009 05:04:22 INFO - Displays: 05:04:22 INFO - Display: 05:04:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:04:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:04:22 INFO - Display Serial Number: 1600x1200 60 05:04:22 INFO - Main Display: Yes 05:04:22 INFO - Mirror: Off 05:04:22 INFO - Online: Yes 05:04:22 INFO - Rotation: Supported 05:04:22 INFO - Return code: 0 05:04:22 INFO - Running post-action listener: _resource_record_post_action 05:04:22 INFO - [mozharness: 2017-03-23 12:04:22.892965Z] Finished run-tests step (success) 05:04:22 INFO - Running post-run listener: _resource_record_post_run 05:04:22 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 786432; Write bytes: 517584896; Read time: 14; Write time: 1868 05:04:22 INFO - TinderboxPrint: CPU usage
54.6% 05:04:22 INFO - TinderboxPrint: I/O read bytes / time
786,432 / 14 05:04:22 INFO - TinderboxPrint: I/O write bytes / time
517,584,896 / 1,868 05:04:22 INFO - TinderboxPrint: CPU idle
2,180.6 (45.4%) 05:04:22 INFO - TinderboxPrint: CPU system
968.1 (20.2%) 05:04:22 INFO - TinderboxPrint: CPU user
1,652.7 (34.4%) 05:04:22 INFO - TinderboxPrint: Swap in / out
209,698,816 / 0 05:04:22 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 200557056; Write bytes: 202504192; Read time: 15771; Write time: 553 05:04:22 INFO - run-tests - Wall time: 1180s; CPU: 55.0%; Read bytes: 786432; Write bytes: 305176576; Read time: 14; Write time: 1282 05:04:23 INFO - Running post-run listener: _upload_blobber_files 05:04:23 INFO - Blob upload gear active. 05:04:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:04:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:04:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:04:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:04:23 INFO - (blobuploader) - INFO - Open directory for files ... 05:04:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:04:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:04:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:04:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:04:24 INFO - (blobuploader) - INFO - Done attempting. 05:04:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:04:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:04:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:04:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:04:25 INFO - (blobuploader) - INFO - Done attempting. 05:04:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:04:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:04:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:04:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:04:26 INFO - (blobuploader) - INFO - Done attempting. 05:04:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:04:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:04:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:04:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:04:28 INFO - (blobuploader) - INFO - Done attempting. 05:04:28 INFO - (blobuploader) - INFO - Iteration through files over. 05:04:28 INFO - Return code: 0 05:04:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:04:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:04:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e6c02c9fd6b0e7340c443a7ad4be4383a9f18ffd77444457a74e115f34c71140298bdb2b89f577d088ba83b4e64289782fbbec8dd27a6faef2336d0b62af8d92", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d793d55bacafed471bf3cdefa4966c55cfe4a0c4223d213b6491e0ddd9155e036ab238a5e98b25da6d981b37a5d6433365f5c0fcf8ae84b28c6409a4588ecd1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/646298284c1e5d5db687d31b860660c7350a929635101f41347560687e9d7312147105ea93ba2440b44a84518bd29d0457ec099e9ef4cfc69a90518c04aec83f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c1766aeec41faff0d21217a653fd11e22e758234878cc4d17468d7b90e3967d680f8a82f306ea46212ba39637dfb4231cbdd6e3aae07aff21ea4db8dd97a1e1"} 05:04:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:04:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:04:28 INFO - Contents: 05:04:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e6c02c9fd6b0e7340c443a7ad4be4383a9f18ffd77444457a74e115f34c71140298bdb2b89f577d088ba83b4e64289782fbbec8dd27a6faef2336d0b62af8d92", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d793d55bacafed471bf3cdefa4966c55cfe4a0c4223d213b6491e0ddd9155e036ab238a5e98b25da6d981b37a5d6433365f5c0fcf8ae84b28c6409a4588ecd1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/646298284c1e5d5db687d31b860660c7350a929635101f41347560687e9d7312147105ea93ba2440b44a84518bd29d0457ec099e9ef4cfc69a90518c04aec83f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c1766aeec41faff0d21217a653fd11e22e758234878cc4d17468d7b90e3967d680f8a82f306ea46212ba39637dfb4231cbdd6e3aae07aff21ea4db8dd97a1e1"} 05:04:28 INFO - Running post-run listener: copy_logs_to_upload_dir 05:04:28 INFO - Copying logs to upload dir... 05:04:28 INFO - mkdir: /builds/slave/test/build/upload/logs 05:04:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.219710 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-23 05:04:28.554387) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 05:04:28.561637) ========= 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.b4uxfJi2VJ/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.L1t1glG4sS/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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/e6c02c9fd6b0e7340c443a7ad4be4383a9f18ffd77444457a74e115f34c71140298bdb2b89f577d088ba83b4e64289782fbbec8dd27a6faef2336d0b62af8d92", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d793d55bacafed471bf3cdefa4966c55cfe4a0c4223d213b6491e0ddd9155e036ab238a5e98b25da6d981b37a5d6433365f5c0fcf8ae84b28c6409a4588ecd1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/646298284c1e5d5db687d31b860660c7350a929635101f41347560687e9d7312147105ea93ba2440b44a84518bd29d0457ec099e9ef4cfc69a90518c04aec83f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c1766aeec41faff0d21217a653fd11e22e758234878cc4d17468d7b90e3967d680f8a82f306ea46212ba39637dfb4231cbdd6e3aae07aff21ea4db8dd97a1e1"} build_url:https://queue.taskcluster.net/v1/task/agp8B7bDSb-VNo_CO1evRw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010034 build_url: 'https://queue.taskcluster.net/v1/task/agp8B7bDSb-VNo_CO1evRw/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/e6c02c9fd6b0e7340c443a7ad4be4383a9f18ffd77444457a74e115f34c71140298bdb2b89f577d088ba83b4e64289782fbbec8dd27a6faef2336d0b62af8d92", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d793d55bacafed471bf3cdefa4966c55cfe4a0c4223d213b6491e0ddd9155e036ab238a5e98b25da6d981b37a5d6433365f5c0fcf8ae84b28c6409a4588ecd1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/646298284c1e5d5db687d31b860660c7350a929635101f41347560687e9d7312147105ea93ba2440b44a84518bd29d0457ec099e9ef4cfc69a90518c04aec83f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c1766aeec41faff0d21217a653fd11e22e758234878cc4d17468d7b90e3967d680f8a82f306ea46212ba39637dfb4231cbdd6e3aae07aff21ea4db8dd97a1e1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 05:04:28.595910) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 05:04:28.596276) ========= 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.b4uxfJi2VJ/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.L1t1glG4sS/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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.005409 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 05:04:28.645453) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 05:04:28.645805) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 05:04:28.646169) ========= ========= Total master_lag: 1.79 =========