builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0343 starttime: 1482854509.38 results: success (0) buildid: 20161227064436 builduid: bfe7680df3a849c5bb19b5b6d5547a42 revision: dccfc624915b1bebe7975076e9b42bd46684cbc6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-27 08:01:49.381075) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-27 08:01:49.381899) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-27 08:01:49.382437) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-27 08:01:49.409406) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 08:01:49.410085) ========= 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.LQUadoY5zF/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.MfEb9mXvyA/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 --2016-12-27 08:01:49-- 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% 153M=0s 2016-12-27 08:01:49 (153 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120417 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 08:01:49.558691) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 08:01:49.559404) ========= 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.LQUadoY5zF/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.MfEb9mXvyA/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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.019571 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 08:01:49.611873) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-27 08:01:49.612594) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dccfc624915b1bebe7975076e9b42bd46684cbc6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev dccfc624915b1bebe7975076e9b42bd46684cbc6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LQUadoY5zF/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.MfEb9mXvyA/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 2016-12-27 08:01:49,696 truncating revision to first 12 chars 2016-12-27 08:01:49,696 Setting DEBUG logging. 2016-12-27 08:01:49,696 attempt 1/10 2016-12-27 08:01:49,696 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dccfc624915b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-27 08:01:50,568 unpacking tar archive at: mozilla-central-dccfc624915b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.115550 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-27 08:01:50.755822) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-27 08:01:50.756389) ========= script_repo_revision: dccfc624915b1bebe7975076e9b42bd46684cbc6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-27 08:01:50.757086) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-27 08:01:50.757595) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-27 08:01:50.778764) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-12-27 08:01:50.779420) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LQUadoY5zF/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.MfEb9mXvyA/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 08:01:50 INFO - MultiFileLogger online at 20161227 08:01:50 in /builds/slave/test 08:01:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:01:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:01:50 INFO - {'append_to_log': False, 08:01:50 INFO - 'base_work_dir': '/builds/slave/test', 08:01:50 INFO - 'blob_upload_branch': 'Firefox', 08:01:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:01:50 INFO - 'branch': 'Firefox', 08:01:50 INFO - 'buildbot_json_path': 'buildprops.json', 08:01:50 INFO - 'config_files': ('talos/mac_config.py',), 08:01:50 INFO - 'default_actions': ('clobber', 08:01:50 INFO - 'read-buildbot-config', 08:01:50 INFO - 'download-and-extract', 08:01:50 INFO - 'populate-webroot', 08:01:50 INFO - 'create-virtualenv', 08:01:50 INFO - 'install', 08:01:50 INFO - 'run-tests'), 08:01:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:01:50 INFO - 'download_minidump_stackwalk': True, 08:01:50 INFO - 'download_symbols': 'ondemand', 08:01:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:01:50 INFO - 'tooltool.py': '/tools/tooltool.py', 08:01:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:01:50 INFO - '/tools/misc-python/virtualenv.py')}, 08:01:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:01:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:01:50 INFO - 'installer_path': 'installer.exe', 08:01:50 INFO - 'log_level': 'info', 08:01:50 INFO - 'log_name': 'talos', 08:01:50 INFO - 'log_to_console': True, 08:01:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:01:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:01:50 INFO - 'opt_config_files': (), 08:01:50 INFO - 'pip_index': False, 08:01:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:01:50 INFO - 'cmd': ('bash', 08:01:50 INFO - '-c', 08:01:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:01:50 INFO - 'enabled': True, 08:01:50 INFO - 'halt_on_failure': False, 08:01:50 INFO - 'name': 'check_screen_resolution'},), 08:01:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:01:50 INFO - 'cmd': ('bash', 08:01:50 INFO - '-c', 08:01:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:01:50 INFO - 'enabled': True, 08:01:50 INFO - 'halt_on_failure': False, 08:01:50 INFO - 'name': 'check_screen_resolution'},), 08:01:50 INFO - 'run_cmd_checks_enabled': True, 08:01:50 INFO - 'sps_profile': False, 08:01:50 INFO - 'sps_profile_interval': 0, 08:01:50 INFO - 'suite': 'dromaeojs-e10s', 08:01:50 INFO - 'system_bits': '32', 08:01:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:01:50 INFO - 'title': 't-yosemite-r7-0343', 08:01:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:01:50 INFO - 'use_talos_json': True, 08:01:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:01:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:01:50 INFO - 'work_dir': 'build'} 08:01:50 INFO - [mozharness: 2016-12-27 16:01:50.981505Z] Running clobber step. 08:01:50 INFO - Running pre-action listener: _resource_record_pre_action 08:01:50 INFO - Running main action method: clobber 08:01:50 INFO - rmtree: /builds/slave/test/build 08:01:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:01:51 INFO - Running post-action listener: _resource_record_post_action 08:01:51 INFO - [mozharness: 2016-12-27 16:01:51.880766Z] Finished clobber step (success) 08:01:51 INFO - [mozharness: 2016-12-27 16:01:51.880940Z] Running read-buildbot-config step. 08:01:51 INFO - Running pre-action listener: _resource_record_pre_action 08:01:51 INFO - Running main action method: read_buildbot_config 08:01:51 INFO - Using buildbot properties: 08:01:51 INFO - { 08:01:51 INFO - "project": "", 08:01:51 INFO - "product": "firefox", 08:01:51 INFO - "script_repo_revision": "production", 08:01:51 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 08:01:51 INFO - "repository": "", 08:01:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 08:01:51 INFO - "buildid": "20161227064436", 08:01:51 INFO - "pgo_build": "False", 08:01:51 INFO - "basedir": "/builds/slave/test", 08:01:51 INFO - "buildnumber": 113, 08:01:51 INFO - "slavename": "t-yosemite-r7-0343", 08:01:51 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 08:01:51 INFO - "platform": "yosemite_r7", 08:01:51 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:01:51 INFO - "branch": "mozilla-central", 08:01:51 INFO - "repo_path": "mozilla-central", 08:01:51 INFO - "revision": "dccfc624915b1bebe7975076e9b42bd46684cbc6", 08:01:51 INFO - "stage_platform": "macosx64", 08:01:51 INFO - "builduid": "bfe7680df3a849c5bb19b5b6d5547a42", 08:01:51 INFO - "slavebuilddir": "test" 08:01:51 INFO - } 08:01:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/IcDfeMPSQpuREzSUetvSmg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 08:01:51 INFO - Running post-action listener: _resource_record_post_action 08:01:51 INFO - [mozharness: 2016-12-27 16:01:51.884318Z] Finished read-buildbot-config step (success) 08:01:51 INFO - [mozharness: 2016-12-27 16:01:51.884456Z] Running download-and-extract step. 08:01:51 INFO - Running pre-action listener: _resource_record_pre_action 08:01:51 INFO - Running main action method: download_and_extract 08:01:51 INFO - mkdir: /builds/slave/test/build/tests 08:01: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')]} 08:01:51 INFO - trying https://queue.taskcluster.net/v1/task/IcDfeMPSQpuREzSUetvSmg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 08:01:51 INFO - Downloading https://queue.taskcluster.net/v1/task/IcDfeMPSQpuREzSUetvSmg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:01:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IcDfeMPSQpuREzSUetvSmg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 08:01:52 INFO - Downloaded 1199 bytes. 08:01:52 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:01:52 INFO - Using the following test package requirements: 08:01:52 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:01:52 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:01:52 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 08:01:52 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:01:52 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 08:01:52 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:01:52 INFO - u'jsshell-mac.zip'], 08:01:52 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:01:52 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 08:01:52 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:01:52 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:01:52 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 08:01:52 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:01:52 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 08:01:52 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:01:52 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 08:01:52 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:01:52 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 08:01:52 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:01:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IcDfeMPSQpuREzSUetvSmg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:01:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IcDfeMPSQpuREzSUetvSmg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:01:52 INFO - Fetch https://queue.taskcluster.net/v1/task/IcDfeMPSQpuREzSUetvSmg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:01:54 INFO - Expected file size: 16294458 08:01:54 INFO - Obtained file size: 16294458 08:02:01 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:02:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IcDfeMPSQpuREzSUetvSmg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:02:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IcDfeMPSQpuREzSUetvSmg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:02:01 INFO - Fetch https://queue.taskcluster.net/v1/task/IcDfeMPSQpuREzSUetvSmg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:02:02 INFO - Expected file size: 16294458 08:02:02 INFO - Obtained file size: 16294458 08:02:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IcDfeMPSQpuREzSUetvSmg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 08:02:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IcDfeMPSQpuREzSUetvSmg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:02:08 INFO - Fetch https://queue.taskcluster.net/v1/task/IcDfeMPSQpuREzSUetvSmg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 08:02:09 INFO - Expected file size: 14409776 08:02:09 INFO - Obtained file size: 14409776 08:02: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')]} 08:02:10 INFO - trying https://queue.taskcluster.net/v1/task/IcDfeMPSQpuREzSUetvSmg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:02:10 INFO - Downloading https://queue.taskcluster.net/v1/task/IcDfeMPSQpuREzSUetvSmg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 08:02:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IcDfeMPSQpuREzSUetvSmg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 08:02:12 INFO - Downloaded 69623876 bytes. 08:02:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IcDfeMPSQpuREzSUetvSmg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:02:12 INFO - mkdir: /builds/slave/test/properties 08:02:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:02:12 INFO - Writing to file /builds/slave/test/properties/build_url 08:02:12 INFO - Contents: 08:02:12 INFO - build_url:https://queue.taskcluster.net/v1/task/IcDfeMPSQpuREzSUetvSmg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:02:13 INFO - Running post-action listener: _resource_record_post_action 08:02:13 INFO - Running post-action listener: set_extra_try_arguments 08:02:13 INFO - [mozharness: 2016-12-27 16:02:13.662053Z] Finished download-and-extract step (success) 08:02:13 INFO - [mozharness: 2016-12-27 16:02:13.662178Z] Running populate-webroot step. 08:02:13 INFO - Running pre-action listener: _resource_record_pre_action 08:02:13 INFO - Running main action method: populate_webroot 08:02:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:02:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:02:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:02:13 INFO - '--tppagecycles', 08:02:13 INFO - '7'], 08:02:13 INFO - 'tests': ['tsvgm']}}, 08:02:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:02:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:02:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:02:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:02:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:02:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:02:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:02:13 INFO - 'talos_options': ['--disable-e10s'], 08:02:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:02:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:02:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:02:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:02:13 INFO - 'talos_options': ['--disable-e10s'], 08:02:13 INFO - 'tests': ['damp', 'tps']}, 08:02:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:02:13 INFO - 'tests': ['damp', 'tps']}, 08:02:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:02:13 INFO - 'tests': ['dromaeo_dom']}, 08:02:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:02:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:02:13 INFO - 'tests': ['basic_compositor_video']}, 08:02:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:02:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:02:13 INFO - 'tests': ['a11yr', 08:02:13 INFO - 'ts_paint', 08:02:13 INFO - 'tpaint', 08:02:13 INFO - 'sessionrestore', 08:02:13 INFO - 'sessionrestore_no_auto_restore', 08:02:13 INFO - 'tabpaint']}, 08:02:13 INFO - 'other-e10s': {'tests': ['a11yr', 08:02:13 INFO - 'ts_paint', 08:02:13 INFO - 'tpaint', 08:02:13 INFO - 'sessionrestore', 08:02:13 INFO - 'sessionrestore_no_auto_restore', 08:02:13 INFO - 'tabpaint']}, 08:02:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:02:13 INFO - 'ts_paint', 08:02:13 INFO - 'tpaint', 08:02:13 INFO - 'sessionrestore', 08:02:13 INFO - 'sessionrestore_no_auto_restore', 08:02:13 INFO - 'tabpaint']}, 08:02:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:02:13 INFO - 'ts_paint', 08:02:13 INFO - 'tpaint', 08:02:13 INFO - 'sessionrestore', 08:02:13 INFO - 'sessionrestore_no_auto_restore', 08:02:13 INFO - 'tabpaint']}, 08:02:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:02:13 INFO - 'tests': ['a11yr', 08:02:13 INFO - 'ts_paint', 08:02:13 INFO - 'tpaint', 08:02:13 INFO - 'sessionrestore', 08:02:13 INFO - 'sessionrestore_no_auto_restore', 08:02:13 INFO - 'tabpaint']}, 08:02:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:02:13 INFO - 'tests': ['a11yr', 08:02:13 INFO - 'ts_paint', 08:02:13 INFO - 'tpaint', 08:02:13 INFO - 'sessionrestore', 08:02:13 INFO - 'sessionrestore_no_auto_restore', 08:02:13 INFO - 'tabpaint']}, 08:02:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:02:13 INFO - 'tests': ['tsvgx', 08:02:13 INFO - 'tsvgr_opacity', 08:02:13 INFO - 'tart', 08:02:13 INFO - 'tscrollx', 08:02:13 INFO - 'cart', 08:02:13 INFO - 'tsvg_static']}, 08:02:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:02:13 INFO - 'tsvgr_opacity', 08:02:13 INFO - 'tart', 08:02:13 INFO - 'tscrollx', 08:02:13 INFO - 'cart', 08:02:13 INFO - 'tsvg_static']}, 08:02:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:02:13 INFO - 'talos_options': ['--disable-e10s'], 08:02:13 INFO - 'tests': ['tp5o']}, 08:02:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:02:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:02:13 INFO - 'talos_options': ['--disable-e10s', 08:02:13 INFO - '--xperf_path', 08:02:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:02:13 INFO - 'tests': ['tp5n']}, 08:02:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:02:13 INFO - 'talos_options': ['--xperf_path', 08:02:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:02:13 INFO - 'tests': ['tp5n']}}, 08:02:13 INFO - 'talos.zip': {'path': '', 08:02:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:02:13 INFO - Running post-action listener: _resource_record_post_action 08:02:13 INFO - [mozharness: 2016-12-27 16:02:13.680723Z] Finished populate-webroot step (success) 08:02:13 INFO - [mozharness: 2016-12-27 16:02:13.680858Z] Running create-virtualenv step. 08:02:13 INFO - Running pre-action listener: _resource_record_pre_action 08:02:13 INFO - Running main action method: create_virtualenv 08:02:13 INFO - Creating virtualenv /builds/slave/test/build/venv 08:02:13 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 08:02:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:02:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:02:13 INFO - Using real prefix '/tools/python27' 08:02:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:02:14 INFO - Installing distribute.............................................................................................................................................................................................done. 08:02:17 INFO - Installing pip.................done. 08:02:17 INFO - Return code: 0 08:02:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:02:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:02:17 INFO - Reading from file tmpfile_stdout 08:02:17 INFO - Output received: 08:02:17 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) 08:02:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:02:17 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')]} 08:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:17 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')]} 08:02:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:17 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 0x109390b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109393768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa81b49c060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10916ed30>, '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 0x109095db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109163be8>, '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.LQUadoY5zF/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.MfEb9mXvyA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 08:02:17 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 08:02:17 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 08:02:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LQUadoY5zF/Render', 08:02:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:17 INFO - 'HOME': '/Users/cltbld', 08:02:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:17 INFO - 'LOGNAME': 'cltbld', 08:02:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:17 INFO - 'MOZ_NO_REMOTE': '1', 08:02:17 INFO - 'NO_EM_RESTART': '1', 08:02:17 INFO - 'PAGER': '/bin/cat', 08:02:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:17 INFO - 'PWD': '/builds/slave/test', 08:02:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:17 INFO - 'SHELL': '/bin/bash', 08:02:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MfEb9mXvyA/Listeners', 08:02:17 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 08:02:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:17 INFO - 'USER': 'cltbld', 08:02:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:17 INFO - 'XPC_FLAGS': '0x0', 08:02:17 INFO - 'XPC_SERVICE_NAME': '0', 08:02:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:18 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 08:02:18 INFO - Cleaning up... 08:02:18 INFO - Return code: 0 08:02:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:02:18 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')]} 08:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:18 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')]} 08:02:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x109390b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109393768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa81b49c060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10916ed30>, '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 0x109095db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109163be8>, '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.LQUadoY5zF/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.MfEb9mXvyA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 08:02:18 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 08:02:18 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 08:02:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LQUadoY5zF/Render', 08:02:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:18 INFO - 'HOME': '/Users/cltbld', 08:02:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:18 INFO - 'LOGNAME': 'cltbld', 08:02:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:18 INFO - 'MOZ_NO_REMOTE': '1', 08:02:18 INFO - 'NO_EM_RESTART': '1', 08:02:18 INFO - 'PAGER': '/bin/cat', 08:02:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:18 INFO - 'PWD': '/builds/slave/test', 08:02:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:18 INFO - 'SHELL': '/bin/bash', 08:02:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MfEb9mXvyA/Listeners', 08:02:18 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 08:02:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:18 INFO - 'USER': 'cltbld', 08:02:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:18 INFO - 'XPC_FLAGS': '0x0', 08:02:18 INFO - 'XPC_SERVICE_NAME': '0', 08:02:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:18 INFO - Downloading/unpacking psutil>=3.1.1 08:02:18 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 08:02:18 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 08:02:18 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 08:02:18 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 08:02:18 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 08:02:18 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 08:02:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:02:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:02:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:02:22 INFO - Installing collected packages: psutil 08:02:22 INFO - Running setup.py install for psutil 08:02:22 INFO - building 'psutil._psutil_osx' extension 08:02:22 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 08:02:22 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 08:02:22 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 08:02:22 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 08:02:22 INFO - building 'psutil._psutil_posix' extension 08:02:22 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 08:02:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:02:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:02:22 INFO - ^ 08:02:22 INFO - 1 warning generated. 08:02:22 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 08:02:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:02:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:02:22 INFO - Successfully installed psutil 08:02:22 INFO - Cleaning up... 08:02:22 INFO - Return code: 0 08:02:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:02:22 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')]} 08:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:22 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')]} 08:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:22 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 0x109390b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109393768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa81b49c060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10916ed30>, '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 0x109095db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109163be8>, '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.LQUadoY5zF/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.MfEb9mXvyA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 08:02:22 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 08:02:22 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 08:02:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LQUadoY5zF/Render', 08:02:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:22 INFO - 'HOME': '/Users/cltbld', 08:02:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:22 INFO - 'LOGNAME': 'cltbld', 08:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:22 INFO - 'MOZ_NO_REMOTE': '1', 08:02:22 INFO - 'NO_EM_RESTART': '1', 08:02:22 INFO - 'PAGER': '/bin/cat', 08:02:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:22 INFO - 'PWD': '/builds/slave/test', 08:02:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:22 INFO - 'SHELL': '/bin/bash', 08:02:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MfEb9mXvyA/Listeners', 08:02:22 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 08:02:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:22 INFO - 'USER': 'cltbld', 08:02:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:22 INFO - 'XPC_FLAGS': '0x0', 08:02:22 INFO - 'XPC_SERVICE_NAME': '0', 08:02:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:23 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 08:02:23 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 08:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:02:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:02:25 INFO - Installing collected packages: mozsystemmonitor 08:02:25 INFO - Running setup.py install for mozsystemmonitor 08:02:25 INFO - Successfully installed mozsystemmonitor 08:02:25 INFO - Cleaning up... 08:02:26 INFO - Return code: 0 08:02:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:02: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')]} 08:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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')]} 08:02:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:26 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 0x109390b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109393768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa81b49c060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10916ed30>, '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 0x109095db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109163be8>, '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.LQUadoY5zF/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.MfEb9mXvyA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 08:02:26 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 08:02:26 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 08:02:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LQUadoY5zF/Render', 08:02:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:26 INFO - 'HOME': '/Users/cltbld', 08:02:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:26 INFO - 'LOGNAME': 'cltbld', 08:02:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:26 INFO - 'MOZ_NO_REMOTE': '1', 08:02:26 INFO - 'NO_EM_RESTART': '1', 08:02:26 INFO - 'PAGER': '/bin/cat', 08:02:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:26 INFO - 'PWD': '/builds/slave/test', 08:02:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:26 INFO - 'SHELL': '/bin/bash', 08:02:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MfEb9mXvyA/Listeners', 08:02:26 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 08:02:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:26 INFO - 'USER': 'cltbld', 08:02:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:26 INFO - 'XPC_FLAGS': '0x0', 08:02:26 INFO - 'XPC_SERVICE_NAME': '0', 08:02:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:26 INFO - Downloading/unpacking jsonschema==2.5.1 08:02:26 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 08:02:26 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 08:02:26 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 08:02:26 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 08:02:26 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 08:02:26 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 08:02:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:02:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:02:28 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 08:02:28 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 08:02:28 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 08:02:28 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 08:02:28 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 08:02:28 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 08:02:29 INFO - Downloading functools32-3.2.3-2.tar.gz 08:02:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:02:29 INFO - warning: no files found matching '*.txt' 08:02:29 INFO - no previously-included directories found matching 'build' 08:02:29 INFO - no previously-included directories found matching 'dist' 08:02:29 INFO - no previously-included directories found matching '.git*' 08:02:29 INFO - Installing collected packages: jsonschema, functools32 08:02:29 INFO - Running setup.py install for functools32 08:02:29 INFO - warning: no files found matching '*.txt' 08:02:29 INFO - no previously-included directories found matching 'build' 08:02:29 INFO - no previously-included directories found matching 'dist' 08:02:29 INFO - no previously-included directories found matching '.git*' 08:02:29 INFO - Successfully installed jsonschema functools32 08:02:29 INFO - Cleaning up... 08:02:29 INFO - Return code: 0 08:02:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:02:29 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')]} 08:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:29 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')]} 08:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:29 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 0x109390b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109393768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa81b49c060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10916ed30>, '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 0x109095db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109163be8>, '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.LQUadoY5zF/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.MfEb9mXvyA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 08:02:29 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 08:02:29 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 08:02:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LQUadoY5zF/Render', 08:02:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:29 INFO - 'HOME': '/Users/cltbld', 08:02:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:29 INFO - 'LOGNAME': 'cltbld', 08:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:29 INFO - 'MOZ_NO_REMOTE': '1', 08:02:29 INFO - 'NO_EM_RESTART': '1', 08:02:29 INFO - 'PAGER': '/bin/cat', 08:02:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:29 INFO - 'PWD': '/builds/slave/test', 08:02:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:29 INFO - 'SHELL': '/bin/bash', 08:02:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MfEb9mXvyA/Listeners', 08:02:29 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 08:02:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:29 INFO - 'USER': 'cltbld', 08:02:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:29 INFO - 'XPC_FLAGS': '0x0', 08:02:29 INFO - 'XPC_SERVICE_NAME': '0', 08:02:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:02:29 INFO - Cleaning up... 08:02:29 INFO - Return code: 0 08:02:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:02:29 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')]} 08:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:29 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')]} 08:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:29 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 0x109390b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109393768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa81b49c060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10916ed30>, '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 0x109095db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109163be8>, '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.LQUadoY5zF/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.MfEb9mXvyA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 08:02:29 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 08:02:29 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 08:02:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LQUadoY5zF/Render', 08:02:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:29 INFO - 'HOME': '/Users/cltbld', 08:02:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:29 INFO - 'LOGNAME': 'cltbld', 08:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:29 INFO - 'MOZ_NO_REMOTE': '1', 08:02:29 INFO - 'NO_EM_RESTART': '1', 08:02:29 INFO - 'PAGER': '/bin/cat', 08:02:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:29 INFO - 'PWD': '/builds/slave/test', 08:02:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:29 INFO - 'SHELL': '/bin/bash', 08:02:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MfEb9mXvyA/Listeners', 08:02:29 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 08:02:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:29 INFO - 'USER': 'cltbld', 08:02:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:29 INFO - 'XPC_FLAGS': '0x0', 08:02:29 INFO - 'XPC_SERVICE_NAME': '0', 08:02:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:30 INFO - Downloading/unpacking blobuploader==1.2.4 08:02:30 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 08:02:30 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 08:02:30 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 08:02:30 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 08:02:30 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 08:02:30 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 08:02:32 INFO - Downloading blobuploader-1.2.4.tar.gz 08:02:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:02:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:02:32 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 08:02:32 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 08:02:32 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 08:02:32 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 08:02:32 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 08:02:32 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 08:02:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:02:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:02:33 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 08:02:33 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 08:02:33 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 08:02:33 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 08:02:33 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 08:02:33 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 08:02:34 INFO - Downloading docopt-0.6.1.tar.gz 08:02:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:02:34 INFO - Installing collected packages: blobuploader, requests, docopt 08:02:34 INFO - Running setup.py install for blobuploader 08:02:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:02:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:02:34 INFO - Running setup.py install for requests 08:02:34 INFO - Running setup.py install for docopt 08:02:34 INFO - Successfully installed blobuploader requests docopt 08:02:34 INFO - Cleaning up... 08:02:35 INFO - Return code: 0 08:02:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02:35 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')]} 08:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:35 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')]} 08:02:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:35 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 0x109390b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109393768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa81b49c060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10916ed30>, '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 0x109095db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109163be8>, '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.LQUadoY5zF/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.MfEb9mXvyA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 08:02:35 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 08:02:35 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 08:02:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LQUadoY5zF/Render', 08:02:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:35 INFO - 'HOME': '/Users/cltbld', 08:02:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:35 INFO - 'LOGNAME': 'cltbld', 08:02:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:35 INFO - 'MOZ_NO_REMOTE': '1', 08:02:35 INFO - 'NO_EM_RESTART': '1', 08:02:35 INFO - 'PAGER': '/bin/cat', 08:02:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:35 INFO - 'PWD': '/builds/slave/test', 08:02:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:35 INFO - 'SHELL': '/bin/bash', 08:02:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MfEb9mXvyA/Listeners', 08:02:35 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 08:02:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:35 INFO - 'USER': 'cltbld', 08:02:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:35 INFO - 'XPC_FLAGS': '0x0', 08:02:35 INFO - 'XPC_SERVICE_NAME': '0', 08:02:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:02:35 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-pSp2UN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:02:35 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-d9inCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:02:35 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-wL55Tm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:02:35 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-zOL2Cw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:02:35 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-88FU9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:02:35 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-EWmgjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:02:35 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-loEOzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:02:36 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-qEuESt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:02:36 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-lIgZSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:02:36 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-uxS8UT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:02:36 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-so8rRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:02:36 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-f5EWwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:02:36 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-Qhn2vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:02:36 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-Iarh2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:36 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-khoHR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:02:36 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-fyBInn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:02:37 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-1esDWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:02:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:02:37 INFO - Running setup.py install for manifestparser 08:02:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:02:37 INFO - Running setup.py install for mozcrash 08:02:37 INFO - Running setup.py install for mozdebug 08:02:37 INFO - Running setup.py install for mozdevice 08:02:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:02:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:02:37 INFO - Running setup.py install for mozfile 08:02:37 INFO - Running setup.py install for mozhttpd 08:02:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:02:38 INFO - Running setup.py install for mozinfo 08:02:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:02:38 INFO - Running setup.py install for mozInstall 08:02:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:02:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:02:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:02:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:02:38 INFO - Running setup.py install for mozleak 08:02:38 INFO - Running setup.py install for mozlog 08:02:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:02:38 INFO - Running setup.py install for moznetwork 08:02:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:02:38 INFO - Running setup.py install for mozprocess 08:02:38 INFO - Running setup.py install for mozprofile 08:02:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:02:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:02:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:02:39 INFO - Running setup.py install for mozrunner 08:02:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:02:39 INFO - Running setup.py install for mozscreenshot 08:02:39 INFO - Running setup.py install for moztest 08:02:39 INFO - Running setup.py install for mozversion 08:02:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:02:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:02:39 INFO - Cleaning up... 08:02:39 INFO - Return code: 0 08:02:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02:39 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')]} 08:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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')]} 08:02:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:40 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 0x109390b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109393768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa81b49c060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10916ed30>, '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 0x109095db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109163be8>, '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.LQUadoY5zF/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.MfEb9mXvyA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 08:02:40 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 08:02:40 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 08:02:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LQUadoY5zF/Render', 08:02:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:40 INFO - 'HOME': '/Users/cltbld', 08:02:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:40 INFO - 'LOGNAME': 'cltbld', 08:02:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:40 INFO - 'MOZ_NO_REMOTE': '1', 08:02:40 INFO - 'NO_EM_RESTART': '1', 08:02:40 INFO - 'PAGER': '/bin/cat', 08:02:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:40 INFO - 'PWD': '/builds/slave/test', 08:02:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:40 INFO - 'SHELL': '/bin/bash', 08:02:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MfEb9mXvyA/Listeners', 08:02:40 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 08:02:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:40 INFO - 'USER': 'cltbld', 08:02:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:40 INFO - 'XPC_FLAGS': '0x0', 08:02:40 INFO - 'XPC_SERVICE_NAME': '0', 08:02:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:02:40 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-NUHO82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:02:40 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)) 08:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:02:40 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-9hRGyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:02:41 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)) 08:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:02:41 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-dWzlTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:02:41 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)) 08:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:02:41 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-794zC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:02:41 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)) 08:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:02:41 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-doReYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:02:41 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)) 08:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:02:41 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-4jhQPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:02:41 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)) 08:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:02:41 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-wTNPZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:02:41 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)) 08:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:02:41 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-B0yC5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:02:41 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)) 08:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:02:41 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-IxxT7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:02:41 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)) 08:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:02:41 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-F9OwtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:02:41 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)) 08:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:02:41 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-KRu7By-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:02:41 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)) 08:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:02:41 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-4FrmIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:02:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 08:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:02:42 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-hEM09D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:02:42 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)) 08:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:02:42 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-tqN87B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:02:42 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)) 08:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:42 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-N1US6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:42 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)) 08:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:02:42 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-_d6S2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:02:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 08:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:02:42 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-oXQaDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:02:42 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)) 08:02:42 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)) 08:02:42 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)) 08:02:42 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)) 08:02:42 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)) 08:02:42 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)) 08:02:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:02:42 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 08:02:42 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 08:02:42 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 08:02:42 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 08:02:42 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 08:02:42 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 08:02:45 INFO - Downloading blessings-1.6.tar.gz 08:02:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:02:45 INFO - Installing collected packages: blessings 08:02:45 INFO - Running setup.py install for blessings 08:02:45 INFO - Successfully installed blessings 08:02:45 INFO - Cleaning up... 08:02:45 INFO - Return code: 0 08:02:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:02:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:02:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:02:45 INFO - Reading from file tmpfile_stdout 08:02:45 INFO - Current package versions: 08:02:45 INFO - blessings == 1.6 08:02:45 INFO - blobuploader == 1.2.4 08:02:45 INFO - docopt == 0.6.1 08:02:45 INFO - functools32 == 3.2.3-2 08:02:45 INFO - jsonschema == 2.5.1 08:02:45 INFO - manifestparser == 1.1 08:02:45 INFO - mozInstall == 1.12 08:02:45 INFO - mozcrash == 1.0 08:02:45 INFO - mozdebug == 0.1 08:02:45 INFO - mozdevice == 0.49 08:02:45 INFO - mozfile == 1.2 08:02:45 INFO - mozhttpd == 0.7 08:02:45 INFO - mozinfo == 0.9 08:02:45 INFO - mozleak == 0.1 08:02:45 INFO - mozlog == 3.4 08:02:45 INFO - moznetwork == 0.27 08:02:45 INFO - mozprocess == 0.23 08:02:45 INFO - mozprofile == 0.28 08:02:45 INFO - mozrunner == 6.13 08:02:45 INFO - mozscreenshot == 0.1 08:02:45 INFO - mozsystemmonitor == 0.3 08:02:45 INFO - moztest == 0.7 08:02:45 INFO - mozversion == 1.4 08:02:45 INFO - psutil == 3.1.1 08:02:45 INFO - requests == 1.2.3 08:02:45 INFO - wsgiref == 0.1.2 08:02:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02:45 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')]} 08:02:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:45 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')]} 08:02:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:45 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 0x109390b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109393768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa81b49c060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10916ed30>, '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 0x109095db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109163be8>, '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.LQUadoY5zF/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.MfEb9mXvyA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 08:02:45 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 08:02:45 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 08:02:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LQUadoY5zF/Render', 08:02:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:45 INFO - 'HOME': '/Users/cltbld', 08:02:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:45 INFO - 'LOGNAME': 'cltbld', 08:02:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:45 INFO - 'MOZ_NO_REMOTE': '1', 08:02:45 INFO - 'NO_EM_RESTART': '1', 08:02:45 INFO - 'PAGER': '/bin/cat', 08:02:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:45 INFO - 'PWD': '/builds/slave/test', 08:02:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:45 INFO - 'SHELL': '/bin/bash', 08:02:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MfEb9mXvyA/Listeners', 08:02:45 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 08:02:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:45 INFO - 'USER': 'cltbld', 08:02:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:45 INFO - 'XPC_FLAGS': '0x0', 08:02:45 INFO - 'XPC_SERVICE_NAME': '0', 08:02:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:46 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)) 08:02:46 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)) 08:02:46 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)) 08:02:46 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)) 08:02:46 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)) 08:02:46 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)) 08:02:46 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)) 08:02:46 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)) 08:02:46 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)) 08:02:46 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)) 08:02:46 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)) 08:02:46 INFO - Cleaning up... 08:02:46 INFO - Return code: 0 08:02:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:02:46 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')]} 08:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:46 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')]} 08:02:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:46 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 0x109390b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109393768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa81b49c060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10916ed30>, '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 0x109095db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109163be8>, '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.LQUadoY5zF/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.MfEb9mXvyA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 08:02:46 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 08:02:46 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 08:02:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LQUadoY5zF/Render', 08:02:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:46 INFO - 'HOME': '/Users/cltbld', 08:02:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:46 INFO - 'LOGNAME': 'cltbld', 08:02:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:46 INFO - 'MOZ_NO_REMOTE': '1', 08:02:46 INFO - 'NO_EM_RESTART': '1', 08:02:46 INFO - 'PAGER': '/bin/cat', 08:02:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:46 INFO - 'PWD': '/builds/slave/test', 08:02:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:46 INFO - 'SHELL': '/bin/bash', 08:02:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MfEb9mXvyA/Listeners', 08:02:46 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 08:02:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:46 INFO - 'USER': 'cltbld', 08:02:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:46 INFO - 'XPC_FLAGS': '0x0', 08:02:46 INFO - 'XPC_SERVICE_NAME': '0', 08:02:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:02:46 INFO - Cleaning up... 08:02:46 INFO - Return code: 0 08:02:46 INFO - Running post-action listener: _resource_record_post_action 08:02:46 INFO - Running post-action listener: _start_resource_monitoring 08:02:46 INFO - Starting resource monitoring. 08:02:46 INFO - [mozharness: 2016-12-27 16:02:46.387494Z] Finished create-virtualenv step (success) 08:02:46 INFO - [mozharness: 2016-12-27 16:02:46.388431Z] Running install step. 08:02:46 INFO - Running pre-action listener: _resource_record_pre_action 08:02:46 INFO - Running main action method: install 08:02:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:02:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:02:46 INFO - Reading from file tmpfile_stdout 08:02:46 INFO - Detecting whether we're running mozinstall >=1.0... 08:02:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:02:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:02:46 INFO - Reading from file tmpfile_stdout 08:02:46 INFO - Output received: 08:02:46 INFO - Usage: mozinstall [options] installer 08:02:46 INFO - Options: 08:02:46 INFO - -h, --help show this help message and exit 08:02:46 INFO - -d DEST, --destination=DEST 08:02:46 INFO - Directory to install application into. [default: 08:02:46 INFO - "/builds/slave/test"] 08:02:46 INFO - --app=APP Application being installed. [default: firefox] 08:02:46 INFO - mkdir: /builds/slave/test/build/application 08:02:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:02:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:03:08 INFO - Reading from file tmpfile_stdout 08:03:08 INFO - Output received: 08:03:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:03:08 INFO - Running post-action listener: _resource_record_post_action 08:03:08 INFO - [mozharness: 2016-12-27 16:03:08.311699Z] Finished install step (success) 08:03:08 INFO - [mozharness: 2016-12-27 16:03:08.311850Z] Running run-tests step. 08:03:08 INFO - Running pre-action listener: _resource_record_pre_action 08:03:08 INFO - Running main action method: run_tests 08:03:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:03:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:03:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:03:08 INFO - 2016-12-27 08:03:08.326 screenresolution[1971:21537] starting screenresolution argv=screenresolution get 08:03:08 INFO - 2016-12-27 08:03:08.329 screenresolution[1971:21537] Display 0: 1600x1200x32@60 08:03:08 INFO - 2016-12-27 08:03:08.334 screenresolution[1972:21539] starting screenresolution argv=screenresolution list 08:03:08 INFO - Available Modes on Display 0 08:03:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:03:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:03:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:03:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:03:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:03:08 INFO - Intel Iris: 08:03:08 INFO - Chipset Model: Intel Iris 08:03:08 INFO - Type: GPU 08:03:08 INFO - Bus: Built-In 08:03:08 INFO - VRAM (Dynamic, Max): 1536 MB 08:03:08 INFO - Vendor: Intel (0x8086) 08:03:08 INFO - Device ID: 0x0a2e 08:03:08 INFO - Revision ID: 0x0009 08:03:08 INFO - Displays: 08:03:08 INFO - Display: 08:03:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:03:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:03:08 INFO - Display Serial Number: 1600x1200 60 08:03:08 INFO - Main Display: Yes 08:03:08 INFO - Mirror: Off 08:03:08 INFO - Online: Yes 08:03:08 INFO - Rotation: Supported 08:03:08 INFO - Return code: 0 08:03:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:03:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:03:08 INFO - Python 2.7.3 08:03:08 INFO - Return code: 0 08:03:08 INFO - grabbing minidump binary from tooltool 08:03:08 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')]} 08:03:08 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 0x10916ed30>, '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 0x109095db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109163be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:03:08 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 08:03:08 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 08:03:08 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 08:03:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:03:08 INFO - Return code: 0 08:03:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:03:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:03:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:03:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:03:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:03:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IcDfeMPSQpuREzSUetvSmg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0343', '--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 08:03:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IcDfeMPSQpuREzSUetvSmg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0343 --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 08:03:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LQUadoY5zF/Render', 08:03:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:08 INFO - 'HOME': '/Users/cltbld', 08:03:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:08 INFO - 'LOGNAME': 'cltbld', 08:03:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:03:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:08 INFO - 'MOZ_NO_REMOTE': '1', 08:03:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:03:08 INFO - 'NO_EM_RESTART': '1', 08:03:08 INFO - 'PAGER': '/bin/cat', 08:03:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:08 INFO - 'PWD': '/builds/slave/test', 08:03:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:03:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:08 INFO - 'SHELL': '/bin/bash', 08:03:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MfEb9mXvyA/Listeners', 08:03:08 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 08:03:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:08 INFO - 'USER': 'cltbld', 08:03:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:08 INFO - 'XPC_FLAGS': '0x0', 08:03:08 INFO - 'XPC_SERVICE_NAME': '0', 08:03:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IcDfeMPSQpuREzSUetvSmg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0343', '--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 08:03:08 INFO - mozversion application_buildid: 20161227064436 08:03:08 INFO - mozversion application_changeset: dccfc624915b1bebe7975076e9b42bd46684cbc6 08:03:08 INFO - mozversion application_display_name: Nightly 08:03:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:03:08 INFO - mozversion application_name: Firefox 08:03:08 INFO - mozversion application_remotingname: firefox 08:03:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:03:08 INFO - mozversion application_vendor: Mozilla 08:03:08 INFO - mozversion application_version: 53.0a1 08:03:08 INFO - mozversion platform_buildid: 20161227064436 08:03:08 INFO - mozversion platform_changeset: dccfc624915b1bebe7975076e9b42bd46684cbc6 08:03:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:03:08 INFO - mozversion platform_version: 53.0a1 08:03:08 INFO - using testdate: 1482854588 08:03:08 INFO - actual date: 1482854588 08:03:08 INFO - starting webserver on 'localhost:52129' 08:03:08 INFO - SUITE-START | Running 2 tests 08:03:08 INFO - TEST-START | dromaeo_css 08:03:08 INFO - operating with platform_type : mac_ 08:03:08 INFO - Initialising browser for dromaeo_css test... 08:03:08 INFO - TEST-INFO | started process 1982 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/tmpZDh8OD/profile http://localhost:52129/getInfo.html) 08:03:09 INFO - PROCESS | 1982 | 1482854589491 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4979 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3825 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2829 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 08:03:11 INFO - PROCESS | 1982 | 2016-12-27 08:03:11.705 plugin-container[1984:21699] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c47, name = 'com.apple.tsm.portname' 08:03:11 INFO - PROCESS | 1982 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:03:11 INFO - PROCESS | 1982 | 2016-12-27 08:03:11.708 plugin-container[1984:21699] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c4b, name = 'com.apple.CFPasteboardClient' 08:03:11 INFO - PROCESS | 1982 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:03:11 INFO - PROCESS | 1982 | 2016-12-27 08:03:11.708 plugin-container[1984:21699] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:03:11 INFO - PROCESS | 1982 | __metrics Screen width/height:1600/1200 08:03:11 INFO - PROCESS | 1982 | colorDepth:24 08:03:11 INFO - PROCESS | 1982 | Browser inner width/height: 1024/689 08:03:11 INFO - PROCESS | 1982 | __metrics 08:03:11 ERROR - PROCESS | 1982 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 08:03:12 INFO - TEST-INFO | 1982: exit 0 08:03:12 INFO - Browser initialized. 08:03:12 INFO - Running cycle 1/1 for dromaeo_css test... 08:03:12 INFO - TEST-INFO | started process 1985 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/tmpZDh8OD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:03:15 INFO - PROCESS | 1985 | 2016-12-27 08:03:15.217 plugin-container[1986:21816] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 08:03:15 INFO - PROCESS | 1985 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:03:15 INFO - PROCESS | 1985 | 2016-12-27 08:03:15.218 plugin-container[1986:21816] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a0b, name = 'com.apple.CFPasteboardClient' 08:03:15 INFO - PROCESS | 1985 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:03:15 INFO - PROCESS | 1985 | 2016-12-27 08:03:15.218 plugin-container[1986:21816] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:03:24 INFO - PROCESS | 1985 | RSS: Main: 232853504 08:03:24 INFO - PROCESS | 1985 | 08:06:27 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:52129/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52129/tests/dromaeo/cssquery-ext.html) 08:06:28 INFO - PROCESS | 1985 | RSS: Main: 253997056 08:06:28 INFO - PROCESS | 1985 | 08:08:13 INFO - PROCESS | 1985 | ************************* 08:08:13 INFO - PROCESS | 1985 | A coding exception was thrown and uncaught in a Task. 08:08:13 INFO - PROCESS | 1985 | 08:08:13 INFO - PROCESS | 1985 | Full message: ReferenceError: fetch is not defined 08:08:13 INFO - PROCESS | 1985 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 08:08:13 INFO - PROCESS | 1985 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 08:08:13 INFO - PROCESS | 1985 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 08:08:13 INFO - PROCESS | 1985 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 08:08:13 INFO - PROCESS | 1985 | TaskImpl@resource://gre/modules/Task.jsm:277:3 08:08:13 INFO - PROCESS | 1985 | asyncFunction@resource://gre/modules/Task.jsm:252:14 08:08:13 INFO - PROCESS | 1985 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 08:08:13 INFO - PROCESS | 1985 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 08:08:13 INFO - PROCESS | 1985 | TaskImpl@resource://gre/modules/Task.jsm:277:3 08:08:13 INFO - PROCESS | 1985 | asyncFunction@resource://gre/modules/Task.jsm:252:14 08:08:13 INFO - PROCESS | 1985 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 08:08:13 INFO - PROCESS | 1985 | 08:08:13 INFO - PROCESS | 1985 | ************************* 08:09:31 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:52129/tests/dromaeo/cssquery-ext.html (next: http://localhost:52129/tests/dromaeo/cssquery-jquery.html) 08:09:31 INFO - PROCESS | 1985 | RSS: Main: 264290304 08:09:31 INFO - PROCESS | 1985 | 08:12:33 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:52129/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52129/tests/dromaeo/cssquery-mootools.html) 08:12:34 INFO - PROCESS | 1985 | RSS: Main: 272855040 08:12:34 INFO - PROCESS | 1985 | 08:15:36 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:52129/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52129/tests/dromaeo/cssquery-prototype.html) 08:15:37 INFO - PROCESS | 1985 | RSS: Main: 269574144 08:15:37 INFO - PROCESS | 1985 | 08:18:39 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:52129/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52129/tests/dromaeo/cssquery-yui.html) 08:18:40 INFO - PROCESS | 1985 | RSS: Main: 274173952 08:18:40 INFO - PROCESS | 1985 | 08:21:43 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:52129/tests/dromaeo/cssquery-yui.html (next: http://localhost:52129/tests/dromaeo/cssquery-dojo.html) 08:21:43 INFO - PROCESS | 1985 | RSS: Main: 276254720 08:21:43 INFO - PROCESS | 1985 | 08:21:43 INFO - PROCESS | 1985 | __start_tp_report 08:21:43 INFO - PROCESS | 1985 | _x_x_mozilla_page_load 08:21:43 INFO - PROCESS | 1985 | _x_x_mozilla_page_load_details 08:21:43 INFO - PROCESS | 1985 | |i|pagename|runs| 08:21:43 INFO - PROCESS | 1985 | |0;dojo.html;3277.442834718098;3281.8851340203096;3287.079617707043;3310.4041272570958;3316.0941567653404;4481.046143096006;4577.816887324503;5272.23552584875;5533.474319939604;5552.944470555293;5433.239346491494;5523.917141242885;5528.612997090206;5533.667979921208;5581.2186293918785;4823.469418363977;5086.440491545927;5115.411727651331;5148.5623721983675;5151.5878729701535;5077.136886729247;5161.535461808437;5172.405173405069;5177.611679124062;5190.558802501791;5165.483451654842;5168.173092305232;5180.197069454241;5182.818601348954;5183.948160518403;5155.2524883892;5157.6647517911215;5167.612429067816;5173.715445650488;5177.378714554277;5020.2720605511995;5112.156494178456;5118.923216151761;5150.175971844525;5150.587952963754;5120.948790512084;5619.971900140473;5660.8867822643315;5699.2590963174525;5747.252857128588;5934.495567876736;6098.39016098391;6137.815865523997;6167;6219.906701399483;5860.179574859523;5900.734466948955;5912.17229587858;6026.005709058;6271.560990730651;3448.5689288838644;4874.293227481995;5479.726013699299;5529.640573362719;5557.749901254453;6251.812445626639;6252.187215661935;6265.467435268053;6273.153124328249;6303.590266632654;4907.631927605373;5481.972590137024;5628.971855140698;6067.423594758491;6068.21113255274;5985.760569577168;6049.969750151309;6056.454919057306;6146.078088286793;6180.690965451709;5600.971995139998;6008.849778755566;6040.909386359208;6064.9689552776135;6095.451409373178;5007.524285192901;6129.540284478593;6164.599301045508;6181.443670069625;6185.41238582334;4858.562729354375;4883.487233840467;4892.633052521075;4893.755312234445;4931.112399768076;4248.745075295492;4275.636570891509;4306.698531102793;4332.393464914914;4342.69601127918;5680.346760122557;5809;5811.796587119515;5817.418258174149;5842.444967728059;6123.84690382744;6134.78528251509;6135.32511423743;6139.140520327158;6162.198914141222;5573.470520300565;5630.40880707528;5747.942520574825;5767.682777447197;5797.130430435384;5270.578353731692;5293.814716484904;5316.229146773773;5345.037893179187;5353.491418315254;5460.672359658433;6140.044157167629;6221.96889015552;6266.49868010558;6336.429721324918;6149.723262453111;6198;6199.5660303780105;6209.875802484015;6230.563860529719;6167.784127555514;6263.530235232467;6279.623222606659;6282.748690052529;6301.684915754286;5015.673981191211;5959.67221802805;6084.665343406155;6091.451769340781;6114.938850611615;6121.3878612140215;6168.537359697951;6186.4741496971465;6196;6229.909765791059;5919.970400148144;6020.969895150496;6023.156758053964;6037.0642550404755;6042.274927008787;5744.626599271034;5796.0436527972415;5819.272590926134;5900.734466948912;5939.821805345847;4456.6657500688225;4492.752898590478;5763.394843541536;5873.060310350324;5890.734916928663;5998.520118390431;6024.849378765566;6036.456718895145;6041.24484439445;6069.150318955261;5671.8865622688145;5710.628809127394;5827.388124246893;5833.4749872511675;5864.179014937998 08:21:43 INFO - PROCESS | 1985 | |1;ext.html;404.88663174311165;483.88144904498404;505.15638883065276;509.44470527125424;510.8722819295176;32701.836490817543;40033.39949900754;40101.598984010154;40131.79934100326;40340.39489407658;41164.38253426201;41604.631513691005;41672.95817604561;41715.37426938598;41961.37057944133;8378.958105209465;8590.527520986343;9257.722268331943;9444.716658500256;9459.479728614924;11123.666290011271;11399.145064120183;11444.656660300205;11464.025557827596;11637.836216378379;10285.125764310043;10647.52086156121;11323.660290191307;11422.600208992686;11448.71378215543;11361.318320900773;11414.31514109152;11432.799556046662;11450.65648030552;11469.967702906779;11184.874873773957;11208.327500349924;11272.718182045432;11273.098152147808;11296.717582060432;38684.613153868384;39007;39133;39218.41172382417;39224;3315.419801534746;3941.2708648899757;3976.980115099406;3991.5409727881083;4118.732282401635;29442;30027.69972300271;30057.098287051424;30059.849700751358;30122;3209.5988001499813;3225.145336485833;3279.344131173751;3307.3881331953667;3333.933321333584;465324.3467565315;466175;466756;469215;469842.6507867473;57514.411851466786;57835;57927.13109303364;58344.70827645835;58540.82918341694;60357.39642603606;60675;60995.39004609897;61020.38979610236;61130.694346527984;14633.926830365994;14812.481563145238;14844.62888427798;14851.925740371445;14853.777193342108;10538.367697938149;10784.676459706221;11418.915203055696;11554.480048397842;11661.416929153509;12870.034747393984;16012.119333436773;16029.438969636007;16044.67910641804;16174.919125404533;7148.571085734872;7195.748148814766;7206.855862882713;7248.710051597877;7255.927440725525;789.7788619186522;845.9830803383898;846.9364797640202;848.2026894718945;864.0840708848641;29535;31272.218194544865;31974.200644984063;32116;33008.66991330056;970.2626004236831;1049.2130901823632;1058.1534772182376;1063.6543123484898;1151.4357964597286;14761.188134652482;15207.923960380349;15222.923885380502;15477.380904763684;15639.609009774618;617789;631722;633272;635610.8219458966;638853.1146885367;56602.43397565972;56779.71610141923;57552;57672;57722;1386.6741315790782;1413.7243237568575;1421.516684327313;1422.2675322209277;1436.5977526292654;27941.441171176055;28628.427431450837;28959.85520072386;29566.113016609535;29734.55398168986;50071.248931265334;50559.49440505548;50680.746596266785;50851.49148508615;50901;494937.0506294891;495703;496336;496835;497225.0277497179;33784;34649.48025779565;38585;40389.79805100956;40886.1822763549;44722.55277447314;44839;44862.10275794531;45192;45839.77080114711;29404;29931.700682993764;37578.812105940386;37624.62375376211;38233;37399.065023374635;37575.624243758306;38375.80812095922;38562.80718596389;38605;26944.595831062943;29098;35972.4604130933;36187.457188142725;36906.44640330344;32785.672143278265;33539.83230083834;33581.664183357854;34074.829625852704;34172.48741268833;22422.439439014157;24173.758262417854;24485.510289793747;24835.62746558767;24980.750192497842 08:21:43 INFO - PROCESS | 1985 | |2;jquery.html;330.4267096587421;365.68002997377295;371.1833965276391;388.86195400632795;394.8677193140298;16797.412090576832;18069.277228910843;18645.347412840554;18854.057297135158;19734.90132549339;17865;20911.895440522778;21465.570688586256;21520.354389368305;21972.89013554934;6362.681865906709;6617.106690596756;6665.733370665168;6683.431908287801;7259.927400725978;7487.625618719069;7674.079110506719;7677.961610191941;7694.846103077935;7715.344195743369;7457.440691948099;7589.848203035936;7604.467687261894;7687.654055567485;7697.730579429721;7372.815679608026;7592.658330375147;7628.54228746277;7647.158812530617;7699.345555627779;6252.6873656317;7137.750178743771;7416.147143078507;7448.106227252711;7451.366633836131;26384.8680756595;26445.47109057808;27223.77493012819;27377;27853.86073069642;2760.2823265950997;2930.2207612009483;2938.5592161175996;2944.8822047118306;2964.733174014349;16065.036097834167;16218.351265949348;16606.50180494587;16745.99048114222;17134.571635709082;1939.7478327817435;1979.6535606268844;1997.8901160436171;1999.8700084494608;2002.5594369238745;108302;115745;130478;136055;138652;14909.70180596382;16861.747073793904;21617.78382216189;21642.70143791346;21917.890410547847;33959.66040339565;34862;35045.47431788525;35046.649533504846;35080.47379289313;8501.872471912926;9634.855477167848;9912.256580756472;10261.538230779634;10404.427756473315;6829.692663830139;7072.92927070733;8112.797180070545;8221.630026648816;8261.504309741435;8221.712240071689;9570.234381249484;9769.658061967939;9969.651062212788;10011.949940250397;3590.389633762267;3655.4151335786146;3880.243352546283;3909.9413508797393;3931.68546516278;757.5530437042172;758.9962050189714;958.4105774948357;963.9637389805987;968.7820240445984;18866.679662313003;19943.700844487343;20007.399778006682;20133;20321;910.3263584947091;924.5007695844168;933.5285680731188;963.4652767713845;975.302658599105;7355;10130.949345253226;10560.419176945341;10580.206484513692;10668.573257069786;517163;528553;539593;544748;563082.3691763112;94516.52741736248;95887;100993;123582;127012;977.9559919803626;1002.218269749582;1031.5564307347763;1033.6537260017828;1034.462079718557;18999.145038473027;19101.90449047746;19318.03409829531;19320.13059412358;19367.515812104248;42377;47837.76081119711;49997.75001124971;51232.74383628058;51521.71195720137;71288;72645.66818940511;73521.6323918377;74862.62568687122;75298;7595.848083038419;7862.2923936845955;8054.597270136353;8106.675732970615;8159.06170790343;11567.768644626893;11594.01450876685;12079.637610871689;12485.500579977062;12518;9679.467629280458;9843.901560984299;10507;10830.18773591968;10995.615153469591;6217.782377616762;6315.55791094619;10663.733406664585;10726.302790318605;10738.624148154777;10079.244056695923;10831.67504974852;10998.725031873948;11071.1696622752;11280;7817.257360550739;7825.295723384923;8017.8797318039105;8023.59882005909;8045;7980.521168729895;10353.482325883826;10539.63111291101;10830;10885 08:21:43 INFO - PROCESS | 1985 | |3;mootools.html;1196.9521219151225;1320.1946812444407;1390.5967269491848;1394.8605139486046;1405.100735529261;7456.739014134507;7754.2633449822315;7894.7236846710375;8342.95828520858;8354.331653467723;7933.127355990837;8151.714689985852;8203.30271926887;8227.794305142374;8239.464434811733;2273.465735552148;2291.3355127013147;2329.6738456616085;2338.018032426385;2338.0647740903605;2063.7110804487384;2293.128611127769;2325.5232677301196;2339.6139636959883;2352.3060697094397;2081.198738485686;2222.48882756966;2302.746697863242;2311.399036250579;2313.641385585237;2271.3186044186677;2286.314105768263;2287.565362581104;2297.5864344417996;2299.701038864945;2297.1730177136383;2308.2613563659634;2330.976690233093;2333.5916214662534;2345.3081341004445;7268.745593904241;8083.070446898623;8289.0467596226;8304.792380190484;8310.8337833243;4929.704217746911;5167.948320516784;5174.922376164361;5181.119209734316;5181.378234611833;3367.090885460912;3371.6965473107293;3445.982770086159;3460.602030766469;3514.3147086318177;1058.439027315524;1178.7347846734501;1193.421190722499;1228.7419641875217;1237.777200103981;10640.46797660114;10689.679309620724;10777.83833242502;10786.191035672357;10806.51370688313;4095.5904409558807;4248.745075295492;4293.248681480791;4398.582134697199;4460;8634.5251011195;8691.130886911258;8697.913020869837;8720.389572729975;8725.432846864933;4945.109880221523;4945.55490005894;4946.678465899705;4956.132676781621;4977.502249774993;4560.247559152769;4600.194965880957;4634.6987445816585;4643.883902902387;4675.696079754805;3659.688926441229;3666.1018050577777;3710.870119545803;3715.777053376806;3743.2700623378723;1070.4112737994071;1084.414416215235;1147.8450409194818;1153.411760002388;1155.6013175454455;629.8645791154923;732.2421293960725;745.4558172533972;759.5936174146805;766.7278116268644;4802.27965805125;5181.35233095863;5311.521963023347;5720.599558030898;5781.699117698484;467.76976551668895;521.9164933610604;548.3912856729028;548.8353493951798;610.4749915073033;2943.925467204455;3530.770499917497;3775.679067279312;3849.40334248192;3871.632194941476;9488.525573721286;9918.156956658764;9926.900730992742;9953.701388958343;9969.155706194377;9731.756706082262;9858.260630452745;9886.15967642744;9888.505574721235;9935.254855885838;7297.9635101825215;7553.8866916996285;7714.919911212435;7750.689972401154;7825.413094017971;4628.213203755437;5551.306086739158;5678.290213723285;5777.277840269966;5849;7591.658375373011;9051.864222036544;9211.40125891815;9251.444913305224;9348.626054957726;7647.732329368446;9151.267898568232;9421.434713917188;9459.952700236454;9483.099105584959;7140.178879428932;7284.890726639211;7291.781246562611;7299.781006569811;7306.123265208209;7715.652795624323;7791.766247012599;7859.371250299848;7864.72473463426;7866.213378662317;6986.54587451814;7063.929360706327;7071.186813516511;7115.75094871677;7200.531965422231;6901.89647155283;6987;6989.860202796017;7004.579725216503;7046.365827075588;6277.246730392382;6396.520260980352;6405.967970160119;6408.871822563429;6447.871042579029;4234.301340278819;4273.957260427356;4276.444062271885;4379.978100109479;4397;4667.276572131325;4874.171390863491;4897.583705385082;4950.331705219894;5016.4231113420965 08:21:43 INFO - PROCESS | 1985 | |4;prototype.html;310.4721972646501;349.8425708431205;353.2070501723631;360.26890789755214;361.51556913735607;4332.956670433295;4901.387326584177;5289.338832645919;5299.9205011924805;5388.7305634718305;4284.614384705376;4653.464851542074;5214.426413094557;5388.946110538894;5405.783768649249;3899.883003509892;4052.837886484537;4063.2889244382263;4071.857484988026;4098.221337945781;3428.2974387661266;3748.8125593720206;3964.464797252363;4091.8083894562287;4154.688398370119;4097.323941549641;4102.220578090169;4105.2405305018665;4122.113745544707;4145.8963525911795;2856.571514272855;3530.082178633548;3552.868279032573;3667;3971.3050216212046;2856.985715071432;3115.43922094023;3148.795328303653;3384.4415671414185;3440.36353274645;4308.763018034007;4860.343853579757;5158.458361872024;5190.169572868323;5190.480951904817;3864.439656249856;4357.268020907673;4559.931601025987;4569.611583015448;4585.610223131038;5098.603656281579;5521.613487055908;5540.889182216373;5586.972065139689;5642.351129620105;3770.6606405423645;3776.773393596393;3790.692211187136;3792.829322680486;3803.695704343646;5889.823305300805;5922.3485416604135;5932.406759324076;5969.089891234807;6103.633781973096;3487.9651203487642;3587.192881601671;3800.790956497364;3805.238952209569;3823.923521529554;3261.3803377358226;3847.8653247136776;3858.9614103858603;3873.7288389812443;3882.641075623509;4531.909361812745;4532.070925460339;4543.068670922453;4564.315352697122;4580.152671755736;5249.606279529051;5567.220589117527;5602.355729091125;5634.436556344414;5649.548036157097;1087.4617064553097;1095.5343978808974;1232.1498166265249;1254.5609036837034;1262.2489618676873;743.0229248538155;793.476305638276;807.7237964016839;839.4795226959202;853.6542700206427;4216.746995180299;4644.581987621063;5216.347956505437;5301.065111234372;5389.892202156013;4914.8771280718265;5143.177091665316;5770.769169233267;5828.854278642983;5851.707414629252;4576.58810707038;4717.716936983792;5357.758900849393;5359.981603495324;5372.838814835562;2460.683534309136;2564.564024115905;2906.593076969226;2935.515639919432;2949;4823;5840.065589505659;5908.497777688859;5908.645481271052;5923.763049478059;4592.586667199901;5449.100898351807;5777.768889244383;5778.422157784188;5996.340402555716;5354.866128346823;5357.383900851452;5829.242198514251;6032.577719559677;6036.396360363929;5084.872803226063;5650.604457687922;5788.27646544182;5834.416558344132;5857;5714.8281754320415;5715.514181294637;5758.782868595537;5776.508996735324;5828.504577110993;5138.8972220556125;5288.286081378965;5787.218725472176;5867.119932010062;5959.553033522417;3555.8755443559353;3806.3529200036614;4098.200850834178;4121.423000779833;4148.481439820022;4733.680496556732;5726.484616384545;5743.56923230751;5757.309122905278;5832.329282132439;4444.066830928557;4501.504834468271;4734.810607575659;5348.304720386325;5599.692016939108;5265.657732247545;5339.866503337447;5595.720213989365;5621.915671264853;5679.517241034393;4934.519644106682;5012.674176178537;5424.891502170013;5543.916841247304;5571.264425238515;4453.888652783707;4655.743934083658;5312.548433383051;5514.36584792754;5671.943280567307;4660.510646382081;4784.712917224978;5144.765256338526;5559.388467268678;5564.610477266552 08:21:43 INFO - PROCESS | 1985 | |5;yui.html;609.6555446172915;706.9116360454943;720.6865013719032;768.5119948832491;824.5300178898027;13667;14369.281535923188;14396.784048239258;14406.35171417286;14498.347574359153;14121;14272;14317.427302907898;14336.928315358435;14366.569002929902;689.1695506914182;715.5277516838887;726.4733068525329;837.4975014991018;874.8512752832002;857.2841677199546;878.6002368922125;881.3610132653839;882.8675698645222;885.6767279942807;932.4731526687434;932.7668082979255;933.9813203735921;939.0890835889177;943.5895385507326;913.1918252346654;926.2636204217663;929.8605209218604;933.6452148183647;936.6393938333722;682.9043933849265;690.5752961928378;698.7554355975368;699.3565919354155;700.5411455496658;13595.456181752717;14347.928260358736;14796.778048329285;14803.703925921529;15100.320485578066;13864.792028119586;14417.351219195161;14438.711225775425;14460.204688742115;14547.3453694584;9372.26770526989;10406.271560990657;11642.76714465706;11679.124065695107;11712.765744685144;2698;3627.075095850568;3708.165662725892;3711.6102809205186;3735.7571757835653;102530.48734756352;104569;105426.47286763517;105861.35346616319;106012.93987060108;10819;10954.287971281841;10968.23222374442;11097.722556936142;11155.776884462266;22697.205597803997;22939.541209176055;22941;22986.8850655749;23012.65481017786;7773.5724535149975;7834.686612535549;7845.490043147177;7913.248241417056;8007.839843203104;4159.9376009359885;4284.293091639907;4322.502912165141;4341.891452713708;4341.979634785823;3357.916052098717;3402.6086999994823;3411.1301618087723;3442.535257740223;3445.2764919366714;639.4500729372736;641.0864518061743;643.3919945651314;646.3278190681639;648.0667838312909;503.5241696596681;578.1991941161522;611.538288592119;621.4841681404423;636.4017823246134;8582;8613.353998450142;8683;8981;9118.908810911806;439.3080897586314;495.6109454078531;515.8684535443438;538.9705662185286;560.2268819187227;4201.411802347674;4237.864680322781;4459.308807134899;4478.552144785495;4618.538146185355;98701;101229.49385253027;101328;102053.48973255086;105926.47036764766;62365;83352;83572;84514.57742711247;84666;76950.84573731398;77565.44869102699;78664.21335786683;78674;80935.97660058546;8629.125788323563;8727.607257673548;8775.166359195866;8787.472751634923;8818.98581663117;48941.02117957692;50593.49406506035;51044;51577;52354.738226308626;56001.71999140141;68264.6586767063;69048.6547567259;69982;71634.64182679054;10339.277859970554;11561.7109572258;11600.477978491157;11601.593944211912;12171.087168462223;10810.243282970117;11290.322580645188;12622;12640.620781376574;12666.050046246384;10564.735881603021;10975.176861735561;11870.762584748429;12032.27806331623;12359.3820308986;9149.542522873962;11742.70643233926;11766.764664706829;11940.701482463008;12217.389130543259;11598.826017609912;11709.941450293034;11863.525458981545;11878.881211188123;12376.07179461526;9435.669751558662;9697.175740062174;9737.561809718438;9812.754681132743;9836.508174591385;9132.954335228547;9587.328886977844;9638.228941684509;9642.662506812509;9702.5148742564 08:21:43 INFO - PROCESS | 1985 | __end_tp_report 08:21:43 INFO - PROCESS | 1985 | __start_cc_report 08:21:43 INFO - PROCESS | 1985 | _x_x_mozilla_cycle_collect,376 08:21:43 INFO - PROCESS | 1985 | __end_cc_report 08:21:43 INFO - PROCESS | 1985 | __startTimestamp1482855703690__endTimestamp 08:21:43 INFO - PROCESS | 1985 | 08:21:43 INFO - PROCESS | 1985 | ------- Summary: start ------- 08:21:43 INFO - PROCESS | 1985 | Number of tests: 6 08:21:43 INFO - PROCESS | 1985 | 08:21:43 INFO - PROCESS | 1985 | [#0] dojo.html Cycles:165 Average:5569.21 Median:5767.68 stddev:679.00 (11.8%) stddev-sans-first:656.85 08:21:43 INFO - PROCESS | 1985 | Values: 3277.4 3281.9 3287.1 3310.4 3316.1 4481.0 4577.8 5272.2 5533.5 5552.9 5433.2 5523.9 5528.6 5533.7 5581.2 4823.5 5086.4 5115.4 5148.6 5151.6 5077.1 5161.5 5172.4 5177.6 5190.6 5165.5 5168.2 5180.2 5182.8 5183.9 5155.3 5157.7 5167.6 5173.7 5177.4 5020.3 5112.2 5118.9 5150.2 5150.6 5120.9 5620.0 5660.9 5699.3 5747.3 5934.5 6098.4 6137.8 6167.0 6219.9 5860.2 5900.7 5912.2 6026.0 6271.6 3448.6 4874.3 5479.7 5529.6 5557.7 6251.8 6252.2 6265.5 6273.2 6303.6 4907.6 5482.0 5629.0 6067.4 6068.2 5985.8 6050.0 6056.5 6146.1 6180.7 5601.0 6008.8 6040.9 6065.0 6095.5 5007.5 6129.5 6164.6 6181.4 6185.4 4858.6 4883.5 4892.6 4893.8 4931.1 4248.7 4275.6 4306.7 4332.4 4342.7 5680.3 5809.0 5811.8 5817.4 5842.4 6123.8 6134.8 6135.3 6139.1 6162.2 5573.5 5630.4 5747.9 5767.7 5797.1 5270.6 5293.8 5316.2 5345.0 5353.5 5460.7 6140.0 6222.0 6266.5 6336.4 6149.7 6198.0 6199.6 6209.9 6230.6 6167.8 6263.5 6279.6 6282.7 6301.7 5015.7 5959.7 6084.7 6091.5 6114.9 6121.4 6168.5 6186.5 6196.0 6229.9 5920.0 6021.0 6023.2 6037.1 6042.3 5744.6 5796.0 5819.3 5900.7 5939.8 4456.7 4492.8 5763.4 5873.1 5890.7 5998.5 6024.8 6036.5 6041.2 6069.2 5671.9 5710.6 5827.4 5833.5 5864.2 08:21:43 INFO - PROCESS | 1985 | 08:21:43 INFO - PROCESS | 1985 | [#1] ext.html Cycles:180 Average:66858.32 Median:37487.34 stddev:143134.22 (381.8%) stddev-sans-first:143448.79 08:21:43 INFO - PROCESS | 1985 | Values: 404.9 483.9 505.2 509.4 510.9 32701.8 40033.4 40101.6 40131.8 40340.4 41164.4 41604.6 41673.0 41715.4 41961.4 8379.0 8590.5 9257.7 9444.7 9459.5 11123.7 11399.1 11444.7 11464.0 11637.8 10285.1 10647.5 11323.7 11422.6 11448.7 11361.3 11414.3 11432.8 11450.7 11470.0 11184.9 11208.3 11272.7 11273.1 11296.7 38684.6 39007.0 39133.0 39218.4 39224.0 3315.4 3941.3 3977.0 3991.5 4118.7 29442.0 30027.7 30057.1 30059.8 30122.0 3209.6 3225.1 3279.3 3307.4 3333.9 465324.3 466175.0 466756.0 469215.0 469842.7 57514.4 57835.0 57927.1 58344.7 58540.8 60357.4 60675.0 60995.4 61020.4 61130.7 14633.9 14812.5 14844.6 14851.9 14853.8 10538.4 10784.7 11418.9 11554.5 11661.4 12870.0 16012.1 16029.4 16044.7 16174.9 7148.6 7195.7 7206.9 7248.7 7255.9 789.8 846.0 846.9 848.2 864.1 29535.0 31272.2 31974.2 32116.0 33008.7 970.3 1049.2 1058.2 1063.7 1151.4 14761.2 15207.9 15222.9 15477.4 15639.6 617789.0 631722.0 633272.0 635610.8 638853.1 56602.4 56779.7 57552.0 57672.0 57722.0 1386.7 1413.7 1421.5 1422.3 1436.6 27941.4 28628.4 28959.9 29566.1 29734.6 50071.2 50559.5 50680.7 50851.5 50901.0 494937.1 495703.0 496336.0 496835.0 497225.0 33784.0 34649.5 38585.0 40389.8 40886.2 44722.6 44839.0 44862.1 45192.0 45839.8 29404.0 29931.7 37578.8 37624.6 38233.0 37399.1 37575.6 38375.8 38562.8 38605.0 26944.6 29098.0 35972.5 36187.5 36906.4 32785.7 33539.8 33581.7 34074.8 34172.5 22422.4 24173.8 24485.5 24835.6 24980.8 08:21:43 INFO - PROCESS | 1985 | 08:21:43 INFO - PROCESS | 1985 | [#2] jquery.html Cycles:180 Average:34018.48 Median:1978.03 stddev:89983.25 (4549.1%) stddev-sans-first:90200.13 08:21:43 INFO - PROCESS | 1985 | Values: 330.4 365.7 371.2 388.9 394.9 16797.4 18069.3 18645.3 18854.1 19734.9 17865.0 20911.9 21465.6 21520.4 21972.9 6362.7 6617.1 6665.7 6683.4 7259.9 7487.6 7674.1 7678.0 7694.8 7715.3 7457.4 7589.8 7604.5 7687.7 7697.7 7372.8 7592.7 7628.5 7647.2 7699.3 6252.7 7137.8 7416.1 7448.1 7451.4 26384.9 26445.5 27223.8 27377.0 27853.9 2760.3 2930.2 2938.6 2944.9 2964.7 16065.0 16218.4 16606.5 16746.0 17134.6 1939.7 1979.7 1997.9 1999.9 2002.6 108302.0 115745.0 130478.0 136055.0 138652.0 14909.7 16861.7 21617.8 21642.7 21917.9 33959.7 34862.0 35045.5 35046.6 35080.5 8501.9 9634.9 9912.3 10261.5 10404.4 6829.7 7072.9 8112.8 8221.6 8261.5 8221.7 9570.2 9769.7 9969.7 10011.9 3590.4 3655.4 3880.2 3909.9 3931.7 757.6 759.0 958.4 964.0 968.8 18866.7 19943.7 20007.4 20133.0 20321.0 910.3 924.5 933.5 963.5 975.3 7355.0 10130.9 10560.4 10580.2 10668.6 517163.0 528553.0 539593.0 544748.0 563082.4 94516.5 95887.0 100993.0 123582.0 127012.0 978.0 1002.2 1031.6 1033.7 1034.5 18999.1 19101.9 19318.0 19320.1 19367.5 42377.0 47837.8 49997.8 51232.7 51521.7 71288.0 72645.7 73521.6 74862.6 75298.0 7595.8 7862.3 8054.6 8106.7 8159.1 11567.8 11594.0 12079.6 12485.5 12518.0 9679.5 9843.9 10507.0 10830.2 10995.6 6217.8 6315.6 10663.7 10726.3 10738.6 10079.2 10831.7 10998.7 11071.2 11280.0 7817.3 7825.3 8017.9 8023.6 8045.0 7980.5 10353.5 10539.6 10830.0 10885.0 08:21:43 INFO - PROCESS | 1985 | 08:21:43 INFO - PROCESS | 1985 | [#3] mootools.html Cycles:180 Average:5292.79 Median:5178.02 stddev:2931.68 (56.6%) stddev-sans-first:2923.74 08:21:43 INFO - PROCESS | 1985 | Values: 1197.0 1320.2 1390.6 1394.9 1405.1 7456.7 7754.3 7894.7 8343.0 8354.3 7933.1 8151.7 8203.3 8227.8 8239.5 2273.5 2291.3 2329.7 2338.0 2338.1 2063.7 2293.1 2325.5 2339.6 2352.3 2081.2 2222.5 2302.7 2311.4 2313.6 2271.3 2286.3 2287.6 2297.6 2299.7 2297.2 2308.3 2331.0 2333.6 2345.3 7268.7 8083.1 8289.0 8304.8 8310.8 4929.7 5167.9 5174.9 5181.1 5181.4 3367.1 3371.7 3446.0 3460.6 3514.3 1058.4 1178.7 1193.4 1228.7 1237.8 10640.5 10689.7 10777.8 10786.2 10806.5 4095.6 4248.7 4293.2 4398.6 4460.0 8634.5 8691.1 8697.9 8720.4 8725.4 4945.1 4945.6 4946.7 4956.1 4977.5 4560.2 4600.2 4634.7 4643.9 4675.7 3659.7 3666.1 3710.9 3715.8 3743.3 1070.4 1084.4 1147.8 1153.4 1155.6 629.9 732.2 745.5 759.6 766.7 4802.3 5181.4 5311.5 5720.6 5781.7 467.8 521.9 548.4 548.8 610.5 2943.9 3530.8 3775.7 3849.4 3871.6 9488.5 9918.2 9926.9 9953.7 9969.2 9731.8 9858.3 9886.2 9888.5 9935.3 7298.0 7553.9 7714.9 7750.7 7825.4 4628.2 5551.3 5678.3 5777.3 5849.0 7591.7 9051.9 9211.4 9251.4 9348.6 7647.7 9151.3 9421.4 9460.0 9483.1 7140.2 7284.9 7291.8 7299.8 7306.1 7715.7 7791.8 7859.4 7864.7 7866.2 6986.5 7063.9 7071.2 7115.8 7200.5 6901.9 6987.0 6989.9 7004.6 7046.4 6277.2 6396.5 6406.0 6408.9 6447.9 4234.3 4274.0 4276.4 4380.0 4397.0 4667.3 4874.2 4897.6 4950.3 5016.4 08:21:43 INFO - PROCESS | 1985 | 08:21:43 INFO - PROCESS | 1985 | [#4] prototype.html Cycles:180 Average:4470.05 Median:4924.70 stddev:1414.87 (28.7%) stddev-sans-first:1383.96 08:21:43 INFO - PROCESS | 1985 | Values: 310.5 349.8 353.2 360.3 361.5 4333.0 4901.4 5289.3 5299.9 5388.7 4284.6 4653.5 5214.4 5388.9 5405.8 3899.9 4052.8 4063.3 4071.9 4098.2 3428.3 3748.8 3964.5 4091.8 4154.7 4097.3 4102.2 4105.2 4122.1 4145.9 2856.6 3530.1 3552.9 3667.0 3971.3 2857.0 3115.4 3148.8 3384.4 3440.4 4308.8 4860.3 5158.5 5190.2 5190.5 3864.4 4357.3 4559.9 4569.6 4585.6 5098.6 5521.6 5540.9 5587.0 5642.4 3770.7 3776.8 3790.7 3792.8 3803.7 5889.8 5922.3 5932.4 5969.1 6103.6 3488.0 3587.2 3800.8 3805.2 3823.9 3261.4 3847.9 3859.0 3873.7 3882.6 4531.9 4532.1 4543.1 4564.3 4580.2 5249.6 5567.2 5602.4 5634.4 5649.5 1087.5 1095.5 1232.1 1254.6 1262.2 743.0 793.5 807.7 839.5 853.7 4216.7 4644.6 5216.3 5301.1 5389.9 4914.9 5143.2 5770.8 5828.9 5851.7 4576.6 4717.7 5357.8 5360.0 5372.8 2460.7 2564.6 2906.6 2935.5 2949.0 4823.0 5840.1 5908.5 5908.6 5923.8 4592.6 5449.1 5777.8 5778.4 5996.3 5354.9 5357.4 5829.2 6032.6 6036.4 5084.9 5650.6 5788.3 5834.4 5857.0 5714.8 5715.5 5758.8 5776.5 5828.5 5138.9 5288.3 5787.2 5867.1 5959.6 3555.9 3806.4 4098.2 4121.4 4148.5 4733.7 5726.5 5743.6 5757.3 5832.3 4444.1 4501.5 4734.8 5348.3 5599.7 5265.7 5339.9 5595.7 5621.9 5679.5 4934.5 5012.7 5424.9 5543.9 5571.3 4453.9 4655.7 5312.5 5514.4 5671.9 4660.5 4784.7 5144.8 5559.4 5564.6 08:21:43 INFO - PROCESS | 1985 | 08:21:43 INFO - PROCESS | 1985 | [#5] yui.html Cycles:180 Average:19732.64 Median:25548.51 stddev:28858.78 (113.0%) stddev-sans-first:28904.01 08:21:43 INFO - PROCESS | 1985 | Values: 609.7 706.9 720.7 768.5 824.5 13667.0 14369.3 14396.8 14406.4 14498.3 14121.0 14272.0 14317.4 14336.9 14366.6 689.2 715.5 726.5 837.5 874.9 857.3 878.6 881.4 882.9 885.7 932.5 932.8 934.0 939.1 943.6 913.2 926.3 929.9 933.6 936.6 682.9 690.6 698.8 699.4 700.5 13595.5 14347.9 14796.8 14803.7 15100.3 13864.8 14417.4 14438.7 14460.2 14547.3 9372.3 10406.3 11642.8 11679.1 11712.8 2698.0 3627.1 3708.2 3711.6 3735.8 102530.5 104569.0 105426.5 105861.4 106012.9 10819.0 10954.3 10968.2 11097.7 11155.8 22697.2 22939.5 22941.0 22986.9 23012.7 7773.6 7834.7 7845.5 7913.2 8007.8 4159.9 4284.3 4322.5 4341.9 4342.0 3357.9 3402.6 3411.1 3442.5 3445.3 639.5 641.1 643.4 646.3 648.1 503.5 578.2 611.5 621.5 636.4 8582.0 8613.4 8683.0 8981.0 9118.9 439.3 495.6 515.9 539.0 560.2 4201.4 4237.9 4459.3 4478.6 4618.5 98701.0 101229.5 101328.0 102053.5 105926.5 62365.0 83352.0 83572.0 84514.6 84666.0 76950.8 77565.4 78664.2 78674.0 80936.0 8629.1 8727.6 8775.2 8787.5 8819.0 48941.0 50593.5 51044.0 51577.0 52354.7 56001.7 68264.7 69048.7 69982.0 71634.6 10339.3 11561.7 11600.5 11601.6 12171.1 10810.2 11290.3 12622.0 12640.6 12666.1 10564.7 10975.2 11870.8 12032.3 12359.4 9149.5 11742.7 11766.8 11940.7 12217.4 11598.8 11709.9 11863.5 11878.9 12376.1 9435.7 9697.2 9737.6 9812.8 9836.5 9133.0 9587.3 9638.2 9642.7 9702.5 08:21:43 INFO - PROCESS | 1985 | -------- Summary: end -------- 08:21:43 INFO - PROCESS | 1985 | 08:21:44 INFO - TEST-INFO | 1985: exit 0 08:21:44 INFO - TEST-OK | dromaeo_css | took 1115396ms 08:21:44 INFO - TEST-START | kraken 08:21:44 INFO - operating with platform_type : mac_ 08:21:44 INFO - Initialising browser for kraken test... 08:21:44 INFO - TEST-INFO | started process 1990 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/tmp3r7laR/profile http://localhost:52129/getInfo.html) 08:21:44 INFO - PROCESS | 1990 | 1482855704813 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4979 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3825 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2829 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 08:21:46 INFO - PROCESS | 1990 | 2016-12-27 08:21:46.922 plugin-container[1991:23804] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 08:21:46 INFO - PROCESS | 1990 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:21:46 INFO - PROCESS | 1990 | 2016-12-27 08:21:46.925 plugin-container[1991:23804] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0f, name = 'com.apple.CFPasteboardClient' 08:21:46 INFO - PROCESS | 1990 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:21:46 INFO - PROCESS | 1990 | 2016-12-27 08:21:46.925 plugin-container[1991:23804] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:21:46 INFO - PROCESS | 1990 | __metrics Screen width/height:1600/1200 08:21:46 INFO - PROCESS | 1990 | colorDepth:24 08:21:46 INFO - PROCESS | 1990 | Browser inner width/height: 1024/689 08:21:46 INFO - PROCESS | 1990 | __metrics 08:21:47 ERROR - PROCESS | 1990 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 08:21:47 INFO - TEST-INFO | 1990: exit 0 08:21:47 INFO - Browser initialized. 08:21:47 INFO - Running cycle 1/1 for kraken test... 08:21:47 INFO - TEST-INFO | started process 1992 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/tmp3r7laR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:21:49 INFO - PROCESS | 1992 | 2016-12-27 08:21:49.982 plugin-container[1993:23922] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x454b, name = 'com.apple.tsm.portname' 08:21:49 INFO - PROCESS | 1992 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:21:49 INFO - PROCESS | 1992 | 2016-12-27 08:21:49.982 plugin-container[1993:23922] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 08:21:49 INFO - PROCESS | 1992 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:21:49 INFO - PROCESS | 1992 | 2016-12-27 08:21:49.982 plugin-container[1993:23922] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:21:59 INFO - PROCESS | 1992 | RSS: Main: 232443904 08:21:59 INFO - PROCESS | 1992 | 08:22:03 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52129/tests/kraken/driver.html?testName=audio-beat-detection) 08:22:04 INFO - PROCESS | 1992 | RSS: Main: 245415936 08:22:04 INFO - PROCESS | 1992 | 08:22:06 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52129/tests/kraken/driver.html?testName=audio-dft) 08:22:07 INFO - PROCESS | 1992 | RSS: Main: 253362176 08:22:07 INFO - PROCESS | 1992 | 08:22:10 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52129/tests/kraken/driver.html?testName=audio-fft) 08:22:11 INFO - PROCESS | 1992 | RSS: Main: 255967232 08:22:11 INFO - PROCESS | 1992 | 08:22:13 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52129/tests/kraken/driver.html?testName=audio-oscillator) 08:22:13 INFO - PROCESS | 1992 | RSS: Main: 258211840 08:22:13 INFO - PROCESS | 1992 | 08:22:15 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52129/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:22:16 INFO - PROCESS | 1992 | RSS: Main: 258838528 08:22:16 INFO - PROCESS | 1992 | 08:22:19 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52129/tests/kraken/driver.html?testName=imaging-darkroom) 08:22:20 INFO - PROCESS | 1992 | RSS: Main: 264216576 08:22:20 INFO - PROCESS | 1992 | 08:22:23 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52129/tests/kraken/driver.html?testName=imaging-desaturate) 08:22:24 INFO - PROCESS | 1992 | RSS: Main: 263446528 08:22:24 INFO - PROCESS | 1992 | 08:22:27 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52129/tests/kraken/driver.html?testName=json-parse-financial) 08:22:27 INFO - PROCESS | 1992 | RSS: Main: 263344128 08:22:27 INFO - PROCESS | 1992 | 08:22:29 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52129/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:22:29 INFO - PROCESS | 1992 | RSS: Main: 262647808 08:22:29 INFO - PROCESS | 1992 | 08:22:32 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52129/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:22:32 INFO - PROCESS | 1992 | RSS: Main: 262688768 08:22:32 INFO - PROCESS | 1992 | 08:22:35 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52129/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:22:35 INFO - PROCESS | 1992 | RSS: Main: 262754304 08:22:35 INFO - PROCESS | 1992 | 08:22:38 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52129/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:22:39 INFO - PROCESS | 1992 | RSS: Main: 263053312 08:22:39 INFO - PROCESS | 1992 | 08:22:42 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52129/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:22:43 INFO - PROCESS | 1992 | RSS: Main: 263225344 08:22:43 INFO - PROCESS | 1992 | 08:22:45 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52129/tests/kraken/driver.html?testName=ai-astar) 08:22:45 INFO - PROCESS | 1992 | RSS: Main: 266170368 08:22:45 INFO - PROCESS | 1992 | 08:22:45 INFO - PROCESS | 1992 | __start_tp_report 08:22:45 INFO - PROCESS | 1992 | _x_x_mozilla_page_load 08:22:45 INFO - PROCESS | 1992 | _x_x_mozilla_page_load_details 08:22:45 INFO - PROCESS | 1992 | |i|pagename|runs| 08:22:45 INFO - PROCESS | 1992 | |0;ai-astar;144;172;163;119;118;162;98;141;174;175 08:22:45 INFO - PROCESS | 1992 | |1;audio-beat-detection;145;113;99;191;100;97;106;134;161;148 08:22:45 INFO - PROCESS | 1992 | |2;audio-dft;204;225;194;196;199;204;199;195;199;199 08:22:45 INFO - PROCESS | 1992 | |3;audio-fft;82;60;59;85;62;61;65;62;72;61 08:22:45 INFO - PROCESS | 1992 | |4;audio-oscillator;86;72;84;73;73;74;111;101;102;96 08:22:45 INFO - PROCESS | 1992 | |5;imaging-gaussian-blur;89;87;89;85;91;90;90;87;95;134 08:22:45 INFO - PROCESS | 1992 | |6;imaging-darkroom;134;119;173;136;100;100;99;100;100;100 08:22:45 INFO - PROCESS | 1992 | |7;imaging-desaturate;98;115;91;91;114;146;93;92;92;97 08:22:45 INFO - PROCESS | 1992 | |8;json-parse-financial;63;61;62;62;63;64;61;66;65;72 08:22:45 INFO - PROCESS | 1992 | |9;json-stringify-tinderbox;73;106;69;105;114;104;77;71;72;71 08:22:45 INFO - PROCESS | 1992 | |10;stanford-crypto-aes;104;108;116;114;82;93;88;92;89;98 08:22:45 INFO - PROCESS | 1992 | |11;stanford-crypto-ccm;147;164;157;162;143;142;143;159;236;190 08:22:45 INFO - PROCESS | 1992 | |12;stanford-crypto-pbkdf2;175;179;176;173;192;155;215;172;223;244 08:22:45 INFO - PROCESS | 1992 | |13;stanford-crypto-sha256-iterative;77;71;74;83;92;91;88;67;74;90 08:22:45 INFO - PROCESS | 1992 | __end_tp_report 08:22:45 INFO - PROCESS | 1992 | __start_cc_report 08:22:45 INFO - PROCESS | 1992 | _x_x_mozilla_cycle_collect,925 08:22:45 INFO - PROCESS | 1992 | __end_cc_report 08:22:45 INFO - PROCESS | 1992 | __startTimestamp1482855765372__endTimestamp 08:22:45 INFO - PROCESS | 1992 | 08:22:45 INFO - PROCESS | 1992 | ------- Summary: start ------- 08:22:45 INFO - PROCESS | 1992 | Number of tests: 14 08:22:45 INFO - PROCESS | 1992 | 08:22:45 INFO - PROCESS | 1992 | [#0] ai-astar Cycles:10 Average:146.60 Median:167.50 stddev:27.26 (16.3%) stddev-sans-first:28.90 08:22:45 INFO - PROCESS | 1992 | Values: 144.0 172.0 163.0 119.0 118.0 162.0 98.0 141.0 174.0 175.0 08:22:45 INFO - PROCESS | 1992 | 08:22:45 INFO - PROCESS | 1992 | [#1] audio-beat-detection Cycles:10 Average:129.40 Median:154.50 stddev:31.73 (20.5%) stddev-sans-first:33.14 08:22:45 INFO - PROCESS | 1992 | Values: 145.0 113.0 99.0 191.0 100.0 97.0 106.0 134.0 161.0 148.0 08:22:45 INFO - PROCESS | 1992 | 08:22:45 INFO - PROCESS | 1992 | [#2] audio-dft Cycles:10 Average:201.40 Median:199.00 stddev:8.93 (4.5%) stddev-sans-first:9.43 08:22:45 INFO - PROCESS | 1992 | Values: 204.0 225.0 194.0 196.0 199.0 204.0 199.0 195.0 199.0 199.0 08:22:45 INFO - PROCESS | 1992 | 08:22:45 INFO - PROCESS | 1992 | [#3] audio-fft Cycles:10 Average:66.90 Median:63.50 stddev:9.50 (15.0%) stddev-sans-first:8.36 08:22:45 INFO - PROCESS | 1992 | Values: 82.0 60.0 59.0 85.0 62.0 61.0 65.0 62.0 72.0 61.0 08:22:45 INFO - PROCESS | 1992 | 08:22:45 INFO - PROCESS | 1992 | [#4] audio-oscillator Cycles:10 Average:87.20 Median:73.50 stddev:14.43 (19.6%) stddev-sans-first:15.30 08:22:45 INFO - PROCESS | 1992 | Values: 86.0 72.0 84.0 73.0 73.0 74.0 111.0 101.0 102.0 96.0 08:22:45 INFO - PROCESS | 1992 | 08:22:45 INFO - PROCESS | 1992 | [#5] imaging-gaussian-blur Cycles:10 Average:93.70 Median:89.50 stddev:14.41 (16.1%) stddev-sans-first:15.19 08:22:45 INFO - PROCESS | 1992 | Values: 89.0 87.0 89.0 85.0 91.0 90.0 90.0 87.0 95.0 134.0 08:22:45 INFO - PROCESS | 1992 | 08:22:45 INFO - PROCESS | 1992 | [#6] imaging-darkroom Cycles:10 Average:116.10 Median:126.50 stddev:24.83 (19.6%) stddev-sans-first:25.48 08:22:45 INFO - PROCESS | 1992 | Values: 134.0 119.0 173.0 136.0 100.0 100.0 99.0 100.0 100.0 100.0 08:22:45 INFO - PROCESS | 1992 | 08:22:45 INFO - PROCESS | 1992 | [#7] imaging-desaturate Cycles:10 Average:102.90 Median:92.00 stddev:17.65 (19.2%) stddev-sans-first:18.64 08:22:45 INFO - PROCESS | 1992 | Values: 98.0 115.0 91.0 91.0 114.0 146.0 93.0 92.0 92.0 97.0 08:22:45 INFO - PROCESS | 1992 | 08:22:45 INFO - PROCESS | 1992 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:63.50 stddev:3.28 (5.2%) stddev-sans-first:3.46 08:22:45 INFO - PROCESS | 1992 | Values: 63.0 61.0 62.0 62.0 63.0 64.0 61.0 66.0 65.0 72.0 08:22:45 INFO - PROCESS | 1992 | 08:22:45 INFO - PROCESS | 1992 | [#9] json-stringify-tinderbox Cycles:10 Average:86.20 Median:71.00 stddev:18.42 (25.9%) stddev-sans-first:18.91 08:22:45 INFO - PROCESS | 1992 | Values: 73.0 106.0 69.0 105.0 114.0 104.0 77.0 71.0 72.0 71.0 08:22:45 INFO - PROCESS | 1992 | 08:22:45 INFO - PROCESS | 1992 | [#10] stanford-crypto-aes Cycles:10 Average:98.40 Median:88.50 stddev:11.61 (13.1%) stddev-sans-first:12.13 08:22:45 INFO - PROCESS | 1992 | Values: 104.0 108.0 116.0 114.0 82.0 93.0 88.0 92.0 89.0 98.0 08:22:45 INFO - PROCESS | 1992 | 08:22:45 INFO - PROCESS | 1992 | [#11] stanford-crypto-ccm Cycles:10 Average:164.30 Median:160.50 stddev:29.04 (18.1%) stddev-sans-first:30.12 08:22:45 INFO - PROCESS | 1992 | Values: 147.0 164.0 157.0 162.0 143.0 142.0 143.0 159.0 236.0 190.0 08:22:45 INFO - PROCESS | 1992 | 08:22:45 INFO - PROCESS | 1992 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.40 Median:185.50 stddev:27.91 (15.0%) stddev-sans-first:29.04 08:22:45 INFO - PROCESS | 1992 | Values: 175.0 179.0 176.0 173.0 192.0 155.0 215.0 172.0 223.0 244.0 08:22:45 INFO - PROCESS | 1992 | 08:22:45 INFO - PROCESS | 1992 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.70 Median:85.50 stddev:9.21 (10.8%) stddev-sans-first:9.68 08:22:45 INFO - PROCESS | 1992 | Values: 77.0 71.0 74.0 83.0 92.0 91.0 88.0 67.0 74.0 90.0 08:22:45 INFO - PROCESS | 1992 | -------- Summary: end -------- 08:22:45 INFO - PROCESS | 1992 | 08:22:46 INFO - TEST-INFO | 1992: exit 0 08:22:46 INFO - TEST-OK | kraken | took 62077ms 08:22:46 INFO - SUITE-END | took 1177s 08:22:46 INFO - Completed test suite (00:19:37) 08:22:46 INFO - javascript benchmark 08:22:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7208.608296711347, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3277.442834718098, 3281.8851340203096, 3287.079617707043, 3310.4041272570958, 3316.0941567653404, 4481.046143096006, 4577.816887324503, 5272.23552584875, 5533.474319939604, 5552.944470555293, 5433.239346491494, 5523.917141242885, 5528.612997090206, 5533.667979921208, 5581.2186293918785, 4823.469418363977, 5086.440491545927, 5115.411727651331, 5148.5623721983675, 5151.5878729701535, 5077.136886729247, 5161.535461808437, 5172.405173405069, 5177.611679124062, 5190.558802501791, 5165.483451654842, 5168.173092305232, 5180.197069454241, 5182.818601348954, 5183.948160518403, 5155.2524883892, 5157.6647517911215, 5167.612429067816, 5173.715445650488, 5177.378714554277, 5020.2720605511995, 5112.156494178456, 5118.923216151761, 5150.175971844525, 5150.587952963754, 5120.948790512084, 5619.971900140473, 5660.8867822643315, 5699.2590963174525, 5747.252857128588, 5934.495567876736, 6098.39016098391, 6137.815865523997, 6167.0, 6219.906701399483, 5860.179574859523, 5900.734466948955, 5912.17229587858, 6026.005709058, 6271.560990730651, 3448.5689288838644, 4874.293227481995, 5479.726013699299, 5529.640573362719, 5557.749901254453, 6251.812445626639, 6252.187215661935, 6265.467435268053, 6273.153124328249, 6303.590266632654, 4907.631927605373, 5481.972590137024, 5628.971855140698, 6067.423594758491, 6068.21113255274, 5985.760569577168, 6049.969750151309, 6056.454919057306, 6146.078088286793, 6180.690965451709, 5600.971995139998, 6008.849778755566, 6040.909386359208, 6064.9689552776135, 6095.451409373178, 5007.524285192901, 6129.540284478593, 6164.599301045508, 6181.443670069625, 6185.41238582334, 4858.562729354375, 4883.487233840467, 4892.633052521075, 4893.755312234445, 4931.112399768076, 4248.745075295492, 4275.636570891509, 4306.698531102793, 4332.393464914914, 4342.69601127918, 5680.346760122557, 5809.0, 5811.796587119515, 5817.418258174149, 5842.444967728059, 6123.84690382744, 6134.78528251509, 6135.32511423743, 6139.140520327158, 6162.198914141222, 5573.470520300565, 5630.40880707528, 5747.942520574825, 5767.682777447197, 5797.130430435384, 5270.578353731692, 5293.814716484904, 5316.229146773773, 5345.037893179187, 5353.491418315254, 5460.672359658433, 6140.044157167629, 6221.96889015552, 6266.49868010558, 6336.429721324918, 6149.723262453111, 6198.0, 6199.5660303780105, 6209.875802484015, 6230.563860529719, 6167.784127555514, 6263.530235232467, 6279.623222606659, 6282.748690052529, 6301.684915754286, 5015.673981191211, 5959.67221802805, 6084.665343406155, 6091.451769340781, 6114.938850611615, 6121.3878612140215, 6168.537359697951, 6186.4741496971465, 6196.0, 6229.909765791059, 5919.970400148144, 6020.969895150496, 6023.156758053964, 6037.0642550404755, 6042.274927008787, 5744.626599271034, 5796.0436527972415, 5819.272590926134, 5900.734466948912, 5939.821805345847, 4456.6657500688225, 4492.752898590478, 5763.394843541536, 5873.060310350324, 5890.734916928663, 5998.520118390431, 6024.849378765566, 6036.456718895145, 6041.24484439445, 6069.150318955261, 5671.8865622688145, 5710.628809127394, 5827.388124246893, 5833.4749872511675, 5864.179014937998], "value": 5528.021656887688, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.88663174311165, 483.88144904498404, 505.15638883065276, 509.44470527125424, 510.8722819295176, 32701.836490817543, 40033.39949900754, 40101.598984010154, 40131.79934100326, 40340.39489407658, 41164.38253426201, 41604.631513691005, 41672.95817604561, 41715.37426938598, 41961.37057944133, 8378.958105209465, 8590.527520986343, 9257.722268331943, 9444.716658500256, 9459.479728614924, 11123.666290011271, 11399.145064120183, 11444.656660300205, 11464.025557827596, 11637.836216378379, 10285.125764310043, 10647.52086156121, 11323.660290191307, 11422.600208992686, 11448.71378215543, 11361.318320900773, 11414.31514109152, 11432.799556046662, 11450.65648030552, 11469.967702906779, 11184.874873773957, 11208.327500349924, 11272.718182045432, 11273.098152147808, 11296.717582060432, 38684.613153868384, 39007.0, 39133.0, 39218.41172382417, 39224.0, 3315.419801534746, 3941.2708648899757, 3976.980115099406, 3991.5409727881083, 4118.732282401635, 29442.0, 30027.69972300271, 30057.098287051424, 30059.849700751358, 30122.0, 3209.5988001499813, 3225.145336485833, 3279.344131173751, 3307.3881331953667, 3333.933321333584, 465324.3467565315, 466175.0, 466756.0, 469215.0, 469842.6507867473, 57514.411851466786, 57835.0, 57927.13109303364, 58344.70827645835, 58540.82918341694, 60357.39642603606, 60675.0, 60995.39004609897, 61020.38979610236, 61130.694346527984, 14633.926830365994, 14812.481563145238, 14844.62888427798, 14851.925740371445, 14853.777193342108, 10538.367697938149, 10784.676459706221, 11418.915203055696, 11554.480048397842, 11661.416929153509, 12870.034747393984, 16012.119333436773, 16029.438969636007, 16044.67910641804, 16174.919125404533, 7148.571085734872, 7195.748148814766, 7206.855862882713, 7248.710051597877, 7255.927440725525, 789.7788619186522, 845.9830803383898, 846.9364797640202, 848.2026894718945, 864.0840708848641, 29535.0, 31272.218194544865, 31974.200644984063, 32116.0, 33008.66991330056, 970.2626004236831, 1049.2130901823632, 1058.1534772182376, 1063.6543123484898, 1151.4357964597286, 14761.188134652482, 15207.923960380349, 15222.923885380502, 15477.380904763684, 15639.609009774618, 617789.0, 631722.0, 633272.0, 635610.8219458966, 638853.1146885367, 56602.43397565972, 56779.71610141923, 57552.0, 57672.0, 57722.0, 1386.6741315790782, 1413.7243237568575, 1421.516684327313, 1422.2675322209277, 1436.5977526292654, 27941.441171176055, 28628.427431450837, 28959.85520072386, 29566.113016609535, 29734.55398168986, 50071.248931265334, 50559.49440505548, 50680.746596266785, 50851.49148508615, 50901.0, 494937.0506294891, 495703.0, 496336.0, 496835.0, 497225.0277497179, 33784.0, 34649.48025779565, 38585.0, 40389.79805100956, 40886.1822763549, 44722.55277447314, 44839.0, 44862.10275794531, 45192.0, 45839.77080114711, 29404.0, 29931.700682993764, 37578.812105940386, 37624.62375376211, 38233.0, 37399.065023374635, 37575.624243758306, 38375.80812095922, 38562.80718596389, 38605.0, 26944.595831062943, 29098.0, 35972.4604130933, 36187.457188142725, 36906.44640330344, 32785.672143278265, 33539.83230083834, 33581.664183357854, 34074.829625852704, 34172.48741268833, 22422.439439014157, 24173.758262417854, 24485.510289793747, 24835.62746558767, 24980.750192497842], "value": 19814.17283214564, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.4267096587421, 365.68002997377295, 371.1833965276391, 388.86195400632795, 394.8677193140298, 16797.412090576832, 18069.277228910843, 18645.347412840554, 18854.057297135158, 19734.90132549339, 17865.0, 20911.895440522778, 21465.570688586256, 21520.354389368305, 21972.89013554934, 6362.681865906709, 6617.106690596756, 6665.733370665168, 6683.431908287801, 7259.927400725978, 7487.625618719069, 7674.079110506719, 7677.961610191941, 7694.846103077935, 7715.344195743369, 7457.440691948099, 7589.848203035936, 7604.467687261894, 7687.654055567485, 7697.730579429721, 7372.815679608026, 7592.658330375147, 7628.54228746277, 7647.158812530617, 7699.345555627779, 6252.6873656317, 7137.750178743771, 7416.147143078507, 7448.106227252711, 7451.366633836131, 26384.8680756595, 26445.47109057808, 27223.77493012819, 27377.0, 27853.86073069642, 2760.2823265950997, 2930.2207612009483, 2938.5592161175996, 2944.8822047118306, 2964.733174014349, 16065.036097834167, 16218.351265949348, 16606.50180494587, 16745.99048114222, 17134.571635709082, 1939.7478327817435, 1979.6535606268844, 1997.8901160436171, 1999.8700084494608, 2002.5594369238745, 108302.0, 115745.0, 130478.0, 136055.0, 138652.0, 14909.70180596382, 16861.747073793904, 21617.78382216189, 21642.70143791346, 21917.890410547847, 33959.66040339565, 34862.0, 35045.47431788525, 35046.649533504846, 35080.47379289313, 8501.872471912926, 9634.855477167848, 9912.256580756472, 10261.538230779634, 10404.427756473315, 6829.692663830139, 7072.92927070733, 8112.797180070545, 8221.630026648816, 8261.504309741435, 8221.712240071689, 9570.234381249484, 9769.658061967939, 9969.651062212788, 10011.949940250397, 3590.389633762267, 3655.4151335786146, 3880.243352546283, 3909.9413508797393, 3931.68546516278, 757.5530437042172, 758.9962050189714, 958.4105774948357, 963.9637389805987, 968.7820240445984, 18866.679662313003, 19943.700844487343, 20007.399778006682, 20133.0, 20321.0, 910.3263584947091, 924.5007695844168, 933.5285680731188, 963.4652767713845, 975.302658599105, 7355.0, 10130.949345253226, 10560.419176945341, 10580.206484513692, 10668.573257069786, 517163.0, 528553.0, 539593.0, 544748.0, 563082.3691763112, 94516.52741736248, 95887.0, 100993.0, 123582.0, 127012.0, 977.9559919803626, 1002.218269749582, 1031.5564307347763, 1033.6537260017828, 1034.462079718557, 18999.145038473027, 19101.90449047746, 19318.03409829531, 19320.13059412358, 19367.515812104248, 42377.0, 47837.76081119711, 49997.75001124971, 51232.74383628058, 51521.71195720137, 71288.0, 72645.66818940511, 73521.6323918377, 74862.62568687122, 75298.0, 7595.848083038419, 7862.2923936845955, 8054.597270136353, 8106.675732970615, 8159.06170790343, 11567.768644626893, 11594.01450876685, 12079.637610871689, 12485.500579977062, 12518.0, 9679.467629280458, 9843.901560984299, 10507.0, 10830.18773591968, 10995.615153469591, 6217.782377616762, 6315.55791094619, 10663.733406664585, 10726.302790318605, 10738.624148154777, 10079.244056695923, 10831.67504974852, 10998.725031873948, 11071.1696622752, 11280.0, 7817.257360550739, 7825.295723384923, 8017.8797318039105, 8023.59882005909, 8045.0, 7980.521168729895, 10353.482325883826, 10539.63111291101, 10830.0, 10885.0], "value": 10635.117341213945, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1196.9521219151225, 1320.1946812444407, 1390.5967269491848, 1394.8605139486046, 1405.100735529261, 7456.739014134507, 7754.2633449822315, 7894.7236846710375, 8342.95828520858, 8354.331653467723, 7933.127355990837, 8151.714689985852, 8203.30271926887, 8227.794305142374, 8239.464434811733, 2273.465735552148, 2291.3355127013147, 2329.6738456616085, 2338.018032426385, 2338.0647740903605, 2063.7110804487384, 2293.128611127769, 2325.5232677301196, 2339.6139636959883, 2352.3060697094397, 2081.198738485686, 2222.48882756966, 2302.746697863242, 2311.399036250579, 2313.641385585237, 2271.3186044186677, 2286.314105768263, 2287.565362581104, 2297.5864344417996, 2299.701038864945, 2297.1730177136383, 2308.2613563659634, 2330.976690233093, 2333.5916214662534, 2345.3081341004445, 7268.745593904241, 8083.070446898623, 8289.0467596226, 8304.792380190484, 8310.8337833243, 4929.704217746911, 5167.948320516784, 5174.922376164361, 5181.119209734316, 5181.378234611833, 3367.090885460912, 3371.6965473107293, 3445.982770086159, 3460.602030766469, 3514.3147086318177, 1058.439027315524, 1178.7347846734501, 1193.421190722499, 1228.7419641875217, 1237.777200103981, 10640.46797660114, 10689.679309620724, 10777.83833242502, 10786.191035672357, 10806.51370688313, 4095.5904409558807, 4248.745075295492, 4293.248681480791, 4398.582134697199, 4460.0, 8634.5251011195, 8691.130886911258, 8697.913020869837, 8720.389572729975, 8725.432846864933, 4945.109880221523, 4945.55490005894, 4946.678465899705, 4956.132676781621, 4977.502249774993, 4560.247559152769, 4600.194965880957, 4634.6987445816585, 4643.883902902387, 4675.696079754805, 3659.688926441229, 3666.1018050577777, 3710.870119545803, 3715.777053376806, 3743.2700623378723, 1070.4112737994071, 1084.414416215235, 1147.8450409194818, 1153.411760002388, 1155.6013175454455, 629.8645791154923, 732.2421293960725, 745.4558172533972, 759.5936174146805, 766.7278116268644, 4802.27965805125, 5181.35233095863, 5311.521963023347, 5720.599558030898, 5781.699117698484, 467.76976551668895, 521.9164933610604, 548.3912856729028, 548.8353493951798, 610.4749915073033, 2943.925467204455, 3530.770499917497, 3775.679067279312, 3849.40334248192, 3871.632194941476, 9488.525573721286, 9918.156956658764, 9926.900730992742, 9953.701388958343, 9969.155706194377, 9731.756706082262, 9858.260630452745, 9886.15967642744, 9888.505574721235, 9935.254855885838, 7297.9635101825215, 7553.8866916996285, 7714.919911212435, 7750.689972401154, 7825.413094017971, 4628.213203755437, 5551.306086739158, 5678.290213723285, 5777.277840269966, 5849.0, 7591.658375373011, 9051.864222036544, 9211.40125891815, 9251.444913305224, 9348.626054957726, 7647.732329368446, 9151.267898568232, 9421.434713917188, 9459.952700236454, 9483.099105584959, 7140.178879428932, 7284.890726639211, 7291.781246562611, 7299.781006569811, 7306.123265208209, 7715.652795624323, 7791.766247012599, 7859.371250299848, 7864.72473463426, 7866.213378662317, 6986.54587451814, 7063.929360706327, 7071.186813516511, 7115.75094871677, 7200.531965422231, 6901.89647155283, 6987.0, 6989.860202796017, 7004.579725216503, 7046.365827075588, 6277.246730392382, 6396.520260980352, 6405.967970160119, 6408.871822563429, 6447.871042579029, 4234.301340278819, 4273.957260427356, 4276.444062271885, 4379.978100109479, 4397.0, 4667.276572131325, 4874.171390863491, 4897.583705385082, 4950.331705219894, 5016.4231113420965], "value": 4220.9930130818775, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.4721972646501, 349.8425708431205, 353.2070501723631, 360.26890789755214, 361.51556913735607, 4332.956670433295, 4901.387326584177, 5289.338832645919, 5299.9205011924805, 5388.7305634718305, 4284.614384705376, 4653.464851542074, 5214.426413094557, 5388.946110538894, 5405.783768649249, 3899.883003509892, 4052.837886484537, 4063.2889244382263, 4071.857484988026, 4098.221337945781, 3428.2974387661266, 3748.8125593720206, 3964.464797252363, 4091.8083894562287, 4154.688398370119, 4097.323941549641, 4102.220578090169, 4105.2405305018665, 4122.113745544707, 4145.8963525911795, 2856.571514272855, 3530.082178633548, 3552.868279032573, 3667.0, 3971.3050216212046, 2856.985715071432, 3115.43922094023, 3148.795328303653, 3384.4415671414185, 3440.36353274645, 4308.763018034007, 4860.343853579757, 5158.458361872024, 5190.169572868323, 5190.480951904817, 3864.439656249856, 4357.268020907673, 4559.931601025987, 4569.611583015448, 4585.610223131038, 5098.603656281579, 5521.613487055908, 5540.889182216373, 5586.972065139689, 5642.351129620105, 3770.6606405423645, 3776.773393596393, 3790.692211187136, 3792.829322680486, 3803.695704343646, 5889.823305300805, 5922.3485416604135, 5932.406759324076, 5969.089891234807, 6103.633781973096, 3487.9651203487642, 3587.192881601671, 3800.790956497364, 3805.238952209569, 3823.923521529554, 3261.3803377358226, 3847.8653247136776, 3858.9614103858603, 3873.7288389812443, 3882.641075623509, 4531.909361812745, 4532.070925460339, 4543.068670922453, 4564.315352697122, 4580.152671755736, 5249.606279529051, 5567.220589117527, 5602.355729091125, 5634.436556344414, 5649.548036157097, 1087.4617064553097, 1095.5343978808974, 1232.1498166265249, 1254.5609036837034, 1262.2489618676873, 743.0229248538155, 793.476305638276, 807.7237964016839, 839.4795226959202, 853.6542700206427, 4216.746995180299, 4644.581987621063, 5216.347956505437, 5301.065111234372, 5389.892202156013, 4914.8771280718265, 5143.177091665316, 5770.769169233267, 5828.854278642983, 5851.707414629252, 4576.58810707038, 4717.716936983792, 5357.758900849393, 5359.981603495324, 5372.838814835562, 2460.683534309136, 2564.564024115905, 2906.593076969226, 2935.515639919432, 2949.0, 4823.0, 5840.065589505659, 5908.497777688859, 5908.645481271052, 5923.763049478059, 4592.586667199901, 5449.100898351807, 5777.768889244383, 5778.422157784188, 5996.340402555716, 5354.866128346823, 5357.383900851452, 5829.242198514251, 6032.577719559677, 6036.396360363929, 5084.872803226063, 5650.604457687922, 5788.27646544182, 5834.416558344132, 5857.0, 5714.8281754320415, 5715.514181294637, 5758.782868595537, 5776.508996735324, 5828.504577110993, 5138.8972220556125, 5288.286081378965, 5787.218725472176, 5867.119932010062, 5959.553033522417, 3555.8755443559353, 3806.3529200036614, 4098.200850834178, 4121.423000779833, 4148.481439820022, 4733.680496556732, 5726.484616384545, 5743.56923230751, 5757.309122905278, 5832.329282132439, 4444.066830928557, 4501.504834468271, 4734.810607575659, 5348.304720386325, 5599.692016939108, 5265.657732247545, 5339.866503337447, 5595.720213989365, 5621.915671264853, 5679.517241034393, 4934.519644106682, 5012.674176178537, 5424.891502170013, 5543.916841247304, 5571.264425238515, 4453.888652783707, 4655.743934083658, 5312.548433383051, 5514.36584792754, 5671.943280567307, 4660.510646382081, 4784.712917224978, 5144.765256338526, 5559.388467268678, 5564.610477266552], "value": 4024.5861403109725, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.6555446172915, 706.9116360454943, 720.6865013719032, 768.5119948832491, 824.5300178898027, 13667.0, 14369.281535923188, 14396.784048239258, 14406.35171417286, 14498.347574359153, 14121.0, 14272.0, 14317.427302907898, 14336.928315358435, 14366.569002929902, 689.1695506914182, 715.5277516838887, 726.4733068525329, 837.4975014991018, 874.8512752832002, 857.2841677199546, 878.6002368922125, 881.3610132653839, 882.8675698645222, 885.6767279942807, 932.4731526687434, 932.7668082979255, 933.9813203735921, 939.0890835889177, 943.5895385507326, 913.1918252346654, 926.2636204217663, 929.8605209218604, 933.6452148183647, 936.6393938333722, 682.9043933849265, 690.5752961928378, 698.7554355975368, 699.3565919354155, 700.5411455496658, 13595.456181752717, 14347.928260358736, 14796.778048329285, 14803.703925921529, 15100.320485578066, 13864.792028119586, 14417.351219195161, 14438.711225775425, 14460.204688742115, 14547.3453694584, 9372.26770526989, 10406.271560990657, 11642.76714465706, 11679.124065695107, 11712.765744685144, 2698.0, 3627.075095850568, 3708.165662725892, 3711.6102809205186, 3735.7571757835653, 102530.48734756352, 104569.0, 105426.47286763517, 105861.35346616319, 106012.93987060108, 10819.0, 10954.287971281841, 10968.23222374442, 11097.722556936142, 11155.776884462266, 22697.205597803997, 22939.541209176055, 22941.0, 22986.8850655749, 23012.65481017786, 7773.5724535149975, 7834.686612535549, 7845.490043147177, 7913.248241417056, 8007.839843203104, 4159.9376009359885, 4284.293091639907, 4322.502912165141, 4341.891452713708, 4341.979634785823, 3357.916052098717, 3402.6086999994823, 3411.1301618087723, 3442.535257740223, 3445.2764919366714, 639.4500729372736, 641.0864518061743, 643.3919945651314, 646.3278190681639, 648.0667838312909, 503.5241696596681, 578.1991941161522, 611.538288592119, 621.4841681404423, 636.4017823246134, 8582.0, 8613.353998450142, 8683.0, 8981.0, 9118.908810911806, 439.3080897586314, 495.6109454078531, 515.8684535443438, 538.9705662185286, 560.2268819187227, 4201.411802347674, 4237.864680322781, 4459.308807134899, 4478.552144785495, 4618.538146185355, 98701.0, 101229.49385253027, 101328.0, 102053.48973255086, 105926.47036764766, 62365.0, 83352.0, 83572.0, 84514.57742711247, 84666.0, 76950.84573731398, 77565.44869102699, 78664.21335786683, 78674.0, 80935.97660058546, 8629.125788323563, 8727.607257673548, 8775.166359195866, 8787.472751634923, 8818.98581663117, 48941.02117957692, 50593.49406506035, 51044.0, 51577.0, 52354.738226308626, 56001.71999140141, 68264.6586767063, 69048.6547567259, 69982.0, 71634.64182679054, 10339.277859970554, 11561.7109572258, 11600.477978491157, 11601.593944211912, 12171.087168462223, 10810.243282970117, 11290.322580645188, 12622.0, 12640.620781376574, 12666.050046246384, 10564.735881603021, 10975.176861735561, 11870.762584748429, 12032.27806331623, 12359.3820308986, 9149.542522873962, 11742.70643233926, 11766.764664706829, 11940.701482463008, 12217.389130543259, 11598.826017609912, 11709.941450293034, 11863.525458981545, 11878.881211188123, 12376.07179461526, 9435.669751558662, 9697.175740062174, 9737.561809718438, 9812.754681132743, 9836.508174591385, 9132.954335228547, 9587.328886977844, 9638.228941684509, 9642.662506812509, 9702.5148742564], "value": 7089.781595007038, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1628.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 172.0, 163.0, 119.0, 118.0, 162.0, 98.0, 141.0, 174.0, 175.0], "value": 146.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 113.0, 99.0, 191.0, 100.0, 97.0, 106.0, 134.0, 161.0, 148.0], "value": 129.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 225.0, 194.0, 196.0, 199.0, 204.0, 199.0, 195.0, 199.0, 199.0], "value": 201.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 59.0, 85.0, 62.0, 61.0, 65.0, 62.0, 72.0, 61.0], "value": 66.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 72.0, 84.0, 73.0, 73.0, 74.0, 111.0, 101.0, 102.0, 96.0], "value": 87.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 89.0, 85.0, 91.0, 90.0, 90.0, 87.0, 95.0, 134.0], "value": 93.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 119.0, 173.0, 136.0, 100.0, 100.0, 99.0, 100.0, 100.0, 100.0], "value": 116.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 115.0, 91.0, 91.0, 114.0, 146.0, 93.0, 92.0, 92.0, 97.0], "value": 102.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 62.0, 62.0, 63.0, 64.0, 61.0, 66.0, 65.0, 72.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 106.0, 69.0, 105.0, 114.0, 104.0, 77.0, 71.0, 72.0, 71.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 108.0, 116.0, 114.0, 82.0, 93.0, 88.0, 92.0, 89.0, 98.0], "value": 98.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 164.0, 157.0, 162.0, 143.0, 142.0, 143.0, 159.0, 236.0, 190.0], "value": 164.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 179.0, 176.0, 173.0, 192.0, 155.0, 215.0, 172.0, 223.0, 244.0], "value": 190.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 71.0, 74.0, 83.0, 92.0, 91.0, 88.0, 67.0, 74.0, 90.0], "value": 80.7, "unit": "score"}]}]} 08:22:46 INFO - Return code: 0 08:22:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:22:46 ERROR - # TBPL SUCCESS # 08:22:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:22:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:22:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:22:46 INFO - 2016-12-27 08:22:46.650 screenresolution[1997:24317] starting screenresolution argv=screenresolution get 08:22:46 INFO - 2016-12-27 08:22:46.653 screenresolution[1997:24317] Display 0: 1600x1200x32@60 08:22:46 INFO - 2016-12-27 08:22:46.659 screenresolution[1998:24320] starting screenresolution argv=screenresolution list 08:22:46 INFO - Available Modes on Display 0 08:22:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:22:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:22:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:22:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:22:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:22:46 INFO - Intel Iris: 08:22:46 INFO - Chipset Model: Intel Iris 08:22:46 INFO - Type: GPU 08:22:46 INFO - Bus: Built-In 08:22:46 INFO - VRAM (Dynamic, Max): 1536 MB 08:22:46 INFO - Vendor: Intel (0x8086) 08:22:46 INFO - Device ID: 0x0a2e 08:22:46 INFO - Revision ID: 0x0009 08:22:46 INFO - Displays: 08:22:46 INFO - Display: 08:22:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:22:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:22:46 INFO - Display Serial Number: 1600x1200 60 08:22:46 INFO - Main Display: Yes 08:22:46 INFO - Mirror: Off 08:22:46 INFO - Online: Yes 08:22:46 INFO - Rotation: Supported 08:22:46 INFO - Return code: 0 08:22:46 INFO - Running post-action listener: _resource_record_post_action 08:22:46 INFO - [mozharness: 2016-12-27 16:22:46.907699Z] Finished run-tests step (success) 08:22:46 INFO - Running post-run listener: _resource_record_post_run 08:22:46 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 634880; Write bytes: 552415744; Read time: 5; Write time: 1673 08:22:46 INFO - TinderboxPrint: CPU usage
54.4% 08:22:46 INFO - TinderboxPrint: I/O read bytes / time
634,880 / 5 08:22:46 INFO - TinderboxPrint: I/O write bytes / time
552,415,744 / 1,673 08:22:46 INFO - TinderboxPrint: CPU idle
2,188.1 (45.6%) 08:22:46 INFO - TinderboxPrint: CPU system
968.7 (20.2%) 08:22:46 INFO - TinderboxPrint: CPU user
1,644.9 (34.3%) 08:22:46 INFO - TinderboxPrint: Swap in / out
249,139,200 / 0 08:22:46 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 228481536; Write bytes: 221024256; Read time: 16480; Write time: 461 08:22:46 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 634880; Write bytes: 302318080; Read time: 5; Write time: 1143 08:22:47 INFO - Running post-run listener: _upload_blobber_files 08:22:47 INFO - Blob upload gear active. 08:22:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:22:47 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 08:22:47 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:22:47 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:22:47 INFO - (blobuploader) - INFO - Open directory for files ... 08:22:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:22:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:22:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:22:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:22:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:22:48 INFO - (blobuploader) - INFO - Done attempting. 08:22:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:22:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:22:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:22:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:22:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:22:49 INFO - (blobuploader) - INFO - Done attempting. 08:22:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:22:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:22:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:22:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:22:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:22:50 INFO - (blobuploader) - INFO - Done attempting. 08:22:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:22:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:22:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:22:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:22:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:22:52 INFO - (blobuploader) - INFO - Done attempting. 08:22:52 INFO - (blobuploader) - INFO - Iteration through files over. 08:22:52 INFO - Return code: 0 08:22:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:22:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:22:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bec02ddc259ba65ff7f301c3c6c7018967127922f3c208c427cf76df3e6f3f8e8f71583f34decde1e0e3af75a40c6e0dfea0ead11aa3c987b4ee8a727a63b4e6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe3c25bfac822ff2000747f41e663a4f0f9f37af312f7cfbf789e0b8da13b7c8255c30ba427baef052cfdca47ebbc9e9f198b22737c8b29fda881645a555cc8f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b53e6f9d937c10906a2781149ae0db2a580f8c8364177c223ad49d89fb94338dc3c7729931c7e00fe8400f8713b7a514d33a90ee5b87477d3be5a5dddba3a04", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51ed4ed3cb5dc1313f4dc2932d07b485b1aa0fc24c746a801e78f261168bb45155686075e70ba23fa4573b78fe4a9c122b29a88e183c502bde5d19b86ca801c4"} 08:22:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:22:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:22:52 INFO - Contents: 08:22:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bec02ddc259ba65ff7f301c3c6c7018967127922f3c208c427cf76df3e6f3f8e8f71583f34decde1e0e3af75a40c6e0dfea0ead11aa3c987b4ee8a727a63b4e6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe3c25bfac822ff2000747f41e663a4f0f9f37af312f7cfbf789e0b8da13b7c8255c30ba427baef052cfdca47ebbc9e9f198b22737c8b29fda881645a555cc8f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b53e6f9d937c10906a2781149ae0db2a580f8c8364177c223ad49d89fb94338dc3c7729931c7e00fe8400f8713b7a514d33a90ee5b87477d3be5a5dddba3a04", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51ed4ed3cb5dc1313f4dc2932d07b485b1aa0fc24c746a801e78f261168bb45155686075e70ba23fa4573b78fe4a9c122b29a88e183c502bde5d19b86ca801c4"} 08:22:52 INFO - Running post-run listener: copy_logs_to_upload_dir 08:22:52 INFO - Copying logs to upload dir... 08:22:52 INFO - mkdir: /builds/slave/test/build/upload/logs 08:22:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.128748 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-12-27 08:22:52.955596) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-27 08:22:52.959115) ========= 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.LQUadoY5zF/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.MfEb9mXvyA/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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/Firefox/sha512/bec02ddc259ba65ff7f301c3c6c7018967127922f3c208c427cf76df3e6f3f8e8f71583f34decde1e0e3af75a40c6e0dfea0ead11aa3c987b4ee8a727a63b4e6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe3c25bfac822ff2000747f41e663a4f0f9f37af312f7cfbf789e0b8da13b7c8255c30ba427baef052cfdca47ebbc9e9f198b22737c8b29fda881645a555cc8f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b53e6f9d937c10906a2781149ae0db2a580f8c8364177c223ad49d89fb94338dc3c7729931c7e00fe8400f8713b7a514d33a90ee5b87477d3be5a5dddba3a04", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51ed4ed3cb5dc1313f4dc2932d07b485b1aa0fc24c746a801e78f261168bb45155686075e70ba23fa4573b78fe4a9c122b29a88e183c502bde5d19b86ca801c4"} build_url:https://queue.taskcluster.net/v1/task/IcDfeMPSQpuREzSUetvSmg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011207 build_url: 'https://queue.taskcluster.net/v1/task/IcDfeMPSQpuREzSUetvSmg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bec02ddc259ba65ff7f301c3c6c7018967127922f3c208c427cf76df3e6f3f8e8f71583f34decde1e0e3af75a40c6e0dfea0ead11aa3c987b4ee8a727a63b4e6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe3c25bfac822ff2000747f41e663a4f0f9f37af312f7cfbf789e0b8da13b7c8255c30ba427baef052cfdca47ebbc9e9f198b22737c8b29fda881645a555cc8f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b53e6f9d937c10906a2781149ae0db2a580f8c8364177c223ad49d89fb94338dc3c7729931c7e00fe8400f8713b7a514d33a90ee5b87477d3be5a5dddba3a04", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51ed4ed3cb5dc1313f4dc2932d07b485b1aa0fc24c746a801e78f261168bb45155686075e70ba23fa4573b78fe4a9c122b29a88e183c502bde5d19b86ca801c4"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-27 08:22:52.998248) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 08:22:52.998721) ========= 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.LQUadoY5zF/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.MfEb9mXvyA/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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.004649 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 08:22:53.050269) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-27 08:22:53.051042) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-27 08:22:53.051731) ========= ========= Total master_lag: 0.21 =========