builder: mozilla-beta_yosemite_r7_devedition_test-dromaeojs slave: t-yosemite-r7-0211 starttime: 1495806885.94 results: success (0) buildid: 20170526051315 builduid: ede73c92b670400980e8921df9921580 revision: a6718df8269d161f0e2685b1266f7dcc981a751d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-26 06:54:45.943421) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-26 06:54:45.944052) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-26 06:54:45.944391) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-26 06:54:45.968392) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 06:54:45.969002) ========= 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.74WqA8FATp/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.ZPaNMOT2L7/Listeners TMPDIR=/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-05-26 06:54:45-- 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.11M=0.001s 2017-05-26 06:54:46 (8.11 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.095576 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 06:54:46.087473) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 06:54:46.087793) ========= 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.74WqA8FATp/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.ZPaNMOT2L7/Listeners TMPDIR=/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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.021715 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 06:54:46.137841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-26 06:54:46.138450) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a6718df8269d161f0e2685b1266f7dcc981a751d --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 a6718df8269d161f0e2685b1266f7dcc981a751d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.74WqA8FATp/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.ZPaNMOT2L7/Listeners TMPDIR=/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-05-26 06:54:46,222 truncating revision to first 12 chars 2017-05-26 06:54:46,223 Setting DEBUG logging. 2017-05-26 06:54:46,223 attempt 1/10 2017-05-26 06:54:46,223 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a6718df8269d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-26 06:54:47,904 unpacking tar archive at: mozilla-beta-a6718df8269d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.944689 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-26 06:54:48.106635) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-26 06:54:48.107105) ========= script_repo_revision: a6718df8269d161f0e2685b1266f7dcc981a751d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-26 06:54:48.107533) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-26 06:54:48.107799) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-26 06:54:48.126983) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-05-26 06:54:48.127508) ========= /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.74WqA8FATp/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.ZPaNMOT2L7/Listeners TMPDIR=/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 06:54:48 INFO - MultiFileLogger online at 20170526 06:54:48 in /builds/slave/test 06:54:48 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 06:54:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:54:48 INFO - {'append_to_log': False, 06:54:48 INFO - 'base_work_dir': '/builds/slave/test', 06:54:48 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:54:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:54:48 INFO - 'branch': 'Mozilla-Beta', 06:54:48 INFO - 'buildbot_json_path': 'buildprops.json', 06:54:48 INFO - 'config_files': ('talos/mac_config.py',), 06:54:48 INFO - 'default_actions': ('clobber', 06:54:48 INFO - 'read-buildbot-config', 06:54:48 INFO - 'download-and-extract', 06:54:48 INFO - 'populate-webroot', 06:54:48 INFO - 'create-virtualenv', 06:54:48 INFO - 'install', 06:54:48 INFO - 'run-tests'), 06:54:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:54:48 INFO - 'download_minidump_stackwalk': True, 06:54:48 INFO - 'download_symbols': 'ondemand', 06:54:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:54:48 INFO - 'tooltool.py': '/tools/tooltool.py', 06:54:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:54:48 INFO - '/tools/misc-python/virtualenv.py')}, 06:54:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:54:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:54:48 INFO - 'gecko_profile': False, 06:54:48 INFO - 'gecko_profile_interval': 0, 06:54:48 INFO - 'installer_path': 'installer.exe', 06:54:48 INFO - 'log_level': 'info', 06:54:48 INFO - 'log_name': 'talos', 06:54:48 INFO - 'log_to_console': True, 06:54:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:54:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:54:48 INFO - 'opt_config_files': (), 06:54:48 INFO - 'pip_index': False, 06:54:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:54:48 INFO - 'cmd': ('bash', 06:54:48 INFO - '-c', 06:54:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:54:48 INFO - 'enabled': True, 06:54:48 INFO - 'halt_on_failure': False, 06:54:48 INFO - 'name': 'check_screen_resolution'},), 06:54:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:54:48 INFO - 'cmd': ('bash', 06:54:48 INFO - '-c', 06:54:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:54:48 INFO - 'enabled': True, 06:54:48 INFO - 'halt_on_failure': False, 06:54:48 INFO - 'name': 'check_screen_resolution'},), 06:54:48 INFO - 'run_cmd_checks_enabled': True, 06:54:48 INFO - 'suite': 'dromaeojs', 06:54:48 INFO - 'system_bits': '32', 06:54:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:54:48 INFO - 'title': 't-yosemite-r7-0211', 06:54:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:54:48 INFO - 'use_talos_json': True, 06:54:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:54:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:54:48 INFO - 'work_dir': 'build'} 06:54:48 INFO - [mozharness: 2017-05-26 13:54:48.332374Z] Running clobber step. 06:54:48 INFO - Running pre-action listener: _resource_record_pre_action 06:54:48 INFO - Running main action method: clobber 06:54:48 INFO - rmtree: /builds/slave/test/build 06:54:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:54:50 INFO - Running post-action listener: _resource_record_post_action 06:54:50 INFO - [mozharness: 2017-05-26 13:54:50.576796Z] Finished clobber step (success) 06:54:50 INFO - [mozharness: 2017-05-26 13:54:50.576872Z] Running read-buildbot-config step. 06:54:50 INFO - Running pre-action listener: _resource_record_pre_action 06:54:50 INFO - Running main action method: read_buildbot_config 06:54:50 INFO - Using buildbot properties: 06:54:50 INFO - { 06:54:50 INFO - "project": "", 06:54:50 INFO - "product": "firefox", 06:54:50 INFO - "script_repo_revision": "production", 06:54:50 INFO - "builddir": "mozilla-beta_yosemite_r7_devedition_test-dromaeojs", 06:54:50 INFO - "repository": "", 06:54:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 DevEdition mozilla-beta talos dromaeojs", 06:54:50 INFO - "buildid": "20170526051315", 06:54:50 INFO - "pgo_build": "False", 06:54:50 INFO - "basedir": "/builds/slave/test", 06:54:50 INFO - "buildnumber": 2, 06:54:50 INFO - "slavename": "t-yosemite-r7-0211", 06:54:50 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 06:54:50 INFO - "platform": "yosemite_r7_devedition", 06:54:50 INFO - "scheduler": "tests-mozilla-beta-macosx64-devedition-talos", 06:54:50 INFO - "branch": "mozilla-beta", 06:54:50 INFO - "repo_path": "releases/mozilla-beta", 06:54:50 INFO - "revision": "a6718df8269d161f0e2685b1266f7dcc981a751d", 06:54:50 INFO - "stage_platform": "macosx64-devedition", 06:54:50 INFO - "builduid": "ede73c92b670400980e8921df9921580", 06:54:50 INFO - "slavebuilddir": "test" 06:54:50 INFO - } 06:54:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 06:54:50 INFO - Running post-action listener: _resource_record_post_action 06:54:50 INFO - [mozharness: 2017-05-26 13:54:50.580164Z] Finished read-buildbot-config step (success) 06:54:50 INFO - [mozharness: 2017-05-26 13:54:50.580297Z] Running download-and-extract step. 06:54:50 INFO - Running pre-action listener: _resource_record_pre_action 06:54:50 INFO - Running main action method: download_and_extract 06:54:50 INFO - mkdir: /builds/slave/test/build/tests 06:54:50 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')]} 06:54:50 INFO - trying https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 06:54:50 INFO - Downloading https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/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 06:54:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/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 06:54:51 INFO - Downloaded 1287 bytes. 06:54:51 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 06:54:51 INFO - Using the following test package requirements: 06:54:51 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 06:54:51 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 06:54:51 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 06:54:51 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 06:54:51 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 06:54:51 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 06:54:51 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 06:54:51 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 06:54:51 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 06:54:51 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 06:54:51 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 06:54:51 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 06:54:51 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 06:54:51 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 06:54:51 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 06:54:51 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 06:54:51 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 06:54:51 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 06:54:51 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 06:54:51 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 06:54:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 06:54:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 06:54:51 INFO - Fetch https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 06:54:53 INFO - Expected file size: 51963612 06:54:53 INFO - Obtained file size: 51963612 06:55:08 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 06:55:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 06:55:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 06:55:08 INFO - Fetch https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 06:55:10 INFO - Expected file size: 51963612 06:55:10 INFO - Obtained file size: 51963612 06:55:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 06:55:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 06:55:24 INFO - Fetch https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 06:55:26 INFO - Expected file size: 14404449 06:55:26 INFO - Obtained file size: 14404449 06:55:26 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')]} 06:55:26 INFO - trying https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 06:55:26 INFO - Downloading https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 06:55:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/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 06:55:29 INFO - Downloaded 74892601 bytes. 06:55:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 06:55:29 INFO - mkdir: /builds/slave/test/properties 06:55:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:55:29 INFO - Writing to file /builds/slave/test/properties/build_url 06:55:29 INFO - Contents: 06:55:29 INFO - build_url:https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 06:55:30 INFO - Running post-action listener: _resource_record_post_action 06:55:30 INFO - Running post-action listener: set_extra_try_arguments 06:55:30 INFO - [mozharness: 2017-05-26 13:55:30.283762Z] Finished download-and-extract step (success) 06:55:30 INFO - [mozharness: 2017-05-26 13:55:30.283922Z] Running populate-webroot step. 06:55:30 INFO - Running pre-action listener: _resource_record_pre_action 06:55:30 INFO - Running main action method: populate_webroot 06:55:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:55:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:55:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:55:30 INFO - '--tppagecycles', 06:55:30 INFO - '7'], 06:55:30 INFO - 'tests': ['tsvgm']}}, 06:55:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:55:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:55:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:55:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:55:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:55:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:55:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:55:30 INFO - 'talos_options': ['--disable-e10s'], 06:55:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:55:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:55:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:55:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:55:30 INFO - 'talos_options': ['--disable-e10s'], 06:55:30 INFO - 'tests': ['damp', 'tps']}, 06:55:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:55:30 INFO - 'tests': ['damp', 'tps']}, 06:55:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:55:30 INFO - 'tests': ['dromaeo_dom']}, 06:55:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:55:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:55:30 INFO - 'tests': ['basic_compositor_video']}, 06:55:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:55:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:55:30 INFO - 'tests': ['a11yr', 06:55:30 INFO - 'ts_paint', 06:55:30 INFO - 'tpaint', 06:55:30 INFO - 'sessionrestore', 06:55:30 INFO - 'sessionrestore_no_auto_restore', 06:55:30 INFO - 'tabpaint']}, 06:55:30 INFO - 'other-e10s': {'tests': ['a11yr', 06:55:30 INFO - 'ts_paint', 06:55:30 INFO - 'tpaint', 06:55:30 INFO - 'sessionrestore', 06:55:30 INFO - 'sessionrestore_no_auto_restore', 06:55:30 INFO - 'tabpaint']}, 06:55:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:55:30 INFO - 'ts_paint', 06:55:30 INFO - 'tpaint', 06:55:30 INFO - 'sessionrestore', 06:55:30 INFO - 'sessionrestore_no_auto_restore', 06:55:30 INFO - 'tabpaint']}, 06:55:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:55:30 INFO - 'ts_paint', 06:55:30 INFO - 'tpaint', 06:55:30 INFO - 'sessionrestore', 06:55:30 INFO - 'sessionrestore_no_auto_restore', 06:55:30 INFO - 'tabpaint']}, 06:55:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:55:30 INFO - 'tests': ['a11yr', 06:55:30 INFO - 'ts_paint', 06:55:30 INFO - 'tpaint', 06:55:30 INFO - 'sessionrestore', 06:55:30 INFO - 'sessionrestore_no_auto_restore', 06:55:30 INFO - 'tabpaint']}, 06:55:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:55:30 INFO - 'tests': ['a11yr', 06:55:30 INFO - 'ts_paint', 06:55:30 INFO - 'tpaint', 06:55:30 INFO - 'sessionrestore', 06:55:30 INFO - 'sessionrestore_no_auto_restore', 06:55:30 INFO - 'tabpaint']}, 06:55:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:55:30 INFO - 'tests': ['tsvgx', 06:55:30 INFO - 'tsvgr_opacity', 06:55:30 INFO - 'tart', 06:55:30 INFO - 'tscrollx', 06:55:30 INFO - 'cart', 06:55:30 INFO - 'tsvg_static']}, 06:55:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:55:30 INFO - 'tsvgr_opacity', 06:55:30 INFO - 'tart', 06:55:30 INFO - 'tscrollx', 06:55:30 INFO - 'cart', 06:55:30 INFO - 'tsvg_static']}, 06:55:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:55:30 INFO - 'talos_options': ['--disable-e10s'], 06:55:30 INFO - 'tests': ['tp5o']}, 06:55:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:55:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:55:30 INFO - 'talos_options': ['--disable-e10s', 06:55:30 INFO - '--xperf_path', 06:55:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:55:30 INFO - 'tests': ['tp5n']}, 06:55:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:55:30 INFO - 'talos_options': ['--xperf_path', 06:55:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:55:30 INFO - 'tests': ['tp5n']}}, 06:55:30 INFO - 'talos.zip': {'path': '', 06:55:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:55:30 INFO - Running post-action listener: _resource_record_post_action 06:55:30 INFO - [mozharness: 2017-05-26 13:55:30.302563Z] Finished populate-webroot step (success) 06:55:30 INFO - [mozharness: 2017-05-26 13:55:30.302705Z] Running create-virtualenv step. 06:55:30 INFO - Running pre-action listener: _resource_record_pre_action 06:55:30 INFO - Running main action method: create_virtualenv 06:55:30 INFO - Creating virtualenv /builds/slave/test/build/venv 06:55:30 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 06:55:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:55:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:55:30 INFO - Using real prefix '/tools/python27' 06:55:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:55:31 INFO - Installing distribute.............................................................................................................................................................................................done. 06:55:33 INFO - Installing pip.................done. 06:55:33 INFO - Return code: 0 06:55:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:55:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:55:34 INFO - Reading from file tmpfile_stdout 06:55:34 INFO - Output received: 06:55:34 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) 06:55:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:55:34 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')]} 06:55:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:34 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')]} 06:55:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:34 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 0x10e885b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e888768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbe256c320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e663d30>, '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 0x10e58adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e658be8>, '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.74WqA8FATp/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.ZPaNMOT2L7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 06:55:34 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 06:55:34 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 06:55:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.74WqA8FATp/Render', 06:55:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:34 INFO - 'HOME': '/Users/cltbld', 06:55:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:34 INFO - 'LOGNAME': 'cltbld', 06:55:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:34 INFO - 'MOZ_NO_REMOTE': '1', 06:55:34 INFO - 'NO_EM_RESTART': '1', 06:55:34 INFO - 'PAGER': '/bin/cat', 06:55:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:34 INFO - 'PWD': '/builds/slave/test', 06:55:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:34 INFO - 'SHELL': '/bin/bash', 06:55:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZPaNMOT2L7/Listeners', 06:55:34 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 06:55:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:34 INFO - 'USER': 'cltbld', 06:55:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:34 INFO - 'XPC_FLAGS': '0x0', 06:55:34 INFO - 'XPC_SERVICE_NAME': '0', 06:55:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:34 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 06:55:34 INFO - Cleaning up... 06:55:34 INFO - Return code: 0 06:55:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:55:34 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')]} 06:55:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:34 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')]} 06:55:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:34 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 0x10e885b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e888768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbe256c320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e663d30>, '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 0x10e58adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e658be8>, '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.74WqA8FATp/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.ZPaNMOT2L7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 06:55:34 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 06:55:34 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 06:55:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.74WqA8FATp/Render', 06:55:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:34 INFO - 'HOME': '/Users/cltbld', 06:55:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:34 INFO - 'LOGNAME': 'cltbld', 06:55:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:34 INFO - 'MOZ_NO_REMOTE': '1', 06:55:34 INFO - 'NO_EM_RESTART': '1', 06:55:34 INFO - 'PAGER': '/bin/cat', 06:55:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:34 INFO - 'PWD': '/builds/slave/test', 06:55:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:34 INFO - 'SHELL': '/bin/bash', 06:55:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZPaNMOT2L7/Listeners', 06:55:34 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 06:55:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:35 INFO - 'USER': 'cltbld', 06:55:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:35 INFO - 'XPC_FLAGS': '0x0', 06:55:35 INFO - 'XPC_SERVICE_NAME': '0', 06:55:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:35 INFO - Downloading/unpacking psutil>=3.1.1 06:55:35 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 06:55:35 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 06:55:35 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 06:55:35 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 06:55:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:55:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:55:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:55:37 INFO - Installing collected packages: psutil 06:55:37 INFO - Running setup.py install for psutil 06:55:37 INFO - building 'psutil._psutil_osx' extension 06:55:37 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 06:55:37 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 06:55:37 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 06:55:37 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 06:55:37 INFO - building 'psutil._psutil_posix' extension 06:55:37 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 06:55:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:55:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:55:37 INFO - ^ 06:55:37 INFO - 1 warning generated. 06:55:37 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 06:55:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:55:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:55:37 INFO - Successfully installed psutil 06:55:37 INFO - Cleaning up... 06:55:38 INFO - Return code: 0 06:55:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:55:38 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')]} 06:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:38 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')]} 06:55:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:38 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 0x10e885b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e888768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbe256c320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e663d30>, '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 0x10e58adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e658be8>, '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.74WqA8FATp/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.ZPaNMOT2L7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 06:55:38 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 06:55:38 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 06:55:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.74WqA8FATp/Render', 06:55:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:38 INFO - 'HOME': '/Users/cltbld', 06:55:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:38 INFO - 'LOGNAME': 'cltbld', 06:55:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:38 INFO - 'MOZ_NO_REMOTE': '1', 06:55:38 INFO - 'NO_EM_RESTART': '1', 06:55:38 INFO - 'PAGER': '/bin/cat', 06:55:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:38 INFO - 'PWD': '/builds/slave/test', 06:55:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:38 INFO - 'SHELL': '/bin/bash', 06:55:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZPaNMOT2L7/Listeners', 06:55:38 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 06:55:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:38 INFO - 'USER': 'cltbld', 06:55:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:38 INFO - 'XPC_FLAGS': '0x0', 06:55:38 INFO - 'XPC_SERVICE_NAME': '0', 06:55:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:55:38 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 06:55:38 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 06:55:38 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 06:55:38 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 06:55:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:55:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:55:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:55:39 INFO - Installing collected packages: mozsystemmonitor 06:55:39 INFO - Running setup.py install for mozsystemmonitor 06:55:39 INFO - Successfully installed mozsystemmonitor 06:55:39 INFO - Cleaning up... 06:55:39 INFO - Return code: 0 06:55:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:55:39 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')]} 06:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:39 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')]} 06:55:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:39 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 0x10e885b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e888768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbe256c320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e663d30>, '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 0x10e58adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e658be8>, '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.74WqA8FATp/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.ZPaNMOT2L7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 06:55:39 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 06:55:39 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 06:55:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.74WqA8FATp/Render', 06:55:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:39 INFO - 'HOME': '/Users/cltbld', 06:55:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:39 INFO - 'LOGNAME': 'cltbld', 06:55:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:39 INFO - 'MOZ_NO_REMOTE': '1', 06:55:39 INFO - 'NO_EM_RESTART': '1', 06:55:39 INFO - 'PAGER': '/bin/cat', 06:55:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:39 INFO - 'PWD': '/builds/slave/test', 06:55:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:39 INFO - 'SHELL': '/bin/bash', 06:55:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZPaNMOT2L7/Listeners', 06:55:39 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 06:55:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:39 INFO - 'USER': 'cltbld', 06:55:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:39 INFO - 'XPC_FLAGS': '0x0', 06:55:39 INFO - 'XPC_SERVICE_NAME': '0', 06:55:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:40 INFO - Downloading/unpacking jsonschema==2.5.1 06:55:40 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 06:55:40 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 06:55:40 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 06:55:40 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 06:55:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:55:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:55:41 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 06:55:41 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 06:55:41 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 06:55:41 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 06:55:41 INFO - Downloading functools32-3.2.3-2.tar.gz 06:55:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:55:41 INFO - warning: no files found matching '*.txt' 06:55:41 INFO - no previously-included directories found matching 'build' 06:55:41 INFO - no previously-included directories found matching 'dist' 06:55:41 INFO - no previously-included directories found matching '.git*' 06:55:41 INFO - Installing collected packages: jsonschema, functools32 06:55:41 INFO - Running setup.py install for functools32 06:55:42 INFO - warning: no files found matching '*.txt' 06:55:42 INFO - no previously-included directories found matching 'build' 06:55:42 INFO - no previously-included directories found matching 'dist' 06:55:42 INFO - no previously-included directories found matching '.git*' 06:55:42 INFO - Successfully installed jsonschema functools32 06:55:42 INFO - Cleaning up... 06:55:42 INFO - Return code: 0 06:55:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:55: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')]} 06:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55: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')]} 06:55:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x10e885b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e888768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbe256c320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e663d30>, '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 0x10e58adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e658be8>, '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.74WqA8FATp/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.ZPaNMOT2L7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 06:55:42 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 06:55:42 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 06:55:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.74WqA8FATp/Render', 06:55:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:42 INFO - 'HOME': '/Users/cltbld', 06:55:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:42 INFO - 'LOGNAME': 'cltbld', 06:55:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:42 INFO - 'MOZ_NO_REMOTE': '1', 06:55:42 INFO - 'NO_EM_RESTART': '1', 06:55:42 INFO - 'PAGER': '/bin/cat', 06:55:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:42 INFO - 'PWD': '/builds/slave/test', 06:55:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:42 INFO - 'SHELL': '/bin/bash', 06:55:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZPaNMOT2L7/Listeners', 06:55:42 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 06:55:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:42 INFO - 'USER': 'cltbld', 06:55:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:42 INFO - 'XPC_FLAGS': '0x0', 06:55:42 INFO - 'XPC_SERVICE_NAME': '0', 06:55:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:55:43 INFO - Cleaning up... 06:55:43 INFO - Return code: 0 06:55:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:55:43 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')]} 06:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:43 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')]} 06:55:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:43 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 0x10e885b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e888768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbe256c320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e663d30>, '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 0x10e58adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e658be8>, '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.74WqA8FATp/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.ZPaNMOT2L7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 06:55:43 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 06:55:43 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 06:55:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.74WqA8FATp/Render', 06:55:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:43 INFO - 'HOME': '/Users/cltbld', 06:55:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:43 INFO - 'LOGNAME': 'cltbld', 06:55:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:43 INFO - 'MOZ_NO_REMOTE': '1', 06:55:43 INFO - 'NO_EM_RESTART': '1', 06:55:43 INFO - 'PAGER': '/bin/cat', 06:55:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:43 INFO - 'PWD': '/builds/slave/test', 06:55:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:43 INFO - 'SHELL': '/bin/bash', 06:55:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZPaNMOT2L7/Listeners', 06:55:43 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 06:55:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:43 INFO - 'USER': 'cltbld', 06:55:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:43 INFO - 'XPC_FLAGS': '0x0', 06:55:43 INFO - 'XPC_SERVICE_NAME': '0', 06:55:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:43 INFO - Downloading/unpacking blobuploader==1.2.4 06:55:43 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 06:55:43 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 06:55:43 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 06:55:43 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 06:55:45 INFO - Downloading blobuploader-1.2.4.tar.gz 06:55:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:55:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:55:45 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 06:55:45 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 06:55:45 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 06:55:45 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 06:55:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:55:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:46 INFO - Downloading docopt-0.6.1.tar.gz 06:55:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:55:46 INFO - Installing collected packages: blobuploader, requests, docopt 06:55:46 INFO - Running setup.py install for blobuploader 06:55:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:55:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:55:46 INFO - Running setup.py install for requests 06:55:47 INFO - Running setup.py install for docopt 06:55:47 INFO - Successfully installed blobuploader requests docopt 06:55:47 INFO - Cleaning up... 06:55:47 INFO - Return code: 0 06:55:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55:47 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')]} 06:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:47 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')]} 06:55:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:47 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 0x10e885b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e888768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbe256c320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e663d30>, '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 0x10e58adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e658be8>, '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.74WqA8FATp/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.ZPaNMOT2L7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 06:55:47 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 06:55:47 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 06:55:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.74WqA8FATp/Render', 06:55:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:47 INFO - 'HOME': '/Users/cltbld', 06:55:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:47 INFO - 'LOGNAME': 'cltbld', 06:55:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:47 INFO - 'MOZ_NO_REMOTE': '1', 06:55:47 INFO - 'NO_EM_RESTART': '1', 06:55:47 INFO - 'PAGER': '/bin/cat', 06:55:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:47 INFO - 'PWD': '/builds/slave/test', 06:55:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:47 INFO - 'SHELL': '/bin/bash', 06:55:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZPaNMOT2L7/Listeners', 06:55:47 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 06:55:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:47 INFO - 'USER': 'cltbld', 06:55:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:47 INFO - 'XPC_FLAGS': '0x0', 06:55:47 INFO - 'XPC_SERVICE_NAME': '0', 06:55:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:55:47 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-7qyaIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:55:47 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-2WK68N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:55:47 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-_HRLWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:55:48 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-bPHUWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:55:48 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-Hyw4P1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:55:48 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-I9BV5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:55:48 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-ZAFNA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:55:48 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-CX3zuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:55:48 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-mUKLro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:55:48 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-6MTord-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:55:48 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-ZL2FoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:55:48 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-UNL7GH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:55:48 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-ZYsjBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:55:49 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-IWzMPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:49 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-mGLnOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:55:49 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-FuSjWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:55:49 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-rY0dKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:55:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:55:49 INFO - Running setup.py install for manifestparser 06:55:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:55:49 INFO - Running setup.py install for mozcrash 06:55:49 INFO - Running setup.py install for mozdebug 06:55:49 INFO - Running setup.py install for mozdevice 06:55:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:55:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:55:50 INFO - Running setup.py install for mozfile 06:55:50 INFO - Running setup.py install for mozhttpd 06:55:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:55:50 INFO - Running setup.py install for mozinfo 06:55:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:55:50 INFO - Running setup.py install for mozInstall 06:55:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:55:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:55:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:55:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:55:50 INFO - Running setup.py install for mozleak 06:55:50 INFO - Running setup.py install for mozlog 06:55:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:55:50 INFO - Running setup.py install for moznetwork 06:55:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:55:51 INFO - Running setup.py install for mozprocess 06:55:51 INFO - Running setup.py install for mozprofile 06:55:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:55:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:55:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:55:51 INFO - Running setup.py install for mozrunner 06:55:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:55:51 INFO - Running setup.py install for mozscreenshot 06:55:51 INFO - Running setup.py install for moztest 06:55:51 INFO - Running setup.py install for mozversion 06:55:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:55:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:55:52 INFO - Cleaning up... 06:55:52 INFO - Return code: 0 06:55:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55:52 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')]} 06:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:52 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')]} 06:55:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:52 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 0x10e885b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e888768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbe256c320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e663d30>, '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 0x10e58adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e658be8>, '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.74WqA8FATp/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.ZPaNMOT2L7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 06:55:52 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 06:55:52 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 06:55:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.74WqA8FATp/Render', 06:55:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:52 INFO - 'HOME': '/Users/cltbld', 06:55:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:52 INFO - 'LOGNAME': 'cltbld', 06:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:52 INFO - 'MOZ_NO_REMOTE': '1', 06:55:52 INFO - 'NO_EM_RESTART': '1', 06:55:52 INFO - 'PAGER': '/bin/cat', 06:55:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:52 INFO - 'PWD': '/builds/slave/test', 06:55:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:52 INFO - 'SHELL': '/bin/bash', 06:55:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZPaNMOT2L7/Listeners', 06:55:52 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 06:55:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:52 INFO - 'USER': 'cltbld', 06:55:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:52 INFO - 'XPC_FLAGS': '0x0', 06:55:52 INFO - 'XPC_SERVICE_NAME': '0', 06:55:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:55:52 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-c9ZtyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:55:52 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)) 06:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:55:52 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-aEX2WB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:55:52 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)) 06:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:55:52 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-hvRq9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:55:52 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)) 06:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:55:52 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-8gVGt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:55:52 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)) 06:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:55:52 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-CvzdT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:55:52 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)) 06:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:55:52 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-ouK4hJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:55:52 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)) 06:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:55:52 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-E8Xjwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:55:53 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)) 06:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:55:53 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-JVP9gO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:55:53 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)) 06:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:55:53 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-xFApNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:55:53 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)) 06:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:55:53 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-LhZo8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:55:53 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)) 06:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:55:53 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-h64qz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:55:53 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)) 06:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:55:53 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-Zk7EKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:55:53 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)) 06:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:55:53 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-bm1qWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:55:53 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)) 06:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:55:53 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-JE4_LI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:55:53 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)) 06:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:53 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-IDWLZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:53 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)) 06:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:55:53 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-XOI1a1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:55:53 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)) 06:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:55:53 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-TatUc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:55:54 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)) 06:55:54 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)) 06:55:54 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)) 06:55:54 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)) 06:55:54 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)) 06:55:54 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)) 06:55:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:55 INFO - Downloading blessings-1.6.tar.gz 06:55:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:55:55 INFO - Installing collected packages: blessings 06:55:55 INFO - Running setup.py install for blessings 06:55:55 INFO - Successfully installed blessings 06:55:55 INFO - Cleaning up... 06:55:55 INFO - Return code: 0 06:55:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:55:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:55:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:55:56 INFO - Reading from file tmpfile_stdout 06:55:56 INFO - Current package versions: 06:55:56 INFO - blessings == 1.6 06:55:56 INFO - blobuploader == 1.2.4 06:55:56 INFO - docopt == 0.6.1 06:55:56 INFO - functools32 == 3.2.3-2 06:55:56 INFO - jsonschema == 2.5.1 06:55:56 INFO - manifestparser == 1.1 06:55:56 INFO - mozInstall == 1.12 06:55:56 INFO - mozcrash == 1.0 06:55:56 INFO - mozdebug == 0.1 06:55:56 INFO - mozdevice == 0.49 06:55:56 INFO - mozfile == 1.2 06:55:56 INFO - mozhttpd == 0.7 06:55:56 INFO - mozinfo == 0.9 06:55:56 INFO - mozleak == 0.1 06:55:56 INFO - mozlog == 3.4 06:55:56 INFO - moznetwork == 0.27 06:55:56 INFO - mozprocess == 0.25 06:55:56 INFO - mozprofile == 0.28 06:55:56 INFO - mozrunner == 6.13 06:55:56 INFO - mozscreenshot == 0.1 06:55:56 INFO - mozsystemmonitor == 0.3 06:55:56 INFO - moztest == 0.8 06:55:56 INFO - mozversion == 1.4 06:55:56 INFO - psutil == 3.1.1 06:55:56 INFO - requests == 1.2.3 06:55:56 INFO - wsgiref == 0.1.2 06:55:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55:56 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')]} 06:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:56 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')]} 06:55:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:56 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 0x10e885b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e888768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbe256c320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e663d30>, '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 0x10e58adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e658be8>, '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.74WqA8FATp/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.ZPaNMOT2L7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 06:55:56 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 06:55:56 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 06:55:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.74WqA8FATp/Render', 06:55:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:56 INFO - 'HOME': '/Users/cltbld', 06:55:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:56 INFO - 'LOGNAME': 'cltbld', 06:55:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:56 INFO - 'MOZ_NO_REMOTE': '1', 06:55:56 INFO - 'NO_EM_RESTART': '1', 06:55:56 INFO - 'PAGER': '/bin/cat', 06:55:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:56 INFO - 'PWD': '/builds/slave/test', 06:55:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:56 INFO - 'SHELL': '/bin/bash', 06:55:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZPaNMOT2L7/Listeners', 06:55:56 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 06:55:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:56 INFO - 'USER': 'cltbld', 06:55:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:56 INFO - 'XPC_FLAGS': '0x0', 06:55:56 INFO - 'XPC_SERVICE_NAME': '0', 06:55:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:56 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)) 06:55:56 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)) 06:55:56 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)) 06:55:56 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)) 06:55:56 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)) 06:55:56 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)) 06:55:56 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)) 06:55:56 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)) 06:55:56 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)) 06:55:56 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)) 06:55:56 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)) 06:55:56 INFO - Cleaning up... 06:55:56 INFO - Return code: 0 06:55:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:55:56 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')]} 06:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:56 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')]} 06:55:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:56 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 0x10e885b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e888768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbe256c320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e663d30>, '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 0x10e58adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e658be8>, '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.74WqA8FATp/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.ZPaNMOT2L7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 06:55:56 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 06:55:56 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 06:55:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.74WqA8FATp/Render', 06:55:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:56 INFO - 'HOME': '/Users/cltbld', 06:55:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:56 INFO - 'LOGNAME': 'cltbld', 06:55:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:56 INFO - 'MOZ_NO_REMOTE': '1', 06:55:56 INFO - 'NO_EM_RESTART': '1', 06:55:56 INFO - 'PAGER': '/bin/cat', 06:55:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:56 INFO - 'PWD': '/builds/slave/test', 06:55:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:56 INFO - 'SHELL': '/bin/bash', 06:55:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZPaNMOT2L7/Listeners', 06:55:56 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 06:55:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:56 INFO - 'USER': 'cltbld', 06:55:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:56 INFO - 'XPC_FLAGS': '0x0', 06:55:56 INFO - 'XPC_SERVICE_NAME': '0', 06:55:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:55:56 INFO - Cleaning up... 06:55:56 INFO - Return code: 0 06:55:56 INFO - Running post-action listener: _resource_record_post_action 06:55:56 INFO - Running post-action listener: _start_resource_monitoring 06:55:56 INFO - Starting resource monitoring. 06:55:56 INFO - [mozharness: 2017-05-26 13:55:56.719109Z] Finished create-virtualenv step (success) 06:55:56 INFO - [mozharness: 2017-05-26 13:55:56.720054Z] Running install step. 06:55:56 INFO - Running pre-action listener: _resource_record_pre_action 06:55:56 INFO - Running main action method: install 06:55:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:55:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:55:56 INFO - Reading from file tmpfile_stdout 06:55:56 INFO - Detecting whether we're running mozinstall >=1.0... 06:55:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:55:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:55:57 INFO - Reading from file tmpfile_stdout 06:55:57 INFO - Output received: 06:55:57 INFO - Usage: mozinstall [options] installer 06:55:57 INFO - Options: 06:55:57 INFO - -h, --help show this help message and exit 06:55:57 INFO - -d DEST, --destination=DEST 06:55:57 INFO - Directory to install application into. [default: 06:55:57 INFO - "/builds/slave/test"] 06:55:57 INFO - --app=APP Application being installed. [default: firefox] 06:55:57 INFO - mkdir: /builds/slave/test/build/application 06:55:57 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'] 06:55:57 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 06:56:17 INFO - Reading from file tmpfile_stdout 06:56:17 INFO - Output received: 06:56:17 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 06:56:17 INFO - Running post-action listener: _resource_record_post_action 06:56:17 INFO - [mozharness: 2017-05-26 13:56:17.041022Z] Finished install step (success) 06:56:17 INFO - [mozharness: 2017-05-26 13:56:17.041175Z] Running run-tests step. 06:56:17 INFO - Running pre-action listener: _resource_record_pre_action 06:56:17 INFO - Running main action method: run_tests 06:56:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:56:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:56:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:56:17 INFO - 2017-05-26 06:56:17.055 screenresolution[1996:16676] starting screenresolution argv=screenresolution get 06:56:17 INFO - 2017-05-26 06:56:17.058 screenresolution[1996:16676] Display 0: 1600x1200x32@60 06:56:17 INFO - 2017-05-26 06:56:17.064 screenresolution[1997:16678] starting screenresolution argv=screenresolution list 06:56:17 INFO - Available Modes on Display 0 06:56:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:56:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:56:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:56:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:56:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:56:17 INFO - Intel Iris: 06:56:17 INFO - Chipset Model: Intel Iris 06:56:17 INFO - Type: GPU 06:56:17 INFO - Bus: Built-In 06:56:17 INFO - VRAM (Dynamic, Max): 1536 MB 06:56:17 INFO - Vendor: Intel (0x8086) 06:56:17 INFO - Device ID: 0x0a2e 06:56:17 INFO - Revision ID: 0x0009 06:56:17 INFO - Displays: 06:56:17 INFO - Display: 06:56:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:56:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:56:17 INFO - Display Serial Number: 1600x1200 60 06:56:17 INFO - Main Display: Yes 06:56:17 INFO - Mirror: Off 06:56:17 INFO - Online: Yes 06:56:17 INFO - Rotation: Supported 06:56:17 INFO - Return code: 0 06:56:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:56:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:56:17 INFO - Python 2.7.3 06:56:17 INFO - Return code: 0 06:56:17 INFO - grabbing minidump binary from tooltool 06:56:17 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')]} 06:56:17 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 0x10e663d30>, '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 0x10e58adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e658be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:56:17 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 06:56:17 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 06:56:17 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 06:56:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:56:17 INFO - Return code: 0 06:56:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:56:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:56:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:56:17 INFO - ENV: RUST_BACKTRACE is now 1 06:56:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:56:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:56:17 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/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0211', '--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 06:56:17 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/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0211 --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 06:56:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.74WqA8FATp/Render', 06:56:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:56:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:56:17 INFO - 'HOME': '/Users/cltbld', 06:56:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:56:17 INFO - 'LOGNAME': 'cltbld', 06:56:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:56:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:56:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:17 INFO - 'MOZ_NO_REMOTE': '1', 06:56:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:56:17 INFO - 'NO_EM_RESTART': '1', 06:56:17 INFO - 'PAGER': '/bin/cat', 06:56:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:56:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:17 INFO - 'PWD': '/builds/slave/test', 06:56:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:56:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:56:17 INFO - 'RUST_BACKTRACE': '1', 06:56:17 INFO - 'SHELL': '/bin/bash', 06:56:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZPaNMOT2L7/Listeners', 06:56:17 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 06:56:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:56:17 INFO - 'USER': 'cltbld', 06:56:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:56:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:56:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:17 INFO - 'XPC_FLAGS': '0x0', 06:56:17 INFO - 'XPC_SERVICE_NAME': '0', 06:56:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:56:17 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/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0211', '--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 06:56:17 INFO - mozversion application_buildid: 20170526051315 06:56:17 INFO - mozversion application_changeset: a6718df8269d161f0e2685b1266f7dcc981a751d 06:56:17 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:56:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:56:17 INFO - mozversion application_name: Firefox 06:56:17 INFO - mozversion application_remotingname: firefox-dev 06:56:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:56:17 INFO - mozversion application_vendor: Mozilla 06:56:17 INFO - mozversion application_version: 54.0 06:56:17 INFO - mozversion platform_buildid: 20170526051315 06:56:17 INFO - mozversion platform_changeset: a6718df8269d161f0e2685b1266f7dcc981a751d 06:56:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:56:17 INFO - mozversion platform_version: 54.0 06:56:17 INFO - using testdate: 1495806977 06:56:17 INFO - actual date: 1495806977 06:56:17 INFO - starting webserver on 'localhost:52938' 06:56:17 INFO - SUITE-START | Running 2 tests 06:56:17 INFO - TEST-START | dromaeo_css 06:56:17 INFO - operating with platform_type : mac_ 06:56:17 INFO - Initialising browser for dromaeo_css test... 06:56:17 INFO - TEST-INFO | started process 2007 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/tmpnLQgBn/profile http://localhost:52938/getInfo.html) 06:56:20 INFO - PROCESS | 2007 | __metrics Screen width/height:1600/1200 06:56:20 INFO - PROCESS | 2007 | colorDepth:24 06:56:20 INFO - PROCESS | 2007 | Browser inner width/height: 1024/689 06:56:20 INFO - PROCESS | 2007 | __metrics 06:56:20 INFO - PROCESS | 2007 | 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" 06:56:20 INFO - PROCESS | 2007 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:56:20 INFO - TEST-INFO | 2007: exit 0 06:56:20 INFO - Browser initialized. 06:56:20 INFO - Running cycle 1/1 for dromaeo_css test... 06:56:20 INFO - TEST-INFO | started process 2010 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/tmpnLQgBn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:56:32 INFO - PROCESS | 2010 | RSS: Main: 194011136 06:56:32 INFO - PROCESS | 2010 | 06:59:36 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:52938/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52938/tests/dromaeo/cssquery-ext.html) 06:59:38 INFO - PROCESS | 2010 | RSS: Main: 368013312 06:59:38 INFO - PROCESS | 2010 | 07:02:41 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:52938/tests/dromaeo/cssquery-ext.html (next: http://localhost:52938/tests/dromaeo/cssquery-jquery.html) 07:02:42 INFO - PROCESS | 2010 | RSS: Main: 328368128 07:02:42 INFO - PROCESS | 2010 | 07:05:44 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:52938/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52938/tests/dromaeo/cssquery-mootools.html) 07:05:45 INFO - PROCESS | 2010 | RSS: Main: 313921536 07:05:45 INFO - PROCESS | 2010 | 07:08:47 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:52938/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52938/tests/dromaeo/cssquery-prototype.html) 07:08:48 INFO - PROCESS | 2010 | RSS: Main: 297693184 07:08:48 INFO - PROCESS | 2010 | 07:11:51 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:52938/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52938/tests/dromaeo/cssquery-yui.html) 07:11:52 INFO - PROCESS | 2010 | RSS: Main: 295059456 07:11:52 INFO - PROCESS | 2010 | 07:14:55 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:52938/tests/dromaeo/cssquery-yui.html (next: http://localhost:52938/tests/dromaeo/cssquery-dojo.html) 07:14:55 INFO - PROCESS | 2010 | RSS: Main: 357621760 07:14:55 INFO - PROCESS | 2010 | 07:14:55 INFO - PROCESS | 2010 | __start_tp_report 07:14:55 INFO - PROCESS | 2010 | _x_x_mozilla_page_load 07:14:55 INFO - PROCESS | 2010 | _x_x_mozilla_page_load_details 07:14:55 INFO - PROCESS | 2010 | |i|pagename|runs| 07:14:55 INFO - PROCESS | 2010 | |0;dojo.html;3389.135770378554;3405.4721518164683;3425.3320602482527;3446.1390848941573;3485.1809824691195;6008.699565021748;6023.2169817923605;6023.457888790013;6060.3939606039485;6064.060070689039;5978.103284507326;6031.306399764028;6037.758489660419;6038.064100064486;6045.455908968192;5368.114261146926;5368.570514358861;5402;5421.891562168754;5562.694051827148;5295.0468915595175;5321.201819727034;5362.168863826094;5381.919271210935;5495.368032676233;5390.8921821563745;5406.729663516828;5412.648177868426;5423.403425623178;5426.131818908975;5405.4324295948945;5448.482394172567;5540.085885828834;5541.667499950016;5544.77820887164;5286.841394758163;5419.214213938996;5422.783088676449;5423.105187644034;5466.808661696821;6051.152838602599;6081.756729730805;6097.902377572035;6099.847503812396;6107.572469927107;6198.783042593487;6237.968810155966;6305.464035556937;6349.333320001426;6363.554551181419;5720.370759216483;6280.026595877646;6350.206224221973;6390.0734393512685;6491.707873145672;6187.628742275478;6191.504679625619;6200.162977998003;6202.81391558254;6204.317525072329;6550.70521826519;6557.573757705829;6567.901481477782;6569.277379488348;6571.704273307712;6145.801568694151;6210.285817130997;6265.686715664198;6276.560640755103;6285.120083188357;6408.967955160288;6412.134361861183;6424.614523128627;6429.03564465334;6438.3883531064475;6312.021636646327;6322.557420980487;6355.936440635534;6359.96820015897;6374.266959299647;6250.843728906813;6271.247450305992;6272.5922815016875;6291.6854157291955;6382.680865956777;4897.559219670246;4922.975385123052;4940.283658869444;4952.925706114411;4958.7024778513405;4391.934120988188;4402.339649052604;4404.031113155101;4418.7127836690515;4432.734035957853;5657.2928383952;5846.853828654318;5904.852378690482;5916.9053725061;5920.37836027211;5324.893502130013;6264.123022776815;6298.433141017331;6310.905336419957;6313.05304204373;4697.037107392976;5738.397468265772;5762.452567006211;5827.300723913073;5830.067189249699;5582.944170558242;5597.692126932976;5614.242077319591;5624.97187514068;5625.887482250332;6566.376194261633;6594.967025164843;6613.3056029117215;6638.037484564711;6682.431993280626;6252.781152659635;6294.433500984934;6498.545101842826;6503.902441463287;6510.73957041732;6566.474682025522;6609.20689517261;6660.467162626881;6694.765683201064;6695.263521012782;6380.87238255223;6387.904181437189;6404.775832845828;6409.519286053472;6429.453496452854;6229.626222426669;6327;6451.1936007999;6457.031445283245;6458.54790164684;6237.376262373727;6261;6262.843428914131;6264.436200741955;6289.9056514153235;6293.402126797947;6322.304546499973;6334.303226645157;6337.2395312562785;6343.080253363144;6136.7852125175405;6173.41352571505;6209.565330427007;6210.037444196157;6289.779857704958;6146.139540464249;6252.812415627538;6256.436920677161;6342.4291813735135;6343.714532845941;6205.565610407409;6261.342559031418;6269.467095296768;6273.059041143865;6281.120643109877 07:14:55 INFO - PROCESS | 2010 | |1;ext.html;749.3330935467435;802.8956235689361;825.5583262954319;876.4960147914951;896.2337201692549;28246.57630135547;37878.484860605546;38010.42984355237;40898.79550602246;41818.79090604546;42452.57547424525;42653.57346426535;42696;42717.71846844592;42800.78599607005;7655.425843061765;9486.241100711926;9660.468674222915;9666.613335466607;9673.081057299545;7707.961460192691;11436;11673;11870.406479675981;11879.287242765462;11693.707657308592;11718.003969662588;11721.824172637418;11727.354995475245;11800;11615.361155136465;11651.708707282301;11658.358790266531;11664.766704665944;11668.649940501798;11366.37484938328;11400.973912347928;11421.54313827446;11443.713907152305;11444.828327575093;39446.80276598599;39641;39661.80169099165;39707.60292397068;39737;3864.613538646141;3885.0870045539277;3890.3386424307937;3900.258950799339;3959.3665013597974;27028.054018109273;27698.16905492818;29453.41093178146;30182;30322.848385758152;3074.3543855790313;3111.4088323218516;3228.4834426491884;3249.8537565809597;3311.106001379638;370060;370643;373072;373909;374255;53425;53430;53542.46457535453;53557.46442535525;53583.46416535863;46252;56281.592960175505;56322;56351;56450;14577.344019519147;14953.252337383088;14975.850241497663;14986.775198372034;15010.549683509513;9301.348905576544;11326.32042077478;12845;12871.806922896165;12908.419121139572;10692.946535267429;11878.346690931909;14203.360848761624;14377.928110359382;14563.563093107225;6175.456135966008;6252.374762523802;6268.247810262797;6292;6357.777477788255;1158.530795028015;1179.6669763167565;1196.85637723472;1200.4837919694442;1201.0602876354624;28174.85912570424;28725.425491490052;28761.856190719333;28820.855895720386;28836.567451488245;1075.1828610256262;1077.8059949209219;1078.2883297023927;1114.4984756859446;1120.574181810923;12736.108472406842;13449.596512104652;13660.65848353799;13675.905927525973;13745.931270343784;531137;533277;534556;534895;535889;46155;46356.5364346359;46424;46425;46457;1399.2863639543905;1452.2230606625405;1454.3818876977032;1455.5633310006956;1461;21894.781052189912;23708.407289817893;25161.622575661015;25696.614550782127;25721.228363149134;35131.64868351386;37382.439263410524;37422;37456.063598410256;37476.875693729235;513874;516821.8317816924;517054;517736;517953;29767.553486697285;30053.69946300509;30121.69878301189;30682.84658576693;30694.079177624706;32013.679863202;38419;38941.805290974495;39020;39094.609053909095;24316.392090197885;27641.58537621897;27901.720982789913;28793.56809647815;29587;23623.763762362156;26095.478090438464;27761.30596735017;29003.709962900102;29264;32923;33040.008799736046;33119.006429807145;33423.1644208887;33701.662983370836;26859.865700671373;28876.566851496824;29585;29636.555451668675;29725.702742972295;20858.687119692913;22485.39049494817;22502.662460062784;22599.435014124778;22644.66033009539 07:14:55 INFO - PROCESS | 2010 | |2;jquery.html;338.41116457364194;432.4022735990516;435.4556803995005;440.3636744903614;449.49431889124736;13430.865691343084;15148.394064237431;18027.99999999998;21936.45158871029;22683.31950041497;19863.404097877086;22503.21238756644;22986.770132298672;23047.234331880158;23612.763872361313;6571.769988050407;6955.756548520802;7022.403095736869;7039.260877607829;7064.9293507064785;6702.932970670304;6910.136232970879;6933.375996160345;6953.617551034691;7002.614856182908;6996.790096297119;7003.5797852129035;7003.964980175092;7009.404200642952;7018.33325834045;6696.564723292995;6866.725330986779;6938.826529336757;6940.930590694129;6946.2706415826115;6706.664666766642;6714.227863795629;6790.76232331871;6792.0830687857;6824.556403833784;27868.581971270447;27894.860525697444;27921.301967450774;27985.30036749077;28277.57583636247;2821.3510892494637;2960.6003189569565;2983.820970741741;3058.571799948009;3071.416430878126;15768.211589420598;15783.447579334783;15800.920995395065;16531.91734041334;16637.084960327178;1960.8725432846961;2026.2097781865084;2137.551114266006;2158.870467771923;2163.664631982045;155974;163634.18362758882;163872;170978;175322.12338938224;19666.91831949228;20351.898240509;20445.48886277855;20773.688394674093;20922;31522.054338369886;31895.043148705576;32093.51859722106;32173;32235;9353.906460935303;9690.273229507815;10143.391396516232;10341.534630941625;10420.478976051167;8612.708093785983;8618.913810861937;8641.611127499278;8792.076831932683;8807.559622019002;7640.350570201484;7726.575038372944;9246.352755307198;9325.533723313807;9455.101765332283;3305.0415379539663;3745.951133682573;3821.8280177392085;3834.7699138051807;3834.7699138051807;807.600237882252;994.6220436234329;1011.8644319266426;1022.4734261855151;1022.9310370662675;20449.89775051115;20527.28154514585;20567.971601419868;20695.379138625864;21029;993.2203220471895;1005.5977608956476;1020.2603112743202;1020.938743675367;1024.6772266736104;10166.237532185116;10308;10759.515821788038;10769.299995500267;10854.72863178411;769806;771201;774350;782194;803681;122010;126736;154939.47832869075;155984;161926.1903690474;1238.2446707508414;1244.6017274472263;1272.9872701272868;1276.7063575377715;1282.1281528560482;17851.910740446736;18725.25098996025;18830.3409380671;18843.811561884206;18862;63533;64033;64121;64224.394390140624;64500.8399328062;89777.55111224402;90948.56495580776;92549;93021.5348923278;93583;11213.887861121611;11429.542818287175;11462.85371462847;11590.942045290058;11790.351530665896;12877.871221288042;12919.354032298159;13123;13144.934275328562;13300.268485233406;11017.669469915916;11191.104711623213;11249.437528123397;11262;11480.540778368771;10253.74365640865;10379.792404152025;10480.895191048297;10537.683869483928;10557.577696892038;8733.781655458664;11480.425978701198;11517.02105321057;11565;11703.941480292544;11410.543578256777;11470.598529051776;11491.650155675077;11526.94236528812;11842.171048026556;9446.149846513572;11101.666949991513;11318.207725459139;11441.771164576496;11443.885561144281 07:14:55 INFO - PROCESS | 2010 | |3;mootools.html;1339.196482110733;1557.7896983907176;1591.2600640702076;1593.4422951966812;1602.214914691801;9361.48511831849;9762.267829912758;10970.286931349458;11309.264897781639;11519.712007199803;9371.812563748737;11190.936860998212;11297.378644174567;11315.773684526304;11379.487923043462;1925.3646296722118;1988.602279544097;2023.5447024419534;2038.4699978005751;2393.3059412770276;1916.425072478251;2077;2396.18529699902;2399.9280021599293;2410.2287268074224;2374.691290132289;2376.0495801679294;2382.880855957204;2384.177458776719;2384.237044145874;2322.837401381904;2370.5140446208484;2375.738668746445;2381;2383.4398916254668;2315.6410756332793;2324.837261391703;2330.4057465346227;2334.7198336199594;2339.4385347516472;11370.374629395379;11461.36962467064;11485.655430337103;11506.769864602746;11512.539498420054;5386.596005299618;5518.255035570187;5539.695316757577;5549.38956714761;5561.582881283879;3002.6697063323018;3218.5815843940372;3350.932981340384;3466.3933811583124;3518.384282750534;1062.5537274344795;1132.1339175530725;1141.3551343490983;1156.011610073392;1164.085080043324;14839.777403338958;15263.473652634648;15687.921560392238;15695;15710.921445392814;4450.5104438511735;4557.020240648277;4581.266997280419;4583;4600;11635.418229088511;11664.591739289084;11680.240784348991;11690.240134391237;11695.947364737214;5547.223388725582;5558.805441809517;5568.832935011957;5575.219469274305;5602.831915042555;4460.77696115193;5073.909109541466;5153.561947234527;5165.457626949116;5260.579153667774;2995.5207166853197;3339.398908196499;3678.76088054281;3761.307411664707;3850.172212974224;923.4044041593135;958.4824194934657;981.3277904635347;988.461288597716;991.6975322526698;956.6460409648474;988.545269176187;997.6009596161593;999.690096070206;1010.1767059846349;6694.029365742038;6839.931600684029;7032.472564557576;7033.191183013917;7075.646217689095;882.2589025218847;1060.3637817309552;1091.5033659684825;1108.5731993182521;1119.652907598647;4242.596953289432;4306.547812479707;4341.131773645284;4446.599806017474;4550.180967425829;11000.724981875517;13228.14017088886;14030.579082627537;14111.647208819862;14129.717405651829;13501.527446539323;13699.178049317074;13943.58169254924;13954.23251721165;13973.441062357595;10042.347247428894;10291.176705863512;10305.124064454456;10305.381677099398;10312.845307320396;6134.478569321657;6651.4013738761805;6834.077399550997;6954.3393377629045;7111.182214045451;11953;12108;12286.508539658313;12537.373131343578;12560.874391255971;12447.253164810141;12578.748425031632;12690.555830545887;12732.681682958;12928.547500837425;9950.253730970062;10239.692809215736;10455.16358691318;10535.683929482127;10548.156147508027;10618.52216650268;10624.468776560987;10694.609700739165;10726.98093681099;10730.302530335503;8671.176238257356;8705.3035757138;8874.955625221832;8899.332550058642;9026.503542305236;8619.094995025433;8728.821609082946;8766.123387661182;8785.297176225758;8915.955420222857;8036.557989310644;8175.7138500152205;8191.508509489449;8193.057798353266;8196.795080123045;5855.707214639337;5893.44012318829;5934;6071.908921366271;6076.908846367396;5140.714821294677;5907.497862681548;5969.373215812451;6134.386561344008;6222.28857206841 07:14:55 INFO - PROCESS | 2010 | |4;prototype.html;381.7823840410966;385.29298736817935;386.45895745955676;395.14648359543384;395.30623755309426;4313.417688612037;4566.520515345883;4654.232051711468;4732.219183834667;4945.579625731808;3918.490596222487;4343.305071188611;4525.615322697575;4622.699524530904;4932.87667808305;3717.293714194301;4077.816498257571;4150.501939767232;4167.208230436223;4197.467924207673;3905.4922860028155;3989.242044011643;4054.533728621202;4179.934116800212;4235.98336399265;4193.895152621179;4228.4080228768;4235;4236.83052677894;4276.871693849174;3312.867485300573;3804.9429258561145;3921.784301863396;3999.3601023836045;4197.202531519001;3405.9829700851583;3826.4069069294305;3833.674137698299;3833.9424908626393;3884.9704828220542;4772.952270477285;4786.941615105503;4808.110499557593;4825;4944.269505672985;3975.9801200994098;4520.50274469808;4681.438227412698;4833.299171620095;4945.604351651895;5260.500252476008;5276.736163191825;5290.100682883881;5298.761555730001;5355.7857685692525;3783.2622638585485;3984.7011474139554;4291.596705844706;4320.373545835868;4363.781810909441;4643.722976181577;4923.606111511071;5136.383633963911;5150.351887396035;5235.397929238148;3960.0693836948294;4129.009037830959;4217.725847819882;4350.390945267665;4361.454818147731;3909.179072394772;4455.9554404456185;4459.777011149495;4504.175808797442;4511.9323210151215;4356.88899330675;4378.343248512685;4384.517703052662;4639.976800115978;4836.564709176191;4823.5658790709;4917.172625740213;4929.595065406414;5104.489551044866;5255.316808814906;1383.2253937794667;1433.0398632915972;1470.1767010473955;1487.8288996765293;1501.459474589147;985.472772066955;1018.1294992781213;1070.4701172919454;1091.5142761471227;1179.4810283475244;4427.22523558376;4784.1295222866;4846.733429661332;4857.319975203474;4953.455119936804;4897.681650692693;5512.39363669996;5550.750216240279;5580.270116263971;5603.4332019404055;3927.1346110597237;4320.675949303814;4516.458025036951;4537.93689259755;4815.518448155157;2750.601162831378;2860.899868504592;2888.9133326000256;2896.782741294411;2925.1809493341475;5138.948610513922;5320.414754377015;5641.774329026875;5723.627964182315;5760.214333556611;4639.907201855944;4979.680384698058;5380.300560927133;5482.451754824486;5693.800716974886;4636.122370439977;5460.672359658433;5563.610547261734;5570.3315602128005;5690.6870122142855;4992.8751781205765;5071.644984851025;5258.263843061898;5520.309961254843;5542;4651.627869770478;4864.95135048645;5250.501202385767;5458.536024437808;5556.888862222814;4994.5754610858485;5417.8103766367985;5646;5723.368839880614;5754.798582049608;4345.152695224401;4411.933820992752;4479.484859241229;4843.854684359475;4874.2444921037295;5026.52248036436;5513.807016754395;5540.362858271189;5547.306586676666;5553.333599968029;4721.645876559341;4762.666613337033;5331.440198779227;5404.514088412873;5462.754176062007;4305.230990472656;4779.665423420327;5316.760745766373;5371.435999220182;5375.435579264277;4579.358889755504;4942.418426103613;5216.713080780593;5257.447967963309;5274.736263186748;4696;4744.430668319824;5233.947660523499;5321.669582604349;5359.356877174764;4328.480582330015;4948.678335908155;5086.296090809472;5219.895602088013;5234.633575649668 07:14:55 INFO - PROCESS | 2010 | |5;yui.html;746.1158527145333;757.6211894052974;782.5852298281912;853.3045567862192;862.3877047296419;15615.453459128932;16394.754078688828;16418.343266269334;16468.752968705478;16539.917300413497;14675.192864392455;15038.398464061424;15271.770923436157;15290.235488225571;15508.224588770572;865.9824705970475;983.7589790501302;994.6319861651199;998.7353351361895;1001.319103009953;974.8878878928907;994.2791476179784;997.4563862694813;1000.774825664227;1002.3935519011003;1037.667946257198;1039.4127318065268;1041.9843702344472;1042.890496497868;1043.1498328861992;1032.7573020340214;1034.5551412892453;1035.4563853976647;1035.6841163445108;1037.0303765978758;757.1103952855428;780.2899361580934;780.7969927818751;781.605289328891;781.8358144789544;16136.838631613651;16518.2566784495;16583.253753581117;16831.83168168327;17035.744463833053;12004.69988250292;14654;14661.04703194289;14662.266886655625;14679.192644404553;11348.319100853974;11844.881551184464;11845.289282642983;11918.940405298004;11952.70118247042;3656.451532270154;3698.184301157802;3706.166112624665;3710.6474884885893;3762.6801721853403;114980.27529587147;116304;118775;120441;122569.77430225762;11085.889141108486;11123.610673626546;11131.554737810558;11178;11712.88287117135;23036.193733219257;23363.299101026998;23448;23453;23541.52916941686;7865.488743231672;7875.251851074138;7879.172686867911;7890.842183156305;8152.429329946846;4436.6672499562665;4473.865784026484;4522.8643140705835;4568.680192386501;4569.109023740405;3182.840857957093;3308.8676452942095;3406.6082400524256;3505.789652620851;3509.1402606361603;602.4788557897388;611.7733943443368;612.8712970276292;613.6103574230395;613.9723712432951;671.2549070531705;676.891697328425;700.544645980117;704.63359053292;740.2412527159704;9296.581653825595;10279.743006424898;10418.270721049605;10428.217883658755;10800.891991080145;690.5429543662867;702.1924786495571;713.0694443750955;734.5262305812721;747.9588622625699;4678.789454474557;5076.13705670037;5076.36545431821;5085.982803439327;5089.796408143707;84216;99338.50330748444;101618.49190754;101927;105786;91801.08198917925;92478;95509.52245238869;96821;96889;62112.68943655343;78781;80402.59798700969;81411;81634;9518.09578090108;9898.804231641421;9915.65295214664;9942.403455792675;9975.700728978143;43388.56611433845;47466.52533474621;48296.75851620719;49809.75095124501;53402.1989670163;59906;60076;67750.3224967744;71034.22414439474;73354.63322683352;11148.721281968015;12708.110432269652;12751.744965100832;13035.413406396925;13437.328133593477;14463;14808.48866423712;14914.328855201325;14933.775993359892;14968.775468368201;13182.27497487609;13275.80086298687;14040.578782636538;14410.711785764435;14415.063020903608;12095.818562721743;13779.448822047407;13784.517541885985;14018.439262429389;14783.260836958325;11734.41327933617;12633.30516821547;13300.800487992494;13410.932945335211;14057.859421406065;9500.904990950003;9936.105750482491;9950.726115158977;10316.587336506456;10337.10093198487;11202.389102201547;11363.659090226976;11489.253198542068;11545.653630391102;11558.479868405773 07:14:55 INFO - PROCESS | 2010 | __end_tp_report 07:14:55 INFO - PROCESS | 2010 | __start_cc_report 07:14:55 INFO - PROCESS | 2010 | _x_x_mozilla_cycle_collect,1933 07:14:55 INFO - PROCESS | 2010 | __end_cc_report 07:14:55 INFO - PROCESS | 2010 | __startTimestamp1495808095544__endTimestamp 07:14:55 INFO - PROCESS | 2010 | 07:14:55 INFO - PROCESS | 2010 | ------- Summary: start ------- 07:14:55 INFO - PROCESS | 2010 | Number of tests: 6 07:14:55 INFO - PROCESS | 2010 | 07:14:55 INFO - PROCESS | 2010 | [#0] dojo.html Cycles:165 Average:5925.55 Median:6205.57 stddev:681.09 (11.0%) stddev-sans-first:653.47 07:14:55 INFO - PROCESS | 2010 | Values: 3389.1 3405.5 3425.3 3446.1 3485.2 6008.7 6023.2 6023.5 6060.4 6064.1 5978.1 6031.3 6037.8 6038.1 6045.5 5368.1 5368.6 5402.0 5421.9 5562.7 5295.0 5321.2 5362.2 5381.9 5495.4 5390.9 5406.7 5412.6 5423.4 5426.1 5405.4 5448.5 5540.1 5541.7 5544.8 5286.8 5419.2 5422.8 5423.1 5466.8 6051.2 6081.8 6097.9 6099.8 6107.6 6198.8 6238.0 6305.5 6349.3 6363.6 5720.4 6280.0 6350.2 6390.1 6491.7 6187.6 6191.5 6200.2 6202.8 6204.3 6550.7 6557.6 6567.9 6569.3 6571.7 6145.8 6210.3 6265.7 6276.6 6285.1 6409.0 6412.1 6424.6 6429.0 6438.4 6312.0 6322.6 6355.9 6360.0 6374.3 6250.8 6271.2 6272.6 6291.7 6382.7 4897.6 4923.0 4940.3 4952.9 4958.7 4391.9 4402.3 4404.0 4418.7 4432.7 5657.3 5846.9 5904.9 5916.9 5920.4 5324.9 6264.1 6298.4 6310.9 6313.1 4697.0 5738.4 5762.5 5827.3 5830.1 5582.9 5597.7 5614.2 5625.0 5625.9 6566.4 6595.0 6613.3 6638.0 6682.4 6252.8 6294.4 6498.5 6503.9 6510.7 6566.5 6609.2 6660.5 6694.8 6695.3 6380.9 6387.9 6404.8 6409.5 6429.5 6229.6 6327.0 6451.2 6457.0 6458.5 6237.4 6261.0 6262.8 6264.4 6289.9 6293.4 6322.3 6334.3 6337.2 6343.1 6136.8 6173.4 6209.6 6210.0 6289.8 6146.1 6252.8 6256.4 6342.4 6343.7 6205.6 6261.3 6269.5 6273.1 6281.1 07:14:55 INFO - PROCESS | 2010 | 07:14:55 INFO - PROCESS | 2010 | [#1] ext.html Cycles:180 Average:59696.61 Median:30252.42 stddev:128000.99 (423.1%) stddev-sans-first:128283.56 07:14:55 INFO - PROCESS | 2010 | Values: 749.3 802.9 825.6 876.5 896.2 28246.6 37878.5 38010.4 40898.8 41818.8 42452.6 42653.6 42696.0 42717.7 42800.8 7655.4 9486.2 9660.5 9666.6 9673.1 7708.0 11436.0 11673.0 11870.4 11879.3 11693.7 11718.0 11721.8 11727.4 11800.0 11615.4 11651.7 11658.4 11664.8 11668.6 11366.4 11401.0 11421.5 11443.7 11444.8 39446.8 39641.0 39661.8 39707.6 39737.0 3864.6 3885.1 3890.3 3900.3 3959.4 27028.1 27698.2 29453.4 30182.0 30322.8 3074.4 3111.4 3228.5 3249.9 3311.1 370060.0 370643.0 373072.0 373909.0 374255.0 53425.0 53430.0 53542.5 53557.5 53583.5 46252.0 56281.6 56322.0 56351.0 56450.0 14577.3 14953.3 14975.9 14986.8 15010.5 9301.3 11326.3 12845.0 12871.8 12908.4 10692.9 11878.3 14203.4 14377.9 14563.6 6175.5 6252.4 6268.2 6292.0 6357.8 1158.5 1179.7 1196.9 1200.5 1201.1 28174.9 28725.4 28761.9 28820.9 28836.6 1075.2 1077.8 1078.3 1114.5 1120.6 12736.1 13449.6 13660.7 13675.9 13745.9 531137.0 533277.0 534556.0 534895.0 535889.0 46155.0 46356.5 46424.0 46425.0 46457.0 1399.3 1452.2 1454.4 1455.6 1461.0 21894.8 23708.4 25161.6 25696.6 25721.2 35131.6 37382.4 37422.0 37456.1 37476.9 513874.0 516821.8 517054.0 517736.0 517953.0 29767.6 30053.7 30121.7 30682.8 30694.1 32013.7 38419.0 38941.8 39020.0 39094.6 24316.4 27641.6 27901.7 28793.6 29587.0 23623.8 26095.5 27761.3 29003.7 29264.0 32923.0 33040.0 33119.0 33423.2 33701.7 26859.9 28876.6 29585.0 29636.6 29725.7 20858.7 22485.4 22502.7 22599.4 22644.7 07:14:55 INFO - PROCESS | 2010 | 07:14:55 INFO - PROCESS | 2010 | [#2] jquery.html Cycles:180 Average:44100.72 Median:2161.27 stddev:130087.39 (6019.0%) stddev-sans-first:130410.82 07:14:55 INFO - PROCESS | 2010 | Values: 338.4 432.4 435.5 440.4 449.5 13430.9 15148.4 18028.0 21936.5 22683.3 19863.4 22503.2 22986.8 23047.2 23612.8 6571.8 6955.8 7022.4 7039.3 7064.9 6702.9 6910.1 6933.4 6953.6 7002.6 6996.8 7003.6 7004.0 7009.4 7018.3 6696.6 6866.7 6938.8 6940.9 6946.3 6706.7 6714.2 6790.8 6792.1 6824.6 27868.6 27894.9 27921.3 27985.3 28277.6 2821.4 2960.6 2983.8 3058.6 3071.4 15768.2 15783.4 15800.9 16531.9 16637.1 1960.9 2026.2 2137.6 2158.9 2163.7 155974.0 163634.2 163872.0 170978.0 175322.1 19666.9 20351.9 20445.5 20773.7 20922.0 31522.1 31895.0 32093.5 32173.0 32235.0 9353.9 9690.3 10143.4 10341.5 10420.5 8612.7 8618.9 8641.6 8792.1 8807.6 7640.4 7726.6 9246.4 9325.5 9455.1 3305.0 3746.0 3821.8 3834.8 3834.8 807.6 994.6 1011.9 1022.5 1022.9 20449.9 20527.3 20568.0 20695.4 21029.0 993.2 1005.6 1020.3 1020.9 1024.7 10166.2 10308.0 10759.5 10769.3 10854.7 769806.0 771201.0 774350.0 782194.0 803681.0 122010.0 126736.0 154939.5 155984.0 161926.2 1238.2 1244.6 1273.0 1276.7 1282.1 17851.9 18725.3 18830.3 18843.8 18862.0 63533.0 64033.0 64121.0 64224.4 64500.8 89777.6 90948.6 92549.0 93021.5 93583.0 11213.9 11429.5 11462.9 11590.9 11790.4 12877.9 12919.4 13123.0 13144.9 13300.3 11017.7 11191.1 11249.4 11262.0 11480.5 10253.7 10379.8 10480.9 10537.7 10557.6 8733.8 11480.4 11517.0 11565.0 11703.9 11410.5 11470.6 11491.7 11526.9 11842.2 9446.1 11101.7 11318.2 11441.8 11443.9 07:14:55 INFO - PROCESS | 2010 | 07:14:55 INFO - PROCESS | 2010 | [#3] mootools.html Cycles:180 Average:6767.89 Median:2384.21 stddev:4310.59 (180.8%) stddev-sans-first:4303.38 07:14:55 INFO - PROCESS | 2010 | Values: 1339.2 1557.8 1591.3 1593.4 1602.2 9361.5 9762.3 10970.3 11309.3 11519.7 9371.8 11190.9 11297.4 11315.8 11379.5 1925.4 1988.6 2023.5 2038.5 2393.3 1916.4 2077.0 2396.2 2399.9 2410.2 2374.7 2376.0 2382.9 2384.2 2384.2 2322.8 2370.5 2375.7 2381.0 2383.4 2315.6 2324.8 2330.4 2334.7 2339.4 11370.4 11461.4 11485.7 11506.8 11512.5 5386.6 5518.3 5539.7 5549.4 5561.6 3002.7 3218.6 3350.9 3466.4 3518.4 1062.6 1132.1 1141.4 1156.0 1164.1 14839.8 15263.5 15687.9 15695.0 15710.9 4450.5 4557.0 4581.3 4583.0 4600.0 11635.4 11664.6 11680.2 11690.2 11695.9 5547.2 5558.8 5568.8 5575.2 5602.8 4460.8 5073.9 5153.6 5165.5 5260.6 2995.5 3339.4 3678.8 3761.3 3850.2 923.4 958.5 981.3 988.5 991.7 956.6 988.5 997.6 999.7 1010.2 6694.0 6839.9 7032.5 7033.2 7075.6 882.3 1060.4 1091.5 1108.6 1119.7 4242.6 4306.5 4341.1 4446.6 4550.2 11000.7 13228.1 14030.6 14111.6 14129.7 13501.5 13699.2 13943.6 13954.2 13973.4 10042.3 10291.2 10305.1 10305.4 10312.8 6134.5 6651.4 6834.1 6954.3 7111.2 11953.0 12108.0 12286.5 12537.4 12560.9 12447.3 12578.7 12690.6 12732.7 12928.5 9950.3 10239.7 10455.2 10535.7 10548.2 10618.5 10624.5 10694.6 10727.0 10730.3 8671.2 8705.3 8875.0 8899.3 9026.5 8619.1 8728.8 8766.1 8785.3 8916.0 8036.6 8175.7 8191.5 8193.1 8196.8 5855.7 5893.4 5934.0 6071.9 6076.9 5140.7 5907.5 5969.4 6134.4 6222.3 07:14:55 INFO - PROCESS | 2010 | 07:14:55 INFO - PROCESS | 2010 | [#4] prototype.html Cycles:180 Average:4411.86 Median:4738.32 stddev:1218.71 (25.7%) stddev-sans-first:1184.00 07:14:55 INFO - PROCESS | 2010 | Values: 381.8 385.3 386.5 395.1 395.3 4313.4 4566.5 4654.2 4732.2 4945.6 3918.5 4343.3 4525.6 4622.7 4932.9 3717.3 4077.8 4150.5 4167.2 4197.5 3905.5 3989.2 4054.5 4179.9 4236.0 4193.9 4228.4 4235.0 4236.8 4276.9 3312.9 3804.9 3921.8 3999.4 4197.2 3406.0 3826.4 3833.7 3833.9 3885.0 4773.0 4786.9 4808.1 4825.0 4944.3 3976.0 4520.5 4681.4 4833.3 4945.6 5260.5 5276.7 5290.1 5298.8 5355.8 3783.3 3984.7 4291.6 4320.4 4363.8 4643.7 4923.6 5136.4 5150.4 5235.4 3960.1 4129.0 4217.7 4350.4 4361.5 3909.2 4456.0 4459.8 4504.2 4511.9 4356.9 4378.3 4384.5 4640.0 4836.6 4823.6 4917.2 4929.6 5104.5 5255.3 1383.2 1433.0 1470.2 1487.8 1501.5 985.5 1018.1 1070.5 1091.5 1179.5 4427.2 4784.1 4846.7 4857.3 4953.5 4897.7 5512.4 5550.8 5580.3 5603.4 3927.1 4320.7 4516.5 4537.9 4815.5 2750.6 2860.9 2888.9 2896.8 2925.2 5138.9 5320.4 5641.8 5723.6 5760.2 4639.9 4979.7 5380.3 5482.5 5693.8 4636.1 5460.7 5563.6 5570.3 5690.7 4992.9 5071.6 5258.3 5520.3 5542.0 4651.6 4865.0 5250.5 5458.5 5556.9 4994.6 5417.8 5646.0 5723.4 5754.8 4345.2 4411.9 4479.5 4843.9 4874.2 5026.5 5513.8 5540.4 5547.3 5553.3 4721.6 4762.7 5331.4 5404.5 5462.8 4305.2 4779.7 5316.8 5371.4 5375.4 4579.4 4942.4 5216.7 5257.4 5274.7 4696.0 4744.4 5233.9 5321.7 5359.4 4328.5 4948.7 5086.3 5219.9 5234.6 07:14:55 INFO - PROCESS | 2010 | 07:14:55 INFO - PROCESS | 2010 | [#5] yui.html Cycles:180 Average:20944.03 Median:23497.26 stddev:30400.75 (129.4%) stddev-sans-first:30448.20 07:14:55 INFO - PROCESS | 2010 | Values: 746.1 757.6 782.6 853.3 862.4 15615.5 16394.8 16418.3 16468.8 16539.9 14675.2 15038.4 15271.8 15290.2 15508.2 866.0 983.8 994.6 998.7 1001.3 974.9 994.3 997.5 1000.8 1002.4 1037.7 1039.4 1042.0 1042.9 1043.1 1032.8 1034.6 1035.5 1035.7 1037.0 757.1 780.3 780.8 781.6 781.8 16136.8 16518.3 16583.3 16831.8 17035.7 12004.7 14654.0 14661.0 14662.3 14679.2 11348.3 11844.9 11845.3 11918.9 11952.7 3656.5 3698.2 3706.2 3710.6 3762.7 114980.3 116304.0 118775.0 120441.0 122569.8 11085.9 11123.6 11131.6 11178.0 11712.9 23036.2 23363.3 23448.0 23453.0 23541.5 7865.5 7875.3 7879.2 7890.8 8152.4 4436.7 4473.9 4522.9 4568.7 4569.1 3182.8 3308.9 3406.6 3505.8 3509.1 602.5 611.8 612.9 613.6 614.0 671.3 676.9 700.5 704.6 740.2 9296.6 10279.7 10418.3 10428.2 10800.9 690.5 702.2 713.1 734.5 748.0 4678.8 5076.1 5076.4 5086.0 5089.8 84216.0 99338.5 101618.5 101927.0 105786.0 91801.1 92478.0 95509.5 96821.0 96889.0 62112.7 78781.0 80402.6 81411.0 81634.0 9518.1 9898.8 9915.7 9942.4 9975.7 43388.6 47466.5 48296.8 49809.8 53402.2 59906.0 60076.0 67750.3 71034.2 73354.6 11148.7 12708.1 12751.7 13035.4 13437.3 14463.0 14808.5 14914.3 14933.8 14968.8 13182.3 13275.8 14040.6 14410.7 14415.1 12095.8 13779.4 13784.5 14018.4 14783.3 11734.4 12633.3 13300.8 13410.9 14057.9 9500.9 9936.1 9950.7 10316.6 10337.1 11202.4 11363.7 11489.3 11545.7 11558.5 07:14:55 INFO - PROCESS | 2010 | -------- Summary: end -------- 07:14:55 INFO - PROCESS | 2010 | 07:14:56 INFO - TEST-INFO | 2010: exit 0 07:14:56 INFO - TEST-OK | dromaeo_css | took 1118514ms 07:14:56 INFO - TEST-START | kraken 07:14:56 INFO - operating with platform_type : mac_ 07:14:56 INFO - Initialising browser for kraken test... 07:14:56 INFO - TEST-INFO | started process 2014 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/tmpV1Gu4h/profile http://localhost:52938/getInfo.html) 07:14:58 INFO - PROCESS | 2014 | __metrics Screen width/height:1600/1200 07:14:58 INFO - PROCESS | 2014 | colorDepth:24 07:14:58 INFO - PROCESS | 2014 | Browser inner width/height: 1024/689 07:14:58 INFO - PROCESS | 2014 | __metrics 07:14:58 INFO - PROCESS | 2014 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:14:58 INFO - PROCESS | 2014 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:14:59 INFO - TEST-INFO | 2014: exit 0 07:14:59 INFO - Browser initialized. 07:14:59 INFO - Running cycle 1/1 for kraken test... 07:14:59 INFO - TEST-INFO | started process 2016 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/tmpV1Gu4h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:15:11 INFO - PROCESS | 2016 | RSS: Main: 193703936 07:15:11 INFO - PROCESS | 2016 | 07:15:14 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52938/tests/kraken/driver.html?testName=audio-beat-detection) 07:15:15 INFO - PROCESS | 2016 | RSS: Main: 244748288 07:15:15 INFO - PROCESS | 2016 | 07:15:17 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52938/tests/kraken/driver.html?testName=audio-dft) 07:15:18 INFO - PROCESS | 2016 | RSS: Main: 258953216 07:15:18 INFO - PROCESS | 2016 | 07:15:21 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52938/tests/kraken/driver.html?testName=audio-fft) 07:15:22 INFO - PROCESS | 2016 | RSS: Main: 355680256 07:15:22 INFO - PROCESS | 2016 | 07:15:24 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52938/tests/kraken/driver.html?testName=audio-oscillator) 07:15:24 INFO - PROCESS | 2016 | RSS: Main: 258813952 07:15:24 INFO - PROCESS | 2016 | 07:15:26 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52938/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:15:27 INFO - PROCESS | 2016 | RSS: Main: 260829184 07:15:27 INFO - PROCESS | 2016 | 07:15:30 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52938/tests/kraken/driver.html?testName=imaging-darkroom) 07:15:31 INFO - PROCESS | 2016 | RSS: Main: 300474368 07:15:31 INFO - PROCESS | 2016 | 07:15:34 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52938/tests/kraken/driver.html?testName=imaging-desaturate) 07:15:34 INFO - PROCESS | 2016 | RSS: Main: 300634112 07:15:34 INFO - PROCESS | 2016 | 07:15:37 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52938/tests/kraken/driver.html?testName=json-parse-financial) 07:15:38 INFO - PROCESS | 2016 | RSS: Main: 300236800 07:15:38 INFO - PROCESS | 2016 | 07:15:39 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52938/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:15:40 INFO - PROCESS | 2016 | RSS: Main: 276131840 07:15:40 INFO - PROCESS | 2016 | 07:15:42 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:15:42 INFO - PROCESS | 2016 | RSS: Main: 280899584 07:15:42 INFO - PROCESS | 2016 | 07:15:45 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:15:45 INFO - PROCESS | 2016 | RSS: Main: 289955840 07:15:45 INFO - PROCESS | 2016 | 07:15:48 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:15:49 INFO - PROCESS | 2016 | RSS: Main: 301228032 07:15:49 INFO - PROCESS | 2016 | 07:15:52 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:15:53 INFO - PROCESS | 2016 | RSS: Main: 294838272 07:15:53 INFO - PROCESS | 2016 | 07:15:54 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52938/tests/kraken/driver.html?testName=ai-astar) 07:15:54 INFO - PROCESS | 2016 | RSS: Main: 339685376 07:15:54 INFO - PROCESS | 2016 | 07:15:54 INFO - PROCESS | 2016 | __start_tp_report 07:15:54 INFO - PROCESS | 2016 | _x_x_mozilla_page_load 07:15:54 INFO - PROCESS | 2016 | _x_x_mozilla_page_load_details 07:15:54 INFO - PROCESS | 2016 | |i|pagename|runs| 07:15:54 INFO - PROCESS | 2016 | |0;ai-astar;107;115;114;115;114;116;114;115;116;115 07:15:54 INFO - PROCESS | 2016 | |1;audio-beat-detection;140;108;110;167;135;112;108;108;128;109 07:15:54 INFO - PROCESS | 2016 | |2;audio-dft;196;256;208;187;249;234;184;183;183;192 07:15:54 INFO - PROCESS | 2016 | |3;audio-fft;85;59;61;91;60;63;60;60;78;60 07:15:54 INFO - PROCESS | 2016 | |4;audio-oscillator;91;69;87;68;69;69;83;68;69;82 07:15:54 INFO - PROCESS | 2016 | |5;imaging-gaussian-blur;87;87;86;86;87;86;86;86;87;87 07:15:54 INFO - PROCESS | 2016 | |6;imaging-darkroom;94;94;93;93;93;94;106;146;147;93 07:15:54 INFO - PROCESS | 2016 | |7;imaging-desaturate;85;87;85;85;85;83;85;84;83;84 07:15:54 INFO - PROCESS | 2016 | |8;json-parse-financial;58;59;62;61;63;63;65;64;64;64 07:15:54 INFO - PROCESS | 2016 | |9;json-stringify-tinderbox;61;60;63;65;62;60;59;59;59;59 07:15:54 INFO - PROCESS | 2016 | |10;stanford-crypto-aes;86;82;79;85;83;84;79;87;88;84 07:15:54 INFO - PROCESS | 2016 | |11;stanford-crypto-ccm;145;146;154;139;135;134;133;138;186;171 07:15:54 INFO - PROCESS | 2016 | |12;stanford-crypto-pbkdf2;165;157;163;175;196;163;165;161;210;213 07:15:54 INFO - PROCESS | 2016 | |13;stanford-crypto-sha256-iterative;66;65;65;65;63;63;64;62;63;64 07:15:54 INFO - PROCESS | 2016 | __end_tp_report 07:15:54 INFO - PROCESS | 2016 | __start_cc_report 07:15:54 INFO - PROCESS | 2016 | _x_x_mozilla_cycle_collect,2141 07:15:54 INFO - PROCESS | 2016 | __end_cc_report 07:15:54 INFO - PROCESS | 2016 | __startTimestamp1495808154987__endTimestamp 07:15:54 INFO - PROCESS | 2016 | 07:15:54 INFO - PROCESS | 2016 | ------- Summary: start ------- 07:15:54 INFO - PROCESS | 2016 | Number of tests: 14 07:15:54 INFO - PROCESS | 2016 | 07:15:54 INFO - PROCESS | 2016 | [#0] ai-astar Cycles:10 Average:114.10 Median:115.00 stddev:2.60 (2.3%) stddev-sans-first:0.78 07:15:54 INFO - PROCESS | 2016 | Values: 107.0 115.0 114.0 115.0 114.0 116.0 114.0 115.0 116.0 115.0 07:15:54 INFO - PROCESS | 2016 | 07:15:54 INFO - PROCESS | 2016 | [#1] audio-beat-detection Cycles:10 Average:122.50 Median:120.00 stddev:19.87 (16.6%) stddev-sans-first:20.04 07:15:54 INFO - PROCESS | 2016 | Values: 140.0 108.0 110.0 167.0 135.0 112.0 108.0 108.0 128.0 109.0 07:15:54 INFO - PROCESS | 2016 | 07:15:54 INFO - PROCESS | 2016 | [#2] audio-dft Cycles:10 Average:207.20 Median:202.00 stddev:28.52 (14.1%) stddev-sans-first:29.96 07:15:54 INFO - PROCESS | 2016 | Values: 196.0 256.0 208.0 187.0 249.0 234.0 184.0 183.0 183.0 192.0 07:15:54 INFO - PROCESS | 2016 | 07:15:54 INFO - PROCESS | 2016 | [#3] audio-fft Cycles:10 Average:67.70 Median:62.00 stddev:12.15 (19.6%) stddev-sans-first:11.16 07:15:54 INFO - PROCESS | 2016 | Values: 85.0 59.0 61.0 91.0 60.0 63.0 60.0 60.0 78.0 60.0 07:15:54 INFO - PROCESS | 2016 | 07:15:54 INFO - PROCESS | 2016 | [#4] audio-oscillator Cycles:10 Average:75.50 Median:75.50 stddev:9.14 (12.1%) stddev-sans-first:7.79 07:15:54 INFO - PROCESS | 2016 | Values: 91.0 69.0 87.0 68.0 69.0 69.0 83.0 68.0 69.0 82.0 07:15:54 INFO - PROCESS | 2016 | 07:15:54 INFO - PROCESS | 2016 | [#5] imaging-gaussian-blur Cycles:10 Average:86.50 Median:87.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 07:15:54 INFO - PROCESS | 2016 | Values: 87.0 87.0 86.0 86.0 87.0 86.0 86.0 86.0 87.0 87.0 07:15:54 INFO - PROCESS | 2016 | 07:15:54 INFO - PROCESS | 2016 | [#6] imaging-darkroom Cycles:10 Average:105.30 Median:93.00 stddev:22.07 (23.7%) stddev-sans-first:23.03 07:15:54 INFO - PROCESS | 2016 | Values: 94.0 94.0 93.0 93.0 93.0 94.0 106.0 146.0 147.0 93.0 07:15:54 INFO - PROCESS | 2016 | 07:15:54 INFO - PROCESS | 2016 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:1.17 (1.4%) stddev-sans-first:1.24 07:15:54 INFO - PROCESS | 2016 | Values: 85.0 87.0 85.0 85.0 85.0 83.0 85.0 84.0 83.0 84.0 07:15:54 INFO - PROCESS | 2016 | 07:15:54 INFO - PROCESS | 2016 | [#8] json-parse-financial Cycles:10 Average:62.30 Median:63.50 stddev:2.31 (3.6%) stddev-sans-first:1.86 07:15:54 INFO - PROCESS | 2016 | Values: 58.0 59.0 62.0 61.0 63.0 63.0 65.0 64.0 64.0 64.0 07:15:55 INFO - PROCESS | 2016 | 07:15:55 INFO - PROCESS | 2016 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:60.50 stddev:2.06 (3.4%) stddev-sans-first:2.18 07:15:55 INFO - PROCESS | 2016 | Values: 61.0 60.0 63.0 65.0 62.0 60.0 59.0 59.0 59.0 59.0 07:15:55 INFO - PROCESS | 2016 | 07:15:55 INFO - PROCESS | 2016 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.50 stddev:3.06 (3.6%) stddev-sans-first:3.13 07:15:55 INFO - PROCESS | 2016 | Values: 86.0 82.0 79.0 85.0 83.0 84.0 79.0 87.0 88.0 84.0 07:15:55 INFO - PROCESS | 2016 | 07:15:55 INFO - PROCESS | 2016 | [#11] stanford-crypto-ccm Cycles:10 Average:148.10 Median:145.50 stddev:17.62 (12.1%) stddev-sans-first:18.65 07:15:55 INFO - PROCESS | 2016 | Values: 145.0 146.0 154.0 139.0 135.0 134.0 133.0 138.0 186.0 171.0 07:15:55 INFO - PROCESS | 2016 | 07:15:55 INFO - PROCESS | 2016 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.80 Median:170.00 stddev:21.31 (12.5%) stddev-sans-first:22.17 07:15:55 INFO - PROCESS | 2016 | Values: 165.0 157.0 163.0 175.0 196.0 163.0 165.0 161.0 210.0 213.0 07:15:55 INFO - PROCESS | 2016 | 07:15:55 INFO - PROCESS | 2016 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.50 stddev:1.25 (1.9%) stddev-sans-first:1.09 07:15:55 INFO - PROCESS | 2016 | Values: 66.0 65.0 65.0 65.0 63.0 63.0 64.0 62.0 63.0 64.0 07:15:55 INFO - PROCESS | 2016 | -------- Summary: end -------- 07:15:55 INFO - PROCESS | 2016 | 07:15:55 INFO - TEST-INFO | 2016: exit 0 07:15:55 INFO - TEST-OK | kraken | took 59541ms 07:15:55 INFO - SUITE-END | took 1178s 07:15:56 INFO - Completed test suite (00:19:38) 07:15:56 INFO - javascript benchmark 07:15:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7684.843222025494, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3389.135770378554, 3405.4721518164683, 3425.3320602482527, 3446.1390848941573, 3485.1809824691195, 6008.699565021748, 6023.2169817923605, 6023.457888790013, 6060.3939606039485, 6064.060070689039, 5978.103284507326, 6031.306399764028, 6037.758489660419, 6038.064100064486, 6045.455908968192, 5368.114261146926, 5368.570514358861, 5402.0, 5421.891562168754, 5562.694051827148, 5295.0468915595175, 5321.201819727034, 5362.168863826094, 5381.919271210935, 5495.368032676233, 5390.8921821563745, 5406.729663516828, 5412.648177868426, 5423.403425623178, 5426.131818908975, 5405.4324295948945, 5448.482394172567, 5540.085885828834, 5541.667499950016, 5544.77820887164, 5286.841394758163, 5419.214213938996, 5422.783088676449, 5423.105187644034, 5466.808661696821, 6051.152838602599, 6081.756729730805, 6097.902377572035, 6099.847503812396, 6107.572469927107, 6198.783042593487, 6237.968810155966, 6305.464035556937, 6349.333320001426, 6363.554551181419, 5720.370759216483, 6280.026595877646, 6350.206224221973, 6390.0734393512685, 6491.707873145672, 6187.628742275478, 6191.504679625619, 6200.162977998003, 6202.81391558254, 6204.317525072329, 6550.70521826519, 6557.573757705829, 6567.901481477782, 6569.277379488348, 6571.704273307712, 6145.801568694151, 6210.285817130997, 6265.686715664198, 6276.560640755103, 6285.120083188357, 6408.967955160288, 6412.134361861183, 6424.614523128627, 6429.03564465334, 6438.3883531064475, 6312.021636646327, 6322.557420980487, 6355.936440635534, 6359.96820015897, 6374.266959299647, 6250.843728906813, 6271.247450305992, 6272.5922815016875, 6291.6854157291955, 6382.680865956777, 4897.559219670246, 4922.975385123052, 4940.283658869444, 4952.925706114411, 4958.7024778513405, 4391.934120988188, 4402.339649052604, 4404.031113155101, 4418.7127836690515, 4432.734035957853, 5657.2928383952, 5846.853828654318, 5904.852378690482, 5916.9053725061, 5920.37836027211, 5324.893502130013, 6264.123022776815, 6298.433141017331, 6310.905336419957, 6313.05304204373, 4697.037107392976, 5738.397468265772, 5762.452567006211, 5827.300723913073, 5830.067189249699, 5582.944170558242, 5597.692126932976, 5614.242077319591, 5624.97187514068, 5625.887482250332, 6566.376194261633, 6594.967025164843, 6613.3056029117215, 6638.037484564711, 6682.431993280626, 6252.781152659635, 6294.433500984934, 6498.545101842826, 6503.902441463287, 6510.73957041732, 6566.474682025522, 6609.20689517261, 6660.467162626881, 6694.765683201064, 6695.263521012782, 6380.87238255223, 6387.904181437189, 6404.775832845828, 6409.519286053472, 6429.453496452854, 6229.626222426669, 6327.0, 6451.1936007999, 6457.031445283245, 6458.54790164684, 6237.376262373727, 6261.0, 6262.843428914131, 6264.436200741955, 6289.9056514153235, 6293.402126797947, 6322.304546499973, 6334.303226645157, 6337.2395312562785, 6343.080253363144, 6136.7852125175405, 6173.41352571505, 6209.565330427007, 6210.037444196157, 6289.779857704958, 6146.139540464249, 6252.812415627538, 6256.436920677161, 6342.4291813735135, 6343.714532845941, 6205.565610407409, 6261.342559031418, 6269.467095296768, 6273.059041143865, 6281.120643109877], "value": 5880.185115061634, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.3330935467435, 802.8956235689361, 825.5583262954319, 876.4960147914951, 896.2337201692549, 28246.57630135547, 37878.484860605546, 38010.42984355237, 40898.79550602246, 41818.79090604546, 42452.57547424525, 42653.57346426535, 42696.0, 42717.71846844592, 42800.78599607005, 7655.425843061765, 9486.241100711926, 9660.468674222915, 9666.613335466607, 9673.081057299545, 7707.961460192691, 11436.0, 11673.0, 11870.406479675981, 11879.287242765462, 11693.707657308592, 11718.003969662588, 11721.824172637418, 11727.354995475245, 11800.0, 11615.361155136465, 11651.708707282301, 11658.358790266531, 11664.766704665944, 11668.649940501798, 11366.37484938328, 11400.973912347928, 11421.54313827446, 11443.713907152305, 11444.828327575093, 39446.80276598599, 39641.0, 39661.80169099165, 39707.60292397068, 39737.0, 3864.613538646141, 3885.0870045539277, 3890.3386424307937, 3900.258950799339, 3959.3665013597974, 27028.054018109273, 27698.16905492818, 29453.41093178146, 30182.0, 30322.848385758152, 3074.3543855790313, 3111.4088323218516, 3228.4834426491884, 3249.8537565809597, 3311.106001379638, 370060.0, 370643.0, 373072.0, 373909.0, 374255.0, 53425.0, 53430.0, 53542.46457535453, 53557.46442535525, 53583.46416535863, 46252.0, 56281.592960175505, 56322.0, 56351.0, 56450.0, 14577.344019519147, 14953.252337383088, 14975.850241497663, 14986.775198372034, 15010.549683509513, 9301.348905576544, 11326.32042077478, 12845.0, 12871.806922896165, 12908.419121139572, 10692.946535267429, 11878.346690931909, 14203.360848761624, 14377.928110359382, 14563.563093107225, 6175.456135966008, 6252.374762523802, 6268.247810262797, 6292.0, 6357.777477788255, 1158.530795028015, 1179.6669763167565, 1196.85637723472, 1200.4837919694442, 1201.0602876354624, 28174.85912570424, 28725.425491490052, 28761.856190719333, 28820.855895720386, 28836.567451488245, 1075.1828610256262, 1077.8059949209219, 1078.2883297023927, 1114.4984756859446, 1120.574181810923, 12736.108472406842, 13449.596512104652, 13660.65848353799, 13675.905927525973, 13745.931270343784, 531137.0, 533277.0, 534556.0, 534895.0, 535889.0, 46155.0, 46356.5364346359, 46424.0, 46425.0, 46457.0, 1399.2863639543905, 1452.2230606625405, 1454.3818876977032, 1455.5633310006956, 1461.0, 21894.781052189912, 23708.407289817893, 25161.622575661015, 25696.614550782127, 25721.228363149134, 35131.64868351386, 37382.439263410524, 37422.0, 37456.063598410256, 37476.875693729235, 513874.0, 516821.8317816924, 517054.0, 517736.0, 517953.0, 29767.553486697285, 30053.69946300509, 30121.69878301189, 30682.84658576693, 30694.079177624706, 32013.679863202, 38419.0, 38941.805290974495, 39020.0, 39094.609053909095, 24316.392090197885, 27641.58537621897, 27901.720982789913, 28793.56809647815, 29587.0, 23623.763762362156, 26095.478090438464, 27761.30596735017, 29003.709962900102, 29264.0, 32923.0, 33040.008799736046, 33119.006429807145, 33423.1644208887, 33701.662983370836, 26859.865700671373, 28876.566851496824, 29585.0, 29636.555451668675, 29725.702742972295, 20858.687119692913, 22485.39049494817, 22502.662460062784, 22599.435014124778, 22644.66033009539], "value": 18781.571399374327, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.41116457364194, 432.4022735990516, 435.4556803995005, 440.3636744903614, 449.49431889124736, 13430.865691343084, 15148.394064237431, 18027.99999999998, 21936.45158871029, 22683.31950041497, 19863.404097877086, 22503.21238756644, 22986.770132298672, 23047.234331880158, 23612.763872361313, 6571.769988050407, 6955.756548520802, 7022.403095736869, 7039.260877607829, 7064.9293507064785, 6702.932970670304, 6910.136232970879, 6933.375996160345, 6953.617551034691, 7002.614856182908, 6996.790096297119, 7003.5797852129035, 7003.964980175092, 7009.404200642952, 7018.33325834045, 6696.564723292995, 6866.725330986779, 6938.826529336757, 6940.930590694129, 6946.2706415826115, 6706.664666766642, 6714.227863795629, 6790.76232331871, 6792.0830687857, 6824.556403833784, 27868.581971270447, 27894.860525697444, 27921.301967450774, 27985.30036749077, 28277.57583636247, 2821.3510892494637, 2960.6003189569565, 2983.820970741741, 3058.571799948009, 3071.416430878126, 15768.211589420598, 15783.447579334783, 15800.920995395065, 16531.91734041334, 16637.084960327178, 1960.8725432846961, 2026.2097781865084, 2137.551114266006, 2158.870467771923, 2163.664631982045, 155974.0, 163634.18362758882, 163872.0, 170978.0, 175322.12338938224, 19666.91831949228, 20351.898240509, 20445.48886277855, 20773.688394674093, 20922.0, 31522.054338369886, 31895.043148705576, 32093.51859722106, 32173.0, 32235.0, 9353.906460935303, 9690.273229507815, 10143.391396516232, 10341.534630941625, 10420.478976051167, 8612.708093785983, 8618.913810861937, 8641.611127499278, 8792.076831932683, 8807.559622019002, 7640.350570201484, 7726.575038372944, 9246.352755307198, 9325.533723313807, 9455.101765332283, 3305.0415379539663, 3745.951133682573, 3821.8280177392085, 3834.7699138051807, 3834.7699138051807, 807.600237882252, 994.6220436234329, 1011.8644319266426, 1022.4734261855151, 1022.9310370662675, 20449.89775051115, 20527.28154514585, 20567.971601419868, 20695.379138625864, 21029.0, 993.2203220471895, 1005.5977608956476, 1020.2603112743202, 1020.938743675367, 1024.6772266736104, 10166.237532185116, 10308.0, 10759.515821788038, 10769.299995500267, 10854.72863178411, 769806.0, 771201.0, 774350.0, 782194.0, 803681.0, 122010.0, 126736.0, 154939.47832869075, 155984.0, 161926.1903690474, 1238.2446707508414, 1244.6017274472263, 1272.9872701272868, 1276.7063575377715, 1282.1281528560482, 17851.910740446736, 18725.25098996025, 18830.3409380671, 18843.811561884206, 18862.0, 63533.0, 64033.0, 64121.0, 64224.394390140624, 64500.8399328062, 89777.55111224402, 90948.56495580776, 92549.0, 93021.5348923278, 93583.0, 11213.887861121611, 11429.542818287175, 11462.85371462847, 11590.942045290058, 11790.351530665896, 12877.871221288042, 12919.354032298159, 13123.0, 13144.934275328562, 13300.268485233406, 11017.669469915916, 11191.104711623213, 11249.437528123397, 11262.0, 11480.540778368771, 10253.74365640865, 10379.792404152025, 10480.895191048297, 10537.683869483928, 10557.577696892038, 8733.781655458664, 11480.425978701198, 11517.02105321057, 11565.0, 11703.941480292544, 11410.543578256777, 11470.598529051776, 11491.650155675077, 11526.94236528812, 11842.171048026556, 9446.149846513572, 11101.666949991513, 11318.207725459139, 11441.771164576496, 11443.885561144281], "value": 11565.94554571061, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.196482110733, 1557.7896983907176, 1591.2600640702076, 1593.4422951966812, 1602.214914691801, 9361.48511831849, 9762.267829912758, 10970.286931349458, 11309.264897781639, 11519.712007199803, 9371.812563748737, 11190.936860998212, 11297.378644174567, 11315.773684526304, 11379.487923043462, 1925.3646296722118, 1988.602279544097, 2023.5447024419534, 2038.4699978005751, 2393.3059412770276, 1916.425072478251, 2077.0, 2396.18529699902, 2399.9280021599293, 2410.2287268074224, 2374.691290132289, 2376.0495801679294, 2382.880855957204, 2384.177458776719, 2384.237044145874, 2322.837401381904, 2370.5140446208484, 2375.738668746445, 2381.0, 2383.4398916254668, 2315.6410756332793, 2324.837261391703, 2330.4057465346227, 2334.7198336199594, 2339.4385347516472, 11370.374629395379, 11461.36962467064, 11485.655430337103, 11506.769864602746, 11512.539498420054, 5386.596005299618, 5518.255035570187, 5539.695316757577, 5549.38956714761, 5561.582881283879, 3002.6697063323018, 3218.5815843940372, 3350.932981340384, 3466.3933811583124, 3518.384282750534, 1062.5537274344795, 1132.1339175530725, 1141.3551343490983, 1156.011610073392, 1164.085080043324, 14839.777403338958, 15263.473652634648, 15687.921560392238, 15695.0, 15710.921445392814, 4450.5104438511735, 4557.020240648277, 4581.266997280419, 4583.0, 4600.0, 11635.418229088511, 11664.591739289084, 11680.240784348991, 11690.240134391237, 11695.947364737214, 5547.223388725582, 5558.805441809517, 5568.832935011957, 5575.219469274305, 5602.831915042555, 4460.77696115193, 5073.909109541466, 5153.561947234527, 5165.457626949116, 5260.579153667774, 2995.5207166853197, 3339.398908196499, 3678.76088054281, 3761.307411664707, 3850.172212974224, 923.4044041593135, 958.4824194934657, 981.3277904635347, 988.461288597716, 991.6975322526698, 956.6460409648474, 988.545269176187, 997.6009596161593, 999.690096070206, 1010.1767059846349, 6694.029365742038, 6839.931600684029, 7032.472564557576, 7033.191183013917, 7075.646217689095, 882.2589025218847, 1060.3637817309552, 1091.5033659684825, 1108.5731993182521, 1119.652907598647, 4242.596953289432, 4306.547812479707, 4341.131773645284, 4446.599806017474, 4550.180967425829, 11000.724981875517, 13228.14017088886, 14030.579082627537, 14111.647208819862, 14129.717405651829, 13501.527446539323, 13699.178049317074, 13943.58169254924, 13954.23251721165, 13973.441062357595, 10042.347247428894, 10291.176705863512, 10305.124064454456, 10305.381677099398, 10312.845307320396, 6134.478569321657, 6651.4013738761805, 6834.077399550997, 6954.3393377629045, 7111.182214045451, 11953.0, 12108.0, 12286.508539658313, 12537.373131343578, 12560.874391255971, 12447.253164810141, 12578.748425031632, 12690.555830545887, 12732.681682958, 12928.547500837425, 9950.253730970062, 10239.692809215736, 10455.16358691318, 10535.683929482127, 10548.156147508027, 10618.52216650268, 10624.468776560987, 10694.609700739165, 10726.98093681099, 10730.302530335503, 8671.176238257356, 8705.3035757138, 8874.955625221832, 8899.332550058642, 9026.503542305236, 8619.094995025433, 8728.821609082946, 8766.123387661182, 8785.297176225758, 8915.955420222857, 8036.557989310644, 8175.7138500152205, 8191.508509489449, 8193.057798353266, 8196.795080123045, 5855.707214639337, 5893.44012318829, 5934.0, 6071.908921366271, 6076.908846367396, 5140.714821294677, 5907.497862681548, 5969.373215812451, 6134.386561344008, 6222.28857206841], "value": 5105.393124732719, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.7823840410966, 385.29298736817935, 386.45895745955676, 395.14648359543384, 395.30623755309426, 4313.417688612037, 4566.520515345883, 4654.232051711468, 4732.219183834667, 4945.579625731808, 3918.490596222487, 4343.305071188611, 4525.615322697575, 4622.699524530904, 4932.87667808305, 3717.293714194301, 4077.816498257571, 4150.501939767232, 4167.208230436223, 4197.467924207673, 3905.4922860028155, 3989.242044011643, 4054.533728621202, 4179.934116800212, 4235.98336399265, 4193.895152621179, 4228.4080228768, 4235.0, 4236.83052677894, 4276.871693849174, 3312.867485300573, 3804.9429258561145, 3921.784301863396, 3999.3601023836045, 4197.202531519001, 3405.9829700851583, 3826.4069069294305, 3833.674137698299, 3833.9424908626393, 3884.9704828220542, 4772.952270477285, 4786.941615105503, 4808.110499557593, 4825.0, 4944.269505672985, 3975.9801200994098, 4520.50274469808, 4681.438227412698, 4833.299171620095, 4945.604351651895, 5260.500252476008, 5276.736163191825, 5290.100682883881, 5298.761555730001, 5355.7857685692525, 3783.2622638585485, 3984.7011474139554, 4291.596705844706, 4320.373545835868, 4363.781810909441, 4643.722976181577, 4923.606111511071, 5136.383633963911, 5150.351887396035, 5235.397929238148, 3960.0693836948294, 4129.009037830959, 4217.725847819882, 4350.390945267665, 4361.454818147731, 3909.179072394772, 4455.9554404456185, 4459.777011149495, 4504.175808797442, 4511.9323210151215, 4356.88899330675, 4378.343248512685, 4384.517703052662, 4639.976800115978, 4836.564709176191, 4823.5658790709, 4917.172625740213, 4929.595065406414, 5104.489551044866, 5255.316808814906, 1383.2253937794667, 1433.0398632915972, 1470.1767010473955, 1487.8288996765293, 1501.459474589147, 985.472772066955, 1018.1294992781213, 1070.4701172919454, 1091.5142761471227, 1179.4810283475244, 4427.22523558376, 4784.1295222866, 4846.733429661332, 4857.319975203474, 4953.455119936804, 4897.681650692693, 5512.39363669996, 5550.750216240279, 5580.270116263971, 5603.4332019404055, 3927.1346110597237, 4320.675949303814, 4516.458025036951, 4537.93689259755, 4815.518448155157, 2750.601162831378, 2860.899868504592, 2888.9133326000256, 2896.782741294411, 2925.1809493341475, 5138.948610513922, 5320.414754377015, 5641.774329026875, 5723.627964182315, 5760.214333556611, 4639.907201855944, 4979.680384698058, 5380.300560927133, 5482.451754824486, 5693.800716974886, 4636.122370439977, 5460.672359658433, 5563.610547261734, 5570.3315602128005, 5690.6870122142855, 4992.8751781205765, 5071.644984851025, 5258.263843061898, 5520.309961254843, 5542.0, 4651.627869770478, 4864.95135048645, 5250.501202385767, 5458.536024437808, 5556.888862222814, 4994.5754610858485, 5417.8103766367985, 5646.0, 5723.368839880614, 5754.798582049608, 4345.152695224401, 4411.933820992752, 4479.484859241229, 4843.854684359475, 4874.2444921037295, 5026.52248036436, 5513.807016754395, 5540.362858271189, 5547.306586676666, 5553.333599968029, 4721.645876559341, 4762.666613337033, 5331.440198779227, 5404.514088412873, 5462.754176062007, 4305.230990472656, 4779.665423420327, 5316.760745766373, 5371.435999220182, 5375.435579264277, 4579.358889755504, 4942.418426103613, 5216.713080780593, 5257.447967963309, 5274.736263186748, 4696.0, 4744.430668319824, 5233.947660523499, 5321.669582604349, 5359.356877174764, 4328.480582330015, 4948.678335908155, 5086.296090809472, 5219.895602088013, 5234.633575649668], "value": 4060.6373272848073, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.1158527145333, 757.6211894052974, 782.5852298281912, 853.3045567862192, 862.3877047296419, 15615.453459128932, 16394.754078688828, 16418.343266269334, 16468.752968705478, 16539.917300413497, 14675.192864392455, 15038.398464061424, 15271.770923436157, 15290.235488225571, 15508.224588770572, 865.9824705970475, 983.7589790501302, 994.6319861651199, 998.7353351361895, 1001.319103009953, 974.8878878928907, 994.2791476179784, 997.4563862694813, 1000.774825664227, 1002.3935519011003, 1037.667946257198, 1039.4127318065268, 1041.9843702344472, 1042.890496497868, 1043.1498328861992, 1032.7573020340214, 1034.5551412892453, 1035.4563853976647, 1035.6841163445108, 1037.0303765978758, 757.1103952855428, 780.2899361580934, 780.7969927818751, 781.605289328891, 781.8358144789544, 16136.838631613651, 16518.2566784495, 16583.253753581117, 16831.83168168327, 17035.744463833053, 12004.69988250292, 14654.0, 14661.04703194289, 14662.266886655625, 14679.192644404553, 11348.319100853974, 11844.881551184464, 11845.289282642983, 11918.940405298004, 11952.70118247042, 3656.451532270154, 3698.184301157802, 3706.166112624665, 3710.6474884885893, 3762.6801721853403, 114980.27529587147, 116304.0, 118775.0, 120441.0, 122569.77430225762, 11085.889141108486, 11123.610673626546, 11131.554737810558, 11178.0, 11712.88287117135, 23036.193733219257, 23363.299101026998, 23448.0, 23453.0, 23541.52916941686, 7865.488743231672, 7875.251851074138, 7879.172686867911, 7890.842183156305, 8152.429329946846, 4436.6672499562665, 4473.865784026484, 4522.8643140705835, 4568.680192386501, 4569.109023740405, 3182.840857957093, 3308.8676452942095, 3406.6082400524256, 3505.789652620851, 3509.1402606361603, 602.4788557897388, 611.7733943443368, 612.8712970276292, 613.6103574230395, 613.9723712432951, 671.2549070531705, 676.891697328425, 700.544645980117, 704.63359053292, 740.2412527159704, 9296.581653825595, 10279.743006424898, 10418.270721049605, 10428.217883658755, 10800.891991080145, 690.5429543662867, 702.1924786495571, 713.0694443750955, 734.5262305812721, 747.9588622625699, 4678.789454474557, 5076.13705670037, 5076.36545431821, 5085.982803439327, 5089.796408143707, 84216.0, 99338.50330748444, 101618.49190754, 101927.0, 105786.0, 91801.08198917925, 92478.0, 95509.52245238869, 96821.0, 96889.0, 62112.68943655343, 78781.0, 80402.59798700969, 81411.0, 81634.0, 9518.09578090108, 9898.804231641421, 9915.65295214664, 9942.403455792675, 9975.700728978143, 43388.56611433845, 47466.52533474621, 48296.75851620719, 49809.75095124501, 53402.1989670163, 59906.0, 60076.0, 67750.3224967744, 71034.22414439474, 73354.63322683352, 11148.721281968015, 12708.110432269652, 12751.744965100832, 13035.413406396925, 13437.328133593477, 14463.0, 14808.48866423712, 14914.328855201325, 14933.775993359892, 14968.775468368201, 13182.27497487609, 13275.80086298687, 14040.578782636538, 14410.711785764435, 14415.063020903608, 12095.818562721743, 13779.448822047407, 13784.517541885985, 14018.439262429389, 14783.260836958325, 11734.41327933617, 12633.30516821547, 13300.800487992494, 13410.932945335211, 14057.859421406065, 9500.904990950003, 9936.105750482491, 9950.726115158977, 10316.587336506456, 10337.10093198487, 11202.389102201547, 11363.659090226976, 11489.253198542068, 11545.653630391102, 11558.479868405773], "value": 7777.487371151745, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1458.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 114.0, 115.0, 114.0, 116.0, 114.0, 115.0, 116.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 108.0, 110.0, 167.0, 135.0, 112.0, 108.0, 108.0, 128.0, 109.0], "value": 122.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 256.0, 208.0, 187.0, 249.0, 234.0, 184.0, 183.0, 183.0, 192.0], "value": 207.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 59.0, 61.0, 91.0, 60.0, 63.0, 60.0, 60.0, 78.0, 60.0], "value": 67.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 69.0, 87.0, 68.0, 69.0, 69.0, 83.0, 68.0, 69.0, 82.0], "value": 75.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 86.0, 86.0, 87.0, 86.0, 86.0, 86.0, 87.0, 87.0], "value": 86.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 93.0, 93.0, 94.0, 106.0, 146.0, 147.0, 93.0], "value": 105.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 85.0, 85.0, 85.0, 83.0, 85.0, 84.0, 83.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 62.0, 61.0, 63.0, 63.0, 65.0, 64.0, 64.0, 64.0], "value": 62.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 63.0, 65.0, 62.0, 60.0, 59.0, 59.0, 59.0, 59.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 79.0, 85.0, 83.0, 84.0, 79.0, 87.0, 88.0, 84.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 154.0, 139.0, 135.0, 134.0, 133.0, 138.0, 186.0, 171.0], "value": 148.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 157.0, 163.0, 175.0, 196.0, 163.0, 165.0, 161.0, 210.0, 213.0], "value": 176.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 63.0, 63.0, 64.0, 62.0, 63.0, 64.0], "value": 64.0, "unit": "score"}]}]} 07:15:56 INFO - Return code: 0 07:15:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:15:56 INFO - # TBPL SUCCESS # 07:15:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:15:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:15:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:15:56 INFO - 2017-05-26 07:15:56.317 screenresolution[2020:18849] starting screenresolution argv=screenresolution get 07:15:56 INFO - 2017-05-26 07:15:56.320 screenresolution[2020:18849] Display 0: 1600x1200x32@60 07:15:56 INFO - 2017-05-26 07:15:56.325 screenresolution[2021:18852] starting screenresolution argv=screenresolution list 07:15:56 INFO - Available Modes on Display 0 07:15:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:15:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:15:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:15:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:15:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:15:56 INFO - Intel Iris: 07:15:56 INFO - Chipset Model: Intel Iris 07:15:56 INFO - Type: GPU 07:15:56 INFO - Bus: Built-In 07:15:56 INFO - VRAM (Dynamic, Max): 1536 MB 07:15:56 INFO - Vendor: Intel (0x8086) 07:15:56 INFO - Device ID: 0x0a2e 07:15:56 INFO - Revision ID: 0x0009 07:15:56 INFO - Displays: 07:15:56 INFO - Display: 07:15:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:15:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:15:56 INFO - Display Serial Number: 1600x1200 60 07:15:56 INFO - Main Display: Yes 07:15:56 INFO - Mirror: Off 07:15:56 INFO - Online: Yes 07:15:56 INFO - Rotation: Supported 07:15:56 INFO - Return code: 0 07:15:56 INFO - Running post-action listener: _resource_record_post_action 07:15:56 INFO - [mozharness: 2017-05-26 14:15:56.557780Z] Finished run-tests step (success) 07:15:56 INFO - Running post-run listener: _resource_record_post_run 07:15:56 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 1744896; Write bytes: 509209600; Read time: 15; Write time: 1561 07:15:56 INFO - TinderboxPrint: CPU usage
53.8% 07:15:56 INFO - TinderboxPrint: I/O read bytes / time
1,744,896 / 15 07:15:56 INFO - TinderboxPrint: I/O write bytes / time
509,209,600 / 1,561 07:15:56 INFO - TinderboxPrint: CPU idle
2,216.7 (46.2%) 07:15:56 INFO - TinderboxPrint: CPU system
952.5 (19.9%) 07:15:56 INFO - TinderboxPrint: CPU user
1,628.5 (33.9%) 07:15:56 INFO - TinderboxPrint: Swap in / out
210,444,288 / 0 07:15:56 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 206066176; Write bytes: 201463808; Read time: 15682; Write time: 428 07:15:56 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 835584; Write bytes: 296674304; Read time: 12; Write time: 1094 07:15:57 INFO - Running post-run listener: _upload_blobber_files 07:15:57 INFO - Blob upload gear active. 07:15:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:15:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:15:57 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'] 07:15:57 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 07:15:57 INFO - (blobuploader) - INFO - Open directory for files ... 07:15:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:15:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:15:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:58 INFO - (blobuploader) - INFO - Done attempting. 07:15:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:15:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:15:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:59 INFO - (blobuploader) - INFO - Done attempting. 07:15:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:15:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:16:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:16:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:16:00 INFO - (blobuploader) - INFO - Done attempting. 07:16:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:16:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:16:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:16:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:16:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:16:02 INFO - (blobuploader) - INFO - Done attempting. 07:16:02 INFO - (blobuploader) - INFO - Iteration through files over. 07:16:02 INFO - Return code: 0 07:16:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:16:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:16:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c714412246ab5f183c8fd4c3d9392616ca47cac484e540070fda0ed478fe16d8ec6fc4850614d76f8b0086842c5cb431216bc9d47a4ca60a7b7eff6abcca14b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0511da064e0958cfe08b873f9f0a0f2ee5285499d23e109ca14e87f57da6ed2d3b8d4e3294669ce4a182f022a991579f52492ecf781e4437889cc570e516bd24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4acff4004c5198122a4fc7d6b816c20828655bece4f4c66f8b3d359f7591cd06f4088a1df9895cf2525ec15ded0281081f0be798c650ce16955125eb1c3423e8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d69cede8dfd0f160d7c5b6eb96f8dcaf26c59e36a9709d272d9c644bbc69d4715365c71b018d52a8a8d6c99f60a19a1e68d70f721799dd5bb95cc9d54836cde"} 07:16:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:16:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:16:02 INFO - Contents: 07:16:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c714412246ab5f183c8fd4c3d9392616ca47cac484e540070fda0ed478fe16d8ec6fc4850614d76f8b0086842c5cb431216bc9d47a4ca60a7b7eff6abcca14b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0511da064e0958cfe08b873f9f0a0f2ee5285499d23e109ca14e87f57da6ed2d3b8d4e3294669ce4a182f022a991579f52492ecf781e4437889cc570e516bd24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4acff4004c5198122a4fc7d6b816c20828655bece4f4c66f8b3d359f7591cd06f4088a1df9895cf2525ec15ded0281081f0be798c650ce16955125eb1c3423e8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d69cede8dfd0f160d7c5b6eb96f8dcaf26c59e36a9709d272d9c644bbc69d4715365c71b018d52a8a8d6c99f60a19a1e68d70f721799dd5bb95cc9d54836cde"} 07:16:02 INFO - Running post-run listener: copy_logs_to_upload_dir 07:16:02 INFO - Copying logs to upload dir... 07:16:02 INFO - mkdir: /builds/slave/test/build/upload/logs 07:16:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.240887 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-05-26 07:16:02.507718) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-26 07:16:02.511715) ========= 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.74WqA8FATp/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.ZPaNMOT2L7/Listeners TMPDIR=/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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/0c714412246ab5f183c8fd4c3d9392616ca47cac484e540070fda0ed478fe16d8ec6fc4850614d76f8b0086842c5cb431216bc9d47a4ca60a7b7eff6abcca14b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0511da064e0958cfe08b873f9f0a0f2ee5285499d23e109ca14e87f57da6ed2d3b8d4e3294669ce4a182f022a991579f52492ecf781e4437889cc570e516bd24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4acff4004c5198122a4fc7d6b816c20828655bece4f4c66f8b3d359f7591cd06f4088a1df9895cf2525ec15ded0281081f0be798c650ce16955125eb1c3423e8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d69cede8dfd0f160d7c5b6eb96f8dcaf26c59e36a9709d272d9c644bbc69d4715365c71b018d52a8a8d6c99f60a19a1e68d70f721799dd5bb95cc9d54836cde"} build_url:https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011205 build_url: 'https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/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/0c714412246ab5f183c8fd4c3d9392616ca47cac484e540070fda0ed478fe16d8ec6fc4850614d76f8b0086842c5cb431216bc9d47a4ca60a7b7eff6abcca14b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0511da064e0958cfe08b873f9f0a0f2ee5285499d23e109ca14e87f57da6ed2d3b8d4e3294669ce4a182f022a991579f52492ecf781e4437889cc570e516bd24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4acff4004c5198122a4fc7d6b816c20828655bece4f4c66f8b3d359f7591cd06f4088a1df9895cf2525ec15ded0281081f0be798c650ce16955125eb1c3423e8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d69cede8dfd0f160d7c5b6eb96f8dcaf26c59e36a9709d272d9c644bbc69d4715365c71b018d52a8a8d6c99f60a19a1e68d70f721799dd5bb95cc9d54836cde"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-26 07:16:02.544658) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 07:16:02.544965) ========= 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.74WqA8FATp/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.ZPaNMOT2L7/Listeners TMPDIR=/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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.005096 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 07:16:02.594161) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-26 07:16:02.594475) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-26 07:16:02.594846) ========= ========= Total master_lag: 0.28 =========