builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0137 starttime: 1488382378.0 results: success (0) buildid: 20170301072336 builduid: 7c30fda4e6d84bbdafbc45cd8658a9b4 revision: 34c6c2f302e7b48e3ad2cec575cbd34d423a9d32 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-01 07:32:57.998029) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-01 07:32:57.998490) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-01 07:32:57.998767) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-01 07:32:58.081784) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 07:32:58.082084) ========= 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.gyFJXrR83y/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.6cCQGoFPoR/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-01 07:32:58-- 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% 161M=0s 2017-03-01 07:32:58 (161 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.194394 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 07:32:58.300837) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 07:32:58.301146) ========= 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.gyFJXrR83y/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.6cCQGoFPoR/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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.022851 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 07:32:58.349955) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-01 07:32:58.350302) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 34c6c2f302e7b48e3ad2cec575cbd34d423a9d32 --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 34c6c2f302e7b48e3ad2cec575cbd34d423a9d32 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gyFJXrR83y/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.6cCQGoFPoR/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-01 07:32:58,435 truncating revision to first 12 chars 2017-03-01 07:32:58,435 Setting DEBUG logging. 2017-03-01 07:32:58,435 attempt 1/10 2017-03-01 07:32:58,435 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/34c6c2f302e7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-01 07:32:59,557 unpacking tar archive at: mozilla-central-34c6c2f302e7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.377366 ========= master_lag: 0.31 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-01 07:33:00.041459) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-01 07:33:00.041809) ========= script_repo_revision: 34c6c2f302e7b48e3ad2cec575cbd34d423a9d32 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-01 07:33:00.042265) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-01 07:33:00.042539) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-01 07:33:00.137055) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-01 07:33:00.137504) ========= /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.gyFJXrR83y/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.6cCQGoFPoR/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 07:33:00 INFO - MultiFileLogger online at 20170301 07:33:00 in /builds/slave/test 07:33:00 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 07:33:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:33:00 INFO - {'append_to_log': False, 07:33:00 INFO - 'base_work_dir': '/builds/slave/test', 07:33:00 INFO - 'blob_upload_branch': 'Firefox', 07:33:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:33:00 INFO - 'branch': 'Firefox', 07:33:00 INFO - 'buildbot_json_path': 'buildprops.json', 07:33:00 INFO - 'config_files': ('talos/mac_config.py',), 07:33:00 INFO - 'default_actions': ('clobber', 07:33:00 INFO - 'read-buildbot-config', 07:33:00 INFO - 'download-and-extract', 07:33:00 INFO - 'populate-webroot', 07:33:00 INFO - 'create-virtualenv', 07:33:00 INFO - 'install', 07:33:00 INFO - 'run-tests'), 07:33:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:33:00 INFO - 'download_minidump_stackwalk': True, 07:33:00 INFO - 'download_symbols': 'ondemand', 07:33:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:33:00 INFO - 'tooltool.py': '/tools/tooltool.py', 07:33:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:33:00 INFO - '/tools/misc-python/virtualenv.py')}, 07:33:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:33:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:33:00 INFO - 'gecko_profile': False, 07:33:00 INFO - 'gecko_profile_interval': 0, 07:33:00 INFO - 'installer_path': 'installer.exe', 07:33:00 INFO - 'log_level': 'info', 07:33:00 INFO - 'log_name': 'talos', 07:33:00 INFO - 'log_to_console': True, 07:33:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:33:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:33:00 INFO - 'opt_config_files': (), 07:33:00 INFO - 'pip_index': False, 07:33:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:33:00 INFO - 'cmd': ('bash', 07:33:00 INFO - '-c', 07:33:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:33:00 INFO - 'enabled': True, 07:33:00 INFO - 'halt_on_failure': False, 07:33:00 INFO - 'name': 'check_screen_resolution'},), 07:33:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:33:00 INFO - 'cmd': ('bash', 07:33:00 INFO - '-c', 07:33:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:33:00 INFO - 'enabled': True, 07:33:00 INFO - 'halt_on_failure': False, 07:33:00 INFO - 'name': 'check_screen_resolution'},), 07:33:00 INFO - 'run_cmd_checks_enabled': True, 07:33:00 INFO - 'suite': 'dromaeojs-e10s', 07:33:00 INFO - 'system_bits': '32', 07:33:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:33:00 INFO - 'title': 't-yosemite-r7-0137', 07:33:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:33:00 INFO - 'use_talos_json': True, 07:33:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:33:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:33:00 INFO - 'work_dir': 'build'} 07:33:00 INFO - [mozharness: 2017-03-01 15:33:00.350938Z] Running clobber step. 07:33:00 INFO - Running pre-action listener: _resource_record_pre_action 07:33:00 INFO - Running main action method: clobber 07:33:00 INFO - rmtree: /builds/slave/test/build 07:33:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:33:02 INFO - Running post-action listener: _resource_record_post_action 07:33:02 INFO - [mozharness: 2017-03-01 15:33:02.434043Z] Finished clobber step (success) 07:33:02 INFO - [mozharness: 2017-03-01 15:33:02.434185Z] Running read-buildbot-config step. 07:33:02 INFO - Running pre-action listener: _resource_record_pre_action 07:33:02 INFO - Running main action method: read_buildbot_config 07:33:02 INFO - Using buildbot properties: 07:33:02 INFO - { 07:33:02 INFO - "project": "", 07:33:02 INFO - "product": "firefox", 07:33:02 INFO - "script_repo_revision": "production", 07:33:02 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 07:33:02 INFO - "repository": "", 07:33:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 07:33:02 INFO - "buildid": "20170301072336", 07:33:02 INFO - "stage_platform": "macosx64", 07:33:02 INFO - "basedir": "/builds/slave/test", 07:33:02 INFO - "buildnumber": 159, 07:33:02 INFO - "platform": "yosemite_r7", 07:33:02 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 07:33:02 INFO - "slavebuilddir": "test", 07:33:02 INFO - "branch": "mozilla-central", 07:33:02 INFO - "revision": "34c6c2f302e7b48e3ad2cec575cbd34d423a9d32", 07:33:02 INFO - "slavename": "t-yosemite-r7-0137", 07:33:02 INFO - "builduid": "7c30fda4e6d84bbdafbc45cd8658a9b4", 07:33:02 INFO - "repo_path": "mozilla-central" 07:33:02 INFO - } 07:33:02 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.dmg. 07:33:02 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.test_packages.json. 07:33:02 INFO - Running post-action listener: _resource_record_post_action 07:33:02 INFO - [mozharness: 2017-03-01 15:33:02.437644Z] Finished read-buildbot-config step (success) 07:33:02 INFO - [mozharness: 2017-03-01 15:33:02.437755Z] Running download-and-extract step. 07:33:02 INFO - Running pre-action listener: _resource_record_pre_action 07:33:02 INFO - Running main action method: download_and_extract 07:33:02 INFO - mkdir: /builds/slave/test/build/tests 07:33: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')]} 07:33:02 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.test_packages.json 07:33:02 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 07:33:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/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 07:33:02 INFO - Downloaded 1199 bytes. 07:33:02 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 07:33:02 INFO - Using the following test package requirements: 07:33:02 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 07:33:02 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:33:02 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 07:33:02 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:33:02 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 07:33:02 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:33:02 INFO - u'jsshell-mac.zip'], 07:33:02 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:33:02 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 07:33:02 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 07:33:02 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:33:02 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 07:33:02 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:33:02 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 07:33:02 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:33:02 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 07:33:02 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:33:02 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 07:33:02 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:33:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.common.tests.zip 07:33:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:33:02 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.common.tests.zip into memory 07:33:03 INFO - Expected file size: 51762826 07:33:03 INFO - Obtained file size: 51762826 07:33:19 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 07:33:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.common.tests.zip 07:33:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:33:19 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.common.tests.zip into memory 07:33:20 INFO - Expected file size: 51762826 07:33:20 INFO - Obtained file size: 51762826 07:33:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.talos.tests.zip 07:33:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:33:35 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 07:33:36 INFO - Expected file size: 14404421 07:33:36 INFO - Obtained file size: 14404421 07:33: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')]} 07:33:36 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.dmg 07:33:36 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 07:33:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 07:33:37 INFO - Downloaded 74973774 bytes. 07:33:37 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.dmg 07:33:37 INFO - mkdir: /builds/slave/test/properties 07:33:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:33:37 INFO - Writing to file /builds/slave/test/properties/build_url 07:33:37 INFO - Contents: 07:33:37 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.dmg 07:33:38 INFO - Running post-action listener: _resource_record_post_action 07:33:38 INFO - Running post-action listener: set_extra_try_arguments 07:33:38 INFO - [mozharness: 2017-03-01 15:33:38.279912Z] Finished download-and-extract step (success) 07:33:38 INFO - [mozharness: 2017-03-01 15:33:38.280055Z] Running populate-webroot step. 07:33:38 INFO - Running pre-action listener: _resource_record_pre_action 07:33:38 INFO - Running main action method: populate_webroot 07:33:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:33:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:33:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:33:38 INFO - '--tppagecycles', 07:33:38 INFO - '7'], 07:33:38 INFO - 'tests': ['tsvgm']}}, 07:33:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:33:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:33:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:33:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:33:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:33:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:33:38 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:33:38 INFO - 'talos_options': ['--disable-e10s'], 07:33:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:33:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:33:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:33:38 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:33:38 INFO - 'talos_options': ['--disable-e10s'], 07:33:38 INFO - 'tests': ['damp', 'tps']}, 07:33:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:33:38 INFO - 'tests': ['damp', 'tps']}, 07:33:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:33:38 INFO - 'tests': ['dromaeo_dom']}, 07:33:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:33:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:33:38 INFO - 'tests': ['basic_compositor_video']}, 07:33:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:33:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:33:38 INFO - 'tests': ['a11yr', 07:33:38 INFO - 'ts_paint', 07:33:38 INFO - 'tpaint', 07:33:38 INFO - 'sessionrestore', 07:33:38 INFO - 'sessionrestore_no_auto_restore', 07:33:38 INFO - 'tabpaint']}, 07:33:38 INFO - 'other-e10s': {'tests': ['a11yr', 07:33:38 INFO - 'ts_paint', 07:33:38 INFO - 'tpaint', 07:33:38 INFO - 'sessionrestore', 07:33:38 INFO - 'sessionrestore_no_auto_restore', 07:33:38 INFO - 'tabpaint']}, 07:33:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:33:38 INFO - 'ts_paint', 07:33:38 INFO - 'tpaint', 07:33:38 INFO - 'sessionrestore', 07:33:38 INFO - 'sessionrestore_no_auto_restore', 07:33:38 INFO - 'tabpaint']}, 07:33:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:33:38 INFO - 'ts_paint', 07:33:38 INFO - 'tpaint', 07:33:38 INFO - 'sessionrestore', 07:33:38 INFO - 'sessionrestore_no_auto_restore', 07:33:38 INFO - 'tabpaint']}, 07:33:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:33:38 INFO - 'tests': ['a11yr', 07:33:38 INFO - 'ts_paint', 07:33:38 INFO - 'tpaint', 07:33:38 INFO - 'sessionrestore', 07:33:38 INFO - 'sessionrestore_no_auto_restore', 07:33:38 INFO - 'tabpaint']}, 07:33:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:33:38 INFO - 'tests': ['a11yr', 07:33:38 INFO - 'ts_paint', 07:33:38 INFO - 'tpaint', 07:33:38 INFO - 'sessionrestore', 07:33:38 INFO - 'sessionrestore_no_auto_restore', 07:33:38 INFO - 'tabpaint']}, 07:33:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:33:38 INFO - 'tests': ['tsvgx', 07:33:38 INFO - 'tsvgr_opacity', 07:33:38 INFO - 'tart', 07:33:38 INFO - 'tscrollx', 07:33:38 INFO - 'cart', 07:33:38 INFO - 'tsvg_static']}, 07:33:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:33:38 INFO - 'tsvgr_opacity', 07:33:38 INFO - 'tart', 07:33:38 INFO - 'tscrollx', 07:33:38 INFO - 'cart', 07:33:38 INFO - 'tsvg_static']}, 07:33:38 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:33:38 INFO - 'talos_options': ['--disable-e10s'], 07:33:38 INFO - 'tests': ['tp5o']}, 07:33:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:33:38 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:33:38 INFO - 'talos_options': ['--disable-e10s', 07:33:38 INFO - '--xperf_path', 07:33:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:33:38 INFO - 'tests': ['tp5n']}, 07:33:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:33:38 INFO - 'talos_options': ['--xperf_path', 07:33:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:33:38 INFO - 'tests': ['tp5n']}}, 07:33:38 INFO - 'talos.zip': {'path': '', 07:33:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:33:38 INFO - Running post-action listener: _resource_record_post_action 07:33:38 INFO - [mozharness: 2017-03-01 15:33:38.298680Z] Finished populate-webroot step (success) 07:33:38 INFO - [mozharness: 2017-03-01 15:33:38.298814Z] Running create-virtualenv step. 07:33:38 INFO - Running pre-action listener: _resource_record_pre_action 07:33:38 INFO - Running main action method: create_virtualenv 07:33:38 INFO - Creating virtualenv /builds/slave/test/build/venv 07:33:38 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 07:33:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:33:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:33:38 INFO - Using real prefix '/tools/python27' 07:33:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:33:39 INFO - Installing distribute.............................................................................................................................................................................................done. 07:33:42 INFO - Installing pip.................done. 07:33:42 INFO - Return code: 0 07:33:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:33:42 INFO - Reading from file tmpfile_stdout 07:33:42 INFO - Output received: 07:33:42 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) 07:33:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1068dbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068de768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a32cd8ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066b9d30>, '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 0x1065e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066aebe8>, '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.gyFJXrR83y/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.6cCQGoFPoR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 07:33:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:33:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gyFJXrR83y/Render', 07:33:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:42 INFO - 'HOME': '/Users/cltbld', 07:33:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:42 INFO - 'LOGNAME': 'cltbld', 07:33:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:42 INFO - 'MOZ_NO_REMOTE': '1', 07:33:42 INFO - 'NO_EM_RESTART': '1', 07:33:42 INFO - 'PAGER': '/bin/cat', 07:33:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:42 INFO - 'PWD': '/builds/slave/test', 07:33:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:42 INFO - 'SHELL': '/bin/bash', 07:33:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6cCQGoFPoR/Listeners', 07:33:42 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 07:33:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:42 INFO - 'USER': 'cltbld', 07:33:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:42 INFO - 'XPC_FLAGS': '0x0', 07:33:42 INFO - 'XPC_SERVICE_NAME': '0', 07:33:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:42 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 07:33:42 INFO - Cleaning up... 07:33:42 INFO - Return code: 0 07:33:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1068dbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068de768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a32cd8ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066b9d30>, '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 0x1065e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066aebe8>, '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.gyFJXrR83y/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.6cCQGoFPoR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 07:33:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:33:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gyFJXrR83y/Render', 07:33:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:42 INFO - 'HOME': '/Users/cltbld', 07:33:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:42 INFO - 'LOGNAME': 'cltbld', 07:33:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:42 INFO - 'MOZ_NO_REMOTE': '1', 07:33:42 INFO - 'NO_EM_RESTART': '1', 07:33:42 INFO - 'PAGER': '/bin/cat', 07:33:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:42 INFO - 'PWD': '/builds/slave/test', 07:33:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:42 INFO - 'SHELL': '/bin/bash', 07:33:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6cCQGoFPoR/Listeners', 07:33:42 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 07:33:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:42 INFO - 'USER': 'cltbld', 07:33:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:42 INFO - 'XPC_FLAGS': '0x0', 07:33:42 INFO - 'XPC_SERVICE_NAME': '0', 07:33:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:42 INFO - Downloading/unpacking psutil>=3.1.1 07:33:42 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 07:33:42 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 07:33:42 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 07:33:42 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 07:33:42 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 07:33:42 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 07:33:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:33:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:33:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:33:46 INFO - Installing collected packages: psutil 07:33:46 INFO - Running setup.py install for psutil 07:33:46 INFO - building 'psutil._psutil_osx' extension 07:33:46 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 07:33:46 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 07:33:46 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 07:33:46 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 07:33:46 INFO - building 'psutil._psutil_posix' extension 07:33:46 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 07:33:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:33:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:33:47 INFO - ^ 07:33:47 INFO - 1 warning generated. 07:33:47 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 07:33:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:33:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:33:47 INFO - Successfully installed psutil 07:33:47 INFO - Cleaning up... 07:33:47 INFO - Return code: 0 07:33:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:47 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 0x1068dbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068de768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a32cd8ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066b9d30>, '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 0x1065e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066aebe8>, '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.gyFJXrR83y/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.6cCQGoFPoR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 07:33:47 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 07:33:47 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 07:33:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gyFJXrR83y/Render', 07:33:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:47 INFO - 'HOME': '/Users/cltbld', 07:33:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:47 INFO - 'LOGNAME': 'cltbld', 07:33:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:47 INFO - 'MOZ_NO_REMOTE': '1', 07:33:47 INFO - 'NO_EM_RESTART': '1', 07:33:47 INFO - 'PAGER': '/bin/cat', 07:33:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:47 INFO - 'PWD': '/builds/slave/test', 07:33:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:47 INFO - 'SHELL': '/bin/bash', 07:33:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6cCQGoFPoR/Listeners', 07:33:47 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 07:33:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:47 INFO - 'USER': 'cltbld', 07:33:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:47 INFO - 'XPC_FLAGS': '0x0', 07:33:47 INFO - 'XPC_SERVICE_NAME': '0', 07:33:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:33:47 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 07:33:47 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 07:33:47 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 07:33:47 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 07:33:47 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 07:33:47 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 07:33:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:33:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:33:50 INFO - Installing collected packages: mozsystemmonitor 07:33:50 INFO - Running setup.py install for mozsystemmonitor 07:33:50 INFO - Successfully installed mozsystemmonitor 07:33:50 INFO - Cleaning up... 07:33:50 INFO - Return code: 0 07:33:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:33:50 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')]} 07:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:50 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')]} 07:33:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:50 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 0x1068dbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068de768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a32cd8ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066b9d30>, '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 0x1065e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066aebe8>, '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.gyFJXrR83y/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.6cCQGoFPoR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 07:33:50 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 07:33:50 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 07:33:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gyFJXrR83y/Render', 07:33:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:50 INFO - 'HOME': '/Users/cltbld', 07:33:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:50 INFO - 'LOGNAME': 'cltbld', 07:33:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:50 INFO - 'MOZ_NO_REMOTE': '1', 07:33:50 INFO - 'NO_EM_RESTART': '1', 07:33:50 INFO - 'PAGER': '/bin/cat', 07:33:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:50 INFO - 'PWD': '/builds/slave/test', 07:33:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:50 INFO - 'SHELL': '/bin/bash', 07:33:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6cCQGoFPoR/Listeners', 07:33:50 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 07:33:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:50 INFO - 'USER': 'cltbld', 07:33:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:50 INFO - 'XPC_FLAGS': '0x0', 07:33:50 INFO - 'XPC_SERVICE_NAME': '0', 07:33:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:50 INFO - Downloading/unpacking jsonschema==2.5.1 07:33:50 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 07:33:50 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 07:33:50 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 07:33:50 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 07:33:50 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 07:33:50 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 07:33:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:33:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:33:53 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 07:33:53 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 07:33:53 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 07:33:53 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 07:33:53 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 07:33:53 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 07:33:53 INFO - Downloading functools32-3.2.3-2.tar.gz 07:33:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:33:53 INFO - warning: no files found matching '*.txt' 07:33:53 INFO - no previously-included directories found matching 'build' 07:33:53 INFO - no previously-included directories found matching 'dist' 07:33:53 INFO - no previously-included directories found matching '.git*' 07:33:53 INFO - Installing collected packages: jsonschema, functools32 07:33:54 INFO - Running setup.py install for functools32 07:33:54 INFO - warning: no files found matching '*.txt' 07:33:54 INFO - no previously-included directories found matching 'build' 07:33:54 INFO - no previously-included directories found matching 'dist' 07:33:54 INFO - no previously-included directories found matching '.git*' 07:33:54 INFO - Successfully installed jsonschema functools32 07:33:54 INFO - Cleaning up... 07:33:54 INFO - Return code: 0 07:33:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33: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')]} 07:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:55 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 0x1068dbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068de768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a32cd8ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066b9d30>, '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 0x1065e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066aebe8>, '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.gyFJXrR83y/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.6cCQGoFPoR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 07:33:55 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 07:33:55 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 07:33:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gyFJXrR83y/Render', 07:33:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:55 INFO - 'HOME': '/Users/cltbld', 07:33:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:55 INFO - 'LOGNAME': 'cltbld', 07:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:55 INFO - 'MOZ_NO_REMOTE': '1', 07:33:55 INFO - 'NO_EM_RESTART': '1', 07:33:55 INFO - 'PAGER': '/bin/cat', 07:33:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:55 INFO - 'PWD': '/builds/slave/test', 07:33:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:55 INFO - 'SHELL': '/bin/bash', 07:33:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6cCQGoFPoR/Listeners', 07:33:55 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 07:33:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:55 INFO - 'USER': 'cltbld', 07:33:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:55 INFO - 'XPC_FLAGS': '0x0', 07:33:55 INFO - 'XPC_SERVICE_NAME': '0', 07:33:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:33:55 INFO - Cleaning up... 07:33:55 INFO - Return code: 0 07:33:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:33: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')]} 07:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33: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')]} 07:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:55 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 0x1068dbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068de768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a32cd8ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066b9d30>, '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 0x1065e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066aebe8>, '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.gyFJXrR83y/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.6cCQGoFPoR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 07:33:55 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 07:33:55 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 07:33:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gyFJXrR83y/Render', 07:33:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:55 INFO - 'HOME': '/Users/cltbld', 07:33:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:55 INFO - 'LOGNAME': 'cltbld', 07:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:55 INFO - 'MOZ_NO_REMOTE': '1', 07:33:55 INFO - 'NO_EM_RESTART': '1', 07:33:55 INFO - 'PAGER': '/bin/cat', 07:33:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:55 INFO - 'PWD': '/builds/slave/test', 07:33:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:55 INFO - 'SHELL': '/bin/bash', 07:33:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6cCQGoFPoR/Listeners', 07:33:55 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 07:33:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:55 INFO - 'USER': 'cltbld', 07:33:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:55 INFO - 'XPC_FLAGS': '0x0', 07:33:55 INFO - 'XPC_SERVICE_NAME': '0', 07:33:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:56 INFO - Downloading/unpacking blobuploader==1.2.4 07:33:56 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 07:33:56 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 07:33:56 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 07:33:56 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 07:33:56 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 07:33:56 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 07:33:59 INFO - Downloading blobuploader-1.2.4.tar.gz 07:33:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:33:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:33:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:33:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:33:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:33:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:33:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:34:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:34:00 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 07:34:00 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 07:34:00 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 07:34:00 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 07:34:00 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 07:34:00 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 07:34:00 INFO - Downloading docopt-0.6.1.tar.gz 07:34:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:34:00 INFO - Installing collected packages: blobuploader, requests, docopt 07:34:00 INFO - Running setup.py install for blobuploader 07:34:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:34:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:34:00 INFO - Running setup.py install for requests 07:34:01 INFO - Running setup.py install for docopt 07:34:01 INFO - Successfully installed blobuploader requests docopt 07:34:01 INFO - Cleaning up... 07:34:01 INFO - Return code: 0 07:34:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34:01 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')]} 07:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:01 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')]} 07:34:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:01 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 0x1068dbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068de768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a32cd8ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066b9d30>, '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 0x1065e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066aebe8>, '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.gyFJXrR83y/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.6cCQGoFPoR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 07:34:01 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 07:34:01 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 07:34:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gyFJXrR83y/Render', 07:34:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:01 INFO - 'HOME': '/Users/cltbld', 07:34:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:01 INFO - 'LOGNAME': 'cltbld', 07:34:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:01 INFO - 'MOZ_NO_REMOTE': '1', 07:34:01 INFO - 'NO_EM_RESTART': '1', 07:34:01 INFO - 'PAGER': '/bin/cat', 07:34:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:01 INFO - 'PWD': '/builds/slave/test', 07:34:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:01 INFO - 'SHELL': '/bin/bash', 07:34:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6cCQGoFPoR/Listeners', 07:34:01 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 07:34:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:01 INFO - 'USER': 'cltbld', 07:34:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:01 INFO - 'XPC_FLAGS': '0x0', 07:34:01 INFO - 'XPC_SERVICE_NAME': '0', 07:34:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:34:01 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-adKQt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:34:01 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-9_SLxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:34:02 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-YygAjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:34:02 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-70lCAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:34:02 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-0BSzih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:34:02 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-Tx_iFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:34:02 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-SUSUqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:34:02 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-GYSLWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:34:02 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-hbqMzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:34:02 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-0KG11J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:34:02 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-myhxnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:34:03 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-eNkie6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:34:03 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-C37yUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:34:03 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-zS91GF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:03 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-qgQAaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:34:03 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-GirS5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:34:03 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-yBmfPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:34:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:34:03 INFO - Running setup.py install for manifestparser 07:34:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:34:03 INFO - Running setup.py install for mozcrash 07:34:04 INFO - Running setup.py install for mozdebug 07:34:04 INFO - Running setup.py install for mozdevice 07:34:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:34:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:34:04 INFO - Running setup.py install for mozfile 07:34:04 INFO - Running setup.py install for mozhttpd 07:34:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:34:04 INFO - Running setup.py install for mozinfo 07:34:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:34:04 INFO - Running setup.py install for mozInstall 07:34:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:34:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:34:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:34:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:34:04 INFO - Running setup.py install for mozleak 07:34:05 INFO - Running setup.py install for mozlog 07:34:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:34:05 INFO - Running setup.py install for moznetwork 07:34:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:34:05 INFO - Running setup.py install for mozprocess 07:34:05 INFO - Running setup.py install for mozprofile 07:34:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:34:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:34:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:34:05 INFO - Running setup.py install for mozrunner 07:34:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:34:05 INFO - Running setup.py install for mozscreenshot 07:34:06 INFO - Running setup.py install for moztest 07:34:06 INFO - Running setup.py install for mozversion 07:34:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:34:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:34:06 INFO - Cleaning up... 07:34:06 INFO - Return code: 0 07:34:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:06 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 0x1068dbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068de768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a32cd8ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066b9d30>, '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 0x1065e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066aebe8>, '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.gyFJXrR83y/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.6cCQGoFPoR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 07:34:06 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 07:34:06 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 07:34:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gyFJXrR83y/Render', 07:34:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:06 INFO - 'HOME': '/Users/cltbld', 07:34:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:06 INFO - 'LOGNAME': 'cltbld', 07:34:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:06 INFO - 'MOZ_NO_REMOTE': '1', 07:34:06 INFO - 'NO_EM_RESTART': '1', 07:34:06 INFO - 'PAGER': '/bin/cat', 07:34:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:06 INFO - 'PWD': '/builds/slave/test', 07:34:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:06 INFO - 'SHELL': '/bin/bash', 07:34:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6cCQGoFPoR/Listeners', 07:34:06 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 07:34:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:06 INFO - 'USER': 'cltbld', 07:34:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:06 INFO - 'XPC_FLAGS': '0x0', 07:34:06 INFO - 'XPC_SERVICE_NAME': '0', 07:34:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:34:06 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-LyKPBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:34:06 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)) 07:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:34:06 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-2Q0B7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:34:06 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)) 07:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:34:06 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-OHWUBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:34:06 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)) 07:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:34:06 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-7NmDjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:34:07 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)) 07:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:34:07 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-lTM1dQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:34:07 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)) 07:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:34:07 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-JTGrBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:34:07 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)) 07:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:34:07 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-tokqqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:34:07 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)) 07:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:34:07 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-BDXYMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:34:07 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)) 07:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:34:07 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-WP0pR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:34:07 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)) 07:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:34:07 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-gONcFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:34:07 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)) 07:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:34:07 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-VZNPkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:34:07 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)) 07:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:34:07 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-r9wQ8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:34:07 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-8FjwEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:34:08 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)) 07:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:34:08 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-ZiAf1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:34:08 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)) 07:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:08 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-lUpPqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:08 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)) 07:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:34:08 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-JGPRsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:34:08 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)) 07:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:34:08 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-mJdYcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:34:08 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)) 07:34:08 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)) 07:34:08 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)) 07:34:08 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)) 07:34:08 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)) 07:34:08 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)) 07:34:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:34: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 07:34: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 07:34: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 07:34: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 07:34: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 07:34: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 07:34:11 INFO - Downloading blessings-1.6.tar.gz 07:34:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:34:11 INFO - Installing collected packages: blessings 07:34:11 INFO - Running setup.py install for blessings 07:34:11 INFO - Successfully installed blessings 07:34:11 INFO - Cleaning up... 07:34:11 INFO - Return code: 0 07:34:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:34:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:34:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:34:11 INFO - Reading from file tmpfile_stdout 07:34:11 INFO - Current package versions: 07:34:11 INFO - blessings == 1.6 07:34:11 INFO - blobuploader == 1.2.4 07:34:11 INFO - docopt == 0.6.1 07:34:11 INFO - functools32 == 3.2.3-2 07:34:11 INFO - jsonschema == 2.5.1 07:34:11 INFO - manifestparser == 1.1 07:34:11 INFO - mozInstall == 1.12 07:34:11 INFO - mozcrash == 1.0 07:34:11 INFO - mozdebug == 0.1 07:34:11 INFO - mozdevice == 0.49 07:34:11 INFO - mozfile == 1.2 07:34:11 INFO - mozhttpd == 0.7 07:34:11 INFO - mozinfo == 0.9 07:34:11 INFO - mozleak == 0.1 07:34:11 INFO - mozlog == 3.4 07:34:11 INFO - moznetwork == 0.27 07:34:11 INFO - mozprocess == 0.25 07:34:11 INFO - mozprofile == 0.28 07:34:11 INFO - mozrunner == 6.13 07:34:11 INFO - mozscreenshot == 0.1 07:34:11 INFO - mozsystemmonitor == 0.3 07:34:11 INFO - moztest == 0.8 07:34:11 INFO - mozversion == 1.4 07:34:11 INFO - psutil == 3.1.1 07:34:11 INFO - requests == 1.2.3 07:34:11 INFO - wsgiref == 0.1.2 07:34:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34: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')]} 07:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34: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')]} 07:34:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:11 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 0x1068dbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068de768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a32cd8ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066b9d30>, '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 0x1065e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066aebe8>, '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.gyFJXrR83y/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.6cCQGoFPoR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 07:34:11 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 07:34:11 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 07:34:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gyFJXrR83y/Render', 07:34:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:11 INFO - 'HOME': '/Users/cltbld', 07:34:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:11 INFO - 'LOGNAME': 'cltbld', 07:34:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:11 INFO - 'MOZ_NO_REMOTE': '1', 07:34:11 INFO - 'NO_EM_RESTART': '1', 07:34:11 INFO - 'PAGER': '/bin/cat', 07:34:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:11 INFO - 'PWD': '/builds/slave/test', 07:34:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:11 INFO - 'SHELL': '/bin/bash', 07:34:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6cCQGoFPoR/Listeners', 07:34:11 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 07:34:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:11 INFO - 'USER': 'cltbld', 07:34:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:11 INFO - 'XPC_FLAGS': '0x0', 07:34:11 INFO - 'XPC_SERVICE_NAME': '0', 07:34:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:12 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)) 07:34:12 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)) 07:34:12 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)) 07:34:12 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)) 07:34:12 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)) 07:34:12 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)) 07:34:12 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)) 07:34:12 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)) 07:34:12 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)) 07:34:12 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)) 07:34:12 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)) 07:34:12 INFO - Cleaning up... 07:34:12 INFO - Return code: 0 07:34:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:12 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 0x1068dbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068de768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a32cd8ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066b9d30>, '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 0x1065e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066aebe8>, '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.gyFJXrR83y/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.6cCQGoFPoR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 07:34:12 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 07:34:12 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 07:34:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gyFJXrR83y/Render', 07:34:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:12 INFO - 'HOME': '/Users/cltbld', 07:34:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:12 INFO - 'LOGNAME': 'cltbld', 07:34:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:12 INFO - 'MOZ_NO_REMOTE': '1', 07:34:12 INFO - 'NO_EM_RESTART': '1', 07:34:12 INFO - 'PAGER': '/bin/cat', 07:34:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:12 INFO - 'PWD': '/builds/slave/test', 07:34:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:12 INFO - 'SHELL': '/bin/bash', 07:34:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6cCQGoFPoR/Listeners', 07:34:12 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 07:34:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:12 INFO - 'USER': 'cltbld', 07:34:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:12 INFO - 'XPC_FLAGS': '0x0', 07:34:12 INFO - 'XPC_SERVICE_NAME': '0', 07:34:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:34:12 INFO - Cleaning up... 07:34:12 INFO - Return code: 0 07:34:12 INFO - Running post-action listener: _resource_record_post_action 07:34:12 INFO - Running post-action listener: _start_resource_monitoring 07:34:12 INFO - Starting resource monitoring. 07:34:12 INFO - [mozharness: 2017-03-01 15:34:12.318827Z] Finished create-virtualenv step (success) 07:34:12 INFO - [mozharness: 2017-03-01 15:34:12.319786Z] Running install step. 07:34:12 INFO - Running pre-action listener: _resource_record_pre_action 07:34:12 INFO - Running main action method: install 07:34:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:34:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:34:12 INFO - Reading from file tmpfile_stdout 07:34:12 INFO - Detecting whether we're running mozinstall >=1.0... 07:34:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:34:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:34:12 INFO - Reading from file tmpfile_stdout 07:34:12 INFO - Output received: 07:34:12 INFO - Usage: mozinstall [options] installer 07:34:12 INFO - Options: 07:34:12 INFO - -h, --help show this help message and exit 07:34:12 INFO - -d DEST, --destination=DEST 07:34:12 INFO - Directory to install application into. [default: 07:34:12 INFO - "/builds/slave/test"] 07:34:12 INFO - --app=APP Application being installed. [default: firefox] 07:34:12 INFO - mkdir: /builds/slave/test/build/application 07:34:12 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'] 07:34:12 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 07:34:33 INFO - Reading from file tmpfile_stdout 07:34:33 INFO - Output received: 07:34:33 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:34:33 INFO - Running post-action listener: _resource_record_post_action 07:34:33 INFO - [mozharness: 2017-03-01 15:34:33.293635Z] Finished install step (success) 07:34:33 INFO - [mozharness: 2017-03-01 15:34:33.293780Z] Running run-tests step. 07:34:33 INFO - Running pre-action listener: _resource_record_pre_action 07:34:33 INFO - Running main action method: run_tests 07:34:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:34:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:34:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:34:33 INFO - 2017-03-01 07:34:33.308 screenresolution[2166:17424] starting screenresolution argv=screenresolution get 07:34:33 INFO - 2017-03-01 07:34:33.311 screenresolution[2166:17424] Display 0: 1600x1200x32@60 07:34:33 INFO - 2017-03-01 07:34:33.317 screenresolution[2167:17428] starting screenresolution argv=screenresolution list 07:34:33 INFO - Available Modes on Display 0 07:34:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:34:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:34:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:34:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:34:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:34:33 INFO - Intel Iris: 07:34:33 INFO - Chipset Model: Intel Iris 07:34:33 INFO - Type: GPU 07:34:33 INFO - Bus: Built-In 07:34:33 INFO - VRAM (Dynamic, Max): 1536 MB 07:34:33 INFO - Vendor: Intel (0x8086) 07:34:33 INFO - Device ID: 0x0a2e 07:34:33 INFO - Revision ID: 0x0009 07:34:33 INFO - Displays: 07:34:33 INFO - Display: 07:34:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:34:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:34:33 INFO - Display Serial Number: 1600x1200 60 07:34:33 INFO - Main Display: Yes 07:34:33 INFO - Mirror: Off 07:34:33 INFO - Online: Yes 07:34:33 INFO - Rotation: Supported 07:34:33 INFO - Return code: 0 07:34:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:34:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:34:33 INFO - Python 2.7.3 07:34:33 INFO - Return code: 0 07:34:33 INFO - grabbing minidump binary from tooltool 07:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:33 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 0x1066b9d30>, '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 0x1065e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066aebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:34:33 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 07:34:33 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 07:34:33 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 07:34:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:34:33 INFO - Return code: 0 07:34:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:34:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:34:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:34:33 INFO - ENV: RUST_BACKTRACE is now 1 07:34:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:34:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:34:33 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://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0137', '--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 07:34:33 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://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0137 --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 07:34:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gyFJXrR83y/Render', 07:34:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:33 INFO - 'HOME': '/Users/cltbld', 07:34:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:33 INFO - 'LOGNAME': 'cltbld', 07:34:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:34:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:34:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:33 INFO - 'MOZ_NO_REMOTE': '1', 07:34:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:34:33 INFO - 'NO_EM_RESTART': '1', 07:34:33 INFO - 'PAGER': '/bin/cat', 07:34:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:33 INFO - 'PWD': '/builds/slave/test', 07:34:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:34:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:33 INFO - 'RUST_BACKTRACE': '1', 07:34:33 INFO - 'SHELL': '/bin/bash', 07:34:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6cCQGoFPoR/Listeners', 07:34:33 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 07:34:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:33 INFO - 'USER': 'cltbld', 07:34:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:33 INFO - 'XPC_FLAGS': '0x0', 07:34:33 INFO - 'XPC_SERVICE_NAME': '0', 07:34:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:33 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://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0137', '--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 07:34:33 INFO - mozversion application_buildid: 20170301024203 07:34:33 INFO - mozversion application_changeset: 34c6c2f302e7b48e3ad2cec575cbd34d423a9d32 07:34:33 INFO - mozversion application_display_name: Nightly 07:34:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:34:33 INFO - mozversion application_name: Firefox 07:34:33 INFO - mozversion application_remotingname: firefox 07:34:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:34:33 INFO - mozversion application_vendor: Mozilla 07:34:33 INFO - mozversion application_version: 54.0a1 07:34:33 INFO - mozversion platform_buildid: 20170301024203 07:34:33 INFO - mozversion platform_changeset: 34c6c2f302e7b48e3ad2cec575cbd34d423a9d32 07:34:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:34:33 INFO - mozversion platform_version: 54.0a1 07:34:33 INFO - using testdate: 1488382473 07:34:33 INFO - actual date: 1488382473 07:34:33 INFO - starting webserver on 'localhost:49503' 07:34:33 INFO - SUITE-START | Running 2 tests 07:34:33 INFO - TEST-START | dromaeo_css 07:34:33 INFO - operating with platform_type : mac_ 07:34:33 INFO - Initialising browser for dromaeo_css test... 07:34:33 INFO - TEST-INFO | started process 2177 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpUlIrpP/profile http://localhost:49503/getInfo.html) 07:34:34 INFO - PROCESS | 2177 | 1488382474441 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 07:34:34 INFO - PROCESS | 2177 | 1488382474442 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method install 07:34:34 INFO - PROCESS | 2177 | 1488382474483 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 07:34:36 INFO - PROCESS | 2177 | 2017-03-01 07:34:36.806 plugin-container[2179:17597] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9347, name = 'com.apple.tsm.portname' 07:34:36 INFO - PROCESS | 2177 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:34:36 INFO - PROCESS | 2177 | 2017-03-01 07:34:36.810 plugin-container[2179:17597] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960f, name = 'com.apple.CFPasteboardClient' 07:34:36 INFO - PROCESS | 2177 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:34:36 INFO - PROCESS | 2177 | 2017-03-01 07:34:36.810 plugin-container[2179:17597] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:34:36 INFO - PROCESS | 2177 | __metrics Screen width/height:1600/1200 07:34:36 INFO - PROCESS | 2177 | colorDepth:24 07:34:36 INFO - PROCESS | 2177 | Browser inner width/height: 1024/689 07:34:36 INFO - PROCESS | 2177 | __metrics 07:34:36 ERROR - PROCESS | 2177 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3354: TypeError: this.tabs is undefined 07:34:36 INFO - PROCESS | 2177 | 1488382476975 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 07:34:37 INFO - TEST-INFO | 2177: exit 0 07:34:37 INFO - Browser initialized. 07:34:37 INFO - Running cycle 1/1 for dromaeo_css test... 07:34:37 INFO - TEST-INFO | started process 2180 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpUlIrpP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:34:38 INFO - PROCESS | 2180 | 1488382478196 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 07:34:38 INFO - PROCESS | 2180 | 1488382478197 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 07:34:40 INFO - PROCESS | 2180 | 2017-03-01 07:34:40.566 plugin-container[2181:17724] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 07:34:40 INFO - PROCESS | 2180 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:34:40 INFO - PROCESS | 2180 | 2017-03-01 07:34:40.567 plugin-container[2181:17724] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0f, name = 'com.apple.CFPasteboardClient' 07:34:40 INFO - PROCESS | 2180 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:34:40 INFO - PROCESS | 2180 | 2017-03-01 07:34:40.567 plugin-container[2181:17724] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:34:50 INFO - PROCESS | 2180 | RSS: Main: 226480128 07:34:50 INFO - PROCESS | 2180 | 07:37:54 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:49503/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49503/tests/dromaeo/cssquery-ext.html) 07:37:55 INFO - PROCESS | 2180 | RSS: Main: 249974784 07:37:55 INFO - PROCESS | 2180 | 07:39:38 INFO - PROCESS | 2180 | ************************* 07:39:38 INFO - PROCESS | 2180 | A coding exception was thrown and uncaught in a Task. 07:39:38 INFO - PROCESS | 2180 | 07:39:38 ERROR - PROCESS | 2180 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:39:38 INFO - PROCESS | 2180 | Full stack: 07:39:38 INFO - PROCESS | 2180 | ************************* 07:40:57 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:49503/tests/dromaeo/cssquery-ext.html (next: http://localhost:49503/tests/dromaeo/cssquery-jquery.html) 07:40:58 INFO - PROCESS | 2180 | RSS: Main: 256520192 07:40:58 INFO - PROCESS | 2180 | 07:44:00 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:49503/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49503/tests/dromaeo/cssquery-mootools.html) 07:44:01 INFO - PROCESS | 2180 | RSS: Main: 268460032 07:44:01 INFO - PROCESS | 2180 | 07:47:03 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:49503/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49503/tests/dromaeo/cssquery-prototype.html) 07:47:03 INFO - PROCESS | 2180 | RSS: Main: 261804032 07:47:03 INFO - PROCESS | 2180 | 07:50:06 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:49503/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49503/tests/dromaeo/cssquery-yui.html) 07:50:07 INFO - PROCESS | 2180 | RSS: Main: 271417344 07:50:07 INFO - PROCESS | 2180 | 07:53:10 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:49503/tests/dromaeo/cssquery-yui.html (next: http://localhost:49503/tests/dromaeo/cssquery-dojo.html) 07:53:10 INFO - PROCESS | 2180 | RSS: Main: 265269248 07:53:10 INFO - PROCESS | 2180 | 07:53:10 INFO - PROCESS | 2180 | __start_tp_report 07:53:10 INFO - PROCESS | 2180 | _x_x_mozilla_page_load 07:53:10 INFO - PROCESS | 2180 | _x_x_mozilla_page_load_details 07:53:10 INFO - PROCESS | 2180 | |i|pagename|runs| 07:53:10 INFO - PROCESS | 2180 | |0;dojo.html;3130.5147702106174;3435.5877294724637;3459.6021457532393;3463.7229021678268;3468.2716629507795;5849.356570777211;5938.554608404371;6003.339632640412;6008.2189315389;6050.273967123941;5875.941240587593;5971.373005834379;5973.133895585138;5975.402459754023;5981.730822113004;5343.973280133604;5366.973165134188;5506.421825708303;5512.448755124496;5593.188987596796;5468.699221542814;5482.862928426801;5492.80775172869;5538.141588053858;5540.889182216353;4527.841525546606;5318.494742999428;5428.158635411518;5506.421825708303;5518.6688798672;5442.564594832404;5470.206820011116;5493.368262649807;5518.227448157261;5527.972360138174;5194.168932970744;5249.973750131263;5263.763130659129;5296.152615581527;5363.195520671891;4369.497507786614;6008.7896923607905;6032;6139.10982907476;6140.109684095826;6315.494760419156;6438.130852334969;6439.259485159219;6447.419732224075;6450.935490645127;6196.81409557714;6501.2198536175965;6517;6517.576357536793;6531.804045878631;5886.58793884424;6102.792231004478;6115.602485838406;6143.1706719592285;6168.753249869955;6561.409473147344;6620.569662971891;6645.700943457556;6646.933530664632;6648.002799580005;6183.196184496077;6289.056641503811;6313.147725057151;6326;6355.237371515448;6239.0953311770445;6248.4376406123665;6340.651264180422;6361.268454127742;6397.200349956255;5348.304720386325;6370.936290637127;6394.328595497499;6403.583767055126;6426.903596446057;6248.218972628421;6265.279492858289;6386.07401926718;6396.0405939109505;6403.007533832263;4818.542238487338;5107.387113546324;5137.306463627438;5147.536721695065;5220.269162317279;4239.788010599457;4533.365328853963;4613.0312634347165;4625.537446255415;4639.744814035261;5999.970000149971;6091.7563297467605;6209.65846878417;6214.098955651496;6224.719887605069;6251.249850018027;6358.618482891041;6384.457321127663;6395.488360931115;6452.0967064610995;6166.075088736726;6202.596831206048;6210.7515699372425;6223.502119830403;6223.813285601349;4736.478987311393;5657.377688454267;5710.914336284876;5712.257406537124;5718.828435146952;6317.368263173646;6410.0705397718;6551.967240163769;6701.698423571049;6708.712730761891;6344.429001389897;6416.550841441054;6435.935640643534;6454.774082907075;6455.419012288917;6647.767328143492;6660.800175994728;6685.799426017227;6686.5988040715765;6687.933120668731;4619.868132307606;5941.22764040672;6266.436020758154;6360.427561519486;6404.9039264412;5214.582833373397;6268.749250029948;6392.4246817786625;6446.903296450463;6488.351164883663;6277.905831412624;6280.497560195082;6290.811275661737;6296.401841825019;6314.084457753692;6143.818944274718;6252.249730032425;6261.655608941552;6265.561410701207;6305.5270854687;4974.303597496281;6028.668423236589;6120.416658368064;6141.4553230608135;6181.53638477125;6270.404311590391;6277.843053923689;6282.089097080989;6283.842903927439;6290.559660823881;6109.053096770008;6115.027386288435;6168;6227.501799856092;6234.812955611339 07:53:10 INFO - PROCESS | 2180 | |1;ext.html;719.2268311565069;725.9782206533804;798.4450806689349;935.2424536125739;936.5785396571536;37021.629783702156;37913;39605.80197099018;39755.60244397555;39881;38469.422958655574;38744.61255387445;38756;38757.22485550287;38915.41626875592;7741.651625676844;7905.604719764017;10326.483675816216;10706.571737130505;10727.034566888979;8953.820923581525;10498.84512703602;10593.099586535154;10597.947010264937;10609.15126789855;10582.100521455686;10614.469276536181;10620.309679870823;10626.734331641732;10633.57465701371;10532.631357902514;10578;10602.416867072308;10606.575736970512;10618.681439556787;10366.118879895143;10375.221858360654;10405.583776648926;10413.114885234763;10436;33339.33321333584;33376.6662333376;33505.16237094068;33514.49728254078;33631.15922101967;3584.551931008624;3602.945955810665;3615.927681446383;3625.492431059654;3763.5483741951143;24865.751342486525;25712.8714356427;25769;25863;25910.74089259121;2996.131121974625;3038.453078445879;3046.8933587324336;3081.445339838828;3147.7009684079976;298679;315736;322612.70855520177;331154;338683.99999999756;40607;42456.57543424588;42633.78683106565;42646.573534264884;42852.78573607112;44127.558724412986;44388.3341749874;44453.888652783295;44525.215356695044;44647.33029004568;12491.875081249253;12520.499180032879;12574.81137782934;12601.747965040648;12616.116871818884;10645.308054976402;10802;10804.729881752863;10813.67558973232;10825.296355736851;11571.710707232387;11596.826047609124;11613.419329033515;11710.590129345432;11821;4753.619710423158;5686.3744988051285;5719.28508936383;5740.655560666373;5750.5112065474905;837.8910741603553;926.2867591954292;927.3137877970388;933.2487347685043;956.8086382723483;22978.42553936165;25566.360840979123;26489.735102649112;26819.195424137306;26858.462830743276;917.7063339731355;1002.4436437776958;1010.4897027001317;1035.7514196592915;1040.4693606260862;12213.633590992284;13435.596932092052;13876.236806975512;14146.85853141476;14269.85730142706;399195;399674;399773;400102.9989700124;401831;53385.73307133517;53417.46582534203;53527.73236133872;53572.66068348245;54345;1400.509821562445;1446.464808021039;1448.9275536223147;1449.1956963885145;1451.2163431746949;21929.451763706034;23816.642750359104;25450.872745636152;26431.33921651974;26440.735592644596;44043;44086.77956610196;44289.33565996577;44358.778206108764;44413.77793111014;363927;366007;366850;367523;367671;21502.462438439165;22034.33896983093;22082.33752987413;22729.772702272767;22822.771772282063;38552.2289554213;38692.22615547617;39253.41119883147;39472;39611.80194099011;32548.674513254566;32618.34763304768;32814.34371312608;33590.328193436486;33609;30834.53748193734;32435.837820810746;33285.33429331351;33421;33672;32239.677603223667;32527.837360813046;32684.836575816968;32815.179620509676;32836;26399.472010560065;28381;28943.56584651274;29194.854025729735;29260.853695731385;17183.57041073983;20784.896075519526;21038.894805525873;22504.774952250922;22940 07:53:10 INFO - PROCESS | 2180 | |2;jquery.html;337.7736916266102;389.66488819615125;392.12556000119713;416.9416281720559;430.65635218119473;14632.41470341185;19848.90831004294;20427.693584596207;20853.47866303343;21184.788152118475;19372.903135484303;20099.899500502514;21680.674789878125;21845.453863653416;21987.450313742163;5770.567207459458;6281.748730050793;6772.796816095525;6831.248562658128;6835.692393842289;6692.799216023527;6813.557118787287;6844.7262109515805;7069.363757261845;7428.997085393484;7501.849963000736;7551.735689250877;7578.242175782405;7582.165961744204;7590.278923502258;7233.710651573957;7417.480776345658;7482.363999060087;7498.512596681226;7500.5874676892745;7010.404115650125;7225.927740722578;7236.095488063992;7274.527155734861;7336.376408005326;19656.901715491473;20782.6747720364;22655.753933533648;25519.23442296734;26111.73888261112;3256.495243237302;3304.5043243513423;3304.8347582620772;3346.8326583670964;3372.595288565388;15032.699346013127;15311.540653780405;15422.383104675799;15637.061776293345;16075.356985720675;1881.5860510687626;1915.2626238897985;1938.6995015772577;1979.2083166733278;1992.7010948357718;119061.40469297598;136798.5203036756;146325;146776;150149;15238.771418428732;18798.90600547016;19803;19835.60328793445;19981.100850461764;20545.48636284075;21676.783232167792;30757.846210768803;30884;30974.53538196929;9182.86225706615;9249.075092490697;9305.488198149167;9356.859647105299;9476.431414115175;8179.5501247430775;8220.177982201732;8406.94913135858;8413.873791893126;8440.282575980988;6829.146356705412;6918.792436226921;6952.478564107611;6958.304169583002;6979.371856532936;3314.105191598303;3560.5935655415965;3598.8200589970397;3917.8236979335998;3927.783971881574;881.7963479849958;982.474376208725;994.7612572982432;997.4713401897006;1029.2229366827996;18065.27738890456;19978;20945.89527052355;21128.260510882046;21167;992.4640694025289;992.7567745902301;1028.6862506935306;1031.4327120083924;1032.9586816527255;10343.534540945675;10594;10754.784904302027;10755.117854375452;10779.083777878812;676051;682365;684302;700847;704007;122957;124115.5176896475;129748.04465938234;147772;148525;967.6274634265858;983.8819341679044;1011;1016.4003238089563;1017.8422344536609;13527.594172174851;17894.463166105037;18116.90941545284;18250.543736406697;18284.634307314045;46962;52442;53931.303434828886;60542.697286515046;61185.38814611797;77238.6138069306;80014;89703.55148224217;93627;93931;9475.763105922408;10901.236913415985;11593.420328983348;11608.593699220486;11700.414979250832;12498.875011249771;12541.184822986477;12863.099583029098;12916.870831291943;13070.150440221356;11020.614278500214;11119.221654484432;11215.719607009563;11379.032782213604;11415.771684566429;10825.242233043611;10862.782744344911;11143.777124457627;11175.38535380562;11288.9435552825;11129.721756956142;11429.428528573704;11433.428328583705;11436.428178591204;11492.195546311677;11237.38194399316;11535.942320288344;11634.53461861516;11648.35934023603;11676.824847627122;9005.504697241453;11188.216824822184;11300.039496642878;11437.428128593703;11483.483243253906 07:53:10 INFO - PROCESS | 2180 | |3;mootools.html;1384.7022890078633;1545.0961187705193;1562.234505092505;1575.5667191522336;1596.9201539923004;9266.768330791734;10235.18118550516;10570;10784.352938823666;10826.729331766699;10660;10827.458627068634;10850;10851.457427128651;10876.891231087688;2290.4617414907525;2335.6262997920335;2344.6131388320905;2350.2831636350907;2367.8816059197056;2319.5940710375703;2323.2101085630884;2357.9410514737096;2362.090595120874;2364.92905212843;2102.9369118926456;2311.919082832101;2317.084751523147;2347.730011048726;2351.0360752091647;2257.3792207143083;2264.2188444986455;2278.111536500766;2280.806131478818;2284.8400611957168;2290.5189910118893;2342.121704360865;2372.7034120734907;2372.727136379321;2377.9643305350432;9330.300227482965;10270.589176432934;10940.343579385262;10954.342739435659;10967.177461690326;5396.298481197419;5549.5837812164245;5553;5556.99974004679;5575.972120139414;3342.181165614416;3415.419378705626;3584.910377240564;3618.3848745713294;3619.2761447710564;1102.0684977958672;1132.9490172942237;1174.0900801878527;1207.4807832631964;1216.8478940132484;13162.86837131626;13351.465941362334;14092.295385230698;14735.631609209748;14772.113673179643;4401.823927042947;4488.64090872736;4659.324397962344;4696.5303469653445;4703.129920964632;10793.62222322215;10817.78364432707;10860.402677852793;10862.619808306672;10915.345079295108;5485.067538518461;5562.499375056264;5568.192612071227;5572.58205634579;5587.245721827582;5110.080185566634;5186.870328241824;5190.506901844319;5191.454897235812;5236.6857988520815;3691.390920498088;3767.246550689873;3773;3840.9039774005873;3862.208247309295;1001.6293971230691;1002.4987506246877;1004.8191325561469;1019.8113349030453;1020.1226944827442;832.4048305461503;901.4591245252795;910.6858133943779;938.8873335199684;948.1087777489138;5683.516901063374;6256.74973001084;6391.936080639227;6528.706208220641;6550.246721627074;990.5839547390113;995.581855620641;1007.415698894654;1023.4780262066251;1038.5741845843168;3419.3845107880325;3969.749528898388;4057.5720398575377;4071.776052317092;4181.184668989578;12654.493820247271;13061.020423468279;13073.411696473491;13119;13124.606261812161;12763.808542871864;12919.483220671256;12950.9352453239;12971.935140324238;13044.217346959213;9756.463394513228;9766.169875560516;9876.35803672759;9882.999999999856;9896.851547226797;5842.766289348378;6160.291566469913;6255.843603909757;6374.904376434264;6415.358464153547;11742.70643233926;11847.585334513251;11951;12044.277343359427;12069;11754.823677645014;11994.940025299818;12068.424278360962;12165.817512737493;12241;7921.128675845537;8052.275295223458;8064.959675201587;8172.060213075572;8189.95905020495;9431.669891553762;9756.902430975599;9818.901810981799;9882.851757223503;9927.354721943051;8684.739457816275;8688.869666954874;8803.33974951894;8820.162084601952;8827.911720882708;8338.29124524398;8426.283765879969;8601.096884827002;8616.310695144248;8739.781505462413;7554.886676699744;7686.231376862269;7712.884306735291;7771.650275737492;7784.455088143775;5199.80404506958;5750.712464376848;5760;5920.8815823684145;5950.434708702666;5771.278590176228;5951.434613711691;5970.850728731816;6107.725152368243;6142.416470435302 07:53:10 INFO - PROCESS | 2180 | |4;prototype.html;357.37102699249346;363.5782492308922;368.1973298209902;375.84402472973716;379.6071066446227;5024.748762561876;5100.979804039189;5455.945440545594;5533.06747423865;5543.223948647193;5357.223202635615;5454.236406903036;5466.34403871536;5490.011797876381;5521.779128834852;4025.134596061846;4300.838773531153;4379.671524635649;4542.523035081318;4588.87572544727;3979.4030895365636;4189.570049371372;4565.794539245742;4593.265077587586;4617.8152873885;4406.986393129582;4411.933820992687;4580.862574122765;4583.404157459542;4601.585857272845;3654.104744337628;4053.8175782089875;4211.22092412903;4573.428321459817;4625.514320996297;3742.288965096623;3755.8920118564815;3831.8695984684587;4187.550283084399;4209.979209979197;4475.843345482925;5394.676319420847;5444.4139033958945;5456.836294911159;5533.418991005927;5125.2312153176945;5257.790708137111;5268;5321.600879933982;5332.573394128499;5128.461511541309;5542.39033706292;5780.537556995472;5858.209141765892;5931.466168044896;4208.305629571148;4303.548127446605;4567.990084362869;4674.657619801824;4685.484596694361;5122.718250496221;5762.789814139036;5795.999999999958;5871.2973237761;6302.275238347603;4597.908041839144;4741.976290118528;4801.375821143229;4838.564529192389;4843.4430040545085;4328.220920234388;4757;4921.194918896266;4952.306677065214;5011.248312753043;4375.453068366454;4995.275685025651;5193.844184674465;5224.738763061831;5252.6585771925465;5023.623228257895;5081.7967281309075;5820.534357251495;5840.591158618856;5886.8822623547285;1410.619132834129;1517.5734809279463;1589.1100983449305;1597.9760303595224;1601.6876709041626;1046.842973553973;1108.4679353910008;1181.558498631668;1184.4551506307196;1216.7992281273491;4689.742064186435;4916.606671466274;5283.65266856949;5287.550558202519;5290.513458674417;5049.343585333883;5323.254744335796;5769.942300577024;5806.767729290781;5857.824265272048;4135.29699951009;4922.483139270396;4998.600111991032;5448.128299472145;5579.581531385163;2641.4320921002077;3018.3661431099713;3026.8940587079787;3068.7391571716207;3082.7533797296164;5937.643741375531;5980.55145864062;6108.938910610926;6164.445199932027;6195.1636529068;5098.974505127525;5436.466296907042;5911.852203694856;5978.790742324085;6135.9079613805825;5735.741891614887;5785.4793068623185;6310.43206111443;6313.684315784284;6321.905171422524;5590.329160500766;5598.412166722435;5915.787263610863;6103.786367477294;6173.506119510518;5884.9705751470965;5915.704214789157;5973.685789126385;5981.3719559445635;6011.467075895619;5122.923156152735;5781.94218057814;5965.313988891333;6340.651264180515;6346.90479642815;4274.845791636179;4406.493253275914;4709.929351059668;4722.834700785456;4793.4247890252;5520.447955204448;5981.970090149695;6016.676331207127;6060.303165091492;6076.3012253591405;5274.3670759509105;5613.943860561505;5872.882542349043;5875.50058245054;5888.381719919346;4909.968906529669;5150.536451719363;5524.751386187711;5586.497215250647;5677.233573467694;4903.5586797188425;4919.877003074952;5570.4151064139305;5690.146478028163;5758.3090029196765;5241.344831896013;5571.247881535941;5765;5875.353711091862;5909.645421274738;4759.119562880878;5342.732863356739;5681.829545113488;5722.17028530869;5739.426057394227 07:53:10 INFO - PROCESS | 2180 | |5;yui.html;703.7466512055659;715.8496715689705;779.4115442840655;787.889695442638;804.493169303339;14499.05756125851;14927.253637318145;15458.381664733426;15534.912556121077;15548.300326485292;14474.5657630271;14498.42006319746;14640.4875829346;14645.04807187532;14651.560453186421;795.7970717467052;917.7889085510336;948.3740731117464;954.5561313988994;959.8128364968834;896.2740180453853;951.9333646644737;953.9618415263382;954.4798085043633;955.1833182628857;846.932245420368;1003.7691330993875;1017.2574020964701;1018.231235417259;1018.6587493189791;1007.6019972110975;1013.9290249682525;1014.9594016239341;1015.1878497202209;1016.7356487313277;743.104559006396;745.9365953893871;749.1160430691782;749.9800271630578;750.8047907544078;15691.450799221973;15970.121643309614;16068.357265709357;16124.193790310555;16334.01995880251;11512.25170363932;12005.819912701316;13257.933710331483;13378.331083445886;14364.856351436456;12232.694182645417;12643.49426022958;12720.474072299068;12842.871571284355;12843.614691559174;4524.524924882906;4567.406237189178;4582.702124361906;4596.1267359201975;4612.538746125394;87611;90144;90542.54728726314;91266;92812;9144.908550914539;11046.779064418666;11048.889511104786;11188.104951603853;11550.768984620261;22466.213682521033;22532.549349012927;22775.886120569623;22809.543809123723;22820.885895570747;7000.719971201095;7220.92779072213;7631.46579739424;7749.643812332819;7805.68777248915;4145.813438395279;4177.352510360838;4188.663345477967;4232.238197124486;4234.745915245096;3311.337732453471;3386.610539787956;3398.04854640701;3399.2861499084975;3403.268297316089;604.1722839709538;604.7490291529055;605.7819185093363;618.5824568416301;621.8880601491775;500.6470438341034;503.9974800126049;520.217073304674;524.4231345519974;538.6364204162174;9319;9343.252539796937;9421.199198068103;9741.902580974242;9799.412035277906;609.5306613907355;613.8987067133962;652.5986518291216;655.7508146904146;683.6991723641581;4292.635126014324;4472.195004899149;4629.259318509023;4656.8602941911795;4687.694552771365;93312;95303;102247.48876255572;102641;105265.47367263268;70911;73304;73773.631131844;78758.21241787623;90734.54632726795;62586;63845;65177.69644607081;68964;75142.87285690829;10541.367517948947;10754.462276886281;10755.731106722395;10764.784704305714;10796.784064318826;45375;47864.5213547874;49222;50173.24740128828;50560.74719626379;54919.901601966936;64136.35863641304;65195;66164.33835661582;68614.3138568608;12417.875821241672;12694.043052215207;12744.299063551594;12804.167729097579;13326.666833329244;13997;14301.213433261271;14434.494792682206;14458;14663.48677796272;12996.155249908727;13102.934485327512;13232.272225027331;13360.265185414895;13654.883493058593;13009.21944683322;13169;13179.209247445184;13180;13970.091944023607;12084.637460876187;12198.81701774492;12465.626031219077;12725.809112863499;12914.612561623166;10552;10662.466876656292;10830.18773591968;11025.889741102486;11091.778164436828;8301.003879534495;9016.143466370684;9859.161971232239;10710.089642380173;10723.463826808473 07:53:10 INFO - PROCESS | 2180 | __end_tp_report 07:53:10 INFO - PROCESS | 2180 | __start_cc_report 07:53:10 INFO - PROCESS | 2180 | _x_x_mozilla_cycle_collect,436 07:53:10 INFO - PROCESS | 2180 | __end_cc_report 07:53:10 INFO - PROCESS | 2180 | __startTimestamp1488383590477__endTimestamp 07:53:10 INFO - PROCESS | 2180 | 07:53:10 INFO - PROCESS | 2180 | ------- Summary: start ------- 07:53:10 INFO - PROCESS | 2180 | Number of tests: 6 07:53:10 INFO - PROCESS | 2180 | 07:53:10 INFO - PROCESS | 2180 | [#0] dojo.html Cycles:165 Average:5915.29 Median:6196.81 stddev:704.32 (11.4%) stddev-sans-first:671.75 07:53:10 INFO - PROCESS | 2180 | Values: 3130.5 3435.6 3459.6 3463.7 3468.3 5849.4 5938.6 6003.3 6008.2 6050.3 5875.9 5971.4 5973.1 5975.4 5981.7 5344.0 5367.0 5506.4 5512.4 5593.2 5468.7 5482.9 5492.8 5538.1 5540.9 4527.8 5318.5 5428.2 5506.4 5518.7 5442.6 5470.2 5493.4 5518.2 5528.0 5194.2 5250.0 5263.8 5296.2 5363.2 4369.5 6008.8 6032.0 6139.1 6140.1 6315.5 6438.1 6439.3 6447.4 6450.9 6196.8 6501.2 6517.0 6517.6 6531.8 5886.6 6102.8 6115.6 6143.2 6168.8 6561.4 6620.6 6645.7 6646.9 6648.0 6183.2 6289.1 6313.1 6326.0 6355.2 6239.1 6248.4 6340.7 6361.3 6397.2 5348.3 6370.9 6394.3 6403.6 6426.9 6248.2 6265.3 6386.1 6396.0 6403.0 4818.5 5107.4 5137.3 5147.5 5220.3 4239.8 4533.4 4613.0 4625.5 4639.7 6000.0 6091.8 6209.7 6214.1 6224.7 6251.2 6358.6 6384.5 6395.5 6452.1 6166.1 6202.6 6210.8 6223.5 6223.8 4736.5 5657.4 5710.9 5712.3 5718.8 6317.4 6410.1 6552.0 6701.7 6708.7 6344.4 6416.6 6435.9 6454.8 6455.4 6647.8 6660.8 6685.8 6686.6 6687.9 4619.9 5941.2 6266.4 6360.4 6404.9 5214.6 6268.7 6392.4 6446.9 6488.4 6277.9 6280.5 6290.8 6296.4 6314.1 6143.8 6252.2 6261.7 6265.6 6305.5 4974.3 6028.7 6120.4 6141.5 6181.5 6270.4 6277.8 6282.1 6283.8 6290.6 6109.1 6115.0 6168.0 6227.5 6234.8 07:53:10 INFO - PROCESS | 2180 | 07:53:10 INFO - PROCESS | 2180 | [#1] ext.html Cycles:180 Average:49584.91 Median:177524.27 stddev:96249.37 (54.2%) stddev-sans-first:96449.45 07:53:10 INFO - PROCESS | 2180 | Values: 719.2 726.0 798.4 935.2 936.6 37021.6 37913.0 39605.8 39755.6 39881.0 38469.4 38744.6 38756.0 38757.2 38915.4 7741.7 7905.6 10326.5 10706.6 10727.0 8953.8 10498.8 10593.1 10597.9 10609.2 10582.1 10614.5 10620.3 10626.7 10633.6 10532.6 10578.0 10602.4 10606.6 10618.7 10366.1 10375.2 10405.6 10413.1 10436.0 33339.3 33376.7 33505.2 33514.5 33631.2 3584.6 3602.9 3615.9 3625.5 3763.5 24865.8 25712.9 25769.0 25863.0 25910.7 2996.1 3038.5 3046.9 3081.4 3147.7 298679.0 315736.0 322612.7 331154.0 338684.0 40607.0 42456.6 42633.8 42646.6 42852.8 44127.6 44388.3 44453.9 44525.2 44647.3 12491.9 12520.5 12574.8 12601.7 12616.1 10645.3 10802.0 10804.7 10813.7 10825.3 11571.7 11596.8 11613.4 11710.6 11821.0 4753.6 5686.4 5719.3 5740.7 5750.5 837.9 926.3 927.3 933.2 956.8 22978.4 25566.4 26489.7 26819.2 26858.5 917.7 1002.4 1010.5 1035.8 1040.5 12213.6 13435.6 13876.2 14146.9 14269.9 399195.0 399674.0 399773.0 400103.0 401831.0 53385.7 53417.5 53527.7 53572.7 54345.0 1400.5 1446.5 1448.9 1449.2 1451.2 21929.5 23816.6 25450.9 26431.3 26440.7 44043.0 44086.8 44289.3 44358.8 44413.8 363927.0 366007.0 366850.0 367523.0 367671.0 21502.5 22034.3 22082.3 22729.8 22822.8 38552.2 38692.2 39253.4 39472.0 39611.8 32548.7 32618.3 32814.3 33590.3 33609.0 30834.5 32435.8 33285.3 33421.0 33672.0 32239.7 32527.8 32684.8 32815.2 32836.0 26399.5 28381.0 28943.6 29194.9 29260.9 17183.6 20784.9 21038.9 22504.8 22940.0 07:53:10 INFO - PROCESS | 2180 | 07:53:10 INFO - PROCESS | 2180 | [#2] jquery.html Cycles:180 Average:39750.30 Median:21678.73 stddev:114845.63 (529.8%) stddev-sans-first:115129.67 07:53:10 INFO - PROCESS | 2180 | Values: 337.8 389.7 392.1 416.9 430.7 14632.4 19848.9 20427.7 20853.5 21184.8 19372.9 20099.9 21680.7 21845.5 21987.5 5770.6 6281.7 6772.8 6831.2 6835.7 6692.8 6813.6 6844.7 7069.4 7429.0 7501.8 7551.7 7578.2 7582.2 7590.3 7233.7 7417.5 7482.4 7498.5 7500.6 7010.4 7225.9 7236.1 7274.5 7336.4 19656.9 20782.7 22655.8 25519.2 26111.7 3256.5 3304.5 3304.8 3346.8 3372.6 15032.7 15311.5 15422.4 15637.1 16075.4 1881.6 1915.3 1938.7 1979.2 1992.7 119061.4 136798.5 146325.0 146776.0 150149.0 15238.8 18798.9 19803.0 19835.6 19981.1 20545.5 21676.8 30757.8 30884.0 30974.5 9182.9 9249.1 9305.5 9356.9 9476.4 8179.6 8220.2 8406.9 8413.9 8440.3 6829.1 6918.8 6952.5 6958.3 6979.4 3314.1 3560.6 3598.8 3917.8 3927.8 881.8 982.5 994.8 997.5 1029.2 18065.3 19978.0 20945.9 21128.3 21167.0 992.5 992.8 1028.7 1031.4 1033.0 10343.5 10594.0 10754.8 10755.1 10779.1 676051.0 682365.0 684302.0 700847.0 704007.0 122957.0 124115.5 129748.0 147772.0 148525.0 967.6 983.9 1011.0 1016.4 1017.8 13527.6 17894.5 18116.9 18250.5 18284.6 46962.0 52442.0 53931.3 60542.7 61185.4 77238.6 80014.0 89703.6 93627.0 93931.0 9475.8 10901.2 11593.4 11608.6 11700.4 12498.9 12541.2 12863.1 12916.9 13070.2 11020.6 11119.2 11215.7 11379.0 11415.8 10825.2 10862.8 11143.8 11175.4 11288.9 11129.7 11429.4 11433.4 11436.4 11492.2 11237.4 11535.9 11634.5 11648.4 11676.8 9005.5 11188.2 11300.0 11437.4 11483.5 07:53:10 INFO - PROCESS | 2180 | 07:53:10 INFO - PROCESS | 2180 | [#3] mootools.html Cycles:180 Average:6462.04 Median:3618.83 stddev:3985.12 (110.1%) stddev-sans-first:3978.03 07:53:10 INFO - PROCESS | 2180 | Values: 1384.7 1545.1 1562.2 1575.6 1596.9 9266.8 10235.2 10570.0 10784.4 10826.7 10660.0 10827.5 10850.0 10851.5 10876.9 2290.5 2335.6 2344.6 2350.3 2367.9 2319.6 2323.2 2357.9 2362.1 2364.9 2102.9 2311.9 2317.1 2347.7 2351.0 2257.4 2264.2 2278.1 2280.8 2284.8 2290.5 2342.1 2372.7 2372.7 2378.0 9330.3 10270.6 10940.3 10954.3 10967.2 5396.3 5549.6 5553.0 5557.0 5576.0 3342.2 3415.4 3584.9 3618.4 3619.3 1102.1 1132.9 1174.1 1207.5 1216.8 13162.9 13351.5 14092.3 14735.6 14772.1 4401.8 4488.6 4659.3 4696.5 4703.1 10793.6 10817.8 10860.4 10862.6 10915.3 5485.1 5562.5 5568.2 5572.6 5587.2 5110.1 5186.9 5190.5 5191.5 5236.7 3691.4 3767.2 3773.0 3840.9 3862.2 1001.6 1002.5 1004.8 1019.8 1020.1 832.4 901.5 910.7 938.9 948.1 5683.5 6256.7 6391.9 6528.7 6550.2 990.6 995.6 1007.4 1023.5 1038.6 3419.4 3969.7 4057.6 4071.8 4181.2 12654.5 13061.0 13073.4 13119.0 13124.6 12763.8 12919.5 12950.9 12971.9 13044.2 9756.5 9766.2 9876.4 9883.0 9896.9 5842.8 6160.3 6255.8 6374.9 6415.4 11742.7 11847.6 11951.0 12044.3 12069.0 11754.8 11994.9 12068.4 12165.8 12241.0 7921.1 8052.3 8065.0 8172.1 8190.0 9431.7 9756.9 9818.9 9882.9 9927.4 8684.7 8688.9 8803.3 8820.2 8827.9 8338.3 8426.3 8601.1 8616.3 8739.8 7554.9 7686.2 7712.9 7771.7 7784.5 5199.8 5750.7 5760.0 5920.9 5950.4 5771.3 5951.4 5970.9 6107.7 6142.4 07:53:10 INFO - PROCESS | 2180 | 07:53:10 INFO - PROCESS | 2180 | [#4] prototype.html Cycles:180 Average:4837.80 Median:5247.00 stddev:1368.41 (26.1%) stddev-sans-first:1330.28 07:53:10 INFO - PROCESS | 2180 | Values: 357.4 363.6 368.2 375.8 379.6 5024.7 5101.0 5455.9 5533.1 5543.2 5357.2 5454.2 5466.3 5490.0 5521.8 4025.1 4300.8 4379.7 4542.5 4588.9 3979.4 4189.6 4565.8 4593.3 4617.8 4407.0 4411.9 4580.9 4583.4 4601.6 3654.1 4053.8 4211.2 4573.4 4625.5 3742.3 3755.9 3831.9 4187.6 4210.0 4475.8 5394.7 5444.4 5456.8 5533.4 5125.2 5257.8 5268.0 5321.6 5332.6 5128.5 5542.4 5780.5 5858.2 5931.5 4208.3 4303.5 4568.0 4674.7 4685.5 5122.7 5762.8 5796.0 5871.3 6302.3 4597.9 4742.0 4801.4 4838.6 4843.4 4328.2 4757.0 4921.2 4952.3 5011.2 4375.5 4995.3 5193.8 5224.7 5252.7 5023.6 5081.8 5820.5 5840.6 5886.9 1410.6 1517.6 1589.1 1598.0 1601.7 1046.8 1108.5 1181.6 1184.5 1216.8 4689.7 4916.6 5283.7 5287.6 5290.5 5049.3 5323.3 5769.9 5806.8 5857.8 4135.3 4922.5 4998.6 5448.1 5579.6 2641.4 3018.4 3026.9 3068.7 3082.8 5937.6 5980.6 6108.9 6164.4 6195.2 5099.0 5436.5 5911.9 5978.8 6135.9 5735.7 5785.5 6310.4 6313.7 6321.9 5590.3 5598.4 5915.8 6103.8 6173.5 5885.0 5915.7 5973.7 5981.4 6011.5 5122.9 5781.9 5965.3 6340.7 6346.9 4274.8 4406.5 4709.9 4722.8 4793.4 5520.4 5982.0 6016.7 6060.3 6076.3 5274.4 5613.9 5872.9 5875.5 5888.4 4910.0 5150.5 5524.8 5586.5 5677.2 4903.6 4919.9 5570.4 5690.1 5758.3 5241.3 5571.2 5765.0 5875.4 5909.6 4759.1 5342.7 5681.8 5722.2 5739.4 07:53:10 INFO - PROCESS | 2180 | 07:53:10 INFO - PROCESS | 2180 | [#5] yui.html Cycles:180 Average:19180.40 Median:4210.45 stddev:26454.86 (628.3%) stddev-sans-first:26492.69 07:53:10 INFO - PROCESS | 2180 | Values: 703.7 715.8 779.4 787.9 804.5 14499.1 14927.3 15458.4 15534.9 15548.3 14474.6 14498.4 14640.5 14645.0 14651.6 795.8 917.8 948.4 954.6 959.8 896.3 951.9 954.0 954.5 955.2 846.9 1003.8 1017.3 1018.2 1018.7 1007.6 1013.9 1015.0 1015.2 1016.7 743.1 745.9 749.1 750.0 750.8 15691.5 15970.1 16068.4 16124.2 16334.0 11512.3 12005.8 13257.9 13378.3 14364.9 12232.7 12643.5 12720.5 12842.9 12843.6 4524.5 4567.4 4582.7 4596.1 4612.5 87611.0 90144.0 90542.5 91266.0 92812.0 9144.9 11046.8 11048.9 11188.1 11550.8 22466.2 22532.5 22775.9 22809.5 22820.9 7000.7 7220.9 7631.5 7749.6 7805.7 4145.8 4177.4 4188.7 4232.2 4234.7 3311.3 3386.6 3398.0 3399.3 3403.3 604.2 604.7 605.8 618.6 621.9 500.6 504.0 520.2 524.4 538.6 9319.0 9343.3 9421.2 9741.9 9799.4 609.5 613.9 652.6 655.8 683.7 4292.6 4472.2 4629.3 4656.9 4687.7 93312.0 95303.0 102247.5 102641.0 105265.5 70911.0 73304.0 73773.6 78758.2 90734.5 62586.0 63845.0 65177.7 68964.0 75142.9 10541.4 10754.5 10755.7 10764.8 10796.8 45375.0 47864.5 49222.0 50173.2 50560.7 54919.9 64136.4 65195.0 66164.3 68614.3 12417.9 12694.0 12744.3 12804.2 13326.7 13997.0 14301.2 14434.5 14458.0 14663.5 12996.2 13102.9 13232.3 13360.3 13654.9 13009.2 13169.0 13179.2 13180.0 13970.1 12084.6 12198.8 12465.6 12725.8 12914.6 10552.0 10662.5 10830.2 11025.9 11091.8 8301.0 9016.1 9859.2 10710.1 10723.5 07:53:10 INFO - PROCESS | 2180 | -------- Summary: end -------- 07:53:10 INFO - PROCESS | 2180 | 07:53:10 INFO - PROCESS | 2180 | 1488383590503 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 07:53:11 INFO - TEST-INFO | 2180: exit 0 07:53:11 INFO - TEST-OK | dromaeo_css | took 1117254ms 07:53:11 INFO - TEST-START | kraken 07:53:11 INFO - operating with platform_type : mac_ 07:53:11 INFO - Initialising browser for kraken test... 07:53:11 INFO - TEST-INFO | started process 2184 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpz0K23i/profile http://localhost:49503/getInfo.html) 07:53:11 INFO - PROCESS | 2184 | 1488383591679 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 07:53:11 INFO - PROCESS | 2184 | 1488383591680 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method install 07:53:11 INFO - PROCESS | 2184 | 1488383591721 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 07:53:14 INFO - PROCESS | 2184 | 2017-03-01 07:53:14.165 plugin-container[2185:19862] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 07:53:14 INFO - PROCESS | 2184 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:53:14 INFO - PROCESS | 2184 | 2017-03-01 07:53:14.169 plugin-container[2185:19862] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 07:53:14 INFO - PROCESS | 2184 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:53:14 INFO - PROCESS | 2184 | 2017-03-01 07:53:14.169 plugin-container[2185:19862] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:53:14 INFO - PROCESS | 2184 | __metrics Screen width/height:1600/1200 07:53:14 INFO - PROCESS | 2184 | colorDepth:24 07:53:14 INFO - PROCESS | 2184 | Browser inner width/height: 1024/689 07:53:14 INFO - PROCESS | 2184 | __metrics 07:53:14 ERROR - PROCESS | 2184 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3354: TypeError: this.tabs is undefined 07:53:14 INFO - PROCESS | 2184 | 1488383594387 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 07:53:15 INFO - TEST-INFO | 2184: exit 0 07:53:15 INFO - Browser initialized. 07:53:15 INFO - Running cycle 1/1 for kraken test... 07:53:15 INFO - TEST-INFO | started process 2186 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpz0K23i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:53:15 INFO - PROCESS | 2186 | 1488383595587 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 07:53:15 INFO - PROCESS | 2186 | 1488383595588 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 07:53:17 INFO - PROCESS | 2186 | 2017-03-01 07:53:17.803 plugin-container[2187:19989] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x473b, name = 'com.apple.tsm.portname' 07:53:17 INFO - PROCESS | 2186 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:53:17 INFO - PROCESS | 2186 | 2017-03-01 07:53:17.804 plugin-container[2187:19989] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 07:53:17 INFO - PROCESS | 2186 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:53:17 INFO - PROCESS | 2186 | 2017-03-01 07:53:17.804 plugin-container[2187:19989] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:53:27 INFO - PROCESS | 2186 | RSS: Main: 226324480 07:53:27 INFO - PROCESS | 2186 | 07:53:30 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:49503/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49503/tests/kraken/driver.html?testName=audio-beat-detection) 07:53:31 INFO - PROCESS | 2186 | RSS: Main: 241082368 07:53:31 INFO - PROCESS | 2186 | 07:53:34 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:49503/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49503/tests/kraken/driver.html?testName=audio-dft) 07:53:34 INFO - PROCESS | 2186 | RSS: Main: 249270272 07:53:34 INFO - PROCESS | 2186 | 07:53:38 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:49503/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49503/tests/kraken/driver.html?testName=audio-fft) 07:53:39 INFO - PROCESS | 2186 | RSS: Main: 251805696 07:53:39 INFO - PROCESS | 2186 | 07:53:41 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:49503/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49503/tests/kraken/driver.html?testName=audio-oscillator) 07:53:41 INFO - PROCESS | 2186 | RSS: Main: 252985344 07:53:41 INFO - PROCESS | 2186 | 07:53:43 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:49503/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49503/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:53:44 INFO - PROCESS | 2186 | RSS: Main: 253259776 07:53:44 INFO - PROCESS | 2186 | 07:53:47 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:49503/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49503/tests/kraken/driver.html?testName=imaging-darkroom) 07:53:48 INFO - PROCESS | 2186 | RSS: Main: 259444736 07:53:48 INFO - PROCESS | 2186 | 07:53:51 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:49503/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49503/tests/kraken/driver.html?testName=imaging-desaturate) 07:53:52 INFO - PROCESS | 2186 | RSS: Main: 258265088 07:53:52 INFO - PROCESS | 2186 | 07:53:55 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:49503/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49503/tests/kraken/driver.html?testName=json-parse-financial) 07:53:56 INFO - PROCESS | 2186 | RSS: Main: 259350528 07:53:56 INFO - PROCESS | 2186 | 07:53:57 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:49503/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49503/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:53:58 INFO - PROCESS | 2186 | RSS: Main: 259432448 07:53:58 INFO - PROCESS | 2186 | 07:54:00 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:49503/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49503/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:54:00 INFO - PROCESS | 2186 | RSS: Main: 259457024 07:54:00 INFO - PROCESS | 2186 | 07:54:03 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:49503/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49503/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:54:03 INFO - PROCESS | 2186 | RSS: Main: 259608576 07:54:03 INFO - PROCESS | 2186 | 07:54:06 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:49503/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49503/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:54:07 INFO - PROCESS | 2186 | RSS: Main: 259915776 07:54:07 INFO - PROCESS | 2186 | 07:54:10 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:49503/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49503/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:54:11 INFO - PROCESS | 2186 | RSS: Main: 257187840 07:54:11 INFO - PROCESS | 2186 | 07:54:13 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:49503/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49503/tests/kraken/driver.html?testName=ai-astar) 07:54:13 INFO - PROCESS | 2186 | RSS: Main: 260730880 07:54:13 INFO - PROCESS | 2186 | 07:54:13 INFO - PROCESS | 2186 | __start_tp_report 07:54:13 INFO - PROCESS | 2186 | _x_x_mozilla_page_load 07:54:13 INFO - PROCESS | 2186 | _x_x_mozilla_page_load_details 07:54:13 INFO - PROCESS | 2186 | |i|pagename|runs| 07:54:13 INFO - PROCESS | 2186 | |0;ai-astar;108;121;125;119;119;119;121;153;183;138 07:54:13 INFO - PROCESS | 2186 | |1;audio-beat-detection;143;114;110;150;113;114;114;111;144;146 07:54:13 INFO - PROCESS | 2186 | |2;audio-dft;209;220;241;241;279;252;199;201;200;202 07:54:13 INFO - PROCESS | 2186 | |3;audio-fft;87;60;63;85;61;60;64;73;102;62 07:54:13 INFO - PROCESS | 2186 | |4;audio-oscillator;86;69;88;100;86;71;82;70;75;85 07:54:13 INFO - PROCESS | 2186 | |5;imaging-gaussian-blur;89;90;106;100;91;90;91;90;91;90 07:54:13 INFO - PROCESS | 2186 | |6;imaging-darkroom;98;98;98;102;99;98;133;139;100;98 07:54:13 INFO - PROCESS | 2186 | |7;imaging-desaturate;90;91;126;99;99;144;144;91;91;90 07:54:13 INFO - PROCESS | 2186 | |8;json-parse-financial;66;65;66;79;67;61;65;66;68;66 07:54:13 INFO - PROCESS | 2186 | |9;json-stringify-tinderbox;57;61;60;67;71;65;60;58;60;77 07:54:13 INFO - PROCESS | 2186 | |10;stanford-crypto-aes;88;94;97;89;89;91;91;91;96;88 07:54:13 INFO - PROCESS | 2186 | |11;stanford-crypto-ccm;153;163;142;147;159;146;141;157;211;160 07:54:13 INFO - PROCESS | 2186 | |12;stanford-crypto-pbkdf2;178;211;266;243;180;173;175;175;215;246 07:54:13 INFO - PROCESS | 2186 | |13;stanford-crypto-sha256-iterative;72;85;76;71;71;69;68;66;70;67 07:54:13 INFO - PROCESS | 2186 | __end_tp_report 07:54:13 INFO - PROCESS | 2186 | __start_cc_report 07:54:13 INFO - PROCESS | 2186 | _x_x_mozilla_cycle_collect,1026 07:54:13 INFO - PROCESS | 2186 | __end_cc_report 07:54:13 INFO - PROCESS | 2186 | __startTimestamp1488383653535__endTimestamp 07:54:13 INFO - PROCESS | 2186 | 07:54:13 INFO - PROCESS | 2186 | ------- Summary: start ------- 07:54:13 INFO - PROCESS | 2186 | Number of tests: 14 07:54:13 INFO - PROCESS | 2186 | 07:54:13 INFO - PROCESS | 2186 | [#0] ai-astar Cycles:10 Average:130.60 Median:123.00 stddev:22.19 (18.0%) stddev-sans-first:21.98 07:54:13 INFO - PROCESS | 2186 | Values: 108.0 121.0 125.0 119.0 119.0 119.0 121.0 153.0 183.0 138.0 07:54:13 INFO - PROCESS | 2186 | 07:54:13 INFO - PROCESS | 2186 | [#1] audio-beat-detection Cycles:10 Average:125.90 Median:128.50 stddev:17.23 (13.4%) stddev-sans-first:17.12 07:54:13 INFO - PROCESS | 2186 | Values: 143.0 114.0 110.0 150.0 113.0 114.0 114.0 111.0 144.0 146.0 07:54:13 INFO - PROCESS | 2186 | 07:54:13 INFO - PROCESS | 2186 | [#2] audio-dft Cycles:10 Average:224.40 Median:230.50 stddev:27.57 (12.0%) stddev-sans-first:28.67 07:54:13 INFO - PROCESS | 2186 | Values: 209.0 220.0 241.0 241.0 279.0 252.0 199.0 201.0 200.0 202.0 07:54:13 INFO - PROCESS | 2186 | 07:54:13 INFO - PROCESS | 2186 | [#3] audio-fft Cycles:10 Average:71.70 Median:63.50 stddev:14.71 (23.2%) stddev-sans-first:14.53 07:54:13 INFO - PROCESS | 2186 | Values: 87.0 60.0 63.0 85.0 61.0 60.0 64.0 73.0 102.0 62.0 07:54:13 INFO - PROCESS | 2186 | 07:54:13 INFO - PROCESS | 2186 | [#4] audio-oscillator Cycles:10 Average:81.20 Median:83.50 stddev:9.87 (11.8%) stddev-sans-first:10.32 07:54:13 INFO - PROCESS | 2186 | Values: 86.0 69.0 88.0 100.0 86.0 71.0 82.0 70.0 75.0 85.0 07:54:13 INFO - PROCESS | 2186 | 07:54:13 INFO - PROCESS | 2186 | [#5] imaging-gaussian-blur Cycles:10 Average:92.80 Median:90.00 stddev:5.59 (6.2%) stddev-sans-first:5.76 07:54:13 INFO - PROCESS | 2186 | Values: 89.0 90.0 106.0 100.0 91.0 90.0 91.0 90.0 91.0 90.0 07:54:13 INFO - PROCESS | 2186 | 07:54:13 INFO - PROCESS | 2186 | [#6] imaging-darkroom Cycles:10 Average:106.30 Median:98.00 stddev:15.77 (16.1%) stddev-sans-first:16.44 07:54:13 INFO - PROCESS | 2186 | Values: 98.0 98.0 98.0 102.0 99.0 98.0 133.0 139.0 100.0 98.0 07:54:13 INFO - PROCESS | 2186 | 07:54:13 INFO - PROCESS | 2186 | [#7] imaging-desaturate Cycles:10 Average:106.50 Median:91.00 stddev:22.54 (24.8%) stddev-sans-first:23.10 07:54:13 INFO - PROCESS | 2186 | Values: 90.0 91.0 126.0 99.0 99.0 144.0 144.0 91.0 91.0 90.0 07:54:13 INFO - PROCESS | 2186 | 07:54:13 INFO - PROCESS | 2186 | [#8] json-parse-financial Cycles:10 Average:66.90 Median:66.00 stddev:4.63 (7.0%) stddev-sans-first:4.90 07:54:13 INFO - PROCESS | 2186 | Values: 66.0 65.0 66.0 79.0 67.0 61.0 65.0 66.0 68.0 66.0 07:54:13 INFO - PROCESS | 2186 | 07:54:13 INFO - PROCESS | 2186 | [#9] json-stringify-tinderbox Cycles:10 Average:63.60 Median:63.00 stddev:6.40 (10.2%) stddev-sans-first:6.32 07:54:13 INFO - PROCESS | 2186 | Values: 57.0 61.0 60.0 67.0 71.0 65.0 60.0 58.0 60.0 77.0 07:54:13 INFO - PROCESS | 2186 | 07:54:13 INFO - PROCESS | 2186 | [#10] stanford-crypto-aes Cycles:10 Average:91.40 Median:91.00 stddev:3.24 (3.6%) stddev-sans-first:3.19 07:54:13 INFO - PROCESS | 2186 | Values: 88.0 94.0 97.0 89.0 89.0 91.0 91.0 91.0 96.0 88.0 07:54:13 INFO - PROCESS | 2186 | 07:54:13 INFO - PROCESS | 2186 | [#11] stanford-crypto-ccm Cycles:10 Average:157.90 Median:158.00 stddev:20.21 (12.8%) stddev-sans-first:21.35 07:54:13 INFO - PROCESS | 2186 | Values: 153.0 163.0 142.0 147.0 159.0 146.0 141.0 157.0 211.0 160.0 07:54:13 INFO - PROCESS | 2186 | 07:54:13 INFO - PROCESS | 2186 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:206.20 Median:213.00 stddev:35.19 (16.5%) stddev-sans-first:35.82 07:54:13 INFO - PROCESS | 2186 | Values: 178.0 211.0 266.0 243.0 180.0 173.0 175.0 175.0 215.0 246.0 07:54:13 INFO - PROCESS | 2186 | 07:54:13 INFO - PROCESS | 2186 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:71.00 stddev:5.52 (7.8%) stddev-sans-first:5.85 07:54:13 INFO - PROCESS | 2186 | Values: 72.0 85.0 76.0 71.0 71.0 69.0 68.0 66.0 70.0 67.0 07:54:13 INFO - PROCESS | 2186 | -------- Summary: end -------- 07:54:13 INFO - PROCESS | 2186 | 07:54:13 INFO - PROCESS | 2186 | 1488383653558 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 07:54:14 INFO - TEST-INFO | 2186: exit 0 07:54:14 INFO - TEST-OK | kraken | took 63254ms 07:54:14 INFO - SUITE-END | took 1180s 07:54:14 INFO - Completed test suite (00:19:40) 07:54:14 INFO - javascript benchmark 07:54:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7544.571854003692, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3130.5147702106174, 3435.5877294724637, 3459.6021457532393, 3463.7229021678268, 3468.2716629507795, 5849.356570777211, 5938.554608404371, 6003.339632640412, 6008.2189315389, 6050.273967123941, 5875.941240587593, 5971.373005834379, 5973.133895585138, 5975.402459754023, 5981.730822113004, 5343.973280133604, 5366.973165134188, 5506.421825708303, 5512.448755124496, 5593.188987596796, 5468.699221542814, 5482.862928426801, 5492.80775172869, 5538.141588053858, 5540.889182216353, 4527.841525546606, 5318.494742999428, 5428.158635411518, 5506.421825708303, 5518.6688798672, 5442.564594832404, 5470.206820011116, 5493.368262649807, 5518.227448157261, 5527.972360138174, 5194.168932970744, 5249.973750131263, 5263.763130659129, 5296.152615581527, 5363.195520671891, 4369.497507786614, 6008.7896923607905, 6032.0, 6139.10982907476, 6140.109684095826, 6315.494760419156, 6438.130852334969, 6439.259485159219, 6447.419732224075, 6450.935490645127, 6196.81409557714, 6501.2198536175965, 6517.0, 6517.576357536793, 6531.804045878631, 5886.58793884424, 6102.792231004478, 6115.602485838406, 6143.1706719592285, 6168.753249869955, 6561.409473147344, 6620.569662971891, 6645.700943457556, 6646.933530664632, 6648.002799580005, 6183.196184496077, 6289.056641503811, 6313.147725057151, 6326.0, 6355.237371515448, 6239.0953311770445, 6248.4376406123665, 6340.651264180422, 6361.268454127742, 6397.200349956255, 5348.304720386325, 6370.936290637127, 6394.328595497499, 6403.583767055126, 6426.903596446057, 6248.218972628421, 6265.279492858289, 6386.07401926718, 6396.0405939109505, 6403.007533832263, 4818.542238487338, 5107.387113546324, 5137.306463627438, 5147.536721695065, 5220.269162317279, 4239.788010599457, 4533.365328853963, 4613.0312634347165, 4625.537446255415, 4639.744814035261, 5999.970000149971, 6091.7563297467605, 6209.65846878417, 6214.098955651496, 6224.719887605069, 6251.249850018027, 6358.618482891041, 6384.457321127663, 6395.488360931115, 6452.0967064610995, 6166.075088736726, 6202.596831206048, 6210.7515699372425, 6223.502119830403, 6223.813285601349, 4736.478987311393, 5657.377688454267, 5710.914336284876, 5712.257406537124, 5718.828435146952, 6317.368263173646, 6410.0705397718, 6551.967240163769, 6701.698423571049, 6708.712730761891, 6344.429001389897, 6416.550841441054, 6435.935640643534, 6454.774082907075, 6455.419012288917, 6647.767328143492, 6660.800175994728, 6685.799426017227, 6686.5988040715765, 6687.933120668731, 4619.868132307606, 5941.22764040672, 6266.436020758154, 6360.427561519486, 6404.9039264412, 5214.582833373397, 6268.749250029948, 6392.4246817786625, 6446.903296450463, 6488.351164883663, 6277.905831412624, 6280.497560195082, 6290.811275661737, 6296.401841825019, 6314.084457753692, 6143.818944274718, 6252.249730032425, 6261.655608941552, 6265.561410701207, 6305.5270854687, 4974.303597496281, 6028.668423236589, 6120.416658368064, 6141.4553230608135, 6181.53638477125, 6270.404311590391, 6277.843053923689, 6282.089097080989, 6283.842903927439, 6290.559660823881, 6109.053096770008, 6115.027386288435, 6168.0, 6227.501799856092, 6234.812955611339], "value": 5871.115986386244, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.2268311565069, 725.9782206533804, 798.4450806689349, 935.2424536125739, 936.5785396571536, 37021.629783702156, 37913.0, 39605.80197099018, 39755.60244397555, 39881.0, 38469.422958655574, 38744.61255387445, 38756.0, 38757.22485550287, 38915.41626875592, 7741.651625676844, 7905.604719764017, 10326.483675816216, 10706.571737130505, 10727.034566888979, 8953.820923581525, 10498.84512703602, 10593.099586535154, 10597.947010264937, 10609.15126789855, 10582.100521455686, 10614.469276536181, 10620.309679870823, 10626.734331641732, 10633.57465701371, 10532.631357902514, 10578.0, 10602.416867072308, 10606.575736970512, 10618.681439556787, 10366.118879895143, 10375.221858360654, 10405.583776648926, 10413.114885234763, 10436.0, 33339.33321333584, 33376.6662333376, 33505.16237094068, 33514.49728254078, 33631.15922101967, 3584.551931008624, 3602.945955810665, 3615.927681446383, 3625.492431059654, 3763.5483741951143, 24865.751342486525, 25712.8714356427, 25769.0, 25863.0, 25910.74089259121, 2996.131121974625, 3038.453078445879, 3046.8933587324336, 3081.445339838828, 3147.7009684079976, 298679.0, 315736.0, 322612.70855520177, 331154.0, 338683.99999999756, 40607.0, 42456.57543424588, 42633.78683106565, 42646.573534264884, 42852.78573607112, 44127.558724412986, 44388.3341749874, 44453.888652783295, 44525.215356695044, 44647.33029004568, 12491.875081249253, 12520.499180032879, 12574.81137782934, 12601.747965040648, 12616.116871818884, 10645.308054976402, 10802.0, 10804.729881752863, 10813.67558973232, 10825.296355736851, 11571.710707232387, 11596.826047609124, 11613.419329033515, 11710.590129345432, 11821.0, 4753.619710423158, 5686.3744988051285, 5719.28508936383, 5740.655560666373, 5750.5112065474905, 837.8910741603553, 926.2867591954292, 927.3137877970388, 933.2487347685043, 956.8086382723483, 22978.42553936165, 25566.360840979123, 26489.735102649112, 26819.195424137306, 26858.462830743276, 917.7063339731355, 1002.4436437776958, 1010.4897027001317, 1035.7514196592915, 1040.4693606260862, 12213.633590992284, 13435.596932092052, 13876.236806975512, 14146.85853141476, 14269.85730142706, 399195.0, 399674.0, 399773.0, 400102.9989700124, 401831.0, 53385.73307133517, 53417.46582534203, 53527.73236133872, 53572.66068348245, 54345.0, 1400.509821562445, 1446.464808021039, 1448.9275536223147, 1449.1956963885145, 1451.2163431746949, 21929.451763706034, 23816.642750359104, 25450.872745636152, 26431.33921651974, 26440.735592644596, 44043.0, 44086.77956610196, 44289.33565996577, 44358.778206108764, 44413.77793111014, 363927.0, 366007.0, 366850.0, 367523.0, 367671.0, 21502.462438439165, 22034.33896983093, 22082.33752987413, 22729.772702272767, 22822.771772282063, 38552.2289554213, 38692.22615547617, 39253.41119883147, 39472.0, 39611.80194099011, 32548.674513254566, 32618.34763304768, 32814.34371312608, 33590.328193436486, 33609.0, 30834.53748193734, 32435.837820810746, 33285.33429331351, 33421.0, 33672.0, 32239.677603223667, 32527.837360813046, 32684.836575816968, 32815.179620509676, 32836.0, 26399.472010560065, 28381.0, 28943.56584651274, 29194.854025729735, 29260.853695731385, 17183.57041073983, 20784.896075519526, 21038.894805525873, 22504.774952250922, 22940.0], "value": 17459.38502159344, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.7736916266102, 389.66488819615125, 392.12556000119713, 416.9416281720559, 430.65635218119473, 14632.41470341185, 19848.90831004294, 20427.693584596207, 20853.47866303343, 21184.788152118475, 19372.903135484303, 20099.899500502514, 21680.674789878125, 21845.453863653416, 21987.450313742163, 5770.567207459458, 6281.748730050793, 6772.796816095525, 6831.248562658128, 6835.692393842289, 6692.799216023527, 6813.557118787287, 6844.7262109515805, 7069.363757261845, 7428.997085393484, 7501.849963000736, 7551.735689250877, 7578.242175782405, 7582.165961744204, 7590.278923502258, 7233.710651573957, 7417.480776345658, 7482.363999060087, 7498.512596681226, 7500.5874676892745, 7010.404115650125, 7225.927740722578, 7236.095488063992, 7274.527155734861, 7336.376408005326, 19656.901715491473, 20782.6747720364, 22655.753933533648, 25519.23442296734, 26111.73888261112, 3256.495243237302, 3304.5043243513423, 3304.8347582620772, 3346.8326583670964, 3372.595288565388, 15032.699346013127, 15311.540653780405, 15422.383104675799, 15637.061776293345, 16075.356985720675, 1881.5860510687626, 1915.2626238897985, 1938.6995015772577, 1979.2083166733278, 1992.7010948357718, 119061.40469297598, 136798.5203036756, 146325.0, 146776.0, 150149.0, 15238.771418428732, 18798.90600547016, 19803.0, 19835.60328793445, 19981.100850461764, 20545.48636284075, 21676.783232167792, 30757.846210768803, 30884.0, 30974.53538196929, 9182.86225706615, 9249.075092490697, 9305.488198149167, 9356.859647105299, 9476.431414115175, 8179.5501247430775, 8220.177982201732, 8406.94913135858, 8413.873791893126, 8440.282575980988, 6829.146356705412, 6918.792436226921, 6952.478564107611, 6958.304169583002, 6979.371856532936, 3314.105191598303, 3560.5935655415965, 3598.8200589970397, 3917.8236979335998, 3927.783971881574, 881.7963479849958, 982.474376208725, 994.7612572982432, 997.4713401897006, 1029.2229366827996, 18065.27738890456, 19978.0, 20945.89527052355, 21128.260510882046, 21167.0, 992.4640694025289, 992.7567745902301, 1028.6862506935306, 1031.4327120083924, 1032.9586816527255, 10343.534540945675, 10594.0, 10754.784904302027, 10755.117854375452, 10779.083777878812, 676051.0, 682365.0, 684302.0, 700847.0, 704007.0, 122957.0, 124115.5176896475, 129748.04465938234, 147772.0, 148525.0, 967.6274634265858, 983.8819341679044, 1011.0, 1016.4003238089563, 1017.8422344536609, 13527.594172174851, 17894.463166105037, 18116.90941545284, 18250.543736406697, 18284.634307314045, 46962.0, 52442.0, 53931.303434828886, 60542.697286515046, 61185.38814611797, 77238.6138069306, 80014.0, 89703.55148224217, 93627.0, 93931.0, 9475.763105922408, 10901.236913415985, 11593.420328983348, 11608.593699220486, 11700.414979250832, 12498.875011249771, 12541.184822986477, 12863.099583029098, 12916.870831291943, 13070.150440221356, 11020.614278500214, 11119.221654484432, 11215.719607009563, 11379.032782213604, 11415.771684566429, 10825.242233043611, 10862.782744344911, 11143.777124457627, 11175.38535380562, 11288.9435552825, 11129.721756956142, 11429.428528573704, 11433.428328583705, 11436.428178591204, 11492.195546311677, 11237.38194399316, 11535.942320288344, 11634.53461861516, 11648.35934023603, 11676.824847627122, 9005.504697241453, 11188.216824822184, 11300.039496642878, 11437.428128593703, 11483.483243253906], "value": 11068.262341386071, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1384.7022890078633, 1545.0961187705193, 1562.234505092505, 1575.5667191522336, 1596.9201539923004, 9266.768330791734, 10235.18118550516, 10570.0, 10784.352938823666, 10826.729331766699, 10660.0, 10827.458627068634, 10850.0, 10851.457427128651, 10876.891231087688, 2290.4617414907525, 2335.6262997920335, 2344.6131388320905, 2350.2831636350907, 2367.8816059197056, 2319.5940710375703, 2323.2101085630884, 2357.9410514737096, 2362.090595120874, 2364.92905212843, 2102.9369118926456, 2311.919082832101, 2317.084751523147, 2347.730011048726, 2351.0360752091647, 2257.3792207143083, 2264.2188444986455, 2278.111536500766, 2280.806131478818, 2284.8400611957168, 2290.5189910118893, 2342.121704360865, 2372.7034120734907, 2372.727136379321, 2377.9643305350432, 9330.300227482965, 10270.589176432934, 10940.343579385262, 10954.342739435659, 10967.177461690326, 5396.298481197419, 5549.5837812164245, 5553.0, 5556.99974004679, 5575.972120139414, 3342.181165614416, 3415.419378705626, 3584.910377240564, 3618.3848745713294, 3619.2761447710564, 1102.0684977958672, 1132.9490172942237, 1174.0900801878527, 1207.4807832631964, 1216.8478940132484, 13162.86837131626, 13351.465941362334, 14092.295385230698, 14735.631609209748, 14772.113673179643, 4401.823927042947, 4488.64090872736, 4659.324397962344, 4696.5303469653445, 4703.129920964632, 10793.62222322215, 10817.78364432707, 10860.402677852793, 10862.619808306672, 10915.345079295108, 5485.067538518461, 5562.499375056264, 5568.192612071227, 5572.58205634579, 5587.245721827582, 5110.080185566634, 5186.870328241824, 5190.506901844319, 5191.454897235812, 5236.6857988520815, 3691.390920498088, 3767.246550689873, 3773.0, 3840.9039774005873, 3862.208247309295, 1001.6293971230691, 1002.4987506246877, 1004.8191325561469, 1019.8113349030453, 1020.1226944827442, 832.4048305461503, 901.4591245252795, 910.6858133943779, 938.8873335199684, 948.1087777489138, 5683.516901063374, 6256.74973001084, 6391.936080639227, 6528.706208220641, 6550.246721627074, 990.5839547390113, 995.581855620641, 1007.415698894654, 1023.4780262066251, 1038.5741845843168, 3419.3845107880325, 3969.749528898388, 4057.5720398575377, 4071.776052317092, 4181.184668989578, 12654.493820247271, 13061.020423468279, 13073.411696473491, 13119.0, 13124.606261812161, 12763.808542871864, 12919.483220671256, 12950.9352453239, 12971.935140324238, 13044.217346959213, 9756.463394513228, 9766.169875560516, 9876.35803672759, 9882.999999999856, 9896.851547226797, 5842.766289348378, 6160.291566469913, 6255.843603909757, 6374.904376434264, 6415.358464153547, 11742.70643233926, 11847.585334513251, 11951.0, 12044.277343359427, 12069.0, 11754.823677645014, 11994.940025299818, 12068.424278360962, 12165.817512737493, 12241.0, 7921.128675845537, 8052.275295223458, 8064.959675201587, 8172.060213075572, 8189.95905020495, 9431.669891553762, 9756.902430975599, 9818.901810981799, 9882.851757223503, 9927.354721943051, 8684.739457816275, 8688.869666954874, 8803.33974951894, 8820.162084601952, 8827.911720882708, 8338.29124524398, 8426.283765879969, 8601.096884827002, 8616.310695144248, 8739.781505462413, 7554.886676699744, 7686.231376862269, 7712.884306735291, 7771.650275737492, 7784.455088143775, 5199.80404506958, 5750.712464376848, 5760.0, 5920.8815823684145, 5950.434708702666, 5771.278590176228, 5951.434613711691, 5970.850728731816, 6107.725152368243, 6142.416470435302], "value": 4961.1001599902465, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.37102699249346, 363.5782492308922, 368.1973298209902, 375.84402472973716, 379.6071066446227, 5024.748762561876, 5100.979804039189, 5455.945440545594, 5533.06747423865, 5543.223948647193, 5357.223202635615, 5454.236406903036, 5466.34403871536, 5490.011797876381, 5521.779128834852, 4025.134596061846, 4300.838773531153, 4379.671524635649, 4542.523035081318, 4588.87572544727, 3979.4030895365636, 4189.570049371372, 4565.794539245742, 4593.265077587586, 4617.8152873885, 4406.986393129582, 4411.933820992687, 4580.862574122765, 4583.404157459542, 4601.585857272845, 3654.104744337628, 4053.8175782089875, 4211.22092412903, 4573.428321459817, 4625.514320996297, 3742.288965096623, 3755.8920118564815, 3831.8695984684587, 4187.550283084399, 4209.979209979197, 4475.843345482925, 5394.676319420847, 5444.4139033958945, 5456.836294911159, 5533.418991005927, 5125.2312153176945, 5257.790708137111, 5268.0, 5321.600879933982, 5332.573394128499, 5128.461511541309, 5542.39033706292, 5780.537556995472, 5858.209141765892, 5931.466168044896, 4208.305629571148, 4303.548127446605, 4567.990084362869, 4674.657619801824, 4685.484596694361, 5122.718250496221, 5762.789814139036, 5795.999999999958, 5871.2973237761, 6302.275238347603, 4597.908041839144, 4741.976290118528, 4801.375821143229, 4838.564529192389, 4843.4430040545085, 4328.220920234388, 4757.0, 4921.194918896266, 4952.306677065214, 5011.248312753043, 4375.453068366454, 4995.275685025651, 5193.844184674465, 5224.738763061831, 5252.6585771925465, 5023.623228257895, 5081.7967281309075, 5820.534357251495, 5840.591158618856, 5886.8822623547285, 1410.619132834129, 1517.5734809279463, 1589.1100983449305, 1597.9760303595224, 1601.6876709041626, 1046.842973553973, 1108.4679353910008, 1181.558498631668, 1184.4551506307196, 1216.7992281273491, 4689.742064186435, 4916.606671466274, 5283.65266856949, 5287.550558202519, 5290.513458674417, 5049.343585333883, 5323.254744335796, 5769.942300577024, 5806.767729290781, 5857.824265272048, 4135.29699951009, 4922.483139270396, 4998.600111991032, 5448.128299472145, 5579.581531385163, 2641.4320921002077, 3018.3661431099713, 3026.8940587079787, 3068.7391571716207, 3082.7533797296164, 5937.643741375531, 5980.55145864062, 6108.938910610926, 6164.445199932027, 6195.1636529068, 5098.974505127525, 5436.466296907042, 5911.852203694856, 5978.790742324085, 6135.9079613805825, 5735.741891614887, 5785.4793068623185, 6310.43206111443, 6313.684315784284, 6321.905171422524, 5590.329160500766, 5598.412166722435, 5915.787263610863, 6103.786367477294, 6173.506119510518, 5884.9705751470965, 5915.704214789157, 5973.685789126385, 5981.3719559445635, 6011.467075895619, 5122.923156152735, 5781.94218057814, 5965.313988891333, 6340.651264180515, 6346.90479642815, 4274.845791636179, 4406.493253275914, 4709.929351059668, 4722.834700785456, 4793.4247890252, 5520.447955204448, 5981.970090149695, 6016.676331207127, 6060.303165091492, 6076.3012253591405, 5274.3670759509105, 5613.943860561505, 5872.882542349043, 5875.50058245054, 5888.381719919346, 4909.968906529669, 5150.536451719363, 5524.751386187711, 5586.497215250647, 5677.233573467694, 4903.5586797188425, 4919.877003074952, 5570.4151064139305, 5690.146478028163, 5758.3090029196765, 5241.344831896013, 5571.247881535941, 5765.0, 5875.353711091862, 5909.645421274738, 4759.119562880878, 5342.732863356739, 5681.829545113488, 5722.17028530869, 5739.426057394227], "value": 4425.419498435412, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.7466512055659, 715.8496715689705, 779.4115442840655, 787.889695442638, 804.493169303339, 14499.05756125851, 14927.253637318145, 15458.381664733426, 15534.912556121077, 15548.300326485292, 14474.5657630271, 14498.42006319746, 14640.4875829346, 14645.04807187532, 14651.560453186421, 795.7970717467052, 917.7889085510336, 948.3740731117464, 954.5561313988994, 959.8128364968834, 896.2740180453853, 951.9333646644737, 953.9618415263382, 954.4798085043633, 955.1833182628857, 846.932245420368, 1003.7691330993875, 1017.2574020964701, 1018.231235417259, 1018.6587493189791, 1007.6019972110975, 1013.9290249682525, 1014.9594016239341, 1015.1878497202209, 1016.7356487313277, 743.104559006396, 745.9365953893871, 749.1160430691782, 749.9800271630578, 750.8047907544078, 15691.450799221973, 15970.121643309614, 16068.357265709357, 16124.193790310555, 16334.01995880251, 11512.25170363932, 12005.819912701316, 13257.933710331483, 13378.331083445886, 14364.856351436456, 12232.694182645417, 12643.49426022958, 12720.474072299068, 12842.871571284355, 12843.614691559174, 4524.524924882906, 4567.406237189178, 4582.702124361906, 4596.1267359201975, 4612.538746125394, 87611.0, 90144.0, 90542.54728726314, 91266.0, 92812.0, 9144.908550914539, 11046.779064418666, 11048.889511104786, 11188.104951603853, 11550.768984620261, 22466.213682521033, 22532.549349012927, 22775.886120569623, 22809.543809123723, 22820.885895570747, 7000.719971201095, 7220.92779072213, 7631.46579739424, 7749.643812332819, 7805.68777248915, 4145.813438395279, 4177.352510360838, 4188.663345477967, 4232.238197124486, 4234.745915245096, 3311.337732453471, 3386.610539787956, 3398.04854640701, 3399.2861499084975, 3403.268297316089, 604.1722839709538, 604.7490291529055, 605.7819185093363, 618.5824568416301, 621.8880601491775, 500.6470438341034, 503.9974800126049, 520.217073304674, 524.4231345519974, 538.6364204162174, 9319.0, 9343.252539796937, 9421.199198068103, 9741.902580974242, 9799.412035277906, 609.5306613907355, 613.8987067133962, 652.5986518291216, 655.7508146904146, 683.6991723641581, 4292.635126014324, 4472.195004899149, 4629.259318509023, 4656.8602941911795, 4687.694552771365, 93312.0, 95303.0, 102247.48876255572, 102641.0, 105265.47367263268, 70911.0, 73304.0, 73773.631131844, 78758.21241787623, 90734.54632726795, 62586.0, 63845.0, 65177.69644607081, 68964.0, 75142.87285690829, 10541.367517948947, 10754.462276886281, 10755.731106722395, 10764.784704305714, 10796.784064318826, 45375.0, 47864.5213547874, 49222.0, 50173.24740128828, 50560.74719626379, 54919.901601966936, 64136.35863641304, 65195.0, 66164.33835661582, 68614.3138568608, 12417.875821241672, 12694.043052215207, 12744.299063551594, 12804.167729097579, 13326.666833329244, 13997.0, 14301.213433261271, 14434.494792682206, 14458.0, 14663.48677796272, 12996.155249908727, 13102.934485327512, 13232.272225027331, 13360.265185414895, 13654.883493058593, 13009.21944683322, 13169.0, 13179.209247445184, 13180.0, 13970.091944023607, 12084.637460876187, 12198.81701774492, 12465.626031219077, 12725.809112863499, 12914.612561623166, 10552.0, 10662.466876656292, 10830.18773591968, 11025.889741102486, 11091.778164436828, 8301.003879534495, 9016.143466370684, 9859.161971232239, 10710.089642380173, 10723.463826808473], "value": 7403.022611161021, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1596.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 121.0, 125.0, 119.0, 119.0, 119.0, 121.0, 153.0, 183.0, 138.0], "value": 130.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 114.0, 110.0, 150.0, 113.0, 114.0, 114.0, 111.0, 144.0, 146.0], "value": 125.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [209.0, 220.0, 241.0, 241.0, 279.0, 252.0, 199.0, 201.0, 200.0, 202.0], "value": 224.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 60.0, 63.0, 85.0, 61.0, 60.0, 64.0, 73.0, 102.0, 62.0], "value": 71.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 69.0, 88.0, 100.0, 86.0, 71.0, 82.0, 70.0, 75.0, 85.0], "value": 81.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 106.0, 100.0, 91.0, 90.0, 91.0, 90.0, 91.0, 90.0], "value": 92.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 98.0, 98.0, 102.0, 99.0, 98.0, 133.0, 139.0, 100.0, 98.0], "value": 106.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 91.0, 126.0, 99.0, 99.0, 144.0, 144.0, 91.0, 91.0, 90.0], "value": 106.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 79.0, 67.0, 61.0, 65.0, 66.0, 68.0, 66.0], "value": 66.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 61.0, 60.0, 67.0, 71.0, 65.0, 60.0, 58.0, 60.0, 77.0], "value": 63.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 94.0, 97.0, 89.0, 89.0, 91.0, 91.0, 91.0, 96.0, 88.0], "value": 91.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 163.0, 142.0, 147.0, 159.0, 146.0, 141.0, 157.0, 211.0, 160.0], "value": 157.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 211.0, 266.0, 243.0, 180.0, 173.0, 175.0, 175.0, 215.0, 246.0], "value": 206.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 85.0, 76.0, 71.0, 71.0, 69.0, 68.0, 66.0, 70.0, 67.0], "value": 71.5, "unit": "score"}]}]} 07:54:14 INFO - Return code: 0 07:54:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:54:14 ERROR - # TBPL SUCCESS # 07:54:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:54:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:54:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:54:14 INFO - 2017-03-01 07:54:14.855 screenresolution[2191:20391] starting screenresolution argv=screenresolution get 07:54:14 INFO - 2017-03-01 07:54:14.858 screenresolution[2191:20391] Display 0: 1600x1200x32@60 07:54:14 INFO - 2017-03-01 07:54:14.864 screenresolution[2192:20395] starting screenresolution argv=screenresolution list 07:54:14 INFO - Available Modes on Display 0 07:54:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:54:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:54:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:54:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:54:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:54:15 INFO - Intel Iris: 07:54:15 INFO - Chipset Model: Intel Iris 07:54:15 INFO - Type: GPU 07:54:15 INFO - Bus: Built-In 07:54:15 INFO - VRAM (Dynamic, Max): 1536 MB 07:54:15 INFO - Vendor: Intel (0x8086) 07:54:15 INFO - Device ID: 0x0a2e 07:54:15 INFO - Revision ID: 0x0009 07:54:15 INFO - Displays: 07:54:15 INFO - Display: 07:54:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:54:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:54:15 INFO - Display Serial Number: 1600x1200 60 07:54:15 INFO - Main Display: Yes 07:54:15 INFO - Mirror: Off 07:54:15 INFO - Online: Yes 07:54:15 INFO - Rotation: Supported 07:54:15 INFO - Return code: 0 07:54:15 INFO - Running post-action listener: _resource_record_post_action 07:54:15 INFO - [mozharness: 2017-03-01 15:54:15.099859Z] Finished run-tests step (success) 07:54:15 INFO - Running post-run listener: _resource_record_post_run 07:54:15 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 1840640; Write bytes: 515015168; Read time: 18; Write time: 2180 07:54:15 INFO - TinderboxPrint: CPU usage
54.5% 07:54:15 INFO - TinderboxPrint: I/O read bytes / time
1,840,640 / 18 07:54:15 INFO - TinderboxPrint: I/O write bytes / time
515,015,168 / 2,180 07:54:15 INFO - TinderboxPrint: CPU idle
2,188.8 (45.5%) 07:54:15 INFO - TinderboxPrint: CPU system
969.6 (20.2%) 07:54:15 INFO - TinderboxPrint: CPU user
1,651.3 (34.3%) 07:54:15 INFO - TinderboxPrint: Swap in / out
212,692,992 / 0 07:54:15 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 202811904; Write bytes: 201658368; Read time: 15758; Write time: 362 07:54:15 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 1840640; Write bytes: 303550976; Read time: 18; Write time: 1789 07:54:15 INFO - Running post-run listener: _upload_blobber_files 07:54:15 INFO - Blob upload gear active. 07:54:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:54:15 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 07:54:15 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'] 07:54:15 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 07:54:15 INFO - (blobuploader) - INFO - Open directory for files ... 07:54:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:54:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:54:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:54:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:54:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:54:18 INFO - (blobuploader) - INFO - Done attempting. 07:54:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:54:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:54:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:54:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:54:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:54:19 INFO - (blobuploader) - INFO - Done attempting. 07:54:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:54:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:54:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:54:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:54:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:54:20 INFO - (blobuploader) - INFO - Done attempting. 07:54:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:54:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:54:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:54:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:54:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:54:22 INFO - (blobuploader) - INFO - Done attempting. 07:54:22 INFO - (blobuploader) - INFO - Iteration through files over. 07:54:22 INFO - Return code: 0 07:54:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:54:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:54:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92def80e879023607d398f4ead05af6f9e3c64e8a6b8c267e72953fd1978346f3210d4646296de760b6d22f12d041cc2bdfd610feefb69a0d4c4fe2cc4d440e3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db342c64370e55f51bf4ac32c8de7b5e455f2803b5ea58df8d03c68329e025a829ab047040b32a679196a3c861a7555e2a52f1026cdc6316d4541d903bf720dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73ae35e751c51834b79fecbd2ed7085121a295260d85fa6822ced4487563d0c9f74019baf99e7d5cd401ccc376ffca204475444329cd7fa0c029a4a505bb995b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b968bf5bb12f735e62072a43bc05a76a4923f69672e349c9934a715d06333b2ff5f994e15f57d644cad15b886f24ad69c3703c311cefb6ac076ea4e826d0b50"} 07:54:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:54:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:54:22 INFO - Contents: 07:54:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92def80e879023607d398f4ead05af6f9e3c64e8a6b8c267e72953fd1978346f3210d4646296de760b6d22f12d041cc2bdfd610feefb69a0d4c4fe2cc4d440e3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db342c64370e55f51bf4ac32c8de7b5e455f2803b5ea58df8d03c68329e025a829ab047040b32a679196a3c861a7555e2a52f1026cdc6316d4541d903bf720dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73ae35e751c51834b79fecbd2ed7085121a295260d85fa6822ced4487563d0c9f74019baf99e7d5cd401ccc376ffca204475444329cd7fa0c029a4a505bb995b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b968bf5bb12f735e62072a43bc05a76a4923f69672e349c9934a715d06333b2ff5f994e15f57d644cad15b886f24ad69c3703c311cefb6ac076ea4e826d0b50"} 07:54:22 INFO - Running post-run listener: copy_logs_to_upload_dir 07:54:22 INFO - Copying logs to upload dir... 07:54:22 INFO - mkdir: /builds/slave/test/build/upload/logs 07:54:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.093247 ========= master_lag: 0.35 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-01 07:54:22.581025) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-01 07:54:22.585683) ========= 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.gyFJXrR83y/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.6cCQGoFPoR/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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/92def80e879023607d398f4ead05af6f9e3c64e8a6b8c267e72953fd1978346f3210d4646296de760b6d22f12d041cc2bdfd610feefb69a0d4c4fe2cc4d440e3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db342c64370e55f51bf4ac32c8de7b5e455f2803b5ea58df8d03c68329e025a829ab047040b32a679196a3c861a7555e2a52f1026cdc6316d4541d903bf720dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73ae35e751c51834b79fecbd2ed7085121a295260d85fa6822ced4487563d0c9f74019baf99e7d5cd401ccc376ffca204475444329cd7fa0c029a4a505bb995b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b968bf5bb12f735e62072a43bc05a76a4923f69672e349c9934a715d06333b2ff5f994e15f57d644cad15b886f24ad69c3703c311cefb6ac076ea4e826d0b50"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011222 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92def80e879023607d398f4ead05af6f9e3c64e8a6b8c267e72953fd1978346f3210d4646296de760b6d22f12d041cc2bdfd610feefb69a0d4c4fe2cc4d440e3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db342c64370e55f51bf4ac32c8de7b5e455f2803b5ea58df8d03c68329e025a829ab047040b32a679196a3c861a7555e2a52f1026cdc6316d4541d903bf720dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73ae35e751c51834b79fecbd2ed7085121a295260d85fa6822ced4487563d0c9f74019baf99e7d5cd401ccc376ffca204475444329cd7fa0c029a4a505bb995b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b968bf5bb12f735e62072a43bc05a76a4923f69672e349c9934a715d06333b2ff5f994e15f57d644cad15b886f24ad69c3703c311cefb6ac076ea4e826d0b50"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-01 07:54:22.628028) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 07:54:22.628411) ========= 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.gyFJXrR83y/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.6cCQGoFPoR/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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.005366 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 07:54:22.677094) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-01 07:54:22.680514) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-01 07:54:22.680879) ========= ========= Total master_lag: 0.79 =========