builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0096 starttime: 1486226861.82 results: success (0) buildid: 20170204072808 builduid: a6da0a684944457d99a4874325e8d6df revision: f20caa37abca28b8f031eaebb6176948bb76fec5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-04 08:47:41.817995) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-04 08:47:41.818477) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-04 08:47:41.818753) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-04 08:47:41.843363) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 08:47:41.843735) ========= 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.TvhCkkk9NV/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.R9bHXAHA3C/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-04 08:47:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 155M=0s 2017-02-04 08:47:41 (155 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.075821 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 08:47:41.943525) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 08:47:41.943892) ========= 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.TvhCkkk9NV/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.R9bHXAHA3C/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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.019871 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 08:47:41.993131) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-04 08:47:41.993489) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f20caa37abca28b8f031eaebb6176948bb76fec5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f20caa37abca28b8f031eaebb6176948bb76fec5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TvhCkkk9NV/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.R9bHXAHA3C/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-04 08:47:42,061 truncating revision to first 12 chars 2017-02-04 08:47:42,061 Setting DEBUG logging. 2017-02-04 08:47:42,061 attempt 1/10 2017-02-04 08:47:42,061 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f20caa37abca?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-04 08:47:43,512 unpacking tar archive at: mozilla-aurora-f20caa37abca/testing/mozharness/ program finished with exit code 0 elapsedTime=1.688660 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-04 08:47:43.705686) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-04 08:47:43.706025) ========= script_repo_revision: f20caa37abca28b8f031eaebb6176948bb76fec5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-04 08:47:43.710505) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-04 08:47:43.710825) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-04 08:47:43.733718) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-02-04 08:47:43.734105) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TvhCkkk9NV/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.R9bHXAHA3C/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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:47:43 INFO - MultiFileLogger online at 20170204 08:47:43 in /builds/slave/test 08:47:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:47:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:47:43 INFO - {'append_to_log': False, 08:47:43 INFO - 'base_work_dir': '/builds/slave/test', 08:47:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:47:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:47:43 INFO - 'branch': 'Mozilla-Aurora', 08:47:43 INFO - 'buildbot_json_path': 'buildprops.json', 08:47:43 INFO - 'config_files': ('talos/mac_config.py',), 08:47:43 INFO - 'default_actions': ('clobber', 08:47:43 INFO - 'read-buildbot-config', 08:47:43 INFO - 'download-and-extract', 08:47:43 INFO - 'populate-webroot', 08:47:43 INFO - 'create-virtualenv', 08:47:43 INFO - 'install', 08:47:43 INFO - 'run-tests'), 08:47:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:47:43 INFO - 'download_minidump_stackwalk': True, 08:47:43 INFO - 'download_symbols': 'ondemand', 08:47:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:47:43 INFO - 'tooltool.py': '/tools/tooltool.py', 08:47:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:47:43 INFO - '/tools/misc-python/virtualenv.py')}, 08:47:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:47:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:47:43 INFO - 'installer_path': 'installer.exe', 08:47:43 INFO - 'log_level': 'info', 08:47:43 INFO - 'log_name': 'talos', 08:47:43 INFO - 'log_to_console': True, 08:47:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:47:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:47:43 INFO - 'opt_config_files': (), 08:47:43 INFO - 'pip_index': False, 08:47:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:47:43 INFO - 'cmd': ('bash', 08:47:43 INFO - '-c', 08:47:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:47:43 INFO - 'enabled': True, 08:47:43 INFO - 'halt_on_failure': False, 08:47:43 INFO - 'name': 'check_screen_resolution'},), 08:47:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:47:43 INFO - 'cmd': ('bash', 08:47:43 INFO - '-c', 08:47:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:47:43 INFO - 'enabled': True, 08:47:43 INFO - 'halt_on_failure': False, 08:47:43 INFO - 'name': 'check_screen_resolution'},), 08:47:43 INFO - 'run_cmd_checks_enabled': True, 08:47:43 INFO - 'sps_profile': False, 08:47:43 INFO - 'sps_profile_interval': 0, 08:47:43 INFO - 'suite': 'dromaeojs-e10s', 08:47:43 INFO - 'system_bits': '32', 08:47:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:47:43 INFO - 'title': 't-yosemite-r7-0096', 08:47:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:47:43 INFO - 'use_talos_json': True, 08:47:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:47:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:47:43 INFO - 'work_dir': 'build'} 08:47:43 INFO - [mozharness: 2017-02-04 16:47:43.945480Z] Running clobber step. 08:47:43 INFO - Running pre-action listener: _resource_record_pre_action 08:47:43 INFO - Running main action method: clobber 08:47:43 INFO - rmtree: /builds/slave/test/build 08:47:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:47:44 INFO - Running post-action listener: _resource_record_post_action 08:47:44 INFO - [mozharness: 2017-02-04 16:47:44.126655Z] Finished clobber step (success) 08:47:44 INFO - [mozharness: 2017-02-04 16:47:44.126786Z] Running read-buildbot-config step. 08:47:44 INFO - Running pre-action listener: _resource_record_pre_action 08:47:44 INFO - Running main action method: read_buildbot_config 08:47:44 INFO - Using buildbot properties: 08:47:44 INFO - { 08:47:44 INFO - "project": "", 08:47:44 INFO - "product": "firefox", 08:47:44 INFO - "script_repo_revision": "production", 08:47:44 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 08:47:44 INFO - "repository": "", 08:47:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 08:47:44 INFO - "buildid": "20170204072808", 08:47:44 INFO - "pgo_build": "False", 08:47:44 INFO - "basedir": "/builds/slave/test", 08:47:44 INFO - "buildnumber": 38, 08:47:44 INFO - "slavename": "t-yosemite-r7-0096", 08:47:44 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 08:47:44 INFO - "platform": "yosemite_r7", 08:47:44 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:47:44 INFO - "branch": "mozilla-aurora", 08:47:44 INFO - "repo_path": "releases/mozilla-aurora", 08:47:44 INFO - "revision": "f20caa37abca28b8f031eaebb6176948bb76fec5", 08:47:44 INFO - "stage_platform": "macosx64", 08:47:44 INFO - "builduid": "a6da0a684944457d99a4874325e8d6df", 08:47:44 INFO - "slavebuilddir": "test" 08:47:44 INFO - } 08:47:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/VhFyK4cgSK2dHGfdHnkhGw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 08:47:44 INFO - Running post-action listener: _resource_record_post_action 08:47:44 INFO - [mozharness: 2017-02-04 16:47:44.129751Z] Finished read-buildbot-config step (success) 08:47:44 INFO - [mozharness: 2017-02-04 16:47:44.129855Z] Running download-and-extract step. 08:47:44 INFO - Running pre-action listener: _resource_record_pre_action 08:47:44 INFO - Running main action method: download_and_extract 08:47:44 INFO - mkdir: /builds/slave/test/build/tests 08:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:44 INFO - trying https://queue.taskcluster.net/v1/task/VhFyK4cgSK2dHGfdHnkhGw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 08:47:44 INFO - Downloading https://queue.taskcluster.net/v1/task/VhFyK4cgSK2dHGfdHnkhGw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:47:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VhFyK4cgSK2dHGfdHnkhGw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 08:47:45 INFO - Downloaded 1199 bytes. 08:47:45 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:47:45 INFO - Using the following test package requirements: 08:47:45 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:47:45 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:47:45 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 08:47:45 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:47:45 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 08:47:45 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:47:45 INFO - u'jsshell-mac.zip'], 08:47:45 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:47:45 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 08:47:45 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:47:45 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:47:45 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 08:47:45 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:47:45 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 08:47:45 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:47:45 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 08:47:45 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:47:45 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 08:47:45 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:47:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VhFyK4cgSK2dHGfdHnkhGw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:47:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VhFyK4cgSK2dHGfdHnkhGw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:47:45 INFO - Fetch https://queue.taskcluster.net/v1/task/VhFyK4cgSK2dHGfdHnkhGw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:47:46 INFO - Expected file size: 16356325 08:47:46 INFO - Obtained file size: 16356325 08:47:53 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:47:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VhFyK4cgSK2dHGfdHnkhGw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:47:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VhFyK4cgSK2dHGfdHnkhGw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:47:53 INFO - Fetch https://queue.taskcluster.net/v1/task/VhFyK4cgSK2dHGfdHnkhGw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:47:54 INFO - Expected file size: 16356325 08:47:54 INFO - Obtained file size: 16356325 08:48:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VhFyK4cgSK2dHGfdHnkhGw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 08:48:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VhFyK4cgSK2dHGfdHnkhGw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:48:01 INFO - Fetch https://queue.taskcluster.net/v1/task/VhFyK4cgSK2dHGfdHnkhGw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 08:48:02 INFO - Expected file size: 14403485 08:48:02 INFO - Obtained file size: 14403485 08:48:02 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:48:02 INFO - trying https://queue.taskcluster.net/v1/task/VhFyK4cgSK2dHGfdHnkhGw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:48:02 INFO - Downloading https://queue.taskcluster.net/v1/task/VhFyK4cgSK2dHGfdHnkhGw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 08:48:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VhFyK4cgSK2dHGfdHnkhGw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 08:48:04 INFO - Downloaded 73831013 bytes. 08:48:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VhFyK4cgSK2dHGfdHnkhGw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:48:04 INFO - mkdir: /builds/slave/test/properties 08:48:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:48:04 INFO - Writing to file /builds/slave/test/properties/build_url 08:48:04 INFO - Contents: 08:48:04 INFO - build_url:https://queue.taskcluster.net/v1/task/VhFyK4cgSK2dHGfdHnkhGw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:48:05 INFO - Running post-action listener: _resource_record_post_action 08:48:05 INFO - Running post-action listener: set_extra_try_arguments 08:48:05 INFO - [mozharness: 2017-02-04 16:48:05.619285Z] Finished download-and-extract step (success) 08:48:05 INFO - [mozharness: 2017-02-04 16:48:05.619449Z] Running populate-webroot step. 08:48:05 INFO - Running pre-action listener: _resource_record_pre_action 08:48:05 INFO - Running main action method: populate_webroot 08:48:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:48:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:48:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:48:05 INFO - '--tppagecycles', 08:48:05 INFO - '7'], 08:48:05 INFO - 'tests': ['tsvgm']}}, 08:48:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:48:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:48:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:48:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:48:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:48:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:48:05 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:48:05 INFO - 'talos_options': ['--disable-e10s'], 08:48:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:48:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:48:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:48:05 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:48:05 INFO - 'talos_options': ['--disable-e10s'], 08:48:05 INFO - 'tests': ['damp', 'tps']}, 08:48:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:48:05 INFO - 'tests': ['damp', 'tps']}, 08:48:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:48:05 INFO - 'tests': ['dromaeo_dom']}, 08:48:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:48:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:48:05 INFO - 'tests': ['basic_compositor_video']}, 08:48:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:48:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:48:05 INFO - 'tests': ['a11yr', 08:48:05 INFO - 'ts_paint', 08:48:05 INFO - 'tpaint', 08:48:05 INFO - 'sessionrestore', 08:48:05 INFO - 'sessionrestore_no_auto_restore', 08:48:05 INFO - 'tabpaint']}, 08:48:05 INFO - 'other-e10s': {'tests': ['a11yr', 08:48:05 INFO - 'ts_paint', 08:48:05 INFO - 'tpaint', 08:48:05 INFO - 'sessionrestore', 08:48:05 INFO - 'sessionrestore_no_auto_restore', 08:48:05 INFO - 'tabpaint']}, 08:48:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:48:05 INFO - 'ts_paint', 08:48:05 INFO - 'tpaint', 08:48:05 INFO - 'sessionrestore', 08:48:05 INFO - 'sessionrestore_no_auto_restore', 08:48:05 INFO - 'tabpaint']}, 08:48:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:48:05 INFO - 'ts_paint', 08:48:05 INFO - 'tpaint', 08:48:05 INFO - 'sessionrestore', 08:48:05 INFO - 'sessionrestore_no_auto_restore', 08:48:05 INFO - 'tabpaint']}, 08:48:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:48:05 INFO - 'tests': ['a11yr', 08:48:05 INFO - 'ts_paint', 08:48:05 INFO - 'tpaint', 08:48:05 INFO - 'sessionrestore', 08:48:05 INFO - 'sessionrestore_no_auto_restore', 08:48:05 INFO - 'tabpaint']}, 08:48:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:48:05 INFO - 'tests': ['a11yr', 08:48:05 INFO - 'ts_paint', 08:48:05 INFO - 'tpaint', 08:48:05 INFO - 'sessionrestore', 08:48:05 INFO - 'sessionrestore_no_auto_restore', 08:48:05 INFO - 'tabpaint']}, 08:48:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:48:05 INFO - 'tests': ['tsvgx', 08:48:05 INFO - 'tsvgr_opacity', 08:48:05 INFO - 'tart', 08:48:05 INFO - 'tscrollx', 08:48:05 INFO - 'cart', 08:48:05 INFO - 'tsvg_static']}, 08:48:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:48:05 INFO - 'tsvgr_opacity', 08:48:05 INFO - 'tart', 08:48:05 INFO - 'tscrollx', 08:48:05 INFO - 'cart', 08:48:05 INFO - 'tsvg_static']}, 08:48:05 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:48:05 INFO - 'talos_options': ['--disable-e10s'], 08:48:05 INFO - 'tests': ['tp5o']}, 08:48:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:48:05 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:48:05 INFO - 'talos_options': ['--disable-e10s', 08:48:05 INFO - '--xperf_path', 08:48:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:48:05 INFO - 'tests': ['tp5n']}, 08:48:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:48:05 INFO - 'talos_options': ['--xperf_path', 08:48:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:48:05 INFO - 'tests': ['tp5n']}}, 08:48:05 INFO - 'talos.zip': {'path': '', 08:48:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:48:05 INFO - Running post-action listener: _resource_record_post_action 08:48:05 INFO - [mozharness: 2017-02-04 16:48:05.638071Z] Finished populate-webroot step (success) 08:48:05 INFO - [mozharness: 2017-02-04 16:48:05.638184Z] Running create-virtualenv step. 08:48:05 INFO - Running pre-action listener: _resource_record_pre_action 08:48:05 INFO - Running main action method: create_virtualenv 08:48:05 INFO - Creating virtualenv /builds/slave/test/build/venv 08:48:05 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:48:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:48:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:48:05 INFO - Using real prefix '/tools/python27' 08:48:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:48:06 INFO - Installing distribute.............................................................................................................................................................................................done. 08:48:09 INFO - Installing pip.................done. 08:48:09 INFO - Return code: 0 08:48:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:48:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:48:09 INFO - Reading from file tmpfile_stdout 08:48:09 INFO - Output received: 08:48:09 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:48:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:48:09 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:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:09 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:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:09 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 0x1098aeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec69d8f950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10968cd30>, '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 0x1095b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109681be8>, '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.TvhCkkk9NV/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.R9bHXAHA3C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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:48:09 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:48:09 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:48:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TvhCkkk9NV/Render', 08:48:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:09 INFO - 'HOME': '/Users/cltbld', 08:48:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:09 INFO - 'LOGNAME': 'cltbld', 08:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:09 INFO - 'MOZ_NO_REMOTE': '1', 08:48:09 INFO - 'NO_EM_RESTART': '1', 08:48:09 INFO - 'PAGER': '/bin/cat', 08:48:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:09 INFO - 'PWD': '/builds/slave/test', 08:48:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:09 INFO - 'SHELL': '/bin/bash', 08:48:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9bHXAHA3C/Listeners', 08:48:09 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 08:48:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:09 INFO - 'USER': 'cltbld', 08:48:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:09 INFO - 'XPC_FLAGS': '0x0', 08:48:09 INFO - 'XPC_SERVICE_NAME': '0', 08:48:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:09 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:48:09 INFO - Cleaning up... 08:48:09 INFO - Return code: 0 08:48:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:48:09 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:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:09 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:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:09 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 0x1098aeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec69d8f950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10968cd30>, '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 0x1095b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109681be8>, '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.TvhCkkk9NV/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.R9bHXAHA3C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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:48:09 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:48:09 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:48:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TvhCkkk9NV/Render', 08:48:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:09 INFO - 'HOME': '/Users/cltbld', 08:48:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:09 INFO - 'LOGNAME': 'cltbld', 08:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:09 INFO - 'MOZ_NO_REMOTE': '1', 08:48:09 INFO - 'NO_EM_RESTART': '1', 08:48:09 INFO - 'PAGER': '/bin/cat', 08:48:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:09 INFO - 'PWD': '/builds/slave/test', 08:48:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:09 INFO - 'SHELL': '/bin/bash', 08:48:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9bHXAHA3C/Listeners', 08:48:09 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 08:48:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:09 INFO - 'USER': 'cltbld', 08:48:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:09 INFO - 'XPC_FLAGS': '0x0', 08:48:09 INFO - 'XPC_SERVICE_NAME': '0', 08:48:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:10 INFO - Downloading/unpacking psutil>=3.1.1 08:48:10 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:48:10 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:48:10 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:48:10 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:48:10 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:48:10 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:48:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:48:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:13 INFO - Installing collected packages: psutil 08:48:13 INFO - Running setup.py install for psutil 08:48:13 INFO - building 'psutil._psutil_osx' extension 08:48:13 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:48:14 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:48:14 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:48:14 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:48:14 INFO - building 'psutil._psutil_posix' extension 08:48:14 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:48:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:48:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:48:14 INFO - ^ 08:48:14 INFO - 1 warning generated. 08:48:14 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:48:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:14 INFO - Successfully installed psutil 08:48:14 INFO - Cleaning up... 08:48:14 INFO - Return code: 0 08:48:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1098aeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec69d8f950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10968cd30>, '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 0x1095b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109681be8>, '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.TvhCkkk9NV/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.R9bHXAHA3C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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:48:14 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:48:14 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:48:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TvhCkkk9NV/Render', 08:48:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:14 INFO - 'HOME': '/Users/cltbld', 08:48:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:14 INFO - 'LOGNAME': 'cltbld', 08:48:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:14 INFO - 'MOZ_NO_REMOTE': '1', 08:48:14 INFO - 'NO_EM_RESTART': '1', 08:48:14 INFO - 'PAGER': '/bin/cat', 08:48:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:14 INFO - 'PWD': '/builds/slave/test', 08:48:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:14 INFO - 'SHELL': '/bin/bash', 08:48:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9bHXAHA3C/Listeners', 08:48:14 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 08:48:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:14 INFO - 'USER': 'cltbld', 08:48:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:14 INFO - 'XPC_FLAGS': '0x0', 08:48:14 INFO - 'XPC_SERVICE_NAME': '0', 08:48:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:48:14 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:48:14 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:48:14 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:48:14 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:48:14 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:48:14 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:48:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:48:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:48:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:48:17 INFO - Installing collected packages: mozsystemmonitor 08:48:17 INFO - Running setup.py install for mozsystemmonitor 08:48:17 INFO - Successfully installed mozsystemmonitor 08:48:17 INFO - Cleaning up... 08:48:17 INFO - Return code: 0 08:48:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:48: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:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48: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:48:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48: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', '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 0x1098aeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec69d8f950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10968cd30>, '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 0x1095b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109681be8>, '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.TvhCkkk9NV/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.R9bHXAHA3C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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:48: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:48: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 jsonschema==2.5.1 08:48:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TvhCkkk9NV/Render', 08:48:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:17 INFO - 'HOME': '/Users/cltbld', 08:48:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:17 INFO - 'LOGNAME': 'cltbld', 08:48:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:17 INFO - 'MOZ_NO_REMOTE': '1', 08:48:17 INFO - 'NO_EM_RESTART': '1', 08:48:17 INFO - 'PAGER': '/bin/cat', 08:48:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:17 INFO - 'PWD': '/builds/slave/test', 08:48:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:17 INFO - 'SHELL': '/bin/bash', 08:48:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9bHXAHA3C/Listeners', 08:48:17 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 08:48:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:17 INFO - 'USER': 'cltbld', 08:48:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:17 INFO - 'XPC_FLAGS': '0x0', 08:48:17 INFO - 'XPC_SERVICE_NAME': '0', 08:48:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:18 INFO - Downloading/unpacking jsonschema==2.5.1 08:48: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:48: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:48: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:48: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:48: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:48: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:48:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:48:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:48:20 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:48:20 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:48:20 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:48:20 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:48:20 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:48:20 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:48:21 INFO - Downloading functools32-3.2.3-2.tar.gz 08:48:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:48:21 INFO - warning: no files found matching '*.txt' 08:48:21 INFO - no previously-included directories found matching 'build' 08:48:21 INFO - no previously-included directories found matching 'dist' 08:48:21 INFO - no previously-included directories found matching '.git*' 08:48:21 INFO - Installing collected packages: jsonschema, functools32 08:48:21 INFO - Running setup.py install for functools32 08:48:21 INFO - warning: no files found matching '*.txt' 08:48:21 INFO - no previously-included directories found matching 'build' 08:48:21 INFO - no previously-included directories found matching 'dist' 08:48:21 INFO - no previously-included directories found matching '.git*' 08:48:21 INFO - Successfully installed jsonschema functools32 08:48:21 INFO - Cleaning up... 08:48:21 INFO - Return code: 0 08:48:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:48:21 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:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:21 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:48:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:21 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 0x1098aeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec69d8f950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10968cd30>, '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 0x1095b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109681be8>, '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.TvhCkkk9NV/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.R9bHXAHA3C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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:48:21 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:48:21 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:48:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TvhCkkk9NV/Render', 08:48:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:21 INFO - 'HOME': '/Users/cltbld', 08:48:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:21 INFO - 'LOGNAME': 'cltbld', 08:48:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:21 INFO - 'MOZ_NO_REMOTE': '1', 08:48:21 INFO - 'NO_EM_RESTART': '1', 08:48:21 INFO - 'PAGER': '/bin/cat', 08:48:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:21 INFO - 'PWD': '/builds/slave/test', 08:48:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:21 INFO - 'SHELL': '/bin/bash', 08:48:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9bHXAHA3C/Listeners', 08:48:21 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 08:48:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:21 INFO - 'USER': 'cltbld', 08:48:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:21 INFO - 'XPC_FLAGS': '0x0', 08:48:21 INFO - 'XPC_SERVICE_NAME': '0', 08:48:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:48:21 INFO - Cleaning up... 08:48:21 INFO - Return code: 0 08:48:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:48:21 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:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:21 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:48:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:21 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 0x1098aeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec69d8f950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10968cd30>, '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 0x1095b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109681be8>, '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.TvhCkkk9NV/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.R9bHXAHA3C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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:48:21 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:48:21 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:48:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TvhCkkk9NV/Render', 08:48:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:21 INFO - 'HOME': '/Users/cltbld', 08:48:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:21 INFO - 'LOGNAME': 'cltbld', 08:48:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:21 INFO - 'MOZ_NO_REMOTE': '1', 08:48:21 INFO - 'NO_EM_RESTART': '1', 08:48:21 INFO - 'PAGER': '/bin/cat', 08:48:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:21 INFO - 'PWD': '/builds/slave/test', 08:48:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:21 INFO - 'SHELL': '/bin/bash', 08:48:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9bHXAHA3C/Listeners', 08:48:21 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 08:48:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:21 INFO - 'USER': 'cltbld', 08:48:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:21 INFO - 'XPC_FLAGS': '0x0', 08:48:21 INFO - 'XPC_SERVICE_NAME': '0', 08:48:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:21 INFO - Downloading/unpacking blobuploader==1.2.4 08:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:21 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:48:21 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:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:24 INFO - Downloading blobuploader-1.2.4.tar.gz 08:48:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:48:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:48:24 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:48:24 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:48:24 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:48:24 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:48:24 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:48:24 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:48:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:48:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:25 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:48:25 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:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:25 INFO - Downloading docopt-0.6.1.tar.gz 08:48:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:48:25 INFO - Installing collected packages: blobuploader, requests, docopt 08:48:25 INFO - Running setup.py install for blobuploader 08:48:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:48:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:48:26 INFO - Running setup.py install for requests 08:48:26 INFO - Running setup.py install for docopt 08:48:26 INFO - Successfully installed blobuploader requests docopt 08:48:26 INFO - Cleaning up... 08:48:26 INFO - Return code: 0 08:48:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48: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:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48: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:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:26 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 0x1098aeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec69d8f950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10968cd30>, '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 0x1095b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109681be8>, '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.TvhCkkk9NV/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.R9bHXAHA3C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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:48:26 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:48:26 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:48:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TvhCkkk9NV/Render', 08:48:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:26 INFO - 'HOME': '/Users/cltbld', 08:48:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:26 INFO - 'LOGNAME': 'cltbld', 08:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:26 INFO - 'MOZ_NO_REMOTE': '1', 08:48:26 INFO - 'NO_EM_RESTART': '1', 08:48:26 INFO - 'PAGER': '/bin/cat', 08:48:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:26 INFO - 'PWD': '/builds/slave/test', 08:48:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:26 INFO - 'SHELL': '/bin/bash', 08:48:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9bHXAHA3C/Listeners', 08:48:26 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 08:48:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:26 INFO - 'USER': 'cltbld', 08:48:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:26 INFO - 'XPC_FLAGS': '0x0', 08:48:26 INFO - 'XPC_SERVICE_NAME': '0', 08:48:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:27 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-w5H54g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:27 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-KZh6_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:27 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-MjGqnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:27 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-ZVqK94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:27 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-8j4nmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:27 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-7mn6VP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:27 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-fcODCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:27 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-JIjsuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:27 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-BHMqjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:28 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-1bux1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:28 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-j56_co-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:28 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-_aRw0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:28 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-oNCAOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:28 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-G7lSJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:28 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-nCR3pH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:28 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-BD5_r9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:28 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-l9H56m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:48:28 INFO - Running setup.py install for manifestparser 08:48:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:48:29 INFO - Running setup.py install for mozcrash 08:48:29 INFO - Running setup.py install for mozdebug 08:48:29 INFO - Running setup.py install for mozdevice 08:48:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:48:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:48:29 INFO - Running setup.py install for mozfile 08:48:29 INFO - Running setup.py install for mozhttpd 08:48:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:48:29 INFO - Running setup.py install for mozinfo 08:48:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:48:29 INFO - Running setup.py install for mozInstall 08:48:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:48:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:48:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:48:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:48:30 INFO - Running setup.py install for mozleak 08:48:30 INFO - Running setup.py install for mozlog 08:48:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:48:30 INFO - Running setup.py install for moznetwork 08:48:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:48:30 INFO - Running setup.py install for mozprocess 08:48:30 INFO - Running setup.py install for mozprofile 08:48:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:48:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:48:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:48:30 INFO - Running setup.py install for mozrunner 08:48:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:48:31 INFO - Running setup.py install for mozscreenshot 08:48:31 INFO - Running setup.py install for moztest 08:48:31 INFO - Running setup.py install for mozversion 08:48:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:48:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:48:31 INFO - Cleaning up... 08:48:31 INFO - Return code: 0 08:48:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:31 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:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:31 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:48:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:31 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 0x1098aeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec69d8f950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10968cd30>, '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 0x1095b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109681be8>, '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.TvhCkkk9NV/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.R9bHXAHA3C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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:48:31 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:48:31 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:48:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TvhCkkk9NV/Render', 08:48:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:31 INFO - 'HOME': '/Users/cltbld', 08:48:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:31 INFO - 'LOGNAME': 'cltbld', 08:48:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:31 INFO - 'MOZ_NO_REMOTE': '1', 08:48:31 INFO - 'NO_EM_RESTART': '1', 08:48:31 INFO - 'PAGER': '/bin/cat', 08:48:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:31 INFO - 'PWD': '/builds/slave/test', 08:48:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:31 INFO - 'SHELL': '/bin/bash', 08:48:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9bHXAHA3C/Listeners', 08:48:31 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 08:48:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:31 INFO - 'USER': 'cltbld', 08:48:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:31 INFO - 'XPC_FLAGS': '0x0', 08:48:31 INFO - 'XPC_SERVICE_NAME': '0', 08:48:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:31 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-hEegOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:31 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:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:31 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-I4xfXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:31 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:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:31 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-1rHM8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:32 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:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:32 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-sd1jvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:32 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:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:32 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-fsTMeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:32 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:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:32 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-hOkbNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:32 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:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:32 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-baCnXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:32 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:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:32 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-gE55EZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:32 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:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:32 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-GLXYAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:32 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:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:32 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-wHq22N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:32 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:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:32 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-aU0eon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:32 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:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:32 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-z2MOtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:33 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-DUY5Bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:33 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:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:33 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-34YCL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:33 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:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:33 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-9zXBhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:33 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:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:33 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-lc5PwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:33 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-BwA9vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:33 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:48:33 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:48:33 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:48:33 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:48:33 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:48:33 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:48:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:48: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:48: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:48: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:48: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:48: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:48: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:48:36 INFO - Downloading blessings-1.6.tar.gz 08:48:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:48:36 INFO - Installing collected packages: blessings 08:48:36 INFO - Running setup.py install for blessings 08:48:36 INFO - Successfully installed blessings 08:48:36 INFO - Cleaning up... 08:48:36 INFO - Return code: 0 08:48:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:48:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:37 INFO - Reading from file tmpfile_stdout 08:48:37 INFO - Current package versions: 08:48:37 INFO - blessings == 1.6 08:48:37 INFO - blobuploader == 1.2.4 08:48:37 INFO - docopt == 0.6.1 08:48:37 INFO - functools32 == 3.2.3-2 08:48:37 INFO - jsonschema == 2.5.1 08:48:37 INFO - manifestparser == 1.1 08:48:37 INFO - mozInstall == 1.12 08:48:37 INFO - mozcrash == 1.0 08:48:37 INFO - mozdebug == 0.1 08:48:37 INFO - mozdevice == 0.49 08:48:37 INFO - mozfile == 1.2 08:48:37 INFO - mozhttpd == 0.7 08:48:37 INFO - mozinfo == 0.9 08:48:37 INFO - mozleak == 0.1 08:48:37 INFO - mozlog == 3.4 08:48:37 INFO - moznetwork == 0.27 08:48:37 INFO - mozprocess == 0.24 08:48:37 INFO - mozprofile == 0.28 08:48:37 INFO - mozrunner == 6.13 08:48:37 INFO - mozscreenshot == 0.1 08:48:37 INFO - mozsystemmonitor == 0.3 08:48:37 INFO - moztest == 0.8 08:48:37 INFO - mozversion == 1.4 08:48:37 INFO - psutil == 3.1.1 08:48:37 INFO - requests == 1.2.3 08:48:37 INFO - wsgiref == 0.1.2 08:48:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:37 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:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:37 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:48:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1098aeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec69d8f950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10968cd30>, '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 0x1095b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109681be8>, '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.TvhCkkk9NV/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.R9bHXAHA3C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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:48:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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:48:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.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:48:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TvhCkkk9NV/Render', 08:48:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:37 INFO - 'HOME': '/Users/cltbld', 08:48:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:37 INFO - 'LOGNAME': 'cltbld', 08:48:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:37 INFO - 'MOZ_NO_REMOTE': '1', 08:48:37 INFO - 'NO_EM_RESTART': '1', 08:48:37 INFO - 'PAGER': '/bin/cat', 08:48:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:37 INFO - 'PWD': '/builds/slave/test', 08:48:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:37 INFO - 'SHELL': '/bin/bash', 08:48:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9bHXAHA3C/Listeners', 08:48:37 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 08:48:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:37 INFO - 'USER': 'cltbld', 08:48:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:37 INFO - 'XPC_FLAGS': '0x0', 08:48:37 INFO - 'XPC_SERVICE_NAME': '0', 08:48:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:48:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:48:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:48:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:48:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:48:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:48:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:48:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:48:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:48:37 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:48:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:48:37 INFO - Cleaning up... 08:48:37 INFO - Return code: 0 08:48:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:48:37 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:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:37 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:48:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1098aeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec69d8f950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10968cd30>, '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 0x1095b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109681be8>, '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.TvhCkkk9NV/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.R9bHXAHA3C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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:48:37 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:48:37 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:48:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TvhCkkk9NV/Render', 08:48:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:37 INFO - 'HOME': '/Users/cltbld', 08:48:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:37 INFO - 'LOGNAME': 'cltbld', 08:48:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:37 INFO - 'MOZ_NO_REMOTE': '1', 08:48:37 INFO - 'NO_EM_RESTART': '1', 08:48:37 INFO - 'PAGER': '/bin/cat', 08:48:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:37 INFO - 'PWD': '/builds/slave/test', 08:48:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:37 INFO - 'SHELL': '/bin/bash', 08:48:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9bHXAHA3C/Listeners', 08:48:37 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 08:48:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:37 INFO - 'USER': 'cltbld', 08:48:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:37 INFO - 'XPC_FLAGS': '0x0', 08:48:37 INFO - 'XPC_SERVICE_NAME': '0', 08:48:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:48:38 INFO - Cleaning up... 08:48:38 INFO - Return code: 0 08:48:38 INFO - Running post-action listener: _resource_record_post_action 08:48:38 INFO - Running post-action listener: _start_resource_monitoring 08:48:38 INFO - Starting resource monitoring. 08:48:38 INFO - [mozharness: 2017-02-04 16:48:38.255185Z] Finished create-virtualenv step (success) 08:48:38 INFO - [mozharness: 2017-02-04 16:48:38.256097Z] Running install step. 08:48:38 INFO - Running pre-action listener: _resource_record_pre_action 08:48:38 INFO - Running main action method: install 08:48:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:38 INFO - Reading from file tmpfile_stdout 08:48:38 INFO - Detecting whether we're running mozinstall >=1.0... 08:48:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:48:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:48:38 INFO - Reading from file tmpfile_stdout 08:48:38 INFO - Output received: 08:48:38 INFO - Usage: mozinstall [options] installer 08:48:38 INFO - Options: 08:48:38 INFO - -h, --help show this help message and exit 08:48:38 INFO - -d DEST, --destination=DEST 08:48:38 INFO - Directory to install application into. [default: 08:48:38 INFO - "/builds/slave/test"] 08:48:38 INFO - --app=APP Application being installed. [default: firefox] 08:48:38 INFO - mkdir: /builds/slave/test/build/application 08:48:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:48:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:48:59 INFO - Reading from file tmpfile_stdout 08:48:59 INFO - Output received: 08:48:59 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:48:59 INFO - Running post-action listener: _resource_record_post_action 08:48:59 INFO - [mozharness: 2017-02-04 16:48:59.078266Z] Finished install step (success) 08:48:59 INFO - [mozharness: 2017-02-04 16:48:59.078393Z] Running run-tests step. 08:48:59 INFO - Running pre-action listener: _resource_record_pre_action 08:48:59 INFO - Running main action method: run_tests 08:48:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:48:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:48:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:48:59 INFO - 2017-02-04 08:48:59.092 screenresolution[1882:9247] starting screenresolution argv=screenresolution get 08:48:59 INFO - 2017-02-04 08:48:59.095 screenresolution[1882:9247] Display 0: 1600x1200x32@60 08:48:59 INFO - 2017-02-04 08:48:59.101 screenresolution[1883:9249] starting screenresolution argv=screenresolution list 08:48:59 INFO - Available Modes on Display 0 08:48:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:48:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:48:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:48:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:48:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:48:59 INFO - Intel Iris: 08:48:59 INFO - Chipset Model: Intel Iris 08:48:59 INFO - Type: GPU 08:48:59 INFO - Bus: Built-In 08:48:59 INFO - VRAM (Dynamic, Max): 1536 MB 08:48:59 INFO - Vendor: Intel (0x8086) 08:48:59 INFO - Device ID: 0x0a2e 08:48:59 INFO - Revision ID: 0x0009 08:48:59 INFO - Displays: 08:48:59 INFO - Display: 08:48:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:48:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:48:59 INFO - Display Serial Number: 1600x1200 60 08:48:59 INFO - Main Display: Yes 08:48:59 INFO - Mirror: Off 08:48:59 INFO - Online: Yes 08:48:59 INFO - Rotation: Supported 08:48:59 INFO - Return code: 0 08:48:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:48:59 INFO - Python 2.7.3 08:48:59 INFO - Return code: 0 08:48:59 INFO - grabbing minidump binary from tooltool 08:48:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:59 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 0x10968cd30>, '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 0x1095b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109681be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:48:59 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:48:59 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:48:59 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:48:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:48:59 INFO - Return code: 0 08:48:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:48:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:48:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:48:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:48:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:48:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VhFyK4cgSK2dHGfdHnkhGw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0096', '--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:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VhFyK4cgSK2dHGfdHnkhGw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0096 --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:48:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TvhCkkk9NV/Render', 08:48:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:59 INFO - 'HOME': '/Users/cltbld', 08:48:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:59 INFO - 'LOGNAME': 'cltbld', 08:48:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:48:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:48:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:59 INFO - 'MOZ_NO_REMOTE': '1', 08:48:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:48:59 INFO - 'NO_EM_RESTART': '1', 08:48:59 INFO - 'PAGER': '/bin/cat', 08:48:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:59 INFO - 'PWD': '/builds/slave/test', 08:48:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:48:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:59 INFO - 'SHELL': '/bin/bash', 08:48:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9bHXAHA3C/Listeners', 08:48:59 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 08:48:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:59 INFO - 'USER': 'cltbld', 08:48:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:59 INFO - 'XPC_FLAGS': '0x0', 08:48:59 INFO - 'XPC_SERVICE_NAME': '0', 08:48:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VhFyK4cgSK2dHGfdHnkhGw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0096', '--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:48:59 INFO - mozversion application_buildid: 20170204072808 08:48:59 INFO - mozversion application_changeset: f20caa37abca28b8f031eaebb6176948bb76fec5 08:48:59 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:48:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:48:59 INFO - mozversion application_name: Firefox 08:48:59 INFO - mozversion application_remotingname: firefox-dev 08:48:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:48:59 INFO - mozversion application_vendor: Mozilla 08:48:59 INFO - mozversion application_version: 53.0a2 08:48:59 INFO - mozversion platform_buildid: 20170204072808 08:48:59 INFO - mozversion platform_changeset: f20caa37abca28b8f031eaebb6176948bb76fec5 08:48:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:48:59 INFO - mozversion platform_version: 53.0a2 08:48:59 INFO - using testdate: 1486226939 08:48:59 INFO - actual date: 1486226939 08:48:59 INFO - starting webserver on 'localhost:49376' 08:48:59 INFO - SUITE-START | Running 2 tests 08:48:59 INFO - TEST-START | dromaeo_css 08:48:59 INFO - operating with platform_type : mac_ 08:48:59 INFO - Initialising browser for dromaeo_css test... 08:48:59 INFO - TEST-INFO | started process 1893 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpRC7aMP/profile http://localhost:49376/getInfo.html) 08:49:02 INFO - PROCESS | 1893 | 2017-02-04 08:49:02.582 plugin-container[1895:9410] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f43, name = 'com.apple.tsm.portname' 08:49:02 INFO - PROCESS | 1893 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:49:02 INFO - PROCESS | 1893 | 2017-02-04 08:49:02.585 plugin-container[1895:9410] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d07, name = 'com.apple.CFPasteboardClient' 08:49:02 INFO - PROCESS | 1893 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:49:02 INFO - PROCESS | 1893 | 2017-02-04 08:49:02.585 plugin-container[1895:9410] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:49:02 INFO - PROCESS | 1893 | __metrics Screen width/height:1600/1200 08:49:02 INFO - PROCESS | 1893 | colorDepth:24 08:49:02 INFO - PROCESS | 1893 | Browser inner width/height: 1024/689 08:49:02 INFO - PROCESS | 1893 | __metrics 08:49:02 ERROR - PROCESS | 1893 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 08:49:02 INFO - PROCESS | 1893 | 1486226942744 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < forceQuit@jar:file:///var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpRC7aMP/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpRC7aMP/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpRC7aMP/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpRC7aMP/profile/extensions/talos-powers@TalosPowersService.js:55:9 08:49:03 INFO - TEST-INFO | 1893: exit 0 08:49:03 INFO - Browser initialized. 08:49:03 INFO - Running cycle 1/1 for dromaeo_css test... 08:49:03 INFO - TEST-INFO | started process 1896 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpRC7aMP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:49:05 INFO - PROCESS | 1896 | 2017-02-04 08:49:05.888 plugin-container[1897:9539] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 08:49:05 INFO - PROCESS | 1896 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:49:05 INFO - PROCESS | 1896 | 2017-02-04 08:49:05.889 plugin-container[1897:9539] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 08:49:05 INFO - PROCESS | 1896 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:49:05 INFO - PROCESS | 1896 | 2017-02-04 08:49:05.889 plugin-container[1897:9539] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:49:15 INFO - PROCESS | 1896 | RSS: Main: 218968064 08:49:15 INFO - PROCESS | 1896 | 08:52:17 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49376/tests/dromaeo/cssquery-ext.html) 08:52:19 INFO - PROCESS | 1896 | RSS: Main: 242229248 08:52:19 INFO - PROCESS | 1896 | 08:54:03 INFO - PROCESS | 1896 | ************************* 08:54:03 INFO - PROCESS | 1896 | A coding exception was thrown and uncaught in a Task. 08:54:03 INFO - PROCESS | 1896 | 08:54:03 ERROR - PROCESS | 1896 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:54:03 INFO - PROCESS | 1896 | Full stack: 08:54:03 INFO - PROCESS | 1896 | ************************* 08:55:21 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-ext.html (next: http://localhost:49376/tests/dromaeo/cssquery-jquery.html) 08:55:22 INFO - PROCESS | 1896 | RSS: Main: 250220544 08:55:22 INFO - PROCESS | 1896 | 08:58:23 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49376/tests/dromaeo/cssquery-mootools.html) 08:58:24 INFO - PROCESS | 1896 | RSS: Main: 256524288 08:58:24 INFO - PROCESS | 1896 | 09:01:26 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49376/tests/dromaeo/cssquery-prototype.html) 09:01:27 INFO - PROCESS | 1896 | RSS: Main: 252960768 09:01:27 INFO - PROCESS | 1896 | 09:04:29 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49376/tests/dromaeo/cssquery-yui.html) 09:04:30 INFO - PROCESS | 1896 | RSS: Main: 257110016 09:04:30 INFO - PROCESS | 1896 | 09:07:32 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-yui.html (next: http://localhost:49376/tests/dromaeo/cssquery-dojo.html) 09:07:33 INFO - PROCESS | 1896 | RSS: Main: 258748416 09:07:33 INFO - PROCESS | 1896 | 09:07:33 INFO - PROCESS | 1896 | __start_tp_report 09:07:33 INFO - PROCESS | 1896 | _x_x_mozilla_page_load 09:07:33 INFO - PROCESS | 1896 | _x_x_mozilla_page_load_details 09:07:33 INFO - PROCESS | 1896 | |i|pagename|runs| 09:07:33 INFO - PROCESS | 1896 | |0;dojo.html;2404.963925541117;2695.3396417877625;3300.735941124709;3310.702036816686;3340.8830690925806;5567.721613919303;5594.7202639868;5609.158626206076;5626.493615574597;5676;5594.692291923942;5620.775168993236;5634.183043458696;5634.690092044946;5650.5479561635075;5105.974470127644;5117.437081920985;5177.45636708144;5215.400228973679;5242;4310.849120280791;5125.513076257749;5179.093658609747;5180.715060671661;5183.455737147602;5085.110105731482;5114.565261952738;5178.508041736029;5183.3779946406485;5186.0665080285535;5167.173252279636;5195.142801437758;5199.714015729133;5236.9526094781195;5268.525832675077;5140.023395554833;5173.586113110942;5175.844724658266;5178.430372659004;5198.870028249286;4379.605835474823;5460.6177567570285;5531.1426728857095;5738.598298119134;5768.711564421804;6073.757049718006;6108.205933228652;6114.419130182626;6119.3502297494215;6218.22272215973;6262.874742505124;6264.310925798159;6279.968600157015;6289.308176100625;6299.590526615755;5134.820281290137;5731.656100633933;5779.797707080232;5790.768369265266;5806.796762113306;6150.477209437248;6238.157848690459;6248.781292654735;6277.780277690259;6285.685715714288;5021.422536408287;6009.2188015557695;6112.53387702335;6114.144019837227;6120;5306.734663266821;6037.45662890342;6222.439980401786;6226.128342032119;6229.4393504584805;6012.278526576839;6095.329513753483;6103.05402662588;6131.724072416752;6142.723577439026;6171.259448866164;6194.752209911643;6203;6203.596766210182;6219.253689557282;4962.627802914796;4964.652474326763;4972.65191436596;4976.929960058605;4984.352034235526;4291.206126866539;4331.761753103609;4355.08543205924;4407.162639098561;4433.8226470941445;4747.454042785124;5636.915446268309;5714.5999780015;5746.051901436216;5754.223179870663;6238.968805155945;6256.874862502725;6296.874062518724;6297.96851015742;6303.086052522451;5568.025595520849;5632;5646.265985421951;5660.433956604306;5664.150377443334;5391.406945236099;5405.729713514309;5405.864853378697;5410.567154627621;5410.756515956791;6357.777477788348;6374.394432528902;6388.201474815648;6391.776287829904;6403.423691867754;6094.360092190256;6120.386183820725;6121.483458747687;6144.109104179958;6263.404976527223;6284.5600807943;6322;6325.905111423424;6334.873302534015;6381.489480841428;6027.969860150846;6109.75560977556;6118.082287656887;6124.418180272867;6125.295591007091;6101.176341193882;6120.111926550627;6157.076438534076;6207.81376558704;6211.782587609412;6028.487578555872;6094;6105.419985101408;6123.326434092335;6139.171211886338;5859.267591551056;6000.429959153874;6055.818325450244;6079.817605471843;6091.969540152271;5679.630823996427;5731.942680573307;5780.682062486436;5789.45000224978;5877.735501902339;6035.486983606443;6039.365866583946;6076.361981991828;6109.43503133753;6134.803982731443;5933.525317974465;5943.316518600243;5951.642901425928;5951.761929522944;5959.880802384015 09:07:33 INFO - PROCESS | 1896 | |1;ext.html;457.599600349694;484.23490884402645;515.5488947171226;523.3432042786303;534.5429657642716;31165;32529.51205731916;36797.26405471896;40487.39268910965;41494.96262593429;38461.80769096158;42779.78610106953;43155.56844431555;43200.567994320045;43259.13481730364;6512.381323774234;8207.58962051898;8979.236764874977;9227.3079519036;9243.445393276392;11053.668389948274;11373.431328433546;11413.885861141407;11509.194356395055;11646.30122192667;11235.382053987069;11252.943735281313;11273.210875238736;11282.041026512756;11291.548338066468;9579.616815327448;11257.549698012112;11327.716807079807;11329.830052549218;11389.829152562635;11238.325700458;11266.098712103012;11324.377159256237;11327.32036077838;11363.886361136449;40939.59060409388;41102;41189.79405102985;41227.76316710503;41282.793586031876;3981.7013723970817;3985.8206380712936;4094.7133700640966;4105.055837157441;4186.183694179636;29631.70368296311;30243.848780756176;30304.939327123666;31351.84324078365;31930.680693193237;3136.6863313668678;3161.162291992624;3165.0979470850925;3170.556122142879;3237.75716821237;486513;487560;489052;490750.5462472701;490824;60273.69863150656;60383.396166037775;60656;60799;60818;63950;64017.71964560683;64034;64078.35921640817;64349.67825160844;16654.50036498907;16839.41062062822;16846.07346595949;16847.915760421365;16891.83108168927;11536.365499897585;11759.647210583697;12941.705829416984;13072.954163666884;13300.73398532024;20893.89553052225;21689.891550542146;21984.45038874041;22100.115995360007;22113.336599902028;7432.85134297311;8704.260137888225;8871.334649901282;8883.600237989305;8901.198892099743;886.1271647427279;899.2131884600974;899.5682072605186;903.1239697493421;934.5747684803398;27429.62851857439;30458.603693224228;30928.0721578353;31149;31270;951.9385884738467;967.2890425537224;1031.9174466042848;1078.5955266774959;1140.5950887435008;14361.856381436051;14376.35306411214;14656.267186640625;14662.882183049413;14823;179433;241234;242632;242868;243879;62149;62453.75092498124;62708;62893;62937;1438.8703231756394;1456.9708605827825;1462.2323280277726;1483.384395475887;1483.8961272710806;25177.992880284582;29431.411371772017;30495.390092198475;30805.845970770002;31056.68943310538;51913.7404312976;52157;52370.476295236556;52424;52652.47347526476;464254.35745642113;464415;465190.6740466276;466211;466520;35917.46123808093;37075.07312317214;41024.79487602662;43713.56286437222;44265.557344426146;47353.76323118362;47892;48003.5199647999;48283.5171648279;48866.5113348862;38648.613513865625;38963.610363896;39090;39599.81200563988;40890.591094088675;39338.60661393464;39504.2099158021;39741.60258397495;40272;40717.59282407256;30801.383972320877;31559.526607101372;37600.623993760804;38774.2245155101;38847.223055539296;33503.83248083744;34705.65294347024;34771.82614086913;35251.11872203215;35261.47107793334;25680.87159564265;25743.742562574134;25758.484830303663;25885.482290354463;25954.83203255896 09:07:33 INFO - PROCESS | 1896 | |2;jquery.html;330.2075019952115;387.42274011722526;395.25691699604744;401.8131568820498;414.3598140872352;20138.798612013874;21398.55328949668;21512.247071352485;21570.676439853374;22017.33947981559;21587.892060539674;21725.23961661342;22000.44998875029;22168.667469987962;22412.991415386306;5424.810131645393;5793.131030345461;5804.303483581955;5808.883822323551;5825.1844741736195;4201;4630.768461576925;4961.9751901240625;5746.856328591798;5811.157382179582;5605.327360716719;6437.034444833289;6542.378474044958;6547.967260163692;6551.279359270477;6333.55665103443;6507.219133703962;6547.803565893031;6580.638064906429;6587.308332625101;5730.570207234432;5747.712614369265;5768.221290125821;5774.105013722879;5778.451047150514;13046.282454465001;13166.341682915912;23376.597404155804;23986.400339991465;25088.99644014237;2558.2581051495044;2632.4735052989477;2637.4988752137033;2652.7214642462454;2659.0427446119384;9411.952940235255;9435.575399107056;9773.755656108655;9995.100440960276;10004.799904001951;1770.4777090758257;1825.6166205096945;1839.9264029438807;1859.6466671332403;1864.5897902461436;136072.999999999;139460;144063.27968360196;145710;146677.2666136673;12101.757964840654;12117.39413029345;12210;12268.141230113984;12302.261864288172;15661;15759;15799.289031993589;15800.446984355493;15854.9207253963;7334.449916256195;7986.64227081386;8577.356698247531;8834.955825220834;8869.113088691209;7528.247175282428;8151.836963260702;8676.95661521701;8680.34897382699;8820.77948051291;4089.9591004090175;4771.067692914968;4840.685355451885;4883.511648835088;4915.361003069578;1570.1128862192825;2060.1759296281607;2060.3825996592604;3465.324261768981;3688.66801987817;858.4334339336008;1024.8206563851297;1026.2662196529518;1062.1184416933927;1066.4561073852392;21011.684824727643;21382.679259811117;22008.669869951962;22070.448238794157;22077.889610551843;1051.75283808305;1074.6561100447782;1087.3584585094675;1096.786126705285;1120.1878637987395;11441.02751266135;11449.427528623535;11499.827502587468;11559.422028898522;11596.884031159749;675588;677421;716171;725720;753321;111932.76134477265;118928.99999999827;137635;146026;152357;905.7319752346635;946.3233787841726;993.513178542509;1014.8173328800739;1015.7257540463886;18095.45713628593;18393.724094138866;18638.881667100017;18699.813001869807;18883;57655.270341888136;57710.711446442496;60168.49578760391;60440;61130.388696112466;64845;80221;84959;85432.71850922366;85860;8204.753857384288;8268;8355.832883342178;8580.485170889766;8675.91324086751;9152.542372881462;12736.74526509483;13213.339333033502;13370.732585348433;14066.437342506186;11615.535378584762;11856.17006809515;11860.94069529647;11880.227785193934;11952.163348565517;10333.5533025378;11519.193656444304;11719.941400292944;11865.11011674145;11923.509561304836;11960.940195298968;11984.101192410779;11990.940045299718;12010.819837702267;12088.818667719815;8494.830103397773;8587.355948303777;8645.913540864762;8751.168638979287;8772.166644168794;10798.838017429902;11698.649040528799;11722.296662200295;11783.351915644378;12206.084543659439 09:07:33 INFO - PROCESS | 1896 | |3;mootools.html;1208.2931485081226;1456.439270880712;1466.3254902744736;1466.3694611317133;1476.2840022589041;6538.574992625476;7470.1035875695;7548.20743821899;8372.246497815195;8385.161483851613;7905.604719764003;8170.468919520227;8170.6323215455295;8277.841102245691;8284.544350060743;2022.929197478085;2221.80003799658;2310.722713274401;2314.96527552086;2320.106758897828;2068.948276293097;2147.7852214778477;2288.3135059482174;2322.036354912709;2349.95300093998;1850.1581780290003;2289.942751431211;2326.941826454335;2340.0639744102323;2345.026813872241;2106.7050612914204;2268.727752669682;2307.134824440843;2318.1538738360546;2325.395397196724;2174.597699425611;2318.826088043387;2326.4183954011496;2338.263447014185;2350.988245058764;8252.257296843252;8299.751007469786;8307;8308.667653293922;8328.208820162075;5019.749012549358;5170.121079416471;5173.094708426011;5179.326687530634;5190.4031036430915;2871.1817132117453;3162.5572419861237;3370.8146051967133;3395.9830200849083;3401.812900290483;857.1668951455251;1130.9434528273553;1148.7645032768262;1152.8558930133734;1179.9233049851732;10525.315854469434;10653.414062226575;10678.305910115896;10689.518971646217;10717.35695858251;4564.566366195206;4694.483606803249;4720.527947205252;4749.4063242094735;4772.546608072227;9318.440893546409;9329.300302477206;9421.90578094224;9438.00900905395;9452.716418507456;5193.143131383279;5205.167173252262;5205.817796377184;5218.7912483500995;5222.3472065991755;4632.930506042412;4638.652101092432;4681.648876334289;4736.928946065812;4757.8096876125255;3858.961410385916;3896.279188350164;3925.450436938831;3982.143839074613;3997.920041599152;989.9703008909744;1170.9180357375071;1212.2665787198794;1267.4106540458547;1275.9744805103846;794.4835856693196;856.1139220906332;878.1218781218781;903.6249956268207;911.5305617606938;5461.617686761968;5536.7785288588;5617.775288988477;5702.714864256771;5724.112762521816;800.6917336825247;998.8801343838786;1006.1196453103535;1010.802893435773;1018.3075508654039;3562.5012498250267;3779.981100094482;3787.981060094682;3803.7717736935874;3822.1591249924973;9485.905140948502;9694.75763105914;9735.9026409735;9787.461689606998;9802.411855288705;9254.167124958785;9458.385204961656;9751.853722194173;9767.560459779326;9797.559109840075;7615.771526854203;7733.110692270348;7749.225077492319;7812.921870781333;7835.725749598737;5446.237526746179;5540.63985840919;5600.27196464457;5689.8862022758485;5770.0190967536455;9002.774930626787;9025.548722563713;9193.724188274362;9200.125988031126;9203.40177888435;8606.913930860612;8900.332475064526;9067.04795996411;9152.17630413266;9169.54152292396;7076.823079422849;7172.569645821268;7173.784786456415;7232.927670723226;7241.782746517402;7748.728794492165;7816.88274675869;7831.96084019599;7832.569208693577;7864.977552918084;6151;7104.289571042855;7124.964375178091;7128.322809333105;7195.604241766753;6929.722811087701;6974.965125174342;7004.859902801813;7030.894536582057;7038.366547010589;6393.264774550986;6413.807585772434;6451.516136289891;6490.902636460552;6508;4081.91836163281;4614.700044497231;4638.721676699409;4675.018246168343;4687.67186296956;4954.702717836942;5001;5038.722870242172;5087.262346959744;5104.974475127749 09:07:33 INFO - PROCESS | 1896 | |4;prototype.html;304.84909969565064;352.71611334741544;363.1284916201117;364.25328077441236;369.4439867998663;4361.847335343264;4435.911281774363;4789.904201915964;5202.427732949377;5295.841124766263;5310.575153987681;5343.599230057742;5360.597955153369;5366.517013468797;5369.973150134244;3350.514175444559;4213.536510983797;4251.341042138473;4263.571703479338;4264.23243816113;3077.7845550811453;3791.109089363997;4199.3281075028;4274.145170965804;4288.807003684841;3780;4161.563035881234;4176.853810116631;4192.268880696183;4192.748435093904;3942.7240093193486;4207.221663992141;4210.705250632457;4242;4309.332053531708;3681.4109742441346;3711.4432835074685;3743.6630703236565;3753.474513568103;3754.3429899767702;4171.91656166875;5223.895522089537;5225.980933717927;5245.167609490871;5254.474552544753;3919.3729003359613;4080.6531444827224;4899.093667671492;4904.651220914241;4908.092002979461;5558.996284013297;5721.513671337942;5734.197212390269;5758.280214973129;5758.309002919635;3346.7322614190807;3409.09658940381;3585.6593623605977;3834.6740527055235;4071.9389209161886;5552.639078459928;5893.899813692808;5938.257717785234;5956.344802071769;5980.641161530322;3003.6695963444004;3310.2386451116377;3878.301905657009;3910.882673519799;3977.3039718049226;3760.2479504099288;3942.64516193544;3964.345882929342;3976.5824588418377;3988.12261302513;4140.710150289511;4384.188925048876;4619.792109355087;4625.629949604024;4635.490096089427;5466.890662186734;5566.636174137362;5667.489925906688;5705.771769129188;5754.971225143931;1063.1813503602184;1095.742500512379;1161.3670549550516;1275.6810797300675;1283.371148137406;847.6185716427509;867.1805144138855;872.2411501993306;874.0909454167595;875.2035647560689;4329.6536277098385;4383.276759334674;4765.428148622187;5051.646384753032;5067.771950262247;4594.540545945379;5054.635248482889;5468.48049435303;5623.240862483594;5701.71491425427;4350.73895566267;4524.88687782808;4917.410290487964;4947.381577302837;4982.476839931827;2451.963220551693;2516.471540976379;2715.728427157308;2937.9706202938123;3045.543168524739;5038.496150384932;5214.426413094557;5284.735763211824;5421.1055175895535;5611.849570837969;5239.973800130975;5450.781968721207;5451.155070964007;5660.462256085665;5800;4745.976270118696;5225.719698673774;5344.652597581145;5506.93489941272;5794.275715535558;4377.4528183977;5032.220005899091;5061.076790819465;5575.442455754554;5647.407022262603;4586.9541304587865;4737.810487580596;5349.866253343697;5449.373322068013;5857.765689372377;4981.800727970841;5173.4826517347965;5395.352557692945;6109.969450152721;6196.349383314687;3926.234384295149;3933.731900887569;3933.822977965941;3963.56400795918;4002.099527606382;5159.896802063862;5298.576113910801;5505.871296384152;5569.637973531708;5855.975204339309;5571;5571;5644.520215781705;5715.5713321500225;5772.826815195551;4782.8999330153565;5643.746031428514;5674.858128546819;5705.286839145107;5784.471472401916;5383.353997520323;5495.670259784426;5540.445955404427;5592.608517403743;5595.832125036255;4891.559759621651;5288.550473209666;5683.403242659627;5712.857178570569;5757.021306377842;5018.146915024382;5200.583953283804;5582.3859375467855;5630.831075067755;5631.493165615114 09:07:33 INFO - PROCESS | 1896 | |5;yui.html;690.3579670906055;704.2851505721691;744.162816831065;793.5278509286974;811.5455345006799;13634.522791702293;14320.570382888503;14356.353964071615;14420.13479191248;14511.129332240072;12096.91127798498;12970.546030888921;13198.670033249173;13226.735465290712;13250;782.647808486182;845.1337379186352;851.221132663612;855.341387131908;871.5337294547419;843.6709683223547;845.5898889038812;855.5764896376303;856.374846362156;856.5417501636625;901.6618767962015;905.6830109461702;906.5104843384564;907.3739120007207;908.8545832666774;875.1336177184605;895.5566994337812;898.2230370729337;900.1538553759445;901.9503927283997;666.4768156996782;674.4267372733186;675.0818886314609;675.0987431778582;675.4326365852659;13576.049676522647;13903.957203209698;14682.412703491847;14692;14709.705805883823;13596.184228946295;13863.653408664763;13966.441342346294;14092.224927628977;14117.78823317651;11282.774344513145;11393.202475826696;11402.657920262405;11515.251508651994;11965.820512692317;3365.831708414594;3450.5859296884532;3455.7926524408363;3473.6873681368547;3545.592256890465;111110.88889111087;112463.43768281188;114890.42554787172;115651.84348156495;115662.26506602408;10837.242387914137;10876.590235765805;10982.670519884416;11023.338599684044;11357.148213883991;21998.01008954601;22435.775642243694;22435.887820561118;22443;22511.662325065136;7364.96317518409;7366.815829604196;7444.516106453063;7445.925540744632;7596.354309883722;3290.68738469845;3943.7042221833476;4040.1717647882115;4131.116314139424;4173.269677806372;3441.8795342162903;3521.7886926784477;3528.8588456461966;3543.681068703829;3556.413191823372;506.3817980022148;634.6033728919425;636.4653690899667;643.6427782580619;646.6475770704883;637.6875331087733;645.7287939065603;669.5714742564762;674.6255828015499;681.465049935798;9069.77325566853;9224.031476694985;9994.700158995242;10114.696559103091;10195.388276703421;436.8864095335236;457.37339844413367;536.5546596325041;551.3056325389314;554.1323650110742;4545.113702827983;4715.764211789466;4759.4764575896625;4771.976140119277;4821.783019764119;110189.34715979267;110253;111102;111861;115053.4247328758;98747;99450;100919.49540252252;101570.98429015615;103189.96810031954;83393;84001.73997390045;84533.30933381298;85156.57421712976;87624.6856297156;9070.455772653662;9255.861162082709;9373.906260937303;9414.540101995894;9497.905020949702;54311;54801.90396191974;54972.45027549673;55619.44380556142;55827.720861395435;72348.27651723416;72810.63594681992;72942;73986.63006684932;75111.87332189913;11024.944875275572;11034.558617655204;11324.6036388726;11648.650540483799;11663.708407289885;11944.522219111486;12068.517259309529;12234;12352.814707779571;12869.099163058496;11145.72135696614;11235.15736319763;11585.768284634429;11594.6521604352;11657.591984280509;9732.172765315028;11140.442977851237;11438.084953203557;11551.036323824801;12064.75870482603;9114.40756350835;9368.578413971523;11786.882131178578;11859.762804743685;12271.325077120488;9508.809823803624;9579.473128977694;9624.230061594915;10077;10247.743806404602;9258.166764991183;9483.573239204114;9562.952185239308;9567.61729530811;9572.9042709572 09:07:33 INFO - PROCESS | 1896 | __end_tp_report 09:07:33 INFO - PROCESS | 1896 | __start_cc_report 09:07:33 INFO - PROCESS | 1896 | _x_x_mozilla_cycle_collect,379 09:07:33 INFO - PROCESS | 1896 | __end_cc_report 09:07:33 INFO - PROCESS | 1896 | __startTimestamp1486228053152__endTimestamp 09:07:33 INFO - PROCESS | 1896 | 09:07:33 INFO - PROCESS | 1896 | ------- Summary: start ------- 09:07:33 INFO - PROCESS | 1896 | Number of tests: 6 09:07:33 INFO - PROCESS | 1896 | 09:07:33 INFO - PROCESS | 1896 | [#0] dojo.html Cycles:165 Average:5667.06 Median:5877.74 stddev:699.08 (11.9%) stddev-sans-first:652.71 09:07:33 INFO - PROCESS | 1896 | Values: 2405.0 2695.3 3300.7 3310.7 3340.9 5567.7 5594.7 5609.2 5626.5 5676.0 5594.7 5620.8 5634.2 5634.7 5650.5 5106.0 5117.4 5177.5 5215.4 5242.0 4310.8 5125.5 5179.1 5180.7 5183.5 5085.1 5114.6 5178.5 5183.4 5186.1 5167.2 5195.1 5199.7 5237.0 5268.5 5140.0 5173.6 5175.8 5178.4 5198.9 4379.6 5460.6 5531.1 5738.6 5768.7 6073.8 6108.2 6114.4 6119.4 6218.2 6262.9 6264.3 6280.0 6289.3 6299.6 5134.8 5731.7 5779.8 5790.8 5806.8 6150.5 6238.2 6248.8 6277.8 6285.7 5021.4 6009.2 6112.5 6114.1 6120.0 5306.7 6037.5 6222.4 6226.1 6229.4 6012.3 6095.3 6103.1 6131.7 6142.7 6171.3 6194.8 6203.0 6203.6 6219.3 4962.6 4964.7 4972.7 4976.9 4984.4 4291.2 4331.8 4355.1 4407.2 4433.8 4747.5 5636.9 5714.6 5746.1 5754.2 6239.0 6256.9 6296.9 6298.0 6303.1 5568.0 5632.0 5646.3 5660.4 5664.2 5391.4 5405.7 5405.9 5410.6 5410.8 6357.8 6374.4 6388.2 6391.8 6403.4 6094.4 6120.4 6121.5 6144.1 6263.4 6284.6 6322.0 6325.9 6334.9 6381.5 6028.0 6109.8 6118.1 6124.4 6125.3 6101.2 6120.1 6157.1 6207.8 6211.8 6028.5 6094.0 6105.4 6123.3 6139.2 5859.3 6000.4 6055.8 6079.8 6092.0 5679.6 5731.9 5780.7 5789.5 5877.7 6035.5 6039.4 6076.4 6109.4 6134.8 5933.5 5943.3 5951.6 5951.8 5959.9 09:07:33 INFO - PROCESS | 1896 | 09:07:33 INFO - PROCESS | 1896 | [#1] ext.html Cycles:180 Average:56573.15 Median:38555.21 stddev:109335.09 (283.6%) stddev-sans-first:109560.63 09:07:33 INFO - PROCESS | 1896 | Values: 457.6 484.2 515.5 523.3 534.5 31165.0 32529.5 36797.3 40487.4 41495.0 38461.8 42779.8 43155.6 43200.6 43259.1 6512.4 8207.6 8979.2 9227.3 9243.4 11053.7 11373.4 11413.9 11509.2 11646.3 11235.4 11252.9 11273.2 11282.0 11291.5 9579.6 11257.5 11327.7 11329.8 11389.8 11238.3 11266.1 11324.4 11327.3 11363.9 40939.6 41102.0 41189.8 41227.8 41282.8 3981.7 3985.8 4094.7 4105.1 4186.2 29631.7 30243.8 30304.9 31351.8 31930.7 3136.7 3161.2 3165.1 3170.6 3237.8 486513.0 487560.0 489052.0 490750.5 490824.0 60273.7 60383.4 60656.0 60799.0 60818.0 63950.0 64017.7 64034.0 64078.4 64349.7 16654.5 16839.4 16846.1 16847.9 16891.8 11536.4 11759.6 12941.7 13073.0 13300.7 20893.9 21689.9 21984.5 22100.1 22113.3 7432.9 8704.3 8871.3 8883.6 8901.2 886.1 899.2 899.6 903.1 934.6 27429.6 30458.6 30928.1 31149.0 31270.0 951.9 967.3 1031.9 1078.6 1140.6 14361.9 14376.4 14656.3 14662.9 14823.0 179433.0 241234.0 242632.0 242868.0 243879.0 62149.0 62453.8 62708.0 62893.0 62937.0 1438.9 1457.0 1462.2 1483.4 1483.9 25178.0 29431.4 30495.4 30805.8 31056.7 51913.7 52157.0 52370.5 52424.0 52652.5 464254.4 464415.0 465190.7 466211.0 466520.0 35917.5 37075.1 41024.8 43713.6 44265.6 47353.8 47892.0 48003.5 48283.5 48866.5 38648.6 38963.6 39090.0 39599.8 40890.6 39338.6 39504.2 39741.6 40272.0 40717.6 30801.4 31559.5 37600.6 38774.2 38847.2 33503.8 34705.7 34771.8 35251.1 35261.5 25680.9 25743.7 25758.5 25885.5 25954.8 09:07:33 INFO - PROCESS | 1896 | 09:07:33 INFO - PROCESS | 1896 | [#2] jquery.html Cycles:180 Average:39317.13 Median:22894.79 stddev:118321.70 (516.8%) stddev-sans-first:118617.41 09:07:33 INFO - PROCESS | 1896 | Values: 330.2 387.4 395.3 401.8 414.4 20138.8 21398.6 21512.2 21570.7 22017.3 21587.9 21725.2 22000.4 22168.7 22413.0 5424.8 5793.1 5804.3 5808.9 5825.2 4201.0 4630.8 4962.0 5746.9 5811.2 5605.3 6437.0 6542.4 6548.0 6551.3 6333.6 6507.2 6547.8 6580.6 6587.3 5730.6 5747.7 5768.2 5774.1 5778.5 13046.3 13166.3 23376.6 23986.4 25089.0 2558.3 2632.5 2637.5 2652.7 2659.0 9412.0 9435.6 9773.8 9995.1 10004.8 1770.5 1825.6 1839.9 1859.6 1864.6 136073.0 139460.0 144063.3 145710.0 146677.3 12101.8 12117.4 12210.0 12268.1 12302.3 15661.0 15759.0 15799.3 15800.4 15854.9 7334.4 7986.6 8577.4 8835.0 8869.1 7528.2 8151.8 8677.0 8680.3 8820.8 4090.0 4771.1 4840.7 4883.5 4915.4 1570.1 2060.2 2060.4 3465.3 3688.7 858.4 1024.8 1026.3 1062.1 1066.5 21011.7 21382.7 22008.7 22070.4 22077.9 1051.8 1074.7 1087.4 1096.8 1120.2 11441.0 11449.4 11499.8 11559.4 11596.9 675588.0 677421.0 716171.0 725720.0 753321.0 111932.8 118929.0 137635.0 146026.0 152357.0 905.7 946.3 993.5 1014.8 1015.7 18095.5 18393.7 18638.9 18699.8 18883.0 57655.3 57710.7 60168.5 60440.0 61130.4 64845.0 80221.0 84959.0 85432.7 85860.0 8204.8 8268.0 8355.8 8580.5 8675.9 9152.5 12736.7 13213.3 13370.7 14066.4 11615.5 11856.2 11860.9 11880.2 11952.2 10333.6 11519.2 11719.9 11865.1 11923.5 11960.9 11984.1 11990.9 12010.8 12088.8 8494.8 8587.4 8645.9 8751.2 8772.2 10798.8 11698.6 11722.3 11783.4 12206.1 09:07:33 INFO - PROCESS | 1896 | 09:07:33 INFO - PROCESS | 1896 | [#3] mootools.html Cycles:180 Average:5360.54 Median:5334.29 stddev:2907.17 (54.5%) stddev-sans-first:2898.58 09:07:33 INFO - PROCESS | 1896 | Values: 1208.3 1456.4 1466.3 1466.4 1476.3 6538.6 7470.1 7548.2 8372.2 8385.2 7905.6 8170.5 8170.6 8277.8 8284.5 2022.9 2221.8 2310.7 2315.0 2320.1 2068.9 2147.8 2288.3 2322.0 2350.0 1850.2 2289.9 2326.9 2340.1 2345.0 2106.7 2268.7 2307.1 2318.2 2325.4 2174.6 2318.8 2326.4 2338.3 2351.0 8252.3 8299.8 8307.0 8308.7 8328.2 5019.7 5170.1 5173.1 5179.3 5190.4 2871.2 3162.6 3370.8 3396.0 3401.8 857.2 1130.9 1148.8 1152.9 1179.9 10525.3 10653.4 10678.3 10689.5 10717.4 4564.6 4694.5 4720.5 4749.4 4772.5 9318.4 9329.3 9421.9 9438.0 9452.7 5193.1 5205.2 5205.8 5218.8 5222.3 4632.9 4638.7 4681.6 4736.9 4757.8 3859.0 3896.3 3925.5 3982.1 3997.9 990.0 1170.9 1212.3 1267.4 1276.0 794.5 856.1 878.1 903.6 911.5 5461.6 5536.8 5617.8 5702.7 5724.1 800.7 998.9 1006.1 1010.8 1018.3 3562.5 3780.0 3788.0 3803.8 3822.2 9485.9 9694.8 9735.9 9787.5 9802.4 9254.2 9458.4 9751.9 9767.6 9797.6 7615.8 7733.1 7749.2 7812.9 7835.7 5446.2 5540.6 5600.3 5689.9 5770.0 9002.8 9025.5 9193.7 9200.1 9203.4 8606.9 8900.3 9067.0 9152.2 9169.5 7076.8 7172.6 7173.8 7232.9 7241.8 7748.7 7816.9 7832.0 7832.6 7865.0 6151.0 7104.3 7125.0 7128.3 7195.6 6929.7 6975.0 7004.9 7030.9 7038.4 6393.3 6413.8 6451.5 6490.9 6508.0 4081.9 4614.7 4638.7 4675.0 4687.7 4954.7 5001.0 5038.7 5087.3 5105.0 09:07:33 INFO - PROCESS | 1896 | 09:07:33 INFO - PROCESS | 1896 | [#4] prototype.html Cycles:180 Average:4487.94 Median:5025.18 stddev:1377.64 (27.4%) stddev-sans-first:1345.25 09:07:33 INFO - PROCESS | 1896 | Values: 304.8 352.7 363.1 364.3 369.4 4361.8 4435.9 4789.9 5202.4 5295.8 5310.6 5343.6 5360.6 5366.5 5370.0 3350.5 4213.5 4251.3 4263.6 4264.2 3077.8 3791.1 4199.3 4274.1 4288.8 3780.0 4161.6 4176.9 4192.3 4192.7 3942.7 4207.2 4210.7 4242.0 4309.3 3681.4 3711.4 3743.7 3753.5 3754.3 4171.9 5223.9 5226.0 5245.2 5254.5 3919.4 4080.7 4899.1 4904.7 4908.1 5559.0 5721.5 5734.2 5758.3 5758.3 3346.7 3409.1 3585.7 3834.7 4071.9 5552.6 5893.9 5938.3 5956.3 5980.6 3003.7 3310.2 3878.3 3910.9 3977.3 3760.2 3942.6 3964.3 3976.6 3988.1 4140.7 4384.2 4619.8 4625.6 4635.5 5466.9 5566.6 5667.5 5705.8 5755.0 1063.2 1095.7 1161.4 1275.7 1283.4 847.6 867.2 872.2 874.1 875.2 4329.7 4383.3 4765.4 5051.6 5067.8 4594.5 5054.6 5468.5 5623.2 5701.7 4350.7 4524.9 4917.4 4947.4 4982.5 2452.0 2516.5 2715.7 2938.0 3045.5 5038.5 5214.4 5284.7 5421.1 5611.8 5240.0 5450.8 5451.2 5660.5 5800.0 4746.0 5225.7 5344.7 5506.9 5794.3 4377.5 5032.2 5061.1 5575.4 5647.4 4587.0 4737.8 5349.9 5449.4 5857.8 4981.8 5173.5 5395.4 6110.0 6196.3 3926.2 3933.7 3933.8 3963.6 4002.1 5159.9 5298.6 5505.9 5569.6 5856.0 5571.0 5571.0 5644.5 5715.6 5772.8 4782.9 5643.7 5674.9 5705.3 5784.5 5383.4 5495.7 5540.4 5592.6 5595.8 4891.6 5288.6 5683.4 5712.9 5757.0 5018.1 5200.6 5582.4 5630.8 5631.5 09:07:33 INFO - PROCESS | 1896 | 09:07:33 INFO - PROCESS | 1896 | [#5] yui.html Cycles:180 Average:21263.29 Median:2501.24 stddev:32437.96 (1296.9%) stddev-sans-first:32492.18 09:07:33 INFO - PROCESS | 1896 | Values: 690.4 704.3 744.2 793.5 811.5 13634.5 14320.6 14356.4 14420.1 14511.1 12096.9 12970.5 13198.7 13226.7 13250.0 782.6 845.1 851.2 855.3 871.5 843.7 845.6 855.6 856.4 856.5 901.7 905.7 906.5 907.4 908.9 875.1 895.6 898.2 900.2 902.0 666.5 674.4 675.1 675.1 675.4 13576.0 13904.0 14682.4 14692.0 14709.7 13596.2 13863.7 13966.4 14092.2 14117.8 11282.8 11393.2 11402.7 11515.3 11965.8 3365.8 3450.6 3455.8 3473.7 3545.6 111110.9 112463.4 114890.4 115651.8 115662.3 10837.2 10876.6 10982.7 11023.3 11357.1 21998.0 22435.8 22435.9 22443.0 22511.7 7365.0 7366.8 7444.5 7445.9 7596.4 3290.7 3943.7 4040.2 4131.1 4173.3 3441.9 3521.8 3528.9 3543.7 3556.4 506.4 634.6 636.5 643.6 646.6 637.7 645.7 669.6 674.6 681.5 9069.8 9224.0 9994.7 10114.7 10195.4 436.9 457.4 536.6 551.3 554.1 4545.1 4715.8 4759.5 4772.0 4821.8 110189.3 110253.0 111102.0 111861.0 115053.4 98747.0 99450.0 100919.5 101571.0 103190.0 83393.0 84001.7 84533.3 85156.6 87624.7 9070.5 9255.9 9373.9 9414.5 9497.9 54311.0 54801.9 54972.5 55619.4 55827.7 72348.3 72810.6 72942.0 73986.6 75111.9 11024.9 11034.6 11324.6 11648.7 11663.7 11944.5 12068.5 12234.0 12352.8 12869.1 11145.7 11235.2 11585.8 11594.7 11657.6 9732.2 11140.4 11438.1 11551.0 12064.8 9114.4 9368.6 11786.9 11859.8 12271.3 9508.8 9579.5 9624.2 10077.0 10247.7 9258.2 9483.6 9563.0 9567.6 9572.9 09:07:33 INFO - PROCESS | 1896 | -------- Summary: end -------- 09:07:33 INFO - PROCESS | 1896 | 09:07:33 INFO - TEST-INFO | 1896: exit 0 09:07:33 INFO - TEST-OK | dromaeo_css | took 1114124ms 09:07:33 INFO - TEST-START | kraken 09:07:33 INFO - operating with platform_type : mac_ 09:07:33 INFO - Initialising browser for kraken test... 09:07:33 INFO - TEST-INFO | started process 1903 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpW7d_kl/profile http://localhost:49376/getInfo.html) 09:07:36 INFO - PROCESS | 1903 | 2017-02-04 09:07:36.765 plugin-container[1904:11726] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 09:07:36 INFO - PROCESS | 1903 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:07:36 INFO - PROCESS | 1903 | 2017-02-04 09:07:36.768 plugin-container[1904:11726] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x441b, name = 'com.apple.CFPasteboardClient' 09:07:36 INFO - PROCESS | 1903 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:07:36 INFO - PROCESS | 1903 | 2017-02-04 09:07:36.768 plugin-container[1904:11726] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:07:36 INFO - PROCESS | 1903 | __metrics Screen width/height:1600/1200 09:07:36 INFO - PROCESS | 1903 | colorDepth:24 09:07:36 INFO - PROCESS | 1903 | Browser inner width/height: 1024/689 09:07:36 INFO - PROCESS | 1903 | __metrics 09:07:36 ERROR - PROCESS | 1903 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 09:07:36 INFO - PROCESS | 1903 | 1486228056941 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < forceQuit@jar:file:///var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpW7d_kl/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpW7d_kl/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpW7d_kl/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpW7d_kl/profile/extensions/talos-powers@TalosPowersService.js:55:9 09:07:37 INFO - TEST-INFO | 1903: exit 0 09:07:37 INFO - Browser initialized. 09:07:37 INFO - Running cycle 1/1 for kraken test... 09:07:37 INFO - TEST-INFO | started process 1905 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpW7d_kl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:07:39 INFO - PROCESS | 1905 | 2017-02-04 09:07:39.992 plugin-container[1906:11856] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x433b, name = 'com.apple.tsm.portname' 09:07:39 INFO - PROCESS | 1905 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:07:39 INFO - PROCESS | 1905 | 2017-02-04 09:07:39.993 plugin-container[1906:11856] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f03, name = 'com.apple.CFPasteboardClient' 09:07:39 INFO - PROCESS | 1905 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:07:39 INFO - PROCESS | 1905 | 2017-02-04 09:07:39.993 plugin-container[1906:11856] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:07:49 INFO - PROCESS | 1905 | RSS: Main: 218611712 09:07:49 INFO - PROCESS | 1905 | 09:07:52 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49376/tests/kraken/driver.html?testName=audio-beat-detection) 09:07:53 INFO - PROCESS | 1905 | RSS: Main: 232644608 09:07:53 INFO - PROCESS | 1905 | 09:07:55 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49376/tests/kraken/driver.html?testName=audio-dft) 09:07:56 INFO - PROCESS | 1905 | RSS: Main: 240553984 09:07:56 INFO - PROCESS | 1905 | 09:07:59 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49376/tests/kraken/driver.html?testName=audio-fft) 09:08:00 INFO - PROCESS | 1905 | RSS: Main: 244334592 09:08:00 INFO - PROCESS | 1905 | 09:08:02 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49376/tests/kraken/driver.html?testName=audio-oscillator) 09:08:02 INFO - PROCESS | 1905 | RSS: Main: 245657600 09:08:02 INFO - PROCESS | 1905 | 09:08:04 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49376/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:08:05 INFO - PROCESS | 1905 | RSS: Main: 246046720 09:08:05 INFO - PROCESS | 1905 | 09:08:08 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49376/tests/kraken/driver.html?testName=imaging-darkroom) 09:08:08 INFO - PROCESS | 1905 | RSS: Main: 249663488 09:08:08 INFO - PROCESS | 1905 | 09:08:12 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49376/tests/kraken/driver.html?testName=imaging-desaturate) 09:08:12 INFO - PROCESS | 1905 | RSS: Main: 249974784 09:08:12 INFO - PROCESS | 1905 | 09:08:15 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49376/tests/kraken/driver.html?testName=json-parse-financial) 09:08:16 INFO - PROCESS | 1905 | RSS: Main: 249614336 09:08:16 INFO - PROCESS | 1905 | 09:08:18 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49376/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:08:18 INFO - PROCESS | 1905 | RSS: Main: 248688640 09:08:18 INFO - PROCESS | 1905 | 09:08:20 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:08:21 INFO - PROCESS | 1905 | RSS: Main: 248737792 09:08:21 INFO - PROCESS | 1905 | 09:08:23 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:08:24 INFO - PROCESS | 1905 | RSS: Main: 248729600 09:08:24 INFO - PROCESS | 1905 | 09:08:27 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:08:27 INFO - PROCESS | 1905 | RSS: Main: 248856576 09:08:27 INFO - PROCESS | 1905 | 09:08:30 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:08:31 INFO - PROCESS | 1905 | RSS: Main: 249151488 09:08:31 INFO - PROCESS | 1905 | 09:08:33 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49376/tests/kraken/driver.html?testName=ai-astar) 09:08:33 INFO - PROCESS | 1905 | RSS: Main: 250822656 09:08:33 INFO - PROCESS | 1905 | 09:08:33 INFO - PROCESS | 1905 | __start_tp_report 09:08:33 INFO - PROCESS | 1905 | _x_x_mozilla_page_load 09:08:33 INFO - PROCESS | 1905 | _x_x_mozilla_page_load_details 09:08:33 INFO - PROCESS | 1905 | |i|pagename|runs| 09:08:33 INFO - PROCESS | 1905 | |0;ai-astar;109;119;120;120;120;118;120;119;120;119 09:08:33 INFO - PROCESS | 1905 | |1;audio-beat-detection;141;113;115;148;113;113;113;107;131;114 09:08:33 INFO - PROCESS | 1905 | |2;audio-dft;197;201;197;203;198;208;195;195;197;200 09:08:33 INFO - PROCESS | 1905 | |3;audio-fft;83;60;57;88;63;60;59;60;83;61 09:08:33 INFO - PROCESS | 1905 | |4;audio-oscillator;88;71;84;75;70;71;81;73;73;82 09:08:33 INFO - PROCESS | 1905 | |5;imaging-gaussian-blur;92;89;92;90;92;90;81;126;92;89 09:08:33 INFO - PROCESS | 1905 | |6;imaging-darkroom;144;106;153;122;143;151;121;107;152;105 09:08:33 INFO - PROCESS | 1905 | |7;imaging-desaturate;78;147;146;97;93;93;95;100;94;118 09:08:33 INFO - PROCESS | 1905 | |8;json-parse-financial;62;61;61;63;64;64;64;65;64;65 09:08:33 INFO - PROCESS | 1905 | |9;json-stringify-tinderbox;69;80;91;109;105;85;71;74;72;74 09:08:33 INFO - PROCESS | 1905 | |10;stanford-crypto-aes;101;108;88;86;88;87;83;84;86;82 09:08:33 INFO - PROCESS | 1905 | |11;stanford-crypto-ccm;131;158;153;138;153;145;144;145;202;150 09:08:33 INFO - PROCESS | 1905 | |12;stanford-crypto-pbkdf2;171;172;170;168;171;169;168;170;166;172 09:08:33 INFO - PROCESS | 1905 | |13;stanford-crypto-sha256-iterative;67;68;64;67;67;66;66;65;68;68 09:08:33 INFO - PROCESS | 1905 | __end_tp_report 09:08:33 INFO - PROCESS | 1905 | __start_cc_report 09:08:33 INFO - PROCESS | 1905 | _x_x_mozilla_cycle_collect,928 09:08:33 INFO - PROCESS | 1905 | __end_cc_report 09:08:33 INFO - PROCESS | 1905 | __startTimestamp1486228113347__endTimestamp 09:08:33 INFO - PROCESS | 1905 | 09:08:33 INFO - PROCESS | 1905 | ------- Summary: start ------- 09:08:33 INFO - PROCESS | 1905 | Number of tests: 14 09:08:33 INFO - PROCESS | 1905 | 09:08:33 INFO - PROCESS | 1905 | [#0] ai-astar Cycles:10 Average:118.40 Median:120.00 stddev:3.37 (2.8%) stddev-sans-first:0.73 09:08:33 INFO - PROCESS | 1905 | Values: 109.0 119.0 120.0 120.0 120.0 118.0 120.0 119.0 120.0 119.0 09:08:33 INFO - PROCESS | 1905 | 09:08:33 INFO - PROCESS | 1905 | [#1] audio-beat-detection Cycles:10 Average:120.80 Median:114.50 stddev:14.01 (12.2%) stddev-sans-first:12.81 09:08:33 INFO - PROCESS | 1905 | Values: 141.0 113.0 115.0 148.0 113.0 113.0 113.0 107.0 131.0 114.0 09:08:33 INFO - PROCESS | 1905 | 09:08:33 INFO - PROCESS | 1905 | [#2] audio-dft Cycles:10 Average:199.10 Median:199.00 stddev:4.04 (2.0%) stddev-sans-first:4.21 09:08:33 INFO - PROCESS | 1905 | Values: 197.0 201.0 197.0 203.0 198.0 208.0 195.0 195.0 197.0 200.0 09:08:33 INFO - PROCESS | 1905 | 09:08:33 INFO - PROCESS | 1905 | [#3] audio-fft Cycles:10 Average:67.40 Median:62.00 stddev:12.08 (19.5%) stddev-sans-first:11.42 09:08:33 INFO - PROCESS | 1905 | Values: 83.0 60.0 57.0 88.0 63.0 60.0 59.0 60.0 83.0 61.0 09:08:33 INFO - PROCESS | 1905 | 09:08:33 INFO - PROCESS | 1905 | [#4] audio-oscillator Cycles:10 Average:76.80 Median:78.00 stddev:6.39 (8.2%) stddev-sans-first:5.34 09:08:33 INFO - PROCESS | 1905 | Values: 88.0 71.0 84.0 75.0 70.0 71.0 81.0 73.0 73.0 82.0 09:08:33 INFO - PROCESS | 1905 | 09:08:33 INFO - PROCESS | 1905 | [#5] imaging-gaussian-blur Cycles:10 Average:93.30 Median:91.00 stddev:11.95 (13.1%) stddev-sans-first:12.67 09:08:33 INFO - PROCESS | 1905 | Values: 92.0 89.0 92.0 90.0 92.0 90.0 81.0 126.0 92.0 89.0 09:08:33 INFO - PROCESS | 1905 | 09:08:33 INFO - PROCESS | 1905 | [#6] imaging-darkroom Cycles:10 Average:130.40 Median:143.50 stddev:20.26 (14.1%) stddev-sans-first:20.88 09:08:33 INFO - PROCESS | 1905 | Values: 144.0 106.0 153.0 122.0 143.0 151.0 121.0 107.0 152.0 105.0 09:08:33 INFO - PROCESS | 1905 | 09:08:33 INFO - PROCESS | 1905 | [#7] imaging-desaturate Cycles:10 Average:106.10 Median:93.00 stddev:23.40 (25.2%) stddev-sans-first:22.50 09:08:33 INFO - PROCESS | 1905 | Values: 78.0 147.0 146.0 97.0 93.0 93.0 95.0 100.0 94.0 118.0 09:08:33 INFO - PROCESS | 1905 | 09:08:33 INFO - PROCESS | 1905 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:64.00 stddev:1.49 (2.3%) stddev-sans-first:1.51 09:08:33 INFO - PROCESS | 1905 | Values: 62.0 61.0 61.0 63.0 64.0 64.0 64.0 65.0 64.0 65.0 09:08:33 INFO - PROCESS | 1905 | 09:08:33 INFO - PROCESS | 1905 | [#9] json-stringify-tinderbox Cycles:10 Average:83.00 Median:74.00 stddev:14.38 (19.4%) stddev-sans-first:14.33 09:08:33 INFO - PROCESS | 1905 | Values: 69.0 80.0 91.0 109.0 105.0 85.0 71.0 74.0 72.0 74.0 09:08:33 INFO - PROCESS | 1905 | 09:08:33 INFO - PROCESS | 1905 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:86.00 stddev:8.42 (9.8%) stddev-sans-first:7.79 09:08:33 INFO - PROCESS | 1905 | Values: 101.0 108.0 88.0 86.0 88.0 87.0 83.0 84.0 86.0 82.0 09:08:33 INFO - PROCESS | 1905 | 09:08:33 INFO - PROCESS | 1905 | [#11] stanford-crypto-ccm Cycles:10 Average:151.90 Median:151.50 stddev:19.27 (12.7%) stddev-sans-first:18.89 09:08:33 INFO - PROCESS | 1905 | Values: 131.0 158.0 153.0 138.0 153.0 145.0 144.0 145.0 202.0 150.0 09:08:33 INFO - PROCESS | 1905 | 09:08:33 INFO - PROCESS | 1905 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.70 Median:170.50 stddev:1.95 (1.1%) stddev-sans-first:2.01 09:08:33 INFO - PROCESS | 1905 | Values: 171.0 172.0 170.0 168.0 171.0 169.0 168.0 170.0 166.0 172.0 09:08:33 INFO - PROCESS | 1905 | 09:08:33 INFO - PROCESS | 1905 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.35 (2.0%) stddev-sans-first:1.42 09:08:33 INFO - PROCESS | 1905 | Values: 67.0 68.0 64.0 67.0 67.0 66.0 66.0 65.0 68.0 68.0 09:08:33 INFO - PROCESS | 1905 | -------- Summary: end -------- 09:08:33 INFO - PROCESS | 1905 | 09:08:34 INFO - TEST-INFO | 1905: exit 0 09:08:34 INFO - TEST-OK | kraken | took 60439ms 09:08:34 INFO - SUITE-END | took 1174s 09:08:34 INFO - Completed test suite (00:19:34) 09:08:34 INFO - javascript benchmark 09:08:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7236.4881037812465, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2404.963925541117, 2695.3396417877625, 3300.735941124709, 3310.702036816686, 3340.8830690925806, 5567.721613919303, 5594.7202639868, 5609.158626206076, 5626.493615574597, 5676.0, 5594.692291923942, 5620.775168993236, 5634.183043458696, 5634.690092044946, 5650.5479561635075, 5105.974470127644, 5117.437081920985, 5177.45636708144, 5215.400228973679, 5242.0, 4310.849120280791, 5125.513076257749, 5179.093658609747, 5180.715060671661, 5183.455737147602, 5085.110105731482, 5114.565261952738, 5178.508041736029, 5183.3779946406485, 5186.0665080285535, 5167.173252279636, 5195.142801437758, 5199.714015729133, 5236.9526094781195, 5268.525832675077, 5140.023395554833, 5173.586113110942, 5175.844724658266, 5178.430372659004, 5198.870028249286, 4379.605835474823, 5460.6177567570285, 5531.1426728857095, 5738.598298119134, 5768.711564421804, 6073.757049718006, 6108.205933228652, 6114.419130182626, 6119.3502297494215, 6218.22272215973, 6262.874742505124, 6264.310925798159, 6279.968600157015, 6289.308176100625, 6299.590526615755, 5134.820281290137, 5731.656100633933, 5779.797707080232, 5790.768369265266, 5806.796762113306, 6150.477209437248, 6238.157848690459, 6248.781292654735, 6277.780277690259, 6285.685715714288, 5021.422536408287, 6009.2188015557695, 6112.53387702335, 6114.144019837227, 6120.0, 5306.734663266821, 6037.45662890342, 6222.439980401786, 6226.128342032119, 6229.4393504584805, 6012.278526576839, 6095.329513753483, 6103.05402662588, 6131.724072416752, 6142.723577439026, 6171.259448866164, 6194.752209911643, 6203.0, 6203.596766210182, 6219.253689557282, 4962.627802914796, 4964.652474326763, 4972.65191436596, 4976.929960058605, 4984.352034235526, 4291.206126866539, 4331.761753103609, 4355.08543205924, 4407.162639098561, 4433.8226470941445, 4747.454042785124, 5636.915446268309, 5714.5999780015, 5746.051901436216, 5754.223179870663, 6238.968805155945, 6256.874862502725, 6296.874062518724, 6297.96851015742, 6303.086052522451, 5568.025595520849, 5632.0, 5646.265985421951, 5660.433956604306, 5664.150377443334, 5391.406945236099, 5405.729713514309, 5405.864853378697, 5410.567154627621, 5410.756515956791, 6357.777477788348, 6374.394432528902, 6388.201474815648, 6391.776287829904, 6403.423691867754, 6094.360092190256, 6120.386183820725, 6121.483458747687, 6144.109104179958, 6263.404976527223, 6284.5600807943, 6322.0, 6325.905111423424, 6334.873302534015, 6381.489480841428, 6027.969860150846, 6109.75560977556, 6118.082287656887, 6124.418180272867, 6125.295591007091, 6101.176341193882, 6120.111926550627, 6157.076438534076, 6207.81376558704, 6211.782587609412, 6028.487578555872, 6094.0, 6105.419985101408, 6123.326434092335, 6139.171211886338, 5859.267591551056, 6000.429959153874, 6055.818325450244, 6079.817605471843, 6091.969540152271, 5679.630823996427, 5731.942680573307, 5780.682062486436, 5789.45000224978, 5877.735501902339, 6035.486983606443, 6039.365866583946, 6076.361981991828, 6109.43503133753, 6134.803982731443, 5933.525317974465, 5943.316518600243, 5951.642901425928, 5951.761929522944, 5959.880802384015], "value": 5617.518951445983, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [457.599600349694, 484.23490884402645, 515.5488947171226, 523.3432042786303, 534.5429657642716, 31165.0, 32529.51205731916, 36797.26405471896, 40487.39268910965, 41494.96262593429, 38461.80769096158, 42779.78610106953, 43155.56844431555, 43200.567994320045, 43259.13481730364, 6512.381323774234, 8207.58962051898, 8979.236764874977, 9227.3079519036, 9243.445393276392, 11053.668389948274, 11373.431328433546, 11413.885861141407, 11509.194356395055, 11646.30122192667, 11235.382053987069, 11252.943735281313, 11273.210875238736, 11282.041026512756, 11291.548338066468, 9579.616815327448, 11257.549698012112, 11327.716807079807, 11329.830052549218, 11389.829152562635, 11238.325700458, 11266.098712103012, 11324.377159256237, 11327.32036077838, 11363.886361136449, 40939.59060409388, 41102.0, 41189.79405102985, 41227.76316710503, 41282.793586031876, 3981.7013723970817, 3985.8206380712936, 4094.7133700640966, 4105.055837157441, 4186.183694179636, 29631.70368296311, 30243.848780756176, 30304.939327123666, 31351.84324078365, 31930.680693193237, 3136.6863313668678, 3161.162291992624, 3165.0979470850925, 3170.556122142879, 3237.75716821237, 486513.0, 487560.0, 489052.0, 490750.5462472701, 490824.0, 60273.69863150656, 60383.396166037775, 60656.0, 60799.0, 60818.0, 63950.0, 64017.71964560683, 64034.0, 64078.35921640817, 64349.67825160844, 16654.50036498907, 16839.41062062822, 16846.07346595949, 16847.915760421365, 16891.83108168927, 11536.365499897585, 11759.647210583697, 12941.705829416984, 13072.954163666884, 13300.73398532024, 20893.89553052225, 21689.891550542146, 21984.45038874041, 22100.115995360007, 22113.336599902028, 7432.85134297311, 8704.260137888225, 8871.334649901282, 8883.600237989305, 8901.198892099743, 886.1271647427279, 899.2131884600974, 899.5682072605186, 903.1239697493421, 934.5747684803398, 27429.62851857439, 30458.603693224228, 30928.0721578353, 31149.0, 31270.0, 951.9385884738467, 967.2890425537224, 1031.9174466042848, 1078.5955266774959, 1140.5950887435008, 14361.856381436051, 14376.35306411214, 14656.267186640625, 14662.882183049413, 14823.0, 179433.0, 241234.0, 242632.0, 242868.0, 243879.0, 62149.0, 62453.75092498124, 62708.0, 62893.0, 62937.0, 1438.8703231756394, 1456.9708605827825, 1462.2323280277726, 1483.384395475887, 1483.8961272710806, 25177.992880284582, 29431.411371772017, 30495.390092198475, 30805.845970770002, 31056.68943310538, 51913.7404312976, 52157.0, 52370.476295236556, 52424.0, 52652.47347526476, 464254.35745642113, 464415.0, 465190.6740466276, 466211.0, 466520.0, 35917.46123808093, 37075.07312317214, 41024.79487602662, 43713.56286437222, 44265.557344426146, 47353.76323118362, 47892.0, 48003.5199647999, 48283.5171648279, 48866.5113348862, 38648.613513865625, 38963.610363896, 39090.0, 39599.81200563988, 40890.591094088675, 39338.60661393464, 39504.2099158021, 39741.60258397495, 40272.0, 40717.59282407256, 30801.383972320877, 31559.526607101372, 37600.623993760804, 38774.2245155101, 38847.223055539296, 33503.83248083744, 34705.65294347024, 34771.82614086913, 35251.11872203215, 35261.47107793334, 25680.87159564265, 25743.742562574134, 25758.484830303663, 25885.482290354463, 25954.83203255896], "value": 20062.54079368714, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.2075019952115, 387.42274011722526, 395.25691699604744, 401.8131568820498, 414.3598140872352, 20138.798612013874, 21398.55328949668, 21512.247071352485, 21570.676439853374, 22017.33947981559, 21587.892060539674, 21725.23961661342, 22000.44998875029, 22168.667469987962, 22412.991415386306, 5424.810131645393, 5793.131030345461, 5804.303483581955, 5808.883822323551, 5825.1844741736195, 4201.0, 4630.768461576925, 4961.9751901240625, 5746.856328591798, 5811.157382179582, 5605.327360716719, 6437.034444833289, 6542.378474044958, 6547.967260163692, 6551.279359270477, 6333.55665103443, 6507.219133703962, 6547.803565893031, 6580.638064906429, 6587.308332625101, 5730.570207234432, 5747.712614369265, 5768.221290125821, 5774.105013722879, 5778.451047150514, 13046.282454465001, 13166.341682915912, 23376.597404155804, 23986.400339991465, 25088.99644014237, 2558.2581051495044, 2632.4735052989477, 2637.4988752137033, 2652.7214642462454, 2659.0427446119384, 9411.952940235255, 9435.575399107056, 9773.755656108655, 9995.100440960276, 10004.799904001951, 1770.4777090758257, 1825.6166205096945, 1839.9264029438807, 1859.6466671332403, 1864.5897902461436, 136072.999999999, 139460.0, 144063.27968360196, 145710.0, 146677.2666136673, 12101.757964840654, 12117.39413029345, 12210.0, 12268.141230113984, 12302.261864288172, 15661.0, 15759.0, 15799.289031993589, 15800.446984355493, 15854.9207253963, 7334.449916256195, 7986.64227081386, 8577.356698247531, 8834.955825220834, 8869.113088691209, 7528.247175282428, 8151.836963260702, 8676.95661521701, 8680.34897382699, 8820.77948051291, 4089.9591004090175, 4771.067692914968, 4840.685355451885, 4883.511648835088, 4915.361003069578, 1570.1128862192825, 2060.1759296281607, 2060.3825996592604, 3465.324261768981, 3688.66801987817, 858.4334339336008, 1024.8206563851297, 1026.2662196529518, 1062.1184416933927, 1066.4561073852392, 21011.684824727643, 21382.679259811117, 22008.669869951962, 22070.448238794157, 22077.889610551843, 1051.75283808305, 1074.6561100447782, 1087.3584585094675, 1096.786126705285, 1120.1878637987395, 11441.02751266135, 11449.427528623535, 11499.827502587468, 11559.422028898522, 11596.884031159749, 675588.0, 677421.0, 716171.0, 725720.0, 753321.0, 111932.76134477265, 118928.99999999827, 137635.0, 146026.0, 152357.0, 905.7319752346635, 946.3233787841726, 993.513178542509, 1014.8173328800739, 1015.7257540463886, 18095.45713628593, 18393.724094138866, 18638.881667100017, 18699.813001869807, 18883.0, 57655.270341888136, 57710.711446442496, 60168.49578760391, 60440.0, 61130.388696112466, 64845.0, 80221.0, 84959.0, 85432.71850922366, 85860.0, 8204.753857384288, 8268.0, 8355.832883342178, 8580.485170889766, 8675.91324086751, 9152.542372881462, 12736.74526509483, 13213.339333033502, 13370.732585348433, 14066.437342506186, 11615.535378584762, 11856.17006809515, 11860.94069529647, 11880.227785193934, 11952.163348565517, 10333.5533025378, 11519.193656444304, 11719.941400292944, 11865.11011674145, 11923.509561304836, 11960.940195298968, 11984.101192410779, 11990.940045299718, 12010.819837702267, 12088.818667719815, 8494.830103397773, 8587.355948303777, 8645.913540864762, 8751.168638979287, 8772.166644168794, 10798.838017429902, 11698.649040528799, 11722.296662200295, 11783.351915644378, 12206.084543659439], "value": 10008.745671744677, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1208.2931485081226, 1456.439270880712, 1466.3254902744736, 1466.3694611317133, 1476.2840022589041, 6538.574992625476, 7470.1035875695, 7548.20743821899, 8372.246497815195, 8385.161483851613, 7905.604719764003, 8170.468919520227, 8170.6323215455295, 8277.841102245691, 8284.544350060743, 2022.929197478085, 2221.80003799658, 2310.722713274401, 2314.96527552086, 2320.106758897828, 2068.948276293097, 2147.7852214778477, 2288.3135059482174, 2322.036354912709, 2349.95300093998, 1850.1581780290003, 2289.942751431211, 2326.941826454335, 2340.0639744102323, 2345.026813872241, 2106.7050612914204, 2268.727752669682, 2307.134824440843, 2318.1538738360546, 2325.395397196724, 2174.597699425611, 2318.826088043387, 2326.4183954011496, 2338.263447014185, 2350.988245058764, 8252.257296843252, 8299.751007469786, 8307.0, 8308.667653293922, 8328.208820162075, 5019.749012549358, 5170.121079416471, 5173.094708426011, 5179.326687530634, 5190.4031036430915, 2871.1817132117453, 3162.5572419861237, 3370.8146051967133, 3395.9830200849083, 3401.812900290483, 857.1668951455251, 1130.9434528273553, 1148.7645032768262, 1152.8558930133734, 1179.9233049851732, 10525.315854469434, 10653.414062226575, 10678.305910115896, 10689.518971646217, 10717.35695858251, 4564.566366195206, 4694.483606803249, 4720.527947205252, 4749.4063242094735, 4772.546608072227, 9318.440893546409, 9329.300302477206, 9421.90578094224, 9438.00900905395, 9452.716418507456, 5193.143131383279, 5205.167173252262, 5205.817796377184, 5218.7912483500995, 5222.3472065991755, 4632.930506042412, 4638.652101092432, 4681.648876334289, 4736.928946065812, 4757.8096876125255, 3858.961410385916, 3896.279188350164, 3925.450436938831, 3982.143839074613, 3997.920041599152, 989.9703008909744, 1170.9180357375071, 1212.2665787198794, 1267.4106540458547, 1275.9744805103846, 794.4835856693196, 856.1139220906332, 878.1218781218781, 903.6249956268207, 911.5305617606938, 5461.617686761968, 5536.7785288588, 5617.775288988477, 5702.714864256771, 5724.112762521816, 800.6917336825247, 998.8801343838786, 1006.1196453103535, 1010.802893435773, 1018.3075508654039, 3562.5012498250267, 3779.981100094482, 3787.981060094682, 3803.7717736935874, 3822.1591249924973, 9485.905140948502, 9694.75763105914, 9735.9026409735, 9787.461689606998, 9802.411855288705, 9254.167124958785, 9458.385204961656, 9751.853722194173, 9767.560459779326, 9797.559109840075, 7615.771526854203, 7733.110692270348, 7749.225077492319, 7812.921870781333, 7835.725749598737, 5446.237526746179, 5540.63985840919, 5600.27196464457, 5689.8862022758485, 5770.0190967536455, 9002.774930626787, 9025.548722563713, 9193.724188274362, 9200.125988031126, 9203.40177888435, 8606.913930860612, 8900.332475064526, 9067.04795996411, 9152.17630413266, 9169.54152292396, 7076.823079422849, 7172.569645821268, 7173.784786456415, 7232.927670723226, 7241.782746517402, 7748.728794492165, 7816.88274675869, 7831.96084019599, 7832.569208693577, 7864.977552918084, 6151.0, 7104.289571042855, 7124.964375178091, 7128.322809333105, 7195.604241766753, 6929.722811087701, 6974.965125174342, 7004.859902801813, 7030.894536582057, 7038.366547010589, 6393.264774550986, 6413.807585772434, 6451.516136289891, 6490.902636460552, 6508.0, 4081.91836163281, 4614.700044497231, 4638.721676699409, 4675.018246168343, 4687.67186296956, 4954.702717836942, 5001.0, 5038.722870242172, 5087.262346959744, 5104.974475127749], "value": 4352.271748987417, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.84909969565064, 352.71611334741544, 363.1284916201117, 364.25328077441236, 369.4439867998663, 4361.847335343264, 4435.911281774363, 4789.904201915964, 5202.427732949377, 5295.841124766263, 5310.575153987681, 5343.599230057742, 5360.597955153369, 5366.517013468797, 5369.973150134244, 3350.514175444559, 4213.536510983797, 4251.341042138473, 4263.571703479338, 4264.23243816113, 3077.7845550811453, 3791.109089363997, 4199.3281075028, 4274.145170965804, 4288.807003684841, 3780.0, 4161.563035881234, 4176.853810116631, 4192.268880696183, 4192.748435093904, 3942.7240093193486, 4207.221663992141, 4210.705250632457, 4242.0, 4309.332053531708, 3681.4109742441346, 3711.4432835074685, 3743.6630703236565, 3753.474513568103, 3754.3429899767702, 4171.91656166875, 5223.895522089537, 5225.980933717927, 5245.167609490871, 5254.474552544753, 3919.3729003359613, 4080.6531444827224, 4899.093667671492, 4904.651220914241, 4908.092002979461, 5558.996284013297, 5721.513671337942, 5734.197212390269, 5758.280214973129, 5758.309002919635, 3346.7322614190807, 3409.09658940381, 3585.6593623605977, 3834.6740527055235, 4071.9389209161886, 5552.639078459928, 5893.899813692808, 5938.257717785234, 5956.344802071769, 5980.641161530322, 3003.6695963444004, 3310.2386451116377, 3878.301905657009, 3910.882673519799, 3977.3039718049226, 3760.2479504099288, 3942.64516193544, 3964.345882929342, 3976.5824588418377, 3988.12261302513, 4140.710150289511, 4384.188925048876, 4619.792109355087, 4625.629949604024, 4635.490096089427, 5466.890662186734, 5566.636174137362, 5667.489925906688, 5705.771769129188, 5754.971225143931, 1063.1813503602184, 1095.742500512379, 1161.3670549550516, 1275.6810797300675, 1283.371148137406, 847.6185716427509, 867.1805144138855, 872.2411501993306, 874.0909454167595, 875.2035647560689, 4329.6536277098385, 4383.276759334674, 4765.428148622187, 5051.646384753032, 5067.771950262247, 4594.540545945379, 5054.635248482889, 5468.48049435303, 5623.240862483594, 5701.71491425427, 4350.73895566267, 4524.88687782808, 4917.410290487964, 4947.381577302837, 4982.476839931827, 2451.963220551693, 2516.471540976379, 2715.728427157308, 2937.9706202938123, 3045.543168524739, 5038.496150384932, 5214.426413094557, 5284.735763211824, 5421.1055175895535, 5611.849570837969, 5239.973800130975, 5450.781968721207, 5451.155070964007, 5660.462256085665, 5800.0, 4745.976270118696, 5225.719698673774, 5344.652597581145, 5506.93489941272, 5794.275715535558, 4377.4528183977, 5032.220005899091, 5061.076790819465, 5575.442455754554, 5647.407022262603, 4586.9541304587865, 4737.810487580596, 5349.866253343697, 5449.373322068013, 5857.765689372377, 4981.800727970841, 5173.4826517347965, 5395.352557692945, 6109.969450152721, 6196.349383314687, 3926.234384295149, 3933.731900887569, 3933.822977965941, 3963.56400795918, 4002.099527606382, 5159.896802063862, 5298.576113910801, 5505.871296384152, 5569.637973531708, 5855.975204339309, 5571.0, 5571.0, 5644.520215781705, 5715.5713321500225, 5772.826815195551, 4782.8999330153565, 5643.746031428514, 5674.858128546819, 5705.286839145107, 5784.471472401916, 5383.353997520323, 5495.670259784426, 5540.445955404427, 5592.608517403743, 5595.832125036255, 4891.559759621651, 5288.550473209666, 5683.403242659627, 5712.857178570569, 5757.021306377842, 5018.146915024382, 5200.583953283804, 5582.3859375467855, 5630.831075067755, 5631.493165615114], "value": 4056.659238139281, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.3579670906055, 704.2851505721691, 744.162816831065, 793.5278509286974, 811.5455345006799, 13634.522791702293, 14320.570382888503, 14356.353964071615, 14420.13479191248, 14511.129332240072, 12096.91127798498, 12970.546030888921, 13198.670033249173, 13226.735465290712, 13250.0, 782.647808486182, 845.1337379186352, 851.221132663612, 855.341387131908, 871.5337294547419, 843.6709683223547, 845.5898889038812, 855.5764896376303, 856.374846362156, 856.5417501636625, 901.6618767962015, 905.6830109461702, 906.5104843384564, 907.3739120007207, 908.8545832666774, 875.1336177184605, 895.5566994337812, 898.2230370729337, 900.1538553759445, 901.9503927283997, 666.4768156996782, 674.4267372733186, 675.0818886314609, 675.0987431778582, 675.4326365852659, 13576.049676522647, 13903.957203209698, 14682.412703491847, 14692.0, 14709.705805883823, 13596.184228946295, 13863.653408664763, 13966.441342346294, 14092.224927628977, 14117.78823317651, 11282.774344513145, 11393.202475826696, 11402.657920262405, 11515.251508651994, 11965.820512692317, 3365.831708414594, 3450.5859296884532, 3455.7926524408363, 3473.6873681368547, 3545.592256890465, 111110.88889111087, 112463.43768281188, 114890.42554787172, 115651.84348156495, 115662.26506602408, 10837.242387914137, 10876.590235765805, 10982.670519884416, 11023.338599684044, 11357.148213883991, 21998.01008954601, 22435.775642243694, 22435.887820561118, 22443.0, 22511.662325065136, 7364.96317518409, 7366.815829604196, 7444.516106453063, 7445.925540744632, 7596.354309883722, 3290.68738469845, 3943.7042221833476, 4040.1717647882115, 4131.116314139424, 4173.269677806372, 3441.8795342162903, 3521.7886926784477, 3528.8588456461966, 3543.681068703829, 3556.413191823372, 506.3817980022148, 634.6033728919425, 636.4653690899667, 643.6427782580619, 646.6475770704883, 637.6875331087733, 645.7287939065603, 669.5714742564762, 674.6255828015499, 681.465049935798, 9069.77325566853, 9224.031476694985, 9994.700158995242, 10114.696559103091, 10195.388276703421, 436.8864095335236, 457.37339844413367, 536.5546596325041, 551.3056325389314, 554.1323650110742, 4545.113702827983, 4715.764211789466, 4759.4764575896625, 4771.976140119277, 4821.783019764119, 110189.34715979267, 110253.0, 111102.0, 111861.0, 115053.4247328758, 98747.0, 99450.0, 100919.49540252252, 101570.98429015615, 103189.96810031954, 83393.0, 84001.73997390045, 84533.30933381298, 85156.57421712976, 87624.6856297156, 9070.455772653662, 9255.861162082709, 9373.906260937303, 9414.540101995894, 9497.905020949702, 54311.0, 54801.90396191974, 54972.45027549673, 55619.44380556142, 55827.720861395435, 72348.27651723416, 72810.63594681992, 72942.0, 73986.63006684932, 75111.87332189913, 11024.944875275572, 11034.558617655204, 11324.6036388726, 11648.650540483799, 11663.708407289885, 11944.522219111486, 12068.517259309529, 12234.0, 12352.814707779571, 12869.099163058496, 11145.72135696614, 11235.15736319763, 11585.768284634429, 11594.6521604352, 11657.591984280509, 9732.172765315028, 11140.442977851237, 11438.084953203557, 11551.036323824801, 12064.75870482603, 9114.40756350835, 9368.578413971523, 11786.882131178578, 11859.762804743685, 12271.325077120488, 9508.809823803624, 9579.473128977694, 9624.230061594915, 10077.0, 10247.743806404602, 9258.166764991183, 9483.573239204114, 9562.952185239308, 9567.61729530811, 9572.9042709572], "value": 7209.79840908499, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 119.0, 120.0, 120.0, 120.0, 118.0, 120.0, 119.0, 120.0, 119.0], "value": 118.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 113.0, 115.0, 148.0, 113.0, 113.0, 113.0, 107.0, 131.0, 114.0], "value": 120.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 201.0, 197.0, 203.0, 198.0, 208.0, 195.0, 195.0, 197.0, 200.0], "value": 199.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 57.0, 88.0, 63.0, 60.0, 59.0, 60.0, 83.0, 61.0], "value": 67.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 84.0, 75.0, 70.0, 71.0, 81.0, 73.0, 73.0, 82.0], "value": 76.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 89.0, 92.0, 90.0, 92.0, 90.0, 81.0, 126.0, 92.0, 89.0], "value": 93.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 106.0, 153.0, 122.0, 143.0, 151.0, 121.0, 107.0, 152.0, 105.0], "value": 130.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 147.0, 146.0, 97.0, 93.0, 93.0, 95.0, 100.0, 94.0, 118.0], "value": 106.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 63.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 80.0, 91.0, 109.0, 105.0, 85.0, 71.0, 74.0, 72.0, 74.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 108.0, 88.0, 86.0, 88.0, 87.0, 83.0, 84.0, 86.0, 82.0], "value": 89.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 158.0, 153.0, 138.0, 153.0, 145.0, 144.0, 145.0, 202.0, 150.0], "value": 151.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 172.0, 170.0, 168.0, 171.0, 169.0, 168.0, 170.0, 166.0, 172.0], "value": 169.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 64.0, 67.0, 67.0, 66.0, 66.0, 65.0, 68.0, 68.0], "value": 66.6, "unit": "score"}]}]} 09:08:34 INFO - Return code: 0 09:08:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:08:34 ERROR - # TBPL SUCCESS # 09:08:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:08:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:08:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:08:34 INFO - 2017-02-04 09:08:34.707 screenresolution[1910:12243] starting screenresolution argv=screenresolution get 09:08:34 INFO - 2017-02-04 09:08:34.709 screenresolution[1910:12243] Display 0: 1600x1200x32@60 09:08:34 INFO - 2017-02-04 09:08:34.715 screenresolution[1911:12246] starting screenresolution argv=screenresolution list 09:08:34 INFO - Available Modes on Display 0 09:08:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:08:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:08:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:08:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:08:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:08:34 INFO - Intel Iris: 09:08:34 INFO - Chipset Model: Intel Iris 09:08:34 INFO - Type: GPU 09:08:34 INFO - Bus: Built-In 09:08:34 INFO - VRAM (Dynamic, Max): 1536 MB 09:08:34 INFO - Vendor: Intel (0x8086) 09:08:34 INFO - Device ID: 0x0a2e 09:08:34 INFO - Revision ID: 0x0009 09:08:34 INFO - Displays: 09:08:34 INFO - Display: 09:08:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:08:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:08:34 INFO - Display Serial Number: 1600x1200 60 09:08:34 INFO - Main Display: Yes 09:08:34 INFO - Mirror: Off 09:08:34 INFO - Online: Yes 09:08:34 INFO - Rotation: Supported 09:08:34 INFO - Return code: 0 09:08:34 INFO - Running post-action listener: _resource_record_post_action 09:08:34 INFO - [mozharness: 2017-02-04 17:08:34.950058Z] Finished run-tests step (success) 09:08:34 INFO - Running post-run listener: _resource_record_post_run 09:08:35 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 3331584; Write bytes: 510044160; Read time: 30; Write time: 1787 09:08:35 INFO - TinderboxPrint: CPU usage
54.2% 09:08:35 INFO - TinderboxPrint: I/O read bytes / time
3,331,584 / 30 09:08:35 INFO - TinderboxPrint: I/O write bytes / time
510,044,160 / 1,787 09:08:35 INFO - TinderboxPrint: CPU idle
2,190.0 (45.8%) 09:08:35 INFO - TinderboxPrint: CPU system
968.4 (20.2%) 09:08:35 INFO - TinderboxPrint: CPU user
1,627.3 (34.0%) 09:08:35 INFO - TinderboxPrint: Swap in / out
211,382,272 / 0 09:08:35 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 199367168; Write bytes: 198819840; Read time: 15507; Write time: 363 09:08:35 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 3331584; Write bytes: 301410304; Read time: 30; Write time: 1395 09:08:35 INFO - Running post-run listener: _upload_blobber_files 09:08:35 INFO - Blob upload gear active. 09:08:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:08:35 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 09:08:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:08:35 INFO - (blobuploader) - INFO - Open directory for files ... 09:08:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:08:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:08:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:36 INFO - (blobuploader) - INFO - Done attempting. 09:08:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:08:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:08:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:37 INFO - (blobuploader) - INFO - Done attempting. 09:08:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:08:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:08:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:38 INFO - (blobuploader) - INFO - Done attempting. 09:08:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:08:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:08:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:40 INFO - (blobuploader) - INFO - Done attempting. 09:08:40 INFO - (blobuploader) - INFO - Iteration through files over. 09:08:40 INFO - Return code: 0 09:08:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:08:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:08:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01e3664bccece0667fdb93c780a63a1b40fc5a43a1c82b7557acd34230aa9d22b2c8206e79d36e483a460bc100b7314820b3dfa7b62971a2216fd2f242bda737", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/99ff28290d51b2c2285f90bf6cec02edbbed92e30c1be546f5caf8b68165e37d6cbecdcde8ab483c6e8c26d019c0297db3620bbc70c4d1170361c93f68e2f484", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffb3b549a6f2dce57d026c7a766ded45264bcd0e03b424bc82116790fd4137d53919f97882d24cde6c4b0f5aa97ca02a5875a67897608670c8c95ff475c7f9b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc820ee9178d15dd443691c1c16465049162deab620ae06edc04911f6222fd6f99eab5d8283ecd93f3507809ede0d6c3fdc7cc6713d3ef2dfadc0ea3029d7d9b"} 09:08:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:08:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:08:40 INFO - Contents: 09:08:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01e3664bccece0667fdb93c780a63a1b40fc5a43a1c82b7557acd34230aa9d22b2c8206e79d36e483a460bc100b7314820b3dfa7b62971a2216fd2f242bda737", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/99ff28290d51b2c2285f90bf6cec02edbbed92e30c1be546f5caf8b68165e37d6cbecdcde8ab483c6e8c26d019c0297db3620bbc70c4d1170361c93f68e2f484", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffb3b549a6f2dce57d026c7a766ded45264bcd0e03b424bc82116790fd4137d53919f97882d24cde6c4b0f5aa97ca02a5875a67897608670c8c95ff475c7f9b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc820ee9178d15dd443691c1c16465049162deab620ae06edc04911f6222fd6f99eab5d8283ecd93f3507809ede0d6c3fdc7cc6713d3ef2dfadc0ea3029d7d9b"} 09:08:40 INFO - Running post-run listener: copy_logs_to_upload_dir 09:08:40 INFO - Copying logs to upload dir... 09:08:40 INFO - mkdir: /builds/slave/test/build/upload/logs 09:08:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.118437 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-02-04 09:08:40.914000) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-04 09:08:40.917682) ========= 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.TvhCkkk9NV/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.R9bHXAHA3C/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01e3664bccece0667fdb93c780a63a1b40fc5a43a1c82b7557acd34230aa9d22b2c8206e79d36e483a460bc100b7314820b3dfa7b62971a2216fd2f242bda737", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/99ff28290d51b2c2285f90bf6cec02edbbed92e30c1be546f5caf8b68165e37d6cbecdcde8ab483c6e8c26d019c0297db3620bbc70c4d1170361c93f68e2f484", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffb3b549a6f2dce57d026c7a766ded45264bcd0e03b424bc82116790fd4137d53919f97882d24cde6c4b0f5aa97ca02a5875a67897608670c8c95ff475c7f9b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc820ee9178d15dd443691c1c16465049162deab620ae06edc04911f6222fd6f99eab5d8283ecd93f3507809ede0d6c3fdc7cc6713d3ef2dfadc0ea3029d7d9b"} build_url:https://queue.taskcluster.net/v1/task/VhFyK4cgSK2dHGfdHnkhGw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011041 build_url: 'https://queue.taskcluster.net/v1/task/VhFyK4cgSK2dHGfdHnkhGw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01e3664bccece0667fdb93c780a63a1b40fc5a43a1c82b7557acd34230aa9d22b2c8206e79d36e483a460bc100b7314820b3dfa7b62971a2216fd2f242bda737", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/99ff28290d51b2c2285f90bf6cec02edbbed92e30c1be546f5caf8b68165e37d6cbecdcde8ab483c6e8c26d019c0297db3620bbc70c4d1170361c93f68e2f484", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffb3b549a6f2dce57d026c7a766ded45264bcd0e03b424bc82116790fd4137d53919f97882d24cde6c4b0f5aa97ca02a5875a67897608670c8c95ff475c7f9b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc820ee9178d15dd443691c1c16465049162deab620ae06edc04911f6222fd6f99eab5d8283ecd93f3507809ede0d6c3fdc7cc6713d3ef2dfadc0ea3029d7d9b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-04 09:08:40.951431) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 09:08:40.951753) ========= 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.TvhCkkk9NV/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.R9bHXAHA3C/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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.004866 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 09:08:41.000186) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-04 09:08:41.000514) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-04 09:08:41.000837) ========= ========= Total master_lag: 0.20 =========