builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0205 starttime: 1496430721.36 results: success (0) buildid: 20170602110524 builduid: bad66c59b15140e897dc1eeb3d166c38 revision: d47466614ea1ea1a4d9c64ff943a0a3670291529 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-02 12:12:01.361724) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-02 12:12:01.362224) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-02 12:12:01.362501) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-02 12:12:01.386649) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 12:12:01.387024) ========= 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.uE6EYE5xZY/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.1oVA3QrX6O/Listeners TMPDIR=/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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-06-02 12:12:01-- 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.17M=0.001s 2017-06-02 12:12:01 (8.17 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131363 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 12:12:01.540633) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 12:12:01.540959) ========= 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.uE6EYE5xZY/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.1oVA3QrX6O/Listeners TMPDIR=/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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.025004 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 12:12:01.589478) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-02 12:12:01.589835) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d47466614ea1ea1a4d9c64ff943a0a3670291529 --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 d47466614ea1ea1a4d9c64ff943a0a3670291529 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uE6EYE5xZY/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.1oVA3QrX6O/Listeners TMPDIR=/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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-06-02 12:12:01,672 truncating revision to first 12 chars 2017-06-02 12:12:01,672 Setting DEBUG logging. 2017-06-02 12:12:01,672 attempt 1/10 2017-06-02 12:12:01,672 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d47466614ea1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-02 12:12:02,392 unpacking tar archive at: mozilla-beta-d47466614ea1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.981518 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-02 12:12:02.594494) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-02 12:12:02.594910) ========= script_repo_revision: d47466614ea1ea1a4d9c64ff943a0a3670291529 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-02 12:12:02.595508) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-02 12:12:02.595802) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-02 12:12:02.614780) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-06-02 12:12:02.615154) ========= /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.uE6EYE5xZY/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.1oVA3QrX6O/Listeners TMPDIR=/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 12:12:02 INFO - MultiFileLogger online at 20170602 12:12:02 in /builds/slave/test 12:12:02 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 12:12:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:12:02 INFO - {'append_to_log': False, 12:12:02 INFO - 'base_work_dir': '/builds/slave/test', 12:12:02 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:12:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:12:02 INFO - 'branch': 'Mozilla-Beta', 12:12:02 INFO - 'buildbot_json_path': 'buildprops.json', 12:12:02 INFO - 'config_files': ('talos/mac_config.py',), 12:12:02 INFO - 'default_actions': ('clobber', 12:12:02 INFO - 'read-buildbot-config', 12:12:02 INFO - 'download-and-extract', 12:12:02 INFO - 'populate-webroot', 12:12:02 INFO - 'create-virtualenv', 12:12:02 INFO - 'install', 12:12:02 INFO - 'run-tests'), 12:12:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:12:02 INFO - 'download_minidump_stackwalk': True, 12:12:02 INFO - 'download_symbols': 'ondemand', 12:12:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:12:02 INFO - 'tooltool.py': '/tools/tooltool.py', 12:12:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:12:02 INFO - '/tools/misc-python/virtualenv.py')}, 12:12:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:12:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:12:02 INFO - 'gecko_profile': False, 12:12:02 INFO - 'gecko_profile_interval': 0, 12:12:02 INFO - 'installer_path': 'installer.exe', 12:12:02 INFO - 'log_level': 'info', 12:12:02 INFO - 'log_name': 'talos', 12:12:02 INFO - 'log_to_console': True, 12:12:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:12:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:12:02 INFO - 'opt_config_files': (), 12:12:02 INFO - 'pip_index': False, 12:12:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:12:02 INFO - 'cmd': ('bash', 12:12:02 INFO - '-c', 12:12:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:12:02 INFO - 'enabled': True, 12:12:02 INFO - 'halt_on_failure': False, 12:12:02 INFO - 'name': 'check_screen_resolution'},), 12:12:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:12:02 INFO - 'cmd': ('bash', 12:12:02 INFO - '-c', 12:12:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:12:02 INFO - 'enabled': True, 12:12:02 INFO - 'halt_on_failure': False, 12:12:02 INFO - 'name': 'check_screen_resolution'},), 12:12:02 INFO - 'run_cmd_checks_enabled': True, 12:12:02 INFO - 'suite': 'dromaeojs', 12:12:02 INFO - 'system_bits': '32', 12:12:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:12:02 INFO - 'title': 't-yosemite-r7-0205', 12:12:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:12:02 INFO - 'use_talos_json': True, 12:12:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:12:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:12:02 INFO - 'work_dir': 'build'} 12:12:02 INFO - [mozharness: 2017-06-02 19:12:02.808509Z] Running clobber step. 12:12:02 INFO - Running pre-action listener: _resource_record_pre_action 12:12:02 INFO - Running main action method: clobber 12:12:02 INFO - rmtree: /builds/slave/test/build 12:12:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:12:04 INFO - Running post-action listener: _resource_record_post_action 12:12:04 INFO - [mozharness: 2017-06-02 19:12:04.739500Z] Finished clobber step (success) 12:12:04 INFO - [mozharness: 2017-06-02 19:12:04.739651Z] Running read-buildbot-config step. 12:12:04 INFO - Running pre-action listener: _resource_record_pre_action 12:12:04 INFO - Running main action method: read_buildbot_config 12:12:04 INFO - Using buildbot properties: 12:12:04 INFO - { 12:12:04 INFO - "project": "", 12:12:04 INFO - "product": "firefox", 12:12:04 INFO - "script_repo_revision": "production", 12:12:04 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 12:12:04 INFO - "repository": "", 12:12:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 12:12:04 INFO - "buildid": "20170602110524", 12:12:04 INFO - "pgo_build": "False", 12:12:04 INFO - "basedir": "/builds/slave/test", 12:12:04 INFO - "buildnumber": 16, 12:12:04 INFO - "slavename": "t-yosemite-r7-0205", 12:12:04 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 12:12:04 INFO - "platform": "yosemite_r7", 12:12:04 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 12:12:04 INFO - "branch": "mozilla-beta", 12:12:04 INFO - "repo_path": "releases/mozilla-beta", 12:12:04 INFO - "revision": "d47466614ea1ea1a4d9c64ff943a0a3670291529", 12:12:04 INFO - "stage_platform": "macosx64", 12:12:04 INFO - "builduid": "bad66c59b15140e897dc1eeb3d166c38", 12:12:04 INFO - "slavebuilddir": "test" 12:12:04 INFO - } 12:12:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/dHAitqXaRFmLcd6K40FYHw/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 12:12:04 INFO - Running post-action listener: _resource_record_post_action 12:12:04 INFO - [mozharness: 2017-06-02 19:12:04.742919Z] Finished read-buildbot-config step (success) 12:12:04 INFO - [mozharness: 2017-06-02 19:12:04.743050Z] Running download-and-extract step. 12:12:04 INFO - Running pre-action listener: _resource_record_pre_action 12:12:04 INFO - Running main action method: download_and_extract 12:12:04 INFO - mkdir: /builds/slave/test/build/tests 12:12:04 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')]} 12:12:04 INFO - trying https://queue.taskcluster.net/v1/task/dHAitqXaRFmLcd6K40FYHw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 12:12:04 INFO - Downloading https://queue.taskcluster.net/v1/task/dHAitqXaRFmLcd6K40FYHw/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 12:12:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dHAitqXaRFmLcd6K40FYHw/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 12:12:06 INFO - Downloaded 1287 bytes. 12:12:06 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 12:12:06 INFO - Using the following test package requirements: 12:12:06 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 12:12:06 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 12:12:06 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 12:12:06 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 12:12:06 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 12:12:06 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 12:12:06 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 12:12:06 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 12:12:06 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 12:12:06 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 12:12:06 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 12:12:06 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 12:12:06 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 12:12:06 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 12:12:06 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 12:12:06 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 12:12:06 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 12:12:06 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 12:12:06 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 12:12:06 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 12:12:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dHAitqXaRFmLcd6K40FYHw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 12:12:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dHAitqXaRFmLcd6K40FYHw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 12:12:06 INFO - Fetch https://queue.taskcluster.net/v1/task/dHAitqXaRFmLcd6K40FYHw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 12:12:07 INFO - Expected file size: 51396308 12:12:07 INFO - Obtained file size: 51396308 12:12:23 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 12:12:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dHAitqXaRFmLcd6K40FYHw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 12:12:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dHAitqXaRFmLcd6K40FYHw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 12:12:23 INFO - Fetch https://queue.taskcluster.net/v1/task/dHAitqXaRFmLcd6K40FYHw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 12:12:25 INFO - Expected file size: 51396308 12:12:25 INFO - Obtained file size: 51396308 12:12:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dHAitqXaRFmLcd6K40FYHw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 12:12:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dHAitqXaRFmLcd6K40FYHw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 12:12:40 INFO - Fetch https://queue.taskcluster.net/v1/task/dHAitqXaRFmLcd6K40FYHw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 12:12:41 INFO - Expected file size: 14404461 12:12:41 INFO - Obtained file size: 14404461 12:12:42 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')]} 12:12:42 INFO - trying https://queue.taskcluster.net/v1/task/dHAitqXaRFmLcd6K40FYHw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 12:12:42 INFO - Downloading https://queue.taskcluster.net/v1/task/dHAitqXaRFmLcd6K40FYHw/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 12:12:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dHAitqXaRFmLcd6K40FYHw/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 12:12:44 INFO - Downloaded 59646691 bytes. 12:12:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dHAitqXaRFmLcd6K40FYHw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 12:12:44 INFO - mkdir: /builds/slave/test/properties 12:12:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:12:44 INFO - Writing to file /builds/slave/test/properties/build_url 12:12:44 INFO - Contents: 12:12:44 INFO - build_url:https://queue.taskcluster.net/v1/task/dHAitqXaRFmLcd6K40FYHw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 12:12:44 INFO - Running post-action listener: _resource_record_post_action 12:12:44 INFO - Running post-action listener: set_extra_try_arguments 12:12:44 INFO - [mozharness: 2017-06-02 19:12:44.665369Z] Finished download-and-extract step (success) 12:12:44 INFO - [mozharness: 2017-06-02 19:12:44.665498Z] Running populate-webroot step. 12:12:44 INFO - Running pre-action listener: _resource_record_pre_action 12:12:44 INFO - Running main action method: populate_webroot 12:12:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:12:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:12:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:12:44 INFO - '--tppagecycles', 12:12:44 INFO - '7'], 12:12:44 INFO - 'tests': ['tsvgm']}}, 12:12:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:12:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:12:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:12:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:12:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:12:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:12:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:12:44 INFO - 'talos_options': ['--disable-e10s'], 12:12:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:12:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:12:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:12:44 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:12:44 INFO - 'talos_options': ['--disable-e10s'], 12:12:44 INFO - 'tests': ['damp', 'tps']}, 12:12:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:12:44 INFO - 'tests': ['damp', 'tps']}, 12:12:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:12:44 INFO - 'tests': ['dromaeo_dom']}, 12:12:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:12:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:12:44 INFO - 'tests': ['basic_compositor_video']}, 12:12:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:12:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:12:44 INFO - 'tests': ['a11yr', 12:12:44 INFO - 'ts_paint', 12:12:44 INFO - 'tpaint', 12:12:44 INFO - 'sessionrestore', 12:12:44 INFO - 'sessionrestore_no_auto_restore', 12:12:44 INFO - 'tabpaint']}, 12:12:44 INFO - 'other-e10s': {'tests': ['a11yr', 12:12:44 INFO - 'ts_paint', 12:12:44 INFO - 'tpaint', 12:12:44 INFO - 'sessionrestore', 12:12:44 INFO - 'sessionrestore_no_auto_restore', 12:12:44 INFO - 'tabpaint']}, 12:12:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:12:44 INFO - 'ts_paint', 12:12:44 INFO - 'tpaint', 12:12:44 INFO - 'sessionrestore', 12:12:44 INFO - 'sessionrestore_no_auto_restore', 12:12:44 INFO - 'tabpaint']}, 12:12:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:12:44 INFO - 'ts_paint', 12:12:44 INFO - 'tpaint', 12:12:44 INFO - 'sessionrestore', 12:12:44 INFO - 'sessionrestore_no_auto_restore', 12:12:44 INFO - 'tabpaint']}, 12:12:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:12:44 INFO - 'tests': ['a11yr', 12:12:44 INFO - 'ts_paint', 12:12:44 INFO - 'tpaint', 12:12:44 INFO - 'sessionrestore', 12:12:44 INFO - 'sessionrestore_no_auto_restore', 12:12:44 INFO - 'tabpaint']}, 12:12:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:12:44 INFO - 'tests': ['a11yr', 12:12:44 INFO - 'ts_paint', 12:12:44 INFO - 'tpaint', 12:12:44 INFO - 'sessionrestore', 12:12:44 INFO - 'sessionrestore_no_auto_restore', 12:12:44 INFO - 'tabpaint']}, 12:12:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:12:44 INFO - 'tests': ['tsvgx', 12:12:44 INFO - 'tsvgr_opacity', 12:12:44 INFO - 'tart', 12:12:44 INFO - 'tscrollx', 12:12:44 INFO - 'cart', 12:12:44 INFO - 'tsvg_static']}, 12:12:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:12:44 INFO - 'tsvgr_opacity', 12:12:44 INFO - 'tart', 12:12:44 INFO - 'tscrollx', 12:12:44 INFO - 'cart', 12:12:44 INFO - 'tsvg_static']}, 12:12:44 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:12:44 INFO - 'talos_options': ['--disable-e10s'], 12:12:44 INFO - 'tests': ['tp5o']}, 12:12:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:12:44 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:12:44 INFO - 'talos_options': ['--disable-e10s', 12:12:44 INFO - '--xperf_path', 12:12:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:12:44 INFO - 'tests': ['tp5n']}, 12:12:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:12:44 INFO - 'talos_options': ['--xperf_path', 12:12:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:12:44 INFO - 'tests': ['tp5n']}}, 12:12:44 INFO - 'talos.zip': {'path': '', 12:12:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:12:44 INFO - Running post-action listener: _resource_record_post_action 12:12:44 INFO - [mozharness: 2017-06-02 19:12:44.685530Z] Finished populate-webroot step (success) 12:12:44 INFO - [mozharness: 2017-06-02 19:12:44.685674Z] Running create-virtualenv step. 12:12:44 INFO - Running pre-action listener: _resource_record_pre_action 12:12:44 INFO - Running main action method: create_virtualenv 12:12:44 INFO - Creating virtualenv /builds/slave/test/build/venv 12:12:44 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 12:12:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:12:44 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 12:12:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:12:44 INFO - Using real prefix '/tools/python27' 12:12:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:12:45 INFO - Installing distribute.............................................................................................................................................................................................done. 12:12:48 INFO - Installing pip.................done. 12:12:48 INFO - Return code: 0 12:12:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:12:48 INFO - Reading from file tmpfile_stdout 12:12:48 INFO - Output received: 12:12:48 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) 12:12:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:12:48 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')]} 12:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:48 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')]} 12:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:48 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 0x10dc95b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc98768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb089c840b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da73d30>, '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 0x10d99adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da68be8>, '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.uE6EYE5xZY/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.1oVA3QrX6O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 12:12:48 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 12:12:48 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 12:12:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uE6EYE5xZY/Render', 12:12:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:12:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:12:48 INFO - 'HOME': '/Users/cltbld', 12:12:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:12:48 INFO - 'LOGNAME': 'cltbld', 12:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:48 INFO - 'MOZ_NO_REMOTE': '1', 12:12:48 INFO - 'NO_EM_RESTART': '1', 12:12:48 INFO - 'PAGER': '/bin/cat', 12:12:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:48 INFO - 'PWD': '/builds/slave/test', 12:12:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:12:48 INFO - 'SHELL': '/bin/bash', 12:12:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1oVA3QrX6O/Listeners', 12:12:48 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 12:12:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:12:48 INFO - 'USER': 'cltbld', 12:12:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:12:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:48 INFO - 'XPC_FLAGS': '0x0', 12:12:48 INFO - 'XPC_SERVICE_NAME': '0', 12:12:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:12:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:49 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 12:12:49 INFO - Cleaning up... 12:12:49 INFO - Return code: 0 12:12:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:12: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')]} 12:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12: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')]} 12:12:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:49 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 0x10dc95b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc98768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb089c840b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da73d30>, '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 0x10d99adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da68be8>, '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.uE6EYE5xZY/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.1oVA3QrX6O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 12:12:49 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 12:12:49 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 12:12:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uE6EYE5xZY/Render', 12:12:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:12:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:12:49 INFO - 'HOME': '/Users/cltbld', 12:12:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:12:49 INFO - 'LOGNAME': 'cltbld', 12:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:49 INFO - 'MOZ_NO_REMOTE': '1', 12:12:49 INFO - 'NO_EM_RESTART': '1', 12:12:49 INFO - 'PAGER': '/bin/cat', 12:12:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:49 INFO - 'PWD': '/builds/slave/test', 12:12:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:12:49 INFO - 'SHELL': '/bin/bash', 12:12:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1oVA3QrX6O/Listeners', 12:12:49 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 12:12:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:12:49 INFO - 'USER': 'cltbld', 12:12:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:12:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:49 INFO - 'XPC_FLAGS': '0x0', 12:12:49 INFO - 'XPC_SERVICE_NAME': '0', 12:12:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:12:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:49 INFO - Downloading/unpacking psutil>=3.1.1 12:12:49 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 12:12:49 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 12:12:49 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 12:12:49 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 12:12:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:12:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:12:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:12:52 INFO - Installing collected packages: psutil 12:12:52 INFO - Running setup.py install for psutil 12:12:52 INFO - building 'psutil._psutil_osx' extension 12:12:52 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 12:12:52 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 12:12:52 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 12:12:52 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 12:12:52 INFO - building 'psutil._psutil_posix' extension 12:12:52 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 12:12:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:12:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:12:52 INFO - ^ 12:12:52 INFO - 1 warning generated. 12:12:52 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 12:12:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:12:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:12:53 INFO - Successfully installed psutil 12:12:53 INFO - Cleaning up... 12:12:53 INFO - Return code: 0 12:12:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:12:53 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')]} 12:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:53 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')]} 12:12:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:53 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 0x10dc95b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc98768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb089c840b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da73d30>, '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 0x10d99adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da68be8>, '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.uE6EYE5xZY/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.1oVA3QrX6O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 12:12:53 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 12:12:53 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 12:12:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uE6EYE5xZY/Render', 12:12:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:12:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:12:53 INFO - 'HOME': '/Users/cltbld', 12:12:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:12:53 INFO - 'LOGNAME': 'cltbld', 12:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:53 INFO - 'MOZ_NO_REMOTE': '1', 12:12:53 INFO - 'NO_EM_RESTART': '1', 12:12:53 INFO - 'PAGER': '/bin/cat', 12:12:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:53 INFO - 'PWD': '/builds/slave/test', 12:12:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:12:53 INFO - 'SHELL': '/bin/bash', 12:12:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1oVA3QrX6O/Listeners', 12:12:53 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 12:12:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:12:53 INFO - 'USER': 'cltbld', 12:12:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:12:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:53 INFO - 'XPC_FLAGS': '0x0', 12:12:53 INFO - 'XPC_SERVICE_NAME': '0', 12:12:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:12:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:12:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:12:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:12:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:12:54 INFO - Installing collected packages: mozsystemmonitor 12:12:54 INFO - Running setup.py install for mozsystemmonitor 12:12:55 INFO - Successfully installed mozsystemmonitor 12:12:55 INFO - Cleaning up... 12:12:55 INFO - Return code: 0 12:12:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:12:55 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')]} 12:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:55 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')]} 12:12:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x10dc95b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc98768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb089c840b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da73d30>, '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 0x10d99adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da68be8>, '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.uE6EYE5xZY/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.1oVA3QrX6O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 12:12:55 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 12:12:55 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 12:12:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uE6EYE5xZY/Render', 12:12:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:12:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:12:55 INFO - 'HOME': '/Users/cltbld', 12:12:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:12:55 INFO - 'LOGNAME': 'cltbld', 12:12:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:55 INFO - 'MOZ_NO_REMOTE': '1', 12:12:55 INFO - 'NO_EM_RESTART': '1', 12:12:55 INFO - 'PAGER': '/bin/cat', 12:12:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:12:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:55 INFO - 'PWD': '/builds/slave/test', 12:12:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:12:55 INFO - 'SHELL': '/bin/bash', 12:12:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1oVA3QrX6O/Listeners', 12:12:55 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 12:12:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:12:55 INFO - 'USER': 'cltbld', 12:12:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:12:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:12:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:55 INFO - 'XPC_FLAGS': '0x0', 12:12:55 INFO - 'XPC_SERVICE_NAME': '0', 12:12:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:12:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:55 INFO - Downloading/unpacking jsonschema==2.5.1 12:12:55 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 12:12:55 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 12:12:55 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 12:12:55 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 12:12:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:12:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:12:56 INFO - Downloading functools32-3.2.3-2.tar.gz 12:12:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:12:57 INFO - warning: no files found matching '*.txt' 12:12:57 INFO - no previously-included directories found matching 'build' 12:12:57 INFO - no previously-included directories found matching 'dist' 12:12:57 INFO - no previously-included directories found matching '.git*' 12:12:57 INFO - Installing collected packages: jsonschema, functools32 12:12:57 INFO - Running setup.py install for functools32 12:12:57 INFO - warning: no files found matching '*.txt' 12:12:57 INFO - no previously-included directories found matching 'build' 12:12:57 INFO - no previously-included directories found matching 'dist' 12:12:57 INFO - no previously-included directories found matching '.git*' 12:12:57 INFO - Successfully installed jsonschema functools32 12:12:57 INFO - Cleaning up... 12:12:57 INFO - Return code: 0 12:12:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:12:57 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')]} 12:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:57 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')]} 12:12:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x10dc95b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc98768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb089c840b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da73d30>, '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 0x10d99adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da68be8>, '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.uE6EYE5xZY/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.1oVA3QrX6O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 12:12:57 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 12:12:57 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 12:12:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uE6EYE5xZY/Render', 12:12:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:12:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:12:57 INFO - 'HOME': '/Users/cltbld', 12:12:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:12:57 INFO - 'LOGNAME': 'cltbld', 12:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:57 INFO - 'MOZ_NO_REMOTE': '1', 12:12:57 INFO - 'NO_EM_RESTART': '1', 12:12:57 INFO - 'PAGER': '/bin/cat', 12:12:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:57 INFO - 'PWD': '/builds/slave/test', 12:12:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:12:57 INFO - 'SHELL': '/bin/bash', 12:12:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1oVA3QrX6O/Listeners', 12:12:57 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 12:12:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:12:57 INFO - 'USER': 'cltbld', 12:12:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:12:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:57 INFO - 'XPC_FLAGS': '0x0', 12:12:57 INFO - 'XPC_SERVICE_NAME': '0', 12:12:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:12:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:12:57 INFO - Cleaning up... 12:12:57 INFO - Return code: 0 12:12:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:12:57 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')]} 12:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:58 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')]} 12:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x10dc95b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc98768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb089c840b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da73d30>, '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 0x10d99adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da68be8>, '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.uE6EYE5xZY/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.1oVA3QrX6O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 12:12:58 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 12:12:58 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 12:12:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uE6EYE5xZY/Render', 12:12:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:12:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:12:58 INFO - 'HOME': '/Users/cltbld', 12:12:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:12:58 INFO - 'LOGNAME': 'cltbld', 12:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:58 INFO - 'MOZ_NO_REMOTE': '1', 12:12:58 INFO - 'NO_EM_RESTART': '1', 12:12:58 INFO - 'PAGER': '/bin/cat', 12:12:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:58 INFO - 'PWD': '/builds/slave/test', 12:12:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:12:58 INFO - 'SHELL': '/bin/bash', 12:12:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1oVA3QrX6O/Listeners', 12:12:58 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 12:12:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:12:58 INFO - 'USER': 'cltbld', 12:12:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:12:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:58 INFO - 'XPC_FLAGS': '0x0', 12:12:58 INFO - 'XPC_SERVICE_NAME': '0', 12:12:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:58 INFO - Downloading/unpacking blobuploader==1.2.4 12:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:00 INFO - Downloading blobuploader-1.2.4.tar.gz 12:13:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:13:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:13:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:01 INFO - Downloading docopt-0.6.1.tar.gz 12:13:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:13:01 INFO - Installing collected packages: blobuploader, requests, docopt 12:13:01 INFO - Running setup.py install for blobuploader 12:13:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:13:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:13:01 INFO - Running setup.py install for requests 12:13:02 INFO - Running setup.py install for docopt 12:13:02 INFO - Successfully installed blobuploader requests docopt 12:13:02 INFO - Cleaning up... 12:13:02 INFO - Return code: 0 12:13:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:13:02 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')]} 12:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:02 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')]} 12:13:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:02 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 0x10dc95b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc98768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb089c840b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da73d30>, '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 0x10d99adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da68be8>, '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.uE6EYE5xZY/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.1oVA3QrX6O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 12:13:02 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 12:13:02 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 12:13:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uE6EYE5xZY/Render', 12:13:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:13:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:13:02 INFO - 'HOME': '/Users/cltbld', 12:13:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:13:02 INFO - 'LOGNAME': 'cltbld', 12:13:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:02 INFO - 'MOZ_NO_REMOTE': '1', 12:13:02 INFO - 'NO_EM_RESTART': '1', 12:13:02 INFO - 'PAGER': '/bin/cat', 12:13:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:13:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:02 INFO - 'PWD': '/builds/slave/test', 12:13:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:13:02 INFO - 'SHELL': '/bin/bash', 12:13:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1oVA3QrX6O/Listeners', 12:13:02 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 12:13:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:13:02 INFO - 'USER': 'cltbld', 12:13:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:13:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:13:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:02 INFO - 'XPC_FLAGS': '0x0', 12:13:02 INFO - 'XPC_SERVICE_NAME': '0', 12:13:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:13:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:13:03 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-louq4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:13:03 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-7H8lfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:13:03 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-dYfHgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:13:03 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-EQL7qX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:13:03 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-dqhFZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:13:03 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-2S5ZUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:13:03 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-EZH3va-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:13:03 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-brChMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:13:03 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-MAHuFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:13:03 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-eMf6ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:13:04 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-2jE9Ts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:13:04 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-eWhncQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:13:04 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-RYmoTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:13:04 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-bw8EC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:13:04 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-ANyIvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:13:04 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-07rk7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:13:04 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-B40ZtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:13:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:13:04 INFO - Running setup.py install for manifestparser 12:13:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:13:04 INFO - Running setup.py install for mozcrash 12:13:05 INFO - Running setup.py install for mozdebug 12:13:05 INFO - Running setup.py install for mozdevice 12:13:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:13:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:13:05 INFO - Running setup.py install for mozfile 12:13:05 INFO - Running setup.py install for mozhttpd 12:13:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:13:05 INFO - Running setup.py install for mozinfo 12:13:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:13:05 INFO - Running setup.py install for mozInstall 12:13:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:13:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:13:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:13:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:13:05 INFO - Running setup.py install for mozleak 12:13:06 INFO - Running setup.py install for mozlog 12:13:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:13:06 INFO - Running setup.py install for moznetwork 12:13:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:13:06 INFO - Running setup.py install for mozprocess 12:13:06 INFO - Running setup.py install for mozprofile 12:13:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:13:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:13:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:13:06 INFO - Running setup.py install for mozrunner 12:13:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:13:06 INFO - Running setup.py install for mozscreenshot 12:13:07 INFO - Running setup.py install for moztest 12:13:07 INFO - Running setup.py install for mozversion 12:13:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:13:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:13:07 INFO - Cleaning up... 12:13:07 INFO - Return code: 0 12:13:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:13:07 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')]} 12:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:07 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')]} 12:13:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:07 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 0x10dc95b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc98768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb089c840b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da73d30>, '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 0x10d99adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da68be8>, '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.uE6EYE5xZY/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.1oVA3QrX6O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 12:13:07 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 12:13:07 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 12:13:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uE6EYE5xZY/Render', 12:13:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:13:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:13:07 INFO - 'HOME': '/Users/cltbld', 12:13:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:13:07 INFO - 'LOGNAME': 'cltbld', 12:13:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:07 INFO - 'MOZ_NO_REMOTE': '1', 12:13:07 INFO - 'NO_EM_RESTART': '1', 12:13:07 INFO - 'PAGER': '/bin/cat', 12:13:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:13:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:07 INFO - 'PWD': '/builds/slave/test', 12:13:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:13:07 INFO - 'SHELL': '/bin/bash', 12:13:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1oVA3QrX6O/Listeners', 12:13:07 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 12:13:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:13:07 INFO - 'USER': 'cltbld', 12:13:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:13:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:13:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:07 INFO - 'XPC_FLAGS': '0x0', 12:13:07 INFO - 'XPC_SERVICE_NAME': '0', 12:13:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:13:07 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-V0U3g6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:13:07 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)) 12:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:13:07 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-oIgZB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:13:07 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)) 12:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:13:07 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-Gg1ZGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:13:08 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)) 12:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:13:08 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-aiZCKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:13:08 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)) 12:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:13:08 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-jxJwH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:13:08 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)) 12:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:13:08 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-jaC5jT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:13:08 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)) 12:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:13:08 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-k5DqZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:13:08 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)) 12:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:13:08 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-Ew15tR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:13:08 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)) 12:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:13:08 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-96Au41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:13:08 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)) 12:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:13:08 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-UVeTuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:13:08 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)) 12:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:13:08 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-wHf1fx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:13:08 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)) 12:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:13:08 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-J3ytSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:13:08 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)) 12:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:13:08 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-yGxHHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:13:09 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)) 12:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:13:09 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-us_aif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:13:09 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)) 12:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:13:09 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-j3cfrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:13:09 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)) 12:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:13:09 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-xgaxBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:13:09 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)) 12:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:13:09 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-m7J5Nh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:13:09 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)) 12:13:09 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)) 12:13:09 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)) 12:13:09 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)) 12:13:09 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)) 12:13:09 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)) 12:13:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:13:09 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 12:13:09 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 12:13:09 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 12:13:09 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 12:13:10 INFO - Downloading blessings-1.6.tar.gz 12:13:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:13:11 INFO - Installing collected packages: blessings 12:13:11 INFO - Running setup.py install for blessings 12:13:11 INFO - Successfully installed blessings 12:13:11 INFO - Cleaning up... 12:13:11 INFO - Return code: 0 12:13:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:13:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:13:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:13:11 INFO - Reading from file tmpfile_stdout 12:13:11 INFO - Current package versions: 12:13:11 INFO - blessings == 1.6 12:13:11 INFO - blobuploader == 1.2.4 12:13:11 INFO - docopt == 0.6.1 12:13:11 INFO - functools32 == 3.2.3-2 12:13:11 INFO - jsonschema == 2.5.1 12:13:11 INFO - manifestparser == 1.1 12:13:11 INFO - mozInstall == 1.12 12:13:11 INFO - mozcrash == 1.0 12:13:11 INFO - mozdebug == 0.1 12:13:11 INFO - mozdevice == 0.49 12:13:11 INFO - mozfile == 1.2 12:13:11 INFO - mozhttpd == 0.7 12:13:11 INFO - mozinfo == 0.9 12:13:11 INFO - mozleak == 0.1 12:13:11 INFO - mozlog == 3.4 12:13:11 INFO - moznetwork == 0.27 12:13:11 INFO - mozprocess == 0.25 12:13:11 INFO - mozprofile == 0.28 12:13:11 INFO - mozrunner == 6.13 12:13:11 INFO - mozscreenshot == 0.1 12:13:11 INFO - mozsystemmonitor == 0.3 12:13:11 INFO - moztest == 0.8 12:13:11 INFO - mozversion == 1.4 12:13:11 INFO - psutil == 3.1.1 12:13:11 INFO - requests == 1.2.3 12:13:11 INFO - wsgiref == 0.1.2 12:13:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:13:11 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')]} 12:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:11 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')]} 12:13:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x10dc95b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc98768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb089c840b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da73d30>, '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 0x10d99adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da68be8>, '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.uE6EYE5xZY/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.1oVA3QrX6O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 12:13:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:13:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:13:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uE6EYE5xZY/Render', 12:13:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:13:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:13:11 INFO - 'HOME': '/Users/cltbld', 12:13:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:13:11 INFO - 'LOGNAME': 'cltbld', 12:13:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:11 INFO - 'MOZ_NO_REMOTE': '1', 12:13:11 INFO - 'NO_EM_RESTART': '1', 12:13:11 INFO - 'PAGER': '/bin/cat', 12:13:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:13:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:11 INFO - 'PWD': '/builds/slave/test', 12:13:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:13:11 INFO - 'SHELL': '/bin/bash', 12:13:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1oVA3QrX6O/Listeners', 12:13:11 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 12:13:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:13:11 INFO - 'USER': 'cltbld', 12:13:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:13:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:13:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:11 INFO - 'XPC_FLAGS': '0x0', 12:13:11 INFO - 'XPC_SERVICE_NAME': '0', 12:13:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:13:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:11 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)) 12:13:11 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)) 12:13:11 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)) 12:13:11 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)) 12:13:11 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)) 12:13:11 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)) 12:13:11 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)) 12:13:11 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)) 12:13:11 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)) 12:13:11 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)) 12:13:11 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)) 12:13:11 INFO - Cleaning up... 12:13:11 INFO - Return code: 0 12:13:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:13:11 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')]} 12:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:11 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')]} 12:13:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x10dc95b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc98768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb089c840b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da73d30>, '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 0x10d99adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da68be8>, '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.uE6EYE5xZY/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.1oVA3QrX6O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 12:13:11 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 12:13:11 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 12:13:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uE6EYE5xZY/Render', 12:13:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:13:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:13:11 INFO - 'HOME': '/Users/cltbld', 12:13:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:13:11 INFO - 'LOGNAME': 'cltbld', 12:13:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:11 INFO - 'MOZ_NO_REMOTE': '1', 12:13:11 INFO - 'NO_EM_RESTART': '1', 12:13:11 INFO - 'PAGER': '/bin/cat', 12:13:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:13:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:11 INFO - 'PWD': '/builds/slave/test', 12:13:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:13:11 INFO - 'SHELL': '/bin/bash', 12:13:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1oVA3QrX6O/Listeners', 12:13:11 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 12:13:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:13:11 INFO - 'USER': 'cltbld', 12:13:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:13:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:13:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:11 INFO - 'XPC_FLAGS': '0x0', 12:13:11 INFO - 'XPC_SERVICE_NAME': '0', 12:13:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:13:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:13:12 INFO - Cleaning up... 12:13:12 INFO - Return code: 0 12:13:12 INFO - Running post-action listener: _resource_record_post_action 12:13:12 INFO - Running post-action listener: _start_resource_monitoring 12:13:12 INFO - Starting resource monitoring. 12:13:12 INFO - [mozharness: 2017-06-02 19:13:12.067571Z] Finished create-virtualenv step (success) 12:13:12 INFO - [mozharness: 2017-06-02 19:13:12.068539Z] Running install step. 12:13:12 INFO - Running pre-action listener: _resource_record_pre_action 12:13:12 INFO - Running main action method: install 12:13:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:13:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:13:12 INFO - Reading from file tmpfile_stdout 12:13:12 INFO - Detecting whether we're running mozinstall >=1.0... 12:13:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:13:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:13:12 INFO - Reading from file tmpfile_stdout 12:13:12 INFO - Output received: 12:13:12 INFO - Usage: mozinstall [options] installer 12:13:12 INFO - Options: 12:13:12 INFO - -h, --help show this help message and exit 12:13:12 INFO - -d DEST, --destination=DEST 12:13:12 INFO - Directory to install application into. [default: 12:13:12 INFO - "/builds/slave/test"] 12:13:12 INFO - --app=APP Application being installed. [default: firefox] 12:13:12 INFO - mkdir: /builds/slave/test/build/application 12:13:12 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'] 12:13:12 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 12:13:27 INFO - Reading from file tmpfile_stdout 12:13:27 INFO - Output received: 12:13:27 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 12:13:27 INFO - Running post-action listener: _resource_record_post_action 12:13:27 INFO - [mozharness: 2017-06-02 19:13:27.150059Z] Finished install step (success) 12:13:27 INFO - [mozharness: 2017-06-02 19:13:27.150189Z] Running run-tests step. 12:13:27 INFO - Running pre-action listener: _resource_record_pre_action 12:13:27 INFO - Running main action method: run_tests 12:13:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:13:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:13:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:13:27 INFO - 2017-06-02 12:13:27.164 screenresolution[4286:82853] starting screenresolution argv=screenresolution get 12:13:27 INFO - 2017-06-02 12:13:27.167 screenresolution[4286:82853] Display 0: 1600x1200x32@60 12:13:27 INFO - 2017-06-02 12:13:27.173 screenresolution[4287:82855] starting screenresolution argv=screenresolution list 12:13:27 INFO - Available Modes on Display 0 12:13:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:13:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:13:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:13:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:13:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:13:27 INFO - Intel Iris: 12:13:27 INFO - Chipset Model: Intel Iris 12:13:27 INFO - Type: GPU 12:13:27 INFO - Bus: Built-In 12:13:27 INFO - VRAM (Dynamic, Max): 1536 MB 12:13:27 INFO - Vendor: Intel (0x8086) 12:13:27 INFO - Device ID: 0x0a2e 12:13:27 INFO - Revision ID: 0x0009 12:13:27 INFO - Displays: 12:13:27 INFO - Display: 12:13:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:13:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:13:27 INFO - Display Serial Number: 1600x1200 60 12:13:27 INFO - Main Display: Yes 12:13:27 INFO - Mirror: Off 12:13:27 INFO - Online: Yes 12:13:27 INFO - Rotation: Supported 12:13:27 INFO - Return code: 0 12:13:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:13:27 INFO - Python 2.7.3 12:13:27 INFO - Return code: 0 12:13:27 INFO - grabbing minidump binary from tooltool 12:13:27 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')]} 12:13:27 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 0x10da73d30>, '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 0x10d99adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da68be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:13:27 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 12:13:27 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 12:13:27 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 12:13:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:13:27 INFO - Return code: 0 12:13:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:13:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:13:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:13:27 INFO - ENV: RUST_BACKTRACE is now 1 12:13:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:13:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:13:27 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/dHAitqXaRFmLcd6K40FYHw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0205', '--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 12:13:27 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/dHAitqXaRFmLcd6K40FYHw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0205 --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 12:13:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uE6EYE5xZY/Render', 12:13:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:13:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:13:27 INFO - 'HOME': '/Users/cltbld', 12:13:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:13:27 INFO - 'LOGNAME': 'cltbld', 12:13:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:13:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:27 INFO - 'MOZ_NO_REMOTE': '1', 12:13:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:13:27 INFO - 'NO_EM_RESTART': '1', 12:13:27 INFO - 'PAGER': '/bin/cat', 12:13:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:27 INFO - 'PWD': '/builds/slave/test', 12:13:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:13:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:13:27 INFO - 'RUST_BACKTRACE': '1', 12:13:27 INFO - 'SHELL': '/bin/bash', 12:13:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1oVA3QrX6O/Listeners', 12:13:27 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 12:13:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:13:27 INFO - 'USER': 'cltbld', 12:13:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:13:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:27 INFO - 'XPC_FLAGS': '0x0', 12:13:27 INFO - 'XPC_SERVICE_NAME': '0', 12:13:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:13:27 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/dHAitqXaRFmLcd6K40FYHw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0205', '--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 12:13:27 INFO - mozversion application_buildid: 20170602110524 12:13:27 INFO - mozversion application_changeset: d47466614ea1ea1a4d9c64ff943a0a3670291529 12:13:27 INFO - mozversion application_display_name: Firefox 12:13:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:13:27 INFO - mozversion application_name: Firefox 12:13:27 INFO - mozversion application_remotingname: firefox 12:13:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:13:27 INFO - mozversion application_vendor: Mozilla 12:13:27 INFO - mozversion application_version: 54.0 12:13:27 INFO - mozversion platform_buildid: 20170602110524 12:13:27 INFO - mozversion platform_changeset: d47466614ea1ea1a4d9c64ff943a0a3670291529 12:13:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:13:27 INFO - mozversion platform_version: 54.0 12:13:27 INFO - using testdate: 1496430807 12:13:27 INFO - actual date: 1496430807 12:13:27 INFO - starting webserver on 'localhost:54502' 12:13:27 INFO - SUITE-START | Running 2 tests 12:13:27 INFO - TEST-START | dromaeo_css 12:13:27 INFO - operating with platform_type : mac_ 12:13:27 INFO - Initialising browser for dromaeo_css test... 12:13:27 INFO - TEST-INFO | started process 4297 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/tmpepFE9G/profile http://localhost:54502/getInfo.html) 12:13:30 INFO - PROCESS | 4297 | __metrics Screen width/height:1600/1200 12:13:30 INFO - PROCESS | 4297 | colorDepth:24 12:13:30 INFO - PROCESS | 4297 | Browser inner width/height: 1024/689 12:13:30 INFO - PROCESS | 4297 | __metrics 12:13:30 INFO - PROCESS | 4297 | 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" 12:13:30 INFO - PROCESS | 4297 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:13:31 INFO - TEST-INFO | 4297: exit 0 12:13:31 INFO - Browser initialized. 12:13:31 INFO - Running cycle 1/1 for dromaeo_css test... 12:13:31 INFO - TEST-INFO | started process 4300 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/tmpepFE9G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:13:43 INFO - PROCESS | 4300 | RSS: Main: 165175296 12:13:43 INFO - PROCESS | 4300 | 12:16:47 INFO - PROCESS | 4300 | Cycle 1(1): loaded http://localhost:54502/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54502/tests/dromaeo/cssquery-ext.html) 12:16:48 INFO - PROCESS | 4300 | RSS: Main: 300113920 12:16:48 INFO - PROCESS | 4300 | 12:19:51 INFO - PROCESS | 4300 | Cycle 1(1): loaded http://localhost:54502/tests/dromaeo/cssquery-ext.html (next: http://localhost:54502/tests/dromaeo/cssquery-jquery.html) 12:19:52 INFO - PROCESS | 4300 | RSS: Main: 305680384 12:19:52 INFO - PROCESS | 4300 | 12:22:54 INFO - PROCESS | 4300 | Cycle 1(1): loaded http://localhost:54502/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54502/tests/dromaeo/cssquery-mootools.html) 12:22:55 INFO - PROCESS | 4300 | RSS: Main: 280576000 12:22:55 INFO - PROCESS | 4300 | 12:25:57 INFO - PROCESS | 4300 | Cycle 1(1): loaded http://localhost:54502/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54502/tests/dromaeo/cssquery-prototype.html) 12:25:58 INFO - PROCESS | 4300 | RSS: Main: 282423296 12:25:58 INFO - PROCESS | 4300 | 12:29:02 INFO - PROCESS | 4300 | Cycle 1(1): loaded http://localhost:54502/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54502/tests/dromaeo/cssquery-yui.html) 12:29:02 INFO - PROCESS | 4300 | RSS: Main: 264962048 12:29:02 INFO - PROCESS | 4300 | 12:32:05 INFO - PROCESS | 4300 | Cycle 1(1): loaded http://localhost:54502/tests/dromaeo/cssquery-yui.html (next: http://localhost:54502/tests/dromaeo/cssquery-dojo.html) 12:32:06 INFO - PROCESS | 4300 | RSS: Main: 401367040 12:32:06 INFO - PROCESS | 4300 | 12:32:06 INFO - PROCESS | 4300 | __start_tp_report 12:32:06 INFO - PROCESS | 4300 | _x_x_mozilla_page_load 12:32:06 INFO - PROCESS | 4300 | _x_x_mozilla_page_load_details 12:32:06 INFO - PROCESS | 4300 | |i|pagename|runs| 12:32:06 INFO - PROCESS | 4300 | |0;dojo.html;2903.361260522685;3552.68025877671;3559.5194648722413;3577.052081198481;3590.1563132663837;6188.752449902004;6212.5029997600195;6222.0355844844125;6226.7820626278035;6247.843803904899;6157.138000679897;6242.001279795234;6246.063090536421;6246.125542424053;6248.37516248375;5501.119820828668;5532.7786888524415;5563.666180029191;5587.106063029916;5650.858728531778;5391.406945236021;5425.213344065108;5457.2359869618085;5632.324121105473;5654.9151762723595;5151;5549.19536667183;5566.276384070065;5590.357108932484;5608.887822243552;5642.605017648766;5644.774209031654;5646.153077038436;5656.236408084897;5658.349289831681;5381.973090134564;5502.532284755801;5563.165525171216;5564.777408903639;5578.246936663539;6102.328743838174;6107.786227482017;6112.755489780404;6128.877422451571;6144.539159563006;6559.311272316386;6568.901466478007;6572.769953051668;6572.868542629169;6577.6053436793945;5395.7032363220005;5536.557075433956;6523.054157147187;6628;6678.332166783282;6129.938700613026;6279.246490421178;6362.491000720024;6371.8407039823915;6373.872522549523;6591.077249185118;6593.967030164818;6600.438962688129;6604.1084453599115;6742.157230346207;6426.325235850262;6427.132337134427;6463.385978332145;6476.967615161894;6481.5138864584405;6650.301718319603;6657.500687448364;6669.566478178903;6678.09845670838;6693.062971184038;6317.747290108436;6323.051542268697;6403.775867844696;6535.967320163369;6554.3445655435025;6553.311902250195;6567.179102612174;6569.113169722122;6570.342965703487;6572.34276572339;5282.603804714662;5316.308879845596;5334.839954801362;5335.759890804923;5371.973140134274;4664.766761661904;4671.43942726875;4691.225947718656;4758.357621721093;4807.543283388142;6119.715820550745;6207.255129384503;6252.155958945576;6326.5255105867245;6335.556511044183;6632.834179145463;6639.601623902581;6646.468282537386;6654.534182607171;6655.767048153291;6224.408681175371;6267.62394256346;6281.528885333618;6297.716602752796;6317.652529110851;5653.067243904709;5686.459786320293;5699.430056994267;5792.160136780228;5806;6863.10779598649;6872.62200578973;6883.724651014104;6888.276730943379;6893.724251030003;6578.473722102125;6580.1116849224745;6625.966870165618;6631.502637302318;6646.069550263063;6484.740610375532;6521.315261897622;6612.173478315211;6877.346652068046;6890.8621827564175;6376.458001069961;6378.394052564999;6392.648404337806;6397;6404.1674582304;6507.609543427409;6533.67331633407;6630.336966303331;6646;6649.434798042221;6383.648899310582;6446.290908000023;6457.515686323451;6461.967690161519;6475.222973243241;6437.066625339393;6444.162258906312;6447.451966582893;6456.192975878015;6458.806235812933;6268;6303.054541818764;6320.62076275425;6342.904856427065;6349.111124442674;5296.761645725875;6408.487321014401;6414.711337989708;6429.935700642934;6438.4527315176865;6159.106929495288;6291.811245662638;6353.459955903615;6368.363163683594;6383.585066970632 12:32:06 INFO - PROCESS | 4300 | |1;ext.html;787.9251471110246;819.6147810529051;830.8961379827523;917.9632814687412;924.1774820409833;29914.551281730764;40771;41229;41440.378394324034;41442.17115657693;42073.57926420735;42387;42387.78806105973;42434.514791982285;42557.78721106398;8016.398770092237;9663.903360966371;9853.753656158617;9866.605335786597;9868.259880508955;8091.474054186459;11632.825507617392;11847;12031.398430078505;12073.879261207363;11906.46420911061;11922.165448418615;11922.880771192264;11924.046076313918;11942.044636429107;11876.346800925945;11885.702857428547;11893.821592676117;11899;11946.701332466671;10621.73445663857;10748.301360411626;11509.539618415338;11589.420528973602;11611.187216894821;39837.601623983675;39993.80018599446;40068.998275043356;40130.59869401327;40147.39778903319;4074.8981275468054;4107.034846810997;4112.300908845474;4114.897127571805;4145.274576949022;27680.861595692095;28301.716982830116;30134.685184629674;30379.392412151854;30582;3278.393497203025;3288.588926384202;3319.4854797506423;3401.098708842159;3419.9829000855084;339105;342532;342673;343605;343764;51894;51914.740426298384;51975.74012129915;51984.48015519796;52013.7399313001;54555.72722136443;54660.18009729857;54726;54776;54872.725636371564;15465.458708945358;15609.453669121753;15611.921940390226;15619.297131629104;15636.765448518281;11708.765824683458;11839.408029598486;13420.597382078553;13480.93259533696;13511.594652160451;10490.685279441628;10555.47222638865;10562.524686389132;10563.577456901638;14332.785008224884;5157.871053223699;5273.683578985273;6182.258129024546;6188.195534580475;6240.344763799826;1132.4394424759796;1145.2613064573304;1178.8644305904759;1187.4181650990952;1256.447163248168;26568.8671556641;28174.71825281762;28618.141455756362;28716.71283287182;28772.136835894955;976.829054915387;1004.3020101029861;1007.7178390050798;1103.1175059952006;1287.7360141171037;13222.537211197561;13229.669258268428;13453.932730336286;13484.662883427796;13749.106308089942;512793;515430;515566;515976;517464;37842.67550635715;39817.2036559273;42845;47811;48196.5180348192;1433.1472773699631;1466.8973171877867;1477.8522147785136;1487.5462983789832;1492.8656420921952;26094.60858087092;27800.304992375353;28209.012684555943;28224.71775282303;28349.14952551427;42255.7887210562;42651.36022959596;42704.78647606742;42805.57194428016;42886.57113428951;486767;496319;535167;541899;615764;38815.41776873293;39920.60079399169;40662.79668601638;40791.18417631571;40925.386119207644;50383;50925;51283.487165129365;51558;51883.48116518786;29011.709882901745;29796.10611681653;31302.373952521277;31582.526262105628;32341;33010.89593192015;33064.83467582647;33165.8944485266;33822.49266260959;34335.14162145966;39689.40465892956;40182.79908600439;41826.163476729685;41843.95390115149;41977;28143.718562814927;33064.66935330616;34348.48477272793;35234.8238258807;35345.823270883484;19960.70058949146;23746.762532374454;25589;26958.865205673847;27011.864940675172 12:32:06 INFO - PROCESS | 4300 | |2;jquery.html;390.3598099117448;394.4812571468519;426.69064927927275;434.4352341955457;443.35270505062596;19636.803631963678;20639.17443302268;21594.24420145295;21683.45791355215;21770;22516.43708907278;22819.201327953524;23021.884890575522;23051.884740576275;23267.418314542145;5750.482456578897;6999.160100787913;7026.156861176666;7042.119735033121;7043.225245223021;7380.667869945839;7677.846443071136;7863.724769633064;7872.881906771375;7876.448648594601;7590.316871481566;7771.261730135628;7860.882086768703;7862.764117076468;7872.763817085468;7830.6084695764985;7850.803729906741;7864.213578642119;7936.722214722486;7942;7536.208698086677;7620.580868052255;7765.72819951299;7769.067711874554;7773.922260777376;27452.039178628853;27749.58375624367;27758.861205693844;27928;28227.177282271812;3472.722182225416;3483.164040630256;3506.143990573049;3544.7341449391397;3626.4197728363333;15720.842791572166;17342.479725608253;17348.86775182072;17770.378036768652;17839.554011149696;1983.8512111591688;2010.577778666482;2024.129624261567;2028.0670891389977;2067.2764532413685;163058;173142;177787;179395.10302448535;179458.10270948694;17139;20704.896475517526;20790.688139677917;20984.895075524524;21300.89349553273;33505.32473376321;33749.83125084408;34246;34290.31419371599;34366.14084647904;10604.416757078434;10695.78608427827;10822.296550724177;10853.674389768319;11127.833082503606;8949.060348663426;8956.596953136994;8993.505357205286;9163.954180229057;9183.816323673624;7826.8434631307055;9601.567929443192;9710.223182145412;9825.459599722084;9831.115199632068;3954.982958691031;4044.858429954996;4056.087380339459;4061.1674606705556;4062.370332598452;665.2806652806723;915.6200176926634;931.487681775021;950.1021534649827;979.1383582447401;22288.32837537191;22306.553868922856;22895.542089158458;23150.768492315197;23487.647685284734;953.5994882149514;972.7568107973007;985.3841349156777;995.8107959487675;1006.1296978113879;11631.360275184777;11689.415529223505;11870;11916.52333906634;11933.940330298294;718034;750679;751387;760803;762594;106692;147320.26339868232;162021;164049;173112;1320.306838909561;1325.1982550556968;1377.9104358216885;1380.1236215003546;1382.2743059893435;20206.79793202108;20676.172953081707;20733.377998660064;21188.258410955543;21201.15195392167;52974.73512632412;62816;63223.6838815803;64741.999999998116;65797.67101164655;73885.26114738999;88072.5596372014;89910.65134023126;91647.54176229076;92722.2183334501;11836.408179590813;11989.700257493632;12021.939890300493;12377.071719621244;12414.565490207799;13589.45642174302;13602.591922242349;13613.795793062915;13928.651783705489;14037.017408781287;11656.650300491;11671.649850504498;11770.234934729215;11953.820692689442;12147.75704485923;10796.460176991277;10946.890531094587;11178.72053198644;11211.103111750877;11297.152713546353;11797.35114568707;11969.581064662694;12100;12189.146759726735;12301;11952.58165964187;12004.199370094555;12229.633111006684;12354.073444491878;12408.759124087519;10270.589176433157;11681.707957301136;11716.70708232301;11840.703982400164;12003.939980300043 12:32:06 INFO - PROCESS | 4300 | |3;mootools.html;1469.3241109089818;1598.680263947211;1610.8147563030254;1623.926923288452;1639.1640263465633;9088.90911090889;11498.42507874606;11509.194356395055;11509.539618415254;11518;10941.23411361205;11249.831252531198;11258.155638327118;11492.13808964329;11518.712032199199;2050.241410678051;2257.6274914639066;2380.309710184053;2530.708968468631;2532.392225865788;2063.2675400232924;2425.2360506440414;2512.271441282026;2513.49730053989;2517.0686845866962;2414.8671823049726;2478.5538603051446;2487.141936032066;2501.0996041425074;2504.5742223821903;2374.7625237476113;2423.297243799296;2434.5861203595255;2435.1233555919853;2478.8512689238705;2443.5845906195814;2467.617519284514;2471.468634243646;2475.4306509502917;2475.7524247575097;9655.17930975868;11230.045446137088;11437.142214333875;11476;11481.425928703531;5912.201852749867;6088.238970128734;6106.297775755756;6112.6638034908065;6116.785912493086;3166.224275052604;3475.7139858252353;3657.7929283336434;3719.0702324418894;3744.5693745219105;1224.8407706998032;1241.7951038078706;1264.1719673613798;1270.4854533913779;1312.127435255554;13552.59342219735;13808.861911380958;14136.92931535346;15523.379064837392;15729.292181851844;3703.5555733312176;4066.044479547304;4310.31035034393;4446.333050042519;4968.552830245295;12050.698732531582;12066.215695979734;12092.214006089576;12095.818562721566;12103;5555.194496797942;6080.179175811298;6100.603460775035;6101.0543365777485;6118.510519158456;5190.662606930538;5410.998965191452;5498.780048798083;5562.414711807197;5570.805021824217;3930.1746633206776;3989.4614227079555;4036.858709945138;4076.7146299759324;4078;1066.3921564708196;1070.930389524694;1072.6674730833467;1086.5002099034375;1087.3312912558877;929.716436486878;931.9347645664874;935.504182783126;963.8361478548663;1018.6231094495084;6449.6130232186215;6536.72533855903;6549.508786841006;6574.671266436755;6750.831229219309;964.4165280005495;982.5971351745893;1034.8292531732332;1053.4943227250963;1064.606095744564;3712.9628703712615;3826.693864490834;4064.7357921735584;4088.1619268049976;4335.869923902288;12494.562690305796;13748.106373085717;13758.65603359924;14231.928840355731;14337.64155896111;13391.933040334736;13913.373898174405;14144.575662730134;14169.291535423394;14192.787108193384;8918.375713700108;9210.769730756785;10281.897181028244;10564.577416903237;10609.575616975235;5522.502974732293;6645.202575690948;6718.529702920749;6838.384545390939;6843.520953533205;11991;12103.092268079754;12170.513179473077;12176;12225.572104976283;12023.75952480928;12215.816762748744;12277.815832762337;12338.50645974151;12432.254064756144;7892.289693927574;9465.242780577399;9530.61877524919;9564.521773911138;9567.425954442755;10215.23385746087;10410.73973150647;10443.843342349719;10447;10461.320014199357;8725.04024557311;8839.337049721426;8933.374663773473;8933.508657023925;8943.195112439911;8669.352822963616;8740.994785599738;8755;8763.518006509703;8767.780805479913;7795.59679257739;7984.880226796487;7989.560574168477;7999.720009799629;7999.920000800151;5108.719020453911;5761.711914404347;5803.3616302207565;5821.534277257894;6022.518198544019;5769.307683078057;5879.20630714848;5967.582269241111;6044.365341639064;6164.969175154096 12:32:06 INFO - PROCESS | 4300 | |4;prototype.html;320.887689308742;350.684384054351;396.1700238001386;398.2016057804106;402.1013035864842;4412.867613971578;5382.120565497459;5458.9454105458935;5461.617686761928;5467.316585426822;4154.335306350985;4698.718076915387;4968.329275547809;5220.216967454884;5276.973615131919;4039.414284928691;4119.855805046824;4384.386185933972;4408.757518336491;4410.779461026952;3986.4418981342637;4218;4253.361995700654;4443.7111587746695;4488.618467430272;3838.7140307996856;3958.406239064149;4225.767582782945;4283.207606592775;4415.741513668605;3838.4050472176577;4347.239233134189;4351.303791393378;4353.825846966101;4381.386605875148;3887.669548088416;3997.8200980955926;4016.4376987221813;4041.6160464755803;4046.6358027777346;4871.926921096187;5029.321041659366;5228.2680424740565;5280.3663560373;5304.92042619361;4215.852445164404;4363.847265345697;4821.252705830567;5046.899062018776;5077.517635824591;4431.645468362523;4737.147313483571;4882.5605695487575;5450.754716037748;5756.503309139612;4431.476975804211;4547.681662283641;4574.817007319703;4595.954040459619;4602.861914142581;4990.326305948687;5333.386660534011;5461.0716178249795;5946.316173640043;6023.578349515536;4177.039280965395;4520.666403411002;4628.004978929479;5008.967780936308;5105.2597373381395;4528.524504926935;4921.340458472713;5148.304978827885;5168.7415629218385;5176.870578235575;4299.570042995675;4333.285007973649;4861.756912154449;4949.183384741549;5351.2875879718895;5253.763580638881;5665.631733937281;5691.459311365414;5703;5711.600187986801;1749.4314347837003;1765.2674140231916;1795.3841542611754;1798.9190486428142;1818.2363407368937;1193.164784650748;1405.5150972914328;1434.870861622459;1436.0613172217422;1454.0621299262127;5296.788128474895;5299.2845965794895;5302.602304827154;5323.600729945269;5333.733313334318;5108.216022267873;5618.348073752012;5643.887122257614;5858.443447872445;5895.970520147372;4306.4066295470875;4373.650107991353;4796.400449943757;4999.725015124203;5349.973250133725;2844.928876778097;3009.714077162666;3036.347185355115;3050.964290530936;3072.6927307269093;5503.642263252876;5838.620489668158;5934.821955341346;5985.102234664835;6123.540734444934;4825.348577942003;5241.397239317527;5616.606837521416;5721.08224805344;5740.569457290637;5109.846704598868;5483.835484935458;6076.6631341104885;6078.513718902565;6139.386061393825;5420.268263784339;5816.807554451412;5839.328477225174;5878.735456904364;5888.676122813286;4736.478987311462;4738.317897146601;5390.299261096033;5659.773609055756;5744.827655170351;4875.731834749123;5516.862078447911;5672.914906276492;5712.228849105484;5862.622283763227;4178.4568006160225;4395.472603253206;4472.9776351118035;4709.011107667428;4712.363830882787;4946.604271658331;5381.892362152813;5675.8864822704145;5869.325027621708;5939.762409503572;5094.6688465249645;5674.771581207184;5701.7434215461235;5728.112142617901;5778.508826749605;5259.501042202954;5379.327584051994;5666.801661941812;5683.8010669626365;5686.431356864446;4859.441164266013;5249.7375131242525;5464.890702186013;5492.917606235989;5533.557315414838;4655.976720116378;4720.12677654635;4983.70423689836;5107.475841669237;5675.0068737971515;5194.922076168936;5206.479352064764;5277.472252774692;5550.4449555044175;5600.943990560042 12:32:06 INFO - PROCESS | 4300 | |5;yui.html;779.4349096904748;810.2181394953876;881.6958149438444;898.9955050224748;917.3945196170529;16478.42325518607;16960.4063857765;17139.400120995768;17313.480595582136;17449.95300281984;15407;15764.605884852856;15981.041137531756;16273.593160171002;16342.264598093085;984.0798853072364;1017.1151098544277;1021.0300214795936;1021.4637315409395;1023.744063984004;1009.5759780892006;1009.6365308488975;1012.0082319327064;1016.293675895253;1039.173856783855;1072.3351522056337;1072.9892701073006;1074.0387353318774;1074.3070719385992;1074.5809134437575;1067.6370034188412;1067.887871773468;1070.0476575847501;1070.6038765656756;1072.8068947589431;793.5516433215215;793.6349279331514;794.8608993426127;796.6415113199083;797.0117054852;16894.83105168945;17029.914850425794;17094.401695940705;17568.29726810926;17864.91067544667;14514.201718905562;14712.852871471363;14827.481038163613;14857.331420086013;14907.850921490755;12139.939300303442;12248.938755306255;12250.326232057234;12303.569375071918;12535.43590538428;3850.306944749944;3861.575226725058;3864.9227015459533;3887.2419878123496;3988.900277493086;61767.69116154435;78904;97705.5114724429;114564.99999999917;121050;11128.66614001565;11284.661460156209;11439.885601143882;11844.230125042017;11874.881251187551;23848.64227036596;23976.16083437106;24031.279061628178;24039.639405408932;24053.278401647978;8206.794830129174;8286.074197258464;8328.250457458858;8335.458195217292;8608.827823443497;4465.508794032654;4590.104929538775;4622.537746225351;4729.290606409066;4857.392825896763;3568.0901370150445;3595.2449985502813;3623.8550457981387;3627.528421305213;3655.415133578668;667.3226674924955;669.3172963577124;675.9526833121732;678.3792829560897;684.7979845945458;599.5263741644139;624.3838317449871;642.6947200080018;664.5281849886538;677.3057615943599;9674.661386851567;9683.854742178732;9744.976777438267;9758.337867722204;9943.502824858728;644.1207751419279;681.924988251292;695.3046953046953;695.9269276725972;708.8688592610383;4625.783777307412;4815.735134567562;4821.7589120543835;4841.9031619367415;4859.839133551019;103684;104691;105572;106806;107111.46444267729;61817.43643072145;62812;73606;88982.11017889867;89089;74032.25967740362;75285.36079182701;77018.99999999888;78036;78239.60880195677;8396.454230475;10624.681259562225;10966.793652698356;11057.944710276397;11315.773684526099;48424;49223.26165107454;49248.261276081605;51147;51242.74378628083;46335.768321158175;63064;63166.10501684957;64239.678801605696;67704.6459070806;12942.621477501782;12958.682605029662;13181.736365272833;13497.797533037208;13524.18854868711;14722.337494812546;14910.627234319229;15091.471798487;15165.09009459436;15754.76367854506;13693.383797729326;14143.292835357985;14172.716545669235;14234.786478202628;14240.786388204393;13219.272939988394;13456.949145772924;14009.673843339107;14155.858441415454;14168.574942751733;13296;13305;13888.375023124187;13908.235047072509;14158.079724817853;9727.610895564381;9932.851007234753;9963.551640176354;10255.794884102426;10389.013043760831;8667.523286219319;10912.399818010086;11233.66299011031;11341.979221870071;11370.715732106764 12:32:06 INFO - PROCESS | 4300 | __end_tp_report 12:32:06 INFO - PROCESS | 4300 | __start_cc_report 12:32:06 INFO - PROCESS | 4300 | _x_x_mozilla_cycle_collect,1369 12:32:06 INFO - PROCESS | 4300 | __end_cc_report 12:32:06 INFO - PROCESS | 4300 | __startTimestamp1496431926046__endTimestamp 12:32:06 INFO - PROCESS | 4300 | 12:32:06 INFO - PROCESS | 4300 | ------- Summary: start ------- 12:32:06 INFO - PROCESS | 4300 | Number of tests: 6 12:32:06 INFO - PROCESS | 4300 | 12:32:06 INFO - PROCESS | 4300 | [#0] dojo.html Cycles:165 Average:6101.00 Median:6342.90 stddev:689.10 (10.9%) stddev-sans-first:643.94 12:32:06 INFO - PROCESS | 4300 | Values: 2903.4 3552.7 3559.5 3577.1 3590.2 6188.8 6212.5 6222.0 6226.8 6247.8 6157.1 6242.0 6246.1 6246.1 6248.4 5501.1 5532.8 5563.7 5587.1 5650.9 5391.4 5425.2 5457.2 5632.3 5654.9 5151.0 5549.2 5566.3 5590.4 5608.9 5642.6 5644.8 5646.2 5656.2 5658.3 5382.0 5502.5 5563.2 5564.8 5578.2 6102.3 6107.8 6112.8 6128.9 6144.5 6559.3 6568.9 6572.8 6572.9 6577.6 5395.7 5536.6 6523.1 6628.0 6678.3 6129.9 6279.2 6362.5 6371.8 6373.9 6591.1 6594.0 6600.4 6604.1 6742.2 6426.3 6427.1 6463.4 6477.0 6481.5 6650.3 6657.5 6669.6 6678.1 6693.1 6317.7 6323.1 6403.8 6536.0 6554.3 6553.3 6567.2 6569.1 6570.3 6572.3 5282.6 5316.3 5334.8 5335.8 5372.0 4664.8 4671.4 4691.2 4758.4 4807.5 6119.7 6207.3 6252.2 6326.5 6335.6 6632.8 6639.6 6646.5 6654.5 6655.8 6224.4 6267.6 6281.5 6297.7 6317.7 5653.1 5686.5 5699.4 5792.2 5806.0 6863.1 6872.6 6883.7 6888.3 6893.7 6578.5 6580.1 6626.0 6631.5 6646.1 6484.7 6521.3 6612.2 6877.3 6890.9 6376.5 6378.4 6392.6 6397.0 6404.2 6507.6 6533.7 6630.3 6646.0 6649.4 6383.6 6446.3 6457.5 6462.0 6475.2 6437.1 6444.2 6447.5 6456.2 6458.8 6268.0 6303.1 6320.6 6342.9 6349.1 5296.8 6408.5 6414.7 6429.9 6438.5 6159.1 6291.8 6353.5 6368.4 6383.6 12:32:06 INFO - PROCESS | 4300 | 12:32:06 INFO - PROCESS | 4300 | [#1] ext.html Cycles:180 Average:60377.00 Median:172975.99 stddev:125966.94 (72.8%) stddev-sans-first:126240.85 12:32:06 INFO - PROCESS | 4300 | Values: 787.9 819.6 830.9 918.0 924.2 29914.6 40771.0 41229.0 41440.4 41442.2 42073.6 42387.0 42387.8 42434.5 42557.8 8016.4 9663.9 9853.8 9866.6 9868.3 8091.5 11632.8 11847.0 12031.4 12073.9 11906.5 11922.2 11922.9 11924.0 11942.0 11876.3 11885.7 11893.8 11899.0 11946.7 10621.7 10748.3 11509.5 11589.4 11611.2 39837.6 39993.8 40069.0 40130.6 40147.4 4074.9 4107.0 4112.3 4114.9 4145.3 27680.9 28301.7 30134.7 30379.4 30582.0 3278.4 3288.6 3319.5 3401.1 3420.0 339105.0 342532.0 342673.0 343605.0 343764.0 51894.0 51914.7 51975.7 51984.5 52013.7 54555.7 54660.2 54726.0 54776.0 54872.7 15465.5 15609.5 15611.9 15619.3 15636.8 11708.8 11839.4 13420.6 13480.9 13511.6 10490.7 10555.5 10562.5 10563.6 14332.8 5157.9 5273.7 6182.3 6188.2 6240.3 1132.4 1145.3 1178.9 1187.4 1256.4 26568.9 28174.7 28618.1 28716.7 28772.1 976.8 1004.3 1007.7 1103.1 1287.7 13222.5 13229.7 13453.9 13484.7 13749.1 512793.0 515430.0 515566.0 515976.0 517464.0 37842.7 39817.2 42845.0 47811.0 48196.5 1433.1 1466.9 1477.9 1487.5 1492.9 26094.6 27800.3 28209.0 28224.7 28349.1 42255.8 42651.4 42704.8 42805.6 42886.6 486767.0 496319.0 535167.0 541899.0 615764.0 38815.4 39920.6 40662.8 40791.2 40925.4 50383.0 50925.0 51283.5 51558.0 51883.5 29011.7 29796.1 31302.4 31582.5 32341.0 33010.9 33064.8 33165.9 33822.5 34335.1 39689.4 40182.8 41826.2 41844.0 41977.0 28143.7 33064.7 34348.5 35234.8 35345.8 19960.7 23746.8 25589.0 26958.9 27011.9 12:32:06 INFO - PROCESS | 4300 | 12:32:06 INFO - PROCESS | 4300 | [#2] jquery.html Cycles:180 Average:44073.67 Median:22958.71 stddev:125347.55 (546.0%) stddev-sans-first:125656.26 12:32:06 INFO - PROCESS | 4300 | Values: 390.4 394.5 426.7 434.4 443.4 19636.8 20639.2 21594.2 21683.5 21770.0 22516.4 22819.2 23021.9 23051.9 23267.4 5750.5 6999.2 7026.2 7042.1 7043.2 7380.7 7677.8 7863.7 7872.9 7876.4 7590.3 7771.3 7860.9 7862.8 7872.8 7830.6 7850.8 7864.2 7936.7 7942.0 7536.2 7620.6 7765.7 7769.1 7773.9 27452.0 27749.6 27758.9 27928.0 28227.2 3472.7 3483.2 3506.1 3544.7 3626.4 15720.8 17342.5 17348.9 17770.4 17839.6 1983.9 2010.6 2024.1 2028.1 2067.3 163058.0 173142.0 177787.0 179395.1 179458.1 17139.0 20704.9 20790.7 20984.9 21300.9 33505.3 33749.8 34246.0 34290.3 34366.1 10604.4 10695.8 10822.3 10853.7 11127.8 8949.1 8956.6 8993.5 9164.0 9183.8 7826.8 9601.6 9710.2 9825.5 9831.1 3955.0 4044.9 4056.1 4061.2 4062.4 665.3 915.6 931.5 950.1 979.1 22288.3 22306.6 22895.5 23150.8 23487.6 953.6 972.8 985.4 995.8 1006.1 11631.4 11689.4 11870.0 11916.5 11933.9 718034.0 750679.0 751387.0 760803.0 762594.0 106692.0 147320.3 162021.0 164049.0 173112.0 1320.3 1325.2 1377.9 1380.1 1382.3 20206.8 20676.2 20733.4 21188.3 21201.2 52974.7 62816.0 63223.7 64742.0 65797.7 73885.3 88072.6 89910.7 91647.5 92722.2 11836.4 11989.7 12021.9 12377.1 12414.6 13589.5 13602.6 13613.8 13928.7 14037.0 11656.7 11671.6 11770.2 11953.8 12147.8 10796.5 10946.9 11178.7 11211.1 11297.2 11797.4 11969.6 12100.0 12189.1 12301.0 11952.6 12004.2 12229.6 12354.1 12408.8 10270.6 11681.7 11716.7 11840.7 12003.9 12:32:06 INFO - PROCESS | 4300 | 12:32:06 INFO - PROCESS | 4300 | [#3] mootools.html Cycles:180 Average:6759.16 Median:2512.88 stddev:4211.52 (167.6%) stddev-sans-first:4204.58 12:32:06 INFO - PROCESS | 4300 | Values: 1469.3 1598.7 1610.8 1623.9 1639.2 9088.9 11498.4 11509.2 11509.5 11518.0 10941.2 11249.8 11258.2 11492.1 11518.7 2050.2 2257.6 2380.3 2530.7 2532.4 2063.3 2425.2 2512.3 2513.5 2517.1 2414.9 2478.6 2487.1 2501.1 2504.6 2374.8 2423.3 2434.6 2435.1 2478.9 2443.6 2467.6 2471.5 2475.4 2475.8 9655.2 11230.0 11437.1 11476.0 11481.4 5912.2 6088.2 6106.3 6112.7 6116.8 3166.2 3475.7 3657.8 3719.1 3744.6 1224.8 1241.8 1264.2 1270.5 1312.1 13552.6 13808.9 14136.9 15523.4 15729.3 3703.6 4066.0 4310.3 4446.3 4968.6 12050.7 12066.2 12092.2 12095.8 12103.0 5555.2 6080.2 6100.6 6101.1 6118.5 5190.7 5411.0 5498.8 5562.4 5570.8 3930.2 3989.5 4036.9 4076.7 4078.0 1066.4 1070.9 1072.7 1086.5 1087.3 929.7 931.9 935.5 963.8 1018.6 6449.6 6536.7 6549.5 6574.7 6750.8 964.4 982.6 1034.8 1053.5 1064.6 3713.0 3826.7 4064.7 4088.2 4335.9 12494.6 13748.1 13758.7 14231.9 14337.6 13391.9 13913.4 14144.6 14169.3 14192.8 8918.4 9210.8 10281.9 10564.6 10609.6 5522.5 6645.2 6718.5 6838.4 6843.5 11991.0 12103.1 12170.5 12176.0 12225.6 12023.8 12215.8 12277.8 12338.5 12432.3 7892.3 9465.2 9530.6 9564.5 9567.4 10215.2 10410.7 10443.8 10447.0 10461.3 8725.0 8839.3 8933.4 8933.5 8943.2 8669.4 8741.0 8755.0 8763.5 8767.8 7795.6 7984.9 7989.6 7999.7 7999.9 5108.7 5761.7 5803.4 5821.5 6022.5 5769.3 5879.2 5967.6 6044.4 6165.0 12:32:06 INFO - PROCESS | 4300 | 12:32:06 INFO - PROCESS | 4300 | [#4] prototype.html Cycles:180 Average:4690.95 Median:5038.11 stddev:1264.15 (25.1%) stddev-sans-first:1224.41 12:32:06 INFO - PROCESS | 4300 | Values: 320.9 350.7 396.2 398.2 402.1 4412.9 5382.1 5458.9 5461.6 5467.3 4154.3 4698.7 4968.3 5220.2 5277.0 4039.4 4119.9 4384.4 4408.8 4410.8 3986.4 4218.0 4253.4 4443.7 4488.6 3838.7 3958.4 4225.8 4283.2 4415.7 3838.4 4347.2 4351.3 4353.8 4381.4 3887.7 3997.8 4016.4 4041.6 4046.6 4871.9 5029.3 5228.3 5280.4 5304.9 4215.9 4363.8 4821.3 5046.9 5077.5 4431.6 4737.1 4882.6 5450.8 5756.5 4431.5 4547.7 4574.8 4596.0 4602.9 4990.3 5333.4 5461.1 5946.3 6023.6 4177.0 4520.7 4628.0 5009.0 5105.3 4528.5 4921.3 5148.3 5168.7 5176.9 4299.6 4333.3 4861.8 4949.2 5351.3 5253.8 5665.6 5691.5 5703.0 5711.6 1749.4 1765.3 1795.4 1798.9 1818.2 1193.2 1405.5 1434.9 1436.1 1454.1 5296.8 5299.3 5302.6 5323.6 5333.7 5108.2 5618.3 5643.9 5858.4 5896.0 4306.4 4373.7 4796.4 4999.7 5350.0 2844.9 3009.7 3036.3 3051.0 3072.7 5503.6 5838.6 5934.8 5985.1 6123.5 4825.3 5241.4 5616.6 5721.1 5740.6 5109.8 5483.8 6076.7 6078.5 6139.4 5420.3 5816.8 5839.3 5878.7 5888.7 4736.5 4738.3 5390.3 5659.8 5744.8 4875.7 5516.9 5672.9 5712.2 5862.6 4178.5 4395.5 4473.0 4709.0 4712.4 4946.6 5381.9 5675.9 5869.3 5939.8 5094.7 5674.8 5701.7 5728.1 5778.5 5259.5 5379.3 5666.8 5683.8 5686.4 4859.4 5249.7 5464.9 5492.9 5533.6 4656.0 4720.1 4983.7 5107.5 5675.0 5194.9 5206.5 5277.5 5550.4 5600.9 12:32:06 INFO - PROCESS | 4300 | 12:32:06 INFO - PROCESS | 4300 | [#5] yui.html Cycles:180 Average:19996.55 Median:20856.78 stddev:27776.07 (133.2%) stddev-sans-first:27816.51 12:32:06 INFO - PROCESS | 4300 | Values: 779.4 810.2 881.7 899.0 917.4 16478.4 16960.4 17139.4 17313.5 17450.0 15407.0 15764.6 15981.0 16273.6 16342.3 984.1 1017.1 1021.0 1021.5 1023.7 1009.6 1009.6 1012.0 1016.3 1039.2 1072.3 1073.0 1074.0 1074.3 1074.6 1067.6 1067.9 1070.0 1070.6 1072.8 793.6 793.6 794.9 796.6 797.0 16894.8 17029.9 17094.4 17568.3 17864.9 14514.2 14712.9 14827.5 14857.3 14907.9 12139.9 12248.9 12250.3 12303.6 12535.4 3850.3 3861.6 3864.9 3887.2 3988.9 61767.7 78904.0 97705.5 114565.0 121050.0 11128.7 11284.7 11439.9 11844.2 11874.9 23848.6 23976.2 24031.3 24039.6 24053.3 8206.8 8286.1 8328.3 8335.5 8608.8 4465.5 4590.1 4622.5 4729.3 4857.4 3568.1 3595.2 3623.9 3627.5 3655.4 667.3 669.3 676.0 678.4 684.8 599.5 624.4 642.7 664.5 677.3 9674.7 9683.9 9745.0 9758.3 9943.5 644.1 681.9 695.3 695.9 708.9 4625.8 4815.7 4821.8 4841.9 4859.8 103684.0 104691.0 105572.0 106806.0 107111.5 61817.4 62812.0 73606.0 88982.1 89089.0 74032.3 75285.4 77019.0 78036.0 78239.6 8396.5 10624.7 10966.8 11057.9 11315.8 48424.0 49223.3 49248.3 51147.0 51242.7 46335.8 63064.0 63166.1 64239.7 67704.6 12942.6 12958.7 13181.7 13497.8 13524.2 14722.3 14910.6 15091.5 15165.1 15754.8 13693.4 14143.3 14172.7 14234.8 14240.8 13219.3 13456.9 14009.7 14155.9 14168.6 13296.0 13305.0 13888.4 13908.2 14158.1 9727.6 9932.9 9963.6 10255.8 10389.0 8667.5 10912.4 11233.7 11342.0 11370.7 12:32:06 INFO - PROCESS | 4300 | -------- Summary: end -------- 12:32:06 INFO - PROCESS | 4300 | 12:32:06 INFO - TEST-INFO | 4300: exit 0 12:32:06 INFO - TEST-OK | dromaeo_css | took 1118895ms 12:32:06 INFO - TEST-START | kraken 12:32:06 INFO - operating with platform_type : mac_ 12:32:06 INFO - Initialising browser for kraken test... 12:32:06 INFO - TEST-INFO | started process 4303 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/tmpdvcC1M/profile http://localhost:54502/getInfo.html) 12:32:08 INFO - PROCESS | 4303 | __metrics Screen width/height:1600/1200 12:32:08 INFO - PROCESS | 4303 | colorDepth:24 12:32:08 INFO - PROCESS | 4303 | Browser inner width/height: 1024/689 12:32:08 INFO - PROCESS | 4303 | __metrics 12:32:09 INFO - PROCESS | 4303 | 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" 12:32:09 INFO - PROCESS | 4303 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:32:09 INFO - TEST-INFO | 4303: exit 0 12:32:09 INFO - Browser initialized. 12:32:09 INFO - Running cycle 1/1 for kraken test... 12:32:09 INFO - TEST-INFO | started process 4305 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/tmpdvcC1M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:32:21 INFO - PROCESS | 4305 | RSS: Main: 165249024 12:32:21 INFO - PROCESS | 4305 | 12:32:24 INFO - PROCESS | 4305 | Cycle 1(1): loaded http://localhost:54502/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54502/tests/kraken/driver.html?testName=audio-beat-detection) 12:32:25 INFO - PROCESS | 4305 | RSS: Main: 216252416 12:32:25 INFO - PROCESS | 4305 | 12:32:28 INFO - PROCESS | 4305 | Cycle 1(1): loaded http://localhost:54502/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54502/tests/kraken/driver.html?testName=audio-dft) 12:32:28 INFO - PROCESS | 4305 | RSS: Main: 231718912 12:32:28 INFO - PROCESS | 4305 | 12:32:31 INFO - PROCESS | 4305 | Cycle 1(1): loaded http://localhost:54502/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54502/tests/kraken/driver.html?testName=audio-fft) 12:32:32 INFO - PROCESS | 4305 | RSS: Main: 327970816 12:32:32 INFO - PROCESS | 4305 | 12:32:34 INFO - PROCESS | 4305 | Cycle 1(1): loaded http://localhost:54502/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54502/tests/kraken/driver.html?testName=audio-oscillator) 12:32:35 INFO - PROCESS | 4305 | RSS: Main: 230608896 12:32:35 INFO - PROCESS | 4305 | 12:32:37 INFO - PROCESS | 4305 | Cycle 1(1): loaded http://localhost:54502/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54502/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:32:37 INFO - PROCESS | 4305 | RSS: Main: 232062976 12:32:37 INFO - PROCESS | 4305 | 12:32:40 INFO - PROCESS | 4305 | Cycle 1(1): loaded http://localhost:54502/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54502/tests/kraken/driver.html?testName=imaging-darkroom) 12:32:41 INFO - PROCESS | 4305 | RSS: Main: 271339520 12:32:41 INFO - PROCESS | 4305 | 12:32:44 INFO - PROCESS | 4305 | Cycle 1(1): loaded http://localhost:54502/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54502/tests/kraken/driver.html?testName=imaging-desaturate) 12:32:45 INFO - PROCESS | 4305 | RSS: Main: 272171008 12:32:45 INFO - PROCESS | 4305 | 12:32:47 INFO - PROCESS | 4305 | Cycle 1(1): loaded http://localhost:54502/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54502/tests/kraken/driver.html?testName=json-parse-financial) 12:32:48 INFO - PROCESS | 4305 | RSS: Main: 269488128 12:32:48 INFO - PROCESS | 4305 | 12:32:50 INFO - PROCESS | 4305 | Cycle 1(1): loaded http://localhost:54502/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54502/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:32:50 INFO - PROCESS | 4305 | RSS: Main: 247791616 12:32:50 INFO - PROCESS | 4305 | 12:32:52 INFO - PROCESS | 4305 | Cycle 1(1): loaded http://localhost:54502/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54502/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:32:53 INFO - PROCESS | 4305 | RSS: Main: 251637760 12:32:53 INFO - PROCESS | 4305 | 12:32:55 INFO - PROCESS | 4305 | Cycle 1(1): loaded http://localhost:54502/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54502/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:32:56 INFO - PROCESS | 4305 | RSS: Main: 256589824 12:32:56 INFO - PROCESS | 4305 | 12:32:59 INFO - PROCESS | 4305 | Cycle 1(1): loaded http://localhost:54502/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:32:59 INFO - PROCESS | 4305 | RSS: Main: 274067456 12:32:59 INFO - PROCESS | 4305 | 12:33:02 INFO - PROCESS | 4305 | Cycle 1(1): loaded http://localhost:54502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:33:03 INFO - PROCESS | 4305 | RSS: Main: 267505664 12:33:03 INFO - PROCESS | 4305 | 12:33:04 INFO - PROCESS | 4305 | Cycle 1(1): loaded http://localhost:54502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54502/tests/kraken/driver.html?testName=ai-astar) 12:33:05 INFO - PROCESS | 4305 | RSS: Main: 312377344 12:33:05 INFO - PROCESS | 4305 | 12:33:05 INFO - PROCESS | 4305 | __start_tp_report 12:33:05 INFO - PROCESS | 4305 | _x_x_mozilla_page_load 12:33:05 INFO - PROCESS | 4305 | _x_x_mozilla_page_load_details 12:33:05 INFO - PROCESS | 4305 | |i|pagename|runs| 12:33:05 INFO - PROCESS | 4305 | |0;ai-astar;102;115;115;113;116;153;169;114;114;114 12:33:05 INFO - PROCESS | 4305 | |1;audio-beat-detection;135;106;107;139;109;116;139;115;126;107 12:33:05 INFO - PROCESS | 4305 | |2;audio-dft;187;186;186;187;183;185;187;183;187;183 12:33:05 INFO - PROCESS | 4305 | |3;audio-fft;82;58;59;95;61;59;60;58;77;59 12:33:05 INFO - PROCESS | 4305 | |4;audio-oscillator;87;69;89;69;69;68;83;68;70;82 12:33:05 INFO - PROCESS | 4305 | |5;imaging-gaussian-blur;87;88;86;87;87;86;87;87;87;90 12:33:05 INFO - PROCESS | 4305 | |6;imaging-darkroom;94;94;93;96;94;110;149;147;93;93 12:33:05 INFO - PROCESS | 4305 | |7;imaging-desaturate;83;83;84;82;85;86;83;84;86;84 12:33:05 INFO - PROCESS | 4305 | |8;json-parse-financial;63;59;54;57;61;61;62;60;62;62 12:33:05 INFO - PROCESS | 4305 | |9;json-stringify-tinderbox;54;67;68;64;52;58;81;85;85;61 12:33:05 INFO - PROCESS | 4305 | |10;stanford-crypto-aes;79;82;85;83;85;92;101;91;85;84 12:33:05 INFO - PROCESS | 4305 | |11;stanford-crypto-ccm;146;154;142;140;132;136;128;143;196;174 12:33:05 INFO - PROCESS | 4305 | |12;stanford-crypto-pbkdf2;163;169;165;162;163;157;162;165;160;162 12:33:05 INFO - PROCESS | 4305 | |13;stanford-crypto-sha256-iterative;66;66;66;65;63;63;63;64;64;62 12:33:05 INFO - PROCESS | 4305 | __end_tp_report 12:33:05 INFO - PROCESS | 4305 | __start_cc_report 12:33:05 INFO - PROCESS | 4305 | _x_x_mozilla_cycle_collect,2085 12:33:05 INFO - PROCESS | 4305 | __end_cc_report 12:33:05 INFO - PROCESS | 4305 | __startTimestamp1496431985234__endTimestamp 12:33:05 INFO - PROCESS | 4305 | 12:33:05 INFO - PROCESS | 4305 | ------- Summary: start ------- 12:33:05 INFO - PROCESS | 4305 | Number of tests: 14 12:33:05 INFO - PROCESS | 4305 | 12:33:05 INFO - PROCESS | 4305 | [#0] ai-astar Cycles:10 Average:122.50 Median:115.00 stddev:21.01 (18.3%) stddev-sans-first:20.94 12:33:05 INFO - PROCESS | 4305 | Values: 102.0 115.0 115.0 113.0 116.0 153.0 169.0 114.0 114.0 114.0 12:33:05 INFO - PROCESS | 4305 | 12:33:05 INFO - PROCESS | 4305 | [#1] audio-beat-detection Cycles:10 Average:119.90 Median:121.00 stddev:13.66 (11.3%) stddev-sans-first:13.35 12:33:05 INFO - PROCESS | 4305 | Values: 135.0 106.0 107.0 139.0 109.0 116.0 139.0 115.0 126.0 107.0 12:33:05 INFO - PROCESS | 4305 | 12:33:05 INFO - PROCESS | 4305 | [#2] audio-dft Cycles:10 Average:185.40 Median:186.50 stddev:1.78 (1.0%) stddev-sans-first:1.79 12:33:05 INFO - PROCESS | 4305 | Values: 187.0 186.0 186.0 187.0 183.0 185.0 187.0 183.0 187.0 183.0 12:33:05 INFO - PROCESS | 4305 | 12:33:05 INFO - PROCESS | 4305 | [#3] audio-fft Cycles:10 Average:66.80 Median:60.50 stddev:13.11 (21.7%) stddev-sans-first:12.70 12:33:05 INFO - PROCESS | 4305 | Values: 82.0 58.0 59.0 95.0 61.0 59.0 60.0 58.0 77.0 59.0 12:33:05 INFO - PROCESS | 4305 | 12:33:05 INFO - PROCESS | 4305 | [#4] audio-oscillator Cycles:10 Average:75.40 Median:76.00 stddev:8.71 (11.5%) stddev-sans-first:8.16 12:33:05 INFO - PROCESS | 4305 | Values: 87.0 69.0 89.0 69.0 69.0 68.0 83.0 68.0 70.0 82.0 12:33:05 INFO - PROCESS | 4305 | 12:33:05 INFO - PROCESS | 4305 | [#5] imaging-gaussian-blur Cycles:10 Average:87.20 Median:87.00 stddev:1.14 (1.3%) stddev-sans-first:1.20 12:33:05 INFO - PROCESS | 4305 | Values: 87.0 88.0 86.0 87.0 87.0 86.0 87.0 87.0 87.0 90.0 12:33:05 INFO - PROCESS | 4305 | 12:33:05 INFO - PROCESS | 4305 | [#6] imaging-darkroom Cycles:10 Average:106.30 Median:93.50 stddev:22.57 (24.1%) stddev-sans-first:23.49 12:33:05 INFO - PROCESS | 4305 | Values: 94.0 94.0 93.0 96.0 94.0 110.0 149.0 147.0 93.0 93.0 12:33:05 INFO - PROCESS | 4305 | 12:33:05 INFO - PROCESS | 4305 | [#7] imaging-desaturate Cycles:10 Average:84.00 Median:84.00 stddev:1.33 (1.6%) stddev-sans-first:1.36 12:33:05 INFO - PROCESS | 4305 | Values: 83.0 83.0 84.0 82.0 85.0 86.0 83.0 84.0 86.0 84.0 12:33:05 INFO - PROCESS | 4305 | 12:33:05 INFO - PROCESS | 4305 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:61.50 stddev:2.77 (4.5%) stddev-sans-first:2.73 12:33:05 INFO - PROCESS | 4305 | Values: 63.0 59.0 54.0 57.0 61.0 61.0 62.0 60.0 62.0 62.0 12:33:05 INFO - PROCESS | 4305 | 12:33:05 INFO - PROCESS | 4305 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.50 stddev:12.30 (18.2%) stddev-sans-first:12.04 12:33:05 INFO - PROCESS | 4305 | Values: 54.0 67.0 68.0 64.0 52.0 58.0 81.0 85.0 85.0 61.0 12:33:05 INFO - PROCESS | 4305 | 12:33:05 INFO - PROCESS | 4305 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:85.00 stddev:6.34 (7.5%) stddev-sans-first:6.09 12:33:05 INFO - PROCESS | 4305 | Values: 79.0 82.0 85.0 83.0 85.0 92.0 101.0 91.0 85.0 84.0 12:33:05 INFO - PROCESS | 4305 | 12:33:05 INFO - PROCESS | 4305 | [#11] stanford-crypto-ccm Cycles:10 Average:149.10 Median:144.50 stddev:20.90 (14.5%) stddev-sans-first:22.14 12:33:05 INFO - PROCESS | 4305 | Values: 146.0 154.0 142.0 140.0 132.0 136.0 128.0 143.0 196.0 174.0 12:33:05 INFO - PROCESS | 4305 | 12:33:05 INFO - PROCESS | 4305 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.80 Median:163.00 stddev:3.19 (2.0%) stddev-sans-first:3.38 12:33:05 INFO - PROCESS | 4305 | Values: 163.0 169.0 165.0 162.0 163.0 157.0 162.0 165.0 160.0 162.0 12:33:05 INFO - PROCESS | 4305 | 12:33:05 INFO - PROCESS | 4305 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.50 stddev:1.48 (2.3%) stddev-sans-first:1.41 12:33:05 INFO - PROCESS | 4305 | Values: 66.0 66.0 66.0 65.0 63.0 63.0 63.0 64.0 64.0 62.0 12:33:05 INFO - PROCESS | 4305 | -------- Summary: end -------- 12:33:05 INFO - PROCESS | 4305 | 12:33:06 INFO - TEST-INFO | 4305: exit 0 12:33:06 INFO - TEST-OK | kraken | took 59425ms 12:33:06 INFO - SUITE-END | took 1178s 12:33:06 INFO - Completed test suite (00:19:38) 12:33:06 INFO - javascript benchmark 12:33:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7959.116749885889, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2903.361260522685, 3552.68025877671, 3559.5194648722413, 3577.052081198481, 3590.1563132663837, 6188.752449902004, 6212.5029997600195, 6222.0355844844125, 6226.7820626278035, 6247.843803904899, 6157.138000679897, 6242.001279795234, 6246.063090536421, 6246.125542424053, 6248.37516248375, 5501.119820828668, 5532.7786888524415, 5563.666180029191, 5587.106063029916, 5650.858728531778, 5391.406945236021, 5425.213344065108, 5457.2359869618085, 5632.324121105473, 5654.9151762723595, 5151.0, 5549.19536667183, 5566.276384070065, 5590.357108932484, 5608.887822243552, 5642.605017648766, 5644.774209031654, 5646.153077038436, 5656.236408084897, 5658.349289831681, 5381.973090134564, 5502.532284755801, 5563.165525171216, 5564.777408903639, 5578.246936663539, 6102.328743838174, 6107.786227482017, 6112.755489780404, 6128.877422451571, 6144.539159563006, 6559.311272316386, 6568.901466478007, 6572.769953051668, 6572.868542629169, 6577.6053436793945, 5395.7032363220005, 5536.557075433956, 6523.054157147187, 6628.0, 6678.332166783282, 6129.938700613026, 6279.246490421178, 6362.491000720024, 6371.8407039823915, 6373.872522549523, 6591.077249185118, 6593.967030164818, 6600.438962688129, 6604.1084453599115, 6742.157230346207, 6426.325235850262, 6427.132337134427, 6463.385978332145, 6476.967615161894, 6481.5138864584405, 6650.301718319603, 6657.500687448364, 6669.566478178903, 6678.09845670838, 6693.062971184038, 6317.747290108436, 6323.051542268697, 6403.775867844696, 6535.967320163369, 6554.3445655435025, 6553.311902250195, 6567.179102612174, 6569.113169722122, 6570.342965703487, 6572.34276572339, 5282.603804714662, 5316.308879845596, 5334.839954801362, 5335.759890804923, 5371.973140134274, 4664.766761661904, 4671.43942726875, 4691.225947718656, 4758.357621721093, 4807.543283388142, 6119.715820550745, 6207.255129384503, 6252.155958945576, 6326.5255105867245, 6335.556511044183, 6632.834179145463, 6639.601623902581, 6646.468282537386, 6654.534182607171, 6655.767048153291, 6224.408681175371, 6267.62394256346, 6281.528885333618, 6297.716602752796, 6317.652529110851, 5653.067243904709, 5686.459786320293, 5699.430056994267, 5792.160136780228, 5806.0, 6863.10779598649, 6872.62200578973, 6883.724651014104, 6888.276730943379, 6893.724251030003, 6578.473722102125, 6580.1116849224745, 6625.966870165618, 6631.502637302318, 6646.069550263063, 6484.740610375532, 6521.315261897622, 6612.173478315211, 6877.346652068046, 6890.8621827564175, 6376.458001069961, 6378.394052564999, 6392.648404337806, 6397.0, 6404.1674582304, 6507.609543427409, 6533.67331633407, 6630.336966303331, 6646.0, 6649.434798042221, 6383.648899310582, 6446.290908000023, 6457.515686323451, 6461.967690161519, 6475.222973243241, 6437.066625339393, 6444.162258906312, 6447.451966582893, 6456.192975878015, 6458.806235812933, 6268.0, 6303.054541818764, 6320.62076275425, 6342.904856427065, 6349.111124442674, 5296.761645725875, 6408.487321014401, 6414.711337989708, 6429.935700642934, 6438.4527315176865, 6159.106929495288, 6291.811245662638, 6353.459955903615, 6368.363163683594, 6383.585066970632], "value": 6055.747261332675, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [787.9251471110246, 819.6147810529051, 830.8961379827523, 917.9632814687412, 924.1774820409833, 29914.551281730764, 40771.0, 41229.0, 41440.378394324034, 41442.17115657693, 42073.57926420735, 42387.0, 42387.78806105973, 42434.514791982285, 42557.78721106398, 8016.398770092237, 9663.903360966371, 9853.753656158617, 9866.605335786597, 9868.259880508955, 8091.474054186459, 11632.825507617392, 11847.0, 12031.398430078505, 12073.879261207363, 11906.46420911061, 11922.165448418615, 11922.880771192264, 11924.046076313918, 11942.044636429107, 11876.346800925945, 11885.702857428547, 11893.821592676117, 11899.0, 11946.701332466671, 10621.73445663857, 10748.301360411626, 11509.539618415338, 11589.420528973602, 11611.187216894821, 39837.601623983675, 39993.80018599446, 40068.998275043356, 40130.59869401327, 40147.39778903319, 4074.8981275468054, 4107.034846810997, 4112.300908845474, 4114.897127571805, 4145.274576949022, 27680.861595692095, 28301.716982830116, 30134.685184629674, 30379.392412151854, 30582.0, 3278.393497203025, 3288.588926384202, 3319.4854797506423, 3401.098708842159, 3419.9829000855084, 339105.0, 342532.0, 342673.0, 343605.0, 343764.0, 51894.0, 51914.740426298384, 51975.74012129915, 51984.48015519796, 52013.7399313001, 54555.72722136443, 54660.18009729857, 54726.0, 54776.0, 54872.725636371564, 15465.458708945358, 15609.453669121753, 15611.921940390226, 15619.297131629104, 15636.765448518281, 11708.765824683458, 11839.408029598486, 13420.597382078553, 13480.93259533696, 13511.594652160451, 10490.685279441628, 10555.47222638865, 10562.524686389132, 10563.577456901638, 14332.785008224884, 5157.871053223699, 5273.683578985273, 6182.258129024546, 6188.195534580475, 6240.344763799826, 1132.4394424759796, 1145.2613064573304, 1178.8644305904759, 1187.4181650990952, 1256.447163248168, 26568.8671556641, 28174.71825281762, 28618.141455756362, 28716.71283287182, 28772.136835894955, 976.829054915387, 1004.3020101029861, 1007.7178390050798, 1103.1175059952006, 1287.7360141171037, 13222.537211197561, 13229.669258268428, 13453.932730336286, 13484.662883427796, 13749.106308089942, 512793.0, 515430.0, 515566.0, 515976.0, 517464.0, 37842.67550635715, 39817.2036559273, 42845.0, 47811.0, 48196.5180348192, 1433.1472773699631, 1466.8973171877867, 1477.8522147785136, 1487.5462983789832, 1492.8656420921952, 26094.60858087092, 27800.304992375353, 28209.012684555943, 28224.71775282303, 28349.14952551427, 42255.7887210562, 42651.36022959596, 42704.78647606742, 42805.57194428016, 42886.57113428951, 486767.0, 496319.0, 535167.0, 541899.0, 615764.0, 38815.41776873293, 39920.60079399169, 40662.79668601638, 40791.18417631571, 40925.386119207644, 50383.0, 50925.0, 51283.487165129365, 51558.0, 51883.48116518786, 29011.709882901745, 29796.10611681653, 31302.373952521277, 31582.526262105628, 32341.0, 33010.89593192015, 33064.83467582647, 33165.8944485266, 33822.49266260959, 34335.14162145966, 39689.40465892956, 40182.79908600439, 41826.163476729685, 41843.95390115149, 41977.0, 28143.718562814927, 33064.66935330616, 34348.48477272793, 35234.8238258807, 35345.823270883484, 19960.70058949146, 23746.762532374454, 25589.0, 26958.865205673847, 27011.864940675172], "value": 19628.629489122155, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.3598099117448, 394.4812571468519, 426.69064927927275, 434.4352341955457, 443.35270505062596, 19636.803631963678, 20639.17443302268, 21594.24420145295, 21683.45791355215, 21770.0, 22516.43708907278, 22819.201327953524, 23021.884890575522, 23051.884740576275, 23267.418314542145, 5750.482456578897, 6999.160100787913, 7026.156861176666, 7042.119735033121, 7043.225245223021, 7380.667869945839, 7677.846443071136, 7863.724769633064, 7872.881906771375, 7876.448648594601, 7590.316871481566, 7771.261730135628, 7860.882086768703, 7862.764117076468, 7872.763817085468, 7830.6084695764985, 7850.803729906741, 7864.213578642119, 7936.722214722486, 7942.0, 7536.208698086677, 7620.580868052255, 7765.72819951299, 7769.067711874554, 7773.922260777376, 27452.039178628853, 27749.58375624367, 27758.861205693844, 27928.0, 28227.177282271812, 3472.722182225416, 3483.164040630256, 3506.143990573049, 3544.7341449391397, 3626.4197728363333, 15720.842791572166, 17342.479725608253, 17348.86775182072, 17770.378036768652, 17839.554011149696, 1983.8512111591688, 2010.577778666482, 2024.129624261567, 2028.0670891389977, 2067.2764532413685, 163058.0, 173142.0, 177787.0, 179395.10302448535, 179458.10270948694, 17139.0, 20704.896475517526, 20790.688139677917, 20984.895075524524, 21300.89349553273, 33505.32473376321, 33749.83125084408, 34246.0, 34290.31419371599, 34366.14084647904, 10604.416757078434, 10695.78608427827, 10822.296550724177, 10853.674389768319, 11127.833082503606, 8949.060348663426, 8956.596953136994, 8993.505357205286, 9163.954180229057, 9183.816323673624, 7826.8434631307055, 9601.567929443192, 9710.223182145412, 9825.459599722084, 9831.115199632068, 3954.982958691031, 4044.858429954996, 4056.087380339459, 4061.1674606705556, 4062.370332598452, 665.2806652806723, 915.6200176926634, 931.487681775021, 950.1021534649827, 979.1383582447401, 22288.32837537191, 22306.553868922856, 22895.542089158458, 23150.768492315197, 23487.647685284734, 953.5994882149514, 972.7568107973007, 985.3841349156777, 995.8107959487675, 1006.1296978113879, 11631.360275184777, 11689.415529223505, 11870.0, 11916.52333906634, 11933.940330298294, 718034.0, 750679.0, 751387.0, 760803.0, 762594.0, 106692.0, 147320.26339868232, 162021.0, 164049.0, 173112.0, 1320.306838909561, 1325.1982550556968, 1377.9104358216885, 1380.1236215003546, 1382.2743059893435, 20206.79793202108, 20676.172953081707, 20733.377998660064, 21188.258410955543, 21201.15195392167, 52974.73512632412, 62816.0, 63223.6838815803, 64741.999999998116, 65797.67101164655, 73885.26114738999, 88072.5596372014, 89910.65134023126, 91647.54176229076, 92722.2183334501, 11836.408179590813, 11989.700257493632, 12021.939890300493, 12377.071719621244, 12414.565490207799, 13589.45642174302, 13602.591922242349, 13613.795793062915, 13928.651783705489, 14037.017408781287, 11656.650300491, 11671.649850504498, 11770.234934729215, 11953.820692689442, 12147.75704485923, 10796.460176991277, 10946.890531094587, 11178.72053198644, 11211.103111750877, 11297.152713546353, 11797.35114568707, 11969.581064662694, 12100.0, 12189.146759726735, 12301.0, 11952.58165964187, 12004.199370094555, 12229.633111006684, 12354.073444491878, 12408.759124087519, 10270.589176433157, 11681.707957301136, 11716.70708232301, 11840.703982400164, 12003.939980300043], "value": 12159.823443730858, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1469.3241109089818, 1598.680263947211, 1610.8147563030254, 1623.926923288452, 1639.1640263465633, 9088.90911090889, 11498.42507874606, 11509.194356395055, 11509.539618415254, 11518.0, 10941.23411361205, 11249.831252531198, 11258.155638327118, 11492.13808964329, 11518.712032199199, 2050.241410678051, 2257.6274914639066, 2380.309710184053, 2530.708968468631, 2532.392225865788, 2063.2675400232924, 2425.2360506440414, 2512.271441282026, 2513.49730053989, 2517.0686845866962, 2414.8671823049726, 2478.5538603051446, 2487.141936032066, 2501.0996041425074, 2504.5742223821903, 2374.7625237476113, 2423.297243799296, 2434.5861203595255, 2435.1233555919853, 2478.8512689238705, 2443.5845906195814, 2467.617519284514, 2471.468634243646, 2475.4306509502917, 2475.7524247575097, 9655.17930975868, 11230.045446137088, 11437.142214333875, 11476.0, 11481.425928703531, 5912.201852749867, 6088.238970128734, 6106.297775755756, 6112.6638034908065, 6116.785912493086, 3166.224275052604, 3475.7139858252353, 3657.7929283336434, 3719.0702324418894, 3744.5693745219105, 1224.8407706998032, 1241.7951038078706, 1264.1719673613798, 1270.4854533913779, 1312.127435255554, 13552.59342219735, 13808.861911380958, 14136.92931535346, 15523.379064837392, 15729.292181851844, 3703.5555733312176, 4066.044479547304, 4310.31035034393, 4446.333050042519, 4968.552830245295, 12050.698732531582, 12066.215695979734, 12092.214006089576, 12095.818562721566, 12103.0, 5555.194496797942, 6080.179175811298, 6100.603460775035, 6101.0543365777485, 6118.510519158456, 5190.662606930538, 5410.998965191452, 5498.780048798083, 5562.414711807197, 5570.805021824217, 3930.1746633206776, 3989.4614227079555, 4036.858709945138, 4076.7146299759324, 4078.0, 1066.3921564708196, 1070.930389524694, 1072.6674730833467, 1086.5002099034375, 1087.3312912558877, 929.716436486878, 931.9347645664874, 935.504182783126, 963.8361478548663, 1018.6231094495084, 6449.6130232186215, 6536.72533855903, 6549.508786841006, 6574.671266436755, 6750.831229219309, 964.4165280005495, 982.5971351745893, 1034.8292531732332, 1053.4943227250963, 1064.606095744564, 3712.9628703712615, 3826.693864490834, 4064.7357921735584, 4088.1619268049976, 4335.869923902288, 12494.562690305796, 13748.106373085717, 13758.65603359924, 14231.928840355731, 14337.64155896111, 13391.933040334736, 13913.373898174405, 14144.575662730134, 14169.291535423394, 14192.787108193384, 8918.375713700108, 9210.769730756785, 10281.897181028244, 10564.577416903237, 10609.575616975235, 5522.502974732293, 6645.202575690948, 6718.529702920749, 6838.384545390939, 6843.520953533205, 11991.0, 12103.092268079754, 12170.513179473077, 12176.0, 12225.572104976283, 12023.75952480928, 12215.816762748744, 12277.815832762337, 12338.50645974151, 12432.254064756144, 7892.289693927574, 9465.242780577399, 9530.61877524919, 9564.521773911138, 9567.425954442755, 10215.23385746087, 10410.73973150647, 10443.843342349719, 10447.0, 10461.320014199357, 8725.04024557311, 8839.337049721426, 8933.374663773473, 8933.508657023925, 8943.195112439911, 8669.352822963616, 8740.994785599738, 8755.0, 8763.518006509703, 8767.780805479913, 7795.59679257739, 7984.880226796487, 7989.560574168477, 7999.720009799629, 7999.920000800151, 5108.719020453911, 5761.711914404347, 5803.3616302207565, 5821.534277257894, 6022.518198544019, 5769.307683078057, 5879.20630714848, 5967.582269241111, 6044.365341639064, 6164.969175154096], "value": 5176.542729568055, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.887689308742, 350.684384054351, 396.1700238001386, 398.2016057804106, 402.1013035864842, 4412.867613971578, 5382.120565497459, 5458.9454105458935, 5461.617686761928, 5467.316585426822, 4154.335306350985, 4698.718076915387, 4968.329275547809, 5220.216967454884, 5276.973615131919, 4039.414284928691, 4119.855805046824, 4384.386185933972, 4408.757518336491, 4410.779461026952, 3986.4418981342637, 4218.0, 4253.361995700654, 4443.7111587746695, 4488.618467430272, 3838.7140307996856, 3958.406239064149, 4225.767582782945, 4283.207606592775, 4415.741513668605, 3838.4050472176577, 4347.239233134189, 4351.303791393378, 4353.825846966101, 4381.386605875148, 3887.669548088416, 3997.8200980955926, 4016.4376987221813, 4041.6160464755803, 4046.6358027777346, 4871.926921096187, 5029.321041659366, 5228.2680424740565, 5280.3663560373, 5304.92042619361, 4215.852445164404, 4363.847265345697, 4821.252705830567, 5046.899062018776, 5077.517635824591, 4431.645468362523, 4737.147313483571, 4882.5605695487575, 5450.754716037748, 5756.503309139612, 4431.476975804211, 4547.681662283641, 4574.817007319703, 4595.954040459619, 4602.861914142581, 4990.326305948687, 5333.386660534011, 5461.0716178249795, 5946.316173640043, 6023.578349515536, 4177.039280965395, 4520.666403411002, 4628.004978929479, 5008.967780936308, 5105.2597373381395, 4528.524504926935, 4921.340458472713, 5148.304978827885, 5168.7415629218385, 5176.870578235575, 4299.570042995675, 4333.285007973649, 4861.756912154449, 4949.183384741549, 5351.2875879718895, 5253.763580638881, 5665.631733937281, 5691.459311365414, 5703.0, 5711.600187986801, 1749.4314347837003, 1765.2674140231916, 1795.3841542611754, 1798.9190486428142, 1818.2363407368937, 1193.164784650748, 1405.5150972914328, 1434.870861622459, 1436.0613172217422, 1454.0621299262127, 5296.788128474895, 5299.2845965794895, 5302.602304827154, 5323.600729945269, 5333.733313334318, 5108.216022267873, 5618.348073752012, 5643.887122257614, 5858.443447872445, 5895.970520147372, 4306.4066295470875, 4373.650107991353, 4796.400449943757, 4999.725015124203, 5349.973250133725, 2844.928876778097, 3009.714077162666, 3036.347185355115, 3050.964290530936, 3072.6927307269093, 5503.642263252876, 5838.620489668158, 5934.821955341346, 5985.102234664835, 6123.540734444934, 4825.348577942003, 5241.397239317527, 5616.606837521416, 5721.08224805344, 5740.569457290637, 5109.846704598868, 5483.835484935458, 6076.6631341104885, 6078.513718902565, 6139.386061393825, 5420.268263784339, 5816.807554451412, 5839.328477225174, 5878.735456904364, 5888.676122813286, 4736.478987311462, 4738.317897146601, 5390.299261096033, 5659.773609055756, 5744.827655170351, 4875.731834749123, 5516.862078447911, 5672.914906276492, 5712.228849105484, 5862.622283763227, 4178.4568006160225, 4395.472603253206, 4472.9776351118035, 4709.011107667428, 4712.363830882787, 4946.604271658331, 5381.892362152813, 5675.8864822704145, 5869.325027621708, 5939.762409503572, 5094.6688465249645, 5674.771581207184, 5701.7434215461235, 5728.112142617901, 5778.508826749605, 5259.501042202954, 5379.327584051994, 5666.801661941812, 5683.8010669626365, 5686.431356864446, 4859.441164266013, 5249.7375131242525, 5464.890702186013, 5492.917606235989, 5533.557315414838, 4655.976720116378, 4720.12677654635, 4983.70423689836, 5107.475841669237, 5675.0068737971515, 5194.922076168936, 5206.479352064764, 5277.472252774692, 5550.4449555044175, 5600.943990560042], "value": 4335.657826228282, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [779.4349096904748, 810.2181394953876, 881.6958149438444, 898.9955050224748, 917.3945196170529, 16478.42325518607, 16960.4063857765, 17139.400120995768, 17313.480595582136, 17449.95300281984, 15407.0, 15764.605884852856, 15981.041137531756, 16273.593160171002, 16342.264598093085, 984.0798853072364, 1017.1151098544277, 1021.0300214795936, 1021.4637315409395, 1023.744063984004, 1009.5759780892006, 1009.6365308488975, 1012.0082319327064, 1016.293675895253, 1039.173856783855, 1072.3351522056337, 1072.9892701073006, 1074.0387353318774, 1074.3070719385992, 1074.5809134437575, 1067.6370034188412, 1067.887871773468, 1070.0476575847501, 1070.6038765656756, 1072.8068947589431, 793.5516433215215, 793.6349279331514, 794.8608993426127, 796.6415113199083, 797.0117054852, 16894.83105168945, 17029.914850425794, 17094.401695940705, 17568.29726810926, 17864.91067544667, 14514.201718905562, 14712.852871471363, 14827.481038163613, 14857.331420086013, 14907.850921490755, 12139.939300303442, 12248.938755306255, 12250.326232057234, 12303.569375071918, 12535.43590538428, 3850.306944749944, 3861.575226725058, 3864.9227015459533, 3887.2419878123496, 3988.900277493086, 61767.69116154435, 78904.0, 97705.5114724429, 114564.99999999917, 121050.0, 11128.66614001565, 11284.661460156209, 11439.885601143882, 11844.230125042017, 11874.881251187551, 23848.64227036596, 23976.16083437106, 24031.279061628178, 24039.639405408932, 24053.278401647978, 8206.794830129174, 8286.074197258464, 8328.250457458858, 8335.458195217292, 8608.827823443497, 4465.508794032654, 4590.104929538775, 4622.537746225351, 4729.290606409066, 4857.392825896763, 3568.0901370150445, 3595.2449985502813, 3623.8550457981387, 3627.528421305213, 3655.415133578668, 667.3226674924955, 669.3172963577124, 675.9526833121732, 678.3792829560897, 684.7979845945458, 599.5263741644139, 624.3838317449871, 642.6947200080018, 664.5281849886538, 677.3057615943599, 9674.661386851567, 9683.854742178732, 9744.976777438267, 9758.337867722204, 9943.502824858728, 644.1207751419279, 681.924988251292, 695.3046953046953, 695.9269276725972, 708.8688592610383, 4625.783777307412, 4815.735134567562, 4821.7589120543835, 4841.9031619367415, 4859.839133551019, 103684.0, 104691.0, 105572.0, 106806.0, 107111.46444267729, 61817.43643072145, 62812.0, 73606.0, 88982.11017889867, 89089.0, 74032.25967740362, 75285.36079182701, 77018.99999999888, 78036.0, 78239.60880195677, 8396.454230475, 10624.681259562225, 10966.793652698356, 11057.944710276397, 11315.773684526099, 48424.0, 49223.26165107454, 49248.261276081605, 51147.0, 51242.74378628083, 46335.768321158175, 63064.0, 63166.10501684957, 64239.678801605696, 67704.6459070806, 12942.621477501782, 12958.682605029662, 13181.736365272833, 13497.797533037208, 13524.18854868711, 14722.337494812546, 14910.627234319229, 15091.471798487, 15165.09009459436, 15754.76367854506, 13693.383797729326, 14143.292835357985, 14172.716545669235, 14234.786478202628, 14240.786388204393, 13219.272939988394, 13456.949145772924, 14009.673843339107, 14155.858441415454, 14168.574942751733, 13296.0, 13305.0, 13888.375023124187, 13908.235047072509, 14158.079724817853, 9727.610895564381, 9932.851007234753, 9963.551640176354, 10255.794884102426, 10389.013043760831, 8667.523286219319, 10912.399818010086, 11233.66299011031, 11341.979221870071, 11370.715732106764], "value": 7835.519879938803, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1437.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 115.0, 115.0, 113.0, 116.0, 153.0, 169.0, 114.0, 114.0, 114.0], "value": 122.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 106.0, 107.0, 139.0, 109.0, 116.0, 139.0, 115.0, 126.0, 107.0], "value": 119.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 186.0, 186.0, 187.0, 183.0, 185.0, 187.0, 183.0, 187.0, 183.0], "value": 185.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 59.0, 95.0, 61.0, 59.0, 60.0, 58.0, 77.0, 59.0], "value": 66.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 69.0, 89.0, 69.0, 69.0, 68.0, 83.0, 68.0, 70.0, 82.0], "value": 75.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 86.0, 87.0, 87.0, 86.0, 87.0, 87.0, 87.0, 90.0], "value": 87.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 96.0, 94.0, 110.0, 149.0, 147.0, 93.0, 93.0], "value": 106.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 84.0, 82.0, 85.0, 86.0, 83.0, 84.0, 86.0, 84.0], "value": 84.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 59.0, 54.0, 57.0, 61.0, 61.0, 62.0, 60.0, 62.0, 62.0], "value": 60.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 67.0, 68.0, 64.0, 52.0, 58.0, 81.0, 85.0, 85.0, 61.0], "value": 67.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 85.0, 83.0, 85.0, 92.0, 101.0, 91.0, 85.0, 84.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 154.0, 142.0, 140.0, 132.0, 136.0, 128.0, 143.0, 196.0, 174.0], "value": 149.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 169.0, 165.0, 162.0, 163.0, 157.0, 162.0, 165.0, 160.0, 162.0], "value": 162.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 63.0, 63.0, 63.0, 64.0, 64.0, 62.0], "value": 64.2, "unit": "score"}]}]} 12:33:06 INFO - Return code: 0 12:33:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:33:06 INFO - # TBPL SUCCESS # 12:33:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:33:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:33:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:33:06 INFO - 2017-06-02 12:33:06.572 screenresolution[4309:84824] starting screenresolution argv=screenresolution get 12:33:06 INFO - 2017-06-02 12:33:06.574 screenresolution[4309:84824] Display 0: 1600x1200x32@60 12:33:06 INFO - 2017-06-02 12:33:06.580 screenresolution[4310:84827] starting screenresolution argv=screenresolution list 12:33:06 INFO - Available Modes on Display 0 12:33:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:33:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:33:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:33:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:33:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:33:06 INFO - Intel Iris: 12:33:06 INFO - Chipset Model: Intel Iris 12:33:06 INFO - Type: GPU 12:33:06 INFO - Bus: Built-In 12:33:06 INFO - VRAM (Dynamic, Max): 1536 MB 12:33:06 INFO - Vendor: Intel (0x8086) 12:33:06 INFO - Device ID: 0x0a2e 12:33:06 INFO - Revision ID: 0x0009 12:33:06 INFO - Displays: 12:33:06 INFO - Display: 12:33:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:33:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:33:06 INFO - Display Serial Number: 1600x1200 60 12:33:06 INFO - Main Display: Yes 12:33:06 INFO - Mirror: Off 12:33:06 INFO - Online: Yes 12:33:06 INFO - Rotation: Supported 12:33:06 INFO - Return code: 0 12:33:06 INFO - Running post-action listener: _resource_record_post_action 12:33:06 INFO - [mozharness: 2017-06-02 19:33:06.819355Z] Finished run-tests step (success) 12:33:06 INFO - Running post-run listener: _resource_record_post_run 12:33:06 INFO - Total resource usage - Wall time: 1194s; CPU: 54.0%; Read bytes: 1265664; Write bytes: 425429504; Read time: 6; Write time: 1405 12:33:06 INFO - TinderboxPrint: CPU usage
54.0% 12:33:06 INFO - TinderboxPrint: I/O read bytes / time
1,265,664 / 6 12:33:06 INFO - TinderboxPrint: I/O write bytes / time
425,429,504 / 1,405 12:33:06 INFO - TinderboxPrint: CPU idle
2,196.6 (46.0%) 12:33:06 INFO - TinderboxPrint: CPU system
963.1 (20.2%) 12:33:06 INFO - TinderboxPrint: CPU user
1,617.9 (33.9%) 12:33:06 INFO - TinderboxPrint: Swap in / out
122,945,536 / 0 12:33:06 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 123091456; Write bytes: 123109376; Read time: 11129; Write time: 279 12:33:06 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 270336; Write bytes: 296542720; Read time: 1; Write time: 1098 12:33:07 INFO - Running post-run listener: _upload_blobber_files 12:33:07 INFO - Blob upload gear active. 12:33:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:33:07 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 12:33:07 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'] 12:33:07 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 12:33:07 INFO - (blobuploader) - INFO - Open directory for files ... 12:33:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:33:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:33:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:33:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:33:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:33:08 INFO - (blobuploader) - INFO - Done attempting. 12:33:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:33:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:33:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:33:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:33:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:33:09 INFO - (blobuploader) - INFO - Done attempting. 12:33:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:33:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:33:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:33:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:33:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:33:10 INFO - (blobuploader) - INFO - Done attempting. 12:33:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:33:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:33:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:33:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:33:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:33:12 INFO - (blobuploader) - INFO - Done attempting. 12:33:12 INFO - (blobuploader) - INFO - Iteration through files over. 12:33:12 INFO - Return code: 0 12:33:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:33:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:33:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/472a7daf95956abdec0443549ec3f7352c225b6bc20cb20cdfa782a26526d53af725ac68ffadb130d2ce82b80c0efe2a0c0adb913dd71102cac90482d29ca859", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a4b5020172f7bddead2b7060ab648484c02609c7ffc9cfa7d5ca4e5c3338a0e5b323c7bbca528b127cf23ca430d0c5c92ebd63223a4ef47f71b6206a275f7834", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0df7a44e9ea8a5eaed8d00e79e53376a7dc4aab15eca09e203496c7007ffaad5c0c200e70674bfdfb9ce2364fbd0803f58e8f4a527a9805f161f5a8ac73fcd3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71b27a0e93ebd97f44c4a6f2e019db6172c0f67193b463c845ac9cefba1d209d000891fdb432a50e4a68c12f48b4cefc973a1ae6dfa07c15e21caa4144f639cf"} 12:33:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:33:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:33:12 INFO - Contents: 12:33:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/472a7daf95956abdec0443549ec3f7352c225b6bc20cb20cdfa782a26526d53af725ac68ffadb130d2ce82b80c0efe2a0c0adb913dd71102cac90482d29ca859", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a4b5020172f7bddead2b7060ab648484c02609c7ffc9cfa7d5ca4e5c3338a0e5b323c7bbca528b127cf23ca430d0c5c92ebd63223a4ef47f71b6206a275f7834", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0df7a44e9ea8a5eaed8d00e79e53376a7dc4aab15eca09e203496c7007ffaad5c0c200e70674bfdfb9ce2364fbd0803f58e8f4a527a9805f161f5a8ac73fcd3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71b27a0e93ebd97f44c4a6f2e019db6172c0f67193b463c845ac9cefba1d209d000891fdb432a50e4a68c12f48b4cefc973a1ae6dfa07c15e21caa4144f639cf"} 12:33:12 INFO - Running post-run listener: copy_logs_to_upload_dir 12:33:12 INFO - Copying logs to upload dir... 12:33:12 INFO - mkdir: /builds/slave/test/build/upload/logs 12:33:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.697637 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-06-02 12:33:12.370833) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-02 12:33:12.378243) ========= 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.uE6EYE5xZY/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.1oVA3QrX6O/Listeners TMPDIR=/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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/472a7daf95956abdec0443549ec3f7352c225b6bc20cb20cdfa782a26526d53af725ac68ffadb130d2ce82b80c0efe2a0c0adb913dd71102cac90482d29ca859", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a4b5020172f7bddead2b7060ab648484c02609c7ffc9cfa7d5ca4e5c3338a0e5b323c7bbca528b127cf23ca430d0c5c92ebd63223a4ef47f71b6206a275f7834", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0df7a44e9ea8a5eaed8d00e79e53376a7dc4aab15eca09e203496c7007ffaad5c0c200e70674bfdfb9ce2364fbd0803f58e8f4a527a9805f161f5a8ac73fcd3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71b27a0e93ebd97f44c4a6f2e019db6172c0f67193b463c845ac9cefba1d209d000891fdb432a50e4a68c12f48b4cefc973a1ae6dfa07c15e21caa4144f639cf"} build_url:https://queue.taskcluster.net/v1/task/dHAitqXaRFmLcd6K40FYHw/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011448 build_url: 'https://queue.taskcluster.net/v1/task/dHAitqXaRFmLcd6K40FYHw/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/472a7daf95956abdec0443549ec3f7352c225b6bc20cb20cdfa782a26526d53af725ac68ffadb130d2ce82b80c0efe2a0c0adb913dd71102cac90482d29ca859", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a4b5020172f7bddead2b7060ab648484c02609c7ffc9cfa7d5ca4e5c3338a0e5b323c7bbca528b127cf23ca430d0c5c92ebd63223a4ef47f71b6206a275f7834", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0df7a44e9ea8a5eaed8d00e79e53376a7dc4aab15eca09e203496c7007ffaad5c0c200e70674bfdfb9ce2364fbd0803f58e8f4a527a9805f161f5a8ac73fcd3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71b27a0e93ebd97f44c4a6f2e019db6172c0f67193b463c845ac9cefba1d209d000891fdb432a50e4a68c12f48b4cefc973a1ae6dfa07c15e21caa4144f639cf"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-02 12:33:12.415330) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 12:33:12.415673) ========= 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.uE6EYE5xZY/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.1oVA3QrX6O/Listeners TMPDIR=/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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.005396 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 12:33:12.464773) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-02 12:33:12.467140) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-02 12:33:12.467519) ========= ========= Total master_lag: 0.20 =========