builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0073 starttime: 1494218374.2 results: success (0) buildid: 20170507201733 builduid: ce63e0c2c032488ba6e57e8223420a16 revision: c3e5497cff1c995821b1c9320fa71f1ef9a8c30e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-07 21:39:34.199006) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-07 21:39:34.199480) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-07 21:39:34.199943) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-07 21:39:34.226275) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 21:39:34.226683) ========= 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.kwtYeVPrzE/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.Gl2B1OPJbc/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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-05-07 21:39:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 94.4M=0s 2017-05-07 21:39:34 (94.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.153073 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 21:39:34.404986) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 21:39:34.405337) ========= 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.kwtYeVPrzE/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.Gl2B1OPJbc/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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.021373 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 21:39:34.454011) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-07 21:39:34.454387) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c3e5497cff1c995821b1c9320fa71f1ef9a8c30e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c3e5497cff1c995821b1c9320fa71f1ef9a8c30e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kwtYeVPrzE/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.Gl2B1OPJbc/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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-05-07 21:39:34,541 truncating revision to first 12 chars 2017-05-07 21:39:34,541 Setting DEBUG logging. 2017-05-07 21:39:34,541 attempt 1/10 2017-05-07 21:39:34,541 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c3e5497cff1c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-07 21:39:35,682 unpacking tar archive at: mozilla-central-c3e5497cff1c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.413821 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-07 21:39:35.896104) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-07 21:39:35.896472) ========= script_repo_revision: c3e5497cff1c995821b1c9320fa71f1ef9a8c30e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-07 21:39:35.896924) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-07 21:39:35.897194) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-07 21:39:35.918014) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-05-07 21:39:35.918424) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kwtYeVPrzE/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.Gl2B1OPJbc/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 21:39:36 INFO - MultiFileLogger online at 20170507 21:39:36 in /builds/slave/test 21:39:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:39:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:39:36 INFO - {'append_to_log': False, 21:39:36 INFO - 'base_work_dir': '/builds/slave/test', 21:39:36 INFO - 'blob_upload_branch': 'Firefox', 21:39:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:39:36 INFO - 'branch': 'Firefox', 21:39:36 INFO - 'buildbot_json_path': 'buildprops.json', 21:39:36 INFO - 'config_files': ('talos/mac_config.py',), 21:39:36 INFO - 'default_actions': ('clobber', 21:39:36 INFO - 'read-buildbot-config', 21:39:36 INFO - 'download-and-extract', 21:39:36 INFO - 'populate-webroot', 21:39:36 INFO - 'create-virtualenv', 21:39:36 INFO - 'install', 21:39:36 INFO - 'run-tests'), 21:39:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:39:36 INFO - 'download_minidump_stackwalk': True, 21:39:36 INFO - 'download_symbols': 'ondemand', 21:39:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:39:36 INFO - 'tooltool.py': '/tools/tooltool.py', 21:39:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:39:36 INFO - '/tools/misc-python/virtualenv.py')}, 21:39:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:39:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:39:36 INFO - 'gecko_profile': False, 21:39:36 INFO - 'gecko_profile_interval': 0, 21:39:36 INFO - 'installer_path': 'installer.exe', 21:39:36 INFO - 'log_level': 'info', 21:39:36 INFO - 'log_name': 'talos', 21:39:36 INFO - 'log_to_console': True, 21:39:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:39:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:39:36 INFO - 'opt_config_files': (), 21:39:36 INFO - 'pip_index': False, 21:39:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:39:36 INFO - 'cmd': ('bash', 21:39:36 INFO - '-c', 21:39:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:39:36 INFO - 'enabled': True, 21:39:36 INFO - 'halt_on_failure': False, 21:39:36 INFO - 'name': 'check_screen_resolution'},), 21:39:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:39:36 INFO - 'cmd': ('bash', 21:39:36 INFO - '-c', 21:39:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:39:36 INFO - 'enabled': True, 21:39:36 INFO - 'halt_on_failure': False, 21:39:36 INFO - 'name': 'check_screen_resolution'},), 21:39:36 INFO - 'run_cmd_checks_enabled': True, 21:39:36 INFO - 'suite': 'dromaeojs-e10s', 21:39:36 INFO - 'system_bits': '32', 21:39:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:39:36 INFO - 'title': 't-yosemite-r7-0073', 21:39:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:39:36 INFO - 'use_talos_json': True, 21:39:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:39:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:39:36 INFO - 'work_dir': 'build'} 21:39:36 INFO - [mozharness: 2017-05-08 04:39:36.151212Z] Running clobber step. 21:39:36 INFO - Running pre-action listener: _resource_record_pre_action 21:39:36 INFO - Running main action method: clobber 21:39:36 INFO - rmtree: /builds/slave/test/build 21:39:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:39:36 INFO - Running post-action listener: _resource_record_post_action 21:39:36 INFO - [mozharness: 2017-05-08 04:39:36.493812Z] Finished clobber step (success) 21:39:36 INFO - [mozharness: 2017-05-08 04:39:36.493971Z] Running read-buildbot-config step. 21:39:36 INFO - Running pre-action listener: _resource_record_pre_action 21:39:36 INFO - Running main action method: read_buildbot_config 21:39:36 INFO - Using buildbot properties: 21:39:36 INFO - { 21:39:36 INFO - "project": "", 21:39:36 INFO - "product": "firefox", 21:39:36 INFO - "script_repo_revision": "production", 21:39:36 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 21:39:36 INFO - "repository": "", 21:39:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 21:39:36 INFO - "buildid": "20170507201733", 21:39:36 INFO - "pgo_build": "False", 21:39:36 INFO - "basedir": "/builds/slave/test", 21:39:36 INFO - "buildnumber": 64, 21:39:36 INFO - "slavename": "t-yosemite-r7-0073", 21:39:36 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 21:39:36 INFO - "platform": "yosemite_r7", 21:39:36 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 21:39:36 INFO - "branch": "mozilla-central", 21:39:36 INFO - "repo_path": "mozilla-central", 21:39:36 INFO - "revision": "c3e5497cff1c995821b1c9320fa71f1ef9a8c30e", 21:39:36 INFO - "stage_platform": "macosx64", 21:39:36 INFO - "builduid": "ce63e0c2c032488ba6e57e8223420a16", 21:39:36 INFO - "slavebuilddir": "test" 21:39:36 INFO - } 21:39:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/RAwyJyWET9WwR3gWBlluCA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 21:39:36 INFO - Running post-action listener: _resource_record_post_action 21:39:36 INFO - [mozharness: 2017-05-08 04:39:36.497638Z] Finished read-buildbot-config step (success) 21:39:36 INFO - [mozharness: 2017-05-08 04:39:36.497750Z] Running download-and-extract step. 21:39:36 INFO - Running pre-action listener: _resource_record_pre_action 21:39:36 INFO - Running main action method: download_and_extract 21:39:36 INFO - mkdir: /builds/slave/test/build/tests 21:39:36 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')]} 21:39:36 INFO - trying https://queue.taskcluster.net/v1/task/RAwyJyWET9WwR3gWBlluCA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 21:39:36 INFO - Downloading https://queue.taskcluster.net/v1/task/RAwyJyWET9WwR3gWBlluCA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 21:39:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RAwyJyWET9WwR3gWBlluCA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 21:39:37 INFO - Downloaded 1325 bytes. 21:39:37 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 21:39:37 INFO - Using the following test package requirements: 21:39:37 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:39:37 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 21:39:37 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 21:39:37 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:39:37 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 21:39:37 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:39:37 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 21:39:37 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:39:37 INFO - u'jsshell-mac.zip'], 21:39:37 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:39:37 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 21:39:37 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 21:39:37 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:39:37 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 21:39:37 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:39:37 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 21:39:37 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:39:37 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 21:39:37 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:39:37 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 21:39:37 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:39:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RAwyJyWET9WwR3gWBlluCA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 21:39:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RAwyJyWET9WwR3gWBlluCA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:39:37 INFO - Fetch https://queue.taskcluster.net/v1/task/RAwyJyWET9WwR3gWBlluCA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 21:39:38 INFO - Content-Length response header: 52705616 21:39:38 INFO - Bytes received: 52705616 21:39:55 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 21:39:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RAwyJyWET9WwR3gWBlluCA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 21:39:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RAwyJyWET9WwR3gWBlluCA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:39:55 INFO - Fetch https://queue.taskcluster.net/v1/task/RAwyJyWET9WwR3gWBlluCA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 21:39:56 INFO - Content-Length response header: 52705616 21:39:56 INFO - Bytes received: 52705616 21:40:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RAwyJyWET9WwR3gWBlluCA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 21:40:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RAwyJyWET9WwR3gWBlluCA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:40:12 INFO - Fetch https://queue.taskcluster.net/v1/task/RAwyJyWET9WwR3gWBlluCA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 21:40:13 INFO - Content-Length response header: 14409362 21:40:13 INFO - Bytes received: 14409362 21:40:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:13 INFO - trying https://queue.taskcluster.net/v1/task/RAwyJyWET9WwR3gWBlluCA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 21:40:13 INFO - Downloading https://queue.taskcluster.net/v1/task/RAwyJyWET9WwR3gWBlluCA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 21:40:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RAwyJyWET9WwR3gWBlluCA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 21:40:15 INFO - Downloaded 70921823 bytes. 21:40:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RAwyJyWET9WwR3gWBlluCA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 21:40:15 INFO - mkdir: /builds/slave/test/properties 21:40:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:40:15 INFO - Writing to file /builds/slave/test/properties/build_url 21:40:15 INFO - Contents: 21:40:15 INFO - build_url:https://queue.taskcluster.net/v1/task/RAwyJyWET9WwR3gWBlluCA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 21:40:16 INFO - Running post-action listener: _resource_record_post_action 21:40:16 INFO - Running post-action listener: set_extra_try_arguments 21:40:16 INFO - [mozharness: 2017-05-08 04:40:16.237601Z] Finished download-and-extract step (success) 21:40:16 INFO - [mozharness: 2017-05-08 04:40:16.237760Z] Running populate-webroot step. 21:40:16 INFO - Running pre-action listener: _resource_record_pre_action 21:40:16 INFO - Running main action method: populate_webroot 21:40:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:40:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:40:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:40:16 INFO - '--tppagecycles', 21:40:16 INFO - '7'], 21:40:16 INFO - 'tests': ['tsvgm']}}, 21:40:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:40:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:40:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:40:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:40:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:40:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:40:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:40:16 INFO - 'talos_options': ['--disable-e10s'], 21:40:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:40:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:40:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:40:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:40:16 INFO - 'talos_options': ['--disable-e10s'], 21:40:16 INFO - 'tests': ['damp', 'tps']}, 21:40:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:40:16 INFO - 'tests': ['damp', 'tps']}, 21:40:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:40:16 INFO - 'tests': ['dromaeo_dom']}, 21:40:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:40:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:40:16 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 21:40:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 21:40:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:40:16 INFO - 'tests': ['a11yr', 21:40:16 INFO - 'ts_paint', 21:40:16 INFO - 'tpaint', 21:40:16 INFO - 'sessionrestore', 21:40:16 INFO - 'sessionrestore_no_auto_restore', 21:40:16 INFO - 'tabpaint']}, 21:40:16 INFO - 'other-e10s': {'tests': ['a11yr', 21:40:16 INFO - 'ts_paint', 21:40:16 INFO - 'tpaint', 21:40:16 INFO - 'sessionrestore', 21:40:16 INFO - 'sessionrestore_no_auto_restore', 21:40:16 INFO - 'tabpaint']}, 21:40:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:40:16 INFO - 'ts_paint', 21:40:16 INFO - 'tpaint', 21:40:16 INFO - 'sessionrestore', 21:40:16 INFO - 'sessionrestore_no_auto_restore', 21:40:16 INFO - 'tabpaint']}, 21:40:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:40:16 INFO - 'ts_paint', 21:40:16 INFO - 'tpaint', 21:40:16 INFO - 'sessionrestore', 21:40:16 INFO - 'sessionrestore_no_auto_restore', 21:40:16 INFO - 'tabpaint']}, 21:40:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:40:16 INFO - 'tests': ['a11yr', 21:40:16 INFO - 'ts_paint', 21:40:16 INFO - 'tpaint', 21:40:16 INFO - 'sessionrestore', 21:40:16 INFO - 'sessionrestore_no_auto_restore', 21:40:16 INFO - 'tabpaint']}, 21:40:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:40:16 INFO - 'tests': ['a11yr', 21:40:16 INFO - 'ts_paint', 21:40:16 INFO - 'tpaint', 21:40:16 INFO - 'sessionrestore', 21:40:16 INFO - 'sessionrestore_no_auto_restore', 21:40:16 INFO - 'tabpaint']}, 21:40:16 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 21:40:16 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 21:40:16 INFO - 'bloom_basic_ref']}, 21:40:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:40:16 INFO - 'tests': ['tsvgx', 21:40:16 INFO - 'tsvgr_opacity', 21:40:16 INFO - 'tart', 21:40:16 INFO - 'tscrollx', 21:40:16 INFO - 'cart', 21:40:16 INFO - 'tsvg_static']}, 21:40:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:40:16 INFO - 'tsvgr_opacity', 21:40:16 INFO - 'tart', 21:40:16 INFO - 'tscrollx', 21:40:16 INFO - 'cart', 21:40:16 INFO - 'tsvg_static']}, 21:40:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:40:16 INFO - 'talos_options': ['--disable-e10s'], 21:40:16 INFO - 'tests': ['tp5o']}, 21:40:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:40:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:40:16 INFO - 'talos_options': ['--disable-e10s', 21:40:16 INFO - '--xperf_path', 21:40:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:40:16 INFO - 'tests': ['tp5n']}, 21:40:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:40:16 INFO - 'talos_options': ['--xperf_path', 21:40:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:40:16 INFO - 'tests': ['tp5n']}}, 21:40:16 INFO - 'talos.zip': {'path': '', 21:40:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:40:16 INFO - Running post-action listener: _resource_record_post_action 21:40:16 INFO - [mozharness: 2017-05-08 04:40:16.257490Z] Finished populate-webroot step (success) 21:40:16 INFO - [mozharness: 2017-05-08 04:40:16.257606Z] Running create-virtualenv step. 21:40:16 INFO - Running pre-action listener: _resource_record_pre_action 21:40:16 INFO - Running main action method: create_virtualenv 21:40:16 INFO - Creating virtualenv /builds/slave/test/build/venv 21:40:16 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 21:40:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:40:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:40:16 INFO - Using real prefix '/tools/python27' 21:40:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:40:17 INFO - Installing distribute.............................................................................................................................................................................................done. 21:40:19 INFO - Installing pip.................done. 21:40:19 INFO - Return code: 0 21:40:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:40:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:40:20 INFO - Reading from file tmpfile_stdout 21:40:20 INFO - Output received: 21:40:20 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) 21:40:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:40:20 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')]} 21:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:20 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')]} 21:40:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:20 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 0x10e816b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e819768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd696c31f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e527d30>, '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 0x10e4dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e51bbe8>, '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.kwtYeVPrzE/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.Gl2B1OPJbc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 21:40:20 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 21:40:20 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 21:40:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwtYeVPrzE/Render', 21:40:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:20 INFO - 'HOME': '/Users/cltbld', 21:40:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:20 INFO - 'LOGNAME': 'cltbld', 21:40:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:20 INFO - 'MOZ_NO_REMOTE': '1', 21:40:20 INFO - 'NO_EM_RESTART': '1', 21:40:20 INFO - 'PAGER': '/bin/cat', 21:40:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:20 INFO - 'PWD': '/builds/slave/test', 21:40:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:20 INFO - 'SHELL': '/bin/bash', 21:40:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gl2B1OPJbc/Listeners', 21:40:20 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 21:40:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:20 INFO - 'USER': 'cltbld', 21:40:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:20 INFO - 'XPC_FLAGS': '0x0', 21:40:20 INFO - 'XPC_SERVICE_NAME': '0', 21:40:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:20 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 21:40:20 INFO - Cleaning up... 21:40:20 INFO - Return code: 0 21:40:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:40:20 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')]} 21:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:20 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')]} 21:40:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:20 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 0x10e816b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e819768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd696c31f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e527d30>, '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 0x10e4dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e51bbe8>, '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.kwtYeVPrzE/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.Gl2B1OPJbc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 21:40:20 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 21:40:20 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 21:40:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwtYeVPrzE/Render', 21:40:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:20 INFO - 'HOME': '/Users/cltbld', 21:40:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:20 INFO - 'LOGNAME': 'cltbld', 21:40:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:20 INFO - 'MOZ_NO_REMOTE': '1', 21:40:20 INFO - 'NO_EM_RESTART': '1', 21:40:20 INFO - 'PAGER': '/bin/cat', 21:40:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:20 INFO - 'PWD': '/builds/slave/test', 21:40:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:20 INFO - 'SHELL': '/bin/bash', 21:40:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gl2B1OPJbc/Listeners', 21:40:20 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 21:40:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:20 INFO - 'USER': 'cltbld', 21:40:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:20 INFO - 'XPC_FLAGS': '0x0', 21:40:20 INFO - 'XPC_SERVICE_NAME': '0', 21:40:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:20 INFO - Downloading/unpacking psutil>=3.1.1 21:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:40:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:40:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:40:22 INFO - Installing collected packages: psutil 21:40:22 INFO - Running setup.py install for psutil 21:40:23 INFO - building 'psutil._psutil_osx' extension 21:40:23 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 21:40:23 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 21:40:23 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 21:40:23 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 21:40:23 INFO - building 'psutil._psutil_posix' extension 21:40:23 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 21:40:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:40:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:40:23 INFO - ^ 21:40:23 INFO - 1 warning generated. 21:40:23 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 21:40:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:40:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:40:23 INFO - Successfully installed psutil 21:40:23 INFO - Cleaning up... 21:40:23 INFO - Return code: 0 21:40:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:40:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e816b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e819768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd696c31f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e527d30>, '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 0x10e4dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e51bbe8>, '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.kwtYeVPrzE/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.Gl2B1OPJbc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 21:40:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:40:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:40:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwtYeVPrzE/Render', 21:40:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:23 INFO - 'HOME': '/Users/cltbld', 21:40:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:23 INFO - 'LOGNAME': 'cltbld', 21:40:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:23 INFO - 'MOZ_NO_REMOTE': '1', 21:40:23 INFO - 'NO_EM_RESTART': '1', 21:40:23 INFO - 'PAGER': '/bin/cat', 21:40:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:23 INFO - 'PWD': '/builds/slave/test', 21:40:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:23 INFO - 'SHELL': '/bin/bash', 21:40:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gl2B1OPJbc/Listeners', 21:40:23 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 21:40:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:23 INFO - 'USER': 'cltbld', 21:40:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:23 INFO - 'XPC_FLAGS': '0x0', 21:40:23 INFO - 'XPC_SERVICE_NAME': '0', 21:40:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:40:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:40:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:40:25 INFO - Installing collected packages: mozsystemmonitor 21:40:25 INFO - Running setup.py install for mozsystemmonitor 21:40:25 INFO - Successfully installed mozsystemmonitor 21:40:25 INFO - Cleaning up... 21:40:25 INFO - Return code: 0 21:40:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:40:25 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')]} 21:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:25 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')]} 21:40:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:25 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 0x10e816b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e819768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd696c31f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e527d30>, '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 0x10e4dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e51bbe8>, '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.kwtYeVPrzE/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.Gl2B1OPJbc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 21:40:25 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 21:40:25 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 21:40:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwtYeVPrzE/Render', 21:40:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:25 INFO - 'HOME': '/Users/cltbld', 21:40:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:25 INFO - 'LOGNAME': 'cltbld', 21:40:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:25 INFO - 'MOZ_NO_REMOTE': '1', 21:40:25 INFO - 'NO_EM_RESTART': '1', 21:40:25 INFO - 'PAGER': '/bin/cat', 21:40:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:25 INFO - 'PWD': '/builds/slave/test', 21:40:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:25 INFO - 'SHELL': '/bin/bash', 21:40:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gl2B1OPJbc/Listeners', 21:40:25 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 21:40:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:25 INFO - 'USER': 'cltbld', 21:40:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:25 INFO - 'XPC_FLAGS': '0x0', 21:40:25 INFO - 'XPC_SERVICE_NAME': '0', 21:40:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:25 INFO - Downloading/unpacking jsonschema==2.5.1 21:40:25 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 21:40:25 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 21:40:25 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 21:40:25 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 21:40:25 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 21:40:25 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 21:40:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:40:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:27 INFO - Downloading functools32-3.2.3-2.tar.gz 21:40:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:40:27 INFO - warning: no files found matching '*.txt' 21:40:27 INFO - no previously-included directories found matching 'build' 21:40:27 INFO - no previously-included directories found matching 'dist' 21:40:27 INFO - no previously-included directories found matching '.git*' 21:40:27 INFO - Installing collected packages: jsonschema, functools32 21:40:27 INFO - Running setup.py install for functools32 21:40:27 INFO - warning: no files found matching '*.txt' 21:40:27 INFO - no previously-included directories found matching 'build' 21:40:27 INFO - no previously-included directories found matching 'dist' 21:40:27 INFO - no previously-included directories found matching '.git*' 21:40:27 INFO - Successfully installed jsonschema functools32 21:40:27 INFO - Cleaning up... 21:40:27 INFO - Return code: 0 21:40:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:29 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 0x10e816b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e819768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd696c31f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e527d30>, '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 0x10e4dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e51bbe8>, '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.kwtYeVPrzE/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.Gl2B1OPJbc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 21:40:29 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 21:40:29 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 21:40:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwtYeVPrzE/Render', 21:40:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:29 INFO - 'HOME': '/Users/cltbld', 21:40:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:29 INFO - 'LOGNAME': 'cltbld', 21:40:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:29 INFO - 'MOZ_NO_REMOTE': '1', 21:40:29 INFO - 'NO_EM_RESTART': '1', 21:40:29 INFO - 'PAGER': '/bin/cat', 21:40:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:29 INFO - 'PWD': '/builds/slave/test', 21:40:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:29 INFO - 'SHELL': '/bin/bash', 21:40:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gl2B1OPJbc/Listeners', 21:40:29 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 21:40:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:29 INFO - 'USER': 'cltbld', 21:40:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:29 INFO - 'XPC_FLAGS': '0x0', 21:40:29 INFO - 'XPC_SERVICE_NAME': '0', 21:40:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:40:29 INFO - Cleaning up... 21:40:29 INFO - Return code: 0 21:40:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:40:29 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')]} 21:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:29 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')]} 21:40:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:29 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 0x10e816b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e819768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd696c31f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e527d30>, '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 0x10e4dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e51bbe8>, '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.kwtYeVPrzE/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.Gl2B1OPJbc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 21:40:29 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 21:40:29 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 21:40:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwtYeVPrzE/Render', 21:40:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:29 INFO - 'HOME': '/Users/cltbld', 21:40:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:29 INFO - 'LOGNAME': 'cltbld', 21:40:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:29 INFO - 'MOZ_NO_REMOTE': '1', 21:40:29 INFO - 'NO_EM_RESTART': '1', 21:40:29 INFO - 'PAGER': '/bin/cat', 21:40:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:29 INFO - 'PWD': '/builds/slave/test', 21:40:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:29 INFO - 'SHELL': '/bin/bash', 21:40:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gl2B1OPJbc/Listeners', 21:40:29 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 21:40:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:29 INFO - 'USER': 'cltbld', 21:40:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:29 INFO - 'XPC_FLAGS': '0x0', 21:40:29 INFO - 'XPC_SERVICE_NAME': '0', 21:40:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:29 INFO - Downloading/unpacking blobuploader==1.2.4 21:40:29 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 21:40:29 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 21:40:29 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 21:40:29 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 21:40:29 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 21:40:29 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 21:40:31 INFO - Downloading blobuploader-1.2.4.tar.gz 21:40:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:40:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:40:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:32 INFO - Downloading docopt-0.6.1.tar.gz 21:40:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:40:32 INFO - Installing collected packages: blobuploader, requests, docopt 21:40:32 INFO - Running setup.py install for blobuploader 21:40:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:40:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:40:32 INFO - Running setup.py install for requests 21:40:32 INFO - Running setup.py install for docopt 21:40:33 INFO - Successfully installed blobuploader requests docopt 21:40:33 INFO - Cleaning up... 21:40:33 INFO - Return code: 0 21:40:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e816b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e819768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd696c31f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e527d30>, '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 0x10e4dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e51bbe8>, '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.kwtYeVPrzE/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.Gl2B1OPJbc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 21:40:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:40:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:40:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwtYeVPrzE/Render', 21:40:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:33 INFO - 'HOME': '/Users/cltbld', 21:40:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:33 INFO - 'LOGNAME': 'cltbld', 21:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:33 INFO - 'MOZ_NO_REMOTE': '1', 21:40:33 INFO - 'NO_EM_RESTART': '1', 21:40:33 INFO - 'PAGER': '/bin/cat', 21:40:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:33 INFO - 'PWD': '/builds/slave/test', 21:40:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:33 INFO - 'SHELL': '/bin/bash', 21:40:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gl2B1OPJbc/Listeners', 21:40:33 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 21:40:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:33 INFO - 'USER': 'cltbld', 21:40:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:33 INFO - 'XPC_FLAGS': '0x0', 21:40:33 INFO - 'XPC_SERVICE_NAME': '0', 21:40:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:40:33 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-oWk_iY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:40:33 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-nGxP63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:40:33 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-2lyysT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:40:33 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-uopgiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:40:33 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-IAq2cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:40:33 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-fejO4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:40:34 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-Gh331c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:40:34 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-HdJwzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:40:34 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-CRTNn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:40:34 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-t0kbNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:40:34 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-dQ4HhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:40:34 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-B3dQtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:40:34 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-Qz3HFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:40:34 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-5jFzuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:40:34 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-1za6nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:40:34 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-pmoPsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:40:35 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-pIOVYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:40:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:40:35 INFO - Running setup.py install for manifestparser 21:40:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:40:35 INFO - Running setup.py install for mozcrash 21:40:35 INFO - Running setup.py install for mozdebug 21:40:35 INFO - Running setup.py install for mozdevice 21:40:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:40:35 INFO - Running setup.py install for mozfile 21:40:35 INFO - Running setup.py install for mozhttpd 21:40:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:40:36 INFO - Running setup.py install for mozinfo 21:40:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:40:36 INFO - Running setup.py install for mozInstall 21:40:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:40:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:40:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:40:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:40:36 INFO - Running setup.py install for mozleak 21:40:36 INFO - Running setup.py install for mozlog 21:40:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:40:36 INFO - Running setup.py install for moznetwork 21:40:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:40:36 INFO - Running setup.py install for mozprocess 21:40:36 INFO - Running setup.py install for mozprofile 21:40:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:40:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:40:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:40:37 INFO - Running setup.py install for mozrunner 21:40:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:40:37 INFO - Running setup.py install for mozscreenshot 21:40:37 INFO - Running setup.py install for moztest 21:40:37 INFO - Running setup.py install for mozversion 21:40:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:40:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:40:37 INFO - Cleaning up... 21:40:37 INFO - Return code: 0 21:40:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e816b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e819768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd696c31f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e527d30>, '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 0x10e4dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e51bbe8>, '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.kwtYeVPrzE/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.Gl2B1OPJbc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 21:40:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:40:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:40:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwtYeVPrzE/Render', 21:40:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:37 INFO - 'HOME': '/Users/cltbld', 21:40:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:37 INFO - 'LOGNAME': 'cltbld', 21:40:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:37 INFO - 'MOZ_NO_REMOTE': '1', 21:40:37 INFO - 'NO_EM_RESTART': '1', 21:40:37 INFO - 'PAGER': '/bin/cat', 21:40:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:37 INFO - 'PWD': '/builds/slave/test', 21:40:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:37 INFO - 'SHELL': '/bin/bash', 21:40:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gl2B1OPJbc/Listeners', 21:40:37 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 21:40:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:37 INFO - 'USER': 'cltbld', 21:40:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:37 INFO - 'XPC_FLAGS': '0x0', 21:40:37 INFO - 'XPC_SERVICE_NAME': '0', 21:40:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:40:38 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-XtU_lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:40:38 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:40:38 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-wZhJy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:40:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:40:38 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-NiWM_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:40:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:40:38 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-vOnnTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:40:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 21:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:40:38 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-6BbX_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:40:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:40:38 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-XxCXbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:40:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:40:38 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-HePwVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:40:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:40:38 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-pm5CJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:40:38 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)) 21:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:40:38 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-_dHwfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:40:38 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)) 21:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:40:38 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-2WOjl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:40:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:40:39 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-TWup3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:40:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:40:39 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-1NneIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:40:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:40:39 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-lAOJzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:40:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:40:39 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-OmdWVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:40:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:40:39 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-p51vvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:40:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:40:39 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-ojlhQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:40:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:40:39 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-k8DPpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:40:39 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)) 21:40:39 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)) 21:40:39 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)) 21:40:39 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)) 21:40:39 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:40:39 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:40:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:40:39 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 21:40:39 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 21:40:39 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 21:40:39 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 21:40:39 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 21:40:39 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 21:40:41 INFO - Downloading blessings-1.6.tar.gz 21:40:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:40:41 INFO - Installing collected packages: blessings 21:40:41 INFO - Running setup.py install for blessings 21:40:41 INFO - Successfully installed blessings 21:40:41 INFO - Cleaning up... 21:40:41 INFO - Return code: 0 21:40:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:40:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:40:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:40:41 INFO - Reading from file tmpfile_stdout 21:40:41 INFO - Current package versions: 21:40:41 INFO - blessings == 1.6 21:40:41 INFO - blobuploader == 1.2.4 21:40:41 INFO - docopt == 0.6.1 21:40:41 INFO - functools32 == 3.2.3-2 21:40:41 INFO - jsonschema == 2.5.1 21:40:41 INFO - manifestparser == 1.1 21:40:41 INFO - mozInstall == 1.12 21:40:41 INFO - mozcrash == 1.0 21:40:41 INFO - mozdebug == 0.1 21:40:41 INFO - mozdevice == 0.50 21:40:41 INFO - mozfile == 1.2 21:40:41 INFO - mozhttpd == 0.7 21:40:41 INFO - mozinfo == 0.9 21:40:41 INFO - mozleak == 0.1 21:40:41 INFO - mozlog == 3.4 21:40:41 INFO - moznetwork == 0.27 21:40:41 INFO - mozprocess == 0.25 21:40:41 INFO - mozprofile == 0.28 21:40:41 INFO - mozrunner == 6.13 21:40:41 INFO - mozscreenshot == 0.1 21:40:41 INFO - mozsystemmonitor == 0.3 21:40:41 INFO - moztest == 0.8 21:40:41 INFO - mozversion == 1.4 21:40:41 INFO - psutil == 3.1.1 21:40:41 INFO - requests == 1.2.3 21:40:41 INFO - wsgiref == 0.1.2 21:40:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:40:41 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')]} 21:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:41 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')]} 21:40:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:41 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 0x10e816b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e819768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd696c31f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e527d30>, '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 0x10e4dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e51bbe8>, '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.kwtYeVPrzE/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.Gl2B1OPJbc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 21:40:41 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 21:40:41 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 21:40:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwtYeVPrzE/Render', 21:40:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:41 INFO - 'HOME': '/Users/cltbld', 21:40:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:41 INFO - 'LOGNAME': 'cltbld', 21:40:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:41 INFO - 'MOZ_NO_REMOTE': '1', 21:40:41 INFO - 'NO_EM_RESTART': '1', 21:40:41 INFO - 'PAGER': '/bin/cat', 21:40:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:41 INFO - 'PWD': '/builds/slave/test', 21:40:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:41 INFO - 'SHELL': '/bin/bash', 21:40:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gl2B1OPJbc/Listeners', 21:40:41 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 21:40:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:41 INFO - 'USER': 'cltbld', 21:40:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:41 INFO - 'XPC_FLAGS': '0x0', 21:40:41 INFO - 'XPC_SERVICE_NAME': '0', 21:40:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:42 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)) 21:40:42 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)) 21:40:42 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)) 21:40:42 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)) 21:40:42 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)) 21:40:42 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)) 21:40:42 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)) 21:40:42 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)) 21:40:42 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)) 21:40:42 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)) 21:40:42 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)) 21:40:42 INFO - Cleaning up... 21:40:42 INFO - Return code: 0 21:40:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:40:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:42 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 0x10e816b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e819768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd696c31f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e527d30>, '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 0x10e4dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e51bbe8>, '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.kwtYeVPrzE/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.Gl2B1OPJbc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 21:40:42 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 21:40:42 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 21:40:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwtYeVPrzE/Render', 21:40:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:42 INFO - 'HOME': '/Users/cltbld', 21:40:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:42 INFO - 'LOGNAME': 'cltbld', 21:40:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:42 INFO - 'MOZ_NO_REMOTE': '1', 21:40:42 INFO - 'NO_EM_RESTART': '1', 21:40:42 INFO - 'PAGER': '/bin/cat', 21:40:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:42 INFO - 'PWD': '/builds/slave/test', 21:40:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:42 INFO - 'SHELL': '/bin/bash', 21:40:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gl2B1OPJbc/Listeners', 21:40:42 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 21:40:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:42 INFO - 'USER': 'cltbld', 21:40:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:42 INFO - 'XPC_FLAGS': '0x0', 21:40:42 INFO - 'XPC_SERVICE_NAME': '0', 21:40:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:40:42 INFO - Cleaning up... 21:40:42 INFO - Return code: 0 21:40:42 INFO - Running post-action listener: _resource_record_post_action 21:40:42 INFO - Running post-action listener: _start_resource_monitoring 21:40:42 INFO - Starting resource monitoring. 21:40:42 INFO - [mozharness: 2017-05-08 04:40:42.329265Z] Finished create-virtualenv step (success) 21:40:42 INFO - [mozharness: 2017-05-08 04:40:42.330238Z] Running install step. 21:40:42 INFO - Running pre-action listener: _resource_record_pre_action 21:40:42 INFO - Running main action method: install 21:40:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:40:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:40:42 INFO - Reading from file tmpfile_stdout 21:40:42 INFO - Detecting whether we're running mozinstall >=1.0... 21:40:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:40:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:40:42 INFO - Reading from file tmpfile_stdout 21:40:42 INFO - Output received: 21:40:42 INFO - Usage: mozinstall [options] installer 21:40:42 INFO - Options: 21:40:42 INFO - -h, --help show this help message and exit 21:40:42 INFO - -d DEST, --destination=DEST 21:40:42 INFO - Directory to install application into. [default: 21:40:42 INFO - "/builds/slave/test"] 21:40:42 INFO - --app=APP Application being installed. [default: firefox] 21:40:42 INFO - mkdir: /builds/slave/test/build/application 21:40:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:40:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 21:41:02 INFO - Reading from file tmpfile_stdout 21:41:02 INFO - Output received: 21:41:02 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:41:02 INFO - Running post-action listener: _resource_record_post_action 21:41:02 INFO - [mozharness: 2017-05-08 04:41:02.261444Z] Finished install step (success) 21:41:02 INFO - [mozharness: 2017-05-08 04:41:02.261579Z] Running run-tests step. 21:41:02 INFO - Running pre-action listener: _resource_record_pre_action 21:41:02 INFO - Running main action method: run_tests 21:41:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:41:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:41:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:41:02 INFO - 2017-05-07 21:41:02.276 screenresolution[1992:19929] starting screenresolution argv=screenresolution get 21:41:02 INFO - 2017-05-07 21:41:02.278 screenresolution[1992:19929] Display 0: 1600x1200x32@60 21:41:02 INFO - 2017-05-07 21:41:02.284 screenresolution[1993:19931] starting screenresolution argv=screenresolution list 21:41:02 INFO - Available Modes on Display 0 21:41:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:41:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:41:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:41:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:41:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:41:02 INFO - Intel Iris: 21:41:02 INFO - Chipset Model: Intel Iris 21:41:02 INFO - Type: GPU 21:41:02 INFO - Bus: Built-In 21:41:02 INFO - VRAM (Dynamic, Max): 1536 MB 21:41:02 INFO - Vendor: Intel (0x8086) 21:41:02 INFO - Device ID: 0x0a2e 21:41:02 INFO - Revision ID: 0x0009 21:41:02 INFO - Displays: 21:41:02 INFO - Display: 21:41:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:41:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:41:02 INFO - Display Serial Number: 1600x1200 60 21:41:02 INFO - Main Display: Yes 21:41:02 INFO - Mirror: Off 21:41:02 INFO - Online: Yes 21:41:02 INFO - Rotation: Supported 21:41:02 INFO - Return code: 0 21:41:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:41:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:41:02 INFO - Python 2.7.3 21:41:02 INFO - Return code: 0 21:41:02 INFO - grabbing minidump binary from tooltool 21:41: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')]} 21:41:02 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 0x10e527d30>, '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 0x10e4dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e51bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:41:02 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 21:41:02 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 21:41:02 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 21:41:02 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:41:02 INFO - Return code: 0 21:41:02 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:41:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:41:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:41:02 INFO - ENV: RUST_BACKTRACE is now 1 21:41:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:41:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:41:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RAwyJyWET9WwR3gWBlluCA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0073', '--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 21:41:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RAwyJyWET9WwR3gWBlluCA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0073 --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 21:41:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwtYeVPrzE/Render', 21:41:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:41:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:41:02 INFO - 'HOME': '/Users/cltbld', 21:41:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:41:02 INFO - 'LOGNAME': 'cltbld', 21:41:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:41:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:02 INFO - 'MOZ_NO_REMOTE': '1', 21:41:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:41:02 INFO - 'NO_EM_RESTART': '1', 21:41:02 INFO - 'PAGER': '/bin/cat', 21:41:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:02 INFO - 'PWD': '/builds/slave/test', 21:41:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:41:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:41:02 INFO - 'RUST_BACKTRACE': '1', 21:41:02 INFO - 'SHELL': '/bin/bash', 21:41:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gl2B1OPJbc/Listeners', 21:41:02 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 21:41:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:41:02 INFO - 'USER': 'cltbld', 21:41:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:41:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:02 INFO - 'XPC_FLAGS': '0x0', 21:41:02 INFO - 'XPC_SERVICE_NAME': '0', 21:41:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:41:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RAwyJyWET9WwR3gWBlluCA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0073', '--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 21:41:02 INFO - mozversion application_buildid: 20170507201733 21:41:02 INFO - mozversion application_changeset: c3e5497cff1c995821b1c9320fa71f1ef9a8c30e 21:41:02 INFO - mozversion application_display_name: Nightly 21:41:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:41:02 INFO - mozversion application_name: Firefox 21:41:02 INFO - mozversion application_remotingname: firefox 21:41:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:41:02 INFO - mozversion application_vendor: Mozilla 21:41:02 INFO - mozversion application_version: 55.0a1 21:41:02 INFO - mozversion platform_buildid: 20170507201733 21:41:02 INFO - mozversion platform_changeset: c3e5497cff1c995821b1c9320fa71f1ef9a8c30e 21:41:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:41:02 INFO - mozversion platform_version: 55.0a1 21:41:02 INFO - using testdate: 1494218462 21:41:02 INFO - actual date: 1494218462 21:41:02 INFO - starting webserver on 'localhost:49308' 21:41:02 INFO - SUITE-START | Running 2 tests 21:41:02 INFO - TEST-START | dromaeo_css 21:41:02 INFO - operating with platform_type : mac_ 21:41:02 INFO - Initialising browser for dromaeo_css test... 21:41:02 INFO - TEST-INFO | started process 2003 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpkytW_2/profile http://localhost:49308/getInfo.html) 21:41:05 INFO - PID 2003 | 2017-05-07 21:41:05.703 plugin-container[2005:20104] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9737, name = 'com.apple.tsm.portname' 21:41:05 INFO - PID 2003 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:41:05 INFO - PID 2003 | 2017-05-07 21:41:05.706 plugin-container[2005:20104] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9857, name = 'com.apple.CFPasteboardClient' 21:41:05 INFO - PID 2003 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:41:05 INFO - PID 2003 | 2017-05-07 21:41:05.706 plugin-container[2005:20104] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:41:05 INFO - PID 2003 | __metrics Screen width/height:1600/1200 21:41:05 INFO - PID 2003 | colorDepth:24 21:41:05 INFO - PID 2003 | Browser inner width/height: 1024/691 21:41:05 INFO - PID 2003 | __metrics 21:41:06 INFO - PID 2003 | 21:41:06 INFO - PID 2003 | ###!!! [Child][MessageChannel] Error: (msgtype=0x7C0029,name=PHal::Msg_EnableWakeLockNotifications) Channel closing: too late to send/recv, messages will be lost 21:41:06 INFO - PID 2003 | 21:41:06 INFO - PID 2003 | 2017-05-07 21:41:06.324 plugin-container[2007:20165] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x433f, name = 'com.apple.tsm.portname' 21:41:06 INFO - PID 2003 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:41:06 INFO - PID 2003 | 2017-05-07 21:41:06.325 plugin-container[2007:20165] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 21:41:06 INFO - PID 2003 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:41:06 INFO - PID 2003 | 2017-05-07 21:41:06.325 plugin-container[2007:20165] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:41:06 INFO - TEST-INFO | 2003: exit 0 21:41:06 INFO - Browser initialized. 21:41:06 INFO - Running cycle 1/1 for dromaeo_css test... 21:41:06 INFO - TEST-INFO | started process 2008 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpkytW_2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:41:09 INFO - PID 2008 | 2017-05-07 21:41:09.323 plugin-container[2009:20275] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x954b, name = 'com.apple.tsm.portname' 21:41:09 INFO - PID 2008 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:41:09 INFO - PID 2008 | 2017-05-07 21:41:09.323 plugin-container[2009:20275] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0f, name = 'com.apple.CFPasteboardClient' 21:41:09 INFO - PID 2008 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:41:09 INFO - PID 2008 | 2017-05-07 21:41:09.323 plugin-container[2009:20275] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:41:09 INFO - PID 2008 | 2017-05-07 21:41:09.813 plugin-container[2010:20320] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 21:41:09 INFO - PID 2008 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:41:09 INFO - PID 2008 | 2017-05-07 21:41:09.814 plugin-container[2010:20320] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 21:41:09 INFO - PID 2008 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:41:09 INFO - PID 2008 | 2017-05-07 21:41:09.814 plugin-container[2010:20320] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:41:19 INFO - PID 2008 | RSS: Main: 233037824 21:41:19 INFO - PID 2008 | 21:44:22 INFO - PID 2008 | Cycle 1(1): loaded http://localhost:49308/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49308/tests/dromaeo/cssquery-ext.html) 21:44:24 INFO - PID 2008 | RSS: Main: 250703872 21:44:24 INFO - PID 2008 | 21:47:26 INFO - PID 2008 | Cycle 1(1): loaded http://localhost:49308/tests/dromaeo/cssquery-ext.html (next: http://localhost:49308/tests/dromaeo/cssquery-jquery.html) 21:47:27 INFO - PID 2008 | RSS: Main: 256032768 21:47:27 INFO - PID 2008 | 21:50:29 INFO - PID 2008 | Cycle 1(1): loaded http://localhost:49308/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49308/tests/dromaeo/cssquery-mootools.html) 21:50:29 INFO - PID 2008 | RSS: Main: 266002432 21:50:29 INFO - PID 2008 | 21:53:31 INFO - PID 2008 | Cycle 1(1): loaded http://localhost:49308/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49308/tests/dromaeo/cssquery-prototype.html) 21:53:32 INFO - PID 2008 | RSS: Main: 261668864 21:53:32 INFO - PID 2008 | 21:56:34 INFO - PID 2008 | Cycle 1(1): loaded http://localhost:49308/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49308/tests/dromaeo/cssquery-yui.html) 21:56:35 INFO - PID 2008 | RSS: Main: 266579968 21:56:35 INFO - PID 2008 | 21:59:37 INFO - PID 2008 | Cycle 1(1): loaded http://localhost:49308/tests/dromaeo/cssquery-yui.html (next: http://localhost:49308/tests/dromaeo/cssquery-dojo.html) 21:59:37 INFO - PID 2008 | RSS: Main: 265445376 21:59:37 INFO - PID 2008 | 21:59:37 INFO - PID 2008 | __start_tp_report 21:59:37 INFO - PID 2008 | _x_x_mozilla_page_load 21:59:37 INFO - PID 2008 | _x_x_mozilla_page_load_details 21:59:37 INFO - PID 2008 | |i|pagename|runs| 21:59:37 INFO - PID 2008 | |0;dojo.html;3588.067102553335;3588.587312459067;3613.439916812895;3628.32875917955;3647.0335361129305;6115.235595550556;6174.289956654986;6183.969080154593;6196.16351792509;6257.906131408033;6154.861350650132;6193.318734939153;6206.1931948846695;6211.192544969159;6242.063690446435;5217.582593392539;5322.8137015204475;5328.1474964005765;5372;5417.377001644822;5358.812441564546;5418.29562156921;5430.647007944491;5438.564914806806;5478.123500239963;4655.86032419028;5353.973230133864;5424.5660347172525;5526.806561770359;5532.695701736443;4439.889002774924;5336.546393556552;5492.642978206404;5492.670439773627;5511.4213007634025;5425.240466334716;5438.510534051954;5486.945130548684;5488.807891723771;5506.394296627368;4582.15230182414;6120.846978825521;6142.2225331421305;6153.969230153865;6171.722272497704;6682.83292917681;6695.631740254284;6701.061851340816;6703.396694297488;6713;5551.472610102034;6762.628055456948;6806.897896531556;6813.046173535709;6817.761378351734;6158.922188616974;6163.414475624809;6224.502039836892;6297.583043815151;6302.306746257908;6858.5199036068;6871.209810871814;6904.171499420102;6916.688749006306;6933.341332573397;6343.936560634427;6356.141920840627;6497.577657452251;6506.642134682544;6602.042703808017;6674.566153200027;6743.629100399525;6764.255931847493;6779.423748981392;6780.627065511346;6419.646919419383;6524.119243902107;6536.7712130075215;6626.834329141713;6667.466602671871;6575.638339891256;6650.102236198051;6674.23246326669;6689.464842812563;6719.260881303053;5342.065138600729;5349.598780091431;5356.116240820299;5360.8659783504945;5389.568834493231;4049.6152865477734;4644.744539050317;4771.403574553181;4778.211595086841;4790.0659371422935;5025.447200807908;6094.451499365078;6279.022108035954;6311.621302721851;6316;6737.494687898427;6760.526763126534;6796.864062718718;6799.830004249834;6806.76176333826;4807.254875494304;5254.316938798008;6332.176817013758;6359.618422894641;6366.140571022853;5863.296404431496;5935.703214839241;5962.433568810956;5965.13505541694;5993.340732519419;6987.5807451552055;6990.545614535039;6999.0551275577145;7014.0531028310525;7029.718811247493;6694.631795251308;6807.727690892507;6814.522983391115;6834.316568343126;6847.726090956306;6987.266337034742;7006.229314775473;7016.894746578703;7020.719171233093;7054.294570542905;6463.903041454288;6560.606363618198;6563.573367731082;6630.900536492053;6682.3317668232785;5928.79249226275;6482.35176482348;6739.932600674127;6772.322767723385;6820.658967051529;5218.843434696965;6368.713407896748;6472.126262954441;6573.934260657524;6586.4401525870835;5714.02861513552;6555;6582.80251592453;6584.637844918576;6585.539012269095;6221.129041934223;6265.310815810166;6318.778842740482;6321.589096708699;6507.154069970874;6490.870182596416;6516;6548.869022619616;6588.670566471561;6603.471722262304;6374.872502549831;6379.298277189413;6408.070829729756;6421.197350331208;6431.196100487439 21:59:37 INFO - PID 2008 | |1;ext.html;725.6661935509666;799.7480793550031;824.0523398092195;1218.9451474683638;1274.4965738533274;31576.8948086817;37488.25023499532;38525.22949541011;38759.22481550367;38770.8061459693;39086;39326.80336598313;39418.80290598543;39453.40819887704;39683.412663493495;7915.327197188231;8082.878756818653;8348.791280218013;8498.53258070809;8572.271356934669;8500.532470714108;8539.444936079166;8543.871841922377;8608.354373421987;8624.18070283322;8543.530105844176;8569.271611912964;8619.094995025525;8652.43759155656;8658.610362533702;8554.18735220153;8597.699080532151;8599.312055035582;8604.956975215146;8625.913740862605;8280.627371768285;8318.45930014547;8342.37432192582;8404.117567655368;8416.326693864476;37983;38103.04742381435;38157.03958485379;38330.616693832984;38404.42393364102;3647.5075864758182;3665.193657395369;3677.9080522986874;3684.8341824617955;3687.520622319108;31003.22491937697;31261.687383126333;31382.372352552822;31427.84286078578;31489.370212595848;3150;3177.4280629486684;3180.538821870839;3187.6334221564584;3194.68053194681;220249;224491;248345;287240;307574;49378;49922.50077499251;49942.75143121379;50012.49987500079;50045.749771250914;51237.48762512327;51623.741881290356;52189.47810521846;52245.47754522482;52480.47519524832;14270.3578338975;14362.497312594009;14379.712405752036;14396.496122635657;14416.990810643154;11787.764244715057;11792.646220613395;11794.469248883821;11815.05479561633;11846.170768046326;11429.257098288585;12156.392180390945;12406.751864962831;13850.09974351664;13861.584152475441;6171.722272497748;6196.938030619726;6197.752089916443;6212.254529456403;6254.278704171102;809.5385630190734;898.5282726568604;960.6397600899662;1043.6868939318174;1044.7231483656838;25016.124435644666;25094.498110037697;25120.371990700012;25319.594638509312;25350.492990140094;1003.508280942333;1005.9497025148713;1124.8818874018111;1125.189863298424;1150.5800382860195;11812.527498899948;12855.678608034874;12876.549320773915;13012.089153759336;13348.73302533944;326285;328686;329436;330198;330742;55985.72007139938;56229.59426014382;56290;56359.43640563624;56437.15344269839;1291.3156027305542;1523.3678023620296;1538.6538028943398;1565.7729629203702;1568.051328945994;24598.754012459645;24898.502029958938;25961.870190648926;27387.767550460674;29133;49899.501004989484;51172.74413627908;51480.74259628678;51595.45213643597;51632;258867;259616;259636;260180;260371;33818.830905845316;34378.65621343755;35186.47220291646;35612.821935890155;35642.64357356393;44691.10617787691;45460.77269613631;47044.29433558568;47046.29430558476;47057.88239529161;26688.332791680365;29846.850765746032;31688.89088881878;31761.682383176798;32068.83965580157;31039.224019399695;31191.84404077965;31260.687393125776;31578.842105789325;31745.8412707935;38429.80785096057;38499.80750096231;38505.80747096246;38536.80731596324;38648.033799155244;29337.85331073331;29941;31291.061268161993;31597.368052639278;31606;20656.58686826285;24301.635475468236;24579.631305530074;24776.150742664104;25653.3586660335 21:59:37 INFO - PID 2008 | |2;jquery.html;402.6376261364772;428.1693514581713;432.58687953004863;442.0297447103608;461.10315436476066;20392.388228353135;21654.350369488922;22269.554608907853;22455.887720561375;22543.54912901743;22673.09307627697;23301.650475242885;23900.5219895602;24099;24103.75896241037;5067.847964561069;6014.909776353358;6131.540134489931;6228.19033525641;6228.968855155718;5857.85355366115;6056.545759068065;6107.236595425572;6148.508119350441;6153.630852121943;5862.941370586283;6044.3955604439425;6054.152418661391;6081.027035674293;6110.08348747687;6036.0945858121195;6059.212302400704;6080.391960803906;6084.209052823149;6091.086337049456;5356.598255130842;5366.91949620756;5413.485718856702;5443.292371991616;5447.155690867922;27644.58533122005;27673.584896226574;27836.721632783614;27938;28077.719222807715;1997.510609900569;2133.4986278224605;2179.626835093881;2253.887305634728;2314.0859360552486;14838.629034274121;17912.552186195448;18485.815141848678;18649.347272845385;18772.530686732804;2143.485563464773;2159.2941576154817;2200.614892393841;2204.8566843155304;2206.1285792112026;153591;156115;156801;158072;159842;9850.852237216448;10480.790384192274;13182;13198.898258909148;13332.600021999355;16750.58123546921;17077.57306067358;17143.57141071483;17154.142292885554;17162.914185428992;7810.336121429742;8565.48607083577;8956.910430895738;9039.367244292967;9087.863682044775;8523.573821309034;8536.658533658709;8571.82856342882;8721.520316382534;8730.650773969097;6993.615351155735;7865.646045927947;8130.878036829452;8150.551719655357;8196.508209507449;2069.4929742212953;2075.9205213289006;2243.618584840581;2251.2665247759132;2253.76335484775;1007.5012868630075;1008.3344992305043;1009.3842755918884;1041.942693151884;1048.2295512798087;20122.230406306542;21323.25368612122;21341.573168536852;21354.252601158885;21612.351629451143;1023.9078482936571;1029.8455231715302;1056.6724315462232;1060.522764755863;1067.1622776120707;9978.75265591801;10065.345752526062;10756.838647420294;11149.832752508719;11305.32168069902;496971;511185;540036;556249;556614;136339.31830340784;137291;137977.3101134508;140902;141498.29250853887;1213.3690480949856;1242.2546472116658;1267.0940277701304;1268.9746205075846;1278.213898452445;21677.02453389633;22284;22921.54156916819;23118.653220201373;23202.883985579963;59308.51728706817;59530;59797.70101149466;60219.39780602138;60228.49428764316;76707;79415.20584794079;79759.60120199362;80046.1995380062;80991;8874.112588741333;8956.417832840845;8981.775455613662;9050.592723327598;9354.485503297385;13034.608961731163;14526.636834079232;14571.708565828412;14668.633284167981;14908.62728431798;12019.699507512381;12153.331566763913;12179.451924663234;12236.08229382782;12427.502899884264;10406.947965260126;11013.889861101286;11316.094712423152;11489.770204596029;11934.761304774029;10893.509792059534;11892.345920974429;12363.69090772702;12418.689532761753;12587.87412125867;8807.383483156118;9126.406783559047;9129.5891684873;9280.62877484893;9353.942132730788;9423.858642120511;11937.52249909994;12048.337341446304;12128.151029428209;12191.085668574715 21:59:37 INFO - PID 2008 | |3;mootools.html;1382.7096309774947;1430.3706369197546;1444.5882923366837;1451.3251338127768;1456.5848733111063;9103.499307538092;10094.747631309221;11765;12022.098342624295;12037.879621203785;11766.588169414072;11971.221870578407;11971.580994665188;12009.579664711715;12271.877281227185;2186.3222401055646;2509.6486491891105;2545.121932933135;2560.9615855762086;2574.8455092694403;2479.5164942836063;2533.7972962162985;2541.2376287113884;2543.046357615894;2558.4115653399635;2358.5282943411303;2466.7163276223287;2523.621456781479;2537.8477291362483;2560.2703229579574;2484.167803785725;2512.1458704040624;2544.669193004907;2548.2610043087484;2551.068859866154;2477.2196758021346;2498.562751518477;2541.8474891506567;2546.6180072989014;2565.3073670108965;11896;11977;11983.46074426653;11988.100892433102;12006;6640.535162538624;6843.973403989441;6907.551009184387;6908.481863860231;6914.9654251728925;4093.9181216375805;4355.390245365651;4402.383666286691;4441.422615060053;4512.278035514335;1203.3441774233063;1256.6292943581666;1256.8994480441543;1304.5694920676153;1306.229324698423;12994.155379900276;15523;16445.177741113017;16547.751783723255;16615.584610384838;5588.748506317225;5728.455796699307;5745.6552606843725;5873.735681894325;5925.762969481172;11875.821862672066;11876.465559049864;11952.58165964187;12021.639350819489;12093.093018023683;6590.044443555754;6632.403083722488;6635.668216589152;6636.5354425190735;6690.933090669128;6047.606905551125;6115.327313995457;6227.1282020517165;6277.462021804596;6279.058141278845;4321.65426765858;4410.206162890647;4447.710898791568;4461.57615026572;4471.910561788746;1241.6523373455448;1268.7335659511607;1269.136986848933;1282.1345591725549;1284.9935750321376;794.5312265763228;798.6126728536655;826.9421140520105;834.2950207075012;839.5298632765549;6244.687765611792;6285.59143655661;6430.3891130342545;6524.575902566318;6570.178727659043;512.4388794270268;577.2466930655451;588.3469349022581;602.728772052578;611.3977731934042;3858.1704933439446;4028.274910516135;4371.519132895379;4594.977025114853;4629.722216667011;14401.351939162763;14780.556583302518;15100.848991510164;15197.6200594986;15210.087394756129;14290.214038227788;14486.927565362106;14952.850471495363;15030.09819410817;15033.323500442506;7692.153863075057;8763.868541971875;8879.24526415262;8888.11118888119;8910.420822646507;5709.22925405065;6594.505412094016;6863.627274545211;7156.320149585781;7461.552306861606;11337.659870203906;12184.939075304566;13476.393562289917;13720.794188086988;13759.931200343934;13697.32902084084;13786.310684465938;13937.442502299795;14097.718045638825;14199.503017394341;9357.035022645321;9391.248700104112;9402.2948278878;9470.668526601812;9518.333716639769;10850.837237441603;10861.619843305447;10950.671479855617;10957.506912188812;10964.342139471339;8977.820443591223;9258.074192580689;9273.629054837731;9279.953600231956;9387.202087822612;7324.340809327186;8926.553672316488;9015.639374425213;9068.954655226682;9250.751148594854;6744.966275168593;8254;8366.33069354438;8379.413441059067;8392.328613710766;5689.77240910359;5805.535557155502;6098.5426093042315;6171.259448866164;6306.810795676137;5345.518903298722;5928.407159284037;6291.528135389955;6308.022256550242;6313.2424109107205 21:59:37 INFO - PID 2008 | |4;prototype.html;308.29400672460065;407.91025974285657;408.7976451656431;409.1795949122011;414.8008955701265;6320.241571011474;6386.936130638698;6442.806715798533;6463.838404039907;6469.676516174184;5441.2654291670615;5676;6164.260288765343;6175.320714721377;6346.841328966778;4132.938005929914;4785.617150627959;4808.951910480885;4812.7968007997915;4813.868740845898;4829.710217386968;4836.927446088312;4850.927236091461;4851.320815085873;4861.416630004387;4099.6105369989955;4588.7246765194195;4675.04499070275;4751.596114330268;4775.259834725605;4738.597219236369;4775.952240477585;4788.449328327252;4788.856334309976;4816.325714399987;3697.4084146536425;4231.978840105779;4233.534311225762;4255.425517555122;4269.359596060584;6079.179310793031;6155.59988600744;6179.721912513947;6217.782377616807;6241.063840423973;5642.379338272828;5647.774089036434;5650.491455769001;5679.858003549903;5681.346645135821;5505.852717440202;6217.751289948396;6530.314316996694;6791;6873.140857392826;4179.97910010448;4779.378680771512;4816.927746083811;4840.757962101916;4846.151923413388;5644.6330988485615;6152.600080994676;6854.554453960526;7169.964150179268;7178.712851485934;4888.853334399973;5058.5194406532055;5140.177571588528;5140.254663073833;5169.922451163236;5254.4220135785035;5271.551918087006;5277.445868183862;5285.308701215651;5292.92060619091;4785.952140478551;4943.3573635427165;5840.678762668094;5857.941420585825;5880.206172166702;5843.883122337529;6011.639301641915;6512.63234720714;6905.654717264117;6980.371766541036;1579.8499142581436;1772.6543324051686;1777.3423833181805;1790.4002159276529;1815;1099.961501347465;1133.1501373969522;1173.3077484284313;1240.584404224577;1253.360785999147;5937.70311484424;6319.778807741707;6390.041493775971;6505.60966342021;6511.544191906521;7044.6125463100025;7072.222055573883;7077.363037326665;7085.362317391459;7096.361327480551;6260.749570017239;6403.359664033559;6431.485481161496;6452.612843229421;6492.935070649328;3074.4619691554335;3488.0582242794303;3671.3662420223277;3671.742977991515;3675.1363429594026;5746.856328591819;7129.037579926644;7261.7396473152785;7306.378957788541;7337.59643219628;6747.325267473311;7290.125184977836;7297.416206703557;7321.853562928712;7338.633068346561;6963.547369420971;7347;7370.77887663371;7446.356543427114;7461.664225109775;6300.338464461165;6527.249366322933;7134.179569349383;7146.106281835422;7147.106611673541;6384.521160913043;6558.737650493927;6733.326667333227;6829.351211634887;7042.401395881203;5383.7308134593895;6074.693940802748;7306.97702321686;7336.926630733838;7346.853062938818;4020.778857162767;4527.524609915911;4555.883808466947;4576.222042252892;4576.931346029745;6160.845978850564;6768.409423785308;6852.246252912076;7035.155781306276;7135.322144396274;5320.494553017457;6512.5766825156215;6772.932270677427;6829.6243706596615;6833.214180369122;6738.966305168443;6822.71439067898;6830.624315662686;6842.486813488908;6860.897086543606;5838.474537291664;6328.608105813254;6668.799936001928;6683.565568238049;6708.463322934056;6535.849735417949;6739.081579144584;6807.591544507345;6811.89782153278;6848.623325717133;5213.400458947118;6651.767188148391;6652.37016930855;6654.234763002317;6682.699278532575 21:59:37 INFO - PID 2008 | |5;yui.html;830.1573902488979;839.7858546070751;840.3781201910587;866.0949307973166;867.3761870342214;14670.559883203521;15206.771898421504;16664.000159990395;17129.229184686686;17129.914350428247;17123.97256164631;17782.82217177828;17793.644127117448;17866;18211.27154913802;977.9902200977988;993.3741742702124;995.920326373892;1003.2425518733346;1004.5228516454698;931.9953400233023;972.5915115651408;1033.0392734756674;1037.1702637889696;1038.5586125896502;1053.515382923856;1054.836500342448;1056.1392465140923;1056.75166335911;1058.3015209961427;1053.1785207538132;1054.46222426563;1055.3509591601187;1056.9524371403268;1068.033429746081;767.1944458318743;779.1351599724302;781.9843603127906;784.4234487651571;790.5967956342249;17393.913030434767;17394.21726022332;17569.472915812545;17751.644967100714;17801.910990444965;17286.3949761759;17401.738973915402;17458.127093645267;17601.823981760273;17734.91132544342;11472.655820325404;13827.308634568331;14061.507847225297;14299.428022879072;14426.134431934117;3524.312759011994;3524.524189234446;3554.253606742587;3554.4845997330244;3557.2351944332095;113435.99999999917;137634.31182844023;138093;138901.61098388987;139345.6392616436;13546.322683865767;13647.454101836014;13692;13733;13766.65583360424;24615.753842461705;25164.496710065698;25174.496510069697;25245.242642720747;25492.107776227742;7595.430342724318;7886.211378862068;7939.64271607779;7944.24529669692;7996.200379962073;3886.281038007921;3912.5304963404005;3932.8623498177426;3948.309045916953;3984.063745019918;4109.424680544666;4231.894202644959;4257.74453532789;4314.1371725655;4372.928632485062;702.8137543550963;829.98340033199;865.6277800545826;869.2698133567833;869.7651634058768;570.6461993563934;634.8793729191439;666.3736088077192;675.3617831149614;696.8083776961275;11026.503807328689;11858.350867441994;12069.396530173457;12129.454174562166;12147.331896745587;649.1301655781182;652.1326635574675;660.3429587560408;665.2648823050556;685.5680921019725;5445.646033007842;5586.245856809279;5599.216109744639;5681.261436013292;5684.971575142098;71830.64084679543;109749;111018.88981110086;112307.87692123138;114320.14079155277;97876;98276.52585211227;98936.5053174744;99189.50405248071;100425.49787251017;72627.63686181641;81851.18148818555;81890.59054704689;84462.73305900417;85204.57397713096;10329.896701032894;12537.373131343578;12942.964562835139;13106.082574220094;13120.540781072617;40990;41405.37891931563;41419.37870931878;42172.789136054125;42536.78731606322;51906.96186076333;68984.65507672429;69640.6517967407;71492;74974;16594;16760.497185084467;16840.410585629445;17102.230399632295;17221.39725109615;15824.525264242091;17763.20065597077;18312.53499720046;18562.350317738816;18720.812791871907;16529.421470248482;17437.82562174362;17819.554511137325;17928.282868685626;18061.367852125113;16523.917380413503;16954.237059332605;17603.383881564085;17714.64570708553;17731.468055958343;13671.111377760413;14115.294235287989;14130.434782608581;14152.575422737335;17184.656306874043;11434.599789007345;11536.59621913229;11541.422928853355;11692.94153529227;12010.279383237033;13200.189729635424;13762.70173341279;14032.947528935167;14043.50847720325;14044.648883777987 21:59:37 INFO - PID 2008 | __end_tp_report 21:59:37 INFO - PID 2008 | __start_cc_report 21:59:37 INFO - PID 2008 | _x_x_mozilla_cycle_collect,402 21:59:37 INFO - PID 2008 | __end_cc_report 21:59:37 INFO - PID 2008 | __startTimestamp1494219577471__endTimestamp 21:59:37 INFO - PID 2008 | 21:59:37 INFO - PID 2008 | ------- Summary: start ------- 21:59:37 INFO - PID 2008 | Number of tests: 6 21:59:37 INFO - PID 2008 | 21:59:37 INFO - PID 2008 | [#0] dojo.html Cycles:165 Average:6115.55 Median:6356.14 stddev:780.60 (12.3%) stddev-sans-first:757.39 21:59:37 INFO - PID 2008 | Values: 3588.1 3588.6 3613.4 3628.3 3647.0 6115.2 6174.3 6184.0 6196.2 6257.9 6154.9 6193.3 6206.2 6211.2 6242.1 5217.6 5322.8 5328.1 5372.0 5417.4 5358.8 5418.3 5430.6 5438.6 5478.1 4655.9 5354.0 5424.6 5526.8 5532.7 4439.9 5336.5 5492.6 5492.7 5511.4 5425.2 5438.5 5486.9 5488.8 5506.4 4582.2 6120.8 6142.2 6154.0 6171.7 6682.8 6695.6 6701.1 6703.4 6713.0 5551.5 6762.6 6806.9 6813.0 6817.8 6158.9 6163.4 6224.5 6297.6 6302.3 6858.5 6871.2 6904.2 6916.7 6933.3 6343.9 6356.1 6497.6 6506.6 6602.0 6674.6 6743.6 6764.3 6779.4 6780.6 6419.6 6524.1 6536.8 6626.8 6667.5 6575.6 6650.1 6674.2 6689.5 6719.3 5342.1 5349.6 5356.1 5360.9 5389.6 4049.6 4644.7 4771.4 4778.2 4790.1 5025.4 6094.5 6279.0 6311.6 6316.0 6737.5 6760.5 6796.9 6799.8 6806.8 4807.3 5254.3 6332.2 6359.6 6366.1 5863.3 5935.7 5962.4 5965.1 5993.3 6987.6 6990.5 6999.1 7014.1 7029.7 6694.6 6807.7 6814.5 6834.3 6847.7 6987.3 7006.2 7016.9 7020.7 7054.3 6463.9 6560.6 6563.6 6630.9 6682.3 5928.8 6482.4 6739.9 6772.3 6820.7 5218.8 6368.7 6472.1 6573.9 6586.4 5714.0 6555.0 6582.8 6584.6 6585.5 6221.1 6265.3 6318.8 6321.6 6507.2 6490.9 6516.0 6548.9 6588.7 6603.5 6374.9 6379.3 6408.1 6421.2 6431.2 21:59:37 INFO - PID 2008 | 21:59:37 INFO - PID 2008 | [#1] ext.html Cycles:180 Average:44472.43 Median:34098.74 stddev:74583.30 (218.7%) stddev-sans-first:74720.20 21:59:37 INFO - PID 2008 | Values: 725.7 799.7 824.1 1218.9 1274.5 31576.9 37488.3 38525.2 38759.2 38770.8 39086.0 39326.8 39418.8 39453.4 39683.4 7915.3 8082.9 8348.8 8498.5 8572.3 8500.5 8539.4 8543.9 8608.4 8624.2 8543.5 8569.3 8619.1 8652.4 8658.6 8554.2 8597.7 8599.3 8605.0 8625.9 8280.6 8318.5 8342.4 8404.1 8416.3 37983.0 38103.0 38157.0 38330.6 38404.4 3647.5 3665.2 3677.9 3684.8 3687.5 31003.2 31261.7 31382.4 31427.8 31489.4 3150.0 3177.4 3180.5 3187.6 3194.7 220249.0 224491.0 248345.0 287240.0 307574.0 49378.0 49922.5 49942.8 50012.5 50045.7 51237.5 51623.7 52189.5 52245.5 52480.5 14270.4 14362.5 14379.7 14396.5 14417.0 11787.8 11792.6 11794.5 11815.1 11846.2 11429.3 12156.4 12406.8 13850.1 13861.6 6171.7 6196.9 6197.8 6212.3 6254.3 809.5 898.5 960.6 1043.7 1044.7 25016.1 25094.5 25120.4 25319.6 25350.5 1003.5 1005.9 1124.9 1125.2 1150.6 11812.5 12855.7 12876.5 13012.1 13348.7 326285.0 328686.0 329436.0 330198.0 330742.0 55985.7 56229.6 56290.0 56359.4 56437.2 1291.3 1523.4 1538.7 1565.8 1568.1 24598.8 24898.5 25961.9 27387.8 29133.0 49899.5 51172.7 51480.7 51595.5 51632.0 258867.0 259616.0 259636.0 260180.0 260371.0 33818.8 34378.7 35186.5 35612.8 35642.6 44691.1 45460.8 47044.3 47046.3 47057.9 26688.3 29846.9 31688.9 31761.7 32068.8 31039.2 31191.8 31260.7 31578.8 31745.8 38429.8 38499.8 38505.8 38536.8 38648.0 29337.9 29941.0 31291.1 31597.4 31606.0 20656.6 24301.6 24579.6 24776.2 25653.4 21:59:37 INFO - PID 2008 | 21:59:37 INFO - PID 2008 | [#2] jquery.html Cycles:180 Average:35726.84 Median:2253.83 stddev:91024.87 (4038.7%) stddev-sans-first:91241.58 21:59:37 INFO - PID 2008 | Values: 402.6 428.2 432.6 442.0 461.1 20392.4 21654.4 22269.6 22455.9 22543.5 22673.1 23301.7 23900.5 24099.0 24103.8 5067.8 6014.9 6131.5 6228.2 6229.0 5857.9 6056.5 6107.2 6148.5 6153.6 5862.9 6044.4 6054.2 6081.0 6110.1 6036.1 6059.2 6080.4 6084.2 6091.1 5356.6 5366.9 5413.5 5443.3 5447.2 27644.6 27673.6 27836.7 27938.0 28077.7 1997.5 2133.5 2179.6 2253.9 2314.1 14838.6 17912.6 18485.8 18649.3 18772.5 2143.5 2159.3 2200.6 2204.9 2206.1 153591.0 156115.0 156801.0 158072.0 159842.0 9850.9 10480.8 13182.0 13198.9 13332.6 16750.6 17077.6 17143.6 17154.1 17162.9 7810.3 8565.5 8956.9 9039.4 9087.9 8523.6 8536.7 8571.8 8721.5 8730.7 6993.6 7865.6 8130.9 8150.6 8196.5 2069.5 2075.9 2243.6 2251.3 2253.8 1007.5 1008.3 1009.4 1041.9 1048.2 20122.2 21323.3 21341.6 21354.3 21612.4 1023.9 1029.8 1056.7 1060.5 1067.2 9978.8 10065.3 10756.8 11149.8 11305.3 496971.0 511185.0 540036.0 556249.0 556614.0 136339.3 137291.0 137977.3 140902.0 141498.3 1213.4 1242.3 1267.1 1269.0 1278.2 21677.0 22284.0 22921.5 23118.7 23202.9 59308.5 59530.0 59797.7 60219.4 60228.5 76707.0 79415.2 79759.6 80046.2 80991.0 8874.1 8956.4 8981.8 9050.6 9354.5 13034.6 14526.6 14571.7 14668.6 14908.6 12019.7 12153.3 12179.5 12236.1 12427.5 10406.9 11013.9 11316.1 11489.8 11934.8 10893.5 11892.3 12363.7 12418.7 12587.9 8807.4 9126.4 9129.6 9280.6 9353.9 9423.9 11937.5 12048.3 12128.2 12191.1 21:59:37 INFO - PID 2008 | 21:59:37 INFO - PID 2008 | [#3] mootools.html Cycles:180 Average:7102.98 Median:4061.10 stddev:4460.78 (109.8%) stddev-sans-first:4452.59 21:59:37 INFO - PID 2008 | Values: 1382.7 1430.4 1444.6 1451.3 1456.6 9103.5 10094.7 11765.0 12022.1 12037.9 11766.6 11971.2 11971.6 12009.6 12271.9 2186.3 2509.6 2545.1 2561.0 2574.8 2479.5 2533.8 2541.2 2543.0 2558.4 2358.5 2466.7 2523.6 2537.8 2560.3 2484.2 2512.1 2544.7 2548.3 2551.1 2477.2 2498.6 2541.8 2546.6 2565.3 11896.0 11977.0 11983.5 11988.1 12006.0 6640.5 6844.0 6907.6 6908.5 6915.0 4093.9 4355.4 4402.4 4441.4 4512.3 1203.3 1256.6 1256.9 1304.6 1306.2 12994.2 15523.0 16445.2 16547.8 16615.6 5588.7 5728.5 5745.7 5873.7 5925.8 11875.8 11876.5 11952.6 12021.6 12093.1 6590.0 6632.4 6635.7 6636.5 6690.9 6047.6 6115.3 6227.1 6277.5 6279.1 4321.7 4410.2 4447.7 4461.6 4471.9 1241.7 1268.7 1269.1 1282.1 1285.0 794.5 798.6 826.9 834.3 839.5 6244.7 6285.6 6430.4 6524.6 6570.2 512.4 577.2 588.3 602.7 611.4 3858.2 4028.3 4371.5 4595.0 4629.7 14401.4 14780.6 15100.8 15197.6 15210.1 14290.2 14486.9 14952.9 15030.1 15033.3 7692.2 8763.9 8879.2 8888.1 8910.4 5709.2 6594.5 6863.6 7156.3 7461.6 11337.7 12184.9 13476.4 13720.8 13759.9 13697.3 13786.3 13937.4 14097.7 14199.5 9357.0 9391.2 9402.3 9470.7 9518.3 10850.8 10861.6 10950.7 10957.5 10964.3 8977.8 9258.1 9273.6 9280.0 9387.2 7324.3 8926.6 9015.6 9069.0 9250.8 6745.0 8254.0 8366.3 8379.4 8392.3 5689.8 5805.5 6098.5 6171.3 6306.8 5345.5 5928.4 6291.5 6308.0 6313.2 21:59:37 INFO - PID 2008 | 21:59:37 INFO - PID 2008 | [#4] prototype.html Cycles:180 Average:5545.12 Median:6158.22 stddev:1686.59 (27.4%) stddev-sans-first:1644.89 21:59:37 INFO - PID 2008 | Values: 308.3 407.9 408.8 409.2 414.8 6320.2 6386.9 6442.8 6463.8 6469.7 5441.3 5676.0 6164.3 6175.3 6346.8 4132.9 4785.6 4809.0 4812.8 4813.9 4829.7 4836.9 4850.9 4851.3 4861.4 4099.6 4588.7 4675.0 4751.6 4775.3 4738.6 4776.0 4788.4 4788.9 4816.3 3697.4 4232.0 4233.5 4255.4 4269.4 6079.2 6155.6 6179.7 6217.8 6241.1 5642.4 5647.8 5650.5 5679.9 5681.3 5505.9 6217.8 6530.3 6791.0 6873.1 4180.0 4779.4 4816.9 4840.8 4846.2 5644.6 6152.6 6854.6 7170.0 7178.7 4888.9 5058.5 5140.2 5140.3 5169.9 5254.4 5271.6 5277.4 5285.3 5292.9 4786.0 4943.4 5840.7 5857.9 5880.2 5843.9 6011.6 6512.6 6905.7 6980.4 1579.8 1772.7 1777.3 1790.4 1815.0 1100.0 1133.2 1173.3 1240.6 1253.4 5937.7 6319.8 6390.0 6505.6 6511.5 7044.6 7072.2 7077.4 7085.4 7096.4 6260.7 6403.4 6431.5 6452.6 6492.9 3074.5 3488.1 3671.4 3671.7 3675.1 5746.9 7129.0 7261.7 7306.4 7337.6 6747.3 7290.1 7297.4 7321.9 7338.6 6963.5 7347.0 7370.8 7446.4 7461.7 6300.3 6527.2 7134.2 7146.1 7147.1 6384.5 6558.7 6733.3 6829.4 7042.4 5383.7 6074.7 7307.0 7336.9 7346.9 4020.8 4527.5 4555.9 4576.2 4576.9 6160.8 6768.4 6852.2 7035.2 7135.3 5320.5 6512.6 6772.9 6829.6 6833.2 6739.0 6822.7 6830.6 6842.5 6860.9 5838.5 6328.6 6668.8 6683.6 6708.5 6535.8 6739.1 6807.6 6811.9 6848.6 5213.4 6651.8 6652.4 6654.2 6682.7 21:59:37 INFO - PID 2008 | 21:59:37 INFO - PID 2008 | [#5] yui.html Cycles:180 Average:22640.48 Median:17797.78 stddev:32432.10 (182.2%) stddev-sans-first:32481.73 21:59:37 INFO - PID 2008 | Values: 830.2 839.8 840.4 866.1 867.4 14670.6 15206.8 16664.0 17129.2 17129.9 17124.0 17782.8 17793.6 17866.0 18211.3 978.0 993.4 995.9 1003.2 1004.5 932.0 972.6 1033.0 1037.2 1038.6 1053.5 1054.8 1056.1 1056.8 1058.3 1053.2 1054.5 1055.4 1057.0 1068.0 767.2 779.1 782.0 784.4 790.6 17393.9 17394.2 17569.5 17751.6 17801.9 17286.4 17401.7 17458.1 17601.8 17734.9 11472.7 13827.3 14061.5 14299.4 14426.1 3524.3 3524.5 3554.3 3554.5 3557.2 113436.0 137634.3 138093.0 138901.6 139345.6 13546.3 13647.5 13692.0 13733.0 13766.7 24615.8 25164.5 25174.5 25245.2 25492.1 7595.4 7886.2 7939.6 7944.2 7996.2 3886.3 3912.5 3932.9 3948.3 3984.1 4109.4 4231.9 4257.7 4314.1 4372.9 702.8 830.0 865.6 869.3 869.8 570.6 634.9 666.4 675.4 696.8 11026.5 11858.4 12069.4 12129.5 12147.3 649.1 652.1 660.3 665.3 685.6 5445.6 5586.2 5599.2 5681.3 5685.0 71830.6 109749.0 111018.9 112307.9 114320.1 97876.0 98276.5 98936.5 99189.5 100425.5 72627.6 81851.2 81890.6 84462.7 85204.6 10329.9 12537.4 12943.0 13106.1 13120.5 40990.0 41405.4 41419.4 42172.8 42536.8 51907.0 68984.7 69640.7 71492.0 74974.0 16594.0 16760.5 16840.4 17102.2 17221.4 15824.5 17763.2 18312.5 18562.4 18720.8 16529.4 17437.8 17819.6 17928.3 18061.4 16523.9 16954.2 17603.4 17714.6 17731.5 13671.1 14115.3 14130.4 14152.6 17184.7 11434.6 11536.6 11541.4 11692.9 12010.3 13200.2 13762.7 14032.9 14043.5 14044.6 21:59:37 INFO - PID 2008 | -------- Summary: end -------- 21:59:37 INFO - PID 2008 | 21:59:38 INFO - TEST-INFO | 2008: exit 0 21:59:38 INFO - TEST-OK | dromaeo_css | took 1115225ms 21:59:38 INFO - TEST-START | kraken 21:59:38 INFO - operating with platform_type : mac_ 21:59:38 INFO - Initialising browser for kraken test... 21:59:38 INFO - TEST-INFO | started process 2018 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpCrc4wI/profile http://localhost:49308/getInfo.html) 21:59:40 INFO - PID 2018 | 2017-05-07 21:59:40.820 plugin-container[2019:22567] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 21:59:40 INFO - PID 2018 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:59:40 INFO - PID 2018 | 2017-05-07 21:59:40.822 plugin-container[2019:22567] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 21:59:40 INFO - PID 2018 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:59:40 INFO - PID 2018 | 2017-05-07 21:59:40.823 plugin-container[2019:22567] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:59:40 INFO - PID 2018 | __metrics Screen width/height:1600/1200 21:59:40 INFO - PID 2018 | colorDepth:24 21:59:40 INFO - PID 2018 | Browser inner width/height: 1024/691 21:59:40 INFO - PID 2018 | __metrics 21:59:42 INFO - TEST-INFO | 2018: exit 0 21:59:42 INFO - Browser initialized. 21:59:42 INFO - Running cycle 1/1 for kraken test... 21:59:42 INFO - TEST-INFO | started process 2021 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpCrc4wI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:59:44 INFO - PID 2021 | 2017-05-07 21:59:44.549 plugin-container[2022:22726] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 21:59:44 INFO - PID 2021 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:59:44 INFO - PID 2021 | 2017-05-07 21:59:44.550 plugin-container[2022:22726] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9617, name = 'com.apple.CFPasteboardClient' 21:59:44 INFO - PID 2021 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:59:44 INFO - PID 2021 | 2017-05-07 21:59:44.550 plugin-container[2022:22726] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:59:45 INFO - PID 2021 | 2017-05-07 21:59:45.067 plugin-container[2023:22770] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x903f, name = 'com.apple.tsm.portname' 21:59:45 INFO - PID 2021 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:59:45 INFO - PID 2021 | 2017-05-07 21:59:45.067 plugin-container[2023:22770] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x940f, name = 'com.apple.CFPasteboardClient' 21:59:45 INFO - PID 2021 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:59:45 INFO - PID 2021 | 2017-05-07 21:59:45.067 plugin-container[2023:22770] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:59:54 INFO - PID 2021 | RSS: Main: 234205184 21:59:54 INFO - PID 2021 | 21:59:57 INFO - PID 2021 | Cycle 1(1): loaded http://localhost:49308/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49308/tests/kraken/driver.html?testName=audio-beat-detection) 21:59:58 INFO - PID 2021 | RSS: Main: 246947840 21:59:58 INFO - PID 2021 | 22:00:00 INFO - PID 2021 | Cycle 1(1): loaded http://localhost:49308/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49308/tests/kraken/driver.html?testName=audio-dft) 22:00:01 INFO - PID 2021 | RSS: Main: 255168512 22:00:01 INFO - PID 2021 | 22:00:04 INFO - PID 2021 | Cycle 1(1): loaded http://localhost:49308/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49308/tests/kraken/driver.html?testName=audio-fft) 22:00:05 INFO - PID 2021 | RSS: Main: 257474560 22:00:05 INFO - PID 2021 | 22:00:07 INFO - PID 2021 | Cycle 1(1): loaded http://localhost:49308/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49308/tests/kraken/driver.html?testName=audio-oscillator) 22:00:08 INFO - PID 2021 | RSS: Main: 258756608 22:00:08 INFO - PID 2021 | 22:00:10 INFO - PID 2021 | Cycle 1(1): loaded http://localhost:49308/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49308/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:00:10 INFO - PID 2021 | RSS: Main: 259387392 22:00:10 INFO - PID 2021 | 22:00:13 INFO - PID 2021 | Cycle 1(1): loaded http://localhost:49308/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49308/tests/kraken/driver.html?testName=imaging-darkroom) 22:00:14 INFO - PID 2021 | RSS: Main: 266723328 22:00:14 INFO - PID 2021 | 22:00:17 INFO - PID 2021 | Cycle 1(1): loaded http://localhost:49308/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49308/tests/kraken/driver.html?testName=imaging-desaturate) 22:00:17 INFO - PID 2021 | RSS: Main: 268333056 22:00:17 INFO - PID 2021 | 22:00:20 INFO - PID 2021 | Cycle 1(1): loaded http://localhost:49308/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49308/tests/kraken/driver.html?testName=json-parse-financial) 22:00:21 INFO - PID 2021 | RSS: Main: 267739136 22:00:21 INFO - PID 2021 | 22:00:22 INFO - PID 2021 | Cycle 1(1): loaded http://localhost:49308/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49308/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:00:23 INFO - PID 2021 | RSS: Main: 267235328 22:00:23 INFO - PID 2021 | 22:00:25 INFO - PID 2021 | Cycle 1(1): loaded http://localhost:49308/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49308/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:00:25 INFO - PID 2021 | RSS: Main: 267288576 22:00:25 INFO - PID 2021 | 22:00:28 INFO - PID 2021 | Cycle 1(1): loaded http://localhost:49308/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49308/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:00:28 INFO - PID 2021 | RSS: Main: 266829824 22:00:28 INFO - PID 2021 | 22:00:31 INFO - PID 2021 | Cycle 1(1): loaded http://localhost:49308/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49308/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:00:32 INFO - PID 2021 | RSS: Main: 267161600 22:00:32 INFO - PID 2021 | 22:00:35 INFO - PID 2021 | Cycle 1(1): loaded http://localhost:49308/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49308/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:00:36 INFO - PID 2021 | RSS: Main: 267247616 22:00:36 INFO - PID 2021 | 22:00:37 INFO - PID 2021 | Cycle 1(1): loaded http://localhost:49308/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49308/tests/kraken/driver.html?testName=ai-astar) 22:00:38 INFO - PID 2021 | RSS: Main: 268828672 22:00:38 INFO - PID 2021 | 22:00:38 INFO - PID 2021 | __start_tp_report 22:00:38 INFO - PID 2021 | _x_x_mozilla_page_load 22:00:38 INFO - PID 2021 | _x_x_mozilla_page_load_details 22:00:38 INFO - PID 2021 | |i|pagename|runs| 22:00:38 INFO - PID 2021 | |0;ai-astar;106;113;98;143;168;169;128;114;114;113 22:00:38 INFO - PID 2021 | |1;audio-beat-detection;152;140;144;145;111;113;108;112;135;108 22:00:38 INFO - PID 2021 | |2;audio-dft;200;199;210;264;287;218;196;195;198;197 22:00:38 INFO - PID 2021 | |3;audio-fft;79;56;64;127;73;87;90;64;77;61 22:00:38 INFO - PID 2021 | |4;audio-oscillator;89;70;88;80;86;70;85;71;71;88 22:00:38 INFO - PID 2021 | |5;imaging-gaussian-blur;90;88;90;88;92;89;93;137;89;90 22:00:38 INFO - PID 2021 | |6;imaging-darkroom;97;101;96;104;96;96;96;97;96;98 22:00:38 INFO - PID 2021 | |7;imaging-desaturate;93;92;128;130;91;91;90;91;91;92 22:00:38 INFO - PID 2021 | |8;json-parse-financial;52;50;49;52;51;51;51;49;52;49 22:00:38 INFO - PID 2021 | |9;json-stringify-tinderbox;57;58;61;56;63;62;57;57;57;56 22:00:38 INFO - PID 2021 | |10;stanford-crypto-aes;83;88;73;107;110;106;107;90;82;85 22:00:38 INFO - PID 2021 | |11;stanford-crypto-ccm;156;148;135;141;157;128;156;155;189;136 22:00:38 INFO - PID 2021 | |12;stanford-crypto-pbkdf2;168;186;184;177;185;183;184;180;179;182 22:00:38 INFO - PID 2021 | |13;stanford-crypto-sha256-iterative;70;67;69;66;72;69;69;67;64;67 22:00:38 INFO - PID 2021 | __end_tp_report 22:00:38 INFO - PID 2021 | __start_cc_report 22:00:38 INFO - PID 2021 | _x_x_mozilla_cycle_collect,974 22:00:38 INFO - PID 2021 | __end_cc_report 22:00:38 INFO - PID 2021 | __startTimestamp1494219637999__endTimestamp 22:00:38 INFO - PID 2021 | 22:00:38 INFO - PID 2021 | ------- Summary: start ------- 22:00:38 INFO - PID 2021 | Number of tests: 14 22:00:38 INFO - PID 2021 | 22:00:38 INFO - PID 2021 | [#0] ai-astar Cycles:10 Average:126.60 Median:135.50 stddev:25.19 (18.6%) stddev-sans-first:25.60 22:00:38 INFO - PID 2021 | Values: 106.0 113.0 98.0 143.0 168.0 169.0 128.0 114.0 114.0 113.0 22:00:38 INFO - PID 2021 | 22:00:38 INFO - PID 2021 | [#1] audio-beat-detection Cycles:10 Average:126.80 Median:137.50 stddev:17.86 (13.0%) stddev-sans-first:16.45 22:00:38 INFO - PID 2021 | Values: 152.0 140.0 144.0 145.0 111.0 113.0 108.0 112.0 135.0 108.0 22:00:38 INFO - PID 2021 | 22:00:38 INFO - PID 2021 | [#2] audio-dft Cycles:10 Average:216.40 Median:205.00 stddev:32.41 (15.8%) stddev-sans-first:33.83 22:00:38 INFO - PID 2021 | Values: 200.0 199.0 210.0 264.0 287.0 218.0 196.0 195.0 198.0 197.0 22:00:38 INFO - PID 2021 | 22:00:38 INFO - PID 2021 | [#3] audio-fft Cycles:10 Average:77.80 Median:75.00 stddev:20.60 (27.5%) stddev-sans-first:21.84 22:00:38 INFO - PID 2021 | Values: 79.0 56.0 64.0 127.0 73.0 87.0 90.0 64.0 77.0 61.0 22:00:38 INFO - PID 2021 | 22:00:38 INFO - PID 2021 | [#4] audio-oscillator Cycles:10 Average:79.80 Median:85.50 stddev:8.38 (9.8%) stddev-sans-first:8.20 22:00:38 INFO - PID 2021 | Values: 89.0 70.0 88.0 80.0 86.0 70.0 85.0 71.0 71.0 88.0 22:00:38 INFO - PID 2021 | 22:00:38 INFO - PID 2021 | [#5] imaging-gaussian-blur Cycles:10 Average:94.60 Median:90.00 stddev:14.98 (16.6%) stddev-sans-first:15.80 22:00:38 INFO - PID 2021 | Values: 90.0 88.0 90.0 88.0 92.0 89.0 93.0 137.0 89.0 90.0 22:00:38 INFO - PID 2021 | 22:00:38 INFO - PID 2021 | [#6] imaging-darkroom Cycles:10 Average:97.70 Median:96.00 stddev:2.71 (2.8%) stddev-sans-first:2.86 22:00:38 INFO - PID 2021 | Values: 97.0 101.0 96.0 104.0 96.0 96.0 96.0 97.0 96.0 98.0 22:00:38 INFO - PID 2021 | 22:00:38 INFO - PID 2021 | [#7] imaging-desaturate Cycles:10 Average:98.90 Median:91.00 stddev:15.89 (17.5%) stddev-sans-first:16.71 22:00:38 INFO - PID 2021 | Values: 93.0 92.0 128.0 130.0 91.0 91.0 90.0 91.0 91.0 92.0 22:00:38 INFO - PID 2021 | 22:00:38 INFO - PID 2021 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:51.00 stddev:1.26 (2.5%) stddev-sans-first:1.24 22:00:38 INFO - PID 2021 | Values: 52.0 50.0 49.0 52.0 51.0 51.0 51.0 49.0 52.0 49.0 22:00:38 INFO - PID 2021 | 22:00:38 INFO - PID 2021 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:57.50 stddev:2.59 (4.5%) stddev-sans-first:2.70 22:00:38 INFO - PID 2021 | Values: 57.0 58.0 61.0 56.0 63.0 62.0 57.0 57.0 57.0 56.0 22:00:38 INFO - PID 2021 | 22:00:38 INFO - PID 2021 | [#10] stanford-crypto-aes Cycles:10 Average:93.10 Median:82.50 stddev:13.20 (16.0%) stddev-sans-first:13.49 22:00:38 INFO - PID 2021 | Values: 83.0 88.0 73.0 107.0 110.0 106.0 107.0 90.0 82.0 85.0 22:00:38 INFO - PID 2021 | 22:00:38 INFO - PID 2021 | [#11] stanford-crypto-ccm Cycles:10 Average:150.10 Median:155.50 stddev:17.18 (11.0%) stddev-sans-first:18.09 22:00:38 INFO - PID 2021 | Values: 156.0 148.0 135.0 141.0 157.0 128.0 156.0 155.0 189.0 136.0 22:00:38 INFO - PID 2021 | 22:00:38 INFO - PID 2021 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.80 Median:183.50 stddev:5.31 (2.9%) stddev-sans-first:2.99 22:00:38 INFO - PID 2021 | Values: 168.0 186.0 184.0 177.0 185.0 183.0 184.0 180.0 179.0 182.0 22:00:38 INFO - PID 2021 | 22:00:38 INFO - PID 2021 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:69.00 stddev:2.26 (3.3%) stddev-sans-first:2.28 22:00:38 INFO - PID 2021 | Values: 70.0 67.0 69.0 66.0 72.0 69.0 69.0 67.0 64.0 67.0 22:00:38 INFO - PID 2021 | -------- Summary: end -------- 22:00:38 INFO - PID 2021 | 22:00:38 INFO - TEST-INFO | 2021: exit 0 22:00:39 INFO - TEST-OK | kraken | took 60954ms 22:00:39 INFO - SUITE-END | took 1176s 22:00:39 INFO - Completed test suite (00:19:36) 22:00:39 INFO - javascript benchmark 22:00:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7996.66911026844, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3588.067102553335, 3588.587312459067, 3613.439916812895, 3628.32875917955, 3647.0335361129305, 6115.235595550556, 6174.289956654986, 6183.969080154593, 6196.16351792509, 6257.906131408033, 6154.861350650132, 6193.318734939153, 6206.1931948846695, 6211.192544969159, 6242.063690446435, 5217.582593392539, 5322.8137015204475, 5328.1474964005765, 5372.0, 5417.377001644822, 5358.812441564546, 5418.29562156921, 5430.647007944491, 5438.564914806806, 5478.123500239963, 4655.86032419028, 5353.973230133864, 5424.5660347172525, 5526.806561770359, 5532.695701736443, 4439.889002774924, 5336.546393556552, 5492.642978206404, 5492.670439773627, 5511.4213007634025, 5425.240466334716, 5438.510534051954, 5486.945130548684, 5488.807891723771, 5506.394296627368, 4582.15230182414, 6120.846978825521, 6142.2225331421305, 6153.969230153865, 6171.722272497704, 6682.83292917681, 6695.631740254284, 6701.061851340816, 6703.396694297488, 6713.0, 5551.472610102034, 6762.628055456948, 6806.897896531556, 6813.046173535709, 6817.761378351734, 6158.922188616974, 6163.414475624809, 6224.502039836892, 6297.583043815151, 6302.306746257908, 6858.5199036068, 6871.209810871814, 6904.171499420102, 6916.688749006306, 6933.341332573397, 6343.936560634427, 6356.141920840627, 6497.577657452251, 6506.642134682544, 6602.042703808017, 6674.566153200027, 6743.629100399525, 6764.255931847493, 6779.423748981392, 6780.627065511346, 6419.646919419383, 6524.119243902107, 6536.7712130075215, 6626.834329141713, 6667.466602671871, 6575.638339891256, 6650.102236198051, 6674.23246326669, 6689.464842812563, 6719.260881303053, 5342.065138600729, 5349.598780091431, 5356.116240820299, 5360.8659783504945, 5389.568834493231, 4049.6152865477734, 4644.744539050317, 4771.403574553181, 4778.211595086841, 4790.0659371422935, 5025.447200807908, 6094.451499365078, 6279.022108035954, 6311.621302721851, 6316.0, 6737.494687898427, 6760.526763126534, 6796.864062718718, 6799.830004249834, 6806.76176333826, 4807.254875494304, 5254.316938798008, 6332.176817013758, 6359.618422894641, 6366.140571022853, 5863.296404431496, 5935.703214839241, 5962.433568810956, 5965.13505541694, 5993.340732519419, 6987.5807451552055, 6990.545614535039, 6999.0551275577145, 7014.0531028310525, 7029.718811247493, 6694.631795251308, 6807.727690892507, 6814.522983391115, 6834.316568343126, 6847.726090956306, 6987.266337034742, 7006.229314775473, 7016.894746578703, 7020.719171233093, 7054.294570542905, 6463.903041454288, 6560.606363618198, 6563.573367731082, 6630.900536492053, 6682.3317668232785, 5928.79249226275, 6482.35176482348, 6739.932600674127, 6772.322767723385, 6820.658967051529, 5218.843434696965, 6368.713407896748, 6472.126262954441, 6573.934260657524, 6586.4401525870835, 5714.02861513552, 6555.0, 6582.80251592453, 6584.637844918576, 6585.539012269095, 6221.129041934223, 6265.310815810166, 6318.778842740482, 6321.589096708699, 6507.154069970874, 6490.870182596416, 6516.0, 6548.869022619616, 6588.670566471561, 6603.471722262304, 6374.872502549831, 6379.298277189413, 6408.070829729756, 6421.197350331208, 6431.196100487439], "value": 6064.590366554649, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.6661935509666, 799.7480793550031, 824.0523398092195, 1218.9451474683638, 1274.4965738533274, 31576.8948086817, 37488.25023499532, 38525.22949541011, 38759.22481550367, 38770.8061459693, 39086.0, 39326.80336598313, 39418.80290598543, 39453.40819887704, 39683.412663493495, 7915.327197188231, 8082.878756818653, 8348.791280218013, 8498.53258070809, 8572.271356934669, 8500.532470714108, 8539.444936079166, 8543.871841922377, 8608.354373421987, 8624.18070283322, 8543.530105844176, 8569.271611912964, 8619.094995025525, 8652.43759155656, 8658.610362533702, 8554.18735220153, 8597.699080532151, 8599.312055035582, 8604.956975215146, 8625.913740862605, 8280.627371768285, 8318.45930014547, 8342.37432192582, 8404.117567655368, 8416.326693864476, 37983.0, 38103.04742381435, 38157.03958485379, 38330.616693832984, 38404.42393364102, 3647.5075864758182, 3665.193657395369, 3677.9080522986874, 3684.8341824617955, 3687.520622319108, 31003.22491937697, 31261.687383126333, 31382.372352552822, 31427.84286078578, 31489.370212595848, 3150.0, 3177.4280629486684, 3180.538821870839, 3187.6334221564584, 3194.68053194681, 220249.0, 224491.0, 248345.0, 287240.0, 307574.0, 49378.0, 49922.50077499251, 49942.75143121379, 50012.49987500079, 50045.749771250914, 51237.48762512327, 51623.741881290356, 52189.47810521846, 52245.47754522482, 52480.47519524832, 14270.3578338975, 14362.497312594009, 14379.712405752036, 14396.496122635657, 14416.990810643154, 11787.764244715057, 11792.646220613395, 11794.469248883821, 11815.05479561633, 11846.170768046326, 11429.257098288585, 12156.392180390945, 12406.751864962831, 13850.09974351664, 13861.584152475441, 6171.722272497748, 6196.938030619726, 6197.752089916443, 6212.254529456403, 6254.278704171102, 809.5385630190734, 898.5282726568604, 960.6397600899662, 1043.6868939318174, 1044.7231483656838, 25016.124435644666, 25094.498110037697, 25120.371990700012, 25319.594638509312, 25350.492990140094, 1003.508280942333, 1005.9497025148713, 1124.8818874018111, 1125.189863298424, 1150.5800382860195, 11812.527498899948, 12855.678608034874, 12876.549320773915, 13012.089153759336, 13348.73302533944, 326285.0, 328686.0, 329436.0, 330198.0, 330742.0, 55985.72007139938, 56229.59426014382, 56290.0, 56359.43640563624, 56437.15344269839, 1291.3156027305542, 1523.3678023620296, 1538.6538028943398, 1565.7729629203702, 1568.051328945994, 24598.754012459645, 24898.502029958938, 25961.870190648926, 27387.767550460674, 29133.0, 49899.501004989484, 51172.74413627908, 51480.74259628678, 51595.45213643597, 51632.0, 258867.0, 259616.0, 259636.0, 260180.0, 260371.0, 33818.830905845316, 34378.65621343755, 35186.47220291646, 35612.821935890155, 35642.64357356393, 44691.10617787691, 45460.77269613631, 47044.29433558568, 47046.29430558476, 47057.88239529161, 26688.332791680365, 29846.850765746032, 31688.89088881878, 31761.682383176798, 32068.83965580157, 31039.224019399695, 31191.84404077965, 31260.687393125776, 31578.842105789325, 31745.8412707935, 38429.80785096057, 38499.80750096231, 38505.80747096246, 38536.80731596324, 38648.033799155244, 29337.85331073331, 29941.0, 31291.061268161993, 31597.368052639278, 31606.0, 20656.58686826285, 24301.635475468236, 24579.631305530074, 24776.150742664104, 25653.3586660335], "value": 17828.228021684623, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.6376261364772, 428.1693514581713, 432.58687953004863, 442.0297447103608, 461.10315436476066, 20392.388228353135, 21654.350369488922, 22269.554608907853, 22455.887720561375, 22543.54912901743, 22673.09307627697, 23301.650475242885, 23900.5219895602, 24099.0, 24103.75896241037, 5067.847964561069, 6014.909776353358, 6131.540134489931, 6228.19033525641, 6228.968855155718, 5857.85355366115, 6056.545759068065, 6107.236595425572, 6148.508119350441, 6153.630852121943, 5862.941370586283, 6044.3955604439425, 6054.152418661391, 6081.027035674293, 6110.08348747687, 6036.0945858121195, 6059.212302400704, 6080.391960803906, 6084.209052823149, 6091.086337049456, 5356.598255130842, 5366.91949620756, 5413.485718856702, 5443.292371991616, 5447.155690867922, 27644.58533122005, 27673.584896226574, 27836.721632783614, 27938.0, 28077.719222807715, 1997.510609900569, 2133.4986278224605, 2179.626835093881, 2253.887305634728, 2314.0859360552486, 14838.629034274121, 17912.552186195448, 18485.815141848678, 18649.347272845385, 18772.530686732804, 2143.485563464773, 2159.2941576154817, 2200.614892393841, 2204.8566843155304, 2206.1285792112026, 153591.0, 156115.0, 156801.0, 158072.0, 159842.0, 9850.852237216448, 10480.790384192274, 13182.0, 13198.898258909148, 13332.600021999355, 16750.58123546921, 17077.57306067358, 17143.57141071483, 17154.142292885554, 17162.914185428992, 7810.336121429742, 8565.48607083577, 8956.910430895738, 9039.367244292967, 9087.863682044775, 8523.573821309034, 8536.658533658709, 8571.82856342882, 8721.520316382534, 8730.650773969097, 6993.615351155735, 7865.646045927947, 8130.878036829452, 8150.551719655357, 8196.508209507449, 2069.4929742212953, 2075.9205213289006, 2243.618584840581, 2251.2665247759132, 2253.76335484775, 1007.5012868630075, 1008.3344992305043, 1009.3842755918884, 1041.942693151884, 1048.2295512798087, 20122.230406306542, 21323.25368612122, 21341.573168536852, 21354.252601158885, 21612.351629451143, 1023.9078482936571, 1029.8455231715302, 1056.6724315462232, 1060.522764755863, 1067.1622776120707, 9978.75265591801, 10065.345752526062, 10756.838647420294, 11149.832752508719, 11305.32168069902, 496971.0, 511185.0, 540036.0, 556249.0, 556614.0, 136339.31830340784, 137291.0, 137977.3101134508, 140902.0, 141498.29250853887, 1213.3690480949856, 1242.2546472116658, 1267.0940277701304, 1268.9746205075846, 1278.213898452445, 21677.02453389633, 22284.0, 22921.54156916819, 23118.653220201373, 23202.883985579963, 59308.51728706817, 59530.0, 59797.70101149466, 60219.39780602138, 60228.49428764316, 76707.0, 79415.20584794079, 79759.60120199362, 80046.1995380062, 80991.0, 8874.112588741333, 8956.417832840845, 8981.775455613662, 9050.592723327598, 9354.485503297385, 13034.608961731163, 14526.636834079232, 14571.708565828412, 14668.633284167981, 14908.62728431798, 12019.699507512381, 12153.331566763913, 12179.451924663234, 12236.08229382782, 12427.502899884264, 10406.947965260126, 11013.889861101286, 11316.094712423152, 11489.770204596029, 11934.761304774029, 10893.509792059534, 11892.345920974429, 12363.69090772702, 12418.689532761753, 12587.87412125867, 8807.383483156118, 9126.406783559047, 9129.5891684873, 9280.62877484893, 9353.942132730788, 9423.858642120511, 11937.52249909994, 12048.337341446304, 12128.151029428209, 12191.085668574715], "value": 10609.30190039007, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1382.7096309774947, 1430.3706369197546, 1444.5882923366837, 1451.3251338127768, 1456.5848733111063, 9103.499307538092, 10094.747631309221, 11765.0, 12022.098342624295, 12037.879621203785, 11766.588169414072, 11971.221870578407, 11971.580994665188, 12009.579664711715, 12271.877281227185, 2186.3222401055646, 2509.6486491891105, 2545.121932933135, 2560.9615855762086, 2574.8455092694403, 2479.5164942836063, 2533.7972962162985, 2541.2376287113884, 2543.046357615894, 2558.4115653399635, 2358.5282943411303, 2466.7163276223287, 2523.621456781479, 2537.8477291362483, 2560.2703229579574, 2484.167803785725, 2512.1458704040624, 2544.669193004907, 2548.2610043087484, 2551.068859866154, 2477.2196758021346, 2498.562751518477, 2541.8474891506567, 2546.6180072989014, 2565.3073670108965, 11896.0, 11977.0, 11983.46074426653, 11988.100892433102, 12006.0, 6640.535162538624, 6843.973403989441, 6907.551009184387, 6908.481863860231, 6914.9654251728925, 4093.9181216375805, 4355.390245365651, 4402.383666286691, 4441.422615060053, 4512.278035514335, 1203.3441774233063, 1256.6292943581666, 1256.8994480441543, 1304.5694920676153, 1306.229324698423, 12994.155379900276, 15523.0, 16445.177741113017, 16547.751783723255, 16615.584610384838, 5588.748506317225, 5728.455796699307, 5745.6552606843725, 5873.735681894325, 5925.762969481172, 11875.821862672066, 11876.465559049864, 11952.58165964187, 12021.639350819489, 12093.093018023683, 6590.044443555754, 6632.403083722488, 6635.668216589152, 6636.5354425190735, 6690.933090669128, 6047.606905551125, 6115.327313995457, 6227.1282020517165, 6277.462021804596, 6279.058141278845, 4321.65426765858, 4410.206162890647, 4447.710898791568, 4461.57615026572, 4471.910561788746, 1241.6523373455448, 1268.7335659511607, 1269.136986848933, 1282.1345591725549, 1284.9935750321376, 794.5312265763228, 798.6126728536655, 826.9421140520105, 834.2950207075012, 839.5298632765549, 6244.687765611792, 6285.59143655661, 6430.3891130342545, 6524.575902566318, 6570.178727659043, 512.4388794270268, 577.2466930655451, 588.3469349022581, 602.728772052578, 611.3977731934042, 3858.1704933439446, 4028.274910516135, 4371.519132895379, 4594.977025114853, 4629.722216667011, 14401.351939162763, 14780.556583302518, 15100.848991510164, 15197.6200594986, 15210.087394756129, 14290.214038227788, 14486.927565362106, 14952.850471495363, 15030.09819410817, 15033.323500442506, 7692.153863075057, 8763.868541971875, 8879.24526415262, 8888.11118888119, 8910.420822646507, 5709.22925405065, 6594.505412094016, 6863.627274545211, 7156.320149585781, 7461.552306861606, 11337.659870203906, 12184.939075304566, 13476.393562289917, 13720.794188086988, 13759.931200343934, 13697.32902084084, 13786.310684465938, 13937.442502299795, 14097.718045638825, 14199.503017394341, 9357.035022645321, 9391.248700104112, 9402.2948278878, 9470.668526601812, 9518.333716639769, 10850.837237441603, 10861.619843305447, 10950.671479855617, 10957.506912188812, 10964.342139471339, 8977.820443591223, 9258.074192580689, 9273.629054837731, 9279.953600231956, 9387.202087822612, 7324.340809327186, 8926.553672316488, 9015.639374425213, 9068.954655226682, 9250.751148594854, 6744.966275168593, 8254.0, 8366.33069354438, 8379.413441059067, 8392.328613710766, 5689.77240910359, 5805.535557155502, 6098.5426093042315, 6171.259448866164, 6306.810795676137, 5345.518903298722, 5928.407159284037, 6291.528135389955, 6308.022256550242, 6313.2424109107205], "value": 5339.576982087751, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.29400672460065, 407.91025974285657, 408.7976451656431, 409.1795949122011, 414.8008955701265, 6320.241571011474, 6386.936130638698, 6442.806715798533, 6463.838404039907, 6469.676516174184, 5441.2654291670615, 5676.0, 6164.260288765343, 6175.320714721377, 6346.841328966778, 4132.938005929914, 4785.617150627959, 4808.951910480885, 4812.7968007997915, 4813.868740845898, 4829.710217386968, 4836.927446088312, 4850.927236091461, 4851.320815085873, 4861.416630004387, 4099.6105369989955, 4588.7246765194195, 4675.04499070275, 4751.596114330268, 4775.259834725605, 4738.597219236369, 4775.952240477585, 4788.449328327252, 4788.856334309976, 4816.325714399987, 3697.4084146536425, 4231.978840105779, 4233.534311225762, 4255.425517555122, 4269.359596060584, 6079.179310793031, 6155.59988600744, 6179.721912513947, 6217.782377616807, 6241.063840423973, 5642.379338272828, 5647.774089036434, 5650.491455769001, 5679.858003549903, 5681.346645135821, 5505.852717440202, 6217.751289948396, 6530.314316996694, 6791.0, 6873.140857392826, 4179.97910010448, 4779.378680771512, 4816.927746083811, 4840.757962101916, 4846.151923413388, 5644.6330988485615, 6152.600080994676, 6854.554453960526, 7169.964150179268, 7178.712851485934, 4888.853334399973, 5058.5194406532055, 5140.177571588528, 5140.254663073833, 5169.922451163236, 5254.4220135785035, 5271.551918087006, 5277.445868183862, 5285.308701215651, 5292.92060619091, 4785.952140478551, 4943.3573635427165, 5840.678762668094, 5857.941420585825, 5880.206172166702, 5843.883122337529, 6011.639301641915, 6512.63234720714, 6905.654717264117, 6980.371766541036, 1579.8499142581436, 1772.6543324051686, 1777.3423833181805, 1790.4002159276529, 1815.0, 1099.961501347465, 1133.1501373969522, 1173.3077484284313, 1240.584404224577, 1253.360785999147, 5937.70311484424, 6319.778807741707, 6390.041493775971, 6505.60966342021, 6511.544191906521, 7044.6125463100025, 7072.222055573883, 7077.363037326665, 7085.362317391459, 7096.361327480551, 6260.749570017239, 6403.359664033559, 6431.485481161496, 6452.612843229421, 6492.935070649328, 3074.4619691554335, 3488.0582242794303, 3671.3662420223277, 3671.742977991515, 3675.1363429594026, 5746.856328591819, 7129.037579926644, 7261.7396473152785, 7306.378957788541, 7337.59643219628, 6747.325267473311, 7290.125184977836, 7297.416206703557, 7321.853562928712, 7338.633068346561, 6963.547369420971, 7347.0, 7370.77887663371, 7446.356543427114, 7461.664225109775, 6300.338464461165, 6527.249366322933, 7134.179569349383, 7146.106281835422, 7147.106611673541, 6384.521160913043, 6558.737650493927, 6733.326667333227, 6829.351211634887, 7042.401395881203, 5383.7308134593895, 6074.693940802748, 7306.97702321686, 7336.926630733838, 7346.853062938818, 4020.778857162767, 4527.524609915911, 4555.883808466947, 4576.222042252892, 4576.931346029745, 6160.845978850564, 6768.409423785308, 6852.246252912076, 7035.155781306276, 7135.322144396274, 5320.494553017457, 6512.5766825156215, 6772.932270677427, 6829.6243706596615, 6833.214180369122, 6738.966305168443, 6822.71439067898, 6830.624315662686, 6842.486813488908, 6860.897086543606, 5838.474537291664, 6328.608105813254, 6668.799936001928, 6683.565568238049, 6708.463322934056, 6535.849735417949, 6739.081579144584, 6807.591544507345, 6811.89782153278, 6848.623325717133, 5213.400458947118, 6651.767188148391, 6652.37016930855, 6654.234763002317, 6682.699278532575], "value": 5024.010265792139, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [830.1573902488979, 839.7858546070751, 840.3781201910587, 866.0949307973166, 867.3761870342214, 14670.559883203521, 15206.771898421504, 16664.000159990395, 17129.229184686686, 17129.914350428247, 17123.97256164631, 17782.82217177828, 17793.644127117448, 17866.0, 18211.27154913802, 977.9902200977988, 993.3741742702124, 995.920326373892, 1003.2425518733346, 1004.5228516454698, 931.9953400233023, 972.5915115651408, 1033.0392734756674, 1037.1702637889696, 1038.5586125896502, 1053.515382923856, 1054.836500342448, 1056.1392465140923, 1056.75166335911, 1058.3015209961427, 1053.1785207538132, 1054.46222426563, 1055.3509591601187, 1056.9524371403268, 1068.033429746081, 767.1944458318743, 779.1351599724302, 781.9843603127906, 784.4234487651571, 790.5967956342249, 17393.913030434767, 17394.21726022332, 17569.472915812545, 17751.644967100714, 17801.910990444965, 17286.3949761759, 17401.738973915402, 17458.127093645267, 17601.823981760273, 17734.91132544342, 11472.655820325404, 13827.308634568331, 14061.507847225297, 14299.428022879072, 14426.134431934117, 3524.312759011994, 3524.524189234446, 3554.253606742587, 3554.4845997330244, 3557.2351944332095, 113435.99999999917, 137634.31182844023, 138093.0, 138901.61098388987, 139345.6392616436, 13546.322683865767, 13647.454101836014, 13692.0, 13733.0, 13766.65583360424, 24615.753842461705, 25164.496710065698, 25174.496510069697, 25245.242642720747, 25492.107776227742, 7595.430342724318, 7886.211378862068, 7939.64271607779, 7944.24529669692, 7996.200379962073, 3886.281038007921, 3912.5304963404005, 3932.8623498177426, 3948.309045916953, 3984.063745019918, 4109.424680544666, 4231.894202644959, 4257.74453532789, 4314.1371725655, 4372.928632485062, 702.8137543550963, 829.98340033199, 865.6277800545826, 869.2698133567833, 869.7651634058768, 570.6461993563934, 634.8793729191439, 666.3736088077192, 675.3617831149614, 696.8083776961275, 11026.503807328689, 11858.350867441994, 12069.396530173457, 12129.454174562166, 12147.331896745587, 649.1301655781182, 652.1326635574675, 660.3429587560408, 665.2648823050556, 685.5680921019725, 5445.646033007842, 5586.245856809279, 5599.216109744639, 5681.261436013292, 5684.971575142098, 71830.64084679543, 109749.0, 111018.88981110086, 112307.87692123138, 114320.14079155277, 97876.0, 98276.52585211227, 98936.5053174744, 99189.50405248071, 100425.49787251017, 72627.63686181641, 81851.18148818555, 81890.59054704689, 84462.73305900417, 85204.57397713096, 10329.896701032894, 12537.373131343578, 12942.964562835139, 13106.082574220094, 13120.540781072617, 40990.0, 41405.37891931563, 41419.37870931878, 42172.789136054125, 42536.78731606322, 51906.96186076333, 68984.65507672429, 69640.6517967407, 71492.0, 74974.0, 16594.0, 16760.497185084467, 16840.410585629445, 17102.230399632295, 17221.39725109615, 15824.525264242091, 17763.20065597077, 18312.53499720046, 18562.350317738816, 18720.812791871907, 16529.421470248482, 17437.82562174362, 17819.554511137325, 17928.282868685626, 18061.367852125113, 16523.917380413503, 16954.237059332605, 17603.383881564085, 17714.64570708553, 17731.468055958343, 13671.111377760413, 14115.294235287989, 14130.434782608581, 14152.575422737335, 17184.656306874043, 11434.599789007345, 11536.59621913229, 11541.422928853355, 11692.94153529227, 12010.279383237033, 13200.189729635424, 13762.70173341279, 14032.947528935167, 14043.50847720325, 14044.648883777987], "value": 8497.105161749716, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 98.0, 143.0, 168.0, 169.0, 128.0, 114.0, 114.0, 113.0], "value": 126.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 140.0, 144.0, 145.0, 111.0, 113.0, 108.0, 112.0, 135.0, 108.0], "value": 126.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 199.0, 210.0, 264.0, 287.0, 218.0, 196.0, 195.0, 198.0, 197.0], "value": 216.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 56.0, 64.0, 127.0, 73.0, 87.0, 90.0, 64.0, 77.0, 61.0], "value": 77.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 88.0, 80.0, 86.0, 70.0, 85.0, 71.0, 71.0, 88.0], "value": 79.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 90.0, 88.0, 92.0, 89.0, 93.0, 137.0, 89.0, 90.0], "value": 94.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 101.0, 96.0, 104.0, 96.0, 96.0, 96.0, 97.0, 96.0, 98.0], "value": 97.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 128.0, 130.0, 91.0, 91.0, 90.0, 91.0, 91.0, 92.0], "value": 98.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 49.0, 52.0, 51.0, 51.0, 51.0, 49.0, 52.0, 49.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 61.0, 56.0, 63.0, 62.0, 57.0, 57.0, 57.0, 56.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 88.0, 73.0, 107.0, 110.0, 106.0, 107.0, 90.0, 82.0, 85.0], "value": 93.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 148.0, 135.0, 141.0, 157.0, 128.0, 156.0, 155.0, 189.0, 136.0], "value": 150.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 186.0, 184.0, 177.0, 185.0, 183.0, 184.0, 180.0, 179.0, 182.0], "value": 180.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 69.0, 66.0, 72.0, 69.0, 69.0, 67.0, 64.0, 67.0], "value": 68.0, "unit": "score"}]}]} 22:00:39 INFO - Return code: 0 22:00:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:00:39 INFO - # TBPL SUCCESS # 22:00:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:00:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:00:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:00:39 INFO - 2017-05-07 22:00:39.346 screenresolution[2028:23168] starting screenresolution argv=screenresolution get 22:00:39 INFO - 2017-05-07 22:00:39.349 screenresolution[2028:23168] Display 0: 1600x1200x32@60 22:00:39 INFO - 2017-05-07 22:00:39.355 screenresolution[2029:23171] starting screenresolution argv=screenresolution list 22:00:39 INFO - Available Modes on Display 0 22:00:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:00:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:00:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:00:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:00:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:00:39 INFO - Intel Iris: 22:00:39 INFO - Chipset Model: Intel Iris 22:00:39 INFO - Type: GPU 22:00:39 INFO - Bus: Built-In 22:00:39 INFO - VRAM (Dynamic, Max): 1536 MB 22:00:39 INFO - Vendor: Intel (0x8086) 22:00:39 INFO - Device ID: 0x0a2e 22:00:39 INFO - Revision ID: 0x0009 22:00:39 INFO - Displays: 22:00:39 INFO - Display: 22:00:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:00:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:00:39 INFO - Display Serial Number: 1600x1200 60 22:00:39 INFO - Main Display: Yes 22:00:39 INFO - Mirror: Off 22:00:39 INFO - Online: Yes 22:00:39 INFO - Rotation: Supported 22:00:39 INFO - Return code: 0 22:00:39 INFO - Running post-action listener: _resource_record_post_action 22:00:39 INFO - [mozharness: 2017-05-08 05:00:39.601537Z] Finished run-tests step (success) 22:00:39 INFO - Running post-run listener: _resource_record_post_run 22:00:39 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 33747968; Write bytes: 530045440; Read time: 317; Write time: 1772 22:00:39 INFO - TinderboxPrint: CPU usage
54.1% 22:00:39 INFO - TinderboxPrint: I/O read bytes / time
33,747,968 / 317 22:00:39 INFO - TinderboxPrint: I/O write bytes / time
530,045,440 / 1,772 22:00:39 INFO - TinderboxPrint: CPU idle
2,195.9 (45.9%) 22:00:39 INFO - TinderboxPrint: CPU system
962.8 (20.1%) 22:00:39 INFO - TinderboxPrint: CPU user
1,627.0 (34.0%) 22:00:39 INFO - TinderboxPrint: Swap in / out
235,839,488 / 0 22:00:39 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 195543552; Write bytes: 195786752; Read time: 15156; Write time: 493 22:00:39 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 32785408; Write bytes: 317411840; Read time: 300; Write time: 1231 22:00:40 INFO - Running post-run listener: _upload_blobber_files 22:00:40 INFO - Blob upload gear active. 22:00:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:00:40 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 22:00:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:00:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:00:40 INFO - (blobuploader) - INFO - Open directory for files ... 22:00:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:00:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:00:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:00:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:00:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:00:41 INFO - (blobuploader) - INFO - Done attempting. 22:00:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:00:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:00:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:00:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:00:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:00:42 INFO - (blobuploader) - INFO - Done attempting. 22:00:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:00:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:00:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:00:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:00:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:00:43 INFO - (blobuploader) - INFO - Done attempting. 22:00:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:00:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:00:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:00:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:00:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:00:45 INFO - (blobuploader) - INFO - Done attempting. 22:00:45 INFO - (blobuploader) - INFO - Iteration through files over. 22:00:45 INFO - Return code: 0 22:00:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:00:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:00:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89887cc587a4d201144ce5bfa2917ba86b84723c9e0853dbfbb410788b4e5db02353c09adeb98fa7d13ec5e2593d4bd86b7af75a48968e15d6a00233c2f2efd7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4a7abe2c3254dda5d7737a7a7b66cf381ae1d486b619a3c36e3fae84db0ffa5477d8fbade3c5ece1da8009dd5d60b2c1001660def3f797d3430443efcbbd4fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2116bc4e08124f4da24a7b5ad3223f120c20a1179de7b98e5bdf2217b42b35aa8c560f325c44576f6173ee6c5ae6ad3396e7663763e13322f0acd37477ed8ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcf93cc862a6f7db8a77c65c40ce36ec91dbb29c8176062a4031d7b7acc356434aa8c54a84b404b3311f23133e984b82c18af589152d675be3043a8dd62a0e39"} 22:00:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:00:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:00:45 INFO - Contents: 22:00:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89887cc587a4d201144ce5bfa2917ba86b84723c9e0853dbfbb410788b4e5db02353c09adeb98fa7d13ec5e2593d4bd86b7af75a48968e15d6a00233c2f2efd7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4a7abe2c3254dda5d7737a7a7b66cf381ae1d486b619a3c36e3fae84db0ffa5477d8fbade3c5ece1da8009dd5d60b2c1001660def3f797d3430443efcbbd4fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2116bc4e08124f4da24a7b5ad3223f120c20a1179de7b98e5bdf2217b42b35aa8c560f325c44576f6173ee6c5ae6ad3396e7663763e13322f0acd37477ed8ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcf93cc862a6f7db8a77c65c40ce36ec91dbb29c8176062a4031d7b7acc356434aa8c54a84b404b3311f23133e984b82c18af589152d675be3043a8dd62a0e39"} 22:00:45 INFO - Running post-run listener: copy_logs_to_upload_dir 22:00:45 INFO - Copying logs to upload dir... 22:00:45 INFO - mkdir: /builds/slave/test/build/upload/logs 22:00:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.777692 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-05-07 22:00:45.740449) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-07 22:00:45.744527) ========= 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.kwtYeVPrzE/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.Gl2B1OPJbc/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89887cc587a4d201144ce5bfa2917ba86b84723c9e0853dbfbb410788b4e5db02353c09adeb98fa7d13ec5e2593d4bd86b7af75a48968e15d6a00233c2f2efd7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4a7abe2c3254dda5d7737a7a7b66cf381ae1d486b619a3c36e3fae84db0ffa5477d8fbade3c5ece1da8009dd5d60b2c1001660def3f797d3430443efcbbd4fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2116bc4e08124f4da24a7b5ad3223f120c20a1179de7b98e5bdf2217b42b35aa8c560f325c44576f6173ee6c5ae6ad3396e7663763e13322f0acd37477ed8ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcf93cc862a6f7db8a77c65c40ce36ec91dbb29c8176062a4031d7b7acc356434aa8c54a84b404b3311f23133e984b82c18af589152d675be3043a8dd62a0e39"} build_url:https://queue.taskcluster.net/v1/task/RAwyJyWET9WwR3gWBlluCA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011208 build_url: 'https://queue.taskcluster.net/v1/task/RAwyJyWET9WwR3gWBlluCA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89887cc587a4d201144ce5bfa2917ba86b84723c9e0853dbfbb410788b4e5db02353c09adeb98fa7d13ec5e2593d4bd86b7af75a48968e15d6a00233c2f2efd7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4a7abe2c3254dda5d7737a7a7b66cf381ae1d486b619a3c36e3fae84db0ffa5477d8fbade3c5ece1da8009dd5d60b2c1001660def3f797d3430443efcbbd4fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2116bc4e08124f4da24a7b5ad3223f120c20a1179de7b98e5bdf2217b42b35aa8c560f325c44576f6173ee6c5ae6ad3396e7663763e13322f0acd37477ed8ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcf93cc862a6f7db8a77c65c40ce36ec91dbb29c8176062a4031d7b7acc356434aa8c54a84b404b3311f23133e984b82c18af589152d675be3043a8dd62a0e39"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-07 22:00:45.780060) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 22:00:45.780380) ========= 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.kwtYeVPrzE/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.Gl2B1OPJbc/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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.005045 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 22:00:45.828631) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-07 22:00:45.828955) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-07 22:00:45.829269) ========= ========= Total master_lag: 0.19 =========