builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0285 starttime: 1495824989.78 results: success (0) buildid: 20170526101616 builduid: 4ca1ed669ad24a59a147e7442a3e4d2f revision: 9664d83f5c056a32a3cc29de9d5934b82809dbfd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-26 11:56:29.785236) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-26 11:56:29.785708) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-26 11:56:29.786009) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-26 11:56:29.810068) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 11:56:29.810497) ========= 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.PBstSXiGnD/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.PfmMset1f7/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-05-26 11:56:29-- 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% 53.3M=0s 2017-05-26 11:56:29 (53.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.100322 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 11:56:29.934200) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 11:56:29.934568) ========= 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.PBstSXiGnD/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.PfmMset1f7/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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.023515 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 11:56:29.983962) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-26 11:56:29.984339) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9664d83f5c056a32a3cc29de9d5934b82809dbfd --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 9664d83f5c056a32a3cc29de9d5934b82809dbfd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PBstSXiGnD/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.PfmMset1f7/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-05-26 11:56:30,069 truncating revision to first 12 chars 2017-05-26 11:56:30,069 Setting DEBUG logging. 2017-05-26 11:56:30,069 attempt 1/10 2017-05-26 11:56:30,069 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/9664d83f5c05?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-26 11:56:31,276 unpacking tar archive at: mozilla-beta-9664d83f5c05/testing/mozharness/ program finished with exit code 0 elapsedTime=1.472109 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-26 11:56:31.479599) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-26 11:56:31.479941) ========= script_repo_revision: 9664d83f5c056a32a3cc29de9d5934b82809dbfd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-26 11:56:31.480323) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-26 11:56:31.480590) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-26 11:56:31.499262) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-05-26 11:56:31.499649) ========= /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.PBstSXiGnD/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.PfmMset1f7/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 11:56:31 INFO - MultiFileLogger online at 20170526 11:56:31 in /builds/slave/test 11:56:31 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 11:56:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:56:31 INFO - {'append_to_log': False, 11:56:31 INFO - 'base_work_dir': '/builds/slave/test', 11:56:31 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:56:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:56:31 INFO - 'branch': 'Mozilla-Beta', 11:56:31 INFO - 'buildbot_json_path': 'buildprops.json', 11:56:31 INFO - 'config_files': ('talos/mac_config.py',), 11:56:31 INFO - 'default_actions': ('clobber', 11:56:31 INFO - 'read-buildbot-config', 11:56:31 INFO - 'download-and-extract', 11:56:31 INFO - 'populate-webroot', 11:56:31 INFO - 'create-virtualenv', 11:56:31 INFO - 'install', 11:56:31 INFO - 'run-tests'), 11:56:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:56:31 INFO - 'download_minidump_stackwalk': True, 11:56:31 INFO - 'download_symbols': 'ondemand', 11:56:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:56:31 INFO - 'tooltool.py': '/tools/tooltool.py', 11:56:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:56:31 INFO - '/tools/misc-python/virtualenv.py')}, 11:56:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:56:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:56:31 INFO - 'gecko_profile': False, 11:56:31 INFO - 'gecko_profile_interval': 0, 11:56:31 INFO - 'installer_path': 'installer.exe', 11:56:31 INFO - 'log_level': 'info', 11:56:31 INFO - 'log_name': 'talos', 11:56:31 INFO - 'log_to_console': True, 11:56:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:56:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:56:31 INFO - 'opt_config_files': (), 11:56:31 INFO - 'pip_index': False, 11:56:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:56:31 INFO - 'cmd': ('bash', 11:56:31 INFO - '-c', 11:56:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:56:31 INFO - 'enabled': True, 11:56:31 INFO - 'halt_on_failure': False, 11:56:31 INFO - 'name': 'check_screen_resolution'},), 11:56:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:56:31 INFO - 'cmd': ('bash', 11:56:31 INFO - '-c', 11:56:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:56:31 INFO - 'enabled': True, 11:56:31 INFO - 'halt_on_failure': False, 11:56:31 INFO - 'name': 'check_screen_resolution'},), 11:56:31 INFO - 'run_cmd_checks_enabled': True, 11:56:31 INFO - 'suite': 'dromaeojs', 11:56:31 INFO - 'system_bits': '32', 11:56:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:56:31 INFO - 'title': 't-yosemite-r7-0285', 11:56:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:56:31 INFO - 'use_talos_json': True, 11:56:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:56:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:56:31 INFO - 'work_dir': 'build'} 11:56:31 INFO - [mozharness: 2017-05-26 18:56:31.702566Z] Running clobber step. 11:56:31 INFO - Running pre-action listener: _resource_record_pre_action 11:56:31 INFO - Running main action method: clobber 11:56:31 INFO - rmtree: /builds/slave/test/build 11:56:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:56:32 INFO - Running post-action listener: _resource_record_post_action 11:56:32 INFO - [mozharness: 2017-05-26 18:56:32.056218Z] Finished clobber step (success) 11:56:32 INFO - [mozharness: 2017-05-26 18:56:32.056396Z] Running read-buildbot-config step. 11:56:32 INFO - Running pre-action listener: _resource_record_pre_action 11:56:32 INFO - Running main action method: read_buildbot_config 11:56:32 INFO - Using buildbot properties: 11:56:32 INFO - { 11:56:32 INFO - "project": "", 11:56:32 INFO - "product": "firefox", 11:56:32 INFO - "script_repo_revision": "production", 11:56:32 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 11:56:32 INFO - "repository": "", 11:56:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 11:56:32 INFO - "buildid": "20170526101616", 11:56:32 INFO - "pgo_build": "False", 11:56:32 INFO - "basedir": "/builds/slave/test", 11:56:32 INFO - "buildnumber": 17, 11:56:32 INFO - "slavename": "t-yosemite-r7-0285", 11:56:32 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 11:56:32 INFO - "platform": "yosemite_r7", 11:56:32 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:56:32 INFO - "branch": "mozilla-beta", 11:56:32 INFO - "repo_path": "releases/mozilla-beta", 11:56:32 INFO - "revision": "9664d83f5c056a32a3cc29de9d5934b82809dbfd", 11:56:32 INFO - "stage_platform": "macosx64", 11:56:32 INFO - "builduid": "4ca1ed669ad24a59a147e7442a3e4d2f", 11:56:32 INFO - "slavebuilddir": "test" 11:56:32 INFO - } 11:56:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/XazcW0iSTz2e7eUi5pYyWA/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 11:56:32 INFO - Running post-action listener: _resource_record_post_action 11:56:32 INFO - [mozharness: 2017-05-26 18:56:32.059899Z] Finished read-buildbot-config step (success) 11:56:32 INFO - [mozharness: 2017-05-26 18:56:32.060021Z] Running download-and-extract step. 11:56:32 INFO - Running pre-action listener: _resource_record_pre_action 11:56:32 INFO - Running main action method: download_and_extract 11:56:32 INFO - mkdir: /builds/slave/test/build/tests 11:56:32 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')]} 11:56:32 INFO - trying https://queue.taskcluster.net/v1/task/XazcW0iSTz2e7eUi5pYyWA/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 11:56:32 INFO - Downloading https://queue.taskcluster.net/v1/task/XazcW0iSTz2e7eUi5pYyWA/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 11:56:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XazcW0iSTz2e7eUi5pYyWA/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 11:56:33 INFO - Downloaded 1287 bytes. 11:56:33 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 11:56:33 INFO - Using the following test package requirements: 11:56:33 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:56:33 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 11:56:33 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 11:56:33 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:56:33 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 11:56:33 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:56:33 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 11:56:33 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:56:33 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:56:33 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 11:56:33 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 11:56:33 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:56:33 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 11:56:33 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:56:33 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 11:56:33 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:56:33 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 11:56:33 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:56:33 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 11:56:33 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 11:56:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XazcW0iSTz2e7eUi5pYyWA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 11:56:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XazcW0iSTz2e7eUi5pYyWA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 11:56:33 INFO - Fetch https://queue.taskcluster.net/v1/task/XazcW0iSTz2e7eUi5pYyWA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 11:56:34 INFO - Expected file size: 51393590 11:56:34 INFO - Obtained file size: 51393590 11:56:50 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 11:56:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XazcW0iSTz2e7eUi5pYyWA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 11:56:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XazcW0iSTz2e7eUi5pYyWA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 11:56:50 INFO - Fetch https://queue.taskcluster.net/v1/task/XazcW0iSTz2e7eUi5pYyWA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 11:56:52 INFO - Expected file size: 51393590 11:56:52 INFO - Obtained file size: 51393590 11:57:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XazcW0iSTz2e7eUi5pYyWA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 11:57:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XazcW0iSTz2e7eUi5pYyWA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 11:57:07 INFO - Fetch https://queue.taskcluster.net/v1/task/XazcW0iSTz2e7eUi5pYyWA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 11:57:08 INFO - Expected file size: 14404449 11:57:08 INFO - Obtained file size: 14404449 11:57: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')]} 11:57:09 INFO - trying https://queue.taskcluster.net/v1/task/XazcW0iSTz2e7eUi5pYyWA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 11:57:09 INFO - Downloading https://queue.taskcluster.net/v1/task/XazcW0iSTz2e7eUi5pYyWA/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 11:57:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XazcW0iSTz2e7eUi5pYyWA/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 11:57:10 INFO - Downloaded 59647559 bytes. 11:57:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XazcW0iSTz2e7eUi5pYyWA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 11:57:10 INFO - mkdir: /builds/slave/test/properties 11:57:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:57:10 INFO - Writing to file /builds/slave/test/properties/build_url 11:57:10 INFO - Contents: 11:57:10 INFO - build_url:https://queue.taskcluster.net/v1/task/XazcW0iSTz2e7eUi5pYyWA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 11:57:11 INFO - Running post-action listener: _resource_record_post_action 11:57:11 INFO - Running post-action listener: set_extra_try_arguments 11:57:11 INFO - [mozharness: 2017-05-26 18:57:11.468922Z] Finished download-and-extract step (success) 11:57:11 INFO - [mozharness: 2017-05-26 18:57:11.469049Z] Running populate-webroot step. 11:57:11 INFO - Running pre-action listener: _resource_record_pre_action 11:57:11 INFO - Running main action method: populate_webroot 11:57:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:57:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:57:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:57:11 INFO - '--tppagecycles', 11:57:11 INFO - '7'], 11:57:11 INFO - 'tests': ['tsvgm']}}, 11:57:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:57:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:57:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:57:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:57:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:57:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:57:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:57:11 INFO - 'talos_options': ['--disable-e10s'], 11:57:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:57:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:57:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:57:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:57:11 INFO - 'talos_options': ['--disable-e10s'], 11:57:11 INFO - 'tests': ['damp', 'tps']}, 11:57:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:57:11 INFO - 'tests': ['damp', 'tps']}, 11:57:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:57:11 INFO - 'tests': ['dromaeo_dom']}, 11:57:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:57:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:57:11 INFO - 'tests': ['basic_compositor_video']}, 11:57:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:57:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:57:11 INFO - 'tests': ['a11yr', 11:57:11 INFO - 'ts_paint', 11:57:11 INFO - 'tpaint', 11:57:11 INFO - 'sessionrestore', 11:57:11 INFO - 'sessionrestore_no_auto_restore', 11:57:11 INFO - 'tabpaint']}, 11:57:11 INFO - 'other-e10s': {'tests': ['a11yr', 11:57:11 INFO - 'ts_paint', 11:57:11 INFO - 'tpaint', 11:57:11 INFO - 'sessionrestore', 11:57:11 INFO - 'sessionrestore_no_auto_restore', 11:57:11 INFO - 'tabpaint']}, 11:57:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:57:11 INFO - 'ts_paint', 11:57:11 INFO - 'tpaint', 11:57:11 INFO - 'sessionrestore', 11:57:11 INFO - 'sessionrestore_no_auto_restore', 11:57:11 INFO - 'tabpaint']}, 11:57:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:57:11 INFO - 'ts_paint', 11:57:11 INFO - 'tpaint', 11:57:11 INFO - 'sessionrestore', 11:57:11 INFO - 'sessionrestore_no_auto_restore', 11:57:11 INFO - 'tabpaint']}, 11:57:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:57:11 INFO - 'tests': ['a11yr', 11:57:11 INFO - 'ts_paint', 11:57:11 INFO - 'tpaint', 11:57:11 INFO - 'sessionrestore', 11:57:11 INFO - 'sessionrestore_no_auto_restore', 11:57:11 INFO - 'tabpaint']}, 11:57:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:57:11 INFO - 'tests': ['a11yr', 11:57:11 INFO - 'ts_paint', 11:57:11 INFO - 'tpaint', 11:57:11 INFO - 'sessionrestore', 11:57:11 INFO - 'sessionrestore_no_auto_restore', 11:57:11 INFO - 'tabpaint']}, 11:57:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:57:11 INFO - 'tests': ['tsvgx', 11:57:11 INFO - 'tsvgr_opacity', 11:57:11 INFO - 'tart', 11:57:11 INFO - 'tscrollx', 11:57:11 INFO - 'cart', 11:57:11 INFO - 'tsvg_static']}, 11:57:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:57:11 INFO - 'tsvgr_opacity', 11:57:11 INFO - 'tart', 11:57:11 INFO - 'tscrollx', 11:57:11 INFO - 'cart', 11:57:11 INFO - 'tsvg_static']}, 11:57:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:57:11 INFO - 'talos_options': ['--disable-e10s'], 11:57:11 INFO - 'tests': ['tp5o']}, 11:57:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:57:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:57:11 INFO - 'talos_options': ['--disable-e10s', 11:57:11 INFO - '--xperf_path', 11:57:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:57:11 INFO - 'tests': ['tp5n']}, 11:57:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:57:11 INFO - 'talos_options': ['--xperf_path', 11:57:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:57:11 INFO - 'tests': ['tp5n']}}, 11:57:11 INFO - 'talos.zip': {'path': '', 11:57:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:57:11 INFO - Running post-action listener: _resource_record_post_action 11:57:11 INFO - [mozharness: 2017-05-26 18:57:11.487512Z] Finished populate-webroot step (success) 11:57:11 INFO - [mozharness: 2017-05-26 18:57:11.487642Z] Running create-virtualenv step. 11:57:11 INFO - Running pre-action listener: _resource_record_pre_action 11:57:11 INFO - Running main action method: create_virtualenv 11:57:11 INFO - Creating virtualenv /builds/slave/test/build/venv 11:57:11 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 11:57:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:57:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:57:11 INFO - Using real prefix '/tools/python27' 11:57:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:57:12 INFO - Installing distribute.............................................................................................................................................................................................done. 11:57:15 INFO - Installing pip.................done. 11:57:15 INFO - Return code: 0 11:57:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:57:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:57:15 INFO - Reading from file tmpfile_stdout 11:57:15 INFO - Output received: 11:57:15 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) 11:57:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:57:15 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')]} 11:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:15 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')]} 11:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:15 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 0x101994b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101997768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f858b49fcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101772d30>, '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 0x101699db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101767be8>, '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.PBstSXiGnD/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.PfmMset1f7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 11:57:15 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 11:57:15 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 11:57:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PBstSXiGnD/Render', 11:57:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:15 INFO - 'HOME': '/Users/cltbld', 11:57:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:15 INFO - 'LOGNAME': 'cltbld', 11:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:15 INFO - 'MOZ_NO_REMOTE': '1', 11:57:15 INFO - 'NO_EM_RESTART': '1', 11:57:15 INFO - 'PAGER': '/bin/cat', 11:57:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:15 INFO - 'PWD': '/builds/slave/test', 11:57:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:15 INFO - 'SHELL': '/bin/bash', 11:57:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PfmMset1f7/Listeners', 11:57:15 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 11:57:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:15 INFO - 'USER': 'cltbld', 11:57:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:15 INFO - 'XPC_FLAGS': '0x0', 11:57:15 INFO - 'XPC_SERVICE_NAME': '0', 11:57:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:15 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 11:57:15 INFO - Cleaning up... 11:57:15 INFO - Return code: 0 11:57:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:57:15 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')]} 11:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:15 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')]} 11:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:15 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 0x101994b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101997768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f858b49fcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101772d30>, '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 0x101699db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101767be8>, '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.PBstSXiGnD/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.PfmMset1f7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 11:57:15 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 11:57:15 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 11:57:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PBstSXiGnD/Render', 11:57:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:15 INFO - 'HOME': '/Users/cltbld', 11:57:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:15 INFO - 'LOGNAME': 'cltbld', 11:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:15 INFO - 'MOZ_NO_REMOTE': '1', 11:57:15 INFO - 'NO_EM_RESTART': '1', 11:57:15 INFO - 'PAGER': '/bin/cat', 11:57:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:15 INFO - 'PWD': '/builds/slave/test', 11:57:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:15 INFO - 'SHELL': '/bin/bash', 11:57:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PfmMset1f7/Listeners', 11:57:15 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 11:57:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:15 INFO - 'USER': 'cltbld', 11:57:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:15 INFO - 'XPC_FLAGS': '0x0', 11:57:15 INFO - 'XPC_SERVICE_NAME': '0', 11:57:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:16 INFO - Downloading/unpacking psutil>=3.1.1 11:57:16 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 11:57:16 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 11:57:16 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 11:57:16 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 11:57:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:57:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:57:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:57:18 INFO - Installing collected packages: psutil 11:57:18 INFO - Running setup.py install for psutil 11:57:18 INFO - building 'psutil._psutil_osx' extension 11:57:18 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 11:57:18 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 11:57:18 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 11:57:18 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 11:57:18 INFO - building 'psutil._psutil_posix' extension 11:57:18 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 11:57:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:57:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:57:18 INFO - ^ 11:57:18 INFO - 1 warning generated. 11:57:18 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 11:57:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:57:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:57:18 INFO - Successfully installed psutil 11:57:18 INFO - Cleaning up... 11:57:18 INFO - Return code: 0 11:57:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:57:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101994b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101997768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f858b49fcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101772d30>, '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 0x101699db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101767be8>, '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.PBstSXiGnD/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.PfmMset1f7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 11:57:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:57:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:57:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PBstSXiGnD/Render', 11:57:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:18 INFO - 'HOME': '/Users/cltbld', 11:57:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:18 INFO - 'LOGNAME': 'cltbld', 11:57:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:18 INFO - 'MOZ_NO_REMOTE': '1', 11:57:18 INFO - 'NO_EM_RESTART': '1', 11:57:18 INFO - 'PAGER': '/bin/cat', 11:57:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:18 INFO - 'PWD': '/builds/slave/test', 11:57:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:18 INFO - 'SHELL': '/bin/bash', 11:57:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PfmMset1f7/Listeners', 11:57:18 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 11:57:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:18 INFO - 'USER': 'cltbld', 11:57:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:18 INFO - 'XPC_FLAGS': '0x0', 11:57:18 INFO - 'XPC_SERVICE_NAME': '0', 11:57:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:57:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:57:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:57:20 INFO - Installing collected packages: mozsystemmonitor 11:57:20 INFO - Running setup.py install for mozsystemmonitor 11:57:20 INFO - Successfully installed mozsystemmonitor 11:57:20 INFO - Cleaning up... 11:57:20 INFO - Return code: 0 11:57:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:57:20 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')]} 11:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:20 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')]} 11:57:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:20 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 0x101994b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101997768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f858b49fcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101772d30>, '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 0x101699db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101767be8>, '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.PBstSXiGnD/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.PfmMset1f7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 11:57:20 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 11:57:20 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 11:57:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PBstSXiGnD/Render', 11:57:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:20 INFO - 'HOME': '/Users/cltbld', 11:57:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:20 INFO - 'LOGNAME': 'cltbld', 11:57:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:20 INFO - 'MOZ_NO_REMOTE': '1', 11:57:20 INFO - 'NO_EM_RESTART': '1', 11:57:20 INFO - 'PAGER': '/bin/cat', 11:57:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:20 INFO - 'PWD': '/builds/slave/test', 11:57:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:20 INFO - 'SHELL': '/bin/bash', 11:57:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PfmMset1f7/Listeners', 11:57:20 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 11:57:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:20 INFO - 'USER': 'cltbld', 11:57:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:20 INFO - 'XPC_FLAGS': '0x0', 11:57:20 INFO - 'XPC_SERVICE_NAME': '0', 11:57:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:21 INFO - Downloading/unpacking jsonschema==2.5.1 11:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:57:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:57:22 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 11:57:22 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 11:57:22 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 11:57:22 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 11:57:22 INFO - Downloading functools32-3.2.3-2.tar.gz 11:57:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:57:22 INFO - warning: no files found matching '*.txt' 11:57:22 INFO - no previously-included directories found matching 'build' 11:57:22 INFO - no previously-included directories found matching 'dist' 11:57:22 INFO - no previously-included directories found matching '.git*' 11:57:22 INFO - Installing collected packages: jsonschema, functools32 11:57:23 INFO - Running setup.py install for functools32 11:57:23 INFO - warning: no files found matching '*.txt' 11:57:23 INFO - no previously-included directories found matching 'build' 11:57:23 INFO - no previously-included directories found matching 'dist' 11:57:23 INFO - no previously-included directories found matching '.git*' 11:57:23 INFO - Successfully installed jsonschema functools32 11:57:23 INFO - Cleaning up... 11:57:23 INFO - Return code: 0 11:57:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:57:23 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')]} 11:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:23 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')]} 11:57:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:23 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 0x101994b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101997768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f858b49fcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101772d30>, '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 0x101699db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101767be8>, '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.PBstSXiGnD/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.PfmMset1f7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 11:57:23 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 11:57:23 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 11:57:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PBstSXiGnD/Render', 11:57:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:23 INFO - 'HOME': '/Users/cltbld', 11:57:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:23 INFO - 'LOGNAME': 'cltbld', 11:57:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:23 INFO - 'MOZ_NO_REMOTE': '1', 11:57:23 INFO - 'NO_EM_RESTART': '1', 11:57:23 INFO - 'PAGER': '/bin/cat', 11:57:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:23 INFO - 'PWD': '/builds/slave/test', 11:57:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:23 INFO - 'SHELL': '/bin/bash', 11:57:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PfmMset1f7/Listeners', 11:57:23 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 11:57:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:23 INFO - 'USER': 'cltbld', 11:57:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:23 INFO - 'XPC_FLAGS': '0x0', 11:57:23 INFO - 'XPC_SERVICE_NAME': '0', 11:57:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:57:23 INFO - Cleaning up... 11:57:23 INFO - Return code: 0 11:57:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:57:23 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')]} 11:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:23 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')]} 11:57:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:23 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 0x101994b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101997768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f858b49fcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101772d30>, '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 0x101699db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101767be8>, '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.PBstSXiGnD/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.PfmMset1f7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 11:57:23 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 11:57:23 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 11:57:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PBstSXiGnD/Render', 11:57:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:23 INFO - 'HOME': '/Users/cltbld', 11:57:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:23 INFO - 'LOGNAME': 'cltbld', 11:57:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:23 INFO - 'MOZ_NO_REMOTE': '1', 11:57:23 INFO - 'NO_EM_RESTART': '1', 11:57:23 INFO - 'PAGER': '/bin/cat', 11:57:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:23 INFO - 'PWD': '/builds/slave/test', 11:57:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:23 INFO - 'SHELL': '/bin/bash', 11:57:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PfmMset1f7/Listeners', 11:57:23 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 11:57:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:23 INFO - 'USER': 'cltbld', 11:57:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:23 INFO - 'XPC_FLAGS': '0x0', 11:57:23 INFO - 'XPC_SERVICE_NAME': '0', 11:57:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:23 INFO - Downloading/unpacking blobuploader==1.2.4 11:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:25 INFO - Downloading blobuploader-1.2.4.tar.gz 11:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:57:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:57:25 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 11:57:25 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 11:57:25 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 11:57:25 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 11:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:57:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:57:25 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 11:57:25 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 11:57:25 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 11:57:25 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 11:57:25 INFO - Downloading docopt-0.6.1.tar.gz 11:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:57:26 INFO - Installing collected packages: blobuploader, requests, docopt 11:57:26 INFO - Running setup.py install for blobuploader 11:57:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:57:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:57:26 INFO - Running setup.py install for requests 11:57:26 INFO - Running setup.py install for docopt 11:57:26 INFO - Successfully installed blobuploader requests docopt 11:57:26 INFO - Cleaning up... 11:57:26 INFO - Return code: 0 11:57:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:27 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 0x101994b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101997768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f858b49fcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101772d30>, '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 0x101699db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101767be8>, '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.PBstSXiGnD/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.PfmMset1f7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 11:57:27 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 11:57:27 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 11:57:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PBstSXiGnD/Render', 11:57:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:27 INFO - 'HOME': '/Users/cltbld', 11:57:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:27 INFO - 'LOGNAME': 'cltbld', 11:57:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:27 INFO - 'MOZ_NO_REMOTE': '1', 11:57:27 INFO - 'NO_EM_RESTART': '1', 11:57:27 INFO - 'PAGER': '/bin/cat', 11:57:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:27 INFO - 'PWD': '/builds/slave/test', 11:57:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:27 INFO - 'SHELL': '/bin/bash', 11:57:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PfmMset1f7/Listeners', 11:57:27 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 11:57:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:27 INFO - 'USER': 'cltbld', 11:57:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:27 INFO - 'XPC_FLAGS': '0x0', 11:57:27 INFO - 'XPC_SERVICE_NAME': '0', 11:57:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:57:28 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-Sl4gTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:57:28 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-1mdach-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:57:28 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-hESDqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:57:28 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-NdISoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:57:28 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-4dJqZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:57:28 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-AnJKo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:57:28 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-e7yV1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:57:28 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-xTE4h8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:57:28 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-bpJf3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:57:28 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-5vSDtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:57:29 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-hxpWGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:57:29 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-5p6aDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:57:29 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-wwFFVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:57:29 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-yNqTdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:57:29 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-cz_52m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:57:29 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-Kzoa9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:57:29 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-AZaRTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:57:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:57:29 INFO - Running setup.py install for manifestparser 11:57:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:57:29 INFO - Running setup.py install for mozcrash 11:57:30 INFO - Running setup.py install for mozdebug 11:57:30 INFO - Running setup.py install for mozdevice 11:57:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:57:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:57:30 INFO - Running setup.py install for mozfile 11:57:30 INFO - Running setup.py install for mozhttpd 11:57:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:57:30 INFO - Running setup.py install for mozinfo 11:57:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:57:30 INFO - Running setup.py install for mozInstall 11:57:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:57:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:57:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:57:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:57:31 INFO - Running setup.py install for mozleak 11:57:31 INFO - Running setup.py install for mozlog 11:57:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:57:31 INFO - Running setup.py install for moznetwork 11:57:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:57:31 INFO - Running setup.py install for mozprocess 11:57:31 INFO - Running setup.py install for mozprofile 11:57:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:57:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:57:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:57:31 INFO - Running setup.py install for mozrunner 11:57:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:57:31 INFO - Running setup.py install for mozscreenshot 11:57:32 INFO - Running setup.py install for moztest 11:57:32 INFO - Running setup.py install for mozversion 11:57:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:57:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:57:32 INFO - Cleaning up... 11:57:32 INFO - Return code: 0 11:57:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:57:32 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')]} 11:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:32 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')]} 11:57:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:32 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 0x101994b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101997768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f858b49fcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101772d30>, '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 0x101699db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101767be8>, '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.PBstSXiGnD/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.PfmMset1f7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 11:57:32 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 11:57:32 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 11:57:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PBstSXiGnD/Render', 11:57:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:32 INFO - 'HOME': '/Users/cltbld', 11:57:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:32 INFO - 'LOGNAME': 'cltbld', 11:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:32 INFO - 'MOZ_NO_REMOTE': '1', 11:57:32 INFO - 'NO_EM_RESTART': '1', 11:57:32 INFO - 'PAGER': '/bin/cat', 11:57:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:32 INFO - 'PWD': '/builds/slave/test', 11:57:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:32 INFO - 'SHELL': '/bin/bash', 11:57:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PfmMset1f7/Listeners', 11:57:32 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 11:57:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:32 INFO - 'USER': 'cltbld', 11:57:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:32 INFO - 'XPC_FLAGS': '0x0', 11:57:32 INFO - 'XPC_SERVICE_NAME': '0', 11:57:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:57:33 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-8ZMT3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:57:33 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)) 11:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:57:33 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-NcY7tY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:57:33 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)) 11:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:57:33 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-axCUX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:57:33 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)) 11:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:57:33 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-9g63cM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:57:33 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)) 11:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:57:33 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-k9PUeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:57:33 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)) 11:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:57:33 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-LTwKck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:57:33 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)) 11:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:57:33 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-v287yG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:57:33 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)) 11:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:57:33 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-kMQR_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:57:34 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)) 11:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:57:34 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-cDIRB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:57:34 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)) 11:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:57:34 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-xP8ZFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:57:34 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)) 11:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:57:34 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-_1m0Qe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:57:34 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)) 11:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:57:34 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-11cXJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:57:34 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)) 11:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:57:34 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-FimE8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:57:34 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)) 11:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:57:34 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-tNLuFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:57:34 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)) 11:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:57:34 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-L0tHTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:57:34 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)) 11:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:57:34 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-apL4Ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:57:34 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)) 11:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:57:34 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-TrWisL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:57:35 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)) 11:57:35 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)) 11:57:35 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)) 11:57:35 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)) 11:57:35 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)) 11:57:35 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)) 11:57:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:57:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:36 INFO - Downloading blessings-1.6.tar.gz 11:57:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:57:37 INFO - Installing collected packages: blessings 11:57:37 INFO - Running setup.py install for blessings 11:57:37 INFO - Successfully installed blessings 11:57:37 INFO - Cleaning up... 11:57:37 INFO - Return code: 0 11:57:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:57:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:57:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:57:37 INFO - Reading from file tmpfile_stdout 11:57:37 INFO - Current package versions: 11:57:37 INFO - blessings == 1.6 11:57:37 INFO - blobuploader == 1.2.4 11:57:37 INFO - docopt == 0.6.1 11:57:37 INFO - functools32 == 3.2.3-2 11:57:37 INFO - jsonschema == 2.5.1 11:57:37 INFO - manifestparser == 1.1 11:57:37 INFO - mozInstall == 1.12 11:57:37 INFO - mozcrash == 1.0 11:57:37 INFO - mozdebug == 0.1 11:57:37 INFO - mozdevice == 0.49 11:57:37 INFO - mozfile == 1.2 11:57:37 INFO - mozhttpd == 0.7 11:57:37 INFO - mozinfo == 0.9 11:57:37 INFO - mozleak == 0.1 11:57:37 INFO - mozlog == 3.4 11:57:37 INFO - moznetwork == 0.27 11:57:37 INFO - mozprocess == 0.25 11:57:37 INFO - mozprofile == 0.28 11:57:37 INFO - mozrunner == 6.13 11:57:37 INFO - mozscreenshot == 0.1 11:57:37 INFO - mozsystemmonitor == 0.3 11:57:37 INFO - moztest == 0.8 11:57:37 INFO - mozversion == 1.4 11:57:37 INFO - psutil == 3.1.1 11:57:37 INFO - requests == 1.2.3 11:57:37 INFO - wsgiref == 0.1.2 11:57:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:57:37 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')]} 11:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:37 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')]} 11:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:37 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 0x101994b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101997768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f858b49fcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101772d30>, '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 0x101699db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101767be8>, '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.PBstSXiGnD/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.PfmMset1f7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 11:57:37 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 11:57:37 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 11:57:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PBstSXiGnD/Render', 11:57:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:37 INFO - 'HOME': '/Users/cltbld', 11:57:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:37 INFO - 'LOGNAME': 'cltbld', 11:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:37 INFO - 'MOZ_NO_REMOTE': '1', 11:57:37 INFO - 'NO_EM_RESTART': '1', 11:57:37 INFO - 'PAGER': '/bin/cat', 11:57:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:37 INFO - 'PWD': '/builds/slave/test', 11:57:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:37 INFO - 'SHELL': '/bin/bash', 11:57:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PfmMset1f7/Listeners', 11:57:37 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 11:57:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:37 INFO - 'USER': 'cltbld', 11:57:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:37 INFO - 'XPC_FLAGS': '0x0', 11:57:37 INFO - 'XPC_SERVICE_NAME': '0', 11:57:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:37 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)) 11:57:37 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)) 11:57:37 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)) 11:57:37 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)) 11:57:37 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)) 11:57:37 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)) 11:57:37 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)) 11:57:37 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)) 11:57:37 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)) 11:57:37 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)) 11:57:37 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)) 11:57:37 INFO - Cleaning up... 11:57:37 INFO - Return code: 0 11:57:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:57:37 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')]} 11:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:37 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')]} 11:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:37 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 0x101994b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101997768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f858b49fcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101772d30>, '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 0x101699db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101767be8>, '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.PBstSXiGnD/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.PfmMset1f7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 11:57:37 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 11:57:37 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 11:57:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PBstSXiGnD/Render', 11:57:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:37 INFO - 'HOME': '/Users/cltbld', 11:57:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:37 INFO - 'LOGNAME': 'cltbld', 11:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:37 INFO - 'MOZ_NO_REMOTE': '1', 11:57:37 INFO - 'NO_EM_RESTART': '1', 11:57:37 INFO - 'PAGER': '/bin/cat', 11:57:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:37 INFO - 'PWD': '/builds/slave/test', 11:57:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:37 INFO - 'SHELL': '/bin/bash', 11:57:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PfmMset1f7/Listeners', 11:57:37 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 11:57:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:37 INFO - 'USER': 'cltbld', 11:57:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:37 INFO - 'XPC_FLAGS': '0x0', 11:57:37 INFO - 'XPC_SERVICE_NAME': '0', 11:57:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:57:38 INFO - Cleaning up... 11:57:38 INFO - Return code: 0 11:57:38 INFO - Running post-action listener: _resource_record_post_action 11:57:38 INFO - Running post-action listener: _start_resource_monitoring 11:57:38 INFO - Starting resource monitoring. 11:57:38 INFO - [mozharness: 2017-05-26 18:57:38.092551Z] Finished create-virtualenv step (success) 11:57:38 INFO - [mozharness: 2017-05-26 18:57:38.093586Z] Running install step. 11:57:38 INFO - Running pre-action listener: _resource_record_pre_action 11:57:38 INFO - Running main action method: install 11:57:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:57:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:57:38 INFO - Reading from file tmpfile_stdout 11:57:38 INFO - Detecting whether we're running mozinstall >=1.0... 11:57:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:57:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:57:38 INFO - Reading from file tmpfile_stdout 11:57:38 INFO - Output received: 11:57:38 INFO - Usage: mozinstall [options] installer 11:57:38 INFO - Options: 11:57:38 INFO - -h, --help show this help message and exit 11:57:38 INFO - -d DEST, --destination=DEST 11:57:38 INFO - Directory to install application into. [default: 11:57:38 INFO - "/builds/slave/test"] 11:57:38 INFO - --app=APP Application being installed. [default: firefox] 11:57:38 INFO - mkdir: /builds/slave/test/build/application 11:57:38 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'] 11:57:38 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 11:57:53 INFO - Reading from file tmpfile_stdout 11:57:53 INFO - Output received: 11:57:53 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:57:53 INFO - Running post-action listener: _resource_record_post_action 11:57:53 INFO - [mozharness: 2017-05-26 18:57:53.603512Z] Finished install step (success) 11:57:53 INFO - [mozharness: 2017-05-26 18:57:53.603668Z] Running run-tests step. 11:57:53 INFO - Running pre-action listener: _resource_record_pre_action 11:57:53 INFO - Running main action method: run_tests 11:57:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:57:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:57:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:57:53 INFO - 2017-05-26 11:57:53.618 screenresolution[1956:277812] starting screenresolution argv=screenresolution get 11:57:53 INFO - 2017-05-26 11:57:53.621 screenresolution[1956:277812] Display 0: 1600x1200x32@60 11:57:53 INFO - 2017-05-26 11:57:53.626 screenresolution[1957:277814] starting screenresolution argv=screenresolution list 11:57:53 INFO - Available Modes on Display 0 11:57:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:57:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:57:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:57:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:57:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:57:53 INFO - Intel Iris: 11:57:53 INFO - Chipset Model: Intel Iris 11:57:53 INFO - Type: GPU 11:57:53 INFO - Bus: Built-In 11:57:53 INFO - VRAM (Dynamic, Max): 1536 MB 11:57:53 INFO - Vendor: Intel (0x8086) 11:57:53 INFO - Device ID: 0x0a2e 11:57:53 INFO - Revision ID: 0x0009 11:57:53 INFO - Displays: 11:57:53 INFO - Display: 11:57:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:57:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:57:53 INFO - Display Serial Number: 1600x1200 60 11:57:53 INFO - Main Display: Yes 11:57:53 INFO - Mirror: Off 11:57:53 INFO - Online: Yes 11:57:53 INFO - Rotation: Supported 11:57:53 INFO - Return code: 0 11:57:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:57:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:57:53 INFO - Python 2.7.3 11:57:53 INFO - Return code: 0 11:57:53 INFO - grabbing minidump binary from tooltool 11:57: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')]} 11:57:53 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 0x101772d30>, '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 0x101699db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101767be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:57:53 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 11:57:53 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 11:57:53 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 11:57:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:57:53 INFO - Return code: 0 11:57:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:57:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:57:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:57:53 INFO - ENV: RUST_BACKTRACE is now 1 11:57:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:57:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:57:53 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/XazcW0iSTz2e7eUi5pYyWA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0285', '--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 11:57:53 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/XazcW0iSTz2e7eUi5pYyWA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0285 --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 11:57:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PBstSXiGnD/Render', 11:57:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:53 INFO - 'HOME': '/Users/cltbld', 11:57:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:53 INFO - 'LOGNAME': 'cltbld', 11:57:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:57:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:53 INFO - 'MOZ_NO_REMOTE': '1', 11:57:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:57:53 INFO - 'NO_EM_RESTART': '1', 11:57:53 INFO - 'PAGER': '/bin/cat', 11:57:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:53 INFO - 'PWD': '/builds/slave/test', 11:57:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:57:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:53 INFO - 'RUST_BACKTRACE': '1', 11:57:53 INFO - 'SHELL': '/bin/bash', 11:57:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PfmMset1f7/Listeners', 11:57:53 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 11:57:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:53 INFO - 'USER': 'cltbld', 11:57:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:53 INFO - 'XPC_FLAGS': '0x0', 11:57:53 INFO - 'XPC_SERVICE_NAME': '0', 11:57:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:53 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/XazcW0iSTz2e7eUi5pYyWA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0285', '--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 11:57:54 INFO - mozversion application_buildid: 20170526101616 11:57:54 INFO - mozversion application_changeset: 9664d83f5c056a32a3cc29de9d5934b82809dbfd 11:57:54 INFO - mozversion application_display_name: Firefox 11:57:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:57:54 INFO - mozversion application_name: Firefox 11:57:54 INFO - mozversion application_remotingname: firefox 11:57:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:57:54 INFO - mozversion application_vendor: Mozilla 11:57:54 INFO - mozversion application_version: 54.0 11:57:54 INFO - mozversion platform_buildid: 20170526101616 11:57:54 INFO - mozversion platform_changeset: 9664d83f5c056a32a3cc29de9d5934b82809dbfd 11:57:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:57:54 INFO - mozversion platform_version: 54.0 11:57:54 INFO - using testdate: 1495825074 11:57:54 INFO - actual date: 1495825074 11:57:54 INFO - starting webserver on 'localhost:49274' 11:57:54 INFO - SUITE-START | Running 2 tests 11:57:54 INFO - TEST-START | dromaeo_css 11:57:54 INFO - operating with platform_type : mac_ 11:57:54 INFO - Initialising browser for dromaeo_css test... 11:57:54 INFO - TEST-INFO | started process 1967 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/tmp3J_LbF/profile http://localhost:49274/getInfo.html) 11:57:56 INFO - PROCESS | 1967 | __metrics Screen width/height:1600/1200 11:57:56 INFO - PROCESS | 1967 | colorDepth:24 11:57:56 INFO - PROCESS | 1967 | Browser inner width/height: 1024/689 11:57:56 INFO - PROCESS | 1967 | __metrics 11:57:56 INFO - PROCESS | 1967 | 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" 11:57:56 INFO - PROCESS | 1967 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:57:57 INFO - TEST-INFO | 1967: exit 0 11:57:57 INFO - Browser initialized. 11:57:57 INFO - Running cycle 1/1 for dromaeo_css test... 11:57:57 INFO - TEST-INFO | started process 1971 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/tmp3J_LbF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:58:10 INFO - PROCESS | 1971 | RSS: Main: 165445632 11:58:10 INFO - PROCESS | 1971 | 12:01:14 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 12:01:15 INFO - PROCESS | 1971 | RSS: Main: 319266816 12:01:15 INFO - PROCESS | 1971 | 12:04:18 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 12:04:19 INFO - PROCESS | 1971 | RSS: Main: 297369600 12:04:19 INFO - PROCESS | 1971 | 12:07:21 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 12:07:22 INFO - PROCESS | 1971 | RSS: Main: 291717120 12:07:22 INFO - PROCESS | 1971 | 12:10:24 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 12:10:25 INFO - PROCESS | 1971 | RSS: Main: 271495168 12:10:25 INFO - PROCESS | 1971 | 12:13:29 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 12:13:29 INFO - PROCESS | 1971 | RSS: Main: 273817600 12:13:29 INFO - PROCESS | 1971 | 12:16:32 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 12:16:33 INFO - PROCESS | 1971 | RSS: Main: 357519360 12:16:33 INFO - PROCESS | 1971 | 12:16:33 INFO - PROCESS | 1971 | __start_tp_report 12:16:33 INFO - PROCESS | 1971 | _x_x_mozilla_page_load 12:16:33 INFO - PROCESS | 1971 | _x_x_mozilla_page_load_details 12:16:33 INFO - PROCESS | 1971 | |i|pagename|runs| 12:16:33 INFO - PROCESS | 1971 | |0;dojo.html;3493.3013397320537;3503.7021853142483;3507.035565219565;3534.4874993125995;3541.9468707969368;6060.636361818289;6085.908711369333;6088.117223002662;6089.695515224238;6108.602940808844;6031.095335699647;6105.114758360035;6107.541934354919;6114.5108391328695;6122.204113465244;5386.542143917772;5418.8916221675545;5426.701531415771;5439.456054394568;5551.500364967153;5312.946870531303;5313.309269794921;5365.356157261114;5525.585581081435;5528.281323427948;5428.158635411518;5443.618946673734;5445.292112025451;5447.809326673548;5456.836294911159;5432.320959880015;5448.046591846431;5450.645708029005;5452.591055670801;5456.91814622781;5278.709670968095;5401.864953376158;5405.378381486101;5422.213779002062;5455.345358556999;6100;6101.694915254264;6102.359252278491;6108.755649774003;6110.602810817327;6205.875882482325;6239.906401403982;6246.593971391845;6271.122042913996;6335.366463353674;6579.769708060243;6583.835404114888;6584.440322572587;6587.80236592903;6591.143151390289;6170.5372097092895;6202.41077097675;6202.875942481171;6207.317195108534;6213.068039794022;6293.748250069946;6380.84047898797;6454.709538070798;6705.865882682319;6718.932810671929;4915.410150781929;6259.593126446766;6285.779997700059;6309.716062777186;6354.904676429857;6498.447631951242;6507.544471886922;6510.348965103546;6512.804615861532;6527.249366322933;5341.439148889388;6103.277060575968;6392.872142557216;6433.356664333529;6453.193350831146;6290.24517057956;6306.432421082125;6337.081123237197;6432.935670643327;6443.420092191632;5256.684598924;5256.842294731164;5258.421573626898;5277.762500687479;5282.867928301823;4625.468071171791;4660.557247061523;4671.416072990876;4673.626109911199;4692.272697731857;5976.701164941735;6022.608530445507;6108.736706092798;6113.358097399798;6114.724837382329;6449.322821103717;6516.218053833571;6516.869662606721;6521.934780652227;6535.607863528108;6206.10011548332;6224.906626400608;6227.595206311666;6230.034344676583;6230.6884655767935;5489.2589500417735;5546.722663866791;5650.29371328584;5709.68596727184;5728;6454.483641308684;6608.43828274602;6675.6995935184;6726.630035347907;6764.154480689914;6494.642794646151;6545.901811472927;6560.475161987125;6563.0811686364905;6568.277489476058;6672.566283191577;6741.2921643226755;6765.42493888025;6765.458763299022;6766.560173588701;6265.843353916006;6316.6841657916;6335.873282534416;6369.8726025480155;6434.8391290218115;6479.838004049937;6508.544401892012;6513.837154071186;6515.576487528296;6524.67376631176;6274.874502510015;6301.369863013662;6346.079818426395;6362.141110949962;6362.77730279438;5190.351206099238;6204.255489341127;6219.160413344322;6343.429091381798;6369.267534233437;5429.375621803385;6235.532335074797;6238;6276.466500347339;6282.623042617458;6200;6267.561270711007;6311.747530098744;6335.936640633535;6341.429271365415;6148.538859585459;6182.598131121463;6202.038684003986;6219.160413344322;6226.034964580497 12:16:33 INFO - PROCESS | 1971 | |1;ext.html;779.1079214299627;814.3363159025394;826.3348004856092;906.2659246010728;915.3958387464274;29928;41917.37123943139;42083.99999999996;42100.578994210126;42289.36565951513;40716.59283407165;40886.38670419946;41120.99999999993;42661.57338426615;42715.786421067925;8076;9636.90363096367;9812.46031468269;9817.656382026631;9822.705318840446;8163;11955.163138580303;12101.878981210208;12369.567065152722;12380.442880070374;12181.025517958586;12184.634460966185;12189.085818563599;12216.389180540982;12218.63344099674;12153.635390938285;12172.26966382011;12182.390880455987;12198;12207.145499815017;11670.766584668345;11696.883031169664;11715;11716.062714982781;11716.23844450108;40656.39015414771;40920.38619420711;40970.1805963882;41011.17977640431;41026;4054.4729185205733;4064.6748260139116;4070.8450950513293;4091.488563929509;4116.0533077392065;28518.857405713046;29316.97390591319;30476.54285185724;30943.381132377228;31038.534421983688;3158.4738999618435;3282.6553211912883;3321.8837340692958;3418.4701371287492;3419.9316013679836;355928;360757;361794;361941;362320.18839905894;54120.18819717707;54148.187777183375;54192;54197.1870421944;54282.7285863576;57098.714506427204;57135.14297285544;57223.713881430325;57280.56316621016;57430.712846436334;15628.140452275235;15723.842761572238;15746.291416886268;15757.606059848365;15762.448314309173;11901.107416943763;12058.819117713241;13313.40089695966;13381.264030478416;13388.06283560161;11420.543178272943;11477.598284060017;11478.483468243949;11483.081353491702;11512.827307590393;4952.579030782352;6139.447449729546;6200.441960223601;6214.937850621526;6222.408871157233;963.5519483440233;982.4301904895144;983.8622592837008;991.965281215154;1011.8330475471612;29922.850385747934;30668.69331306703;30794.692053079183;31156.75718627708;31494;1056.9365838049587;1065.2969040433277;1066.8826429092794;1102.3165637304921;1103.0568863621647;12444.626661200178;13202.613725558871;15461.9226903867;15550.066995980278;15587.688246235011;368487.1575642105;422927;442825;443744;444223;50072;62597.68701156465;63928.36071639224;63985;64016;1472.4699108320997;1507.6532397548406;1508.8792896568468;1525.305985776469;1525.862672359493;30304.393912122076;31312.843435782674;31477.527837082922;31488.527672085394;32061;50743.49256507387;50825.23762143645;50889.23666145085;50896.74551627218;51030.74484627553;424972;425016;425078;425791.7420825752;425993;36401;37297.44053839249;37621;37641;37677;45921.54078459173;46603.53396465992;46719.76640116778;47045.58863234108;47201.05597887954;28619.284517886386;28893.133206003855;31755.523667145473;32624.510632340058;33024;31345.686543134278;31981;32269.838650806596;32482;32517;37957;38123.42814857835;38873.80563097166;38892.80553597214;38935.80532097322;37288.627113728515;38278.42582361322;39219.41170882382;40188.59811401965;40511.594884050784;30553.54169687501;31838.36323273568;31927.36145277035;31968.040958770343;32583.348333032733 12:16:33 INFO - PROCESS | 1971 | |2;jquery.html;365.4572959155654;406.24844038528727;416.1053734470887;421.5236782435847;457.1930542592325;21187.788122118793;21772.80249586274;22521.436964075907;22570.097196112158;22860.199893003748;18497.630047399045;21019.894900525513;21695.45761355963;22861.657075143885;24388.78056097197;5850.946829570676;5897.439743224398;7154.749583764569;7201;7205.351518363373;6934.791956241321;6941.965290173542;6977.651117444133;7017.6140312282805;7056.753013644524;6740.696668649898;7028.297170282956;7048.154221493428;7067.363937245646;7119.9288007119785;6899.206591242021;6945.861082778341;6968.79093627192;6969.965150174242;6987.301269872997;6550.868982620321;6930.896036559456;6944.895826562605;6945.305469453065;6957.686904089278;27923.860380697966;28320.291992700142;28414.28964275889;28418.715812841812;28680.13959581195;2953.7636989040825;3238.983805080983;3538.327717733622;3588.6743300332237;3649.0147660131615;16321.918390407973;16330.938488998177;16355.59111022222;16383.59041023972;16686.9153505023;1877.7652793400825;2037.6739721644465;2112.904919278636;2167.6098302305577;2187.332863476639;150212;156080;158207.41792582156;158460.62309065487;159804;16506.092164930804;20866.47833804167;21026.684599731016;21131;21197.470063248544;32623.51064734031;33283.500747488804;33302.833485832416;33309.50035749466;33361.332773344395;10725.30285531438;10863.45682715861;11022.614208502664;11040.392778397105;11183.888161118448;7354.521956072838;9213.493257870881;9247.213986811063;9403.200727938201;9441.716748497556;9456.763580910532;9487.383320084173;9551.47466889314;9642.517874106266;9698.70903872885;3407.761456698057;3464.6535346465657;4106.782337537756;4106.856260030944;4123.443335149716;706.3352105732183;974.6539978307599;1068.8129577323937;1083.1767856429012;1086.1582273737915;22403.439914001956;22714.20500282515;22766.31701048971;22771.544569108526;22856.65715014276;1051.5636011055326;1060.6287799270194;1077.5743581285506;1094.7919895219882;1102.1238115698038;11257.718557035976;11833.940830295793;12045.39773011346;12091.516339346328;12368.628941131781;732005;741848;744763;757479;773830.1308493421;111106.44446777714;120817.5836483283;144324;147300.5269947287;150686;1074.9801113762865;1228.6621179175797;1268.1820225954393;1271.1864406779669;1274.5220542296638;15207.923960380127;19899.701504477154;20987.790122098584;21256.574868502852;21298.25456109029;62204.06693899685;63503.6824815873;63831.723365533355;65136.674316628116;65741.027769167;71092;86545.56727216576;86947.56526217329;87484.5625771867;88638.55680721556;11838.704032399259;12067.336296503776;12213.755724885275;12324.445399957203;12363.75272494563;13580.52468163649;13703.246321452018;13717.725645487233;13863.514776982756;14078.225697586322;11059.944700276768;11278.943605281922;11355.716107097389;11381.54473821071;11730.70673233176;8768.386212965032;10946.945265273622;11169.162312826407;11395.259308144945;11481.138914581607;11793.823092653445;11807.406000189865;11826.290422574673;11868.287902725864;11976.640700778991;11137.94431027872;11883.702907427038;12203.63389098293;12249.632511024683;12264.448099835707;10604.939506049333;11261.605843795427;11699.649010529698;11958.402079896145;11997.220180688228 12:16:33 INFO - PROCESS | 1971 | |3;mootools.html;1605.66281080973;1618.0776957134424;1628.9918550407253;1646.9752953705693;1657.5856035991005;10735;11434;11445.656630301084;11453.599124030661;11467.59863404781;10821.891781082188;11111.72220694483;11270.887291127106;11310.547578096866;11322.490487928042;2003.8396928245706;2460.1635443949053;2461.618449140386;2461.938451538708;2466.0382450844186;2324.9651255231183;2377.6671266022686;2388.486475407787;2390.3546042568496;2425.6725342078857;2322.7909488146065;2351.3533778211045;2368.0291080656934;2451.669024681672;2456.9017239310497;2093.701904819007;2300.5283916797016;2407.41018450479;2413.6017557103055;2419.733829278778;2408.6989126359204;2427.927162185137;2437.110454684045;2438.6220135878966;2440.6217036359394;10977.560897564088;11173;11204.21570490066;11213.383263920481;11220.438978051146;5690.715464226813;5934.317553481319;5947.851303717398;5960.582759206857;5961.8807623847715;3500.9474857877153;3637.963620363789;3662.505561749156;3704.592494825567;3756.398976163828;1243.0180157675425;1245.2901845947813;1289.7162624222656;1296.753616812812;1307.9084464087423;13871;14093.5067272646;14506.637334066627;15592;15836.287367068395;4549.158405694957;4720.598749106364;4743.501932297059;4760.45254795696;4762.285657151455;10320.845187322197;12071.456784444721;12072.396380181131;12078.456469458895;12092.87907120935;4960.082384758831;5511.889762204813;5670.5180059695385;5694.088945768657;5696.971515142481;5176.689398636094;5278.604104692086;5304.840854774363;5346.732663366816;5362.2224777407055;3844.4809950656863;3875.198032914652;3888.1446081861945;3935.9212815743526;3958.1094253793244;1006.4766321512773;1008.193445243802;1015.0914931136591;1017.7710015246511;1024.8155332040155;914.5107367558325;938.3478482454765;972.9902700973041;981.7741919358444;1004.2869562610482;6554.213494380705;6581.308962558958;6611.371919667624;6689.899651505231;6764;783.9608019599111;933.4679232837218;934.61210102997;990.9207263418909;1034.332855308322;3516.9472457913153;4168.083021735213;4177.060161463707;4181.581841815855;4276.679249056333;13481.730365392637;14101.435942562182;14126.364313605913;14143.64640883986;14147.646308842155;13027.544035958696;13435.529756458476;13773.38019789112;13775.517856874962;13877.514286999907;10089.293749437616;10319.122874555747;10363.689089327332;10380.740481488023;10381;6505.186851643544;6756.493263005393;6846.520743547904;6995.160580730345;7003.719851206099;10962.177836662442;11091.389973551532;12067.75864482723;12751.362431878555;12799.744005120032;10576.41829699374;12393.194442361219;12596.181248218836;12669.429875655433;12817.423215955117;9079.364444488823;9210.9539452305;9308.44149351014;9310.975792662666;9322.48726320059;8606.741797745826;10306.381617102998;10415.94792026035;10417.374957502574;10423.530941107516;8655.17775811297;8874.334424918286;8894.555272236234;8939.329550283885;9080.682176123804;8517.063123056583;8547.102554231964;8553.87169192475;8615.267702245379;8643.956780216058;8025.678972841021;8195.221453961864;8206.015278166658;8212.548309843016;8214.219649133323;5890.705464726832;5914.940850591611;5945.34601193877;6106.938930610637;6161.4146656067605;5969.76120955157;6011.917854786006;6129.2032035835055;6183.938160618516;6301.275353334425 12:16:33 INFO - PROCESS | 1971 | |4;prototype.html;378.55330709762467;383.3081288274663;383.82344121704017;386.3451449792601;390.04439124145847;4415.8233670653135;4861.6353773467;5058.797648094076;5071.087204303224;5236.188390799422;4422.38086667866;4561.1105834362315;4631.536846315366;4734.952650473494;5077.461269365317;3210.7752457327997;3402.0134161093315;3961.7028722845757;4244.561904857061;4265.229929579221;3585.8924232273075;4176.331786914095;4270.935935960963;4274.760319507339;4331.9423273944785;3652.6529979652023;3946.565877753445;4253.447491665535;4271.530131685512;4298.355246713002;3553.662402071799;3978.880633581012;4240.597143271384;4278.893027674302;4293.484781826185;3188;3658.2134841009047;3756.906077348061;3929.390944403622;3968.2024172957995;4965.726885021322;4992.279207831704;5015.423226328946;5021.372328458942;5028.472010438888;3966.560565252349;4225.640820530228;4375.2999520076955;4910.926336104962;4919.458859525449;4475.7985890635;4674.532546745332;5187.847043476952;5415.943890941268;5435.239066530649;3578.7254661984252;3803.904902377435;3868.516435445569;4353.346997950302;4362.760048197348;4850.59332793493;5435.945640543583;5560.332760068777;5735.770569177228;5739.713014349308;4296.957030429656;4436.578525040116;4439.3819037484345;4439.400680908101;4442.711223770445;3920.0203897031815;4048.291548978917;4486.842960496367;4503.73895309314;4556.270996640522;4878.390131256677;4907.263910413395;4913.459519452857;4943.72809495474;4994.901121753209;4800.167900938463;4826.8793280168275;5198.9740051299505;5291.809342897895;5484.287042684426;1334;1364.40648317982;1511.916844573537;1538.99230503849;1540.8767298616083;1073.4900922062113;1095.2442814457997;1169.1990986174499;1177.381874515886;1178.7347846734588;4507.444931498628;4834.446681688956;4940.8764780880765;5116.74416279192;5184.948150518522;5142.434332223453;5685;5690.459406356389;5701.00232459318;5729.942700573024;4077.1437998020747;4755.216793702361;4976.889444097439;5157.4584668610005;5175.689458632494;2644.286042768442;2821.943561128766;2874.2526942994973;2947.1011341540607;2947.778916581265;5011.34852469184;5806.709664516758;5833;5851.707414629252;5879.588428810028;5276.918231762479;5313.707746073926;5444.5916556258435;5729.8772169167905;5800.709964501758;4939.728314942641;5196.1034222508515;5414.214938833847;5835.7373918174635;5862.677552734555;4946.3817022872145;4975.825846095369;4993.850184494471;5306.761195746123;5650.547956163415;4899.16714158601;4950.529699678525;5264.868053368544;5535.972320138373;5617.803376881953;5445;5647.774089036392;5815.302163740378;5820.933568583092;5858.355580886185;4019.979900100481;4431.404694309981;4454.732716037048;4457.8216871324785;4467.8212871484775;4694.483606803317;5162.7542019221755;5238.921416178837;5328.907573947254;5657.4908258256955;5405.8107966221;5464.104024866827;5492.505674489315;5497.835064948058;5529.50703310112;4865.562099410929;4945.23348880924;4972;5452.265198339151;5489.286392768914;4181.477315335583;5146.76839542229;5248.52763251294;5260.395054568774;5334.333208348957;4382.934255986226;5417.29575155243;5418.295621569171;5437.782488700408;5453.982026650006;4937.481564435682;5295.822506496225;5298.880447820902;5314.883874386423;5345.1447768356875 12:16:33 INFO - PROCESS | 1971 | |5;yui.html;779.1818590479994;785.8389030248796;809.68422315297;865.6234537975981;869.6869127114239;15182.620434489143;18086.186121624527;18115.456536303915;18139.90930045348;18159.45521634353;16080.437184698538;16201.594960125973;16265.756013659804;16266.75599866003;16291.674166516692;1002.3184234720387;1015.192921627308;1022.7494263905354;1026.035526604989;1027.9280450368476;998.1166667499243;1004.2618675273668;1005.0100650858934;1005.7636455432968;1006.9295149339549;1031.5048776587244;1037.7094413564214;1039.3504059962524;1040.7866387390566;1040.921930855185;1046.9057784799365;1059.809234337819;1059.90990765785;1064.6433444796003;1068.172166570906;777.6889244302267;778.4122987144726;779.380392587894;780.0288640642436;780.2821404307994;16697.332106715716;16978.151092445452;17085.231164597622;17304;17764.37824676143;14543.563693089225;14571.19858407787;14615;14683.192424416653;14850;11860.52557897683;12062.758744825142;12169.634910952685;12221.266723996589;12306;3718.9814050929845;3887.300285948528;3911.963329717627;3953.2686453006286;4009.258287216874;99974.99999999927;108920.4553977225;109209;109816.35275470874;110780;11300.378479183559;11508.827367589492;11681.88318116825;11788.823167652492;11969.102317326235;23490.64764028541;23650.7634923652;23874.403139921294;23899.402514937265;23909;8080.232377924088;8110.188981101843;8115.75652730419;8126.471779334324;8259.050209226016;4574.817007319736;4588.403507543998;4656.4877863434995;4679.485256621769;4881.292212629149;3567.4292113261754;3659.213269147146;3661.908452288714;3674.154944362758;3675.2649470106085;641.7400952614199;697.3653974882832;716.4304378019488;733.5561984999106;734.6510407556368;723.5224751663876;739.3309055304958;743.6765007221876;746.6677328588726;761.1893333599809;10683.30558513694;10724.463776811284;10827.187960902964;11219.439028048564;11395.943020284845;568.7042737776333;573.7001176184524;655.131950166032;701.4949236549676;761.1323091675495;4867.513248675175;4999.75001249936;5207.583393328525;5227.625939161131;5287.535109054814;84520;94898.0510194903;100406.4979675097;102752.48623756833;103605.48197258965;78322.6083869577;86254;89870;90656;93662.53168734112;80275.59862200651;80898.19101809025;81284.59357703292;81616;82892.58553707192;8248.340132789242;10017.5492102857;10255.07704306616;10276.588936442458;10292.691219263434;50497.24254136117;50988.49011509837;51418;51717.7414112927;53127.468725313796;65780;65954.34045659674;66264.00603991041;67025.66487167533;67369;12682.492700292254;12705.301208433624;12924.806127907901;12971.785268414482;13075.934620327218;13076.084674073105;13151.796060255092;13819.79270310926;13935.47356652279;14025.018248722492;12079.939600301943;12625.747485050431;12788.936055319664;12952.28762418076;13000.609981700563;12427.875721242672;12756;12762.192317690093;13163.210207387587;13288.402021908843;12190.878091218974;12322.322272274752;12711.173773704679;12809;12901.612951611467;9162.358634895494;9214.723558293263;9221.861672075058;9297.67458138962;9695;9093.726878237185;10253.231007674305;10511.632092876713;10651.78797869646;10737.516811743646 12:16:33 INFO - PROCESS | 1971 | __end_tp_report 12:16:33 INFO - PROCESS | 1971 | __start_cc_report 12:16:33 INFO - PROCESS | 1971 | _x_x_mozilla_cycle_collect,1423 12:16:33 INFO - PROCESS | 1971 | __end_cc_report 12:16:33 INFO - PROCESS | 1971 | __startTimestamp1495826193150__endTimestamp 12:16:33 INFO - PROCESS | 1971 | 12:16:33 INFO - PROCESS | 1971 | ------- Summary: start ------- 12:16:33 INFO - PROCESS | 1971 | Number of tests: 6 12:16:33 INFO - PROCESS | 1971 | 12:16:33 INFO - PROCESS | 1971 | [#0] dojo.html Cycles:165 Average:5989.63 Median:6219.16 stddev:664.97 (10.7%) stddev-sans-first:637.52 12:16:33 INFO - PROCESS | 1971 | Values: 3493.3 3503.7 3507.0 3534.5 3541.9 6060.6 6085.9 6088.1 6089.7 6108.6 6031.1 6105.1 6107.5 6114.5 6122.2 5386.5 5418.9 5426.7 5439.5 5551.5 5312.9 5313.3 5365.4 5525.6 5528.3 5428.2 5443.6 5445.3 5447.8 5456.8 5432.3 5448.0 5450.6 5452.6 5456.9 5278.7 5401.9 5405.4 5422.2 5455.3 6100.0 6101.7 6102.4 6108.8 6110.6 6205.9 6239.9 6246.6 6271.1 6335.4 6579.8 6583.8 6584.4 6587.8 6591.1 6170.5 6202.4 6202.9 6207.3 6213.1 6293.7 6380.8 6454.7 6705.9 6718.9 4915.4 6259.6 6285.8 6309.7 6354.9 6498.4 6507.5 6510.3 6512.8 6527.2 5341.4 6103.3 6392.9 6433.4 6453.2 6290.2 6306.4 6337.1 6432.9 6443.4 5256.7 5256.8 5258.4 5277.8 5282.9 4625.5 4660.6 4671.4 4673.6 4692.3 5976.7 6022.6 6108.7 6113.4 6114.7 6449.3 6516.2 6516.9 6521.9 6535.6 6206.1 6224.9 6227.6 6230.0 6230.7 5489.3 5546.7 5650.3 5709.7 5728.0 6454.5 6608.4 6675.7 6726.6 6764.2 6494.6 6545.9 6560.5 6563.1 6568.3 6672.6 6741.3 6765.4 6765.5 6766.6 6265.8 6316.7 6335.9 6369.9 6434.8 6479.8 6508.5 6513.8 6515.6 6524.7 6274.9 6301.4 6346.1 6362.1 6362.8 5190.4 6204.3 6219.2 6343.4 6369.3 5429.4 6235.5 6238.0 6276.5 6282.6 6200.0 6267.6 6311.7 6335.9 6341.4 6148.5 6182.6 6202.0 6219.2 6226.0 12:16:33 INFO - PROCESS | 1971 | 12:16:33 INFO - PROCESS | 1971 | [#1] ext.html Cycles:180 Average:56490.69 Median:199360.59 stddev:106821.94 (53.6%) stddev-sans-first:107039.70 12:16:33 INFO - PROCESS | 1971 | Values: 779.1 814.3 826.3 906.3 915.4 29928.0 41917.4 42084.0 42100.6 42289.4 40716.6 40886.4 41121.0 42661.6 42715.8 8076.0 9636.9 9812.5 9817.7 9822.7 8163.0 11955.2 12101.9 12369.6 12380.4 12181.0 12184.6 12189.1 12216.4 12218.6 12153.6 12172.3 12182.4 12198.0 12207.1 11670.8 11696.9 11715.0 11716.1 11716.2 40656.4 40920.4 40970.2 41011.2 41026.0 4054.5 4064.7 4070.8 4091.5 4116.1 28518.9 29317.0 30476.5 30943.4 31038.5 3158.5 3282.7 3321.9 3418.5 3419.9 355928.0 360757.0 361794.0 361941.0 362320.2 54120.2 54148.2 54192.0 54197.2 54282.7 57098.7 57135.1 57223.7 57280.6 57430.7 15628.1 15723.8 15746.3 15757.6 15762.4 11901.1 12058.8 13313.4 13381.3 13388.1 11420.5 11477.6 11478.5 11483.1 11512.8 4952.6 6139.4 6200.4 6214.9 6222.4 963.6 982.4 983.9 992.0 1011.8 29922.9 30668.7 30794.7 31156.8 31494.0 1056.9 1065.3 1066.9 1102.3 1103.1 12444.6 13202.6 15461.9 15550.1 15587.7 368487.2 422927.0 442825.0 443744.0 444223.0 50072.0 62597.7 63928.4 63985.0 64016.0 1472.5 1507.7 1508.9 1525.3 1525.9 30304.4 31312.8 31477.5 31488.5 32061.0 50743.5 50825.2 50889.2 50896.7 51030.7 424972.0 425016.0 425078.0 425791.7 425993.0 36401.0 37297.4 37621.0 37641.0 37677.0 45921.5 46603.5 46719.8 47045.6 47201.1 28619.3 28893.1 31755.5 32624.5 33024.0 31345.7 31981.0 32269.8 32482.0 32517.0 37957.0 38123.4 38873.8 38892.8 38935.8 37288.6 38278.4 39219.4 40188.6 40511.6 30553.5 31838.4 31927.4 31968.0 32583.3 12:16:33 INFO - PROCESS | 1971 | 12:16:33 INFO - PROCESS | 1971 | [#2] jquery.html Cycles:180 Average:42951.16 Median:11980.07 stddev:124692.54 (1040.8%) stddev-sans-first:125001.34 12:16:33 INFO - PROCESS | 1971 | Values: 365.5 406.2 416.1 421.5 457.2 21187.8 21772.8 22521.4 22570.1 22860.2 18497.6 21019.9 21695.5 22861.7 24388.8 5850.9 5897.4 7154.7 7201.0 7205.4 6934.8 6942.0 6977.7 7017.6 7056.8 6740.7 7028.3 7048.2 7067.4 7119.9 6899.2 6945.9 6968.8 6970.0 6987.3 6550.9 6930.9 6944.9 6945.3 6957.7 27923.9 28320.3 28414.3 28418.7 28680.1 2953.8 3239.0 3538.3 3588.7 3649.0 16321.9 16330.9 16355.6 16383.6 16686.9 1877.8 2037.7 2112.9 2167.6 2187.3 150212.0 156080.0 158207.4 158460.6 159804.0 16506.1 20866.5 21026.7 21131.0 21197.5 32623.5 33283.5 33302.8 33309.5 33361.3 10725.3 10863.5 11022.6 11040.4 11183.9 7354.5 9213.5 9247.2 9403.2 9441.7 9456.8 9487.4 9551.5 9642.5 9698.7 3407.8 3464.7 4106.8 4106.9 4123.4 706.3 974.7 1068.8 1083.2 1086.2 22403.4 22714.2 22766.3 22771.5 22856.7 1051.6 1060.6 1077.6 1094.8 1102.1 11257.7 11833.9 12045.4 12091.5 12368.6 732005.0 741848.0 744763.0 757479.0 773830.1 111106.4 120817.6 144324.0 147300.5 150686.0 1075.0 1228.7 1268.2 1271.2 1274.5 15207.9 19899.7 20987.8 21256.6 21298.3 62204.1 63503.7 63831.7 65136.7 65741.0 71092.0 86545.6 86947.6 87484.6 88638.6 11838.7 12067.3 12213.8 12324.4 12363.8 13580.5 13703.2 13717.7 13863.5 14078.2 11059.9 11278.9 11355.7 11381.5 11730.7 8768.4 10946.9 11169.2 11395.3 11481.1 11793.8 11807.4 11826.3 11868.3 11976.6 11137.9 11883.7 12203.6 12249.6 12264.4 10604.9 11261.6 11699.6 11958.4 11997.2 12:16:33 INFO - PROCESS | 1971 | 12:16:33 INFO - PROCESS | 1971 | [#3] mootools.html Cycles:180 Average:6761.48 Median:2454.29 stddev:4209.39 (171.5%) stddev-sans-first:4203.37 12:16:33 INFO - PROCESS | 1971 | Values: 1605.7 1618.1 1629.0 1647.0 1657.6 10735.0 11434.0 11445.7 11453.6 11467.6 10821.9 11111.7 11270.9 11310.5 11322.5 2003.8 2460.2 2461.6 2461.9 2466.0 2325.0 2377.7 2388.5 2390.4 2425.7 2322.8 2351.4 2368.0 2451.7 2456.9 2093.7 2300.5 2407.4 2413.6 2419.7 2408.7 2427.9 2437.1 2438.6 2440.6 10977.6 11173.0 11204.2 11213.4 11220.4 5690.7 5934.3 5947.9 5960.6 5961.9 3500.9 3638.0 3662.5 3704.6 3756.4 1243.0 1245.3 1289.7 1296.8 1307.9 13871.0 14093.5 14506.6 15592.0 15836.3 4549.2 4720.6 4743.5 4760.5 4762.3 10320.8 12071.5 12072.4 12078.5 12092.9 4960.1 5511.9 5670.5 5694.1 5697.0 5176.7 5278.6 5304.8 5346.7 5362.2 3844.5 3875.2 3888.1 3935.9 3958.1 1006.5 1008.2 1015.1 1017.8 1024.8 914.5 938.3 973.0 981.8 1004.3 6554.2 6581.3 6611.4 6689.9 6764.0 784.0 933.5 934.6 990.9 1034.3 3516.9 4168.1 4177.1 4181.6 4276.7 13481.7 14101.4 14126.4 14143.6 14147.6 13027.5 13435.5 13773.4 13775.5 13877.5 10089.3 10319.1 10363.7 10380.7 10381.0 6505.2 6756.5 6846.5 6995.2 7003.7 10962.2 11091.4 12067.8 12751.4 12799.7 10576.4 12393.2 12596.2 12669.4 12817.4 9079.4 9211.0 9308.4 9311.0 9322.5 8606.7 10306.4 10415.9 10417.4 10423.5 8655.2 8874.3 8894.6 8939.3 9080.7 8517.1 8547.1 8553.9 8615.3 8644.0 8025.7 8195.2 8206.0 8212.5 8214.2 5890.7 5914.9 5945.3 6106.9 6161.4 5969.8 6011.9 6129.2 6183.9 6301.3 12:16:33 INFO - PROCESS | 1971 | 12:16:33 INFO - PROCESS | 1971 | [#4] prototype.html Cycles:180 Average:4494.55 Median:4912.19 stddev:1267.82 (25.8%) stddev-sans-first:1233.16 12:16:33 INFO - PROCESS | 1971 | Values: 378.6 383.3 383.8 386.3 390.0 4415.8 4861.6 5058.8 5071.1 5236.2 4422.4 4561.1 4631.5 4735.0 5077.5 3210.8 3402.0 3961.7 4244.6 4265.2 3585.9 4176.3 4270.9 4274.8 4331.9 3652.7 3946.6 4253.4 4271.5 4298.4 3553.7 3978.9 4240.6 4278.9 4293.5 3188.0 3658.2 3756.9 3929.4 3968.2 4965.7 4992.3 5015.4 5021.4 5028.5 3966.6 4225.6 4375.3 4910.9 4919.5 4475.8 4674.5 5187.8 5415.9 5435.2 3578.7 3803.9 3868.5 4353.3 4362.8 4850.6 5435.9 5560.3 5735.8 5739.7 4297.0 4436.6 4439.4 4439.4 4442.7 3920.0 4048.3 4486.8 4503.7 4556.3 4878.4 4907.3 4913.5 4943.7 4994.9 4800.2 4826.9 5199.0 5291.8 5484.3 1334.0 1364.4 1511.9 1539.0 1540.9 1073.5 1095.2 1169.2 1177.4 1178.7 4507.4 4834.4 4940.9 5116.7 5184.9 5142.4 5685.0 5690.5 5701.0 5729.9 4077.1 4755.2 4976.9 5157.5 5175.7 2644.3 2821.9 2874.3 2947.1 2947.8 5011.3 5806.7 5833.0 5851.7 5879.6 5276.9 5313.7 5444.6 5729.9 5800.7 4939.7 5196.1 5414.2 5835.7 5862.7 4946.4 4975.8 4993.9 5306.8 5650.5 4899.2 4950.5 5264.9 5536.0 5617.8 5445.0 5647.8 5815.3 5820.9 5858.4 4020.0 4431.4 4454.7 4457.8 4467.8 4694.5 5162.8 5238.9 5328.9 5657.5 5405.8 5464.1 5492.5 5497.8 5529.5 4865.6 4945.2 4972.0 5452.3 5489.3 4181.5 5146.8 5248.5 5260.4 5334.3 4382.9 5417.3 5418.3 5437.8 5454.0 4937.5 5295.8 5298.9 5314.9 5345.1 12:16:33 INFO - PROCESS | 1971 | 12:16:33 INFO - PROCESS | 1971 | [#5] yui.html Cycles:180 Average:20654.17 Median:18100.82 stddev:29201.58 (161.3%) stddev-sans-first:29245.36 12:16:33 INFO - PROCESS | 1971 | Values: 779.2 785.8 809.7 865.6 869.7 15182.6 18086.2 18115.5 18139.9 18159.5 16080.4 16201.6 16265.8 16266.8 16291.7 1002.3 1015.2 1022.7 1026.0 1027.9 998.1 1004.3 1005.0 1005.8 1006.9 1031.5 1037.7 1039.4 1040.8 1040.9 1046.9 1059.8 1059.9 1064.6 1068.2 777.7 778.4 779.4 780.0 780.3 16697.3 16978.2 17085.2 17304.0 17764.4 14543.6 14571.2 14615.0 14683.2 14850.0 11860.5 12062.8 12169.6 12221.3 12306.0 3719.0 3887.3 3912.0 3953.3 4009.3 99975.0 108920.5 109209.0 109816.4 110780.0 11300.4 11508.8 11681.9 11788.8 11969.1 23490.6 23650.8 23874.4 23899.4 23909.0 8080.2 8110.2 8115.8 8126.5 8259.1 4574.8 4588.4 4656.5 4679.5 4881.3 3567.4 3659.2 3661.9 3674.2 3675.3 641.7 697.4 716.4 733.6 734.7 723.5 739.3 743.7 746.7 761.2 10683.3 10724.5 10827.2 11219.4 11395.9 568.7 573.7 655.1 701.5 761.1 4867.5 4999.8 5207.6 5227.6 5287.5 84520.0 94898.1 100406.5 102752.5 103605.5 78322.6 86254.0 89870.0 90656.0 93662.5 80275.6 80898.2 81284.6 81616.0 82892.6 8248.3 10017.5 10255.1 10276.6 10292.7 50497.2 50988.5 51418.0 51717.7 53127.5 65780.0 65954.3 66264.0 67025.7 67369.0 12682.5 12705.3 12924.8 12971.8 13075.9 13076.1 13151.8 13819.8 13935.5 14025.0 12079.9 12625.7 12788.9 12952.3 13000.6 12427.9 12756.0 12762.2 13163.2 13288.4 12190.9 12322.3 12711.2 12809.0 12901.6 9162.4 9214.7 9221.9 9297.7 9695.0 9093.7 10253.2 10511.6 10651.8 10737.5 12:16:33 INFO - PROCESS | 1971 | -------- Summary: end -------- 12:16:33 INFO - PROCESS | 1971 | 12:16:33 INFO - TEST-INFO | 1971: exit 0 12:16:33 INFO - TEST-OK | dromaeo_css | took 1119537ms 12:16:33 INFO - TEST-START | kraken 12:16:33 INFO - operating with platform_type : mac_ 12:16:33 INFO - Initialising browser for kraken test... 12:16:33 INFO - TEST-INFO | started process 1976 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/tmp59swyg/profile http://localhost:49274/getInfo.html) 12:16:36 INFO - PROCESS | 1976 | __metrics Screen width/height:1600/1200 12:16:36 INFO - PROCESS | 1976 | colorDepth:24 12:16:36 INFO - PROCESS | 1976 | Browser inner width/height: 1024/689 12:16:36 INFO - PROCESS | 1976 | __metrics 12:16:36 INFO - PROCESS | 1976 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:16:36 INFO - PROCESS | 1976 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:16:36 INFO - TEST-INFO | 1976: exit 0 12:16:36 INFO - Browser initialized. 12:16:36 INFO - Running cycle 1/1 for kraken test... 12:16:36 INFO - TEST-INFO | started process 1978 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/tmp59swyg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:16:49 INFO - PROCESS | 1978 | RSS: Main: 165097472 12:16:49 INFO - PROCESS | 1978 | 12:16:51 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 12:16:52 INFO - PROCESS | 1978 | RSS: Main: 215842816 12:16:52 INFO - PROCESS | 1978 | 12:16:55 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 12:16:55 INFO - PROCESS | 1978 | RSS: Main: 231211008 12:16:55 INFO - PROCESS | 1978 | 12:16:59 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 12:16:59 INFO - PROCESS | 1978 | RSS: Main: 328364032 12:16:59 INFO - PROCESS | 1978 | 12:17:01 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 12:17:02 INFO - PROCESS | 1978 | RSS: Main: 230105088 12:17:02 INFO - PROCESS | 1978 | 12:17:04 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:17:05 INFO - PROCESS | 1978 | RSS: Main: 232022016 12:17:05 INFO - PROCESS | 1978 | 12:17:07 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 12:17:08 INFO - PROCESS | 1978 | RSS: Main: 272379904 12:17:08 INFO - PROCESS | 1978 | 12:17:11 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 12:17:12 INFO - PROCESS | 1978 | RSS: Main: 272437248 12:17:12 INFO - PROCESS | 1978 | 12:17:15 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 12:17:15 INFO - PROCESS | 1978 | RSS: Main: 271278080 12:17:15 INFO - PROCESS | 1978 | 12:17:17 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:17:18 INFO - PROCESS | 1978 | RSS: Main: 247156736 12:17:18 INFO - PROCESS | 1978 | 12:17:20 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:17:20 INFO - PROCESS | 1978 | RSS: Main: 252010496 12:17:20 INFO - PROCESS | 1978 | 12:17:22 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:17:23 INFO - PROCESS | 1978 | RSS: Main: 255037440 12:17:23 INFO - PROCESS | 1978 | 12:17:26 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:17:27 INFO - PROCESS | 1978 | RSS: Main: 270487552 12:17:27 INFO - PROCESS | 1978 | 12:17:30 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:17:30 INFO - PROCESS | 1978 | RSS: Main: 264687616 12:17:30 INFO - PROCESS | 1978 | 12:17:32 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 12:17:32 INFO - PROCESS | 1978 | RSS: Main: 309030912 12:17:32 INFO - PROCESS | 1978 | 12:17:32 INFO - PROCESS | 1978 | __start_tp_report 12:17:32 INFO - PROCESS | 1978 | _x_x_mozilla_page_load 12:17:32 INFO - PROCESS | 1978 | _x_x_mozilla_page_load_details 12:17:32 INFO - PROCESS | 1978 | |i|pagename|runs| 12:17:32 INFO - PROCESS | 1978 | |0;ai-astar;104;115;115;115;115;115;115;115;114;115 12:17:32 INFO - PROCESS | 1978 | |1;audio-beat-detection;141;111;94;157;139;164;105;107;128;107 12:17:32 INFO - PROCESS | 1978 | |2;audio-dft;185;184;186;207;263;197;182;187;183;184 12:17:32 INFO - PROCESS | 1978 | |3;audio-fft;93;84;84;118;66;59;58;59;75;58 12:17:32 INFO - PROCESS | 1978 | |4;audio-oscillator;87;69;88;70;69;67;82;69;68;83 12:17:32 INFO - PROCESS | 1978 | |5;imaging-gaussian-blur;91;91;90;91;90;91;92;89;90;90 12:17:32 INFO - PROCESS | 1978 | |6;imaging-darkroom;96;100;94;135;149;107;96;96;97;95 12:17:32 INFO - PROCESS | 1978 | |7;imaging-desaturate;84;84;83;86;101;130;97;82;84;83 12:17:32 INFO - PROCESS | 1978 | |8;json-parse-financial;63;61;61;60;63;63;63;65;65;64 12:17:32 INFO - PROCESS | 1978 | |9;json-stringify-tinderbox;55;59;68;66;63;58;59;59;59;59 12:17:32 INFO - PROCESS | 1978 | |10;stanford-crypto-aes;90;98;97;96;88;79;80;80;83;85 12:17:32 INFO - PROCESS | 1978 | |11;stanford-crypto-ccm;138;137;125;133;134;136;138;138;183;152 12:17:32 INFO - PROCESS | 1978 | |12;stanford-crypto-pbkdf2;163;212;213;162;161;162;163;161;161;162 12:17:32 INFO - PROCESS | 1978 | |13;stanford-crypto-sha256-iterative;65;63;66;64;64;62;63;63;62;64 12:17:32 INFO - PROCESS | 1978 | __end_tp_report 12:17:32 INFO - PROCESS | 1978 | __start_cc_report 12:17:32 INFO - PROCESS | 1978 | _x_x_mozilla_cycle_collect,2142 12:17:32 INFO - PROCESS | 1978 | __end_cc_report 12:17:32 INFO - PROCESS | 1978 | __startTimestamp1495826252703__endTimestamp 12:17:32 INFO - PROCESS | 1978 | 12:17:32 INFO - PROCESS | 1978 | ------- Summary: start ------- 12:17:32 INFO - PROCESS | 1978 | Number of tests: 14 12:17:32 INFO - PROCESS | 1978 | 12:17:32 INFO - PROCESS | 1978 | [#0] ai-astar Cycles:10 Average:113.80 Median:115.00 stddev:3.46 (3.0%) stddev-sans-first:0.33 12:17:32 INFO - PROCESS | 1978 | Values: 104.0 115.0 115.0 115.0 115.0 115.0 115.0 115.0 114.0 115.0 12:17:32 INFO - PROCESS | 1978 | 12:17:32 INFO - PROCESS | 1978 | [#1] audio-beat-detection Cycles:10 Average:125.30 Median:140.00 stddev:24.06 (17.2%) stddev-sans-first:24.84 12:17:32 INFO - PROCESS | 1978 | Values: 141.0 111.0 94.0 157.0 139.0 164.0 105.0 107.0 128.0 107.0 12:17:32 INFO - PROCESS | 1978 | 12:17:32 INFO - PROCESS | 1978 | [#2] audio-dft Cycles:10 Average:195.80 Median:186.50 stddev:24.87 (13.3%) stddev-sans-first:26.07 12:17:32 INFO - PROCESS | 1978 | Values: 185.0 184.0 186.0 207.0 263.0 197.0 182.0 187.0 183.0 184.0 12:17:32 INFO - PROCESS | 1978 | 12:17:32 INFO - PROCESS | 1978 | [#3] audio-fft Cycles:10 Average:75.40 Median:70.50 stddev:19.73 (28.0%) stddev-sans-first:19.88 12:17:32 INFO - PROCESS | 1978 | Values: 93.0 84.0 84.0 118.0 66.0 59.0 58.0 59.0 75.0 58.0 12:17:32 INFO - PROCESS | 1978 | 12:17:32 INFO - PROCESS | 1978 | [#4] audio-oscillator Cycles:10 Average:75.20 Median:76.00 stddev:8.64 (11.4%) stddev-sans-first:8.04 12:17:32 INFO - PROCESS | 1978 | Values: 87.0 69.0 88.0 70.0 69.0 67.0 82.0 69.0 68.0 83.0 12:17:32 INFO - PROCESS | 1978 | 12:17:32 INFO - PROCESS | 1978 | [#5] imaging-gaussian-blur Cycles:10 Average:90.50 Median:91.00 stddev:0.85 (0.9%) stddev-sans-first:0.88 12:17:32 INFO - PROCESS | 1978 | Values: 91.0 91.0 90.0 91.0 90.0 91.0 92.0 89.0 90.0 90.0 12:17:32 INFO - PROCESS | 1978 | 12:17:32 INFO - PROCESS | 1978 | [#6] imaging-darkroom Cycles:10 Average:106.50 Median:95.50 stddev:19.35 (20.3%) stddev-sans-first:20.15 12:17:32 INFO - PROCESS | 1978 | Values: 96.0 100.0 94.0 135.0 149.0 107.0 96.0 96.0 97.0 95.0 12:17:32 INFO - PROCESS | 1978 | 12:17:32 INFO - PROCESS | 1978 | [#7] imaging-desaturate Cycles:10 Average:91.40 Median:84.00 stddev:15.04 (17.9%) stddev-sans-first:15.71 12:17:32 INFO - PROCESS | 1978 | Values: 84.0 84.0 83.0 86.0 101.0 130.0 97.0 82.0 84.0 83.0 12:17:32 INFO - PROCESS | 1978 | 12:17:32 INFO - PROCESS | 1978 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:63.00 stddev:1.69 (2.7%) stddev-sans-first:1.79 12:17:32 INFO - PROCESS | 1978 | Values: 63.0 61.0 61.0 60.0 63.0 63.0 63.0 65.0 65.0 64.0 12:17:32 INFO - PROCESS | 1978 | 12:17:32 INFO - PROCESS | 1978 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:59.00 stddev:3.95 (6.7%) stddev-sans-first:3.66 12:17:32 INFO - PROCESS | 1978 | Values: 55.0 59.0 68.0 66.0 63.0 58.0 59.0 59.0 59.0 59.0 12:17:32 INFO - PROCESS | 1978 | 12:17:32 INFO - PROCESS | 1978 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:89.00 stddev:7.38 (8.3%) stddev-sans-first:7.78 12:17:32 INFO - PROCESS | 1978 | Values: 90.0 98.0 97.0 96.0 88.0 79.0 80.0 80.0 83.0 85.0 12:17:32 INFO - PROCESS | 1978 | 12:17:32 INFO - PROCESS | 1978 | [#11] stanford-crypto-ccm Cycles:10 Average:141.40 Median:138.00 stddev:16.06 (11.6%) stddev-sans-first:16.98 12:17:32 INFO - PROCESS | 1978 | Values: 138.0 137.0 125.0 133.0 134.0 136.0 138.0 138.0 183.0 152.0 12:17:32 INFO - PROCESS | 1978 | 12:17:32 INFO - PROCESS | 1978 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.00 Median:162.50 stddev:21.36 (13.1%) stddev-sans-first:22.41 12:17:32 INFO - PROCESS | 1978 | Values: 163.0 212.0 213.0 162.0 161.0 162.0 163.0 161.0 161.0 162.0 12:17:32 INFO - PROCESS | 1978 | 12:17:32 INFO - PROCESS | 1978 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.00 stddev:1.26 (2.0%) stddev-sans-first:1.24 12:17:32 INFO - PROCESS | 1978 | Values: 65.0 63.0 66.0 64.0 64.0 62.0 63.0 63.0 62.0 64.0 12:17:32 INFO - PROCESS | 1978 | -------- Summary: end -------- 12:17:32 INFO - PROCESS | 1978 | 12:17:33 INFO - TEST-INFO | 1978: exit 0 12:17:33 INFO - TEST-OK | kraken | took 59827ms 12:17:33 INFO - SUITE-END | took 1179s 12:17:33 INFO - Completed test suite (00:19:39) 12:17:33 INFO - javascript benchmark 12:17:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7862.494209868132, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3493.3013397320537, 3503.7021853142483, 3507.035565219565, 3534.4874993125995, 3541.9468707969368, 6060.636361818289, 6085.908711369333, 6088.117223002662, 6089.695515224238, 6108.602940808844, 6031.095335699647, 6105.114758360035, 6107.541934354919, 6114.5108391328695, 6122.204113465244, 5386.542143917772, 5418.8916221675545, 5426.701531415771, 5439.456054394568, 5551.500364967153, 5312.946870531303, 5313.309269794921, 5365.356157261114, 5525.585581081435, 5528.281323427948, 5428.158635411518, 5443.618946673734, 5445.292112025451, 5447.809326673548, 5456.836294911159, 5432.320959880015, 5448.046591846431, 5450.645708029005, 5452.591055670801, 5456.91814622781, 5278.709670968095, 5401.864953376158, 5405.378381486101, 5422.213779002062, 5455.345358556999, 6100.0, 6101.694915254264, 6102.359252278491, 6108.755649774003, 6110.602810817327, 6205.875882482325, 6239.906401403982, 6246.593971391845, 6271.122042913996, 6335.366463353674, 6579.769708060243, 6583.835404114888, 6584.440322572587, 6587.80236592903, 6591.143151390289, 6170.5372097092895, 6202.41077097675, 6202.875942481171, 6207.317195108534, 6213.068039794022, 6293.748250069946, 6380.84047898797, 6454.709538070798, 6705.865882682319, 6718.932810671929, 4915.410150781929, 6259.593126446766, 6285.779997700059, 6309.716062777186, 6354.904676429857, 6498.447631951242, 6507.544471886922, 6510.348965103546, 6512.804615861532, 6527.249366322933, 5341.439148889388, 6103.277060575968, 6392.872142557216, 6433.356664333529, 6453.193350831146, 6290.24517057956, 6306.432421082125, 6337.081123237197, 6432.935670643327, 6443.420092191632, 5256.684598924, 5256.842294731164, 5258.421573626898, 5277.762500687479, 5282.867928301823, 4625.468071171791, 4660.557247061523, 4671.416072990876, 4673.626109911199, 4692.272697731857, 5976.701164941735, 6022.608530445507, 6108.736706092798, 6113.358097399798, 6114.724837382329, 6449.322821103717, 6516.218053833571, 6516.869662606721, 6521.934780652227, 6535.607863528108, 6206.10011548332, 6224.906626400608, 6227.595206311666, 6230.034344676583, 6230.6884655767935, 5489.2589500417735, 5546.722663866791, 5650.29371328584, 5709.68596727184, 5728.0, 6454.483641308684, 6608.43828274602, 6675.6995935184, 6726.630035347907, 6764.154480689914, 6494.642794646151, 6545.901811472927, 6560.475161987125, 6563.0811686364905, 6568.277489476058, 6672.566283191577, 6741.2921643226755, 6765.42493888025, 6765.458763299022, 6766.560173588701, 6265.843353916006, 6316.6841657916, 6335.873282534416, 6369.8726025480155, 6434.8391290218115, 6479.838004049937, 6508.544401892012, 6513.837154071186, 6515.576487528296, 6524.67376631176, 6274.874502510015, 6301.369863013662, 6346.079818426395, 6362.141110949962, 6362.77730279438, 5190.351206099238, 6204.255489341127, 6219.160413344322, 6343.429091381798, 6369.267534233437, 5429.375621803385, 6235.532335074797, 6238.0, 6276.466500347339, 6282.623042617458, 6200.0, 6267.561270711007, 6311.747530098744, 6335.936640633535, 6341.429271365415, 6148.538859585459, 6182.598131121463, 6202.038684003986, 6219.160413344322, 6226.034964580497], "value": 5948.375191981195, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [779.1079214299627, 814.3363159025394, 826.3348004856092, 906.2659246010728, 915.3958387464274, 29928.0, 41917.37123943139, 42083.99999999996, 42100.578994210126, 42289.36565951513, 40716.59283407165, 40886.38670419946, 41120.99999999993, 42661.57338426615, 42715.786421067925, 8076.0, 9636.90363096367, 9812.46031468269, 9817.656382026631, 9822.705318840446, 8163.0, 11955.163138580303, 12101.878981210208, 12369.567065152722, 12380.442880070374, 12181.025517958586, 12184.634460966185, 12189.085818563599, 12216.389180540982, 12218.63344099674, 12153.635390938285, 12172.26966382011, 12182.390880455987, 12198.0, 12207.145499815017, 11670.766584668345, 11696.883031169664, 11715.0, 11716.062714982781, 11716.23844450108, 40656.39015414771, 40920.38619420711, 40970.1805963882, 41011.17977640431, 41026.0, 4054.4729185205733, 4064.6748260139116, 4070.8450950513293, 4091.488563929509, 4116.0533077392065, 28518.857405713046, 29316.97390591319, 30476.54285185724, 30943.381132377228, 31038.534421983688, 3158.4738999618435, 3282.6553211912883, 3321.8837340692958, 3418.4701371287492, 3419.9316013679836, 355928.0, 360757.0, 361794.0, 361941.0, 362320.18839905894, 54120.18819717707, 54148.187777183375, 54192.0, 54197.1870421944, 54282.7285863576, 57098.714506427204, 57135.14297285544, 57223.713881430325, 57280.56316621016, 57430.712846436334, 15628.140452275235, 15723.842761572238, 15746.291416886268, 15757.606059848365, 15762.448314309173, 11901.107416943763, 12058.819117713241, 13313.40089695966, 13381.264030478416, 13388.06283560161, 11420.543178272943, 11477.598284060017, 11478.483468243949, 11483.081353491702, 11512.827307590393, 4952.579030782352, 6139.447449729546, 6200.441960223601, 6214.937850621526, 6222.408871157233, 963.5519483440233, 982.4301904895144, 983.8622592837008, 991.965281215154, 1011.8330475471612, 29922.850385747934, 30668.69331306703, 30794.692053079183, 31156.75718627708, 31494.0, 1056.9365838049587, 1065.2969040433277, 1066.8826429092794, 1102.3165637304921, 1103.0568863621647, 12444.626661200178, 13202.613725558871, 15461.9226903867, 15550.066995980278, 15587.688246235011, 368487.1575642105, 422927.0, 442825.0, 443744.0, 444223.0, 50072.0, 62597.68701156465, 63928.36071639224, 63985.0, 64016.0, 1472.4699108320997, 1507.6532397548406, 1508.8792896568468, 1525.305985776469, 1525.862672359493, 30304.393912122076, 31312.843435782674, 31477.527837082922, 31488.527672085394, 32061.0, 50743.49256507387, 50825.23762143645, 50889.23666145085, 50896.74551627218, 51030.74484627553, 424972.0, 425016.0, 425078.0, 425791.7420825752, 425993.0, 36401.0, 37297.44053839249, 37621.0, 37641.0, 37677.0, 45921.54078459173, 46603.53396465992, 46719.76640116778, 47045.58863234108, 47201.05597887954, 28619.284517886386, 28893.133206003855, 31755.523667145473, 32624.510632340058, 33024.0, 31345.686543134278, 31981.0, 32269.838650806596, 32482.0, 32517.0, 37957.0, 38123.42814857835, 38873.80563097166, 38892.80553597214, 38935.80532097322, 37288.627113728515, 38278.42582361322, 39219.41170882382, 40188.59811401965, 40511.594884050784, 30553.54169687501, 31838.36323273568, 31927.36145277035, 31968.040958770343, 32583.348333032733], "value": 20010.413988014378, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.4572959155654, 406.24844038528727, 416.1053734470887, 421.5236782435847, 457.1930542592325, 21187.788122118793, 21772.80249586274, 22521.436964075907, 22570.097196112158, 22860.199893003748, 18497.630047399045, 21019.894900525513, 21695.45761355963, 22861.657075143885, 24388.78056097197, 5850.946829570676, 5897.439743224398, 7154.749583764569, 7201.0, 7205.351518363373, 6934.791956241321, 6941.965290173542, 6977.651117444133, 7017.6140312282805, 7056.753013644524, 6740.696668649898, 7028.297170282956, 7048.154221493428, 7067.363937245646, 7119.9288007119785, 6899.206591242021, 6945.861082778341, 6968.79093627192, 6969.965150174242, 6987.301269872997, 6550.868982620321, 6930.896036559456, 6944.895826562605, 6945.305469453065, 6957.686904089278, 27923.860380697966, 28320.291992700142, 28414.28964275889, 28418.715812841812, 28680.13959581195, 2953.7636989040825, 3238.983805080983, 3538.327717733622, 3588.6743300332237, 3649.0147660131615, 16321.918390407973, 16330.938488998177, 16355.59111022222, 16383.59041023972, 16686.9153505023, 1877.7652793400825, 2037.6739721644465, 2112.904919278636, 2167.6098302305577, 2187.332863476639, 150212.0, 156080.0, 158207.41792582156, 158460.62309065487, 159804.0, 16506.092164930804, 20866.47833804167, 21026.684599731016, 21131.0, 21197.470063248544, 32623.51064734031, 33283.500747488804, 33302.833485832416, 33309.50035749466, 33361.332773344395, 10725.30285531438, 10863.45682715861, 11022.614208502664, 11040.392778397105, 11183.888161118448, 7354.521956072838, 9213.493257870881, 9247.213986811063, 9403.200727938201, 9441.716748497556, 9456.763580910532, 9487.383320084173, 9551.47466889314, 9642.517874106266, 9698.70903872885, 3407.761456698057, 3464.6535346465657, 4106.782337537756, 4106.856260030944, 4123.443335149716, 706.3352105732183, 974.6539978307599, 1068.8129577323937, 1083.1767856429012, 1086.1582273737915, 22403.439914001956, 22714.20500282515, 22766.31701048971, 22771.544569108526, 22856.65715014276, 1051.5636011055326, 1060.6287799270194, 1077.5743581285506, 1094.7919895219882, 1102.1238115698038, 11257.718557035976, 11833.940830295793, 12045.39773011346, 12091.516339346328, 12368.628941131781, 732005.0, 741848.0, 744763.0, 757479.0, 773830.1308493421, 111106.44446777714, 120817.5836483283, 144324.0, 147300.5269947287, 150686.0, 1074.9801113762865, 1228.6621179175797, 1268.1820225954393, 1271.1864406779669, 1274.5220542296638, 15207.923960380127, 19899.701504477154, 20987.790122098584, 21256.574868502852, 21298.25456109029, 62204.06693899685, 63503.6824815873, 63831.723365533355, 65136.674316628116, 65741.027769167, 71092.0, 86545.56727216576, 86947.56526217329, 87484.5625771867, 88638.55680721556, 11838.704032399259, 12067.336296503776, 12213.755724885275, 12324.445399957203, 12363.75272494563, 13580.52468163649, 13703.246321452018, 13717.725645487233, 13863.514776982756, 14078.225697586322, 11059.944700276768, 11278.943605281922, 11355.716107097389, 11381.54473821071, 11730.70673233176, 8768.386212965032, 10946.945265273622, 11169.162312826407, 11395.259308144945, 11481.138914581607, 11793.823092653445, 11807.406000189865, 11826.290422574673, 11868.287902725864, 11976.640700778991, 11137.94431027872, 11883.702907427038, 12203.63389098293, 12249.632511024683, 12264.448099835707, 10604.939506049333, 11261.605843795427, 11699.649010529698, 11958.402079896145, 11997.220180688228], "value": 11873.773090008848, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1605.66281080973, 1618.0776957134424, 1628.9918550407253, 1646.9752953705693, 1657.5856035991005, 10735.0, 11434.0, 11445.656630301084, 11453.599124030661, 11467.59863404781, 10821.891781082188, 11111.72220694483, 11270.887291127106, 11310.547578096866, 11322.490487928042, 2003.8396928245706, 2460.1635443949053, 2461.618449140386, 2461.938451538708, 2466.0382450844186, 2324.9651255231183, 2377.6671266022686, 2388.486475407787, 2390.3546042568496, 2425.6725342078857, 2322.7909488146065, 2351.3533778211045, 2368.0291080656934, 2451.669024681672, 2456.9017239310497, 2093.701904819007, 2300.5283916797016, 2407.41018450479, 2413.6017557103055, 2419.733829278778, 2408.6989126359204, 2427.927162185137, 2437.110454684045, 2438.6220135878966, 2440.6217036359394, 10977.560897564088, 11173.0, 11204.21570490066, 11213.383263920481, 11220.438978051146, 5690.715464226813, 5934.317553481319, 5947.851303717398, 5960.582759206857, 5961.8807623847715, 3500.9474857877153, 3637.963620363789, 3662.505561749156, 3704.592494825567, 3756.398976163828, 1243.0180157675425, 1245.2901845947813, 1289.7162624222656, 1296.753616812812, 1307.9084464087423, 13871.0, 14093.5067272646, 14506.637334066627, 15592.0, 15836.287367068395, 4549.158405694957, 4720.598749106364, 4743.501932297059, 4760.45254795696, 4762.285657151455, 10320.845187322197, 12071.456784444721, 12072.396380181131, 12078.456469458895, 12092.87907120935, 4960.082384758831, 5511.889762204813, 5670.5180059695385, 5694.088945768657, 5696.971515142481, 5176.689398636094, 5278.604104692086, 5304.840854774363, 5346.732663366816, 5362.2224777407055, 3844.4809950656863, 3875.198032914652, 3888.1446081861945, 3935.9212815743526, 3958.1094253793244, 1006.4766321512773, 1008.193445243802, 1015.0914931136591, 1017.7710015246511, 1024.8155332040155, 914.5107367558325, 938.3478482454765, 972.9902700973041, 981.7741919358444, 1004.2869562610482, 6554.213494380705, 6581.308962558958, 6611.371919667624, 6689.899651505231, 6764.0, 783.9608019599111, 933.4679232837218, 934.61210102997, 990.9207263418909, 1034.332855308322, 3516.9472457913153, 4168.083021735213, 4177.060161463707, 4181.581841815855, 4276.679249056333, 13481.730365392637, 14101.435942562182, 14126.364313605913, 14143.64640883986, 14147.646308842155, 13027.544035958696, 13435.529756458476, 13773.38019789112, 13775.517856874962, 13877.514286999907, 10089.293749437616, 10319.122874555747, 10363.689089327332, 10380.740481488023, 10381.0, 6505.186851643544, 6756.493263005393, 6846.520743547904, 6995.160580730345, 7003.719851206099, 10962.177836662442, 11091.389973551532, 12067.75864482723, 12751.362431878555, 12799.744005120032, 10576.41829699374, 12393.194442361219, 12596.181248218836, 12669.429875655433, 12817.423215955117, 9079.364444488823, 9210.9539452305, 9308.44149351014, 9310.975792662666, 9322.48726320059, 8606.741797745826, 10306.381617102998, 10415.94792026035, 10417.374957502574, 10423.530941107516, 8655.17775811297, 8874.334424918286, 8894.555272236234, 8939.329550283885, 9080.682176123804, 8517.063123056583, 8547.102554231964, 8553.87169192475, 8615.267702245379, 8643.956780216058, 8025.678972841021, 8195.221453961864, 8206.015278166658, 8212.548309843016, 8214.219649133323, 5890.705464726832, 5914.940850591611, 5945.34601193877, 6106.938930610637, 6161.4146656067605, 5969.76120955157, 6011.917854786006, 6129.2032035835055, 6183.938160618516, 6301.275353334425], "value": 5161.678729288977, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.55330709762467, 383.3081288274663, 383.82344121704017, 386.3451449792601, 390.04439124145847, 4415.8233670653135, 4861.6353773467, 5058.797648094076, 5071.087204303224, 5236.188390799422, 4422.38086667866, 4561.1105834362315, 4631.536846315366, 4734.952650473494, 5077.461269365317, 3210.7752457327997, 3402.0134161093315, 3961.7028722845757, 4244.561904857061, 4265.229929579221, 3585.8924232273075, 4176.331786914095, 4270.935935960963, 4274.760319507339, 4331.9423273944785, 3652.6529979652023, 3946.565877753445, 4253.447491665535, 4271.530131685512, 4298.355246713002, 3553.662402071799, 3978.880633581012, 4240.597143271384, 4278.893027674302, 4293.484781826185, 3188.0, 3658.2134841009047, 3756.906077348061, 3929.390944403622, 3968.2024172957995, 4965.726885021322, 4992.279207831704, 5015.423226328946, 5021.372328458942, 5028.472010438888, 3966.560565252349, 4225.640820530228, 4375.2999520076955, 4910.926336104962, 4919.458859525449, 4475.7985890635, 4674.532546745332, 5187.847043476952, 5415.943890941268, 5435.239066530649, 3578.7254661984252, 3803.904902377435, 3868.516435445569, 4353.346997950302, 4362.760048197348, 4850.59332793493, 5435.945640543583, 5560.332760068777, 5735.770569177228, 5739.713014349308, 4296.957030429656, 4436.578525040116, 4439.3819037484345, 4439.400680908101, 4442.711223770445, 3920.0203897031815, 4048.291548978917, 4486.842960496367, 4503.73895309314, 4556.270996640522, 4878.390131256677, 4907.263910413395, 4913.459519452857, 4943.72809495474, 4994.901121753209, 4800.167900938463, 4826.8793280168275, 5198.9740051299505, 5291.809342897895, 5484.287042684426, 1334.0, 1364.40648317982, 1511.916844573537, 1538.99230503849, 1540.8767298616083, 1073.4900922062113, 1095.2442814457997, 1169.1990986174499, 1177.381874515886, 1178.7347846734588, 4507.444931498628, 4834.446681688956, 4940.8764780880765, 5116.74416279192, 5184.948150518522, 5142.434332223453, 5685.0, 5690.459406356389, 5701.00232459318, 5729.942700573024, 4077.1437998020747, 4755.216793702361, 4976.889444097439, 5157.4584668610005, 5175.689458632494, 2644.286042768442, 2821.943561128766, 2874.2526942994973, 2947.1011341540607, 2947.778916581265, 5011.34852469184, 5806.709664516758, 5833.0, 5851.707414629252, 5879.588428810028, 5276.918231762479, 5313.707746073926, 5444.5916556258435, 5729.8772169167905, 5800.709964501758, 4939.728314942641, 5196.1034222508515, 5414.214938833847, 5835.7373918174635, 5862.677552734555, 4946.3817022872145, 4975.825846095369, 4993.850184494471, 5306.761195746123, 5650.547956163415, 4899.16714158601, 4950.529699678525, 5264.868053368544, 5535.972320138373, 5617.803376881953, 5445.0, 5647.774089036392, 5815.302163740378, 5820.933568583092, 5858.355580886185, 4019.979900100481, 4431.404694309981, 4454.732716037048, 4457.8216871324785, 4467.8212871484775, 4694.483606803317, 5162.7542019221755, 5238.921416178837, 5328.907573947254, 5657.4908258256955, 5405.8107966221, 5464.104024866827, 5492.505674489315, 5497.835064948058, 5529.50703310112, 4865.562099410929, 4945.23348880924, 4972.0, 5452.265198339151, 5489.286392768914, 4181.477315335583, 5146.76839542229, 5248.52763251294, 5260.395054568774, 5334.333208348957, 4382.934255986226, 5417.29575155243, 5418.295621569171, 5437.782488700408, 5453.982026650006, 4937.481564435682, 5295.822506496225, 5298.880447820902, 5314.883874386423, 5345.1447768356875], "value": 4130.223560632078, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [779.1818590479994, 785.8389030248796, 809.68422315297, 865.6234537975981, 869.6869127114239, 15182.620434489143, 18086.186121624527, 18115.456536303915, 18139.90930045348, 18159.45521634353, 16080.437184698538, 16201.594960125973, 16265.756013659804, 16266.75599866003, 16291.674166516692, 1002.3184234720387, 1015.192921627308, 1022.7494263905354, 1026.035526604989, 1027.9280450368476, 998.1166667499243, 1004.2618675273668, 1005.0100650858934, 1005.7636455432968, 1006.9295149339549, 1031.5048776587244, 1037.7094413564214, 1039.3504059962524, 1040.7866387390566, 1040.921930855185, 1046.9057784799365, 1059.809234337819, 1059.90990765785, 1064.6433444796003, 1068.172166570906, 777.6889244302267, 778.4122987144726, 779.380392587894, 780.0288640642436, 780.2821404307994, 16697.332106715716, 16978.151092445452, 17085.231164597622, 17304.0, 17764.37824676143, 14543.563693089225, 14571.19858407787, 14615.0, 14683.192424416653, 14850.0, 11860.52557897683, 12062.758744825142, 12169.634910952685, 12221.266723996589, 12306.0, 3718.9814050929845, 3887.300285948528, 3911.963329717627, 3953.2686453006286, 4009.258287216874, 99974.99999999927, 108920.4553977225, 109209.0, 109816.35275470874, 110780.0, 11300.378479183559, 11508.827367589492, 11681.88318116825, 11788.823167652492, 11969.102317326235, 23490.64764028541, 23650.7634923652, 23874.403139921294, 23899.402514937265, 23909.0, 8080.232377924088, 8110.188981101843, 8115.75652730419, 8126.471779334324, 8259.050209226016, 4574.817007319736, 4588.403507543998, 4656.4877863434995, 4679.485256621769, 4881.292212629149, 3567.4292113261754, 3659.213269147146, 3661.908452288714, 3674.154944362758, 3675.2649470106085, 641.7400952614199, 697.3653974882832, 716.4304378019488, 733.5561984999106, 734.6510407556368, 723.5224751663876, 739.3309055304958, 743.6765007221876, 746.6677328588726, 761.1893333599809, 10683.30558513694, 10724.463776811284, 10827.187960902964, 11219.439028048564, 11395.943020284845, 568.7042737776333, 573.7001176184524, 655.131950166032, 701.4949236549676, 761.1323091675495, 4867.513248675175, 4999.75001249936, 5207.583393328525, 5227.625939161131, 5287.535109054814, 84520.0, 94898.0510194903, 100406.4979675097, 102752.48623756833, 103605.48197258965, 78322.6083869577, 86254.0, 89870.0, 90656.0, 93662.53168734112, 80275.59862200651, 80898.19101809025, 81284.59357703292, 81616.0, 82892.58553707192, 8248.340132789242, 10017.5492102857, 10255.07704306616, 10276.588936442458, 10292.691219263434, 50497.24254136117, 50988.49011509837, 51418.0, 51717.7414112927, 53127.468725313796, 65780.0, 65954.34045659674, 66264.00603991041, 67025.66487167533, 67369.0, 12682.492700292254, 12705.301208433624, 12924.806127907901, 12971.785268414482, 13075.934620327218, 13076.084674073105, 13151.796060255092, 13819.79270310926, 13935.47356652279, 14025.018248722492, 12079.939600301943, 12625.747485050431, 12788.936055319664, 12952.28762418076, 13000.609981700563, 12427.875721242672, 12756.0, 12762.192317690093, 13163.210207387587, 13288.402021908843, 12190.878091218974, 12322.322272274752, 12711.173773704679, 12809.0, 12901.612951611467, 9162.358634895494, 9214.723558293263, 9221.861672075058, 9297.67458138962, 9695.0, 9093.726878237185, 10253.231007674305, 10511.632092876713, 10651.78797869646, 10737.516811743646], "value": 7839.88666189526, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1461.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 114.0, 115.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 111.0, 94.0, 157.0, 139.0, 164.0, 105.0, 107.0, 128.0, 107.0], "value": 125.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 186.0, 207.0, 263.0, 197.0, 182.0, 187.0, 183.0, 184.0], "value": 195.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 84.0, 84.0, 118.0, 66.0, 59.0, 58.0, 59.0, 75.0, 58.0], "value": 75.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 69.0, 88.0, 70.0, 69.0, 67.0, 82.0, 69.0, 68.0, 83.0], "value": 75.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 90.0, 91.0, 90.0, 91.0, 92.0, 89.0, 90.0, 90.0], "value": 90.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 100.0, 94.0, 135.0, 149.0, 107.0, 96.0, 96.0, 97.0, 95.0], "value": 106.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 86.0, 101.0, 130.0, 97.0, 82.0, 84.0, 83.0], "value": 91.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 61.0, 60.0, 63.0, 63.0, 63.0, 65.0, 65.0, 64.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 59.0, 68.0, 66.0, 63.0, 58.0, 59.0, 59.0, 59.0, 59.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 98.0, 97.0, 96.0, 88.0, 79.0, 80.0, 80.0, 83.0, 85.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 125.0, 133.0, 134.0, 136.0, 138.0, 138.0, 183.0, 152.0], "value": 141.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 212.0, 213.0, 162.0, 161.0, 162.0, 163.0, 161.0, 161.0, 162.0], "value": 172.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 66.0, 64.0, 64.0, 62.0, 63.0, 63.0, 62.0, 64.0], "value": 63.6, "unit": "score"}]}]} 12:17:33 INFO - Return code: 0 12:17:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:17:34 INFO - # TBPL SUCCESS # 12:17:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:17:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:17:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:17:34 INFO - 2017-05-26 12:17:34.066 screenresolution[1982:279886] starting screenresolution argv=screenresolution get 12:17:34 INFO - 2017-05-26 12:17:34.068 screenresolution[1982:279886] Display 0: 1600x1200x32@60 12:17:34 INFO - 2017-05-26 12:17:34.074 screenresolution[1983:279889] starting screenresolution argv=screenresolution list 12:17:34 INFO - Available Modes on Display 0 12:17:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:17:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:17:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:17:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:17:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:17:34 INFO - Intel Iris: 12:17:34 INFO - Chipset Model: Intel Iris 12:17:34 INFO - Type: GPU 12:17:34 INFO - Bus: Built-In 12:17:34 INFO - VRAM (Dynamic, Max): 1536 MB 12:17:34 INFO - Vendor: Intel (0x8086) 12:17:34 INFO - Device ID: 0x0a2e 12:17:34 INFO - Revision ID: 0x0009 12:17:34 INFO - Displays: 12:17:34 INFO - Display: 12:17:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:17:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:17:34 INFO - Display Serial Number: 1600x1200 60 12:17:34 INFO - Main Display: Yes 12:17:34 INFO - Mirror: Off 12:17:34 INFO - Online: Yes 12:17:34 INFO - Rotation: Supported 12:17:34 INFO - Return code: 0 12:17:34 INFO - Running post-action listener: _resource_record_post_action 12:17:34 INFO - [mozharness: 2017-05-26 19:17:34.309133Z] Finished run-tests step (success) 12:17:34 INFO - Running post-run listener: _resource_record_post_run 12:17:34 INFO - Total resource usage - Wall time: 1195s; CPU: 54.0%; Read bytes: 1649664; Write bytes: 421434368; Read time: 23; Write time: 1358 12:17:34 INFO - TinderboxPrint: CPU usage
53.8% 12:17:34 INFO - TinderboxPrint: I/O read bytes / time
1,649,664 / 23 12:17:34 INFO - TinderboxPrint: I/O write bytes / time
421,434,368 / 1,358 12:17:34 INFO - TinderboxPrint: CPU idle
2,209.4 (46.2%) 12:17:34 INFO - TinderboxPrint: CPU system
953.0 (19.9%) 12:17:34 INFO - TinderboxPrint: CPU user
1,619.3 (33.9%) 12:17:34 INFO - TinderboxPrint: Swap in / out
139,665,408 / 0 12:17:34 INFO - install - Wall time: 16s; CPU: 54.0%; Read bytes: 117447168; Write bytes: 113184768; Read time: 10873; Write time: 246 12:17:34 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 1649664; Write bytes: 297448448; Read time: 23; Write time: 1074 12:17:34 INFO - Running post-run listener: _upload_blobber_files 12:17:34 INFO - Blob upload gear active. 12:17:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:17:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:17:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:17:35 INFO - (blobuploader) - INFO - Open directory for files ... 12:17:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:17:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:17:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:17:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:17:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:17:35 INFO - (blobuploader) - INFO - Done attempting. 12:17:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:17:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:17:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:17:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:17:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:17:37 INFO - (blobuploader) - INFO - Done attempting. 12:17:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:17:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:17:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:17:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:17:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:17:38 INFO - (blobuploader) - INFO - Done attempting. 12:17:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:17:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:17:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:17:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:17:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:17:40 INFO - (blobuploader) - INFO - Done attempting. 12:17:40 INFO - (blobuploader) - INFO - Iteration through files over. 12:17:40 INFO - Return code: 0 12:17:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:17:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:17:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a2ce537d3023325105cdcfd0bfa1db0e3de65ab6b0aeacab8a0f66c118a6bbde26a36ef8e7107d28e6fd44622652cd5d712cc8258c89825112fd43090ef93820", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/140374eee8379fccb43c5be87a852514acea529efacbd3165bcb421d22d48e826d3fb4c4a8483de1f0a264d27c76d9cb366e89c542e67a0a9c43ffa8bd0b1ca4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f39f40f70d87328e4e948f6331e8f8903fffb870e885254ebe31ecafb14f3e4b2dbc8c4d6394839f340718ef58c8cadb3c4b5c2fe8ef814496a6bd4641c29950", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cabd6587e183d99794039aef6c3f017399780f01d046bf45971a5e78293714043eb4fc6b16e4846f65637beaa4d56b17dd262fd82139eb508401ef7ace85f1d8"} 12:17:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:17:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:17:40 INFO - Contents: 12:17:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a2ce537d3023325105cdcfd0bfa1db0e3de65ab6b0aeacab8a0f66c118a6bbde26a36ef8e7107d28e6fd44622652cd5d712cc8258c89825112fd43090ef93820", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/140374eee8379fccb43c5be87a852514acea529efacbd3165bcb421d22d48e826d3fb4c4a8483de1f0a264d27c76d9cb366e89c542e67a0a9c43ffa8bd0b1ca4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f39f40f70d87328e4e948f6331e8f8903fffb870e885254ebe31ecafb14f3e4b2dbc8c4d6394839f340718ef58c8cadb3c4b5c2fe8ef814496a6bd4641c29950", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cabd6587e183d99794039aef6c3f017399780f01d046bf45971a5e78293714043eb4fc6b16e4846f65637beaa4d56b17dd262fd82139eb508401ef7ace85f1d8"} 12:17:40 INFO - Running post-run listener: copy_logs_to_upload_dir 12:17:40 INFO - Copying logs to upload dir... 12:17:40 INFO - mkdir: /builds/slave/test/build/upload/logs 12:17:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.056568 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-05-26 12:17:40.597485) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-26 12:17:40.601242) ========= 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.PBstSXiGnD/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.PfmMset1f7/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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/a2ce537d3023325105cdcfd0bfa1db0e3de65ab6b0aeacab8a0f66c118a6bbde26a36ef8e7107d28e6fd44622652cd5d712cc8258c89825112fd43090ef93820", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/140374eee8379fccb43c5be87a852514acea529efacbd3165bcb421d22d48e826d3fb4c4a8483de1f0a264d27c76d9cb366e89c542e67a0a9c43ffa8bd0b1ca4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f39f40f70d87328e4e948f6331e8f8903fffb870e885254ebe31ecafb14f3e4b2dbc8c4d6394839f340718ef58c8cadb3c4b5c2fe8ef814496a6bd4641c29950", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cabd6587e183d99794039aef6c3f017399780f01d046bf45971a5e78293714043eb4fc6b16e4846f65637beaa4d56b17dd262fd82139eb508401ef7ace85f1d8"} build_url:https://queue.taskcluster.net/v1/task/XazcW0iSTz2e7eUi5pYyWA/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011284 build_url: 'https://queue.taskcluster.net/v1/task/XazcW0iSTz2e7eUi5pYyWA/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/a2ce537d3023325105cdcfd0bfa1db0e3de65ab6b0aeacab8a0f66c118a6bbde26a36ef8e7107d28e6fd44622652cd5d712cc8258c89825112fd43090ef93820", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/140374eee8379fccb43c5be87a852514acea529efacbd3165bcb421d22d48e826d3fb4c4a8483de1f0a264d27c76d9cb366e89c542e67a0a9c43ffa8bd0b1ca4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f39f40f70d87328e4e948f6331e8f8903fffb870e885254ebe31ecafb14f3e4b2dbc8c4d6394839f340718ef58c8cadb3c4b5c2fe8ef814496a6bd4641c29950", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cabd6587e183d99794039aef6c3f017399780f01d046bf45971a5e78293714043eb4fc6b16e4846f65637beaa4d56b17dd262fd82139eb508401ef7ace85f1d8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-26 12:17:40.634761) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 12:17:40.635365) ========= 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.PBstSXiGnD/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.PfmMset1f7/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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.005072 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 12:17:40.684707) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-26 12:17:40.685027) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-26 12:17:40.685336) ========= ========= Total master_lag: 0.18 =========