builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0199 starttime: 1486649480.36 results: success (0) buildid: 20170209051221 builduid: 249ca57e356d450385b1d58566a2f58a revision: 1419fa7ee013b44501b90487bf8f8873dbaf3727 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 06:11:20.363204) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 06:11:20.363611) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 06:11:20.363882) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 06:11:20.389324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 06:11:20.389594) ========= 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.BPzWKj7672/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.BM2fe4JSY6/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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-02-09 06:11:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 24.6M=0s 2017-02-09 06:11:20 (24.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.146513 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 06:11:20.560006) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 06:11:20.563409) ========= 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.BPzWKj7672/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.BM2fe4JSY6/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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.027199 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 06:11:20.612836) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-09 06:11:20.613184) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1419fa7ee013b44501b90487bf8f8873dbaf3727 --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-aurora --rev 1419fa7ee013b44501b90487bf8f8873dbaf3727 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BPzWKj7672/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.BM2fe4JSY6/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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-02-09 06:11:20,722 truncating revision to first 12 chars 2017-02-09 06:11:20,723 Setting DEBUG logging. 2017-02-09 06:11:20,723 attempt 1/10 2017-02-09 06:11:20,723 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1419fa7ee013?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-09 06:11:22,874 unpacking tar archive at: mozilla-aurora-1419fa7ee013/testing/mozharness/ program finished with exit code 0 elapsedTime=2.423035 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-09 06:11:23.063719) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 06:11:23.064055) ========= script_repo_revision: 1419fa7ee013b44501b90487bf8f8873dbaf3727 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 06:11:23.067447) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 06:11:23.067714) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 06:11:23.087300) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-09 06:11:23.087571) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BPzWKj7672/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.BM2fe4JSY6/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 06:11:23 INFO - MultiFileLogger online at 20170209 06:11:23 in /builds/slave/test 06:11:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:11:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:11:23 INFO - {'append_to_log': False, 06:11:23 INFO - 'base_work_dir': '/builds/slave/test', 06:11:23 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:11:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:11:23 INFO - 'branch': 'Mozilla-Aurora', 06:11:23 INFO - 'buildbot_json_path': 'buildprops.json', 06:11:23 INFO - 'config_files': ('talos/mac_config.py',), 06:11:23 INFO - 'default_actions': ('clobber', 06:11:23 INFO - 'read-buildbot-config', 06:11:23 INFO - 'download-and-extract', 06:11:23 INFO - 'populate-webroot', 06:11:23 INFO - 'create-virtualenv', 06:11:23 INFO - 'install', 06:11:23 INFO - 'run-tests'), 06:11:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:11:23 INFO - 'download_minidump_stackwalk': True, 06:11:23 INFO - 'download_symbols': 'ondemand', 06:11:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:11:23 INFO - 'tooltool.py': '/tools/tooltool.py', 06:11:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:11:23 INFO - '/tools/misc-python/virtualenv.py')}, 06:11:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:11:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:11:23 INFO - 'installer_path': 'installer.exe', 06:11:23 INFO - 'log_level': 'info', 06:11:23 INFO - 'log_name': 'talos', 06:11:23 INFO - 'log_to_console': True, 06:11:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:11:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:11:23 INFO - 'opt_config_files': (), 06:11:23 INFO - 'pip_index': False, 06:11:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:11:23 INFO - 'cmd': ('bash', 06:11:23 INFO - '-c', 06:11:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:11:23 INFO - 'enabled': True, 06:11:23 INFO - 'halt_on_failure': False, 06:11:23 INFO - 'name': 'check_screen_resolution'},), 06:11:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:11:23 INFO - 'cmd': ('bash', 06:11:23 INFO - '-c', 06:11:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:11:23 INFO - 'enabled': True, 06:11:23 INFO - 'halt_on_failure': False, 06:11:23 INFO - 'name': 'check_screen_resolution'},), 06:11:23 INFO - 'run_cmd_checks_enabled': True, 06:11:23 INFO - 'sps_profile': False, 06:11:23 INFO - 'sps_profile_interval': 0, 06:11:23 INFO - 'suite': 'dromaeojs-e10s', 06:11:23 INFO - 'system_bits': '32', 06:11:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:11:23 INFO - 'title': 't-yosemite-r7-0199', 06:11:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:11:23 INFO - 'use_talos_json': True, 06:11:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:11:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:11:23 INFO - 'work_dir': 'build'} 06:11:23 INFO - [mozharness: 2017-02-09 14:11:23.309539Z] Running clobber step. 06:11:23 INFO - Running pre-action listener: _resource_record_pre_action 06:11:23 INFO - Running main action method: clobber 06:11:23 INFO - rmtree: /builds/slave/test/build 06:11:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:11:26 INFO - Running post-action listener: _resource_record_post_action 06:11:26 INFO - [mozharness: 2017-02-09 14:11:26.389765Z] Finished clobber step (success) 06:11:26 INFO - [mozharness: 2017-02-09 14:11:26.389982Z] Running read-buildbot-config step. 06:11:26 INFO - Running pre-action listener: _resource_record_pre_action 06:11:26 INFO - Running main action method: read_buildbot_config 06:11:26 INFO - Using buildbot properties: 06:11:26 INFO - { 06:11:26 INFO - "project": "", 06:11:26 INFO - "product": "firefox", 06:11:26 INFO - "script_repo_revision": "production", 06:11:26 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 06:11:26 INFO - "repository": "", 06:11:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 06:11:26 INFO - "buildid": "20170209051221", 06:11:26 INFO - "pgo_build": "False", 06:11:26 INFO - "basedir": "/builds/slave/test", 06:11:26 INFO - "buildnumber": 56, 06:11:26 INFO - "slavename": "t-yosemite-r7-0199", 06:11:26 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 06:11:26 INFO - "platform": "yosemite_r7", 06:11:26 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 06:11:26 INFO - "branch": "mozilla-aurora", 06:11:26 INFO - "repo_path": "releases/mozilla-aurora", 06:11:26 INFO - "revision": "1419fa7ee013b44501b90487bf8f8873dbaf3727", 06:11:26 INFO - "stage_platform": "macosx64", 06:11:26 INFO - "builduid": "249ca57e356d450385b1d58566a2f58a", 06:11:26 INFO - "slavebuilddir": "test" 06:11:26 INFO - } 06:11:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/IDa6-Oq5QDeZrlGz4nopxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 06:11:26 INFO - Running post-action listener: _resource_record_post_action 06:11:26 INFO - [mozharness: 2017-02-09 14:11:26.397233Z] Finished read-buildbot-config step (success) 06:11:26 INFO - [mozharness: 2017-02-09 14:11:26.397617Z] Running download-and-extract step. 06:11:26 INFO - Running pre-action listener: _resource_record_pre_action 06:11:26 INFO - Running main action method: download_and_extract 06:11:26 INFO - mkdir: /builds/slave/test/build/tests 06:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:26 INFO - trying https://queue.taskcluster.net/v1/task/IDa6-Oq5QDeZrlGz4nopxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 06:11:26 INFO - Downloading https://queue.taskcluster.net/v1/task/IDa6-Oq5QDeZrlGz4nopxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 06:11:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IDa6-Oq5QDeZrlGz4nopxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 06:11:27 INFO - Downloaded 1199 bytes. 06:11:27 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 06:11:27 INFO - Using the following test package requirements: 06:11:27 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 06:11:27 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:11:27 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 06:11:27 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:11:27 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 06:11:27 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:11:27 INFO - u'jsshell-mac.zip'], 06:11:27 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:11:27 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 06:11:27 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 06:11:27 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:11:27 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 06:11:27 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:11:27 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 06:11:27 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:11:27 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 06:11:27 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:11:27 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 06:11:27 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 06:11:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IDa6-Oq5QDeZrlGz4nopxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 06:11:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IDa6-Oq5QDeZrlGz4nopxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:11:27 INFO - Fetch https://queue.taskcluster.net/v1/task/IDa6-Oq5QDeZrlGz4nopxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 06:11:28 INFO - Expected file size: 16357926 06:11:28 INFO - Obtained file size: 16357926 06:11:35 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 06:11:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IDa6-Oq5QDeZrlGz4nopxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 06:11:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IDa6-Oq5QDeZrlGz4nopxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:11:35 INFO - Fetch https://queue.taskcluster.net/v1/task/IDa6-Oq5QDeZrlGz4nopxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 06:11:36 INFO - Expected file size: 16357926 06:11:36 INFO - Obtained file size: 16357926 06:11:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IDa6-Oq5QDeZrlGz4nopxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 06:11:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IDa6-Oq5QDeZrlGz4nopxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 06:11:42 INFO - Fetch https://queue.taskcluster.net/v1/task/IDa6-Oq5QDeZrlGz4nopxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 06:11:43 INFO - Expected file size: 14403485 06:11:43 INFO - Obtained file size: 14403485 06:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:44 INFO - trying https://queue.taskcluster.net/v1/task/IDa6-Oq5QDeZrlGz4nopxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 06:11:44 INFO - Downloading https://queue.taskcluster.net/v1/task/IDa6-Oq5QDeZrlGz4nopxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 06:11:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IDa6-Oq5QDeZrlGz4nopxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 06:11:46 INFO - Downloaded 73819668 bytes. 06:11:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IDa6-Oq5QDeZrlGz4nopxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 06:11:46 INFO - mkdir: /builds/slave/test/properties 06:11:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:11:46 INFO - Writing to file /builds/slave/test/properties/build_url 06:11:46 INFO - Contents: 06:11:46 INFO - build_url:https://queue.taskcluster.net/v1/task/IDa6-Oq5QDeZrlGz4nopxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 06:11:46 INFO - Running post-action listener: _resource_record_post_action 06:11:46 INFO - Running post-action listener: set_extra_try_arguments 06:11:46 INFO - [mozharness: 2017-02-09 14:11:46.915766Z] Finished download-and-extract step (success) 06:11:46 INFO - [mozharness: 2017-02-09 14:11:46.915892Z] Running populate-webroot step. 06:11:46 INFO - Running pre-action listener: _resource_record_pre_action 06:11:46 INFO - Running main action method: populate_webroot 06:11:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:11:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:11:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:11:46 INFO - '--tppagecycles', 06:11:46 INFO - '7'], 06:11:46 INFO - 'tests': ['tsvgm']}}, 06:11:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:11:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:11:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:11:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:11:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:11:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:11:46 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:11:46 INFO - 'talos_options': ['--disable-e10s'], 06:11:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:11:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:11:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:11:46 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:11:46 INFO - 'talos_options': ['--disable-e10s'], 06:11:46 INFO - 'tests': ['damp', 'tps']}, 06:11:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:11:46 INFO - 'tests': ['damp', 'tps']}, 06:11:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:11:46 INFO - 'tests': ['dromaeo_dom']}, 06:11:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:11:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:11:46 INFO - 'tests': ['basic_compositor_video']}, 06:11:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:11:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:11:46 INFO - 'tests': ['a11yr', 06:11:46 INFO - 'ts_paint', 06:11:46 INFO - 'tpaint', 06:11:46 INFO - 'sessionrestore', 06:11:46 INFO - 'sessionrestore_no_auto_restore', 06:11:46 INFO - 'tabpaint']}, 06:11:46 INFO - 'other-e10s': {'tests': ['a11yr', 06:11:46 INFO - 'ts_paint', 06:11:46 INFO - 'tpaint', 06:11:46 INFO - 'sessionrestore', 06:11:46 INFO - 'sessionrestore_no_auto_restore', 06:11:46 INFO - 'tabpaint']}, 06:11:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:11:46 INFO - 'ts_paint', 06:11:46 INFO - 'tpaint', 06:11:46 INFO - 'sessionrestore', 06:11:46 INFO - 'sessionrestore_no_auto_restore', 06:11:46 INFO - 'tabpaint']}, 06:11:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:11:46 INFO - 'ts_paint', 06:11:46 INFO - 'tpaint', 06:11:46 INFO - 'sessionrestore', 06:11:46 INFO - 'sessionrestore_no_auto_restore', 06:11:46 INFO - 'tabpaint']}, 06:11:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:11:46 INFO - 'tests': ['a11yr', 06:11:46 INFO - 'ts_paint', 06:11:46 INFO - 'tpaint', 06:11:46 INFO - 'sessionrestore', 06:11:46 INFO - 'sessionrestore_no_auto_restore', 06:11:46 INFO - 'tabpaint']}, 06:11:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:11:46 INFO - 'tests': ['a11yr', 06:11:46 INFO - 'ts_paint', 06:11:46 INFO - 'tpaint', 06:11:46 INFO - 'sessionrestore', 06:11:46 INFO - 'sessionrestore_no_auto_restore', 06:11:46 INFO - 'tabpaint']}, 06:11:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:11:46 INFO - 'tests': ['tsvgx', 06:11:46 INFO - 'tsvgr_opacity', 06:11:46 INFO - 'tart', 06:11:46 INFO - 'tscrollx', 06:11:46 INFO - 'cart', 06:11:46 INFO - 'tsvg_static']}, 06:11:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:11:46 INFO - 'tsvgr_opacity', 06:11:46 INFO - 'tart', 06:11:46 INFO - 'tscrollx', 06:11:46 INFO - 'cart', 06:11:46 INFO - 'tsvg_static']}, 06:11:46 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:11:46 INFO - 'talos_options': ['--disable-e10s'], 06:11:46 INFO - 'tests': ['tp5o']}, 06:11:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:11:46 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:11:46 INFO - 'talos_options': ['--disable-e10s', 06:11:46 INFO - '--xperf_path', 06:11:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:11:46 INFO - 'tests': ['tp5n']}, 06:11:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:11:46 INFO - 'talos_options': ['--xperf_path', 06:11:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:11:46 INFO - 'tests': ['tp5n']}}, 06:11:46 INFO - 'talos.zip': {'path': '', 06:11:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:11:46 INFO - Running post-action listener: _resource_record_post_action 06:11:46 INFO - [mozharness: 2017-02-09 14:11:46.934254Z] Finished populate-webroot step (success) 06:11:46 INFO - [mozharness: 2017-02-09 14:11:46.934368Z] Running create-virtualenv step. 06:11:46 INFO - Running pre-action listener: _resource_record_pre_action 06:11:46 INFO - Running main action method: create_virtualenv 06:11:46 INFO - Creating virtualenv /builds/slave/test/build/venv 06:11:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:11:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:11:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:11:47 INFO - Using real prefix '/tools/python27' 06:11:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:11:47 INFO - Installing distribute.............................................................................................................................................................................................done. 06:11:50 INFO - Installing pip.................done. 06:11:50 INFO - Return code: 0 06:11:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:11:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:11:50 INFO - Reading from file tmpfile_stdout 06:11:50 INFO - Output received: 06:11:50 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:11:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:50 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x108be7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffed8d555f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c5d30>, '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 0x1088ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089babe8>, '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.BPzWKj7672/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.BM2fe4JSY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:11:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:11:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:11:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BPzWKj7672/Render', 06:11:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:11:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:11:50 INFO - 'HOME': '/Users/cltbld', 06:11:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:11:50 INFO - 'LOGNAME': 'cltbld', 06:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:50 INFO - 'MOZ_NO_REMOTE': '1', 06:11:50 INFO - 'NO_EM_RESTART': '1', 06:11:50 INFO - 'PAGER': '/bin/cat', 06:11:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:50 INFO - 'PWD': '/builds/slave/test', 06:11:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:11:50 INFO - 'SHELL': '/bin/bash', 06:11:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BM2fe4JSY6/Listeners', 06:11:50 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 06:11:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:11:50 INFO - 'USER': 'cltbld', 06:11:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:11:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:50 INFO - 'XPC_FLAGS': '0x0', 06:11:50 INFO - 'XPC_SERVICE_NAME': '0', 06:11:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:11:51 INFO - Cleaning up... 06:11:51 INFO - Return code: 0 06:11:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:51 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x108be7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffed8d555f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c5d30>, '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 0x1088ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089babe8>, '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.BPzWKj7672/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.BM2fe4JSY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:11:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:11:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BPzWKj7672/Render', 06:11:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:11:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:11:51 INFO - 'HOME': '/Users/cltbld', 06:11:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:11:51 INFO - 'LOGNAME': 'cltbld', 06:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:51 INFO - 'MOZ_NO_REMOTE': '1', 06:11:51 INFO - 'NO_EM_RESTART': '1', 06:11:51 INFO - 'PAGER': '/bin/cat', 06:11:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:51 INFO - 'PWD': '/builds/slave/test', 06:11:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:11:51 INFO - 'SHELL': '/bin/bash', 06:11:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BM2fe4JSY6/Listeners', 06:11:51 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 06:11:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:11:51 INFO - 'USER': 'cltbld', 06:11:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:11:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:51 INFO - 'XPC_FLAGS': '0x0', 06:11:51 INFO - 'XPC_SERVICE_NAME': '0', 06:11:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:51 INFO - Downloading/unpacking psutil>=3.1.1 06:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:11:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:11:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:11:54 INFO - Installing collected packages: psutil 06:11:54 INFO - Running setup.py install for psutil 06:11:54 INFO - building 'psutil._psutil_osx' extension 06:11:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:11:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:11:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:11:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:11:55 INFO - building 'psutil._psutil_posix' extension 06:11:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:11:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:11:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:11:55 INFO - ^ 06:11:55 INFO - 1 warning generated. 06:11:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:11:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:11:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:11:56 INFO - Successfully installed psutil 06:11:56 INFO - Cleaning up... 06:11:56 INFO - Return code: 0 06:11:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x108be7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffed8d555f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c5d30>, '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 0x1088ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089babe8>, '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.BPzWKj7672/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.BM2fe4JSY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:11:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:11:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:11:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BPzWKj7672/Render', 06:11:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:11:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:11:56 INFO - 'HOME': '/Users/cltbld', 06:11:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:11:56 INFO - 'LOGNAME': 'cltbld', 06:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:56 INFO - 'MOZ_NO_REMOTE': '1', 06:11:56 INFO - 'NO_EM_RESTART': '1', 06:11:56 INFO - 'PAGER': '/bin/cat', 06:11:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:56 INFO - 'PWD': '/builds/slave/test', 06:11:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:11:56 INFO - 'SHELL': '/bin/bash', 06:11:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BM2fe4JSY6/Listeners', 06:11:56 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 06:11:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:11:56 INFO - 'USER': 'cltbld', 06:11:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:11:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:56 INFO - 'XPC_FLAGS': '0x0', 06:11:56 INFO - 'XPC_SERVICE_NAME': '0', 06:11:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:11:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:11:59 INFO - Installing collected packages: mozsystemmonitor 06:11:59 INFO - Running setup.py install for mozsystemmonitor 06:11:59 INFO - Successfully installed mozsystemmonitor 06:11:59 INFO - Cleaning up... 06:11:59 INFO - Return code: 0 06:11:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x108be7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffed8d555f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c5d30>, '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 0x1088ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089babe8>, '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.BPzWKj7672/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.BM2fe4JSY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:11:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:11:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BPzWKj7672/Render', 06:11:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:11:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:11:59 INFO - 'HOME': '/Users/cltbld', 06:11:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:11:59 INFO - 'LOGNAME': 'cltbld', 06:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:59 INFO - 'MOZ_NO_REMOTE': '1', 06:11:59 INFO - 'NO_EM_RESTART': '1', 06:11:59 INFO - 'PAGER': '/bin/cat', 06:11:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:59 INFO - 'PWD': '/builds/slave/test', 06:11:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:11:59 INFO - 'SHELL': '/bin/bash', 06:11:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BM2fe4JSY6/Listeners', 06:11:59 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 06:11:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:11:59 INFO - 'USER': 'cltbld', 06:11:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:11:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:59 INFO - 'XPC_FLAGS': '0x0', 06:11:59 INFO - 'XPC_SERVICE_NAME': '0', 06:11:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:59 INFO - Downloading/unpacking jsonschema==2.5.1 06:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:12:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:02 INFO - Downloading functools32-3.2.3-2.tar.gz 06:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:12:02 INFO - warning: no files found matching '*.txt' 06:12:02 INFO - no previously-included directories found matching 'build' 06:12:02 INFO - no previously-included directories found matching 'dist' 06:12:02 INFO - no previously-included directories found matching '.git*' 06:12:02 INFO - Installing collected packages: jsonschema, functools32 06:12:02 INFO - Running setup.py install for functools32 06:12:02 INFO - warning: no files found matching '*.txt' 06:12:02 INFO - no previously-included directories found matching 'build' 06:12:02 INFO - no previously-included directories found matching 'dist' 06:12:02 INFO - no previously-included directories found matching '.git*' 06:12:02 INFO - Successfully installed jsonschema functools32 06:12:02 INFO - Cleaning up... 06:12:03 INFO - Return code: 0 06:12:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:03 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x108be7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffed8d555f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c5d30>, '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 0x1088ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089babe8>, '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.BPzWKj7672/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.BM2fe4JSY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:12:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:12:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:12:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BPzWKj7672/Render', 06:12:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:03 INFO - 'HOME': '/Users/cltbld', 06:12:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:03 INFO - 'LOGNAME': 'cltbld', 06:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:03 INFO - 'MOZ_NO_REMOTE': '1', 06:12:03 INFO - 'NO_EM_RESTART': '1', 06:12:03 INFO - 'PAGER': '/bin/cat', 06:12:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:03 INFO - 'PWD': '/builds/slave/test', 06:12:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:03 INFO - 'SHELL': '/bin/bash', 06:12:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BM2fe4JSY6/Listeners', 06:12:03 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 06:12:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:03 INFO - 'USER': 'cltbld', 06:12:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:03 INFO - 'XPC_FLAGS': '0x0', 06:12:03 INFO - 'XPC_SERVICE_NAME': '0', 06:12:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:12:04 INFO - Cleaning up... 06:12:04 INFO - Return code: 0 06:12:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:04 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x108be7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffed8d555f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c5d30>, '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 0x1088ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089babe8>, '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.BPzWKj7672/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.BM2fe4JSY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:12:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:12:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:12:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BPzWKj7672/Render', 06:12:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:04 INFO - 'HOME': '/Users/cltbld', 06:12:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:04 INFO - 'LOGNAME': 'cltbld', 06:12:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:04 INFO - 'MOZ_NO_REMOTE': '1', 06:12:04 INFO - 'NO_EM_RESTART': '1', 06:12:04 INFO - 'PAGER': '/bin/cat', 06:12:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:04 INFO - 'PWD': '/builds/slave/test', 06:12:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:04 INFO - 'SHELL': '/bin/bash', 06:12:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BM2fe4JSY6/Listeners', 06:12:04 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 06:12:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:04 INFO - 'USER': 'cltbld', 06:12:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:04 INFO - 'XPC_FLAGS': '0x0', 06:12:04 INFO - 'XPC_SERVICE_NAME': '0', 06:12:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:04 INFO - Downloading/unpacking blobuploader==1.2.4 06:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:07 INFO - Downloading blobuploader-1.2.4.tar.gz 06:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:12:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:12:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:09 INFO - Downloading docopt-0.6.1.tar.gz 06:12:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:12:09 INFO - Installing collected packages: blobuploader, requests, docopt 06:12:09 INFO - Running setup.py install for blobuploader 06:12:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:12:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:12:09 INFO - Running setup.py install for requests 06:12:09 INFO - Running setup.py install for docopt 06:12:09 INFO - Successfully installed blobuploader requests docopt 06:12:09 INFO - Cleaning up... 06:12:10 INFO - Return code: 0 06:12:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:12:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:10 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x108be7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffed8d555f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c5d30>, '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 0x1088ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089babe8>, '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.BPzWKj7672/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.BM2fe4JSY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:12:10 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:12:10 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:12:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BPzWKj7672/Render', 06:12:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:10 INFO - 'HOME': '/Users/cltbld', 06:12:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:10 INFO - 'LOGNAME': 'cltbld', 06:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:10 INFO - 'MOZ_NO_REMOTE': '1', 06:12:10 INFO - 'NO_EM_RESTART': '1', 06:12:10 INFO - 'PAGER': '/bin/cat', 06:12:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:10 INFO - 'PWD': '/builds/slave/test', 06:12:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:10 INFO - 'SHELL': '/bin/bash', 06:12:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BM2fe4JSY6/Listeners', 06:12:10 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 06:12:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:10 INFO - 'USER': 'cltbld', 06:12:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:10 INFO - 'XPC_FLAGS': '0x0', 06:12:10 INFO - 'XPC_SERVICE_NAME': '0', 06:12:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:12:10 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-0KlnZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:12:10 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-F1vSWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:12:10 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-qK9620-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:12:10 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-QvxvM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:12:10 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-GuWOVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:12:10 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-SAGeEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:12:10 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-zV8GiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:12:11 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-syZtkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:12:11 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-CFIoKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:12:11 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-hAYd0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:12:11 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-__LHzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:12:11 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-ONU4zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:12:11 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-te2gSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:12:11 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-LlHJO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:11 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-bXaone-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:12:11 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-FUHPgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:12:12 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-8RT5Hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:12:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:12:12 INFO - Running setup.py install for manifestparser 06:12:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:12:12 INFO - Running setup.py install for mozcrash 06:12:12 INFO - Running setup.py install for mozdebug 06:12:12 INFO - Running setup.py install for mozdevice 06:12:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:12:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:12:12 INFO - Running setup.py install for mozfile 06:12:12 INFO - Running setup.py install for mozhttpd 06:12:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:12:13 INFO - Running setup.py install for mozinfo 06:12:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:12:13 INFO - Running setup.py install for mozInstall 06:12:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:12:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:12:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:12:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:12:13 INFO - Running setup.py install for mozleak 06:12:13 INFO - Running setup.py install for mozlog 06:12:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:12:13 INFO - Running setup.py install for moznetwork 06:12:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:12:13 INFO - Running setup.py install for mozprocess 06:12:13 INFO - Running setup.py install for mozprofile 06:12:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:12:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:12:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:12:14 INFO - Running setup.py install for mozrunner 06:12:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:12:14 INFO - Running setup.py install for mozscreenshot 06:12:14 INFO - Running setup.py install for moztest 06:12:14 INFO - Running setup.py install for mozversion 06:12:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:12:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:12:14 INFO - Cleaning up... 06:12:14 INFO - Return code: 0 06:12:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:14 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x108be7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffed8d555f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c5d30>, '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 0x1088ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089babe8>, '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.BPzWKj7672/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.BM2fe4JSY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:12:14 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:12:14 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:12:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BPzWKj7672/Render', 06:12:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:14 INFO - 'HOME': '/Users/cltbld', 06:12:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:14 INFO - 'LOGNAME': 'cltbld', 06:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:14 INFO - 'MOZ_NO_REMOTE': '1', 06:12:14 INFO - 'NO_EM_RESTART': '1', 06:12:14 INFO - 'PAGER': '/bin/cat', 06:12:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:14 INFO - 'PWD': '/builds/slave/test', 06:12:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:14 INFO - 'SHELL': '/bin/bash', 06:12:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BM2fe4JSY6/Listeners', 06:12:14 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 06:12:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:14 INFO - 'USER': 'cltbld', 06:12:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:14 INFO - 'XPC_FLAGS': '0x0', 06:12:14 INFO - 'XPC_SERVICE_NAME': '0', 06:12:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:12:14 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-5H4qn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:12:15 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-YGkOw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:12:15 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-frAV_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:12:15 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-VC96ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:12:15 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-BsdGzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:12:15 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-PuP3zj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:12:15 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-qn5VNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:12:15 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-Tg0XQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:12:15 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-6W02QB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:12:15 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-2kXgWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:12:16 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-9hFky2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:12:16 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-lFKBUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:12:16 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-5dxBab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:12:16 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-Tcra_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:16 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-bh3nFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:12:16 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-2Eoo4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:12:16 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-15b91j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:12:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:12: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 06:12: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 06:12:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12: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 06:12: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 06:12:19 INFO - Downloading blessings-1.6.tar.gz 06:12:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:12:19 INFO - Installing collected packages: blessings 06:12:19 INFO - Running setup.py install for blessings 06:12:19 INFO - Successfully installed blessings 06:12:19 INFO - Cleaning up... 06:12:19 INFO - Return code: 0 06:12:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:12:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:12:20 INFO - Reading from file tmpfile_stdout 06:12:20 INFO - Current package versions: 06:12:20 INFO - blessings == 1.6 06:12:20 INFO - blobuploader == 1.2.4 06:12:20 INFO - docopt == 0.6.1 06:12:20 INFO - functools32 == 3.2.3-2 06:12:20 INFO - jsonschema == 2.5.1 06:12:20 INFO - manifestparser == 1.1 06:12:20 INFO - mozInstall == 1.12 06:12:20 INFO - mozcrash == 1.0 06:12:20 INFO - mozdebug == 0.1 06:12:20 INFO - mozdevice == 0.49 06:12:20 INFO - mozfile == 1.2 06:12:20 INFO - mozhttpd == 0.7 06:12:20 INFO - mozinfo == 0.9 06:12:20 INFO - mozleak == 0.1 06:12:20 INFO - mozlog == 3.4 06:12:20 INFO - moznetwork == 0.27 06:12:20 INFO - mozprocess == 0.24 06:12:20 INFO - mozprofile == 0.28 06:12:20 INFO - mozrunner == 6.13 06:12:20 INFO - mozscreenshot == 0.1 06:12:20 INFO - mozsystemmonitor == 0.3 06:12:20 INFO - moztest == 0.8 06:12:20 INFO - mozversion == 1.4 06:12:20 INFO - psutil == 3.1.1 06:12:20 INFO - requests == 1.2.3 06:12:20 INFO - wsgiref == 0.1.2 06:12:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:20 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x108be7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffed8d555f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c5d30>, '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 0x1088ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089babe8>, '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.BPzWKj7672/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.BM2fe4JSY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:12:20 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:12:20 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:12:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BPzWKj7672/Render', 06:12:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:20 INFO - 'HOME': '/Users/cltbld', 06:12:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:20 INFO - 'LOGNAME': 'cltbld', 06:12:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:20 INFO - 'MOZ_NO_REMOTE': '1', 06:12:20 INFO - 'NO_EM_RESTART': '1', 06:12:20 INFO - 'PAGER': '/bin/cat', 06:12:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:20 INFO - 'PWD': '/builds/slave/test', 06:12:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:20 INFO - 'SHELL': '/bin/bash', 06:12:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BM2fe4JSY6/Listeners', 06:12:20 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 06:12:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:20 INFO - 'USER': 'cltbld', 06:12:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:20 INFO - 'XPC_FLAGS': '0x0', 06:12:20 INFO - 'XPC_SERVICE_NAME': '0', 06:12:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:12:20 INFO - Cleaning up... 06:12:20 INFO - Return code: 0 06:12:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x108be7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffed8d555f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c5d30>, '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 0x1088ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089babe8>, '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.BPzWKj7672/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.BM2fe4JSY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:12:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:12:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:12:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BPzWKj7672/Render', 06:12:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:20 INFO - 'HOME': '/Users/cltbld', 06:12:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:20 INFO - 'LOGNAME': 'cltbld', 06:12:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:20 INFO - 'MOZ_NO_REMOTE': '1', 06:12:20 INFO - 'NO_EM_RESTART': '1', 06:12:20 INFO - 'PAGER': '/bin/cat', 06:12:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:20 INFO - 'PWD': '/builds/slave/test', 06:12:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:20 INFO - 'SHELL': '/bin/bash', 06:12:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BM2fe4JSY6/Listeners', 06:12:20 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 06:12:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:20 INFO - 'USER': 'cltbld', 06:12:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:20 INFO - 'XPC_FLAGS': '0x0', 06:12:20 INFO - 'XPC_SERVICE_NAME': '0', 06:12:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:12:20 INFO - Cleaning up... 06:12:20 INFO - Return code: 0 06:12:20 INFO - Running post-action listener: _resource_record_post_action 06:12:20 INFO - Running post-action listener: _start_resource_monitoring 06:12:20 INFO - Starting resource monitoring. 06:12:20 INFO - [mozharness: 2017-02-09 14:12:20.639646Z] Finished create-virtualenv step (success) 06:12:20 INFO - [mozharness: 2017-02-09 14:12:20.640560Z] Running install step. 06:12:20 INFO - Running pre-action listener: _resource_record_pre_action 06:12:20 INFO - Running main action method: install 06:12:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:12:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:12:20 INFO - Reading from file tmpfile_stdout 06:12:20 INFO - Detecting whether we're running mozinstall >=1.0... 06:12:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:12:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:12:21 INFO - Reading from file tmpfile_stdout 06:12:21 INFO - Output received: 06:12:21 INFO - Usage: mozinstall [options] installer 06:12:21 INFO - Options: 06:12:21 INFO - -h, --help show this help message and exit 06:12:21 INFO - -d DEST, --destination=DEST 06:12:21 INFO - Directory to install application into. [default: 06:12:21 INFO - "/builds/slave/test"] 06:12:21 INFO - --app=APP Application being installed. [default: firefox] 06:12:21 INFO - mkdir: /builds/slave/test/build/application 06:12:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:12:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 06:12:40 INFO - Reading from file tmpfile_stdout 06:12:40 INFO - Output received: 06:12:40 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 06:12:40 INFO - Running post-action listener: _resource_record_post_action 06:12:40 INFO - [mozharness: 2017-02-09 14:12:40.647502Z] Finished install step (success) 06:12:40 INFO - [mozharness: 2017-02-09 14:12:40.647639Z] Running run-tests step. 06:12:40 INFO - Running pre-action listener: _resource_record_pre_action 06:12:40 INFO - Running main action method: run_tests 06:12:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:12:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:12:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:12:40 INFO - 2017-02-09 06:12:40.660 screenresolution[1622:7688] starting screenresolution argv=screenresolution get 06:12:40 INFO - 2017-02-09 06:12:40.662 screenresolution[1622:7688] Display 0: 1600x1200x32@60 06:12:40 INFO - 2017-02-09 06:12:40.667 screenresolution[1623:7690] starting screenresolution argv=screenresolution list 06:12:40 INFO - Available Modes on Display 0 06:12:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:12:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:12:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:12:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:12:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:12:40 INFO - Intel Iris: 06:12:40 INFO - Chipset Model: Intel Iris 06:12:40 INFO - Type: GPU 06:12:40 INFO - Bus: Built-In 06:12:40 INFO - VRAM (Dynamic, Max): 1536 MB 06:12:40 INFO - Vendor: Intel (0x8086) 06:12:40 INFO - Device ID: 0x0a2e 06:12:40 INFO - Revision ID: 0x0009 06:12:40 INFO - Displays: 06:12:40 INFO - Display: 06:12:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:12:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:12:40 INFO - Display Serial Number: 1600x1200 60 06:12:40 INFO - Main Display: Yes 06:12:40 INFO - Mirror: Off 06:12:40 INFO - Online: Yes 06:12:40 INFO - Rotation: Supported 06:12:40 INFO - Return code: 0 06:12:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:12:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:12:40 INFO - Python 2.7.3 06:12:40 INFO - Return code: 0 06:12:40 INFO - grabbing minidump binary from tooltool 06:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:40 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 0x1089c5d30>, '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 0x1088ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089babe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:12:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:12:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:12:40 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:12:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:12:41 INFO - Return code: 0 06:12:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:12:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:12:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:12:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:12:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:12:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IDa6-Oq5QDeZrlGz4nopxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0199', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:12:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IDa6-Oq5QDeZrlGz4nopxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0199 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:12:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BPzWKj7672/Render', 06:12:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:41 INFO - 'HOME': '/Users/cltbld', 06:12:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:41 INFO - 'LOGNAME': 'cltbld', 06:12:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:12:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:41 INFO - 'MOZ_NO_REMOTE': '1', 06:12:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:12:41 INFO - 'NO_EM_RESTART': '1', 06:12:41 INFO - 'PAGER': '/bin/cat', 06:12:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:41 INFO - 'PWD': '/builds/slave/test', 06:12:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:12:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:41 INFO - 'SHELL': '/bin/bash', 06:12:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BM2fe4JSY6/Listeners', 06:12:41 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 06:12:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:41 INFO - 'USER': 'cltbld', 06:12:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:41 INFO - 'XPC_FLAGS': '0x0', 06:12:41 INFO - 'XPC_SERVICE_NAME': '0', 06:12:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IDa6-Oq5QDeZrlGz4nopxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0199', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:12:41 INFO - mozversion application_buildid: 20170209051221 06:12:41 INFO - mozversion application_changeset: 1419fa7ee013b44501b90487bf8f8873dbaf3727 06:12:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:12:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:12:41 INFO - mozversion application_name: Firefox 06:12:41 INFO - mozversion application_remotingname: firefox-dev 06:12:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:12:41 INFO - mozversion application_vendor: Mozilla 06:12:41 INFO - mozversion application_version: 53.0a2 06:12:41 INFO - mozversion platform_buildid: 20170209051221 06:12:41 INFO - mozversion platform_changeset: 1419fa7ee013b44501b90487bf8f8873dbaf3727 06:12:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:12:41 INFO - mozversion platform_version: 53.0a2 06:12:41 INFO - using testdate: 1486649561 06:12:41 INFO - actual date: 1486649561 06:12:41 INFO - starting webserver on 'localhost:49241' 06:12:41 INFO - SUITE-START | Running 2 tests 06:12:41 INFO - TEST-START | dromaeo_css 06:12:41 INFO - operating with platform_type : mac_ 06:12:41 INFO - Initialising browser for dromaeo_css test... 06:12:41 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmpfXRach/profile http://localhost:49241/getInfo.html) 06:12:44 INFO - PROCESS | 1633 | 2017-02-09 06:12:44.171 plugin-container[1635:7870] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4e43, name = 'com.apple.tsm.portname' 06:12:44 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:12:44 INFO - PROCESS | 1633 | 2017-02-09 06:12:44.174 plugin-container[1635:7870] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x970f, name = 'com.apple.CFPasteboardClient' 06:12:44 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:12:44 INFO - PROCESS | 1633 | 2017-02-09 06:12:44.174 plugin-container[1635:7870] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:12:44 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 06:12:44 INFO - PROCESS | 1633 | colorDepth:24 06:12:44 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 06:12:44 INFO - PROCESS | 1633 | __metrics 06:12:44 ERROR - PROCESS | 1633 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 06:12:44 INFO - PROCESS | 1633 | 1486649564367 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < forceQuit@jar:file:///var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmpfXRach/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmpfXRach/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmpfXRach/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmpfXRach/profile/extensions/talos-powers@TalosPowersService.js:55:9 06:12:44 INFO - TEST-INFO | 1633: exit 0 06:12:44 INFO - Browser initialized. 06:12:44 INFO - Running cycle 1/1 for dromaeo_css test... 06:12:44 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmpfXRach/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:12:47 INFO - PROCESS | 1636 | 2017-02-09 06:12:47.403 plugin-container[1637:8005] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 06:12:47 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:12:47 INFO - PROCESS | 1636 | 2017-02-09 06:12:47.404 plugin-container[1637:8005] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 06:12:47 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:12:47 INFO - PROCESS | 1636 | 2017-02-09 06:12:47.404 plugin-container[1637:8005] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:12:57 INFO - PROCESS | 1636 | RSS: Main: 218759168 06:12:57 INFO - PROCESS | 1636 | 06:15:59 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 06:16:01 INFO - PROCESS | 1636 | RSS: Main: 238936064 06:16:01 INFO - PROCESS | 1636 | 06:17:45 INFO - PROCESS | 1636 | ************************* 06:17:45 INFO - PROCESS | 1636 | A coding exception was thrown and uncaught in a Task. 06:17:45 INFO - PROCESS | 1636 | 06:17:45 ERROR - PROCESS | 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:17:45 INFO - PROCESS | 1636 | Full stack: 06:17:45 INFO - PROCESS | 1636 | ************************* 06:19:03 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 06:19:04 INFO - PROCESS | 1636 | RSS: Main: 246820864 06:19:04 INFO - PROCESS | 1636 | 06:22:06 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 06:22:06 INFO - PROCESS | 1636 | RSS: Main: 253276160 06:22:06 INFO - PROCESS | 1636 | 06:25:08 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 06:25:09 INFO - PROCESS | 1636 | RSS: Main: 249618432 06:25:09 INFO - PROCESS | 1636 | 06:28:12 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 06:28:13 INFO - PROCESS | 1636 | RSS: Main: 258031616 06:28:13 INFO - PROCESS | 1636 | 06:31:15 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 06:31:16 INFO - PROCESS | 1636 | RSS: Main: 260153344 06:31:16 INFO - PROCESS | 1636 | 06:31:16 INFO - PROCESS | 1636 | __start_tp_report 06:31:16 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 06:31:16 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 06:31:16 INFO - PROCESS | 1636 | |i|pagename|runs| 06:31:16 INFO - PROCESS | 1636 | |0;dojo.html;2991.7905746597735;3326.4345061339554;3370.3259348130364;3377.814220217887;3417.948730769039;4529.932051019229;4919.680220785646;5657.207990881275;5712.771489140429;5762.452567006138;5771.971140144294;5812.3025236971625;5823.883522329551;5859.648421094737;5868.794592189274;5293.100172970595;5318.707471089088;5327.334083239595;5367.06076436624;5372.57019438446;5390.407055223922;5401.648892821973;5405.108157154064;5423.674579525222;5445.237666726662;4603.3785438965815;5213.765380557884;5233.607479439057;5409.377921539014;5422.9728851355685;5260.552853007499;5280.102382594968;5322.840314790524;5326.147816349366;5395.082835917903;5208.192730126836;5293.444188360205;5299.311089558333;5306.946930530684;5313.256144139824;5559.610827242094;5730.598858079936;5756.338021127582;5853.051058530511;5960.910586341209;5112.565431938289;6144.3717414885095;6207.472364848948;6257.749690012394;6277.905831412532;6301.464375528086;6308.179936608211;6321.87356252877;6328.493720502349;6340.3025667177035;5953.880922381528;6005.249343832021;6007.30915944672;6011.368806275322;6024.518038556948;6173.753049877954;6182.227221597301;6243.344448832807;6259.436650701458;6282.968585157137;6156.8152955410515;6242.812715618538;6244.438000579969;6256.812295631047;6265.185525881606;6285.182926219562;6292.2134733158355;6294.685265736694;6311.147995020613;6332.905006424908;6126.448619624255;6161.44546990773;6168.506519478431;6220.564560480813;6302.1177035215105;5264.81541653125;6188.44304012641;6237.376262373817;6267.373262673787;6280.2777680566405;4228.4080228768;5032.043911656773;5055.317532133115;5068.341115654941;5114.028334616411;3784.735068545175;4362.956370436318;4413.845515406945;4525.818967241339;4570.54294570547;4616.3998680172035;4984.451710311862;5819.79630712923;5829.038208695602;5847.415258474203;6210.5652604317265;6283.05754136874;6291.02489114188;6304.590201636879;6312.179416675803;5633.492985631313;5691.03252447085;5840.2115714378015;5914.733836977346;5930.881382372415;5524.116141417434;5543.057680194376;5544.002079625626;5555.611107222456;5569.972150139223;6459.321771213955;6475.32009139043;6476.967615162082;6493.22081350241;6508.8047358579315;6152.138700582012;6184;6209.565330426827;6210.844728881814;6264.5301602379095;5384.680753215487;5945.64326140433;6393.1688880445245;6437.356264373712;6458.289588145206;6231.22109736283;6243.43809057187;6268;6272.655003974643;6301.275353334425;6119.502553941512;6195.628262304276;6215.627062376272;6263.0605409187165;6277.591956522811;4882.92675609859;4894.902101958012;6183.5671502994355;6208.9689551551955;6219.937800621936;6132.6627035513475;6175;6182.196314479089;6183.598066125687;6186.164867742978;5821.679807610622;5909.113632955091;5914.231149950651;6075.149479072845;6095.908561371672;6052.636841789506;6087.421694938974;6112.868254063078;6127.877442451215;6190.907136393048;5979.5814292999075;6046.818595442144;6052.061930400795;6064.939350606437;6071.817845464643 06:31:16 INFO - PROCESS | 1636 | |1;ext.html;451.2081297323196;457.86264120763764;491.37595254027366;492.98767530811733;520.6017396691532;39345.81962541125;40276;40347.59652403475;40363.59636403635;40493.19013619733;41690.583094169124;42128.36807447891;42134.15731685364;42217;42259.57740422595;6449.322821103787;7995.160508146648;8137.674493020272;9068.455892646429;9307.34848560601;9304.627814887397;11294.152938529602;11301.095912326995;11374.943125284362;11457.59898403556;8747.38768286217;10088.646897358594;11442.542298308099;11458.770824583504;11474.139439542068;11372.37451940143;11422.94288528552;11434.085273178167;11436.94281528587;11469.541218351256;11127.443627818657;11172;11276.267042642203;11285.943570282177;11329.886701132966;40388.19223615541;40596.79701601503;40689;40689.79655101735;40751.388729169084;3961.7028722845903;3993.740406873573;4052.837886484537;4070.3080476319096;4102.3026085565525;29285.56071658927;29328.973485928105;29394.85302573495;29642.25894352637;30123;3085.1053194573547;3338.0486561329903;3364.713999310062;3367.696907278332;3369.5619569456057;371792;448825;452759;453910;456787;59942.700286498286;59994;60290;60394.698026510465;60410.885619004;63293;63726;64454.677726611066;64517;64696.35303646903;16378.508644740677;16599.91700041492;16619.584510387096;16629.251683674265;16657.083860387553;9654.95172524147;9671.516424178904;12773.978081753437;12833.550825721242;13012.284324362061;15882.444114455939;16007.43973960929;16057.518274451784;16062.839371606135;16093.919530402272;6932.23745388007;7112.608806515588;7126.35862772353;7129;7207.9639601801655;863.9568021598894;884.9911101344472;886.5434301334818;905.4793493741125;917.8806755121791;29809;29826.10521684353;29997.10008699699;30363.968011769583;30692.69307306943;901.0043901488891;946.2997381937455;972.3145182646217;1112.9777404451866;1195.282830301812;13414.396352164176;13506;15005.69988600222;15067.020643658127;15185.936984411206;370053;371217;372039;373186;374023;54358;54435.45564544383;54448.45551544513;54473.09344173014;54630;1408.2677007955806;1433.491110655723;1448.4278709909738;1453.5493996861007;1453.7092581483746;24171.637425438985;25078.620675863003;27129.59305610378;27529.31176720598;27709.30726731848;34354;45978.770106149255;45999;46014.539854601026;46018.76990615026;322635;323026;323445.9138521462;324304.3784781061;325393;24779;24986;25175.622365664163;25237.873810631565;46105.76947115377;49077;49589.75205123951;50181.74909125431;50371.49628503815;52237.17169899035;30621.77512899459;32352.029439116865;39392.21215575615;40198.79900600478;43282.78358608187;40771.99049918962;41555.37666934938;42030.36954445625;42299;42737;33461;33768.1557961053;33956.66043339535;39799.80100099481;40481.78554643365;30445.54331684982;34735.30529389449;37128.81435592805;37330.06674833151;37537;21943.670844937657;26899.596506052032;27047.459050819267;27183.320416989733;27209.72790272151 06:31:16 INFO - PROCESS | 1636 | |2;jquery.html;396.2056077564483;396.38758118706596;403.94748682671246;409.76848080834316;421.3027439587482;19496.220151193953;20193.697094543557;20752.27367042154;20866.582668346644;20898.791012089874;20237.59524809503;20760.377188684324;20857.748535087907;20881.68677469839;20893.686594701092;5126.282320475128;5424.376196737367;5471.917921231165;5516.200150978106;5539.030669632798;5431.293931788862;5465.945340546603;5468.781248750045;5478.58910581708;5614.326280846304;5918.2898052233795;6002.459778619924;6005.87988240235;6017.669028203469;6045.546584006195;5404.054290499186;5571.721413929328;5986.491148252404;6011.669358185298;6021.157038014681;5327.706976116312;5381;5425.647332923348;5428.240046393508;5437.456254374571;13624.727505449935;15556.455524056604;20696.482587935272;25908.481830363475;26149.73850261492;2557.8337408068414;2590.326515106086;2637.4329519153475;2664.200739778059;2687.771539419152;10109.949450252701;10230.23273254509;10378.221633377527;10696.893031069745;10724.571017159304;1533.7699345098213;1846.8549499310514;1886.5849513107094;1900.6673832079468;1904.523869032742;135422;136552;143295.28352358277;144156.83764743537;144413.99999999895;11924.224925379822;12284.570040048555;12289.877101228873;12303.523577170798;12323.876761232452;16174.838251617568;16180.676386472205;16201.351945922032;16216;16238.431654892258;8909.262693774652;9067.093290671011;9068.319876009326;9109.77225569366;9127.771805704777;7400.444966627524;8762.036176020632;8820.647174113092;8833.64665413389;9005.414648047856;4908.435529914034;4917.975410122998;4931.950680493221;4988.526090021514;5009.12340340439;2061.5567652954687;2097.6958341040463;2122.936311910645;2123.309924274617;2127.457498337945;409.49836450348084;415.5159239485965;1019.2966852871494;1044.5404022230193;1064.5582083435443;11539.711507212387;11761.176717629854;11774.116941229271;11973.102017348734;12134.939325303318;368.158757239706;384.7229994404025;386.0118097669974;430.37165738022213;437.59959636932484;5946.1972633693895;5973.133895585116;5989.31122920861;6036.3058248302;6135.202423684982;782692;805120;818050;820479;821171;123777;156172.21913890357;156948;157049.42950570578;157265;1017.3031473440717;1038.1072277841201;1073.6993641780314;1074.8763892152347;1074.9570017199223;15635.765463518284;19608.8039119607;19809.7655040116;20029.699554506402;20202.787832730082;54165.645858853844;59921.40078599158;61222;61433.692831535554;61460.69269653623;83357.16642833494;86007;86257;86793.56603216943;88923.55538222268;7006.474514411541;8319.958400207961;8492;8925.509096999727;8984.730458086267;11245.887541124812;11681.941590291994;13234.470621175431;13278.336083195994;13520.12119212248;9896.960819114178;10711.785764284516;11482;11598.47806848677;11987.520499179935;9132.49771262587;9998.700038998843;11196.608118715805;11398.487068081791;11513.94243028813;11631.243969141979;11772.823407649063;11850.348230847387;12007.219530730474;12029.819552706891;7693.961530192313;7801.258880406353;7820.960895195488;8070.556119413253;8163.428560000981;8547.27348175412;10465.319754215952;11622.128340374336;11882.881171188523;11935.224210426295 06:31:16 INFO - PROCESS | 1636 | |3;mootools.html;1216.2094638484984;1415.1721243072802;1426.1816184364927;1426.351010290318;1440.8113306522118;7439.256074392558;7703.998480197581;8017.799555011127;8478.3641226908;8534.01858786239;6664.933350666492;8282.130376310475;8291.91708082919;8389.41274110811;8409.243168114868;2280.908763649452;2320.2575175943703;2324.407276144581;2341.7775311345395;2342.9297121086393;2058.6397380458434;2136.529963408048;2306.630939049752;2341.882905854709;2346.061575369857;2228.3315005498366;2332.8716920569364;2335.1243283768586;2335.708036495438;2340.1341503643675;2286.3598192506042;2319.396956791238;2336.9298921032228;2341.2390972933863;2344.753800850912;1981.5640559077124;2314.247869442438;2346.507233480971;2352.141468364052;2377.9286621401384;8272.420930534865;8312;8397.874031889527;8404.663813447454;8432.15678432158;4904.60763138948;5037.420696619863;5041.798328066873;5043.041822053798;5045.697258164522;3291.983540082308;3451.9827400862837;3509.6314886937016;3516.1519169472554;3578.0339308386588;1207.4928530017414;1228.318283352739;1273.770721270171;1277.482619539088;1290.0002498063982;10492.16062714981;10629.84055239172;10734.624288149877;10772.245942784008;10775.730606734816;3706.036430528028;4313.97843010783;4316.460442444694;4541.591256786905;4680.953190468052;7985.760427187193;9455.479948602893;9539.189168920719;9547.570359333708;9644.132028117363;5203.245529398292;5247.711375874287;5254.264402983586;5262.158054711228;5264.947350526446;4514.796834142471;4614.792334344963;4743.667943244009;4743.905121897543;4835.927461088087;3869.9806500967316;3935.6457918787446;3978.781167035783;4028.3756017817286;4045.777482238505;1088.7985722641338;1174.9353785541707;1210.5702475621204;1252.3362617812575;1289.548657969703;769.5805785846727;827.4084029918637;889.8131392407538;904.4573256046451;907.6732376344511;5214.504622060974;5390.4879036491475;5408.37803652585;5436.6194366393975;5541.168824676251;901.7700486375932;950.619752099152;964.5852283518154;1006.3710181136789;1024.206240163864;3234.725048370915;3425.0581090200394;3624.619414961391;3640.6541378568995;3707.870224542128;9695.757606059764;9841.901580984242;10037;10050.899491005142;10076.345037572535;9697.466639334903;9715.854262186072;9732.756681082888;9739.756506087404;10015.949920250352;7576.545407275581;7714;7722.150563438017;7727.961360193163;7737.458377913605;4313.525512193719;4560.224761790437;5198.532132108128;5236.476352364885;5355.3305836770405;9145.039770823967;9152.908470915205;9213.309001825024;9255.953720231355;9299.767505812139;9142.58858351389;9293.67472138472;9375.484348360633;9402.858957115786;9405.341626086381;6694.397504224643;6766.763163289458;6794.898076528757;6805.9659701701175;6824.385805277549;7722.459427839997;7806.804829879298;7812.765617031499;7813.257740514642;7830.960845195737;6922.342377474132;6991.7902462926195;7094;7117.110361204849;7175.31834475724;6855.348741869514;6969.895451568129;6978.057962175041;7096.148462184571;7096.432285417258;5390.622656414013;5900.144479050599;6254.8123556293385;6266.561340706106;6302.401271879165;4759.50025247344;4783.976080119716;4810.807567697393;4823.300621409946;4828.130936431476;4757.5718185363485;4798.49615790337;4838.879028024327;4969.35398398206;4989.600831933364 06:31:16 INFO - PROCESS | 1636 | |4;prototype.html;313.9232432755648;345.0167023981652;357.6789509405172;367.18301778542764;372.53247174795644;4968.925466118011;5103.923441148386;5297.576193904488;5467.617266791326;5470.835874923749;5096.362954630671;5259.526642602165;5348.224507446418;5348.625596208267;5358.4641535846395;3535.257595904863;3874.5156855393075;4023.8189281482255;4261.424707664457;4267.829286828523;3744.794036328001;4076.857309994151;4160.7087503874745;4243.97878010611;4275.850345237917;3318.634950155481;3600.3879340512044;4061.1674606705556;4158.584141585832;4175.624193822556;3410.795352278871;3683.5763887153053;4188.874333769992;4196.733763767562;4201.6218540331365;3139.3407384449292;3277.2626159114247;3672.944905826388;3740.60723624021;3758.32350176968;4247.5964783345535;4606.447226332828;4823.456493921946;5203.713795741271;5245.947540524584;4482.5965663090155;4852.8544143675745;4857.514248575149;4873.541633370648;4910.877228069291;5047.772850221749;5114.43741188469;5362.034833729927;5729.942700572982;5732.828015159552;3714.7741245388956;3887.3974533947285;3915.8237879295502;4071.3282308419075;4114.012636967136;5333.813316533902;5457.727113644341;5925.34821169671;5951.791687290924;5956.694034810722;3684.2078953024693;4052.4124002019544;4197.202531519001;4214.810333534998;4232.423602056258;3790.574032619126;3815.5421349438243;4044.7775372354213;4206.170315912588;4278.315469524861;4847.104424531179;4850.175470170079;4854.2233242681;4858.6356023298395;4869.805207791649;5677.687727175045;5720.513756330675;5733.140028995684;5777.335606405233;5790.855228619234;1249.881261280177;1316.0787448785698;1350.959471215865;1363.3660347938057;1396.6578188343717;896.2561074308309;975.2100798353357;984.9212063035084;997.3567049253191;1003.9347442416366;4297.269464191032;4538.886527836765;4927.408710954708;4958.479359667255;4984.230598137681;4652.1626107300335;4740.881477963078;4770.642201834877;5290.783329587719;5509.752061157257;4335;4931.654784165145;4961.11477638495;4978.303037574742;5005.624578156653;2751.954257382222;2827.4203788223363;2853.3579944512317;2907.3252607601057;2922.5888641870542;5047.596192304681;5124.56441202502;5608.579356548194;5692.658440493584;5782.479576838105;4701.412323459567;4775.785089670973;5388.5419739321815;5668.829935101953;5731.191716059101;5246.842594722164;5638.661680299195;5698.6580805151825;5771.47056030144;6044.304904935901;5163.845084647466;5277.788888444419;5418.918716219338;5807.82576522705;5839.2190381933915;5444.5916556259235;5544.419840345482;5683.687397193029;5765.3946335634155;5779.393163717749;4802.855914322576;5224.615476898701;5623.606347555796;6051.515878729779;6072.089186622042;3857.9614203858723;3859.2088621831895;3903.2583809076186;3909.9609003909595;3918.0204948762807;4903.117438861039;5153;5467.261919640957;5661.2923384576925;5808.680522571299;4683.531646835289;5060.987802439453;5380.569554435558;5612.7193640317;5645.40723224072;4183.769892655811;4698.342232087579;5559.054960656779;5579.218909352613;5626.184203290418;4742.383490146259;4793.544613261734;5106.055379754757;5520.963470091353;5521;5159.277701121921;5174.765771392879;5243.423223445342;5630.4369563043365;5661.037623604079;4896.4124305083615;5276.366835979554;5521.806736764194;5523.834284971457;5562 06:31:16 INFO - PROCESS | 1636 | |5;yui.html;693.1578132568931;701.7929710735333;767.9539227646342;810.6838333050111;820.552798724695;14831.851681483182;15335.69328613427;15380.000299980493;15482.458113966013;15513.84486155138;14152.50466233682;14306.35621397037;14311.642208944782;14333.21167335796;14343.282835858217;674.8549061951679;686.7562015484481;805.4643661964786;851.6380538271226;856.2037305306063;861.8621020636699;862.1077185113409;862.2067697718084;863.8013256950906;864.3776480933749;900.3292547052422;917.499962520428;919.6781126605702;919.7240827751648;921.663592788634;908.8636704494313;913.5021413329752;914.1041779056495;918.5774543709902;922.2714055895867;676.5805200775501;684.934931181537;687;690.1063123255396;691.1084700736044;12453.93773031129;15156.090634561851;15205.31576079068;15414.537563873102;15534.922325388414;13430.52993145245;14159.433622655082;14356.138631682132;14374.496892608708;14380.209088500129;10987.121030317636;11394.943025284903;11487.42562871853;11659.533618655329;12039.217450865666;4371.431713877208;4426.136903303857;4440.067585806984;4450.554944505556;4468.0840427712565;93267;101791;109899.45050274697;111122;113945.43027284893;9393.295502837314;10335.638252661121;10440.089144600664;10652.946735266429;11170.609028683957;20650.89674551648;20762.06570704322;20873.582528349347;21056.15775368968;21097.89451052735;7481.625918704043;7532.284432978859;7569.735059272899;7621.771346859603;7677.76966690989;3635.5455568053994;4137.524184718796;4184.100418410057;4192.993681516475;4203.91592168155;3356.664333566624;3416.9658303417145;3432.798520517799;3469.8612055517497;3520;512.8717820544864;657.8848851197175;663.9269680335159;673.3670349871105;673.9561928474634;525.5165247971875;535.6893002058797;539.4201233673816;543.1065896600071;547.4498129380028;9363.4381937084;9838.508074596242;9863.852042219372;10060.446675432775;10251.026152515498;621.6301300726061;636.8503401700597;654.4633400611453;657.7599176300616;676.4892506157918;4244.915101697949;4325.113351762881;4462.196804575207;4764.928526072112;4807.855764327076;70659;108958;110309.44845275882;110695.3395699049;111146;93011;94818;94978;95781.04218957861;98545;69458.61082778317;70195;73491;77416.61291693618;80941;9141.77145571366;10360.844587331045;10788.730281743019;11203.327800332007;11305.830412543653;40393.59606403898;49731;53259.46740532545;53635.19547206717;53688.99485880275;65247.67376163089;66281.66859165866;67499.3250067493;69250.65374673094;69686.65156674184;12782.745923198332;12803.231806091664;12890.226586404846;13128.277944713132;13559.525416610371;13757.10578812414;14052.929735351257;14609.342579584158;14674.486392976194;15273.23633818327;13667.658308542366;13935.721285574435;14291.142531448146;14330.713385732435;14388.352524136648;13796.310184490936;13935.651608709863;14237.288135592971;14346.713065738419;14361.425542978583;12764.489420423079;13378.264195469343;13609.183448993092;14004.649883752987;14060.718785624435;10524.526566280574;10627.628033018807;10798;11265.887341126812;11403.828942565702;7750.534967901944;8696.39125261251;10460.738481538023;10503.10723588473;10532.631357902743 06:31:16 INFO - PROCESS | 1636 | __end_tp_report 06:31:16 INFO - PROCESS | 1636 | __start_cc_report 06:31:16 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,367 06:31:16 INFO - PROCESS | 1636 | __end_cc_report 06:31:16 INFO - PROCESS | 1636 | __startTimestamp1486650676102__endTimestamp 06:31:16 INFO - PROCESS | 1636 | 06:31:16 INFO - PROCESS | 1636 | ------- Summary: start ------- 06:31:16 INFO - PROCESS | 1636 | Number of tests: 6 06:31:16 INFO - PROCESS | 1636 | 06:31:16 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5745.68 Median:6007.31 stddev:688.53 (11.5%) stddev-sans-first:655.87 06:31:16 INFO - PROCESS | 1636 | Values: 2991.8 3326.4 3370.3 3377.8 3417.9 4529.9 4919.7 5657.2 5712.8 5762.5 5772.0 5812.3 5823.9 5859.6 5868.8 5293.1 5318.7 5327.3 5367.1 5372.6 5390.4 5401.6 5405.1 5423.7 5445.2 4603.4 5213.8 5233.6 5409.4 5423.0 5260.6 5280.1 5322.8 5326.1 5395.1 5208.2 5293.4 5299.3 5306.9 5313.3 5559.6 5730.6 5756.3 5853.1 5960.9 5112.6 6144.4 6207.5 6257.7 6277.9 6301.5 6308.2 6321.9 6328.5 6340.3 5953.9 6005.2 6007.3 6011.4 6024.5 6173.8 6182.2 6243.3 6259.4 6283.0 6156.8 6242.8 6244.4 6256.8 6265.2 6285.2 6292.2 6294.7 6311.1 6332.9 6126.4 6161.4 6168.5 6220.6 6302.1 5264.8 6188.4 6237.4 6267.4 6280.3 4228.4 5032.0 5055.3 5068.3 5114.0 3784.7 4363.0 4413.8 4525.8 4570.5 4616.4 4984.5 5819.8 5829.0 5847.4 6210.6 6283.1 6291.0 6304.6 6312.2 5633.5 5691.0 5840.2 5914.7 5930.9 5524.1 5543.1 5544.0 5555.6 5570.0 6459.3 6475.3 6477.0 6493.2 6508.8 6152.1 6184.0 6209.6 6210.8 6264.5 5384.7 5945.6 6393.2 6437.4 6458.3 6231.2 6243.4 6268.0 6272.7 6301.3 6119.5 6195.6 6215.6 6263.1 6277.6 4882.9 4894.9 6183.6 6209.0 6219.9 6132.7 6175.0 6182.2 6183.6 6186.2 5821.7 5909.1 5914.2 6075.1 6095.9 6052.6 6087.4 6112.9 6127.9 6190.9 5979.6 6046.8 6052.1 6064.9 6071.8 06:31:16 INFO - PROCESS | 1636 | 06:31:16 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:54160.80 Median:205258.03 stddev:100433.30 (48.9%) stddev-sans-first:100634.08 06:31:16 INFO - PROCESS | 1636 | Values: 451.2 457.9 491.4 493.0 520.6 39345.8 40276.0 40347.6 40363.6 40493.2 41690.6 42128.4 42134.2 42217.0 42259.6 6449.3 7995.2 8137.7 9068.5 9307.3 9304.6 11294.2 11301.1 11374.9 11457.6 8747.4 10088.6 11442.5 11458.8 11474.1 11372.4 11422.9 11434.1 11436.9 11469.5 11127.4 11172.0 11276.3 11285.9 11329.9 40388.2 40596.8 40689.0 40689.8 40751.4 3961.7 3993.7 4052.8 4070.3 4102.3 29285.6 29329.0 29394.9 29642.3 30123.0 3085.1 3338.0 3364.7 3367.7 3369.6 371792.0 448825.0 452759.0 453910.0 456787.0 59942.7 59994.0 60290.0 60394.7 60410.9 63293.0 63726.0 64454.7 64517.0 64696.4 16378.5 16599.9 16619.6 16629.3 16657.1 9655.0 9671.5 12774.0 12833.6 13012.3 15882.4 16007.4 16057.5 16062.8 16093.9 6932.2 7112.6 7126.4 7129.0 7208.0 864.0 885.0 886.5 905.5 917.9 29809.0 29826.1 29997.1 30364.0 30692.7 901.0 946.3 972.3 1113.0 1195.3 13414.4 13506.0 15005.7 15067.0 15185.9 370053.0 371217.0 372039.0 373186.0 374023.0 54358.0 54435.5 54448.5 54473.1 54630.0 1408.3 1433.5 1448.4 1453.5 1453.7 24171.6 25078.6 27129.6 27529.3 27709.3 34354.0 45978.8 45999.0 46014.5 46018.8 322635.0 323026.0 323445.9 324304.4 325393.0 24779.0 24986.0 25175.6 25237.9 46105.8 49077.0 49589.8 50181.7 50371.5 52237.2 30621.8 32352.0 39392.2 40198.8 43282.8 40772.0 41555.4 42030.4 42299.0 42737.0 33461.0 33768.2 33956.7 39799.8 40481.8 30445.5 34735.3 37128.8 37330.1 37537.0 21943.7 26899.6 27047.5 27183.3 27209.7 06:31:16 INFO - PROCESS | 1636 | 06:31:16 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:42138.89 Median:14393.59 stddev:134608.14 (935.2%) stddev-sans-first:134949.26 06:31:16 INFO - PROCESS | 1636 | Values: 396.2 396.4 403.9 409.8 421.3 19496.2 20193.7 20752.3 20866.6 20898.8 20237.6 20760.4 20857.7 20881.7 20893.7 5126.3 5424.4 5471.9 5516.2 5539.0 5431.3 5465.9 5468.8 5478.6 5614.3 5918.3 6002.5 6005.9 6017.7 6045.5 5404.1 5571.7 5986.5 6011.7 6021.2 5327.7 5381.0 5425.6 5428.2 5437.5 13624.7 15556.5 20696.5 25908.5 26149.7 2557.8 2590.3 2637.4 2664.2 2687.8 10109.9 10230.2 10378.2 10696.9 10724.6 1533.8 1846.9 1886.6 1900.7 1904.5 135422.0 136552.0 143295.3 144156.8 144414.0 11924.2 12284.6 12289.9 12303.5 12323.9 16174.8 16180.7 16201.4 16216.0 16238.4 8909.3 9067.1 9068.3 9109.8 9127.8 7400.4 8762.0 8820.6 8833.6 9005.4 4908.4 4918.0 4932.0 4988.5 5009.1 2061.6 2097.7 2122.9 2123.3 2127.5 409.5 415.5 1019.3 1044.5 1064.6 11539.7 11761.2 11774.1 11973.1 12134.9 368.2 384.7 386.0 430.4 437.6 5946.2 5973.1 5989.3 6036.3 6135.2 782692.0 805120.0 818050.0 820479.0 821171.0 123777.0 156172.2 156948.0 157049.4 157265.0 1017.3 1038.1 1073.7 1074.9 1075.0 15635.8 19608.8 19809.8 20029.7 20202.8 54165.6 59921.4 61222.0 61433.7 61460.7 83357.2 86007.0 86257.0 86793.6 88923.6 7006.5 8320.0 8492.0 8925.5 8984.7 11245.9 11681.9 13234.5 13278.3 13520.1 9897.0 10711.8 11482.0 11598.5 11987.5 9132.5 9998.7 11196.6 11398.5 11513.9 11631.2 11772.8 11850.3 12007.2 12029.8 7694.0 7801.3 7821.0 8070.6 8163.4 8547.3 10465.3 11622.1 11882.9 11935.2 06:31:16 INFO - PROCESS | 1636 | 06:31:16 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:5342.05 Median:5042.42 stddev:2925.38 (58.0%) stddev-sans-first:2917.15 06:31:16 INFO - PROCESS | 1636 | Values: 1216.2 1415.2 1426.2 1426.4 1440.8 7439.3 7704.0 8017.8 8478.4 8534.0 6664.9 8282.1 8291.9 8389.4 8409.2 2280.9 2320.3 2324.4 2341.8 2342.9 2058.6 2136.5 2306.6 2341.9 2346.1 2228.3 2332.9 2335.1 2335.7 2340.1 2286.4 2319.4 2336.9 2341.2 2344.8 1981.6 2314.2 2346.5 2352.1 2377.9 8272.4 8312.0 8397.9 8404.7 8432.2 4904.6 5037.4 5041.8 5043.0 5045.7 3292.0 3452.0 3509.6 3516.2 3578.0 1207.5 1228.3 1273.8 1277.5 1290.0 10492.2 10629.8 10734.6 10772.2 10775.7 3706.0 4314.0 4316.5 4541.6 4681.0 7985.8 9455.5 9539.2 9547.6 9644.1 5203.2 5247.7 5254.3 5262.2 5264.9 4514.8 4614.8 4743.7 4743.9 4835.9 3870.0 3935.6 3978.8 4028.4 4045.8 1088.8 1174.9 1210.6 1252.3 1289.5 769.6 827.4 889.8 904.5 907.7 5214.5 5390.5 5408.4 5436.6 5541.2 901.8 950.6 964.6 1006.4 1024.2 3234.7 3425.1 3624.6 3640.7 3707.9 9695.8 9841.9 10037.0 10050.9 10076.3 9697.5 9715.9 9732.8 9739.8 10015.9 7576.5 7714.0 7722.2 7728.0 7737.5 4313.5 4560.2 5198.5 5236.5 5355.3 9145.0 9152.9 9213.3 9256.0 9299.8 9142.6 9293.7 9375.5 9402.9 9405.3 6694.4 6766.8 6794.9 6806.0 6824.4 7722.5 7806.8 7812.8 7813.3 7831.0 6922.3 6991.8 7094.0 7117.1 7175.3 6855.3 6969.9 6978.1 7096.1 7096.4 5390.6 5900.1 6254.8 6266.6 6302.4 4759.5 4784.0 4810.8 4823.3 4828.1 4757.6 4798.5 4838.9 4969.4 4989.6 06:31:16 INFO - PROCESS | 1636 | 06:31:16 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4501.93 Median:4929.53 stddev:1337.00 (27.1%) stddev-sans-first:1303.28 06:31:16 INFO - PROCESS | 1636 | Values: 313.9 345.0 357.7 367.2 372.5 4968.9 5103.9 5297.6 5467.6 5470.8 5096.4 5259.5 5348.2 5348.6 5358.5 3535.3 3874.5 4023.8 4261.4 4267.8 3744.8 4076.9 4160.7 4244.0 4275.9 3318.6 3600.4 4061.2 4158.6 4175.6 3410.8 3683.6 4188.9 4196.7 4201.6 3139.3 3277.3 3672.9 3740.6 3758.3 4247.6 4606.4 4823.5 5203.7 5245.9 4482.6 4852.9 4857.5 4873.5 4910.9 5047.8 5114.4 5362.0 5729.9 5732.8 3714.8 3887.4 3915.8 4071.3 4114.0 5333.8 5457.7 5925.3 5951.8 5956.7 3684.2 4052.4 4197.2 4214.8 4232.4 3790.6 3815.5 4044.8 4206.2 4278.3 4847.1 4850.2 4854.2 4858.6 4869.8 5677.7 5720.5 5733.1 5777.3 5790.9 1249.9 1316.1 1351.0 1363.4 1396.7 896.3 975.2 984.9 997.4 1003.9 4297.3 4538.9 4927.4 4958.5 4984.2 4652.2 4740.9 4770.6 5290.8 5509.8 4335.0 4931.7 4961.1 4978.3 5005.6 2752.0 2827.4 2853.4 2907.3 2922.6 5047.6 5124.6 5608.6 5692.7 5782.5 4701.4 4775.8 5388.5 5668.8 5731.2 5246.8 5638.7 5698.7 5771.5 6044.3 5163.8 5277.8 5418.9 5807.8 5839.2 5444.6 5544.4 5683.7 5765.4 5779.4 4802.9 5224.6 5623.6 6051.5 6072.1 3858.0 3859.2 3903.3 3910.0 3918.0 4903.1 5153.0 5467.3 5661.3 5808.7 4683.5 5061.0 5380.6 5612.7 5645.4 4183.8 4698.3 5559.1 5579.2 5626.2 4742.4 4793.5 5106.1 5521.0 5521.0 5159.3 5174.8 5243.4 5630.4 5661.0 4896.4 5276.4 5521.8 5523.8 5562.0 06:31:16 INFO - PROCESS | 1636 | 06:31:16 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:20504.58 Median:4198.45 stddev:29756.48 (708.7%) stddev-sans-first:29802.77 06:31:16 INFO - PROCESS | 1636 | Values: 693.2 701.8 768.0 810.7 820.6 14831.9 15335.7 15380.0 15482.5 15513.8 14152.5 14306.4 14311.6 14333.2 14343.3 674.9 686.8 805.5 851.6 856.2 861.9 862.1 862.2 863.8 864.4 900.3 917.5 919.7 919.7 921.7 908.9 913.5 914.1 918.6 922.3 676.6 684.9 687.0 690.1 691.1 12453.9 15156.1 15205.3 15414.5 15534.9 13430.5 14159.4 14356.1 14374.5 14380.2 10987.1 11394.9 11487.4 11659.5 12039.2 4371.4 4426.1 4440.1 4450.6 4468.1 93267.0 101791.0 109899.5 111122.0 113945.4 9393.3 10335.6 10440.1 10652.9 11170.6 20650.9 20762.1 20873.6 21056.2 21097.9 7481.6 7532.3 7569.7 7621.8 7677.8 3635.5 4137.5 4184.1 4193.0 4203.9 3356.7 3417.0 3432.8 3469.9 3520.0 512.9 657.9 663.9 673.4 674.0 525.5 535.7 539.4 543.1 547.4 9363.4 9838.5 9863.9 10060.4 10251.0 621.6 636.9 654.5 657.8 676.5 4244.9 4325.1 4462.2 4764.9 4807.9 70659.0 108958.0 110309.4 110695.3 111146.0 93011.0 94818.0 94978.0 95781.0 98545.0 69458.6 70195.0 73491.0 77416.6 80941.0 9141.8 10360.8 10788.7 11203.3 11305.8 40393.6 49731.0 53259.5 53635.2 53689.0 65247.7 66281.7 67499.3 69250.7 69686.7 12782.7 12803.2 12890.2 13128.3 13559.5 13757.1 14052.9 14609.3 14674.5 15273.2 13667.7 13935.7 14291.1 14330.7 14388.4 13796.3 13935.7 14237.3 14346.7 14361.4 12764.5 13378.3 13609.2 14004.6 14060.7 10524.5 10627.6 10798.0 11265.9 11403.8 7750.5 8696.4 10460.7 10503.1 10532.6 06:31:16 INFO - PROCESS | 1636 | -------- Summary: end -------- 06:31:16 INFO - PROCESS | 1636 | 06:31:16 INFO - TEST-INFO | 1636: exit 0 06:31:16 INFO - TEST-OK | dromaeo_css | took 1115498ms 06:31:16 INFO - TEST-START | kraken 06:31:16 INFO - operating with platform_type : mac_ 06:31:16 INFO - Initialising browser for kraken test... 06:31:16 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmp2GiDdp/profile http://localhost:49241/getInfo.html) 06:31:19 INFO - PROCESS | 1649 | 2017-02-09 06:31:19.634 plugin-container[1650:10313] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 06:31:19 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:31:19 INFO - PROCESS | 1649 | 2017-02-09 06:31:19.637 plugin-container[1650:10313] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d1f, name = 'com.apple.CFPasteboardClient' 06:31:19 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:31:19 INFO - PROCESS | 1649 | 2017-02-09 06:31:19.637 plugin-container[1650:10313] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:31:19 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 06:31:19 INFO - PROCESS | 1649 | colorDepth:24 06:31:19 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 06:31:19 INFO - PROCESS | 1649 | __metrics 06:31:19 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 06:31:19 INFO - PROCESS | 1649 | 1486650679810 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < forceQuit@jar:file:///var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmp2GiDdp/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmp2GiDdp/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmp2GiDdp/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmp2GiDdp/profile/extensions/talos-powers@TalosPowersService.js:55:9 06:31:20 INFO - TEST-INFO | 1649: exit 0 06:31:20 INFO - Browser initialized. 06:31:20 INFO - Running cycle 1/1 for kraken test... 06:31:20 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmp2GiDdp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:31:23 INFO - PROCESS | 1651 | 2017-02-09 06:31:23.133 plugin-container[1652:10439] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 06:31:23 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:31:23 INFO - PROCESS | 1651 | 2017-02-09 06:31:23.133 plugin-container[1652:10439] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4723, name = 'com.apple.CFPasteboardClient' 06:31:23 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:31:23 INFO - PROCESS | 1651 | 2017-02-09 06:31:23.134 plugin-container[1652:10439] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:31:32 INFO - PROCESS | 1651 | RSS: Main: 218361856 06:31:32 INFO - PROCESS | 1651 | 06:31:35 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 06:31:36 INFO - PROCESS | 1651 | RSS: Main: 232763392 06:31:36 INFO - PROCESS | 1651 | 06:31:39 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 06:31:40 INFO - PROCESS | 1651 | RSS: Main: 241205248 06:31:40 INFO - PROCESS | 1651 | 06:31:43 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 06:31:44 INFO - PROCESS | 1651 | RSS: Main: 244584448 06:31:44 INFO - PROCESS | 1651 | 06:31:46 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 06:31:46 INFO - PROCESS | 1651 | RSS: Main: 244719616 06:31:46 INFO - PROCESS | 1651 | 06:31:48 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:31:49 INFO - PROCESS | 1651 | RSS: Main: 246226944 06:31:49 INFO - PROCESS | 1651 | 06:31:52 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 06:31:52 INFO - PROCESS | 1651 | RSS: Main: 250732544 06:31:52 INFO - PROCESS | 1651 | 06:31:56 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 06:31:56 INFO - PROCESS | 1651 | RSS: Main: 249503744 06:31:56 INFO - PROCESS | 1651 | 06:31:59 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 06:32:00 INFO - PROCESS | 1651 | RSS: Main: 249679872 06:32:00 INFO - PROCESS | 1651 | 06:32:01 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:32:02 INFO - PROCESS | 1651 | RSS: Main: 249122816 06:32:02 INFO - PROCESS | 1651 | 06:32:04 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:32:05 INFO - PROCESS | 1651 | RSS: Main: 249077760 06:32:05 INFO - PROCESS | 1651 | 06:32:07 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:32:08 INFO - PROCESS | 1651 | RSS: Main: 249143296 06:32:08 INFO - PROCESS | 1651 | 06:32:10 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:32:11 INFO - PROCESS | 1651 | RSS: Main: 249487360 06:32:11 INFO - PROCESS | 1651 | 06:32:14 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:32:15 INFO - PROCESS | 1651 | RSS: Main: 249257984 06:32:15 INFO - PROCESS | 1651 | 06:32:17 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 06:32:17 INFO - PROCESS | 1651 | RSS: Main: 251133952 06:32:17 INFO - PROCESS | 1651 | 06:32:17 INFO - PROCESS | 1651 | __start_tp_report 06:32:17 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 06:32:17 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 06:32:17 INFO - PROCESS | 1651 | |i|pagename|runs| 06:32:17 INFO - PROCESS | 1651 | |0;ai-astar;106;162;118;120;116;120;119;122;122;169 06:32:17 INFO - PROCESS | 1651 | |1;audio-beat-detection;138;111;108;149;139;143;115;108;141;131 06:32:17 INFO - PROCESS | 1651 | |2;audio-dft;221;178;185;185;170;273;277;257;199;196 06:32:17 INFO - PROCESS | 1651 | |3;audio-fft;92;59;60;86;58;58;59;62;93;81 06:32:17 INFO - PROCESS | 1651 | |4;audio-oscillator;86;71;86;76;106;64;114;99;101;80 06:32:17 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;91;87;90;88;99;87;91;86;93;87 06:32:17 INFO - PROCESS | 1651 | |6;imaging-darkroom;126;152;144;98;130;104;156;103;100;155 06:32:17 INFO - PROCESS | 1651 | |7;imaging-desaturate;92;92;150;150;91;91;97;90;93;94 06:32:17 INFO - PROCESS | 1651 | |8;json-parse-financial;56;55;57;60;59;58;48;53;57;80 06:32:17 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;68;70;72;80;101;108;104;79;69;71 06:32:17 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;86;103;109;105;95;85;86;86;83;88 06:32:17 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;140;130;137;150;154;141;144;157;212;132 06:32:17 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;169;172;170;165;170;170;170;170;169;169 06:32:17 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;68;68;68;65;69;66;68;80;73;65 06:32:17 INFO - PROCESS | 1651 | __end_tp_report 06:32:17 INFO - PROCESS | 1651 | __start_cc_report 06:32:17 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,951 06:32:17 INFO - PROCESS | 1651 | __end_cc_report 06:32:17 INFO - PROCESS | 1651 | __startTimestamp1486650737274__endTimestamp 06:32:17 INFO - PROCESS | 1651 | 06:32:17 INFO - PROCESS | 1651 | ------- Summary: start ------- 06:32:17 INFO - PROCESS | 1651 | Number of tests: 14 06:32:17 INFO - PROCESS | 1651 | 06:32:17 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:127.40 Median:121.00 stddev:20.66 (17.1%) stddev-sans-first:20.41 06:32:17 INFO - PROCESS | 1651 | Values: 106.0 162.0 118.0 120.0 116.0 120.0 119.0 122.0 122.0 169.0 06:32:17 INFO - PROCESS | 1651 | 06:32:17 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:128.30 Median:138.50 stddev:16.06 (11.6%) stddev-sans-first:16.65 06:32:17 INFO - PROCESS | 1651 | Values: 138.0 111.0 108.0 149.0 139.0 143.0 115.0 108.0 141.0 131.0 06:32:17 INFO - PROCESS | 1651 | 06:32:17 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:214.10 Median:210.00 stddev:40.57 (19.3%) stddev-sans-first:42.95 06:32:17 INFO - PROCESS | 1651 | Values: 221.0 178.0 185.0 185.0 170.0 273.0 277.0 257.0 199.0 196.0 06:32:17 INFO - PROCESS | 1651 | 06:32:17 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:70.80 Median:71.50 stddev:15.19 (21.2%) stddev-sans-first:14.05 06:32:17 INFO - PROCESS | 1651 | Values: 92.0 59.0 60.0 86.0 58.0 58.0 59.0 62.0 93.0 81.0 06:32:17 INFO - PROCESS | 1651 | 06:32:17 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:88.30 Median:78.00 stddev:16.23 (20.8%) stddev-sans-first:17.19 06:32:17 INFO - PROCESS | 1651 | Values: 86.0 71.0 86.0 76.0 106.0 64.0 114.0 99.0 101.0 80.0 06:32:17 INFO - PROCESS | 1651 | 06:32:17 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:89.90 Median:90.50 stddev:3.93 (4.3%) stddev-sans-first:4.15 06:32:17 INFO - PROCESS | 1651 | Values: 91.0 87.0 90.0 88.0 99.0 87.0 91.0 86.0 93.0 87.0 06:32:17 INFO - PROCESS | 1651 | 06:32:17 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:126.80 Median:148.00 stddev:24.09 (16.3%) stddev-sans-first:25.55 06:32:17 INFO - PROCESS | 1651 | Values: 126.0 152.0 144.0 98.0 130.0 104.0 156.0 103.0 100.0 155.0 06:32:17 INFO - PROCESS | 1651 | 06:32:17 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:104.00 Median:92.00 stddev:24.32 (26.4%) stddev-sans-first:25.41 06:32:17 INFO - PROCESS | 1651 | Values: 92.0 92.0 150.0 150.0 91.0 91.0 97.0 90.0 93.0 94.0 06:32:17 INFO - PROCESS | 1651 | 06:32:17 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:57.50 stddev:8.35 (14.5%) stddev-sans-first:8.82 06:32:17 INFO - PROCESS | 1651 | Values: 56.0 55.0 57.0 60.0 59.0 58.0 48.0 53.0 57.0 80.0 06:32:17 INFO - PROCESS | 1651 | 06:32:17 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:82.20 Median:70.50 stddev:15.86 (22.5%) stddev-sans-first:15.97 06:32:17 INFO - PROCESS | 1651 | Values: 68.0 70.0 72.0 80.0 101.0 108.0 104.0 79.0 69.0 71.0 06:32:17 INFO - PROCESS | 1651 | 06:32:17 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:92.60 Median:86.00 stddev:9.65 (11.2%) stddev-sans-first:9.94 06:32:17 INFO - PROCESS | 1651 | Values: 86.0 103.0 109.0 105.0 95.0 85.0 86.0 86.0 83.0 88.0 06:32:17 INFO - PROCESS | 1651 | 06:32:17 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:149.70 Median:147.00 stddev:23.61 (16.1%) stddev-sans-first:24.78 06:32:17 INFO - PROCESS | 1651 | Values: 140.0 130.0 137.0 150.0 154.0 141.0 144.0 157.0 212.0 132.0 06:32:17 INFO - PROCESS | 1651 | 06:32:17 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.40 Median:170.00 stddev:1.78 (1.0%) stddev-sans-first:1.88 06:32:17 INFO - PROCESS | 1651 | Values: 169.0 172.0 170.0 165.0 170.0 170.0 170.0 170.0 169.0 169.0 06:32:17 INFO - PROCESS | 1651 | 06:32:17 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:68.00 stddev:4.50 (6.6%) stddev-sans-first:4.76 06:32:17 INFO - PROCESS | 1651 | Values: 68.0 68.0 68.0 65.0 69.0 66.0 68.0 80.0 73.0 65.0 06:32:17 INFO - PROCESS | 1651 | -------- Summary: end -------- 06:32:17 INFO - PROCESS | 1651 | 06:32:18 INFO - TEST-INFO | 1651: exit 0 06:32:18 INFO - TEST-OK | kraken | took 61383ms 06:32:18 INFO - SUITE-END | took 1176s 06:32:18 INFO - Completed test suite (00:19:37) 06:32:18 INFO - javascript benchmark 06:32:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7171.122119401246, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2991.7905746597735, 3326.4345061339554, 3370.3259348130364, 3377.814220217887, 3417.948730769039, 4529.932051019229, 4919.680220785646, 5657.207990881275, 5712.771489140429, 5762.452567006138, 5771.971140144294, 5812.3025236971625, 5823.883522329551, 5859.648421094737, 5868.794592189274, 5293.100172970595, 5318.707471089088, 5327.334083239595, 5367.06076436624, 5372.57019438446, 5390.407055223922, 5401.648892821973, 5405.108157154064, 5423.674579525222, 5445.237666726662, 4603.3785438965815, 5213.765380557884, 5233.607479439057, 5409.377921539014, 5422.9728851355685, 5260.552853007499, 5280.102382594968, 5322.840314790524, 5326.147816349366, 5395.082835917903, 5208.192730126836, 5293.444188360205, 5299.311089558333, 5306.946930530684, 5313.256144139824, 5559.610827242094, 5730.598858079936, 5756.338021127582, 5853.051058530511, 5960.910586341209, 5112.565431938289, 6144.3717414885095, 6207.472364848948, 6257.749690012394, 6277.905831412532, 6301.464375528086, 6308.179936608211, 6321.87356252877, 6328.493720502349, 6340.3025667177035, 5953.880922381528, 6005.249343832021, 6007.30915944672, 6011.368806275322, 6024.518038556948, 6173.753049877954, 6182.227221597301, 6243.344448832807, 6259.436650701458, 6282.968585157137, 6156.8152955410515, 6242.812715618538, 6244.438000579969, 6256.812295631047, 6265.185525881606, 6285.182926219562, 6292.2134733158355, 6294.685265736694, 6311.147995020613, 6332.905006424908, 6126.448619624255, 6161.44546990773, 6168.506519478431, 6220.564560480813, 6302.1177035215105, 5264.81541653125, 6188.44304012641, 6237.376262373817, 6267.373262673787, 6280.2777680566405, 4228.4080228768, 5032.043911656773, 5055.317532133115, 5068.341115654941, 5114.028334616411, 3784.735068545175, 4362.956370436318, 4413.845515406945, 4525.818967241339, 4570.54294570547, 4616.3998680172035, 4984.451710311862, 5819.79630712923, 5829.038208695602, 5847.415258474203, 6210.5652604317265, 6283.05754136874, 6291.02489114188, 6304.590201636879, 6312.179416675803, 5633.492985631313, 5691.03252447085, 5840.2115714378015, 5914.733836977346, 5930.881382372415, 5524.116141417434, 5543.057680194376, 5544.002079625626, 5555.611107222456, 5569.972150139223, 6459.321771213955, 6475.32009139043, 6476.967615162082, 6493.22081350241, 6508.8047358579315, 6152.138700582012, 6184.0, 6209.565330426827, 6210.844728881814, 6264.5301602379095, 5384.680753215487, 5945.64326140433, 6393.1688880445245, 6437.356264373712, 6458.289588145206, 6231.22109736283, 6243.43809057187, 6268.0, 6272.655003974643, 6301.275353334425, 6119.502553941512, 6195.628262304276, 6215.627062376272, 6263.0605409187165, 6277.591956522811, 4882.92675609859, 4894.902101958012, 6183.5671502994355, 6208.9689551551955, 6219.937800621936, 6132.6627035513475, 6175.0, 6182.196314479089, 6183.598066125687, 6186.164867742978, 5821.679807610622, 5909.113632955091, 5914.231149950651, 6075.149479072845, 6095.908561371672, 6052.636841789506, 6087.421694938974, 6112.868254063078, 6127.877442451215, 6190.907136393048, 5979.5814292999075, 6046.818595442144, 6052.061930400795, 6064.939350606437, 6071.817845464643], "value": 5702.064082785614, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [451.2081297323196, 457.86264120763764, 491.37595254027366, 492.98767530811733, 520.6017396691532, 39345.81962541125, 40276.0, 40347.59652403475, 40363.59636403635, 40493.19013619733, 41690.583094169124, 42128.36807447891, 42134.15731685364, 42217.0, 42259.57740422595, 6449.322821103787, 7995.160508146648, 8137.674493020272, 9068.455892646429, 9307.34848560601, 9304.627814887397, 11294.152938529602, 11301.095912326995, 11374.943125284362, 11457.59898403556, 8747.38768286217, 10088.646897358594, 11442.542298308099, 11458.770824583504, 11474.139439542068, 11372.37451940143, 11422.94288528552, 11434.085273178167, 11436.94281528587, 11469.541218351256, 11127.443627818657, 11172.0, 11276.267042642203, 11285.943570282177, 11329.886701132966, 40388.19223615541, 40596.79701601503, 40689.0, 40689.79655101735, 40751.388729169084, 3961.7028722845903, 3993.740406873573, 4052.837886484537, 4070.3080476319096, 4102.3026085565525, 29285.56071658927, 29328.973485928105, 29394.85302573495, 29642.25894352637, 30123.0, 3085.1053194573547, 3338.0486561329903, 3364.713999310062, 3367.696907278332, 3369.5619569456057, 371792.0, 448825.0, 452759.0, 453910.0, 456787.0, 59942.700286498286, 59994.0, 60290.0, 60394.698026510465, 60410.885619004, 63293.0, 63726.0, 64454.677726611066, 64517.0, 64696.35303646903, 16378.508644740677, 16599.91700041492, 16619.584510387096, 16629.251683674265, 16657.083860387553, 9654.95172524147, 9671.516424178904, 12773.978081753437, 12833.550825721242, 13012.284324362061, 15882.444114455939, 16007.43973960929, 16057.518274451784, 16062.839371606135, 16093.919530402272, 6932.23745388007, 7112.608806515588, 7126.35862772353, 7129.0, 7207.9639601801655, 863.9568021598894, 884.9911101344472, 886.5434301334818, 905.4793493741125, 917.8806755121791, 29809.0, 29826.10521684353, 29997.10008699699, 30363.968011769583, 30692.69307306943, 901.0043901488891, 946.2997381937455, 972.3145182646217, 1112.9777404451866, 1195.282830301812, 13414.396352164176, 13506.0, 15005.69988600222, 15067.020643658127, 15185.936984411206, 370053.0, 371217.0, 372039.0, 373186.0, 374023.0, 54358.0, 54435.45564544383, 54448.45551544513, 54473.09344173014, 54630.0, 1408.2677007955806, 1433.491110655723, 1448.4278709909738, 1453.5493996861007, 1453.7092581483746, 24171.637425438985, 25078.620675863003, 27129.59305610378, 27529.31176720598, 27709.30726731848, 34354.0, 45978.770106149255, 45999.0, 46014.539854601026, 46018.76990615026, 322635.0, 323026.0, 323445.9138521462, 324304.3784781061, 325393.0, 24779.0, 24986.0, 25175.622365664163, 25237.873810631565, 46105.76947115377, 49077.0, 49589.75205123951, 50181.74909125431, 50371.49628503815, 52237.17169899035, 30621.77512899459, 32352.029439116865, 39392.21215575615, 40198.79900600478, 43282.78358608187, 40771.99049918962, 41555.37666934938, 42030.36954445625, 42299.0, 42737.0, 33461.0, 33768.1557961053, 33956.66043339535, 39799.80100099481, 40481.78554643365, 30445.54331684982, 34735.30529389449, 37128.81435592805, 37330.06674833151, 37537.0, 21943.670844937657, 26899.596506052032, 27047.459050819267, 27183.320416989733, 27209.72790272151], "value": 19317.308422943235, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.2056077564483, 396.38758118706596, 403.94748682671246, 409.76848080834316, 421.3027439587482, 19496.220151193953, 20193.697094543557, 20752.27367042154, 20866.582668346644, 20898.791012089874, 20237.59524809503, 20760.377188684324, 20857.748535087907, 20881.68677469839, 20893.686594701092, 5126.282320475128, 5424.376196737367, 5471.917921231165, 5516.200150978106, 5539.030669632798, 5431.293931788862, 5465.945340546603, 5468.781248750045, 5478.58910581708, 5614.326280846304, 5918.2898052233795, 6002.459778619924, 6005.87988240235, 6017.669028203469, 6045.546584006195, 5404.054290499186, 5571.721413929328, 5986.491148252404, 6011.669358185298, 6021.157038014681, 5327.706976116312, 5381.0, 5425.647332923348, 5428.240046393508, 5437.456254374571, 13624.727505449935, 15556.455524056604, 20696.482587935272, 25908.481830363475, 26149.73850261492, 2557.8337408068414, 2590.326515106086, 2637.4329519153475, 2664.200739778059, 2687.771539419152, 10109.949450252701, 10230.23273254509, 10378.221633377527, 10696.893031069745, 10724.571017159304, 1533.7699345098213, 1846.8549499310514, 1886.5849513107094, 1900.6673832079468, 1904.523869032742, 135422.0, 136552.0, 143295.28352358277, 144156.83764743537, 144413.99999999895, 11924.224925379822, 12284.570040048555, 12289.877101228873, 12303.523577170798, 12323.876761232452, 16174.838251617568, 16180.676386472205, 16201.351945922032, 16216.0, 16238.431654892258, 8909.262693774652, 9067.093290671011, 9068.319876009326, 9109.77225569366, 9127.771805704777, 7400.444966627524, 8762.036176020632, 8820.647174113092, 8833.64665413389, 9005.414648047856, 4908.435529914034, 4917.975410122998, 4931.950680493221, 4988.526090021514, 5009.12340340439, 2061.5567652954687, 2097.6958341040463, 2122.936311910645, 2123.309924274617, 2127.457498337945, 409.49836450348084, 415.5159239485965, 1019.2966852871494, 1044.5404022230193, 1064.5582083435443, 11539.711507212387, 11761.176717629854, 11774.116941229271, 11973.102017348734, 12134.939325303318, 368.158757239706, 384.7229994404025, 386.0118097669974, 430.37165738022213, 437.59959636932484, 5946.1972633693895, 5973.133895585116, 5989.31122920861, 6036.3058248302, 6135.202423684982, 782692.0, 805120.0, 818050.0, 820479.0, 821171.0, 123777.0, 156172.21913890357, 156948.0, 157049.42950570578, 157265.0, 1017.3031473440717, 1038.1072277841201, 1073.6993641780314, 1074.8763892152347, 1074.9570017199223, 15635.765463518284, 19608.8039119607, 19809.7655040116, 20029.699554506402, 20202.787832730082, 54165.645858853844, 59921.40078599158, 61222.0, 61433.692831535554, 61460.69269653623, 83357.16642833494, 86007.0, 86257.0, 86793.56603216943, 88923.55538222268, 7006.474514411541, 8319.958400207961, 8492.0, 8925.509096999727, 8984.730458086267, 11245.887541124812, 11681.941590291994, 13234.470621175431, 13278.336083195994, 13520.12119212248, 9896.960819114178, 10711.785764284516, 11482.0, 11598.47806848677, 11987.520499179935, 9132.49771262587, 9998.700038998843, 11196.608118715805, 11398.487068081791, 11513.94243028813, 11631.243969141979, 11772.823407649063, 11850.348230847387, 12007.219530730474, 12029.819552706891, 7693.961530192313, 7801.258880406353, 7820.960895195488, 8070.556119413253, 8163.428560000981, 8547.27348175412, 10465.319754215952, 11622.128340374336, 11882.881171188523, 11935.224210426295], "value": 9322.667198998728, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1216.2094638484984, 1415.1721243072802, 1426.1816184364927, 1426.351010290318, 1440.8113306522118, 7439.256074392558, 7703.998480197581, 8017.799555011127, 8478.3641226908, 8534.01858786239, 6664.933350666492, 8282.130376310475, 8291.91708082919, 8389.41274110811, 8409.243168114868, 2280.908763649452, 2320.2575175943703, 2324.407276144581, 2341.7775311345395, 2342.9297121086393, 2058.6397380458434, 2136.529963408048, 2306.630939049752, 2341.882905854709, 2346.061575369857, 2228.3315005498366, 2332.8716920569364, 2335.1243283768586, 2335.708036495438, 2340.1341503643675, 2286.3598192506042, 2319.396956791238, 2336.9298921032228, 2341.2390972933863, 2344.753800850912, 1981.5640559077124, 2314.247869442438, 2346.507233480971, 2352.141468364052, 2377.9286621401384, 8272.420930534865, 8312.0, 8397.874031889527, 8404.663813447454, 8432.15678432158, 4904.60763138948, 5037.420696619863, 5041.798328066873, 5043.041822053798, 5045.697258164522, 3291.983540082308, 3451.9827400862837, 3509.6314886937016, 3516.1519169472554, 3578.0339308386588, 1207.4928530017414, 1228.318283352739, 1273.770721270171, 1277.482619539088, 1290.0002498063982, 10492.16062714981, 10629.84055239172, 10734.624288149877, 10772.245942784008, 10775.730606734816, 3706.036430528028, 4313.97843010783, 4316.460442444694, 4541.591256786905, 4680.953190468052, 7985.760427187193, 9455.479948602893, 9539.189168920719, 9547.570359333708, 9644.132028117363, 5203.245529398292, 5247.711375874287, 5254.264402983586, 5262.158054711228, 5264.947350526446, 4514.796834142471, 4614.792334344963, 4743.667943244009, 4743.905121897543, 4835.927461088087, 3869.9806500967316, 3935.6457918787446, 3978.781167035783, 4028.3756017817286, 4045.777482238505, 1088.7985722641338, 1174.9353785541707, 1210.5702475621204, 1252.3362617812575, 1289.548657969703, 769.5805785846727, 827.4084029918637, 889.8131392407538, 904.4573256046451, 907.6732376344511, 5214.504622060974, 5390.4879036491475, 5408.37803652585, 5436.6194366393975, 5541.168824676251, 901.7700486375932, 950.619752099152, 964.5852283518154, 1006.3710181136789, 1024.206240163864, 3234.725048370915, 3425.0581090200394, 3624.619414961391, 3640.6541378568995, 3707.870224542128, 9695.757606059764, 9841.901580984242, 10037.0, 10050.899491005142, 10076.345037572535, 9697.466639334903, 9715.854262186072, 9732.756681082888, 9739.756506087404, 10015.949920250352, 7576.545407275581, 7714.0, 7722.150563438017, 7727.961360193163, 7737.458377913605, 4313.525512193719, 4560.224761790437, 5198.532132108128, 5236.476352364885, 5355.3305836770405, 9145.039770823967, 9152.908470915205, 9213.309001825024, 9255.953720231355, 9299.767505812139, 9142.58858351389, 9293.67472138472, 9375.484348360633, 9402.858957115786, 9405.341626086381, 6694.397504224643, 6766.763163289458, 6794.898076528757, 6805.9659701701175, 6824.385805277549, 7722.459427839997, 7806.804829879298, 7812.765617031499, 7813.257740514642, 7830.960845195737, 6922.342377474132, 6991.7902462926195, 7094.0, 7117.110361204849, 7175.31834475724, 6855.348741869514, 6969.895451568129, 6978.057962175041, 7096.148462184571, 7096.432285417258, 5390.622656414013, 5900.144479050599, 6254.8123556293385, 6266.561340706106, 6302.401271879165, 4759.50025247344, 4783.976080119716, 4810.807567697393, 4823.300621409946, 4828.130936431476, 4757.5718185363485, 4798.49615790337, 4838.879028024327, 4969.35398398206, 4989.600831933364], "value": 4349.210167161375, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.9232432755648, 345.0167023981652, 357.6789509405172, 367.18301778542764, 372.53247174795644, 4968.925466118011, 5103.923441148386, 5297.576193904488, 5467.617266791326, 5470.835874923749, 5096.362954630671, 5259.526642602165, 5348.224507446418, 5348.625596208267, 5358.4641535846395, 3535.257595904863, 3874.5156855393075, 4023.8189281482255, 4261.424707664457, 4267.829286828523, 3744.794036328001, 4076.857309994151, 4160.7087503874745, 4243.97878010611, 4275.850345237917, 3318.634950155481, 3600.3879340512044, 4061.1674606705556, 4158.584141585832, 4175.624193822556, 3410.795352278871, 3683.5763887153053, 4188.874333769992, 4196.733763767562, 4201.6218540331365, 3139.3407384449292, 3277.2626159114247, 3672.944905826388, 3740.60723624021, 3758.32350176968, 4247.5964783345535, 4606.447226332828, 4823.456493921946, 5203.713795741271, 5245.947540524584, 4482.5965663090155, 4852.8544143675745, 4857.514248575149, 4873.541633370648, 4910.877228069291, 5047.772850221749, 5114.43741188469, 5362.034833729927, 5729.942700572982, 5732.828015159552, 3714.7741245388956, 3887.3974533947285, 3915.8237879295502, 4071.3282308419075, 4114.012636967136, 5333.813316533902, 5457.727113644341, 5925.34821169671, 5951.791687290924, 5956.694034810722, 3684.2078953024693, 4052.4124002019544, 4197.202531519001, 4214.810333534998, 4232.423602056258, 3790.574032619126, 3815.5421349438243, 4044.7775372354213, 4206.170315912588, 4278.315469524861, 4847.104424531179, 4850.175470170079, 4854.2233242681, 4858.6356023298395, 4869.805207791649, 5677.687727175045, 5720.513756330675, 5733.140028995684, 5777.335606405233, 5790.855228619234, 1249.881261280177, 1316.0787448785698, 1350.959471215865, 1363.3660347938057, 1396.6578188343717, 896.2561074308309, 975.2100798353357, 984.9212063035084, 997.3567049253191, 1003.9347442416366, 4297.269464191032, 4538.886527836765, 4927.408710954708, 4958.479359667255, 4984.230598137681, 4652.1626107300335, 4740.881477963078, 4770.642201834877, 5290.783329587719, 5509.752061157257, 4335.0, 4931.654784165145, 4961.11477638495, 4978.303037574742, 5005.624578156653, 2751.954257382222, 2827.4203788223363, 2853.3579944512317, 2907.3252607601057, 2922.5888641870542, 5047.596192304681, 5124.56441202502, 5608.579356548194, 5692.658440493584, 5782.479576838105, 4701.412323459567, 4775.785089670973, 5388.5419739321815, 5668.829935101953, 5731.191716059101, 5246.842594722164, 5638.661680299195, 5698.6580805151825, 5771.47056030144, 6044.304904935901, 5163.845084647466, 5277.788888444419, 5418.918716219338, 5807.82576522705, 5839.2190381933915, 5444.5916556259235, 5544.419840345482, 5683.687397193029, 5765.3946335634155, 5779.393163717749, 4802.855914322576, 5224.615476898701, 5623.606347555796, 6051.515878729779, 6072.089186622042, 3857.9614203858723, 3859.2088621831895, 3903.2583809076186, 3909.9609003909595, 3918.0204948762807, 4903.117438861039, 5153.0, 5467.261919640957, 5661.2923384576925, 5808.680522571299, 4683.531646835289, 5060.987802439453, 5380.569554435558, 5612.7193640317, 5645.40723224072, 4183.769892655811, 4698.342232087579, 5559.054960656779, 5579.218909352613, 5626.184203290418, 4742.383490146259, 4793.544613261734, 5106.055379754757, 5520.963470091353, 5521.0, 5159.277701121921, 5174.765771392879, 5243.423223445342, 5630.4369563043365, 5661.037623604079, 4896.4124305083615, 5276.366835979554, 5521.806736764194, 5523.834284971457, 5562.0], "value": 4095.6185194359705, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.1578132568931, 701.7929710735333, 767.9539227646342, 810.6838333050111, 820.552798724695, 14831.851681483182, 15335.69328613427, 15380.000299980493, 15482.458113966013, 15513.84486155138, 14152.50466233682, 14306.35621397037, 14311.642208944782, 14333.21167335796, 14343.282835858217, 674.8549061951679, 686.7562015484481, 805.4643661964786, 851.6380538271226, 856.2037305306063, 861.8621020636699, 862.1077185113409, 862.2067697718084, 863.8013256950906, 864.3776480933749, 900.3292547052422, 917.499962520428, 919.6781126605702, 919.7240827751648, 921.663592788634, 908.8636704494313, 913.5021413329752, 914.1041779056495, 918.5774543709902, 922.2714055895867, 676.5805200775501, 684.934931181537, 687.0, 690.1063123255396, 691.1084700736044, 12453.93773031129, 15156.090634561851, 15205.31576079068, 15414.537563873102, 15534.922325388414, 13430.52993145245, 14159.433622655082, 14356.138631682132, 14374.496892608708, 14380.209088500129, 10987.121030317636, 11394.943025284903, 11487.42562871853, 11659.533618655329, 12039.217450865666, 4371.431713877208, 4426.136903303857, 4440.067585806984, 4450.554944505556, 4468.0840427712565, 93267.0, 101791.0, 109899.45050274697, 111122.0, 113945.43027284893, 9393.295502837314, 10335.638252661121, 10440.089144600664, 10652.946735266429, 11170.609028683957, 20650.89674551648, 20762.06570704322, 20873.582528349347, 21056.15775368968, 21097.89451052735, 7481.625918704043, 7532.284432978859, 7569.735059272899, 7621.771346859603, 7677.76966690989, 3635.5455568053994, 4137.524184718796, 4184.100418410057, 4192.993681516475, 4203.91592168155, 3356.664333566624, 3416.9658303417145, 3432.798520517799, 3469.8612055517497, 3520.0, 512.8717820544864, 657.8848851197175, 663.9269680335159, 673.3670349871105, 673.9561928474634, 525.5165247971875, 535.6893002058797, 539.4201233673816, 543.1065896600071, 547.4498129380028, 9363.4381937084, 9838.508074596242, 9863.852042219372, 10060.446675432775, 10251.026152515498, 621.6301300726061, 636.8503401700597, 654.4633400611453, 657.7599176300616, 676.4892506157918, 4244.915101697949, 4325.113351762881, 4462.196804575207, 4764.928526072112, 4807.855764327076, 70659.0, 108958.0, 110309.44845275882, 110695.3395699049, 111146.0, 93011.0, 94818.0, 94978.0, 95781.04218957861, 98545.0, 69458.61082778317, 70195.0, 73491.0, 77416.61291693618, 80941.0, 9141.77145571366, 10360.844587331045, 10788.730281743019, 11203.327800332007, 11305.830412543653, 40393.59606403898, 49731.0, 53259.46740532545, 53635.19547206717, 53688.99485880275, 65247.67376163089, 66281.66859165866, 67499.3250067493, 69250.65374673094, 69686.65156674184, 12782.745923198332, 12803.231806091664, 12890.226586404846, 13128.277944713132, 13559.525416610371, 13757.10578812414, 14052.929735351257, 14609.342579584158, 14674.486392976194, 15273.23633818327, 13667.658308542366, 13935.721285574435, 14291.142531448146, 14330.713385732435, 14388.352524136648, 13796.310184490936, 13935.651608709863, 14237.288135592971, 14346.713065738419, 14361.425542978583, 12764.489420423079, 13378.264195469343, 13609.183448993092, 14004.649883752987, 14060.718785624435, 10524.526566280574, 10627.628033018807, 10798.0, 11265.887341126812, 11403.828942565702, 7750.534967901944, 8696.39125261251, 10460.738481538023, 10503.10723588473, 10532.631357902743], "value": 7434.089155670863, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1570.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 162.0, 118.0, 120.0, 116.0, 120.0, 119.0, 122.0, 122.0, 169.0], "value": 127.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 111.0, 108.0, 149.0, 139.0, 143.0, 115.0, 108.0, 141.0, 131.0], "value": 128.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [221.0, 178.0, 185.0, 185.0, 170.0, 273.0, 277.0, 257.0, 199.0, 196.0], "value": 214.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 59.0, 60.0, 86.0, 58.0, 58.0, 59.0, 62.0, 93.0, 81.0], "value": 70.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 86.0, 76.0, 106.0, 64.0, 114.0, 99.0, 101.0, 80.0], "value": 88.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 90.0, 88.0, 99.0, 87.0, 91.0, 86.0, 93.0, 87.0], "value": 89.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 152.0, 144.0, 98.0, 130.0, 104.0, 156.0, 103.0, 100.0, 155.0], "value": 126.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 150.0, 150.0, 91.0, 91.0, 97.0, 90.0, 93.0, 94.0], "value": 104.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 57.0, 60.0, 59.0, 58.0, 48.0, 53.0, 57.0, 80.0], "value": 58.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 72.0, 80.0, 101.0, 108.0, 104.0, 79.0, 69.0, 71.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 103.0, 109.0, 105.0, 95.0, 85.0, 86.0, 86.0, 83.0, 88.0], "value": 92.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 130.0, 137.0, 150.0, 154.0, 141.0, 144.0, 157.0, 212.0, 132.0], "value": 149.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 172.0, 170.0, 165.0, 170.0, 170.0, 170.0, 170.0, 169.0, 169.0], "value": 169.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 65.0, 69.0, 66.0, 68.0, 80.0, 73.0, 65.0], "value": 69.0, "unit": "score"}]}]} 06:32:18 INFO - Return code: 0 06:32:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:32:18 ERROR - # TBPL SUCCESS # 06:32:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:32:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:32:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:32:18 INFO - 2017-02-09 06:32:18.635 screenresolution[1656:10828] starting screenresolution argv=screenresolution get 06:32:18 INFO - 2017-02-09 06:32:18.638 screenresolution[1656:10828] Display 0: 1600x1200x32@60 06:32:18 INFO - 2017-02-09 06:32:18.644 screenresolution[1657:10831] starting screenresolution argv=screenresolution list 06:32:18 INFO - Available Modes on Display 0 06:32:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:32:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:32:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:32:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:32:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:32:18 INFO - Intel Iris: 06:32:18 INFO - Chipset Model: Intel Iris 06:32:18 INFO - Type: GPU 06:32:18 INFO - Bus: Built-In 06:32:18 INFO - VRAM (Dynamic, Max): 1536 MB 06:32:18 INFO - Vendor: Intel (0x8086) 06:32:18 INFO - Device ID: 0x0a2e 06:32:18 INFO - Revision ID: 0x0009 06:32:18 INFO - Displays: 06:32:18 INFO - Display: 06:32:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:32:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:32:18 INFO - Display Serial Number: 1600x1200 60 06:32:18 INFO - Main Display: Yes 06:32:18 INFO - Mirror: Off 06:32:18 INFO - Online: Yes 06:32:18 INFO - Rotation: Supported 06:32:18 INFO - Return code: 0 06:32:18 INFO - Running post-action listener: _resource_record_post_action 06:32:18 INFO - [mozharness: 2017-02-09 14:32:18.880218Z] Finished run-tests step (success) 06:32:18 INFO - Running post-run listener: _resource_record_post_run 06:32:18 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 39283200; Write bytes: 510416896; Read time: 385; Write time: 1965 06:32:18 INFO - TinderboxPrint: CPU usage
54.3% 06:32:18 INFO - TinderboxPrint: I/O read bytes / time
39,283,200 / 385 06:32:18 INFO - TinderboxPrint: I/O write bytes / time
510,416,896 / 1,965 06:32:18 INFO - TinderboxPrint: CPU idle
2,187.9 (45.7%) 06:32:18 INFO - TinderboxPrint: CPU system
969.1 (20.2%) 06:32:18 INFO - TinderboxPrint: CPU user
1,632.7 (34.1%) 06:32:18 INFO - TinderboxPrint: Swap in / out
247,332,864 / 0 06:32:18 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 193702400; Write bytes: 189700096; Read time: 14615; Write time: 407 06:32:18 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 38296064; Write bytes: 299204608; Read time: 370; Write time: 1499 06:32:19 INFO - Running post-run listener: _upload_blobber_files 06:32:19 INFO - Blob upload gear active. 06:32:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:32:19 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 06:32:19 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:32:19 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:32:19 INFO - (blobuploader) - INFO - Open directory for files ... 06:32:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:32:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:32:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:32:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:32:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:32:20 INFO - (blobuploader) - INFO - Done attempting. 06:32:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:32:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:32:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:32:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:32:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:32:21 INFO - (blobuploader) - INFO - Done attempting. 06:32:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:32:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:32:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:32:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:32:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:32:22 INFO - (blobuploader) - INFO - Done attempting. 06:32:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:32:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:32:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:32:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:32:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:32:24 INFO - (blobuploader) - INFO - Done attempting. 06:32:24 INFO - (blobuploader) - INFO - Iteration through files over. 06:32:24 INFO - Return code: 0 06:32:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:32:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:32:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ae196cbf7866a31d32ef767908209fb19637465d12df3c8f05c8ddea5a3e1aad1496e296c033a6b18d6edd30664ce98215b477d96843cefaf9289cde1cdc888", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f3bda0bd28fb39875d475d63e632f93bef7b56c16a54e59225baa72329a9cc08a4761c3c75a4026004c6b397aa77b1152ddd2e88667875fce7f14d451aff2dd5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d1b2f3d78692a3660028aae7a0549ea9bd0630d958ecf72c290a4007dedcf70a3aa48597462591e3a3559849c45f778ab5dee0c90bccf11316adf114c093507", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5584eae6766ed98ce90308c5b298ebec154ddc97b3f396194f4e5a9fc2c815c153ded7ecb2a09fe7fc03c742f457f1ac260bbcb1c83de6080765680dcc56d0e0"} 06:32:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:32:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:32:24 INFO - Contents: 06:32:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ae196cbf7866a31d32ef767908209fb19637465d12df3c8f05c8ddea5a3e1aad1496e296c033a6b18d6edd30664ce98215b477d96843cefaf9289cde1cdc888", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f3bda0bd28fb39875d475d63e632f93bef7b56c16a54e59225baa72329a9cc08a4761c3c75a4026004c6b397aa77b1152ddd2e88667875fce7f14d451aff2dd5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d1b2f3d78692a3660028aae7a0549ea9bd0630d958ecf72c290a4007dedcf70a3aa48597462591e3a3559849c45f778ab5dee0c90bccf11316adf114c093507", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5584eae6766ed98ce90308c5b298ebec154ddc97b3f396194f4e5a9fc2c815c153ded7ecb2a09fe7fc03c742f457f1ac260bbcb1c83de6080765680dcc56d0e0"} 06:32:24 INFO - Running post-run listener: copy_logs_to_upload_dir 06:32:24 INFO - Copying logs to upload dir... 06:32:24 INFO - mkdir: /builds/slave/test/build/upload/logs 06:32:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.752233 ========= master_lag: 0.62 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-09 06:32:25.456790) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 06:32:25.462592) ========= 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.BPzWKj7672/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.BM2fe4JSY6/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ae196cbf7866a31d32ef767908209fb19637465d12df3c8f05c8ddea5a3e1aad1496e296c033a6b18d6edd30664ce98215b477d96843cefaf9289cde1cdc888", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f3bda0bd28fb39875d475d63e632f93bef7b56c16a54e59225baa72329a9cc08a4761c3c75a4026004c6b397aa77b1152ddd2e88667875fce7f14d451aff2dd5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d1b2f3d78692a3660028aae7a0549ea9bd0630d958ecf72c290a4007dedcf70a3aa48597462591e3a3559849c45f778ab5dee0c90bccf11316adf114c093507", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5584eae6766ed98ce90308c5b298ebec154ddc97b3f396194f4e5a9fc2c815c153ded7ecb2a09fe7fc03c742f457f1ac260bbcb1c83de6080765680dcc56d0e0"} build_url:https://queue.taskcluster.net/v1/task/IDa6-Oq5QDeZrlGz4nopxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011158 build_url: 'https://queue.taskcluster.net/v1/task/IDa6-Oq5QDeZrlGz4nopxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ae196cbf7866a31d32ef767908209fb19637465d12df3c8f05c8ddea5a3e1aad1496e296c033a6b18d6edd30664ce98215b477d96843cefaf9289cde1cdc888", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f3bda0bd28fb39875d475d63e632f93bef7b56c16a54e59225baa72329a9cc08a4761c3c75a4026004c6b397aa77b1152ddd2e88667875fce7f14d451aff2dd5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d1b2f3d78692a3660028aae7a0549ea9bd0630d958ecf72c290a4007dedcf70a3aa48597462591e3a3559849c45f778ab5dee0c90bccf11316adf114c093507", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5584eae6766ed98ce90308c5b298ebec154ddc97b3f396194f4e5a9fc2c815c153ded7ecb2a09fe7fc03c742f457f1ac260bbcb1c83de6080765680dcc56d0e0"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 06:32:25.500215) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 06:32:25.500536) ========= 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.BPzWKj7672/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.BM2fe4JSY6/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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.005255 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 06:32:25.552723) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 06:32:25.553023) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 06:32:25.556344) ========= ========= Total master_lag: 0.76 =========