builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0231 starttime: 1486174231.17 results: success (0) buildid: 20170203170012 builduid: b41a63a5d0f943aea3aafe3cb0682850 revision: 94079d43835ff229dce0f9b226cedd64c6aaef60 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 18:10:31.174117) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 18:10:31.174600) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-03 18:10:31.175078) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-03 18:10:31.201069) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-03 18:10:31.201419) ========= 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.V66Ut7Rims/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.xyfgG0pUga/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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-02-03 18:10:31-- 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% 18.5M=0.001s 2017-02-03 18:10:31 (18.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.579385 ========= master_lag: 0.70 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-03 18:10:32.480340) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 18:10:32.480978) ========= 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.V66Ut7Rims/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.xyfgG0pUga/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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.024659 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 18:10:32.531958) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-03 18:10:32.532320) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 94079d43835ff229dce0f9b226cedd64c6aaef60 --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 94079d43835ff229dce0f9b226cedd64c6aaef60 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.V66Ut7Rims/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.xyfgG0pUga/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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-02-03 18:10:32,640 truncating revision to first 12 chars 2017-02-03 18:10:32,640 Setting DEBUG logging. 2017-02-03 18:10:32,640 attempt 1/10 2017-02-03 18:10:32,640 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/94079d43835f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-03 18:10:33,699 unpacking tar archive at: mozilla-central-94079d43835f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.320828 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-03 18:10:33.878162) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 18:10:33.878520) ========= script_repo_revision: 94079d43835ff229dce0f9b226cedd64c6aaef60 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 18:10:33.879170) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 18:10:33.879816) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 18:10:33.899597) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-02-03 18:10:33.899880) ========= /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.V66Ut7Rims/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.xyfgG0pUga/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 18:10:34 INFO - MultiFileLogger online at 20170203 18:10:34 in /builds/slave/test 18:10:34 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 18:10:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:10:34 INFO - {'append_to_log': False, 18:10:34 INFO - 'base_work_dir': '/builds/slave/test', 18:10:34 INFO - 'blob_upload_branch': 'Firefox', 18:10:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:10:34 INFO - 'branch': 'Firefox', 18:10:34 INFO - 'buildbot_json_path': 'buildprops.json', 18:10:34 INFO - 'config_files': ('talos/mac_config.py',), 18:10:34 INFO - 'default_actions': ('clobber', 18:10:34 INFO - 'read-buildbot-config', 18:10:34 INFO - 'download-and-extract', 18:10:34 INFO - 'populate-webroot', 18:10:34 INFO - 'create-virtualenv', 18:10:34 INFO - 'install', 18:10:34 INFO - 'run-tests'), 18:10:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:10:34 INFO - 'download_minidump_stackwalk': True, 18:10:34 INFO - 'download_symbols': 'ondemand', 18:10:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:10:34 INFO - 'tooltool.py': '/tools/tooltool.py', 18:10:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:10:34 INFO - '/tools/misc-python/virtualenv.py')}, 18:10:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:10:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:10:34 INFO - 'installer_path': 'installer.exe', 18:10:34 INFO - 'log_level': 'info', 18:10:34 INFO - 'log_name': 'talos', 18:10:34 INFO - 'log_to_console': True, 18:10:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:10:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:10:34 INFO - 'opt_config_files': (), 18:10:34 INFO - 'pip_index': False, 18:10:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:10:34 INFO - 'cmd': ('bash', 18:10:34 INFO - '-c', 18:10:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:10:34 INFO - 'enabled': True, 18:10:34 INFO - 'halt_on_failure': False, 18:10:34 INFO - 'name': 'check_screen_resolution'},), 18:10:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:10:34 INFO - 'cmd': ('bash', 18:10:34 INFO - '-c', 18:10:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:10:34 INFO - 'enabled': True, 18:10:34 INFO - 'halt_on_failure': False, 18:10:34 INFO - 'name': 'check_screen_resolution'},), 18:10:34 INFO - 'run_cmd_checks_enabled': True, 18:10:34 INFO - 'sps_profile': False, 18:10:34 INFO - 'sps_profile_interval': 0, 18:10:34 INFO - 'suite': 'dromaeojs-e10s', 18:10:34 INFO - 'system_bits': '32', 18:10:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:10:34 INFO - 'title': 't-yosemite-r7-0231', 18:10:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:10:34 INFO - 'use_talos_json': True, 18:10:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:10:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:10:34 INFO - 'work_dir': 'build'} 18:10:34 INFO - [mozharness: 2017-02-04 02:10:34.115568Z] Running clobber step. 18:10:34 INFO - Running pre-action listener: _resource_record_pre_action 18:10:34 INFO - Running main action method: clobber 18:10:34 INFO - rmtree: /builds/slave/test/build 18:10:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:10:36 INFO - Running post-action listener: _resource_record_post_action 18:10:36 INFO - [mozharness: 2017-02-04 02:10:36.639039Z] Finished clobber step (success) 18:10:36 INFO - [mozharness: 2017-02-04 02:10:36.639225Z] Running read-buildbot-config step. 18:10:36 INFO - Running pre-action listener: _resource_record_pre_action 18:10:36 INFO - Running main action method: read_buildbot_config 18:10:36 INFO - Using buildbot properties: 18:10:36 INFO - { 18:10:36 INFO - "project": "", 18:10:36 INFO - "product": "firefox", 18:10:36 INFO - "script_repo_revision": "production", 18:10:36 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 18:10:36 INFO - "repository": "", 18:10:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 18:10:36 INFO - "buildid": "20170203170012", 18:10:36 INFO - "pgo_build": "False", 18:10:36 INFO - "basedir": "/builds/slave/test", 18:10:36 INFO - "buildnumber": 81, 18:10:36 INFO - "slavename": "t-yosemite-r7-0231", 18:10:36 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 18:10:36 INFO - "platform": "yosemite_r7", 18:10:36 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:10:36 INFO - "branch": "mozilla-central", 18:10:36 INFO - "repo_path": "mozilla-central", 18:10:36 INFO - "revision": "94079d43835ff229dce0f9b226cedd64c6aaef60", 18:10:36 INFO - "stage_platform": "macosx64", 18:10:36 INFO - "builduid": "b41a63a5d0f943aea3aafe3cb0682850", 18:10:36 INFO - "slavebuilddir": "test" 18:10:36 INFO - } 18:10:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/WHNEwAUFT46LLvJ_81_tJA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 18:10:36 INFO - Running post-action listener: _resource_record_post_action 18:10:36 INFO - [mozharness: 2017-02-04 02:10:36.642562Z] Finished read-buildbot-config step (success) 18:10:36 INFO - [mozharness: 2017-02-04 02:10:36.642693Z] Running download-and-extract step. 18:10:36 INFO - Running pre-action listener: _resource_record_pre_action 18:10:36 INFO - Running main action method: download_and_extract 18:10:36 INFO - mkdir: /builds/slave/test/build/tests 18:10: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')]} 18:10:36 INFO - trying https://queue.taskcluster.net/v1/task/WHNEwAUFT46LLvJ_81_tJA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 18:10:36 INFO - Downloading https://queue.taskcluster.net/v1/task/WHNEwAUFT46LLvJ_81_tJA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 18:10:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WHNEwAUFT46LLvJ_81_tJA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 18:10:37 INFO - Downloaded 1199 bytes. 18:10:37 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 18:10:37 INFO - Using the following test package requirements: 18:10:37 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 18:10:37 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:10:37 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 18:10:37 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:10:37 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 18:10:37 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:10:37 INFO - u'jsshell-mac.zip'], 18:10:37 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:10:37 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 18:10:37 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 18:10:37 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:10:37 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 18:10:37 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:10:37 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 18:10:37 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:10:37 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 18:10:37 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:10:37 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 18:10:37 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:10:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WHNEwAUFT46LLvJ_81_tJA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 18:10:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WHNEwAUFT46LLvJ_81_tJA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:10:37 INFO - Fetch https://queue.taskcluster.net/v1/task/WHNEwAUFT46LLvJ_81_tJA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 18:10:38 INFO - Expected file size: 34849825 18:10:38 INFO - Obtained file size: 34849825 18:10:45 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:10:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WHNEwAUFT46LLvJ_81_tJA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 18:10:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WHNEwAUFT46LLvJ_81_tJA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:10:45 INFO - Fetch https://queue.taskcluster.net/v1/task/WHNEwAUFT46LLvJ_81_tJA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 18:10:46 INFO - Expected file size: 34849825 18:10:46 INFO - Obtained file size: 34849825 18:10:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WHNEwAUFT46LLvJ_81_tJA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 18:10:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WHNEwAUFT46LLvJ_81_tJA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:10:53 INFO - Fetch https://queue.taskcluster.net/v1/task/WHNEwAUFT46LLvJ_81_tJA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 18:10:55 INFO - Expected file size: 14403454 18:10:55 INFO - Obtained file size: 14403454 18:10:55 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')]} 18:10:55 INFO - trying https://queue.taskcluster.net/v1/task/WHNEwAUFT46LLvJ_81_tJA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 18:10:55 INFO - Downloading https://queue.taskcluster.net/v1/task/WHNEwAUFT46LLvJ_81_tJA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 18:10:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WHNEwAUFT46LLvJ_81_tJA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 18:10:57 INFO - Downloaded 70288639 bytes. 18:10:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WHNEwAUFT46LLvJ_81_tJA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 18:10:57 INFO - mkdir: /builds/slave/test/properties 18:10:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:10:57 INFO - Writing to file /builds/slave/test/properties/build_url 18:10:57 INFO - Contents: 18:10:57 INFO - build_url:https://queue.taskcluster.net/v1/task/WHNEwAUFT46LLvJ_81_tJA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 18:10:58 INFO - Running post-action listener: _resource_record_post_action 18:10:58 INFO - Running post-action listener: set_extra_try_arguments 18:10:58 INFO - [mozharness: 2017-02-04 02:10:58.549368Z] Finished download-and-extract step (success) 18:10:58 INFO - [mozharness: 2017-02-04 02:10:58.549505Z] Running populate-webroot step. 18:10:58 INFO - Running pre-action listener: _resource_record_pre_action 18:10:58 INFO - Running main action method: populate_webroot 18:10:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:10:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:10:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:10:58 INFO - '--tppagecycles', 18:10:58 INFO - '7'], 18:10:58 INFO - 'tests': ['tsvgm']}}, 18:10:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:10:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:10:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:10:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:10:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:10:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:10:58 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:10:58 INFO - 'talos_options': ['--disable-e10s'], 18:10:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:10:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:10:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:10:58 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:10:58 INFO - 'talos_options': ['--disable-e10s'], 18:10:58 INFO - 'tests': ['damp', 'tps']}, 18:10:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:10:58 INFO - 'tests': ['damp', 'tps']}, 18:10:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:10:58 INFO - 'tests': ['dromaeo_dom']}, 18:10:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:10:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:10:58 INFO - 'tests': ['basic_compositor_video']}, 18:10:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:10:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:10:58 INFO - 'tests': ['a11yr', 18:10:58 INFO - 'ts_paint', 18:10:58 INFO - 'tpaint', 18:10:58 INFO - 'sessionrestore', 18:10:58 INFO - 'sessionrestore_no_auto_restore', 18:10:58 INFO - 'tabpaint']}, 18:10:58 INFO - 'other-e10s': {'tests': ['a11yr', 18:10:58 INFO - 'ts_paint', 18:10:58 INFO - 'tpaint', 18:10:58 INFO - 'sessionrestore', 18:10:58 INFO - 'sessionrestore_no_auto_restore', 18:10:58 INFO - 'tabpaint']}, 18:10:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:10:58 INFO - 'ts_paint', 18:10:58 INFO - 'tpaint', 18:10:58 INFO - 'sessionrestore', 18:10:58 INFO - 'sessionrestore_no_auto_restore', 18:10:58 INFO - 'tabpaint']}, 18:10:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:10:58 INFO - 'ts_paint', 18:10:58 INFO - 'tpaint', 18:10:58 INFO - 'sessionrestore', 18:10:58 INFO - 'sessionrestore_no_auto_restore', 18:10:58 INFO - 'tabpaint']}, 18:10:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:10:58 INFO - 'tests': ['a11yr', 18:10:58 INFO - 'ts_paint', 18:10:58 INFO - 'tpaint', 18:10:58 INFO - 'sessionrestore', 18:10:58 INFO - 'sessionrestore_no_auto_restore', 18:10:58 INFO - 'tabpaint']}, 18:10:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:10:58 INFO - 'tests': ['a11yr', 18:10:58 INFO - 'ts_paint', 18:10:58 INFO - 'tpaint', 18:10:58 INFO - 'sessionrestore', 18:10:58 INFO - 'sessionrestore_no_auto_restore', 18:10:58 INFO - 'tabpaint']}, 18:10:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:10:58 INFO - 'tests': ['tsvgx', 18:10:58 INFO - 'tsvgr_opacity', 18:10:58 INFO - 'tart', 18:10:58 INFO - 'tscrollx', 18:10:58 INFO - 'cart', 18:10:58 INFO - 'tsvg_static']}, 18:10:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:10:58 INFO - 'tsvgr_opacity', 18:10:58 INFO - 'tart', 18:10:58 INFO - 'tscrollx', 18:10:58 INFO - 'cart', 18:10:58 INFO - 'tsvg_static']}, 18:10:58 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:10:58 INFO - 'talos_options': ['--disable-e10s'], 18:10:58 INFO - 'tests': ['tp5o']}, 18:10:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:10:58 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:10:58 INFO - 'talos_options': ['--disable-e10s', 18:10:58 INFO - '--xperf_path', 18:10:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:10:58 INFO - 'tests': ['tp5n']}, 18:10:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:10:58 INFO - 'talos_options': ['--xperf_path', 18:10:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:10:58 INFO - 'tests': ['tp5n']}}, 18:10:58 INFO - 'talos.zip': {'path': '', 18:10:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:10:58 INFO - Running post-action listener: _resource_record_post_action 18:10:58 INFO - [mozharness: 2017-02-04 02:10:58.568252Z] Finished populate-webroot step (success) 18:10:58 INFO - [mozharness: 2017-02-04 02:10:58.568378Z] Running create-virtualenv step. 18:10:58 INFO - Running pre-action listener: _resource_record_pre_action 18:10:58 INFO - Running main action method: create_virtualenv 18:10:58 INFO - Creating virtualenv /builds/slave/test/build/venv 18:10:58 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 18:10:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:10:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:10:58 INFO - Using real prefix '/tools/python27' 18:10:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:10:59 INFO - Installing distribute.............................................................................................................................................................................................done. 18:11:02 INFO - Installing pip.................done. 18:11:02 INFO - Return code: 0 18:11:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:11:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:11:02 INFO - Reading from file tmpfile_stdout 18:11:02 INFO - Output received: 18:11:02 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) 18:11:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:11: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')]} 18:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11: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')]} 18:11:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fd04b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd07768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f842acd2960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fae2d30>, '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 0x10fa09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fad7be8>, '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.V66Ut7Rims/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.xyfgG0pUga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 18:11:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:11:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:11:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V66Ut7Rims/Render', 18:11:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:11:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:11:02 INFO - 'HOME': '/Users/cltbld', 18:11:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:11:02 INFO - 'LOGNAME': 'cltbld', 18:11:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:02 INFO - 'MOZ_NO_REMOTE': '1', 18:11:02 INFO - 'NO_EM_RESTART': '1', 18:11:02 INFO - 'PAGER': '/bin/cat', 18:11:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:11:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:02 INFO - 'PWD': '/builds/slave/test', 18:11:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:11:02 INFO - 'SHELL': '/bin/bash', 18:11:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyfgG0pUga/Listeners', 18:11:02 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 18:11:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:11:02 INFO - 'USER': 'cltbld', 18:11:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:11:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:11:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:02 INFO - 'XPC_FLAGS': '0x0', 18:11:02 INFO - 'XPC_SERVICE_NAME': '0', 18:11:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:02 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 18:11:02 INFO - Cleaning up... 18:11:02 INFO - Return code: 0 18:11:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:11: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')]} 18:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11: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')]} 18:11:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fd04b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd07768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f842acd2960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fae2d30>, '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 0x10fa09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fad7be8>, '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.V66Ut7Rims/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.xyfgG0pUga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 18:11:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:11:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:11:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V66Ut7Rims/Render', 18:11:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:11:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:11:02 INFO - 'HOME': '/Users/cltbld', 18:11:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:11:02 INFO - 'LOGNAME': 'cltbld', 18:11:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:02 INFO - 'MOZ_NO_REMOTE': '1', 18:11:02 INFO - 'NO_EM_RESTART': '1', 18:11:02 INFO - 'PAGER': '/bin/cat', 18:11:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:11:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:02 INFO - 'PWD': '/builds/slave/test', 18:11:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:11:02 INFO - 'SHELL': '/bin/bash', 18:11:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyfgG0pUga/Listeners', 18:11:02 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 18:11:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:11:02 INFO - 'USER': 'cltbld', 18:11:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:11:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:11:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:02 INFO - 'XPC_FLAGS': '0x0', 18:11:02 INFO - 'XPC_SERVICE_NAME': '0', 18:11:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:11:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:03 INFO - Downloading/unpacking psutil>=3.1.1 18:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:11:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:11:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:11:06 INFO - Installing collected packages: psutil 18:11:06 INFO - Running setup.py install for psutil 18:11:07 INFO - building 'psutil._psutil_osx' extension 18:11:07 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 18:11:07 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 18:11:07 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 18:11:07 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 18:11:07 INFO - building 'psutil._psutil_posix' extension 18:11:07 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 18:11:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:11:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:11:07 INFO - ^ 18:11:07 INFO - 1 warning generated. 18:11:07 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 18:11:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:11:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:11:08 INFO - Successfully installed psutil 18:11:08 INFO - Cleaning up... 18:11:08 INFO - Return code: 0 18:11:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:08 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 0x10fd04b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd07768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f842acd2960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fae2d30>, '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 0x10fa09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fad7be8>, '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.V66Ut7Rims/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.xyfgG0pUga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 18:11:08 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 18:11:08 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 18:11:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V66Ut7Rims/Render', 18:11:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:11:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:11:08 INFO - 'HOME': '/Users/cltbld', 18:11:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:11:08 INFO - 'LOGNAME': 'cltbld', 18:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:08 INFO - 'MOZ_NO_REMOTE': '1', 18:11:08 INFO - 'NO_EM_RESTART': '1', 18:11:08 INFO - 'PAGER': '/bin/cat', 18:11:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:08 INFO - 'PWD': '/builds/slave/test', 18:11:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:11:08 INFO - 'SHELL': '/bin/bash', 18:11:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyfgG0pUga/Listeners', 18:11:08 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 18:11:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:11:08 INFO - 'USER': 'cltbld', 18:11:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:11:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:08 INFO - 'XPC_FLAGS': '0x0', 18:11:08 INFO - 'XPC_SERVICE_NAME': '0', 18:11:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:11:08 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 18:11:08 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 18:11:08 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 18:11:08 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 18:11:08 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 18:11:08 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 18:11:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:11:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:11:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:11:11 INFO - Installing collected packages: mozsystemmonitor 18:11:11 INFO - Running setup.py install for mozsystemmonitor 18:11:11 INFO - Successfully installed mozsystemmonitor 18:11:11 INFO - Cleaning up... 18:11:11 INFO - Return code: 0 18:11:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:11:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fd04b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd07768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f842acd2960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fae2d30>, '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 0x10fa09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fad7be8>, '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.V66Ut7Rims/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.xyfgG0pUga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 18:11:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:11:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V66Ut7Rims/Render', 18:11:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:11:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:11:11 INFO - 'HOME': '/Users/cltbld', 18:11:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:11:11 INFO - 'LOGNAME': 'cltbld', 18:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:11 INFO - 'MOZ_NO_REMOTE': '1', 18:11:11 INFO - 'NO_EM_RESTART': '1', 18:11:11 INFO - 'PAGER': '/bin/cat', 18:11:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:11 INFO - 'PWD': '/builds/slave/test', 18:11:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:11:11 INFO - 'SHELL': '/bin/bash', 18:11:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyfgG0pUga/Listeners', 18:11:11 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 18:11:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:11:11 INFO - 'USER': 'cltbld', 18:11:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:11:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:11 INFO - 'XPC_FLAGS': '0x0', 18:11:11 INFO - 'XPC_SERVICE_NAME': '0', 18:11:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:11 INFO - Downloading/unpacking jsonschema==2.5.1 18:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:11:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:14 INFO - Downloading functools32-3.2.3-2.tar.gz 18:11:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:11:14 INFO - warning: no files found matching '*.txt' 18:11:14 INFO - no previously-included directories found matching 'build' 18:11:14 INFO - no previously-included directories found matching 'dist' 18:11:14 INFO - no previously-included directories found matching '.git*' 18:11:14 INFO - Installing collected packages: jsonschema, functools32 18:11:14 INFO - Running setup.py install for functools32 18:11:14 INFO - warning: no files found matching '*.txt' 18:11:14 INFO - no previously-included directories found matching 'build' 18:11:14 INFO - no previously-included directories found matching 'dist' 18:11:14 INFO - no previously-included directories found matching '.git*' 18:11:15 INFO - Successfully installed jsonschema functools32 18:11:15 INFO - Cleaning up... 18:11:15 INFO - Return code: 0 18:11:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:11:15 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')]} 18:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:15 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')]} 18:11:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:15 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 0x10fd04b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd07768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f842acd2960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fae2d30>, '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 0x10fa09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fad7be8>, '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.V66Ut7Rims/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.xyfgG0pUga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 18:11:15 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 18:11:15 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 18:11:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V66Ut7Rims/Render', 18:11:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:11:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:11:15 INFO - 'HOME': '/Users/cltbld', 18:11:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:11:15 INFO - 'LOGNAME': 'cltbld', 18:11:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:15 INFO - 'MOZ_NO_REMOTE': '1', 18:11:15 INFO - 'NO_EM_RESTART': '1', 18:11:15 INFO - 'PAGER': '/bin/cat', 18:11:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:11:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:15 INFO - 'PWD': '/builds/slave/test', 18:11:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:11:15 INFO - 'SHELL': '/bin/bash', 18:11:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyfgG0pUga/Listeners', 18:11:15 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 18:11:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:11:15 INFO - 'USER': 'cltbld', 18:11:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:11:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:11:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:15 INFO - 'XPC_FLAGS': '0x0', 18:11:15 INFO - 'XPC_SERVICE_NAME': '0', 18:11:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:11:15 INFO - Cleaning up... 18:11:15 INFO - Return code: 0 18:11:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:11:15 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')]} 18:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:15 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')]} 18:11:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:15 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 0x10fd04b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd07768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f842acd2960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fae2d30>, '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 0x10fa09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fad7be8>, '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.V66Ut7Rims/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.xyfgG0pUga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 18:11:15 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 18:11:15 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 18:11:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V66Ut7Rims/Render', 18:11:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:11:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:11:15 INFO - 'HOME': '/Users/cltbld', 18:11:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:11:15 INFO - 'LOGNAME': 'cltbld', 18:11:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:15 INFO - 'MOZ_NO_REMOTE': '1', 18:11:15 INFO - 'NO_EM_RESTART': '1', 18:11:15 INFO - 'PAGER': '/bin/cat', 18:11:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:11:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:15 INFO - 'PWD': '/builds/slave/test', 18:11:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:11:15 INFO - 'SHELL': '/bin/bash', 18:11:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyfgG0pUga/Listeners', 18:11:15 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 18:11:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:11:15 INFO - 'USER': 'cltbld', 18:11:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:11:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:11:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:15 INFO - 'XPC_FLAGS': '0x0', 18:11:15 INFO - 'XPC_SERVICE_NAME': '0', 18:11:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:15 INFO - Downloading/unpacking blobuploader==1.2.4 18:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:18 INFO - Downloading blobuploader-1.2.4.tar.gz 18:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:11:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:11:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:11:19 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 18:11:19 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 18:11:19 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 18:11:19 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 18:11:19 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 18:11:19 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 18:11:19 INFO - Downloading docopt-0.6.1.tar.gz 18:11:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:11:19 INFO - Installing collected packages: blobuploader, requests, docopt 18:11:19 INFO - Running setup.py install for blobuploader 18:11:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:11:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:11:19 INFO - Running setup.py install for requests 18:11:20 INFO - Running setup.py install for docopt 18:11:20 INFO - Successfully installed blobuploader requests docopt 18:11:20 INFO - Cleaning up... 18:11:20 INFO - Return code: 0 18:11:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:11: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')]} 18:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11: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')]} 18:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:20 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 0x10fd04b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd07768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f842acd2960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fae2d30>, '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 0x10fa09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fad7be8>, '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.V66Ut7Rims/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.xyfgG0pUga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 18:11:20 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 18:11:20 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 18:11:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V66Ut7Rims/Render', 18:11:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:11:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:11:20 INFO - 'HOME': '/Users/cltbld', 18:11:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:11:20 INFO - 'LOGNAME': 'cltbld', 18:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:20 INFO - 'MOZ_NO_REMOTE': '1', 18:11:20 INFO - 'NO_EM_RESTART': '1', 18:11:20 INFO - 'PAGER': '/bin/cat', 18:11:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:20 INFO - 'PWD': '/builds/slave/test', 18:11:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:11:20 INFO - 'SHELL': '/bin/bash', 18:11:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyfgG0pUga/Listeners', 18:11:20 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 18:11:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:11:20 INFO - 'USER': 'cltbld', 18:11:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:11:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:20 INFO - 'XPC_FLAGS': '0x0', 18:11:20 INFO - 'XPC_SERVICE_NAME': '0', 18:11:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:11:20 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-WRitoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:11:20 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-OH7BrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:11:20 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-4oEmeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:11:20 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-yhZGme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:11:21 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-YC924C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:11:21 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-l5Isio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:11:21 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-eZYer1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:11:21 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-fcicQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:11:21 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-slEaRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:11:21 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-UFBhrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:11:21 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-BbDZYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:11:21 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-8TU6og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:11:21 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-fqxz7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:11:21 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-dbnyx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:11:22 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-Ux2v2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:11:22 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-oIMeZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:11:22 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-dHQKxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:11:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:11:22 INFO - Running setup.py install for manifestparser 18:11:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:11:22 INFO - Running setup.py install for mozcrash 18:11:22 INFO - Running setup.py install for mozdebug 18:11:22 INFO - Running setup.py install for mozdevice 18:11:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:11:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:11:23 INFO - Running setup.py install for mozfile 18:11:23 INFO - Running setup.py install for mozhttpd 18:11:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:11:23 INFO - Running setup.py install for mozinfo 18:11:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:11:23 INFO - Running setup.py install for mozInstall 18:11:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:11:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:11:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:11:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:11:23 INFO - Running setup.py install for mozleak 18:11:23 INFO - Running setup.py install for mozlog 18:11:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:11:23 INFO - Running setup.py install for moznetwork 18:11:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:11:24 INFO - Running setup.py install for mozprocess 18:11:24 INFO - Running setup.py install for mozprofile 18:11:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:11:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:11:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:11:24 INFO - Running setup.py install for mozrunner 18:11:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:11:24 INFO - Running setup.py install for mozscreenshot 18:11:24 INFO - Running setup.py install for moztest 18:11:24 INFO - Running setup.py install for mozversion 18:11:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:11:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:11:24 INFO - Cleaning up... 18:11:24 INFO - Return code: 0 18:11:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:11:24 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')]} 18:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:24 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')]} 18:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:24 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 0x10fd04b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd07768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f842acd2960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fae2d30>, '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 0x10fa09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fad7be8>, '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.V66Ut7Rims/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.xyfgG0pUga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 18:11:24 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 18:11:24 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 18:11:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V66Ut7Rims/Render', 18:11:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:11:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:11:24 INFO - 'HOME': '/Users/cltbld', 18:11:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:11:24 INFO - 'LOGNAME': 'cltbld', 18:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:24 INFO - 'MOZ_NO_REMOTE': '1', 18:11:24 INFO - 'NO_EM_RESTART': '1', 18:11:24 INFO - 'PAGER': '/bin/cat', 18:11:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:24 INFO - 'PWD': '/builds/slave/test', 18:11:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:11:24 INFO - 'SHELL': '/bin/bash', 18:11:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyfgG0pUga/Listeners', 18:11:24 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 18:11:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:11:24 INFO - 'USER': 'cltbld', 18:11:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:11:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:24 INFO - 'XPC_FLAGS': '0x0', 18:11:24 INFO - 'XPC_SERVICE_NAME': '0', 18:11:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:11:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:11:25 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-s73nho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:11:25 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)) 18:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:11:25 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-9kpV_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:11:25 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)) 18:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:11:25 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-T4ILBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:11:25 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)) 18:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:11:25 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-YhPb4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:11:25 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-RHOkDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:11:25 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)) 18:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:11:25 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-1iF7fP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:11:25 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)) 18:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:11:25 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-Tn7wgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:11:25 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)) 18:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:11:25 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-PN5CqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:11:26 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)) 18:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:11:26 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-AzQDfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:11:26 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)) 18:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:11:26 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-IwhTWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:11:26 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)) 18:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:11:26 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-LzlKln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:11:26 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)) 18:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:11:26 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-7S2c0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 18:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:11:26 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-kiUdVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:11:26 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)) 18:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:11:26 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-xliVvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:11:26 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)) 18:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:11:26 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-7TFJpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:11:26 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)) 18:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:11:26 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-zRE8Vs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:11:26 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)) 18:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:11:26 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-mZiu24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:11:27 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)) 18:11:27 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)) 18:11:27 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)) 18:11:27 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)) 18:11:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:11:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:11:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:11: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 18:11: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 18:11: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 18:11: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 18:11: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 18:11: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 18:11:29 INFO - Downloading blessings-1.6.tar.gz 18:11:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:11:29 INFO - Installing collected packages: blessings 18:11:29 INFO - Running setup.py install for blessings 18:11:29 INFO - Successfully installed blessings 18:11:29 INFO - Cleaning up... 18:11:30 INFO - Return code: 0 18:11:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:11:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:11:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:11:30 INFO - Reading from file tmpfile_stdout 18:11:30 INFO - Current package versions: 18:11:30 INFO - blessings == 1.6 18:11:30 INFO - blobuploader == 1.2.4 18:11:30 INFO - docopt == 0.6.1 18:11:30 INFO - functools32 == 3.2.3-2 18:11:30 INFO - jsonschema == 2.5.1 18:11:30 INFO - manifestparser == 1.1 18:11:30 INFO - mozInstall == 1.12 18:11:30 INFO - mozcrash == 1.0 18:11:30 INFO - mozdebug == 0.1 18:11:30 INFO - mozdevice == 0.49 18:11:30 INFO - mozfile == 1.2 18:11:30 INFO - mozhttpd == 0.7 18:11:30 INFO - mozinfo == 0.9 18:11:30 INFO - mozleak == 0.1 18:11:30 INFO - mozlog == 3.4 18:11:30 INFO - moznetwork == 0.27 18:11:30 INFO - mozprocess == 0.24 18:11:30 INFO - mozprofile == 0.28 18:11:30 INFO - mozrunner == 6.13 18:11:30 INFO - mozscreenshot == 0.1 18:11:30 INFO - mozsystemmonitor == 0.3 18:11:30 INFO - moztest == 0.8 18:11:30 INFO - mozversion == 1.4 18:11:30 INFO - psutil == 3.1.1 18:11:30 INFO - requests == 1.2.3 18:11:30 INFO - wsgiref == 0.1.2 18:11:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:11:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:30 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 0x10fd04b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd07768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f842acd2960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fae2d30>, '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 0x10fa09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fad7be8>, '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.V66Ut7Rims/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.xyfgG0pUga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 18:11:30 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 18:11:30 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 18:11:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V66Ut7Rims/Render', 18:11:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:11:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:11:30 INFO - 'HOME': '/Users/cltbld', 18:11:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:11:30 INFO - 'LOGNAME': 'cltbld', 18:11:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:30 INFO - 'MOZ_NO_REMOTE': '1', 18:11:30 INFO - 'NO_EM_RESTART': '1', 18:11:30 INFO - 'PAGER': '/bin/cat', 18:11:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:11:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:30 INFO - 'PWD': '/builds/slave/test', 18:11:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:11:30 INFO - 'SHELL': '/bin/bash', 18:11:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyfgG0pUga/Listeners', 18:11:30 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 18:11:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:11:30 INFO - 'USER': 'cltbld', 18:11:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:11:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:11:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:30 INFO - 'XPC_FLAGS': '0x0', 18:11:30 INFO - 'XPC_SERVICE_NAME': '0', 18:11:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:11:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:30 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)) 18:11:30 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)) 18:11:30 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)) 18:11:30 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)) 18:11:30 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)) 18:11:30 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)) 18:11:30 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)) 18:11:30 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)) 18:11:30 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)) 18:11:30 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)) 18:11:30 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)) 18:11:30 INFO - Cleaning up... 18:11:30 INFO - Return code: 0 18:11:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:11:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:30 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 0x10fd04b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd07768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f842acd2960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fae2d30>, '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 0x10fa09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fad7be8>, '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.V66Ut7Rims/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.xyfgG0pUga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 18:11:30 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 18:11:30 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 18:11:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V66Ut7Rims/Render', 18:11:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:11:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:11:30 INFO - 'HOME': '/Users/cltbld', 18:11:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:11:30 INFO - 'LOGNAME': 'cltbld', 18:11:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:30 INFO - 'MOZ_NO_REMOTE': '1', 18:11:30 INFO - 'NO_EM_RESTART': '1', 18:11:30 INFO - 'PAGER': '/bin/cat', 18:11:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:11:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:30 INFO - 'PWD': '/builds/slave/test', 18:11:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:11:30 INFO - 'SHELL': '/bin/bash', 18:11:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyfgG0pUga/Listeners', 18:11:30 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 18:11:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:11:30 INFO - 'USER': 'cltbld', 18:11:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:11:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:11:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:30 INFO - 'XPC_FLAGS': '0x0', 18:11:30 INFO - 'XPC_SERVICE_NAME': '0', 18:11:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:11:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:11:30 INFO - Cleaning up... 18:11:30 INFO - Return code: 0 18:11:30 INFO - Running post-action listener: _resource_record_post_action 18:11:30 INFO - Running post-action listener: _start_resource_monitoring 18:11:30 INFO - Starting resource monitoring. 18:11:30 INFO - [mozharness: 2017-02-04 02:11:30.839114Z] Finished create-virtualenv step (success) 18:11:30 INFO - [mozharness: 2017-02-04 02:11:30.840022Z] Running install step. 18:11:30 INFO - Running pre-action listener: _resource_record_pre_action 18:11:30 INFO - Running main action method: install 18:11:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:11:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:11:31 INFO - Reading from file tmpfile_stdout 18:11:31 INFO - Detecting whether we're running mozinstall >=1.0... 18:11:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:11:31 INFO - Reading from file tmpfile_stdout 18:11:31 INFO - Output received: 18:11:31 INFO - Usage: mozinstall [options] installer 18:11:31 INFO - Options: 18:11:31 INFO - -h, --help show this help message and exit 18:11:31 INFO - -d DEST, --destination=DEST 18:11:31 INFO - Directory to install application into. [default: 18:11:31 INFO - "/builds/slave/test"] 18:11:31 INFO - --app=APP Application being installed. [default: firefox] 18:11:31 INFO - mkdir: /builds/slave/test/build/application 18:11:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:11:53 INFO - Reading from file tmpfile_stdout 18:11:53 INFO - Output received: 18:11:53 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:11:53 INFO - Running post-action listener: _resource_record_post_action 18:11:53 INFO - [mozharness: 2017-02-04 02:11:53.340394Z] Finished install step (success) 18:11:53 INFO - [mozharness: 2017-02-04 02:11:53.340518Z] Running run-tests step. 18:11:53 INFO - Running pre-action listener: _resource_record_pre_action 18:11:53 INFO - Running main action method: run_tests 18:11:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:11:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:11:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:11:53 INFO - 2017-02-03 18:11:53.354 screenresolution[1629:7624] starting screenresolution argv=screenresolution get 18:11:53 INFO - 2017-02-03 18:11:53.356 screenresolution[1629:7624] Display 0: 1600x1200x32@60 18:11:53 INFO - 2017-02-03 18:11:53.362 screenresolution[1630:7626] starting screenresolution argv=screenresolution list 18:11:53 INFO - Available Modes on Display 0 18:11:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:11:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:11:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:11:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:11:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:11:53 INFO - Intel Iris: 18:11:53 INFO - Chipset Model: Intel Iris 18:11:53 INFO - Type: GPU 18:11:53 INFO - Bus: Built-In 18:11:53 INFO - VRAM (Dynamic, Max): 1536 MB 18:11:53 INFO - Vendor: Intel (0x8086) 18:11:53 INFO - Device ID: 0x0a2e 18:11:53 INFO - Revision ID: 0x0009 18:11:53 INFO - Displays: 18:11:53 INFO - Display: 18:11:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:11:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:11:53 INFO - Display Serial Number: 1600x1200 60 18:11:53 INFO - Main Display: Yes 18:11:53 INFO - Mirror: Off 18:11:53 INFO - Online: Yes 18:11:53 INFO - Rotation: Supported 18:11:53 INFO - Return code: 0 18:11:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:11:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:11:53 INFO - Python 2.7.3 18:11:53 INFO - Return code: 0 18:11:53 INFO - grabbing minidump binary from tooltool 18:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:53 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 0x10fae2d30>, '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 0x10fa09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fad7be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:11:53 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 18:11:53 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 18:11:53 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 18:11:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:11:53 INFO - Return code: 0 18:11:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:11:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:11:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:11:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:11:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:11:53 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/WHNEwAUFT46LLvJ_81_tJA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0231', '--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 18:11:53 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/WHNEwAUFT46LLvJ_81_tJA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0231 --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 18:11:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V66Ut7Rims/Render', 18:11:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:11:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:11:53 INFO - 'HOME': '/Users/cltbld', 18:11:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:11:53 INFO - 'LOGNAME': 'cltbld', 18:11:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:11:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:53 INFO - 'MOZ_NO_REMOTE': '1', 18:11:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:11:53 INFO - 'NO_EM_RESTART': '1', 18:11:53 INFO - 'PAGER': '/bin/cat', 18:11:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:53 INFO - 'PWD': '/builds/slave/test', 18:11:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:11:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:11:53 INFO - 'SHELL': '/bin/bash', 18:11:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyfgG0pUga/Listeners', 18:11:53 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 18:11:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:11:53 INFO - 'USER': 'cltbld', 18:11:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:11:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:53 INFO - 'XPC_FLAGS': '0x0', 18:11:53 INFO - 'XPC_SERVICE_NAME': '0', 18:11:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:11:53 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/WHNEwAUFT46LLvJ_81_tJA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0231', '--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 18:11:53 INFO - mozversion application_buildid: 20170203170012 18:11:53 INFO - mozversion application_changeset: 94079d43835ff229dce0f9b226cedd64c6aaef60 18:11:53 INFO - mozversion application_display_name: Nightly 18:11:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:11:53 INFO - mozversion application_name: Firefox 18:11:53 INFO - mozversion application_remotingname: firefox 18:11:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:11:53 INFO - mozversion application_vendor: Mozilla 18:11:53 INFO - mozversion application_version: 54.0a1 18:11:53 INFO - mozversion platform_buildid: 20170203170012 18:11:53 INFO - mozversion platform_changeset: 94079d43835ff229dce0f9b226cedd64c6aaef60 18:11:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:11:53 INFO - mozversion platform_version: 54.0a1 18:11:53 INFO - using testdate: 1486174313 18:11:53 INFO - actual date: 1486174313 18:11:53 INFO - starting webserver on 'localhost:49236' 18:11:53 INFO - SUITE-START | Running 2 tests 18:11:53 INFO - TEST-START | dromaeo_css 18:11:53 INFO - operating with platform_type : mac_ 18:11:53 INFO - Initialising browser for dromaeo_css test... 18:11:53 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmp0wtyRA/profile http://localhost:49236/getInfo.html) 18:11:56 INFO - PROCESS | 1640 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 18:11:56 INFO - PROCESS | 1640 | 2017-02-03 18:11:56.789 plugin-container[1642:7795] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x903f, name = 'com.apple.tsm.portname' 18:11:56 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:11:56 INFO - PROCESS | 1640 | 2017-02-03 18:11:56.792 plugin-container[1642:7795] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950f, name = 'com.apple.CFPasteboardClient' 18:11:56 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:11:56 INFO - PROCESS | 1640 | 2017-02-03 18:11:56.792 plugin-container[1642:7795] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:11:56 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 18:11:56 INFO - PROCESS | 1640 | colorDepth:24 18:11:56 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 18:11:56 INFO - PROCESS | 1640 | __metrics 18:11:56 ERROR - PROCESS | 1640 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 18:11:56 INFO - PROCESS | 1640 | 1486174316943 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < forceQuit@jar:file:///var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmp0wtyRA/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmp0wtyRA/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmp0wtyRA/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmp0wtyRA/profile/extensions/talos-powers@TalosPowersService.js:55:9 18:11:57 INFO - TEST-INFO | 1640: exit 0 18:11:57 INFO - Browser initialized. 18:11:57 INFO - Running cycle 1/1 for dromaeo_css test... 18:11:57 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmp0wtyRA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:11:59 INFO - PROCESS | 1644 | 2017-02-03 18:11:59.975 plugin-container[1645:7920] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 18:11:59 INFO - PROCESS | 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:11:59 INFO - PROCESS | 1644 | 2017-02-03 18:11:59.976 plugin-container[1645:7920] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4417, name = 'com.apple.CFPasteboardClient' 18:11:59 INFO - PROCESS | 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:11:59 INFO - PROCESS | 1644 | 2017-02-03 18:11:59.976 plugin-container[1645:7920] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:12:09 INFO - PROCESS | 1644 | RSS: Main: 233861120 18:12:09 INFO - PROCESS | 1644 | 18:15:12 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 18:15:13 INFO - PROCESS | 1644 | RSS: Main: 257507328 18:15:13 INFO - PROCESS | 1644 | 18:16:57 INFO - PROCESS | 1644 | ************************* 18:16:57 INFO - PROCESS | 1644 | A coding exception was thrown and uncaught in a Task. 18:16:57 INFO - PROCESS | 1644 | 18:16:57 ERROR - PROCESS | 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:16:57 INFO - PROCESS | 1644 | Full stack: 18:16:57 INFO - PROCESS | 1644 | ************************* 18:18:16 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 18:18:16 INFO - PROCESS | 1644 | RSS: Main: 264949760 18:18:16 INFO - PROCESS | 1644 | 18:21:18 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 18:21:19 INFO - PROCESS | 1644 | RSS: Main: 280018944 18:21:19 INFO - PROCESS | 1644 | 18:24:21 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 18:24:21 INFO - PROCESS | 1644 | RSS: Main: 273051648 18:24:21 INFO - PROCESS | 1644 | 18:27:24 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 18:27:25 INFO - PROCESS | 1644 | RSS: Main: 283267072 18:27:25 INFO - PROCESS | 1644 | 18:30:27 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 18:30:28 INFO - PROCESS | 1644 | RSS: Main: 282955776 18:30:28 INFO - PROCESS | 1644 | 18:30:28 INFO - PROCESS | 1644 | __start_tp_report 18:30:28 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 18:30:28 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 18:30:28 INFO - PROCESS | 1644 | |i|pagename|runs| 18:30:28 INFO - PROCESS | 1644 | |0;dojo.html;3344.4983252512125;3355.513450549669;3376.4428869236576;3386.6274709781933;3394.677505636964;5628.577856660746;5695.943040569593;5761.827145185646;5810.360860305363;5824.359320474744;5621.072523033695;5671.6880571568545;5676.120201368794;5677.914831277534;5744.396838331978;4776.604710775532;5106.106431374495;5152.793888244466;5160.303359046518;5314.123169676998;4610.3315019322345;5270.525652691257;5314.4951229633125;5332.546733527654;5340.412554619008;4135.834566617332;5153.098207813637;5228.607854410934;5230.320058392384;5294.364676238876;5182.119039763249;5218.086834803894;5218.13900706383;5237.869053273661;5242.580593552545;5073.568746656539;5165.328507294028;5177.326947496839;5203.16749320107;5207.140821764404;5455.809046683347;5587.832365029056;5611.438856114397;5696.544276457874;5792.478676919055;6239.37606239377;6289.622622642656;6305.4009869062365;6306.1486699295465;6313.87372252557;6297.779577714804;6298.905516417258;6305.59013664115;6322.9051564226575;6323.05154226865;5639.943600563983;5662.971685141589;5767.913481297784;5795.246617939725;5812.59311848175;6312.652804095727;6326.304106548276;6336.6831658416895;6342.841428964312;6352.523560732963;5877.412258774174;5939.4357536034;6127.342242870382;6151.630902145886;6195.876082478325;6257.155284036597;6309.621422714652;6313.3686631336495;6322.083297921776;6340.144080549159;6090.36051214625;6105.338445949952;6146.924288249538;6161.137440758297;6207.34822843604;6262.5616206866;6270.49836013127;6280.9685951569945;6292.590981586182;6312.5581209314905;4381.759003254851;5005.799768009311;5024.79900803971;5036.924446133311;5049.318342023853;4324.956750432519;4341.001569639001;4400.867973960786;4447.466304043471;4491.955080449219;5732.914006289909;5746.339170995389;5748.913766293509;5775.306963164448;5788.131780232999;6283.8114856554375;6300.527460440394;6310.8422289442215;6313.463355614732;6317.6209427434505;5606.299212598426;5633.436656334416;5689.743961521742;5723.399043100415;5763.88472230553;5412.404635490093;5420.620556561082;5427.3215848019;5504.532114770209;5527.309086364205;6310.2743184534365;6316.368363163647;6325.14610527582;6338.30278669346;6342.556021078481;6068.362821903636;6281.309056003744;6292.114730962512;6313.90529142054;6318.273398559225;6184.257889053342;6251.093591429127;6263.311035786151;6297.1813664223355;6336.778212762531;6159.938400616115;6231.345708700521;6232.345603711545;6235.407636274728;6239.126522286792;5101.775573862321;5358.598105142208;6052.0921861719335;6102.145699601971;6289.371062893674;6079.483243924316;6147.692615369303;6152.98475751496;6153.692315384303;6200.131981522501;4676.55572720591;4990.426100998432;6123.2958209804665;6142.9078563820685;6154.046122850965;4861.6596838220985;5542.722863856871;5758.395368486249;5920.111983202554;6022.759089636365;6137.539684523768;6148.569600127948;6158.137860699595;6168.568200225941;6179.227596550431;5966.76132954677;5981.671008094597;5987;6020.909686354796;6022.307434645072 18:30:28 INFO - PROCESS | 1644 | |1;ext.html;450.6237291861296;536.5466181076991;550.3670778604604;562.7580140539568;588.5056552495903;37674.81162594187;38515.03712407191;40157.59842401575;40236.59763402365;40288.59711402889;40811.59188408122;41360.37959430603;41558;41610.99999999993;41655;7938.722144724936;8319.500829950191;8821.38250322476;9360.4383736976;9377.953110234474;9180.0819918008;9333.719988400326;9404.670836520723;9420.3985322495;9423.387479813824;9370.484623345714;9433.009533998935;9436.528173591327;9446.716598502022;9469;9345.112214339626;9399.24806015524;9401.717948461488;9416.858747118798;9427.434353938786;9156.816863662756;9236.168744812932;9243.214326782232;9252.814943701089;9256.8611470828;35850.92447226588;35990.8200458996;36385.81807090974;36476.63523364759;36696.63303366959;3358.9664103358896;3944.881653550398;3952.5849785772657;3973.8211780469946;4074.388841673743;27973.580396294074;28632.856835715895;28709.85645071782;28710.71289287101;28855.278618034507;2467.4448249143798;2673.957156708885;3007.7593792496546;3104.5343198520177;3295.571575695168;391169;434040;436870;444340;444879;32633;55101.38783345944;56859.57851053757;57095.42904570984;60171.991400429804;58129.4187058124;58321.708391457774;59230;59381.40618593759;59417.81164376688;15019.924900375647;15158.393664253526;15176.696466070616;15187;15209.771853422208;11430.028447582048;11617.88382116168;11648.126390520745;11848.229865058744;11918.344491053076;17672.734908976374;17816.376426824998;17901.910490447466;17909.492671026066;17964.820351796578;7939.28546430824;8032.156623554442;8062.7581172564915;8086.110527841933;8086.433949623588;858.4849090545747;862.7357648598688;869.4870026684287;870.3863776037878;887.1837909123493;30656.38687226243;30670;30736;31048.844755776077;31090.22274443157;762.7528990101224;949.3164921256684;989.5992123190119;1104.3815463340554;1199.0467578275293;15698;15864.841351586567;15959.061407888168;16094.597635059217;16621.335146594243;189797;219800;219988;220203;220203.89898050408;60917.39082609117;61278;61606.38393616006;61694.38305616887;61697.76604467975;1202.6331968749441;1378.6415531961761;1424.5156646740159;1424.8076509671268;1426.436557559758;29117.980870669424;29366.706332936395;29642.407151857275;29895.850520747255;30840.691593083782;51673.48326516837;52261.51254118263;52425.737871311925;52434;52434.95130097301;495378;498073;498084;498271;498885;24897.25308240756;25619.743802561738;25703.871480643225;25773;26422.60366094472;40952;41127.58872411357;41719.331226751805;41917.79041104775;42109.57890421057;30404;34724.65275347214;34735.13162170966;35518;36125.63874361328;26611.467770644093;29248.56127158052;29346.266343340732;32938.50592241166;34353.797617083284;33442.16394590155;33709.49435758514;33935.66064339325;33981.49027764635;35588.822055889555;26868.73131268662;27359.905603775627;32197;32434.675653243165;32517;20518.17927282892;23641.054357825495;24402.87798561067;24454.899529521572;24731.13441029555 18:30:28 INFO - PROCESS | 1644 | |2;jquery.html;397.8846134620962;404.69445568595705;417.6262245290465;418.3494665794689;433.1856110512239;19648.50878728031;20248.392548223575;20670.30536353156;20846.478838029056;21012.89493552532;20500.17999280027;20585.588288234263;20871.165153393846;21054.578908421823;21183.152673893026;5820.068788993773;6136.693165341738;6140.938590614103;6141.570090093695;6175.907361389583;5583.776648934037;5859.707014649251;5996.2504686914135;6097.969510152443;6109.14471973924;5848.298204215479;5990.700464976756;5999.310079340867;6000.789972350969;6009.489193418564;5865.944130056588;5976.432238937294;6521.967390163042;6529.2817790043055;6544.640044797534;5836.445537673914;5840;5844.912326315109;5845.766169353221;5857.736401861926;18790.624187516172;24028.759712402825;24312.027518899224;25107.748922510724;26417.207483775517;2589.8216311578376;2898.7680985521106;2902.5646153076996;2913.907284768212;2939.6766355700856;10194.694159175237;10314.850324388286;10364.740881477948;10750.677479675622;10819.459027048617;1542.406173623152;1792.5518620344915;1834;1850.2506484873647;1871.4853415310763;129355.35322323423;131800;132263.33868330694;139050;147401;10940.741814691253;11185.049270811909;11924.284542927453;12177.69555761113;12390.62828115158;15805.36778528869;15830.76253856193;15861.444849430214;15870.968387054805;15881;8518.063013068557;8559;8705.869411958825;8747.737567872973;8811.867821982676;7621.352185064221;8189.385796065319;8303.418760686814;8384.53885036329;8396.160383961555;4860.829870954571;4914.410270767459;4936.308916751657;4950.851474455772;4997.85006449807;2048.201201531404;2086.35323049852;2088.1125521653235;2088.457001179704;2096.2243969730994;991.8710567626163;1000.284796370584;1023.4013102335068;1023.5445226873969;1034.8447732839984;20716.58566828655;21222.681659775117;21804.563908722055;21831.672524912137;21848.907554622205;1010.3735683876043;1020.4948550467566;1040.9115225205792;1041.3023274406166;1057.3127467146262;9771.804563908825;11246.381449020218;11322.433878306052;11538.711532211593;11600.071994240441;399566;503851;720458;732250;739534;132177.67822321845;163650;168971;169011;169412;937.3110763588757;951.9762005949907;971.820213260549;974.9415035097917;977.2621670638622;15400;16838.57903552421;17825.910870445565;19273.132709028407;19405.32081377145;57443;59796;60071.39928600658;61400.078998815945;61830.38169618246;83409;89006.55496722474;89151;89751.65372519549;90619;6782.626955517494;7944.285014348505;8595.699150529701;8656.567171641518;8718.346124040596;9458.763530911507;10568.630097946534;12822.87177128254;13102.082854200115;13574.914006879624;9364.812703746024;11170.664880053286;11291.322520648788;11294.830577541508;11432.485538150637;11035.337879727242;11088.667339979813;11093;11360.659180224606;11577.421128943688;11293.548258069584;11674.824877627012;11715.531378744754;11735.418207994227;11847.466863990969;7243.311885370881;7341.889871652036;7559.622018899143;7757.65090570937;8616;9480.905190948002;11296.209265351346;11327.037201837937;11661.533538658698;11668.824967625662 18:30:28 INFO - PROCESS | 1644 | |3;mootools.html;1303.4981532110146;1310.4627102887816;1407.064302239011;1443.5885772554825;1449.6448370149312;7071.328223818729;7950.721724739636;8299.709510167146;8769.517676527788;8792.604332805024;7092.893606595892;8638.524881131536;8643.524606146659;8649.697260595865;8651.87022194666;2041.540653352991;2276.6015947209253;2318.2349824557855;2319.5940710375703;2329.9631663909568;2031.8113903366548;2219.4784225706944;2290.1297506947335;2308.803751681109;2325.686032385623;2278.7835155660187;2286.6455699366625;2305.4236440889777;2313.456337760625;2316.177756896303;2212.7344718633867;2260.706108205939;2295.0360848443693;2299.298713892254;2301.746807851135;1956.432634535983;2014.939551813448;2079.2930403662826;2321.872297023663;2382.60686986647;8449.662013519452;8619.094995025558;8644.524551149685;8726.476411415271;8769.386142969995;5109.718965456898;5218.165093585046;5271.262023316739;5274.894502109936;5280.313559237313;3472.44440889459;3488.7906725596545;3521.9295614087573;3556.590992035923;3616.8914932552066;1207.4445754952733;1221.9816702749465;1230.9322987235698;1254.0907841814703;1273.1533530202405;11149.944250278777;11179.385133817637;11280.717982050432;11299.887001129884;11315.924987126209;4191.8532851350055;4522.321651752263;4552.408186935677;4597.747123908151;4601.378813860153;8832.381733278737;8966.551672416354;8977.787998620102;8981.910180898238;8986.14631609996;5163.715995620277;5167.147420675622;5175.171972484384;5181.611379146579;5194.454582268883;4587.17430862448;4683.789229484613;4860.4896485869185;4861.052094841472;4897.314375987365;3653.0684675408133;3673.246984368198;3759.755615884959;3759.887203383903;3803.6196380361744;1146.3694967767694;1158.4960542164185;1158.6987383280407;1165;1165.580391059218;856.9314454843598;861.2291998661289;863.1239292118505;874.5539774714814;900.3292547052488;5174.508421699932;5627.915581266284;5689.118186681071;5914.6746928918465;6004.609700369462;726.5785844210345;973.245734555725;974.34718738444;981.6809536900536;1029.2332212501733;3567.7502574819514;3634.945475817865;3764.8305826237884;3841.8847434577006;3842.2315536892734;10124;10426.895731042745;10488.26582139243;10500.737481563023;10510.106640935453;10120.089191972758;10140.847887281549;10266.589336426608;10445.477726113664;10459.163266938627;8062.435629505878;8155.836883262302;8161.061477929995;8174.3051840593025;8194.139615340422;5497.39528651856;5534.225208470737;5609.074502707008;5627.971860140673;5680.573956953328;9129.406588571721;9318.72043838686;9470.384425012353;9543.761405964906;9655.710328690151;9182.908170918205;9689.273304502332;9690.903090969001;9736.95131524338;9871.50642467888;7318.926810731825;7339.853202935805;7371.631418429164;7385.741499047507;7431.108267007994;7939.920600794149;8021.27808497238;8066.7579972600915;8115;8161.347092232726;6077.756889724362;6241.095041219089;6986.9650651746415;7172.641367931478;7345.449091318279;7148.356647901714;7197.568145911262;7219.278072192738;7239.457040722073;7311.488195826454;6390.297067322684;6404.295527491879;6407.10300557913;6469.644169570531;6470.773522926675;4349.934750978675;4978.303037574815;5022.673526220784;5028.874278142929;5140.30605868203;4382.539833317455;4638.9330453996445;4946.332245146859;5046.369203849519;5214.634975551827 18:30:28 INFO - PROCESS | 1644 | |4;prototype.html;362.2483347054862;363.78536663368607;369.8982779735571;371.91260053887333;373.51256610123795;4887.633427492939;5357.973210133953;5403.8108666196695;5442.1836724491295;5549.864326655437;4715.0098479319295;4726.527347265272;4743.833965811197;5430.5384042356345;5481.890362192754;3931.8034098295116;4008.8196031178522;4084.774567629714;4125.876223713293;4175.206710724952;3299.703026727594;3311.8344082795884;3827.674647654953;4171.791410429481;4238.660907127438;3958.406239064149;4189.05746207104;4200.151933149405;4206.128272918552;4226.9154616907645;3826.349520581508;4052.371882358239;4155.875323740278;4196.391523229115;4218.873433796991;3526.2771131917893;3544.3088597723454;3556.2176321209295;3574;3584.605693373727;4812.941152946346;5082.872928176788;5356.491133342326;5397.704550907793;5411.783528658849;4201.626081264076;4545.250033744428;4635.096156249533;4792.448868380111;4794.5205479452125;5392.272043274147;5664.862273535375;5733;5757.286550175156;5803.448672376117;3286.457734473809;3952.170044290702;3970.724152574138;3985.5416627087966;4003.979980100081;5352.812651557177;5472.452754724535;5686.914696279559;6155.138280640714;6169.198004259462;3584.426491761306;3836.1778155376533;3900.7464514807016;3939.7045221608496;3962.473398675181;3706.4440333949583;3969.2656858480696;3985.4818873546255;3993.341098718679;4030.274550580865;4113.799117472138;4389.495208051051;4421.093675796454;4681.899753557911;4698.577128058491;5370.355557333145;5569.387367389584;5718.513926316226;5838.511179649247;5944.851378715567;1237.1401875696304;1296.6758310422395;1299.6490947444138;1301.1542497376781;1307.7384523095418;724.4675163754636;768.4352001279055;770.5723323555369;837.9832403351899;885.0132102705566;4353.25994580922;4646.233371493733;5141.794328226903;5217.6086793489885;5226.92159617606;5206.7917283309;5474.151506516497;5545.889082218414;5600.327960644749;5678.858028549319;4710.552497512731;4883.34074899891;5052.368453943257;5138.922916156261;5143.691378517301;2716.0901098131953;2800.571708428716;2885.9422811544073;2927.780416468773;3004.9482681061454;5944.464998150187;5959.348090099864;5972.65615236577;5983.730732117066;5985.431384018511;4881.900782663418;5316.441773613715;5612.663240205601;6140.3552626974415;6167.506599472032;5426.321709786277;6013.767177728555;6077.513798896078;6174.536909731788;6209.143793854697;5253.894922101613;5563.833085007456;5832.533397328289;5961.721053420688;6096.756129754937;4731.574158325767;5177.08447874289;5485;5805.622634528742;5927.377625349276;5758.827235182951;6175.6912154393;6223.97720740752;6319.96840015797;6332.746690132343;3994.540627827837;4028.469181710931;4037.9394309085974;4047.6357127858632;4056.290149223815;5794.24773232728;5950.285965684146;5999.940000599938;6009.639421634716;6040.939590604038;5338.57291416678;5377.892442151213;5623.69428534299;5820.5925585210325;5969.343372228965;4866.756662166948;5330.573554115739;5858.384869588632;5894.911576326273;5903.2325797646035;5259.949838624314;5462.426445223195;5592.524635406036;5645.266115404971;5715.542097031236;5454.672719636835;5785.3636100028125;5839.766409343749;5876.559258055578;5891.293044834647;5270.183121616155;5361.410244872983;5608;5612.270404847343;5758.445219790717 18:30:28 INFO - PROCESS | 1644 | |5;yui.html;707.3386383731215;708.2563308526046;781.679511400326;785.2187073861506;826.0847954669713;14666.926665366671;15341.69316613667;15426.845731542695;15429;15512.379504819808;14186.645333866658;14362.569122926303;14374.20941848198;14385.280735963186;14395.06432081914;870.2385412763832;875.6103533927405;892.5001998880615;899.5232526760827;902.4089221559889;885.4864178776327;886.0784783824814;886.5921676029035;886.9201771840533;887.609451841191;933.3606479561488;941.8822647169104;942.9481378524179;943.0004195552701;943.7310366545536;925.8194652042854;932.7947851472666;938.2072149034055;939.4551160326994;940.8870935487786;695.3602685529326;696.195893742728;697.1425147069083;698.0924797762888;699.5173330402006;15203.923980380026;15506.922465387714;15709.842901570952;15726.606834829221;15773.526794196192;13834.723305533933;14002.719945601133;14069.788953165711;14208.431662733477;14210.289485525682;8844.46933184011;9516.762820833317;11855.288682679067;11867.58463453775;11919.94040029803;3305.3058857639926;3570.071781336871;3635.8545658173643;3673.155174309897;3843.942340864889;91810;95101.5244923771;95169.52415237948;96115;96712;8085.272325490734;9186.549407134416;10310.278280520291;10595.682129536126;10791.78416431667;19379.224831006883;20499.38501844947;21751;22023.33929982103;22115.668264976037;7489.400847932152;7563.168051514329;7622.428317876182;7630.542167469969;7723.729669461542;4013.177298653769;4081.5918408158946;4102.077032667686;4112.588741125864;4118.423420721101;3678.393065144221;3749.7937613431523;3755.6244375562223;3789.1853251550497;3797.715171362159;574.4657468554285;674.1270055278426;676.2662511175331;679.8368391585984;691.2948792231996;653.2879161713755;663.6316844151543;694.3958755882414;696.8223103108675;714.1572943926113;8021;9907.900920990698;9916.25628077897;10053.12098228973;10297.897021029694;545.7462280039721;552.7070652554153;561.882004779001;582.5368831778746;722.2344315026089;4504.819807207675;4975.5522003019905;4982.476839931827;4994.4755800640405;5008.398992120969;94806;98430.53923651823;99064.00935990692;99342;101140.49429752951;53362.7331863346;61700.69149654223;86211.56894215614;88593;89489.55255223683;71436;72152.63923680453;72729.90905136427;73174.26825731674;74153.6292318535;10093.495325233562;10775.245732798943;10782.460876956278;10833.729156771144;11072.169587281147;47427;47582;48440;48754.07475551478;49023.26465103098;64258.678706606166;65099.02351464827;65648.6717566409;66852.665736671;67284.65430691457;12841.229526228457;12852.228866268053;12976.469588430165;13032.41354139085;13308.201507909556;14384.568462946128;14389.712205755617;14614.41542338337;14670;15353.07881527112;13511.594652160451;13617.931910340385;13620.727585448038;13829.170249785046;14208.857911420753;13773.449062037405;13819.654508637364;13997.860021399656;14043.929780351033;14113.264745072609;12914.870851291367;13188.54296388543;13548.796768048684;13728;14018.509352172625;10421.739456513647;10732.635396590164;10939.398333091756;10958.342499450058;11269.66191014271;9021.06047199829;10814.945925270324;10874.02133807961;10917.508712107816;10974.122070234202 18:30:28 INFO - PROCESS | 1644 | __end_tp_report 18:30:28 INFO - PROCESS | 1644 | __start_cc_report 18:30:28 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,414 18:30:28 INFO - PROCESS | 1644 | __end_cc_report 18:30:28 INFO - PROCESS | 1644 | __startTimestamp1486175428151__endTimestamp 18:30:28 INFO - PROCESS | 1644 | 18:30:28 INFO - PROCESS | 1644 | ------- Summary: start ------- 18:30:28 INFO - PROCESS | 1644 | Number of tests: 6 18:30:28 INFO - PROCESS | 1644 | 18:30:28 INFO - PROCESS | 1644 | [#0] dojo.html Cycles:165 Average:5710.59 Median:5877.41 stddev:676.84 (11.5%) stddev-sans-first:652.97 18:30:28 INFO - PROCESS | 1644 | Values: 3344.5 3355.5 3376.4 3386.6 3394.7 5628.6 5695.9 5761.8 5810.4 5824.4 5621.1 5671.7 5676.1 5677.9 5744.4 4776.6 5106.1 5152.8 5160.3 5314.1 4610.3 5270.5 5314.5 5332.5 5340.4 4135.8 5153.1 5228.6 5230.3 5294.4 5182.1 5218.1 5218.1 5237.9 5242.6 5073.6 5165.3 5177.3 5203.2 5207.1 5455.8 5587.8 5611.4 5696.5 5792.5 6239.4 6289.6 6305.4 6306.1 6313.9 6297.8 6298.9 6305.6 6322.9 6323.1 5639.9 5663.0 5767.9 5795.2 5812.6 6312.7 6326.3 6336.7 6342.8 6352.5 5877.4 5939.4 6127.3 6151.6 6195.9 6257.2 6309.6 6313.4 6322.1 6340.1 6090.4 6105.3 6146.9 6161.1 6207.3 6262.6 6270.5 6281.0 6292.6 6312.6 4381.8 5005.8 5024.8 5036.9 5049.3 4325.0 4341.0 4400.9 4447.5 4492.0 5732.9 5746.3 5748.9 5775.3 5788.1 6283.8 6300.5 6310.8 6313.5 6317.6 5606.3 5633.4 5689.7 5723.4 5763.9 5412.4 5420.6 5427.3 5504.5 5527.3 6310.3 6316.4 6325.1 6338.3 6342.6 6068.4 6281.3 6292.1 6313.9 6318.3 6184.3 6251.1 6263.3 6297.2 6336.8 6159.9 6231.3 6232.3 6235.4 6239.1 5101.8 5358.6 6052.1 6102.1 6289.4 6079.5 6147.7 6153.0 6153.7 6200.1 4676.6 4990.4 6123.3 6142.9 6154.0 4861.7 5542.7 5758.4 5920.1 6022.8 6137.5 6148.6 6158.1 6168.6 6179.2 5966.8 5981.7 5987.0 6020.9 6022.3 18:30:28 INFO - PROCESS | 1644 | 18:30:28 INFO - PROCESS | 1644 | [#1] ext.html Cycles:180 Average:53297.47 Median:214842.02 stddev:106442.51 (49.5%) stddev-sans-first:106667.15 18:30:28 INFO - PROCESS | 1644 | Values: 450.6 536.5 550.4 562.8 588.5 37674.8 38515.0 40157.6 40236.6 40288.6 40811.6 41360.4 41558.0 41611.0 41655.0 7938.7 8319.5 8821.4 9360.4 9378.0 9180.1 9333.7 9404.7 9420.4 9423.4 9370.5 9433.0 9436.5 9446.7 9469.0 9345.1 9399.2 9401.7 9416.9 9427.4 9156.8 9236.2 9243.2 9252.8 9256.9 35850.9 35990.8 36385.8 36476.6 36696.6 3359.0 3944.9 3952.6 3973.8 4074.4 27973.6 28632.9 28709.9 28710.7 28855.3 2467.4 2674.0 3007.8 3104.5 3295.6 391169.0 434040.0 436870.0 444340.0 444879.0 32633.0 55101.4 56859.6 57095.4 60172.0 58129.4 58321.7 59230.0 59381.4 59417.8 15019.9 15158.4 15176.7 15187.0 15209.8 11430.0 11617.9 11648.1 11848.2 11918.3 17672.7 17816.4 17901.9 17909.5 17964.8 7939.3 8032.2 8062.8 8086.1 8086.4 858.5 862.7 869.5 870.4 887.2 30656.4 30670.0 30736.0 31048.8 31090.2 762.8 949.3 989.6 1104.4 1199.0 15698.0 15864.8 15959.1 16094.6 16621.3 189797.0 219800.0 219988.0 220203.0 220203.9 60917.4 61278.0 61606.4 61694.4 61697.8 1202.6 1378.6 1424.5 1424.8 1426.4 29118.0 29366.7 29642.4 29895.9 30840.7 51673.5 52261.5 52425.7 52434.0 52435.0 495378.0 498073.0 498084.0 498271.0 498885.0 24897.3 25619.7 25703.9 25773.0 26422.6 40952.0 41127.6 41719.3 41917.8 42109.6 30404.0 34724.7 34735.1 35518.0 36125.6 26611.5 29248.6 29346.3 32938.5 34353.8 33442.2 33709.5 33935.7 33981.5 35588.8 26868.7 27359.9 32197.0 32434.7 32517.0 20518.2 23641.1 24402.9 24454.9 24731.1 18:30:28 INFO - PROCESS | 1644 | 18:30:28 INFO - PROCESS | 1644 | [#2] jquery.html Cycles:180 Average:37565.35 Median:22938.83 stddev:107313.94 (467.8%) stddev-sans-first:107578.70 18:30:28 INFO - PROCESS | 1644 | Values: 397.9 404.7 417.6 418.3 433.2 19648.5 20248.4 20670.3 20846.5 21012.9 20500.2 20585.6 20871.2 21054.6 21183.2 5820.1 6136.7 6140.9 6141.6 6175.9 5583.8 5859.7 5996.3 6098.0 6109.1 5848.3 5990.7 5999.3 6000.8 6009.5 5865.9 5976.4 6522.0 6529.3 6544.6 5836.4 5840.0 5844.9 5845.8 5857.7 18790.6 24028.8 24312.0 25107.7 26417.2 2589.8 2898.8 2902.6 2913.9 2939.7 10194.7 10314.9 10364.7 10750.7 10819.5 1542.4 1792.6 1834.0 1850.3 1871.5 129355.4 131800.0 132263.3 139050.0 147401.0 10940.7 11185.0 11924.3 12177.7 12390.6 15805.4 15830.8 15861.4 15871.0 15881.0 8518.1 8559.0 8705.9 8747.7 8811.9 7621.4 8189.4 8303.4 8384.5 8396.2 4860.8 4914.4 4936.3 4950.9 4997.9 2048.2 2086.4 2088.1 2088.5 2096.2 991.9 1000.3 1023.4 1023.5 1034.8 20716.6 21222.7 21804.6 21831.7 21848.9 1010.4 1020.5 1040.9 1041.3 1057.3 9771.8 11246.4 11322.4 11538.7 11600.1 399566.0 503851.0 720458.0 732250.0 739534.0 132177.7 163650.0 168971.0 169011.0 169412.0 937.3 952.0 971.8 974.9 977.3 15400.0 16838.6 17825.9 19273.1 19405.3 57443.0 59796.0 60071.4 61400.1 61830.4 83409.0 89006.6 89151.0 89751.7 90619.0 6782.6 7944.3 8595.7 8656.6 8718.3 9458.8 10568.6 12822.9 13102.1 13574.9 9364.8 11170.7 11291.3 11294.8 11432.5 11035.3 11088.7 11093.0 11360.7 11577.4 11293.5 11674.8 11715.5 11735.4 11847.5 7243.3 7341.9 7559.6 7757.7 8616.0 9480.9 11296.2 11327.0 11661.5 11668.8 18:30:28 INFO - PROCESS | 1644 | 18:30:28 INFO - PROCESS | 1644 | [#3] mootools.html Cycles:180 Average:5488.76 Median:5152.01 stddev:3061.34 (59.4%) stddev-sans-first:3053.77 18:30:28 INFO - PROCESS | 1644 | Values: 1303.5 1310.5 1407.1 1443.6 1449.6 7071.3 7950.7 8299.7 8769.5 8792.6 7092.9 8638.5 8643.5 8649.7 8651.9 2041.5 2276.6 2318.2 2319.6 2330.0 2031.8 2219.5 2290.1 2308.8 2325.7 2278.8 2286.6 2305.4 2313.5 2316.2 2212.7 2260.7 2295.0 2299.3 2301.7 1956.4 2014.9 2079.3 2321.9 2382.6 8449.7 8619.1 8644.5 8726.5 8769.4 5109.7 5218.2 5271.3 5274.9 5280.3 3472.4 3488.8 3521.9 3556.6 3616.9 1207.4 1222.0 1230.9 1254.1 1273.2 11149.9 11179.4 11280.7 11299.9 11315.9 4191.9 4522.3 4552.4 4597.7 4601.4 8832.4 8966.6 8977.8 8981.9 8986.1 5163.7 5167.1 5175.2 5181.6 5194.5 4587.2 4683.8 4860.5 4861.1 4897.3 3653.1 3673.2 3759.8 3759.9 3803.6 1146.4 1158.5 1158.7 1165.0 1165.6 856.9 861.2 863.1 874.6 900.3 5174.5 5627.9 5689.1 5914.7 6004.6 726.6 973.2 974.3 981.7 1029.2 3567.8 3634.9 3764.8 3841.9 3842.2 10124.0 10426.9 10488.3 10500.7 10510.1 10120.1 10140.8 10266.6 10445.5 10459.2 8062.4 8155.8 8161.1 8174.3 8194.1 5497.4 5534.2 5609.1 5628.0 5680.6 9129.4 9318.7 9470.4 9543.8 9655.7 9182.9 9689.3 9690.9 9737.0 9871.5 7318.9 7339.9 7371.6 7385.7 7431.1 7939.9 8021.3 8066.8 8115.0 8161.3 6077.8 6241.1 6987.0 7172.6 7345.4 7148.4 7197.6 7219.3 7239.5 7311.5 6390.3 6404.3 6407.1 6469.6 6470.8 4349.9 4978.3 5022.7 5028.9 5140.3 4382.5 4638.9 4946.3 5046.4 5214.6 18:30:28 INFO - PROCESS | 1644 | 18:30:28 INFO - PROCESS | 1644 | [#4] prototype.html Cycles:180 Average:4629.00 Median:5240.41 stddev:1445.06 (27.6%) stddev-sans-first:1413.19 18:30:28 INFO - PROCESS | 1644 | Values: 362.2 363.8 369.9 371.9 373.5 4887.6 5358.0 5403.8 5442.2 5549.9 4715.0 4726.5 4743.8 5430.5 5481.9 3931.8 4008.8 4084.8 4125.9 4175.2 3299.7 3311.8 3827.7 4171.8 4238.7 3958.4 4189.1 4200.2 4206.1 4226.9 3826.3 4052.4 4155.9 4196.4 4218.9 3526.3 3544.3 3556.2 3574.0 3584.6 4812.9 5082.9 5356.5 5397.7 5411.8 4201.6 4545.3 4635.1 4792.4 4794.5 5392.3 5664.9 5733.0 5757.3 5803.4 3286.5 3952.2 3970.7 3985.5 4004.0 5352.8 5472.5 5686.9 6155.1 6169.2 3584.4 3836.2 3900.7 3939.7 3962.5 3706.4 3969.3 3985.5 3993.3 4030.3 4113.8 4389.5 4421.1 4681.9 4698.6 5370.4 5569.4 5718.5 5838.5 5944.9 1237.1 1296.7 1299.6 1301.2 1307.7 724.5 768.4 770.6 838.0 885.0 4353.3 4646.2 5141.8 5217.6 5226.9 5206.8 5474.2 5545.9 5600.3 5678.9 4710.6 4883.3 5052.4 5138.9 5143.7 2716.1 2800.6 2885.9 2927.8 3004.9 5944.5 5959.3 5972.7 5983.7 5985.4 4881.9 5316.4 5612.7 6140.4 6167.5 5426.3 6013.8 6077.5 6174.5 6209.1 5253.9 5563.8 5832.5 5961.7 6096.8 4731.6 5177.1 5485.0 5805.6 5927.4 5758.8 6175.7 6224.0 6320.0 6332.7 3994.5 4028.5 4037.9 4047.6 4056.3 5794.2 5950.3 5999.9 6009.6 6040.9 5338.6 5377.9 5623.7 5820.6 5969.3 4866.8 5330.6 5858.4 5894.9 5903.2 5259.9 5462.4 5592.5 5645.3 5715.5 5454.7 5785.4 5839.8 5876.6 5891.3 5270.2 5361.4 5608.0 5612.3 5758.4 18:30:28 INFO - PROCESS | 1644 | 18:30:28 INFO - PROCESS | 1644 | [#5] yui.html Cycles:180 Average:19411.80 Median:48011.00 stddev:27043.37 (56.3%) stddev-sans-first:27082.76 18:30:28 INFO - PROCESS | 1644 | Values: 707.3 708.3 781.7 785.2 826.1 14666.9 15341.7 15426.8 15429.0 15512.4 14186.6 14362.6 14374.2 14385.3 14395.1 870.2 875.6 892.5 899.5 902.4 885.5 886.1 886.6 886.9 887.6 933.4 941.9 942.9 943.0 943.7 925.8 932.8 938.2 939.5 940.9 695.4 696.2 697.1 698.1 699.5 15203.9 15506.9 15709.8 15726.6 15773.5 13834.7 14002.7 14069.8 14208.4 14210.3 8844.5 9516.8 11855.3 11867.6 11919.9 3305.3 3570.1 3635.9 3673.2 3843.9 91810.0 95101.5 95169.5 96115.0 96712.0 8085.3 9186.5 10310.3 10595.7 10791.8 19379.2 20499.4 21751.0 22023.3 22115.7 7489.4 7563.2 7622.4 7630.5 7723.7 4013.2 4081.6 4102.1 4112.6 4118.4 3678.4 3749.8 3755.6 3789.2 3797.7 574.5 674.1 676.3 679.8 691.3 653.3 663.6 694.4 696.8 714.2 8021.0 9907.9 9916.3 10053.1 10297.9 545.7 552.7 561.9 582.5 722.2 4504.8 4975.6 4982.5 4994.5 5008.4 94806.0 98430.5 99064.0 99342.0 101140.5 53362.7 61700.7 86211.6 88593.0 89489.6 71436.0 72152.6 72729.9 73174.3 74153.6 10093.5 10775.2 10782.5 10833.7 11072.2 47427.0 47582.0 48440.0 48754.1 49023.3 64258.7 65099.0 65648.7 66852.7 67284.7 12841.2 12852.2 12976.5 13032.4 13308.2 14384.6 14389.7 14614.4 14670.0 15353.1 13511.6 13617.9 13620.7 13829.2 14208.9 13773.4 13819.7 13997.9 14043.9 14113.3 12914.9 13188.5 13548.8 13728.0 14018.5 10421.7 10732.6 10939.4 10958.3 11269.7 9021.1 10814.9 10874.0 10917.5 10974.1 18:30:28 INFO - PROCESS | 1644 | -------- Summary: end -------- 18:30:28 INFO - PROCESS | 1644 | 18:30:28 INFO - TEST-INFO | 1644: exit 0 18:30:28 INFO - TEST-OK | dromaeo_css | took 1114832ms 18:30:28 INFO - TEST-START | kraken 18:30:28 INFO - operating with platform_type : mac_ 18:30:28 INFO - Initialising browser for kraken test... 18:30:28 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmpMKZfIV/profile http://localhost:49236/getInfo.html) 18:30:31 INFO - PROCESS | 1652 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 18:30:31 INFO - PROCESS | 1652 | 2017-02-03 18:30:31.524 plugin-container[1653:9913] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.tsm.portname' 18:30:31 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:30:31 INFO - PROCESS | 1652 | 2017-02-03 18:30:31.527 plugin-container[1653:9913] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8947, name = 'com.apple.CFPasteboardClient' 18:30:31 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:30:31 INFO - PROCESS | 1652 | 2017-02-03 18:30:31.527 plugin-container[1653:9913] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:30:31 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 18:30:31 INFO - PROCESS | 1652 | colorDepth:24 18:30:31 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 18:30:31 INFO - PROCESS | 1652 | __metrics 18:30:31 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 18:30:31 INFO - PROCESS | 1652 | 1486175431676 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < forceQuit@jar:file:///var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmpMKZfIV/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmpMKZfIV/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmpMKZfIV/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmpMKZfIV/profile/extensions/talos-powers@TalosPowersService.js:55:9 18:30:32 INFO - TEST-INFO | 1652: exit 0 18:30:32 INFO - Browser initialized. 18:30:32 INFO - Running cycle 1/1 for kraken test... 18:30:32 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmpMKZfIV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:30:34 INFO - PROCESS | 1654 | 2017-02-03 18:30:34.983 plugin-container[1655:10030] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4537, name = 'com.apple.tsm.portname' 18:30:34 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:30:34 INFO - PROCESS | 1654 | 2017-02-03 18:30:34.984 plugin-container[1655:10030] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 18:30:34 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:30:34 INFO - PROCESS | 1654 | 2017-02-03 18:30:34.984 plugin-container[1655:10030] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:30:44 INFO - PROCESS | 1654 | RSS: Main: 233480192 18:30:44 INFO - PROCESS | 1654 | 18:30:47 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 18:30:48 INFO - PROCESS | 1654 | RSS: Main: 246988800 18:30:48 INFO - PROCESS | 1654 | 18:30:51 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 18:30:52 INFO - PROCESS | 1654 | RSS: Main: 254914560 18:30:52 INFO - PROCESS | 1654 | 18:30:55 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 18:30:56 INFO - PROCESS | 1654 | RSS: Main: 257564672 18:30:56 INFO - PROCESS | 1654 | 18:30:58 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 18:30:59 INFO - PROCESS | 1654 | RSS: Main: 258777088 18:30:59 INFO - PROCESS | 1654 | 18:31:01 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:31:01 INFO - PROCESS | 1654 | RSS: Main: 259141632 18:31:01 INFO - PROCESS | 1654 | 18:31:04 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 18:31:05 INFO - PROCESS | 1654 | RSS: Main: 265891840 18:31:05 INFO - PROCESS | 1654 | 18:31:08 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 18:31:08 INFO - PROCESS | 1654 | RSS: Main: 265695232 18:31:08 INFO - PROCESS | 1654 | 18:31:12 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 18:31:12 INFO - PROCESS | 1654 | RSS: Main: 265515008 18:31:12 INFO - PROCESS | 1654 | 18:31:14 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:31:15 INFO - PROCESS | 1654 | RSS: Main: 264851456 18:31:15 INFO - PROCESS | 1654 | 18:31:17 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:31:17 INFO - PROCESS | 1654 | RSS: Main: 264806400 18:31:17 INFO - PROCESS | 1654 | 18:31:20 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:31:20 INFO - PROCESS | 1654 | RSS: Main: 264859648 18:31:20 INFO - PROCESS | 1654 | 18:31:23 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:31:24 INFO - PROCESS | 1654 | RSS: Main: 265224192 18:31:24 INFO - PROCESS | 1654 | 18:31:27 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:31:28 INFO - PROCESS | 1654 | RSS: Main: 265285632 18:31:28 INFO - PROCESS | 1654 | 18:31:29 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 18:31:30 INFO - PROCESS | 1654 | RSS: Main: 268353536 18:31:30 INFO - PROCESS | 1654 | 18:31:30 INFO - PROCESS | 1654 | __start_tp_report 18:31:30 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 18:31:30 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 18:31:30 INFO - PROCESS | 1654 | |i|pagename|runs| 18:31:30 INFO - PROCESS | 1654 | |0;ai-astar;110;130;175;142;173;151;118;118;118;118 18:31:30 INFO - PROCESS | 1654 | |1;audio-beat-detection;148;102;131;192;149;122;149;152;135;148 18:31:30 INFO - PROCESS | 1654 | |2;audio-dft;213;213;200;194;199;185;203;230;282;232 18:31:30 INFO - PROCESS | 1654 | |3;audio-fft;71;73;84;103;50;81;51;74;66;52 18:31:30 INFO - PROCESS | 1654 | |4;audio-oscillator;88;74;86;75;92;59;68;71;100;87 18:31:30 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;82;128;137;106;90;87;91;87;89;87 18:31:30 INFO - PROCESS | 1654 | |6;imaging-darkroom;97;97;95;105;96;95;97;96;120;154 18:31:30 INFO - PROCESS | 1654 | |7;imaging-desaturate;92;96;95;137;150;120;88;143;152;102 18:31:30 INFO - PROCESS | 1654 | |8;json-parse-financial;55;65;94;102;103;84;64;66;65;63 18:31:30 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;70;74;74;75;72;69;71;66;72;72 18:31:30 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;102;81;104;104;119;80;79;75;100;114 18:31:30 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;147;160;156;162;142;151;142;152;211;177 18:31:30 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;174;176;174;170;178;173;173;177;173;179 18:31:30 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;68;70;67;69;68;69;68;68;67;67 18:31:30 INFO - PROCESS | 1654 | __end_tp_report 18:31:30 INFO - PROCESS | 1654 | __start_cc_report 18:31:30 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1016 18:31:30 INFO - PROCESS | 1654 | __end_cc_report 18:31:30 INFO - PROCESS | 1654 | __startTimestamp1486175490049__endTimestamp 18:31:30 INFO - PROCESS | 1654 | 18:31:30 INFO - PROCESS | 1654 | ------- Summary: start ------- 18:31:30 INFO - PROCESS | 1654 | Number of tests: 14 18:31:30 INFO - PROCESS | 1654 | 18:31:30 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:135.30 Median:136.00 stddev:23.93 (17.6%) stddev-sans-first:23.57 18:31:30 INFO - PROCESS | 1654 | Values: 110.0 130.0 175.0 142.0 173.0 151.0 118.0 118.0 118.0 118.0 18:31:30 INFO - PROCESS | 1654 | 18:31:30 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:142.80 Median:148.50 stddev:23.41 (15.8%) stddev-sans-first:24.76 18:31:30 INFO - PROCESS | 1654 | Values: 148.0 102.0 131.0 192.0 149.0 122.0 149.0 152.0 135.0 148.0 18:31:30 INFO - PROCESS | 1654 | 18:31:30 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:215.10 Median:213.00 stddev:27.84 (13.1%) stddev-sans-first:29.52 18:31:30 INFO - PROCESS | 1654 | Values: 213.0 213.0 200.0 194.0 199.0 185.0 203.0 230.0 282.0 232.0 18:31:30 INFO - PROCESS | 1654 | 18:31:30 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:70.50 Median:72.00 stddev:16.77 (23.3%) stddev-sans-first:17.78 18:31:30 INFO - PROCESS | 1654 | Values: 71.0 73.0 84.0 103.0 50.0 81.0 51.0 74.0 66.0 52.0 18:31:30 INFO - PROCESS | 1654 | 18:31:30 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:80.00 Median:80.50 stddev:12.56 (15.6%) stddev-sans-first:12.99 18:31:30 INFO - PROCESS | 1654 | Values: 88.0 74.0 86.0 75.0 92.0 59.0 68.0 71.0 100.0 87.0 18:31:30 INFO - PROCESS | 1654 | 18:31:30 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:98.40 Median:87.00 stddev:19.14 (22.0%) stddev-sans-first:19.36 18:31:30 INFO - PROCESS | 1654 | Values: 82.0 128.0 137.0 106.0 90.0 87.0 91.0 87.0 89.0 87.0 18:31:30 INFO - PROCESS | 1654 | 18:31:30 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:105.20 Median:96.00 stddev:18.80 (19.6%) stddev-sans-first:19.70 18:31:30 INFO - PROCESS | 1654 | Values: 97.0 97.0 95.0 105.0 96.0 95.0 97.0 96.0 120.0 154.0 18:31:30 INFO - PROCESS | 1654 | 18:31:30 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:117.50 Median:120.00 stddev:25.85 (21.5%) stddev-sans-first:25.71 18:31:30 INFO - PROCESS | 1654 | Values: 92.0 96.0 95.0 137.0 150.0 120.0 88.0 143.0 152.0 102.0 18:31:30 INFO - PROCESS | 1654 | 18:31:30 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:76.10 Median:65.00 stddev:17.92 (27.6%) stddev-sans-first:17.30 18:31:30 INFO - PROCESS | 1654 | Values: 55.0 65.0 94.0 102.0 103.0 84.0 64.0 66.0 65.0 63.0 18:31:30 INFO - PROCESS | 1654 | 18:31:30 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:72.00 stddev:2.68 (3.7%) stddev-sans-first:2.78 18:31:30 INFO - PROCESS | 1654 | Values: 70.0 74.0 74.0 75.0 72.0 69.0 71.0 66.0 72.0 72.0 18:31:30 INFO - PROCESS | 1654 | 18:31:30 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:95.80 Median:97.00 stddev:15.79 (16.3%) stddev-sans-first:16.59 18:31:30 INFO - PROCESS | 1654 | Values: 102.0 81.0 104.0 104.0 119.0 80.0 79.0 75.0 100.0 114.0 18:31:30 INFO - PROCESS | 1654 | 18:31:30 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:160.00 Median:158.00 stddev:20.74 (13.1%) stddev-sans-first:21.46 18:31:30 INFO - PROCESS | 1654 | Values: 147.0 160.0 156.0 162.0 142.0 151.0 142.0 152.0 211.0 177.0 18:31:30 INFO - PROCESS | 1654 | 18:31:30 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.70 Median:175.00 stddev:2.75 (1.6%) stddev-sans-first:2.91 18:31:30 INFO - PROCESS | 1654 | Values: 174.0 176.0 174.0 170.0 178.0 173.0 173.0 177.0 173.0 179.0 18:31:30 INFO - PROCESS | 1654 | 18:31:30 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:0.99 (1.5%) stddev-sans-first:1.05 18:31:30 INFO - PROCESS | 1654 | Values: 68.0 70.0 67.0 69.0 68.0 69.0 68.0 68.0 67.0 67.0 18:31:30 INFO - PROCESS | 1654 | -------- Summary: end -------- 18:31:30 INFO - PROCESS | 1654 | 18:31:30 INFO - TEST-INFO | 1654: exit 0 18:31:30 INFO - TEST-OK | kraken | took 62133ms 18:31:30 INFO - SUITE-END | took 1176s 18:31:31 INFO - Completed test suite (00:19:37) 18:31:31 INFO - javascript benchmark 18:31:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7227.347500974124, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3344.4983252512125, 3355.513450549669, 3376.4428869236576, 3386.6274709781933, 3394.677505636964, 5628.577856660746, 5695.943040569593, 5761.827145185646, 5810.360860305363, 5824.359320474744, 5621.072523033695, 5671.6880571568545, 5676.120201368794, 5677.914831277534, 5744.396838331978, 4776.604710775532, 5106.106431374495, 5152.793888244466, 5160.303359046518, 5314.123169676998, 4610.3315019322345, 5270.525652691257, 5314.4951229633125, 5332.546733527654, 5340.412554619008, 4135.834566617332, 5153.098207813637, 5228.607854410934, 5230.320058392384, 5294.364676238876, 5182.119039763249, 5218.086834803894, 5218.13900706383, 5237.869053273661, 5242.580593552545, 5073.568746656539, 5165.328507294028, 5177.326947496839, 5203.16749320107, 5207.140821764404, 5455.809046683347, 5587.832365029056, 5611.438856114397, 5696.544276457874, 5792.478676919055, 6239.37606239377, 6289.622622642656, 6305.4009869062365, 6306.1486699295465, 6313.87372252557, 6297.779577714804, 6298.905516417258, 6305.59013664115, 6322.9051564226575, 6323.05154226865, 5639.943600563983, 5662.971685141589, 5767.913481297784, 5795.246617939725, 5812.59311848175, 6312.652804095727, 6326.304106548276, 6336.6831658416895, 6342.841428964312, 6352.523560732963, 5877.412258774174, 5939.4357536034, 6127.342242870382, 6151.630902145886, 6195.876082478325, 6257.155284036597, 6309.621422714652, 6313.3686631336495, 6322.083297921776, 6340.144080549159, 6090.36051214625, 6105.338445949952, 6146.924288249538, 6161.137440758297, 6207.34822843604, 6262.5616206866, 6270.49836013127, 6280.9685951569945, 6292.590981586182, 6312.5581209314905, 4381.759003254851, 5005.799768009311, 5024.79900803971, 5036.924446133311, 5049.318342023853, 4324.956750432519, 4341.001569639001, 4400.867973960786, 4447.466304043471, 4491.955080449219, 5732.914006289909, 5746.339170995389, 5748.913766293509, 5775.306963164448, 5788.131780232999, 6283.8114856554375, 6300.527460440394, 6310.8422289442215, 6313.463355614732, 6317.6209427434505, 5606.299212598426, 5633.436656334416, 5689.743961521742, 5723.399043100415, 5763.88472230553, 5412.404635490093, 5420.620556561082, 5427.3215848019, 5504.532114770209, 5527.309086364205, 6310.2743184534365, 6316.368363163647, 6325.14610527582, 6338.30278669346, 6342.556021078481, 6068.362821903636, 6281.309056003744, 6292.114730962512, 6313.90529142054, 6318.273398559225, 6184.257889053342, 6251.093591429127, 6263.311035786151, 6297.1813664223355, 6336.778212762531, 6159.938400616115, 6231.345708700521, 6232.345603711545, 6235.407636274728, 6239.126522286792, 5101.775573862321, 5358.598105142208, 6052.0921861719335, 6102.145699601971, 6289.371062893674, 6079.483243924316, 6147.692615369303, 6152.98475751496, 6153.692315384303, 6200.131981522501, 4676.55572720591, 4990.426100998432, 6123.2958209804665, 6142.9078563820685, 6154.046122850965, 4861.6596838220985, 5542.722863856871, 5758.395368486249, 5920.111983202554, 6022.759089636365, 6137.539684523768, 6148.569600127948, 6158.137860699595, 6168.568200225941, 6179.227596550431, 5966.76132954677, 5981.671008094597, 5987.0, 6020.909686354796, 6022.307434645072], "value": 5667.699688783202, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [450.6237291861296, 536.5466181076991, 550.3670778604604, 562.7580140539568, 588.5056552495903, 37674.81162594187, 38515.03712407191, 40157.59842401575, 40236.59763402365, 40288.59711402889, 40811.59188408122, 41360.37959430603, 41558.0, 41610.99999999993, 41655.0, 7938.722144724936, 8319.500829950191, 8821.38250322476, 9360.4383736976, 9377.953110234474, 9180.0819918008, 9333.719988400326, 9404.670836520723, 9420.3985322495, 9423.387479813824, 9370.484623345714, 9433.009533998935, 9436.528173591327, 9446.716598502022, 9469.0, 9345.112214339626, 9399.24806015524, 9401.717948461488, 9416.858747118798, 9427.434353938786, 9156.816863662756, 9236.168744812932, 9243.214326782232, 9252.814943701089, 9256.8611470828, 35850.92447226588, 35990.8200458996, 36385.81807090974, 36476.63523364759, 36696.63303366959, 3358.9664103358896, 3944.881653550398, 3952.5849785772657, 3973.8211780469946, 4074.388841673743, 27973.580396294074, 28632.856835715895, 28709.85645071782, 28710.71289287101, 28855.278618034507, 2467.4448249143798, 2673.957156708885, 3007.7593792496546, 3104.5343198520177, 3295.571575695168, 391169.0, 434040.0, 436870.0, 444340.0, 444879.0, 32633.0, 55101.38783345944, 56859.57851053757, 57095.42904570984, 60171.991400429804, 58129.4187058124, 58321.708391457774, 59230.0, 59381.40618593759, 59417.81164376688, 15019.924900375647, 15158.393664253526, 15176.696466070616, 15187.0, 15209.771853422208, 11430.028447582048, 11617.88382116168, 11648.126390520745, 11848.229865058744, 11918.344491053076, 17672.734908976374, 17816.376426824998, 17901.910490447466, 17909.492671026066, 17964.820351796578, 7939.28546430824, 8032.156623554442, 8062.7581172564915, 8086.110527841933, 8086.433949623588, 858.4849090545747, 862.7357648598688, 869.4870026684287, 870.3863776037878, 887.1837909123493, 30656.38687226243, 30670.0, 30736.0, 31048.844755776077, 31090.22274443157, 762.7528990101224, 949.3164921256684, 989.5992123190119, 1104.3815463340554, 1199.0467578275293, 15698.0, 15864.841351586567, 15959.061407888168, 16094.597635059217, 16621.335146594243, 189797.0, 219800.0, 219988.0, 220203.0, 220203.89898050408, 60917.39082609117, 61278.0, 61606.38393616006, 61694.38305616887, 61697.76604467975, 1202.6331968749441, 1378.6415531961761, 1424.5156646740159, 1424.8076509671268, 1426.436557559758, 29117.980870669424, 29366.706332936395, 29642.407151857275, 29895.850520747255, 30840.691593083782, 51673.48326516837, 52261.51254118263, 52425.737871311925, 52434.0, 52434.95130097301, 495378.0, 498073.0, 498084.0, 498271.0, 498885.0, 24897.25308240756, 25619.743802561738, 25703.871480643225, 25773.0, 26422.60366094472, 40952.0, 41127.58872411357, 41719.331226751805, 41917.79041104775, 42109.57890421057, 30404.0, 34724.65275347214, 34735.13162170966, 35518.0, 36125.63874361328, 26611.467770644093, 29248.56127158052, 29346.266343340732, 32938.50592241166, 34353.797617083284, 33442.16394590155, 33709.49435758514, 33935.66064339325, 33981.49027764635, 35588.822055889555, 26868.73131268662, 27359.905603775627, 32197.0, 32434.675653243165, 32517.0, 20518.17927282892, 23641.054357825495, 24402.87798561067, 24454.899529521572, 24731.13441029555], "value": 18453.955280541497, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.8846134620962, 404.69445568595705, 417.6262245290465, 418.3494665794689, 433.1856110512239, 19648.50878728031, 20248.392548223575, 20670.30536353156, 20846.478838029056, 21012.89493552532, 20500.17999280027, 20585.588288234263, 20871.165153393846, 21054.578908421823, 21183.152673893026, 5820.068788993773, 6136.693165341738, 6140.938590614103, 6141.570090093695, 6175.907361389583, 5583.776648934037, 5859.707014649251, 5996.2504686914135, 6097.969510152443, 6109.14471973924, 5848.298204215479, 5990.700464976756, 5999.310079340867, 6000.789972350969, 6009.489193418564, 5865.944130056588, 5976.432238937294, 6521.967390163042, 6529.2817790043055, 6544.640044797534, 5836.445537673914, 5840.0, 5844.912326315109, 5845.766169353221, 5857.736401861926, 18790.624187516172, 24028.759712402825, 24312.027518899224, 25107.748922510724, 26417.207483775517, 2589.8216311578376, 2898.7680985521106, 2902.5646153076996, 2913.907284768212, 2939.6766355700856, 10194.694159175237, 10314.850324388286, 10364.740881477948, 10750.677479675622, 10819.459027048617, 1542.406173623152, 1792.5518620344915, 1834.0, 1850.2506484873647, 1871.4853415310763, 129355.35322323423, 131800.0, 132263.33868330694, 139050.0, 147401.0, 10940.741814691253, 11185.049270811909, 11924.284542927453, 12177.69555761113, 12390.62828115158, 15805.36778528869, 15830.76253856193, 15861.444849430214, 15870.968387054805, 15881.0, 8518.063013068557, 8559.0, 8705.869411958825, 8747.737567872973, 8811.867821982676, 7621.352185064221, 8189.385796065319, 8303.418760686814, 8384.53885036329, 8396.160383961555, 4860.829870954571, 4914.410270767459, 4936.308916751657, 4950.851474455772, 4997.85006449807, 2048.201201531404, 2086.35323049852, 2088.1125521653235, 2088.457001179704, 2096.2243969730994, 991.8710567626163, 1000.284796370584, 1023.4013102335068, 1023.5445226873969, 1034.8447732839984, 20716.58566828655, 21222.681659775117, 21804.563908722055, 21831.672524912137, 21848.907554622205, 1010.3735683876043, 1020.4948550467566, 1040.9115225205792, 1041.3023274406166, 1057.3127467146262, 9771.804563908825, 11246.381449020218, 11322.433878306052, 11538.711532211593, 11600.071994240441, 399566.0, 503851.0, 720458.0, 732250.0, 739534.0, 132177.67822321845, 163650.0, 168971.0, 169011.0, 169412.0, 937.3110763588757, 951.9762005949907, 971.820213260549, 974.9415035097917, 977.2621670638622, 15400.0, 16838.57903552421, 17825.910870445565, 19273.132709028407, 19405.32081377145, 57443.0, 59796.0, 60071.39928600658, 61400.078998815945, 61830.38169618246, 83409.0, 89006.55496722474, 89151.0, 89751.65372519549, 90619.0, 6782.626955517494, 7944.285014348505, 8595.699150529701, 8656.567171641518, 8718.346124040596, 9458.763530911507, 10568.630097946534, 12822.87177128254, 13102.082854200115, 13574.914006879624, 9364.812703746024, 11170.664880053286, 11291.322520648788, 11294.830577541508, 11432.485538150637, 11035.337879727242, 11088.667339979813, 11093.0, 11360.659180224606, 11577.421128943688, 11293.548258069584, 11674.824877627012, 11715.531378744754, 11735.418207994227, 11847.466863990969, 7243.311885370881, 7341.889871652036, 7559.622018899143, 7757.65090570937, 8616.0, 9480.905190948002, 11296.209265351346, 11327.037201837937, 11661.533538658698, 11668.824967625662], "value": 9961.852055402234, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1303.4981532110146, 1310.4627102887816, 1407.064302239011, 1443.5885772554825, 1449.6448370149312, 7071.328223818729, 7950.721724739636, 8299.709510167146, 8769.517676527788, 8792.604332805024, 7092.893606595892, 8638.524881131536, 8643.524606146659, 8649.697260595865, 8651.87022194666, 2041.540653352991, 2276.6015947209253, 2318.2349824557855, 2319.5940710375703, 2329.9631663909568, 2031.8113903366548, 2219.4784225706944, 2290.1297506947335, 2308.803751681109, 2325.686032385623, 2278.7835155660187, 2286.6455699366625, 2305.4236440889777, 2313.456337760625, 2316.177756896303, 2212.7344718633867, 2260.706108205939, 2295.0360848443693, 2299.298713892254, 2301.746807851135, 1956.432634535983, 2014.939551813448, 2079.2930403662826, 2321.872297023663, 2382.60686986647, 8449.662013519452, 8619.094995025558, 8644.524551149685, 8726.476411415271, 8769.386142969995, 5109.718965456898, 5218.165093585046, 5271.262023316739, 5274.894502109936, 5280.313559237313, 3472.44440889459, 3488.7906725596545, 3521.9295614087573, 3556.590992035923, 3616.8914932552066, 1207.4445754952733, 1221.9816702749465, 1230.9322987235698, 1254.0907841814703, 1273.1533530202405, 11149.944250278777, 11179.385133817637, 11280.717982050432, 11299.887001129884, 11315.924987126209, 4191.8532851350055, 4522.321651752263, 4552.408186935677, 4597.747123908151, 4601.378813860153, 8832.381733278737, 8966.551672416354, 8977.787998620102, 8981.910180898238, 8986.14631609996, 5163.715995620277, 5167.147420675622, 5175.171972484384, 5181.611379146579, 5194.454582268883, 4587.17430862448, 4683.789229484613, 4860.4896485869185, 4861.052094841472, 4897.314375987365, 3653.0684675408133, 3673.246984368198, 3759.755615884959, 3759.887203383903, 3803.6196380361744, 1146.3694967767694, 1158.4960542164185, 1158.6987383280407, 1165.0, 1165.580391059218, 856.9314454843598, 861.2291998661289, 863.1239292118505, 874.5539774714814, 900.3292547052488, 5174.508421699932, 5627.915581266284, 5689.118186681071, 5914.6746928918465, 6004.609700369462, 726.5785844210345, 973.245734555725, 974.34718738444, 981.6809536900536, 1029.2332212501733, 3567.7502574819514, 3634.945475817865, 3764.8305826237884, 3841.8847434577006, 3842.2315536892734, 10124.0, 10426.895731042745, 10488.26582139243, 10500.737481563023, 10510.106640935453, 10120.089191972758, 10140.847887281549, 10266.589336426608, 10445.477726113664, 10459.163266938627, 8062.435629505878, 8155.836883262302, 8161.061477929995, 8174.3051840593025, 8194.139615340422, 5497.39528651856, 5534.225208470737, 5609.074502707008, 5627.971860140673, 5680.573956953328, 9129.406588571721, 9318.72043838686, 9470.384425012353, 9543.761405964906, 9655.710328690151, 9182.908170918205, 9689.273304502332, 9690.903090969001, 9736.95131524338, 9871.50642467888, 7318.926810731825, 7339.853202935805, 7371.631418429164, 7385.741499047507, 7431.108267007994, 7939.920600794149, 8021.27808497238, 8066.7579972600915, 8115.0, 8161.347092232726, 6077.756889724362, 6241.095041219089, 6986.9650651746415, 7172.641367931478, 7345.449091318279, 7148.356647901714, 7197.568145911262, 7219.278072192738, 7239.457040722073, 7311.488195826454, 6390.297067322684, 6404.295527491879, 6407.10300557913, 6469.644169570531, 6470.773522926675, 4349.934750978675, 4978.303037574815, 5022.673526220784, 5028.874278142929, 5140.30605868203, 4382.539833317455, 4638.9330453996445, 4946.332245146859, 5046.369203849519, 5214.634975551827], "value": 4421.576047972254, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.2483347054862, 363.78536663368607, 369.8982779735571, 371.91260053887333, 373.51256610123795, 4887.633427492939, 5357.973210133953, 5403.8108666196695, 5442.1836724491295, 5549.864326655437, 4715.0098479319295, 4726.527347265272, 4743.833965811197, 5430.5384042356345, 5481.890362192754, 3931.8034098295116, 4008.8196031178522, 4084.774567629714, 4125.876223713293, 4175.206710724952, 3299.703026727594, 3311.8344082795884, 3827.674647654953, 4171.791410429481, 4238.660907127438, 3958.406239064149, 4189.05746207104, 4200.151933149405, 4206.128272918552, 4226.9154616907645, 3826.349520581508, 4052.371882358239, 4155.875323740278, 4196.391523229115, 4218.873433796991, 3526.2771131917893, 3544.3088597723454, 3556.2176321209295, 3574.0, 3584.605693373727, 4812.941152946346, 5082.872928176788, 5356.491133342326, 5397.704550907793, 5411.783528658849, 4201.626081264076, 4545.250033744428, 4635.096156249533, 4792.448868380111, 4794.5205479452125, 5392.272043274147, 5664.862273535375, 5733.0, 5757.286550175156, 5803.448672376117, 3286.457734473809, 3952.170044290702, 3970.724152574138, 3985.5416627087966, 4003.979980100081, 5352.812651557177, 5472.452754724535, 5686.914696279559, 6155.138280640714, 6169.198004259462, 3584.426491761306, 3836.1778155376533, 3900.7464514807016, 3939.7045221608496, 3962.473398675181, 3706.4440333949583, 3969.2656858480696, 3985.4818873546255, 3993.341098718679, 4030.274550580865, 4113.799117472138, 4389.495208051051, 4421.093675796454, 4681.899753557911, 4698.577128058491, 5370.355557333145, 5569.387367389584, 5718.513926316226, 5838.511179649247, 5944.851378715567, 1237.1401875696304, 1296.6758310422395, 1299.6490947444138, 1301.1542497376781, 1307.7384523095418, 724.4675163754636, 768.4352001279055, 770.5723323555369, 837.9832403351899, 885.0132102705566, 4353.25994580922, 4646.233371493733, 5141.794328226903, 5217.6086793489885, 5226.92159617606, 5206.7917283309, 5474.151506516497, 5545.889082218414, 5600.327960644749, 5678.858028549319, 4710.552497512731, 4883.34074899891, 5052.368453943257, 5138.922916156261, 5143.691378517301, 2716.0901098131953, 2800.571708428716, 2885.9422811544073, 2927.780416468773, 3004.9482681061454, 5944.464998150187, 5959.348090099864, 5972.65615236577, 5983.730732117066, 5985.431384018511, 4881.900782663418, 5316.441773613715, 5612.663240205601, 6140.3552626974415, 6167.506599472032, 5426.321709786277, 6013.767177728555, 6077.513798896078, 6174.536909731788, 6209.143793854697, 5253.894922101613, 5563.833085007456, 5832.533397328289, 5961.721053420688, 6096.756129754937, 4731.574158325767, 5177.08447874289, 5485.0, 5805.622634528742, 5927.377625349276, 5758.827235182951, 6175.6912154393, 6223.97720740752, 6319.96840015797, 6332.746690132343, 3994.540627827837, 4028.469181710931, 4037.9394309085974, 4047.6357127858632, 4056.290149223815, 5794.24773232728, 5950.285965684146, 5999.940000599938, 6009.639421634716, 6040.939590604038, 5338.57291416678, 5377.892442151213, 5623.69428534299, 5820.5925585210325, 5969.343372228965, 4866.756662166948, 5330.573554115739, 5858.384869588632, 5894.911576326273, 5903.2325797646035, 5259.949838624314, 5462.426445223195, 5592.524635406036, 5645.266115404971, 5715.542097031236, 5454.672719636835, 5785.3636100028125, 5839.766409343749, 5876.559258055578, 5891.293044834647, 5270.183121616155, 5361.410244872983, 5608.0, 5612.270404847343, 5758.445219790717], "value": 4171.989965054045, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.3386383731215, 708.2563308526046, 781.679511400326, 785.2187073861506, 826.0847954669713, 14666.926665366671, 15341.69316613667, 15426.845731542695, 15429.0, 15512.379504819808, 14186.645333866658, 14362.569122926303, 14374.20941848198, 14385.280735963186, 14395.06432081914, 870.2385412763832, 875.6103533927405, 892.5001998880615, 899.5232526760827, 902.4089221559889, 885.4864178776327, 886.0784783824814, 886.5921676029035, 886.9201771840533, 887.609451841191, 933.3606479561488, 941.8822647169104, 942.9481378524179, 943.0004195552701, 943.7310366545536, 925.8194652042854, 932.7947851472666, 938.2072149034055, 939.4551160326994, 940.8870935487786, 695.3602685529326, 696.195893742728, 697.1425147069083, 698.0924797762888, 699.5173330402006, 15203.923980380026, 15506.922465387714, 15709.842901570952, 15726.606834829221, 15773.526794196192, 13834.723305533933, 14002.719945601133, 14069.788953165711, 14208.431662733477, 14210.289485525682, 8844.46933184011, 9516.762820833317, 11855.288682679067, 11867.58463453775, 11919.94040029803, 3305.3058857639926, 3570.071781336871, 3635.8545658173643, 3673.155174309897, 3843.942340864889, 91810.0, 95101.5244923771, 95169.52415237948, 96115.0, 96712.0, 8085.272325490734, 9186.549407134416, 10310.278280520291, 10595.682129536126, 10791.78416431667, 19379.224831006883, 20499.38501844947, 21751.0, 22023.33929982103, 22115.668264976037, 7489.400847932152, 7563.168051514329, 7622.428317876182, 7630.542167469969, 7723.729669461542, 4013.177298653769, 4081.5918408158946, 4102.077032667686, 4112.588741125864, 4118.423420721101, 3678.393065144221, 3749.7937613431523, 3755.6244375562223, 3789.1853251550497, 3797.715171362159, 574.4657468554285, 674.1270055278426, 676.2662511175331, 679.8368391585984, 691.2948792231996, 653.2879161713755, 663.6316844151543, 694.3958755882414, 696.8223103108675, 714.1572943926113, 8021.0, 9907.900920990698, 9916.25628077897, 10053.12098228973, 10297.897021029694, 545.7462280039721, 552.7070652554153, 561.882004779001, 582.5368831778746, 722.2344315026089, 4504.819807207675, 4975.5522003019905, 4982.476839931827, 4994.4755800640405, 5008.398992120969, 94806.0, 98430.53923651823, 99064.00935990692, 99342.0, 101140.49429752951, 53362.7331863346, 61700.69149654223, 86211.56894215614, 88593.0, 89489.55255223683, 71436.0, 72152.63923680453, 72729.90905136427, 73174.26825731674, 74153.6292318535, 10093.495325233562, 10775.245732798943, 10782.460876956278, 10833.729156771144, 11072.169587281147, 47427.0, 47582.0, 48440.0, 48754.07475551478, 49023.26465103098, 64258.678706606166, 65099.02351464827, 65648.6717566409, 66852.665736671, 67284.65430691457, 12841.229526228457, 12852.228866268053, 12976.469588430165, 13032.41354139085, 13308.201507909556, 14384.568462946128, 14389.712205755617, 14614.41542338337, 14670.0, 15353.07881527112, 13511.594652160451, 13617.931910340385, 13620.727585448038, 13829.170249785046, 14208.857911420753, 13773.449062037405, 13819.654508637364, 13997.860021399656, 14043.929780351033, 14113.264745072609, 12914.870851291367, 13188.54296388543, 13548.796768048684, 13728.0, 14018.509352172625, 10421.739456513647, 10732.635396590164, 10939.398333091756, 10958.342499450058, 11269.66191014271, 9021.06047199829, 10814.945925270324, 10874.02133807961, 10917.508712107816, 10974.122070234202], "value": 7414.3449701772, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1611.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 130.0, 175.0, 142.0, 173.0, 151.0, 118.0, 118.0, 118.0, 118.0], "value": 135.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 102.0, 131.0, 192.0, 149.0, 122.0, 149.0, 152.0, 135.0, 148.0], "value": 142.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [213.0, 213.0, 200.0, 194.0, 199.0, 185.0, 203.0, 230.0, 282.0, 232.0], "value": 215.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 84.0, 103.0, 50.0, 81.0, 51.0, 74.0, 66.0, 52.0], "value": 70.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 74.0, 86.0, 75.0, 92.0, 59.0, 68.0, 71.0, 100.0, 87.0], "value": 80.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 128.0, 137.0, 106.0, 90.0, 87.0, 91.0, 87.0, 89.0, 87.0], "value": 98.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 95.0, 105.0, 96.0, 95.0, 97.0, 96.0, 120.0, 154.0], "value": 105.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 96.0, 95.0, 137.0, 150.0, 120.0, 88.0, 143.0, 152.0, 102.0], "value": 117.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 65.0, 94.0, 102.0, 103.0, 84.0, 64.0, 66.0, 65.0, 63.0], "value": 76.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 74.0, 74.0, 75.0, 72.0, 69.0, 71.0, 66.0, 72.0, 72.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 81.0, 104.0, 104.0, 119.0, 80.0, 79.0, 75.0, 100.0, 114.0], "value": 95.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 160.0, 156.0, 162.0, 142.0, 151.0, 142.0, 152.0, 211.0, 177.0], "value": 160.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 176.0, 174.0, 170.0, 178.0, 173.0, 173.0, 177.0, 173.0, 179.0], "value": 174.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 67.0, 69.0, 68.0, 69.0, 68.0, 68.0, 67.0, 67.0], "value": 68.1, "unit": "score"}]}]} 18:31:31 INFO - Return code: 0 18:31:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:31:31 ERROR - # TBPL SUCCESS # 18:31:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:31:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:31:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:31:31 INFO - 2017-02-03 18:31:31.371 screenresolution[1659:10419] starting screenresolution argv=screenresolution get 18:31:31 INFO - 2017-02-03 18:31:31.374 screenresolution[1659:10419] Display 0: 1600x1200x32@60 18:31:31 INFO - 2017-02-03 18:31:31.380 screenresolution[1660:10422] starting screenresolution argv=screenresolution list 18:31:31 INFO - Available Modes on Display 0 18:31:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:31:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:31:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:31:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:31:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:31:31 INFO - Intel Iris: 18:31:31 INFO - Chipset Model: Intel Iris 18:31:31 INFO - Type: GPU 18:31:31 INFO - Bus: Built-In 18:31:31 INFO - VRAM (Dynamic, Max): 1536 MB 18:31:31 INFO - Vendor: Intel (0x8086) 18:31:31 INFO - Device ID: 0x0a2e 18:31:31 INFO - Revision ID: 0x0009 18:31:31 INFO - Displays: 18:31:31 INFO - Display: 18:31:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:31:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:31:31 INFO - Display Serial Number: 1600x1200 60 18:31:31 INFO - Main Display: Yes 18:31:31 INFO - Mirror: Off 18:31:31 INFO - Online: Yes 18:31:31 INFO - Rotation: Supported 18:31:31 INFO - Return code: 0 18:31:31 INFO - Running post-action listener: _resource_record_post_action 18:31:31 INFO - [mozharness: 2017-02-04 02:31:31.617731Z] Finished run-tests step (success) 18:31:31 INFO - Running post-run listener: _resource_record_post_run 18:31:31 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 38771200; Write bytes: 561700352; Read time: 242; Write time: 1743 18:31:31 INFO - TinderboxPrint: CPU usage
54.4% 18:31:31 INFO - TinderboxPrint: I/O read bytes / time
38,771,200 / 242 18:31:31 INFO - TinderboxPrint: I/O write bytes / time
561,700,352 / 1,743 18:31:31 INFO - TinderboxPrint: CPU idle
2,191.8 (45.6%) 18:31:31 INFO - TinderboxPrint: CPU system
963.1 (20.1%) 18:31:31 INFO - TinderboxPrint: CPU user
1,646.8 (34.3%) 18:31:31 INFO - TinderboxPrint: Swap in / out
290,729,984 / 0 18:31:31 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 247347712; Write bytes: 234364928; Read time: 17616; Write time: 504 18:31:31 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 31429120; Write bytes: 306005504; Read time: 186; Write time: 1175 18:31:32 INFO - Running post-run listener: _upload_blobber_files 18:31:32 INFO - Blob upload gear active. 18:31:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:31:32 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 18:31:32 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'] 18:31:32 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 18:31:32 INFO - (blobuploader) - INFO - Open directory for files ... 18:31:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:31:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:31:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:31:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:31:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:31:33 INFO - (blobuploader) - INFO - Done attempting. 18:31:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:31:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:31:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:31:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:31:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:31:34 INFO - (blobuploader) - INFO - Done attempting. 18:31:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:31:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:31:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:31:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:31:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:31:35 INFO - (blobuploader) - INFO - Done attempting. 18:31:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:31:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:31:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:31:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:31:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:31:38 INFO - (blobuploader) - INFO - Done attempting. 18:31:38 INFO - (blobuploader) - INFO - Iteration through files over. 18:31:38 INFO - Return code: 0 18:31:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:31:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:31:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d8a0fd6cb475c8f0d3a16cf43b8eb6d492b7bd4691cbe6db5e8c624ed1b99fedacd014efde0b7f2dd11e0036669c6e58ca1b9164c4c5c320ffedec845a5fc73", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0c8ac3c69bab6854b17c8a49a777acbf3b7b5048c7a7aeca8d6fe06bb2b1542c53201a86c9a2e1b2fa8c5a7195cde93ba95410b6191ed73ec73fad9ebe7547a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31f71855dfed5531469970cd786be4175ced4ed31e5e1b12b21bfb3566659312b4f58593b3d8a50bf28c0409d50ab24d38111b34338d14d1ac859ce23e93d402", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db7667f3b78079a3c292cc0f6ceee8a77b65ea9d373b4c1f0ccb66e332476c7574d7d0c4a4e019d59c43767d4738a0ad5a2c45421fdfad95fd827ffc9ef6551b"} 18:31:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:31:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:31:38 INFO - Contents: 18:31:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d8a0fd6cb475c8f0d3a16cf43b8eb6d492b7bd4691cbe6db5e8c624ed1b99fedacd014efde0b7f2dd11e0036669c6e58ca1b9164c4c5c320ffedec845a5fc73", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0c8ac3c69bab6854b17c8a49a777acbf3b7b5048c7a7aeca8d6fe06bb2b1542c53201a86c9a2e1b2fa8c5a7195cde93ba95410b6191ed73ec73fad9ebe7547a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31f71855dfed5531469970cd786be4175ced4ed31e5e1b12b21bfb3566659312b4f58593b3d8a50bf28c0409d50ab24d38111b34338d14d1ac859ce23e93d402", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db7667f3b78079a3c292cc0f6ceee8a77b65ea9d373b4c1f0ccb66e332476c7574d7d0c4a4e019d59c43767d4738a0ad5a2c45421fdfad95fd827ffc9ef6551b"} 18:31:38 INFO - Running post-run listener: copy_logs_to_upload_dir 18:31:38 INFO - Copying logs to upload dir... 18:31:38 INFO - mkdir: /builds/slave/test/build/upload/logs 18:31:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.852610 ========= master_lag: 0.17 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-02-03 18:31:38.923922) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 18:31:38.927658) ========= 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.V66Ut7Rims/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.xyfgG0pUga/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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/7d8a0fd6cb475c8f0d3a16cf43b8eb6d492b7bd4691cbe6db5e8c624ed1b99fedacd014efde0b7f2dd11e0036669c6e58ca1b9164c4c5c320ffedec845a5fc73", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0c8ac3c69bab6854b17c8a49a777acbf3b7b5048c7a7aeca8d6fe06bb2b1542c53201a86c9a2e1b2fa8c5a7195cde93ba95410b6191ed73ec73fad9ebe7547a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31f71855dfed5531469970cd786be4175ced4ed31e5e1b12b21bfb3566659312b4f58593b3d8a50bf28c0409d50ab24d38111b34338d14d1ac859ce23e93d402", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db7667f3b78079a3c292cc0f6ceee8a77b65ea9d373b4c1f0ccb66e332476c7574d7d0c4a4e019d59c43767d4738a0ad5a2c45421fdfad95fd827ffc9ef6551b"} build_url:https://queue.taskcluster.net/v1/task/WHNEwAUFT46LLvJ_81_tJA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/WHNEwAUFT46LLvJ_81_tJA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d8a0fd6cb475c8f0d3a16cf43b8eb6d492b7bd4691cbe6db5e8c624ed1b99fedacd014efde0b7f2dd11e0036669c6e58ca1b9164c4c5c320ffedec845a5fc73", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0c8ac3c69bab6854b17c8a49a777acbf3b7b5048c7a7aeca8d6fe06bb2b1542c53201a86c9a2e1b2fa8c5a7195cde93ba95410b6191ed73ec73fad9ebe7547a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31f71855dfed5531469970cd786be4175ced4ed31e5e1b12b21bfb3566659312b4f58593b3d8a50bf28c0409d50ab24d38111b34338d14d1ac859ce23e93d402", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db7667f3b78079a3c292cc0f6ceee8a77b65ea9d373b4c1f0ccb66e332476c7574d7d0c4a4e019d59c43767d4738a0ad5a2c45421fdfad95fd827ffc9ef6551b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 18:31:38.962123) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 18:31:38.962556) ========= 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.V66Ut7Rims/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.xyfgG0pUga/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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.005064 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 18:31:39.011135) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 18:31:39.011451) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 18:31:39.011769) ========= ========= Total master_lag: 0.99 =========