builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0201 starttime: 1491133329.05 results: success (0) buildid: 20170402030202 builduid: 9f9704ef7d9d48469f84a8647184be40 revision: 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-02 04:42:09.048354) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-02 04:42:09.048805) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-02 04:42:09.049142) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-02 04:42:09.076437) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 04:42:09.076786) ========= 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.kRBiHTOvmh/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.tmTBlZQNIe/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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-04-02 04:42:09-- 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% 19.0M=0.001s 2017-04-02 04:42:09 (19.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.813248 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 04:42:09.917474) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 04:42:09.917798) ========= 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.kRBiHTOvmh/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.tmTBlZQNIe/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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.026690 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 04:42:09.966373) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-02 04:42:09.966751) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 --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 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kRBiHTOvmh/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.tmTBlZQNIe/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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-04-02 04:42:09,984 truncating revision to first 12 chars 2017-04-02 04:42:09,984 Setting DEBUG logging. 2017-04-02 04:42:09,984 attempt 1/10 2017-04-02 04:42:09,984 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7a3f514cf849?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-02 04:42:11,805 unpacking tar archive at: mozilla-central-7a3f514cf849/testing/mozharness/ program finished with exit code 0 elapsedTime=2.101292 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-02 04:42:12.092329) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-02 04:42:12.092673) ========= script_repo_revision: 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-02 04:42:12.093187) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-02 04:42:12.093490) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-02 04:42:12.113792) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 40 secs) (at 2017-04-02 04:42:12.114291) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.kRBiHTOvmh/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.tmTBlZQNIe/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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:42:12 INFO - MultiFileLogger online at 20170402 04:42:12 in /builds/slave/test 04:42:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:42:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:42:12 INFO - {'append_to_log': False, 04:42:12 INFO - 'base_work_dir': '/builds/slave/test', 04:42:12 INFO - 'blob_upload_branch': 'Firefox', 04:42:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:42:12 INFO - 'branch': 'Firefox', 04:42:12 INFO - 'buildbot_json_path': 'buildprops.json', 04:42:12 INFO - 'config_files': ('talos/mac_config.py',), 04:42:12 INFO - 'default_actions': ('clobber', 04:42:12 INFO - 'read-buildbot-config', 04:42:12 INFO - 'download-and-extract', 04:42:12 INFO - 'populate-webroot', 04:42:12 INFO - 'create-virtualenv', 04:42:12 INFO - 'install', 04:42:12 INFO - 'run-tests'), 04:42:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:42:12 INFO - 'download_minidump_stackwalk': True, 04:42:12 INFO - 'download_symbols': 'ondemand', 04:42:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:42:12 INFO - 'tooltool.py': '/tools/tooltool.py', 04:42:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:42:12 INFO - '/tools/misc-python/virtualenv.py')}, 04:42:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:42:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:42:12 INFO - 'gecko_profile': False, 04:42:12 INFO - 'gecko_profile_interval': 0, 04:42:12 INFO - 'installer_path': 'installer.exe', 04:42:12 INFO - 'log_level': 'info', 04:42:12 INFO - 'log_name': 'talos', 04:42:12 INFO - 'log_to_console': True, 04:42:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:42:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:42:12 INFO - 'opt_config_files': (), 04:42:12 INFO - 'pip_index': False, 04:42:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:42:12 INFO - 'cmd': ('bash', 04:42:12 INFO - '-c', 04:42:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:42:12 INFO - 'enabled': True, 04:42:12 INFO - 'halt_on_failure': False, 04:42:12 INFO - 'name': 'check_screen_resolution'},), 04:42:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:42:12 INFO - 'cmd': ('bash', 04:42:12 INFO - '-c', 04:42:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:42:12 INFO - 'enabled': True, 04:42:12 INFO - 'halt_on_failure': False, 04:42:12 INFO - 'name': 'check_screen_resolution'},), 04:42:12 INFO - 'run_cmd_checks_enabled': True, 04:42:12 INFO - 'suite': 'dromaeojs', 04:42:12 INFO - 'system_bits': '32', 04:42:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:42:12 INFO - 'title': 't-yosemite-r7-0201', 04:42:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:42:12 INFO - 'use_talos_json': True, 04:42:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:42:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:42:12 INFO - 'work_dir': 'build'} 04:42:12 INFO - [mozharness: 2017-04-02 11:42:12.245742Z] Running clobber step. 04:42:12 INFO - Running pre-action listener: _resource_record_pre_action 04:42:12 INFO - Running main action method: clobber 04:42:12 INFO - rmtree: /builds/slave/test/build 04:42:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:42:14 INFO - Running post-action listener: _resource_record_post_action 04:42:14 INFO - [mozharness: 2017-04-02 11:42:14.786753Z] Finished clobber step (success) 04:42:14 INFO - [mozharness: 2017-04-02 11:42:14.786918Z] Running read-buildbot-config step. 04:42:14 INFO - Running pre-action listener: _resource_record_pre_action 04:42:14 INFO - Running main action method: read_buildbot_config 04:42:14 INFO - Using buildbot properties: 04:42:14 INFO - { 04:42:14 INFO - "project": "", 04:42:14 INFO - "product": "firefox", 04:42:14 INFO - "script_repo_revision": "production", 04:42:14 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:42:14 INFO - "repository": "", 04:42:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:42:14 INFO - "buildid": "20170402030202", 04:42:14 INFO - "stage_platform": "macosx64", 04:42:14 INFO - "basedir": "/builds/slave/test", 04:42:14 INFO - "nightly_build": "True", 04:42:14 INFO - "buildnumber": 18, 04:42:14 INFO - "slavename": "t-yosemite-r7-0201", 04:42:14 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 04:42:14 INFO - "platform": "yosemite_r7", 04:42:14 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:42:14 INFO - "branch": "mozilla-central", 04:42:14 INFO - "repo_path": "mozilla-central", 04:42:14 INFO - "revision": "7a3f514cf8490d271ee373a1d2999e4ea4dee2d7", 04:42:14 INFO - "pgo_build": "False", 04:42:14 INFO - "builduid": "9f9704ef7d9d48469f84a8647184be40", 04:42:14 INFO - "slavebuilddir": "test" 04:42:14 INFO - } 04:42:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:42:14 INFO - Running post-action listener: _resource_record_post_action 04:42:14 INFO - [mozharness: 2017-04-02 11:42:14.790264Z] Finished read-buildbot-config step (success) 04:42:14 INFO - [mozharness: 2017-04-02 11:42:14.790371Z] Running download-and-extract step. 04:42:14 INFO - Running pre-action listener: _resource_record_pre_action 04:42:14 INFO - Running main action method: download_and_extract 04:42:14 INFO - mkdir: /builds/slave/test/build/tests 04:42: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:42:14 INFO - trying https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:42:14 INFO - Downloading https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:42:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:42:16 INFO - Downloaded 1325 bytes. 04:42:16 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:42:16 INFO - Using the following test package requirements: 04:42:16 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:42:16 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:42:16 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:42:16 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:42:16 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:42:16 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:42:16 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:42:16 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:42:16 INFO - u'jsshell-mac.zip'], 04:42:16 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:42:16 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:42:16 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:42:16 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:42:16 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:42:16 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:42:16 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:42:16 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:42:16 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:42:16 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:42:16 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:42:16 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:42:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:42:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:42:16 INFO - Fetch https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:42:19 INFO - Expected file size: 52518396 04:42:19 INFO - Obtained file size: 52518396 04:42:35 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:42:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:42:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:42:35 INFO - Fetch https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:42:38 INFO - Expected file size: 52518396 04:42:38 INFO - Obtained file size: 52518396 04:42:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:42:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:42:53 INFO - Fetch https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:42:54 INFO - Expected file size: 14404152 04:42:54 INFO - Obtained file size: 14404152 04:42:54 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:42:54 INFO - trying https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:42:54 INFO - Downloading https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:42:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:42:57 INFO - Downloaded 75666717 bytes. 04:42:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:42:57 INFO - mkdir: /builds/slave/test/properties 04:42:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:42:57 INFO - Writing to file /builds/slave/test/properties/build_url 04:42:57 INFO - Contents: 04:42:57 INFO - build_url:https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:43:00 INFO - Running post-action listener: _resource_record_post_action 04:43:00 INFO - Running post-action listener: set_extra_try_arguments 04:43:00 INFO - [mozharness: 2017-04-02 11:43:00.199472Z] Finished download-and-extract step (success) 04:43:00 INFO - [mozharness: 2017-04-02 11:43:00.199614Z] Running populate-webroot step. 04:43:00 INFO - Running pre-action listener: _resource_record_pre_action 04:43:00 INFO - Running main action method: populate_webroot 04:43:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:43:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:43:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:43:00 INFO - '--tppagecycles', 04:43:00 INFO - '7'], 04:43:00 INFO - 'tests': ['tsvgm']}}, 04:43:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:43:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:43:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:43:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:43:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:43:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:43:00 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:43:00 INFO - 'talos_options': ['--disable-e10s'], 04:43:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:43:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:43:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:43:00 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:43:00 INFO - 'talos_options': ['--disable-e10s'], 04:43:00 INFO - 'tests': ['damp', 'tps']}, 04:43:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:43:00 INFO - 'tests': ['damp', 'tps']}, 04:43:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:43:00 INFO - 'tests': ['dromaeo_dom']}, 04:43:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:43:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:43:00 INFO - 'tests': ['basic_compositor_video']}, 04:43:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:43:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:43:00 INFO - 'tests': ['a11yr', 04:43:00 INFO - 'ts_paint', 04:43:00 INFO - 'tpaint', 04:43:00 INFO - 'sessionrestore', 04:43:00 INFO - 'sessionrestore_no_auto_restore', 04:43:00 INFO - 'tabpaint']}, 04:43:00 INFO - 'other-e10s': {'tests': ['a11yr', 04:43:00 INFO - 'ts_paint', 04:43:00 INFO - 'tpaint', 04:43:00 INFO - 'sessionrestore', 04:43:00 INFO - 'sessionrestore_no_auto_restore', 04:43:00 INFO - 'tabpaint']}, 04:43:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:43:00 INFO - 'ts_paint', 04:43:00 INFO - 'tpaint', 04:43:00 INFO - 'sessionrestore', 04:43:00 INFO - 'sessionrestore_no_auto_restore', 04:43:00 INFO - 'tabpaint']}, 04:43:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:43:00 INFO - 'ts_paint', 04:43:00 INFO - 'tpaint', 04:43:00 INFO - 'sessionrestore', 04:43:00 INFO - 'sessionrestore_no_auto_restore', 04:43:00 INFO - 'tabpaint']}, 04:43:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:43:00 INFO - 'tests': ['a11yr', 04:43:00 INFO - 'ts_paint', 04:43:00 INFO - 'tpaint', 04:43:00 INFO - 'sessionrestore', 04:43:00 INFO - 'sessionrestore_no_auto_restore', 04:43:00 INFO - 'tabpaint']}, 04:43:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:43:00 INFO - 'tests': ['a11yr', 04:43:00 INFO - 'ts_paint', 04:43:00 INFO - 'tpaint', 04:43:00 INFO - 'sessionrestore', 04:43:00 INFO - 'sessionrestore_no_auto_restore', 04:43:00 INFO - 'tabpaint']}, 04:43:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:43:00 INFO - 'tests': ['tsvgx', 04:43:00 INFO - 'tsvgr_opacity', 04:43:00 INFO - 'tart', 04:43:00 INFO - 'tscrollx', 04:43:00 INFO - 'cart', 04:43:00 INFO - 'tsvg_static']}, 04:43:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:43:00 INFO - 'tsvgr_opacity', 04:43:00 INFO - 'tart', 04:43:00 INFO - 'tscrollx', 04:43:00 INFO - 'cart', 04:43:00 INFO - 'tsvg_static']}, 04:43:00 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:43:00 INFO - 'talos_options': ['--disable-e10s'], 04:43:00 INFO - 'tests': ['tp5o']}, 04:43:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:43:00 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:43:00 INFO - 'talos_options': ['--disable-e10s', 04:43:00 INFO - '--xperf_path', 04:43:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:43:00 INFO - 'tests': ['tp5n']}, 04:43:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:43:00 INFO - 'talos_options': ['--xperf_path', 04:43:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:43:00 INFO - 'tests': ['tp5n']}}, 04:43:00 INFO - 'talos.zip': {'path': '', 04:43:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:43:00 INFO - Running post-action listener: _resource_record_post_action 04:43:00 INFO - [mozharness: 2017-04-02 11:43:00.217667Z] Finished populate-webroot step (success) 04:43:00 INFO - [mozharness: 2017-04-02 11:43:00.217800Z] Running create-virtualenv step. 04:43:00 INFO - Running pre-action listener: _resource_record_pre_action 04:43:00 INFO - Running main action method: create_virtualenv 04:43:00 INFO - Creating virtualenv /builds/slave/test/build/venv 04:43:00 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:43:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:43:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:43:00 INFO - Using real prefix '/tools/python27' 04:43:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:43:01 INFO - Installing distribute.............................................................................................................................................................................................done. 04:43:03 INFO - Installing pip.................done. 04:43:03 INFO - Return code: 0 04:43:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:43:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:43:04 INFO - Reading from file tmpfile_stdout 04:43:04 INFO - Output received: 04:43:04 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:43:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:05 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 0x10ec59b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec5c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8c9cdcab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea37d30>, '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 0x10e95edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea2cbe8>, '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.kRBiHTOvmh/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.tmTBlZQNIe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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:43:05 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:43:05 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:43:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kRBiHTOvmh/Render', 04:43:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:05 INFO - 'HOME': '/Users/cltbld', 04:43:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:05 INFO - 'LOGNAME': 'cltbld', 04:43:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:05 INFO - 'MOZ_NO_REMOTE': '1', 04:43:05 INFO - 'NO_EM_RESTART': '1', 04:43:05 INFO - 'PAGER': '/bin/cat', 04:43:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:05 INFO - 'PWD': '/builds/slave/test', 04:43:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:05 INFO - 'SHELL': '/bin/bash', 04:43:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tmTBlZQNIe/Listeners', 04:43:05 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 04:43:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:05 INFO - 'USER': 'cltbld', 04:43:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:05 INFO - 'XPC_FLAGS': '0x0', 04:43:05 INFO - 'XPC_SERVICE_NAME': '0', 04:43:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:05 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:43:05 INFO - Cleaning up... 04:43:05 INFO - Return code: 0 04:43:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:43: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:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43: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:43:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:05 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 0x10ec59b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec5c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8c9cdcab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea37d30>, '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 0x10e95edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea2cbe8>, '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.kRBiHTOvmh/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.tmTBlZQNIe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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:43:05 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:43:05 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:43:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kRBiHTOvmh/Render', 04:43:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:05 INFO - 'HOME': '/Users/cltbld', 04:43:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:05 INFO - 'LOGNAME': 'cltbld', 04:43:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:05 INFO - 'MOZ_NO_REMOTE': '1', 04:43:05 INFO - 'NO_EM_RESTART': '1', 04:43:05 INFO - 'PAGER': '/bin/cat', 04:43:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:05 INFO - 'PWD': '/builds/slave/test', 04:43:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:05 INFO - 'SHELL': '/bin/bash', 04:43:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tmTBlZQNIe/Listeners', 04:43:05 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 04:43:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:05 INFO - 'USER': 'cltbld', 04:43:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:05 INFO - 'XPC_FLAGS': '0x0', 04:43:05 INFO - 'XPC_SERVICE_NAME': '0', 04:43:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:06 INFO - Downloading/unpacking psutil>=3.1.1 04:43:06 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:43:06 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:43:06 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:43:06 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:43:06 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:43:06 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:43:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:43:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:43:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:43:12 INFO - Installing collected packages: psutil 04:43:12 INFO - Running setup.py install for psutil 04:43:12 INFO - building 'psutil._psutil_osx' extension 04:43:12 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:43:12 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:43:12 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:43:12 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:43:13 INFO - building 'psutil._psutil_posix' extension 04:43:13 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:43:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:43:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:43:13 INFO - ^ 04:43:13 INFO - 1 warning generated. 04:43:13 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:43:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:43:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:43:13 INFO - Successfully installed psutil 04:43:13 INFO - Cleaning up... 04:43:13 INFO - Return code: 0 04:43:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:43:13 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:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:13 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:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:13 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 0x10ec59b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec5c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8c9cdcab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea37d30>, '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 0x10e95edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea2cbe8>, '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.kRBiHTOvmh/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.tmTBlZQNIe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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:43:13 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:43:13 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:43:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kRBiHTOvmh/Render', 04:43:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:13 INFO - 'HOME': '/Users/cltbld', 04:43:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:13 INFO - 'LOGNAME': 'cltbld', 04:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:13 INFO - 'MOZ_NO_REMOTE': '1', 04:43:13 INFO - 'NO_EM_RESTART': '1', 04:43:13 INFO - 'PAGER': '/bin/cat', 04:43:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:13 INFO - 'PWD': '/builds/slave/test', 04:43:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:13 INFO - 'SHELL': '/bin/bash', 04:43:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tmTBlZQNIe/Listeners', 04:43:13 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 04:43:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:13 INFO - 'USER': 'cltbld', 04:43:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:13 INFO - 'XPC_FLAGS': '0x0', 04:43:13 INFO - 'XPC_SERVICE_NAME': '0', 04:43:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:43:13 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:43:13 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:43:13 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:43:13 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:43:13 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:43:13 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:43:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:43:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:43:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:43:17 INFO - Installing collected packages: mozsystemmonitor 04:43:17 INFO - Running setup.py install for mozsystemmonitor 04:43:17 INFO - Successfully installed mozsystemmonitor 04:43:17 INFO - Cleaning up... 04:43:17 INFO - Return code: 0 04:43:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ec59b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec5c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8c9cdcab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea37d30>, '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 0x10e95edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea2cbe8>, '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.kRBiHTOvmh/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.tmTBlZQNIe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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:43:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:43:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:43:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kRBiHTOvmh/Render', 04:43:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:17 INFO - 'HOME': '/Users/cltbld', 04:43:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:17 INFO - 'LOGNAME': 'cltbld', 04:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:17 INFO - 'MOZ_NO_REMOTE': '1', 04:43:17 INFO - 'NO_EM_RESTART': '1', 04:43:17 INFO - 'PAGER': '/bin/cat', 04:43:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:17 INFO - 'PWD': '/builds/slave/test', 04:43:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:17 INFO - 'SHELL': '/bin/bash', 04:43:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tmTBlZQNIe/Listeners', 04:43:17 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 04:43:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:17 INFO - 'USER': 'cltbld', 04:43:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:17 INFO - 'XPC_FLAGS': '0x0', 04:43:17 INFO - 'XPC_SERVICE_NAME': '0', 04:43:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:17 INFO - Downloading/unpacking jsonschema==2.5.1 04:43:17 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:43:17 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:43:17 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:43:17 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:43:17 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:43:17 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:43:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:43:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:21 INFO - Downloading functools32-3.2.3-2.tar.gz 04:43:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:43:21 INFO - warning: no files found matching '*.txt' 04:43:21 INFO - no previously-included directories found matching 'build' 04:43:21 INFO - no previously-included directories found matching 'dist' 04:43:21 INFO - no previously-included directories found matching '.git*' 04:43:21 INFO - Installing collected packages: jsonschema, functools32 04:43:21 INFO - Running setup.py install for functools32 04:43:21 INFO - warning: no files found matching '*.txt' 04:43:21 INFO - no previously-included directories found matching 'build' 04:43:21 INFO - no previously-included directories found matching 'dist' 04:43:21 INFO - no previously-included directories found matching '.git*' 04:43:21 INFO - Successfully installed jsonschema functools32 04:43:21 INFO - Cleaning up... 04:43:22 INFO - Return code: 0 04:43:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ec59b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec5c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8c9cdcab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea37d30>, '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 0x10e95edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea2cbe8>, '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.kRBiHTOvmh/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.tmTBlZQNIe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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:43:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:43:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:43:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kRBiHTOvmh/Render', 04:43:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:22 INFO - 'HOME': '/Users/cltbld', 04:43:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:22 INFO - 'LOGNAME': 'cltbld', 04:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:22 INFO - 'MOZ_NO_REMOTE': '1', 04:43:22 INFO - 'NO_EM_RESTART': '1', 04:43:22 INFO - 'PAGER': '/bin/cat', 04:43:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:22 INFO - 'PWD': '/builds/slave/test', 04:43:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:22 INFO - 'SHELL': '/bin/bash', 04:43:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tmTBlZQNIe/Listeners', 04:43:22 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 04:43:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:22 INFO - 'USER': 'cltbld', 04:43:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:22 INFO - 'XPC_FLAGS': '0x0', 04:43:22 INFO - 'XPC_SERVICE_NAME': '0', 04:43:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:43:22 INFO - Cleaning up... 04:43:22 INFO - Return code: 0 04:43:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ec59b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec5c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8c9cdcab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea37d30>, '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 0x10e95edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea2cbe8>, '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.kRBiHTOvmh/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.tmTBlZQNIe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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:43:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:43:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:43:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kRBiHTOvmh/Render', 04:43:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:22 INFO - 'HOME': '/Users/cltbld', 04:43:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:22 INFO - 'LOGNAME': 'cltbld', 04:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:22 INFO - 'MOZ_NO_REMOTE': '1', 04:43:22 INFO - 'NO_EM_RESTART': '1', 04:43:22 INFO - 'PAGER': '/bin/cat', 04:43:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:22 INFO - 'PWD': '/builds/slave/test', 04:43:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:22 INFO - 'SHELL': '/bin/bash', 04:43:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tmTBlZQNIe/Listeners', 04:43:22 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 04:43:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:22 INFO - 'USER': 'cltbld', 04:43:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:22 INFO - 'XPC_FLAGS': '0x0', 04:43:22 INFO - 'XPC_SERVICE_NAME': '0', 04:43:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:22 INFO - Downloading/unpacking blobuploader==1.2.4 04:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:22 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:43:22 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:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:26 INFO - Downloading blobuploader-1.2.4.tar.gz 04:43:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:43:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:43:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:27 INFO - Downloading docopt-0.6.1.tar.gz 04:43:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:43:27 INFO - Installing collected packages: blobuploader, requests, docopt 04:43:27 INFO - Running setup.py install for blobuploader 04:43:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:43:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:43:27 INFO - Running setup.py install for requests 04:43:28 INFO - Running setup.py install for docopt 04:43:28 INFO - Successfully installed blobuploader requests docopt 04:43:28 INFO - Cleaning up... 04:43:28 INFO - Return code: 0 04:43:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:43:28 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:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:28 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:43:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:28 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 0x10ec59b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec5c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8c9cdcab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea37d30>, '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 0x10e95edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea2cbe8>, '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.kRBiHTOvmh/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.tmTBlZQNIe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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:43:28 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:43:28 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:43:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kRBiHTOvmh/Render', 04:43:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:28 INFO - 'HOME': '/Users/cltbld', 04:43:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:28 INFO - 'LOGNAME': 'cltbld', 04:43:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:28 INFO - 'MOZ_NO_REMOTE': '1', 04:43:28 INFO - 'NO_EM_RESTART': '1', 04:43:28 INFO - 'PAGER': '/bin/cat', 04:43:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:28 INFO - 'PWD': '/builds/slave/test', 04:43:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:28 INFO - 'SHELL': '/bin/bash', 04:43:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tmTBlZQNIe/Listeners', 04:43:28 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 04:43:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:28 INFO - 'USER': 'cltbld', 04:43:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:28 INFO - 'XPC_FLAGS': '0x0', 04:43:28 INFO - 'XPC_SERVICE_NAME': '0', 04:43:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:43:28 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-Pa8cbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:43:28 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-m4VyyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:43:28 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-VuJBTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:43:28 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-vjBZP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:43:29 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-TVU36S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:43:29 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-394pII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:43:29 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-NwWFB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:43:29 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-K2EOAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:43:29 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-B7UJXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:43:29 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-nmk9uY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:43:29 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-KLTAt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:43:29 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-GgTUqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:43:29 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-t5w6eZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:43:29 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-BEhOB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:30 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-5EyiTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:43:30 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-djZgiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:43:30 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-v7UvMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:43:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:43:30 INFO - Running setup.py install for manifestparser 04:43:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:43:30 INFO - Running setup.py install for mozcrash 04:43:30 INFO - Running setup.py install for mozdebug 04:43:30 INFO - Running setup.py install for mozdevice 04:43:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:43:30 INFO - Running setup.py install for mozfile 04:43:31 INFO - Running setup.py install for mozhttpd 04:43:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:43:31 INFO - Running setup.py install for mozinfo 04:43:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:43:31 INFO - Running setup.py install for mozInstall 04:43:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:43:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:43:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:43:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:43:31 INFO - Running setup.py install for mozleak 04:43:31 INFO - Running setup.py install for mozlog 04:43:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:43:31 INFO - Running setup.py install for moznetwork 04:43:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:43:31 INFO - Running setup.py install for mozprocess 04:43:32 INFO - Running setup.py install for mozprofile 04:43:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:43:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:43:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:43:32 INFO - Running setup.py install for mozrunner 04:43:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:43:32 INFO - Running setup.py install for mozscreenshot 04:43:32 INFO - Running setup.py install for moztest 04:43:32 INFO - Running setup.py install for mozversion 04:43:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:43:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:43:32 INFO - Cleaning up... 04:43:32 INFO - Return code: 0 04:43:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:43: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:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43: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:43:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x10ec59b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec5c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8c9cdcab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea37d30>, '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 0x10e95edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea2cbe8>, '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.kRBiHTOvmh/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.tmTBlZQNIe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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:43:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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:43:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.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:43:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kRBiHTOvmh/Render', 04:43:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:32 INFO - 'HOME': '/Users/cltbld', 04:43:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:32 INFO - 'LOGNAME': 'cltbld', 04:43:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:32 INFO - 'MOZ_NO_REMOTE': '1', 04:43:32 INFO - 'NO_EM_RESTART': '1', 04:43:32 INFO - 'PAGER': '/bin/cat', 04:43:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:32 INFO - 'PWD': '/builds/slave/test', 04:43:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:32 INFO - 'SHELL': '/bin/bash', 04:43:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tmTBlZQNIe/Listeners', 04:43:32 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 04:43:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:32 INFO - 'USER': 'cltbld', 04:43:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:32 INFO - 'XPC_FLAGS': '0x0', 04:43:32 INFO - 'XPC_SERVICE_NAME': '0', 04:43:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:43:33 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-ZbVl7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:43:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:43:33 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-URzYze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:43:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:43:33 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-_Ze8P2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:43:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:43:33 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-L15wQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:43:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:43:33 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-Rb9g32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:43:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:43:33 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-39nal3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:43:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:43:33 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-HVxXGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:43:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:43:33 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-YyNrqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:43:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:43:34 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-cLj2oV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:43:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:43:34 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-CmlL4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:43:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:43:34 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-ULs_ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:43:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:43:34 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-OywBtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:43:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:43:34 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-CD1ZZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:43:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:43:34 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-edRxCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:43:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:34 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-bfCyaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:43:34 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-i5DieO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:43:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:43:34 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-vmWLkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:43:34 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:43:34 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:43:34 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:43:34 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:43:34 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:43:34 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:43:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:43:34 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:43:34 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:43:34 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:43:34 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:43:34 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:43:34 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:43:38 INFO - Downloading blessings-1.6.tar.gz 04:43:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:43:38 INFO - Installing collected packages: blessings 04:43:38 INFO - Running setup.py install for blessings 04:43:38 INFO - Successfully installed blessings 04:43:38 INFO - Cleaning up... 04:43:38 INFO - Return code: 0 04:43:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:43:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:43:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:43:39 INFO - Reading from file tmpfile_stdout 04:43:39 INFO - Current package versions: 04:43:39 INFO - blessings == 1.6 04:43:39 INFO - blobuploader == 1.2.4 04:43:39 INFO - docopt == 0.6.1 04:43:39 INFO - functools32 == 3.2.3-2 04:43:39 INFO - jsonschema == 2.5.1 04:43:39 INFO - manifestparser == 1.1 04:43:39 INFO - mozInstall == 1.12 04:43:39 INFO - mozcrash == 1.0 04:43:39 INFO - mozdebug == 0.1 04:43:39 INFO - mozdevice == 0.49 04:43:39 INFO - mozfile == 1.2 04:43:39 INFO - mozhttpd == 0.7 04:43:39 INFO - mozinfo == 0.9 04:43:39 INFO - mozleak == 0.1 04:43:39 INFO - mozlog == 3.4 04:43:39 INFO - moznetwork == 0.27 04:43:39 INFO - mozprocess == 0.25 04:43:39 INFO - mozprofile == 0.28 04:43:39 INFO - mozrunner == 6.13 04:43:39 INFO - mozscreenshot == 0.1 04:43:39 INFO - mozsystemmonitor == 0.3 04:43:39 INFO - moztest == 0.8 04:43:39 INFO - mozversion == 1.4 04:43:39 INFO - psutil == 3.1.1 04:43:39 INFO - requests == 1.2.3 04:43:39 INFO - wsgiref == 0.1.2 04:43:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:39 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 0x10ec59b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec5c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8c9cdcab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea37d30>, '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 0x10e95edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea2cbe8>, '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.kRBiHTOvmh/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.tmTBlZQNIe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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:43:39 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:43:39 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:43:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kRBiHTOvmh/Render', 04:43:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:39 INFO - 'HOME': '/Users/cltbld', 04:43:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:39 INFO - 'LOGNAME': 'cltbld', 04:43:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:39 INFO - 'MOZ_NO_REMOTE': '1', 04:43:39 INFO - 'NO_EM_RESTART': '1', 04:43:39 INFO - 'PAGER': '/bin/cat', 04:43:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:39 INFO - 'PWD': '/builds/slave/test', 04:43:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:39 INFO - 'SHELL': '/bin/bash', 04:43:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tmTBlZQNIe/Listeners', 04:43:39 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 04:43:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:39 INFO - 'USER': 'cltbld', 04:43:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:39 INFO - 'XPC_FLAGS': '0x0', 04:43:39 INFO - 'XPC_SERVICE_NAME': '0', 04:43:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:39 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:43:39 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:43:39 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:43:39 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:43:39 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:43:39 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:43:39 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:43:39 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:43:39 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:43:39 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:43:39 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:43:39 INFO - Cleaning up... 04:43:39 INFO - Return code: 0 04:43:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:39 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 0x10ec59b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec5c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8c9cdcab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea37d30>, '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 0x10e95edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea2cbe8>, '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.kRBiHTOvmh/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.tmTBlZQNIe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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:43:39 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:43:39 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:43:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kRBiHTOvmh/Render', 04:43:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:39 INFO - 'HOME': '/Users/cltbld', 04:43:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:39 INFO - 'LOGNAME': 'cltbld', 04:43:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:39 INFO - 'MOZ_NO_REMOTE': '1', 04:43:39 INFO - 'NO_EM_RESTART': '1', 04:43:39 INFO - 'PAGER': '/bin/cat', 04:43:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:39 INFO - 'PWD': '/builds/slave/test', 04:43:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:39 INFO - 'SHELL': '/bin/bash', 04:43:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tmTBlZQNIe/Listeners', 04:43:39 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 04:43:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:39 INFO - 'USER': 'cltbld', 04:43:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:39 INFO - 'XPC_FLAGS': '0x0', 04:43:39 INFO - 'XPC_SERVICE_NAME': '0', 04:43:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:43:39 INFO - Cleaning up... 04:43:39 INFO - Return code: 0 04:43:39 INFO - Running post-action listener: _resource_record_post_action 04:43:39 INFO - Running post-action listener: _start_resource_monitoring 04:43:39 INFO - Starting resource monitoring. 04:43:39 INFO - [mozharness: 2017-04-02 11:43:39.681705Z] Finished create-virtualenv step (success) 04:43:39 INFO - [mozharness: 2017-04-02 11:43:39.682634Z] Running install step. 04:43:39 INFO - Running pre-action listener: _resource_record_pre_action 04:43:39 INFO - Running main action method: install 04:43:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:43:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:43:39 INFO - Reading from file tmpfile_stdout 04:43:39 INFO - Detecting whether we're running mozinstall >=1.0... 04:43:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:43:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:43:40 INFO - Reading from file tmpfile_stdout 04:43:40 INFO - Output received: 04:43:40 INFO - Usage: mozinstall [options] installer 04:43:40 INFO - Options: 04:43:40 INFO - -h, --help show this help message and exit 04:43:40 INFO - -d DEST, --destination=DEST 04:43:40 INFO - Directory to install application into. [default: 04:43:40 INFO - "/builds/slave/test"] 04:43:40 INFO - --app=APP Application being installed. [default: firefox] 04:43:40 INFO - mkdir: /builds/slave/test/build/application 04:43:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:43:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:44:00 INFO - Reading from file tmpfile_stdout 04:44:00 INFO - Output received: 04:44:00 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:44:00 INFO - Running post-action listener: _resource_record_post_action 04:44:00 INFO - [mozharness: 2017-04-02 11:44:00.152733Z] Finished install step (success) 04:44:00 INFO - [mozharness: 2017-04-02 11:44:00.152874Z] Running run-tests step. 04:44:00 INFO - Running pre-action listener: _resource_record_pre_action 04:44:00 INFO - Running main action method: run_tests 04:44:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:44:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:44:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:44:00 INFO - 2017-04-02 04:44:00.167 screenresolution[1674:15069] starting screenresolution argv=screenresolution get 04:44:00 INFO - 2017-04-02 04:44:00.169 screenresolution[1674:15069] Display 0: 1600x1200x32@60 04:44:00 INFO - 2017-04-02 04:44:00.175 screenresolution[1675:15071] starting screenresolution argv=screenresolution list 04:44:00 INFO - Available Modes on Display 0 04:44:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:44:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:44:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:44:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:44:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:44:00 INFO - Intel Iris: 04:44:00 INFO - Chipset Model: Intel Iris 04:44:00 INFO - Type: GPU 04:44:00 INFO - Bus: Built-In 04:44:00 INFO - VRAM (Dynamic, Max): 1536 MB 04:44:00 INFO - Vendor: Intel (0x8086) 04:44:00 INFO - Device ID: 0x0a2e 04:44:00 INFO - Revision ID: 0x0009 04:44:00 INFO - Displays: 04:44:00 INFO - Display: 04:44:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:44:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:44:00 INFO - Display Serial Number: 1600x1200 60 04:44:00 INFO - Main Display: Yes 04:44:00 INFO - Mirror: Off 04:44:00 INFO - Online: Yes 04:44:00 INFO - Rotation: Supported 04:44:00 INFO - Return code: 0 04:44:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:44:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:44:00 INFO - Python 2.7.3 04:44:00 INFO - Return code: 0 04:44:00 INFO - grabbing minidump binary from tooltool 04:44:00 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:44:00 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 0x10ea37d30>, '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 0x10e95edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea2cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:44:00 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:44:00 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:44:00 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:44:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:44:00 INFO - Return code: 0 04:44:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:44:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:44:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:44:00 INFO - ENV: RUST_BACKTRACE is now 1 04:44:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:44:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:44:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0201', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:44:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0201 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:44:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kRBiHTOvmh/Render', 04:44:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:00 INFO - 'HOME': '/Users/cltbld', 04:44:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:00 INFO - 'LOGNAME': 'cltbld', 04:44:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:44:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:00 INFO - 'MOZ_NO_REMOTE': '1', 04:44:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:44:00 INFO - 'NO_EM_RESTART': '1', 04:44:00 INFO - 'PAGER': '/bin/cat', 04:44:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:00 INFO - 'PWD': '/builds/slave/test', 04:44:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:44:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:00 INFO - 'RUST_BACKTRACE': '1', 04:44:00 INFO - 'SHELL': '/bin/bash', 04:44:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tmTBlZQNIe/Listeners', 04:44:00 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 04:44:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:00 INFO - 'USER': 'cltbld', 04:44:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:00 INFO - 'XPC_FLAGS': '0x0', 04:44:00 INFO - 'XPC_SERVICE_NAME': '0', 04:44:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0201', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:44:00 INFO - mozversion application_buildid: 20170402030202 04:44:00 INFO - mozversion application_changeset: 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 04:44:00 INFO - mozversion application_display_name: Nightly 04:44:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:44:00 INFO - mozversion application_name: Firefox 04:44:00 INFO - mozversion application_remotingname: firefox 04:44:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:44:00 INFO - mozversion application_vendor: Mozilla 04:44:00 INFO - mozversion application_version: 55.0a1 04:44:00 INFO - mozversion platform_buildid: 20170402030202 04:44:00 INFO - mozversion platform_changeset: 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 04:44:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:44:00 INFO - mozversion platform_version: 55.0a1 04:44:00 INFO - using testdate: 1491133440 04:44:00 INFO - actual date: 1491133440 04:44:00 INFO - starting webserver on 'localhost:49252' 04:44:00 INFO - SUITE-START | Running 2 tests 04:44:00 INFO - TEST-START | dromaeo_css 04:44:00 INFO - operating with platform_type : mac_ 04:44:00 INFO - Initialising browser for dromaeo_css test... 04:44:01 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/tmp3wrTx7/profile http://localhost:49252/getInfo.html) 04:44:04 INFO - PID 1685 | __metrics Screen width/height:1600/1200 04:44:04 INFO - PID 1685 | colorDepth:24 04:44:04 INFO - PID 1685 | Browser inner width/height: 1024/689 04:44:04 INFO - PID 1685 | __metrics 04:44:04 INFO - PID 1685 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:44:04 INFO - PID 1685 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:44:05 INFO - TEST-INFO | 1685: exit 0 04:44:05 INFO - Browser initialized. 04:44:05 INFO - Running cycle 1/1 for dromaeo_css test... 04:44:05 INFO - TEST-INFO | started process 1689 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/tmp3wrTx7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:44:17 INFO - PID 1689 | RSS: Main: 232595456 04:44:17 INFO - PID 1689 | 04:47:23 INFO - PID 1689 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49252/tests/dromaeo/cssquery-ext.html) 04:47:25 INFO - PID 1689 | RSS: Main: 353599488 04:47:25 INFO - PID 1689 | 04:49:07 INFO - PID 1689 | ************************* 04:49:07 INFO - PID 1689 | A coding exception was thrown and uncaught in a Task. 04:49:07 INFO - PID 1689 | 04:49:07 ERROR - PID 1689 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:49:07 INFO - PID 1689 | Full stack: 04:49:07 INFO - PID 1689 | ************************* 04:49:07 INFO - PID 1689 | ************************* 04:49:07 INFO - PID 1689 | A coding exception was thrown and uncaught in a Task. 04:49:07 INFO - PID 1689 | 04:49:07 ERROR - PID 1689 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:49:07 INFO - PID 1689 | Full stack: 04:49:07 INFO - PID 1689 | ************************* 04:49:07 INFO - PID 1689 | ************************* 04:49:07 INFO - PID 1689 | A coding exception was thrown and uncaught in a Task. 04:49:07 INFO - PID 1689 | 04:49:07 ERROR - PID 1689 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:49:07 INFO - PID 1689 | Full stack: 04:49:07 INFO - PID 1689 | ************************* 04:49:07 INFO - PID 1689 | ************************* 04:49:07 INFO - PID 1689 | A coding exception was thrown and uncaught in a Task. 04:49:07 INFO - PID 1689 | 04:49:07 ERROR - PID 1689 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:49:07 INFO - PID 1689 | Full stack: 04:49:07 INFO - PID 1689 | ************************* 04:50:28 INFO - PID 1689 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-ext.html (next: http://localhost:49252/tests/dromaeo/cssquery-jquery.html) 04:50:28 INFO - PID 1689 | RSS: Main: 370065408 04:50:28 INFO - PID 1689 | 04:53:31 INFO - PID 1689 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49252/tests/dromaeo/cssquery-mootools.html) 04:53:31 INFO - PID 1689 | RSS: Main: 337600512 04:53:31 INFO - PID 1689 | 04:56:34 INFO - PID 1689 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49252/tests/dromaeo/cssquery-prototype.html) 04:56:34 INFO - PID 1689 | RSS: Main: 330207232 04:56:34 INFO - PID 1689 | 04:59:38 INFO - PID 1689 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49252/tests/dromaeo/cssquery-yui.html) 04:59:39 INFO - PID 1689 | RSS: Main: 332455936 04:59:39 INFO - PID 1689 | 05:02:42 INFO - PID 1689 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-yui.html (next: http://localhost:49252/tests/dromaeo/cssquery-dojo.html) 05:02:42 INFO - PID 1689 | RSS: Main: 591519744 05:02:42 INFO - PID 1689 | 05:02:42 INFO - PID 1689 | __start_tp_report 05:02:42 INFO - PID 1689 | _x_x_mozilla_page_load 05:02:42 INFO - PID 1689 | _x_x_mozilla_page_load_details 05:02:42 INFO - PID 1689 | |i|pagename|runs| 05:02:42 INFO - PID 1689 | |0;dojo.html;3520.049586611615;3526.418141006734;3539.4867744177077;3565.589957154926;3604.1890574620716;6093.756249750005;6159.445649891509;6198.876022479553;6200.945839207334;6202.658853763047;5114.232865070241;6130.386961303868;6136.856084434195;6141.915626108644;6237.157983672203;5341.759620817073;5343.65266257692;5388.4611538846;5423.132298832187;5494.230807686927;4683.250679891218;5335.439778823206;5394.433584473613;5400.432954539776;5475.5072043516075;5267.078261304295;5433.1035379162395;5438.972805135989;5462.071447853855;5502.147167189092;3947.5460322063045;5337.412884582693;5347.786088556453;5370.946290537084;5389.164679474688;5390.326209223847;5391.973040134813;5400.945990540084;5453.972730136364;5458.426865179178;6171.321154672983;6232.87534249317;6252.249730032379;6252.53106017046;6256.874862502725;6400.839979000562;6474.417302442803;6487.967560162169;6547;6653.234877989044;6131.143615429162;6787.219469760991;6788.422984046362;6792.66036698168;6809.421199198074;6302.842428939267;6311.652859092702;6313.147725057151;6315.210598675166;6316.557840951135;6604.3725846044545;6754.257031726506;6937.549059311129;6946.305369463114;6946.409555187764;6338.683065846689;6376.107344971708;6432.71052802625;6529.053287273318;6546.410823025951;6713.966430167818;6716.932830671729;6718.093057437183;6733.091032710619;6746;6545.05096760967;6632.568883022588;6644.501662375341;6652.434543063797;6659.2008958925235;5300.549453296436;6375.394337537927;6451.967740161269;6452.741890324428;6595.175603049619;5354.678719276856;5360.758765855546;5368.892622147535;5391.245225668409;5411.2153737708595;4742.241241401359;4755.358026666425;4764.785584648699;4766.618670506351;4808.8797780055775;6194.225721784777;6245.437910587978;6265.749370025239;6275.748970041147;6329.113924050636;6652.8669426611195;6684.131062961784;6740.797776066725;6748.426383757337;6752.83117922046;6334.493240540745;6360.9045864312075;6365.331640177715;6371.936280637227;6376.904346434807;5555.527780138734;5566.74748181664;5904.3210030847;5947.1376650385455;6028.849278768066;6671.5997040177745;6685.09751183584;6795.7961261162245;6881.965590172017;6884.345987131214;6462.159919210472;6695.564788288941;6763;6774.3225677431865;6810.148731408574;6647.468202543688;6664.033715111184;6692.933070669231;6807.421369183477;6824.283450237654;6637.103990961158;6670.266270710121;6672.633005184567;6672.933270667231;6673.165854268216;6427.421532062137;6510.869782604226;6519.250286217146;6645.6677166140535;6763.560368576027;6486.286508484157;6534.117894084237;6551.4103730664465;6563.868722625616;6570.277269500256;6359.141515895295;6522.445592124723;6528.477721782151;6537.967310163419;6557.96721016411;6187.566870319214;6316.62100273985;6398.776042838478;6407.167068281094;6411.3909178627955;6213.782517611862;6233.594816337105;6239.688015599293;6285.874282514415;6295.496360291074;6317.210348706411;6317.842053948688;6326.525510586816;6326.841828954313;6335.461485773577 05:02:42 INFO - PID 1689 | |1;ext.html;804.8470790549795;824.44350063707;1123.1295745797006;1146.0945852776308;1146.82797580363;28921;37761.62238377616;38556;38566.22867542647;38607.42088868669;40528.59471405285;40978.18043639125;41025.58974410255;41099.38350924731;41102.38346424806;6066.787662431816;8544.999999999984;8678.86981695275;8685.522296273703;8706;6149.385061493837;8394.706185283516;8594.742157735278;8604;8615.35384846136;8623.008354039272;8673.176048275403;8689.217970382664;8690.348223883235;8691.60887760049;7199.6400179991315;8568.143185681445;8653.134686531359;8662.177093176138;8756.518391488466;8277.461964972317;8460.83078338436;8537.530435826027;8538.957305213435;8562.100979397199;37962.050948726224;38225.85322440331;38266;38278.808605956794;38338.80830595857;2724.3189202699327;3023.6091397956966;3031.9393612127633;3036.7418769404626;3060.143159915205;27511.037113700924;27553.724462755315;27724.861375693195;27899.721002789916;28770.712292877222;2820.85895705216;2847.8893231639677;2854.100958198161;2867.3691787806647;2884.4375346807383;315650.4217478921;315658;316183;316193;317031;39964.60035399667;41144;50440.49559504431;50464.49535504671;50519.24221136686;51877.221841672406;52620.73689631604;52685;52747;52851.3365561999;14299;14600.780988285183;14620.634484137981;14634.487792927197;14657.633559161106;9387.718368448957;9503.477308747946;9562.378445401027;11731.35477548726;11856.288622682494;13029;13038.282894440898;13112.016598755132;13122.14706044104;13251.668708282177;5494.835154945358;5531.778728850801;5597.412271711411;5607.186957891083;5609.1305847593685;978.9265805064649;983.8475036369374;984.2863923655293;984.7144328144901;1013.9290249682599;22539.98570064351;24086.87956560206;29646.258843528653;30121.604344852596;30300.54549181764;945.2721404518483;1056.4928834159493;1060.4538662588773;1097.939613321275;1098.9890101099047;11693.590724324607;12389;12416.068794840423;12447.439865206088;12509.812352814715;452971;454142.45857541;455464;455741.72129139805;456318;55255.44744552583;55329.723351382985;55517;55528.44471555314;55547.72226138844;1368.9121032217793;1452.1069542231662;1453.302414840861;1504.3606467251375;1519.03541251304;23454.296371108892;23467.178648747213;23497.76502234956;23504.17735379322;23507.294781156594;38609.613903860605;38618.6138138615;38695.87172705528;38701.8389448317;38735.6126438732;437925;438548;438764;438820;439135;33198.668013319555;34047.82976085104;34086;34121.65878341185;34204.828975855955;41803.53687620919;42031.57968420276;42461.36307955445;42872;43307.35038974481;29328.853355733085;29982.25044373908;30169.245768855955;30276.69723302739;30341.544876826425;26331.548770551337;28816.135515934555;29341.85329073341;30029.5495567571;30399.696003039688;35525;36422;36468.635313646526;36529.086772830895;36615.90152295435;25550.616740748534;29305.85347073251;29714.405711886073;29810;30292.69707302987;19430.8056919429;23959.94066758895;24238.394040149138;24294.757052429955;24858.751412485643 05:02:42 INFO - PID 1689 | |2;jquery.html;385.795528369964;423.1116374802414;431.9568043195681;434.1187389599114;452.50676762329056;17490.12549372531;21195.57608847822;21612.027458764394;22127.89360531975;22431.766252856087;22237.777622223774;22646.961773440387;22767.31698049057;22814.315570532868;23019;4904.48502907195;6018.87962240756;6218.720157592919;6248.156498872662;6252.06219067139;6090.3909609038965;6205.22434695663;6206.255249370082;6210.347913469089;6217.875642487147;5950.494207992326;6182.01087825948;6183.938160618403;6227.688615569226;6252.406021427957;6053.576249662526;6064.840693124628;6076.058210977306;6127.050307202391;6143.631382117065;5412.972935135299;5498.257735205736;5500.50495455407;5504.64219825714;5515.04216003317;26535.420911314366;27145.592816107775;27772.722272777417;27845.164645060682;27848.582271265946;2008.9698654520193;2009.2063634864146;2023.5143565544163;2058.5882823435372;2098.5383215692523;16032.679346413122;16273.942193757368;16303.673926521404;16955.237014334383;17309.65380692379;1872.5880306332585;1891.1111777464569;1907.9427617171507;1910.083160083168;1996.301294546897;129564.40871182618;148319;149802.25098874545;154967.45032549754;157591.42408575997;11250;11683.415829208505;12246.50974472271;12256.632301030982;12341.69145771345;14400.063995840237;15242.542723718307;15272.770908436383;16287.429939952044;16372.754408683879;7343.669534870944;8662.523561204069;8759.824803503894;8942.329325300629;8964.820703585892;8364.832703346021;8377.329813614897;8389.538575378412;8559;8596.957015215008;7712.958750568601;7785.299323060952;7898.44710870245;7911.248431399123;7918.564478953597;2158.3309174155747;2176.640854259061;2177.5536015116863;2184.4429670433938;2330;894.7226359828344;900.2752784008935;915.4507295622573;943.3160958305174;959.5058544849409;17172.712046596556;19578;20569.794302057086;21232.256871009442;21235.575288494143;805.6253841963515;949.4730424614405;973.7955029443896;976.1117383181413;979.1725991537139;10614.840777388345;10990.285631434092;10995.450227488753;11033.337999719883;11114.777704445865;657146;694334;695709;708995;716697;155519;159140;160340.96590341107;160742;160954.39045609627;1086.266769930294;1120.4061847220985;1139.6751925701135;1141.6517962021662;1143.3082984794246;15495.767563486783;17597.29610815553;18518;18556.907215464376;18968.71546926825;57973.71013144907;59447.10829337477;60307.69846150741;60875.391246088744;60943.390566093774;81497;82408.58795705983;83658.57559883242;84169.5791521063;84839.5758021206;8875.644974200959;10683.30558513694;12187.695307617381;12806.399200099988;13104.868951310365;12066.75866482683;12694.746105078031;14100.294985250492;14160.079594826715;14579.125252484884;9315.72052838416;11736.237144585915;11986.880131198925;12102.45538950767;12114.091443141975;8956.014838367644;11221.943890280496;11228.606998755004;11270.478485404694;11342.092632589209;11844.881551184379;12042.096842737004;12078.094142939139;12165.391730413621;12262.754744904874;12695.619131426072;12703.36483175856;13010.349482526026;13088.0838341319;13170.407331669907;11689.298642081503;11842.526298947945;12048.096392770753;12057.638270851889;12071 05:02:42 INFO - PID 1689 | |3;mootools.html;1363.2910886339102;1431.4202747887102;1447.4282658349946;1452.9346179421925;1461.5907545887148;10281.794364112713;10711.250212485129;10713.732156696067;10715.946420267906;10720.517576709037;10578.471076446185;10891.564337426493;10970.725731856688;10991.450427478614;11014.39420831854;2043.5504189078379;2151.6880052392394;2420.854748715074;2424.260600516842;2477.665515155458;1994;2340.2862127051244;2441.8412803167826;2452.16626347042;2459.0655550890638;2090.6863970404484;2348.1664009276715;2448.681671382718;2448.8285819992607;2462.802975761944;2422.1830358027423;2441.1455990403306;2451.0685939342934;2455.8035357171384;2465.457599328145;2023.8785672859528;2401.8799060046927;2411.44536756547;2431.3192306154306;2433.7201221859536;10684.145268378512;10949.83575246372;10951.123910087254;10952.835707464394;10955;6173.845653858644;6374.139491168679;6381.266154392258;6388.680565971729;6403.391677790602;3460.74044446665;3872.9736619795776;4037.2732908076537;4084.65280451162;4090.406891000788;1121.6018313498753;1156.832259322402;1187.2223693480785;1211.6667916322995;1212.1454374665927;15056.397744090224;15085.24573771307;15197.936144469892;15206.543803685796;15210.467633632881;4324.675649326313;5013.24801279811;5246.108161612535;5347.839564813062;5371.731413429313;11372.886271137348;11374.488148033193;11405.315681059163;11406.973372396524;11434.94282528582;6024.216851809324;6247.312795592481;6260.593061450991;6266.624002559861;6268.435840774352;5662.68855212959;5773.278340207474;5816.651000939957;5879.970600146972;5910.99513082777;3507.824608769551;4051.716379853441;4165.687573431944;4168.916621667549;4217.0511634881905;1230.9384530773425;1245.1657389549023;1254.084518301645;1269.8285731426324;1270.8093785932185;584.9675323054812;707.91505019398;739.5784402890301;751.8308380614318;763.5151678684076;5482.780688772405;6396.648184349905;6510.9023364649565;6569.474442044625;6641.103451034049;574.7212601888081;577.2207519848172;600.495583709686;605.1950905295946;705.2418649951322;3736.551613806361;3903.082775547744;4134.607212314825;4295.548967358445;4351.129774045204;12941.54704585335;13633.727325453436;13635.38640761168;13660.726785464236;13679.794803077963;13148.40832162555;13377.33113344329;13567.321633918265;13681.589552313446;13700.383482743102;9780.119789219005;10005.799884002425;10129.797404052026;10132.54403551842;10266.691999240034;6257.906131407942;6518.087467754613;6567.179102612174;6704.363085506869;6772.572329774918;12225.755484890075;12266.509339626315;12292.631221063382;12324.938375308066;12426.689332766753;12463.189892656948;12603.054770892037;12687.492500299884;12713.55502557406;12931.965442764744;8151.959240203761;8447.35276621053;8617.396782225183;8990.32572557074;9059.184673379428;10001.849972250568;10211.23415743837;10307.175425966054;10315.742106447398;10317.587296508056;6468.417842394207;7600.745876930245;8596.742097737078;8662.393632445668;8710.651573937224;8373.832523349622;8463.111373305714;8494.490330580185;8585.012723536873;8604.78488037779;7585.886211706718;7763.650635721519;7774.378049755893;7783.649735761791;7787.377009839312;4929.852104436729;5622.381538030895;5635.577331700057;5737.483626473638;5753.338366087954;5207.3230480037355;5827.621204621686;5964.254468191476;6038.818835434944;6054.648517025219 05:02:42 INFO - PID 1689 | |4;prototype.html;360.88090929993103;382.4721883800355;392.23905623091207;401.35382034923765;413.43978908578896;6070.6661133637635;6085.939140608603;6106.603070800395;6113.663748493831;6155;5331.893362132755;5534.169874518824;5853.560982926277;5866.149408335788;5989.9517584422765;4582.793774280165;4594.2419500782335;4601.585857272845;4602.493725690171;4613.884652883671;4604.1482325769675;4611.285250786117;4627.6117164850575;4633.9073218535605;4649.256119020957;3438.896833095011;4196.943497686142;4356.6514678825615;4411.367793916255;4603.677742558022;3626.4016437287814;4180.79096045198;4353.62994145498;4361.978190109029;4392.714473559208;3512.982435087834;3674.393725035366;3750.19370835269;3787.8295476703615;3794.696424286078;5151.562117220041;5601.159826026088;5774.845030993776;5794.304683437972;5906.23218981534;5216.869578260574;5246.449122842123;5263.526282634582;5282.894342113174;5284.075286824829;6387.648679322635;6393.392627700361;6407.231132264112;6412;6416.00551914454;4152.730072545275;4255.063885945118;4297.462817147856;4301.419308393358;4340.631046361063;5850.297964244275;6502.349765023507;6656.7684978278685;6665.567397680488;6814.2845001274645;3232.8383580820864;4226.77423547174;4232.238197124547;4233.539428897026;4242.512111107262;4022.2759903217116;4281.571842815756;4305.677074219383;4428.955710442919;4440.711353761995;3976.3696884277306;4299.054208074219;4877.707337559757;5131.101492447743;5184.7407629618365;5266.97366513165;5290.603204759658;6087.421694938974;6378.840528986812;6399.264084630234;1312.9015323850558;1335.3790487423394;1431.8782903453114;1508.9698206035819;1529.3806008566548;977.750673578233;991.1278075293695;1010.661428421487;1012.9797404051877;1023.948802559869;6013.6993150342305;6052.697365131726;6060.727267272983;6089.208402907594;6095.786647467317;6613.173353330833;6626.204855417381;6635.388405058535;6657.900131498031;6659.667016649245;5100.438951715382;5523.812380338247;5638.548916086703;6036.547258955596;6146.508279337642;2779.652543432071;3187.6971687689634;3280.70473657372;3311.2053107254087;3409.7954122752712;5669.546436285087;5966.463018328372;6246.843828904223;6461.676916154173;6783.287754785775;6701.966490167518;6852.211995620468;6889.138857642794;6900;6936.4797640177185;6561.3851258638515;6740.730370785113;6819.454443644497;6832.931670683329;6844.5208835382045;6362.618242905441;6565.474762019123;6569.441597464269;6576.309487503743;6623.834404139935;6458.967705161444;6570.901436478361;6581.605103693793;6586.1438013058;6603.174603174603;5526.47498487643;5974.312954010345;6553.4101930826455;6820.62486563224;6884.65576721172;4353.281708518059;4385.693001489993;4388.407564978687;4400.3399490076745;4406.955930440655;6421.967890160519;6729.014940592635;6738.820706376463;6745.9662701686175;6765.830854228684;4940.654154209315;5462.481064298885;5682.005649011324;5953.987822070345;6072.119542666377;6482.254540727877;6486.518891536644;6492.675366231764;6505.674716264073;6507.642079685663;5305.469453054664;5906;6020.939790602038;6286.277078136073;6328.936710633019;6092.360302168208;6414.967925160345;6415.3263907289065;6463.25672547663;6470.255920569195;6008.399160084132;6233.81816364287;6300.590461620163;6306.527010474141;6310.716017779303 05:02:42 INFO - PID 1689 | |5;yui.html;711.2460791560945;713.4292565947242;727.3526561360394;747.506645613895;751.7932568543646;15524.534263972071;16420.261088251027;16610.335586576537;16624.750628740578;17825.82174178258;17600.471985840413;17911.193996270165;18036;18169.7274540882;18528.88826670401;990.6730778842982;1012.5848402155118;1013.9645112421067;1014.9949250253738;1023.2990401574945;984.601236499219;1019.5819713917296;1029.6447725534679;1034.5965073621294;1047.3611097230682;1093.404094768349;1093.9398333091676;1100.1418893263267;1104.7293413113798;1107.197281970573;1069.3423544520142;1074.8925107489267;1076.7200527862733;1076.7469644633504;1080.8865069167741;711.6086152616041;797.7925739307764;802.2659266770897;803.5821372886124;808.7816289601775;16599.83400165995;16895.986240825467;17018.659626807395;17295.048772317517;17504.299828006864;14707.485238016618;14884.181370024644;14961.625959351104;15051.247437628075;15741.370345186178;11400.486978085923;11730.296182229093;11824.704382390422;11875.109366797438;12002.279863208236;2957.822530648168;2996.161074899032;3000.7599392048583;3021.0483697635173;3122.2194451387154;90911.09088909092;99575.0042499573;100885;101231.49384253031;104129;11477.483513241925;11480.196386252883;11536.826947595793;11775.646730598095;11993.820092698617;23761.643575346385;24064.278071657878;24072.87963560206;24103.758962410502;24405.145819896574;7967.960160199162;8026.678932842621;8041.597920103972;8109.43233973628;8155.918440815634;4187.581241875788;4212.7472351659;4225.577442255812;4268.146370725867;4306.82772689089;3557.839897204632;4077.9796101019306;4184.225918205142;4186.162767446523;4189.141226048653;821.8068753842842;850;852.7441767469734;856.1010938514535;886.5611522296505;541.8320320700595;560.4255637971031;581.9388964158787;583.2388732703862;600.9477633880338;7871.842563148705;9811;9886.703398898044;10249.590016399261;10621.787564248672;545.4490964126181;573.5698226330252;581.825452364289;604.1873679900526;608.3612207182441;4685.648576356787;4808.35087263215;4845.491223421561;4847.175980083394;4864;105627;105724;107436;107576.4621176889;109862;59662.403375966554;66286.66856665783;88596;89182;93082;73707.2629273711;73726.63136684282;73968.63015684887;74207.25792742112;74430.62784686041;9819.803603928025;10086.495675216356;10590.258681892194;10616.787664246518;10759.946200268949;34805.9558213254;34894;35065.824670876485;35255.82372088226;35442;48053.03893922172;48451;48660.75669621629;48864.75567622281;48963.75518122387;13183.604491865259;13258.933705331412;13728.313584320544;13806.240656763573;13969.790453143009;14343.687524244124;14563.635909102357;14569;14618.85381146175;14887.851121488646;13595.53795615386;13667.455409516519;13696.246706431242;13710.24593647359;14251.429942802171;13347.332633368487;13566.796498052734;13662.248576328397;13710.931445343109;14265.786013209603;11338.716532086764;12904.16122952005;12908.644592318047;13038.175874926337;13183.868161318263;9563.665271715456;9805;9893.604255829687;9957.850632240377;10511.526981285708;7558.093028836574;9530.95234523823;9596.280278978966;11073;11514.712132196762 05:02:42 INFO - PID 1689 | __end_tp_report 05:02:42 INFO - PID 1689 | __start_cc_report 05:02:42 INFO - PID 1689 | _x_x_mozilla_cycle_collect,1910 05:02:42 INFO - PID 1689 | __end_cc_report 05:02:42 INFO - PID 1689 | __startTimestamp1491134562976__endTimestamp 05:02:42 INFO - PID 1689 | 05:02:42 INFO - PID 1689 | ------- Summary: start ------- 05:02:42 INFO - PID 1689 | Number of tests: 6 05:02:42 INFO - PID 1689 | 05:02:42 INFO - PID 1689 | [#0] dojo.html Cycles:165 Average:6107.25 Median:6329.11 stddev:735.31 (11.6%) stddev-sans-first:709.00 05:02:42 INFO - PID 1689 | Values: 3520.0 3526.4 3539.5 3565.6 3604.2 6093.8 6159.4 6198.9 6200.9 6202.7 5114.2 6130.4 6136.9 6141.9 6237.2 5341.8 5343.7 5388.5 5423.1 5494.2 4683.3 5335.4 5394.4 5400.4 5475.5 5267.1 5433.1 5439.0 5462.1 5502.1 3947.5 5337.4 5347.8 5370.9 5389.2 5390.3 5392.0 5400.9 5454.0 5458.4 6171.3 6232.9 6252.2 6252.5 6256.9 6400.8 6474.4 6488.0 6547.0 6653.2 6131.1 6787.2 6788.4 6792.7 6809.4 6302.8 6311.7 6313.1 6315.2 6316.6 6604.4 6754.3 6937.5 6946.3 6946.4 6338.7 6376.1 6432.7 6529.1 6546.4 6714.0 6716.9 6718.1 6733.1 6746.0 6545.1 6632.6 6644.5 6652.4 6659.2 5300.5 6375.4 6452.0 6452.7 6595.2 5354.7 5360.8 5368.9 5391.2 5411.2 4742.2 4755.4 4764.8 4766.6 4808.9 6194.2 6245.4 6265.7 6275.7 6329.1 6652.9 6684.1 6740.8 6748.4 6752.8 6334.5 6360.9 6365.3 6371.9 6376.9 5555.5 5566.7 5904.3 5947.1 6028.8 6671.6 6685.1 6795.8 6882.0 6884.3 6462.2 6695.6 6763.0 6774.3 6810.1 6647.5 6664.0 6692.9 6807.4 6824.3 6637.1 6670.3 6672.6 6672.9 6673.2 6427.4 6510.9 6519.3 6645.7 6763.6 6486.3 6534.1 6551.4 6563.9 6570.3 6359.1 6522.4 6528.5 6538.0 6558.0 6187.6 6316.6 6398.8 6407.2 6411.4 6213.8 6233.6 6239.7 6285.9 6295.5 6317.2 6317.8 6326.5 6326.8 6335.5 05:02:42 INFO - PID 1689 | 05:02:42 INFO - PID 1689 | [#1] ext.html Cycles:180 Average:53591.10 Median:37188.76 stddev:108373.62 (291.4%) stddev-sans-first:108605.16 05:02:42 INFO - PID 1689 | Values: 804.8 824.4 1123.1 1146.1 1146.8 28921.0 37761.6 38556.0 38566.2 38607.4 40528.6 40978.2 41025.6 41099.4 41102.4 6066.8 8545.0 8678.9 8685.5 8706.0 6149.4 8394.7 8594.7 8604.0 8615.4 8623.0 8673.2 8689.2 8690.3 8691.6 7199.6 8568.1 8653.1 8662.2 8756.5 8277.5 8460.8 8537.5 8539.0 8562.1 37962.1 38225.9 38266.0 38278.8 38338.8 2724.3 3023.6 3031.9 3036.7 3060.1 27511.0 27553.7 27724.9 27899.7 28770.7 2820.9 2847.9 2854.1 2867.4 2884.4 315650.4 315658.0 316183.0 316193.0 317031.0 39964.6 41144.0 50440.5 50464.5 50519.2 51877.2 52620.7 52685.0 52747.0 52851.3 14299.0 14600.8 14620.6 14634.5 14657.6 9387.7 9503.5 9562.4 11731.4 11856.3 13029.0 13038.3 13112.0 13122.1 13251.7 5494.8 5531.8 5597.4 5607.2 5609.1 978.9 983.8 984.3 984.7 1013.9 22540.0 24086.9 29646.3 30121.6 30300.5 945.3 1056.5 1060.5 1097.9 1099.0 11693.6 12389.0 12416.1 12447.4 12509.8 452971.0 454142.5 455464.0 455741.7 456318.0 55255.4 55329.7 55517.0 55528.4 55547.7 1368.9 1452.1 1453.3 1504.4 1519.0 23454.3 23467.2 23497.8 23504.2 23507.3 38609.6 38618.6 38695.9 38701.8 38735.6 437925.0 438548.0 438764.0 438820.0 439135.0 33198.7 34047.8 34086.0 34121.7 34204.8 41803.5 42031.6 42461.4 42872.0 43307.4 29328.9 29982.3 30169.2 30276.7 30341.5 26331.5 28816.1 29341.9 30029.5 30399.7 35525.0 36422.0 36468.6 36529.1 36615.9 25550.6 29305.9 29714.4 29810.0 30292.7 19430.8 23959.9 24238.4 24294.8 24858.8 05:02:42 INFO - PID 1689 | 05:02:42 INFO - PID 1689 | [#2] jquery.html Cycles:180 Average:40488.62 Median:11894.33 stddev:116563.66 (980.0%) stddev-sans-first:116851.76 05:02:42 INFO - PID 1689 | Values: 385.8 423.1 432.0 434.1 452.5 17490.1 21195.6 21612.0 22127.9 22431.8 22237.8 22647.0 22767.3 22814.3 23019.0 4904.5 6018.9 6218.7 6248.2 6252.1 6090.4 6205.2 6206.3 6210.3 6217.9 5950.5 6182.0 6183.9 6227.7 6252.4 6053.6 6064.8 6076.1 6127.1 6143.6 5413.0 5498.3 5500.5 5504.6 5515.0 26535.4 27145.6 27772.7 27845.2 27848.6 2009.0 2009.2 2023.5 2058.6 2098.5 16032.7 16273.9 16303.7 16955.2 17309.7 1872.6 1891.1 1907.9 1910.1 1996.3 129564.4 148319.0 149802.3 154967.5 157591.4 11250.0 11683.4 12246.5 12256.6 12341.7 14400.1 15242.5 15272.8 16287.4 16372.8 7343.7 8662.5 8759.8 8942.3 8964.8 8364.8 8377.3 8389.5 8559.0 8597.0 7713.0 7785.3 7898.4 7911.2 7918.6 2158.3 2176.6 2177.6 2184.4 2330.0 894.7 900.3 915.5 943.3 959.5 17172.7 19578.0 20569.8 21232.3 21235.6 805.6 949.5 973.8 976.1 979.2 10614.8 10990.3 10995.5 11033.3 11114.8 657146.0 694334.0 695709.0 708995.0 716697.0 155519.0 159140.0 160341.0 160742.0 160954.4 1086.3 1120.4 1139.7 1141.7 1143.3 15495.8 17597.3 18518.0 18556.9 18968.7 57973.7 59447.1 60307.7 60875.4 60943.4 81497.0 82408.6 83658.6 84169.6 84839.6 8875.6 10683.3 12187.7 12806.4 13104.9 12066.8 12694.7 14100.3 14160.1 14579.1 9315.7 11736.2 11986.9 12102.5 12114.1 8956.0 11221.9 11228.6 11270.5 11342.1 11844.9 12042.1 12078.1 12165.4 12262.8 12695.6 12703.4 13010.3 13088.1 13170.4 11689.3 11842.5 12048.1 12057.6 12071.0 05:02:42 INFO - PID 1689 | 05:02:42 INFO - PID 1689 | [#3] mootools.html Cycles:180 Average:6689.23 Median:2460.93 stddev:4170.32 (169.5%) stddev-sans-first:4162.81 05:02:42 INFO - PID 1689 | Values: 1363.3 1431.4 1447.4 1452.9 1461.6 10281.8 10711.3 10713.7 10715.9 10720.5 10578.5 10891.6 10970.7 10991.5 11014.4 2043.6 2151.7 2420.9 2424.3 2477.7 1994.0 2340.3 2441.8 2452.2 2459.1 2090.7 2348.2 2448.7 2448.8 2462.8 2422.2 2441.1 2451.1 2455.8 2465.5 2023.9 2401.9 2411.4 2431.3 2433.7 10684.1 10949.8 10951.1 10952.8 10955.0 6173.8 6374.1 6381.3 6388.7 6403.4 3460.7 3873.0 4037.3 4084.7 4090.4 1121.6 1156.8 1187.2 1211.7 1212.1 15056.4 15085.2 15197.9 15206.5 15210.5 4324.7 5013.2 5246.1 5347.8 5371.7 11372.9 11374.5 11405.3 11407.0 11434.9 6024.2 6247.3 6260.6 6266.6 6268.4 5662.7 5773.3 5816.7 5880.0 5911.0 3507.8 4051.7 4165.7 4168.9 4217.1 1230.9 1245.2 1254.1 1269.8 1270.8 585.0 707.9 739.6 751.8 763.5 5482.8 6396.6 6510.9 6569.5 6641.1 574.7 577.2 600.5 605.2 705.2 3736.6 3903.1 4134.6 4295.5 4351.1 12941.5 13633.7 13635.4 13660.7 13679.8 13148.4 13377.3 13567.3 13681.6 13700.4 9780.1 10005.8 10129.8 10132.5 10266.7 6257.9 6518.1 6567.2 6704.4 6772.6 12225.8 12266.5 12292.6 12324.9 12426.7 12463.2 12603.1 12687.5 12713.6 12932.0 8152.0 8447.4 8617.4 8990.3 9059.2 10001.8 10211.2 10307.2 10315.7 10317.6 6468.4 7600.7 8596.7 8662.4 8710.7 8373.8 8463.1 8494.5 8585.0 8604.8 7585.9 7763.7 7774.4 7783.6 7787.4 4929.9 5622.4 5635.6 5737.5 5753.3 5207.3 5827.6 5964.3 6038.8 6054.6 05:02:42 INFO - PID 1689 | 05:02:42 INFO - PID 1689 | [#4] prototype.html Cycles:180 Average:5154.67 Median:5851.93 stddev:1639.83 (28.0%) stddev-sans-first:1604.47 05:02:42 INFO - PID 1689 | Values: 360.9 382.5 392.2 401.4 413.4 6070.7 6085.9 6106.6 6113.7 6155.0 5331.9 5534.2 5853.6 5866.1 5990.0 4582.8 4594.2 4601.6 4602.5 4613.9 4604.1 4611.3 4627.6 4633.9 4649.3 3438.9 4196.9 4356.7 4411.4 4603.7 3626.4 4180.8 4353.6 4362.0 4392.7 3513.0 3674.4 3750.2 3787.8 3794.7 5151.6 5601.2 5774.8 5794.3 5906.2 5216.9 5246.4 5263.5 5282.9 5284.1 6387.6 6393.4 6407.2 6412.0 6416.0 4152.7 4255.1 4297.5 4301.4 4340.6 5850.3 6502.3 6656.8 6665.6 6814.3 3232.8 4226.8 4232.2 4233.5 4242.5 4022.3 4281.6 4305.7 4429.0 4440.7 3976.4 4299.1 4877.7 5131.1 5184.7 5267.0 5290.6 6087.4 6378.8 6399.3 1312.9 1335.4 1431.9 1509.0 1529.4 977.8 991.1 1010.7 1013.0 1023.9 6013.7 6052.7 6060.7 6089.2 6095.8 6613.2 6626.2 6635.4 6657.9 6659.7 5100.4 5523.8 5638.5 6036.5 6146.5 2779.7 3187.7 3280.7 3311.2 3409.8 5669.5 5966.5 6246.8 6461.7 6783.3 6702.0 6852.2 6889.1 6900.0 6936.5 6561.4 6740.7 6819.5 6832.9 6844.5 6362.6 6565.5 6569.4 6576.3 6623.8 6459.0 6570.9 6581.6 6586.1 6603.2 5526.5 5974.3 6553.4 6820.6 6884.7 4353.3 4385.7 4388.4 4400.3 4407.0 6422.0 6729.0 6738.8 6746.0 6765.8 4940.7 5462.5 5682.0 5954.0 6072.1 6482.3 6486.5 6492.7 6505.7 6507.6 5305.5 5906.0 6020.9 6286.3 6328.9 6092.4 6415.0 6415.3 6463.3 6470.3 6008.4 6233.8 6300.6 6306.5 6310.7 05:02:42 INFO - PID 1689 | 05:02:42 INFO - PID 1689 | [#5] yui.html Cycles:180 Average:19390.53 Median:23912.96 stddev:27393.12 (114.6%) stddev-sans-first:27434.06 05:02:42 INFO - PID 1689 | Values: 711.2 713.4 727.4 747.5 751.8 15524.5 16420.3 16610.3 16624.8 17825.8 17600.5 17911.2 18036.0 18169.7 18528.9 990.7 1012.6 1014.0 1015.0 1023.3 984.6 1019.6 1029.6 1034.6 1047.4 1093.4 1093.9 1100.1 1104.7 1107.2 1069.3 1074.9 1076.7 1076.7 1080.9 711.6 797.8 802.3 803.6 808.8 16599.8 16896.0 17018.7 17295.0 17504.3 14707.5 14884.2 14961.6 15051.2 15741.4 11400.5 11730.3 11824.7 11875.1 12002.3 2957.8 2996.2 3000.8 3021.0 3122.2 90911.1 99575.0 100885.0 101231.5 104129.0 11477.5 11480.2 11536.8 11775.6 11993.8 23761.6 24064.3 24072.9 24103.8 24405.1 7968.0 8026.7 8041.6 8109.4 8155.9 4187.6 4212.7 4225.6 4268.1 4306.8 3557.8 4078.0 4184.2 4186.2 4189.1 821.8 850.0 852.7 856.1 886.6 541.8 560.4 581.9 583.2 600.9 7871.8 9811.0 9886.7 10249.6 10621.8 545.4 573.6 581.8 604.2 608.4 4685.6 4808.4 4845.5 4847.2 4864.0 105627.0 105724.0 107436.0 107576.5 109862.0 59662.4 66286.7 88596.0 89182.0 93082.0 73707.3 73726.6 73968.6 74207.3 74430.6 9819.8 10086.5 10590.3 10616.8 10759.9 34806.0 34894.0 35065.8 35255.8 35442.0 48053.0 48451.0 48660.8 48864.8 48963.8 13183.6 13258.9 13728.3 13806.2 13969.8 14343.7 14563.6 14569.0 14618.9 14887.9 13595.5 13667.5 13696.2 13710.2 14251.4 13347.3 13566.8 13662.2 13710.9 14265.8 11338.7 12904.2 12908.6 13038.2 13183.9 9563.7 9805.0 9893.6 9957.9 10511.5 7558.1 9531.0 9596.3 11073.0 11514.7 05:02:42 INFO - PID 1689 | -------- Summary: end -------- 05:02:42 INFO - PID 1689 | 05:02:43 INFO - TEST-INFO | 1689: exit 0 05:02:43 INFO - TEST-OK | dromaeo_css | took 1123054ms 05:02:43 INFO - TEST-START | kraken 05:02:43 INFO - operating with platform_type : mac_ 05:02:43 INFO - Initialising browser for kraken test... 05:02:43 INFO - TEST-INFO | started process 1694 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/tmpiBcNRA/profile http://localhost:49252/getInfo.html) 05:02:46 INFO - PID 1694 | __metrics Screen width/height:1600/1200 05:02:46 INFO - PID 1694 | colorDepth:24 05:02:46 INFO - PID 1694 | Browser inner width/height: 1024/689 05:02:46 INFO - PID 1694 | __metrics 05:02:46 INFO - PID 1694 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:02:46 INFO - PID 1694 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:02:47 INFO - TEST-INFO | 1694: exit 0 05:02:47 INFO - Browser initialized. 05:02:47 INFO - Running cycle 1/1 for kraken test... 05:02:47 INFO - TEST-INFO | started process 1696 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/tmpiBcNRA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:02:59 INFO - PID 1696 | RSS: Main: 232501248 05:02:59 INFO - PID 1696 | 05:03:02 INFO - PID 1696 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-beat-detection) 05:03:03 INFO - PID 1696 | RSS: Main: 287031296 05:03:03 INFO - PID 1696 | 05:03:05 INFO - PID 1696 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-dft) 05:03:06 INFO - PID 1696 | RSS: Main: 287543296 05:03:06 INFO - PID 1696 | 05:03:10 INFO - PID 1696 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-fft) 05:03:10 INFO - PID 1696 | RSS: Main: 380104704 05:03:10 INFO - PID 1696 | 05:03:12 INFO - PID 1696 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-oscillator) 05:03:13 INFO - PID 1696 | RSS: Main: 284020736 05:03:13 INFO - PID 1696 | 05:03:15 INFO - PID 1696 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49252/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:03:16 INFO - PID 1696 | RSS: Main: 285851648 05:03:16 INFO - PID 1696 | 05:03:19 INFO - PID 1696 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49252/tests/kraken/driver.html?testName=imaging-darkroom) 05:03:19 INFO - PID 1696 | RSS: Main: 327827456 05:03:19 INFO - PID 1696 | 05:03:23 INFO - PID 1696 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49252/tests/kraken/driver.html?testName=imaging-desaturate) 05:03:23 INFO - PID 1696 | RSS: Main: 336977920 05:03:23 INFO - PID 1696 | 05:03:26 INFO - PID 1696 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49252/tests/kraken/driver.html?testName=json-parse-financial) 05:03:27 INFO - PID 1696 | RSS: Main: 339447808 05:03:27 INFO - PID 1696 | 05:03:28 INFO - PID 1696 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49252/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:03:29 INFO - PID 1696 | RSS: Main: 305401856 05:03:29 INFO - PID 1696 | 05:03:31 INFO - PID 1696 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:03:32 INFO - PID 1696 | RSS: Main: 309977088 05:03:32 INFO - PID 1696 | 05:03:34 INFO - PID 1696 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:03:35 INFO - PID 1696 | RSS: Main: 311615488 05:03:35 INFO - PID 1696 | 05:03:38 INFO - PID 1696 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:03:39 INFO - PID 1696 | RSS: Main: 328781824 05:03:39 INFO - PID 1696 | 05:03:42 INFO - PID 1696 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:03:43 INFO - PID 1696 | RSS: Main: 311873536 05:03:43 INFO - PID 1696 | 05:03:44 INFO - PID 1696 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49252/tests/kraken/driver.html?testName=ai-astar) 05:03:45 INFO - PID 1696 | RSS: Main: 377503744 05:03:45 INFO - PID 1696 | 05:03:45 INFO - PID 1696 | __start_tp_report 05:03:45 INFO - PID 1696 | _x_x_mozilla_page_load 05:03:45 INFO - PID 1696 | _x_x_mozilla_page_load_details 05:03:45 INFO - PID 1696 | |i|pagename|runs| 05:03:45 INFO - PID 1696 | |0;ai-astar;110;122;121;121;120;125;123;123;123;124 05:03:45 INFO - PID 1696 | |1;audio-beat-detection;158;121;120;162;117;120;121;117;144;115 05:03:45 INFO - PID 1696 | |2;audio-dft;293;281;221;209;217;214;208;212;211;219 05:03:45 INFO - PID 1696 | |3;audio-fft;83;63;65;96;66;66;62;63;83;65 05:03:45 INFO - PID 1696 | |4;audio-oscillator;95;74;97;74;75;76;93;73;75;92 05:03:45 INFO - PID 1696 | |5;imaging-gaussian-blur;92;90;90;90;91;91;92;91;92;91 05:03:45 INFO - PID 1696 | |6;imaging-darkroom;99;97;100;100;97;98;99;99;98;98 05:03:45 INFO - PID 1696 | |7;imaging-desaturate;100;100;100;98;100;97;100;102;102;101 05:03:45 INFO - PID 1696 | |8;json-parse-financial;50;49;50;51;51;50;53;53;52;53 05:03:45 INFO - PID 1696 | |9;json-stringify-tinderbox;58;73;70;67;66;64;64;64;64;64 05:03:45 INFO - PID 1696 | |10;stanford-crypto-aes;91;89;89;92;92;93;89;110;88;89 05:03:45 INFO - PID 1696 | |11;stanford-crypto-ccm;154;150;148;165;167;173;169;168;227;163 05:03:45 INFO - PID 1696 | |12;stanford-crypto-pbkdf2;198;237;260;203;197;197;201;201;196;197 05:03:45 INFO - PID 1696 | |13;stanford-crypto-sha256-iterative;73;74;72;75;73;73;72;73;75;72 05:03:45 INFO - PID 1696 | __end_tp_report 05:03:45 INFO - PID 1696 | __start_cc_report 05:03:45 INFO - PID 1696 | _x_x_mozilla_cycle_collect,2139 05:03:45 INFO - PID 1696 | __end_cc_report 05:03:45 INFO - PID 1696 | __startTimestamp1491134625129__endTimestamp 05:03:45 INFO - PID 1696 | 05:03:45 INFO - PID 1696 | ------- Summary: start ------- 05:03:45 INFO - PID 1696 | Number of tests: 14 05:03:45 INFO - PID 1696 | 05:03:45 INFO - PID 1696 | [#0] ai-astar Cycles:10 Average:121.20 Median:123.00 stddev:4.21 (3.4%) stddev-sans-first:1.59 05:03:45 INFO - PID 1696 | Values: 110.0 122.0 121.0 121.0 120.0 125.0 123.0 123.0 123.0 124.0 05:03:45 INFO - PID 1696 | 05:03:45 INFO - PID 1696 | [#1] audio-beat-detection Cycles:10 Average:129.50 Median:121.00 stddev:18.03 (14.9%) stddev-sans-first:15.91 05:03:45 INFO - PID 1696 | Values: 158.0 121.0 120.0 162.0 117.0 120.0 121.0 117.0 144.0 115.0 05:03:45 INFO - PID 1696 | 05:03:45 INFO - PID 1696 | [#2] audio-dft Cycles:10 Average:228.50 Median:218.00 stddev:31.24 (14.3%) stddev-sans-first:22.81 05:03:45 INFO - PID 1696 | Values: 293.0 281.0 221.0 209.0 217.0 214.0 208.0 212.0 211.0 219.0 05:03:45 INFO - PID 1696 | 05:03:45 INFO - PID 1696 | [#3] audio-fft Cycles:10 Average:71.20 Median:66.00 stddev:11.75 (17.8%) stddev-sans-first:11.67 05:03:45 INFO - PID 1696 | Values: 83.0 63.0 65.0 96.0 66.0 66.0 62.0 63.0 83.0 65.0 05:03:45 INFO - PID 1696 | 05:03:45 INFO - PID 1696 | [#4] audio-oscillator Cycles:10 Average:82.40 Median:84.00 stddev:10.31 (12.3%) stddev-sans-first:9.87 05:03:45 INFO - PID 1696 | Values: 95.0 74.0 97.0 74.0 75.0 76.0 93.0 73.0 75.0 92.0 05:03:45 INFO - PID 1696 | 05:03:45 INFO - PID 1696 | [#5] imaging-gaussian-blur Cycles:10 Average:91.00 Median:91.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 05:03:45 INFO - PID 1696 | Values: 92.0 90.0 90.0 90.0 91.0 91.0 92.0 91.0 92.0 91.0 05:03:45 INFO - PID 1696 | 05:03:45 INFO - PID 1696 | [#6] imaging-darkroom Cycles:10 Average:98.50 Median:98.00 stddev:1.08 (1.1%) stddev-sans-first:1.13 05:03:45 INFO - PID 1696 | Values: 99.0 97.0 100.0 100.0 97.0 98.0 99.0 99.0 98.0 98.0 05:03:45 INFO - PID 1696 | 05:03:45 INFO - PID 1696 | [#7] imaging-desaturate Cycles:10 Average:100.00 Median:101.50 stddev:1.56 (1.5%) stddev-sans-first:1.66 05:03:45 INFO - PID 1696 | Values: 100.0 100.0 100.0 98.0 100.0 97.0 100.0 102.0 102.0 101.0 05:03:45 INFO - PID 1696 | 05:03:45 INFO - PID 1696 | [#8] json-parse-financial Cycles:10 Average:51.20 Median:51.50 stddev:1.48 (2.9%) stddev-sans-first:1.50 05:03:45 INFO - PID 1696 | Values: 50.0 49.0 50.0 51.0 51.0 50.0 53.0 53.0 52.0 53.0 05:03:45 INFO - PID 1696 | 05:03:45 INFO - PID 1696 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.00 stddev:4.03 (6.2%) stddev-sans-first:3.27 05:03:45 INFO - PID 1696 | Values: 58.0 73.0 70.0 67.0 66.0 64.0 64.0 64.0 64.0 64.0 05:03:45 INFO - PID 1696 | 05:03:45 INFO - PID 1696 | [#10] stanford-crypto-aes Cycles:10 Average:92.20 Median:90.00 stddev:6.48 (7.2%) stddev-sans-first:6.86 05:03:45 INFO - PID 1696 | Values: 91.0 89.0 89.0 92.0 92.0 93.0 89.0 110.0 88.0 89.0 05:03:45 INFO - PID 1696 | 05:03:45 INFO - PID 1696 | [#11] stanford-crypto-ccm Cycles:10 Average:168.40 Median:167.50 stddev:22.26 (13.3%) stddev-sans-first:22.99 05:03:45 INFO - PID 1696 | Values: 154.0 150.0 148.0 165.0 167.0 173.0 169.0 168.0 227.0 163.0 05:03:45 INFO - PID 1696 | 05:03:45 INFO - PID 1696 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:208.70 Median:201.00 stddev:21.78 (10.8%) stddev-sans-first:22.76 05:03:45 INFO - PID 1696 | Values: 198.0 237.0 260.0 203.0 197.0 197.0 201.0 201.0 196.0 197.0 05:03:45 INFO - PID 1696 | 05:03:45 INFO - PID 1696 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:73.00 stddev:1.14 (1.6%) stddev-sans-first:1.20 05:03:45 INFO - PID 1696 | Values: 73.0 74.0 72.0 75.0 73.0 73.0 72.0 73.0 75.0 72.0 05:03:45 INFO - PID 1696 | -------- Summary: end -------- 05:03:45 INFO - PID 1696 | 05:03:46 INFO - TEST-INFO | 1696: exit 0 05:03:46 INFO - TEST-OK | kraken | took 62244ms 05:03:46 INFO - SUITE-END | took 1185s 05:03:46 INFO - Completed test suite (00:19:45) 05:03:46 INFO - javascript benchmark 05:03:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7651.178346413883, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3520.049586611615, 3526.418141006734, 3539.4867744177077, 3565.589957154926, 3604.1890574620716, 6093.756249750005, 6159.445649891509, 6198.876022479553, 6200.945839207334, 6202.658853763047, 5114.232865070241, 6130.386961303868, 6136.856084434195, 6141.915626108644, 6237.157983672203, 5341.759620817073, 5343.65266257692, 5388.4611538846, 5423.132298832187, 5494.230807686927, 4683.250679891218, 5335.439778823206, 5394.433584473613, 5400.432954539776, 5475.5072043516075, 5267.078261304295, 5433.1035379162395, 5438.972805135989, 5462.071447853855, 5502.147167189092, 3947.5460322063045, 5337.412884582693, 5347.786088556453, 5370.946290537084, 5389.164679474688, 5390.326209223847, 5391.973040134813, 5400.945990540084, 5453.972730136364, 5458.426865179178, 6171.321154672983, 6232.87534249317, 6252.249730032379, 6252.53106017046, 6256.874862502725, 6400.839979000562, 6474.417302442803, 6487.967560162169, 6547.0, 6653.234877989044, 6131.143615429162, 6787.219469760991, 6788.422984046362, 6792.66036698168, 6809.421199198074, 6302.842428939267, 6311.652859092702, 6313.147725057151, 6315.210598675166, 6316.557840951135, 6604.3725846044545, 6754.257031726506, 6937.549059311129, 6946.305369463114, 6946.409555187764, 6338.683065846689, 6376.107344971708, 6432.71052802625, 6529.053287273318, 6546.410823025951, 6713.966430167818, 6716.932830671729, 6718.093057437183, 6733.091032710619, 6746.0, 6545.05096760967, 6632.568883022588, 6644.501662375341, 6652.434543063797, 6659.2008958925235, 5300.549453296436, 6375.394337537927, 6451.967740161269, 6452.741890324428, 6595.175603049619, 5354.678719276856, 5360.758765855546, 5368.892622147535, 5391.245225668409, 5411.2153737708595, 4742.241241401359, 4755.358026666425, 4764.785584648699, 4766.618670506351, 4808.8797780055775, 6194.225721784777, 6245.437910587978, 6265.749370025239, 6275.748970041147, 6329.113924050636, 6652.8669426611195, 6684.131062961784, 6740.797776066725, 6748.426383757337, 6752.83117922046, 6334.493240540745, 6360.9045864312075, 6365.331640177715, 6371.936280637227, 6376.904346434807, 5555.527780138734, 5566.74748181664, 5904.3210030847, 5947.1376650385455, 6028.849278768066, 6671.5997040177745, 6685.09751183584, 6795.7961261162245, 6881.965590172017, 6884.345987131214, 6462.159919210472, 6695.564788288941, 6763.0, 6774.3225677431865, 6810.148731408574, 6647.468202543688, 6664.033715111184, 6692.933070669231, 6807.421369183477, 6824.283450237654, 6637.103990961158, 6670.266270710121, 6672.633005184567, 6672.933270667231, 6673.165854268216, 6427.421532062137, 6510.869782604226, 6519.250286217146, 6645.6677166140535, 6763.560368576027, 6486.286508484157, 6534.117894084237, 6551.4103730664465, 6563.868722625616, 6570.277269500256, 6359.141515895295, 6522.445592124723, 6528.477721782151, 6537.967310163419, 6557.96721016411, 6187.566870319214, 6316.62100273985, 6398.776042838478, 6407.167068281094, 6411.3909178627955, 6213.782517611862, 6233.594816337105, 6239.688015599293, 6285.874282514415, 6295.496360291074, 6317.210348706411, 6317.842053948688, 6326.525510586816, 6326.841828954313, 6335.461485773577], "value": 6058.235248587402, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [804.8470790549795, 824.44350063707, 1123.1295745797006, 1146.0945852776308, 1146.82797580363, 28921.0, 37761.62238377616, 38556.0, 38566.22867542647, 38607.42088868669, 40528.59471405285, 40978.18043639125, 41025.58974410255, 41099.38350924731, 41102.38346424806, 6066.787662431816, 8544.999999999984, 8678.86981695275, 8685.522296273703, 8706.0, 6149.385061493837, 8394.706185283516, 8594.742157735278, 8604.0, 8615.35384846136, 8623.008354039272, 8673.176048275403, 8689.217970382664, 8690.348223883235, 8691.60887760049, 7199.6400179991315, 8568.143185681445, 8653.134686531359, 8662.177093176138, 8756.518391488466, 8277.461964972317, 8460.83078338436, 8537.530435826027, 8538.957305213435, 8562.100979397199, 37962.050948726224, 38225.85322440331, 38266.0, 38278.808605956794, 38338.80830595857, 2724.3189202699327, 3023.6091397956966, 3031.9393612127633, 3036.7418769404626, 3060.143159915205, 27511.037113700924, 27553.724462755315, 27724.861375693195, 27899.721002789916, 28770.712292877222, 2820.85895705216, 2847.8893231639677, 2854.100958198161, 2867.3691787806647, 2884.4375346807383, 315650.4217478921, 315658.0, 316183.0, 316193.0, 317031.0, 39964.60035399667, 41144.0, 50440.49559504431, 50464.49535504671, 50519.24221136686, 51877.221841672406, 52620.73689631604, 52685.0, 52747.0, 52851.3365561999, 14299.0, 14600.780988285183, 14620.634484137981, 14634.487792927197, 14657.633559161106, 9387.718368448957, 9503.477308747946, 9562.378445401027, 11731.35477548726, 11856.288622682494, 13029.0, 13038.282894440898, 13112.016598755132, 13122.14706044104, 13251.668708282177, 5494.835154945358, 5531.778728850801, 5597.412271711411, 5607.186957891083, 5609.1305847593685, 978.9265805064649, 983.8475036369374, 984.2863923655293, 984.7144328144901, 1013.9290249682599, 22539.98570064351, 24086.87956560206, 29646.258843528653, 30121.604344852596, 30300.54549181764, 945.2721404518483, 1056.4928834159493, 1060.4538662588773, 1097.939613321275, 1098.9890101099047, 11693.590724324607, 12389.0, 12416.068794840423, 12447.439865206088, 12509.812352814715, 452971.0, 454142.45857541, 455464.0, 455741.72129139805, 456318.0, 55255.44744552583, 55329.723351382985, 55517.0, 55528.44471555314, 55547.72226138844, 1368.9121032217793, 1452.1069542231662, 1453.302414840861, 1504.3606467251375, 1519.03541251304, 23454.296371108892, 23467.178648747213, 23497.76502234956, 23504.17735379322, 23507.294781156594, 38609.613903860605, 38618.6138138615, 38695.87172705528, 38701.8389448317, 38735.6126438732, 437925.0, 438548.0, 438764.0, 438820.0, 439135.0, 33198.668013319555, 34047.82976085104, 34086.0, 34121.65878341185, 34204.828975855955, 41803.53687620919, 42031.57968420276, 42461.36307955445, 42872.0, 43307.35038974481, 29328.853355733085, 29982.25044373908, 30169.245768855955, 30276.69723302739, 30341.544876826425, 26331.548770551337, 28816.135515934555, 29341.85329073341, 30029.5495567571, 30399.696003039688, 35525.0, 36422.0, 36468.635313646526, 36529.086772830895, 36615.90152295435, 25550.616740748534, 29305.85347073251, 29714.405711886073, 29810.0, 30292.69707302987, 19430.8056919429, 23959.94066758895, 24238.394040149138, 24294.757052429955, 24858.751412485643], "value": 17639.28977875367, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.795528369964, 423.1116374802414, 431.9568043195681, 434.1187389599114, 452.50676762329056, 17490.12549372531, 21195.57608847822, 21612.027458764394, 22127.89360531975, 22431.766252856087, 22237.777622223774, 22646.961773440387, 22767.31698049057, 22814.315570532868, 23019.0, 4904.48502907195, 6018.87962240756, 6218.720157592919, 6248.156498872662, 6252.06219067139, 6090.3909609038965, 6205.22434695663, 6206.255249370082, 6210.347913469089, 6217.875642487147, 5950.494207992326, 6182.01087825948, 6183.938160618403, 6227.688615569226, 6252.406021427957, 6053.576249662526, 6064.840693124628, 6076.058210977306, 6127.050307202391, 6143.631382117065, 5412.972935135299, 5498.257735205736, 5500.50495455407, 5504.64219825714, 5515.04216003317, 26535.420911314366, 27145.592816107775, 27772.722272777417, 27845.164645060682, 27848.582271265946, 2008.9698654520193, 2009.2063634864146, 2023.5143565544163, 2058.5882823435372, 2098.5383215692523, 16032.679346413122, 16273.942193757368, 16303.673926521404, 16955.237014334383, 17309.65380692379, 1872.5880306332585, 1891.1111777464569, 1907.9427617171507, 1910.083160083168, 1996.301294546897, 129564.40871182618, 148319.0, 149802.25098874545, 154967.45032549754, 157591.42408575997, 11250.0, 11683.415829208505, 12246.50974472271, 12256.632301030982, 12341.69145771345, 14400.063995840237, 15242.542723718307, 15272.770908436383, 16287.429939952044, 16372.754408683879, 7343.669534870944, 8662.523561204069, 8759.824803503894, 8942.329325300629, 8964.820703585892, 8364.832703346021, 8377.329813614897, 8389.538575378412, 8559.0, 8596.957015215008, 7712.958750568601, 7785.299323060952, 7898.44710870245, 7911.248431399123, 7918.564478953597, 2158.3309174155747, 2176.640854259061, 2177.5536015116863, 2184.4429670433938, 2330.0, 894.7226359828344, 900.2752784008935, 915.4507295622573, 943.3160958305174, 959.5058544849409, 17172.712046596556, 19578.0, 20569.794302057086, 21232.256871009442, 21235.575288494143, 805.6253841963515, 949.4730424614405, 973.7955029443896, 976.1117383181413, 979.1725991537139, 10614.840777388345, 10990.285631434092, 10995.450227488753, 11033.337999719883, 11114.777704445865, 657146.0, 694334.0, 695709.0, 708995.0, 716697.0, 155519.0, 159140.0, 160340.96590341107, 160742.0, 160954.39045609627, 1086.266769930294, 1120.4061847220985, 1139.6751925701135, 1141.6517962021662, 1143.3082984794246, 15495.767563486783, 17597.29610815553, 18518.0, 18556.907215464376, 18968.71546926825, 57973.71013144907, 59447.10829337477, 60307.69846150741, 60875.391246088744, 60943.390566093774, 81497.0, 82408.58795705983, 83658.57559883242, 84169.5791521063, 84839.5758021206, 8875.644974200959, 10683.30558513694, 12187.695307617381, 12806.399200099988, 13104.868951310365, 12066.75866482683, 12694.746105078031, 14100.294985250492, 14160.079594826715, 14579.125252484884, 9315.72052838416, 11736.237144585915, 11986.880131198925, 12102.45538950767, 12114.091443141975, 8956.014838367644, 11221.943890280496, 11228.606998755004, 11270.478485404694, 11342.092632589209, 11844.881551184379, 12042.096842737004, 12078.094142939139, 12165.391730413621, 12262.754744904874, 12695.619131426072, 12703.36483175856, 13010.349482526026, 13088.0838341319, 13170.407331669907, 11689.298642081503, 11842.526298947945, 12048.096392770753, 12057.638270851889, 12071.0], "value": 10558.128580994693, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1363.2910886339102, 1431.4202747887102, 1447.4282658349946, 1452.9346179421925, 1461.5907545887148, 10281.794364112713, 10711.250212485129, 10713.732156696067, 10715.946420267906, 10720.517576709037, 10578.471076446185, 10891.564337426493, 10970.725731856688, 10991.450427478614, 11014.39420831854, 2043.5504189078379, 2151.6880052392394, 2420.854748715074, 2424.260600516842, 2477.665515155458, 1994.0, 2340.2862127051244, 2441.8412803167826, 2452.16626347042, 2459.0655550890638, 2090.6863970404484, 2348.1664009276715, 2448.681671382718, 2448.8285819992607, 2462.802975761944, 2422.1830358027423, 2441.1455990403306, 2451.0685939342934, 2455.8035357171384, 2465.457599328145, 2023.8785672859528, 2401.8799060046927, 2411.44536756547, 2431.3192306154306, 2433.7201221859536, 10684.145268378512, 10949.83575246372, 10951.123910087254, 10952.835707464394, 10955.0, 6173.845653858644, 6374.139491168679, 6381.266154392258, 6388.680565971729, 6403.391677790602, 3460.74044446665, 3872.9736619795776, 4037.2732908076537, 4084.65280451162, 4090.406891000788, 1121.6018313498753, 1156.832259322402, 1187.2223693480785, 1211.6667916322995, 1212.1454374665927, 15056.397744090224, 15085.24573771307, 15197.936144469892, 15206.543803685796, 15210.467633632881, 4324.675649326313, 5013.24801279811, 5246.108161612535, 5347.839564813062, 5371.731413429313, 11372.886271137348, 11374.488148033193, 11405.315681059163, 11406.973372396524, 11434.94282528582, 6024.216851809324, 6247.312795592481, 6260.593061450991, 6266.624002559861, 6268.435840774352, 5662.68855212959, 5773.278340207474, 5816.651000939957, 5879.970600146972, 5910.99513082777, 3507.824608769551, 4051.716379853441, 4165.687573431944, 4168.916621667549, 4217.0511634881905, 1230.9384530773425, 1245.1657389549023, 1254.084518301645, 1269.8285731426324, 1270.8093785932185, 584.9675323054812, 707.91505019398, 739.5784402890301, 751.8308380614318, 763.5151678684076, 5482.780688772405, 6396.648184349905, 6510.9023364649565, 6569.474442044625, 6641.103451034049, 574.7212601888081, 577.2207519848172, 600.495583709686, 605.1950905295946, 705.2418649951322, 3736.551613806361, 3903.082775547744, 4134.607212314825, 4295.548967358445, 4351.129774045204, 12941.54704585335, 13633.727325453436, 13635.38640761168, 13660.726785464236, 13679.794803077963, 13148.40832162555, 13377.33113344329, 13567.321633918265, 13681.589552313446, 13700.383482743102, 9780.119789219005, 10005.799884002425, 10129.797404052026, 10132.54403551842, 10266.691999240034, 6257.906131407942, 6518.087467754613, 6567.179102612174, 6704.363085506869, 6772.572329774918, 12225.755484890075, 12266.509339626315, 12292.631221063382, 12324.938375308066, 12426.689332766753, 12463.189892656948, 12603.054770892037, 12687.492500299884, 12713.55502557406, 12931.965442764744, 8151.959240203761, 8447.35276621053, 8617.396782225183, 8990.32572557074, 9059.184673379428, 10001.849972250568, 10211.23415743837, 10307.175425966054, 10315.742106447398, 10317.587296508056, 6468.417842394207, 7600.745876930245, 8596.742097737078, 8662.393632445668, 8710.651573937224, 8373.832523349622, 8463.111373305714, 8494.490330580185, 8585.012723536873, 8604.78488037779, 7585.886211706718, 7763.650635721519, 7774.378049755893, 7783.649735761791, 7787.377009839312, 4929.852104436729, 5622.381538030895, 5635.577331700057, 5737.483626473638, 5753.338366087954, 5207.3230480037355, 5827.621204621686, 5964.254468191476, 6038.818835434944, 6054.648517025219], "value": 5040.325115743465, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.88090929993103, 382.4721883800355, 392.23905623091207, 401.35382034923765, 413.43978908578896, 6070.6661133637635, 6085.939140608603, 6106.603070800395, 6113.663748493831, 6155.0, 5331.893362132755, 5534.169874518824, 5853.560982926277, 5866.149408335788, 5989.9517584422765, 4582.793774280165, 4594.2419500782335, 4601.585857272845, 4602.493725690171, 4613.884652883671, 4604.1482325769675, 4611.285250786117, 4627.6117164850575, 4633.9073218535605, 4649.256119020957, 3438.896833095011, 4196.943497686142, 4356.6514678825615, 4411.367793916255, 4603.677742558022, 3626.4016437287814, 4180.79096045198, 4353.62994145498, 4361.978190109029, 4392.714473559208, 3512.982435087834, 3674.393725035366, 3750.19370835269, 3787.8295476703615, 3794.696424286078, 5151.562117220041, 5601.159826026088, 5774.845030993776, 5794.304683437972, 5906.23218981534, 5216.869578260574, 5246.449122842123, 5263.526282634582, 5282.894342113174, 5284.075286824829, 6387.648679322635, 6393.392627700361, 6407.231132264112, 6412.0, 6416.00551914454, 4152.730072545275, 4255.063885945118, 4297.462817147856, 4301.419308393358, 4340.631046361063, 5850.297964244275, 6502.349765023507, 6656.7684978278685, 6665.567397680488, 6814.2845001274645, 3232.8383580820864, 4226.77423547174, 4232.238197124547, 4233.539428897026, 4242.512111107262, 4022.2759903217116, 4281.571842815756, 4305.677074219383, 4428.955710442919, 4440.711353761995, 3976.3696884277306, 4299.054208074219, 4877.707337559757, 5131.101492447743, 5184.7407629618365, 5266.97366513165, 5290.603204759658, 6087.421694938974, 6378.840528986812, 6399.264084630234, 1312.9015323850558, 1335.3790487423394, 1431.8782903453114, 1508.9698206035819, 1529.3806008566548, 977.750673578233, 991.1278075293695, 1010.661428421487, 1012.9797404051877, 1023.948802559869, 6013.6993150342305, 6052.697365131726, 6060.727267272983, 6089.208402907594, 6095.786647467317, 6613.173353330833, 6626.204855417381, 6635.388405058535, 6657.900131498031, 6659.667016649245, 5100.438951715382, 5523.812380338247, 5638.548916086703, 6036.547258955596, 6146.508279337642, 2779.652543432071, 3187.6971687689634, 3280.70473657372, 3311.2053107254087, 3409.7954122752712, 5669.546436285087, 5966.463018328372, 6246.843828904223, 6461.676916154173, 6783.287754785775, 6701.966490167518, 6852.211995620468, 6889.138857642794, 6900.0, 6936.4797640177185, 6561.3851258638515, 6740.730370785113, 6819.454443644497, 6832.931670683329, 6844.5208835382045, 6362.618242905441, 6565.474762019123, 6569.441597464269, 6576.309487503743, 6623.834404139935, 6458.967705161444, 6570.901436478361, 6581.605103693793, 6586.1438013058, 6603.174603174603, 5526.47498487643, 5974.312954010345, 6553.4101930826455, 6820.62486563224, 6884.65576721172, 4353.281708518059, 4385.693001489993, 4388.407564978687, 4400.3399490076745, 4406.955930440655, 6421.967890160519, 6729.014940592635, 6738.820706376463, 6745.9662701686175, 6765.830854228684, 4940.654154209315, 5462.481064298885, 5682.005649011324, 5953.987822070345, 6072.119542666377, 6482.254540727877, 6486.518891536644, 6492.675366231764, 6505.674716264073, 6507.642079685663, 5305.469453054664, 5906.0, 6020.939790602038, 6286.277078136073, 6328.936710633019, 6092.360302168208, 6414.967925160345, 6415.3263907289065, 6463.25672547663, 6470.255920569195, 6008.399160084132, 6233.81816364287, 6300.590461620163, 6306.527010474141, 6310.716017779303], "value": 4640.797868035088, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.2460791560945, 713.4292565947242, 727.3526561360394, 747.506645613895, 751.7932568543646, 15524.534263972071, 16420.261088251027, 16610.335586576537, 16624.750628740578, 17825.82174178258, 17600.471985840413, 17911.193996270165, 18036.0, 18169.7274540882, 18528.88826670401, 990.6730778842982, 1012.5848402155118, 1013.9645112421067, 1014.9949250253738, 1023.2990401574945, 984.601236499219, 1019.5819713917296, 1029.6447725534679, 1034.5965073621294, 1047.3611097230682, 1093.404094768349, 1093.9398333091676, 1100.1418893263267, 1104.7293413113798, 1107.197281970573, 1069.3423544520142, 1074.8925107489267, 1076.7200527862733, 1076.7469644633504, 1080.8865069167741, 711.6086152616041, 797.7925739307764, 802.2659266770897, 803.5821372886124, 808.7816289601775, 16599.83400165995, 16895.986240825467, 17018.659626807395, 17295.048772317517, 17504.299828006864, 14707.485238016618, 14884.181370024644, 14961.625959351104, 15051.247437628075, 15741.370345186178, 11400.486978085923, 11730.296182229093, 11824.704382390422, 11875.109366797438, 12002.279863208236, 2957.822530648168, 2996.161074899032, 3000.7599392048583, 3021.0483697635173, 3122.2194451387154, 90911.09088909092, 99575.0042499573, 100885.0, 101231.49384253031, 104129.0, 11477.483513241925, 11480.196386252883, 11536.826947595793, 11775.646730598095, 11993.820092698617, 23761.643575346385, 24064.278071657878, 24072.87963560206, 24103.758962410502, 24405.145819896574, 7967.960160199162, 8026.678932842621, 8041.597920103972, 8109.43233973628, 8155.918440815634, 4187.581241875788, 4212.7472351659, 4225.577442255812, 4268.146370725867, 4306.82772689089, 3557.839897204632, 4077.9796101019306, 4184.225918205142, 4186.162767446523, 4189.141226048653, 821.8068753842842, 850.0, 852.7441767469734, 856.1010938514535, 886.5611522296505, 541.8320320700595, 560.4255637971031, 581.9388964158787, 583.2388732703862, 600.9477633880338, 7871.842563148705, 9811.0, 9886.703398898044, 10249.590016399261, 10621.787564248672, 545.4490964126181, 573.5698226330252, 581.825452364289, 604.1873679900526, 608.3612207182441, 4685.648576356787, 4808.35087263215, 4845.491223421561, 4847.175980083394, 4864.0, 105627.0, 105724.0, 107436.0, 107576.4621176889, 109862.0, 59662.403375966554, 66286.66856665783, 88596.0, 89182.0, 93082.0, 73707.2629273711, 73726.63136684282, 73968.63015684887, 74207.25792742112, 74430.62784686041, 9819.803603928025, 10086.495675216356, 10590.258681892194, 10616.787664246518, 10759.946200268949, 34805.9558213254, 34894.0, 35065.824670876485, 35255.82372088226, 35442.0, 48053.03893922172, 48451.0, 48660.75669621629, 48864.75567622281, 48963.75518122387, 13183.604491865259, 13258.933705331412, 13728.313584320544, 13806.240656763573, 13969.790453143009, 14343.687524244124, 14563.635909102357, 14569.0, 14618.85381146175, 14887.851121488646, 13595.53795615386, 13667.455409516519, 13696.246706431242, 13710.24593647359, 14251.429942802171, 13347.332633368487, 13566.796498052734, 13662.248576328397, 13710.931445343109, 14265.786013209603, 11338.716532086764, 12904.16122952005, 12908.644592318047, 13038.175874926337, 13183.868161318263, 9563.665271715456, 9805.0, 9893.604255829687, 9957.850632240377, 10511.526981285708, 7558.093028836574, 9530.95234523823, 9596.280278978966, 11073.0, 11514.712132196762], "value": 7601.001693160691, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1581.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 122.0, 121.0, 121.0, 120.0, 125.0, 123.0, 123.0, 123.0, 124.0], "value": 121.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 121.0, 120.0, 162.0, 117.0, 120.0, 121.0, 117.0, 144.0, 115.0], "value": 129.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [293.0, 281.0, 221.0, 209.0, 217.0, 214.0, 208.0, 212.0, 211.0, 219.0], "value": 228.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 63.0, 65.0, 96.0, 66.0, 66.0, 62.0, 63.0, 83.0, 65.0], "value": 71.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 74.0, 97.0, 74.0, 75.0, 76.0, 93.0, 73.0, 75.0, 92.0], "value": 82.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 90.0, 90.0, 91.0, 91.0, 92.0, 91.0, 92.0, 91.0], "value": 91.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 97.0, 100.0, 100.0, 97.0, 98.0, 99.0, 99.0, 98.0, 98.0], "value": 98.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 100.0, 100.0, 98.0, 100.0, 97.0, 100.0, 102.0, 102.0, 101.0], "value": 100.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 50.0, 51.0, 51.0, 50.0, 53.0, 53.0, 52.0, 53.0], "value": 51.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 73.0, 70.0, 67.0, 66.0, 64.0, 64.0, 64.0, 64.0, 64.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 89.0, 92.0, 92.0, 93.0, 89.0, 110.0, 88.0, 89.0], "value": 92.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 150.0, 148.0, 165.0, 167.0, 173.0, 169.0, 168.0, 227.0, 163.0], "value": 168.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 237.0, 260.0, 203.0, 197.0, 197.0, 201.0, 201.0, 196.0, 197.0], "value": 208.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 72.0, 75.0, 73.0, 73.0, 72.0, 73.0, 75.0, 72.0], "value": 73.2, "unit": "score"}]}]} 05:03:46 INFO - Return code: 0 05:03:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:03:46 ERROR - # TBPL SUCCESS # 05:03:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:03:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:03:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:03:46 INFO - 2017-04-02 05:03:46.448 screenresolution[1700:17296] starting screenresolution argv=screenresolution get 05:03:46 INFO - 2017-04-02 05:03:46.451 screenresolution[1700:17296] Display 0: 1600x1200x32@60 05:03:46 INFO - 2017-04-02 05:03:46.457 screenresolution[1701:17299] starting screenresolution argv=screenresolution list 05:03:46 INFO - Available Modes on Display 0 05:03:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:03:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:03:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:03:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:03:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:03:46 INFO - Intel Iris: 05:03:46 INFO - Chipset Model: Intel Iris 05:03:46 INFO - Type: GPU 05:03:46 INFO - Bus: Built-In 05:03:46 INFO - VRAM (Dynamic, Max): 1536 MB 05:03:46 INFO - Vendor: Intel (0x8086) 05:03:46 INFO - Device ID: 0x0a2e 05:03:46 INFO - Revision ID: 0x0009 05:03:46 INFO - Displays: 05:03:46 INFO - Display: 05:03:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:03:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:03:46 INFO - Display Serial Number: 1600x1200 60 05:03:46 INFO - Main Display: Yes 05:03:46 INFO - Mirror: Off 05:03:46 INFO - Online: Yes 05:03:46 INFO - Rotation: Supported 05:03:46 INFO - Return code: 0 05:03:46 INFO - Running post-action listener: _resource_record_post_action 05:03:46 INFO - [mozharness: 2017-04-02 12:03:46.696238Z] Finished run-tests step (success) 05:03:46 INFO - Running post-run listener: _resource_record_post_run 05:03:46 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 32816128; Write bytes: 517878272; Read time: 198; Write time: 1592 05:03:46 INFO - TinderboxPrint: CPU usage
53.4% 05:03:46 INFO - TinderboxPrint: I/O read bytes / time
32,816,128 / 198 05:03:46 INFO - TinderboxPrint: I/O write bytes / time
517,878,272 / 1,592 05:03:46 INFO - TinderboxPrint: CPU idle
2,246.9 (46.6%) 05:03:46 INFO - TinderboxPrint: CPU system
964.4 (20.0%) 05:03:46 INFO - TinderboxPrint: CPU user
1,614.4 (33.5%) 05:03:46 INFO - TinderboxPrint: Swap in / out
240,017,408 / 0 05:03:46 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207294976; Write bytes: 204101120; Read time: 15654; Write time: 433 05:03:46 INFO - run-tests - Wall time: 1187s; CPU: 53.0%; Read bytes: 30854144; Write bytes: 302922752; Read time: 180; Write time: 1123 05:03:47 INFO - Running post-run listener: _upload_blobber_files 05:03:47 INFO - Blob upload gear active. 05:03:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:03:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:03:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:03:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:03:47 INFO - (blobuploader) - INFO - Open directory for files ... 05:03:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:03:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:03:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:49 INFO - (blobuploader) - INFO - Done attempting. 05:03:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:03:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:03:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:50 INFO - (blobuploader) - INFO - Done attempting. 05:03:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:03:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:03:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:51 INFO - (blobuploader) - INFO - Done attempting. 05:03:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:03:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:03:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:52 INFO - (blobuploader) - INFO - Done attempting. 05:03:52 INFO - (blobuploader) - INFO - Iteration through files over. 05:03:52 INFO - Return code: 0 05:03:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:03:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:03:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/907bd54d165961dd7367061cd2ca2ca29d53e5c20502063d14556359b59a72bb0803eb74c284f9ddc83da074e52a879aa31a1eecfa0d95557873b32618bee1c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fca86566a9324ec421832619f55920f66c8f51c75c71a645234c8d8d43b0693e5bd3665c1a2c9bee0964eecc24157de58d9b13474814cf627ff3e6c2bb1bf37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd5c2b32e87f51d24ea4732089eb28e4cbaf8c57ea23ddd353e5431237ed9d654faf5309d9de4206f7465e305cbd8ba3ba11bc9d1260bb8e783e299e9d1d5908", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21464b81989bf379b210c6feec5d0f8821bc221ab8912b755d4070d542f9cd4269018bc983b55e07c7a7a9217b79587cc720cb259a64b0df7338def8fb49be11"} 05:03:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:03:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:03:52 INFO - Contents: 05:03:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/907bd54d165961dd7367061cd2ca2ca29d53e5c20502063d14556359b59a72bb0803eb74c284f9ddc83da074e52a879aa31a1eecfa0d95557873b32618bee1c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fca86566a9324ec421832619f55920f66c8f51c75c71a645234c8d8d43b0693e5bd3665c1a2c9bee0964eecc24157de58d9b13474814cf627ff3e6c2bb1bf37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd5c2b32e87f51d24ea4732089eb28e4cbaf8c57ea23ddd353e5431237ed9d654faf5309d9de4206f7465e305cbd8ba3ba11bc9d1260bb8e783e299e9d1d5908", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21464b81989bf379b210c6feec5d0f8821bc221ab8912b755d4070d542f9cd4269018bc983b55e07c7a7a9217b79587cc720cb259a64b0df7338def8fb49be11"} 05:03:52 INFO - Running post-run listener: copy_logs_to_upload_dir 05:03:52 INFO - Copying logs to upload dir... 05:03:52 INFO - mkdir: /builds/slave/test/build/upload/logs 05:03:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1300.942930 ========= master_lag: -0.02 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 40 secs) (at 2017-04-02 05:03:53.033632) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-02 05:03:53.037583) ========= 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.kRBiHTOvmh/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.tmTBlZQNIe/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/907bd54d165961dd7367061cd2ca2ca29d53e5c20502063d14556359b59a72bb0803eb74c284f9ddc83da074e52a879aa31a1eecfa0d95557873b32618bee1c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fca86566a9324ec421832619f55920f66c8f51c75c71a645234c8d8d43b0693e5bd3665c1a2c9bee0964eecc24157de58d9b13474814cf627ff3e6c2bb1bf37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd5c2b32e87f51d24ea4732089eb28e4cbaf8c57ea23ddd353e5431237ed9d654faf5309d9de4206f7465e305cbd8ba3ba11bc9d1260bb8e783e299e9d1d5908", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21464b81989bf379b210c6feec5d0f8821bc221ab8912b755d4070d542f9cd4269018bc983b55e07c7a7a9217b79587cc720cb259a64b0df7338def8fb49be11"} build_url:https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011046 build_url: 'https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/907bd54d165961dd7367061cd2ca2ca29d53e5c20502063d14556359b59a72bb0803eb74c284f9ddc83da074e52a879aa31a1eecfa0d95557873b32618bee1c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fca86566a9324ec421832619f55920f66c8f51c75c71a645234c8d8d43b0693e5bd3665c1a2c9bee0964eecc24157de58d9b13474814cf627ff3e6c2bb1bf37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd5c2b32e87f51d24ea4732089eb28e4cbaf8c57ea23ddd353e5431237ed9d654faf5309d9de4206f7465e305cbd8ba3ba11bc9d1260bb8e783e299e9d1d5908", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21464b81989bf379b210c6feec5d0f8821bc221ab8912b755d4070d542f9cd4269018bc983b55e07c7a7a9217b79587cc720cb259a64b0df7338def8fb49be11"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-02 05:03:53.073528) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 05:03:53.073942) ========= 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.kRBiHTOvmh/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.tmTBlZQNIe/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005072 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 05:03:53.123041) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-02 05:03:53.123362) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-02 05:03:53.123693) ========= ========= Total master_lag: 0.12 =========