builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0069 starttime: 1496631302.63 results: success (0) buildid: 20170604183818 builduid: 22326c3f1cee41f490d7388aa11ebf83 revision: 09f9827c36d63365507fa3999e66c298eed81808 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-04 19:55:02.631794) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-04 19:55:02.632830) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-04 19:55:02.633210) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-04 19:55:02.659965) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-04 19:55:02.660429) ========= 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.dVpeJPBT2G/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.c94wsBdgT3/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-06-04 19:55:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 20.1M=0.001s 2017-06-04 19:55:02 (20.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.189693 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-04 19:55:02.886935) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-04 19:55:02.887273) ========= 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.dVpeJPBT2G/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.c94wsBdgT3/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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.027698 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-04 19:55:02.939307) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-06-04 19:55:02.940060) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 09f9827c36d63365507fa3999e66c298eed81808 --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 09f9827c36d63365507fa3999e66c298eed81808 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dVpeJPBT2G/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.c94wsBdgT3/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-06-04 19:55:03,041 truncating revision to first 12 chars 2017-06-04 19:55:03,041 Setting DEBUG logging. 2017-06-04 19:55:03,041 attempt 1/10 2017-06-04 19:55:03,041 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/09f9827c36d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-04 19:55:04,810 unpacking tar archive at: mozilla-beta-09f9827c36d6/testing/mozharness/ program finished with exit code 0 elapsedTime=2.049534 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-06-04 19:55:05.017804) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-04 19:55:05.018139) ========= script_repo_revision: 09f9827c36d63365507fa3999e66c298eed81808 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-04 19:55:05.018576) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-04 19:55:05.018868) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-04 19:55:05.038406) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-06-04 19:55:05.039098) ========= /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.dVpeJPBT2G/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.c94wsBdgT3/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 19:55:05 INFO - MultiFileLogger online at 20170604 19:55:05 in /builds/slave/test 19:55:05 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 19:55:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:55:05 INFO - {'append_to_log': False, 19:55:05 INFO - 'base_work_dir': '/builds/slave/test', 19:55:05 INFO - 'blob_upload_branch': 'Mozilla-Beta', 19:55:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:55:05 INFO - 'branch': 'Mozilla-Beta', 19:55:05 INFO - 'buildbot_json_path': 'buildprops.json', 19:55:05 INFO - 'config_files': ('talos/mac_config.py',), 19:55:05 INFO - 'default_actions': ('clobber', 19:55:05 INFO - 'read-buildbot-config', 19:55:05 INFO - 'download-and-extract', 19:55:05 INFO - 'populate-webroot', 19:55:05 INFO - 'create-virtualenv', 19:55:05 INFO - 'install', 19:55:05 INFO - 'run-tests'), 19:55:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:55:05 INFO - 'download_minidump_stackwalk': True, 19:55:05 INFO - 'download_symbols': 'ondemand', 19:55:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:55:05 INFO - 'tooltool.py': '/tools/tooltool.py', 19:55:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:55:05 INFO - '/tools/misc-python/virtualenv.py')}, 19:55:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:55:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:55:05 INFO - 'gecko_profile': False, 19:55:05 INFO - 'gecko_profile_interval': 0, 19:55:05 INFO - 'installer_path': 'installer.exe', 19:55:05 INFO - 'log_level': 'info', 19:55:05 INFO - 'log_name': 'talos', 19:55:05 INFO - 'log_to_console': True, 19:55:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:55:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:55:05 INFO - 'opt_config_files': (), 19:55:05 INFO - 'pip_index': False, 19:55:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:55:05 INFO - 'cmd': ('bash', 19:55:05 INFO - '-c', 19:55:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:55:05 INFO - 'enabled': True, 19:55:05 INFO - 'halt_on_failure': False, 19:55:05 INFO - 'name': 'check_screen_resolution'},), 19:55:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:55:05 INFO - 'cmd': ('bash', 19:55:05 INFO - '-c', 19:55:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:55:05 INFO - 'enabled': True, 19:55:05 INFO - 'halt_on_failure': False, 19:55:05 INFO - 'name': 'check_screen_resolution'},), 19:55:05 INFO - 'run_cmd_checks_enabled': True, 19:55:05 INFO - 'suite': 'dromaeojs', 19:55:05 INFO - 'system_bits': '32', 19:55:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:55:05 INFO - 'title': 't-yosemite-r7-0069', 19:55:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:55:05 INFO - 'use_talos_json': True, 19:55:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:55:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:55:05 INFO - 'work_dir': 'build'} 19:55:05 INFO - [mozharness: 2017-06-05 02:55:05.253989Z] Running clobber step. 19:55:05 INFO - Running pre-action listener: _resource_record_pre_action 19:55:05 INFO - Running main action method: clobber 19:55:05 INFO - rmtree: /builds/slave/test/build 19:55:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:55:08 INFO - Running post-action listener: _resource_record_post_action 19:55:08 INFO - [mozharness: 2017-06-05 02:55:08.391700Z] Finished clobber step (success) 19:55:08 INFO - [mozharness: 2017-06-05 02:55:08.391985Z] Running read-buildbot-config step. 19:55:08 INFO - Running pre-action listener: _resource_record_pre_action 19:55:08 INFO - Running main action method: read_buildbot_config 19:55:08 INFO - Using buildbot properties: 19:55:08 INFO - { 19:55:08 INFO - "project": "", 19:55:08 INFO - "product": "firefox", 19:55:08 INFO - "script_repo_revision": "production", 19:55:08 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 19:55:08 INFO - "repository": "", 19:55:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 19:55:08 INFO - "buildid": "20170604183818", 19:55:08 INFO - "pgo_build": "False", 19:55:08 INFO - "basedir": "/builds/slave/test", 19:55:08 INFO - "buildnumber": 34, 19:55:08 INFO - "slavename": "t-yosemite-r7-0069", 19:55:08 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 19:55:08 INFO - "platform": "yosemite_r7", 19:55:08 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 19:55:08 INFO - "branch": "mozilla-beta", 19:55:08 INFO - "repo_path": "releases/mozilla-beta", 19:55:08 INFO - "revision": "09f9827c36d63365507fa3999e66c298eed81808", 19:55:08 INFO - "stage_platform": "macosx64", 19:55:08 INFO - "builduid": "22326c3f1cee41f490d7388aa11ebf83", 19:55:08 INFO - "slavebuilddir": "test" 19:55:08 INFO - } 19:55:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/YmubvILwTymedS21mpWXwA/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 19:55:08 INFO - Running post-action listener: _resource_record_post_action 19:55:08 INFO - [mozharness: 2017-06-05 02:55:08.398006Z] Finished read-buildbot-config step (success) 19:55:08 INFO - [mozharness: 2017-06-05 02:55:08.398216Z] Running download-and-extract step. 19:55:08 INFO - Running pre-action listener: _resource_record_pre_action 19:55:08 INFO - Running main action method: download_and_extract 19:55:08 INFO - mkdir: /builds/slave/test/build/tests 19:55:08 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')]} 19:55:08 INFO - trying https://queue.taskcluster.net/v1/task/YmubvILwTymedS21mpWXwA/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 19:55:08 INFO - Downloading https://queue.taskcluster.net/v1/task/YmubvILwTymedS21mpWXwA/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 19:55:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YmubvILwTymedS21mpWXwA/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 19:55:09 INFO - Downloaded 1287 bytes. 19:55:09 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 19:55:09 INFO - Using the following test package requirements: 19:55:09 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:55:09 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 19:55:09 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 19:55:09 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:55:09 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 19:55:09 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:55:09 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 19:55:09 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 19:55:09 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:55:09 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 19:55:09 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 19:55:09 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:55:09 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 19:55:09 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:55:09 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 19:55:09 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:55:09 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 19:55:09 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:55:09 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 19:55:09 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 19:55:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YmubvILwTymedS21mpWXwA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 19:55:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YmubvILwTymedS21mpWXwA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 19:55:09 INFO - Fetch https://queue.taskcluster.net/v1/task/YmubvILwTymedS21mpWXwA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 19:55:11 INFO - Expected file size: 51393774 19:55:11 INFO - Obtained file size: 51393774 19:55:27 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 19:55:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YmubvILwTymedS21mpWXwA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 19:55:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YmubvILwTymedS21mpWXwA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 19:55:27 INFO - Fetch https://queue.taskcluster.net/v1/task/YmubvILwTymedS21mpWXwA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 19:55:29 INFO - Expected file size: 51393774 19:55:29 INFO - Obtained file size: 51393774 19:55:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YmubvILwTymedS21mpWXwA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 19:55:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YmubvILwTymedS21mpWXwA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 19:55:44 INFO - Fetch https://queue.taskcluster.net/v1/task/YmubvILwTymedS21mpWXwA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 19:55:46 INFO - Expected file size: 14404461 19:55:46 INFO - Obtained file size: 14404461 19:55:46 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')]} 19:55:46 INFO - trying https://queue.taskcluster.net/v1/task/YmubvILwTymedS21mpWXwA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 19:55:46 INFO - Downloading https://queue.taskcluster.net/v1/task/YmubvILwTymedS21mpWXwA/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 19:55:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YmubvILwTymedS21mpWXwA/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 19:55:48 INFO - Downloaded 59647984 bytes. 19:55:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YmubvILwTymedS21mpWXwA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 19:55:48 INFO - mkdir: /builds/slave/test/properties 19:55:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:55:48 INFO - Writing to file /builds/slave/test/properties/build_url 19:55:48 INFO - Contents: 19:55:48 INFO - build_url:https://queue.taskcluster.net/v1/task/YmubvILwTymedS21mpWXwA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 19:55:49 INFO - Running post-action listener: _resource_record_post_action 19:55:49 INFO - Running post-action listener: set_extra_try_arguments 19:55:49 INFO - [mozharness: 2017-06-05 02:55:49.189107Z] Finished download-and-extract step (success) 19:55:49 INFO - [mozharness: 2017-06-05 02:55:49.189280Z] Running populate-webroot step. 19:55:49 INFO - Running pre-action listener: _resource_record_pre_action 19:55:49 INFO - Running main action method: populate_webroot 19:55:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:55:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:55:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:55:49 INFO - '--tppagecycles', 19:55:49 INFO - '7'], 19:55:49 INFO - 'tests': ['tsvgm']}}, 19:55:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:55:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:55:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:55:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:55:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:55:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:55:49 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:55:49 INFO - 'talos_options': ['--disable-e10s'], 19:55:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:55:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:55:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:55:49 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:55:49 INFO - 'talos_options': ['--disable-e10s'], 19:55:49 INFO - 'tests': ['damp', 'tps']}, 19:55:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:55:49 INFO - 'tests': ['damp', 'tps']}, 19:55:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:55:49 INFO - 'tests': ['dromaeo_dom']}, 19:55:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:55:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:55:49 INFO - 'tests': ['basic_compositor_video']}, 19:55:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:55:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:55:49 INFO - 'tests': ['a11yr', 19:55:49 INFO - 'ts_paint', 19:55:49 INFO - 'tpaint', 19:55:49 INFO - 'sessionrestore', 19:55:49 INFO - 'sessionrestore_no_auto_restore', 19:55:49 INFO - 'tabpaint']}, 19:55:49 INFO - 'other-e10s': {'tests': ['a11yr', 19:55:49 INFO - 'ts_paint', 19:55:49 INFO - 'tpaint', 19:55:49 INFO - 'sessionrestore', 19:55:49 INFO - 'sessionrestore_no_auto_restore', 19:55:49 INFO - 'tabpaint']}, 19:55:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:55:49 INFO - 'ts_paint', 19:55:49 INFO - 'tpaint', 19:55:49 INFO - 'sessionrestore', 19:55:49 INFO - 'sessionrestore_no_auto_restore', 19:55:49 INFO - 'tabpaint']}, 19:55:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:55:49 INFO - 'ts_paint', 19:55:49 INFO - 'tpaint', 19:55:49 INFO - 'sessionrestore', 19:55:49 INFO - 'sessionrestore_no_auto_restore', 19:55:49 INFO - 'tabpaint']}, 19:55:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:55:49 INFO - 'tests': ['a11yr', 19:55:49 INFO - 'ts_paint', 19:55:49 INFO - 'tpaint', 19:55:49 INFO - 'sessionrestore', 19:55:49 INFO - 'sessionrestore_no_auto_restore', 19:55:49 INFO - 'tabpaint']}, 19:55:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:55:49 INFO - 'tests': ['a11yr', 19:55:49 INFO - 'ts_paint', 19:55:49 INFO - 'tpaint', 19:55:49 INFO - 'sessionrestore', 19:55:49 INFO - 'sessionrestore_no_auto_restore', 19:55:49 INFO - 'tabpaint']}, 19:55:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:55:49 INFO - 'tests': ['tsvgx', 19:55:49 INFO - 'tsvgr_opacity', 19:55:49 INFO - 'tart', 19:55:49 INFO - 'tscrollx', 19:55:49 INFO - 'cart', 19:55:49 INFO - 'tsvg_static']}, 19:55:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:55:49 INFO - 'tsvgr_opacity', 19:55:49 INFO - 'tart', 19:55:49 INFO - 'tscrollx', 19:55:49 INFO - 'cart', 19:55:49 INFO - 'tsvg_static']}, 19:55:49 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:55:49 INFO - 'talos_options': ['--disable-e10s'], 19:55:49 INFO - 'tests': ['tp5o']}, 19:55:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:55:49 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:55:49 INFO - 'talos_options': ['--disable-e10s', 19:55:49 INFO - '--xperf_path', 19:55:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:55:49 INFO - 'tests': ['tp5n']}, 19:55:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:55:49 INFO - 'talos_options': ['--xperf_path', 19:55:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:55:49 INFO - 'tests': ['tp5n']}}, 19:55:49 INFO - 'talos.zip': {'path': '', 19:55:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:55:49 INFO - Running post-action listener: _resource_record_post_action 19:55:49 INFO - [mozharness: 2017-06-05 02:55:49.209421Z] Finished populate-webroot step (success) 19:55:49 INFO - [mozharness: 2017-06-05 02:55:49.209554Z] Running create-virtualenv step. 19:55:49 INFO - Running pre-action listener: _resource_record_pre_action 19:55:49 INFO - Running main action method: create_virtualenv 19:55:49 INFO - Creating virtualenv /builds/slave/test/build/venv 19:55:49 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 19:55:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:55:49 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 19:55:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:55:49 INFO - Using real prefix '/tools/python27' 19:55:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:55:50 INFO - Installing distribute.............................................................................................................................................................................................done. 19:55:52 INFO - Installing pip.................done. 19:55:52 INFO - Return code: 0 19:55:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:55:53 INFO - Reading from file tmpfile_stdout 19:55:53 INFO - Output received: 19:55:53 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) 19:55:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1077ebb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077ee768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd57855cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075c9d30>, '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 0x1074f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075bebe8>, '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.dVpeJPBT2G/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.c94wsBdgT3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 19:55:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:55:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:55:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dVpeJPBT2G/Render', 19:55:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:55:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:55:53 INFO - 'HOME': '/Users/cltbld', 19:55:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:55:53 INFO - 'LOGNAME': 'cltbld', 19:55:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:53 INFO - 'MOZ_NO_REMOTE': '1', 19:55:53 INFO - 'NO_EM_RESTART': '1', 19:55:53 INFO - 'PAGER': '/bin/cat', 19:55:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:55:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:53 INFO - 'PWD': '/builds/slave/test', 19:55:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:55:53 INFO - 'SHELL': '/bin/bash', 19:55:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c94wsBdgT3/Listeners', 19:55:53 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 19:55:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:55:53 INFO - 'USER': 'cltbld', 19:55:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:55:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:55:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:53 INFO - 'XPC_FLAGS': '0x0', 19:55:53 INFO - 'XPC_SERVICE_NAME': '0', 19:55:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:53 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 19:55:53 INFO - Cleaning up... 19:55:53 INFO - Return code: 0 19:55:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1077ebb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077ee768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd57855cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075c9d30>, '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 0x1074f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075bebe8>, '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.dVpeJPBT2G/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.c94wsBdgT3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 19:55:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:55:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:55:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dVpeJPBT2G/Render', 19:55:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:55:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:55:53 INFO - 'HOME': '/Users/cltbld', 19:55:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:55:53 INFO - 'LOGNAME': 'cltbld', 19:55:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:53 INFO - 'MOZ_NO_REMOTE': '1', 19:55:53 INFO - 'NO_EM_RESTART': '1', 19:55:53 INFO - 'PAGER': '/bin/cat', 19:55:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:55:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:53 INFO - 'PWD': '/builds/slave/test', 19:55:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:55:53 INFO - 'SHELL': '/bin/bash', 19:55:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c94wsBdgT3/Listeners', 19:55:53 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 19:55:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:55:53 INFO - 'USER': 'cltbld', 19:55:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:55:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:55:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:53 INFO - 'XPC_FLAGS': '0x0', 19:55:53 INFO - 'XPC_SERVICE_NAME': '0', 19:55:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:53 INFO - Downloading/unpacking psutil>=3.1.1 19:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:55:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:55:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:55:56 INFO - Installing collected packages: psutil 19:55:56 INFO - Running setup.py install for psutil 19:55:56 INFO - building 'psutil._psutil_osx' extension 19:55:56 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 19:55:56 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 19:55:56 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 19:55:56 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 19:55:56 INFO - building 'psutil._psutil_posix' extension 19:55:56 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 19:55:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:55:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:55:57 INFO - ^ 19:55:57 INFO - 1 warning generated. 19:55:57 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 19:55:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:55:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:55:57 INFO - Successfully installed psutil 19:55:57 INFO - Cleaning up... 19:55:57 INFO - Return code: 0 19:55:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1077ebb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077ee768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd57855cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075c9d30>, '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 0x1074f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075bebe8>, '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.dVpeJPBT2G/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.c94wsBdgT3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 19:55:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:55:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:55:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dVpeJPBT2G/Render', 19:55:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:55:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:55:57 INFO - 'HOME': '/Users/cltbld', 19:55:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:55:57 INFO - 'LOGNAME': 'cltbld', 19:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:57 INFO - 'MOZ_NO_REMOTE': '1', 19:55:57 INFO - 'NO_EM_RESTART': '1', 19:55:57 INFO - 'PAGER': '/bin/cat', 19:55:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:57 INFO - 'PWD': '/builds/slave/test', 19:55:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:55:57 INFO - 'SHELL': '/bin/bash', 19:55:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c94wsBdgT3/Listeners', 19:55:57 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 19:55:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:55:57 INFO - 'USER': 'cltbld', 19:55:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:55:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:57 INFO - 'XPC_FLAGS': '0x0', 19:55:57 INFO - 'XPC_SERVICE_NAME': '0', 19:55:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:55:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:55:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:55:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:55:59 INFO - Installing collected packages: mozsystemmonitor 19:55:59 INFO - Running setup.py install for mozsystemmonitor 19:55:59 INFO - Successfully installed mozsystemmonitor 19:55:59 INFO - Cleaning up... 19:55:59 INFO - Return code: 0 19:55:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:55:59 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')]} 19:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:59 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')]} 19:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:59 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 0x1077ebb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077ee768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd57855cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075c9d30>, '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 0x1074f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075bebe8>, '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.dVpeJPBT2G/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.c94wsBdgT3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 19:55:59 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 19:55:59 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 19:55:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dVpeJPBT2G/Render', 19:55:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:55:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:55:59 INFO - 'HOME': '/Users/cltbld', 19:55:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:55:59 INFO - 'LOGNAME': 'cltbld', 19:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:59 INFO - 'MOZ_NO_REMOTE': '1', 19:55:59 INFO - 'NO_EM_RESTART': '1', 19:55:59 INFO - 'PAGER': '/bin/cat', 19:55:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:59 INFO - 'PWD': '/builds/slave/test', 19:55:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:55:59 INFO - 'SHELL': '/bin/bash', 19:55:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c94wsBdgT3/Listeners', 19:55:59 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 19:55:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:55:59 INFO - 'USER': 'cltbld', 19:55:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:55:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:59 INFO - 'XPC_FLAGS': '0x0', 19:55:59 INFO - 'XPC_SERVICE_NAME': '0', 19:55:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:59 INFO - Downloading/unpacking jsonschema==2.5.1 19:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:56:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:01 INFO - Downloading functools32-3.2.3-2.tar.gz 19:56:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:56:01 INFO - warning: no files found matching '*.txt' 19:56:01 INFO - no previously-included directories found matching 'build' 19:56:01 INFO - no previously-included directories found matching 'dist' 19:56:01 INFO - no previously-included directories found matching '.git*' 19:56:01 INFO - Installing collected packages: jsonschema, functools32 19:56:01 INFO - Running setup.py install for functools32 19:56:01 INFO - warning: no files found matching '*.txt' 19:56:01 INFO - no previously-included directories found matching 'build' 19:56:01 INFO - no previously-included directories found matching 'dist' 19:56:01 INFO - no previously-included directories found matching '.git*' 19:56:01 INFO - Successfully installed jsonschema functools32 19:56:01 INFO - Cleaning up... 19:56:01 INFO - Return code: 0 19:56:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:56:01 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')]} 19:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:01 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')]} 19:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:01 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 0x1077ebb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077ee768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd57855cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075c9d30>, '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 0x1074f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075bebe8>, '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.dVpeJPBT2G/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.c94wsBdgT3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 19:56:01 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 19:56:01 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 19:56:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dVpeJPBT2G/Render', 19:56:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:01 INFO - 'HOME': '/Users/cltbld', 19:56:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:01 INFO - 'LOGNAME': 'cltbld', 19:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:01 INFO - 'MOZ_NO_REMOTE': '1', 19:56:01 INFO - 'NO_EM_RESTART': '1', 19:56:01 INFO - 'PAGER': '/bin/cat', 19:56:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:01 INFO - 'PWD': '/builds/slave/test', 19:56:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:01 INFO - 'SHELL': '/bin/bash', 19:56:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c94wsBdgT3/Listeners', 19:56:01 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 19:56:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:01 INFO - 'USER': 'cltbld', 19:56:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:01 INFO - 'XPC_FLAGS': '0x0', 19:56:01 INFO - 'XPC_SERVICE_NAME': '0', 19:56:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:56:01 INFO - Cleaning up... 19:56:01 INFO - Return code: 0 19:56:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:56:01 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')]} 19:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:01 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')]} 19:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:01 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 0x1077ebb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077ee768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd57855cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075c9d30>, '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 0x1074f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075bebe8>, '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.dVpeJPBT2G/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.c94wsBdgT3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 19:56:01 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 19:56:01 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 19:56:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dVpeJPBT2G/Render', 19:56:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:01 INFO - 'HOME': '/Users/cltbld', 19:56:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:01 INFO - 'LOGNAME': 'cltbld', 19:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:01 INFO - 'MOZ_NO_REMOTE': '1', 19:56:01 INFO - 'NO_EM_RESTART': '1', 19:56:01 INFO - 'PAGER': '/bin/cat', 19:56:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:01 INFO - 'PWD': '/builds/slave/test', 19:56:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:01 INFO - 'SHELL': '/bin/bash', 19:56:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c94wsBdgT3/Listeners', 19:56:01 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 19:56:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:01 INFO - 'USER': 'cltbld', 19:56:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:01 INFO - 'XPC_FLAGS': '0x0', 19:56:01 INFO - 'XPC_SERVICE_NAME': '0', 19:56:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:01 INFO - Downloading/unpacking blobuploader==1.2.4 19:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:03 INFO - Downloading blobuploader-1.2.4.tar.gz 19:56:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:56:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:56:03 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 19:56:03 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 19:56:03 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 19:56:03 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 19:56:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:56:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:56:03 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 19:56:03 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 19:56:03 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 19:56:03 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 19:56:04 INFO - Downloading docopt-0.6.1.tar.gz 19:56:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:56:04 INFO - Installing collected packages: blobuploader, requests, docopt 19:56:04 INFO - Running setup.py install for blobuploader 19:56:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:56:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:56:04 INFO - Running setup.py install for requests 19:56:04 INFO - Running setup.py install for docopt 19:56:05 INFO - Successfully installed blobuploader requests docopt 19:56:05 INFO - Cleaning up... 19:56:05 INFO - Return code: 0 19:56:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:56:05 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')]} 19:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:05 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')]} 19:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:05 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 0x1077ebb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077ee768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd57855cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075c9d30>, '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 0x1074f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075bebe8>, '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.dVpeJPBT2G/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.c94wsBdgT3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 19:56:05 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 19:56:05 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 19:56:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dVpeJPBT2G/Render', 19:56:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:05 INFO - 'HOME': '/Users/cltbld', 19:56:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:05 INFO - 'LOGNAME': 'cltbld', 19:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:05 INFO - 'MOZ_NO_REMOTE': '1', 19:56:05 INFO - 'NO_EM_RESTART': '1', 19:56:05 INFO - 'PAGER': '/bin/cat', 19:56:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:05 INFO - 'PWD': '/builds/slave/test', 19:56:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:05 INFO - 'SHELL': '/bin/bash', 19:56:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c94wsBdgT3/Listeners', 19:56:05 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 19:56:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:05 INFO - 'USER': 'cltbld', 19:56:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:05 INFO - 'XPC_FLAGS': '0x0', 19:56:05 INFO - 'XPC_SERVICE_NAME': '0', 19:56:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:56:05 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-ISc6Am-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:56:05 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-iwFG4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:56:05 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-BAw63v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:56:05 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-UXVMpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:56:05 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-3nSWpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:56:05 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-PffpgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:56:06 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-0P1PqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:56:06 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-t21iiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:56:06 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-oRxZCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:56:06 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-J2o1kS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:56:06 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-FoFvbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:56:06 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-KJBUAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:56:06 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-Yd9F5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:56:06 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-zRnAYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:56:06 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-ab5gCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:56:06 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-0L0Kgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:56:07 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-ngrTLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:56:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:56:07 INFO - Running setup.py install for manifestparser 19:56:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:56:07 INFO - Running setup.py install for mozcrash 19:56:07 INFO - Running setup.py install for mozdebug 19:56:07 INFO - Running setup.py install for mozdevice 19:56:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:56:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:56:07 INFO - Running setup.py install for mozfile 19:56:07 INFO - Running setup.py install for mozhttpd 19:56:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:56:08 INFO - Running setup.py install for mozinfo 19:56:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:56:08 INFO - Running setup.py install for mozInstall 19:56:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:56:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:56:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:56:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:56:08 INFO - Running setup.py install for mozleak 19:56:08 INFO - Running setup.py install for mozlog 19:56:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:56:08 INFO - Running setup.py install for moznetwork 19:56:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:56:08 INFO - Running setup.py install for mozprocess 19:56:08 INFO - Running setup.py install for mozprofile 19:56:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:56:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:56:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:56:09 INFO - Running setup.py install for mozrunner 19:56:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:56:09 INFO - Running setup.py install for mozscreenshot 19:56:09 INFO - Running setup.py install for moztest 19:56:09 INFO - Running setup.py install for mozversion 19:56:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:56:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:56:09 INFO - Cleaning up... 19:56:09 INFO - Return code: 0 19:56:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:56:09 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')]} 19:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:09 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')]} 19:56:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:09 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 0x1077ebb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077ee768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd57855cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075c9d30>, '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 0x1074f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075bebe8>, '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.dVpeJPBT2G/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.c94wsBdgT3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 19:56:09 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 19:56:09 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 19:56:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dVpeJPBT2G/Render', 19:56:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:09 INFO - 'HOME': '/Users/cltbld', 19:56:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:09 INFO - 'LOGNAME': 'cltbld', 19:56:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:09 INFO - 'MOZ_NO_REMOTE': '1', 19:56:09 INFO - 'NO_EM_RESTART': '1', 19:56:09 INFO - 'PAGER': '/bin/cat', 19:56:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:09 INFO - 'PWD': '/builds/slave/test', 19:56:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:09 INFO - 'SHELL': '/bin/bash', 19:56:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c94wsBdgT3/Listeners', 19:56:09 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 19:56:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:09 INFO - 'USER': 'cltbld', 19:56:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:09 INFO - 'XPC_FLAGS': '0x0', 19:56:09 INFO - 'XPC_SERVICE_NAME': '0', 19:56:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:56:10 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-fUjf2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:56:10 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)) 19:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:56:10 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-jrRBjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:56:10 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)) 19:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:56:10 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-P8KEnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:56:10 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)) 19:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:56:10 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-l0rsUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:56:10 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)) 19:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:56:10 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-NW1fRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:56:10 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)) 19:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:56:10 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-zV1pxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:56:10 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)) 19:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:56:10 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-BSAoHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:56:10 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)) 19:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:56:10 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-bj6TtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:56:10 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)) 19:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:56:10 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-S5kvye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:56:10 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)) 19:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:56:10 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-cIciVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:56:11 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)) 19:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:56:11 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-AnNJR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:56:11 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)) 19:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:56:11 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-JftiMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:56:11 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)) 19:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:56:11 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-XstiBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:56:11 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)) 19:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:56:11 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-sTQmmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:56:11 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)) 19:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:56:11 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-rHHfjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:56:11 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)) 19:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:56:11 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-zEuAqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:56:11 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)) 19:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:56:11 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-HsQkwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:56:11 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)) 19:56:11 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)) 19:56:11 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)) 19:56:11 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)) 19:56:11 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)) 19:56:11 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)) 19:56:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:56:11 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 19:56:11 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 19:56:11 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 19:56:11 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 19:56:13 INFO - Downloading blessings-1.6.tar.gz 19:56:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:56:13 INFO - Installing collected packages: blessings 19:56:13 INFO - Running setup.py install for blessings 19:56:13 INFO - Successfully installed blessings 19:56:13 INFO - Cleaning up... 19:56:13 INFO - Return code: 0 19:56:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:56:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:56:13 INFO - Reading from file tmpfile_stdout 19:56:13 INFO - Current package versions: 19:56:13 INFO - blessings == 1.6 19:56:13 INFO - blobuploader == 1.2.4 19:56:13 INFO - docopt == 0.6.1 19:56:13 INFO - functools32 == 3.2.3-2 19:56:13 INFO - jsonschema == 2.5.1 19:56:13 INFO - manifestparser == 1.1 19:56:13 INFO - mozInstall == 1.12 19:56:13 INFO - mozcrash == 1.0 19:56:13 INFO - mozdebug == 0.1 19:56:13 INFO - mozdevice == 0.49 19:56:13 INFO - mozfile == 1.2 19:56:13 INFO - mozhttpd == 0.7 19:56:13 INFO - mozinfo == 0.9 19:56:13 INFO - mozleak == 0.1 19:56:13 INFO - mozlog == 3.4 19:56:13 INFO - moznetwork == 0.27 19:56:13 INFO - mozprocess == 0.25 19:56:13 INFO - mozprofile == 0.28 19:56:13 INFO - mozrunner == 6.13 19:56:13 INFO - mozscreenshot == 0.1 19:56:13 INFO - mozsystemmonitor == 0.3 19:56:13 INFO - moztest == 0.8 19:56:13 INFO - mozversion == 1.4 19:56:13 INFO - psutil == 3.1.1 19:56:13 INFO - requests == 1.2.3 19:56:13 INFO - wsgiref == 0.1.2 19:56:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:13 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 0x1077ebb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077ee768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd57855cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075c9d30>, '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 0x1074f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075bebe8>, '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.dVpeJPBT2G/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.c94wsBdgT3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 19:56:13 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 19:56:13 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 19:56:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dVpeJPBT2G/Render', 19:56:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:13 INFO - 'HOME': '/Users/cltbld', 19:56:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:13 INFO - 'LOGNAME': 'cltbld', 19:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:13 INFO - 'MOZ_NO_REMOTE': '1', 19:56:13 INFO - 'NO_EM_RESTART': '1', 19:56:13 INFO - 'PAGER': '/bin/cat', 19:56:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:13 INFO - 'PWD': '/builds/slave/test', 19:56:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:13 INFO - 'SHELL': '/bin/bash', 19:56:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c94wsBdgT3/Listeners', 19:56:13 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 19:56:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:13 INFO - 'USER': 'cltbld', 19:56:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:13 INFO - 'XPC_FLAGS': '0x0', 19:56:13 INFO - 'XPC_SERVICE_NAME': '0', 19:56:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:56:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:56:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:56:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:56:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:56:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:56:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:56:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:56:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:56:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:56:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:56:14 INFO - Cleaning up... 19:56:14 INFO - Return code: 0 19:56:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:56:14 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')]} 19:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:14 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')]} 19:56:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1077ebb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077ee768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd57855cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075c9d30>, '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 0x1074f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075bebe8>, '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.dVpeJPBT2G/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.c94wsBdgT3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 19:56:14 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 19:56:14 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 19:56:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dVpeJPBT2G/Render', 19:56:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:14 INFO - 'HOME': '/Users/cltbld', 19:56:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:14 INFO - 'LOGNAME': 'cltbld', 19:56:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:14 INFO - 'MOZ_NO_REMOTE': '1', 19:56:14 INFO - 'NO_EM_RESTART': '1', 19:56:14 INFO - 'PAGER': '/bin/cat', 19:56:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:14 INFO - 'PWD': '/builds/slave/test', 19:56:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:14 INFO - 'SHELL': '/bin/bash', 19:56:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c94wsBdgT3/Listeners', 19:56:14 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 19:56:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:14 INFO - 'USER': 'cltbld', 19:56:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:14 INFO - 'XPC_FLAGS': '0x0', 19:56:14 INFO - 'XPC_SERVICE_NAME': '0', 19:56:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:56:14 INFO - Cleaning up... 19:56:14 INFO - Return code: 0 19:56:14 INFO - Running post-action listener: _resource_record_post_action 19:56:14 INFO - Running post-action listener: _start_resource_monitoring 19:56:14 INFO - Starting resource monitoring. 19:56:14 INFO - [mozharness: 2017-06-05 02:56:14.446159Z] Finished create-virtualenv step (success) 19:56:14 INFO - [mozharness: 2017-06-05 02:56:14.447106Z] Running install step. 19:56:14 INFO - Running pre-action listener: _resource_record_pre_action 19:56:14 INFO - Running main action method: install 19:56:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:56:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:56:14 INFO - Reading from file tmpfile_stdout 19:56:14 INFO - Detecting whether we're running mozinstall >=1.0... 19:56:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:56:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:56:14 INFO - Reading from file tmpfile_stdout 19:56:14 INFO - Output received: 19:56:14 INFO - Usage: mozinstall [options] installer 19:56:14 INFO - Options: 19:56:14 INFO - -h, --help show this help message and exit 19:56:14 INFO - -d DEST, --destination=DEST 19:56:14 INFO - Directory to install application into. [default: 19:56:14 INFO - "/builds/slave/test"] 19:56:14 INFO - --app=APP Application being installed. [default: firefox] 19:56:14 INFO - mkdir: /builds/slave/test/build/application 19:56:14 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'] 19:56:14 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 19:56:29 INFO - Reading from file tmpfile_stdout 19:56:29 INFO - Output received: 19:56:29 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 19:56:29 INFO - Running post-action listener: _resource_record_post_action 19:56:29 INFO - [mozharness: 2017-06-05 02:56:29.468990Z] Finished install step (success) 19:56:29 INFO - [mozharness: 2017-06-05 02:56:29.469119Z] Running run-tests step. 19:56:29 INFO - Running pre-action listener: _resource_record_pre_action 19:56:29 INFO - Running main action method: run_tests 19:56:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:56:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:56:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:56:29 INFO - 2017-06-04 19:56:29.483 screenresolution[1623:7459] starting screenresolution argv=screenresolution get 19:56:29 INFO - 2017-06-04 19:56:29.486 screenresolution[1623:7459] Display 0: 1600x1200x32@60 19:56:29 INFO - 2017-06-04 19:56:29.491 screenresolution[1624:7461] starting screenresolution argv=screenresolution list 19:56:29 INFO - Available Modes on Display 0 19:56:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:56:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:56:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:56:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:56:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:56:29 INFO - Intel Iris: 19:56:29 INFO - Chipset Model: Intel Iris 19:56:29 INFO - Type: GPU 19:56:29 INFO - Bus: Built-In 19:56:29 INFO - VRAM (Dynamic, Max): 1536 MB 19:56:29 INFO - Vendor: Intel (0x8086) 19:56:29 INFO - Device ID: 0x0a2e 19:56:29 INFO - Revision ID: 0x0009 19:56:29 INFO - Displays: 19:56:29 INFO - Display: 19:56:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:56:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:56:29 INFO - Display Serial Number: 1600x1200 60 19:56:29 INFO - Main Display: Yes 19:56:29 INFO - Mirror: Off 19:56:29 INFO - Online: Yes 19:56:29 INFO - Rotation: Supported 19:56:29 INFO - Return code: 0 19:56:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:56:29 INFO - Python 2.7.3 19:56:29 INFO - Return code: 0 19:56:29 INFO - grabbing minidump binary from tooltool 19:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:29 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 0x1075c9d30>, '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 0x1074f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075bebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:56:29 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 19:56:29 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 19:56:29 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 19:56:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:56:29 INFO - Return code: 0 19:56:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:56:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:56:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:56:29 INFO - ENV: RUST_BACKTRACE is now 1 19:56:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:56:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:56:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YmubvILwTymedS21mpWXwA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0069', '--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 19:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YmubvILwTymedS21mpWXwA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0069 --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 19:56:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dVpeJPBT2G/Render', 19:56:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:29 INFO - 'HOME': '/Users/cltbld', 19:56:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:29 INFO - 'LOGNAME': 'cltbld', 19:56:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:56:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:29 INFO - 'MOZ_NO_REMOTE': '1', 19:56:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:56:29 INFO - 'NO_EM_RESTART': '1', 19:56:29 INFO - 'PAGER': '/bin/cat', 19:56:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:29 INFO - 'PWD': '/builds/slave/test', 19:56:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:56:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:29 INFO - 'RUST_BACKTRACE': '1', 19:56:29 INFO - 'SHELL': '/bin/bash', 19:56:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c94wsBdgT3/Listeners', 19:56:29 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 19:56:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:29 INFO - 'USER': 'cltbld', 19:56:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:29 INFO - 'XPC_FLAGS': '0x0', 19:56:29 INFO - 'XPC_SERVICE_NAME': '0', 19:56:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YmubvILwTymedS21mpWXwA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0069', '--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 19:56:30 INFO - mozversion application_buildid: 20170604183818 19:56:30 INFO - mozversion application_changeset: 09f9827c36d63365507fa3999e66c298eed81808 19:56:30 INFO - mozversion application_display_name: Firefox 19:56:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:56:30 INFO - mozversion application_name: Firefox 19:56:30 INFO - mozversion application_remotingname: firefox 19:56:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 19:56:30 INFO - mozversion application_vendor: Mozilla 19:56:30 INFO - mozversion application_version: 54.0 19:56:30 INFO - mozversion platform_buildid: 20170604183818 19:56:30 INFO - mozversion platform_changeset: 09f9827c36d63365507fa3999e66c298eed81808 19:56:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 19:56:30 INFO - mozversion platform_version: 54.0 19:56:30 INFO - using testdate: 1496631390 19:56:30 INFO - actual date: 1496631390 19:56:30 INFO - starting webserver on 'localhost:49220' 19:56:30 INFO - SUITE-START | Running 2 tests 19:56:30 INFO - TEST-START | dromaeo_css 19:56:30 INFO - operating with platform_type : mac_ 19:56:30 INFO - Initialising browser for dromaeo_css test... 19:56:30 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/tmpbU9neA/profile http://localhost:49220/getInfo.html) 19:56:32 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 19:56:32 INFO - PROCESS | 1634 | colorDepth:24 19:56:32 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 19:56:32 INFO - PROCESS | 1634 | __metrics 19:56:32 INFO - PROCESS | 1634 | 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" 19:56:32 INFO - PROCESS | 1634 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:56:33 INFO - TEST-INFO | 1634: exit 0 19:56:33 INFO - Browser initialized. 19:56:33 INFO - Running cycle 1/1 for dromaeo_css test... 19:56:33 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/tmpbU9neA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:56:45 INFO - PROCESS | 1637 | RSS: Main: 165154816 19:56:45 INFO - PROCESS | 1637 | 19:59:49 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49220/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49220/tests/dromaeo/cssquery-ext.html) 19:59:51 INFO - PROCESS | 1637 | RSS: Main: 337268736 19:59:51 INFO - PROCESS | 1637 | 20:02:54 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49220/tests/dromaeo/cssquery-ext.html (next: http://localhost:49220/tests/dromaeo/cssquery-jquery.html) 20:02:55 INFO - PROCESS | 1637 | RSS: Main: 303693824 20:02:55 INFO - PROCESS | 1637 | 20:05:57 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49220/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49220/tests/dromaeo/cssquery-mootools.html) 20:05:58 INFO - PROCESS | 1637 | RSS: Main: 286081024 20:05:58 INFO - PROCESS | 1637 | 20:09:00 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49220/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49220/tests/dromaeo/cssquery-prototype.html) 20:09:01 INFO - PROCESS | 1637 | RSS: Main: 272224256 20:09:01 INFO - PROCESS | 1637 | 20:12:04 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49220/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49220/tests/dromaeo/cssquery-yui.html) 20:12:05 INFO - PROCESS | 1637 | RSS: Main: 274423808 20:12:05 INFO - PROCESS | 1637 | 20:15:08 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49220/tests/dromaeo/cssquery-yui.html (next: http://localhost:49220/tests/dromaeo/cssquery-dojo.html) 20:15:08 INFO - PROCESS | 1637 | RSS: Main: 439005184 20:15:08 INFO - PROCESS | 1637 | 20:15:08 INFO - PROCESS | 1637 | __start_tp_report 20:15:08 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 20:15:08 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 20:15:08 INFO - PROCESS | 1637 | |i|pagename|runs| 20:15:08 INFO - PROCESS | 1637 | |0;dojo.html;3609.3142302962433;3610.2238018825965;3622.1669016126298;3649.4343376776574;3676.448532720092;5105.259737338084;6145.969270153649;6176.53675974302;6194.3805619438035;6229.781957631478;6165.352637973016;6171.228596425447;6176.814695559129;6193.7832175873855;6208.130861679358;5539.41836107209;5547.861303467415;5593.077142271521;5598.384177740445;5705.743241554119;5446.673199608016;5454.263674403965;5468.453154684519;5683.886322273552;5701.971490142543;5583.609147359686;5619.859503512404;5657.23627310312;5669.801556945507;5690.658560486363;5668.68822214778;5669.26299581056;5673.943260567424;5681.914771278434;5690.288713910741;5395.622306438551;5452.645578037414;5570.164475328733;5582.0789569721355;5654.547636189095;6128.422616821487;6137.4689182037;6151.692415379258;6153.938460615426;6162.84592885177;6435.131257280254;6442.355764423567;6520.4457621102265;6560.803175904731;6590.736370545173;6644.402003819631;6660.167479065117;6708.932910670928;6716.294789047178;6718.764843230463;5511.862203444906;6289.245290565115;6304.464120549759;6310.8422289442215;6312.305646378894;6279.340669229665;6587.901181482282;6641.269460359356;6777.2545020047755;6856.485763567653;6424.743010279536;6471.773487927994;6517.250516190604;6534;6545.37818907203;6678.465722742169;6688.130543029472;6693.631850248185;6693.933060669428;6694.531382803254;6322.525810564226;6357.332480089524;6429.260635027032;6592.571482853599;6600.86798264032;6407.807765767035;6467.062275969958;6489.70796314167;6547.377999090078;6570.901436478457;5318.095923692981;5329.200619906967;5330.147176451749;5331;5365.570754339644;4700.764961751899;4756.453007904066;4770.260609605517;4788.592969597623;4789.832355867528;6131.877781547492;6137.96931015351;6181.381861813783;6206.751729930843;6346.2067241594805;6460.483161347081;6473.838154046187;6483.059956306309;6567.704453299613;6609.735610575619;6317.273513545909;6317.873642527124;6322.304546499881;6324.968375158095;6332.525060620472;5832.941670583325;5841.795537156264;5854.736536855767;5859.355470898197;5895.616784908967;6583.506237032338;6633.900491492728;6915.723371065101;6953.965230173817;6962.199347075151;6560.475161986934;6608.173978252718;6642.335766423319;6685.498587605852;6692.564983276072;6859.9314006859295;6899.827504312432;6917.757878474229;6937.583744975318;6938.236793952762;6345.619262844244;6527.576740703768;6560.3111673273615;6567.408933196035;6571.211454625475;5103.77033033507;6473.093766872736;6575.309592492719;6608.900866487103;6663.233728121328;6301.747930082745;6355.428011478989;6368.490520758235;6369.617822930639;6395.712192951235;6396.9680151600805;6412.871742565216;6454.644994525346;6475.870482590228;6497.285298617243;6368.96815515938;6376.904346434714;6378.712957916998;6388.201474815648;6394.808155755335;6310.873782524415;6327.746890124344;6346.873062538816;6353.841153971188;6448.451881590117;6355.650439225887;6368.395002474757;6376.266729326001;6389.4888408926245;6397 20:15:08 INFO - PROCESS | 1637 | |1;ext.html;763.3969164360155;819.393648699962;836.4354061008819;910.4355299714174;917.9357444978846;29641.25896852577;42401.575984240146;42626.36060459092;44193.55806441935;44679;43220.56779432205;43338;43510;43514.56485435145;43640.781796091054;7995;9697;9854.852177217348;9869.21046316293;9884.456354900478;8090.433669643127;8157.918420815805;8170.918290817105;8177.427580069398;11788.292702437839;12000.819987700192;12013.279203247834;12036.398180091004;12052.457639406204;12079.698007549838;11965.282083075;11986.70033249167;12016.69958251042;12023.879761202363;12026.338551379671;11731.941340293244;11786.469608867621;11801.055915526736;11803;11843.111766617538;41517.79241103775;41673;41768.74693759192;41816.790916045225;41820.790896045626;4025.81883815229;4091.181763647253;4106.876793696194;4109.445224894661;4110.547839737626;27950.860245698845;28655.71344286551;30286.697133028607;30768.230794230098;30818.53772193419;3281.1797050737314;3308.718758905496;3311.7516186286125;3407.642197569244;3429.2627085176805;345934;349070;350526;351399;351820;54470.45529544654;54476;54596.18105728417;54683.63290917759;54690.45309546933;56620;56713.716431418405;56721.43278567244;56735.86528269412;56748;15709.685806284038;15816.60458488547;15824.367025319088;15833.52499425019;15845.841541584667;13604.319784010957;13604.659883502794;13612.31938403076;13628.04603677733;13632;10587.258891877495;10795.622153224756;10889.509972051277;10973.451327433597;12215.450304736309;4638.443386793607;4839.467658557556;4848.80604775805;5250.264962905197;5383.865403364869;1056.9928553265945;1071.705281047718;1116.3636727065657;1142.8514293142005;1143.5025763792776;13030.674233144058;16416.75374869354;16661.916690416714;16678.6664266714;17143.914280428766;1037.2687255484866;1166.585862018988;1174.453878946277;1179.5812486567318;1221.5358163897663;8542.145785421408;8548.871766923501;8573.142685731376;8811.911880881238;8813.294936405073;472109;472410;473328.2667173353;473393;473459;49021.5097849017;59939.100913486334;59962;59969.10046349308;60109.39890601126;1302.6808431934237;1314.8093526438804;1474.6829431672243;1518.7949626800462;1520.8859335549657;25936.962521499685;28552.714472855005;28650.28374290576;30273.69726302797;31595.526067109473;34616;42469.575304247795;42698;42743.786281068395;42786;438422;440449;440583;496921;508543;35101.64898350984;35490.112747180494;35522;36333.45499817558;36868.26263474662;46165.76917115393;46378.30432543582;46536.069278614916;46775.766121169174;46837.53162468332;30744.692553075078;31283.37433251368;31312.373752524367;32133.875314363886;32430.351392971537;30971.380572388876;31155;31256.374872502878;31746.206344841565;32187.67812321847;37657.62342376541;38295.80852095722;38477.80761096177;38483.80758096192;38632.6136738629;30734;31705.207369815016;31936.68063319337;32765.672343276263;32783;24070.39824004414;25322;25489.745102548735;25578;25718.742812571636 20:15:08 INFO - PROCESS | 1637 | |2;jquery.html;425.78072292769247;433.6816079119477;435.9128174365128;438.8880835386977;448.19996306592736;20027.99999999998;21399.03704333305;22240.110395584157;22513.887430562867;22561;22843.885780571072;23561.410964725892;23961.28116156518;24125.7937103145;24531.63202551963;6832.795016149498;7037.3666370026685;7132.144142702883;7219.494635375526;7277.526960747535;6900.3099690031095;7009.75465858695;7014.298570142996;7022.683979220922;7023.473239507032;6078.635281883079;6801.6599170041545;6932.791926671239;6963;6967.512274140812;6673.766418175389;6942.791716248521;7007.789766307019;7014.859702805941;7025.156981162268;6907.378335949788;6914.274001229849;6924;6924.792256232321;6925.861482770367;22458.775412245832;25736.227913162635;26753;28024.439511209865;28391.29021774472;3036.149878034154;3069.2480342316276;3090.8300043497597;3124.187711195083;3154.4006638738797;13241.536546220836;15904.602384940468;16412.917935410365;16684.49946501607;17373.7393939091;1810.8279713427203;2036.7485223928522;2054.78424765399;2070.068469188856;2095.549456866766;106674;151252;156104.21947890302;163068.18465907715;164977;22645.638431735275;23109.653355199687;23133.30600082;23556.7644323558;24967.12615058464;45507.31739023917;46315.30527042097;47310;47404.525954740704;47510.762446187546;11800.232984855957;12011.699707507381;12100.455479503444;12134.393280336124;12302.323372214614;9831;9846.655367062118;9847.50762461874;10025.749356266006;10075.395476271447;9583.747819262468;9639.132478076866;9789.363691360039;11883.287002779862;12057.276563406049;4598.954010459919;4667.416572928384;4722.669413141047;4723;4748.715077095385;1054.5149231353664;1071;1096.3641088168843;1098.9230753847155;1135.812590922505;22627.20804771825;23071.659399333865;23200.3039908803;23260;23390.298291051295;1093.6937657455926;1099.1536516881956;1100.9614663486739;1112.1547623805966;1117.0895719988346;11601.477933493014;12341.93829030867;12663.620091397273;12884.355782210852;12887.48450061987;640515;644630;786735;797043;808762;119086.21370679447;148319;151607;152699.23650381676;159493.2025339866;1270.3203785974458;1298.3248710670398;1356.8127888097915;1360.415021540747;1366.6036849313787;19566.92381919008;20548;20801.58396832085;21454.46363840854;21525.784742152377;66847;68211.65894170497;68404.6579767098;69590;71105;91992;92853;93195;95735.04264957261;96085;11508.94245528767;11744.823827642422;11983.940080299542;12151.756964860477;12240.387980601112;13155.868441315464;13156.80264796048;13194.340282986004;13408.32958352098;13553.051286410251;11662.416879156179;11860.584879529175;11942.880571194524;12020.278783272683;12100.03199744036;10641.414722190353;10657.413842238751;10707.839382409426;10766.192535559707;11036.061934735637;11764.470598823245;12002.75994480088;12019.879801201876;12089.274643521065;12180.573679921516;9607.951960240154;11801.763964720829;11913.82129268079;11931.761364772483;12147.453364598437;11548.59579914699;11612.477438515456;11827.408629568316;11940.343281119622;12048.698782530508 20:15:08 INFO - PROCESS | 1637 | |3;mootools.html;1383.2323060701312;1390.3951780975283;1461.963450913727;1618.4416376350161;1652.2977734462854;9772.267079968995;10934.507947142378;11588.304701717903;11606.187566870323;11663.425437565926;10647.361158330506;10920.071793897509;11056.723581910457;11068.667939961793;11113.166512511574;2364.7871691547757;2389.904403823845;2399.5081008393327;2403.6995375578053;2410.1684918703018;2290.209877592228;2359.8584084954873;2372.810175185981;2375.406148462884;2386.129062892049;2295.2540424362064;2360.6695062691238;2371.3834403055157;2374.5844477216506;2387.1525608409024;2299.448132448217;2341.5785158671433;2346.5541547105995;2365.9999999999914;2372.715274167111;2350.717913850332;2375.0381095656285;2379.3813608461924;2383.2731017039796;2385.522895420923;11330.490127944262;11584.536618535249;11589.014933730643;11606.129540284512;11656.766864662744;5192.402873669538;5233.319668443116;5284.9958507883375;5337.092694241988;5338.492843179892;3279.754018448626;3360.2358761650084;3389.068006298263;3431.9656803431894;3522.559680039995;1120.8318752187156;1152.4353066997112;1166.3293606176483;1191.6008137274023;1194.3073017649742;14394.208318542476;14690.926545367312;14979.550613481504;15940.840591594051;16036.278367473491;4386.868393948187;4510.323451482304;4532.410786597721;4545.136424079415;4545.522720114406;12293.692657683629;12302.261864288172;12302.323372214614;12307.323097229739;12321;4855.36880205571;4997.30037794709;5015.824446144367;5016.272640467185;5051.696898186047;4537.3647689323525;5031.949680503221;5215.869603259873;5268.315119034501;5300.814471493479;3297.3405318936307;3721.497597824259;3733.757305775116;3830.3296923038915;3835;917.0233701108432;933.2347475070377;948.5209968965628;956.9090936361034;962.7737481691797;973.9318247722733;986.6349450703286;1002.754325190333;1007.5012868629929;1018.3635227982511;6954.301862990046;7108.928910710827;7181.640917954186;7309.744158954411;7331.633418329062;1007.4937967738132;1042.358949246208;1044.7022598559374;1059.6291298045776;1080.0333701337258;3953;4140.15126898985;4422.447194100738;4442.3336499524685;4449.7997590108525;12631.557895473614;13635.931820340835;14258.85741142596;14262.786058209134;14282.57152285433;13416.865831341562;14191.574252772434;14209.431622734975;14218;14218.28908554568;10194.592216311414;10583.364998100138;10707.678769636923;10711.08955738771;10717.303375280737;6673.232578253369;6705.6647167642395;6789.4568434524135;6810.5913645181445;6815.863682726417;10864.728381790519;12576.056795740173;12950.481980721042;12975.221486710827;12985.740285194055;11157.776844463227;11460.484278207334;12978.545750898673;13165.473381065034;13252.602421926971;8678.652853886026;8860.246879015098;8861.955690221508;9081.137291957253;9435.150836424755;10558;10639.946800265949;10753.24727269115;10759.924007599177;10778.676639700821;9044;9054.683086092218;9066.184043436122;9147.588358524015;9212.170904618617;7627.771166865003;8744.344174186834;8816.51509167002;8819.38264321517;8957.372983891066;7722.613869306625;7803.258690424401;7923.84152316962;7935.84128317442;7950.7217247396065;5082.517160869711;5824.737886795019;5873.207117039145;6037.516998640186;6050.42520960508;5499.972500137474;5643.379228284967;5983.760649574142;6260.937390626035;6302.590331628429 20:15:08 INFO - PROCESS | 1637 | |4;prototype.html;395.3792545703247;396.9543502497213;398.3252459732894;399.94000899865;400.5733893403523;4689.390379250701;4832.765732205455;5073.923891141631;5349.224362467445;5408.567314614821;4910.140725373063;4922.655414121004;5048.737815546114;5074.264231686403;5115.923261151086;3701.444783282516;4104.466419365478;4136.793160341986;4159.542450330461;4163.9583604163945;3249.9275239171016;3626.87305944292;3669.7247706422127;3870.283997460465;4009.9774557487945;3299.6535363786816;3512.8243587820634;3515.296940611875;4150.647194988414;4169.603887630686;3922.7254092213557;4058.6753059755297;4067.8169482373364;4167.832726981952;4168.3955826405;3697.7411581189326;3703.2038111805823;3705.573859006222;3720;3720.386136287509;4498.820047198108;4856.620256074533;4946.9364086721525;5208.713520756357;5223.667964669023;4546.818127274905;4777.378940737682;4842.198873884019;5010.649254552146;5035.546800787946;5006.674566153189;5159.968006398735;5659.377468478464;5673;5709.200711900337;3901.9219615607813;4410.911781764379;4536.138133754576;4555.681102322838;4596.149712303235;5030.522100400456;5920.822375328747;5950.756837523603;6000.759969601254;6023.735015646719;4484.013517026249;4629.935114923519;4657.534246575383;4668.766561671903;4668.883277918079;4307.095509942885;4460.773287346005;4777.617790576745;4823.43238447506;4839.2983017462275;4217.62041416274;4400.405945197357;4514.029483661028;5084.915184774225;5147.194778845538;4427.29163333865;5191.454897235736;5510.311211098613;5529.060059789765;5557.665780372254;1452.6876721504716;1514.258013573341;1559.9298031588605;1609.937441288744;1615.2929027881041;1119.5857532712948;1207.6075275535486;1223.7430139670769;1229.7601967616229;1239.9504019839105;4584.472785629695;4598.011427543094;4807.855764327076;5231.9476805232225;5249.238860365225;5448.101063324507;5484.341878974548;5864.589478736533;5873.119032145212;5929.517620594851;4711.411073615798;4928.310036594879;5032.547070763649;5229.790808367623;5296.655717378358;2752.4632696624367;2779.527480328349;2811.831290122599;3045.6040714707387;3067.8159310441447;4999.800007999639;5396.92061587684;5421.403645598981;6067.544934129958;6178.598391104564;4730.503297153749;5262.473752624784;5753.798617048383;5839.926825976802;5956.910646340309;5662.886742265132;5883.235179426647;5937.584369094122;6108.72510737009;6109.572329936862;4787.712737235777;4983;5550.417206193453;5807.303123625192;5852.707364631666;4761.500042495627;5453.972730136324;5662.074894535877;5708.914366284592;5882.8822523720355;5440.633324503853;5520.227168196376;6147.66187859672;6165.181271524822;6170.938290617037;4312.412552468494;4893.657443978887;4954.628402869871;5093.821716239914;5177.844664660066;5373.871486987777;5740.655560666373;5819.359870414336;5881.941180588139;5910.468057874812;5261.4738526147075;5649.971750141223;5652.943470565407;5718.1136923776885;5737.827865164052;5521.101421753611;5594.608377413705;5630.60585758993;5663.7451314690115;5682.6306290091015;4835.734034628129;4877.609791216765;5166.793328266977;5549.667019978814;5625.718714064198;5662;5689.411317850286;5718.628289161191;5730.369659337553;5753.050746626927;5029.899402011866;5109.029284435946;5115.370589616403;5527.668339899619;5528.004959107399 20:15:08 INFO - PROCESS | 1637 | |5;yui.html;800.2637573432442;817.1420008990558;836.8284501677157;886.6674996876171;896.9192772650463;15701.764473532892;17295.30818767248;17301.91349043253;17304.653906921852;17325.22036508357;14498.710025799504;15927.203639817992;16109;16151.273192706327;16184.83815161848;1002.5288114586133;1016.8881423043459;1034.1468288661847;1034.8861625221257;1037.7457522906898;1023.0179028133001;1025.7384366986407;1026.7381817636492;1027.193652982409;1028.1209565821227;1062.7661914378825;1064.387976913274;1066.1524088349781;1066.845307430422;1070.2775626452153;1056.060106505211;1056.0653821368069;1057.735566108473;1058.9629362972337;1060.6022741471947;783.3380793229712;783.600363814453;783.6786917363853;783.8745800671923;786.4652036615099;15139.470118545909;15201.771973420407;15262.771058434133;15735.92132039344;15736.370545178179;12353.691157721129;12449.75100497994;12657.683557911034;12714.809277860839;12916.160449570747;11307.434628268553;11387.25982811123;11484.081273498101;11509.885530700836;11957.581484647995;3815.790131542764;3831.5543266038394;3851.5570709368503;3863.343231650598;3893.377059670439;108764;111351.44324278327;111646.44176779146;112625.43687281512;113331;9375.578098985561;9454.14912657864;9536.570854311572;10245.129164021142;11278.097752179807;22962.885185574298;22987.54024919492;22987.96554155067;23002.194923177944;23008.309750707507;7966.522008679498;8033.718819841394;8248.257656810916;8284;8409.20112589303;4560.8175672973375;4648.047150334173;4662.9766851166205;4664.580187783115;4871.14754917888;3632.055665526982;3727.683146932487;3731.2350968051483;3734.589195188527;3736.645018723217;554.833549935026;628.1770880147022;634.4321831960369;672.4217173231017;673.0980486148486;599.7391134856351;653.098723761216;665.4476784269045;684.5037347922716;688.8622275544811;9001.504917229484;9981.45102019396;10558.841617375745;10655.946720266349;10699.679009629723;572.4490302098335;593.6675461741438;621.3537920562565;672.1665135232374;727.9571391583128;4962.230854217602;5028.723420211923;5052.317937078521;5054.368203974504;5056.797728090835;86543.56728216444;88737.66893496603;94402.80784556778;96794.5160274194;110194.44902775435;69066.65466672635;70238;86266.27467450616;87912.5604371974;90262.54868725615;75674;75903;77598.83601745978;78253.43493129991;78396.60801696069;11120.944395277971;11160.441977901235;11415.885841141482;11431.771364572496;11460.656180314603;50517.242241367145;50605;52289.738551307;52307.21539176992;53017;65466.34533654793;66245.0063249042;66599.66700166662;66951.33048669451;67591.98612020725;11579;12508.562200322946;12570.245785252913;13372.264525451194;13456.192628442324;15520.611984700472;15737.055776653437;16043.438479653156;16135.804870264408;16702.66594668124;14357.56927292183;14805.629859253175;14812.777808332668;14884.925575372054;15249.542513724162;14320.581813861052;14882.979782890065;15217.163056032025;15427.580797458155;15560.844391556393;10705.518251678537;14147.36336864823;14343;14431.878300276532;14474.131552106906;8678.305735541267;9983.900160998588;10008.39949603026;10466.63366782159;10532.842007369742;9949.751256218364;10651.736436270909;11760.88239117598;11874.346910919983;12212.32832194238 20:15:08 INFO - PROCESS | 1637 | __end_tp_report 20:15:08 INFO - PROCESS | 1637 | __start_cc_report 20:15:08 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1897 20:15:08 INFO - PROCESS | 1637 | __end_cc_report 20:15:08 INFO - PROCESS | 1637 | __startTimestamp1496632508691__endTimestamp 20:15:08 INFO - PROCESS | 1637 | 20:15:08 INFO - PROCESS | 1637 | ------- Summary: start ------- 20:15:08 INFO - PROCESS | 1637 | Number of tests: 6 20:15:08 INFO - PROCESS | 1637 | 20:15:08 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:6125.11 Median:6346.87 stddev:664.21 (10.5%) stddev-sans-first:636.25 20:15:08 INFO - PROCESS | 1637 | Values: 3609.3 3610.2 3622.2 3649.4 3676.4 5105.3 6146.0 6176.5 6194.4 6229.8 6165.4 6171.2 6176.8 6193.8 6208.1 5539.4 5547.9 5593.1 5598.4 5705.7 5446.7 5454.3 5468.5 5683.9 5702.0 5583.6 5619.9 5657.2 5669.8 5690.7 5668.7 5669.3 5673.9 5681.9 5690.3 5395.6 5452.6 5570.2 5582.1 5654.5 6128.4 6137.5 6151.7 6153.9 6162.8 6435.1 6442.4 6520.4 6560.8 6590.7 6644.4 6660.2 6708.9 6716.3 6718.8 5511.9 6289.2 6304.5 6310.8 6312.3 6279.3 6587.9 6641.3 6777.3 6856.5 6424.7 6471.8 6517.3 6534.0 6545.4 6678.5 6688.1 6693.6 6693.9 6694.5 6322.5 6357.3 6429.3 6592.6 6600.9 6407.8 6467.1 6489.7 6547.4 6570.9 5318.1 5329.2 5330.1 5331.0 5365.6 4700.8 4756.5 4770.3 4788.6 4789.8 6131.9 6138.0 6181.4 6206.8 6346.2 6460.5 6473.8 6483.1 6567.7 6609.7 6317.3 6317.9 6322.3 6325.0 6332.5 5832.9 5841.8 5854.7 5859.4 5895.6 6583.5 6633.9 6915.7 6954.0 6962.2 6560.5 6608.2 6642.3 6685.5 6692.6 6859.9 6899.8 6917.8 6937.6 6938.2 6345.6 6527.6 6560.3 6567.4 6571.2 5103.8 6473.1 6575.3 6608.9 6663.2 6301.7 6355.4 6368.5 6369.6 6395.7 6397.0 6412.9 6454.6 6475.9 6497.3 6369.0 6376.9 6378.7 6388.2 6394.8 6310.9 6327.7 6346.9 6353.8 6448.5 6355.7 6368.4 6376.3 6389.5 6397.0 20:15:08 INFO - PROCESS | 1637 | 20:15:08 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:57213.06 Median:192813.82 stddev:115035.76 (59.7%) stddev-sans-first:115280.39 20:15:08 INFO - PROCESS | 1637 | Values: 763.4 819.4 836.4 910.4 917.9 29641.3 42401.6 42626.4 44193.6 44679.0 43220.6 43338.0 43510.0 43514.6 43640.8 7995.0 9697.0 9854.9 9869.2 9884.5 8090.4 8157.9 8170.9 8177.4 11788.3 12000.8 12013.3 12036.4 12052.5 12079.7 11965.3 11986.7 12016.7 12023.9 12026.3 11731.9 11786.5 11801.1 11803.0 11843.1 41517.8 41673.0 41768.7 41816.8 41820.8 4025.8 4091.2 4106.9 4109.4 4110.5 27950.9 28655.7 30286.7 30768.2 30818.5 3281.2 3308.7 3311.8 3407.6 3429.3 345934.0 349070.0 350526.0 351399.0 351820.0 54470.5 54476.0 54596.2 54683.6 54690.5 56620.0 56713.7 56721.4 56735.9 56748.0 15709.7 15816.6 15824.4 15833.5 15845.8 13604.3 13604.7 13612.3 13628.0 13632.0 10587.3 10795.6 10889.5 10973.5 12215.5 4638.4 4839.5 4848.8 5250.3 5383.9 1057.0 1071.7 1116.4 1142.9 1143.5 13030.7 16416.8 16661.9 16678.7 17143.9 1037.3 1166.6 1174.5 1179.6 1221.5 8542.1 8548.9 8573.1 8811.9 8813.3 472109.0 472410.0 473328.3 473393.0 473459.0 49021.5 59939.1 59962.0 59969.1 60109.4 1302.7 1314.8 1474.7 1518.8 1520.9 25937.0 28552.7 28650.3 30273.7 31595.5 34616.0 42469.6 42698.0 42743.8 42786.0 438422.0 440449.0 440583.0 496921.0 508543.0 35101.6 35490.1 35522.0 36333.5 36868.3 46165.8 46378.3 46536.1 46775.8 46837.5 30744.7 31283.4 31312.4 32133.9 32430.4 30971.4 31155.0 31256.4 31746.2 32187.7 37657.6 38295.8 38477.8 38483.8 38632.6 30734.0 31705.2 31936.7 32765.7 32783.0 24070.4 25322.0 25489.7 25578.0 25718.7 20:15:08 INFO - PROCESS | 1637 | 20:15:08 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:43656.48 Median:22349.44 stddev:123196.22 (551.2%) stddev-sans-first:123499.06 20:15:08 INFO - PROCESS | 1637 | Values: 425.8 433.7 435.9 438.9 448.2 20028.0 21399.0 22240.1 22513.9 22561.0 22843.9 23561.4 23961.3 24125.8 24531.6 6832.8 7037.4 7132.1 7219.5 7277.5 6900.3 7009.8 7014.3 7022.7 7023.5 6078.6 6801.7 6932.8 6963.0 6967.5 6673.8 6942.8 7007.8 7014.9 7025.2 6907.4 6914.3 6924.0 6924.8 6925.9 22458.8 25736.2 26753.0 28024.4 28391.3 3036.1 3069.2 3090.8 3124.2 3154.4 13241.5 15904.6 16412.9 16684.5 17373.7 1810.8 2036.7 2054.8 2070.1 2095.5 106674.0 151252.0 156104.2 163068.2 164977.0 22645.6 23109.7 23133.3 23556.8 24967.1 45507.3 46315.3 47310.0 47404.5 47510.8 11800.2 12011.7 12100.5 12134.4 12302.3 9831.0 9846.7 9847.5 10025.7 10075.4 9583.7 9639.1 9789.4 11883.3 12057.3 4599.0 4667.4 4722.7 4723.0 4748.7 1054.5 1071.0 1096.4 1098.9 1135.8 22627.2 23071.7 23200.3 23260.0 23390.3 1093.7 1099.2 1101.0 1112.2 1117.1 11601.5 12341.9 12663.6 12884.4 12887.5 640515.0 644630.0 786735.0 797043.0 808762.0 119086.2 148319.0 151607.0 152699.2 159493.2 1270.3 1298.3 1356.8 1360.4 1366.6 19566.9 20548.0 20801.6 21454.5 21525.8 66847.0 68211.7 68404.7 69590.0 71105.0 91992.0 92853.0 93195.0 95735.0 96085.0 11508.9 11744.8 11983.9 12151.8 12240.4 13155.9 13156.8 13194.3 13408.3 13553.1 11662.4 11860.6 11942.9 12020.3 12100.0 10641.4 10657.4 10707.8 10766.2 11036.1 11764.5 12002.8 12019.9 12089.3 12180.6 9608.0 11801.8 11913.8 11931.8 12147.5 11548.6 11612.5 11827.4 11940.3 12048.7 20:15:08 INFO - PROCESS | 1637 | 20:15:08 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:6778.94 Median:2385.83 stddev:4342.93 (182.0%) stddev-sans-first:4336.19 20:15:08 INFO - PROCESS | 1637 | Values: 1383.2 1390.4 1462.0 1618.4 1652.3 9772.3 10934.5 11588.3 11606.2 11663.4 10647.4 10920.1 11056.7 11068.7 11113.2 2364.8 2389.9 2399.5 2403.7 2410.2 2290.2 2359.9 2372.8 2375.4 2386.1 2295.3 2360.7 2371.4 2374.6 2387.2 2299.4 2341.6 2346.6 2366.0 2372.7 2350.7 2375.0 2379.4 2383.3 2385.5 11330.5 11584.5 11589.0 11606.1 11656.8 5192.4 5233.3 5285.0 5337.1 5338.5 3279.8 3360.2 3389.1 3432.0 3522.6 1120.8 1152.4 1166.3 1191.6 1194.3 14394.2 14690.9 14979.6 15940.8 16036.3 4386.9 4510.3 4532.4 4545.1 4545.5 12293.7 12302.3 12302.3 12307.3 12321.0 4855.4 4997.3 5015.8 5016.3 5051.7 4537.4 5031.9 5215.9 5268.3 5300.8 3297.3 3721.5 3733.8 3830.3 3835.0 917.0 933.2 948.5 956.9 962.8 973.9 986.6 1002.8 1007.5 1018.4 6954.3 7108.9 7181.6 7309.7 7331.6 1007.5 1042.4 1044.7 1059.6 1080.0 3953.0 4140.2 4422.4 4442.3 4449.8 12631.6 13635.9 14258.9 14262.8 14282.6 13416.9 14191.6 14209.4 14218.0 14218.3 10194.6 10583.4 10707.7 10711.1 10717.3 6673.2 6705.7 6789.5 6810.6 6815.9 10864.7 12576.1 12950.5 12975.2 12985.7 11157.8 11460.5 12978.5 13165.5 13252.6 8678.7 8860.2 8862.0 9081.1 9435.2 10558.0 10639.9 10753.2 10759.9 10778.7 9044.0 9054.7 9066.2 9147.6 9212.2 7627.8 8744.3 8816.5 8819.4 8957.4 7722.6 7803.3 7923.8 7935.8 7950.7 5082.5 5824.7 5873.2 6037.5 6050.4 5500.0 5643.4 5983.8 6260.9 6302.6 20:15:08 INFO - PROCESS | 1637 | 20:15:08 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4653.14 Median:5020.27 stddev:1333.66 (26.6%) stddev-sans-first:1298.54 20:15:08 INFO - PROCESS | 1637 | Values: 395.4 397.0 398.3 399.9 400.6 4689.4 4832.8 5073.9 5349.2 5408.6 4910.1 4922.7 5048.7 5074.3 5115.9 3701.4 4104.5 4136.8 4159.5 4164.0 3249.9 3626.9 3669.7 3870.3 4010.0 3299.7 3512.8 3515.3 4150.6 4169.6 3922.7 4058.7 4067.8 4167.8 4168.4 3697.7 3703.2 3705.6 3720.0 3720.4 4498.8 4856.6 4946.9 5208.7 5223.7 4546.8 4777.4 4842.2 5010.6 5035.5 5006.7 5160.0 5659.4 5673.0 5709.2 3901.9 4410.9 4536.1 4555.7 4596.1 5030.5 5920.8 5950.8 6000.8 6023.7 4484.0 4629.9 4657.5 4668.8 4668.9 4307.1 4460.8 4777.6 4823.4 4839.3 4217.6 4400.4 4514.0 5084.9 5147.2 4427.3 5191.5 5510.3 5529.1 5557.7 1452.7 1514.3 1559.9 1609.9 1615.3 1119.6 1207.6 1223.7 1229.8 1240.0 4584.5 4598.0 4807.9 5231.9 5249.2 5448.1 5484.3 5864.6 5873.1 5929.5 4711.4 4928.3 5032.5 5229.8 5296.7 2752.5 2779.5 2811.8 3045.6 3067.8 4999.8 5396.9 5421.4 6067.5 6178.6 4730.5 5262.5 5753.8 5839.9 5956.9 5662.9 5883.2 5937.6 6108.7 6109.6 4787.7 4983.0 5550.4 5807.3 5852.7 4761.5 5454.0 5662.1 5708.9 5882.9 5440.6 5520.2 6147.7 6165.2 6170.9 4312.4 4893.7 4954.6 5093.8 5177.8 5373.9 5740.7 5819.4 5881.9 5910.5 5261.5 5650.0 5652.9 5718.1 5737.8 5521.1 5594.6 5630.6 5663.7 5682.6 4835.7 4877.6 5166.8 5549.7 5625.7 5662.0 5689.4 5718.6 5730.4 5753.1 5029.9 5109.0 5115.4 5527.7 5528.0 20:15:08 INFO - PROCESS | 1637 | 20:15:08 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:20460.33 Median:17303.28 stddev:28736.16 (166.1%) stddev-sans-first:28778.85 20:15:08 INFO - PROCESS | 1637 | Values: 800.3 817.1 836.8 886.7 896.9 15701.8 17295.3 17301.9 17304.7 17325.2 14498.7 15927.2 16109.0 16151.3 16184.8 1002.5 1016.9 1034.1 1034.9 1037.7 1023.0 1025.7 1026.7 1027.2 1028.1 1062.8 1064.4 1066.2 1066.8 1070.3 1056.1 1056.1 1057.7 1059.0 1060.6 783.3 783.6 783.7 783.9 786.5 15139.5 15201.8 15262.8 15735.9 15736.4 12353.7 12449.8 12657.7 12714.8 12916.2 11307.4 11387.3 11484.1 11509.9 11957.6 3815.8 3831.6 3851.6 3863.3 3893.4 108764.0 111351.4 111646.4 112625.4 113331.0 9375.6 9454.1 9536.6 10245.1 11278.1 22962.9 22987.5 22988.0 23002.2 23008.3 7966.5 8033.7 8248.3 8284.0 8409.2 4560.8 4648.0 4663.0 4664.6 4871.1 3632.1 3727.7 3731.2 3734.6 3736.6 554.8 628.2 634.4 672.4 673.1 599.7 653.1 665.4 684.5 688.9 9001.5 9981.5 10558.8 10655.9 10699.7 572.4 593.7 621.4 672.2 728.0 4962.2 5028.7 5052.3 5054.4 5056.8 86543.6 88737.7 94402.8 96794.5 110194.4 69066.7 70238.0 86266.3 87912.6 90262.5 75674.0 75903.0 77598.8 78253.4 78396.6 11120.9 11160.4 11415.9 11431.8 11460.7 50517.2 50605.0 52289.7 52307.2 53017.0 65466.3 66245.0 66599.7 66951.3 67592.0 11579.0 12508.6 12570.2 13372.3 13456.2 15520.6 15737.1 16043.4 16135.8 16702.7 14357.6 14805.6 14812.8 14884.9 15249.5 14320.6 14883.0 15217.2 15427.6 15560.8 10705.5 14147.4 14343.0 14431.9 14474.1 8678.3 9983.9 10008.4 10466.6 10532.8 9949.8 10651.7 11760.9 11874.3 12212.3 20:15:08 INFO - PROCESS | 1637 | -------- Summary: end -------- 20:15:08 INFO - PROCESS | 1637 | 20:15:09 INFO - TEST-INFO | 1637: exit 0 20:15:09 INFO - TEST-OK | dromaeo_css | took 1119188ms 20:15:09 INFO - TEST-START | kraken 20:15:09 INFO - operating with platform_type : mac_ 20:15:09 INFO - Initialising browser for kraken test... 20:15:09 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/tmpFqL7G2/profile http://localhost:49220/getInfo.html) 20:15:11 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 20:15:11 INFO - PROCESS | 1646 | colorDepth:24 20:15:11 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 20:15:11 INFO - PROCESS | 1646 | __metrics 20:15:11 INFO - PROCESS | 1646 | 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" 20:15:11 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:15:12 INFO - TEST-INFO | 1646: exit 0 20:15:12 INFO - Browser initialized. 20:15:12 INFO - Running cycle 1/1 for kraken test... 20:15:12 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/tmpFqL7G2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:15:24 INFO - PROCESS | 1648 | RSS: Main: 165441536 20:15:24 INFO - PROCESS | 1648 | 20:15:26 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49220/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49220/tests/kraken/driver.html?testName=audio-beat-detection) 20:15:27 INFO - PROCESS | 1648 | RSS: Main: 215711744 20:15:27 INFO - PROCESS | 1648 | 20:15:30 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49220/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49220/tests/kraken/driver.html?testName=audio-dft) 20:15:31 INFO - PROCESS | 1648 | RSS: Main: 231464960 20:15:31 INFO - PROCESS | 1648 | 20:15:34 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49220/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49220/tests/kraken/driver.html?testName=audio-fft) 20:15:34 INFO - PROCESS | 1648 | RSS: Main: 328126464 20:15:34 INFO - PROCESS | 1648 | 20:15:36 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49220/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49220/tests/kraken/driver.html?testName=audio-oscillator) 20:15:37 INFO - PROCESS | 1648 | RSS: Main: 229343232 20:15:37 INFO - PROCESS | 1648 | 20:15:39 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49220/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49220/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:15:39 INFO - PROCESS | 1648 | RSS: Main: 231079936 20:15:39 INFO - PROCESS | 1648 | 20:15:42 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49220/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49220/tests/kraken/driver.html?testName=imaging-darkroom) 20:15:43 INFO - PROCESS | 1648 | RSS: Main: 271986688 20:15:43 INFO - PROCESS | 1648 | 20:15:46 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49220/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49220/tests/kraken/driver.html?testName=imaging-desaturate) 20:15:47 INFO - PROCESS | 1648 | RSS: Main: 274468864 20:15:47 INFO - PROCESS | 1648 | 20:15:50 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49220/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49220/tests/kraken/driver.html?testName=json-parse-financial) 20:15:50 INFO - PROCESS | 1648 | RSS: Main: 268775424 20:15:50 INFO - PROCESS | 1648 | 20:15:52 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49220/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49220/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:15:52 INFO - PROCESS | 1648 | RSS: Main: 246648832 20:15:52 INFO - PROCESS | 1648 | 20:15:54 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49220/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49220/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:15:55 INFO - PROCESS | 1648 | RSS: Main: 250544128 20:15:55 INFO - PROCESS | 1648 | 20:15:57 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49220/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49220/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:15:58 INFO - PROCESS | 1648 | RSS: Main: 254603264 20:15:58 INFO - PROCESS | 1648 | 20:16:01 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49220/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49220/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:16:01 INFO - PROCESS | 1648 | RSS: Main: 260329472 20:16:01 INFO - PROCESS | 1648 | 20:16:04 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49220/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49220/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:16:05 INFO - PROCESS | 1648 | RSS: Main: 261365760 20:16:05 INFO - PROCESS | 1648 | 20:16:07 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49220/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49220/tests/kraken/driver.html?testName=ai-astar) 20:16:07 INFO - PROCESS | 1648 | RSS: Main: 305455104 20:16:07 INFO - PROCESS | 1648 | 20:16:07 INFO - PROCESS | 1648 | __start_tp_report 20:16:07 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 20:16:07 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 20:16:07 INFO - PROCESS | 1648 | |i|pagename|runs| 20:16:07 INFO - PROCESS | 1648 | |0;ai-astar;133;170;165;114;116;117;116;115;115;115 20:16:07 INFO - PROCESS | 1648 | |1;audio-beat-detection;143;107;108;146;108;114;126;136;153;110 20:16:07 INFO - PROCESS | 1648 | |2;audio-dft;184;181;186;182;182;185;183;181;183;185 20:16:07 INFO - PROCESS | 1648 | |3;audio-fft;83;58;59;92;62;60;58;59;74;58 20:16:07 INFO - PROCESS | 1648 | |4;audio-oscillator;91;68;85;68;68;67;82;68;69;82 20:16:07 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;86;86;126;94;90;88;92;88;87;88 20:16:07 INFO - PROCESS | 1648 | |6;imaging-darkroom;94;94;97;93;102;139;148;94;93;93 20:16:07 INFO - PROCESS | 1648 | |7;imaging-desaturate;83;82;83;82;84;86;83;83;83;84 20:16:07 INFO - PROCESS | 1648 | |8;json-parse-financial;61;61;57;59;62;62;62;61;60;62 20:16:07 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;60;59;57;62;58;56;59;55;56;56 20:16:07 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;85;81;84;84;79;83;86;89;106;86 20:16:07 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;158;138;143;138;168;165;138;146;155;135 20:16:07 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;163;169;163;160;162;160;164;161;160;164 20:16:07 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;64;63;65;67;77;79;77;75;62;63 20:16:07 INFO - PROCESS | 1648 | __end_tp_report 20:16:07 INFO - PROCESS | 1648 | __start_cc_report 20:16:07 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,2006 20:16:07 INFO - PROCESS | 1648 | __end_cc_report 20:16:07 INFO - PROCESS | 1648 | __startTimestamp1496632567360__endTimestamp 20:16:07 INFO - PROCESS | 1648 | 20:16:07 INFO - PROCESS | 1648 | ------- Summary: start ------- 20:16:07 INFO - PROCESS | 1648 | Number of tests: 14 20:16:07 INFO - PROCESS | 1648 | 20:16:07 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:127.60 Median:116.50 stddev:21.78 (18.7%) stddev-sans-first:23.01 20:16:07 INFO - PROCESS | 1648 | Values: 133.0 170.0 165.0 114.0 116.0 117.0 116.0 115.0 115.0 115.0 20:16:07 INFO - PROCESS | 1648 | 20:16:07 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:125.10 Median:131.00 stddev:18.01 (13.7%) stddev-sans-first:17.90 20:16:07 INFO - PROCESS | 1648 | Values: 143.0 107.0 108.0 146.0 108.0 114.0 126.0 136.0 153.0 110.0 20:16:07 INFO - PROCESS | 1648 | 20:16:07 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:183.20 Median:183.50 stddev:1.75 (1.0%) stddev-sans-first:1.83 20:16:07 INFO - PROCESS | 1648 | Values: 184.0 181.0 186.0 182.0 182.0 185.0 183.0 181.0 183.0 185.0 20:16:07 INFO - PROCESS | 1648 | 20:16:07 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:66.30 Median:61.00 stddev:12.34 (20.2%) stddev-sans-first:11.51 20:16:07 INFO - PROCESS | 1648 | Values: 83.0 58.0 59.0 92.0 62.0 60.0 58.0 59.0 74.0 58.0 20:16:07 INFO - PROCESS | 1648 | 20:16:07 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:74.80 Median:75.50 stddev:9.13 (12.1%) stddev-sans-first:7.57 20:16:07 INFO - PROCESS | 1648 | Values: 91.0 68.0 85.0 68.0 68.0 67.0 82.0 68.0 69.0 82.0 20:16:07 INFO - PROCESS | 1648 | 20:16:07 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:92.50 Median:88.00 stddev:12.05 (13.7%) stddev-sans-first:12.55 20:16:07 INFO - PROCESS | 1648 | Values: 86.0 86.0 126.0 94.0 90.0 88.0 92.0 88.0 87.0 88.0 20:16:07 INFO - PROCESS | 1648 | 20:16:07 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:104.70 Median:93.50 stddev:20.74 (22.2%) stddev-sans-first:21.64 20:16:07 INFO - PROCESS | 1648 | Values: 94.0 94.0 97.0 93.0 102.0 139.0 148.0 94.0 93.0 93.0 20:16:07 INFO - PROCESS | 1648 | 20:16:07 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:83.30 Median:83.00 stddev:1.16 (1.4%) stddev-sans-first:1.22 20:16:07 INFO - PROCESS | 1648 | Values: 83.0 82.0 83.0 82.0 84.0 86.0 83.0 83.0 83.0 84.0 20:16:07 INFO - PROCESS | 1648 | 20:16:07 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:60.70 Median:61.50 stddev:1.64 (2.7%) stddev-sans-first:1.73 20:16:07 INFO - PROCESS | 1648 | Values: 61.0 61.0 57.0 59.0 62.0 62.0 62.0 61.0 60.0 62.0 20:16:07 INFO - PROCESS | 1648 | 20:16:07 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:57.80 Median:58.50 stddev:2.20 (3.8%) stddev-sans-first:2.19 20:16:07 INFO - PROCESS | 1648 | Values: 60.0 59.0 57.0 62.0 58.0 56.0 59.0 55.0 56.0 56.0 20:16:07 INFO - PROCESS | 1648 | 20:16:07 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:84.50 stddev:7.45 (8.8%) stddev-sans-first:7.89 20:16:07 INFO - PROCESS | 1648 | Values: 85.0 81.0 84.0 84.0 79.0 83.0 86.0 89.0 106.0 86.0 20:16:07 INFO - PROCESS | 1648 | 20:16:07 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:148.40 Median:150.50 stddev:12.18 (8.1%) stddev-sans-first:12.41 20:16:07 INFO - PROCESS | 1648 | Values: 158.0 138.0 143.0 138.0 168.0 165.0 138.0 146.0 155.0 135.0 20:16:07 INFO - PROCESS | 1648 | 20:16:07 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.60 Median:163.00 stddev:2.76 (1.7%) stddev-sans-first:2.92 20:16:07 INFO - PROCESS | 1648 | Values: 163.0 169.0 163.0 160.0 162.0 160.0 164.0 161.0 160.0 164.0 20:16:07 INFO - PROCESS | 1648 | 20:16:07 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:71.00 stddev:6.91 (9.7%) stddev-sans-first:7.07 20:16:07 INFO - PROCESS | 1648 | Values: 64.0 63.0 65.0 67.0 77.0 79.0 77.0 75.0 62.0 63.0 20:16:07 INFO - PROCESS | 1648 | -------- Summary: end -------- 20:16:07 INFO - PROCESS | 1648 | 20:16:08 INFO - TEST-INFO | 1648: exit 0 20:16:08 INFO - TEST-OK | kraken | took 59137ms 20:16:08 INFO - SUITE-END | took 1178s 20:16:08 INFO - Completed test suite (00:19:38) 20:16:08 INFO - javascript benchmark 20:16:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7901.96946824678, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3609.3142302962433, 3610.2238018825965, 3622.1669016126298, 3649.4343376776574, 3676.448532720092, 5105.259737338084, 6145.969270153649, 6176.53675974302, 6194.3805619438035, 6229.781957631478, 6165.352637973016, 6171.228596425447, 6176.814695559129, 6193.7832175873855, 6208.130861679358, 5539.41836107209, 5547.861303467415, 5593.077142271521, 5598.384177740445, 5705.743241554119, 5446.673199608016, 5454.263674403965, 5468.453154684519, 5683.886322273552, 5701.971490142543, 5583.609147359686, 5619.859503512404, 5657.23627310312, 5669.801556945507, 5690.658560486363, 5668.68822214778, 5669.26299581056, 5673.943260567424, 5681.914771278434, 5690.288713910741, 5395.622306438551, 5452.645578037414, 5570.164475328733, 5582.0789569721355, 5654.547636189095, 6128.422616821487, 6137.4689182037, 6151.692415379258, 6153.938460615426, 6162.84592885177, 6435.131257280254, 6442.355764423567, 6520.4457621102265, 6560.803175904731, 6590.736370545173, 6644.402003819631, 6660.167479065117, 6708.932910670928, 6716.294789047178, 6718.764843230463, 5511.862203444906, 6289.245290565115, 6304.464120549759, 6310.8422289442215, 6312.305646378894, 6279.340669229665, 6587.901181482282, 6641.269460359356, 6777.2545020047755, 6856.485763567653, 6424.743010279536, 6471.773487927994, 6517.250516190604, 6534.0, 6545.37818907203, 6678.465722742169, 6688.130543029472, 6693.631850248185, 6693.933060669428, 6694.531382803254, 6322.525810564226, 6357.332480089524, 6429.260635027032, 6592.571482853599, 6600.86798264032, 6407.807765767035, 6467.062275969958, 6489.70796314167, 6547.377999090078, 6570.901436478457, 5318.095923692981, 5329.200619906967, 5330.147176451749, 5331.0, 5365.570754339644, 4700.764961751899, 4756.453007904066, 4770.260609605517, 4788.592969597623, 4789.832355867528, 6131.877781547492, 6137.96931015351, 6181.381861813783, 6206.751729930843, 6346.2067241594805, 6460.483161347081, 6473.838154046187, 6483.059956306309, 6567.704453299613, 6609.735610575619, 6317.273513545909, 6317.873642527124, 6322.304546499881, 6324.968375158095, 6332.525060620472, 5832.941670583325, 5841.795537156264, 5854.736536855767, 5859.355470898197, 5895.616784908967, 6583.506237032338, 6633.900491492728, 6915.723371065101, 6953.965230173817, 6962.199347075151, 6560.475161986934, 6608.173978252718, 6642.335766423319, 6685.498587605852, 6692.564983276072, 6859.9314006859295, 6899.827504312432, 6917.757878474229, 6937.583744975318, 6938.236793952762, 6345.619262844244, 6527.576740703768, 6560.3111673273615, 6567.408933196035, 6571.211454625475, 5103.77033033507, 6473.093766872736, 6575.309592492719, 6608.900866487103, 6663.233728121328, 6301.747930082745, 6355.428011478989, 6368.490520758235, 6369.617822930639, 6395.712192951235, 6396.9680151600805, 6412.871742565216, 6454.644994525346, 6475.870482590228, 6497.285298617243, 6368.96815515938, 6376.904346434714, 6378.712957916998, 6388.201474815648, 6394.808155755335, 6310.873782524415, 6327.746890124344, 6346.873062538816, 6353.841153971188, 6448.451881590117, 6355.650439225887, 6368.395002474757, 6376.266729326001, 6389.4888408926245, 6397.0], "value": 6084.610813406454, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.3969164360155, 819.393648699962, 836.4354061008819, 910.4355299714174, 917.9357444978846, 29641.25896852577, 42401.575984240146, 42626.36060459092, 44193.55806441935, 44679.0, 43220.56779432205, 43338.0, 43510.0, 43514.56485435145, 43640.781796091054, 7995.0, 9697.0, 9854.852177217348, 9869.21046316293, 9884.456354900478, 8090.433669643127, 8157.918420815805, 8170.918290817105, 8177.427580069398, 11788.292702437839, 12000.819987700192, 12013.279203247834, 12036.398180091004, 12052.457639406204, 12079.698007549838, 11965.282083075, 11986.70033249167, 12016.69958251042, 12023.879761202363, 12026.338551379671, 11731.941340293244, 11786.469608867621, 11801.055915526736, 11803.0, 11843.111766617538, 41517.79241103775, 41673.0, 41768.74693759192, 41816.790916045225, 41820.790896045626, 4025.81883815229, 4091.181763647253, 4106.876793696194, 4109.445224894661, 4110.547839737626, 27950.860245698845, 28655.71344286551, 30286.697133028607, 30768.230794230098, 30818.53772193419, 3281.1797050737314, 3308.718758905496, 3311.7516186286125, 3407.642197569244, 3429.2627085176805, 345934.0, 349070.0, 350526.0, 351399.0, 351820.0, 54470.45529544654, 54476.0, 54596.18105728417, 54683.63290917759, 54690.45309546933, 56620.0, 56713.716431418405, 56721.43278567244, 56735.86528269412, 56748.0, 15709.685806284038, 15816.60458488547, 15824.367025319088, 15833.52499425019, 15845.841541584667, 13604.319784010957, 13604.659883502794, 13612.31938403076, 13628.04603677733, 13632.0, 10587.258891877495, 10795.622153224756, 10889.509972051277, 10973.451327433597, 12215.450304736309, 4638.443386793607, 4839.467658557556, 4848.80604775805, 5250.264962905197, 5383.865403364869, 1056.9928553265945, 1071.705281047718, 1116.3636727065657, 1142.8514293142005, 1143.5025763792776, 13030.674233144058, 16416.75374869354, 16661.916690416714, 16678.6664266714, 17143.914280428766, 1037.2687255484866, 1166.585862018988, 1174.453878946277, 1179.5812486567318, 1221.5358163897663, 8542.145785421408, 8548.871766923501, 8573.142685731376, 8811.911880881238, 8813.294936405073, 472109.0, 472410.0, 473328.2667173353, 473393.0, 473459.0, 49021.5097849017, 59939.100913486334, 59962.0, 59969.10046349308, 60109.39890601126, 1302.6808431934237, 1314.8093526438804, 1474.6829431672243, 1518.7949626800462, 1520.8859335549657, 25936.962521499685, 28552.714472855005, 28650.28374290576, 30273.69726302797, 31595.526067109473, 34616.0, 42469.575304247795, 42698.0, 42743.786281068395, 42786.0, 438422.0, 440449.0, 440583.0, 496921.0, 508543.0, 35101.64898350984, 35490.112747180494, 35522.0, 36333.45499817558, 36868.26263474662, 46165.76917115393, 46378.30432543582, 46536.069278614916, 46775.766121169174, 46837.53162468332, 30744.692553075078, 31283.37433251368, 31312.373752524367, 32133.875314363886, 32430.351392971537, 30971.380572388876, 31155.0, 31256.374872502878, 31746.206344841565, 32187.67812321847, 37657.62342376541, 38295.80852095722, 38477.80761096177, 38483.80758096192, 38632.6136738629, 30734.0, 31705.207369815016, 31936.68063319337, 32765.672343276263, 32783.0, 24070.39824004414, 25322.0, 25489.745102548735, 25578.0, 25718.742812571636], "value": 18916.49093070984, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.78072292769247, 433.6816079119477, 435.9128174365128, 438.8880835386977, 448.19996306592736, 20027.99999999998, 21399.03704333305, 22240.110395584157, 22513.887430562867, 22561.0, 22843.885780571072, 23561.410964725892, 23961.28116156518, 24125.7937103145, 24531.63202551963, 6832.795016149498, 7037.3666370026685, 7132.144142702883, 7219.494635375526, 7277.526960747535, 6900.3099690031095, 7009.75465858695, 7014.298570142996, 7022.683979220922, 7023.473239507032, 6078.635281883079, 6801.6599170041545, 6932.791926671239, 6963.0, 6967.512274140812, 6673.766418175389, 6942.791716248521, 7007.789766307019, 7014.859702805941, 7025.156981162268, 6907.378335949788, 6914.274001229849, 6924.0, 6924.792256232321, 6925.861482770367, 22458.775412245832, 25736.227913162635, 26753.0, 28024.439511209865, 28391.29021774472, 3036.149878034154, 3069.2480342316276, 3090.8300043497597, 3124.187711195083, 3154.4006638738797, 13241.536546220836, 15904.602384940468, 16412.917935410365, 16684.49946501607, 17373.7393939091, 1810.8279713427203, 2036.7485223928522, 2054.78424765399, 2070.068469188856, 2095.549456866766, 106674.0, 151252.0, 156104.21947890302, 163068.18465907715, 164977.0, 22645.638431735275, 23109.653355199687, 23133.30600082, 23556.7644323558, 24967.12615058464, 45507.31739023917, 46315.30527042097, 47310.0, 47404.525954740704, 47510.762446187546, 11800.232984855957, 12011.699707507381, 12100.455479503444, 12134.393280336124, 12302.323372214614, 9831.0, 9846.655367062118, 9847.50762461874, 10025.749356266006, 10075.395476271447, 9583.747819262468, 9639.132478076866, 9789.363691360039, 11883.287002779862, 12057.276563406049, 4598.954010459919, 4667.416572928384, 4722.669413141047, 4723.0, 4748.715077095385, 1054.5149231353664, 1071.0, 1096.3641088168843, 1098.9230753847155, 1135.812590922505, 22627.20804771825, 23071.659399333865, 23200.3039908803, 23260.0, 23390.298291051295, 1093.6937657455926, 1099.1536516881956, 1100.9614663486739, 1112.1547623805966, 1117.0895719988346, 11601.477933493014, 12341.93829030867, 12663.620091397273, 12884.355782210852, 12887.48450061987, 640515.0, 644630.0, 786735.0, 797043.0, 808762.0, 119086.21370679447, 148319.0, 151607.0, 152699.23650381676, 159493.2025339866, 1270.3203785974458, 1298.3248710670398, 1356.8127888097915, 1360.415021540747, 1366.6036849313787, 19566.92381919008, 20548.0, 20801.58396832085, 21454.46363840854, 21525.784742152377, 66847.0, 68211.65894170497, 68404.6579767098, 69590.0, 71105.0, 91992.0, 92853.0, 93195.0, 95735.04264957261, 96085.0, 11508.94245528767, 11744.823827642422, 11983.940080299542, 12151.756964860477, 12240.387980601112, 13155.868441315464, 13156.80264796048, 13194.340282986004, 13408.32958352098, 13553.051286410251, 11662.416879156179, 11860.584879529175, 11942.880571194524, 12020.278783272683, 12100.03199744036, 10641.414722190353, 10657.413842238751, 10707.839382409426, 10766.192535559707, 11036.061934735637, 11764.470598823245, 12002.75994480088, 12019.879801201876, 12089.274643521065, 12180.573679921516, 9607.951960240154, 11801.763964720829, 11913.82129268079, 11931.761364772483, 12147.453364598437, 11548.59579914699, 11612.477438515456, 11827.408629568316, 11940.343281119622, 12048.698782530508], "value": 12358.287361190156, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1383.2323060701312, 1390.3951780975283, 1461.963450913727, 1618.4416376350161, 1652.2977734462854, 9772.267079968995, 10934.507947142378, 11588.304701717903, 11606.187566870323, 11663.425437565926, 10647.361158330506, 10920.071793897509, 11056.723581910457, 11068.667939961793, 11113.166512511574, 2364.7871691547757, 2389.904403823845, 2399.5081008393327, 2403.6995375578053, 2410.1684918703018, 2290.209877592228, 2359.8584084954873, 2372.810175185981, 2375.406148462884, 2386.129062892049, 2295.2540424362064, 2360.6695062691238, 2371.3834403055157, 2374.5844477216506, 2387.1525608409024, 2299.448132448217, 2341.5785158671433, 2346.5541547105995, 2365.9999999999914, 2372.715274167111, 2350.717913850332, 2375.0381095656285, 2379.3813608461924, 2383.2731017039796, 2385.522895420923, 11330.490127944262, 11584.536618535249, 11589.014933730643, 11606.129540284512, 11656.766864662744, 5192.402873669538, 5233.319668443116, 5284.9958507883375, 5337.092694241988, 5338.492843179892, 3279.754018448626, 3360.2358761650084, 3389.068006298263, 3431.9656803431894, 3522.559680039995, 1120.8318752187156, 1152.4353066997112, 1166.3293606176483, 1191.6008137274023, 1194.3073017649742, 14394.208318542476, 14690.926545367312, 14979.550613481504, 15940.840591594051, 16036.278367473491, 4386.868393948187, 4510.323451482304, 4532.410786597721, 4545.136424079415, 4545.522720114406, 12293.692657683629, 12302.261864288172, 12302.323372214614, 12307.323097229739, 12321.0, 4855.36880205571, 4997.30037794709, 5015.824446144367, 5016.272640467185, 5051.696898186047, 4537.3647689323525, 5031.949680503221, 5215.869603259873, 5268.315119034501, 5300.814471493479, 3297.3405318936307, 3721.497597824259, 3733.757305775116, 3830.3296923038915, 3835.0, 917.0233701108432, 933.2347475070377, 948.5209968965628, 956.9090936361034, 962.7737481691797, 973.9318247722733, 986.6349450703286, 1002.754325190333, 1007.5012868629929, 1018.3635227982511, 6954.301862990046, 7108.928910710827, 7181.640917954186, 7309.744158954411, 7331.633418329062, 1007.4937967738132, 1042.358949246208, 1044.7022598559374, 1059.6291298045776, 1080.0333701337258, 3953.0, 4140.15126898985, 4422.447194100738, 4442.3336499524685, 4449.7997590108525, 12631.557895473614, 13635.931820340835, 14258.85741142596, 14262.786058209134, 14282.57152285433, 13416.865831341562, 14191.574252772434, 14209.431622734975, 14218.0, 14218.28908554568, 10194.592216311414, 10583.364998100138, 10707.678769636923, 10711.08955738771, 10717.303375280737, 6673.232578253369, 6705.6647167642395, 6789.4568434524135, 6810.5913645181445, 6815.863682726417, 10864.728381790519, 12576.056795740173, 12950.481980721042, 12975.221486710827, 12985.740285194055, 11157.776844463227, 11460.484278207334, 12978.545750898673, 13165.473381065034, 13252.602421926971, 8678.652853886026, 8860.246879015098, 8861.955690221508, 9081.137291957253, 9435.150836424755, 10558.0, 10639.946800265949, 10753.24727269115, 10759.924007599177, 10778.676639700821, 9044.0, 9054.683086092218, 9066.184043436122, 9147.588358524015, 9212.170904618617, 7627.771166865003, 8744.344174186834, 8816.51509167002, 8819.38264321517, 8957.372983891066, 7722.613869306625, 7803.258690424401, 7923.84152316962, 7935.84128317442, 7950.7217247396065, 5082.517160869711, 5824.737886795019, 5873.207117039145, 6037.516998640186, 6050.42520960508, 5499.972500137474, 5643.379228284967, 5983.760649574142, 6260.937390626035, 6302.590331628429], "value": 5119.157469112903, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.3792545703247, 396.9543502497213, 398.3252459732894, 399.94000899865, 400.5733893403523, 4689.390379250701, 4832.765732205455, 5073.923891141631, 5349.224362467445, 5408.567314614821, 4910.140725373063, 4922.655414121004, 5048.737815546114, 5074.264231686403, 5115.923261151086, 3701.444783282516, 4104.466419365478, 4136.793160341986, 4159.542450330461, 4163.9583604163945, 3249.9275239171016, 3626.87305944292, 3669.7247706422127, 3870.283997460465, 4009.9774557487945, 3299.6535363786816, 3512.8243587820634, 3515.296940611875, 4150.647194988414, 4169.603887630686, 3922.7254092213557, 4058.6753059755297, 4067.8169482373364, 4167.832726981952, 4168.3955826405, 3697.7411581189326, 3703.2038111805823, 3705.573859006222, 3720.0, 3720.386136287509, 4498.820047198108, 4856.620256074533, 4946.9364086721525, 5208.713520756357, 5223.667964669023, 4546.818127274905, 4777.378940737682, 4842.198873884019, 5010.649254552146, 5035.546800787946, 5006.674566153189, 5159.968006398735, 5659.377468478464, 5673.0, 5709.200711900337, 3901.9219615607813, 4410.911781764379, 4536.138133754576, 4555.681102322838, 4596.149712303235, 5030.522100400456, 5920.822375328747, 5950.756837523603, 6000.759969601254, 6023.735015646719, 4484.013517026249, 4629.935114923519, 4657.534246575383, 4668.766561671903, 4668.883277918079, 4307.095509942885, 4460.773287346005, 4777.617790576745, 4823.43238447506, 4839.2983017462275, 4217.62041416274, 4400.405945197357, 4514.029483661028, 5084.915184774225, 5147.194778845538, 4427.29163333865, 5191.454897235736, 5510.311211098613, 5529.060059789765, 5557.665780372254, 1452.6876721504716, 1514.258013573341, 1559.9298031588605, 1609.937441288744, 1615.2929027881041, 1119.5857532712948, 1207.6075275535486, 1223.7430139670769, 1229.7601967616229, 1239.9504019839105, 4584.472785629695, 4598.011427543094, 4807.855764327076, 5231.9476805232225, 5249.238860365225, 5448.101063324507, 5484.341878974548, 5864.589478736533, 5873.119032145212, 5929.517620594851, 4711.411073615798, 4928.310036594879, 5032.547070763649, 5229.790808367623, 5296.655717378358, 2752.4632696624367, 2779.527480328349, 2811.831290122599, 3045.6040714707387, 3067.8159310441447, 4999.800007999639, 5396.92061587684, 5421.403645598981, 6067.544934129958, 6178.598391104564, 4730.503297153749, 5262.473752624784, 5753.798617048383, 5839.926825976802, 5956.910646340309, 5662.886742265132, 5883.235179426647, 5937.584369094122, 6108.72510737009, 6109.572329936862, 4787.712737235777, 4983.0, 5550.417206193453, 5807.303123625192, 5852.707364631666, 4761.500042495627, 5453.972730136324, 5662.074894535877, 5708.914366284592, 5882.8822523720355, 5440.633324503853, 5520.227168196376, 6147.66187859672, 6165.181271524822, 6170.938290617037, 4312.412552468494, 4893.657443978887, 4954.628402869871, 5093.821716239914, 5177.844664660066, 5373.871486987777, 5740.655560666373, 5819.359870414336, 5881.941180588139, 5910.468057874812, 5261.4738526147075, 5649.971750141223, 5652.943470565407, 5718.1136923776885, 5737.827865164052, 5521.101421753611, 5594.608377413705, 5630.60585758993, 5663.7451314690115, 5682.6306290091015, 4835.734034628129, 4877.609791216765, 5166.793328266977, 5549.667019978814, 5625.718714064198, 5662.0, 5689.411317850286, 5718.628289161191, 5730.369659337553, 5753.050746626927, 5029.899402011866, 5109.029284435946, 5115.370589616403, 5527.668339899619, 5528.004959107399], "value": 4271.973657253893, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.2637573432442, 817.1420008990558, 836.8284501677157, 886.6674996876171, 896.9192772650463, 15701.764473532892, 17295.30818767248, 17301.91349043253, 17304.653906921852, 17325.22036508357, 14498.710025799504, 15927.203639817992, 16109.0, 16151.273192706327, 16184.83815161848, 1002.5288114586133, 1016.8881423043459, 1034.1468288661847, 1034.8861625221257, 1037.7457522906898, 1023.0179028133001, 1025.7384366986407, 1026.7381817636492, 1027.193652982409, 1028.1209565821227, 1062.7661914378825, 1064.387976913274, 1066.1524088349781, 1066.845307430422, 1070.2775626452153, 1056.060106505211, 1056.0653821368069, 1057.735566108473, 1058.9629362972337, 1060.6022741471947, 783.3380793229712, 783.600363814453, 783.6786917363853, 783.8745800671923, 786.4652036615099, 15139.470118545909, 15201.771973420407, 15262.771058434133, 15735.92132039344, 15736.370545178179, 12353.691157721129, 12449.75100497994, 12657.683557911034, 12714.809277860839, 12916.160449570747, 11307.434628268553, 11387.25982811123, 11484.081273498101, 11509.885530700836, 11957.581484647995, 3815.790131542764, 3831.5543266038394, 3851.5570709368503, 3863.343231650598, 3893.377059670439, 108764.0, 111351.44324278327, 111646.44176779146, 112625.43687281512, 113331.0, 9375.578098985561, 9454.14912657864, 9536.570854311572, 10245.129164021142, 11278.097752179807, 22962.885185574298, 22987.54024919492, 22987.96554155067, 23002.194923177944, 23008.309750707507, 7966.522008679498, 8033.718819841394, 8248.257656810916, 8284.0, 8409.20112589303, 4560.8175672973375, 4648.047150334173, 4662.9766851166205, 4664.580187783115, 4871.14754917888, 3632.055665526982, 3727.683146932487, 3731.2350968051483, 3734.589195188527, 3736.645018723217, 554.833549935026, 628.1770880147022, 634.4321831960369, 672.4217173231017, 673.0980486148486, 599.7391134856351, 653.098723761216, 665.4476784269045, 684.5037347922716, 688.8622275544811, 9001.504917229484, 9981.45102019396, 10558.841617375745, 10655.946720266349, 10699.679009629723, 572.4490302098335, 593.6675461741438, 621.3537920562565, 672.1665135232374, 727.9571391583128, 4962.230854217602, 5028.723420211923, 5052.317937078521, 5054.368203974504, 5056.797728090835, 86543.56728216444, 88737.66893496603, 94402.80784556778, 96794.5160274194, 110194.44902775435, 69066.65466672635, 70238.0, 86266.27467450616, 87912.5604371974, 90262.54868725615, 75674.0, 75903.0, 77598.83601745978, 78253.43493129991, 78396.60801696069, 11120.944395277971, 11160.441977901235, 11415.885841141482, 11431.771364572496, 11460.656180314603, 50517.242241367145, 50605.0, 52289.738551307, 52307.21539176992, 53017.0, 65466.34533654793, 66245.0063249042, 66599.66700166662, 66951.33048669451, 67591.98612020725, 11579.0, 12508.562200322946, 12570.245785252913, 13372.264525451194, 13456.192628442324, 15520.611984700472, 15737.055776653437, 16043.438479653156, 16135.804870264408, 16702.66594668124, 14357.56927292183, 14805.629859253175, 14812.777808332668, 14884.925575372054, 15249.542513724162, 14320.581813861052, 14882.979782890065, 15217.163056032025, 15427.580797458155, 15560.844391556393, 10705.518251678537, 14147.36336864823, 14343.0, 14431.878300276532, 14474.131552106906, 8678.305735541267, 9983.900160998588, 10008.39949603026, 10466.63366782159, 10532.842007369742, 9949.751256218364, 10651.736436270909, 11760.88239117598, 11874.346910919983, 12212.32832194238], "value": 7825.49211742617, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1442.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 170.0, 165.0, 114.0, 116.0, 117.0, 116.0, 115.0, 115.0, 115.0], "value": 127.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 107.0, 108.0, 146.0, 108.0, 114.0, 126.0, 136.0, 153.0, 110.0], "value": 125.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 181.0, 186.0, 182.0, 182.0, 185.0, 183.0, 181.0, 183.0, 185.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 59.0, 92.0, 62.0, 60.0, 58.0, 59.0, 74.0, 58.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 68.0, 85.0, 68.0, 68.0, 67.0, 82.0, 68.0, 69.0, 82.0], "value": 74.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 126.0, 94.0, 90.0, 88.0, 92.0, 88.0, 87.0, 88.0], "value": 92.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 97.0, 93.0, 102.0, 139.0, 148.0, 94.0, 93.0, 93.0], "value": 104.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 82.0, 84.0, 86.0, 83.0, 83.0, 83.0, 84.0], "value": 83.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 57.0, 59.0, 62.0, 62.0, 62.0, 61.0, 60.0, 62.0], "value": 60.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 57.0, 62.0, 58.0, 56.0, 59.0, 55.0, 56.0, 56.0], "value": 57.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 81.0, 84.0, 84.0, 79.0, 83.0, 86.0, 89.0, 106.0, 86.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 138.0, 143.0, 138.0, 168.0, 165.0, 138.0, 146.0, 155.0, 135.0], "value": 148.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 169.0, 163.0, 160.0, 162.0, 160.0, 164.0, 161.0, 160.0, 164.0], "value": 162.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 67.0, 77.0, 79.0, 77.0, 75.0, 62.0, 63.0], "value": 69.2, "unit": "score"}]}]} 20:16:08 INFO - Return code: 0 20:16:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:16:08 INFO - # TBPL SUCCESS # 20:16:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:16:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:16:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:16:08 INFO - 2017-06-04 20:16:08.712 screenresolution[1652:9837] starting screenresolution argv=screenresolution get 20:16:08 INFO - 2017-06-04 20:16:08.715 screenresolution[1652:9837] Display 0: 1600x1200x32@60 20:16:08 INFO - 2017-06-04 20:16:08.721 screenresolution[1653:9840] starting screenresolution argv=screenresolution list 20:16:08 INFO - Available Modes on Display 0 20:16:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:16:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:16:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:16:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:16:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:16:08 INFO - Intel Iris: 20:16:08 INFO - Chipset Model: Intel Iris 20:16:08 INFO - Type: GPU 20:16:08 INFO - Bus: Built-In 20:16:08 INFO - VRAM (Dynamic, Max): 1536 MB 20:16:08 INFO - Vendor: Intel (0x8086) 20:16:08 INFO - Device ID: 0x0a2e 20:16:08 INFO - Revision ID: 0x0009 20:16:08 INFO - Displays: 20:16:08 INFO - Display: 20:16:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:16:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:16:08 INFO - Display Serial Number: 1600x1200 60 20:16:08 INFO - Main Display: Yes 20:16:08 INFO - Mirror: Off 20:16:08 INFO - Online: Yes 20:16:08 INFO - Rotation: Supported 20:16:08 INFO - Return code: 0 20:16:08 INFO - Running post-action listener: _resource_record_post_action 20:16:08 INFO - [mozharness: 2017-06-05 03:16:08.965682Z] Finished run-tests step (success) 20:16:08 INFO - Running post-run listener: _resource_record_post_run 20:16:09 INFO - Total resource usage - Wall time: 1194s; CPU: 54.0%; Read bytes: 40682496; Write bytes: 423502848; Read time: 394; Write time: 1459 20:16:09 INFO - TinderboxPrint: CPU usage
53.9% 20:16:09 INFO - TinderboxPrint: I/O read bytes / time
40,682,496 / 394 20:16:09 INFO - TinderboxPrint: I/O write bytes / time
423,502,848 / 1,459 20:16:09 INFO - TinderboxPrint: CPU idle
2,201.5 (46.1%) 20:16:09 INFO - TinderboxPrint: CPU system
955.3 (20.0%) 20:16:09 INFO - TinderboxPrint: CPU user
1,620.9 (33.9%) 20:16:09 INFO - TinderboxPrint: Swap in / out
161,837,056 / 0 20:16:09 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 864256; Write bytes: 123052032; Read time: 13; Write time: 274 20:16:09 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 34817024; Write bytes: 296991744; Read time: 352; Write time: 1139 20:16:09 INFO - Running post-run listener: _upload_blobber_files 20:16:09 INFO - Blob upload gear active. 20:16:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:16:09 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 20:16:09 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'] 20:16:09 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 20:16:09 INFO - (blobuploader) - INFO - Open directory for files ... 20:16:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:16:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:16:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:16:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:16:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:16:10 INFO - (blobuploader) - INFO - Done attempting. 20:16:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:16:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:16:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:16:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:16:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:16:11 INFO - (blobuploader) - INFO - Done attempting. 20:16:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:16:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:16:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:16:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:16:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:16:12 INFO - (blobuploader) - INFO - Done attempting. 20:16:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:16:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:16:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:16:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:16:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:16:14 INFO - (blobuploader) - INFO - Done attempting. 20:16:14 INFO - (blobuploader) - INFO - Iteration through files over. 20:16:14 INFO - Return code: 0 20:16:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:16:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:16:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d7634b18295dbfa0088aaa143e05d11f06343e0318335097cdd7a3a7de87bcc2f312a20644509d7831d911312a8a04dcb71d044a7545fef89c923392537c2c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c544dbe28037b245634b568bcf0b5ac7d9378348117d09a72a4872a308430aef10fee542640683bfd9abe08f89c5674ecfa863f341ea3ee40554ab79b10f1be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a0f0477de6dec6fcbbd15f620b5135dbdd8c50e6f6f5cfee9bfda5e84eebe1c3da02b374606bfb1fa5c08f2900586ce5b5dc7a201dd969d5301b395ad844d29e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5680f39a886023a42284fff854c80db4c6254179aeadb6f7aefe32ed1a420235f11906e63f7d9ad98355d5865ed13e92c264fb7c27c9dd361f9e3c2e51fd110a"} 20:16:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:16:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:16:14 INFO - Contents: 20:16:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d7634b18295dbfa0088aaa143e05d11f06343e0318335097cdd7a3a7de87bcc2f312a20644509d7831d911312a8a04dcb71d044a7545fef89c923392537c2c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c544dbe28037b245634b568bcf0b5ac7d9378348117d09a72a4872a308430aef10fee542640683bfd9abe08f89c5674ecfa863f341ea3ee40554ab79b10f1be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a0f0477de6dec6fcbbd15f620b5135dbdd8c50e6f6f5cfee9bfda5e84eebe1c3da02b374606bfb1fa5c08f2900586ce5b5dc7a201dd969d5301b395ad844d29e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5680f39a886023a42284fff854c80db4c6254179aeadb6f7aefe32ed1a420235f11906e63f7d9ad98355d5865ed13e92c264fb7c27c9dd361f9e3c2e51fd110a"} 20:16:14 INFO - Running post-run listener: copy_logs_to_upload_dir 20:16:14 INFO - Copying logs to upload dir... 20:16:14 INFO - mkdir: /builds/slave/test/build/upload/logs 20:16:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.529645 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-06-04 20:16:14.603011) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-04 20:16:14.606970) ========= 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.dVpeJPBT2G/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.c94wsBdgT3/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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/9d7634b18295dbfa0088aaa143e05d11f06343e0318335097cdd7a3a7de87bcc2f312a20644509d7831d911312a8a04dcb71d044a7545fef89c923392537c2c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c544dbe28037b245634b568bcf0b5ac7d9378348117d09a72a4872a308430aef10fee542640683bfd9abe08f89c5674ecfa863f341ea3ee40554ab79b10f1be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a0f0477de6dec6fcbbd15f620b5135dbdd8c50e6f6f5cfee9bfda5e84eebe1c3da02b374606bfb1fa5c08f2900586ce5b5dc7a201dd969d5301b395ad844d29e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5680f39a886023a42284fff854c80db4c6254179aeadb6f7aefe32ed1a420235f11906e63f7d9ad98355d5865ed13e92c264fb7c27c9dd361f9e3c2e51fd110a"} build_url:https://queue.taskcluster.net/v1/task/YmubvILwTymedS21mpWXwA/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009923 build_url: 'https://queue.taskcluster.net/v1/task/YmubvILwTymedS21mpWXwA/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/9d7634b18295dbfa0088aaa143e05d11f06343e0318335097cdd7a3a7de87bcc2f312a20644509d7831d911312a8a04dcb71d044a7545fef89c923392537c2c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c544dbe28037b245634b568bcf0b5ac7d9378348117d09a72a4872a308430aef10fee542640683bfd9abe08f89c5674ecfa863f341ea3ee40554ab79b10f1be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a0f0477de6dec6fcbbd15f620b5135dbdd8c50e6f6f5cfee9bfda5e84eebe1c3da02b374606bfb1fa5c08f2900586ce5b5dc7a201dd969d5301b395ad844d29e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5680f39a886023a42284fff854c80db4c6254179aeadb6f7aefe32ed1a420235f11906e63f7d9ad98355d5865ed13e92c264fb7c27c9dd361f9e3c2e51fd110a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-04 20:16:14.637208) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-04 20:16:14.637495) ========= 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.dVpeJPBT2G/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.c94wsBdgT3/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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.004917 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-04 20:16:14.685330) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-04 20:16:14.685655) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-04 20:16:14.685993) ========= ========= Total master_lag: 0.19 =========