builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0269 starttime: 1488382382.16 results: success (0) buildid: 20170301072336 builduid: 7c30fda4e6d84bbdafbc45cd8658a9b4 revision: 34c6c2f302e7b48e3ad2cec575cbd34d423a9d32 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-01 07:33:02.156783) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-01 07:33:02.157237) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-01 07:33:02.157541) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-01 07:33:02.182632) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 07:33:02.182983) ========= 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.0qyWs5DeAF/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.S14m8eK4qG/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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:33:02-- 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% 149M=0s 2017-03-01 07:33:02 (149 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.084038 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 07:33:02.291735) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 07:33:02.292042) ========= 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.0qyWs5DeAF/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.S14m8eK4qG/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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.022205 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 07:33:02.340305) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 07:33:02.340661) ========= 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.0qyWs5DeAF/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.S14m8eK4qG/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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:33:02,433 truncating revision to first 12 chars 2017-03-01 07:33:02,433 Setting DEBUG logging. 2017-03-01 07:33:02,433 attempt 1/10 2017-03-01 07:33:02,433 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:33:03,059 unpacking tar archive at: mozilla-central-34c6c2f302e7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.887835 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 07:33:03.252426) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-01 07:33:03.252781) ========= script_repo_revision: 34c6c2f302e7b48e3ad2cec575cbd34d423a9d32 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-01 07:33:03.253223) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-01 07:33:03.253526) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-01 07:33:03.273995) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-03-01 07:33:03.274418) ========= /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.0qyWs5DeAF/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.S14m8eK4qG/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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:03 INFO - MultiFileLogger online at 20170301 07:33:03 in /builds/slave/test 07:33:03 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:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:33:03 INFO - {'append_to_log': False, 07:33:03 INFO - 'base_work_dir': '/builds/slave/test', 07:33:03 INFO - 'blob_upload_branch': 'Firefox', 07:33:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:33:03 INFO - 'branch': 'Firefox', 07:33:03 INFO - 'buildbot_json_path': 'buildprops.json', 07:33:03 INFO - 'config_files': ('talos/mac_config.py',), 07:33:03 INFO - 'default_actions': ('clobber', 07:33:03 INFO - 'read-buildbot-config', 07:33:03 INFO - 'download-and-extract', 07:33:03 INFO - 'populate-webroot', 07:33:03 INFO - 'create-virtualenv', 07:33:03 INFO - 'install', 07:33:03 INFO - 'run-tests'), 07:33:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:33:03 INFO - 'download_minidump_stackwalk': True, 07:33:03 INFO - 'download_symbols': 'ondemand', 07:33:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:33:03 INFO - 'tooltool.py': '/tools/tooltool.py', 07:33:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:33:03 INFO - '/tools/misc-python/virtualenv.py')}, 07:33:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:33:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:33:03 INFO - 'gecko_profile': False, 07:33:03 INFO - 'gecko_profile_interval': 0, 07:33:03 INFO - 'installer_path': 'installer.exe', 07:33:03 INFO - 'log_level': 'info', 07:33:03 INFO - 'log_name': 'talos', 07:33:03 INFO - 'log_to_console': True, 07:33:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:33:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:33:03 INFO - 'opt_config_files': (), 07:33:03 INFO - 'pip_index': False, 07:33:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:33:03 INFO - 'cmd': ('bash', 07:33:03 INFO - '-c', 07:33:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:33:03 INFO - 'enabled': True, 07:33:03 INFO - 'halt_on_failure': False, 07:33:03 INFO - 'name': 'check_screen_resolution'},), 07:33:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:33:03 INFO - 'cmd': ('bash', 07:33:03 INFO - '-c', 07:33:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:33:03 INFO - 'enabled': True, 07:33:03 INFO - 'halt_on_failure': False, 07:33:03 INFO - 'name': 'check_screen_resolution'},), 07:33:03 INFO - 'run_cmd_checks_enabled': True, 07:33:03 INFO - 'suite': 'dromaeojs-e10s', 07:33:03 INFO - 'system_bits': '32', 07:33:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:33:03 INFO - 'title': 't-yosemite-r7-0269', 07:33:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:33:03 INFO - 'use_talos_json': True, 07:33:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:33:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:33:03 INFO - 'work_dir': 'build'} 07:33:03 INFO - [mozharness: 2017-03-01 15:33:03.486298Z] Running clobber step. 07:33:03 INFO - Running pre-action listener: _resource_record_pre_action 07:33:03 INFO - Running main action method: clobber 07:33:03 INFO - rmtree: /builds/slave/test/build 07:33:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:33:05 INFO - Running post-action listener: _resource_record_post_action 07:33:05 INFO - [mozharness: 2017-03-01 15:33:05.422585Z] Finished clobber step (success) 07:33:05 INFO - [mozharness: 2017-03-01 15:33:05.422720Z] Running read-buildbot-config step. 07:33:05 INFO - Running pre-action listener: _resource_record_pre_action 07:33:05 INFO - Running main action method: read_buildbot_config 07:33:05 INFO - Using buildbot properties: 07:33:05 INFO - { 07:33:05 INFO - "project": "", 07:33:05 INFO - "product": "firefox", 07:33:05 INFO - "script_repo_revision": "production", 07:33:05 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 07:33:05 INFO - "repository": "", 07:33:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 07:33:05 INFO - "buildid": "20170301072336", 07:33:05 INFO - "stage_platform": "macosx64", 07:33:05 INFO - "basedir": "/builds/slave/test", 07:33:05 INFO - "buildnumber": 104, 07:33:05 INFO - "platform": "yosemite_r7", 07:33:05 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 07:33:05 INFO - "slavebuilddir": "test", 07:33:05 INFO - "branch": "mozilla-central", 07:33:05 INFO - "revision": "34c6c2f302e7b48e3ad2cec575cbd34d423a9d32", 07:33:05 INFO - "slavename": "t-yosemite-r7-0269", 07:33:05 INFO - "builduid": "7c30fda4e6d84bbdafbc45cd8658a9b4", 07:33:05 INFO - "repo_path": "mozilla-central" 07:33:05 INFO - } 07:33:05 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:05 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:05 INFO - Running post-action listener: _resource_record_post_action 07:33:05 INFO - [mozharness: 2017-03-01 15:33:05.426012Z] Finished read-buildbot-config step (success) 07:33:05 INFO - [mozharness: 2017-03-01 15:33:05.426130Z] Running download-and-extract step. 07:33:05 INFO - Running pre-action listener: _resource_record_pre_action 07:33:05 INFO - Running main action method: download_and_extract 07:33:05 INFO - mkdir: /builds/slave/test/build/tests 07:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:05 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:05 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:05 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:05 INFO - Downloaded 1199 bytes. 07:33:05 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 07:33:05 INFO - Using the following test package requirements: 07:33:05 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 07:33:05 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:33:05 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 07:33:05 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:33:05 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 07:33:05 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:33:05 INFO - u'jsshell-mac.zip'], 07:33:05 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:33:05 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 07:33:05 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 07:33:05 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:33:05 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 07:33:05 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:33:05 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 07:33:05 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:33:05 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 07:33:05 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:33:05 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 07:33:05 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:33:05 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:05 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:05 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:06 INFO - Expected file size: 51762826 07:33:06 INFO - Obtained file size: 51762826 07:33:22 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:22 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:22 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:22 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:23 INFO - Expected file size: 51762826 07:33:23 INFO - Obtained file size: 51762826 07:33:38 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:38 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:38 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:39 INFO - Expected file size: 14404421 07:33:39 INFO - Obtained file size: 14404421 07:33:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:39 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.dmg 07:33:39 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:39 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:41 INFO - Downloaded 74973774 bytes. 07:33:41 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:41 INFO - mkdir: /builds/slave/test/properties 07:33:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:33:41 INFO - Writing to file /builds/slave/test/properties/build_url 07:33:41 INFO - Contents: 07:33:41 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.dmg 07:33:41 INFO - Running post-action listener: _resource_record_post_action 07:33:41 INFO - Running post-action listener: set_extra_try_arguments 07:33:41 INFO - [mozharness: 2017-03-01 15:33:41.878881Z] Finished download-and-extract step (success) 07:33:41 INFO - [mozharness: 2017-03-01 15:33:41.879019Z] Running populate-webroot step. 07:33:41 INFO - Running pre-action listener: _resource_record_pre_action 07:33:41 INFO - Running main action method: populate_webroot 07:33:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:33:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:33:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:33:41 INFO - '--tppagecycles', 07:33:41 INFO - '7'], 07:33:41 INFO - 'tests': ['tsvgm']}}, 07:33:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:33:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:33:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:33:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:33:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:33:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:33:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:33:41 INFO - 'talos_options': ['--disable-e10s'], 07:33:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:33:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:33:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:33:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:33:41 INFO - 'talos_options': ['--disable-e10s'], 07:33:41 INFO - 'tests': ['damp', 'tps']}, 07:33:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:33:41 INFO - 'tests': ['damp', 'tps']}, 07:33:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:33:41 INFO - 'tests': ['dromaeo_dom']}, 07:33:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:33:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:33:41 INFO - 'tests': ['basic_compositor_video']}, 07:33:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:33:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:33:41 INFO - 'tests': ['a11yr', 07:33:41 INFO - 'ts_paint', 07:33:41 INFO - 'tpaint', 07:33:41 INFO - 'sessionrestore', 07:33:41 INFO - 'sessionrestore_no_auto_restore', 07:33:41 INFO - 'tabpaint']}, 07:33:41 INFO - 'other-e10s': {'tests': ['a11yr', 07:33:41 INFO - 'ts_paint', 07:33:41 INFO - 'tpaint', 07:33:41 INFO - 'sessionrestore', 07:33:41 INFO - 'sessionrestore_no_auto_restore', 07:33:41 INFO - 'tabpaint']}, 07:33:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:33:41 INFO - 'ts_paint', 07:33:41 INFO - 'tpaint', 07:33:41 INFO - 'sessionrestore', 07:33:41 INFO - 'sessionrestore_no_auto_restore', 07:33:41 INFO - 'tabpaint']}, 07:33:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:33:41 INFO - 'ts_paint', 07:33:41 INFO - 'tpaint', 07:33:41 INFO - 'sessionrestore', 07:33:41 INFO - 'sessionrestore_no_auto_restore', 07:33:41 INFO - 'tabpaint']}, 07:33:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:33:41 INFO - 'tests': ['a11yr', 07:33:41 INFO - 'ts_paint', 07:33:41 INFO - 'tpaint', 07:33:41 INFO - 'sessionrestore', 07:33:41 INFO - 'sessionrestore_no_auto_restore', 07:33:41 INFO - 'tabpaint']}, 07:33:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:33:41 INFO - 'tests': ['a11yr', 07:33:41 INFO - 'ts_paint', 07:33:41 INFO - 'tpaint', 07:33:41 INFO - 'sessionrestore', 07:33:41 INFO - 'sessionrestore_no_auto_restore', 07:33:41 INFO - 'tabpaint']}, 07:33:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:33:41 INFO - 'tests': ['tsvgx', 07:33:41 INFO - 'tsvgr_opacity', 07:33:41 INFO - 'tart', 07:33:41 INFO - 'tscrollx', 07:33:41 INFO - 'cart', 07:33:41 INFO - 'tsvg_static']}, 07:33:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:33:41 INFO - 'tsvgr_opacity', 07:33:41 INFO - 'tart', 07:33:41 INFO - 'tscrollx', 07:33:41 INFO - 'cart', 07:33:41 INFO - 'tsvg_static']}, 07:33:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:33:41 INFO - 'talos_options': ['--disable-e10s'], 07:33:41 INFO - 'tests': ['tp5o']}, 07:33:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:33:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:33:41 INFO - 'talos_options': ['--disable-e10s', 07:33:41 INFO - '--xperf_path', 07:33:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:33:41 INFO - 'tests': ['tp5n']}, 07:33:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:33:41 INFO - 'talos_options': ['--xperf_path', 07:33:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:33:41 INFO - 'tests': ['tp5n']}}, 07:33:41 INFO - 'talos.zip': {'path': '', 07:33:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:33:41 INFO - Running post-action listener: _resource_record_post_action 07:33:41 INFO - [mozharness: 2017-03-01 15:33:41.897390Z] Finished populate-webroot step (success) 07:33:41 INFO - [mozharness: 2017-03-01 15:33:41.897478Z] Running create-virtualenv step. 07:33:41 INFO - Running pre-action listener: _resource_record_pre_action 07:33:41 INFO - Running main action method: create_virtualenv 07:33:41 INFO - Creating virtualenv /builds/slave/test/build/venv 07:33:41 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:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:33:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:33:42 INFO - Using real prefix '/tools/python27' 07:33:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:33:42 INFO - Installing distribute.............................................................................................................................................................................................done. 07:33:45 INFO - Installing pip.................done. 07:33:45 INFO - Return code: 0 07:33:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:33:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:33:46 INFO - Reading from file tmpfile_stdout 07:33:46 INFO - Output received: 07:33:46 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:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:46 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 0x101773b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101776768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea8ad89090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101551d30>, '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 0x101478db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101546be8>, '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.0qyWs5DeAF/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.S14m8eK4qG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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:46 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:46 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:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0qyWs5DeAF/Render', 07:33:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:46 INFO - 'HOME': '/Users/cltbld', 07:33:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:46 INFO - 'LOGNAME': 'cltbld', 07:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:46 INFO - 'MOZ_NO_REMOTE': '1', 07:33:46 INFO - 'NO_EM_RESTART': '1', 07:33:46 INFO - 'PAGER': '/bin/cat', 07:33:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:46 INFO - 'PWD': '/builds/slave/test', 07:33:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:46 INFO - 'SHELL': '/bin/bash', 07:33:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S14m8eK4qG/Listeners', 07:33:46 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 07:33:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:46 INFO - 'USER': 'cltbld', 07:33:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:46 INFO - 'XPC_FLAGS': '0x0', 07:33:46 INFO - 'XPC_SERVICE_NAME': '0', 07:33:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:46 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:46 INFO - Cleaning up... 07:33:46 INFO - Return code: 0 07:33:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:46 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 0x101773b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101776768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea8ad89090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101551d30>, '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 0x101478db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101546be8>, '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.0qyWs5DeAF/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.S14m8eK4qG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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:46 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:46 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:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0qyWs5DeAF/Render', 07:33:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:46 INFO - 'HOME': '/Users/cltbld', 07:33:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:46 INFO - 'LOGNAME': 'cltbld', 07:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:46 INFO - 'MOZ_NO_REMOTE': '1', 07:33:46 INFO - 'NO_EM_RESTART': '1', 07:33:46 INFO - 'PAGER': '/bin/cat', 07:33:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:46 INFO - 'PWD': '/builds/slave/test', 07:33:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:46 INFO - 'SHELL': '/bin/bash', 07:33:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S14m8eK4qG/Listeners', 07:33:46 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 07:33:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:46 INFO - 'USER': 'cltbld', 07:33:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:46 INFO - 'XPC_FLAGS': '0x0', 07:33:46 INFO - 'XPC_SERVICE_NAME': '0', 07:33:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:46 INFO - Downloading/unpacking psutil>=3.1.1 07:33:46 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:46 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 - 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:46 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:46 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:46 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 - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:33:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:33:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:33:50 INFO - Installing collected packages: psutil 07:33:50 INFO - Running setup.py install for psutil 07:33:50 INFO - building 'psutil._psutil_osx' extension 07:33:50 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:50 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:50 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:50 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:50 INFO - building 'psutil._psutil_posix' extension 07:33:50 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:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:33:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:33:50 INFO - ^ 07:33:50 INFO - 1 warning generated. 07:33:50 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:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:33:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:33:51 INFO - Successfully installed psutil 07:33:51 INFO - Cleaning up... 07:33:51 INFO - Return code: 0 07:33:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:33:51 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:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:51 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:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:51 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 0x101773b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101776768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea8ad89090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101551d30>, '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 0x101478db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101546be8>, '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.0qyWs5DeAF/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.S14m8eK4qG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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:51 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:51 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:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0qyWs5DeAF/Render', 07:33:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:51 INFO - 'HOME': '/Users/cltbld', 07:33:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:51 INFO - 'LOGNAME': 'cltbld', 07:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:51 INFO - 'MOZ_NO_REMOTE': '1', 07:33:51 INFO - 'NO_EM_RESTART': '1', 07:33:51 INFO - 'PAGER': '/bin/cat', 07:33:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:51 INFO - 'PWD': '/builds/slave/test', 07:33:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:51 INFO - 'SHELL': '/bin/bash', 07:33:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S14m8eK4qG/Listeners', 07:33:51 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 07:33:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:51 INFO - 'USER': 'cltbld', 07:33:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:51 INFO - 'XPC_FLAGS': '0x0', 07:33:51 INFO - 'XPC_SERVICE_NAME': '0', 07:33:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:33:51 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:51 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:51 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:51 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:51 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:51 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 mozsystemmonitor-0.3.tar.gz 07:33:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:33:54 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:54 INFO - Installing collected packages: mozsystemmonitor 07:33:54 INFO - Running setup.py install for mozsystemmonitor 07:33:54 INFO - Successfully installed mozsystemmonitor 07:33:54 INFO - Cleaning up... 07:33:54 INFO - Return code: 0 07:33:54 INFO - Installing jsonschema==2.5.1 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:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101773b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101776768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea8ad89090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101551d30>, '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 0x101478db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101546be8>, '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.0qyWs5DeAF/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.S14m8eK4qG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:33:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:33:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0qyWs5DeAF/Render', 07:33:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:54 INFO - 'HOME': '/Users/cltbld', 07:33:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:54 INFO - 'LOGNAME': 'cltbld', 07:33:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:54 INFO - 'MOZ_NO_REMOTE': '1', 07:33:54 INFO - 'NO_EM_RESTART': '1', 07:33:54 INFO - 'PAGER': '/bin/cat', 07:33:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:54 INFO - 'PWD': '/builds/slave/test', 07:33:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:54 INFO - 'SHELL': '/bin/bash', 07:33:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S14m8eK4qG/Listeners', 07:33:54 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 07:33:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:54 INFO - 'USER': 'cltbld', 07:33:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:54 INFO - 'XPC_FLAGS': '0x0', 07:33:54 INFO - 'XPC_SERVICE_NAME': '0', 07:33:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:54 INFO - Downloading/unpacking jsonschema==2.5.1 07:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:33:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:33:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:33:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:33:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:33:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:33:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:33:57 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:57 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:57 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:57 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:57 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:57 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:57 INFO - Downloading functools32-3.2.3-2.tar.gz 07:33:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:33:57 INFO - warning: no files found matching '*.txt' 07:33:57 INFO - no previously-included directories found matching 'build' 07:33:57 INFO - no previously-included directories found matching 'dist' 07:33:57 INFO - no previously-included directories found matching '.git*' 07:33:57 INFO - Installing collected packages: jsonschema, functools32 07:33:57 INFO - Running setup.py install for functools32 07:33:57 INFO - warning: no files found matching '*.txt' 07:33:57 INFO - no previously-included directories found matching 'build' 07:33:57 INFO - no previously-included directories found matching 'dist' 07:33:57 INFO - no previously-included directories found matching '.git*' 07:33:57 INFO - Successfully installed jsonschema functools32 07:33:57 INFO - Cleaning up... 07:33:57 INFO - Return code: 0 07:33:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:33:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:57 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 0x101773b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101776768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea8ad89090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101551d30>, '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 0x101478db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101546be8>, '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.0qyWs5DeAF/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.S14m8eK4qG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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:57 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:57 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:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0qyWs5DeAF/Render', 07:33:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:57 INFO - 'HOME': '/Users/cltbld', 07:33:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:57 INFO - 'LOGNAME': 'cltbld', 07:33:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:57 INFO - 'MOZ_NO_REMOTE': '1', 07:33:57 INFO - 'NO_EM_RESTART': '1', 07:33:57 INFO - 'PAGER': '/bin/cat', 07:33:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:57 INFO - 'PWD': '/builds/slave/test', 07:33:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:57 INFO - 'SHELL': '/bin/bash', 07:33:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S14m8eK4qG/Listeners', 07:33:57 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 07:33:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:57 INFO - 'USER': 'cltbld', 07:33:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:57 INFO - 'XPC_FLAGS': '0x0', 07:33:57 INFO - 'XPC_SERVICE_NAME': '0', 07:33:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:33:58 INFO - Cleaning up... 07:33:58 INFO - Return code: 0 07:33:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101773b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101776768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea8ad89090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101551d30>, '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 0x101478db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101546be8>, '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.0qyWs5DeAF/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.S14m8eK4qG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:33:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:33:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0qyWs5DeAF/Render', 07:33:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:58 INFO - 'HOME': '/Users/cltbld', 07:33:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:58 INFO - 'LOGNAME': 'cltbld', 07:33:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:58 INFO - 'MOZ_NO_REMOTE': '1', 07:33:58 INFO - 'NO_EM_RESTART': '1', 07:33:58 INFO - 'PAGER': '/bin/cat', 07:33:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:58 INFO - 'PWD': '/builds/slave/test', 07:33:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:58 INFO - 'SHELL': '/bin/bash', 07:33:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S14m8eK4qG/Listeners', 07:33:58 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 07:33:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:58 INFO - 'USER': 'cltbld', 07:33:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:58 INFO - 'XPC_FLAGS': '0x0', 07:33:58 INFO - 'XPC_SERVICE_NAME': '0', 07:33:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:58 INFO - Downloading/unpacking blobuploader==1.2.4 07:33:58 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:58 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:58 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:58 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:58 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:58 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:01 INFO - Downloading blobuploader-1.2.4.tar.gz 07:34:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:34:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:34:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:34:02 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:02 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:02 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:02 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:02 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:02 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:02 INFO - Downloading docopt-0.6.1.tar.gz 07:34:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:34:02 INFO - Installing collected packages: blobuploader, requests, docopt 07:34:02 INFO - Running setup.py install for blobuploader 07:34:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:34:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:34:02 INFO - Running setup.py install for requests 07:34:03 INFO - Running setup.py install for docopt 07:34:03 INFO - Successfully installed blobuploader requests docopt 07:34:03 INFO - Cleaning up... 07:34:03 INFO - Return code: 0 07:34:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34:03 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:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:04 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:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:04 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 0x101773b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101776768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea8ad89090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101551d30>, '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 0x101478db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101546be8>, '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.0qyWs5DeAF/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.S14m8eK4qG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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:04 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:04 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:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0qyWs5DeAF/Render', 07:34:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:04 INFO - 'HOME': '/Users/cltbld', 07:34:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:04 INFO - 'LOGNAME': 'cltbld', 07:34:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:04 INFO - 'MOZ_NO_REMOTE': '1', 07:34:04 INFO - 'NO_EM_RESTART': '1', 07:34:04 INFO - 'PAGER': '/bin/cat', 07:34:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:04 INFO - 'PWD': '/builds/slave/test', 07:34:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:04 INFO - 'SHELL': '/bin/bash', 07:34:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S14m8eK4qG/Listeners', 07:34:04 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 07:34:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:04 INFO - 'USER': 'cltbld', 07:34:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:04 INFO - 'XPC_FLAGS': '0x0', 07:34:04 INFO - 'XPC_SERVICE_NAME': '0', 07:34:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:34:04 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-1GaLgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:34:04 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-cSezAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:34:04 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-mz97i4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:34:04 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-nBoJdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:34:04 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-yMowOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:34:04 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-Ik9GqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:34:04 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-pPvEi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:34:05 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-0nw5qM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:34:05 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-E6zs61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:34:05 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-s146Se-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:34:05 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-r4x3Wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:34:05 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-dKA65w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:34:05 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-4F4cKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:34:05 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-ygmi2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:05 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-S3xfp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:34:05 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-ImSuDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:34:05 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-BNUeeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:34:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:34:06 INFO - Running setup.py install for manifestparser 07:34:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:34:06 INFO - Running setup.py install for mozcrash 07:34:06 INFO - Running setup.py install for mozdebug 07:34:06 INFO - Running setup.py install for mozdevice 07:34:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:34:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:34:06 INFO - Running setup.py install for mozfile 07:34:06 INFO - Running setup.py install for mozhttpd 07:34:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:34:06 INFO - Running setup.py install for mozinfo 07:34:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:34:07 INFO - Running setup.py install for mozInstall 07:34:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:34:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:34:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:34:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:34:07 INFO - Running setup.py install for mozleak 07:34:07 INFO - Running setup.py install for mozlog 07:34:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:34:07 INFO - Running setup.py install for moznetwork 07:34:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:34:07 INFO - Running setup.py install for mozprocess 07:34:07 INFO - Running setup.py install for mozprofile 07:34:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:34:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:34:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:34:08 INFO - Running setup.py install for mozrunner 07:34:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:34:08 INFO - Running setup.py install for mozscreenshot 07:34:08 INFO - Running setup.py install for moztest 07:34:08 INFO - Running setup.py install for mozversion 07:34:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:34:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:34:08 INFO - Cleaning up... 07:34:08 INFO - Return code: 0 07:34:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:08 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 0x101773b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101776768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea8ad89090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101551d30>, '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 0x101478db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101546be8>, '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.0qyWs5DeAF/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.S14m8eK4qG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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:08 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:08 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:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0qyWs5DeAF/Render', 07:34:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:08 INFO - 'HOME': '/Users/cltbld', 07:34:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:08 INFO - 'LOGNAME': 'cltbld', 07:34:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:08 INFO - 'MOZ_NO_REMOTE': '1', 07:34:08 INFO - 'NO_EM_RESTART': '1', 07:34:08 INFO - 'PAGER': '/bin/cat', 07:34:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:08 INFO - 'PWD': '/builds/slave/test', 07:34:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:08 INFO - 'SHELL': '/bin/bash', 07:34:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S14m8eK4qG/Listeners', 07:34:08 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 07:34:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:08 INFO - 'USER': 'cltbld', 07:34:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:08 INFO - 'XPC_FLAGS': '0x0', 07:34:08 INFO - 'XPC_SERVICE_NAME': '0', 07:34:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:34:08 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-jUsmrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:34:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:34:09 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-K4t17G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:34:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:34:09 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-9w5Flr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:34:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:34:09 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-vsXw_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:34:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:34:09 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-chpJh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:34:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:34:09 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-CbgE1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:34:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:34:09 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-WxUld4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:34:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:34:09 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-kyejKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:34:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:34:09 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-6pLdb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:34:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:34:09 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-5Mo_yv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:34:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:34:09 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-7fPhji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:34:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:34:10 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-0nN6u1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:34:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:34:10 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-gKxmJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:34:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:34:10 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-cQdc9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:34:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:10 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-wFprIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:34:10 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-khomjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:34:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:34:10 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-f9eD2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:34:10 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:10 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:10 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:10 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:10 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:10 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:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:13 INFO - Downloading blessings-1.6.tar.gz 07:34:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:34:13 INFO - Installing collected packages: blessings 07:34:13 INFO - Running setup.py install for blessings 07:34:13 INFO - Successfully installed blessings 07:34:13 INFO - Cleaning up... 07:34:13 INFO - Return code: 0 07:34:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:34:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:34:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:34:13 INFO - Reading from file tmpfile_stdout 07:34:13 INFO - Current package versions: 07:34:13 INFO - blessings == 1.6 07:34:13 INFO - blobuploader == 1.2.4 07:34:13 INFO - docopt == 0.6.1 07:34:13 INFO - functools32 == 3.2.3-2 07:34:13 INFO - jsonschema == 2.5.1 07:34:13 INFO - manifestparser == 1.1 07:34:13 INFO - mozInstall == 1.12 07:34:13 INFO - mozcrash == 1.0 07:34:13 INFO - mozdebug == 0.1 07:34:13 INFO - mozdevice == 0.49 07:34:13 INFO - mozfile == 1.2 07:34:13 INFO - mozhttpd == 0.7 07:34:13 INFO - mozinfo == 0.9 07:34:13 INFO - mozleak == 0.1 07:34:13 INFO - mozlog == 3.4 07:34:13 INFO - moznetwork == 0.27 07:34:13 INFO - mozprocess == 0.25 07:34:13 INFO - mozprofile == 0.28 07:34:13 INFO - mozrunner == 6.13 07:34:13 INFO - mozscreenshot == 0.1 07:34:13 INFO - mozsystemmonitor == 0.3 07:34:13 INFO - moztest == 0.8 07:34:13 INFO - mozversion == 1.4 07:34:13 INFO - psutil == 3.1.1 07:34:13 INFO - requests == 1.2.3 07:34:13 INFO - wsgiref == 0.1.2 07:34:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:14 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 0x101773b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101776768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea8ad89090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101551d30>, '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 0x101478db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101546be8>, '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.0qyWs5DeAF/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.S14m8eK4qG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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:14 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:14 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:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0qyWs5DeAF/Render', 07:34:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:14 INFO - 'HOME': '/Users/cltbld', 07:34:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:14 INFO - 'LOGNAME': 'cltbld', 07:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:14 INFO - 'MOZ_NO_REMOTE': '1', 07:34:14 INFO - 'NO_EM_RESTART': '1', 07:34:14 INFO - 'PAGER': '/bin/cat', 07:34:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:14 INFO - 'PWD': '/builds/slave/test', 07:34:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:14 INFO - 'SHELL': '/bin/bash', 07:34:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S14m8eK4qG/Listeners', 07:34:14 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 07:34:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:14 INFO - 'USER': 'cltbld', 07:34:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:14 INFO - 'XPC_FLAGS': '0x0', 07:34:14 INFO - 'XPC_SERVICE_NAME': '0', 07:34:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:14 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:14 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:14 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:14 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:14 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:14 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:14 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:14 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:14 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:14 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:14 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:14 INFO - Cleaning up... 07:34:14 INFO - Return code: 0 07:34:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:34:14 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:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:14 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:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:14 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 0x101773b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101776768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea8ad89090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101551d30>, '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 0x101478db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101546be8>, '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.0qyWs5DeAF/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.S14m8eK4qG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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:14 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:14 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:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0qyWs5DeAF/Render', 07:34:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:14 INFO - 'HOME': '/Users/cltbld', 07:34:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:14 INFO - 'LOGNAME': 'cltbld', 07:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:14 INFO - 'MOZ_NO_REMOTE': '1', 07:34:14 INFO - 'NO_EM_RESTART': '1', 07:34:14 INFO - 'PAGER': '/bin/cat', 07:34:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:14 INFO - 'PWD': '/builds/slave/test', 07:34:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:14 INFO - 'SHELL': '/bin/bash', 07:34:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S14m8eK4qG/Listeners', 07:34:14 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 07:34:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:14 INFO - 'USER': 'cltbld', 07:34:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:14 INFO - 'XPC_FLAGS': '0x0', 07:34:14 INFO - 'XPC_SERVICE_NAME': '0', 07:34:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:34:14 INFO - Cleaning up... 07:34:14 INFO - Return code: 0 07:34:14 INFO - Running post-action listener: _resource_record_post_action 07:34:14 INFO - Running post-action listener: _start_resource_monitoring 07:34:14 INFO - Starting resource monitoring. 07:34:14 INFO - [mozharness: 2017-03-01 15:34:14.556876Z] Finished create-virtualenv step (success) 07:34:14 INFO - [mozharness: 2017-03-01 15:34:14.557850Z] Running install step. 07:34:14 INFO - Running pre-action listener: _resource_record_pre_action 07:34:14 INFO - Running main action method: install 07:34:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:34:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:34:14 INFO - Reading from file tmpfile_stdout 07:34:14 INFO - Detecting whether we're running mozinstall >=1.0... 07:34:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:34:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:34:14 INFO - Reading from file tmpfile_stdout 07:34:14 INFO - Output received: 07:34:14 INFO - Usage: mozinstall [options] installer 07:34:14 INFO - Options: 07:34:14 INFO - -h, --help show this help message and exit 07:34:14 INFO - -d DEST, --destination=DEST 07:34:14 INFO - Directory to install application into. [default: 07:34:14 INFO - "/builds/slave/test"] 07:34:14 INFO - --app=APP Application being installed. [default: firefox] 07:34:14 INFO - mkdir: /builds/slave/test/build/application 07:34:14 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:14 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:35 INFO - Reading from file tmpfile_stdout 07:34:35 INFO - Output received: 07:34:35 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:34:35 INFO - Running post-action listener: _resource_record_post_action 07:34:35 INFO - [mozharness: 2017-03-01 15:34:35.218300Z] Finished install step (success) 07:34:35 INFO - [mozharness: 2017-03-01 15:34:35.218428Z] Running run-tests step. 07:34:35 INFO - Running pre-action listener: _resource_record_pre_action 07:34:35 INFO - Running main action method: run_tests 07:34:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:34:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:34:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:34:35 INFO - 2017-03-01 07:34:35.232 screenresolution[2166:21762] starting screenresolution argv=screenresolution get 07:34:35 INFO - 2017-03-01 07:34:35.235 screenresolution[2166:21762] Display 0: 1600x1200x32@60 07:34:35 INFO - 2017-03-01 07:34:35.241 screenresolution[2167:21764] starting screenresolution argv=screenresolution list 07:34:35 INFO - Available Modes on Display 0 07:34:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:34:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:34:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:34:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:34:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:34:35 INFO - Intel Iris: 07:34:35 INFO - Chipset Model: Intel Iris 07:34:35 INFO - Type: GPU 07:34:35 INFO - Bus: Built-In 07:34:35 INFO - VRAM (Dynamic, Max): 1536 MB 07:34:35 INFO - Vendor: Intel (0x8086) 07:34:35 INFO - Device ID: 0x0a2e 07:34:35 INFO - Revision ID: 0x0009 07:34:35 INFO - Displays: 07:34:35 INFO - Display: 07:34:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:34:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:34:35 INFO - Display Serial Number: 1600x1200 60 07:34:35 INFO - Main Display: Yes 07:34:35 INFO - Mirror: Off 07:34:35 INFO - Online: Yes 07:34:35 INFO - Rotation: Supported 07:34:35 INFO - Return code: 0 07:34:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:34:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:34:35 INFO - Python 2.7.3 07:34:35 INFO - Return code: 0 07:34:35 INFO - grabbing minidump binary from tooltool 07:34:35 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:35 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 0x101551d30>, '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 0x101478db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101546be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:34:35 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:35 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:35 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:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:34:35 INFO - Return code: 0 07:34:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:34:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:34:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:34:35 INFO - ENV: RUST_BACKTRACE is now 1 07:34:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:34:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:34:35 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-0269', '--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:35 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-0269 --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:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0qyWs5DeAF/Render', 07:34:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:35 INFO - 'HOME': '/Users/cltbld', 07:34:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:35 INFO - 'LOGNAME': 'cltbld', 07:34:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:34:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:35 INFO - 'MOZ_NO_REMOTE': '1', 07:34:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:34:35 INFO - 'NO_EM_RESTART': '1', 07:34:35 INFO - 'PAGER': '/bin/cat', 07:34:35 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:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:35 INFO - 'PWD': '/builds/slave/test', 07:34:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:34:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:35 INFO - 'RUST_BACKTRACE': '1', 07:34:35 INFO - 'SHELL': '/bin/bash', 07:34:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S14m8eK4qG/Listeners', 07:34:35 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 07:34:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:35 INFO - 'USER': 'cltbld', 07:34:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:35 INFO - 'XPC_FLAGS': '0x0', 07:34:35 INFO - 'XPC_SERVICE_NAME': '0', 07:34:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:35 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-0269', '--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:35 INFO - mozversion application_buildid: 20170301024203 07:34:35 INFO - mozversion application_changeset: 34c6c2f302e7b48e3ad2cec575cbd34d423a9d32 07:34:35 INFO - mozversion application_display_name: Nightly 07:34:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:34:35 INFO - mozversion application_name: Firefox 07:34:35 INFO - mozversion application_remotingname: firefox 07:34:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:34:35 INFO - mozversion application_vendor: Mozilla 07:34:35 INFO - mozversion application_version: 54.0a1 07:34:35 INFO - mozversion platform_buildid: 20170301024203 07:34:35 INFO - mozversion platform_changeset: 34c6c2f302e7b48e3ad2cec575cbd34d423a9d32 07:34:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:34:35 INFO - mozversion platform_version: 54.0a1 07:34:35 INFO - using testdate: 1488382475 07:34:35 INFO - actual date: 1488382475 07:34:35 INFO - starting webserver on 'localhost:52160' 07:34:35 INFO - SUITE-START | Running 2 tests 07:34:35 INFO - TEST-START | dromaeo_css 07:34:35 INFO - operating with platform_type : mac_ 07:34:35 INFO - Initialising browser for dromaeo_css test... 07:34:35 INFO - TEST-INFO | started process 2177 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmpVLFHpj/profile http://localhost:52160/getInfo.html) 07:34:36 INFO - PROCESS | 2177 | 1488382476358 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:36 INFO - PROCESS | 2177 | 1488382476359 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method install 07:34:36 INFO - PROCESS | 2177 | 1488382476401 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 07:34:38 INFO - PROCESS | 2177 | 2017-03-01 07:34:38.491 plugin-container[2179:21936] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x903f, name = 'com.apple.tsm.portname' 07:34:38 INFO - PROCESS | 2177 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:34:38 INFO - PROCESS | 2177 | 2017-03-01 07:34:38.494 plugin-container[2179:21936] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c07, name = 'com.apple.CFPasteboardClient' 07:34:38 INFO - PROCESS | 2177 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:34:38 INFO - PROCESS | 2177 | 2017-03-01 07:34:38.494 plugin-container[2179:21936] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:34:38 INFO - PROCESS | 2177 | __metrics Screen width/height:1600/1200 07:34:38 INFO - PROCESS | 2177 | colorDepth:24 07:34:38 INFO - PROCESS | 2177 | Browser inner width/height: 1024/689 07:34:38 INFO - PROCESS | 2177 | __metrics 07:34:38 ERROR - PROCESS | 2177 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3354: TypeError: this.tabs is undefined 07:34:38 INFO - PROCESS | 2177 | 1488382478650 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 07:34:39 INFO - TEST-INFO | 2177: exit 0 07:34:39 INFO - Browser initialized. 07:34:39 INFO - Running cycle 1/1 for dromaeo_css test... 07:34:39 INFO - TEST-INFO | started process 2180 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmpVLFHpj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:34:39 INFO - PROCESS | 2180 | 1488382479649 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:39 INFO - PROCESS | 2180 | 1488382479650 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 07:34:41 INFO - PROCESS | 2180 | 2017-03-01 07:34:41.776 plugin-container[2181:22063] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 07:34:41 INFO - PROCESS | 2180 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:34:41 INFO - PROCESS | 2180 | 2017-03-01 07:34:41.777 plugin-container[2181:22063] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 07:34:41 INFO - PROCESS | 2180 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:34:41 INFO - PROCESS | 2180 | 2017-03-01 07:34:41.777 plugin-container[2181:22063] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:34:51 INFO - PROCESS | 2180 | RSS: Main: 226197504 07:34:51 INFO - PROCESS | 2180 | 07:37:55 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:52160/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52160/tests/dromaeo/cssquery-ext.html) 07:37:57 INFO - PROCESS | 2180 | RSS: Main: 254246912 07:37:57 INFO - PROCESS | 2180 | 07:39:39 INFO - PROCESS | 2180 | ************************* 07:39:39 INFO - PROCESS | 2180 | A coding exception was thrown and uncaught in a Task. 07:39:39 INFO - PROCESS | 2180 | 07:39:39 ERROR - PROCESS | 2180 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:39:39 INFO - PROCESS | 2180 | Full stack: 07:39:39 INFO - PROCESS | 2180 | ************************* 07:40:59 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:52160/tests/dromaeo/cssquery-ext.html (next: http://localhost:52160/tests/dromaeo/cssquery-jquery.html) 07:40:59 INFO - PROCESS | 2180 | RSS: Main: 259862528 07:40:59 INFO - PROCESS | 2180 | 07:44:01 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:52160/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52160/tests/dromaeo/cssquery-mootools.html) 07:44:02 INFO - PROCESS | 2180 | RSS: Main: 271990784 07:44:02 INFO - PROCESS | 2180 | 07:47:04 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:52160/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52160/tests/dromaeo/cssquery-prototype.html) 07:47:05 INFO - PROCESS | 2180 | RSS: Main: 264790016 07:47:05 INFO - PROCESS | 2180 | 07:50:08 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:52160/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52160/tests/dromaeo/cssquery-yui.html) 07:50:08 INFO - PROCESS | 2180 | RSS: Main: 273510400 07:50:08 INFO - PROCESS | 2180 | 07:53:11 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:52160/tests/dromaeo/cssquery-yui.html (next: http://localhost:52160/tests/dromaeo/cssquery-dojo.html) 07:53:11 INFO - PROCESS | 2180 | RSS: Main: 268468224 07:53:11 INFO - PROCESS | 2180 | 07:53:11 INFO - PROCESS | 2180 | __start_tp_report 07:53:11 INFO - PROCESS | 2180 | _x_x_mozilla_page_load 07:53:11 INFO - PROCESS | 2180 | _x_x_mozilla_page_load_details 07:53:11 INFO - PROCESS | 2180 | |i|pagename|runs| 07:53:11 INFO - PROCESS | 2180 | |0;dojo.html;3441.0021093882774;3441.36334778066;3464.8960531184057;3469.705075068619;3470.132466883279;5814.1278808178795;5982.521398288138;5984.222051133352;6025.487833534149;6081.6351018938785;5866.061430171173;5867.735951882165;5885.911711324323;5891.469767720904;5899.469047785698;5307.20391941209;5420.078586640261;5455;5502.98194833955;5524.502794748471;5452.482014208644;5493.725313734317;5512.924979628974;5526.336839579256;5559.054960656698;5353.464653534655;5440.238366628655;5502.312210973629;5518.144687573433;5520.613557051008;4597.034622729231;5452;5503.174523821419;5554.416786237468;5562.137868630369;4416.470023597189;5174.793008279665;5232.084385232607;5288.894222115575;5341.359036915556;5098.59211263098;5232.848773269875;5634.943650563483;5678.9432105678825;5940.6435613863305;6382.297947225801;6399.616023038632;6413.16628838248;6426.775062872777;6440.355964403569;6469.547131700783;6478.125453063823;6487.286398496161;6496.5127615428555;6496.902546461807;5919.644821310735;5964.761409543657;6183.412575805291;6189;6205.906911396378;6426.775062872777;6502.122213501211;6511.641859697667;6592.373724496261;6609.768658096944;6284.591501552384;6302.684865756693;6354.205724284465;6356.269029061625;6356.713947872357;5881.3530511643685;6439.098526206335;6439.613623182624;6461.450776683941;6470.09418681385;5614.6631202128;6238.937610623836;6244.594101383486;6310.021946598285;6334.904976425358;6212.782552610637;6258.812235632939;6300.905486417708;6348.714307856158;6385.936140638627;5122.948770512247;5163.509466600667;5165.14775062118;5184.870378240575;5193.169092945111;4541.2733962565835;4643.164230438486;4664.463586687507;4680;4685.9531404686195;5955.493783028404;6022.156898034279;6026.427489388501;6202.658853762996;6216.813495595139;6281.591696539802;6310.211223597051;6311.842203944846;6356.745730170834;6438.3883531064475;6176.938230617726;6195.132681424604;6199.5660303779205;6201.255849298113;6214.974529202721;5503.174523821459;5700.4869561738815;5707.571932105108;5726.455986681259;5765.135229715576;6360.1731774869895;6460.935390646034;6511.869762604816;6529.804105876831;6561;6337.017762246859;6395.936040639534;6444.258910225384;6461.450776684034;6464.967675161783;6644.235912869888;6646.60120392778;6655.600663960178;6667.733290668319;6671.532992690465;5097.974510127426;6237.625742455467;6265.248170219603;6287.088372186099;6372.107904893226;6411.134496842867;6418.229812422539;6425.903611445926;6432.871342573216;6452.387023232973;5413.593980451403;6247.625142491465;6261.311255761953;6288.465480434214;6300.779472718433;6158.32258451561;6183.598066125687;6209.161763161916;6230.190075290183;6290.559660823698;5718.828435146952;5932.673702946379;6244.843878903063;6267.717952692049;6285.811425657238;6282.905756413749;6290.150829637941;6303.905441418291;6317.652529110943;6347.587406818542;6022.066579680157;6027.336992930862;6085.117657939485;6123.740204357105;6161.630302181883 07:53:11 INFO - PROCESS | 2180 | |1;ext.html;709.8083517450289;780.9570473623951;804.5213098206565;846.7290467050547;940.2337095267361;36422.63577364226;37347.81326093369;38675.613243867556;38821.61178388215;38888.638897638586;31454.84272578634;37421;37618.43572346417;37691.434628480594;37710.43434348487;6475.740970361192;8914.821703565925;9512.952435237848;9822.017798220157;10681.038706516412;10563.524641391155;10628.946855265713;10664;10664.360138391683;10680;10641.467926603638;10678.25252232344;10678.704078623094;10716.464176791169;10718.78562428751;10628.840567391495;10650.201234907374;10661.466926653637;10664.360138391721;10678.572857085746;10360.015798499131;10362.844557331646;10395.480225988671;10435.37387756737;10446.63436779709;32777.83611081953;32853.50719739206;33004.00987970341;33010.504842427385;33288.667113329044;3686;3690.4279836625365;3699.5375578052744;3711.109333759905;3729.850805967758;20736.792632073786;24189.637155442684;24547.87726061376;24702.876485617635;24823;2966.2485272714707;2996.955045674317;3028.530577760451;3045.923851903698;3049.2529330314214;330540;334880.32559837046;336034;337273;337455.99999999756;41921.37117943233;42417.36373954393;42562.57437425648;42582.57417425848;42612.57387426086;43475;43530.564694353285;43545;43644.345334820006;43704.78147609305;12582.119251652479;12758.61724148277;12822.871771282355;12840;12877;10813.351198928089;10950.890491094988;10961.287516311415;10961.725956851142;10972.561097556008;10815.78368432627;11258.549658013588;11348.716282093013;11427.371494567878;11454.828177577343;5496.1755736639825;5613.214150019001;5631.070873305941;5640.943590564124;5659.518940889988;1043.5512729526376;1058.8200005999;1073.2755390111643;1090.7872964771793;1117.201201141188;21983.780162198174;26549.734502655112;26594.468110637677;26937.730622693914;27276.454470910867;1129.7232178116415;1138.7950168969664;1161.7560312334504;1162.9069674426025;1180.5159884447335;13593.864061359458;13892.722145557032;13900;13945.651358716113;14056.929715351358;376447;454960;455760;455833;455902;35108.648913511046;45931.77034114808;46149.30776038362;46316.3052554212;46782.5321746785;1360.843502997168;1393.3938736649386;1395.023483561511;1399.3982587487478;1404.1504889541884;25873.26628214285;25963;26135.08527201539;26664.733352667;26765;31798.841005794824;35262;38135;38155.046123847125;38430.61569384382;381909;444170;457400;464029;465234;21812.89093554522;21928.78071219331;21984;22124.557508850055;22216.333509994725;32932;36348.27303453969;36636.81681591575;38070.2385952285;38093.2381352377;30307.242318942204;31413;32312.35375292434;32384.35231295314;32890.34219315648;31525.211869703442;31774;32361.676383235867;32500.187495312806;32611.18472038218;31824.36351273008;32056.198595035312;32102.35795284128;32156.51765223477;32743;23984.64023039621;24683;26285;26666.46667066609;27816.72183278141;18668.253269869598;19347.516312091746;22353.21174306084;22474.77525224727;22704.772952270265 07:53:11 INFO - PROCESS | 2180 | |2;jquery.html;313.95761572187746;387.5775404808756;412.25587813995725;428.74061192978246;438.84201687392533;19964.30124945627;20166.991650417494;20704.48238794031;21481.03335349909;21555.568888622238;20737.481562960933;20761.480962975933;21006.789932100673;21290.68063979038;21367.145314187415;6281.340459251781;6599.934000660004;6609.471242300629;6618.238902526223;6627.138471998657;6324.557280990332;6408.166938298014;6419.486441084726;6439.323870993549;6519.152510173671;6494.512911531654;6494.610323380589;6504.024396340563;6512.055751915969;6529.118568993173;5442.074847275972;6344.619322840645;6404.871902561946;6537;6541.771038013694;6109.3890610939;6250.218722659668;6370.140031095789;6394.360563943615;6401.679916004181;24516.774161291865;25163.748362516322;25443;25445.491090178093;25516.362090947874;2900.7389334959953;2909.621749172594;2911.737943585066;2918.824870507755;2948.3808400235976;13082.691730826937;14829.851701482956;14978.775318370233;15610.609734756608;16227.83772162275;1890.8960007199598;1933.8549608779258;1952.306931039489;1956.9217231310731;1964.1554131723353;153299;157059.21470392574;158787;160622;162722;19725.802741972682;20454.59090818205;20468.283610073577;20612.69080963787;20686.79313206879;31069.067927962198;31074.91237806666;31125.844370778002;31226;31245;9748.561314740853;9918.454485003394;10073.018167318734;10078.899211007943;10081.739782527184;8311;8329.416940814084;8344.958275208706;8490.066092729918;8506.447080939719;9159.175674189355;9167.954160229156;9186.58660360272;9291.953540232256;9325.393849399903;3102.844857757103;3881.3983832506005;3881.4760007399204;3885.7668539887695;3895.7078219133678;785.8310463250428;957.1577012229333;964.7732782796037;983.311681822727;1025.3642741500169;17336.219870105622;18825.529361766065;18951;20316.39050828448;20455;781.9530828150329;961.3414810854587;976.7802244494932;981.8527220916919;1003;8697.721930755442;9659.855102173473;10108.039736225193;10420.739481512872;10475.94762026185;668076;673558;691009;706551;727257;97884.51057744665;115324;138516;150240.49759502264;155609.22195389177;966.3090890013674;984.2224642532319;1022.6880801355658;1024.36489376587;1024.4058446101244;18876.528086797938;19005.714914276574;19160;19193.424197274104;19297.324593639154;46579.53420465752;54025;56579.71710141423;57134;60897.69551152216;82564.58717706373;82836.58581707053;82941.341173175;83535.61002919193;83656.58171709103;11315.490802914053;11319.207655464039;11427.600033999102;11628.01161901214;11699.2980421175;10475.895241047798;12681.936590317358;12815.807762883378;13001.4149363277;13147.73704525885;9409.858852117086;10414.59402980588;10900.836487452536;10936.671899843017;11263.605773797877;8582.78543036429;8873.955630221808;10800.973907478778;11324.037456815933;11375.772484550098;10677.14582833356;11624.329853799778;11746.530138794353;11773.47019384147;11822.054235660955;9295.907040929775;11274.083405821195;11589.594364197214;11652.242604230698;11781.646550603153;9967.152792012761;10486.47567621631;10992.570965774397;11194.384308863091;11355.716107097389 07:53:11 INFO - PROCESS | 2180 | |3;mootools.html;1295.410588182377;1504.8269449013362;1519.5517322389894;1529.1818876900861;1572.976405353919;9178.036306187854;9469.952650236757;10263.384196948178;10798.51406686699;10875.184361172904;10116.241281903849;10465.424401657925;10491.475426228677;10686.679399618004;10686.839697404544;2274.7270327560673;2314.918977835776;2318.3624503261653;2319.3158018384615;2320.153144102407;2286.588414085464;2313.0747700919683;2323.3262353917344;2324.39565712915;2330.0330362899376;2280.2019293247395;2291;2312.7455979842202;2314.9537009259807;2318.9536209275802;2268.6143355629583;2270.398344438717;2273.886305684709;2289.828262880291;2298.7241531016302;2239.2722365231202;2278.544291141778;2299.655051742235;2303.021215983217;2308.607536718762;10779.407132607703;10848.403337816417;10864.348139111678;10869.619563315326;10877.347359158397;5523.8066667666435;5719.342275638313;5730;5731.971340143315;5738.512226460714;3275.279438523521;3353.279045005336;3531.6644918732677;3587.7129829613827;3601.8019008954498;1155.5320095361392;1177.5054477119631;1188.4533114767216;1189.2626571525623;1215.9756804863941;14831.332590033475;14847.777283340758;14899.106053636817;14969.850301497063;15014.24928753569;4668;4676.342078417041;4761.547652972962;4799.232122860326;4848.830290939871;12391.194572352768;12445.315507647167;12451.190672606434;12451.501939922482;12467.875321246853;5736.196932429463;5792.913106303409;5802.361740208574;5806.1581070744505;5810.12848072784;4332.155229730172;4718.693284936468;4952;5034.119029169954;5075.822346217865;3820.4078367853026;3958.861439849649;3967.3652215645357;3981.641652251253;4040.2727509048655;1080.5191689698165;1083.2363183955292;1088.472091035847;1098.5715570927346;1114.2144787924494;765.3112199020815;902.5919565477875;915.8214148241162;916.4730280088842;929.8486385424671;6326.936730632635;6387.744490220432;6491.188601424822;6493.188351456068;6597.60414375139;958.6405098088217;965.8696076029787;975.8292298847815;1002.6240159940022;1017.2980643356209;3537.451694987281;4019.633324669568;4031.314676505001;4062.1266427718183;4140.792960351971;10868.67393978182;12541.93729031349;12979.156354837094;13002.869971300355;13011;12285.1400401971;12752.93623531895;12754.68113297175;13017;13045.608631741063;9027.14242146995;9243.352965292364;9251.629934802668;9251.889773227256;9337.813243735087;6284.402981716729;6362.981922892315;6569.441597464269;6699.866002680016;6740.618173274565;9732.367396119229;11594.6521604352;11788.70528236801;11882;11938.1046421517;11575.479103440533;12076.51693932233;12165.756684866075;12219.022478201545;12222.388880556115;8659.48043117415;8880.467171969702;9544.95227523858;9634.421934683942;9903.851442228228;7403.185649578434;9935.701928942144;10027.649032283834;10129.696109116738;10149.34029288094;8552.486850788973;8564.614592343234;8815.118488151134;8848.601812918305;8932.151445612657;8503.319734421355;8572.357073219659;8632.179942905665;8686.131386861263;8786.824263514565;7604.125525564631;7636.923630763844;7703.922960770545;7708.882212079329;7725.690972361267;5637.52081073097;5741.081426971665;5878.853028674146;5900.5574581907385;5905.43898329658;4127.8968025798395;5958.523318134626;5964.8807023860145;5965.940340596539;6123.112148738497 07:53:11 INFO - PROCESS | 2180 | |4;prototype.html;334.5216340632895;347.8799814064148;369.0717844620779;371.331603114394;386.1485424638674;5659.264295641561;5686.545076393889;5713.571482138846;5767.250257466529;5770.422957704228;4876.1954277544255;5495.890082198363;5549.472800083996;5578.497935185833;5717.827225654256;3405.370006548784;3700.9814950925206;4238.30068038774;4315.525292217869;4345.760983145926;3642.6357364263495;3688.5020522229424;4360.454943132108;4377;4399.736015839044;3813.9809300953457;4333.804978775946;4354.978225108885;4357.498887627916;4387.780610969455;3507.4563442666426;3754.530683664542;3946.205173035425;4328.134373125372;4337;3168.6989735975044;3565.2156525564333;3578.159132603836;3757.718171137148;3786.5266841644793;4924.3105965164905;5364.329458817648;5425.728713564306;5442.346918369782;5473.452654734495;3678.5401824771902;4169.353750168699;4400.7579583122915;4986.5761410280165;5075.949240507584;4908.950910490885;5642.85892852682;5853.009976607974;5909.37951515089;5993;4404.955950440487;4723.527647235283;4733.644976626732;4778.832740854054;4778.928316075262;4598.0344127733215;5443.782248710047;5734.483896449298;6314.336994615545;6347.904781428282;4072.6741860651077;4688.367070445446;4706.822894546168;4787.712737235777;4908.631852610997;4709.481956984729;4953.2570114483115;4957.7273249971595;4976.516438492997;4992.925106123411;4205.894852628709;4593.862184134415;5088;5306.930297184102;5442.292501974718;5401.864953376118;5869.442402971711;5891.263592050994;5899.203607513016;5901.144334071621;1482.5848762346561;1527.6257316957194;1589.2200735176675;1604.3582566973305;1609.5895546635768;1004.8542961270575;1111.4772761316885;1132.5583022621183;1229.3668760588305;1236.7694144326454;4631.444226692751;4796.424429068534;4813.4945830687975;5141.765976165693;5267.341582302212;4829.295594467109;5119.846404607793;5192.377849186212;5192.533546565352;5588.910162518351;4562.429696287964;4603.58567728906;4700.976495117503;5039.5968322534845;5101.311322971425;2600.973990260073;2711.4034912319257;2766.9723302766715;2949.808262462933;3066.883850143394;5155.628410930939;5315.707636079976;5572.684252869536;5948.910766338422;6094.421030002142;5147.650235550954;5224.9738751306;5475.6440831345835;5578.330600327906;5865.442782935615;4919.1391506486225;5752.9424705753245;6179.443850053427;6349.920288659904;6501.561914282144;5120.692758434506;5592.3009623797025;5892.204552385545;6117.602355846856;6242.565399494291;5106.744662766772;5610;5912.46787789101;5966.940330596812;5967.224260846062;6287.371262873676;6306.684665766602;6307.369263073656;6318.810435686937;6418.748344072861;4087.959120408758;4493.348464472568;4808.2547205183255;4825.9034819304115;4840.467548569584;5434.75543600531;5695.601307908572;5773.884522309446;5866.450797267762;6130.356312587292;4947.6536642434685;5629.521490673339;5768.625039372428;5889.381614930542;5952.214475497849;4822.4187022329625;5259.685738275147;5360.25791617718;5651.971740141437;5926.407359264039;4989.326440930428;5502.312210973629;5614.88770224585;5731.627444216113;5811.593188476766;5259.658122222043;5860.531157507475;5942.425257306903;5947.553933455095;5961.642301461926;4587.6788624795945;5635.520980716685;5656.37779844225;5716.599838011466;5861.794837180678 07:53:11 INFO - PROCESS | 2180 | |5;yui.html;640.5516138702906;658.3581008516694;747.4132805747489;761.4187903008798;827.7847759582511;14399.784003239947;14858.034227775188;15366.078035317889;15388.61528461789;15555.377784888618;14010.439582416717;14211.573652790406;14303.213323267217;14374.784378234308;14542.0547664402;928.9256859451227;942.9669961551347;944.6740874398322;947.114447991127;947.2280091725222;846.9618867150962;957.4351132831628;959.6017652674132;960.7021823234785;961.8316794560959;1006.084463138544;1006.3408467453829;1008.2438171371472;1010.1413798271484;1010.9191264698807;1004.2367800471621;1006.320733504885;1006.3760468509498;1006.6225165562914;1008.1229330482527;739;743.3607097895805;744.2892038103598;744.9068866391701;746.447628754723;15052.096874187584;15270.3128359223;15407.922960385238;15758.527244182693;16051.91974040134;13568.796468052988;13834.031617786759;13870.791938120936;14152.36314365856;14164.150150990974;11353.489092990836;11595.188336816425;11628.6511404658;11660.766784664344;11966.64100076999;3644.325799727059;3647.8358473868475;3680.9263814723554;3700.1489657378684;3811.8094095295123;103632;103988;105561.4165787506;106073.46963265134;106597.46701266522;10641.308314959502;10656.467176641137;10709.892901071045;10892.965168308998;10944.671659850059;21992.01035953386;22078.77921220799;22354.105835766386;22365.217217397312;22437.663435048486;7054.118235220598;7460.14208366034;7564.546127232384;7626.4661473697415;7673.539587624648;4104.281750693616;4215.156968606291;4215.241256573846;4218.873433796991;4225.408442818008;2807.7332653397893;3273.525338825857;3318.435865902802;3359.4792807114936;3360.9663903361143;568.0456832521404;569.6667449541982;578.3551340255668;584.2229834320344;588.5115354255958;577.9682117483579;596.0403749962557;622.3185611755121;645.2805122288614;653.6600967496875;7538.585377804274;7687.923120768721;9276.814463710689;9533.142017218484;10044.096031357212;616.6669998201011;621.3196549777986;631.4285571557656;633.7496688807895;645.7633631595536;3764.7741135531955;4388.210122177975;4539.432570928634;4587.311903214544;4608.28571571407;88092.6786098209;91739.0826091744;98530.5073474628;101051.49474252581;101934;55107;79267.8109828353;80776.78834817483;87805;93597.5320123395;77560.2243977553;78408;78709;79832.60083699544;80596.19403805886;8460.153984601491;8461.661533538589;8513.233808957224;8649.30805535543;8725.563721814011;43031.569684302754;50476;51325.48674513207;52113.7394313026;52151.95696086133;57921;65879.34120658733;67478.98781518183;67792.6610366945;68417.94746157623;12453.1905426147;12510.374481276081;12636.810447843474;13131.409086590935;13316.40076196554;13635.045546811629;13689.726205475636;13725.176489410667;13864.722705545631;14220.146791192561;13020.242594142614;13061;13232.801507977196;13613.11514751538;13641.931790340985;12864;13181.40683669218;13217.801732974205;13348.132371395828;14055.718885622435;12632.621021369374;12866.742665146458;13092;13531.25578093175;13640.908727301594;10383.48082595852;10509.579616815241;10527.894721052691;10599.364038157735;11206.215564910379;8466.671665292093;8806.559672016501;9393;10459.84310235332;10532.842007370049 07:53:11 INFO - PROCESS | 2180 | __end_tp_report 07:53:11 INFO - PROCESS | 2180 | __start_cc_report 07:53:11 INFO - PROCESS | 2180 | _x_x_mozilla_cycle_collect,432 07:53:11 INFO - PROCESS | 2180 | __end_cc_report 07:53:11 INFO - PROCESS | 2180 | __startTimestamp1488383591878__endTimestamp 07:53:11 INFO - PROCESS | 2180 | 07:53:11 INFO - PROCESS | 2180 | ------- Summary: start ------- 07:53:11 INFO - PROCESS | 2180 | Number of tests: 6 07:53:11 INFO - PROCESS | 2180 | 07:53:11 INFO - PROCESS | 2180 | [#0] dojo.html Cycles:165 Average:5917.23 Median:6199.57 stddev:666.70 (10.8%) stddev-sans-first:639.82 07:53:11 INFO - PROCESS | 2180 | Values: 3441.0 3441.4 3464.9 3469.7 3470.1 5814.1 5982.5 5984.2 6025.5 6081.6 5866.1 5867.7 5885.9 5891.5 5899.5 5307.2 5420.1 5455.0 5503.0 5524.5 5452.5 5493.7 5512.9 5526.3 5559.1 5353.5 5440.2 5502.3 5518.1 5520.6 4597.0 5452.0 5503.2 5554.4 5562.1 4416.5 5174.8 5232.1 5288.9 5341.4 5098.6 5232.8 5634.9 5678.9 5940.6 6382.3 6399.6 6413.2 6426.8 6440.4 6469.5 6478.1 6487.3 6496.5 6496.9 5919.6 5964.8 6183.4 6189.0 6205.9 6426.8 6502.1 6511.6 6592.4 6609.8 6284.6 6302.7 6354.2 6356.3 6356.7 5881.4 6439.1 6439.6 6461.5 6470.1 5614.7 6238.9 6244.6 6310.0 6334.9 6212.8 6258.8 6300.9 6348.7 6385.9 5122.9 5163.5 5165.1 5184.9 5193.2 4541.3 4643.2 4664.5 4680.0 4686.0 5955.5 6022.2 6026.4 6202.7 6216.8 6281.6 6310.2 6311.8 6356.7 6438.4 6176.9 6195.1 6199.6 6201.3 6215.0 5503.2 5700.5 5707.6 5726.5 5765.1 6360.2 6460.9 6511.9 6529.8 6561.0 6337.0 6395.9 6444.3 6461.5 6465.0 6644.2 6646.6 6655.6 6667.7 6671.5 5098.0 6237.6 6265.2 6287.1 6372.1 6411.1 6418.2 6425.9 6432.9 6452.4 5413.6 6247.6 6261.3 6288.5 6300.8 6158.3 6183.6 6209.2 6230.2 6290.6 5718.8 5932.7 6244.8 6267.7 6285.8 6282.9 6290.2 6303.9 6317.7 6347.6 6022.1 6027.3 6085.1 6123.7 6161.6 07:53:11 INFO - PROCESS | 2180 | 07:53:11 INFO - PROCESS | 2180 | [#1] ext.html Cycles:180 Average:52389.52 Median:3047.59 stddev:108933.09 (3574.4%) stddev-sans-first:109169.57 07:53:11 INFO - PROCESS | 2180 | Values: 709.8 781.0 804.5 846.7 940.2 36422.6 37347.8 38675.6 38821.6 38888.6 31454.8 37421.0 37618.4 37691.4 37710.4 6475.7 8914.8 9513.0 9822.0 10681.0 10563.5 10628.9 10664.0 10664.4 10680.0 10641.5 10678.3 10678.7 10716.5 10718.8 10628.8 10650.2 10661.5 10664.4 10678.6 10360.0 10362.8 10395.5 10435.4 10446.6 32777.8 32853.5 33004.0 33010.5 33288.7 3686.0 3690.4 3699.5 3711.1 3729.9 20736.8 24189.6 24547.9 24702.9 24823.0 2966.2 2997.0 3028.5 3045.9 3049.3 330540.0 334880.3 336034.0 337273.0 337456.0 41921.4 42417.4 42562.6 42582.6 42612.6 43475.0 43530.6 43545.0 43644.3 43704.8 12582.1 12758.6 12822.9 12840.0 12877.0 10813.4 10950.9 10961.3 10961.7 10972.6 10815.8 11258.5 11348.7 11427.4 11454.8 5496.2 5613.2 5631.1 5640.9 5659.5 1043.6 1058.8 1073.3 1090.8 1117.2 21983.8 26549.7 26594.5 26937.7 27276.5 1129.7 1138.8 1161.8 1162.9 1180.5 13593.9 13892.7 13900.0 13945.7 14056.9 376447.0 454960.0 455760.0 455833.0 455902.0 35108.6 45931.8 46149.3 46316.3 46782.5 1360.8 1393.4 1395.0 1399.4 1404.2 25873.3 25963.0 26135.1 26664.7 26765.0 31798.8 35262.0 38135.0 38155.0 38430.6 381909.0 444170.0 457400.0 464029.0 465234.0 21812.9 21928.8 21984.0 22124.6 22216.3 32932.0 36348.3 36636.8 38070.2 38093.2 30307.2 31413.0 32312.4 32384.4 32890.3 31525.2 31774.0 32361.7 32500.2 32611.2 31824.4 32056.2 32102.4 32156.5 32743.0 23984.6 24683.0 26285.0 26666.5 27816.7 18668.3 19347.5 22353.2 22474.8 22704.8 07:53:11 INFO - PROCESS | 2180 | 07:53:11 INFO - PROCESS | 2180 | [#2] jquery.html Cycles:180 Average:40354.24 Median:2905.18 stddev:115874.52 (3988.5%) stddev-sans-first:116160.57 07:53:11 INFO - PROCESS | 2180 | Values: 314.0 387.6 412.3 428.7 438.8 19964.3 20167.0 20704.5 21481.0 21555.6 20737.5 20761.5 21006.8 21290.7 21367.1 6281.3 6599.9 6609.5 6618.2 6627.1 6324.6 6408.2 6419.5 6439.3 6519.2 6494.5 6494.6 6504.0 6512.1 6529.1 5442.1 6344.6 6404.9 6537.0 6541.8 6109.4 6250.2 6370.1 6394.4 6401.7 24516.8 25163.7 25443.0 25445.5 25516.4 2900.7 2909.6 2911.7 2918.8 2948.4 13082.7 14829.9 14978.8 15610.6 16227.8 1890.9 1933.9 1952.3 1956.9 1964.2 153299.0 157059.2 158787.0 160622.0 162722.0 19725.8 20454.6 20468.3 20612.7 20686.8 31069.1 31074.9 31125.8 31226.0 31245.0 9748.6 9918.5 10073.0 10078.9 10081.7 8311.0 8329.4 8345.0 8490.1 8506.4 9159.2 9168.0 9186.6 9292.0 9325.4 3102.8 3881.4 3881.5 3885.8 3895.7 785.8 957.2 964.8 983.3 1025.4 17336.2 18825.5 18951.0 20316.4 20455.0 782.0 961.3 976.8 981.9 1003.0 8697.7 9659.9 10108.0 10420.7 10475.9 668076.0 673558.0 691009.0 706551.0 727257.0 97884.5 115324.0 138516.0 150240.5 155609.2 966.3 984.2 1022.7 1024.4 1024.4 18876.5 19005.7 19160.0 19193.4 19297.3 46579.5 54025.0 56579.7 57134.0 60897.7 82564.6 82836.6 82941.3 83535.6 83656.6 11315.5 11319.2 11427.6 11628.0 11699.3 10475.9 12681.9 12815.8 13001.4 13147.7 9409.9 10414.6 10900.8 10936.7 11263.6 8582.8 8874.0 10801.0 11324.0 11375.8 10677.1 11624.3 11746.5 11773.5 11822.1 9295.9 11274.1 11589.6 11652.2 11781.6 9967.2 10486.5 10992.6 11194.4 11355.7 07:53:11 INFO - PROCESS | 2180 | 07:53:11 INFO - PROCESS | 2180 | [#3] mootools.html Cycles:180 Average:6517.28 Median:3562.58 stddev:4048.45 (113.6%) stddev-sans-first:4040.79 07:53:11 INFO - PROCESS | 2180 | Values: 1295.4 1504.8 1519.6 1529.2 1573.0 9178.0 9470.0 10263.4 10798.5 10875.2 10116.2 10465.4 10491.5 10686.7 10686.8 2274.7 2314.9 2318.4 2319.3 2320.2 2286.6 2313.1 2323.3 2324.4 2330.0 2280.2 2291.0 2312.7 2315.0 2319.0 2268.6 2270.4 2273.9 2289.8 2298.7 2239.3 2278.5 2299.7 2303.0 2308.6 10779.4 10848.4 10864.3 10869.6 10877.3 5523.8 5719.3 5730.0 5732.0 5738.5 3275.3 3353.3 3531.7 3587.7 3601.8 1155.5 1177.5 1188.5 1189.3 1216.0 14831.3 14847.8 14899.1 14969.9 15014.2 4668.0 4676.3 4761.5 4799.2 4848.8 12391.2 12445.3 12451.2 12451.5 12467.9 5736.2 5792.9 5802.4 5806.2 5810.1 4332.2 4718.7 4952.0 5034.1 5075.8 3820.4 3958.9 3967.4 3981.6 4040.3 1080.5 1083.2 1088.5 1098.6 1114.2 765.3 902.6 915.8 916.5 929.8 6326.9 6387.7 6491.2 6493.2 6597.6 958.6 965.9 975.8 1002.6 1017.3 3537.5 4019.6 4031.3 4062.1 4140.8 10868.7 12541.9 12979.2 13002.9 13011.0 12285.1 12752.9 12754.7 13017.0 13045.6 9027.1 9243.4 9251.6 9251.9 9337.8 6284.4 6363.0 6569.4 6699.9 6740.6 9732.4 11594.7 11788.7 11882.0 11938.1 11575.5 12076.5 12165.8 12219.0 12222.4 8659.5 8880.5 9545.0 9634.4 9903.9 7403.2 9935.7 10027.6 10129.7 10149.3 8552.5 8564.6 8815.1 8848.6 8932.2 8503.3 8572.4 8632.2 8686.1 8786.8 7604.1 7636.9 7703.9 7708.9 7725.7 5637.5 5741.1 5878.9 5900.6 5905.4 4127.9 5958.5 5964.9 5965.9 6123.1 07:53:11 INFO - PROCESS | 2180 | 07:53:11 INFO - PROCESS | 2180 | [#4] prototype.html Cycles:180 Average:4751.32 Median:5104.03 stddev:1394.49 (27.3%) stddev-sans-first:1358.42 07:53:11 INFO - PROCESS | 2180 | Values: 334.5 347.9 369.1 371.3 386.1 5659.3 5686.5 5713.6 5767.3 5770.4 4876.2 5495.9 5549.5 5578.5 5717.8 3405.4 3701.0 4238.3 4315.5 4345.8 3642.6 3688.5 4360.5 4377.0 4399.7 3814.0 4333.8 4355.0 4357.5 4387.8 3507.5 3754.5 3946.2 4328.1 4337.0 3168.7 3565.2 3578.2 3757.7 3786.5 4924.3 5364.3 5425.7 5442.3 5473.5 3678.5 4169.4 4400.8 4986.6 5075.9 4909.0 5642.9 5853.0 5909.4 5993.0 4405.0 4723.5 4733.6 4778.8 4778.9 4598.0 5443.8 5734.5 6314.3 6347.9 4072.7 4688.4 4706.8 4787.7 4908.6 4709.5 4953.3 4957.7 4976.5 4992.9 4205.9 4593.9 5088.0 5306.9 5442.3 5401.9 5869.4 5891.3 5899.2 5901.1 1482.6 1527.6 1589.2 1604.4 1609.6 1004.9 1111.5 1132.6 1229.4 1236.8 4631.4 4796.4 4813.5 5141.8 5267.3 4829.3 5119.8 5192.4 5192.5 5588.9 4562.4 4603.6 4701.0 5039.6 5101.3 2601.0 2711.4 2767.0 2949.8 3066.9 5155.6 5315.7 5572.7 5948.9 6094.4 5147.7 5225.0 5475.6 5578.3 5865.4 4919.1 5752.9 6179.4 6349.9 6501.6 5120.7 5592.3 5892.2 6117.6 6242.6 5106.7 5610.0 5912.5 5966.9 5967.2 6287.4 6306.7 6307.4 6318.8 6418.7 4088.0 4493.3 4808.3 4825.9 4840.5 5434.8 5695.6 5773.9 5866.5 6130.4 4947.7 5629.5 5768.6 5889.4 5952.2 4822.4 5259.7 5360.3 5652.0 5926.4 4989.3 5502.3 5614.9 5731.6 5811.6 5259.7 5860.5 5942.4 5947.6 5961.6 4587.7 5635.5 5656.4 5716.6 5861.8 07:53:11 INFO - PROCESS | 2180 | 07:53:11 INFO - PROCESS | 2180 | [#5] yui.html Cycles:180 Average:19797.97 Median:3646.08 stddev:28330.58 (777.0%) stddev-sans-first:28373.54 07:53:11 INFO - PROCESS | 2180 | Values: 640.6 658.4 747.4 761.4 827.8 14399.8 14858.0 15366.1 15388.6 15555.4 14010.4 14211.6 14303.2 14374.8 14542.1 928.9 943.0 944.7 947.1 947.2 847.0 957.4 959.6 960.7 961.8 1006.1 1006.3 1008.2 1010.1 1010.9 1004.2 1006.3 1006.4 1006.6 1008.1 739.0 743.4 744.3 744.9 746.4 15052.1 15270.3 15407.9 15758.5 16051.9 13568.8 13834.0 13870.8 14152.4 14164.2 11353.5 11595.2 11628.7 11660.8 11966.6 3644.3 3647.8 3680.9 3700.1 3811.8 103632.0 103988.0 105561.4 106073.5 106597.5 10641.3 10656.5 10709.9 10893.0 10944.7 21992.0 22078.8 22354.1 22365.2 22437.7 7054.1 7460.1 7564.5 7626.5 7673.5 4104.3 4215.2 4215.2 4218.9 4225.4 2807.7 3273.5 3318.4 3359.5 3361.0 568.0 569.7 578.4 584.2 588.5 578.0 596.0 622.3 645.3 653.7 7538.6 7687.9 9276.8 9533.1 10044.1 616.7 621.3 631.4 633.7 645.8 3764.8 4388.2 4539.4 4587.3 4608.3 88092.7 91739.1 98530.5 101051.5 101934.0 55107.0 79267.8 80776.8 87805.0 93597.5 77560.2 78408.0 78709.0 79832.6 80596.2 8460.2 8461.7 8513.2 8649.3 8725.6 43031.6 50476.0 51325.5 52113.7 52152.0 57921.0 65879.3 67479.0 67792.7 68417.9 12453.2 12510.4 12636.8 13131.4 13316.4 13635.0 13689.7 13725.2 13864.7 14220.1 13020.2 13061.0 13232.8 13613.1 13641.9 12864.0 13181.4 13217.8 13348.1 14055.7 12632.6 12866.7 13092.0 13531.3 13640.9 10383.5 10509.6 10527.9 10599.4 11206.2 8466.7 8806.6 9393.0 10459.8 10532.8 07:53:11 INFO - PROCESS | 2180 | -------- Summary: end -------- 07:53:11 INFO - PROCESS | 2180 | 07:53:11 INFO - PROCESS | 2180 | 1488383591905 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 07:53:12 INFO - TEST-INFO | 2180: exit 0 07:53:12 INFO - TEST-OK | dromaeo_css | took 1116753ms 07:53:12 INFO - TEST-START | kraken 07:53:12 INFO - operating with platform_type : mac_ 07:53:12 INFO - Initialising browser for kraken test... 07:53:12 INFO - TEST-INFO | started process 2185 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmppOJUtJ/profile http://localhost:52160/getInfo.html) 07:53:13 INFO - PROCESS | 2185 | 1488383593126 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:13 INFO - PROCESS | 2185 | 1488383593127 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method install 07:53:13 INFO - PROCESS | 2185 | 1488383593168 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 07:53:15 INFO - PROCESS | 2185 | 2017-03-01 07:53:15.328 plugin-container[2186:24239] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 07:53:15 INFO - PROCESS | 2185 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:53:15 INFO - PROCESS | 2185 | 2017-03-01 07:53:15.330 plugin-container[2186:24239] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 07:53:15 INFO - PROCESS | 2185 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:53:15 INFO - PROCESS | 2185 | 2017-03-01 07:53:15.330 plugin-container[2186:24239] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:53:15 INFO - PROCESS | 2185 | __metrics Screen width/height:1600/1200 07:53:15 INFO - PROCESS | 2185 | colorDepth:24 07:53:15 INFO - PROCESS | 2185 | Browser inner width/height: 1024/689 07:53:15 INFO - PROCESS | 2185 | __metrics 07:53:15 ERROR - PROCESS | 2185 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3354: TypeError: this.tabs is undefined 07:53:15 INFO - PROCESS | 2185 | 1488383595531 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 07:53:16 INFO - TEST-INFO | 2185: exit 0 07:53:16 INFO - Browser initialized. 07:53:16 INFO - Running cycle 1/1 for kraken test... 07:53:16 INFO - TEST-INFO | started process 2187 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmppOJUtJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:53:16 INFO - PROCESS | 2187 | 1488383596615 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:16 INFO - PROCESS | 2187 | 1488383596616 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 07:53:18 INFO - PROCESS | 2187 | 2017-03-01 07:53:18.987 plugin-container[2188:24363] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4537, name = 'com.apple.tsm.portname' 07:53:18 INFO - PROCESS | 2187 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:53:18 INFO - PROCESS | 2187 | 2017-03-01 07:53:18.988 plugin-container[2188:24363] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 07:53:18 INFO - PROCESS | 2187 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:53:18 INFO - PROCESS | 2187 | 2017-03-01 07:53:18.988 plugin-container[2188:24363] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:53:28 INFO - PROCESS | 2187 | RSS: Main: 226320384 07:53:28 INFO - PROCESS | 2187 | 07:53:31 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:52160/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52160/tests/kraken/driver.html?testName=audio-beat-detection) 07:53:32 INFO - PROCESS | 2187 | RSS: Main: 241340416 07:53:32 INFO - PROCESS | 2187 | 07:53:35 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:52160/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52160/tests/kraken/driver.html?testName=audio-dft) 07:53:36 INFO - PROCESS | 2187 | RSS: Main: 249470976 07:53:36 INFO - PROCESS | 2187 | 07:53:39 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:52160/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52160/tests/kraken/driver.html?testName=audio-fft) 07:53:40 INFO - PROCESS | 2187 | RSS: Main: 252104704 07:53:40 INFO - PROCESS | 2187 | 07:53:42 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:52160/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52160/tests/kraken/driver.html?testName=audio-oscillator) 07:53:42 INFO - PROCESS | 2187 | RSS: Main: 253194240 07:53:42 INFO - PROCESS | 2187 | 07:53:44 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:52160/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52160/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:53:45 INFO - PROCESS | 2187 | RSS: Main: 253583360 07:53:45 INFO - PROCESS | 2187 | 07:53:48 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:52160/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52160/tests/kraken/driver.html?testName=imaging-darkroom) 07:53:49 INFO - PROCESS | 2187 | RSS: Main: 260558848 07:53:49 INFO - PROCESS | 2187 | 07:53:52 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:52160/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52160/tests/kraken/driver.html?testName=imaging-desaturate) 07:53:53 INFO - PROCESS | 2187 | RSS: Main: 257187840 07:53:53 INFO - PROCESS | 2187 | 07:53:56 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:52160/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52160/tests/kraken/driver.html?testName=json-parse-financial) 07:53:57 INFO - PROCESS | 2187 | RSS: Main: 258195456 07:53:57 INFO - PROCESS | 2187 | 07:53:59 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:52160/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52160/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:54:00 INFO - PROCESS | 2187 | RSS: Main: 259158016 07:54:00 INFO - PROCESS | 2187 | 07:54:02 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:52160/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52160/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:54:02 INFO - PROCESS | 2187 | RSS: Main: 258674688 07:54:02 INFO - PROCESS | 2187 | 07:54:05 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:52160/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52160/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:54:05 INFO - PROCESS | 2187 | RSS: Main: 259436544 07:54:05 INFO - PROCESS | 2187 | 07:54:08 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:52160/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52160/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:54:09 INFO - PROCESS | 2187 | RSS: Main: 259293184 07:54:09 INFO - PROCESS | 2187 | 07:54:12 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:52160/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52160/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:54:13 INFO - PROCESS | 2187 | RSS: Main: 267608064 07:54:13 INFO - PROCESS | 2187 | 07:54:14 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:52160/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52160/tests/kraken/driver.html?testName=ai-astar) 07:54:15 INFO - PROCESS | 2187 | RSS: Main: 270807040 07:54:15 INFO - PROCESS | 2187 | 07:54:15 INFO - PROCESS | 2187 | __start_tp_report 07:54:15 INFO - PROCESS | 2187 | _x_x_mozilla_page_load 07:54:15 INFO - PROCESS | 2187 | _x_x_mozilla_page_load_details 07:54:15 INFO - PROCESS | 2187 | |i|pagename|runs| 07:54:15 INFO - PROCESS | 2187 | |0;ai-astar;108;118;124;121;119;120;120;120;120;147 07:54:15 INFO - PROCESS | 2187 | |1;audio-beat-detection;145;112;112;152;113;117;111;123;167;146 07:54:15 INFO - PROCESS | 2187 | |2;audio-dft;218;252;194;281;211;279;277;196;196;197 07:54:15 INFO - PROCESS | 2187 | |3;audio-fft;86;64;65;99;62;61;61;61;74;59 07:54:15 INFO - PROCESS | 2187 | |4;audio-oscillator;89;72;84;73;72;70;82;69;72;83 07:54:15 INFO - PROCESS | 2187 | |5;imaging-gaussian-blur;90;105;89;90;89;86;122;76;123;77 07:54:15 INFO - PROCESS | 2187 | |6;imaging-darkroom;94;96;91;156;153;98;97;124;135;156 07:54:15 INFO - PROCESS | 2187 | |7;imaging-desaturate;90;95;91;90;131;144;92;119;100;143 07:54:15 INFO - PROCESS | 2187 | |8;json-parse-financial;64;66;66;66;68;69;74;106;104;60 07:54:15 INFO - PROCESS | 2187 | |9;json-stringify-tinderbox;64;86;50;79;94;87;48;72;86;87 07:54:15 INFO - PROCESS | 2187 | |10;stanford-crypto-aes;101;108;109;101;90;91;88;88;91;97 07:54:15 INFO - PROCESS | 2187 | |11;stanford-crypto-ccm;154;142;155;159;149;139;142;148;213;173 07:54:15 INFO - PROCESS | 2187 | |12;stanford-crypto-pbkdf2;177;175;173;176;178;178;171;172;179;176 07:54:15 INFO - PROCESS | 2187 | |13;stanford-crypto-sha256-iterative;71;68;67;68;66;69;66;68;69;67 07:54:15 INFO - PROCESS | 2187 | __end_tp_report 07:54:15 INFO - PROCESS | 2187 | __start_cc_report 07:54:15 INFO - PROCESS | 2187 | _x_x_mozilla_cycle_collect,1012 07:54:15 INFO - PROCESS | 2187 | __end_cc_report 07:54:15 INFO - PROCESS | 2187 | __startTimestamp1488383655005__endTimestamp 07:54:15 INFO - PROCESS | 2187 | 07:54:15 INFO - PROCESS | 2187 | ------- Summary: start ------- 07:54:15 INFO - PROCESS | 2187 | Number of tests: 14 07:54:15 INFO - PROCESS | 2187 | 07:54:15 INFO - PROCESS | 2187 | [#0] ai-astar Cycles:10 Average:121.70 Median:120.00 stddev:9.81 (8.2%) stddev-sans-first:9.07 07:54:15 INFO - PROCESS | 2187 | Values: 108.0 118.0 124.0 121.0 119.0 120.0 120.0 120.0 120.0 147.0 07:54:15 INFO - PROCESS | 2187 | 07:54:15 INFO - PROCESS | 2187 | [#1] audio-beat-detection Cycles:10 Average:129.80 Median:134.00 stddev:20.68 (15.4%) stddev-sans-first:21.19 07:54:15 INFO - PROCESS | 2187 | Values: 145.0 112.0 112.0 152.0 113.0 117.0 111.0 123.0 167.0 146.0 07:54:15 INFO - PROCESS | 2187 | 07:54:15 INFO - PROCESS | 2187 | [#2] audio-dft Cycles:10 Average:230.10 Median:235.00 stddev:37.85 (16.1%) stddev-sans-first:39.90 07:54:15 INFO - PROCESS | 2187 | Values: 218.0 252.0 194.0 281.0 211.0 279.0 277.0 196.0 196.0 197.0 07:54:15 INFO - PROCESS | 2187 | 07:54:15 INFO - PROCESS | 2187 | [#3] audio-fft Cycles:10 Average:69.20 Median:64.50 stddev:13.31 (20.6%) stddev-sans-first:12.66 07:54:15 INFO - PROCESS | 2187 | Values: 86.0 64.0 65.0 99.0 62.0 61.0 61.0 61.0 74.0 59.0 07:54:15 INFO - PROCESS | 2187 | 07:54:15 INFO - PROCESS | 2187 | [#4] audio-oscillator Cycles:10 Average:76.60 Median:77.50 stddev:7.12 (9.2%) stddev-sans-first:5.97 07:54:15 INFO - PROCESS | 2187 | Values: 89.0 72.0 84.0 73.0 72.0 70.0 82.0 69.0 72.0 83.0 07:54:15 INFO - PROCESS | 2187 | 07:54:15 INFO - PROCESS | 2187 | [#5] imaging-gaussian-blur Cycles:10 Average:94.70 Median:87.50 stddev:16.67 (19.0%) stddev-sans-first:17.59 07:54:15 INFO - PROCESS | 2187 | Values: 90.0 105.0 89.0 90.0 89.0 86.0 122.0 76.0 123.0 77.0 07:54:15 INFO - PROCESS | 2187 | 07:54:15 INFO - PROCESS | 2187 | [#6] imaging-darkroom Cycles:10 Average:120.00 Median:92.50 stddev:27.94 (30.2%) stddev-sans-first:28.01 07:54:15 INFO - PROCESS | 2187 | Values: 94.0 96.0 91.0 156.0 153.0 98.0 97.0 124.0 135.0 156.0 07:54:15 INFO - PROCESS | 2187 | 07:54:15 INFO - PROCESS | 2187 | [#7] imaging-desaturate Cycles:10 Average:109.50 Median:90.00 stddev:22.55 (25.1%) stddev-sans-first:22.78 07:54:15 INFO - PROCESS | 2187 | Values: 90.0 95.0 91.0 90.0 131.0 144.0 92.0 119.0 100.0 143.0 07:54:15 INFO - PROCESS | 2187 | 07:54:15 INFO - PROCESS | 2187 | [#8] json-parse-financial Cycles:10 Average:74.30 Median:66.00 stddev:16.57 (25.1%) stddev-sans-first:17.15 07:54:15 INFO - PROCESS | 2187 | Values: 64.0 66.0 66.0 66.0 68.0 69.0 74.0 106.0 104.0 60.0 07:54:15 INFO - PROCESS | 2187 | 07:54:15 INFO - PROCESS | 2187 | [#9] json-stringify-tinderbox Cycles:10 Average:75.30 Median:86.00 stddev:16.30 (18.9%) stddev-sans-first:16.76 07:54:15 INFO - PROCESS | 2187 | Values: 64.0 86.0 50.0 79.0 94.0 87.0 48.0 72.0 86.0 87.0 07:54:15 INFO - PROCESS | 2187 | 07:54:15 INFO - PROCESS | 2187 | [#10] stanford-crypto-aes Cycles:10 Average:96.40 Median:89.00 stddev:8.00 (9.0%) stddev-sans-first:8.31 07:54:15 INFO - PROCESS | 2187 | Values: 101.0 108.0 109.0 101.0 90.0 91.0 88.0 88.0 91.0 97.0 07:54:15 INFO - PROCESS | 2187 | 07:54:15 INFO - PROCESS | 2187 | [#11] stanford-crypto-ccm Cycles:10 Average:157.40 Median:154.50 stddev:21.93 (14.2%) stddev-sans-first:23.22 07:54:15 INFO - PROCESS | 2187 | Values: 154.0 142.0 155.0 159.0 149.0 139.0 142.0 148.0 213.0 173.0 07:54:15 INFO - PROCESS | 2187 | 07:54:15 INFO - PROCESS | 2187 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.50 Median:176.50 stddev:2.72 (1.5%) stddev-sans-first:2.83 07:54:15 INFO - PROCESS | 2187 | Values: 177.0 175.0 173.0 176.0 178.0 178.0 171.0 172.0 179.0 176.0 07:54:15 INFO - PROCESS | 2187 | 07:54:15 INFO - PROCESS | 2187 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.52 (2.2%) stddev-sans-first:1.13 07:54:15 INFO - PROCESS | 2187 | Values: 71.0 68.0 67.0 68.0 66.0 69.0 66.0 68.0 69.0 67.0 07:54:15 INFO - PROCESS | 2187 | -------- Summary: end -------- 07:54:15 INFO - PROCESS | 2187 | 07:54:15 INFO - PROCESS | 2187 | 1488383655028 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 07:54:16 INFO - TEST-INFO | 2187: exit 0 07:54:16 INFO - TEST-OK | kraken | took 63500ms 07:54:16 INFO - SUITE-END | took 1180s 07:54:16 INFO - Completed test suite (00:19:40) 07:54:16 INFO - javascript benchmark 07:54:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7509.413068657663, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3441.0021093882774, 3441.36334778066, 3464.8960531184057, 3469.705075068619, 3470.132466883279, 5814.1278808178795, 5982.521398288138, 5984.222051133352, 6025.487833534149, 6081.6351018938785, 5866.061430171173, 5867.735951882165, 5885.911711324323, 5891.469767720904, 5899.469047785698, 5307.20391941209, 5420.078586640261, 5455.0, 5502.98194833955, 5524.502794748471, 5452.482014208644, 5493.725313734317, 5512.924979628974, 5526.336839579256, 5559.054960656698, 5353.464653534655, 5440.238366628655, 5502.312210973629, 5518.144687573433, 5520.613557051008, 4597.034622729231, 5452.0, 5503.174523821419, 5554.416786237468, 5562.137868630369, 4416.470023597189, 5174.793008279665, 5232.084385232607, 5288.894222115575, 5341.359036915556, 5098.59211263098, 5232.848773269875, 5634.943650563483, 5678.9432105678825, 5940.6435613863305, 6382.297947225801, 6399.616023038632, 6413.16628838248, 6426.775062872777, 6440.355964403569, 6469.547131700783, 6478.125453063823, 6487.286398496161, 6496.5127615428555, 6496.902546461807, 5919.644821310735, 5964.761409543657, 6183.412575805291, 6189.0, 6205.906911396378, 6426.775062872777, 6502.122213501211, 6511.641859697667, 6592.373724496261, 6609.768658096944, 6284.591501552384, 6302.684865756693, 6354.205724284465, 6356.269029061625, 6356.713947872357, 5881.3530511643685, 6439.098526206335, 6439.613623182624, 6461.450776683941, 6470.09418681385, 5614.6631202128, 6238.937610623836, 6244.594101383486, 6310.021946598285, 6334.904976425358, 6212.782552610637, 6258.812235632939, 6300.905486417708, 6348.714307856158, 6385.936140638627, 5122.948770512247, 5163.509466600667, 5165.14775062118, 5184.870378240575, 5193.169092945111, 4541.2733962565835, 4643.164230438486, 4664.463586687507, 4680.0, 4685.9531404686195, 5955.493783028404, 6022.156898034279, 6026.427489388501, 6202.658853762996, 6216.813495595139, 6281.591696539802, 6310.211223597051, 6311.842203944846, 6356.745730170834, 6438.3883531064475, 6176.938230617726, 6195.132681424604, 6199.5660303779205, 6201.255849298113, 6214.974529202721, 5503.174523821459, 5700.4869561738815, 5707.571932105108, 5726.455986681259, 5765.135229715576, 6360.1731774869895, 6460.935390646034, 6511.869762604816, 6529.804105876831, 6561.0, 6337.017762246859, 6395.936040639534, 6444.258910225384, 6461.450776684034, 6464.967675161783, 6644.235912869888, 6646.60120392778, 6655.600663960178, 6667.733290668319, 6671.532992690465, 5097.974510127426, 6237.625742455467, 6265.248170219603, 6287.088372186099, 6372.107904893226, 6411.134496842867, 6418.229812422539, 6425.903611445926, 6432.871342573216, 6452.387023232973, 5413.593980451403, 6247.625142491465, 6261.311255761953, 6288.465480434214, 6300.779472718433, 6158.32258451561, 6183.598066125687, 6209.161763161916, 6230.190075290183, 6290.559660823698, 5718.828435146952, 5932.673702946379, 6244.843878903063, 6267.717952692049, 6285.811425657238, 6282.905756413749, 6290.150829637941, 6303.905441418291, 6317.652529110943, 6347.587406818542, 6022.066579680157, 6027.336992930862, 6085.117657939485, 6123.740204357105, 6161.630302181883], "value": 5875.474812546582, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.8083517450289, 780.9570473623951, 804.5213098206565, 846.7290467050547, 940.2337095267361, 36422.63577364226, 37347.81326093369, 38675.613243867556, 38821.61178388215, 38888.638897638586, 31454.84272578634, 37421.0, 37618.43572346417, 37691.434628480594, 37710.43434348487, 6475.740970361192, 8914.821703565925, 9512.952435237848, 9822.017798220157, 10681.038706516412, 10563.524641391155, 10628.946855265713, 10664.0, 10664.360138391683, 10680.0, 10641.467926603638, 10678.25252232344, 10678.704078623094, 10716.464176791169, 10718.78562428751, 10628.840567391495, 10650.201234907374, 10661.466926653637, 10664.360138391721, 10678.572857085746, 10360.015798499131, 10362.844557331646, 10395.480225988671, 10435.37387756737, 10446.63436779709, 32777.83611081953, 32853.50719739206, 33004.00987970341, 33010.504842427385, 33288.667113329044, 3686.0, 3690.4279836625365, 3699.5375578052744, 3711.109333759905, 3729.850805967758, 20736.792632073786, 24189.637155442684, 24547.87726061376, 24702.876485617635, 24823.0, 2966.2485272714707, 2996.955045674317, 3028.530577760451, 3045.923851903698, 3049.2529330314214, 330540.0, 334880.32559837046, 336034.0, 337273.0, 337455.99999999756, 41921.37117943233, 42417.36373954393, 42562.57437425648, 42582.57417425848, 42612.57387426086, 43475.0, 43530.564694353285, 43545.0, 43644.345334820006, 43704.78147609305, 12582.119251652479, 12758.61724148277, 12822.871771282355, 12840.0, 12877.0, 10813.351198928089, 10950.890491094988, 10961.287516311415, 10961.725956851142, 10972.561097556008, 10815.78368432627, 11258.549658013588, 11348.716282093013, 11427.371494567878, 11454.828177577343, 5496.1755736639825, 5613.214150019001, 5631.070873305941, 5640.943590564124, 5659.518940889988, 1043.5512729526376, 1058.8200005999, 1073.2755390111643, 1090.7872964771793, 1117.201201141188, 21983.780162198174, 26549.734502655112, 26594.468110637677, 26937.730622693914, 27276.454470910867, 1129.7232178116415, 1138.7950168969664, 1161.7560312334504, 1162.9069674426025, 1180.5159884447335, 13593.864061359458, 13892.722145557032, 13900.0, 13945.651358716113, 14056.929715351358, 376447.0, 454960.0, 455760.0, 455833.0, 455902.0, 35108.648913511046, 45931.77034114808, 46149.30776038362, 46316.3052554212, 46782.5321746785, 1360.843502997168, 1393.3938736649386, 1395.023483561511, 1399.3982587487478, 1404.1504889541884, 25873.26628214285, 25963.0, 26135.08527201539, 26664.733352667, 26765.0, 31798.841005794824, 35262.0, 38135.0, 38155.046123847125, 38430.61569384382, 381909.0, 444170.0, 457400.0, 464029.0, 465234.0, 21812.89093554522, 21928.78071219331, 21984.0, 22124.557508850055, 22216.333509994725, 32932.0, 36348.27303453969, 36636.81681591575, 38070.2385952285, 38093.2381352377, 30307.242318942204, 31413.0, 32312.35375292434, 32384.35231295314, 32890.34219315648, 31525.211869703442, 31774.0, 32361.676383235867, 32500.187495312806, 32611.18472038218, 31824.36351273008, 32056.198595035312, 32102.35795284128, 32156.51765223477, 32743.0, 23984.64023039621, 24683.0, 26285.0, 26666.46667066609, 27816.72183278141, 18668.253269869598, 19347.516312091746, 22353.21174306084, 22474.77525224727, 22704.772952270265], "value": 17400.16830680874, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.95761572187746, 387.5775404808756, 412.25587813995725, 428.74061192978246, 438.84201687392533, 19964.30124945627, 20166.991650417494, 20704.48238794031, 21481.03335349909, 21555.568888622238, 20737.481562960933, 20761.480962975933, 21006.789932100673, 21290.68063979038, 21367.145314187415, 6281.340459251781, 6599.934000660004, 6609.471242300629, 6618.238902526223, 6627.138471998657, 6324.557280990332, 6408.166938298014, 6419.486441084726, 6439.323870993549, 6519.152510173671, 6494.512911531654, 6494.610323380589, 6504.024396340563, 6512.055751915969, 6529.118568993173, 5442.074847275972, 6344.619322840645, 6404.871902561946, 6537.0, 6541.771038013694, 6109.3890610939, 6250.218722659668, 6370.140031095789, 6394.360563943615, 6401.679916004181, 24516.774161291865, 25163.748362516322, 25443.0, 25445.491090178093, 25516.362090947874, 2900.7389334959953, 2909.621749172594, 2911.737943585066, 2918.824870507755, 2948.3808400235976, 13082.691730826937, 14829.851701482956, 14978.775318370233, 15610.609734756608, 16227.83772162275, 1890.8960007199598, 1933.8549608779258, 1952.306931039489, 1956.9217231310731, 1964.1554131723353, 153299.0, 157059.21470392574, 158787.0, 160622.0, 162722.0, 19725.802741972682, 20454.59090818205, 20468.283610073577, 20612.69080963787, 20686.79313206879, 31069.067927962198, 31074.91237806666, 31125.844370778002, 31226.0, 31245.0, 9748.561314740853, 9918.454485003394, 10073.018167318734, 10078.899211007943, 10081.739782527184, 8311.0, 8329.416940814084, 8344.958275208706, 8490.066092729918, 8506.447080939719, 9159.175674189355, 9167.954160229156, 9186.58660360272, 9291.953540232256, 9325.393849399903, 3102.844857757103, 3881.3983832506005, 3881.4760007399204, 3885.7668539887695, 3895.7078219133678, 785.8310463250428, 957.1577012229333, 964.7732782796037, 983.311681822727, 1025.3642741500169, 17336.219870105622, 18825.529361766065, 18951.0, 20316.39050828448, 20455.0, 781.9530828150329, 961.3414810854587, 976.7802244494932, 981.8527220916919, 1003.0, 8697.721930755442, 9659.855102173473, 10108.039736225193, 10420.739481512872, 10475.94762026185, 668076.0, 673558.0, 691009.0, 706551.0, 727257.0, 97884.51057744665, 115324.0, 138516.0, 150240.49759502264, 155609.22195389177, 966.3090890013674, 984.2224642532319, 1022.6880801355658, 1024.36489376587, 1024.4058446101244, 18876.528086797938, 19005.714914276574, 19160.0, 19193.424197274104, 19297.324593639154, 46579.53420465752, 54025.0, 56579.71710141423, 57134.0, 60897.69551152216, 82564.58717706373, 82836.58581707053, 82941.341173175, 83535.61002919193, 83656.58171709103, 11315.490802914053, 11319.207655464039, 11427.600033999102, 11628.01161901214, 11699.2980421175, 10475.895241047798, 12681.936590317358, 12815.807762883378, 13001.4149363277, 13147.73704525885, 9409.858852117086, 10414.59402980588, 10900.836487452536, 10936.671899843017, 11263.605773797877, 8582.78543036429, 8873.955630221808, 10800.973907478778, 11324.037456815933, 11375.772484550098, 10677.14582833356, 11624.329853799778, 11746.530138794353, 11773.47019384147, 11822.054235660955, 9295.907040929775, 11274.083405821195, 11589.594364197214, 11652.242604230698, 11781.646550603153, 9967.152792012761, 10486.47567621631, 10992.570965774397, 11194.384308863091, 11355.716107097389], "value": 11022.942895726266, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1295.410588182377, 1504.8269449013362, 1519.5517322389894, 1529.1818876900861, 1572.976405353919, 9178.036306187854, 9469.952650236757, 10263.384196948178, 10798.51406686699, 10875.184361172904, 10116.241281903849, 10465.424401657925, 10491.475426228677, 10686.679399618004, 10686.839697404544, 2274.7270327560673, 2314.918977835776, 2318.3624503261653, 2319.3158018384615, 2320.153144102407, 2286.588414085464, 2313.0747700919683, 2323.3262353917344, 2324.39565712915, 2330.0330362899376, 2280.2019293247395, 2291.0, 2312.7455979842202, 2314.9537009259807, 2318.9536209275802, 2268.6143355629583, 2270.398344438717, 2273.886305684709, 2289.828262880291, 2298.7241531016302, 2239.2722365231202, 2278.544291141778, 2299.655051742235, 2303.021215983217, 2308.607536718762, 10779.407132607703, 10848.403337816417, 10864.348139111678, 10869.619563315326, 10877.347359158397, 5523.8066667666435, 5719.342275638313, 5730.0, 5731.971340143315, 5738.512226460714, 3275.279438523521, 3353.279045005336, 3531.6644918732677, 3587.7129829613827, 3601.8019008954498, 1155.5320095361392, 1177.5054477119631, 1188.4533114767216, 1189.2626571525623, 1215.9756804863941, 14831.332590033475, 14847.777283340758, 14899.106053636817, 14969.850301497063, 15014.24928753569, 4668.0, 4676.342078417041, 4761.547652972962, 4799.232122860326, 4848.830290939871, 12391.194572352768, 12445.315507647167, 12451.190672606434, 12451.501939922482, 12467.875321246853, 5736.196932429463, 5792.913106303409, 5802.361740208574, 5806.1581070744505, 5810.12848072784, 4332.155229730172, 4718.693284936468, 4952.0, 5034.119029169954, 5075.822346217865, 3820.4078367853026, 3958.861439849649, 3967.3652215645357, 3981.641652251253, 4040.2727509048655, 1080.5191689698165, 1083.2363183955292, 1088.472091035847, 1098.5715570927346, 1114.2144787924494, 765.3112199020815, 902.5919565477875, 915.8214148241162, 916.4730280088842, 929.8486385424671, 6326.936730632635, 6387.744490220432, 6491.188601424822, 6493.188351456068, 6597.60414375139, 958.6405098088217, 965.8696076029787, 975.8292298847815, 1002.6240159940022, 1017.2980643356209, 3537.451694987281, 4019.633324669568, 4031.314676505001, 4062.1266427718183, 4140.792960351971, 10868.67393978182, 12541.93729031349, 12979.156354837094, 13002.869971300355, 13011.0, 12285.1400401971, 12752.93623531895, 12754.68113297175, 13017.0, 13045.608631741063, 9027.14242146995, 9243.352965292364, 9251.629934802668, 9251.889773227256, 9337.813243735087, 6284.402981716729, 6362.981922892315, 6569.441597464269, 6699.866002680016, 6740.618173274565, 9732.367396119229, 11594.6521604352, 11788.70528236801, 11882.0, 11938.1046421517, 11575.479103440533, 12076.51693932233, 12165.756684866075, 12219.022478201545, 12222.388880556115, 8659.48043117415, 8880.467171969702, 9544.95227523858, 9634.421934683942, 9903.851442228228, 7403.185649578434, 9935.701928942144, 10027.649032283834, 10129.696109116738, 10149.34029288094, 8552.486850788973, 8564.614592343234, 8815.118488151134, 8848.601812918305, 8932.151445612657, 8503.319734421355, 8572.357073219659, 8632.179942905665, 8686.131386861263, 8786.824263514565, 7604.125525564631, 7636.923630763844, 7703.922960770545, 7708.882212079329, 7725.690972361267, 5637.52081073097, 5741.081426971665, 5878.853028674146, 5900.5574581907385, 5905.43898329658, 4127.8968025798395, 5958.523318134626, 5964.8807023860145, 5965.940340596539, 6123.112148738497], "value": 4990.133587897761, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.5216340632895, 347.8799814064148, 369.0717844620779, 371.331603114394, 386.1485424638674, 5659.264295641561, 5686.545076393889, 5713.571482138846, 5767.250257466529, 5770.422957704228, 4876.1954277544255, 5495.890082198363, 5549.472800083996, 5578.497935185833, 5717.827225654256, 3405.370006548784, 3700.9814950925206, 4238.30068038774, 4315.525292217869, 4345.760983145926, 3642.6357364263495, 3688.5020522229424, 4360.454943132108, 4377.0, 4399.736015839044, 3813.9809300953457, 4333.804978775946, 4354.978225108885, 4357.498887627916, 4387.780610969455, 3507.4563442666426, 3754.530683664542, 3946.205173035425, 4328.134373125372, 4337.0, 3168.6989735975044, 3565.2156525564333, 3578.159132603836, 3757.718171137148, 3786.5266841644793, 4924.3105965164905, 5364.329458817648, 5425.728713564306, 5442.346918369782, 5473.452654734495, 3678.5401824771902, 4169.353750168699, 4400.7579583122915, 4986.5761410280165, 5075.949240507584, 4908.950910490885, 5642.85892852682, 5853.009976607974, 5909.37951515089, 5993.0, 4404.955950440487, 4723.527647235283, 4733.644976626732, 4778.832740854054, 4778.928316075262, 4598.0344127733215, 5443.782248710047, 5734.483896449298, 6314.336994615545, 6347.904781428282, 4072.6741860651077, 4688.367070445446, 4706.822894546168, 4787.712737235777, 4908.631852610997, 4709.481956984729, 4953.2570114483115, 4957.7273249971595, 4976.516438492997, 4992.925106123411, 4205.894852628709, 4593.862184134415, 5088.0, 5306.930297184102, 5442.292501974718, 5401.864953376118, 5869.442402971711, 5891.263592050994, 5899.203607513016, 5901.144334071621, 1482.5848762346561, 1527.6257316957194, 1589.2200735176675, 1604.3582566973305, 1609.5895546635768, 1004.8542961270575, 1111.4772761316885, 1132.5583022621183, 1229.3668760588305, 1236.7694144326454, 4631.444226692751, 4796.424429068534, 4813.4945830687975, 5141.765976165693, 5267.341582302212, 4829.295594467109, 5119.846404607793, 5192.377849186212, 5192.533546565352, 5588.910162518351, 4562.429696287964, 4603.58567728906, 4700.976495117503, 5039.5968322534845, 5101.311322971425, 2600.973990260073, 2711.4034912319257, 2766.9723302766715, 2949.808262462933, 3066.883850143394, 5155.628410930939, 5315.707636079976, 5572.684252869536, 5948.910766338422, 6094.421030002142, 5147.650235550954, 5224.9738751306, 5475.6440831345835, 5578.330600327906, 5865.442782935615, 4919.1391506486225, 5752.9424705753245, 6179.443850053427, 6349.920288659904, 6501.561914282144, 5120.692758434506, 5592.3009623797025, 5892.204552385545, 6117.602355846856, 6242.565399494291, 5106.744662766772, 5610.0, 5912.46787789101, 5966.940330596812, 5967.224260846062, 6287.371262873676, 6306.684665766602, 6307.369263073656, 6318.810435686937, 6418.748344072861, 4087.959120408758, 4493.348464472568, 4808.2547205183255, 4825.9034819304115, 4840.467548569584, 5434.75543600531, 5695.601307908572, 5773.884522309446, 5866.450797267762, 6130.356312587292, 4947.6536642434685, 5629.521490673339, 5768.625039372428, 5889.381614930542, 5952.214475497849, 4822.4187022329625, 5259.685738275147, 5360.25791617718, 5651.971740141437, 5926.407359264039, 4989.326440930428, 5502.312210973629, 5614.88770224585, 5731.627444216113, 5811.593188476766, 5259.658122222043, 5860.531157507475, 5942.425257306903, 5947.553933455095, 5961.642301461926, 4587.6788624795945, 5635.520980716685, 5656.37779844225, 5716.599838011466, 5861.794837180678], "value": 4338.050760255656, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.5516138702906, 658.3581008516694, 747.4132805747489, 761.4187903008798, 827.7847759582511, 14399.784003239947, 14858.034227775188, 15366.078035317889, 15388.61528461789, 15555.377784888618, 14010.439582416717, 14211.573652790406, 14303.213323267217, 14374.784378234308, 14542.0547664402, 928.9256859451227, 942.9669961551347, 944.6740874398322, 947.114447991127, 947.2280091725222, 846.9618867150962, 957.4351132831628, 959.6017652674132, 960.7021823234785, 961.8316794560959, 1006.084463138544, 1006.3408467453829, 1008.2438171371472, 1010.1413798271484, 1010.9191264698807, 1004.2367800471621, 1006.320733504885, 1006.3760468509498, 1006.6225165562914, 1008.1229330482527, 739.0, 743.3607097895805, 744.2892038103598, 744.9068866391701, 746.447628754723, 15052.096874187584, 15270.3128359223, 15407.922960385238, 15758.527244182693, 16051.91974040134, 13568.796468052988, 13834.031617786759, 13870.791938120936, 14152.36314365856, 14164.150150990974, 11353.489092990836, 11595.188336816425, 11628.6511404658, 11660.766784664344, 11966.64100076999, 3644.325799727059, 3647.8358473868475, 3680.9263814723554, 3700.1489657378684, 3811.8094095295123, 103632.0, 103988.0, 105561.4165787506, 106073.46963265134, 106597.46701266522, 10641.308314959502, 10656.467176641137, 10709.892901071045, 10892.965168308998, 10944.671659850059, 21992.01035953386, 22078.77921220799, 22354.105835766386, 22365.217217397312, 22437.663435048486, 7054.118235220598, 7460.14208366034, 7564.546127232384, 7626.4661473697415, 7673.539587624648, 4104.281750693616, 4215.156968606291, 4215.241256573846, 4218.873433796991, 4225.408442818008, 2807.7332653397893, 3273.525338825857, 3318.435865902802, 3359.4792807114936, 3360.9663903361143, 568.0456832521404, 569.6667449541982, 578.3551340255668, 584.2229834320344, 588.5115354255958, 577.9682117483579, 596.0403749962557, 622.3185611755121, 645.2805122288614, 653.6600967496875, 7538.585377804274, 7687.923120768721, 9276.814463710689, 9533.142017218484, 10044.096031357212, 616.6669998201011, 621.3196549777986, 631.4285571557656, 633.7496688807895, 645.7633631595536, 3764.7741135531955, 4388.210122177975, 4539.432570928634, 4587.311903214544, 4608.28571571407, 88092.6786098209, 91739.0826091744, 98530.5073474628, 101051.49474252581, 101934.0, 55107.0, 79267.8109828353, 80776.78834817483, 87805.0, 93597.5320123395, 77560.2243977553, 78408.0, 78709.0, 79832.60083699544, 80596.19403805886, 8460.153984601491, 8461.661533538589, 8513.233808957224, 8649.30805535543, 8725.563721814011, 43031.569684302754, 50476.0, 51325.48674513207, 52113.7394313026, 52151.95696086133, 57921.0, 65879.34120658733, 67478.98781518183, 67792.6610366945, 68417.94746157623, 12453.1905426147, 12510.374481276081, 12636.810447843474, 13131.409086590935, 13316.40076196554, 13635.045546811629, 13689.726205475636, 13725.176489410667, 13864.722705545631, 14220.146791192561, 13020.242594142614, 13061.0, 13232.801507977196, 13613.11514751538, 13641.931790340985, 12864.0, 13181.40683669218, 13217.801732974205, 13348.132371395828, 14055.718885622435, 12632.621021369374, 12866.742665146458, 13092.0, 13531.25578093175, 13640.908727301594, 10383.48082595852, 10509.579616815241, 10527.894721052691, 10599.364038157735, 11206.215564910379, 8466.671665292093, 8806.559672016501, 9393.0, 10459.84310235332, 10532.842007370049], "value": 7350.175236001121, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1598.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 118.0, 124.0, 121.0, 119.0, 120.0, 120.0, 120.0, 120.0, 147.0], "value": 121.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 112.0, 112.0, 152.0, 113.0, 117.0, 111.0, 123.0, 167.0, 146.0], "value": 129.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [218.0, 252.0, 194.0, 281.0, 211.0, 279.0, 277.0, 196.0, 196.0, 197.0], "value": 230.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 64.0, 65.0, 99.0, 62.0, 61.0, 61.0, 61.0, 74.0, 59.0], "value": 69.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 72.0, 84.0, 73.0, 72.0, 70.0, 82.0, 69.0, 72.0, 83.0], "value": 76.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 105.0, 89.0, 90.0, 89.0, 86.0, 122.0, 76.0, 123.0, 77.0], "value": 94.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 91.0, 156.0, 153.0, 98.0, 97.0, 124.0, 135.0, 156.0], "value": 120.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 95.0, 91.0, 90.0, 131.0, 144.0, 92.0, 119.0, 100.0, 143.0], "value": 109.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 66.0, 66.0, 68.0, 69.0, 74.0, 106.0, 104.0, 60.0], "value": 74.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 86.0, 50.0, 79.0, 94.0, 87.0, 48.0, 72.0, 86.0, 87.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 108.0, 109.0, 101.0, 90.0, 91.0, 88.0, 88.0, 91.0, 97.0], "value": 96.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 142.0, 155.0, 159.0, 149.0, 139.0, 142.0, 148.0, 213.0, 173.0], "value": 157.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 175.0, 173.0, 176.0, 178.0, 178.0, 171.0, 172.0, 179.0, 176.0], "value": 175.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 67.0, 68.0, 66.0, 69.0, 66.0, 68.0, 69.0, 67.0], "value": 67.9, "unit": "score"}]}]} 07:54:16 INFO - Return code: 0 07:54:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:54:16 ERROR - # TBPL SUCCESS # 07:54:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:54:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:54:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:54:16 INFO - 2017-03-01 07:54:16.371 screenresolution[2192:24777] starting screenresolution argv=screenresolution get 07:54:16 INFO - 2017-03-01 07:54:16.375 screenresolution[2192:24777] Display 0: 1600x1200x32@60 07:54:16 INFO - 2017-03-01 07:54:16.382 screenresolution[2193:24780] starting screenresolution argv=screenresolution list 07:54:16 INFO - Available Modes on Display 0 07:54:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:54:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:54:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:54:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:54:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:54:16 INFO - Intel Iris: 07:54:16 INFO - Chipset Model: Intel Iris 07:54:16 INFO - Type: GPU 07:54:16 INFO - Bus: Built-In 07:54:16 INFO - VRAM (Dynamic, Max): 1536 MB 07:54:16 INFO - Vendor: Intel (0x8086) 07:54:16 INFO - Device ID: 0x0a2e 07:54:16 INFO - Revision ID: 0x0009 07:54:16 INFO - Displays: 07:54:16 INFO - Display: 07:54:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:54:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:54:16 INFO - Display Serial Number: 1600x1200 60 07:54:16 INFO - Main Display: Yes 07:54:16 INFO - Mirror: Off 07:54:16 INFO - Online: Yes 07:54:16 INFO - Rotation: Supported 07:54:16 INFO - Return code: 0 07:54:16 INFO - Running post-action listener: _resource_record_post_action 07:54:16 INFO - [mozharness: 2017-03-01 15:54:16.625847Z] Finished run-tests step (success) 07:54:16 INFO - Running post-run listener: _resource_record_post_run 07:54:16 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 245760; Write bytes: 516327424; Read time: 2; Write time: 1629 07:54:16 INFO - TinderboxPrint: CPU usage
54.4% 07:54:16 INFO - TinderboxPrint: I/O read bytes / time
245,760 / 2 07:54:16 INFO - TinderboxPrint: I/O write bytes / time
516,327,424 / 1,629 07:54:16 INFO - TinderboxPrint: CPU idle
2,191.3 (45.6%) 07:54:16 INFO - TinderboxPrint: CPU system
963.0 (20.0%) 07:54:16 INFO - TinderboxPrint: CPU user
1,651.4 (34.4%) 07:54:16 INFO - TinderboxPrint: Swap in / out
210,165,760 / 0 07:54:16 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203860480; Write bytes: 202890240; Read time: 15685; Write time: 439 07:54:16 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 245760; Write bytes: 302767104; Read time: 2; Write time: 1154 07:54:17 INFO - Running post-run listener: _upload_blobber_files 07:54:17 INFO - Blob upload gear active. 07:54:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:54:17 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:17 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:17 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:17 INFO - (blobuploader) - INFO - Open directory for files ... 07:54:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:54:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:54:17 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/d2db87d1b7cdd2004b7212b337e056017b9180cb4cf8cd3ffd5bf2f3842771289b03cda90f317a60e3b867c7a95813a5364f7251fc7a2beac9602afd6a36bc45", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/040cdd4218eb5bf960ee3f49e3a1d33ce38589ed10719f54bdf3c79c7093929b08a4ac0ca110ba51b566285886b67af7dbcf58e2630bfca72119fd4e5c121a2c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2daeda4ad8772d4acc10972f82ded58a0d762896e92235f093c6a444f7a47ab3969412fb5cad799bcb489a4abe541e2a7a847ad47dd5306a3806e67180414680", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92d22dd8d92a1f315c160b090408298662a2a26bd5e0ab9af49138b678163e04c279bc5c33ca6b719e9449cc9775fa900b1b0daa7d24eee875b7f3b7acac6058"} 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/d2db87d1b7cdd2004b7212b337e056017b9180cb4cf8cd3ffd5bf2f3842771289b03cda90f317a60e3b867c7a95813a5364f7251fc7a2beac9602afd6a36bc45", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/040cdd4218eb5bf960ee3f49e3a1d33ce38589ed10719f54bdf3c79c7093929b08a4ac0ca110ba51b566285886b67af7dbcf58e2630bfca72119fd4e5c121a2c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2daeda4ad8772d4acc10972f82ded58a0d762896e92235f093c6a444f7a47ab3969412fb5cad799bcb489a4abe541e2a7a847ad47dd5306a3806e67180414680", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92d22dd8d92a1f315c160b090408298662a2a26bd5e0ab9af49138b678163e04c279bc5c33ca6b719e9449cc9775fa900b1b0daa7d24eee875b7f3b7acac6058"} 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=1279.508709 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-03-01 07:54:22.823617) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-01 07:54:22.826778) ========= 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.0qyWs5DeAF/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.S14m8eK4qG/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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/d2db87d1b7cdd2004b7212b337e056017b9180cb4cf8cd3ffd5bf2f3842771289b03cda90f317a60e3b867c7a95813a5364f7251fc7a2beac9602afd6a36bc45", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/040cdd4218eb5bf960ee3f49e3a1d33ce38589ed10719f54bdf3c79c7093929b08a4ac0ca110ba51b566285886b67af7dbcf58e2630bfca72119fd4e5c121a2c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2daeda4ad8772d4acc10972f82ded58a0d762896e92235f093c6a444f7a47ab3969412fb5cad799bcb489a4abe541e2a7a847ad47dd5306a3806e67180414680", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92d22dd8d92a1f315c160b090408298662a2a26bd5e0ab9af49138b678163e04c279bc5c33ca6b719e9449cc9775fa900b1b0daa7d24eee875b7f3b7acac6058"} 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.011285 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/d2db87d1b7cdd2004b7212b337e056017b9180cb4cf8cd3ffd5bf2f3842771289b03cda90f317a60e3b867c7a95813a5364f7251fc7a2beac9602afd6a36bc45", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/040cdd4218eb5bf960ee3f49e3a1d33ce38589ed10719f54bdf3c79c7093929b08a4ac0ca110ba51b566285886b67af7dbcf58e2630bfca72119fd4e5c121a2c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2daeda4ad8772d4acc10972f82ded58a0d762896e92235f093c6a444f7a47ab3969412fb5cad799bcb489a4abe541e2a7a847ad47dd5306a3806e67180414680", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92d22dd8d92a1f315c160b090408298662a2a26bd5e0ab9af49138b678163e04c279bc5c33ca6b719e9449cc9775fa900b1b0daa7d24eee875b7f3b7acac6058"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-01 07:54:22.864552) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 07:54:22.864878) ========= 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.0qyWs5DeAF/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.S14m8eK4qG/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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.005229 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 07:54:22.913217) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-01 07:54:22.913544) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-01 07:54:22.913868) ========= ========= Total master_lag: 0.18 =========