builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0096 starttime: 1486210965.1 results: success (0) buildid: 20170204030205 builduid: 919b4b863515410bb6db811abb7219b8 revision: 7aa5e444af0ff686714d6165bd0e7e6d1abd0970 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-04 04:22:45.098193) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-04 04:22:45.098753) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-04 04:22:45.099047) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-04 04:22:45.123931) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 04:22:45.124346) ========= 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.Rtm9tW3vHt/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.yGRqmxlIQw/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 04:22:45-- 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% 147M=0s 2017-02-04 04:22:45 (147 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.488468 ========= master_lag: 0.17 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 04:22:45.782784) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 04:22:45.783288) ========= 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.Rtm9tW3vHt/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.yGRqmxlIQw/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.019807 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 04:22:45.825493) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-04 04:22:45.825933) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7aa5e444af0ff686714d6165bd0e7e6d1abd0970 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 7aa5e444af0ff686714d6165bd0e7e6d1abd0970 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Rtm9tW3vHt/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.yGRqmxlIQw/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 04:22:45,913 truncating revision to first 12 chars 2017-02-04 04:22:45,913 Setting DEBUG logging. 2017-02-04 04:22:45,913 attempt 1/10 2017-02-04 04:22:45,913 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7aa5e444af0f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-04 04:22:47,149 unpacking tar archive at: mozilla-central-7aa5e444af0f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.486563 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-04 04:22:47.336341) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-04 04:22:47.336656) ========= script_repo_revision: 7aa5e444af0ff686714d6165bd0e7e6d1abd0970 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-04 04:22:47.337052) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-04 04:22:47.337329) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-04 04:22:47.356963) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-02-04 04:22:47.357357) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Rtm9tW3vHt/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.yGRqmxlIQw/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 04:22:47 INFO - MultiFileLogger online at 20170204 04:22:47 in /builds/slave/test 04:22:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:22:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:22:47 INFO - {'append_to_log': False, 04:22:47 INFO - 'base_work_dir': '/builds/slave/test', 04:22:47 INFO - 'blob_upload_branch': 'Firefox', 04:22:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:22:47 INFO - 'branch': 'Firefox', 04:22:47 INFO - 'buildbot_json_path': 'buildprops.json', 04:22:47 INFO - 'config_files': ('talos/mac_config.py',), 04:22:47 INFO - 'default_actions': ('clobber', 04:22:47 INFO - 'read-buildbot-config', 04:22:47 INFO - 'download-and-extract', 04:22:47 INFO - 'populate-webroot', 04:22:47 INFO - 'create-virtualenv', 04:22:47 INFO - 'install', 04:22:47 INFO - 'run-tests'), 04:22:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:22:47 INFO - 'download_minidump_stackwalk': True, 04:22:47 INFO - 'download_symbols': 'ondemand', 04:22:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:22:47 INFO - 'tooltool.py': '/tools/tooltool.py', 04:22:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:22:47 INFO - '/tools/misc-python/virtualenv.py')}, 04:22:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:22:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:22:47 INFO - 'installer_path': 'installer.exe', 04:22:47 INFO - 'log_level': 'info', 04:22:47 INFO - 'log_name': 'talos', 04:22:47 INFO - 'log_to_console': True, 04:22:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:22:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:22:47 INFO - 'opt_config_files': (), 04:22:47 INFO - 'pip_index': False, 04:22:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:22:47 INFO - 'cmd': ('bash', 04:22:47 INFO - '-c', 04:22:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:22:47 INFO - 'enabled': True, 04:22:47 INFO - 'halt_on_failure': False, 04:22:47 INFO - 'name': 'check_screen_resolution'},), 04:22:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:22:47 INFO - 'cmd': ('bash', 04:22:47 INFO - '-c', 04:22:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:22:47 INFO - 'enabled': True, 04:22:47 INFO - 'halt_on_failure': False, 04:22:47 INFO - 'name': 'check_screen_resolution'},), 04:22:47 INFO - 'run_cmd_checks_enabled': True, 04:22:47 INFO - 'sps_profile': False, 04:22:47 INFO - 'sps_profile_interval': 0, 04:22:47 INFO - 'suite': 'dromaeojs-e10s', 04:22:47 INFO - 'system_bits': '32', 04:22:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:22:47 INFO - 'title': 't-yosemite-r7-0096', 04:22:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:22:47 INFO - 'use_talos_json': True, 04:22:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:22:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:22:47 INFO - 'work_dir': 'build'} 04:22:47 INFO - [mozharness: 2017-02-04 12:22:47.567729Z] Running clobber step. 04:22:47 INFO - Running pre-action listener: _resource_record_pre_action 04:22:47 INFO - Running main action method: clobber 04:22:47 INFO - rmtree: /builds/slave/test/build 04:22:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:22:49 INFO - Running post-action listener: _resource_record_post_action 04:22:49 INFO - [mozharness: 2017-02-04 12:22:49.374992Z] Finished clobber step (success) 04:22:49 INFO - [mozharness: 2017-02-04 12:22:49.375185Z] Running read-buildbot-config step. 04:22:49 INFO - Running pre-action listener: _resource_record_pre_action 04:22:49 INFO - Running main action method: read_buildbot_config 04:22:49 INFO - Using buildbot properties: 04:22:49 INFO - { 04:22:49 INFO - "project": "", 04:22:49 INFO - "product": "firefox", 04:22:49 INFO - "script_repo_revision": "production", 04:22:49 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:22:49 INFO - "repository": "", 04:22:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:22:49 INFO - "buildid": "20170204030205", 04:22:49 INFO - "stage_platform": "macosx64", 04:22:49 INFO - "basedir": "/builds/slave/test", 04:22:49 INFO - "nightly_build": "True", 04:22:49 INFO - "buildnumber": 82, 04:22:49 INFO - "slavename": "t-yosemite-r7-0096", 04:22:49 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:22:49 INFO - "platform": "yosemite_r7", 04:22:49 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:22:49 INFO - "branch": "mozilla-central", 04:22:49 INFO - "repo_path": "mozilla-central", 04:22:49 INFO - "revision": "7aa5e444af0ff686714d6165bd0e7e6d1abd0970", 04:22:49 INFO - "pgo_build": "False", 04:22:49 INFO - "builduid": "919b4b863515410bb6db811abb7219b8", 04:22:49 INFO - "slavebuilddir": "test" 04:22:49 INFO - } 04:22:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/NS6fQSoISISw3FvvWU7BUA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 04:22:49 INFO - Running post-action listener: _resource_record_post_action 04:22:49 INFO - [mozharness: 2017-02-04 12:22:49.384438Z] Finished read-buildbot-config step (success) 04:22:49 INFO - [mozharness: 2017-02-04 12:22:49.385089Z] Running download-and-extract step. 04:22:49 INFO - Running pre-action listener: _resource_record_pre_action 04:22:49 INFO - Running main action method: download_and_extract 04:22:49 INFO - mkdir: /builds/slave/test/build/tests 04:22:49 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')]} 04:22:49 INFO - trying https://queue.taskcluster.net/v1/task/NS6fQSoISISw3FvvWU7BUA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 04:22:49 INFO - Downloading https://queue.taskcluster.net/v1/task/NS6fQSoISISw3FvvWU7BUA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:22:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NS6fQSoISISw3FvvWU7BUA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 04:22:50 INFO - Downloaded 1199 bytes. 04:22:50 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:22:50 INFO - Using the following test package requirements: 04:22:50 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:22:50 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:22:50 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 04:22:50 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:22:50 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 04:22:50 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:22:50 INFO - u'jsshell-mac.zip'], 04:22:50 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:22:50 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 04:22:50 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:22:50 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:22:50 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 04:22:50 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:22:50 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 04:22:50 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:22:50 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 04:22:50 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:22:50 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 04:22:50 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:22:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NS6fQSoISISw3FvvWU7BUA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:22:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NS6fQSoISISw3FvvWU7BUA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:22:50 INFO - Fetch https://queue.taskcluster.net/v1/task/NS6fQSoISISw3FvvWU7BUA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:22:52 INFO - Expected file size: 34851118 04:22:52 INFO - Obtained file size: 34851118 04:22:59 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:22:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NS6fQSoISISw3FvvWU7BUA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:22:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NS6fQSoISISw3FvvWU7BUA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:22:59 INFO - Fetch https://queue.taskcluster.net/v1/task/NS6fQSoISISw3FvvWU7BUA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:23:00 INFO - Expected file size: 34851118 04:23:00 INFO - Obtained file size: 34851118 04:23:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NS6fQSoISISw3FvvWU7BUA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 04:23:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NS6fQSoISISw3FvvWU7BUA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:23:06 INFO - Fetch https://queue.taskcluster.net/v1/task/NS6fQSoISISw3FvvWU7BUA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 04:23:07 INFO - Expected file size: 14403454 04:23:07 INFO - Obtained file size: 14403454 04:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:23:08 INFO - trying https://queue.taskcluster.net/v1/task/NS6fQSoISISw3FvvWU7BUA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:23:08 INFO - Downloading https://queue.taskcluster.net/v1/task/NS6fQSoISISw3FvvWU7BUA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 04:23:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NS6fQSoISISw3FvvWU7BUA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 04:23:10 INFO - Downloaded 70365052 bytes. 04:23:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NS6fQSoISISw3FvvWU7BUA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:23:10 INFO - mkdir: /builds/slave/test/properties 04:23:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:23:10 INFO - Writing to file /builds/slave/test/properties/build_url 04:23:10 INFO - Contents: 04:23:10 INFO - build_url:https://queue.taskcluster.net/v1/task/NS6fQSoISISw3FvvWU7BUA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:23:10 INFO - Running post-action listener: _resource_record_post_action 04:23:10 INFO - Running post-action listener: set_extra_try_arguments 04:23:10 INFO - [mozharness: 2017-02-04 12:23:10.754638Z] Finished download-and-extract step (success) 04:23:10 INFO - [mozharness: 2017-02-04 12:23:10.754785Z] Running populate-webroot step. 04:23:10 INFO - Running pre-action listener: _resource_record_pre_action 04:23:10 INFO - Running main action method: populate_webroot 04:23:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:23:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:23:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:23:10 INFO - '--tppagecycles', 04:23:10 INFO - '7'], 04:23:10 INFO - 'tests': ['tsvgm']}}, 04:23:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:23:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:23:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:23:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:23:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:23:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:23:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:23:10 INFO - 'talos_options': ['--disable-e10s'], 04:23:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:23:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:23:10 INFO - 'talos_options': ['--disable-e10s'], 04:23:10 INFO - 'tests': ['damp', 'tps']}, 04:23:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:23:10 INFO - 'tests': ['damp', 'tps']}, 04:23:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:23:10 INFO - 'tests': ['dromaeo_dom']}, 04:23:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:23:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:23:10 INFO - 'tests': ['basic_compositor_video']}, 04:23:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:23:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:23:10 INFO - 'tests': ['a11yr', 04:23:10 INFO - 'ts_paint', 04:23:10 INFO - 'tpaint', 04:23:10 INFO - 'sessionrestore', 04:23:10 INFO - 'sessionrestore_no_auto_restore', 04:23:10 INFO - 'tabpaint']}, 04:23:10 INFO - 'other-e10s': {'tests': ['a11yr', 04:23:10 INFO - 'ts_paint', 04:23:10 INFO - 'tpaint', 04:23:10 INFO - 'sessionrestore', 04:23:10 INFO - 'sessionrestore_no_auto_restore', 04:23:10 INFO - 'tabpaint']}, 04:23:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:23:10 INFO - 'ts_paint', 04:23:10 INFO - 'tpaint', 04:23:10 INFO - 'sessionrestore', 04:23:10 INFO - 'sessionrestore_no_auto_restore', 04:23:10 INFO - 'tabpaint']}, 04:23:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:23:10 INFO - 'ts_paint', 04:23:10 INFO - 'tpaint', 04:23:10 INFO - 'sessionrestore', 04:23:10 INFO - 'sessionrestore_no_auto_restore', 04:23:10 INFO - 'tabpaint']}, 04:23:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:23:10 INFO - 'tests': ['a11yr', 04:23:10 INFO - 'ts_paint', 04:23:10 INFO - 'tpaint', 04:23:10 INFO - 'sessionrestore', 04:23:10 INFO - 'sessionrestore_no_auto_restore', 04:23:10 INFO - 'tabpaint']}, 04:23:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:23:10 INFO - 'tests': ['a11yr', 04:23:10 INFO - 'ts_paint', 04:23:10 INFO - 'tpaint', 04:23:10 INFO - 'sessionrestore', 04:23:10 INFO - 'sessionrestore_no_auto_restore', 04:23:10 INFO - 'tabpaint']}, 04:23:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:23:10 INFO - 'tests': ['tsvgx', 04:23:10 INFO - 'tsvgr_opacity', 04:23:10 INFO - 'tart', 04:23:10 INFO - 'tscrollx', 04:23:10 INFO - 'cart', 04:23:10 INFO - 'tsvg_static']}, 04:23:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:23:10 INFO - 'tsvgr_opacity', 04:23:10 INFO - 'tart', 04:23:10 INFO - 'tscrollx', 04:23:10 INFO - 'cart', 04:23:10 INFO - 'tsvg_static']}, 04:23:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:23:10 INFO - 'talos_options': ['--disable-e10s'], 04:23:10 INFO - 'tests': ['tp5o']}, 04:23:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:23:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:23:10 INFO - 'talos_options': ['--disable-e10s', 04:23:10 INFO - '--xperf_path', 04:23:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:10 INFO - 'tests': ['tp5n']}, 04:23:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:23:10 INFO - 'talos_options': ['--xperf_path', 04:23:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:10 INFO - 'tests': ['tp5n']}}, 04:23:10 INFO - 'talos.zip': {'path': '', 04:23:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:23:10 INFO - Running post-action listener: _resource_record_post_action 04:23:10 INFO - [mozharness: 2017-02-04 12:23:10.773557Z] Finished populate-webroot step (success) 04:23:10 INFO - [mozharness: 2017-02-04 12:23:10.773666Z] Running create-virtualenv step. 04:23:10 INFO - Running pre-action listener: _resource_record_pre_action 04:23:10 INFO - Running main action method: create_virtualenv 04:23:10 INFO - Creating virtualenv /builds/slave/test/build/venv 04:23:10 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 04:23:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:23:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:23:10 INFO - Using real prefix '/tools/python27' 04:23:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:23:11 INFO - Installing distribute.............................................................................................................................................................................................done. 04:23:14 INFO - Installing pip.................done. 04:23:14 INFO - Return code: 0 04:23:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:23:14 INFO - Reading from file tmpfile_stdout 04:23:14 INFO - Output received: 04:23:14 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) 04:23:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:23: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')]} 04:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23: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')]} 04:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5104c1750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a84d30>, '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 0x1099abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a79be8>, '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.Rtm9tW3vHt/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.yGRqmxlIQw/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 04:23: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', 'pip>=1.5'] in /builds/slave/test/build 04:23: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 pip>=1.5 04:23:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rtm9tW3vHt/Render', 04:23:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:23:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:23:14 INFO - 'HOME': '/Users/cltbld', 04:23:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:23:14 INFO - 'LOGNAME': 'cltbld', 04:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:14 INFO - 'MOZ_NO_REMOTE': '1', 04:23:14 INFO - 'NO_EM_RESTART': '1', 04:23:14 INFO - 'PAGER': '/bin/cat', 04:23:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:14 INFO - 'PWD': '/builds/slave/test', 04:23:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:23:14 INFO - 'SHELL': '/bin/bash', 04:23:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yGRqmxlIQw/Listeners', 04:23:14 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 04:23:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:23:14 INFO - 'USER': 'cltbld', 04:23:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:23:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:14 INFO - 'XPC_FLAGS': '0x0', 04:23:14 INFO - 'XPC_SERVICE_NAME': '0', 04:23:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:14 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 04:23:14 INFO - Cleaning up... 04:23:14 INFO - Return code: 0 04:23:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:23: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')]} 04:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23: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')]} 04:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23: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', '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 0x109ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5104c1750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a84d30>, '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 0x1099abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a79be8>, '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.Rtm9tW3vHt/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.yGRqmxlIQw/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 04:23: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:23: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 psutil>=3.1.1 04:23:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rtm9tW3vHt/Render', 04:23:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:23:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:23:14 INFO - 'HOME': '/Users/cltbld', 04:23:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:23:14 INFO - 'LOGNAME': 'cltbld', 04:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:14 INFO - 'MOZ_NO_REMOTE': '1', 04:23:14 INFO - 'NO_EM_RESTART': '1', 04:23:14 INFO - 'PAGER': '/bin/cat', 04:23:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:14 INFO - 'PWD': '/builds/slave/test', 04:23:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:23:14 INFO - 'SHELL': '/bin/bash', 04:23:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yGRqmxlIQw/Listeners', 04:23:14 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 04:23:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:23:14 INFO - 'USER': 'cltbld', 04:23:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:23:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:14 INFO - 'XPC_FLAGS': '0x0', 04:23:14 INFO - 'XPC_SERVICE_NAME': '0', 04:23:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:23:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:15 INFO - Downloading/unpacking psutil>=3.1.1 04:23:15 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 04:23:15 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 04:23:15 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 04:23:15 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 04:23:15 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 04:23:15 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 04:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:23:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:19 INFO - Installing collected packages: psutil 04:23:19 INFO - Running setup.py install for psutil 04:23:19 INFO - building 'psutil._psutil_osx' extension 04:23:19 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 04:23:19 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 04:23:19 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 04:23:19 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 04:23:19 INFO - building 'psutil._psutil_posix' extension 04:23:19 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 04:23:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:23:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:23:19 INFO - ^ 04:23:19 INFO - 1 warning generated. 04:23:19 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 04:23:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:19 INFO - Successfully installed psutil 04:23:19 INFO - Cleaning up... 04:23:19 INFO - Return code: 0 04:23:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:23:19 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')]} 04:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:19 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')]} 04:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:19 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 0x109ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5104c1750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a84d30>, '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 0x1099abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a79be8>, '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.Rtm9tW3vHt/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.yGRqmxlIQw/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 04:23:19 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 04:23:19 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 04:23:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rtm9tW3vHt/Render', 04:23:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:23:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:23:19 INFO - 'HOME': '/Users/cltbld', 04:23:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:23:19 INFO - 'LOGNAME': 'cltbld', 04:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:19 INFO - 'MOZ_NO_REMOTE': '1', 04:23:19 INFO - 'NO_EM_RESTART': '1', 04:23:19 INFO - 'PAGER': '/bin/cat', 04:23:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:19 INFO - 'PWD': '/builds/slave/test', 04:23:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:23:19 INFO - 'SHELL': '/bin/bash', 04:23:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yGRqmxlIQw/Listeners', 04:23:19 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 04:23:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:23:19 INFO - 'USER': 'cltbld', 04:23:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:23:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:19 INFO - 'XPC_FLAGS': '0x0', 04:23:19 INFO - 'XPC_SERVICE_NAME': '0', 04:23:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:23:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:23:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:23:22 INFO - Installing collected packages: mozsystemmonitor 04:23:22 INFO - Running setup.py install for mozsystemmonitor 04:23:23 INFO - Successfully installed mozsystemmonitor 04:23:23 INFO - Cleaning up... 04:23:23 INFO - Return code: 0 04:23:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:23:23 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')]} 04:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:23 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')]} 04:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x109ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5104c1750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a84d30>, '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 0x1099abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a79be8>, '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.Rtm9tW3vHt/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.yGRqmxlIQw/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 04:23:23 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 04:23:23 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 04:23:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rtm9tW3vHt/Render', 04:23:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:23:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:23:23 INFO - 'HOME': '/Users/cltbld', 04:23:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:23:23 INFO - 'LOGNAME': 'cltbld', 04:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:23 INFO - 'MOZ_NO_REMOTE': '1', 04:23:23 INFO - 'NO_EM_RESTART': '1', 04:23:23 INFO - 'PAGER': '/bin/cat', 04:23:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:23 INFO - 'PWD': '/builds/slave/test', 04:23:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:23:23 INFO - 'SHELL': '/bin/bash', 04:23:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yGRqmxlIQw/Listeners', 04:23:23 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 04:23:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:23:23 INFO - 'USER': 'cltbld', 04:23:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:23:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:23 INFO - 'XPC_FLAGS': '0x0', 04:23:23 INFO - 'XPC_SERVICE_NAME': '0', 04:23:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:23:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:23 INFO - Downloading/unpacking jsonschema==2.5.1 04:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:23:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23:26 INFO - Downloading functools32-3.2.3-2.tar.gz 04:23:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:23:26 INFO - warning: no files found matching '*.txt' 04:23:26 INFO - no previously-included directories found matching 'build' 04:23:26 INFO - no previously-included directories found matching 'dist' 04:23:26 INFO - no previously-included directories found matching '.git*' 04:23:26 INFO - Installing collected packages: jsonschema, functools32 04:23:26 INFO - Running setup.py install for functools32 04:23:26 INFO - warning: no files found matching '*.txt' 04:23:26 INFO - no previously-included directories found matching 'build' 04:23:26 INFO - no previously-included directories found matching 'dist' 04:23:26 INFO - no previously-included directories found matching '.git*' 04:23:26 INFO - Successfully installed jsonschema functools32 04:23:26 INFO - Cleaning up... 04:23:26 INFO - Return code: 0 04:23:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:23: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')]} 04:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23: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')]} 04:23:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5104c1750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a84d30>, '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 0x1099abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a79be8>, '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.Rtm9tW3vHt/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.yGRqmxlIQw/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 04:23:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:23:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:23:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rtm9tW3vHt/Render', 04:23:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:23:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:23:26 INFO - 'HOME': '/Users/cltbld', 04:23:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:23:26 INFO - 'LOGNAME': 'cltbld', 04:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:26 INFO - 'MOZ_NO_REMOTE': '1', 04:23:26 INFO - 'NO_EM_RESTART': '1', 04:23:26 INFO - 'PAGER': '/bin/cat', 04:23:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:26 INFO - 'PWD': '/builds/slave/test', 04:23:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:23:26 INFO - 'SHELL': '/bin/bash', 04:23:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yGRqmxlIQw/Listeners', 04:23:26 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 04:23:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:23:26 INFO - 'USER': 'cltbld', 04:23:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:23:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:26 INFO - 'XPC_FLAGS': '0x0', 04:23:26 INFO - 'XPC_SERVICE_NAME': '0', 04:23:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:23:27 INFO - Cleaning up... 04:23:27 INFO - Return code: 0 04:23:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:23:27 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')]} 04:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:27 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')]} 04:23:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:27 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 0x109ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5104c1750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a84d30>, '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 0x1099abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a79be8>, '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.Rtm9tW3vHt/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.yGRqmxlIQw/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 04:23:27 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 04:23:27 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 04:23:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rtm9tW3vHt/Render', 04:23:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:23:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:23:27 INFO - 'HOME': '/Users/cltbld', 04:23:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:23:27 INFO - 'LOGNAME': 'cltbld', 04:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:27 INFO - 'MOZ_NO_REMOTE': '1', 04:23:27 INFO - 'NO_EM_RESTART': '1', 04:23:27 INFO - 'PAGER': '/bin/cat', 04:23:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:27 INFO - 'PWD': '/builds/slave/test', 04:23:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:23:27 INFO - 'SHELL': '/bin/bash', 04:23:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yGRqmxlIQw/Listeners', 04:23:27 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 04:23:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:23:27 INFO - 'USER': 'cltbld', 04:23:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:23:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:27 INFO - 'XPC_FLAGS': '0x0', 04:23:27 INFO - 'XPC_SERVICE_NAME': '0', 04:23:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:27 INFO - Downloading/unpacking blobuploader==1.2.4 04:23:27 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 04:23:27 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 04:23:27 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 04:23:27 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 04:23:27 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 04:23:27 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 04:23:29 INFO - Downloading blobuploader-1.2.4.tar.gz 04:23:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:23:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:23:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:31 INFO - Downloading docopt-0.6.1.tar.gz 04:23:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:23:31 INFO - Installing collected packages: blobuploader, requests, docopt 04:23:31 INFO - Running setup.py install for blobuploader 04:23:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:23:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:23:31 INFO - Running setup.py install for requests 04:23:31 INFO - Running setup.py install for docopt 04:23:32 INFO - Successfully installed blobuploader requests docopt 04:23:32 INFO - Cleaning up... 04:23:32 INFO - Return code: 0 04:23:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:32 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')]} 04:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:32 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')]} 04:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:32 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 0x109ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5104c1750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a84d30>, '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 0x1099abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a79be8>, '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.Rtm9tW3vHt/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.yGRqmxlIQw/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 04:23:32 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 04:23:32 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 04:23:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rtm9tW3vHt/Render', 04:23:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:23:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:23:32 INFO - 'HOME': '/Users/cltbld', 04:23:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:23:32 INFO - 'LOGNAME': 'cltbld', 04:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:32 INFO - 'MOZ_NO_REMOTE': '1', 04:23:32 INFO - 'NO_EM_RESTART': '1', 04:23:32 INFO - 'PAGER': '/bin/cat', 04:23:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:32 INFO - 'PWD': '/builds/slave/test', 04:23:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:23:32 INFO - 'SHELL': '/bin/bash', 04:23:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yGRqmxlIQw/Listeners', 04:23:32 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 04:23:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:23:32 INFO - 'USER': 'cltbld', 04:23:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:23:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:32 INFO - 'XPC_FLAGS': '0x0', 04:23:32 INFO - 'XPC_SERVICE_NAME': '0', 04:23:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:32 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-cnkeFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:32 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-i3REQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:32 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-MMOuDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:32 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-WIfw_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:32 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-RgIXs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:32 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-RkWc36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:33 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-Z0qQta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:33 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-ww0l3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:33 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-Ni9n5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:33 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-70o1Ig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:33 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-uahpkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:33 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-nct9rt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:33 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-9zDiQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:33 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-dT6ezp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:33 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-xVKmzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:33 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-4cTHOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:34 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-HgYmbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:23:34 INFO - Running setup.py install for manifestparser 04:23:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:23:34 INFO - Running setup.py install for mozcrash 04:23:34 INFO - Running setup.py install for mozdebug 04:23:34 INFO - Running setup.py install for mozdevice 04:23:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:23:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:23:34 INFO - Running setup.py install for mozfile 04:23:34 INFO - Running setup.py install for mozhttpd 04:23:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:23:35 INFO - Running setup.py install for mozinfo 04:23:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:23:35 INFO - Running setup.py install for mozInstall 04:23:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:23:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:23:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:23:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:23:35 INFO - Running setup.py install for mozleak 04:23:35 INFO - Running setup.py install for mozlog 04:23:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:23:35 INFO - Running setup.py install for moznetwork 04:23:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:23:35 INFO - Running setup.py install for mozprocess 04:23:35 INFO - Running setup.py install for mozprofile 04:23:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:23:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:23:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:23:36 INFO - Running setup.py install for mozrunner 04:23:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:23:36 INFO - Running setup.py install for mozscreenshot 04:23:36 INFO - Running setup.py install for moztest 04:23:36 INFO - Running setup.py install for mozversion 04:23:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:23:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:23:36 INFO - Cleaning up... 04:23:36 INFO - Return code: 0 04:23:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:36 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')]} 04:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:36 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')]} 04:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:36 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 0x109ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5104c1750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a84d30>, '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 0x1099abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a79be8>, '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.Rtm9tW3vHt/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.yGRqmxlIQw/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 04:23:36 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 04:23:36 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 04:23:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rtm9tW3vHt/Render', 04:23:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:23:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:23:36 INFO - 'HOME': '/Users/cltbld', 04:23:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:23:36 INFO - 'LOGNAME': 'cltbld', 04:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:36 INFO - 'MOZ_NO_REMOTE': '1', 04:23:36 INFO - 'NO_EM_RESTART': '1', 04:23:36 INFO - 'PAGER': '/bin/cat', 04:23:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:36 INFO - 'PWD': '/builds/slave/test', 04:23:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:23:36 INFO - 'SHELL': '/bin/bash', 04:23:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yGRqmxlIQw/Listeners', 04:23:36 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 04:23:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:23:36 INFO - 'USER': 'cltbld', 04:23:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:23:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:36 INFO - 'XPC_FLAGS': '0x0', 04:23:36 INFO - 'XPC_SERVICE_NAME': '0', 04:23:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:37 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-Rv3TMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:37 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)) 04:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:37 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-rjtbWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:37 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)) 04:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:37 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-o1nrHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:37 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)) 04:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:37 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-w2CqSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:37 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)) 04:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:37 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-RFkjz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:37 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)) 04:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:37 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-rBU4R1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:37 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)) 04:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:37 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-OdCSnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:37 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)) 04:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:37 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-PNJaGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:37 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)) 04:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:37 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-wuVDC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:37 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)) 04:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:37 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-lQXnc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:38 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)) 04:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:38 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-YltN71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:38 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)) 04:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:38 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-XAbVSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:38 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)) 04:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:38 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-K3Qjxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:38 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)) 04:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:38 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-oUOhxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:38 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)) 04:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:38 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-b9oWL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:38 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)) 04:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:38 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-i7vt37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:38 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)) 04:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:38 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-_sKakF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:38 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)) 04:23:38 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)) 04:23:38 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)) 04:23:38 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)) 04:23:38 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)) 04:23:38 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)) 04:23:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:23:38 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 04:23:38 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 04:23:38 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 04:23:38 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 04:23:38 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 04:23:38 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 04:23:41 INFO - Downloading blessings-1.6.tar.gz 04:23:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:23:41 INFO - Installing collected packages: blessings 04:23:41 INFO - Running setup.py install for blessings 04:23:41 INFO - Successfully installed blessings 04:23:41 INFO - Cleaning up... 04:23:41 INFO - Return code: 0 04:23:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:23:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:42 INFO - Reading from file tmpfile_stdout 04:23:42 INFO - Current package versions: 04:23:42 INFO - blessings == 1.6 04:23:42 INFO - blobuploader == 1.2.4 04:23:42 INFO - docopt == 0.6.1 04:23:42 INFO - functools32 == 3.2.3-2 04:23:42 INFO - jsonschema == 2.5.1 04:23:42 INFO - manifestparser == 1.1 04:23:42 INFO - mozInstall == 1.12 04:23:42 INFO - mozcrash == 1.0 04:23:42 INFO - mozdebug == 0.1 04:23:42 INFO - mozdevice == 0.49 04:23:42 INFO - mozfile == 1.2 04:23:42 INFO - mozhttpd == 0.7 04:23:42 INFO - mozinfo == 0.9 04:23:42 INFO - mozleak == 0.1 04:23:42 INFO - mozlog == 3.4 04:23:42 INFO - moznetwork == 0.27 04:23:42 INFO - mozprocess == 0.24 04:23:42 INFO - mozprofile == 0.28 04:23:42 INFO - mozrunner == 6.13 04:23:42 INFO - mozscreenshot == 0.1 04:23:42 INFO - mozsystemmonitor == 0.3 04:23:42 INFO - moztest == 0.8 04:23:42 INFO - mozversion == 1.4 04:23:42 INFO - psutil == 3.1.1 04:23:42 INFO - requests == 1.2.3 04:23:42 INFO - wsgiref == 0.1.2 04:23:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:42 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')]} 04:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:42 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')]} 04:23:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:42 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 0x109ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5104c1750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a84d30>, '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 0x1099abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a79be8>, '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.Rtm9tW3vHt/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.yGRqmxlIQw/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 04:23:42 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 04:23:42 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 04:23:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rtm9tW3vHt/Render', 04:23:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:23:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:23:42 INFO - 'HOME': '/Users/cltbld', 04:23:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:23:42 INFO - 'LOGNAME': 'cltbld', 04:23:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:42 INFO - 'MOZ_NO_REMOTE': '1', 04:23:42 INFO - 'NO_EM_RESTART': '1', 04:23:42 INFO - 'PAGER': '/bin/cat', 04:23:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:23:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:42 INFO - 'PWD': '/builds/slave/test', 04:23:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:23:42 INFO - 'SHELL': '/bin/bash', 04:23:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yGRqmxlIQw/Listeners', 04:23:42 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 04:23:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:23:42 INFO - 'USER': 'cltbld', 04:23:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:23:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:23:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:42 INFO - 'XPC_FLAGS': '0x0', 04:23:42 INFO - 'XPC_SERVICE_NAME': '0', 04:23:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:23:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:42 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)) 04:23:42 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)) 04:23:42 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)) 04:23:42 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)) 04:23:42 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)) 04:23:42 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)) 04:23:42 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)) 04:23:42 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)) 04:23:42 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)) 04:23:42 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)) 04:23:42 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)) 04:23:42 INFO - Cleaning up... 04:23:42 INFO - Return code: 0 04:23:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:23:42 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')]} 04:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:42 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')]} 04:23:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:42 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 0x109ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5104c1750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a84d30>, '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 0x1099abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a79be8>, '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.Rtm9tW3vHt/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.yGRqmxlIQw/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 04:23:42 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 04:23:42 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 04:23:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rtm9tW3vHt/Render', 04:23:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:23:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:23:42 INFO - 'HOME': '/Users/cltbld', 04:23:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:23:42 INFO - 'LOGNAME': 'cltbld', 04:23:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:42 INFO - 'MOZ_NO_REMOTE': '1', 04:23:42 INFO - 'NO_EM_RESTART': '1', 04:23:42 INFO - 'PAGER': '/bin/cat', 04:23:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:23:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:42 INFO - 'PWD': '/builds/slave/test', 04:23:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:23:42 INFO - 'SHELL': '/bin/bash', 04:23:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yGRqmxlIQw/Listeners', 04:23:42 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 04:23:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:23:42 INFO - 'USER': 'cltbld', 04:23:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:23:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:23:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:42 INFO - 'XPC_FLAGS': '0x0', 04:23:42 INFO - 'XPC_SERVICE_NAME': '0', 04:23:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:23:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:23:42 INFO - Cleaning up... 04:23:42 INFO - Return code: 0 04:23:42 INFO - Running post-action listener: _resource_record_post_action 04:23:42 INFO - Running post-action listener: _start_resource_monitoring 04:23:42 INFO - Starting resource monitoring. 04:23:42 INFO - [mozharness: 2017-02-04 12:23:42.652212Z] Finished create-virtualenv step (success) 04:23:42 INFO - [mozharness: 2017-02-04 12:23:42.653172Z] Running install step. 04:23:42 INFO - Running pre-action listener: _resource_record_pre_action 04:23:42 INFO - Running main action method: install 04:23:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:42 INFO - Reading from file tmpfile_stdout 04:23:42 INFO - Detecting whether we're running mozinstall >=1.0... 04:23:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:23:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:23:43 INFO - Reading from file tmpfile_stdout 04:23:43 INFO - Output received: 04:23:43 INFO - Usage: mozinstall [options] installer 04:23:43 INFO - Options: 04:23:43 INFO - -h, --help show this help message and exit 04:23:43 INFO - -d DEST, --destination=DEST 04:23:43 INFO - Directory to install application into. [default: 04:23:43 INFO - "/builds/slave/test"] 04:23:43 INFO - --app=APP Application being installed. [default: firefox] 04:23:43 INFO - mkdir: /builds/slave/test/build/application 04:23:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:23:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:24:04 INFO - Reading from file tmpfile_stdout 04:24:04 INFO - Output received: 04:24:04 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:24:04 INFO - Running post-action listener: _resource_record_post_action 04:24:04 INFO - [mozharness: 2017-02-04 12:24:04.812328Z] Finished install step (success) 04:24:04 INFO - [mozharness: 2017-02-04 12:24:04.812482Z] Running run-tests step. 04:24:04 INFO - Running pre-action listener: _resource_record_pre_action 04:24:04 INFO - Running main action method: run_tests 04:24:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:24:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:24:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:24:04 INFO - 2017-02-04 04:24:04.826 screenresolution[1926:22090] starting screenresolution argv=screenresolution get 04:24:04 INFO - 2017-02-04 04:24:04.829 screenresolution[1926:22090] Display 0: 1600x1200x32@60 04:24:04 INFO - 2017-02-04 04:24:04.835 screenresolution[1927:22092] starting screenresolution argv=screenresolution list 04:24:04 INFO - Available Modes on Display 0 04:24:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:24:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:24:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:24:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:24:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:24:05 INFO - Intel Iris: 04:24:05 INFO - Chipset Model: Intel Iris 04:24:05 INFO - Type: GPU 04:24:05 INFO - Bus: Built-In 04:24:05 INFO - VRAM (Dynamic, Max): 1536 MB 04:24:05 INFO - Vendor: Intel (0x8086) 04:24:05 INFO - Device ID: 0x0a2e 04:24:05 INFO - Revision ID: 0x0009 04:24:05 INFO - Displays: 04:24:05 INFO - Display: 04:24:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:24:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:24:05 INFO - Display Serial Number: 1600x1200 60 04:24:05 INFO - Main Display: Yes 04:24:05 INFO - Mirror: Off 04:24:05 INFO - Online: Yes 04:24:05 INFO - Rotation: Supported 04:24:05 INFO - Return code: 0 04:24:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:24:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:24:05 INFO - Python 2.7.3 04:24:05 INFO - Return code: 0 04:24:05 INFO - grabbing minidump binary from tooltool 04:24:05 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')]} 04:24:05 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 0x109a84d30>, '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 0x1099abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a79be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:24:05 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 04:24:05 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 04:24:05 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 04:24:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:24:05 INFO - Return code: 0 04:24:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:24:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:24:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:24:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:24:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:24:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NS6fQSoISISw3FvvWU7BUA/artifacts/public/build/firefox-54.0a1.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 04:24:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NS6fQSoISISw3FvvWU7BUA/artifacts/public/build/firefox-54.0a1.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 04:24:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rtm9tW3vHt/Render', 04:24:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:05 INFO - 'HOME': '/Users/cltbld', 04:24:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:05 INFO - 'LOGNAME': 'cltbld', 04:24:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:24:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:05 INFO - 'MOZ_NO_REMOTE': '1', 04:24:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:24:05 INFO - 'NO_EM_RESTART': '1', 04:24:05 INFO - 'PAGER': '/bin/cat', 04:24:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:05 INFO - 'PWD': '/builds/slave/test', 04:24:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:24:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:05 INFO - 'SHELL': '/bin/bash', 04:24:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yGRqmxlIQw/Listeners', 04:24:05 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 04:24:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:05 INFO - 'USER': 'cltbld', 04:24:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:05 INFO - 'XPC_FLAGS': '0x0', 04:24:05 INFO - 'XPC_SERVICE_NAME': '0', 04:24:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NS6fQSoISISw3FvvWU7BUA/artifacts/public/build/firefox-54.0a1.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 04:24:05 INFO - mozversion application_buildid: 20170204030205 04:24:05 INFO - mozversion application_changeset: 7aa5e444af0ff686714d6165bd0e7e6d1abd0970 04:24:05 INFO - mozversion application_display_name: Nightly 04:24:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:24:05 INFO - mozversion application_name: Firefox 04:24:05 INFO - mozversion application_remotingname: firefox 04:24:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:24:05 INFO - mozversion application_vendor: Mozilla 04:24:05 INFO - mozversion application_version: 54.0a1 04:24:05 INFO - mozversion platform_buildid: 20170204030205 04:24:05 INFO - mozversion platform_changeset: 7aa5e444af0ff686714d6165bd0e7e6d1abd0970 04:24:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:24:05 INFO - mozversion platform_version: 54.0a1 04:24:05 INFO - using testdate: 1486211045 04:24:05 INFO - actual date: 1486211045 04:24:05 INFO - starting webserver on 'localhost:54344' 04:24:05 INFO - SUITE-START | Running 2 tests 04:24:05 INFO - TEST-START | dromaeo_css 04:24:05 INFO - operating with platform_type : mac_ 04:24:05 INFO - Initialising browser for dromaeo_css test... 04:24:05 INFO - TEST-INFO | started process 1937 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpcLyqVF/profile http://localhost:54344/getInfo.html) 04:24:08 INFO - PROCESS | 1937 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 04:24:08 INFO - PROCESS | 1937 | 2017-02-04 04:24:08.830 plugin-container[1941:22273] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f3f, name = 'com.apple.tsm.portname' 04:24:08 INFO - PROCESS | 1937 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:24:08 INFO - PROCESS | 1937 | 2017-02-04 04:24:08.830 plugin-container[1941:22273] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950b, name = 'com.apple.CFPasteboardClient' 04:24:08 INFO - PROCESS | 1937 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:24:08 INFO - PROCESS | 1937 | 2017-02-04 04:24:08.830 plugin-container[1941:22273] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:24:08 INFO - PROCESS | 1937 | __metrics Screen width/height:1600/1200 04:24:08 INFO - PROCESS | 1937 | colorDepth:24 04:24:08 INFO - PROCESS | 1937 | Browser inner width/height: 1024/689 04:24:08 INFO - PROCESS | 1937 | __metrics 04:24:08 ERROR - PROCESS | 1937 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 04:24:08 INFO - PROCESS | 1937 | 1486211048959 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/FirefoxNightly.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/FirefoxNightly.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/tmpcLyqVF/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpcLyqVF/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpcLyqVF/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpcLyqVF/profile/extensions/talos-powers@TalosPowersService.js:55:9 04:24:09 INFO - TEST-INFO | 1937: exit 0 04:24:09 INFO - Browser initialized. 04:24:09 INFO - Running cycle 1/1 for dromaeo_css test... 04:24:09 INFO - TEST-INFO | started process 1942 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpcLyqVF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:24:12 INFO - PROCESS | 1942 | 2017-02-04 04:24:12.278 plugin-container[1943:22395] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b4b, name = 'com.apple.tsm.portname' 04:24:12 INFO - PROCESS | 1942 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:24:12 INFO - PROCESS | 1942 | 2017-02-04 04:24:12.279 plugin-container[1943:22395] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0f, name = 'com.apple.CFPasteboardClient' 04:24:12 INFO - PROCESS | 1942 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:24:12 INFO - PROCESS | 1942 | 2017-02-04 04:24:12.279 plugin-container[1943:22395] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:24:21 INFO - PROCESS | 1942 | RSS: Main: 233324544 04:24:21 INFO - PROCESS | 1942 | 04:27:24 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:54344/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54344/tests/dromaeo/cssquery-ext.html) 04:27:25 INFO - PROCESS | 1942 | RSS: Main: 259448832 04:27:25 INFO - PROCESS | 1942 | 04:29:10 INFO - PROCESS | 1942 | ************************* 04:29:10 INFO - PROCESS | 1942 | A coding exception was thrown and uncaught in a Task. 04:29:10 INFO - PROCESS | 1942 | 04:29:10 ERROR - PROCESS | 1942 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:29:10 INFO - PROCESS | 1942 | Full stack: 04:29:10 INFO - PROCESS | 1942 | ************************* 04:30:28 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:54344/tests/dromaeo/cssquery-ext.html (next: http://localhost:54344/tests/dromaeo/cssquery-jquery.html) 04:30:29 INFO - PROCESS | 1942 | RSS: Main: 267681792 04:30:29 INFO - PROCESS | 1942 | 04:33:31 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:54344/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54344/tests/dromaeo/cssquery-mootools.html) 04:33:31 INFO - PROCESS | 1942 | RSS: Main: 278441984 04:33:31 INFO - PROCESS | 1942 | 04:36:33 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:54344/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54344/tests/dromaeo/cssquery-prototype.html) 04:36:34 INFO - PROCESS | 1942 | RSS: Main: 271429632 04:36:34 INFO - PROCESS | 1942 | 04:39:37 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:54344/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54344/tests/dromaeo/cssquery-yui.html) 04:39:37 INFO - PROCESS | 1942 | RSS: Main: 276451328 04:39:37 INFO - PROCESS | 1942 | 04:42:41 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:54344/tests/dromaeo/cssquery-yui.html (next: http://localhost:54344/tests/dromaeo/cssquery-dojo.html) 04:42:41 INFO - PROCESS | 1942 | RSS: Main: 278601728 04:42:41 INFO - PROCESS | 1942 | 04:42:41 INFO - PROCESS | 1942 | __start_tp_report 04:42:41 INFO - PROCESS | 1942 | _x_x_mozilla_page_load 04:42:41 INFO - PROCESS | 1942 | _x_x_mozilla_page_load_details 04:42:41 INFO - PROCESS | 1942 | |i|pagename|runs| 04:42:41 INFO - PROCESS | 1942 | |0;dojo.html;3249.7237734792543;3291.769576129671;3308.586426696663;3326.6174389945163;3337.9666203337974;5370.973145134279;5458.481444262794;5499.202615620733;5519.530839878616;5569.693666848321;5402.324709411324;5508.55931525479;5547.362053363864;5594.24477695512;5625.437456254373;4974.77613507393;5029.145045342282;5119.488051194888;5134.871628209287;5139;4918.655694101414;5046.54581087702;5204.9739751301195;5221.738913054351;5227.242049902762;4898.069366820293;4900.093482705675;5155;5182.766775495112;5198.766055527511;5013.273075404046;5054.11552978231;5095.643304968654;5114.820981265638;5158.277841102249;5003.874903127415;5061.772220250097;5075.847724568269;5082.288479612857;5100.795968161269;4157.875263742062;5344.637117535004;5504.284443022381;5557.610967232255;5574.163875418679;5899.174115623816;6106.786262480792;6122.295935967376;6154.5076393888385;6163.137160797492;6233.407826256544;6237.906431403487;6248.562600617958;6251;6255.781047663356;5772.769089236425;5774.826755197309;5790.478856902815;5792.102224155263;5810.564207684441;6042.274927008787;6113.932424433873;6121.270068921596;6122.733612273343;6133.548895741563;6009.519238460913;6038;6049.939500604937;6066.575339726265;6083.057126145454;6064.241969753781;6134.8159555213415;6153.507719382439;6157.9384206158265;6176.752929882754;4940.431850337185;5878;5932.911006334822;6026.6384016958245;6111.724972376253;6132.8756461173125;6135.4776558202;6140.8416929778305;6145.863015342176;6146.5390095743;4107.507099148062;4889.462159162489;4899.044686286211;4910.435299940481;4943.184374578226;4271.572842715704;4279.679024073207;4283.443152390169;4332.696711230184;4399.494058183286;4717.528247175255;5516.724163791875;5525.171224316385;5527.336719593594;5560.77756889728;5967.98544247479;6017.06735456005;6039.818805435844;6061.6666083365835;6073.331933487313;5460.563154947595;5503.724813759376;5561.777528898799;5569.0254205513875;5586.385497595261;5317.042932272228;5329.760160792774;5347.278117454094;5357.11607584752;5417.620766546383;6238.220222472191;6265.404786545271;6268.843278918063;6285.685715714288;6305.180326557518;5960.4635582797755;6169.1054797053275;6190.226221722285;6210.813675589739;6215.65813880241;5151.768170432414;6093.238345206849;6217;6256.90504161779;6281.842953926189;6064.211652485149;6114.052321890114;6123.908141377972;6132.860319284376;6152.169457123231;5695.430456954271;6072.7553793601055;6202.131701561875;6216.409441103088;6228.750849966132;5340.679559226459;5818.359980402237;5914.526837852875;5937.435943585352;5952.255968003999;5991.7603295867675;6002.549808764447;6017;6039.214902062704;6073.696315184135;5640.492355687844;5717.37108918027;5812.3025236971835;5848.590598658223;5871.6770577618645;5960.910586341121;6066.787662431793;6068.089786532056;6086.147939288591;6102.511799056154;5835.94164058354;5855.38518455556;5871;5892.6759028252145;5918.378570250062 04:42:41 INFO - PROCESS | 1942 | |1;ext.html;443.02313398955306;454.7498875618409;475.5553557423809;483.70010593432056;537.991930121048;37405.8778236653;40121.1975760485;40145;40211.39682904755;40338.59661403385;41135.91480638949;41866.58133418665;41885.162296754046;41919.3712094318;41963.95090122749;9025.458472491655;9387.48368839717;10668.573257069707;11034.889651103507;11038.17213708971;10823.080038196762;10928.125749940025;10934.726631834228;10947.397893115876;10960.671179864577;9907.959664235259;10209.489525523732;10993.61522346718;11006.064484518785;11028.944855275713;10915.181361397887;10923.726906827393;11000.954909283606;11002.50488728009;11008.009279164833;10837.891621083767;10918.563257469692;10927.508262128224;10935;10955.287906286067;29606.407871842443;37179.88460346194;37240.81379593112;37247;37307.81346093279;3895.18201177753;3903.882883513499;3949.2228497176097;3949.940750888739;3952.3083460394314;27799.86100069507;28667.56998645022;28726.85636571804;28891.422171556453;29052.854735726396;3147.5593416921647;3148.5277208418693;3168.0970923286754;3265.346930613887;3269.493228549579;481516;482246;485909;485923.99999999645;486491;57019;57317.71341143268;57681.13478297829;57874.71062644744;57983.71008145017;59590.70204648949;59924.700376497836;59972.700136499036;60216;60325.39674603286;13994;14648.707025859423;14930.552083437515;15183.316750746242;15238.238088095552;8419.789505262417;10974.506147223394;11688.298702077902;11691.064714822794;11720.06239500838;13879.930600346934;17586.296548137932;17813.910930445265;17838.55403614894;17967.820321796877;6226.688665566703;7974.727202747189;8012.519248844971;8027.357811375076;8069.354451643854;802.0390146092748;847.6143354773563;863.4603372891943;873.0658195730507;877.5953886351351;24082.555046696903;28780.424391512053;29757.809687612687;30247.395052098836;30705.846470767505;1020.9489525523694;1025.497506221946;1036.1451802263011;1058.6506452870535;1062.3094988257694;13491.718286762938;13926.442942282398;15207.771883421758;15486.303116359792;15815.604609884615;627044;631220;632079;633442;638395;59463.70268148718;60030.399696003355;60048.69975650181;60121;60136;1236.0667695889726;1387.4172847403913;1415.7876318552298;1428.7142571485745;1433.6129245103973;24349.634755479037;28075.438491229652;29189.270268243465;33187.668123319425;33656;55810.44189558052;55937.16094258508;56339.71830140987;56432.7178364122;56742;542148;547713;547968;549574;549770;25729.871350643127;26216;26523.469530609666;26843;27018.459630807665;42304.730858074305;42790.716278511696;43603.345949810144;43909.78045109754;44086.55913440953;35844.462333065545;36100.458493122096;36100.81949590235;36992.44511332386;37365.626343736214;35696.464553032245;35857.8282115645;36259.637403625624;36643.63356366402;36863.63136368709;25220.86506107266;30987.84506077455;34451.13872153116;35735.28529429449;35879.46180807238;22865;31029.379412412076;31830.84084579562;31995.36009279755;32248;23742.287731367396;24076.435031722882;24080.397990050387;24129.879350603136;24279.514409711355 04:42:41 INFO - PROCESS | 1942 | |2;jquery.html;345.4852270117525;381.7231361097129;392.15099309993855;403.54802621064414;416.35880743654775;8669.523176225304;19077.71383429248;20693.896530517362;20844;20860.687089693667;17042.573935651613;21909.671354929687;22628.660570091462;23033;23091.307260782163;6743.460523158135;6925.134358205224;7289.744858929938;7647.044119485065;7756.224377562226;7569.318761311481;7669.156392796788;7703.306702396783;7744.883826742604;7974.880376794353;7758.418118641096;8002.0797608274925;8018.679252829909;8024.759257222293;8029.759107226792;7780.727674531393;7798;7909.881351779728;7973.760787176394;8006.599670016476;7432.665530051161;7729.458937874351;7764.844703105906;7765.53406795594;7773.689052437896;26636.467270654477;27628.723712762818;27800.02699905514;28337.29156771097;29237.97667081642;2804.2708895687065;2827.2225138086983;2940.5001149804584;2940.588317635533;2944.89692860751;16355.83644163555;16883.746743798853;17283.567910802205;17346.3061477542;17436.564085897826;1990.6914428263642;2054.4658388818866;2054.897255137252;2062.092679221138;2065.4216819290623;83598.58200708957;117880.41059794732;118569;157356;161247;19852.50368740793;22568;23392.64911026336;23654.526909461714;23840.284791456284;40494;40745.59254407418;40960;41049.38425923613;41195.7940210297;8163.510189388537;8357.331413486907;8611.397202195787;8778.561071946377;11099.889001109885;8212.712555060543;8234.711785087493;8245.988724530298;8352.248297653241;8496.150384961455;4270.829166833292;4477.701466574722;4834.154023045953;4948.430930443045;4968.8757781055765;1635.2886494374984;2067.4934641013047;2106.231225602644;2118.2691971269887;2119.9470013249793;730.9524880882726;826.2398593294064;832.213558187507;861.8922634670666;873.8033942363045;20980.580388392147;21708.674369884466;21766.782332176794;21817.890910545346;21959.890200548896;865.8787769712245;877.903430622631;892.7768057985504;895.2524641924066;905.1310741687921;11237.157213209042;11316.6039188628;11317.660470185907;11379.146564007568;11444.370559619301;723029;728061;732106;753722;765901;170287.14856425885;170474;171694;171961;173932.1303393475;1086.5870969031716;1091.252492042953;1139.1854823801023;1145.4215621111452;1151.1251448898897;18452.985085820408;20422.897885510476;20521.076551555514;20804.167833286498;20849;43357;45981.77009114933;59341.10988335265;60541.48646283878;61244.99999999822;88900;89247.55376223077;89463.55268223878;91113.54443227741;91619;8049.7120460726;8381.371397145116;8632;8759.211670949646;8804.427712198687;8278.172182781673;12870.22778633285;13648.385822638204;13710.314484275546;13993.720125597634;11786.705332366759;11888.881111188777;11900.821487677866;12026.15816892809;12075.275483470668;10932.016118549369;11457.59898403552;11556.826647600124;11852.64442066705;11913.702157446132;10005.749856253651;10248.026437488426;11834.230774999598;12132.636020919386;12180.269183848997;8437.831243375222;8456.154384561494;8581.27059199975;8738.25724813398;8850.380473366802;10925.890741092488;11652.766944661229;11716.179867409199;11936.880631193577;11993.820092698443 04:42:41 INFO - PROCESS | 1942 | |3;mootools.html;1167.9532818687258;1380.2753554383942;1386.6810633554283;1396.343718452327;1396.9441222351104;8144.877826832595;8251.834963300731;8586.22723954844;8625.913740862581;8647.481151130929;7001.334873187039;8480.83038339233;8588.785280367994;8623.827523449527;8625.91374086259;2240.395093324801;2274.590573696734;2282.7945484906354;2287.588234117858;2289.061484791236;2249.80876625487;2275.8634481931053;2284.565932472833;2296.047140436725;2299.9655005174936;2149.441145302217;2151.0427859602405;2168.761436242012;2175.5213852952324;2179.6730490426403;2166.1768527959275;2241.5628952354296;2255.8984845681985;2264.784845439681;2267.036509483471;1855.7587513623278;1972.260402349119;2049.6822992436196;2227.2761352560483;2295.2769877488536;8283.792905177359;8469.280111190556;8494.193051660082;8540.957295213546;8617.65529378824;5013.573846223076;5095.592352611782;5172.19830926207;5174.896502069975;5191.896162076738;2943.1906225787866;3307.140143562691;3314.734821214297;3493.772904761208;3519.085037890167;911.5214512380986;1027.3887037212846;1186.1104171871098;1203.1096988228735;1237.2700106936861;8933.86599201006;10886.129109671287;10987.121030317636;10993.230473866832;11085.83371249432;4240.342746874239;4410.647148228134;4491.3487544306545;4497.145542346943;4504.797284122223;8804.075572064841;8807.33944954131;8853.424527405698;8858.335624828163;8875.378723489423;5119.539241468286;5126.641135120581;5130.615203859726;5141.742912854343;5154.433012368637;4637.072585482917;4652.116097941448;4669.509701481364;4741.668083234141;4767.380240568704;3608.9819550902075;3672.4491326301268;3675.338439080991;3752.1182522107283;3776.188119554309;1129.5086637312795;1133.8582677165355;1138.4023387721513;1153.1927650644582;1154.3608076531345;847.8219573889429;884.5179377239419;887.5562218890555;916.863089768682;946.3091942881597;5480.534154596824;5768.653880767168;5768.826935191867;5787.421257874179;5938.554608404387;982.3958265666706;982.7248370456284;989.4113002763344;999.14073896449;1047.4082143588848;3749.544412879254;3861.7449328968196;3881.86413475527;3890.8638197662945;3965.643092121723;8186.2632363087605;9165.725028249164;9984.950075249722;10183.949080254699;10199.439030853375;9931.155851752537;10011.549480273405;10033.147182489423;10037;10167.135793457639;7749.922500775033;8034.999999999883;8038.316743076787;8043.11525732169;8045;5316.548093411949;5422.701751403711;5480.314960629921;5500.697461639488;5543;9062;9159.394939275342;9161.992180859967;9246.861297080415;9383.765405864908;7143.571385716874;9170.266378689555;9506.049395060438;9550.713478595653;9584.185344245818;5632.831015069554;7102.609356485236;7106.7157313706875;7118.822029449305;7148.28517148281;7526.473146879666;7573.431992600687;7670.654820532978;7682.8079298018;7686.039245094364;6940.652967351713;7006.089208402875;7215.927840721525;7341.265873412616;7348.485606007528;6030.879382412415;7142.5000249982;7211.134663840373;7259.455540834353;7307.7807665770115;6372.36276372359;6377;6435.131257280207;6453.290138084901;6461.095446637569;5038.395392552917;5038.697678139323;5041.294218809297;5120.129577971679;5191.480851914778;4958.776855041459;5034.672746271481;5040.117979353672;5121.820736274212;5226.63413561047 04:42:41 INFO - PROCESS | 1942 | |4;prototype.html;357.57270062275575;360.10693480169175;368.893021023903;374.4626461028426;374.7863717680921;4455.462865311466;4718.032803275329;4738.336632871396;5000.524950129732;5121.231815227718;4239.957600423995;5022.547970682647;5177.352830896138;5187.247849061884;5222.738863056841;3426.6059403168706;3531.5585551806025;4118.814653340592;4123.257813593567;4127.62851343379;3206.6431173087763;3978.860739874105;4135.875923722293;4140.151268989865;4157.688173386993;4041.959580404188;4077.4495443115243;4085.2406945907983;4085.754854708712;4090.2637525245445;4027.6979226558124;4046.6560342370785;4066.0648050948153;4071.9185616287805;4071.959280407217;3052.8473576321094;3615.421532554805;3636.890893273206;3652.3060618482405;3660.816959152058;3947.5855035221175;4006.959930400717;5050.494950504957;5070.29015937769;5090.574639101058;3842.500474938268;4333.848315308981;4540.7502587357685;4569.977150114261;4584.037352156051;4768.809247630091;4969.676970996874;5273.419923808378;5453.809116680897;5465.961467321236;3571.3750243639083;3782.432635104729;3820.6370394812448;3828.0238539172333;3848.903777405559;4757.476677565465;5682.971585142089;5703.65778053314;5818.323571157272;5891.7054147292465;3795.899189235091;3835.0824587706147;3846.3461211594094;3874.2445223181207;3876.1472476055224;3246.717546569092;3897.317969355408;3912.3349030664854;3919.9608003920166;3927.7643341399607;3652.945205821915;4062.979685101615;4375.431193944767;4490.416245888014;4595.724256544618;5495;5539.778408863681;5564.718465429155;5571.5513966369035;5627.380988091307;1129.7119234595125;1173.7065733566608;1200.4657927222477;1258.426966292135;1264.3804535777404;735.1655870586923;803.4857691077598;859.7420773767844;869.6912596028319;871.847426700325;4303.849365272201;4756.548127927841;4912.435069966999;4912.641931872649;5010.924836127461;4844.698768085202;4917.041176970456;4926.58124059459;5202.92195617066;5501.707098831771;4165.8333666653;4206.495220573551;4238.8497974959955;4929.457759646436;4947.925781113287;2362.8658244042954;2690.435008648167;2881.3084859633536;2882.5964364988918;2897.435000174946;5500.477454641803;5625.38120806711;5640.717964101778;5657.377688454267;5657.830265092054;4308.6983911126545;4891.486393928657;5306.602004849652;5539.833804985777;5607.252446301283;4469.351943968171;5632.436756324417;5635.605507614428;5647.548196144298;5654.886902261932;4419.558044195554;4504.729716217037;5493.890122197614;5497.725113744376;5526.557875370041;4624.260118381043;4801.5355316627365;4993.725345106054;5162.741862906914;5438.89363530532;4934.568974997211;5541.33503979525;5597.328320601554;5666.320041595035;5719.3136823581435;3098.209956461088;3419.042668052949;3826.617338266151;3827.1771569112775;3847.711421643332;5076.517730815566;5194.428612852507;5688.886222275614;5701.914471283017;5723.8569035774435;4723.905521889475;5317.973410132925;5461.481159289861;5539.529140023144;5570.108782594765;5053.949460505495;5123.871903202301;5522.420145884625;5544.61187716856;5579.972100139474;4598.3102534620075;4892.290617860462;4901.460839307602;5089.1094058538865;5478.589105817;4754.976225118852;5240.842774716764;5275.788968441373;5528.391876893458;5529.557635389078;4991.725455100004;5088.9058852346925;5291.391489978701;5460.3720572133125;5463.836084917459 04:42:41 INFO - PROCESS | 1942 | |5;yui.html;672.4653900149381;707.7947395255374;771.44455991686;820.3323091608746;824.979375515612;13490.59528214154;15399.846001539981;16745.41391051315;17486.38797642083;17498.56253593661;16217.432389866357;16299.91850040748;16377.181140942936;16391.4263000795;16416.343346266163;880.955952202389;893.0444424465824;906.0531744327161;906.8367693815144;909.417972497602;855.2132038524542;871.0853603716105;893.8346405914895;896.9686060987834;899.5322432335182;943.7923656795494;950.1021534649759;950.2208189284789;950.6150009246267;951.8143961927427;933.8785957825473;941.2517048946036;941.9434833909919;942.3074040580168;946.7396465971879;679.140886778226;709.2198581560294;709.230484923853;710.9608971506565;711.1111111111111;15111.848881511154;15380.077195368314;15423.691526169527;15665.686686266325;15740.763888541682;13777.655558611015;14166.858331416657;14172.433102675881;14173.149611023371;14179.220142892136;11844.34856082915;11910.523579056828;11913.652159193816;11979.401029948467;12014.459349329214;3653.2693461307845;3655.0862284428895;3675.3384390809642;3725.739198256123;3832.6550610444915;105249.47375263074;107533;108211;108629;109257.25027121317;9482.241420686467;10794.136469082454;10826.779512156261;10970.616028439126;11284.492197851116;22223.22218722337;22535.211267605555;22538.098476061103;22599;22601.547969040526;7443.776686699408;7469;7507.474476786681;7515.549067055994;7577.696892124363;3698.7239402406126;3858.864939727096;3870.59358767331;3909.0227443139215;3999.440078389028;3195.4887218045;3520.2607452435277;3616.240589476187;3733.8506459741848;3851.0757418219987;710.1832892174041;714.3142583120159;725.2602345607451;728.6101935464501;737.8118579762127;559.7928766356392;656.1601150527238;668.6026205231091;703.929607039292;707.2785758526275;8566.48601083937;10155.289129760846;10374.325668831501;10380.844287335696;10798.244122911477;549.9505044546011;681.7000519771285;682.8156397772574;694.8783962806489;726.4733068525277;4822.493638167942;5003.49965003504;5017;5036.6726162799305;5045.924311135336;70654;93010.53494732484;95903;102099.97900021053;102939;58090.709546451995;82581.58709206416;85628.71556926651;87013.56493217494;92612;54156;75003;75565.11087222863;76522.61738691271;79236;9965.750856228653;10814.405207713651;10885.945570272099;11134;11287.830682539605;48052.27921581109;51092.23361649504;51427.228591571904;52506.73746631242;52871;65799;66793;68318.65840670765;68832.06565749418;69414;11864.22882512634;12008;12719.93640031831;12736.554220602235;12744.553940612033;12406.25562466255;14266.500672476413;14353.856461435253;14409.279536023367;14598.27008649542;13036.869631303565;13317.533886313933;13602.93198534001;13974.441022359399;14192.858071419567;13492.325383730971;13622.659433514242;13911.860881391056;14077.296135193405;14140.858591413955;10933.070688991525;11462.82805757931;13004.609861704164;13450.192988420726;13686.452541898212;11089.33463992163;11219.49512271966;11369.204155709353;11568.016718579014;11632.88367116318;10273.74315642115;10782.73043173927;10788.622398216025;10796.730081748019;10807.486951826593 04:42:41 INFO - PROCESS | 1942 | __end_tp_report 04:42:41 INFO - PROCESS | 1942 | __start_cc_report 04:42:41 INFO - PROCESS | 1942 | _x_x_mozilla_cycle_collect,412 04:42:41 INFO - PROCESS | 1942 | __end_cc_report 04:42:41 INFO - PROCESS | 1942 | __startTimestamp1486212161254__endTimestamp 04:42:41 INFO - PROCESS | 1942 | 04:42:41 INFO - PROCESS | 1942 | ------- Summary: start ------- 04:42:41 INFO - PROCESS | 1942 | Number of tests: 6 04:42:41 INFO - PROCESS | 1942 | 04:42:41 INFO - PROCESS | 1942 | [#0] dojo.html Cycles:165 Average:5600.34 Median:5818.36 stddev:658.34 (11.3%) stddev-sans-first:634.01 04:42:41 INFO - PROCESS | 1942 | Values: 3249.7 3291.8 3308.6 3326.6 3338.0 5371.0 5458.5 5499.2 5519.5 5569.7 5402.3 5508.6 5547.4 5594.2 5625.4 4974.8 5029.1 5119.5 5134.9 5139.0 4918.7 5046.5 5205.0 5221.7 5227.2 4898.1 4900.1 5155.0 5182.8 5198.8 5013.3 5054.1 5095.6 5114.8 5158.3 5003.9 5061.8 5075.8 5082.3 5100.8 4157.9 5344.6 5504.3 5557.6 5574.2 5899.2 6106.8 6122.3 6154.5 6163.1 6233.4 6237.9 6248.6 6251.0 6255.8 5772.8 5774.8 5790.5 5792.1 5810.6 6042.3 6113.9 6121.3 6122.7 6133.5 6009.5 6038.0 6049.9 6066.6 6083.1 6064.2 6134.8 6153.5 6157.9 6176.8 4940.4 5878.0 5932.9 6026.6 6111.7 6132.9 6135.5 6140.8 6145.9 6146.5 4107.5 4889.5 4899.0 4910.4 4943.2 4271.6 4279.7 4283.4 4332.7 4399.5 4717.5 5516.7 5525.2 5527.3 5560.8 5968.0 6017.1 6039.8 6061.7 6073.3 5460.6 5503.7 5561.8 5569.0 5586.4 5317.0 5329.8 5347.3 5357.1 5417.6 6238.2 6265.4 6268.8 6285.7 6305.2 5960.5 6169.1 6190.2 6210.8 6215.7 5151.8 6093.2 6217.0 6256.9 6281.8 6064.2 6114.1 6123.9 6132.9 6152.2 5695.4 6072.8 6202.1 6216.4 6228.8 5340.7 5818.4 5914.5 5937.4 5952.3 5991.8 6002.5 6017.0 6039.2 6073.7 5640.5 5717.4 5812.3 5848.6 5871.7 5960.9 6066.8 6068.1 6086.1 6102.5 5835.9 5855.4 5871.0 5892.7 5918.4 04:42:41 INFO - PROCESS | 1942 | 04:42:41 INFO - PROCESS | 1942 | [#1] ext.html Cycles:180 Average:68361.12 Median:35715.87 stddev:149134.69 (417.6%) stddev-sans-first:149465.87 04:42:41 INFO - PROCESS | 1942 | Values: 443.0 454.7 475.6 483.7 538.0 37405.9 40121.2 40145.0 40211.4 40338.6 41135.9 41866.6 41885.2 41919.4 41964.0 9025.5 9387.5 10668.6 11034.9 11038.2 10823.1 10928.1 10934.7 10947.4 10960.7 9908.0 10209.5 10993.6 11006.1 11028.9 10915.2 10923.7 11001.0 11002.5 11008.0 10837.9 10918.6 10927.5 10935.0 10955.3 29606.4 37179.9 37240.8 37247.0 37307.8 3895.2 3903.9 3949.2 3949.9 3952.3 27799.9 28667.6 28726.9 28891.4 29052.9 3147.6 3148.5 3168.1 3265.3 3269.5 481516.0 482246.0 485909.0 485924.0 486491.0 57019.0 57317.7 57681.1 57874.7 57983.7 59590.7 59924.7 59972.7 60216.0 60325.4 13994.0 14648.7 14930.6 15183.3 15238.2 8419.8 10974.5 11688.3 11691.1 11720.1 13879.9 17586.3 17813.9 17838.6 17967.8 6226.7 7974.7 8012.5 8027.4 8069.4 802.0 847.6 863.5 873.1 877.6 24082.6 28780.4 29757.8 30247.4 30705.8 1020.9 1025.5 1036.1 1058.7 1062.3 13491.7 13926.4 15207.8 15486.3 15815.6 627044.0 631220.0 632079.0 633442.0 638395.0 59463.7 60030.4 60048.7 60121.0 60136.0 1236.1 1387.4 1415.8 1428.7 1433.6 24349.6 28075.4 29189.3 33187.7 33656.0 55810.4 55937.2 56339.7 56432.7 56742.0 542148.0 547713.0 547968.0 549574.0 549770.0 25729.9 26216.0 26523.5 26843.0 27018.5 42304.7 42790.7 43603.3 43909.8 44086.6 35844.5 36100.5 36100.8 36992.4 37365.6 35696.5 35857.8 36259.6 36643.6 36863.6 25220.9 30987.8 34451.1 35735.3 35879.5 22865.0 31029.4 31830.8 31995.4 32248.0 23742.3 24076.4 24080.4 24129.9 24279.5 04:42:41 INFO - PROCESS | 1942 | 04:42:41 INFO - PROCESS | 1942 | [#2] jquery.html Cycles:180 Average:42561.43 Median:2940.54 stddev:123680.28 (4206.0%) stddev-sans-first:123986.61 04:42:41 INFO - PROCESS | 1942 | Values: 345.5 381.7 392.2 403.5 416.4 8669.5 19077.7 20693.9 20844.0 20860.7 17042.6 21909.7 22628.7 23033.0 23091.3 6743.5 6925.1 7289.7 7647.0 7756.2 7569.3 7669.2 7703.3 7744.9 7974.9 7758.4 8002.1 8018.7 8024.8 8029.8 7780.7 7798.0 7909.9 7973.8 8006.6 7432.7 7729.5 7764.8 7765.5 7773.7 26636.5 27628.7 27800.0 28337.3 29238.0 2804.3 2827.2 2940.5 2940.6 2944.9 16355.8 16883.7 17283.6 17346.3 17436.6 1990.7 2054.5 2054.9 2062.1 2065.4 83598.6 117880.4 118569.0 157356.0 161247.0 19852.5 22568.0 23392.6 23654.5 23840.3 40494.0 40745.6 40960.0 41049.4 41195.8 8163.5 8357.3 8611.4 8778.6 11099.9 8212.7 8234.7 8246.0 8352.2 8496.2 4270.8 4477.7 4834.2 4948.4 4968.9 1635.3 2067.5 2106.2 2118.3 2119.9 731.0 826.2 832.2 861.9 873.8 20980.6 21708.7 21766.8 21817.9 21959.9 865.9 877.9 892.8 895.3 905.1 11237.2 11316.6 11317.7 11379.1 11444.4 723029.0 728061.0 732106.0 753722.0 765901.0 170287.1 170474.0 171694.0 171961.0 173932.1 1086.6 1091.3 1139.2 1145.4 1151.1 18453.0 20422.9 20521.1 20804.2 20849.0 43357.0 45981.8 59341.1 60541.5 61245.0 88900.0 89247.6 89463.6 91113.5 91619.0 8049.7 8381.4 8632.0 8759.2 8804.4 8278.2 12870.2 13648.4 13710.3 13993.7 11786.7 11888.9 11900.8 12026.2 12075.3 10932.0 11457.6 11556.8 11852.6 11913.7 10005.7 10248.0 11834.2 12132.6 12180.3 8437.8 8456.2 8581.3 8738.3 8850.4 10925.9 11652.8 11716.2 11936.9 11993.8 04:42:41 INFO - PROCESS | 1942 | 04:42:41 INFO - PROCESS | 1942 | [#3] mootools.html Cycles:180 Average:5376.96 Median:5173.55 stddev:2944.98 (56.9%) stddev-sans-first:2936.25 04:42:41 INFO - PROCESS | 1942 | Values: 1168.0 1380.3 1386.7 1396.3 1396.9 8144.9 8251.8 8586.2 8625.9 8647.5 7001.3 8480.8 8588.8 8623.8 8625.9 2240.4 2274.6 2282.8 2287.6 2289.1 2249.8 2275.9 2284.6 2296.0 2300.0 2149.4 2151.0 2168.8 2175.5 2179.7 2166.2 2241.6 2255.9 2264.8 2267.0 1855.8 1972.3 2049.7 2227.3 2295.3 8283.8 8469.3 8494.2 8541.0 8617.7 5013.6 5095.6 5172.2 5174.9 5191.9 2943.2 3307.1 3314.7 3493.8 3519.1 911.5 1027.4 1186.1 1203.1 1237.3 8933.9 10886.1 10987.1 10993.2 11085.8 4240.3 4410.6 4491.3 4497.1 4504.8 8804.1 8807.3 8853.4 8858.3 8875.4 5119.5 5126.6 5130.6 5141.7 5154.4 4637.1 4652.1 4669.5 4741.7 4767.4 3609.0 3672.4 3675.3 3752.1 3776.2 1129.5 1133.9 1138.4 1153.2 1154.4 847.8 884.5 887.6 916.9 946.3 5480.5 5768.7 5768.8 5787.4 5938.6 982.4 982.7 989.4 999.1 1047.4 3749.5 3861.7 3881.9 3890.9 3965.6 8186.3 9165.7 9985.0 10183.9 10199.4 9931.2 10011.5 10033.1 10037.0 10167.1 7749.9 8035.0 8038.3 8043.1 8045.0 5316.5 5422.7 5480.3 5500.7 5543.0 9062.0 9159.4 9162.0 9246.9 9383.8 7143.6 9170.3 9506.0 9550.7 9584.2 5632.8 7102.6 7106.7 7118.8 7148.3 7526.5 7573.4 7670.7 7682.8 7686.0 6940.7 7006.1 7215.9 7341.3 7348.5 6030.9 7142.5 7211.1 7259.5 7307.8 6372.4 6377.0 6435.1 6453.3 6461.1 5038.4 5038.7 5041.3 5120.1 5191.5 4958.8 5034.7 5040.1 5121.8 5226.6 04:42:41 INFO - PROCESS | 1942 | 04:42:41 INFO - PROCESS | 1942 | [#4] prototype.html Cycles:180 Average:4352.87 Median:4785.17 stddev:1321.03 (27.6%) stddev-sans-first:1290.26 04:42:41 INFO - PROCESS | 1942 | Values: 357.6 360.1 368.9 374.5 374.8 4455.5 4718.0 4738.3 5000.5 5121.2 4240.0 5022.5 5177.4 5187.2 5222.7 3426.6 3531.6 4118.8 4123.3 4127.6 3206.6 3978.9 4135.9 4140.2 4157.7 4042.0 4077.4 4085.2 4085.8 4090.3 4027.7 4046.7 4066.1 4071.9 4072.0 3052.8 3615.4 3636.9 3652.3 3660.8 3947.6 4007.0 5050.5 5070.3 5090.6 3842.5 4333.8 4540.8 4570.0 4584.0 4768.8 4969.7 5273.4 5453.8 5466.0 3571.4 3782.4 3820.6 3828.0 3848.9 4757.5 5683.0 5703.7 5818.3 5891.7 3795.9 3835.1 3846.3 3874.2 3876.1 3246.7 3897.3 3912.3 3920.0 3927.8 3652.9 4063.0 4375.4 4490.4 4595.7 5495.0 5539.8 5564.7 5571.6 5627.4 1129.7 1173.7 1200.5 1258.4 1264.4 735.2 803.5 859.7 869.7 871.8 4303.8 4756.5 4912.4 4912.6 5010.9 4844.7 4917.0 4926.6 5202.9 5501.7 4165.8 4206.5 4238.8 4929.5 4947.9 2362.9 2690.4 2881.3 2882.6 2897.4 5500.5 5625.4 5640.7 5657.4 5657.8 4308.7 4891.5 5306.6 5539.8 5607.3 4469.4 5632.4 5635.6 5647.5 5654.9 4419.6 4504.7 5493.9 5497.7 5526.6 4624.3 4801.5 4993.7 5162.7 5438.9 4934.6 5541.3 5597.3 5666.3 5719.3 3098.2 3419.0 3826.6 3827.2 3847.7 5076.5 5194.4 5688.9 5701.9 5723.9 4723.9 5318.0 5461.5 5539.5 5570.1 5053.9 5123.9 5522.4 5544.6 5580.0 4598.3 4892.3 4901.5 5089.1 5478.6 4755.0 5240.8 5275.8 5528.4 5529.6 4991.7 5088.9 5291.4 5460.4 5463.8 04:42:41 INFO - PROCESS | 1942 | 04:42:41 INFO - PROCESS | 1942 | [#5] yui.html Cycles:180 Average:20008.36 Median:3712.23 stddev:28179.03 (759.1%) stddev-sans-first:28220.68 04:42:41 INFO - PROCESS | 1942 | Values: 672.5 707.8 771.4 820.3 825.0 13490.6 15399.8 16745.4 17486.4 17498.6 16217.4 16299.9 16377.2 16391.4 16416.3 881.0 893.0 906.1 906.8 909.4 855.2 871.1 893.8 897.0 899.5 943.8 950.1 950.2 950.6 951.8 933.9 941.3 941.9 942.3 946.7 679.1 709.2 709.2 711.0 711.1 15111.8 15380.1 15423.7 15665.7 15740.8 13777.7 14166.9 14172.4 14173.1 14179.2 11844.3 11910.5 11913.7 11979.4 12014.5 3653.3 3655.1 3675.3 3725.7 3832.7 105249.5 107533.0 108211.0 108629.0 109257.3 9482.2 10794.1 10826.8 10970.6 11284.5 22223.2 22535.2 22538.1 22599.0 22601.5 7443.8 7469.0 7507.5 7515.5 7577.7 3698.7 3858.9 3870.6 3909.0 3999.4 3195.5 3520.3 3616.2 3733.9 3851.1 710.2 714.3 725.3 728.6 737.8 559.8 656.2 668.6 703.9 707.3 8566.5 10155.3 10374.3 10380.8 10798.2 550.0 681.7 682.8 694.9 726.5 4822.5 5003.5 5017.0 5036.7 5045.9 70654.0 93010.5 95903.0 102100.0 102939.0 58090.7 82581.6 85628.7 87013.6 92612.0 54156.0 75003.0 75565.1 76522.6 79236.0 9965.8 10814.4 10885.9 11134.0 11287.8 48052.3 51092.2 51427.2 52506.7 52871.0 65799.0 66793.0 68318.7 68832.1 69414.0 11864.2 12008.0 12719.9 12736.6 12744.6 12406.3 14266.5 14353.9 14409.3 14598.3 13036.9 13317.5 13602.9 13974.4 14192.9 13492.3 13622.7 13911.9 14077.3 14140.9 10933.1 11462.8 13004.6 13450.2 13686.5 11089.3 11219.5 11369.2 11568.0 11632.9 10273.7 10782.7 10788.6 10796.7 10807.5 04:42:41 INFO - PROCESS | 1942 | -------- Summary: end -------- 04:42:41 INFO - PROCESS | 1942 | 04:42:42 INFO - TEST-INFO | 1942: exit 0 04:42:42 INFO - TEST-OK | dromaeo_css | took 1116655ms 04:42:42 INFO - TEST-START | kraken 04:42:42 INFO - operating with platform_type : mac_ 04:42:42 INFO - Initialising browser for kraken test... 04:42:42 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpv7LycL/profile http://localhost:54344/getInfo.html) 04:42:45 INFO - PROCESS | 1949 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 04:42:45 INFO - PROCESS | 1949 | 2017-02-04 04:42:45.128 plugin-container[1951:24518] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 04:42:45 INFO - PROCESS | 1949 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:42:45 INFO - PROCESS | 1949 | 2017-02-04 04:42:45.128 plugin-container[1951:24518] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 04:42:45 INFO - PROCESS | 1949 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:42:45 INFO - PROCESS | 1949 | 2017-02-04 04:42:45.128 plugin-container[1951:24518] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:42:45 INFO - PROCESS | 1949 | __metrics Screen width/height:1600/1200 04:42:45 INFO - PROCESS | 1949 | colorDepth:24 04:42:45 INFO - PROCESS | 1949 | Browser inner width/height: 1024/689 04:42:45 INFO - PROCESS | 1949 | __metrics 04:42:45 ERROR - PROCESS | 1949 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 04:42:45 INFO - PROCESS | 1949 | 1486212165320 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/FirefoxNightly.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/FirefoxNightly.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/tmpv7LycL/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpv7LycL/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpv7LycL/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpv7LycL/profile/extensions/talos-powers@TalosPowersService.js:55:9 04:42:46 INFO - TEST-INFO | 1949: exit 0 04:42:46 INFO - Browser initialized. 04:42:46 INFO - Running cycle 1/1 for kraken test... 04:42:46 INFO - TEST-INFO | started process 1952 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpv7LycL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:42:48 INFO - PROCESS | 1952 | 2017-02-04 04:42:48.534 plugin-container[1953:24639] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b4b, name = 'com.apple.tsm.portname' 04:42:48 INFO - PROCESS | 1952 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:42:48 INFO - PROCESS | 1952 | 2017-02-04 04:42:48.534 plugin-container[1953:24639] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900f, name = 'com.apple.CFPasteboardClient' 04:42:48 INFO - PROCESS | 1952 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:42:48 INFO - PROCESS | 1952 | 2017-02-04 04:42:48.534 plugin-container[1953:24639] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:42:58 INFO - PROCESS | 1952 | RSS: Main: 233713664 04:42:58 INFO - PROCESS | 1952 | 04:43:00 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:54344/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54344/tests/kraken/driver.html?testName=audio-beat-detection) 04:43:01 INFO - PROCESS | 1952 | RSS: Main: 247365632 04:43:01 INFO - PROCESS | 1952 | 04:43:04 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:54344/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54344/tests/kraken/driver.html?testName=audio-dft) 04:43:05 INFO - PROCESS | 1952 | RSS: Main: 256385024 04:43:05 INFO - PROCESS | 1952 | 04:43:08 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:54344/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54344/tests/kraken/driver.html?testName=audio-fft) 04:43:09 INFO - PROCESS | 1952 | RSS: Main: 258260992 04:43:09 INFO - PROCESS | 1952 | 04:43:11 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:54344/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54344/tests/kraken/driver.html?testName=audio-oscillator) 04:43:12 INFO - PROCESS | 1952 | RSS: Main: 259145728 04:43:12 INFO - PROCESS | 1952 | 04:43:14 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:54344/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54344/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:43:14 INFO - PROCESS | 1952 | RSS: Main: 259739648 04:43:14 INFO - PROCESS | 1952 | 04:43:17 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:54344/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54344/tests/kraken/driver.html?testName=imaging-darkroom) 04:43:18 INFO - PROCESS | 1952 | RSS: Main: 265093120 04:43:18 INFO - PROCESS | 1952 | 04:43:21 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:54344/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54344/tests/kraken/driver.html?testName=imaging-desaturate) 04:43:22 INFO - PROCESS | 1952 | RSS: Main: 266563584 04:43:22 INFO - PROCESS | 1952 | 04:43:24 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:54344/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54344/tests/kraken/driver.html?testName=json-parse-financial) 04:43:25 INFO - PROCESS | 1952 | RSS: Main: 266276864 04:43:25 INFO - PROCESS | 1952 | 04:43:27 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:54344/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54344/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:43:27 INFO - PROCESS | 1952 | RSS: Main: 265854976 04:43:27 INFO - PROCESS | 1952 | 04:43:30 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:54344/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54344/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:43:30 INFO - PROCESS | 1952 | RSS: Main: 265883648 04:43:30 INFO - PROCESS | 1952 | 04:43:32 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:54344/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54344/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:43:33 INFO - PROCESS | 1952 | RSS: Main: 265912320 04:43:33 INFO - PROCESS | 1952 | 04:43:36 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:54344/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54344/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:43:37 INFO - PROCESS | 1952 | RSS: Main: 266227712 04:43:37 INFO - PROCESS | 1952 | 04:43:40 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:54344/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54344/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:43:41 INFO - PROCESS | 1952 | RSS: Main: 266014720 04:43:41 INFO - PROCESS | 1952 | 04:43:42 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:54344/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54344/tests/kraken/driver.html?testName=ai-astar) 04:43:42 INFO - PROCESS | 1952 | RSS: Main: 267935744 04:43:42 INFO - PROCESS | 1952 | 04:43:42 INFO - PROCESS | 1952 | __start_tp_report 04:43:42 INFO - PROCESS | 1952 | _x_x_mozilla_page_load 04:43:42 INFO - PROCESS | 1952 | _x_x_mozilla_page_load_details 04:43:42 INFO - PROCESS | 1952 | |i|pagename|runs| 04:43:42 INFO - PROCESS | 1952 | |0;ai-astar;113;120;118;117;117;117;118;116;117;118 04:43:42 INFO - PROCESS | 1952 | |1;audio-beat-detection;148;113;130;192;109;154;148;121;135;113 04:43:42 INFO - PROCESS | 1952 | |2;audio-dft;271;268;203;215;242;196;286;279;209;194 04:43:42 INFO - PROCESS | 1952 | |3;audio-fft;89;70;51;74;73;87;85;87;97;69 04:43:42 INFO - PROCESS | 1952 | |4;audio-oscillator;87;72;84;71;71;72;80;72;108;115 04:43:42 INFO - PROCESS | 1952 | |5;imaging-gaussian-blur;89;86;89;85;105;85;96;134;87;121 04:43:42 INFO - PROCESS | 1952 | |6;imaging-darkroom;132;96;150;95;95;95;95;95;95;104 04:43:42 INFO - PROCESS | 1952 | |7;imaging-desaturate;101;96;92;93;94;92;91;94;92;83 04:43:42 INFO - PROCESS | 1952 | |8;json-parse-financial;61;63;64;63;63;63;62;63;66;61 04:43:42 INFO - PROCESS | 1952 | |9;json-stringify-tinderbox;71;73;96;59;95;119;113;109;71;73 04:43:42 INFO - PROCESS | 1952 | |10;stanford-crypto-aes;88;88;90;113;97;92;90;87;90;91 04:43:42 INFO - PROCESS | 1952 | |11;stanford-crypto-ccm;141;143;160;151;139;139;137;140;188;166 04:43:42 INFO - PROCESS | 1952 | |12;stanford-crypto-pbkdf2;175;175;188;244;207;176;178;237;190;181 04:43:42 INFO - PROCESS | 1952 | |13;stanford-crypto-sha256-iterative;69;66;66;69;68;68;66;69;66;67 04:43:42 INFO - PROCESS | 1952 | __end_tp_report 04:43:42 INFO - PROCESS | 1952 | __start_cc_report 04:43:42 INFO - PROCESS | 1952 | _x_x_mozilla_cycle_collect,986 04:43:42 INFO - PROCESS | 1952 | __end_cc_report 04:43:42 INFO - PROCESS | 1952 | __startTimestamp1486212222967__endTimestamp 04:43:42 INFO - PROCESS | 1952 | 04:43:42 INFO - PROCESS | 1952 | ------- Summary: start ------- 04:43:42 INFO - PROCESS | 1952 | Number of tests: 14 04:43:42 INFO - PROCESS | 1952 | 04:43:42 INFO - PROCESS | 1952 | [#0] ai-astar Cycles:10 Average:117.10 Median:117.50 stddev:1.79 (1.5%) stddev-sans-first:1.13 04:43:42 INFO - PROCESS | 1952 | Values: 113.0 120.0 118.0 117.0 117.0 117.0 118.0 116.0 117.0 118.0 04:43:42 INFO - PROCESS | 1952 | 04:43:42 INFO - PROCESS | 1952 | [#1] audio-beat-detection Cycles:10 Average:136.30 Median:141.50 stddev:25.38 (17.9%) stddev-sans-first:26.56 04:43:42 INFO - PROCESS | 1952 | Values: 148.0 113.0 130.0 192.0 109.0 154.0 148.0 121.0 135.0 113.0 04:43:42 INFO - PROCESS | 1952 | 04:43:42 INFO - PROCESS | 1952 | [#2] audio-dft Cycles:10 Average:236.30 Median:255.00 stddev:36.90 (14.5%) stddev-sans-first:36.94 04:43:42 INFO - PROCESS | 1952 | Values: 271.0 268.0 203.0 215.0 242.0 196.0 286.0 279.0 209.0 194.0 04:43:42 INFO - PROCESS | 1952 | 04:43:42 INFO - PROCESS | 1952 | [#3] audio-fft Cycles:10 Average:78.20 Median:86.00 stddev:13.36 (15.5%) stddev-sans-first:13.59 04:43:42 INFO - PROCESS | 1952 | Values: 89.0 70.0 51.0 74.0 73.0 87.0 85.0 87.0 97.0 69.0 04:43:42 INFO - PROCESS | 1952 | 04:43:42 INFO - PROCESS | 1952 | [#4] audio-oscillator Cycles:10 Average:83.20 Median:72.00 stddev:16.07 (22.3%) stddev-sans-first:16.99 04:43:42 INFO - PROCESS | 1952 | Values: 87.0 72.0 84.0 71.0 71.0 72.0 80.0 72.0 108.0 115.0 04:43:42 INFO - PROCESS | 1952 | 04:43:42 INFO - PROCESS | 1952 | [#5] imaging-gaussian-blur Cycles:10 Average:97.70 Median:86.50 stddev:17.13 (19.8%) stddev-sans-first:17.88 04:43:42 INFO - PROCESS | 1952 | Values: 89.0 86.0 89.0 85.0 105.0 85.0 96.0 134.0 87.0 121.0 04:43:42 INFO - PROCESS | 1952 | 04:43:42 INFO - PROCESS | 1952 | [#6] imaging-darkroom Cycles:10 Average:105.20 Median:95.00 stddev:19.54 (20.6%) stddev-sans-first:18.16 04:43:42 INFO - PROCESS | 1952 | Values: 132.0 96.0 150.0 95.0 95.0 95.0 95.0 95.0 95.0 104.0 04:43:42 INFO - PROCESS | 1952 | 04:43:42 INFO - PROCESS | 1952 | [#7] imaging-desaturate Cycles:10 Average:92.80 Median:92.50 stddev:4.49 (4.9%) stddev-sans-first:3.66 04:43:42 INFO - PROCESS | 1952 | Values: 101.0 96.0 92.0 93.0 94.0 92.0 91.0 94.0 92.0 83.0 04:43:42 INFO - PROCESS | 1952 | 04:43:42 INFO - PROCESS | 1952 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.00 stddev:1.45 (2.3%) stddev-sans-first:1.36 04:43:42 INFO - PROCESS | 1952 | Values: 61.0 63.0 64.0 63.0 63.0 63.0 62.0 63.0 66.0 61.0 04:43:42 INFO - PROCESS | 1952 | 04:43:42 INFO - PROCESS | 1952 | [#9] json-stringify-tinderbox Cycles:10 Average:87.90 Median:72.00 stddev:21.11 (29.3%) stddev-sans-first:21.48 04:43:42 INFO - PROCESS | 1952 | Values: 71.0 73.0 96.0 59.0 95.0 119.0 113.0 109.0 71.0 73.0 04:43:42 INFO - PROCESS | 1952 | 04:43:42 INFO - PROCESS | 1952 | [#10] stanford-crypto-aes Cycles:10 Average:92.60 Median:90.00 stddev:7.69 (8.5%) stddev-sans-first:7.98 04:43:42 INFO - PROCESS | 1952 | Values: 88.0 88.0 90.0 113.0 97.0 92.0 90.0 87.0 90.0 91.0 04:43:42 INFO - PROCESS | 1952 | 04:43:42 INFO - PROCESS | 1952 | [#11] stanford-crypto-ccm Cycles:10 Average:150.40 Median:147.00 stddev:16.47 (11.2%) stddev-sans-first:17.11 04:43:42 INFO - PROCESS | 1952 | Values: 141.0 143.0 160.0 151.0 139.0 139.0 137.0 140.0 188.0 166.0 04:43:42 INFO - PROCESS | 1952 | 04:43:42 INFO - PROCESS | 1952 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.10 Median:189.00 stddev:25.88 (13.7%) stddev-sans-first:26.41 04:43:42 INFO - PROCESS | 1952 | Values: 175.0 175.0 188.0 244.0 207.0 176.0 178.0 237.0 190.0 181.0 04:43:42 INFO - PROCESS | 1952 | 04:43:42 INFO - PROCESS | 1952 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:1.35 (2.0%) stddev-sans-first:1.30 04:43:42 INFO - PROCESS | 1952 | Values: 69.0 66.0 66.0 69.0 68.0 68.0 66.0 69.0 66.0 67.0 04:43:42 INFO - PROCESS | 1952 | -------- Summary: end -------- 04:43:42 INFO - PROCESS | 1952 | 04:43:43 INFO - TEST-INFO | 1952: exit 0 04:43:43 INFO - TEST-OK | kraken | took 61807ms 04:43:43 INFO - SUITE-END | took 1178s 04:43:44 INFO - Completed test suite (00:19:38) 04:43:44 INFO - javascript benchmark 04:43:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7344.463738239892, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3249.7237734792543, 3291.769576129671, 3308.586426696663, 3326.6174389945163, 3337.9666203337974, 5370.973145134279, 5458.481444262794, 5499.202615620733, 5519.530839878616, 5569.693666848321, 5402.324709411324, 5508.55931525479, 5547.362053363864, 5594.24477695512, 5625.437456254373, 4974.77613507393, 5029.145045342282, 5119.488051194888, 5134.871628209287, 5139.0, 4918.655694101414, 5046.54581087702, 5204.9739751301195, 5221.738913054351, 5227.242049902762, 4898.069366820293, 4900.093482705675, 5155.0, 5182.766775495112, 5198.766055527511, 5013.273075404046, 5054.11552978231, 5095.643304968654, 5114.820981265638, 5158.277841102249, 5003.874903127415, 5061.772220250097, 5075.847724568269, 5082.288479612857, 5100.795968161269, 4157.875263742062, 5344.637117535004, 5504.284443022381, 5557.610967232255, 5574.163875418679, 5899.174115623816, 6106.786262480792, 6122.295935967376, 6154.5076393888385, 6163.137160797492, 6233.407826256544, 6237.906431403487, 6248.562600617958, 6251.0, 6255.781047663356, 5772.769089236425, 5774.826755197309, 5790.478856902815, 5792.102224155263, 5810.564207684441, 6042.274927008787, 6113.932424433873, 6121.270068921596, 6122.733612273343, 6133.548895741563, 6009.519238460913, 6038.0, 6049.939500604937, 6066.575339726265, 6083.057126145454, 6064.241969753781, 6134.8159555213415, 6153.507719382439, 6157.9384206158265, 6176.752929882754, 4940.431850337185, 5878.0, 5932.911006334822, 6026.6384016958245, 6111.724972376253, 6132.8756461173125, 6135.4776558202, 6140.8416929778305, 6145.863015342176, 6146.5390095743, 4107.507099148062, 4889.462159162489, 4899.044686286211, 4910.435299940481, 4943.184374578226, 4271.572842715704, 4279.679024073207, 4283.443152390169, 4332.696711230184, 4399.494058183286, 4717.528247175255, 5516.724163791875, 5525.171224316385, 5527.336719593594, 5560.77756889728, 5967.98544247479, 6017.06735456005, 6039.818805435844, 6061.6666083365835, 6073.331933487313, 5460.563154947595, 5503.724813759376, 5561.777528898799, 5569.0254205513875, 5586.385497595261, 5317.042932272228, 5329.760160792774, 5347.278117454094, 5357.11607584752, 5417.620766546383, 6238.220222472191, 6265.404786545271, 6268.843278918063, 6285.685715714288, 6305.180326557518, 5960.4635582797755, 6169.1054797053275, 6190.226221722285, 6210.813675589739, 6215.65813880241, 5151.768170432414, 6093.238345206849, 6217.0, 6256.90504161779, 6281.842953926189, 6064.211652485149, 6114.052321890114, 6123.908141377972, 6132.860319284376, 6152.169457123231, 5695.430456954271, 6072.7553793601055, 6202.131701561875, 6216.409441103088, 6228.750849966132, 5340.679559226459, 5818.359980402237, 5914.526837852875, 5937.435943585352, 5952.255968003999, 5991.7603295867675, 6002.549808764447, 6017.0, 6039.214902062704, 6073.696315184135, 5640.492355687844, 5717.37108918027, 5812.3025236971835, 5848.590598658223, 5871.6770577618645, 5960.910586341121, 6066.787662431793, 6068.089786532056, 6086.147939288591, 6102.511799056154, 5835.94164058354, 5855.38518455556, 5871.0, 5892.6759028252145, 5918.378570250062], "value": 5558.481051969821, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [443.02313398955306, 454.7498875618409, 475.5553557423809, 483.70010593432056, 537.991930121048, 37405.8778236653, 40121.1975760485, 40145.0, 40211.39682904755, 40338.59661403385, 41135.91480638949, 41866.58133418665, 41885.162296754046, 41919.3712094318, 41963.95090122749, 9025.458472491655, 9387.48368839717, 10668.573257069707, 11034.889651103507, 11038.17213708971, 10823.080038196762, 10928.125749940025, 10934.726631834228, 10947.397893115876, 10960.671179864577, 9907.959664235259, 10209.489525523732, 10993.61522346718, 11006.064484518785, 11028.944855275713, 10915.181361397887, 10923.726906827393, 11000.954909283606, 11002.50488728009, 11008.009279164833, 10837.891621083767, 10918.563257469692, 10927.508262128224, 10935.0, 10955.287906286067, 29606.407871842443, 37179.88460346194, 37240.81379593112, 37247.0, 37307.81346093279, 3895.18201177753, 3903.882883513499, 3949.2228497176097, 3949.940750888739, 3952.3083460394314, 27799.86100069507, 28667.56998645022, 28726.85636571804, 28891.422171556453, 29052.854735726396, 3147.5593416921647, 3148.5277208418693, 3168.0970923286754, 3265.346930613887, 3269.493228549579, 481516.0, 482246.0, 485909.0, 485923.99999999645, 486491.0, 57019.0, 57317.71341143268, 57681.13478297829, 57874.71062644744, 57983.71008145017, 59590.70204648949, 59924.700376497836, 59972.700136499036, 60216.0, 60325.39674603286, 13994.0, 14648.707025859423, 14930.552083437515, 15183.316750746242, 15238.238088095552, 8419.789505262417, 10974.506147223394, 11688.298702077902, 11691.064714822794, 11720.06239500838, 13879.930600346934, 17586.296548137932, 17813.910930445265, 17838.55403614894, 17967.820321796877, 6226.688665566703, 7974.727202747189, 8012.519248844971, 8027.357811375076, 8069.354451643854, 802.0390146092748, 847.6143354773563, 863.4603372891943, 873.0658195730507, 877.5953886351351, 24082.555046696903, 28780.424391512053, 29757.809687612687, 30247.395052098836, 30705.846470767505, 1020.9489525523694, 1025.497506221946, 1036.1451802263011, 1058.6506452870535, 1062.3094988257694, 13491.718286762938, 13926.442942282398, 15207.771883421758, 15486.303116359792, 15815.604609884615, 627044.0, 631220.0, 632079.0, 633442.0, 638395.0, 59463.70268148718, 60030.399696003355, 60048.69975650181, 60121.0, 60136.0, 1236.0667695889726, 1387.4172847403913, 1415.7876318552298, 1428.7142571485745, 1433.6129245103973, 24349.634755479037, 28075.438491229652, 29189.270268243465, 33187.668123319425, 33656.0, 55810.44189558052, 55937.16094258508, 56339.71830140987, 56432.7178364122, 56742.0, 542148.0, 547713.0, 547968.0, 549574.0, 549770.0, 25729.871350643127, 26216.0, 26523.469530609666, 26843.0, 27018.459630807665, 42304.730858074305, 42790.716278511696, 43603.345949810144, 43909.78045109754, 44086.55913440953, 35844.462333065545, 36100.458493122096, 36100.81949590235, 36992.44511332386, 37365.626343736214, 35696.464553032245, 35857.8282115645, 36259.637403625624, 36643.63356366402, 36863.63136368709, 25220.86506107266, 30987.84506077455, 34451.13872153116, 35735.28529429449, 35879.46180807238, 22865.0, 31029.379412412076, 31830.84084579562, 31995.36009279755, 32248.0, 23742.287731367396, 24076.435031722882, 24080.397990050387, 24129.879350603136, 24279.514409711355], "value": 19594.355900759867, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.4852270117525, 381.7231361097129, 392.15099309993855, 403.54802621064414, 416.35880743654775, 8669.523176225304, 19077.71383429248, 20693.896530517362, 20844.0, 20860.687089693667, 17042.573935651613, 21909.671354929687, 22628.660570091462, 23033.0, 23091.307260782163, 6743.460523158135, 6925.134358205224, 7289.744858929938, 7647.044119485065, 7756.224377562226, 7569.318761311481, 7669.156392796788, 7703.306702396783, 7744.883826742604, 7974.880376794353, 7758.418118641096, 8002.0797608274925, 8018.679252829909, 8024.759257222293, 8029.759107226792, 7780.727674531393, 7798.0, 7909.881351779728, 7973.760787176394, 8006.599670016476, 7432.665530051161, 7729.458937874351, 7764.844703105906, 7765.53406795594, 7773.689052437896, 26636.467270654477, 27628.723712762818, 27800.02699905514, 28337.29156771097, 29237.97667081642, 2804.2708895687065, 2827.2225138086983, 2940.5001149804584, 2940.588317635533, 2944.89692860751, 16355.83644163555, 16883.746743798853, 17283.567910802205, 17346.3061477542, 17436.564085897826, 1990.6914428263642, 2054.4658388818866, 2054.897255137252, 2062.092679221138, 2065.4216819290623, 83598.58200708957, 117880.41059794732, 118569.0, 157356.0, 161247.0, 19852.50368740793, 22568.0, 23392.64911026336, 23654.526909461714, 23840.284791456284, 40494.0, 40745.59254407418, 40960.0, 41049.38425923613, 41195.7940210297, 8163.510189388537, 8357.331413486907, 8611.397202195787, 8778.561071946377, 11099.889001109885, 8212.712555060543, 8234.711785087493, 8245.988724530298, 8352.248297653241, 8496.150384961455, 4270.829166833292, 4477.701466574722, 4834.154023045953, 4948.430930443045, 4968.8757781055765, 1635.2886494374984, 2067.4934641013047, 2106.231225602644, 2118.2691971269887, 2119.9470013249793, 730.9524880882726, 826.2398593294064, 832.213558187507, 861.8922634670666, 873.8033942363045, 20980.580388392147, 21708.674369884466, 21766.782332176794, 21817.890910545346, 21959.890200548896, 865.8787769712245, 877.903430622631, 892.7768057985504, 895.2524641924066, 905.1310741687921, 11237.157213209042, 11316.6039188628, 11317.660470185907, 11379.146564007568, 11444.370559619301, 723029.0, 728061.0, 732106.0, 753722.0, 765901.0, 170287.14856425885, 170474.0, 171694.0, 171961.0, 173932.1303393475, 1086.5870969031716, 1091.252492042953, 1139.1854823801023, 1145.4215621111452, 1151.1251448898897, 18452.985085820408, 20422.897885510476, 20521.076551555514, 20804.167833286498, 20849.0, 43357.0, 45981.77009114933, 59341.10988335265, 60541.48646283878, 61244.99999999822, 88900.0, 89247.55376223077, 89463.55268223878, 91113.54443227741, 91619.0, 8049.7120460726, 8381.371397145116, 8632.0, 8759.211670949646, 8804.427712198687, 8278.172182781673, 12870.22778633285, 13648.385822638204, 13710.314484275546, 13993.720125597634, 11786.705332366759, 11888.881111188777, 11900.821487677866, 12026.15816892809, 12075.275483470668, 10932.016118549369, 11457.59898403552, 11556.826647600124, 11852.64442066705, 11913.702157446132, 10005.749856253651, 10248.026437488426, 11834.230774999598, 12132.636020919386, 12180.269183848997, 8437.831243375222, 8456.154384561494, 8581.27059199975, 8738.25724813398, 8850.380473366802, 10925.890741092488, 11652.766944661229, 11716.179867409199, 11936.880631193577, 11993.820092698443], "value": 11084.771489638439, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1167.9532818687258, 1380.2753554383942, 1386.6810633554283, 1396.343718452327, 1396.9441222351104, 8144.877826832595, 8251.834963300731, 8586.22723954844, 8625.913740862581, 8647.481151130929, 7001.334873187039, 8480.83038339233, 8588.785280367994, 8623.827523449527, 8625.91374086259, 2240.395093324801, 2274.590573696734, 2282.7945484906354, 2287.588234117858, 2289.061484791236, 2249.80876625487, 2275.8634481931053, 2284.565932472833, 2296.047140436725, 2299.9655005174936, 2149.441145302217, 2151.0427859602405, 2168.761436242012, 2175.5213852952324, 2179.6730490426403, 2166.1768527959275, 2241.5628952354296, 2255.8984845681985, 2264.784845439681, 2267.036509483471, 1855.7587513623278, 1972.260402349119, 2049.6822992436196, 2227.2761352560483, 2295.2769877488536, 8283.792905177359, 8469.280111190556, 8494.193051660082, 8540.957295213546, 8617.65529378824, 5013.573846223076, 5095.592352611782, 5172.19830926207, 5174.896502069975, 5191.896162076738, 2943.1906225787866, 3307.140143562691, 3314.734821214297, 3493.772904761208, 3519.085037890167, 911.5214512380986, 1027.3887037212846, 1186.1104171871098, 1203.1096988228735, 1237.2700106936861, 8933.86599201006, 10886.129109671287, 10987.121030317636, 10993.230473866832, 11085.83371249432, 4240.342746874239, 4410.647148228134, 4491.3487544306545, 4497.145542346943, 4504.797284122223, 8804.075572064841, 8807.33944954131, 8853.424527405698, 8858.335624828163, 8875.378723489423, 5119.539241468286, 5126.641135120581, 5130.615203859726, 5141.742912854343, 5154.433012368637, 4637.072585482917, 4652.116097941448, 4669.509701481364, 4741.668083234141, 4767.380240568704, 3608.9819550902075, 3672.4491326301268, 3675.338439080991, 3752.1182522107283, 3776.188119554309, 1129.5086637312795, 1133.8582677165355, 1138.4023387721513, 1153.1927650644582, 1154.3608076531345, 847.8219573889429, 884.5179377239419, 887.5562218890555, 916.863089768682, 946.3091942881597, 5480.534154596824, 5768.653880767168, 5768.826935191867, 5787.421257874179, 5938.554608404387, 982.3958265666706, 982.7248370456284, 989.4113002763344, 999.14073896449, 1047.4082143588848, 3749.544412879254, 3861.7449328968196, 3881.86413475527, 3890.8638197662945, 3965.643092121723, 8186.2632363087605, 9165.725028249164, 9984.950075249722, 10183.949080254699, 10199.439030853375, 9931.155851752537, 10011.549480273405, 10033.147182489423, 10037.0, 10167.135793457639, 7749.922500775033, 8034.999999999883, 8038.316743076787, 8043.11525732169, 8045.0, 5316.548093411949, 5422.701751403711, 5480.314960629921, 5500.697461639488, 5543.0, 9062.0, 9159.394939275342, 9161.992180859967, 9246.861297080415, 9383.765405864908, 7143.571385716874, 9170.266378689555, 9506.049395060438, 9550.713478595653, 9584.185344245818, 5632.831015069554, 7102.609356485236, 7106.7157313706875, 7118.822029449305, 7148.28517148281, 7526.473146879666, 7573.431992600687, 7670.654820532978, 7682.8079298018, 7686.039245094364, 6940.652967351713, 7006.089208402875, 7215.927840721525, 7341.265873412616, 7348.485606007528, 6030.879382412415, 7142.5000249982, 7211.134663840373, 7259.455540834353, 7307.7807665770115, 6372.36276372359, 6377.0, 6435.131257280207, 6453.290138084901, 6461.095446637569, 5038.395392552917, 5038.697678139323, 5041.294218809297, 5120.129577971679, 5191.480851914778, 4958.776855041459, 5034.672746271481, 5040.117979353672, 5121.820736274212, 5226.63413561047], "value": 4353.100088029973, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.57270062275575, 360.10693480169175, 368.893021023903, 374.4626461028426, 374.7863717680921, 4455.462865311466, 4718.032803275329, 4738.336632871396, 5000.524950129732, 5121.231815227718, 4239.957600423995, 5022.547970682647, 5177.352830896138, 5187.247849061884, 5222.738863056841, 3426.6059403168706, 3531.5585551806025, 4118.814653340592, 4123.257813593567, 4127.62851343379, 3206.6431173087763, 3978.860739874105, 4135.875923722293, 4140.151268989865, 4157.688173386993, 4041.959580404188, 4077.4495443115243, 4085.2406945907983, 4085.754854708712, 4090.2637525245445, 4027.6979226558124, 4046.6560342370785, 4066.0648050948153, 4071.9185616287805, 4071.959280407217, 3052.8473576321094, 3615.421532554805, 3636.890893273206, 3652.3060618482405, 3660.816959152058, 3947.5855035221175, 4006.959930400717, 5050.494950504957, 5070.29015937769, 5090.574639101058, 3842.500474938268, 4333.848315308981, 4540.7502587357685, 4569.977150114261, 4584.037352156051, 4768.809247630091, 4969.676970996874, 5273.419923808378, 5453.809116680897, 5465.961467321236, 3571.3750243639083, 3782.432635104729, 3820.6370394812448, 3828.0238539172333, 3848.903777405559, 4757.476677565465, 5682.971585142089, 5703.65778053314, 5818.323571157272, 5891.7054147292465, 3795.899189235091, 3835.0824587706147, 3846.3461211594094, 3874.2445223181207, 3876.1472476055224, 3246.717546569092, 3897.317969355408, 3912.3349030664854, 3919.9608003920166, 3927.7643341399607, 3652.945205821915, 4062.979685101615, 4375.431193944767, 4490.416245888014, 4595.724256544618, 5495.0, 5539.778408863681, 5564.718465429155, 5571.5513966369035, 5627.380988091307, 1129.7119234595125, 1173.7065733566608, 1200.4657927222477, 1258.426966292135, 1264.3804535777404, 735.1655870586923, 803.4857691077598, 859.7420773767844, 869.6912596028319, 871.847426700325, 4303.849365272201, 4756.548127927841, 4912.435069966999, 4912.641931872649, 5010.924836127461, 4844.698768085202, 4917.041176970456, 4926.58124059459, 5202.92195617066, 5501.707098831771, 4165.8333666653, 4206.495220573551, 4238.8497974959955, 4929.457759646436, 4947.925781113287, 2362.8658244042954, 2690.435008648167, 2881.3084859633536, 2882.5964364988918, 2897.435000174946, 5500.477454641803, 5625.38120806711, 5640.717964101778, 5657.377688454267, 5657.830265092054, 4308.6983911126545, 4891.486393928657, 5306.602004849652, 5539.833804985777, 5607.252446301283, 4469.351943968171, 5632.436756324417, 5635.605507614428, 5647.548196144298, 5654.886902261932, 4419.558044195554, 4504.729716217037, 5493.890122197614, 5497.725113744376, 5526.557875370041, 4624.260118381043, 4801.5355316627365, 4993.725345106054, 5162.741862906914, 5438.89363530532, 4934.568974997211, 5541.33503979525, 5597.328320601554, 5666.320041595035, 5719.3136823581435, 3098.209956461088, 3419.042668052949, 3826.617338266151, 3827.1771569112775, 3847.711421643332, 5076.517730815566, 5194.428612852507, 5688.886222275614, 5701.914471283017, 5723.8569035774435, 4723.905521889475, 5317.973410132925, 5461.481159289861, 5539.529140023144, 5570.108782594765, 5053.949460505495, 5123.871903202301, 5522.420145884625, 5544.61187716856, 5579.972100139474, 4598.3102534620075, 4892.290617860462, 4901.460839307602, 5089.1094058538865, 5478.589105817, 4754.976225118852, 5240.842774716764, 5275.788968441373, 5528.391876893458, 5529.557635389078, 4991.725455100004, 5088.9058852346925, 5291.391489978701, 5460.3720572133125, 5463.836084917459], "value": 3949.251926567091, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.4653900149381, 707.7947395255374, 771.44455991686, 820.3323091608746, 824.979375515612, 13490.59528214154, 15399.846001539981, 16745.41391051315, 17486.38797642083, 17498.56253593661, 16217.432389866357, 16299.91850040748, 16377.181140942936, 16391.4263000795, 16416.343346266163, 880.955952202389, 893.0444424465824, 906.0531744327161, 906.8367693815144, 909.417972497602, 855.2132038524542, 871.0853603716105, 893.8346405914895, 896.9686060987834, 899.5322432335182, 943.7923656795494, 950.1021534649759, 950.2208189284789, 950.6150009246267, 951.8143961927427, 933.8785957825473, 941.2517048946036, 941.9434833909919, 942.3074040580168, 946.7396465971879, 679.140886778226, 709.2198581560294, 709.230484923853, 710.9608971506565, 711.1111111111111, 15111.848881511154, 15380.077195368314, 15423.691526169527, 15665.686686266325, 15740.763888541682, 13777.655558611015, 14166.858331416657, 14172.433102675881, 14173.149611023371, 14179.220142892136, 11844.34856082915, 11910.523579056828, 11913.652159193816, 11979.401029948467, 12014.459349329214, 3653.2693461307845, 3655.0862284428895, 3675.3384390809642, 3725.739198256123, 3832.6550610444915, 105249.47375263074, 107533.0, 108211.0, 108629.0, 109257.25027121317, 9482.241420686467, 10794.136469082454, 10826.779512156261, 10970.616028439126, 11284.492197851116, 22223.22218722337, 22535.211267605555, 22538.098476061103, 22599.0, 22601.547969040526, 7443.776686699408, 7469.0, 7507.474476786681, 7515.549067055994, 7577.696892124363, 3698.7239402406126, 3858.864939727096, 3870.59358767331, 3909.0227443139215, 3999.440078389028, 3195.4887218045, 3520.2607452435277, 3616.240589476187, 3733.8506459741848, 3851.0757418219987, 710.1832892174041, 714.3142583120159, 725.2602345607451, 728.6101935464501, 737.8118579762127, 559.7928766356392, 656.1601150527238, 668.6026205231091, 703.929607039292, 707.2785758526275, 8566.48601083937, 10155.289129760846, 10374.325668831501, 10380.844287335696, 10798.244122911477, 549.9505044546011, 681.7000519771285, 682.8156397772574, 694.8783962806489, 726.4733068525277, 4822.493638167942, 5003.49965003504, 5017.0, 5036.6726162799305, 5045.924311135336, 70654.0, 93010.53494732484, 95903.0, 102099.97900021053, 102939.0, 58090.709546451995, 82581.58709206416, 85628.71556926651, 87013.56493217494, 92612.0, 54156.0, 75003.0, 75565.11087222863, 76522.61738691271, 79236.0, 9965.750856228653, 10814.405207713651, 10885.945570272099, 11134.0, 11287.830682539605, 48052.27921581109, 51092.23361649504, 51427.228591571904, 52506.73746631242, 52871.0, 65799.0, 66793.0, 68318.65840670765, 68832.06565749418, 69414.0, 11864.22882512634, 12008.0, 12719.93640031831, 12736.554220602235, 12744.553940612033, 12406.25562466255, 14266.500672476413, 14353.856461435253, 14409.279536023367, 14598.27008649542, 13036.869631303565, 13317.533886313933, 13602.93198534001, 13974.441022359399, 14192.858071419567, 13492.325383730971, 13622.659433514242, 13911.860881391056, 14077.296135193405, 14140.858591413955, 10933.070688991525, 11462.82805757931, 13004.609861704164, 13450.192988420726, 13686.452541898212, 11089.33463992163, 11219.49512271966, 11369.204155709353, 11568.016718579014, 11632.88367116318, 10273.74315642115, 10782.73043173927, 10788.622398216025, 10796.730081748019, 10807.486951826593], "value": 7561.036701705331, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1603.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 120.0, 118.0, 117.0, 117.0, 117.0, 118.0, 116.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 113.0, 130.0, 192.0, 109.0, 154.0, 148.0, 121.0, 135.0, 113.0], "value": 136.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [271.0, 268.0, 203.0, 215.0, 242.0, 196.0, 286.0, 279.0, 209.0, 194.0], "value": 236.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 51.0, 74.0, 73.0, 87.0, 85.0, 87.0, 97.0, 69.0], "value": 78.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 84.0, 71.0, 71.0, 72.0, 80.0, 72.0, 108.0, 115.0], "value": 83.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 85.0, 105.0, 85.0, 96.0, 134.0, 87.0, 121.0], "value": 97.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 96.0, 150.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 104.0], "value": 105.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 96.0, 92.0, 93.0, 94.0, 92.0, 91.0, 94.0, 92.0, 83.0], "value": 92.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 64.0, 63.0, 63.0, 63.0, 62.0, 63.0, 66.0, 61.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 96.0, 59.0, 95.0, 119.0, 113.0, 109.0, 71.0, 73.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 90.0, 113.0, 97.0, 92.0, 90.0, 87.0, 90.0, 91.0], "value": 92.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 143.0, 160.0, 151.0, 139.0, 139.0, 137.0, 140.0, 188.0, 166.0], "value": 150.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 188.0, 244.0, 207.0, 176.0, 178.0, 237.0, 190.0, 181.0], "value": 195.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 66.0, 69.0, 68.0, 68.0, 66.0, 69.0, 66.0, 67.0], "value": 67.4, "unit": "score"}]}]} 04:43:44 INFO - Return code: 0 04:43:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:43:44 ERROR - # TBPL SUCCESS # 04:43:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:43:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:43:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:43:44 INFO - 2017-02-04 04:43:44.262 screenresolution[1957:25010] starting screenresolution argv=screenresolution get 04:43:44 INFO - 2017-02-04 04:43:44.265 screenresolution[1957:25010] Display 0: 1600x1200x32@60 04:43:44 INFO - 2017-02-04 04:43:44.271 screenresolution[1958:25013] starting screenresolution argv=screenresolution list 04:43:44 INFO - Available Modes on Display 0 04:43:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:43:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:43:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:43:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:43:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:43:44 INFO - Intel Iris: 04:43:44 INFO - Chipset Model: Intel Iris 04:43:44 INFO - Type: GPU 04:43:44 INFO - Bus: Built-In 04:43:44 INFO - VRAM (Dynamic, Max): 1536 MB 04:43:44 INFO - Vendor: Intel (0x8086) 04:43:44 INFO - Device ID: 0x0a2e 04:43:44 INFO - Revision ID: 0x0009 04:43:44 INFO - Displays: 04:43:44 INFO - Display: 04:43:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:43:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:43:44 INFO - Display Serial Number: 1600x1200 60 04:43:44 INFO - Main Display: Yes 04:43:44 INFO - Mirror: Off 04:43:44 INFO - Online: Yes 04:43:44 INFO - Rotation: Supported 04:43:44 INFO - Return code: 0 04:43:44 INFO - Running post-action listener: _resource_record_post_action 04:43:44 INFO - [mozharness: 2017-02-04 12:43:44.509746Z] Finished run-tests step (success) 04:43:44 INFO - Running post-run listener: _resource_record_post_run 04:43:44 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 1552384; Write bytes: 558435840; Read time: 15; Write time: 2026 04:43:44 INFO - TinderboxPrint: CPU usage
54.4% 04:43:44 INFO - TinderboxPrint: I/O read bytes / time
1,552,384 / 15 04:43:44 INFO - TinderboxPrint: I/O write bytes / time
558,435,840 / 2,026 04:43:44 INFO - TinderboxPrint: CPU idle
2,189.0 (45.6%) 04:43:44 INFO - TinderboxPrint: CPU system
968.4 (20.2%) 04:43:44 INFO - TinderboxPrint: CPU user
1,648.2 (34.3%) 04:43:44 INFO - TinderboxPrint: Swap in / out
253,128,704 / 0 04:43:44 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 252285440; Write bytes: 246453760; Read time: 18158; Write time: 546 04:43:44 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 1507328; Write bytes: 302790656; Read time: 14; Write time: 1435 04:43:44 INFO - Running post-run listener: _upload_blobber_files 04:43:44 INFO - Blob upload gear active. 04:43:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:43:44 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 04:43:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:43:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:43:45 INFO - (blobuploader) - INFO - Open directory for files ... 04:43:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:43:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:43:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:46 INFO - (blobuploader) - INFO - Done attempting. 04:43:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:43:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:43:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:47 INFO - (blobuploader) - INFO - Done attempting. 04:43:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:43:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:43:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:48 INFO - (blobuploader) - INFO - Done attempting. 04:43:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:43:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:43:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:50 INFO - (blobuploader) - INFO - Done attempting. 04:43:50 INFO - (blobuploader) - INFO - Iteration through files over. 04:43:50 INFO - Return code: 0 04:43:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:43:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:43:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92b22fd3ef9bc93250153fd93ef1de58b41977f109a113e71bf053c5c087d289dae83252f04025db826632d2172525d50993b204982bd620a8c911c2b3571666", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2943fa31e1d6db281e4bce6eea4f7f1d055d7c9a3e76049e70f2d1489de928287399f4d2b5ff374871e702120885432bdbd637aee65871b111a138d4cc17096", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88857a17138ea429adf699c66412ea6c9287a2558998a68a0e97ad4ce54b08c7c0c1543d05344bb1757bdd161830f99661baa750da64f10218910cb0193be7ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4f5129bec663a628a528444e579f2411b059bd4a5dc129063b85145cd0b474cdb0f5e4cfa4174d6044103b9d6f5ad709a4e62f2f8292bb5487aba1f53ffd16f"} 04:43:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:43:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:43:50 INFO - Contents: 04:43:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92b22fd3ef9bc93250153fd93ef1de58b41977f109a113e71bf053c5c087d289dae83252f04025db826632d2172525d50993b204982bd620a8c911c2b3571666", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2943fa31e1d6db281e4bce6eea4f7f1d055d7c9a3e76049e70f2d1489de928287399f4d2b5ff374871e702120885432bdbd637aee65871b111a138d4cc17096", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88857a17138ea429adf699c66412ea6c9287a2558998a68a0e97ad4ce54b08c7c0c1543d05344bb1757bdd161830f99661baa750da64f10218910cb0193be7ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4f5129bec663a628a528444e579f2411b059bd4a5dc129063b85145cd0b474cdb0f5e4cfa4174d6044103b9d6f5ad709a4e62f2f8292bb5487aba1f53ffd16f"} 04:43:50 INFO - Running post-run listener: copy_logs_to_upload_dir 04:43:50 INFO - Copying logs to upload dir... 04:43:50 INFO - mkdir: /builds/slave/test/build/upload/logs 04:43:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.595476 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-02-04 04:43:51.002378) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-04 04:43:51.006034) ========= 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.Rtm9tW3vHt/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.yGRqmxlIQw/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/Firefox/sha512/92b22fd3ef9bc93250153fd93ef1de58b41977f109a113e71bf053c5c087d289dae83252f04025db826632d2172525d50993b204982bd620a8c911c2b3571666", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2943fa31e1d6db281e4bce6eea4f7f1d055d7c9a3e76049e70f2d1489de928287399f4d2b5ff374871e702120885432bdbd637aee65871b111a138d4cc17096", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88857a17138ea429adf699c66412ea6c9287a2558998a68a0e97ad4ce54b08c7c0c1543d05344bb1757bdd161830f99661baa750da64f10218910cb0193be7ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4f5129bec663a628a528444e579f2411b059bd4a5dc129063b85145cd0b474cdb0f5e4cfa4174d6044103b9d6f5ad709a4e62f2f8292bb5487aba1f53ffd16f"} build_url:https://queue.taskcluster.net/v1/task/NS6fQSoISISw3FvvWU7BUA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010909 build_url: 'https://queue.taskcluster.net/v1/task/NS6fQSoISISw3FvvWU7BUA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92b22fd3ef9bc93250153fd93ef1de58b41977f109a113e71bf053c5c087d289dae83252f04025db826632d2172525d50993b204982bd620a8c911c2b3571666", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2943fa31e1d6db281e4bce6eea4f7f1d055d7c9a3e76049e70f2d1489de928287399f4d2b5ff374871e702120885432bdbd637aee65871b111a138d4cc17096", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88857a17138ea429adf699c66412ea6c9287a2558998a68a0e97ad4ce54b08c7c0c1543d05344bb1757bdd161830f99661baa750da64f10218910cb0193be7ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4f5129bec663a628a528444e579f2411b059bd4a5dc129063b85145cd0b474cdb0f5e4cfa4174d6044103b9d6f5ad709a4e62f2f8292bb5487aba1f53ffd16f"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-04 04:43:51.046782) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 04:43:51.047378) ========= 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.Rtm9tW3vHt/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.yGRqmxlIQw/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.005277 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 04:43:51.097232) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-04 04:43:51.097559) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-04 04:43:51.097916) ========= ========= Total master_lag: 0.34 =========