builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0210 starttime: 1496156304.84 results: success (0) buildid: 20170530071016 builduid: 12fa030cfc5748e3acb28b7fe324d362 revision: 3524778fe631486d5a9cd4f5392177f297b337dc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 07:58:24.842989) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 07:58:24.843449) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 07:58:24.843736) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 07:58:24.867478) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 07:58:24.867796) ========= 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.rAvih0dTFV/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.54qLvLEGma/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-05-30 07:58:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.05M=0.001s 2017-05-30 07:58:25 (8.05 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.161102 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 07:58:25.084320) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 07:58:25.084629) ========= 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.rAvih0dTFV/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.54qLvLEGma/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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.022897 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 07:58:25.131513) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-30 07:58:25.131839) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3524778fe631486d5a9cd4f5392177f297b337dc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3524778fe631486d5a9cd4f5392177f297b337dc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rAvih0dTFV/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.54qLvLEGma/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-05-30 07:58:25,233 truncating revision to first 12 chars 2017-05-30 07:58:25,233 Setting DEBUG logging. 2017-05-30 07:58:25,233 attempt 1/10 2017-05-30 07:58:25,233 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/3524778fe631?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-30 07:58:26,469 unpacking tar archive at: mozilla-beta-3524778fe631/testing/mozharness/ program finished with exit code 0 elapsedTime=1.510279 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-30 07:58:26.665613) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 07:58:26.665909) ========= script_repo_revision: 3524778fe631486d5a9cd4f5392177f297b337dc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 07:58:26.666282) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 07:58:26.666547) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 07:58:26.685658) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-05-30 07:58:26.685952) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rAvih0dTFV/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.54qLvLEGma/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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:58:26 INFO - MultiFileLogger online at 20170530 07:58:26 in /builds/slave/test 07:58:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 07:58:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:58:26 INFO - {'append_to_log': False, 07:58:26 INFO - 'base_work_dir': '/builds/slave/test', 07:58:26 INFO - 'blob_upload_branch': 'Mozilla-Beta', 07:58:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:58:26 INFO - 'branch': 'Mozilla-Beta', 07:58:26 INFO - 'buildbot_json_path': 'buildprops.json', 07:58:26 INFO - 'config_files': ('talos/mac_config.py',), 07:58:26 INFO - 'default_actions': ('clobber', 07:58:26 INFO - 'read-buildbot-config', 07:58:26 INFO - 'download-and-extract', 07:58:26 INFO - 'populate-webroot', 07:58:26 INFO - 'create-virtualenv', 07:58:26 INFO - 'install', 07:58:26 INFO - 'run-tests'), 07:58:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:58:26 INFO - 'download_minidump_stackwalk': True, 07:58:26 INFO - 'download_symbols': 'ondemand', 07:58:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:58:26 INFO - 'tooltool.py': '/tools/tooltool.py', 07:58:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:58:26 INFO - '/tools/misc-python/virtualenv.py')}, 07:58:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:58:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:58:26 INFO - 'gecko_profile': False, 07:58:26 INFO - 'gecko_profile_interval': 0, 07:58:26 INFO - 'installer_path': 'installer.exe', 07:58:26 INFO - 'log_level': 'info', 07:58:26 INFO - 'log_name': 'talos', 07:58:26 INFO - 'log_to_console': True, 07:58:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:58:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:58:26 INFO - 'opt_config_files': (), 07:58:26 INFO - 'pip_index': False, 07:58:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:58:26 INFO - 'cmd': ('bash', 07:58:26 INFO - '-c', 07:58:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:58:26 INFO - 'enabled': True, 07:58:26 INFO - 'halt_on_failure': False, 07:58:26 INFO - 'name': 'check_screen_resolution'},), 07:58:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:58:26 INFO - 'cmd': ('bash', 07:58:26 INFO - '-c', 07:58:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:58:26 INFO - 'enabled': True, 07:58:26 INFO - 'halt_on_failure': False, 07:58:26 INFO - 'name': 'check_screen_resolution'},), 07:58:26 INFO - 'run_cmd_checks_enabled': True, 07:58:26 INFO - 'suite': 'dromaeojs', 07:58:26 INFO - 'system_bits': '32', 07:58:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:58:26 INFO - 'title': 't-yosemite-r7-0210', 07:58:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:58:26 INFO - 'use_talos_json': True, 07:58:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:58:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:58:26 INFO - 'work_dir': 'build'} 07:58:26 INFO - [mozharness: 2017-05-30 14:58:26.909578Z] Running clobber step. 07:58:26 INFO - Running pre-action listener: _resource_record_pre_action 07:58:26 INFO - Running main action method: clobber 07:58:26 INFO - rmtree: /builds/slave/test/build 07:58:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:58:30 INFO - Running post-action listener: _resource_record_post_action 07:58:30 INFO - [mozharness: 2017-05-30 14:58:30.597674Z] Finished clobber step (success) 07:58:30 INFO - [mozharness: 2017-05-30 14:58:30.597977Z] Running read-buildbot-config step. 07:58:30 INFO - Running pre-action listener: _resource_record_pre_action 07:58:30 INFO - Running main action method: read_buildbot_config 07:58:30 INFO - Using buildbot properties: 07:58:30 INFO - { 07:58:30 INFO - "project": "", 07:58:30 INFO - "product": "firefox", 07:58:30 INFO - "script_repo_revision": "production", 07:58:30 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 07:58:30 INFO - "repository": "", 07:58:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 07:58:30 INFO - "buildid": "20170530071016", 07:58:30 INFO - "pgo_build": "False", 07:58:30 INFO - "basedir": "/builds/slave/test", 07:58:30 INFO - "buildnumber": 18, 07:58:30 INFO - "slavename": "t-yosemite-r7-0210", 07:58:30 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 07:58:30 INFO - "platform": "yosemite_r7", 07:58:30 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 07:58:30 INFO - "branch": "mozilla-beta", 07:58:30 INFO - "repo_path": "releases/mozilla-beta", 07:58:30 INFO - "revision": "3524778fe631486d5a9cd4f5392177f297b337dc", 07:58:30 INFO - "stage_platform": "macosx64", 07:58:30 INFO - "builduid": "12fa030cfc5748e3acb28b7fe324d362", 07:58:30 INFO - "slavebuilddir": "test" 07:58:30 INFO - } 07:58:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/ERxogNTaS5WkiMpYexpBOQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 07:58:30 INFO - Running post-action listener: _resource_record_post_action 07:58:30 INFO - [mozharness: 2017-05-30 14:58:30.603598Z] Finished read-buildbot-config step (success) 07:58:30 INFO - [mozharness: 2017-05-30 14:58:30.603804Z] Running download-and-extract step. 07:58:30 INFO - Running pre-action listener: _resource_record_pre_action 07:58:30 INFO - Running main action method: download_and_extract 07:58:30 INFO - mkdir: /builds/slave/test/build/tests 07:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:58:30 INFO - trying https://queue.taskcluster.net/v1/task/ERxogNTaS5WkiMpYexpBOQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 07:58:30 INFO - Downloading https://queue.taskcluster.net/v1/task/ERxogNTaS5WkiMpYexpBOQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 07:58:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ERxogNTaS5WkiMpYexpBOQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 07:58:31 INFO - Downloaded 1287 bytes. 07:58:31 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 07:58:31 INFO - Using the following test package requirements: 07:58:31 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:58:31 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 07:58:31 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 07:58:31 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:58:31 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 07:58:31 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:58:31 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 07:58:31 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 07:58:31 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:58:31 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 07:58:31 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 07:58:31 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:58:31 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 07:58:31 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:58:31 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 07:58:31 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:58:31 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 07:58:31 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:58:31 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 07:58:31 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 07:58:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ERxogNTaS5WkiMpYexpBOQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 07:58:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ERxogNTaS5WkiMpYexpBOQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 07:58:31 INFO - Fetch https://queue.taskcluster.net/v1/task/ERxogNTaS5WkiMpYexpBOQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 07:58:33 INFO - Expected file size: 51393622 07:58:33 INFO - Obtained file size: 51393622 07:58:48 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 07:58:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ERxogNTaS5WkiMpYexpBOQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 07:58:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ERxogNTaS5WkiMpYexpBOQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 07:58:48 INFO - Fetch https://queue.taskcluster.net/v1/task/ERxogNTaS5WkiMpYexpBOQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 07:58:50 INFO - Expected file size: 51393622 07:58:50 INFO - Obtained file size: 51393622 07:59:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ERxogNTaS5WkiMpYexpBOQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 07:59:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ERxogNTaS5WkiMpYexpBOQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 07:59:05 INFO - Fetch https://queue.taskcluster.net/v1/task/ERxogNTaS5WkiMpYexpBOQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 07:59:06 INFO - Expected file size: 14404461 07:59:06 INFO - Obtained file size: 14404461 07:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:59:06 INFO - trying https://queue.taskcluster.net/v1/task/ERxogNTaS5WkiMpYexpBOQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 07:59:06 INFO - Downloading https://queue.taskcluster.net/v1/task/ERxogNTaS5WkiMpYexpBOQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 07:59:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ERxogNTaS5WkiMpYexpBOQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 07:59:08 INFO - Downloaded 59646205 bytes. 07:59:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ERxogNTaS5WkiMpYexpBOQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 07:59:08 INFO - mkdir: /builds/slave/test/properties 07:59:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:59:08 INFO - Writing to file /builds/slave/test/properties/build_url 07:59:08 INFO - Contents: 07:59:08 INFO - build_url:https://queue.taskcluster.net/v1/task/ERxogNTaS5WkiMpYexpBOQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 07:59:08 INFO - Running post-action listener: _resource_record_post_action 07:59:08 INFO - Running post-action listener: set_extra_try_arguments 07:59:08 INFO - [mozharness: 2017-05-30 14:59:08.885692Z] Finished download-and-extract step (success) 07:59:08 INFO - [mozharness: 2017-05-30 14:59:08.885822Z] Running populate-webroot step. 07:59:08 INFO - Running pre-action listener: _resource_record_pre_action 07:59:08 INFO - Running main action method: populate_webroot 07:59:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:59:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:59:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:59:08 INFO - '--tppagecycles', 07:59:08 INFO - '7'], 07:59:08 INFO - 'tests': ['tsvgm']}}, 07:59:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:59:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:59:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:59:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:59:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:59:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:59:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:59:08 INFO - 'talos_options': ['--disable-e10s'], 07:59:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:59:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:59:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:59:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:59:08 INFO - 'talos_options': ['--disable-e10s'], 07:59:08 INFO - 'tests': ['damp', 'tps']}, 07:59:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:59:08 INFO - 'tests': ['damp', 'tps']}, 07:59:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:59:08 INFO - 'tests': ['dromaeo_dom']}, 07:59:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:59:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:59:08 INFO - 'tests': ['basic_compositor_video']}, 07:59:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:59:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:59:08 INFO - 'tests': ['a11yr', 07:59:08 INFO - 'ts_paint', 07:59:08 INFO - 'tpaint', 07:59:08 INFO - 'sessionrestore', 07:59:08 INFO - 'sessionrestore_no_auto_restore', 07:59:08 INFO - 'tabpaint']}, 07:59:08 INFO - 'other-e10s': {'tests': ['a11yr', 07:59:08 INFO - 'ts_paint', 07:59:08 INFO - 'tpaint', 07:59:08 INFO - 'sessionrestore', 07:59:08 INFO - 'sessionrestore_no_auto_restore', 07:59:08 INFO - 'tabpaint']}, 07:59:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:59:08 INFO - 'ts_paint', 07:59:08 INFO - 'tpaint', 07:59:08 INFO - 'sessionrestore', 07:59:08 INFO - 'sessionrestore_no_auto_restore', 07:59:08 INFO - 'tabpaint']}, 07:59:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:59:08 INFO - 'ts_paint', 07:59:08 INFO - 'tpaint', 07:59:08 INFO - 'sessionrestore', 07:59:08 INFO - 'sessionrestore_no_auto_restore', 07:59:08 INFO - 'tabpaint']}, 07:59:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:59:08 INFO - 'tests': ['a11yr', 07:59:08 INFO - 'ts_paint', 07:59:08 INFO - 'tpaint', 07:59:08 INFO - 'sessionrestore', 07:59:08 INFO - 'sessionrestore_no_auto_restore', 07:59:08 INFO - 'tabpaint']}, 07:59:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:59:08 INFO - 'tests': ['a11yr', 07:59:08 INFO - 'ts_paint', 07:59:08 INFO - 'tpaint', 07:59:08 INFO - 'sessionrestore', 07:59:08 INFO - 'sessionrestore_no_auto_restore', 07:59:08 INFO - 'tabpaint']}, 07:59:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:59:08 INFO - 'tests': ['tsvgx', 07:59:08 INFO - 'tsvgr_opacity', 07:59:08 INFO - 'tart', 07:59:08 INFO - 'tscrollx', 07:59:08 INFO - 'cart', 07:59:08 INFO - 'tsvg_static']}, 07:59:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:59:08 INFO - 'tsvgr_opacity', 07:59:08 INFO - 'tart', 07:59:08 INFO - 'tscrollx', 07:59:08 INFO - 'cart', 07:59:08 INFO - 'tsvg_static']}, 07:59:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:59:08 INFO - 'talos_options': ['--disable-e10s'], 07:59:08 INFO - 'tests': ['tp5o']}, 07:59:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:59:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:59:08 INFO - 'talos_options': ['--disable-e10s', 07:59:08 INFO - '--xperf_path', 07:59:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:59:08 INFO - 'tests': ['tp5n']}, 07:59:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:59:08 INFO - 'talos_options': ['--xperf_path', 07:59:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:59:08 INFO - 'tests': ['tp5n']}}, 07:59:08 INFO - 'talos.zip': {'path': '', 07:59:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:59:08 INFO - Running post-action listener: _resource_record_post_action 07:59:08 INFO - [mozharness: 2017-05-30 14:59:08.904150Z] Finished populate-webroot step (success) 07:59:08 INFO - [mozharness: 2017-05-30 14:59:08.904289Z] Running create-virtualenv step. 07:59:08 INFO - Running pre-action listener: _resource_record_pre_action 07:59:08 INFO - Running main action method: create_virtualenv 07:59:08 INFO - Creating virtualenv /builds/slave/test/build/venv 07:59:08 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:59:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:59:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:59:09 INFO - Using real prefix '/tools/python27' 07:59:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:59:09 INFO - Installing distribute.............................................................................................................................................................................................done. 07:59:12 INFO - Installing pip.................done. 07:59:12 INFO - Return code: 0 07:59:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:59:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:59:12 INFO - Reading from file tmpfile_stdout 07:59:12 INFO - Output received: 07:59:12 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:59:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x101d93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc104ccf50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b71d30>, '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 0x101a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b66be8>, '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.rAvih0dTFV/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.54qLvLEGma/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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:59:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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:59:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:59:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rAvih0dTFV/Render', 07:59:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:12 INFO - 'HOME': '/Users/cltbld', 07:59:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:12 INFO - 'LOGNAME': 'cltbld', 07:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:12 INFO - 'MOZ_NO_REMOTE': '1', 07:59:12 INFO - 'NO_EM_RESTART': '1', 07:59:12 INFO - 'PAGER': '/bin/cat', 07:59:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:12 INFO - 'PWD': '/builds/slave/test', 07:59:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:12 INFO - 'SHELL': '/bin/bash', 07:59:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.54qLvLEGma/Listeners', 07:59:12 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 07:59:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:12 INFO - 'USER': 'cltbld', 07:59:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:12 INFO - 'XPC_FLAGS': '0x0', 07:59:12 INFO - 'XPC_SERVICE_NAME': '0', 07:59:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:13 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:59:13 INFO - Cleaning up... 07:59:13 INFO - Return code: 0 07:59:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:59:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:13 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/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 0x101d93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc104ccf50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b71d30>, '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 0x101a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b66be8>, '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.rAvih0dTFV/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.54qLvLEGma/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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:59:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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:59:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:59:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rAvih0dTFV/Render', 07:59:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:13 INFO - 'HOME': '/Users/cltbld', 07:59:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:13 INFO - 'LOGNAME': 'cltbld', 07:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:13 INFO - 'MOZ_NO_REMOTE': '1', 07:59:13 INFO - 'NO_EM_RESTART': '1', 07:59:13 INFO - 'PAGER': '/bin/cat', 07:59:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:13 INFO - 'PWD': '/builds/slave/test', 07:59:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:13 INFO - 'SHELL': '/bin/bash', 07:59:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.54qLvLEGma/Listeners', 07:59:13 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 07:59:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:13 INFO - 'USER': 'cltbld', 07:59:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:13 INFO - 'XPC_FLAGS': '0x0', 07:59:13 INFO - 'XPC_SERVICE_NAME': '0', 07:59:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:13 INFO - Downloading/unpacking psutil>=3.1.1 07:59:13 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:59:13 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:59:13 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:59:13 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:59:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:59:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:59:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:59:15 INFO - Installing collected packages: psutil 07:59:15 INFO - Running setup.py install for psutil 07:59:15 INFO - building 'psutil._psutil_osx' extension 07:59:15 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:59:16 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:59:16 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:59:16 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:59:16 INFO - building 'psutil._psutil_posix' extension 07:59:16 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:59:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:59:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:59:16 INFO - ^ 07:59:16 INFO - 1 warning generated. 07:59:16 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:59:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:59:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:59:16 INFO - Successfully installed psutil 07:59:16 INFO - Cleaning up... 07:59:16 INFO - Return code: 0 07:59:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:16 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/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 0x101d93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc104ccf50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b71d30>, '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 0x101a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b66be8>, '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.rAvih0dTFV/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.54qLvLEGma/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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:59:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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:59:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:59:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rAvih0dTFV/Render', 07:59:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:16 INFO - 'HOME': '/Users/cltbld', 07:59:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:16 INFO - 'LOGNAME': 'cltbld', 07:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:16 INFO - 'MOZ_NO_REMOTE': '1', 07:59:16 INFO - 'NO_EM_RESTART': '1', 07:59:16 INFO - 'PAGER': '/bin/cat', 07:59:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:16 INFO - 'PWD': '/builds/slave/test', 07:59:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:16 INFO - 'SHELL': '/bin/bash', 07:59:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.54qLvLEGma/Listeners', 07:59:16 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 07:59:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:16 INFO - 'USER': 'cltbld', 07:59:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:16 INFO - 'XPC_FLAGS': '0x0', 07:59:16 INFO - 'XPC_SERVICE_NAME': '0', 07:59:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:59:17 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:59:17 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:59:17 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:59:17 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:59:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:59:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:59:18 INFO - Installing collected packages: mozsystemmonitor 07:59:18 INFO - Running setup.py install for mozsystemmonitor 07:59:18 INFO - Successfully installed mozsystemmonitor 07:59:18 INFO - Cleaning up... 07:59:18 INFO - Return code: 0 07:59:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:18 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/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 0x101d93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc104ccf50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b71d30>, '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 0x101a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b66be8>, '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.rAvih0dTFV/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.54qLvLEGma/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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:59:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:59:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rAvih0dTFV/Render', 07:59:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:18 INFO - 'HOME': '/Users/cltbld', 07:59:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:18 INFO - 'LOGNAME': 'cltbld', 07:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:18 INFO - 'MOZ_NO_REMOTE': '1', 07:59:18 INFO - 'NO_EM_RESTART': '1', 07:59:18 INFO - 'PAGER': '/bin/cat', 07:59:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:18 INFO - 'PWD': '/builds/slave/test', 07:59:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:18 INFO - 'SHELL': '/bin/bash', 07:59:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.54qLvLEGma/Listeners', 07:59:18 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 07:59:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:18 INFO - 'USER': 'cltbld', 07:59:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:18 INFO - 'XPC_FLAGS': '0x0', 07:59:18 INFO - 'XPC_SERVICE_NAME': '0', 07:59:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:19 INFO - Downloading/unpacking jsonschema==2.5.1 07:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:59:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:20 INFO - Downloading functools32-3.2.3-2.tar.gz 07:59:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:59:20 INFO - warning: no files found matching '*.txt' 07:59:20 INFO - no previously-included directories found matching 'build' 07:59:20 INFO - no previously-included directories found matching 'dist' 07:59:20 INFO - no previously-included directories found matching '.git*' 07:59:20 INFO - Installing collected packages: jsonschema, functools32 07:59:20 INFO - Running setup.py install for functools32 07:59:20 INFO - warning: no files found matching '*.txt' 07:59:20 INFO - no previously-included directories found matching 'build' 07:59:20 INFO - no previously-included directories found matching 'dist' 07:59:20 INFO - no previously-included directories found matching '.git*' 07:59:20 INFO - Successfully installed jsonschema functools32 07:59:20 INFO - Cleaning up... 07:59:21 INFO - Return code: 0 07:59:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:59:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x101d93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc104ccf50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b71d30>, '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 0x101a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b66be8>, '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.rAvih0dTFV/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.54qLvLEGma/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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:59:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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:59:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:59:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rAvih0dTFV/Render', 07:59:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:21 INFO - 'HOME': '/Users/cltbld', 07:59:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:21 INFO - 'LOGNAME': 'cltbld', 07:59:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:21 INFO - 'MOZ_NO_REMOTE': '1', 07:59:21 INFO - 'NO_EM_RESTART': '1', 07:59:21 INFO - 'PAGER': '/bin/cat', 07:59:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:21 INFO - 'PWD': '/builds/slave/test', 07:59:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:21 INFO - 'SHELL': '/bin/bash', 07:59:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.54qLvLEGma/Listeners', 07:59:21 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 07:59:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:21 INFO - 'USER': 'cltbld', 07:59:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:21 INFO - 'XPC_FLAGS': '0x0', 07:59:21 INFO - 'XPC_SERVICE_NAME': '0', 07:59:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:59:21 INFO - Cleaning up... 07:59:21 INFO - Return code: 0 07:59:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:59:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x101d93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc104ccf50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b71d30>, '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 0x101a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b66be8>, '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.rAvih0dTFV/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.54qLvLEGma/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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:59:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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:59:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:59:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rAvih0dTFV/Render', 07:59:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:21 INFO - 'HOME': '/Users/cltbld', 07:59:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:21 INFO - 'LOGNAME': 'cltbld', 07:59:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:21 INFO - 'MOZ_NO_REMOTE': '1', 07:59:21 INFO - 'NO_EM_RESTART': '1', 07:59:21 INFO - 'PAGER': '/bin/cat', 07:59:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:21 INFO - 'PWD': '/builds/slave/test', 07:59:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:21 INFO - 'SHELL': '/bin/bash', 07:59:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.54qLvLEGma/Listeners', 07:59:21 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 07:59:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:21 INFO - 'USER': 'cltbld', 07:59:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:21 INFO - 'XPC_FLAGS': '0x0', 07:59:21 INFO - 'XPC_SERVICE_NAME': '0', 07:59:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:21 INFO - Downloading/unpacking blobuploader==1.2.4 07:59:21 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:59:21 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:59:21 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:59:21 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:59:22 INFO - Downloading blobuploader-1.2.4.tar.gz 07:59:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:59:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:59:23 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:59:23 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:59:23 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:59:23 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:59:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:59:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:59:23 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:59:23 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:59:23 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:59:23 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:59:23 INFO - Downloading docopt-0.6.1.tar.gz 07:59:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:59:23 INFO - Installing collected packages: blobuploader, requests, docopt 07:59:23 INFO - Running setup.py install for blobuploader 07:59:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:59:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:59:24 INFO - Running setup.py install for requests 07:59:24 INFO - Running setup.py install for docopt 07:59:24 INFO - Successfully installed blobuploader requests docopt 07:59:24 INFO - Cleaning up... 07:59:24 INFO - Return code: 0 07:59:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:24 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/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 0x101d93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc104ccf50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b71d30>, '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 0x101a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b66be8>, '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.rAvih0dTFV/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.54qLvLEGma/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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:59:24 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:59:24 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:59:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rAvih0dTFV/Render', 07:59:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:24 INFO - 'HOME': '/Users/cltbld', 07:59:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:24 INFO - 'LOGNAME': 'cltbld', 07:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:24 INFO - 'MOZ_NO_REMOTE': '1', 07:59:24 INFO - 'NO_EM_RESTART': '1', 07:59:24 INFO - 'PAGER': '/bin/cat', 07:59:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:24 INFO - 'PWD': '/builds/slave/test', 07:59:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:24 INFO - 'SHELL': '/bin/bash', 07:59:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.54qLvLEGma/Listeners', 07:59:24 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 07:59:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:24 INFO - 'USER': 'cltbld', 07:59:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:24 INFO - 'XPC_FLAGS': '0x0', 07:59:24 INFO - 'XPC_SERVICE_NAME': '0', 07:59:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:59:25 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-idOmHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:59:25 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-HF_yIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:59:25 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-TQk_Ag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:59:25 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-PAa7FY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:59:25 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-zwNTnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:59:25 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-9roUYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:59:25 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-INbfFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:59:25 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-kgZCFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:59:25 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-_AIlS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:59:25 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-k67Jql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:59:26 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-8zeUra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:59:26 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-cxe8EZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:59:26 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-W91OQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:59:26 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-C8V_4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:26 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-8dw7G5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:59:26 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-jXg9ug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:59:26 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-wwCFq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:59:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:59:26 INFO - Running setup.py install for manifestparser 07:59:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:59:26 INFO - Running setup.py install for mozcrash 07:59:27 INFO - Running setup.py install for mozdebug 07:59:27 INFO - Running setup.py install for mozdevice 07:59:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:59:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:59:27 INFO - Running setup.py install for mozfile 07:59:27 INFO - Running setup.py install for mozhttpd 07:59:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:59:27 INFO - Running setup.py install for mozinfo 07:59:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:59:27 INFO - Running setup.py install for mozInstall 07:59:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:59:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:59:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:59:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:59:27 INFO - Running setup.py install for mozleak 07:59:28 INFO - Running setup.py install for mozlog 07:59:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:59:28 INFO - Running setup.py install for moznetwork 07:59:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:59:28 INFO - Running setup.py install for mozprocess 07:59:28 INFO - Running setup.py install for mozprofile 07:59:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:59:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:59:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:59:28 INFO - Running setup.py install for mozrunner 07:59:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:59:28 INFO - Running setup.py install for mozscreenshot 07:59:29 INFO - Running setup.py install for moztest 07:59:29 INFO - Running setup.py install for mozversion 07:59:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:59:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:59:29 INFO - Cleaning up... 07:59:29 INFO - Return code: 0 07:59:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:29 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/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 0x101d93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc104ccf50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b71d30>, '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 0x101a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b66be8>, '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.rAvih0dTFV/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.54qLvLEGma/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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:59:29 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:59:29 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:59:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rAvih0dTFV/Render', 07:59:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:29 INFO - 'HOME': '/Users/cltbld', 07:59:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:29 INFO - 'LOGNAME': 'cltbld', 07:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:29 INFO - 'MOZ_NO_REMOTE': '1', 07:59:29 INFO - 'NO_EM_RESTART': '1', 07:59:29 INFO - 'PAGER': '/bin/cat', 07:59:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:29 INFO - 'PWD': '/builds/slave/test', 07:59:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:29 INFO - 'SHELL': '/bin/bash', 07:59:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.54qLvLEGma/Listeners', 07:59:29 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 07:59:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:29 INFO - 'USER': 'cltbld', 07:59:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:29 INFO - 'XPC_FLAGS': '0x0', 07:59:29 INFO - 'XPC_SERVICE_NAME': '0', 07:59:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:59:29 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-Zui90R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:59:29 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:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:59:29 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-ME688h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:59:29 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:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:59:29 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-yLiSvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:59:29 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:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:59:30 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-h9z2_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:59:30 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:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:59:30 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-t0xXkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:59:30 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:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:59:30 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-rSott0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:59:30 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:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:59:30 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-Za5xfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:59:30 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:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:59:30 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-Ewppot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:59:30 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:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:59:30 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-SKBB92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:59:30 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:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:59:30 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-AfVDBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:59:30 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:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:59:30 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-wF6IhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:59:30 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:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:59:30 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-27jFMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:59:30 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:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:59:30 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-GrAwbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:59:31 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:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:59:31 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-SLksqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:59:31 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:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:31 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-l7qEwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:31 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:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:59:31 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-If7QAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:59:31 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:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:59:31 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-djjxvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:59:31 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:59:31 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:59:31 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:59:31 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:59:31 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:59:31 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:59:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:32 INFO - Downloading blessings-1.6.tar.gz 07:59:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:59:32 INFO - Installing collected packages: blessings 07:59:32 INFO - Running setup.py install for blessings 07:59:33 INFO - Successfully installed blessings 07:59:33 INFO - Cleaning up... 07:59:33 INFO - Return code: 0 07:59:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:59:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:59:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:59:33 INFO - Reading from file tmpfile_stdout 07:59:33 INFO - Current package versions: 07:59:33 INFO - blessings == 1.6 07:59:33 INFO - blobuploader == 1.2.4 07:59:33 INFO - docopt == 0.6.1 07:59:33 INFO - functools32 == 3.2.3-2 07:59:33 INFO - jsonschema == 2.5.1 07:59:33 INFO - manifestparser == 1.1 07:59:33 INFO - mozInstall == 1.12 07:59:33 INFO - mozcrash == 1.0 07:59:33 INFO - mozdebug == 0.1 07:59:33 INFO - mozdevice == 0.49 07:59:33 INFO - mozfile == 1.2 07:59:33 INFO - mozhttpd == 0.7 07:59:33 INFO - mozinfo == 0.9 07:59:33 INFO - mozleak == 0.1 07:59:33 INFO - mozlog == 3.4 07:59:33 INFO - moznetwork == 0.27 07:59:33 INFO - mozprocess == 0.25 07:59:33 INFO - mozprofile == 0.28 07:59:33 INFO - mozrunner == 6.13 07:59:33 INFO - mozscreenshot == 0.1 07:59:33 INFO - mozsystemmonitor == 0.3 07:59:33 INFO - moztest == 0.8 07:59:33 INFO - mozversion == 1.4 07:59:33 INFO - psutil == 3.1.1 07:59:33 INFO - requests == 1.2.3 07:59:33 INFO - wsgiref == 0.1.2 07:59:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:59:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:33 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/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 0x101d93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc104ccf50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b71d30>, '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 0x101a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b66be8>, '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.rAvih0dTFV/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.54qLvLEGma/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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:59:33 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:59:33 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:59:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rAvih0dTFV/Render', 07:59:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:33 INFO - 'HOME': '/Users/cltbld', 07:59:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:33 INFO - 'LOGNAME': 'cltbld', 07:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:33 INFO - 'MOZ_NO_REMOTE': '1', 07:59:33 INFO - 'NO_EM_RESTART': '1', 07:59:33 INFO - 'PAGER': '/bin/cat', 07:59:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:33 INFO - 'PWD': '/builds/slave/test', 07:59:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:33 INFO - 'SHELL': '/bin/bash', 07:59:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.54qLvLEGma/Listeners', 07:59:33 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 07:59:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:33 INFO - 'USER': 'cltbld', 07:59:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:33 INFO - 'XPC_FLAGS': '0x0', 07:59:33 INFO - 'XPC_SERVICE_NAME': '0', 07:59:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:33 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:59:33 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:59:33 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:59:33 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:59:33 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:59:33 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:59:33 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:59:33 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:59:33 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:59:33 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:59:33 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:59:33 INFO - Cleaning up... 07:59:33 INFO - Return code: 0 07:59:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:59:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:33 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/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 0x101d93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc104ccf50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b71d30>, '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 0x101a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b66be8>, '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.rAvih0dTFV/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.54qLvLEGma/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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:59:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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:59:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:59:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rAvih0dTFV/Render', 07:59:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:33 INFO - 'HOME': '/Users/cltbld', 07:59:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:33 INFO - 'LOGNAME': 'cltbld', 07:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:33 INFO - 'MOZ_NO_REMOTE': '1', 07:59:33 INFO - 'NO_EM_RESTART': '1', 07:59:33 INFO - 'PAGER': '/bin/cat', 07:59:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:33 INFO - 'PWD': '/builds/slave/test', 07:59:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:33 INFO - 'SHELL': '/bin/bash', 07:59:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.54qLvLEGma/Listeners', 07:59:33 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 07:59:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:33 INFO - 'USER': 'cltbld', 07:59:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:33 INFO - 'XPC_FLAGS': '0x0', 07:59:33 INFO - 'XPC_SERVICE_NAME': '0', 07:59:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:59:33 INFO - Cleaning up... 07:59:33 INFO - Return code: 0 07:59:33 INFO - Running post-action listener: _resource_record_post_action 07:59:33 INFO - Running post-action listener: _start_resource_monitoring 07:59:34 INFO - Starting resource monitoring. 07:59:34 INFO - [mozharness: 2017-05-30 14:59:34.013515Z] Finished create-virtualenv step (success) 07:59:34 INFO - [mozharness: 2017-05-30 14:59:34.014492Z] Running install step. 07:59:34 INFO - Running pre-action listener: _resource_record_pre_action 07:59:34 INFO - Running main action method: install 07:59:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:59:34 INFO - Reading from file tmpfile_stdout 07:59:34 INFO - Detecting whether we're running mozinstall >=1.0... 07:59:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:59:34 INFO - Reading from file tmpfile_stdout 07:59:34 INFO - Output received: 07:59:34 INFO - Usage: mozinstall [options] installer 07:59:34 INFO - Options: 07:59:34 INFO - -h, --help show this help message and exit 07:59:34 INFO - -d DEST, --destination=DEST 07:59:34 INFO - Directory to install application into. [default: 07:59:34 INFO - "/builds/slave/test"] 07:59:34 INFO - --app=APP Application being installed. [default: firefox] 07:59:34 INFO - mkdir: /builds/slave/test/build/application 07:59:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 07:59:48 INFO - Reading from file tmpfile_stdout 07:59:48 INFO - Output received: 07:59:48 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 07:59:48 INFO - Running post-action listener: _resource_record_post_action 07:59:48 INFO - [mozharness: 2017-05-30 14:59:48.808615Z] Finished install step (success) 07:59:48 INFO - [mozharness: 2017-05-30 14:59:48.808730Z] Running run-tests step. 07:59:48 INFO - Running pre-action listener: _resource_record_pre_action 07:59:48 INFO - Running main action method: run_tests 07:59:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:59:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:59:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:59:48 INFO - 2017-05-30 07:59:48.823 screenresolution[1925:20948] starting screenresolution argv=screenresolution get 07:59:48 INFO - 2017-05-30 07:59:48.826 screenresolution[1925:20948] Display 0: 1600x1200x32@60 07:59:48 INFO - 2017-05-30 07:59:48.832 screenresolution[1926:20950] starting screenresolution argv=screenresolution list 07:59:48 INFO - Available Modes on Display 0 07:59:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:59:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:59:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:59:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:59:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:59:49 INFO - Intel Iris: 07:59:49 INFO - Chipset Model: Intel Iris 07:59:49 INFO - Type: GPU 07:59:49 INFO - Bus: Built-In 07:59:49 INFO - VRAM (Dynamic, Max): 1536 MB 07:59:49 INFO - Vendor: Intel (0x8086) 07:59:49 INFO - Device ID: 0x0a2e 07:59:49 INFO - Revision ID: 0x0009 07:59:49 INFO - Displays: 07:59:49 INFO - Display: 07:59:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:59:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:59:49 INFO - Display Serial Number: 1600x1200 60 07:59:49 INFO - Main Display: Yes 07:59:49 INFO - Mirror: Off 07:59:49 INFO - Online: Yes 07:59:49 INFO - Rotation: Supported 07:59:49 INFO - Return code: 0 07:59:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:59:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:59:49 INFO - Python 2.7.3 07:59:49 INFO - Return code: 0 07:59:49 INFO - grabbing minidump binary from tooltool 07:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:59:49 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 0x101b71d30>, '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 0x101a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b66be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:59:49 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:59:49 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:59:49 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:59:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:59:49 INFO - Return code: 0 07:59:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:59:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:59:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:59:49 INFO - ENV: RUST_BACKTRACE is now 1 07:59:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:59:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:59:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ERxogNTaS5WkiMpYexpBOQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0210', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:59:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ERxogNTaS5WkiMpYexpBOQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0210 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:59:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rAvih0dTFV/Render', 07:59:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:49 INFO - 'HOME': '/Users/cltbld', 07:59:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:49 INFO - 'LOGNAME': 'cltbld', 07:59:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:59:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:49 INFO - 'MOZ_NO_REMOTE': '1', 07:59:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:59:49 INFO - 'NO_EM_RESTART': '1', 07:59:49 INFO - 'PAGER': '/bin/cat', 07:59:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:49 INFO - 'PWD': '/builds/slave/test', 07:59:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:59:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:49 INFO - 'RUST_BACKTRACE': '1', 07:59:49 INFO - 'SHELL': '/bin/bash', 07:59:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.54qLvLEGma/Listeners', 07:59:49 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 07:59:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:49 INFO - 'USER': 'cltbld', 07:59:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:49 INFO - 'XPC_FLAGS': '0x0', 07:59:49 INFO - 'XPC_SERVICE_NAME': '0', 07:59:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ERxogNTaS5WkiMpYexpBOQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0210', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:59:49 INFO - mozversion application_buildid: 20170530071016 07:59:49 INFO - mozversion application_changeset: 3524778fe631486d5a9cd4f5392177f297b337dc 07:59:49 INFO - mozversion application_display_name: Firefox 07:59:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:59:49 INFO - mozversion application_name: Firefox 07:59:49 INFO - mozversion application_remotingname: firefox 07:59:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:59:49 INFO - mozversion application_vendor: Mozilla 07:59:49 INFO - mozversion application_version: 54.0 07:59:49 INFO - mozversion platform_buildid: 20170530071016 07:59:49 INFO - mozversion platform_changeset: 3524778fe631486d5a9cd4f5392177f297b337dc 07:59:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:59:49 INFO - mozversion platform_version: 54.0 07:59:49 INFO - using testdate: 1496156389 07:59:49 INFO - actual date: 1496156389 07:59:49 INFO - starting webserver on 'localhost:55823' 07:59:49 INFO - SUITE-START | Running 2 tests 07:59:49 INFO - TEST-START | dromaeo_css 07:59:49 INFO - operating with platform_type : mac_ 07:59:49 INFO - Initialising browser for dromaeo_css test... 07:59:49 INFO - TEST-INFO | started process 1936 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/tmpRrfvEb/profile http://localhost:55823/getInfo.html) 07:59:51 INFO - PROCESS | 1936 | __metrics Screen width/height:1600/1200 07:59:51 INFO - PROCESS | 1936 | colorDepth:24 07:59:51 INFO - PROCESS | 1936 | Browser inner width/height: 1024/689 07:59:51 INFO - PROCESS | 1936 | __metrics 07:59:52 INFO - PROCESS | 1936 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:59:52 INFO - PROCESS | 1936 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:59:52 INFO - TEST-INFO | 1936: exit 0 07:59:52 INFO - Browser initialized. 07:59:52 INFO - Running cycle 1/1 for dromaeo_css test... 07:59:52 INFO - TEST-INFO | started process 1940 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/tmpRrfvEb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:00:04 INFO - PROCESS | 1940 | RSS: Main: 165130240 08:00:04 INFO - PROCESS | 1940 | 08:03:08 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:55823/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55823/tests/dromaeo/cssquery-ext.html) 08:03:10 INFO - PROCESS | 1940 | RSS: Main: 297435136 08:03:10 INFO - PROCESS | 1940 | 08:06:12 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:55823/tests/dromaeo/cssquery-ext.html (next: http://localhost:55823/tests/dromaeo/cssquery-jquery.html) 08:06:13 INFO - PROCESS | 1940 | RSS: Main: 301195264 08:06:13 INFO - PROCESS | 1940 | 08:09:15 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:55823/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55823/tests/dromaeo/cssquery-mootools.html) 08:09:16 INFO - PROCESS | 1940 | RSS: Main: 277884928 08:09:16 INFO - PROCESS | 1940 | 08:12:18 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:55823/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55823/tests/dromaeo/cssquery-prototype.html) 08:12:19 INFO - PROCESS | 1940 | RSS: Main: 275066880 08:12:19 INFO - PROCESS | 1940 | 08:15:23 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:55823/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55823/tests/dromaeo/cssquery-yui.html) 08:15:23 INFO - PROCESS | 1940 | RSS: Main: 265506816 08:15:23 INFO - PROCESS | 1940 | 08:18:26 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:55823/tests/dromaeo/cssquery-yui.html (next: http://localhost:55823/tests/dromaeo/cssquery-dojo.html) 08:18:27 INFO - PROCESS | 1940 | RSS: Main: 475463680 08:18:27 INFO - PROCESS | 1940 | 08:18:27 INFO - PROCESS | 1940 | __start_tp_report 08:18:27 INFO - PROCESS | 1940 | _x_x_mozilla_page_load 08:18:27 INFO - PROCESS | 1940 | _x_x_mozilla_page_load_details 08:18:27 INFO - PROCESS | 1940 | |i|pagename|runs| 08:18:27 INFO - PROCESS | 1940 | |0;dojo.html;3484.7734897231676;3515.595706493754;3516.630753770854;3545.8758943436983;3561.341151886901;6082.908756368653;6101.938980610193;6109.541784366168;6129.908051379227;6164.291106522751;6103.206583144196;6121.081837724343;6169.2596888373455;6184.041473571604;6187.81436556904;5463.508284254416;5495.725213739297;5528.44715528446;5544.140658197985;5632.690202038907;5420.268263784398;5425.484578965012;5435.619506634537;5599.300087489064;5613;5477.616566840323;5501.862453438676;5506.119020956648;5518.503334699876;5541.0580201365665;5577.135543990667;5584.972075139639;5590.468905453975;5596.692181929992;5601.187827764992;5404.351477822686;5502.477264659851;5534.308211473566;5545.112781954908;5559.305086864142;5916.142159386908;5947.9702601486715;6018.879622407528;6026.276846778414;6030.33666296707;5388.272583201257;6264.467520260783;6319.273283572402;6353.777617783356;6436.324185960453;6455.83860403489;6485.092087107809;6492.967535162341;6523.086767852505;6528.249251336109;6258;6276.121343011982;6276.246850377938;6303.401176888188;6311.084892690534;5810.5351571875;6082.543809214327;6340.270868850049;6391;6589.110470086573;5548.585110796721;6204.751809927642;6343.777967771106;6345.777897773556;6377.01156320771;6490.837729056811;6505.934940650627;6543.247526534415;6546.3453654635105;6552.148220731275;6263.091851681481;6359.2368915729485;6425.293217746044;6440.549161558646;6447.903281450782;6428.067930150102;6435.967820160963;6463.256725476536;6468.06213099098;6475.740970361133;5261.631685781958;5284.3658760948165;5298.470152984671;5298.576113910878;5319.601029922694;4554.795034223468;4574;4662.114198302312;4685.4143232095985;4715.292706094114;6057.151998720183;6083.330833608299;6177.4749146323065;6182.938170618237;6241.625502469867;6413.518986075969;6491.642959637171;6495.545311828221;6500.739970401226;6515.674216289167;6208.410201030895;6232.0963460298;6236.563440559117;6241.75032998684;6248.593841400295;5502.80740174092;5536.280283563111;5624.29696287964;5640.210370548127;5643.943560564424;6476.352364763486;6485.416312531895;6503.739850405931;6514.4788416925585;6543.116679248241;6472.223333200046;6506.674666266573;6520.902186467112;6521.315261897433;6528.738850445929;6708.597484150967;6714.127163468718;6724.058631791651;6726.327367263235;6744.359285867835;6277.340879207617;6315.084312774714;6373.968130159319;6385.29761726219;6392.137061496638;6303.243610766737;6319.715612797527;6345.7144428499905;6458.418742313026;6479.5788273762055;5477.808276710296;6187.195664563578;6306.148669929501;6374.808755737336;6379.87240255183;6306.0225665022;6357.205349331333;6359.7456101755415;6362.491000719839;6364.87270254583;6148;6183.81448556544;6239.06414037898;6249.937500624936;6302.810915672537;6365;6367.713452894724;6371.426571608392;6377.713002914973;6392.9041064385;6236.251649802053;6270.278917924497;6295.748170073146;6305.2433707953505;6316 08:18:27 INFO - PROCESS | 1940 | |1;ext.html;787.2285160542668;795.5266616363264;822.5270469480049;911.6080085563206;912.3294378631705;25931;42027.579724202784;42418;42572.787136064275;42773.78613106938;43402;43762.12475750483;43903.78048109755;44000.77999609998;44013.11973760531;8064.395170362217;9731.51342432879;9892.35699679522;9914.851277230848;9916.801663966717;8072.071711753136;11789.528418863278;11969.341686207255;12304.077194210426;12311.692207694834;12023.819642705366;12057;12075.275483470976;12081.637550873487;12093.455794489226;11998.100142489304;12027.819582706266;12030.27818330903;12035.93982030093;12059.457324420422;11710.414479276002;11751.118666100077;11784.764304713943;11789.58736444229;11790.35153066581;41166;41188.97027574305;41199.7940010301;41308.173836523405;41413.1717365651;3972.6623237024887;3991.6806655467494;3995.260876737813;4022;4024.2957482440747;29626.407471850656;29940.850295748598;30100.548491772643;30258.243543911358;30373.848130759427;3174.3175217328385;3206.4709322961685;3259.4947783093658;3260.7065364117107;3276.6887145721357;380240;381702.09148954356;382028;382988;383505;46338.5366146341;46387.536124638995;46407.53592464099;46464.07071858544;46485;47986.760066199444;48053.03893922102;48094.797630059526;48100;48111;14593.343299551545;14700.55898323052;14720.411183552753;14736.778948315783;14742.852571474148;10931.617393391192;11111.499982500807;12606.747865042647;12627;12639;10802.541656876378;12069.879301206876;12197.560487902456;12317.815232771516;12489.313087780078;4893.608511319086;4904.901901961941;5075.5178258065425;5516.758729285959;5622.943770562324;1109.7835921995134;1143.2683082826998;1157.1552766480515;1166.8891455311732;1219.3049961522024;25828.225153245432;28048.158555243375;28362.149135525968;28381;28541.143765687062;1266.7593157300084;1278.5844600504872;1284.8907842833464;1328.6412668579624;1334.7463981843418;14552.981291309507;14628.756555692886;14643.56069317922;14655;14741.92629036848;482198;485129;485258;485596;486979;59256.814863702486;59450.70274648599;59610.70194648999;59653.70173149106;59818;1322.715616142534;1461.7441947659117;1478.0466599043557;1547.0794877048138;1547.1954583616457;23625.763742363044;25587.744122558535;26202.213933582025;26964.46071078607;28676.13971580856;37610.43584346292;37808.62191378051;37809;37852.81073594725;37898.810505947295;423380;425638;426073;427742.86128569156;428600;29963.850180748956;31053.068407947798;31066.53400199044;31075.844620776752;31133.8443307782;29551.85224073866;30533.23666908345;31571;37266;38877.61122388853;27097.72902270952;27367.72632273652;27825.16524504268;28620.713792862636;28649.427011459236;23248.883755581115;27039.188824335302;27729.306767330978;28715;28805.711942881142;31380;31576.684233157375;32445.51331729979;32578.185545361557;32808;26891.462170756084;27394.315142121606;28316.716832831407;28466.857665711537;28823;22642.547149057256;22737.31788046361;23065.769342307034;23139.652905206098;23185.884070579537 08:18:27 INFO - PROCESS | 1940 | |2;jquery.html;415.47857438914156;434.5567521128447;441.5054258177886;442.52428639212843;450.9255972764496;19844.801551984478;21285.57428851422;22284.108635654553;22305.44236394091;22445.32664020078;22670.88664556679;23254.65118023231;23514.177003804827;23999.920003599836;24250;6143.508519318444;6797.898031529531;6893.931060689379;7083.85832283354;7184.353408193261;6933.237343892168;7009.018737376771;7013.719451221945;7027.789166325018;7032.718691252369;6661.966690166542;6895.448364130857;6980.511364204508;6982.2668619794695;7031.1211098612675;6738.932610673928;6934.618595977219;7011.859762804741;7026.473014523931;7085.504014718972;6932.480063995221;6985.720571177147;6991.7902462926195;6993.615351155684;6997.300269972962;22020.33938981833;27429.588556171675;27611;27681.446371072467;27947.86026069877;3014.125903487986;3077.707617776308;3096.6748491408302;3106.3476669899346;3147.323325485009;16720.498385048468;17020.319187232497;17518.474445766646;18083.18625661835;18214.27142914295;2060.917563297466;2074.512489564951;2092.5082605587677;2112.704221409004;2188.8686678799163;142359.28820355833;142594;142815;143328;143900;21664.675029874565;22393.544419612674;22425.775742242695;22555.323340299816;22638.886805565868;36439;36502.08744781402;37315;37343.4398484023;37349.626503735155;11262.943685281522;11495.195336326544;11714.589989350332;11721.941390293165;11915.642530724092;9404.24766018717;9426.340156189139;9494.572744226527;9547.713568592953;9599.040095990485;8642.827143457222;9055.909440905638;10517.947410263052;10814.29707069038;11027.724306892393;3103.658597554267;3283.6387997320276;3583.7133029357587;4186.413902053715;4227.915441691149;1111.4053981120062;1132.9660110196708;1142.2917790969652;1156.7744289863397;1178.3754610056512;23590.29229123129;23591;23611.52776944486;23656.29031129069;23940.640890386658;1157.5022740221616;1162.354893034374;1176.723469984553;1203.1157099531838;1208.3656080557778;12470.376481175905;12527.498900044078;12586.559470418675;12843.550475733304;12845.935770321088;739702;752755;779319.5170120678;816706;817183;136970;137742.5564360899;171954.28045719632;174319;175785;1296.8378952630922;1297.5912587534897;1356.6065840906026;1357.511295933463;1361.8910487161004;20733.89633051825;20842.062107205515;21245.78754212438;21499.785002150405;21582.676259856427;62212.37787622247;62582.68708656428;63543;66947;66977.33022669711;87617;87808.68286975828;87906;89795;90337;11896.107791915814;12011.879881201075;12077.879221207675;12324.212989116708;12329.938350308192;13490.460381584626;13520.526781562598;13901.23543205093;13925.442982281;13929.860701392856;11533.480993355151;11538;11890.76218475643;11985.161038727554;12050.939745301217;10762.3542587445;10803.891961080602;10809.45952702346;11023;11222.607208747655;10551.577936882746;10704.30422022566;11617.244879082833;11877.406129693309;12072.275663460221;9778.313709271491;11970.940145299217;12115.878841211475;12250.632481025226;12289.1397602167;11378.772424551627;11683.649490515298;11826.231294965799;11905.583304584297;11958.342291174069 08:18:27 INFO - PROCESS | 1940 | |3;mootools.html;1603.823579406265;1630.3478608556568;1650.8844380893336;1653.140367009155;1663.4593757028965;10823.78352432952;11600.941995290033;11608.94195529021;11617.361045142514;11639.301641901491;10952.561897524109;11310.434478276095;11560.6531804046;11569.074474042078;11583.884161158387;2472.5796614575565;2514.5222407742563;2519.6598459207958;2527.0397249045336;2530.3547595363248;2164.3723320237114;2185.7814218578173;2200.0539767899795;2217.3569664797187;2435.512897420523;2373.0507796881298;2445.1808644104244;2445.4986727720775;2474.443250268693;2474.492728990562;2389.056322752503;2457.594496908008;2462.926112216627;2467.962980555284;2471.0733474946896;1827.7349784281337;2439.9390015249583;2465.9753402465926;2472.0359059966627;2512.9371765706005;11255.887441125566;11467.19729618927;11475.59835405765;11477;11482.942585287105;5860.70696465175;6042.758289668408;6051.939480605181;6053.51571874249;6060.757569697207;3428.3486137634018;3461.9826900865587;3520.049586611626;3674.3569875271987;3764.5858955514873;1189.143816452153;1216.9087318451152;1236.486857953948;1255.5417272695493;1287.9484820607165;14156.858431415658;14510.782338264935;14903.70192596142;15963.281652325673;16195.83804161955;4179.874603761892;4293.613574778285;4332.241857674894;4440.977795111004;4441;11942.641720748392;11978.161528693083;11982.16124871268;11993.880061199276;12007.859253370916;5913.408659134138;5913.70431478433;5920.467157955804;5932.495737862244;5935.169076329317;5204.34945631796;5331.333583302087;5368.892622147613;5442.91835622466;5471.753771080311;3860.729748917549;3934.960650393459;3964.2467931093;4002.7398219115667;4004.1791432756213;1030.701096681954;1032.9018743219383;1046.7592453735683;1050.1965996013057;1050.3277902142636;951.2247518272586;957.4877440569401;969.8448248280241;980.8038392321564;991.4137380191636;6573.934260657428;6609.405153536205;6630.734770609218;6667.099941507834;6795.116634837538;948.5589201021559;960.4669408478222;963.5567638886191;1009.4649835587151;1050.7478205230689;3082.5838511801066;4071.145059537471;4136.896577585584;4294.742315461082;4401.053773438726;13650.795238071238;14361.138331700131;14368.425262989573;14387.136771793517;14410.783838242434;14272.714545709028;14287.85712142886;14316.642083947985;14318.355673994694;14362.210078445785;8962.32782541312;9257.935337436147;10135.087842094246;10339;10666.040056394962;6096.177016102769;6693.330666933462;6866.793996180123;6981.02265682815;6988.196357418962;12274.38628068575;12495.750084998432;12506.249625022529;12595.811062833882;12651.430685618985;12880.742385152056;12994.415251313525;13043.934780326037;13115.540956066492;13147.802782958071;8214.05538363096;8488.448250863674;8508.74473765788;8509.787255318419;8542.932133483315;10434.68695939123;10442.53008614599;10560.207984401048;10565.418901960466;10579;8974.82050358976;8997.32520060985;9000.59497322635;9040.231580315747;9082.54587270647;8655.48067115975;8733.388662793543;8814.250788683034;8828;8877.11228877133;7755.340796032175;7924;8060.274575288252;8186.222308880647;8188.5905704715715;5893.823185304448;5928.525717942641;5949;6079.240094988127;6175.814725558241;5936.762529498772;6117.724702388492;6161.753529858755;6174.969125154345;6229.781957631461 08:18:27 INFO - PROCESS | 1940 | |4;prototype.html;332.9267561136549;352.68434750897944;385.12768579168187;404.437831414334;405.0501573809416;4787.090452813967;4851.908320627861;4996.350474438327;5191.896162076766;5262.815801446945;4250.321123156351;4778.4743678195455;4863.683860549062;4988.376452943382;5128.8974220515565;4127.855525056616;4449.132419178261;4457.910841783162;4464.3303504474425;4504.301833215857;3534.32847758925;3783.772973621578;3911.4915061042166;4130.710850240484;4380.2115619188535;3318.402687516258;4095.9385609215888;4216.451861258048;4307.827686892536;4320.395144679747;4219.814040399509;4221.746695198282;4253.893652658678;4263.358606936321;4298.118885628439;3951.8024098794945;4003.459532963071;4003.8598649047435;4004.4994375703036;4035.7982100894837;4714.929276060861;4969.478204788517;5002.59979201663;5022.472640372781;5125.846224613268;4149.398337241083;4225.3873188387815;4499.910001799978;4756.595689366408;4822.493638167977;4673.322368256618;5038.571721403685;5344.358676958751;5421.0755181910645;5445.786985678429;3807.60020197878;3835.884923452273;4074.8623559858743;4365.257906155929;4399.538048504893;5608.139848677204;5609.1305847593685;5631.5776316776;5658.603897727202;5666.943330566683;4017.794661601508;4445.177642136216;4457.420535330386;4519.864404067883;4534.9319760203625;3679.8344074516713;4285;4545.9089818443335;4576.313552967082;4608.124456353282;3958.5645578986287;4475.9705267788595;4511.774411279423;4891.584215341736;4945.752712364368;5441.673499590037;5443.700596467153;5489.3687225969525;5495.763453222993;5544.1960915667005;1329.3419757220045;1411.7153390414674;1446.0045137709892;1456.1117718191895;1479.993604349053;1053.9631112911165;1087.2497976396262;1139.897409233173;1168.363242033094;1178.7701398227264;4103.9179216415505;4406.518850108442;4879.268109783561;5119.564836988823;5230;5285;5369.946300537023;5630.85922851932;5672.716364181774;5695.971520142372;4458.06380660065;4855.830045948445;5177.534021938043;5218.530332270114;5280.313559237275;2724.196362073193;2874.5688146777734;2911.583385789789;2914.7791690182044;2923.5614657801075;4638.1883170445035;5555.527780138653;5620.269364982526;5802;5849.923277236605;4437.844675436344;4892.681975671641;5207.869803254949;5413.861524697722;5795.362510123883;4919.606431485473;5072.170511264046;5431.491861754813;5798.652080875161;5820.563457740602;5212.9834682238115;5473.397926228191;5668.461496157858;5679.346875109415;5738.885222295614;4670.953290467188;4877.317175595348;5455.672659640434;5560.832225232746;5589.664620122806;5757.366689664217;5818.970905145447;5821.621594596338;5848.122781582797;5849.356570777126;4007.859724909614;4165.770882601365;4193.22425351311;4245;4582.747948862844;4552.203364411149;4798.296604705419;5120.974395128001;5500.367457742411;5577;4674;4956.553910148104;4969.726665033313;5434.592405569519;5440.591955603267;5171.095058364695;5187.4553171916405;5333.626646134733;5451.945480545144;5550.5282051026115;4714.3399924011355;4961.11477638495;5337.329836393156;5356.3572371315695;5369.4630536946;4851.805927762991;5128.512731307879;5147.40804807437;5233.738313084406;5345.1982202669915;4185.162967406592;4417.602415782595;5110.7734143805965;5296.867578310573;5368.543673787772 08:18:27 INFO - PROCESS | 1940 | |5;yui.html;796.661418896969;813.3046245460131;841.5245386356712;891.1355984694846;901.4320977783996;15781.526554203378;17534.73697894531;17566.385176518823;17587;17589.384371547;15451.768223476656;15850.128242946634;15867.444639437623;15919.92040039801;16129.677406451863;1001.2190491416707;1037.3827572594294;1040.2562168049842;1041.4272150317333;1041.8385150301679;1022.9283950123495;1028.3521381529663;1031.520343040486;1031.690492852145;1033.4006276359694;1046.2414749306768;1068.1294744782977;1068.6687126990619;1069.107295408335;1091.7270682329417;1080.4813689429118;1080.5407701726735;1081.070279559582;1081.729567608098;1083.0523292119397;788.9171636978092;789.388224126301;790.1348023913805;792.065362871811;792.9008873890764;17064.402745903833;17187.570310742332;17217.311307547683;18114.365997190165;18409;14438;14812.925935370255;14891;14944.103353798699;15110.471133510275;10239.283250172492;12036.759264814655;12050.337231452266;12181.573644922386;12371.505139794488;3363.7477189210663;3775.830087646035;3797;3799.354109801313;4038.434619153321;112916;114154.42922785415;114989.4250528742;116811;117254;11191.552337906392;11561.826572601418;11596.362200078907;11676.47455864488;11849.703757405961;23745.693986830545;23756.287311380685;23763.643545346833;23772.930218140224;23810.523789524457;7797.571133587707;7822.726204582926;8034.718784842503;8365.498070115813;8384.496930184208;4519.502854685982;4672.486026537078;4681.882952926204;4738.928916066262;4759.262314341283;3665.9266814663556;3692.649198326155;3750.1937083527173;3782.451544526083;3789.5073640426567;668.7525615522288;669.4945316286173;675.746595026865;682.7883356159606;689.4484412470003;674.1606699658956;680.8519122169563;701.242657929435;705.7741522712786;734.2281945605716;10706.839397409045;10822.78354432907;10874.891251087545;10932;11172.385518796382;676.1716896801478;698.860227954401;703.2967032967033;724.7825652304288;733.7872017114977;5123.487651234921;5206.193040078794;5210.713410762369;5234.26720259164;5239.449857764956;85730;88160.55919720489;109862.35206471909;111320;113088;49435.75282123566;63770.36229637737;74133;81350.77973830397;97841;60010.79978400495;63048.68475657684;75563;76040.61979690177;79242.60378698069;8572.571371431528;9675.903240967782;10779.89220107789;11207.887921120684;11495.425228738362;45055.54944450514;48275;48301;49673.75815604639;50174.22996355466;56309.71845140748;57886;67064;68958.65520672566;71510.56978860497;13346.13250138738;13603.863961360656;13721.794173087612;13992.720145597235;14155.079919805179;15884.92057539705;15921.522354329389;16002.599935001717;16173.272202751139;16449.25978331002;14353;14504.854951450772;14706.926465367605;14737.778933316224;14983.925080374529;13977.440902364198;14068.577942661737;14866.628334291729;15187.240637967836;15235.466758663393;13572.524961626295;13928.50583043347;14497.347619357366;14500.637484062983;14999.2500374983;10187.847182292124;10619.30974486656;10622.415767132881;10767.946160269148;10794.73013174677;9327.673531426639;10262.332948358333;11347.262427942158;11729.765404691687;11760.529578817093 08:18:27 INFO - PROCESS | 1940 | __end_tp_report 08:18:27 INFO - PROCESS | 1940 | __start_cc_report 08:18:27 INFO - PROCESS | 1940 | _x_x_mozilla_cycle_collect,1408 08:18:27 INFO - PROCESS | 1940 | __end_cc_report 08:18:27 INFO - PROCESS | 1940 | __startTimestamp1496157507028__endTimestamp 08:18:27 INFO - PROCESS | 1940 | 08:18:27 INFO - PROCESS | 1940 | ------- Summary: start ------- 08:18:27 INFO - PROCESS | 1940 | Number of tests: 6 08:18:27 INFO - PROCESS | 1940 | 08:18:27 INFO - PROCESS | 1940 | [#0] dojo.html Cycles:165 Average:6011.13 Median:6258.00 stddev:639.05 (10.2%) stddev-sans-first:609.50 08:18:27 INFO - PROCESS | 1940 | Values: 3484.8 3515.6 3516.6 3545.9 3561.3 6082.9 6101.9 6109.5 6129.9 6164.3 6103.2 6121.1 6169.3 6184.0 6187.8 5463.5 5495.7 5528.4 5544.1 5632.7 5420.3 5425.5 5435.6 5599.3 5613.0 5477.6 5501.9 5506.1 5518.5 5541.1 5577.1 5585.0 5590.5 5596.7 5601.2 5404.4 5502.5 5534.3 5545.1 5559.3 5916.1 5948.0 6018.9 6026.3 6030.3 5388.3 6264.5 6319.3 6353.8 6436.3 6455.8 6485.1 6493.0 6523.1 6528.2 6258.0 6276.1 6276.2 6303.4 6311.1 5810.5 6082.5 6340.3 6391.0 6589.1 5548.6 6204.8 6343.8 6345.8 6377.0 6490.8 6505.9 6543.2 6546.3 6552.1 6263.1 6359.2 6425.3 6440.5 6447.9 6428.1 6436.0 6463.3 6468.1 6475.7 5261.6 5284.4 5298.5 5298.6 5319.6 4554.8 4574.0 4662.1 4685.4 4715.3 6057.2 6083.3 6177.5 6182.9 6241.6 6413.5 6491.6 6495.5 6500.7 6515.7 6208.4 6232.1 6236.6 6241.8 6248.6 5502.8 5536.3 5624.3 5640.2 5643.9 6476.4 6485.4 6503.7 6514.5 6543.1 6472.2 6506.7 6520.9 6521.3 6528.7 6708.6 6714.1 6724.1 6726.3 6744.4 6277.3 6315.1 6374.0 6385.3 6392.1 6303.2 6319.7 6345.7 6458.4 6479.6 5477.8 6187.2 6306.1 6374.8 6379.9 6306.0 6357.2 6359.7 6362.5 6364.9 6148.0 6183.8 6239.1 6249.9 6302.8 6365.0 6367.7 6371.4 6377.7 6392.9 6236.3 6270.3 6295.7 6305.2 6316.0 08:18:27 INFO - PROCESS | 1940 | 08:18:27 INFO - PROCESS | 1940 | [#1] ext.html Cycles:180 Average:56201.97 Median:30316.05 stddev:115024.67 (379.4%) stddev-sans-first:115272.10 08:18:27 INFO - PROCESS | 1940 | Values: 787.2 795.5 822.5 911.6 912.3 25931.0 42027.6 42418.0 42572.8 42773.8 43402.0 43762.1 43903.8 44000.8 44013.1 8064.4 9731.5 9892.4 9914.9 9916.8 8072.1 11789.5 11969.3 12304.1 12311.7 12023.8 12057.0 12075.3 12081.6 12093.5 11998.1 12027.8 12030.3 12035.9 12059.5 11710.4 11751.1 11784.8 11789.6 11790.4 41166.0 41189.0 41199.8 41308.2 41413.2 3972.7 3991.7 3995.3 4022.0 4024.3 29626.4 29940.9 30100.5 30258.2 30373.8 3174.3 3206.5 3259.5 3260.7 3276.7 380240.0 381702.1 382028.0 382988.0 383505.0 46338.5 46387.5 46407.5 46464.1 46485.0 47986.8 48053.0 48094.8 48100.0 48111.0 14593.3 14700.6 14720.4 14736.8 14742.9 10931.6 11111.5 12606.7 12627.0 12639.0 10802.5 12069.9 12197.6 12317.8 12489.3 4893.6 4904.9 5075.5 5516.8 5622.9 1109.8 1143.3 1157.2 1166.9 1219.3 25828.2 28048.2 28362.1 28381.0 28541.1 1266.8 1278.6 1284.9 1328.6 1334.7 14553.0 14628.8 14643.6 14655.0 14741.9 482198.0 485129.0 485258.0 485596.0 486979.0 59256.8 59450.7 59610.7 59653.7 59818.0 1322.7 1461.7 1478.0 1547.1 1547.2 23625.8 25587.7 26202.2 26964.5 28676.1 37610.4 37808.6 37809.0 37852.8 37898.8 423380.0 425638.0 426073.0 427742.9 428600.0 29963.9 31053.1 31066.5 31075.8 31133.8 29551.9 30533.2 31571.0 37266.0 38877.6 27097.7 27367.7 27825.2 28620.7 28649.4 23248.9 27039.2 27729.3 28715.0 28805.7 31380.0 31576.7 32445.5 32578.2 32808.0 26891.5 27394.3 28316.7 28466.9 28823.0 22642.5 22737.3 23065.8 23139.7 23185.9 08:18:27 INFO - PROCESS | 1940 | 08:18:27 INFO - PROCESS | 1940 | [#2] jquery.html Cycles:180 Average:44579.53 Median:22152.22 stddev:129945.44 (586.6%) stddev-sans-first:130267.66 08:18:27 INFO - PROCESS | 1940 | Values: 415.5 434.6 441.5 442.5 450.9 19844.8 21285.6 22284.1 22305.4 22445.3 22670.9 23254.7 23514.2 23999.9 24250.0 6143.5 6797.9 6893.9 7083.9 7184.4 6933.2 7009.0 7013.7 7027.8 7032.7 6662.0 6895.4 6980.5 6982.3 7031.1 6738.9 6934.6 7011.9 7026.5 7085.5 6932.5 6985.7 6991.8 6993.6 6997.3 22020.3 27429.6 27611.0 27681.4 27947.9 3014.1 3077.7 3096.7 3106.3 3147.3 16720.5 17020.3 17518.5 18083.2 18214.3 2060.9 2074.5 2092.5 2112.7 2188.9 142359.3 142594.0 142815.0 143328.0 143900.0 21664.7 22393.5 22425.8 22555.3 22638.9 36439.0 36502.1 37315.0 37343.4 37349.6 11262.9 11495.2 11714.6 11721.9 11915.6 9404.2 9426.3 9494.6 9547.7 9599.0 8642.8 9055.9 10517.9 10814.3 11027.7 3103.7 3283.6 3583.7 4186.4 4227.9 1111.4 1133.0 1142.3 1156.8 1178.4 23590.3 23591.0 23611.5 23656.3 23940.6 1157.5 1162.4 1176.7 1203.1 1208.4 12470.4 12527.5 12586.6 12843.6 12845.9 739702.0 752755.0 779319.5 816706.0 817183.0 136970.0 137742.6 171954.3 174319.0 175785.0 1296.8 1297.6 1356.6 1357.5 1361.9 20733.9 20842.1 21245.8 21499.8 21582.7 62212.4 62582.7 63543.0 66947.0 66977.3 87617.0 87808.7 87906.0 89795.0 90337.0 11896.1 12011.9 12077.9 12324.2 12329.9 13490.5 13520.5 13901.2 13925.4 13929.9 11533.5 11538.0 11890.8 11985.2 12050.9 10762.4 10803.9 10809.5 11023.0 11222.6 10551.6 10704.3 11617.2 11877.4 12072.3 9778.3 11970.9 12115.9 12250.6 12289.1 11378.8 11683.6 11826.2 11905.6 11958.3 08:18:27 INFO - PROCESS | 1940 | 08:18:27 INFO - PROCESS | 1940 | [#3] mootools.html Cycles:180 Average:6852.78 Median:2513.73 stddev:4340.58 (172.7%) stddev-sans-first:4334.83 08:18:27 INFO - PROCESS | 1940 | Values: 1603.8 1630.3 1650.9 1653.1 1663.5 10823.8 11600.9 11608.9 11617.4 11639.3 10952.6 11310.4 11560.7 11569.1 11583.9 2472.6 2514.5 2519.7 2527.0 2530.4 2164.4 2185.8 2200.1 2217.4 2435.5 2373.1 2445.2 2445.5 2474.4 2474.5 2389.1 2457.6 2462.9 2468.0 2471.1 1827.7 2439.9 2466.0 2472.0 2512.9 11255.9 11467.2 11475.6 11477.0 11482.9 5860.7 6042.8 6051.9 6053.5 6060.8 3428.3 3462.0 3520.0 3674.4 3764.6 1189.1 1216.9 1236.5 1255.5 1287.9 14156.9 14510.8 14903.7 15963.3 16195.8 4179.9 4293.6 4332.2 4441.0 4441.0 11942.6 11978.2 11982.2 11993.9 12007.9 5913.4 5913.7 5920.5 5932.5 5935.2 5204.3 5331.3 5368.9 5442.9 5471.8 3860.7 3935.0 3964.2 4002.7 4004.2 1030.7 1032.9 1046.8 1050.2 1050.3 951.2 957.5 969.8 980.8 991.4 6573.9 6609.4 6630.7 6667.1 6795.1 948.6 960.5 963.6 1009.5 1050.7 3082.6 4071.1 4136.9 4294.7 4401.1 13650.8 14361.1 14368.4 14387.1 14410.8 14272.7 14287.9 14316.6 14318.4 14362.2 8962.3 9257.9 10135.1 10339.0 10666.0 6096.2 6693.3 6866.8 6981.0 6988.2 12274.4 12495.8 12506.2 12595.8 12651.4 12880.7 12994.4 13043.9 13115.5 13147.8 8214.1 8488.4 8508.7 8509.8 8542.9 10434.7 10442.5 10560.2 10565.4 10579.0 8974.8 8997.3 9000.6 9040.2 9082.5 8655.5 8733.4 8814.3 8828.0 8877.1 7755.3 7924.0 8060.3 8186.2 8188.6 5893.8 5928.5 5949.0 6079.2 6175.8 5936.8 6117.7 6161.8 6175.0 6229.8 08:18:27 INFO - PROCESS | 1940 | 08:18:27 INFO - PROCESS | 1940 | [#4] prototype.html Cycles:180 Average:4508.22 Median:4851.86 stddev:1260.42 (26.0%) stddev-sans-first:1224.38 08:18:27 INFO - PROCESS | 1940 | Values: 332.9 352.7 385.1 404.4 405.1 4787.1 4851.9 4996.4 5191.9 5262.8 4250.3 4778.5 4863.7 4988.4 5128.9 4127.9 4449.1 4457.9 4464.3 4504.3 3534.3 3783.8 3911.5 4130.7 4380.2 3318.4 4095.9 4216.5 4307.8 4320.4 4219.8 4221.7 4253.9 4263.4 4298.1 3951.8 4003.5 4003.9 4004.5 4035.8 4714.9 4969.5 5002.6 5022.5 5125.8 4149.4 4225.4 4499.9 4756.6 4822.5 4673.3 5038.6 5344.4 5421.1 5445.8 3807.6 3835.9 4074.9 4365.3 4399.5 5608.1 5609.1 5631.6 5658.6 5666.9 4017.8 4445.2 4457.4 4519.9 4534.9 3679.8 4285.0 4545.9 4576.3 4608.1 3958.6 4476.0 4511.8 4891.6 4945.8 5441.7 5443.7 5489.4 5495.8 5544.2 1329.3 1411.7 1446.0 1456.1 1480.0 1054.0 1087.2 1139.9 1168.4 1178.8 4103.9 4406.5 4879.3 5119.6 5230.0 5285.0 5369.9 5630.9 5672.7 5696.0 4458.1 4855.8 5177.5 5218.5 5280.3 2724.2 2874.6 2911.6 2914.8 2923.6 4638.2 5555.5 5620.3 5802.0 5849.9 4437.8 4892.7 5207.9 5413.9 5795.4 4919.6 5072.2 5431.5 5798.7 5820.6 5213.0 5473.4 5668.5 5679.3 5738.9 4671.0 4877.3 5455.7 5560.8 5589.7 5757.4 5819.0 5821.6 5848.1 5849.4 4007.9 4165.8 4193.2 4245.0 4582.7 4552.2 4798.3 5121.0 5500.4 5577.0 4674.0 4956.6 4969.7 5434.6 5440.6 5171.1 5187.5 5333.6 5451.9 5550.5 4714.3 4961.1 5337.3 5356.4 5369.5 4851.8 5128.5 5147.4 5233.7 5345.2 4185.2 4417.6 5110.8 5296.9 5368.5 08:18:27 INFO - PROCESS | 1940 | 08:18:27 INFO - PROCESS | 1940 | [#5] yui.html Cycles:180 Average:20438.66 Median:16756.83 stddev:28728.13 (171.4%) stddev-sans-first:28770.86 08:18:27 INFO - PROCESS | 1940 | Values: 796.7 813.3 841.5 891.1 901.4 15781.5 17534.7 17566.4 17587.0 17589.4 15451.8 15850.1 15867.4 15919.9 16129.7 1001.2 1037.4 1040.3 1041.4 1041.8 1022.9 1028.4 1031.5 1031.7 1033.4 1046.2 1068.1 1068.7 1069.1 1091.7 1080.5 1080.5 1081.1 1081.7 1083.1 788.9 789.4 790.1 792.1 792.9 17064.4 17187.6 17217.3 18114.4 18409.0 14438.0 14812.9 14891.0 14944.1 15110.5 10239.3 12036.8 12050.3 12181.6 12371.5 3363.7 3775.8 3797.0 3799.4 4038.4 112916.0 114154.4 114989.4 116811.0 117254.0 11191.6 11561.8 11596.4 11676.5 11849.7 23745.7 23756.3 23763.6 23772.9 23810.5 7797.6 7822.7 8034.7 8365.5 8384.5 4519.5 4672.5 4681.9 4738.9 4759.3 3665.9 3692.6 3750.2 3782.5 3789.5 668.8 669.5 675.7 682.8 689.4 674.2 680.9 701.2 705.8 734.2 10706.8 10822.8 10874.9 10932.0 11172.4 676.2 698.9 703.3 724.8 733.8 5123.5 5206.2 5210.7 5234.3 5239.4 85730.0 88160.6 109862.4 111320.0 113088.0 49435.8 63770.4 74133.0 81350.8 97841.0 60010.8 63048.7 75563.0 76040.6 79242.6 8572.6 9675.9 10779.9 11207.9 11495.4 45055.5 48275.0 48301.0 49673.8 50174.2 56309.7 57886.0 67064.0 68958.7 71510.6 13346.1 13603.9 13721.8 13992.7 14155.1 15884.9 15921.5 16002.6 16173.3 16449.3 14353.0 14504.9 14706.9 14737.8 14983.9 13977.4 14068.6 14866.6 15187.2 15235.5 13572.5 13928.5 14497.3 14500.6 14999.3 10187.8 10619.3 10622.4 10767.9 10794.7 9327.7 10262.3 11347.3 11729.8 11760.5 08:18:27 INFO - PROCESS | 1940 | -------- Summary: end -------- 08:18:27 INFO - PROCESS | 1940 | 08:18:27 INFO - TEST-INFO | 1940: exit 0 08:18:27 INFO - TEST-OK | dromaeo_css | took 1118211ms 08:18:27 INFO - TEST-START | kraken 08:18:27 INFO - operating with platform_type : mac_ 08:18:27 INFO - Initialising browser for kraken test... 08:18:27 INFO - TEST-INFO | started process 1944 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/tmp26WG3q/profile http://localhost:55823/getInfo.html) 08:18:29 INFO - PROCESS | 1944 | __metrics Screen width/height:1600/1200 08:18:29 INFO - PROCESS | 1944 | colorDepth:24 08:18:29 INFO - PROCESS | 1944 | Browser inner width/height: 1024/689 08:18:29 INFO - PROCESS | 1944 | __metrics 08:18:29 INFO - PROCESS | 1944 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:18:29 INFO - PROCESS | 1944 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:18:30 INFO - TEST-INFO | 1944: exit 0 08:18:30 INFO - Browser initialized. 08:18:30 INFO - Running cycle 1/1 for kraken test... 08:18:30 INFO - TEST-INFO | started process 1946 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/tmp26WG3q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:18:42 INFO - PROCESS | 1946 | RSS: Main: 168898560 08:18:42 INFO - PROCESS | 1946 | 08:18:45 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:55823/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55823/tests/kraken/driver.html?testName=audio-beat-detection) 08:18:46 INFO - PROCESS | 1946 | RSS: Main: 219652096 08:18:46 INFO - PROCESS | 1946 | 08:18:49 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:55823/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55823/tests/kraken/driver.html?testName=audio-dft) 08:18:49 INFO - PROCESS | 1946 | RSS: Main: 229302272 08:18:49 INFO - PROCESS | 1946 | 08:18:52 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:55823/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55823/tests/kraken/driver.html?testName=audio-fft) 08:18:53 INFO - PROCESS | 1946 | RSS: Main: 325599232 08:18:53 INFO - PROCESS | 1946 | 08:18:55 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:55823/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55823/tests/kraken/driver.html?testName=audio-oscillator) 08:18:55 INFO - PROCESS | 1946 | RSS: Main: 229658624 08:18:55 INFO - PROCESS | 1946 | 08:18:57 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:55823/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55823/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:18:58 INFO - PROCESS | 1946 | RSS: Main: 230666240 08:18:58 INFO - PROCESS | 1946 | 08:19:01 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:55823/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55823/tests/kraken/driver.html?testName=imaging-darkroom) 08:19:02 INFO - PROCESS | 1946 | RSS: Main: 271601664 08:19:02 INFO - PROCESS | 1946 | 08:19:04 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:55823/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55823/tests/kraken/driver.html?testName=imaging-desaturate) 08:19:05 INFO - PROCESS | 1946 | RSS: Main: 271724544 08:19:05 INFO - PROCESS | 1946 | 08:19:08 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:55823/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55823/tests/kraken/driver.html?testName=json-parse-financial) 08:19:09 INFO - PROCESS | 1946 | RSS: Main: 270815232 08:19:09 INFO - PROCESS | 1946 | 08:19:10 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:55823/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55823/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:19:11 INFO - PROCESS | 1946 | RSS: Main: 249692160 08:19:11 INFO - PROCESS | 1946 | 08:19:13 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:55823/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55823/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:19:13 INFO - PROCESS | 1946 | RSS: Main: 251379712 08:19:13 INFO - PROCESS | 1946 | 08:19:15 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:55823/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55823/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:19:16 INFO - PROCESS | 1946 | RSS: Main: 258867200 08:19:16 INFO - PROCESS | 1946 | 08:19:19 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:55823/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55823/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:19:20 INFO - PROCESS | 1946 | RSS: Main: 260698112 08:19:20 INFO - PROCESS | 1946 | 08:19:22 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:55823/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55823/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:19:23 INFO - PROCESS | 1946 | RSS: Main: 261890048 08:19:23 INFO - PROCESS | 1946 | 08:19:25 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:55823/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55823/tests/kraken/driver.html?testName=ai-astar) 08:19:25 INFO - PROCESS | 1946 | RSS: Main: 306098176 08:19:25 INFO - PROCESS | 1946 | 08:19:25 INFO - PROCESS | 1946 | __start_tp_report 08:19:25 INFO - PROCESS | 1946 | _x_x_mozilla_page_load 08:19:25 INFO - PROCESS | 1946 | _x_x_mozilla_page_load_details 08:19:25 INFO - PROCESS | 1946 | |i|pagename|runs| 08:19:25 INFO - PROCESS | 1946 | |0;ai-astar;118;123;168;163;116;115;117;116;117;118 08:19:25 INFO - PROCESS | 1946 | |1;audio-beat-detection;137;127;135;171;111;107;106;108;127;109 08:19:25 INFO - PROCESS | 1946 | |2;audio-dft;185;185;182;186;184;184;185;186;184;183 08:19:25 INFO - PROCESS | 1946 | |3;audio-fft;83;59;60;94;59;60;59;63;74;58 08:19:25 INFO - PROCESS | 1946 | |4;audio-oscillator;92;68;87;68;68;65;82;69;68;82 08:19:25 INFO - PROCESS | 1946 | |5;imaging-gaussian-blur;86;86;88;86;86;85;86;86;86;86 08:19:25 INFO - PROCESS | 1946 | |6;imaging-darkroom;92;93;94;93;93;93;94;94;93;93 08:19:25 INFO - PROCESS | 1946 | |7;imaging-desaturate;83;84;85;83;84;85;84;83;86;86 08:19:25 INFO - PROCESS | 1946 | |8;json-parse-financial;62;61;60;59;62;62;61;62;62;62 08:19:25 INFO - PROCESS | 1946 | |9;json-stringify-tinderbox;55;59;67;66;60;57;58;59;58;58 08:19:25 INFO - PROCESS | 1946 | |10;stanford-crypto-aes;82;84;84;84;79;83;84;81;89;120 08:19:25 INFO - PROCESS | 1946 | |11;stanford-crypto-ccm;124;157;147;121;138;132;130;133;150;135 08:19:25 INFO - PROCESS | 1946 | |12;stanford-crypto-pbkdf2;186;221;167;173;158;161;150;151;161;161 08:19:25 INFO - PROCESS | 1946 | |13;stanford-crypto-sha256-iterative;65;64;63;65;65;65;75;83;81;79 08:19:25 INFO - PROCESS | 1946 | __end_tp_report 08:19:25 INFO - PROCESS | 1946 | __start_cc_report 08:19:25 INFO - PROCESS | 1946 | _x_x_mozilla_cycle_collect,2023 08:19:25 INFO - PROCESS | 1946 | __end_cc_report 08:19:25 INFO - PROCESS | 1946 | __startTimestamp1496157565559__endTimestamp 08:19:25 INFO - PROCESS | 1946 | 08:19:25 INFO - PROCESS | 1946 | ------- Summary: start ------- 08:19:25 INFO - PROCESS | 1946 | Number of tests: 14 08:19:25 INFO - PROCESS | 1946 | 08:19:25 INFO - PROCESS | 1946 | [#0] ai-astar Cycles:10 Average:127.10 Median:118.00 stddev:20.39 (17.3%) stddev-sans-first:21.36 08:19:25 INFO - PROCESS | 1946 | Values: 118.0 123.0 168.0 163.0 116.0 115.0 117.0 116.0 117.0 118.0 08:19:25 INFO - PROCESS | 1946 | 08:19:25 INFO - PROCESS | 1946 | [#1] audio-beat-detection Cycles:10 Average:123.80 Median:127.00 stddev:20.49 (16.1%) stddev-sans-first:21.17 08:19:25 INFO - PROCESS | 1946 | Values: 137.0 127.0 135.0 171.0 111.0 107.0 106.0 108.0 127.0 109.0 08:19:25 INFO - PROCESS | 1946 | 08:19:25 INFO - PROCESS | 1946 | [#2] audio-dft Cycles:10 Average:184.40 Median:185.00 stddev:1.26 (0.7%) stddev-sans-first:1.32 08:19:25 INFO - PROCESS | 1946 | Values: 185.0 185.0 182.0 186.0 184.0 184.0 185.0 186.0 184.0 183.0 08:19:25 INFO - PROCESS | 1946 | 08:19:25 INFO - PROCESS | 1946 | [#3] audio-fft Cycles:10 Average:66.90 Median:61.50 stddev:12.56 (20.4%) stddev-sans-first:11.90 08:19:25 INFO - PROCESS | 1946 | Values: 83.0 59.0 60.0 94.0 59.0 60.0 59.0 63.0 74.0 58.0 08:19:25 INFO - PROCESS | 1946 | 08:19:25 INFO - PROCESS | 1946 | [#4] audio-oscillator Cycles:10 Average:74.90 Median:75.50 stddev:9.79 (13.0%) stddev-sans-first:8.20 08:19:25 INFO - PROCESS | 1946 | Values: 92.0 68.0 87.0 68.0 68.0 65.0 82.0 69.0 68.0 82.0 08:19:25 INFO - PROCESS | 1946 | 08:19:25 INFO - PROCESS | 1946 | [#5] imaging-gaussian-blur Cycles:10 Average:86.10 Median:86.00 stddev:0.74 (0.9%) stddev-sans-first:0.78 08:19:25 INFO - PROCESS | 1946 | Values: 86.0 86.0 88.0 86.0 86.0 85.0 86.0 86.0 86.0 86.0 08:19:25 INFO - PROCESS | 1946 | 08:19:25 INFO - PROCESS | 1946 | [#6] imaging-darkroom Cycles:10 Average:93.20 Median:93.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 08:19:25 INFO - PROCESS | 1946 | Values: 92.0 93.0 94.0 93.0 93.0 93.0 94.0 94.0 93.0 93.0 08:19:25 INFO - PROCESS | 1946 | 08:19:25 INFO - PROCESS | 1946 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.50 stddev:1.16 (1.4%) stddev-sans-first:1.13 08:19:25 INFO - PROCESS | 1946 | Values: 83.0 84.0 85.0 83.0 84.0 85.0 84.0 83.0 86.0 86.0 08:19:25 INFO - PROCESS | 1946 | 08:19:25 INFO - PROCESS | 1946 | [#8] json-parse-financial Cycles:10 Average:61.30 Median:62.00 stddev:1.06 (1.7%) stddev-sans-first:1.09 08:19:25 INFO - PROCESS | 1946 | Values: 62.0 61.0 60.0 59.0 62.0 62.0 61.0 62.0 62.0 62.0 08:19:25 INFO - PROCESS | 1946 | 08:19:25 INFO - PROCESS | 1946 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:59.00 stddev:3.83 (6.5%) stddev-sans-first:3.67 08:19:25 INFO - PROCESS | 1946 | Values: 55.0 59.0 67.0 66.0 60.0 57.0 58.0 59.0 58.0 58.0 08:19:25 INFO - PROCESS | 1946 | 08:19:25 INFO - PROCESS | 1946 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:84.00 stddev:11.88 (14.1%) stddev-sans-first:12.46 08:19:25 INFO - PROCESS | 1946 | Values: 82.0 84.0 84.0 84.0 79.0 83.0 84.0 81.0 89.0 120.0 08:19:25 INFO - PROCESS | 1946 | 08:19:25 INFO - PROCESS | 1946 | [#11] stanford-crypto-ccm Cycles:10 Average:136.70 Median:136.50 stddev:11.49 (8.4%) stddev-sans-first:11.23 08:19:25 INFO - PROCESS | 1946 | Values: 124.0 157.0 147.0 121.0 138.0 132.0 130.0 133.0 150.0 135.0 08:19:25 INFO - PROCESS | 1946 | 08:19:25 INFO - PROCESS | 1946 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.90 Median:164.00 stddev:21.11 (12.9%) stddev-sans-first:21.47 08:19:25 INFO - PROCESS | 1946 | Values: 186.0 221.0 167.0 173.0 158.0 161.0 150.0 151.0 161.0 161.0 08:19:25 INFO - PROCESS | 1946 | 08:19:25 INFO - PROCESS | 1946 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:70.00 stddev:8.02 (11.5%) stddev-sans-first:8.25 08:19:25 INFO - PROCESS | 1946 | Values: 65.0 64.0 63.0 65.0 65.0 65.0 75.0 83.0 81.0 79.0 08:19:25 INFO - PROCESS | 1946 | -------- Summary: end -------- 08:19:25 INFO - PROCESS | 1946 | 08:19:26 INFO - TEST-INFO | 1946: exit 0 08:19:26 INFO - TEST-OK | kraken | took 58791ms 08:19:26 INFO - SUITE-END | took 1177s 08:19:26 INFO - Completed test suite (00:19:37) 08:19:26 INFO - javascript benchmark 08:19:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7861.280609170943, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3484.7734897231676, 3515.595706493754, 3516.630753770854, 3545.8758943436983, 3561.341151886901, 6082.908756368653, 6101.938980610193, 6109.541784366168, 6129.908051379227, 6164.291106522751, 6103.206583144196, 6121.081837724343, 6169.2596888373455, 6184.041473571604, 6187.81436556904, 5463.508284254416, 5495.725213739297, 5528.44715528446, 5544.140658197985, 5632.690202038907, 5420.268263784398, 5425.484578965012, 5435.619506634537, 5599.300087489064, 5613.0, 5477.616566840323, 5501.862453438676, 5506.119020956648, 5518.503334699876, 5541.0580201365665, 5577.135543990667, 5584.972075139639, 5590.468905453975, 5596.692181929992, 5601.187827764992, 5404.351477822686, 5502.477264659851, 5534.308211473566, 5545.112781954908, 5559.305086864142, 5916.142159386908, 5947.9702601486715, 6018.879622407528, 6026.276846778414, 6030.33666296707, 5388.272583201257, 6264.467520260783, 6319.273283572402, 6353.777617783356, 6436.324185960453, 6455.83860403489, 6485.092087107809, 6492.967535162341, 6523.086767852505, 6528.249251336109, 6258.0, 6276.121343011982, 6276.246850377938, 6303.401176888188, 6311.084892690534, 5810.5351571875, 6082.543809214327, 6340.270868850049, 6391.0, 6589.110470086573, 5548.585110796721, 6204.751809927642, 6343.777967771106, 6345.777897773556, 6377.01156320771, 6490.837729056811, 6505.934940650627, 6543.247526534415, 6546.3453654635105, 6552.148220731275, 6263.091851681481, 6359.2368915729485, 6425.293217746044, 6440.549161558646, 6447.903281450782, 6428.067930150102, 6435.967820160963, 6463.256725476536, 6468.06213099098, 6475.740970361133, 5261.631685781958, 5284.3658760948165, 5298.470152984671, 5298.576113910878, 5319.601029922694, 4554.795034223468, 4574.0, 4662.114198302312, 4685.4143232095985, 4715.292706094114, 6057.151998720183, 6083.330833608299, 6177.4749146323065, 6182.938170618237, 6241.625502469867, 6413.518986075969, 6491.642959637171, 6495.545311828221, 6500.739970401226, 6515.674216289167, 6208.410201030895, 6232.0963460298, 6236.563440559117, 6241.75032998684, 6248.593841400295, 5502.80740174092, 5536.280283563111, 5624.29696287964, 5640.210370548127, 5643.943560564424, 6476.352364763486, 6485.416312531895, 6503.739850405931, 6514.4788416925585, 6543.116679248241, 6472.223333200046, 6506.674666266573, 6520.902186467112, 6521.315261897433, 6528.738850445929, 6708.597484150967, 6714.127163468718, 6724.058631791651, 6726.327367263235, 6744.359285867835, 6277.340879207617, 6315.084312774714, 6373.968130159319, 6385.29761726219, 6392.137061496638, 6303.243610766737, 6319.715612797527, 6345.7144428499905, 6458.418742313026, 6479.5788273762055, 5477.808276710296, 6187.195664563578, 6306.148669929501, 6374.808755737336, 6379.87240255183, 6306.0225665022, 6357.205349331333, 6359.7456101755415, 6362.491000719839, 6364.87270254583, 6148.0, 6183.81448556544, 6239.06414037898, 6249.937500624936, 6302.810915672537, 6365.0, 6367.713452894724, 6371.426571608392, 6377.713002914973, 6392.9041064385, 6236.251649802053, 6270.278917924497, 6295.748170073146, 6305.2433707953505, 6316.0], "value": 5971.609728168911, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [787.2285160542668, 795.5266616363264, 822.5270469480049, 911.6080085563206, 912.3294378631705, 25931.0, 42027.579724202784, 42418.0, 42572.787136064275, 42773.78613106938, 43402.0, 43762.12475750483, 43903.78048109755, 44000.77999609998, 44013.11973760531, 8064.395170362217, 9731.51342432879, 9892.35699679522, 9914.851277230848, 9916.801663966717, 8072.071711753136, 11789.528418863278, 11969.341686207255, 12304.077194210426, 12311.692207694834, 12023.819642705366, 12057.0, 12075.275483470976, 12081.637550873487, 12093.455794489226, 11998.100142489304, 12027.819582706266, 12030.27818330903, 12035.93982030093, 12059.457324420422, 11710.414479276002, 11751.118666100077, 11784.764304713943, 11789.58736444229, 11790.35153066581, 41166.0, 41188.97027574305, 41199.7940010301, 41308.173836523405, 41413.1717365651, 3972.6623237024887, 3991.6806655467494, 3995.260876737813, 4022.0, 4024.2957482440747, 29626.407471850656, 29940.850295748598, 30100.548491772643, 30258.243543911358, 30373.848130759427, 3174.3175217328385, 3206.4709322961685, 3259.4947783093658, 3260.7065364117107, 3276.6887145721357, 380240.0, 381702.09148954356, 382028.0, 382988.0, 383505.0, 46338.5366146341, 46387.536124638995, 46407.53592464099, 46464.07071858544, 46485.0, 47986.760066199444, 48053.03893922102, 48094.797630059526, 48100.0, 48111.0, 14593.343299551545, 14700.55898323052, 14720.411183552753, 14736.778948315783, 14742.852571474148, 10931.617393391192, 11111.499982500807, 12606.747865042647, 12627.0, 12639.0, 10802.541656876378, 12069.879301206876, 12197.560487902456, 12317.815232771516, 12489.313087780078, 4893.608511319086, 4904.901901961941, 5075.5178258065425, 5516.758729285959, 5622.943770562324, 1109.7835921995134, 1143.2683082826998, 1157.1552766480515, 1166.8891455311732, 1219.3049961522024, 25828.225153245432, 28048.158555243375, 28362.149135525968, 28381.0, 28541.143765687062, 1266.7593157300084, 1278.5844600504872, 1284.8907842833464, 1328.6412668579624, 1334.7463981843418, 14552.981291309507, 14628.756555692886, 14643.56069317922, 14655.0, 14741.92629036848, 482198.0, 485129.0, 485258.0, 485596.0, 486979.0, 59256.814863702486, 59450.70274648599, 59610.70194648999, 59653.70173149106, 59818.0, 1322.715616142534, 1461.7441947659117, 1478.0466599043557, 1547.0794877048138, 1547.1954583616457, 23625.763742363044, 25587.744122558535, 26202.213933582025, 26964.46071078607, 28676.13971580856, 37610.43584346292, 37808.62191378051, 37809.0, 37852.81073594725, 37898.810505947295, 423380.0, 425638.0, 426073.0, 427742.86128569156, 428600.0, 29963.850180748956, 31053.068407947798, 31066.53400199044, 31075.844620776752, 31133.8443307782, 29551.85224073866, 30533.23666908345, 31571.0, 37266.0, 38877.61122388853, 27097.72902270952, 27367.72632273652, 27825.16524504268, 28620.713792862636, 28649.427011459236, 23248.883755581115, 27039.188824335302, 27729.306767330978, 28715.0, 28805.711942881142, 31380.0, 31576.684233157375, 32445.51331729979, 32578.185545361557, 32808.0, 26891.462170756084, 27394.315142121606, 28316.716832831407, 28466.857665711537, 28823.0, 22642.547149057256, 22737.31788046361, 23065.769342307034, 23139.652905206098, 23185.884070579537], "value": 18781.045920690147, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.47857438914156, 434.5567521128447, 441.5054258177886, 442.52428639212843, 450.9255972764496, 19844.801551984478, 21285.57428851422, 22284.108635654553, 22305.44236394091, 22445.32664020078, 22670.88664556679, 23254.65118023231, 23514.177003804827, 23999.920003599836, 24250.0, 6143.508519318444, 6797.898031529531, 6893.931060689379, 7083.85832283354, 7184.353408193261, 6933.237343892168, 7009.018737376771, 7013.719451221945, 7027.789166325018, 7032.718691252369, 6661.966690166542, 6895.448364130857, 6980.511364204508, 6982.2668619794695, 7031.1211098612675, 6738.932610673928, 6934.618595977219, 7011.859762804741, 7026.473014523931, 7085.504014718972, 6932.480063995221, 6985.720571177147, 6991.7902462926195, 6993.615351155684, 6997.300269972962, 22020.33938981833, 27429.588556171675, 27611.0, 27681.446371072467, 27947.86026069877, 3014.125903487986, 3077.707617776308, 3096.6748491408302, 3106.3476669899346, 3147.323325485009, 16720.498385048468, 17020.319187232497, 17518.474445766646, 18083.18625661835, 18214.27142914295, 2060.917563297466, 2074.512489564951, 2092.5082605587677, 2112.704221409004, 2188.8686678799163, 142359.28820355833, 142594.0, 142815.0, 143328.0, 143900.0, 21664.675029874565, 22393.544419612674, 22425.775742242695, 22555.323340299816, 22638.886805565868, 36439.0, 36502.08744781402, 37315.0, 37343.4398484023, 37349.626503735155, 11262.943685281522, 11495.195336326544, 11714.589989350332, 11721.941390293165, 11915.642530724092, 9404.24766018717, 9426.340156189139, 9494.572744226527, 9547.713568592953, 9599.040095990485, 8642.827143457222, 9055.909440905638, 10517.947410263052, 10814.29707069038, 11027.724306892393, 3103.658597554267, 3283.6387997320276, 3583.7133029357587, 4186.413902053715, 4227.915441691149, 1111.4053981120062, 1132.9660110196708, 1142.2917790969652, 1156.7744289863397, 1178.3754610056512, 23590.29229123129, 23591.0, 23611.52776944486, 23656.29031129069, 23940.640890386658, 1157.5022740221616, 1162.354893034374, 1176.723469984553, 1203.1157099531838, 1208.3656080557778, 12470.376481175905, 12527.498900044078, 12586.559470418675, 12843.550475733304, 12845.935770321088, 739702.0, 752755.0, 779319.5170120678, 816706.0, 817183.0, 136970.0, 137742.5564360899, 171954.28045719632, 174319.0, 175785.0, 1296.8378952630922, 1297.5912587534897, 1356.6065840906026, 1357.511295933463, 1361.8910487161004, 20733.89633051825, 20842.062107205515, 21245.78754212438, 21499.785002150405, 21582.676259856427, 62212.37787622247, 62582.68708656428, 63543.0, 66947.0, 66977.33022669711, 87617.0, 87808.68286975828, 87906.0, 89795.0, 90337.0, 11896.107791915814, 12011.879881201075, 12077.879221207675, 12324.212989116708, 12329.938350308192, 13490.460381584626, 13520.526781562598, 13901.23543205093, 13925.442982281, 13929.860701392856, 11533.480993355151, 11538.0, 11890.76218475643, 11985.161038727554, 12050.939745301217, 10762.3542587445, 10803.891961080602, 10809.45952702346, 11023.0, 11222.607208747655, 10551.577936882746, 10704.30422022566, 11617.244879082833, 11877.406129693309, 12072.275663460221, 9778.313709271491, 11970.940145299217, 12115.878841211475, 12250.632481025226, 12289.1397602167, 11378.772424551627, 11683.649490515298, 11826.231294965799, 11905.583304584297, 11958.342291174069], "value": 12234.153472655393, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1603.823579406265, 1630.3478608556568, 1650.8844380893336, 1653.140367009155, 1663.4593757028965, 10823.78352432952, 11600.941995290033, 11608.94195529021, 11617.361045142514, 11639.301641901491, 10952.561897524109, 11310.434478276095, 11560.6531804046, 11569.074474042078, 11583.884161158387, 2472.5796614575565, 2514.5222407742563, 2519.6598459207958, 2527.0397249045336, 2530.3547595363248, 2164.3723320237114, 2185.7814218578173, 2200.0539767899795, 2217.3569664797187, 2435.512897420523, 2373.0507796881298, 2445.1808644104244, 2445.4986727720775, 2474.443250268693, 2474.492728990562, 2389.056322752503, 2457.594496908008, 2462.926112216627, 2467.962980555284, 2471.0733474946896, 1827.7349784281337, 2439.9390015249583, 2465.9753402465926, 2472.0359059966627, 2512.9371765706005, 11255.887441125566, 11467.19729618927, 11475.59835405765, 11477.0, 11482.942585287105, 5860.70696465175, 6042.758289668408, 6051.939480605181, 6053.51571874249, 6060.757569697207, 3428.3486137634018, 3461.9826900865587, 3520.049586611626, 3674.3569875271987, 3764.5858955514873, 1189.143816452153, 1216.9087318451152, 1236.486857953948, 1255.5417272695493, 1287.9484820607165, 14156.858431415658, 14510.782338264935, 14903.70192596142, 15963.281652325673, 16195.83804161955, 4179.874603761892, 4293.613574778285, 4332.241857674894, 4440.977795111004, 4441.0, 11942.641720748392, 11978.161528693083, 11982.16124871268, 11993.880061199276, 12007.859253370916, 5913.408659134138, 5913.70431478433, 5920.467157955804, 5932.495737862244, 5935.169076329317, 5204.34945631796, 5331.333583302087, 5368.892622147613, 5442.91835622466, 5471.753771080311, 3860.729748917549, 3934.960650393459, 3964.2467931093, 4002.7398219115667, 4004.1791432756213, 1030.701096681954, 1032.9018743219383, 1046.7592453735683, 1050.1965996013057, 1050.3277902142636, 951.2247518272586, 957.4877440569401, 969.8448248280241, 980.8038392321564, 991.4137380191636, 6573.934260657428, 6609.405153536205, 6630.734770609218, 6667.099941507834, 6795.116634837538, 948.5589201021559, 960.4669408478222, 963.5567638886191, 1009.4649835587151, 1050.7478205230689, 3082.5838511801066, 4071.145059537471, 4136.896577585584, 4294.742315461082, 4401.053773438726, 13650.795238071238, 14361.138331700131, 14368.425262989573, 14387.136771793517, 14410.783838242434, 14272.714545709028, 14287.85712142886, 14316.642083947985, 14318.355673994694, 14362.210078445785, 8962.32782541312, 9257.935337436147, 10135.087842094246, 10339.0, 10666.040056394962, 6096.177016102769, 6693.330666933462, 6866.793996180123, 6981.02265682815, 6988.196357418962, 12274.38628068575, 12495.750084998432, 12506.249625022529, 12595.811062833882, 12651.430685618985, 12880.742385152056, 12994.415251313525, 13043.934780326037, 13115.540956066492, 13147.802782958071, 8214.05538363096, 8488.448250863674, 8508.74473765788, 8509.787255318419, 8542.932133483315, 10434.68695939123, 10442.53008614599, 10560.207984401048, 10565.418901960466, 10579.0, 8974.82050358976, 8997.32520060985, 9000.59497322635, 9040.231580315747, 9082.54587270647, 8655.48067115975, 8733.388662793543, 8814.250788683034, 8828.0, 8877.11228877133, 7755.340796032175, 7924.0, 8060.274575288252, 8186.222308880647, 8188.5905704715715, 5893.823185304448, 5928.525717942641, 5949.0, 6079.240094988127, 6175.814725558241, 5936.762529498772, 6117.724702388492, 6161.753529858755, 6174.969125154345, 6229.781957631461], "value": 5205.17531365223, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.9267561136549, 352.68434750897944, 385.12768579168187, 404.437831414334, 405.0501573809416, 4787.090452813967, 4851.908320627861, 4996.350474438327, 5191.896162076766, 5262.815801446945, 4250.321123156351, 4778.4743678195455, 4863.683860549062, 4988.376452943382, 5128.8974220515565, 4127.855525056616, 4449.132419178261, 4457.910841783162, 4464.3303504474425, 4504.301833215857, 3534.32847758925, 3783.772973621578, 3911.4915061042166, 4130.710850240484, 4380.2115619188535, 3318.402687516258, 4095.9385609215888, 4216.451861258048, 4307.827686892536, 4320.395144679747, 4219.814040399509, 4221.746695198282, 4253.893652658678, 4263.358606936321, 4298.118885628439, 3951.8024098794945, 4003.459532963071, 4003.8598649047435, 4004.4994375703036, 4035.7982100894837, 4714.929276060861, 4969.478204788517, 5002.59979201663, 5022.472640372781, 5125.846224613268, 4149.398337241083, 4225.3873188387815, 4499.910001799978, 4756.595689366408, 4822.493638167977, 4673.322368256618, 5038.571721403685, 5344.358676958751, 5421.0755181910645, 5445.786985678429, 3807.60020197878, 3835.884923452273, 4074.8623559858743, 4365.257906155929, 4399.538048504893, 5608.139848677204, 5609.1305847593685, 5631.5776316776, 5658.603897727202, 5666.943330566683, 4017.794661601508, 4445.177642136216, 4457.420535330386, 4519.864404067883, 4534.9319760203625, 3679.8344074516713, 4285.0, 4545.9089818443335, 4576.313552967082, 4608.124456353282, 3958.5645578986287, 4475.9705267788595, 4511.774411279423, 4891.584215341736, 4945.752712364368, 5441.673499590037, 5443.700596467153, 5489.3687225969525, 5495.763453222993, 5544.1960915667005, 1329.3419757220045, 1411.7153390414674, 1446.0045137709892, 1456.1117718191895, 1479.993604349053, 1053.9631112911165, 1087.2497976396262, 1139.897409233173, 1168.363242033094, 1178.7701398227264, 4103.9179216415505, 4406.518850108442, 4879.268109783561, 5119.564836988823, 5230.0, 5285.0, 5369.946300537023, 5630.85922851932, 5672.716364181774, 5695.971520142372, 4458.06380660065, 4855.830045948445, 5177.534021938043, 5218.530332270114, 5280.313559237275, 2724.196362073193, 2874.5688146777734, 2911.583385789789, 2914.7791690182044, 2923.5614657801075, 4638.1883170445035, 5555.527780138653, 5620.269364982526, 5802.0, 5849.923277236605, 4437.844675436344, 4892.681975671641, 5207.869803254949, 5413.861524697722, 5795.362510123883, 4919.606431485473, 5072.170511264046, 5431.491861754813, 5798.652080875161, 5820.563457740602, 5212.9834682238115, 5473.397926228191, 5668.461496157858, 5679.346875109415, 5738.885222295614, 4670.953290467188, 4877.317175595348, 5455.672659640434, 5560.832225232746, 5589.664620122806, 5757.366689664217, 5818.970905145447, 5821.621594596338, 5848.122781582797, 5849.356570777126, 4007.859724909614, 4165.770882601365, 4193.22425351311, 4245.0, 4582.747948862844, 4552.203364411149, 4798.296604705419, 5120.974395128001, 5500.367457742411, 5577.0, 4674.0, 4956.553910148104, 4969.726665033313, 5434.592405569519, 5440.591955603267, 5171.095058364695, 5187.4553171916405, 5333.626646134733, 5451.945480545144, 5550.5282051026115, 4714.3399924011355, 4961.11477638495, 5337.329836393156, 5356.3572371315695, 5369.4630536946, 4851.805927762991, 5128.512731307879, 5147.40804807437, 5233.738313084406, 5345.1982202669915, 4185.162967406592, 4417.602415782595, 5110.7734143805965, 5296.867578310573, 5368.543673787772], "value": 4140.972909003117, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [796.661418896969, 813.3046245460131, 841.5245386356712, 891.1355984694846, 901.4320977783996, 15781.526554203378, 17534.73697894531, 17566.385176518823, 17587.0, 17589.384371547, 15451.768223476656, 15850.128242946634, 15867.444639437623, 15919.92040039801, 16129.677406451863, 1001.2190491416707, 1037.3827572594294, 1040.2562168049842, 1041.4272150317333, 1041.8385150301679, 1022.9283950123495, 1028.3521381529663, 1031.520343040486, 1031.690492852145, 1033.4006276359694, 1046.2414749306768, 1068.1294744782977, 1068.6687126990619, 1069.107295408335, 1091.7270682329417, 1080.4813689429118, 1080.5407701726735, 1081.070279559582, 1081.729567608098, 1083.0523292119397, 788.9171636978092, 789.388224126301, 790.1348023913805, 792.065362871811, 792.9008873890764, 17064.402745903833, 17187.570310742332, 17217.311307547683, 18114.365997190165, 18409.0, 14438.0, 14812.925935370255, 14891.0, 14944.103353798699, 15110.471133510275, 10239.283250172492, 12036.759264814655, 12050.337231452266, 12181.573644922386, 12371.505139794488, 3363.7477189210663, 3775.830087646035, 3797.0, 3799.354109801313, 4038.434619153321, 112916.0, 114154.42922785415, 114989.4250528742, 116811.0, 117254.0, 11191.552337906392, 11561.826572601418, 11596.362200078907, 11676.47455864488, 11849.703757405961, 23745.693986830545, 23756.287311380685, 23763.643545346833, 23772.930218140224, 23810.523789524457, 7797.571133587707, 7822.726204582926, 8034.718784842503, 8365.498070115813, 8384.496930184208, 4519.502854685982, 4672.486026537078, 4681.882952926204, 4738.928916066262, 4759.262314341283, 3665.9266814663556, 3692.649198326155, 3750.1937083527173, 3782.451544526083, 3789.5073640426567, 668.7525615522288, 669.4945316286173, 675.746595026865, 682.7883356159606, 689.4484412470003, 674.1606699658956, 680.8519122169563, 701.242657929435, 705.7741522712786, 734.2281945605716, 10706.839397409045, 10822.78354432907, 10874.891251087545, 10932.0, 11172.385518796382, 676.1716896801478, 698.860227954401, 703.2967032967033, 724.7825652304288, 733.7872017114977, 5123.487651234921, 5206.193040078794, 5210.713410762369, 5234.26720259164, 5239.449857764956, 85730.0, 88160.55919720489, 109862.35206471909, 111320.0, 113088.0, 49435.75282123566, 63770.36229637737, 74133.0, 81350.77973830397, 97841.0, 60010.79978400495, 63048.68475657684, 75563.0, 76040.61979690177, 79242.60378698069, 8572.571371431528, 9675.903240967782, 10779.89220107789, 11207.887921120684, 11495.425228738362, 45055.54944450514, 48275.0, 48301.0, 49673.75815604639, 50174.22996355466, 56309.71845140748, 57886.0, 67064.0, 68958.65520672566, 71510.56978860497, 13346.13250138738, 13603.863961360656, 13721.794173087612, 13992.720145597235, 14155.079919805179, 15884.92057539705, 15921.522354329389, 16002.599935001717, 16173.272202751139, 16449.25978331002, 14353.0, 14504.854951450772, 14706.926465367605, 14737.778933316224, 14983.925080374529, 13977.440902364198, 14068.577942661737, 14866.628334291729, 15187.240637967836, 15235.466758663393, 13572.524961626295, 13928.50583043347, 14497.347619357366, 14500.637484062983, 14999.2500374983, 10187.847182292124, 10619.30974486656, 10622.415767132881, 10767.946160269148, 10794.73013174677, 9327.673531426639, 10262.332948358333, 11347.262427942158, 11729.765404691687, 11760.529578817093], "value": 7979.842507773674, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1424.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 123.0, 168.0, 163.0, 116.0, 115.0, 117.0, 116.0, 117.0, 118.0], "value": 127.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 127.0, 135.0, 171.0, 111.0, 107.0, 106.0, 108.0, 127.0, 109.0], "value": 123.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 182.0, 186.0, 184.0, 184.0, 185.0, 186.0, 184.0, 183.0], "value": 184.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 60.0, 94.0, 59.0, 60.0, 59.0, 63.0, 74.0, 58.0], "value": 66.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 68.0, 87.0, 68.0, 68.0, 65.0, 82.0, 69.0, 68.0, 82.0], "value": 74.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 88.0, 86.0, 86.0, 85.0, 86.0, 86.0, 86.0, 86.0], "value": 86.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 94.0, 93.0, 93.0, 93.0, 94.0, 94.0, 93.0, 93.0], "value": 93.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 85.0, 83.0, 84.0, 85.0, 84.0, 83.0, 86.0, 86.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 60.0, 59.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0], "value": 61.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 59.0, 67.0, 66.0, 60.0, 57.0, 58.0, 59.0, 58.0, 58.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 84.0, 84.0, 79.0, 83.0, 84.0, 81.0, 89.0, 120.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 157.0, 147.0, 121.0, 138.0, 132.0, 130.0, 133.0, 150.0, 135.0], "value": 136.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 221.0, 167.0, 173.0, 158.0, 161.0, 150.0, 151.0, 161.0, 161.0], "value": 168.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 63.0, 65.0, 65.0, 65.0, 75.0, 83.0, 81.0, 79.0], "value": 70.5, "unit": "score"}]}]} 08:19:26 INFO - Return code: 0 08:19:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:19:26 INFO - # TBPL SUCCESS # 08:19:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:19:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:19:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:19:26 INFO - 2017-05-30 08:19:26.874 screenresolution[1950:23302] starting screenresolution argv=screenresolution get 08:19:26 INFO - 2017-05-30 08:19:26.877 screenresolution[1950:23302] Display 0: 1600x1200x32@60 08:19:26 INFO - 2017-05-30 08:19:26.883 screenresolution[1951:23305] starting screenresolution argv=screenresolution list 08:19:26 INFO - Available Modes on Display 0 08:19:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:19:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:19:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:19:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:19:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:19:27 INFO - Intel Iris: 08:19:27 INFO - Chipset Model: Intel Iris 08:19:27 INFO - Type: GPU 08:19:27 INFO - Bus: Built-In 08:19:27 INFO - VRAM (Dynamic, Max): 1536 MB 08:19:27 INFO - Vendor: Intel (0x8086) 08:19:27 INFO - Device ID: 0x0a2e 08:19:27 INFO - Revision ID: 0x0009 08:19:27 INFO - Displays: 08:19:27 INFO - Display: 08:19:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:19:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:19:27 INFO - Display Serial Number: 1600x1200 60 08:19:27 INFO - Main Display: Yes 08:19:27 INFO - Mirror: Off 08:19:27 INFO - Online: Yes 08:19:27 INFO - Rotation: Supported 08:19:27 INFO - Return code: 0 08:19:27 INFO - Running post-action listener: _resource_record_post_action 08:19:27 INFO - [mozharness: 2017-05-30 15:19:27.119644Z] Finished run-tests step (success) 08:19:27 INFO - Running post-run listener: _resource_record_post_run 08:19:27 INFO - Total resource usage - Wall time: 1192s; CPU: 54.0%; Read bytes: 974848; Write bytes: 425631744; Read time: 17; Write time: 1403 08:19:27 INFO - TinderboxPrint: CPU usage
53.7% 08:19:27 INFO - TinderboxPrint: I/O read bytes / time
974,848 / 17 08:19:27 INFO - TinderboxPrint: I/O write bytes / time
425,631,744 / 1,403 08:19:27 INFO - TinderboxPrint: CPU idle
2,206.5 (46.3%) 08:19:27 INFO - TinderboxPrint: CPU system
948.4 (19.9%) 08:19:27 INFO - TinderboxPrint: CPU user
1,614.7 (33.9%) 08:19:27 INFO - TinderboxPrint: Swap in / out
122,564,608 / 0 08:19:27 INFO - install - Wall time: 15s; CPU: 53.0%; Read bytes: 113764864; Write bytes: 113180672; Read time: 10016; Write time: 246 08:19:27 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 974848; Write bytes: 302522368; Read time: 17; Write time: 1126 08:19:27 INFO - Running post-run listener: _upload_blobber_files 08:19:27 INFO - Blob upload gear active. 08:19:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:19:27 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 08:19:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:19:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:19:28 INFO - (blobuploader) - INFO - Open directory for files ... 08:19:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:19:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:19:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:19:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:19:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:19:29 INFO - (blobuploader) - INFO - Done attempting. 08:19:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:19:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:19:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:19:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:19:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:19:29 INFO - (blobuploader) - INFO - Done attempting. 08:19:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:19:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:19:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:19:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:19:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:19:30 INFO - (blobuploader) - INFO - Done attempting. 08:19:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:19:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:19:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:19:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:19:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:19:32 INFO - (blobuploader) - INFO - Done attempting. 08:19:32 INFO - (blobuploader) - INFO - Iteration through files over. 08:19:32 INFO - Return code: 0 08:19:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:19:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:19:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/47d7781bad4b6eab390625b326c3627f854e9e27a86a904878f3f2663706180519685808118734bcf2d583417aa9784238143af14c40b948588c533a4d43134d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d427c92738ea7d56a090e59b619ac0dae32219378ebba5f84054889d8807a52aa7c087774576be979757d20f922414ab50152bf05e6af8de29a8fdc68ace4dd4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/641ddad9f609bb804c498d2244fa03a7df7adc4d90310171ac5761cf5101d094bd8d90a1dea76a81d5b1d30d6fe8b025ea7061ca14b1c6264f1a963bda4ff792", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5c106d578c2c4f16470d8e8f52d00b079243d59cef1f78485c3781b7ed11cef7301f89a047e48b76444dad99b025a6169050fdafe723db2feba0fd64b72dbedf"} 08:19:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:19:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:19:32 INFO - Contents: 08:19:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/47d7781bad4b6eab390625b326c3627f854e9e27a86a904878f3f2663706180519685808118734bcf2d583417aa9784238143af14c40b948588c533a4d43134d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d427c92738ea7d56a090e59b619ac0dae32219378ebba5f84054889d8807a52aa7c087774576be979757d20f922414ab50152bf05e6af8de29a8fdc68ace4dd4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/641ddad9f609bb804c498d2244fa03a7df7adc4d90310171ac5761cf5101d094bd8d90a1dea76a81d5b1d30d6fe8b025ea7061ca14b1c6264f1a963bda4ff792", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5c106d578c2c4f16470d8e8f52d00b079243d59cef1f78485c3781b7ed11cef7301f89a047e48b76444dad99b025a6169050fdafe723db2feba0fd64b72dbedf"} 08:19:32 INFO - Running post-run listener: copy_logs_to_upload_dir 08:19:32 INFO - Copying logs to upload dir... 08:19:32 INFO - mkdir: /builds/slave/test/build/upload/logs 08:19:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.004988 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-05-30 08:19:32.782789) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 08:19:32.786186) ========= 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.rAvih0dTFV/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.54qLvLEGma/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/47d7781bad4b6eab390625b326c3627f854e9e27a86a904878f3f2663706180519685808118734bcf2d583417aa9784238143af14c40b948588c533a4d43134d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d427c92738ea7d56a090e59b619ac0dae32219378ebba5f84054889d8807a52aa7c087774576be979757d20f922414ab50152bf05e6af8de29a8fdc68ace4dd4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/641ddad9f609bb804c498d2244fa03a7df7adc4d90310171ac5761cf5101d094bd8d90a1dea76a81d5b1d30d6fe8b025ea7061ca14b1c6264f1a963bda4ff792", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5c106d578c2c4f16470d8e8f52d00b079243d59cef1f78485c3781b7ed11cef7301f89a047e48b76444dad99b025a6169050fdafe723db2feba0fd64b72dbedf"} build_url:https://queue.taskcluster.net/v1/task/ERxogNTaS5WkiMpYexpBOQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011245 build_url: 'https://queue.taskcluster.net/v1/task/ERxogNTaS5WkiMpYexpBOQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/47d7781bad4b6eab390625b326c3627f854e9e27a86a904878f3f2663706180519685808118734bcf2d583417aa9784238143af14c40b948588c533a4d43134d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d427c92738ea7d56a090e59b619ac0dae32219378ebba5f84054889d8807a52aa7c087774576be979757d20f922414ab50152bf05e6af8de29a8fdc68ace4dd4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/641ddad9f609bb804c498d2244fa03a7df7adc4d90310171ac5761cf5101d094bd8d90a1dea76a81d5b1d30d6fe8b025ea7061ca14b1c6264f1a963bda4ff792", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5c106d578c2c4f16470d8e8f52d00b079243d59cef1f78485c3781b7ed11cef7301f89a047e48b76444dad99b025a6169050fdafe723db2feba0fd64b72dbedf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 08:19:32.819450) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 08:19:32.819796) ========= 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.rAvih0dTFV/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.54qLvLEGma/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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.005267 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 08:19:32.868701) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 08:19:32.869024) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 08:19:32.869410) ========= ========= Total master_lag: 0.26 =========