builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0270 starttime: 1493723584.44 results: success (0) buildid: 20170502020321 builduid: 39e11a909a6f4ff98df74d0e75f5e9f4 revision: a812a96caba20dea7bc3815b71b4784afc6b864b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-02 04:13:04.445226) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-02 04:13:04.445903) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-02 04:13:04.446332) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-02 04:13:04.473816) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 04:13:04.474247) ========= 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.gM5us60eHv/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.odg8H5uu3h/Listeners TMPDIR=/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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-05-02 04:13:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2017-05-02 04:13:04 (159 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128524 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 04:13:04.629524) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 04:13:04.630068) ========= 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.gM5us60eHv/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.odg8H5uu3h/Listeners TMPDIR=/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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.021476 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 04:13:04.679967) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-05-02 04:13:04.680328) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a812a96caba20dea7bc3815b71b4784afc6b864b --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 a812a96caba20dea7bc3815b71b4784afc6b864b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gM5us60eHv/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.odg8H5uu3h/Listeners TMPDIR=/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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-05-02 04:13:04,764 truncating revision to first 12 chars 2017-05-02 04:13:04,764 Setting DEBUG logging. 2017-05-02 04:13:04,764 attempt 1/10 2017-05-02 04:13:04,764 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a812a96caba2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-02 04:13:06,846 unpacking tar archive at: mozilla-central-a812a96caba2/testing/mozharness/ program finished with exit code 0 elapsedTime=2.349972 ========= master_lag: 0.68 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-05-02 04:13:07.709584) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-02 04:13:07.709940) ========= script_repo_revision: a812a96caba20dea7bc3815b71b4784afc6b864b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-02 04:13:07.710340) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-02 04:13:07.710599) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-02 04:13:08.142965) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-05-02 04:13:08.143410) ========= /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.gM5us60eHv/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.odg8H5uu3h/Listeners TMPDIR=/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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:13:08 INFO - MultiFileLogger online at 20170502 04:13:08 in /builds/slave/test 04:13:08 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:13:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:13:08 INFO - {'append_to_log': False, 04:13:08 INFO - 'base_work_dir': '/builds/slave/test', 04:13:08 INFO - 'blob_upload_branch': 'Firefox', 04:13:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:13:08 INFO - 'branch': 'Firefox', 04:13:08 INFO - 'buildbot_json_path': 'buildprops.json', 04:13:08 INFO - 'config_files': ('talos/mac_config.py',), 04:13:08 INFO - 'default_actions': ('clobber', 04:13:08 INFO - 'read-buildbot-config', 04:13:08 INFO - 'download-and-extract', 04:13:08 INFO - 'populate-webroot', 04:13:08 INFO - 'create-virtualenv', 04:13:08 INFO - 'install', 04:13:08 INFO - 'run-tests'), 04:13:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:13:08 INFO - 'download_minidump_stackwalk': True, 04:13:08 INFO - 'download_symbols': 'ondemand', 04:13:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:13:08 INFO - 'tooltool.py': '/tools/tooltool.py', 04:13:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:13:08 INFO - '/tools/misc-python/virtualenv.py')}, 04:13:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:13:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:13:08 INFO - 'gecko_profile': False, 04:13:08 INFO - 'gecko_profile_interval': 0, 04:13:08 INFO - 'installer_path': 'installer.exe', 04:13:08 INFO - 'log_level': 'info', 04:13:08 INFO - 'log_name': 'talos', 04:13:08 INFO - 'log_to_console': True, 04:13:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:13:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:13:08 INFO - 'opt_config_files': (), 04:13:08 INFO - 'pip_index': False, 04:13:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:13:08 INFO - 'cmd': ('bash', 04:13:08 INFO - '-c', 04:13:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:13:08 INFO - 'enabled': True, 04:13:08 INFO - 'halt_on_failure': False, 04:13:08 INFO - 'name': 'check_screen_resolution'},), 04:13:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:13:08 INFO - 'cmd': ('bash', 04:13:08 INFO - '-c', 04:13:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:13:08 INFO - 'enabled': True, 04:13:08 INFO - 'halt_on_failure': False, 04:13:08 INFO - 'name': 'check_screen_resolution'},), 04:13:08 INFO - 'run_cmd_checks_enabled': True, 04:13:08 INFO - 'suite': 'dromaeojs', 04:13:08 INFO - 'system_bits': '32', 04:13:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:13:08 INFO - 'title': 't-yosemite-r7-0270', 04:13:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:13:08 INFO - 'use_talos_json': True, 04:13:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:13:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:13:08 INFO - 'work_dir': 'build'} 04:13:08 INFO - [mozharness: 2017-05-02 11:13:08.350474Z] Running clobber step. 04:13:08 INFO - Running pre-action listener: _resource_record_pre_action 04:13:08 INFO - Running main action method: clobber 04:13:08 INFO - rmtree: /builds/slave/test/build 04:13:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:13:11 INFO - Running post-action listener: _resource_record_post_action 04:13:11 INFO - [mozharness: 2017-05-02 11:13:11.622826Z] Finished clobber step (success) 04:13:11 INFO - [mozharness: 2017-05-02 11:13:11.623089Z] Running read-buildbot-config step. 04:13:11 INFO - Running pre-action listener: _resource_record_pre_action 04:13:11 INFO - Running main action method: read_buildbot_config 04:13:11 INFO - Using buildbot properties: 04:13:11 INFO - { 04:13:11 INFO - "project": "", 04:13:11 INFO - "product": "firefox", 04:13:11 INFO - "script_repo_revision": "production", 04:13:11 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:13:11 INFO - "repository": "", 04:13:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:13:11 INFO - "buildid": "20170502020321", 04:13:11 INFO - "pgo_build": "False", 04:13:11 INFO - "basedir": "/builds/slave/test", 04:13:11 INFO - "buildnumber": 45, 04:13:11 INFO - "slavename": "t-yosemite-r7-0270", 04:13:11 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 04:13:11 INFO - "platform": "yosemite_r7", 04:13:11 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:13:11 INFO - "branch": "mozilla-central", 04:13:11 INFO - "repo_path": "mozilla-central", 04:13:11 INFO - "revision": "a812a96caba20dea7bc3815b71b4784afc6b864b", 04:13:11 INFO - "stage_platform": "macosx64", 04:13:11 INFO - "builduid": "39e11a909a6f4ff98df74d0e75f5e9f4", 04:13:11 INFO - "slavebuilddir": "test" 04:13:11 INFO - } 04:13:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:13:11 INFO - Running post-action listener: _resource_record_post_action 04:13:11 INFO - [mozharness: 2017-05-02 11:13:11.628736Z] Finished read-buildbot-config step (success) 04:13:11 INFO - [mozharness: 2017-05-02 11:13:11.628961Z] Running download-and-extract step. 04:13:11 INFO - Running pre-action listener: _resource_record_pre_action 04:13:11 INFO - Running main action method: download_and_extract 04:13:11 INFO - mkdir: /builds/slave/test/build/tests 04:13:11 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:13:11 INFO - trying https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:13:11 INFO - Downloading https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/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:13:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/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:13:12 INFO - Downloaded 1325 bytes. 04:13:12 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:13:12 INFO - Using the following test package requirements: 04:13:12 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:13:12 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:13:12 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:13:12 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:13:12 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:13:12 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:13:12 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:13:12 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:13:12 INFO - u'jsshell-mac.zip'], 04:13:12 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:13:12 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:13:12 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:13:12 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:13:12 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:13:12 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:13:12 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:13:12 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:13:12 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:13:12 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:13:12 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:13:12 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:13:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:13:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:13:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:13:14 INFO - Content-Length response header: 52699764 04:13:14 INFO - Bytes received: 52699764 04:13:30 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:13:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:13:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:13:30 INFO - Fetch https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:13:32 INFO - Content-Length response header: 52699764 04:13:32 INFO - Bytes received: 52699764 04:13:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:13:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:13:48 INFO - Fetch https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:13:49 INFO - Content-Length response header: 14408811 04:13:49 INFO - Bytes received: 14408811 04:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:49 INFO - trying https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:13:49 INFO - Downloading https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:13:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/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:13:51 INFO - Downloaded 71248184 bytes. 04:13:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:13:51 INFO - mkdir: /builds/slave/test/properties 04:13:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:13:51 INFO - Writing to file /builds/slave/test/properties/build_url 04:13:51 INFO - Contents: 04:13:51 INFO - build_url:https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:13:52 INFO - Running post-action listener: _resource_record_post_action 04:13:52 INFO - Running post-action listener: set_extra_try_arguments 04:13:52 INFO - [mozharness: 2017-05-02 11:13:52.259691Z] Finished download-and-extract step (success) 04:13:52 INFO - [mozharness: 2017-05-02 11:13:52.259810Z] Running populate-webroot step. 04:13:52 INFO - Running pre-action listener: _resource_record_pre_action 04:13:52 INFO - Running main action method: populate_webroot 04:13:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:13:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:13:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:13:52 INFO - '--tppagecycles', 04:13:52 INFO - '7'], 04:13:52 INFO - 'tests': ['tsvgm']}}, 04:13:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:13:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:13:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:13:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:13:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:13:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:13:52 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:13:52 INFO - 'talos_options': ['--disable-e10s'], 04:13:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:13:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:52 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:13:52 INFO - 'talos_options': ['--disable-e10s'], 04:13:52 INFO - 'tests': ['damp', 'tps']}, 04:13:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:13:52 INFO - 'tests': ['damp', 'tps']}, 04:13:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:13:52 INFO - 'tests': ['dromaeo_dom']}, 04:13:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:13:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:13:52 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:13:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:13:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:13:52 INFO - 'tests': ['a11yr', 04:13:52 INFO - 'ts_paint', 04:13:52 INFO - 'tpaint', 04:13:52 INFO - 'sessionrestore', 04:13:52 INFO - 'sessionrestore_no_auto_restore', 04:13:52 INFO - 'tabpaint']}, 04:13:52 INFO - 'other-e10s': {'tests': ['a11yr', 04:13:52 INFO - 'ts_paint', 04:13:52 INFO - 'tpaint', 04:13:52 INFO - 'sessionrestore', 04:13:52 INFO - 'sessionrestore_no_auto_restore', 04:13:52 INFO - 'tabpaint']}, 04:13:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:13:52 INFO - 'ts_paint', 04:13:52 INFO - 'tpaint', 04:13:52 INFO - 'sessionrestore', 04:13:52 INFO - 'sessionrestore_no_auto_restore', 04:13:52 INFO - 'tabpaint']}, 04:13:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:13:52 INFO - 'ts_paint', 04:13:52 INFO - 'tpaint', 04:13:52 INFO - 'sessionrestore', 04:13:52 INFO - 'sessionrestore_no_auto_restore', 04:13:52 INFO - 'tabpaint']}, 04:13:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:13:52 INFO - 'tests': ['a11yr', 04:13:52 INFO - 'ts_paint', 04:13:52 INFO - 'tpaint', 04:13:52 INFO - 'sessionrestore', 04:13:52 INFO - 'sessionrestore_no_auto_restore', 04:13:52 INFO - 'tabpaint']}, 04:13:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:13:52 INFO - 'tests': ['a11yr', 04:13:52 INFO - 'ts_paint', 04:13:52 INFO - 'tpaint', 04:13:52 INFO - 'sessionrestore', 04:13:52 INFO - 'sessionrestore_no_auto_restore', 04:13:52 INFO - 'tabpaint']}, 04:13:52 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:13:52 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:13:52 INFO - 'bloom_basic_ref']}, 04:13:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:13:52 INFO - 'tests': ['tsvgx', 04:13:52 INFO - 'tsvgr_opacity', 04:13:52 INFO - 'tart', 04:13:52 INFO - 'tscrollx', 04:13:52 INFO - 'cart', 04:13:52 INFO - 'tsvg_static']}, 04:13:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:13:52 INFO - 'tsvgr_opacity', 04:13:52 INFO - 'tart', 04:13:52 INFO - 'tscrollx', 04:13:52 INFO - 'cart', 04:13:52 INFO - 'tsvg_static']}, 04:13:52 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:13:52 INFO - 'talos_options': ['--disable-e10s'], 04:13:52 INFO - 'tests': ['tp5o']}, 04:13:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:13:52 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:13:52 INFO - 'talos_options': ['--disable-e10s', 04:13:52 INFO - '--xperf_path', 04:13:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:52 INFO - 'tests': ['tp5n']}, 04:13:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:13:52 INFO - 'talos_options': ['--xperf_path', 04:13:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:52 INFO - 'tests': ['tp5n']}}, 04:13:52 INFO - 'talos.zip': {'path': '', 04:13:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:13:52 INFO - Running post-action listener: _resource_record_post_action 04:13:52 INFO - [mozharness: 2017-05-02 11:13:52.279134Z] Finished populate-webroot step (success) 04:13:52 INFO - [mozharness: 2017-05-02 11:13:52.279276Z] Running create-virtualenv step. 04:13:52 INFO - Running pre-action listener: _resource_record_pre_action 04:13:52 INFO - Running main action method: create_virtualenv 04:13:52 INFO - Creating virtualenv /builds/slave/test/build/venv 04:13:52 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:13:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:13:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:13:52 INFO - Using real prefix '/tools/python27' 04:13:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:13:53 INFO - Installing distribute.............................................................................................................................................................................................done. 04:13:56 INFO - Installing pip.................done. 04:13:56 INFO - Return code: 0 04:13:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:13:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:13:56 INFO - Reading from file tmpfile_stdout 04:13:56 INFO - Output received: 04:13:56 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:13:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d5a6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5a9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc373565f00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d384d30>, '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 0x10d2aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d379be8>, '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.gM5us60eHv/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.odg8H5uu3h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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:13:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:13:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:13:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gM5us60eHv/Render', 04:13:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:13:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:13:56 INFO - 'HOME': '/Users/cltbld', 04:13:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:13:56 INFO - 'LOGNAME': 'cltbld', 04:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:56 INFO - 'MOZ_NO_REMOTE': '1', 04:13:56 INFO - 'NO_EM_RESTART': '1', 04:13:56 INFO - 'PAGER': '/bin/cat', 04:13:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:56 INFO - 'PWD': '/builds/slave/test', 04:13:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:13:56 INFO - 'SHELL': '/bin/bash', 04:13:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.odg8H5uu3h/Listeners', 04:13:56 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 04:13:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:13:56 INFO - 'USER': 'cltbld', 04:13:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:13:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:56 INFO - 'XPC_FLAGS': '0x0', 04:13:56 INFO - 'XPC_SERVICE_NAME': '0', 04:13:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:56 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:13:56 INFO - Cleaning up... 04:13:56 INFO - Return code: 0 04:13:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d5a6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5a9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc373565f00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d384d30>, '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 0x10d2aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d379be8>, '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.gM5us60eHv/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.odg8H5uu3h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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:13:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:13:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:13:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gM5us60eHv/Render', 04:13:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:13:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:13:56 INFO - 'HOME': '/Users/cltbld', 04:13:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:13:56 INFO - 'LOGNAME': 'cltbld', 04:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:56 INFO - 'MOZ_NO_REMOTE': '1', 04:13:56 INFO - 'NO_EM_RESTART': '1', 04:13:56 INFO - 'PAGER': '/bin/cat', 04:13:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:56 INFO - 'PWD': '/builds/slave/test', 04:13:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:13:56 INFO - 'SHELL': '/bin/bash', 04:13:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.odg8H5uu3h/Listeners', 04:13:56 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 04:13:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:13:56 INFO - 'USER': 'cltbld', 04:13:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:13:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:56 INFO - 'XPC_FLAGS': '0x0', 04:13:56 INFO - 'XPC_SERVICE_NAME': '0', 04:13:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:56 INFO - Downloading/unpacking psutil>=3.1.1 04:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:14:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:00 INFO - Installing collected packages: psutil 04:14:00 INFO - Running setup.py install for psutil 04:14:00 INFO - building 'psutil._psutil_osx' extension 04:14:00 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:14:00 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:14:00 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:14:01 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:14:01 INFO - building 'psutil._psutil_posix' extension 04:14:01 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:14:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:14:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:14:01 INFO - ^ 04:14:01 INFO - 1 warning generated. 04:14:01 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:14:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:01 INFO - Successfully installed psutil 04:14:01 INFO - Cleaning up... 04:14:01 INFO - Return code: 0 04:14:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:14:01 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:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:01 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:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:02 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 0x10d5a6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5a9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc373565f00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d384d30>, '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 0x10d2aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d379be8>, '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.gM5us60eHv/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.odg8H5uu3h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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:14:02 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:14:02 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:14:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gM5us60eHv/Render', 04:14:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:02 INFO - 'HOME': '/Users/cltbld', 04:14:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:02 INFO - 'LOGNAME': 'cltbld', 04:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:02 INFO - 'MOZ_NO_REMOTE': '1', 04:14:02 INFO - 'NO_EM_RESTART': '1', 04:14:02 INFO - 'PAGER': '/bin/cat', 04:14:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:02 INFO - 'PWD': '/builds/slave/test', 04:14:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:02 INFO - 'SHELL': '/bin/bash', 04:14:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.odg8H5uu3h/Listeners', 04:14:02 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 04:14:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:02 INFO - 'USER': 'cltbld', 04:14:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:02 INFO - 'XPC_FLAGS': '0x0', 04:14:02 INFO - 'XPC_SERVICE_NAME': '0', 04:14:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:14:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:14:05 INFO - Installing collected packages: mozsystemmonitor 04:14:05 INFO - Running setup.py install for mozsystemmonitor 04:14:05 INFO - Successfully installed mozsystemmonitor 04:14:05 INFO - Cleaning up... 04:14:06 INFO - Return code: 0 04:14:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:14:06 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:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:06 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:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:06 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 0x10d5a6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5a9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc373565f00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d384d30>, '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 0x10d2aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d379be8>, '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.gM5us60eHv/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.odg8H5uu3h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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:14:06 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:14:06 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:14:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gM5us60eHv/Render', 04:14:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:06 INFO - 'HOME': '/Users/cltbld', 04:14:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:06 INFO - 'LOGNAME': 'cltbld', 04:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:06 INFO - 'MOZ_NO_REMOTE': '1', 04:14:06 INFO - 'NO_EM_RESTART': '1', 04:14:06 INFO - 'PAGER': '/bin/cat', 04:14:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:06 INFO - 'PWD': '/builds/slave/test', 04:14:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:06 INFO - 'SHELL': '/bin/bash', 04:14:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.odg8H5uu3h/Listeners', 04:14:06 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 04:14:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:06 INFO - 'USER': 'cltbld', 04:14:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:06 INFO - 'XPC_FLAGS': '0x0', 04:14:06 INFO - 'XPC_SERVICE_NAME': '0', 04:14:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:06 INFO - Downloading/unpacking jsonschema==2.5.1 04:14: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:14: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:14: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:14: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:14: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:14: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:14:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:14:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:09 INFO - Downloading functools32-3.2.3-2.tar.gz 04:14:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:14:09 INFO - warning: no files found matching '*.txt' 04:14:09 INFO - no previously-included directories found matching 'build' 04:14:09 INFO - no previously-included directories found matching 'dist' 04:14:09 INFO - no previously-included directories found matching '.git*' 04:14:09 INFO - Installing collected packages: jsonschema, functools32 04:14:09 INFO - Running setup.py install for functools32 04:14:09 INFO - warning: no files found matching '*.txt' 04:14:09 INFO - no previously-included directories found matching 'build' 04:14:09 INFO - no previously-included directories found matching 'dist' 04:14:09 INFO - no previously-included directories found matching '.git*' 04:14:09 INFO - Successfully installed jsonschema functools32 04:14:09 INFO - Cleaning up... 04:14:09 INFO - Return code: 0 04:14:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d5a6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5a9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc373565f00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d384d30>, '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 0x10d2aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d379be8>, '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.gM5us60eHv/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.odg8H5uu3h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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:14:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:14:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gM5us60eHv/Render', 04:14:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:09 INFO - 'HOME': '/Users/cltbld', 04:14:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:09 INFO - 'LOGNAME': 'cltbld', 04:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:09 INFO - 'MOZ_NO_REMOTE': '1', 04:14:09 INFO - 'NO_EM_RESTART': '1', 04:14:09 INFO - 'PAGER': '/bin/cat', 04:14:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:09 INFO - 'PWD': '/builds/slave/test', 04:14:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:09 INFO - 'SHELL': '/bin/bash', 04:14:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.odg8H5uu3h/Listeners', 04:14:09 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 04:14:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:09 INFO - 'USER': 'cltbld', 04:14:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:09 INFO - 'XPC_FLAGS': '0x0', 04:14:09 INFO - 'XPC_SERVICE_NAME': '0', 04:14:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:14:09 INFO - Cleaning up... 04:14:09 INFO - Return code: 0 04:14:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d5a6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5a9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc373565f00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d384d30>, '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 0x10d2aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d379be8>, '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.gM5us60eHv/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.odg8H5uu3h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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:14:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:14:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gM5us60eHv/Render', 04:14:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:09 INFO - 'HOME': '/Users/cltbld', 04:14:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:09 INFO - 'LOGNAME': 'cltbld', 04:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:09 INFO - 'MOZ_NO_REMOTE': '1', 04:14:09 INFO - 'NO_EM_RESTART': '1', 04:14:09 INFO - 'PAGER': '/bin/cat', 04:14:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:09 INFO - 'PWD': '/builds/slave/test', 04:14:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:09 INFO - 'SHELL': '/bin/bash', 04:14:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.odg8H5uu3h/Listeners', 04:14:09 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 04:14:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:09 INFO - 'USER': 'cltbld', 04:14:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:09 INFO - 'XPC_FLAGS': '0x0', 04:14:09 INFO - 'XPC_SERVICE_NAME': '0', 04:14:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:10 INFO - Downloading/unpacking blobuploader==1.2.4 04:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:12 INFO - Downloading blobuploader-1.2.4.tar.gz 04:14:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:14:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:14:12 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:14:12 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:14:12 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:14:12 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:14:12 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:14:12 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:14:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:14:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:14: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:14: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:14: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:14: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:14: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:14: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:14:14 INFO - Downloading docopt-0.6.1.tar.gz 04:14:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:14:14 INFO - Installing collected packages: blobuploader, requests, docopt 04:14:14 INFO - Running setup.py install for blobuploader 04:14:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:14:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:14:14 INFO - Running setup.py install for requests 04:14:15 INFO - Running setup.py install for docopt 04:14:15 INFO - Successfully installed blobuploader requests docopt 04:14:15 INFO - Cleaning up... 04:14:15 INFO - Return code: 0 04:14:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:15 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:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:15 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:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:15 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 0x10d5a6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5a9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc373565f00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d384d30>, '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 0x10d2aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d379be8>, '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.gM5us60eHv/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.odg8H5uu3h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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:14:15 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:14:15 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:14:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gM5us60eHv/Render', 04:14:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:15 INFO - 'HOME': '/Users/cltbld', 04:14:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:15 INFO - 'LOGNAME': 'cltbld', 04:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:15 INFO - 'MOZ_NO_REMOTE': '1', 04:14:15 INFO - 'NO_EM_RESTART': '1', 04:14:15 INFO - 'PAGER': '/bin/cat', 04:14:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:15 INFO - 'PWD': '/builds/slave/test', 04:14:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:15 INFO - 'SHELL': '/bin/bash', 04:14:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.odg8H5uu3h/Listeners', 04:14:15 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 04:14:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:15 INFO - 'USER': 'cltbld', 04:14:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:15 INFO - 'XPC_FLAGS': '0x0', 04:14:15 INFO - 'XPC_SERVICE_NAME': '0', 04:14:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:15 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-GrwzwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:15 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-GuV2Ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:15 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-OPTXxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:15 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-HC9wM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:15 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-zZcDv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:16 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-O3hqCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:16 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-gaiPuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:16 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-q2Z1YR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:16 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-ES_efv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:16 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-FbBHdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:16 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-bjZBWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:16 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-sBSzUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:16 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-_Bk3Aa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:16 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-T1LmOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:16 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-E8NAGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:17 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-Ekbjry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:17 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-sPFTGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:14:17 INFO - Running setup.py install for manifestparser 04:14:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:14:17 INFO - Running setup.py install for mozcrash 04:14:17 INFO - Running setup.py install for mozdebug 04:14:17 INFO - Running setup.py install for mozdevice 04:14:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:14:17 INFO - Running setup.py install for mozfile 04:14:18 INFO - Running setup.py install for mozhttpd 04:14:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:14:18 INFO - Running setup.py install for mozinfo 04:14:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:14:18 INFO - Running setup.py install for mozInstall 04:14:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:14:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:14:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:14:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:14:18 INFO - Running setup.py install for mozleak 04:14:18 INFO - Running setup.py install for mozlog 04:14:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:14:18 INFO - Running setup.py install for moznetwork 04:14:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:14:18 INFO - Running setup.py install for mozprocess 04:14:19 INFO - Running setup.py install for mozprofile 04:14:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:14:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:14:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:14:19 INFO - Running setup.py install for mozrunner 04:14:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:14:19 INFO - Running setup.py install for mozscreenshot 04:14:19 INFO - Running setup.py install for moztest 04:14:19 INFO - Running setup.py install for mozversion 04:14:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:14:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:14:19 INFO - Cleaning up... 04:14:19 INFO - Return code: 0 04:14:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:19 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 0x10d5a6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5a9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc373565f00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d384d30>, '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 0x10d2aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d379be8>, '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.gM5us60eHv/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.odg8H5uu3h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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:14:19 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:14:19 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:14:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gM5us60eHv/Render', 04:14:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:19 INFO - 'HOME': '/Users/cltbld', 04:14:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:19 INFO - 'LOGNAME': 'cltbld', 04:14:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:19 INFO - 'MOZ_NO_REMOTE': '1', 04:14:19 INFO - 'NO_EM_RESTART': '1', 04:14:19 INFO - 'PAGER': '/bin/cat', 04:14:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:19 INFO - 'PWD': '/builds/slave/test', 04:14:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:19 INFO - 'SHELL': '/bin/bash', 04:14:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.odg8H5uu3h/Listeners', 04:14:19 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 04:14:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:19 INFO - 'USER': 'cltbld', 04:14:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:19 INFO - 'XPC_FLAGS': '0x0', 04:14:19 INFO - 'XPC_SERVICE_NAME': '0', 04:14:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:20 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-Ed8lKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:20 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:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:20 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-KcpGCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:20 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:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:20 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-VicgZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:20 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:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:20 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-GsnCRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:20 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-aZ7f_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:20 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:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:20 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-pFGkHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:20 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:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:20 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-Gmq1Ch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:20 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:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:20 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-kFummG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:20 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:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:20 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-s5czx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:21 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:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:21 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-XiEr_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:21 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:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:21 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-BaHwmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:21 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:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:21 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-JqZsvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:21 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:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:21 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-2ap8XL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:21 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:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:21 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-F5R4bO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:21 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:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:21 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-f6lk3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:21 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:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:21 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-b8Jmz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:21 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:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:21 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-sWFnre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:21 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:14:21 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:14:21 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:14:21 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:14:21 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:14:21 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:14:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:14: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:14: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:14: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:14: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:14: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:14: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:14:24 INFO - Downloading blessings-1.6.tar.gz 04:14:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:14:24 INFO - Installing collected packages: blessings 04:14:24 INFO - Running setup.py install for blessings 04:14:24 INFO - Successfully installed blessings 04:14:24 INFO - Cleaning up... 04:14:24 INFO - Return code: 0 04:14:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:14:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:25 INFO - Reading from file tmpfile_stdout 04:14:25 INFO - Current package versions: 04:14:25 INFO - blessings == 1.6 04:14:25 INFO - blobuploader == 1.2.4 04:14:25 INFO - docopt == 0.6.1 04:14:25 INFO - functools32 == 3.2.3-2 04:14:25 INFO - jsonschema == 2.5.1 04:14:25 INFO - manifestparser == 1.1 04:14:25 INFO - mozInstall == 1.12 04:14:25 INFO - mozcrash == 1.0 04:14:25 INFO - mozdebug == 0.1 04:14:25 INFO - mozdevice == 0.50 04:14:25 INFO - mozfile == 1.2 04:14:25 INFO - mozhttpd == 0.7 04:14:25 INFO - mozinfo == 0.9 04:14:25 INFO - mozleak == 0.1 04:14:25 INFO - mozlog == 3.4 04:14:25 INFO - moznetwork == 0.27 04:14:25 INFO - mozprocess == 0.25 04:14:25 INFO - mozprofile == 0.28 04:14:25 INFO - mozrunner == 6.13 04:14:25 INFO - mozscreenshot == 0.1 04:14:25 INFO - mozsystemmonitor == 0.3 04:14:25 INFO - moztest == 0.8 04:14:25 INFO - mozversion == 1.4 04:14:25 INFO - psutil == 3.1.1 04:14:25 INFO - requests == 1.2.3 04:14:25 INFO - wsgiref == 0.1.2 04:14:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:25 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:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:25 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:14:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:25 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 0x10d5a6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5a9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc373565f00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d384d30>, '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 0x10d2aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d379be8>, '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.gM5us60eHv/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.odg8H5uu3h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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:14:25 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:14:25 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:14:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gM5us60eHv/Render', 04:14:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:25 INFO - 'HOME': '/Users/cltbld', 04:14:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:25 INFO - 'LOGNAME': 'cltbld', 04:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:25 INFO - 'MOZ_NO_REMOTE': '1', 04:14:25 INFO - 'NO_EM_RESTART': '1', 04:14:25 INFO - 'PAGER': '/bin/cat', 04:14:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:25 INFO - 'PWD': '/builds/slave/test', 04:14:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:25 INFO - 'SHELL': '/bin/bash', 04:14:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.odg8H5uu3h/Listeners', 04:14:25 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 04:14:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:25 INFO - 'USER': 'cltbld', 04:14:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:25 INFO - 'XPC_FLAGS': '0x0', 04:14:25 INFO - 'XPC_SERVICE_NAME': '0', 04:14:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:25 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:14:25 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:14:25 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:14:25 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:14:25 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:14:25 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:14:25 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:14:25 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:14:25 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:14:25 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:14:25 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:14:25 INFO - Cleaning up... 04:14:25 INFO - Return code: 0 04:14:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:14:25 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:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:25 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:14:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:25 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 0x10d5a6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5a9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc373565f00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d384d30>, '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 0x10d2aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d379be8>, '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.gM5us60eHv/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.odg8H5uu3h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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:14:25 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:14:25 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:14:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gM5us60eHv/Render', 04:14:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:25 INFO - 'HOME': '/Users/cltbld', 04:14:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:25 INFO - 'LOGNAME': 'cltbld', 04:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:25 INFO - 'MOZ_NO_REMOTE': '1', 04:14:25 INFO - 'NO_EM_RESTART': '1', 04:14:25 INFO - 'PAGER': '/bin/cat', 04:14:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:25 INFO - 'PWD': '/builds/slave/test', 04:14:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:25 INFO - 'SHELL': '/bin/bash', 04:14:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.odg8H5uu3h/Listeners', 04:14:25 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 04:14:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:25 INFO - 'USER': 'cltbld', 04:14:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:25 INFO - 'XPC_FLAGS': '0x0', 04:14:25 INFO - 'XPC_SERVICE_NAME': '0', 04:14:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:14:25 INFO - Cleaning up... 04:14:25 INFO - Return code: 0 04:14:25 INFO - Running post-action listener: _resource_record_post_action 04:14:25 INFO - Running post-action listener: _start_resource_monitoring 04:14:25 INFO - Starting resource monitoring. 04:14:25 INFO - [mozharness: 2017-05-02 11:14:25.750008Z] Finished create-virtualenv step (success) 04:14:25 INFO - [mozharness: 2017-05-02 11:14:25.750990Z] Running install step. 04:14:25 INFO - Running pre-action listener: _resource_record_pre_action 04:14:25 INFO - Running main action method: install 04:14:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:26 INFO - Reading from file tmpfile_stdout 04:14:26 INFO - Detecting whether we're running mozinstall >=1.0... 04:14:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:14:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:14:26 INFO - Reading from file tmpfile_stdout 04:14:26 INFO - Output received: 04:14:26 INFO - Usage: mozinstall [options] installer 04:14:26 INFO - Options: 04:14:26 INFO - -h, --help show this help message and exit 04:14:26 INFO - -d DEST, --destination=DEST 04:14:26 INFO - Directory to install application into. [default: 04:14:26 INFO - "/builds/slave/test"] 04:14:26 INFO - --app=APP Application being installed. [default: firefox] 04:14:26 INFO - mkdir: /builds/slave/test/build/application 04:14:26 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:14:26 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:14:46 INFO - Reading from file tmpfile_stdout 04:14:46 INFO - Output received: 04:14:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:14:46 INFO - Running post-action listener: _resource_record_post_action 04:14:46 INFO - [mozharness: 2017-05-02 11:14:46.466779Z] Finished install step (success) 04:14:46 INFO - [mozharness: 2017-05-02 11:14:46.466916Z] Running run-tests step. 04:14:46 INFO - Running pre-action listener: _resource_record_pre_action 04:14:46 INFO - Running main action method: run_tests 04:14:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:14:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:14:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:14:46 INFO - 2017-05-02 04:14:46.482 screenresolution[1899:18043] starting screenresolution argv=screenresolution get 04:14:46 INFO - 2017-05-02 04:14:46.484 screenresolution[1899:18043] Display 0: 1600x1200x32@60 04:14:46 INFO - 2017-05-02 04:14:46.490 screenresolution[1900:18046] starting screenresolution argv=screenresolution list 04:14:46 INFO - Available Modes on Display 0 04:14:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:14:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:14:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:14:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:14:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:14:46 INFO - Intel Iris: 04:14:46 INFO - Chipset Model: Intel Iris 04:14:46 INFO - Type: GPU 04:14:46 INFO - Bus: Built-In 04:14:46 INFO - VRAM (Dynamic, Max): 1536 MB 04:14:46 INFO - Vendor: Intel (0x8086) 04:14:46 INFO - Device ID: 0x0a2e 04:14:46 INFO - Revision ID: 0x0009 04:14:46 INFO - Displays: 04:14:46 INFO - Display: 04:14:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:14:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:14:46 INFO - Display Serial Number: 1600x1200 60 04:14:46 INFO - Main Display: Yes 04:14:46 INFO - Mirror: Off 04:14:46 INFO - Online: Yes 04:14:46 INFO - Rotation: Supported 04:14:46 INFO - Return code: 0 04:14:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:14:46 INFO - Python 2.7.3 04:14:46 INFO - Return code: 0 04:14:46 INFO - grabbing minidump binary from tooltool 04:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:46 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 0x10d384d30>, '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 0x10d2aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d379be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:14:46 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:14:46 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:14:46 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:14:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:14:46 INFO - Return code: 0 04:14:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:14:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:14:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:14:46 INFO - ENV: RUST_BACKTRACE is now 1 04:14:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:14:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:14:46 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0270', '--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:14:46 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0270 --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:14:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gM5us60eHv/Render', 04:14:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:46 INFO - 'HOME': '/Users/cltbld', 04:14:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:46 INFO - 'LOGNAME': 'cltbld', 04:14:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:14:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:46 INFO - 'MOZ_NO_REMOTE': '1', 04:14:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:14:46 INFO - 'NO_EM_RESTART': '1', 04:14:46 INFO - 'PAGER': '/bin/cat', 04:14:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:46 INFO - 'PWD': '/builds/slave/test', 04:14:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:14:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:46 INFO - 'RUST_BACKTRACE': '1', 04:14:46 INFO - 'SHELL': '/bin/bash', 04:14:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.odg8H5uu3h/Listeners', 04:14:46 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 04:14:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:46 INFO - 'USER': 'cltbld', 04:14:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:46 INFO - 'XPC_FLAGS': '0x0', 04:14:46 INFO - 'XPC_SERVICE_NAME': '0', 04:14:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:46 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0270', '--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:14:47 INFO - mozversion application_buildid: 20170502020321 04:14:47 INFO - mozversion application_changeset: a812a96caba20dea7bc3815b71b4784afc6b864b 04:14:47 INFO - mozversion application_display_name: Nightly 04:14:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:14:47 INFO - mozversion application_name: Firefox 04:14:47 INFO - mozversion application_remotingname: firefox 04:14:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:14:47 INFO - mozversion application_vendor: Mozilla 04:14:47 INFO - mozversion application_version: 55.0a1 04:14:47 INFO - mozversion platform_buildid: 20170502020321 04:14:47 INFO - mozversion platform_changeset: a812a96caba20dea7bc3815b71b4784afc6b864b 04:14:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:14:47 INFO - mozversion platform_version: 55.0a1 04:14:47 INFO - using testdate: 1493723687 04:14:47 INFO - actual date: 1493723687 04:14:47 INFO - starting webserver on 'localhost:56657' 04:14:47 INFO - SUITE-START | Running 2 tests 04:14:47 INFO - TEST-START | dromaeo_css 04:14:47 INFO - operating with platform_type : mac_ 04:14:47 INFO - Initialising browser for dromaeo_css test... 04:14:47 INFO - TEST-INFO | started process 1910 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/tmpk4KWoS/profile http://localhost:56657/getInfo.html) 04:14:49 INFO - PID 1910 | __metrics Screen width/height:1600/1200 04:14:49 INFO - PID 1910 | colorDepth:24 04:14:49 INFO - PID 1910 | Browser inner width/height: 1024/689 04:14:49 INFO - PID 1910 | __metrics 04:14:49 INFO - PID 1910 | 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:14:49 INFO - PID 1910 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:14:50 INFO - TEST-INFO | 1910: exit 0 04:14:50 INFO - Browser initialized. 04:14:50 INFO - Running cycle 1/1 for dromaeo_css test... 04:14:50 INFO - TEST-INFO | started process 1912 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/tmpk4KWoS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:15:03 INFO - PID 1912 | RSS: Main: 240951296 04:15:03 INFO - PID 1912 | 04:18:08 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:56657/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56657/tests/dromaeo/cssquery-ext.html) 04:18:09 INFO - PID 1912 | RSS: Main: 386248704 04:18:09 INFO - PID 1912 | 04:19:52 INFO - PID 1912 | ************************* 04:19:52 INFO - PID 1912 | A coding exception was thrown and uncaught in a Task. 04:19:52 INFO - PID 1912 | 04:19:52 ERROR - PID 1912 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:19:52 INFO - PID 1912 | Full stack: 04:19:52 INFO - PID 1912 | ************************* 04:19:52 INFO - PID 1912 | ************************* 04:19:52 INFO - PID 1912 | A coding exception was thrown and uncaught in a Task. 04:19:52 INFO - PID 1912 | 04:19:52 ERROR - PID 1912 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:19:52 INFO - PID 1912 | Full stack: 04:19:52 INFO - PID 1912 | ************************* 04:19:52 INFO - PID 1912 | ************************* 04:19:52 INFO - PID 1912 | A coding exception was thrown and uncaught in a Task. 04:19:52 INFO - PID 1912 | 04:19:52 ERROR - PID 1912 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:19:52 INFO - PID 1912 | Full stack: 04:19:52 INFO - PID 1912 | ************************* 04:19:52 INFO - PID 1912 | ************************* 04:19:52 INFO - PID 1912 | A coding exception was thrown and uncaught in a Task. 04:19:52 INFO - PID 1912 | 04:19:52 ERROR - PID 1912 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:19:52 INFO - PID 1912 | Full stack: 04:19:52 INFO - PID 1912 | ************************* 04:21:12 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:56657/tests/dromaeo/cssquery-ext.html (next: http://localhost:56657/tests/dromaeo/cssquery-jquery.html) 04:21:12 INFO - PID 1912 | RSS: Main: 370864128 04:21:12 INFO - PID 1912 | 04:24:14 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:56657/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56657/tests/dromaeo/cssquery-mootools.html) 04:24:15 INFO - PID 1912 | RSS: Main: 351948800 04:24:15 INFO - PID 1912 | 04:27:18 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:56657/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56657/tests/dromaeo/cssquery-prototype.html) 04:27:18 INFO - PID 1912 | RSS: Main: 323039232 04:27:18 INFO - PID 1912 | 04:30:22 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:56657/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56657/tests/dromaeo/cssquery-yui.html) 04:30:22 INFO - PID 1912 | RSS: Main: 334778368 04:30:22 INFO - PID 1912 | 04:33:25 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:56657/tests/dromaeo/cssquery-yui.html (next: http://localhost:56657/tests/dromaeo/cssquery-dojo.html) 04:33:25 INFO - PID 1912 | RSS: Main: 378314752 04:33:25 INFO - PID 1912 | 04:33:25 INFO - PID 1912 | __start_tp_report 04:33:25 INFO - PID 1912 | _x_x_mozilla_page_load 04:33:25 INFO - PID 1912 | _x_x_mozilla_page_load_details 04:33:25 INFO - PID 1912 | |i|pagename|runs| 04:33:25 INFO - PID 1912 | |0;dojo.html;3512.069301635067;3518.524999125117;3550.130218096566;3552.360575096483;3576.821158942052;5993.160957465947;6091.692560820282;6170.814875553735;6253.687315634217;6261.686915654216;6131.835460087202;6174.289956654986;6221.00463925772;6231.096491008801;6267.2165979252595;4864.562189402953;5161.690298582097;5352.411234764173;5383.219433182196;5397.541208997221;5402.432744561824;5404.270423492837;5482.369527504328;5483.396826349099;5484.8354549363585;5270.077736396153;5341.412444631087;5350.625456218067;5352.973235133838;5384.273123128406;5268.657537260104;5270.49930256625;5278.313819203518;5280.313559237313;5283.735813209324;5199.1161502544655;5259.763310650992;5263.26314315996;5286.788528458857;5287.233351164098;5966.761329546813;5984.222051133368;5987.072003839412;5989.55078369124;5999.850003749898;6400.199975003125;6401.7759378422;6408.743650253984;6413.486921046305;6428.292887782341;6454.354564543555;6587.505937054692;6714.697838597275;6715.093462382565;6745.898811517831;6250.9998400255745;6298.086777417248;6313.558050936436;6338.429541341301;6347.301796802394;5664.291963504562;6850.143732033496;6855.245922948472;6865.622390768555;6893.75871844483;6353.809385718436;6396.392342727433;6401.487880969511;6457.61254324742;6555.6066636002;6636.502262330345;6678.632675202911;6683.565568238147;6687.665616719145;6699.564528305645;6566.9343306566325;6568.441682456949;6572.671366431755;6576.736930522726;6586.407223349922;6404.039394090923;6458.935410645928;6476.740930362827;6587.143671322698;6592.143021407186;5262.158054711228;5334.759935802898;5337.306150200449;5340.492653198017;5343.385510666245;4604.355390245369;4707.552782485658;4710.199266124767;4714;4760.880977975578;6222.315545290015;6280.214973128359;6293.024581189923;6293.622382657055;6297.748090076438;6443.5167362448;6575.210974683068;6580.177477815273;6620.503462240351;6623.4701223901975;5469.15228139639;6101.005087479836;6220.160278362454;6278.843028924222;6314.305426403092;5821.592488525847;5822.184894114827;5834.124881267759;5839.474447299678;5844.12338149281;6852.074969879002;6879.3251301277305;6922.06552115458;6926.826829329307;6946.548474349152;6451.516136289703;6529.9020514691365;6600.8349791255605;6676.732930682719;6693.665316734241;6912.792616221522;6915.170179578483;6933.791986240421;6944.722211111499;6953.617551034539;6515;6525.314841941527;6577.638229897401;6581.045748366556;6588.40704336612;5430.13117901134;6418.871622567429;6498.285188629153;6589.374009469093;6623;5295.629305948547;6162.291336496361;6309.747610095545;6356.713947872449;6358.014507751306;6251.749930002749;6306.400891915261;6343.52423568225;6351.460125889351;6374.649394283359;6247.219097612799;6303.6532990685955;6319.747210111544;6334.8733025338315;6335.556511044367;6306.716197771203;6442.742290308523;6445.12990746262;6448.871022579616;6452.387023232785;5167.354080739908;6291.559590828598;6295.087212354091;6301.054841773587;6328.746850125944 04:33:25 INFO - PID 1912 | |1;ext.html;771.6334740998027;788.5150632361099;802.8795680647904;1113.0817075912364;1119.5633702855887;26511.4697706046;26716.732832671667;26765.197044088683;26769;26775.598366024526;26961.92152313905;37901.86294411165;38125.618743812556;38189.85430437084;38278.4258236126;8117.39119566032;8244.010718713733;8261.13258107899;8263.710770123047;8276.255137037666;5873.941260587403;8125.4718443301;8272.090070092285;8285.171482851696;8321.583920803936;6000.129981152752;7413.481056326059;8293.295069919064;8312.085670576233;8315.916840831605;8300.958495207546;8348.457350272212;8352.206540378655;8355.498670079754;8356.164383561656;8183.877241841377;8273.83452330956;8276.048254450756;8285.95857020717;8292.253697167283;25571.61642575363;25698.743012569823;25703.61444578333;25735.356616084562;36635;3478.7650384113526;3507.6667716566885;3509.78941263525;3510.947335789965;3513.2797776455764;30927;30939.690603093906;30976.225594360098;30978;31045.689543104505;3052.8931487397836;3159.699828516287;3167.683231676837;3176.428242916274;3181.8545323683456;292885;296850;299760;299802;300422;49175.75412122916;49263.75368123208;49326.75336623366;49372.50627493679;49403.752981234866;42405.57594424016;52516;52522;52575.737121314145;52628.47371526312;14002.929985350009;14145.85854141466;14148.929255353863;14166.220857852917;14173.503927362493;11475.540978360772;11488.655340339803;11494.367809770376;11496.137789665641;11503.76992460163;10876.477293178961;12651;12809.871901280869;12898.097133200587;12906.09657323997;4634.802985510929;4895.527758481944;5808.88382232353;5963.2844058713235;5982.222311099529;1005.5173516711873;1030.1346868630387;1032.6592224565875;1058.327842009623;1059.2055958031476;24197.274081777574;25154;25217.369565760637;25249.242522724348;25302;916.876221710074;928.4614923344444;1098.3794156301665;1141.1612464838338;1143.6111722014555;10825.891741082645;12015.459304331325;12043.518259269706;12477.688057798629;12486.625401237978;305759;306630;307453;307850;309323;53742.46257537375;53746.7312663442;53903;53903;54037.45962540403;1488.739470592642;1493.2160615676858;1533.4709525213784;1534.647031182834;1566.0681894273116;24087.51824963456;24119.276421707378;24177;24196.39509012289;24304.635430468203;39183.608163918;39273.60726392699;39296;39310.606893931836;39311.60688393079;284724;284918;284978.5751071231;285869;286170.56914715294;34127.82936085304;35061.29877402489;35537.82231088828;35701.46447803337;35787.64212357947;36875.26249475049;44649.55350446454;46373;46443;46501.53498464972;25750;28877.422451550432;30618.08145755631;30935;31602.683973159976;30828.38343233078;31106.533401998535;31603.525947111273;31697.890573829805;31782.52326215155;36449.387722646774;36734;37979.050523737125;38153.809230953666;38353.80823095867;27356.316092097855;27516.07387482857;29802.701972979994;30302.84848575743;32434.351312973136;23268.41828954222;23547.529049418572;24201.878990604935;24244;24433.267001989967 04:33:25 INFO - PID 1912 | |2;jquery.html;376.4428645604505;412.4967539601687;422.12409250804586;429.51893878855685;444.32019010913297;19393.933333666642;20568.588628227426;20759.68860467094;21279.04244309006;21315;21085.789142108573;21102.83934383612;21278.36164915055;21900.561988760215;22085;5882.235309409771;6172.290186628527;6177.969110154443;6178.320384757673;6178.567500274982;5752.769889204447;5909.7636094556165;5966.850828729295;6000.459958603725;6094.878102437949;5928.40715928408;5944.405559444064;5946.078357854518;5947.970260148715;5949.048152295633;5685.516731077842;5900.996830538818;5940.881182376372;5973.850653733692;5981.1028345748055;5303.071962406563;5304.124819404794;5311.229871668586;5311.681299122065;5317;25708.357291067685;26473.073442429424;26897.924083036654;27035.864820675968;27388.863055684793;2200.515886504966;2209.414505156135;2247.426906138924;2247.8763667998255;2249.2127755285683;13938.721225575533;17247.31010759568;17601.383951561635;18020.729689054675;18107.909460452745;2074.502119491326;2101.6532272175073;2132.6694362373855;2148.602508535926;2175.4343870593602;131986.02020969693;148426;149516.53384263106;150279;150820;11375.658730238107;11893.34586597728;11906;11938.64184074479;12009.579664711693;15875;15882.602934926488;15908.840911590967;15912.204389780696;15918.044917304998;7045.252351582887;7239.819004524824;8624;8922.152395522415;8958.193762561401;8388.8741668875;8415.873761893576;8432.45189062709;8574.571271436404;8574.928133983252;5990.31111422192;7456.142543607446;7465.664045117983;7491.438142139253;7498.137714162941;2014.1377937076686;2042.0708577597159;2044.3866839947957;2045.7623138001593;2064.9690254646193;913.620847348343;924.6393906376519;931.9207867331218;941.8445956417252;970.1123472023161;18432.354867579572;20319;20942.47643808917;20970.790292096885;21060.47348816292;943.1370296178919;964.1611797735875;968.2012339819677;999.1806718490913;1001.6944831826218;10650.786984260272;10870;10870.239083264254;10900.705750821002;10957.616483423042;538863;549333;554754;564283;568041;139463;142104;143216;145092;146441.26779366034;1079.681493959284;1161.3670549550516;1173.861354486147;1174.7767924094394;1177.252444697606;18197.727034094765;18236.544086397946;18244.361447349278;18289.26842926268;18420;55942.24490918317;56345.71827140838;56743.71628141833;57171.14243286437;58149.709251453474;76563;77932.61033695022;78155;78834;79237.81143282971;8617.784555386166;8748.343874209333;8865.335099867407;8932.151445612917;9171.724848254564;13091.672708182372;14369;14424;14752.852471475577;15005.324760386027;9684.852422962424;11501.884981150082;11721.706957326134;11752.882471175179;11849.407529623657;11427;11465.082793376676;11692.123090768056;11767.941160294144;11895.345755983504;12114.939425302817;12191.939040304742;12372.876271237532;12506.37468126572;12594.370281486072;8796.560171991247;8886.357163201543;9123.27013838878;9254.583543740413;9254.953725231331;10146.391216527032;10206.285560010729;11821.586244481401;11959.103067270164;12307.69230769238 04:33:25 INFO - PID 1912 | |3;mootools.html;1201.8437603111595;1257.4467234416857;1476.8375478697342;1496.790449337093;1499.7600383938568;9710.757231069227;10163.59345626175;10950.34297942124;11488.827667584992;11793.292402455858;11286;11394.487248073836;11409.144314176428;11410.942945285282;11412.31526108434;2159.341400872733;2447.8617442889054;2458.0782206672543;2503.9749602504016;2510;2090.9372718818386;2184.595849767798;2449;2543.122622695167;2554.3741783263126;2481.1068015514493;2497.2258599834017;2504.9980007996764;2508.3352911478473;2514.5599520084;2105.768365479796;2496.1887386599337;2499.5875680512695;2505.8621775802326;2512.937176570582;2449.3956458519697;2461.59383701689;2488.5271798358253;2496.3509487533192;2503.111395454624;11450.141239407078;11551.191416600841;11573.710657233552;11581.710457238552;11584.015358694436;6469.417752402306;6705.664716764142;6712.160979877515;6716.697748601325;6727.428168605626;3582.247727977128;3940.4089386591954;4124.422580838685;4283.87148385549;4305.0098477350075;1250.7998720204723;1252.0922331309728;1276.5978716704208;1297.7274772297828;1297.8831905128584;16319.184040797913;16401.753973690404;16409.17954102302;16421.343146274136;16425.753613695684;5664.20701101846;5929.673867937305;5942.970285148546;6055.878882422415;6107.083937409424;13850.515231966832;13868.4452621894;13868.514601988882;13869.930650346683;13872.167669939634;6790.166655003121;6801.761938332134;6811.93188068113;6813.965930170318;6816.977453382033;5213.3222681051975;6140.232470941132;6232.781852635136;6288.874222515524;6385.680715964183;3920.3727403615853;4130.524989626171;4182.163567286555;4729.6588188846745;4729.777004807735;1304.7847105227531;1377.9871794231233;1433.3621538415514;1455.6943041961094;1475.7565001774801;705.3158436316764;791.0981481111537;800.4556901307167;813.1421350475306;817.7873752824308;6544.672766361663;6853.074834897325;6996.090508233999;6996.755113571001;7067.116610423697;912.2747415804452;944.244604316544;952.0812416018575;954.8185844689486;959.7648576098901;3824.0057585028094;3827.2154208387215;3905.843766249375;3973.3642617181113;3978.522577290744;13712;15355.385784568716;15378.231088445533;15389.076655400711;15399.384024639114;13794.172349659053;13899.332080150245;15270.31283592241;15276.847231527765;15287;8475.74572762818;8672.696455624024;8702.825943481095;8710.390272680852;8729.258013068833;6541.476681865534;6802.285759995129;6920.30796920304;6967.372936435745;7078.256783037707;12693.873061269638;13459.663508412368;13563.86436135626;13743.656408589864;13787.96590255755;13446.731065378834;13688.315584220949;13907.165570065828;13983.580492585239;14292;9187.678431254873;9204.677836275967;9323.72028839136;9421.81156376855;9447.244220462484;9566.808663826823;9850.507474626384;9854.753631159278;10604.204684648528;10727.517261723397;7542.509736867086;9059.36584439083;9219.677311294072;9230.676926307548;9566.61733530651;8985.326100542356;9020.81958360816;9038;9062.139096785795;9064.592093355946;8184.590770461572;8314.210150035737;8314.542700151549;8319.459235149938;8319.708810191614;6012.669303188367;6039.577229594062;6138.324784273637;6162.907556386568;6240.625562466266;5241.947580524146;5486.588505861996;6102.542309326907;6181.165542651865;6300.831173473889 04:33:25 INFO - PID 1912 | |4;prototype.html;338.4212995777221;394.3690095846646;400.95751047277065;402.6879168644301;407.3604441027586;5654.660720356782;5794.696193356498;5868.2664666916635;5943.315144610337;6006.66963317018;4474.776261186936;4757.666963312569;5431.375391829941;5844.970775146118;5846.473817356437;4469.240229161051;4475.896328725502;4476.060027394235;4476.932846007313;4492.056668099703;4469.932951005738;4490.259107247301;4520.186366454037;4524.773761311938;4526.592606665399;3561.982190089046;4042.818073186699;4103.466549348595;4470.463544374663;4492.820287188509;4004.7997600120025;4427.778611069466;4429.291313389875;4453.153900758862;4457.64338852891;3103.332783451569;3900.7907548660005;3963.1083006323347;3964.385520244367;3980.3432433648413;5552.225685287337;5723.227364305807;5745.3105627324985;5754.021816291241;5798.681072541009;5366.350881400646;5367.677939323653;5380.569554435636;5396.271503347037;5441.29263195782;5990.652103276771;6299.9370006299805;6317.905231421532;6318.210223722035;6330.493560515194;4087.182563487285;4319.524852266248;4427.00392411708;4483.282674772054;4588.564086411819;6358.245787562218;6560.835979100513;6567.408933195939;6570.408663220285;6580.5393622446445;3704.981475092607;3904.375299951994;4092.2224777292217;4318.1363727254675;4465.642748580106;4118.773467459318;4198.4961804583645;4531.45622525299;4681.518795038635;4705.905881882343;5340.198970154508;5386.865328366822;5387.191921211771;5393.271908292409;5401.864953376197;6031.849203769941;6334.936650633527;6338.556301058881;6344.460720838688;6368.713407896656;1243.5958313548133;1449.4999225267266;1450.0139904864582;1458.5332693537966;1461.7661174212076;923.2337160157188;940.5767404667927;948.4783369147079;961.4952150121243;963.3160456076124;5649.700568869183;5657.377688454267;5997.790077347359;6008.609440386361;6055.666938318347;6551.475881929434;6554;6557.622899191223;6561.915899527215;6611.23970743361;5883.235029491136;5928.67392293428;5931.703414829241;5959.314678811906;6010.939890601038;3372.747043971663;3387.627360990289;3390.355832391838;3403.540522029544;3415.777974431654;6012.428819262163;6134.1904138279315;6611.636360000246;6659.966700166468;6803.353681400259;6649.634270115093;6691.899621505681;6699.162604674416;6699.665016749143;6786.423154031864;4724.952750472588;5966.105084237399;6216.875662486816;6767.763128290486;6804.699720635488;6089;6327.3356297589935;6366.299707032315;6485.481161506974;6524.445422139172;6408.038794180724;6410.551261411656;6413.294537600954;6429.8392540185;6524.347565243438;5930.695247045643;6466.224053113657;6510.804675859732;6743;6787.253402125861;4162.62536371728;4175.390381011867;4182.372644103287;4188.434561334303;4193.140406216779;6339.2392912850755;6434.485241180788;6456.515761317826;6538.574992625464;6578.572392794453;5298.231756395378;5764.711764411846;6263.154474145932;6327.873442531216;6349.841253968503;5535.6955367455175;6043.8186854394435;6241.3134555197985;6295.842603934938;6301.716422761078;6061.817146339816;6179.84550386244;6182.814515564541;6190.319064902767;6277.937220627735;6234.719437625408;6291.168973961827;6302.968485157545;6311.873762524816;6396.857052887149;5378.784848606168;5789.797357092481;6055.910710804766;6160.691965401802;6162.506999439945 04:33:25 INFO - PID 1912 | |5;yui.html;706.1914108345941;857.3055824781924;860.8837806896067;865.1348651348651;883.2801266967423;12832.294223817698;17764.46706598804;18083.638327233464;18735.06324683767;18747.343842965463;14237.430502779902;17039.659206815857;17615.91192044038;17616.383426580072;17801.554961125945;946.9668561600346;958.2669258017587;964.9758756031121;966.6665000574826;966.9081437263449;655.9836004099888;667.3360006793248;819.6557445872718;979.2508730820928;981.1267971505366;1024.8155332040267;1030.7114008077713;1031.9380837149758;1032.6747074671455;1034.2708390584658;1028.9073983341461;1029.613894789454;1030.0935177044153;1030.953607087679;1035.5495359518595;758.3175142371854;759.1952530317881;759.255929189392;759.5898214963913;763.0347610273009;16423.91788041064;16511.752323715154;16715;16891.408800691916;17049.318027278892;16357.427490037791;16486.83513164865;16813.663726725397;16875;17093.31626734929;12709.237445753284;13815.447382104703;13950.790738138936;14038.227897465635;14125.223112728796;3403.0301364111356;3419;3429.228423604694;3430.433978393562;3430.7598468107244;89622.55188724014;120409;122813;123262;124995.75004249932;10723.356598604109;11140.944295278634;11876.94061529704;12089.03287736979;12113.091518136;17691.292348305924;19540.902295488715;23688.881555592456;25049.12328068509;25123.37191570189;7662.387009039264;7829.491083079695;7953.721619743281;7965.362770978424;7967.322777563972;3895.4935858338235;3989.4414781930554;3989.8005099744896;3993.4409182714444;3999.8200080996426;3494.2836718472654;4111.280525907954;4193.370994350872;4199.181159673834;4203.5376108628025;862.0603542139098;884.4516399832145;888.9288856891433;891.3315013739696;892.0856122474386;664.8902931016328;672.2202245395416;674.1775034457953;682.3892616108556;690.4717890813532;10124.797504049879;10494.527746251437;10874;11956.58151964677;11990.580329688419;659.7394029358377;663.1147418196762;663.741140955028;674.9730010799512;679.4258851270669;5232.843014709489;5254.043587401852;5419.783208671609;5466.398696143421;5551.694656793915;105454;107316;108223.45888270508;108289.45855270674;109486;69829.60340793258;78420.21579784129;89023.66464503038;94645.52677236707;96354;84763.57618211993;85094;85761;86046.2790744194;86122.27755444856;9469.715908522756;10200.234982376203;10830.837537436788;11154.55381784752;11286.66140015801;31712;38009.80995095007;38363.424548631236;41647.95880103022;42457.938551536456;54466.83429896941;54800.53397597197;55162.72418637881;55261.89476210373;55729;13681.521146759816;13957.441702331793;14172.29138543048;14194.503192388216;14204.28978551089;12589.622311330675;15269.77095343593;15335.309911053806;15485.922570387076;15539.844601554292;12282.508699652271;12368.1960672556;12478;12525.874741252836;12535.749285014066;13837.515686950908;14040.578782636538;14245.928770356082;14377.56867293983;14380.921430892515;13392.732145357233;13624.18254904709;13784.172949623055;13789.103708258932;13963.650908726957;10177.643782467578;10241.897581024094;10292.279540432099;10408.063274305348;10532.262741608014;11456.599019034295;11692.94153529227;11741.589044383405;11751.529938802352;11886.227395219283 04:33:25 INFO - PID 1912 | __end_tp_report 04:33:25 INFO - PID 1912 | __start_cc_report 04:33:25 INFO - PID 1912 | _x_x_mozilla_cycle_collect,1394 04:33:25 INFO - PID 1912 | __end_cc_report 04:33:25 INFO - PID 1912 | __startTimestamp1493724805561__endTimestamp 04:33:25 INFO - PID 1912 | 04:33:25 INFO - PID 1912 | ------- Summary: start ------- 04:33:25 INFO - PID 1912 | Number of tests: 6 04:33:25 INFO - PID 1912 | 04:33:25 INFO - PID 1912 | [#0] dojo.html Cycles:165 Average:6058.32 Median:6306.40 stddev:722.53 (11.5%) stddev-sans-first:696.59 04:33:25 INFO - PID 1912 | Values: 3512.1 3518.5 3550.1 3552.4 3576.8 5993.2 6091.7 6170.8 6253.7 6261.7 6131.8 6174.3 6221.0 6231.1 6267.2 4864.6 5161.7 5352.4 5383.2 5397.5 5402.4 5404.3 5482.4 5483.4 5484.8 5270.1 5341.4 5350.6 5353.0 5384.3 5268.7 5270.5 5278.3 5280.3 5283.7 5199.1 5259.8 5263.3 5286.8 5287.2 5966.8 5984.2 5987.1 5989.6 5999.9 6400.2 6401.8 6408.7 6413.5 6428.3 6454.4 6587.5 6714.7 6715.1 6745.9 6251.0 6298.1 6313.6 6338.4 6347.3 5664.3 6850.1 6855.2 6865.6 6893.8 6353.8 6396.4 6401.5 6457.6 6555.6 6636.5 6678.6 6683.6 6687.7 6699.6 6566.9 6568.4 6572.7 6576.7 6586.4 6404.0 6458.9 6476.7 6587.1 6592.1 5262.2 5334.8 5337.3 5340.5 5343.4 4604.4 4707.6 4710.2 4714.0 4760.9 6222.3 6280.2 6293.0 6293.6 6297.7 6443.5 6575.2 6580.2 6620.5 6623.5 5469.2 6101.0 6220.2 6278.8 6314.3 5821.6 5822.2 5834.1 5839.5 5844.1 6852.1 6879.3 6922.1 6926.8 6946.5 6451.5 6529.9 6600.8 6676.7 6693.7 6912.8 6915.2 6933.8 6944.7 6953.6 6515.0 6525.3 6577.6 6581.0 6588.4 5430.1 6418.9 6498.3 6589.4 6623.0 5295.6 6162.3 6309.7 6356.7 6358.0 6251.7 6306.4 6343.5 6351.5 6374.6 6247.2 6303.7 6319.7 6334.9 6335.6 6306.7 6442.7 6445.1 6448.9 6452.4 5167.4 6291.6 6295.1 6301.1 6328.7 04:33:25 INFO - PID 1912 | 04:33:25 INFO - PID 1912 | [#1] ext.html Cycles:180 Average:44237.77 Median:17133.12 stddev:77965.45 (455.1%) stddev-sans-first:78115.86 04:33:25 INFO - PID 1912 | Values: 771.6 788.5 802.9 1113.1 1119.6 26511.5 26716.7 26765.2 26769.0 26775.6 26961.9 37901.9 38125.6 38189.9 38278.4 8117.4 8244.0 8261.1 8263.7 8276.3 5873.9 8125.5 8272.1 8285.2 8321.6 6000.1 7413.5 8293.3 8312.1 8315.9 8301.0 8348.5 8352.2 8355.5 8356.2 8183.9 8273.8 8276.0 8286.0 8292.3 25571.6 25698.7 25703.6 25735.4 36635.0 3478.8 3507.7 3509.8 3510.9 3513.3 30927.0 30939.7 30976.2 30978.0 31045.7 3052.9 3159.7 3167.7 3176.4 3181.9 292885.0 296850.0 299760.0 299802.0 300422.0 49175.8 49263.8 49326.8 49372.5 49403.8 42405.6 52516.0 52522.0 52575.7 52628.5 14002.9 14145.9 14148.9 14166.2 14173.5 11475.5 11488.7 11494.4 11496.1 11503.8 10876.5 12651.0 12809.9 12898.1 12906.1 4634.8 4895.5 5808.9 5963.3 5982.2 1005.5 1030.1 1032.7 1058.3 1059.2 24197.3 25154.0 25217.4 25249.2 25302.0 916.9 928.5 1098.4 1141.2 1143.6 10825.9 12015.5 12043.5 12477.7 12486.6 305759.0 306630.0 307453.0 307850.0 309323.0 53742.5 53746.7 53903.0 53903.0 54037.5 1488.7 1493.2 1533.5 1534.6 1566.1 24087.5 24119.3 24177.0 24196.4 24304.6 39183.6 39273.6 39296.0 39310.6 39311.6 284724.0 284918.0 284978.6 285869.0 286170.6 34127.8 35061.3 35537.8 35701.5 35787.6 36875.3 44649.6 46373.0 46443.0 46501.5 25750.0 28877.4 30618.1 30935.0 31602.7 30828.4 31106.5 31603.5 31697.9 31782.5 36449.4 36734.0 37979.1 38153.8 38353.8 27356.3 27516.1 29802.7 30302.8 32434.4 23268.4 23547.5 24201.9 24244.0 24433.3 04:33:25 INFO - PID 1912 | 04:33:25 INFO - PID 1912 | [#2] jquery.html Cycles:180 Average:35676.02 Median:12147.21 stddev:94265.62 (776.0%) stddev-sans-first:94492.80 04:33:25 INFO - PID 1912 | Values: 376.4 412.5 422.1 429.5 444.3 19393.9 20568.6 20759.7 21279.0 21315.0 21085.8 21102.8 21278.4 21900.6 22085.0 5882.2 6172.3 6178.0 6178.3 6178.6 5752.8 5909.8 5966.9 6000.5 6094.9 5928.4 5944.4 5946.1 5948.0 5949.0 5685.5 5901.0 5940.9 5973.9 5981.1 5303.1 5304.1 5311.2 5311.7 5317.0 25708.4 26473.1 26897.9 27035.9 27388.9 2200.5 2209.4 2247.4 2247.9 2249.2 13938.7 17247.3 17601.4 18020.7 18107.9 2074.5 2101.7 2132.7 2148.6 2175.4 131986.0 148426.0 149516.5 150279.0 150820.0 11375.7 11893.3 11906.0 11938.6 12009.6 15875.0 15882.6 15908.8 15912.2 15918.0 7045.3 7239.8 8624.0 8922.2 8958.2 8388.9 8415.9 8432.5 8574.6 8574.9 5990.3 7456.1 7465.7 7491.4 7498.1 2014.1 2042.1 2044.4 2045.8 2065.0 913.6 924.6 931.9 941.8 970.1 18432.4 20319.0 20942.5 20970.8 21060.5 943.1 964.2 968.2 999.2 1001.7 10650.8 10870.0 10870.2 10900.7 10957.6 538863.0 549333.0 554754.0 564283.0 568041.0 139463.0 142104.0 143216.0 145092.0 146441.3 1079.7 1161.4 1173.9 1174.8 1177.3 18197.7 18236.5 18244.4 18289.3 18420.0 55942.2 56345.7 56743.7 57171.1 58149.7 76563.0 77932.6 78155.0 78834.0 79237.8 8617.8 8748.3 8865.3 8932.2 9171.7 13091.7 14369.0 14424.0 14752.9 15005.3 9684.9 11501.9 11721.7 11752.9 11849.4 11427.0 11465.1 11692.1 11767.9 11895.3 12114.9 12191.9 12372.9 12506.4 12594.4 8796.6 8886.4 9123.3 9254.6 9255.0 10146.4 10206.3 11821.6 11959.1 12307.7 04:33:25 INFO - PID 1912 | 04:33:25 INFO - PID 1912 | [#3] mootools.html Cycles:180 Average:7136.06 Median:3930.39 stddev:4538.30 (115.5%) stddev-sans-first:4529.12 04:33:25 INFO - PID 1912 | Values: 1201.8 1257.4 1476.8 1496.8 1499.8 9710.8 10163.6 10950.3 11488.8 11793.3 11286.0 11394.5 11409.1 11410.9 11412.3 2159.3 2447.9 2458.1 2504.0 2510.0 2090.9 2184.6 2449.0 2543.1 2554.4 2481.1 2497.2 2505.0 2508.3 2514.6 2105.8 2496.2 2499.6 2505.9 2512.9 2449.4 2461.6 2488.5 2496.4 2503.1 11450.1 11551.2 11573.7 11581.7 11584.0 6469.4 6705.7 6712.2 6716.7 6727.4 3582.2 3940.4 4124.4 4283.9 4305.0 1250.8 1252.1 1276.6 1297.7 1297.9 16319.2 16401.8 16409.2 16421.3 16425.8 5664.2 5929.7 5943.0 6055.9 6107.1 13850.5 13868.4 13868.5 13869.9 13872.2 6790.2 6801.8 6811.9 6814.0 6817.0 5213.3 6140.2 6232.8 6288.9 6385.7 3920.4 4130.5 4182.2 4729.7 4729.8 1304.8 1378.0 1433.4 1455.7 1475.8 705.3 791.1 800.5 813.1 817.8 6544.7 6853.1 6996.1 6996.8 7067.1 912.3 944.2 952.1 954.8 959.8 3824.0 3827.2 3905.8 3973.4 3978.5 13712.0 15355.4 15378.2 15389.1 15399.4 13794.2 13899.3 15270.3 15276.8 15287.0 8475.7 8672.7 8702.8 8710.4 8729.3 6541.5 6802.3 6920.3 6967.4 7078.3 12693.9 13459.7 13563.9 13743.7 13788.0 13446.7 13688.3 13907.2 13983.6 14292.0 9187.7 9204.7 9323.7 9421.8 9447.2 9566.8 9850.5 9854.8 10604.2 10727.5 7542.5 9059.4 9219.7 9230.7 9566.6 8985.3 9020.8 9038.0 9062.1 9064.6 8184.6 8314.2 8314.5 8319.5 8319.7 6012.7 6039.6 6138.3 6162.9 6240.6 5241.9 5486.6 6102.5 6181.2 6300.8 04:33:25 INFO - PID 1912 | 04:33:25 INFO - PID 1912 | [#4] prototype.html Cycles:180 Average:5140.03 Median:5875.75 stddev:1599.72 (27.2%) stddev-sans-first:1563.08 04:33:25 INFO - PID 1912 | Values: 338.4 394.4 401.0 402.7 407.4 5654.7 5794.7 5868.3 5943.3 6006.7 4474.8 4757.7 5431.4 5845.0 5846.5 4469.2 4475.9 4476.1 4476.9 4492.1 4469.9 4490.3 4520.2 4524.8 4526.6 3562.0 4042.8 4103.5 4470.5 4492.8 4004.8 4427.8 4429.3 4453.2 4457.6 3103.3 3900.8 3963.1 3964.4 3980.3 5552.2 5723.2 5745.3 5754.0 5798.7 5366.4 5367.7 5380.6 5396.3 5441.3 5990.7 6299.9 6317.9 6318.2 6330.5 4087.2 4319.5 4427.0 4483.3 4588.6 6358.2 6560.8 6567.4 6570.4 6580.5 3705.0 3904.4 4092.2 4318.1 4465.6 4118.8 4198.5 4531.5 4681.5 4705.9 5340.2 5386.9 5387.2 5393.3 5401.9 6031.8 6334.9 6338.6 6344.5 6368.7 1243.6 1449.5 1450.0 1458.5 1461.8 923.2 940.6 948.5 961.5 963.3 5649.7 5657.4 5997.8 6008.6 6055.7 6551.5 6554.0 6557.6 6561.9 6611.2 5883.2 5928.7 5931.7 5959.3 6010.9 3372.7 3387.6 3390.4 3403.5 3415.8 6012.4 6134.2 6611.6 6660.0 6803.4 6649.6 6691.9 6699.2 6699.7 6786.4 4725.0 5966.1 6216.9 6767.8 6804.7 6089.0 6327.3 6366.3 6485.5 6524.4 6408.0 6410.6 6413.3 6429.8 6524.3 5930.7 6466.2 6510.8 6743.0 6787.3 4162.6 4175.4 4182.4 4188.4 4193.1 6339.2 6434.5 6456.5 6538.6 6578.6 5298.2 5764.7 6263.2 6327.9 6349.8 5535.7 6043.8 6241.3 6295.8 6301.7 6061.8 6179.8 6182.8 6190.3 6277.9 6234.7 6291.2 6303.0 6311.9 6396.9 5378.8 5789.8 6055.9 6160.7 6162.5 04:33:25 INFO - PID 1912 | 04:33:25 INFO - PID 1912 | [#5] yui.html Cycles:180 Average:20807.50 Median:17942.60 stddev:30155.89 (168.1%) stddev-sans-first:30202.71 04:33:25 INFO - PID 1912 | Values: 706.2 857.3 860.9 865.1 883.3 12832.3 17764.5 18083.6 18735.1 18747.3 14237.4 17039.7 17615.9 17616.4 17801.6 947.0 958.3 965.0 966.7 966.9 656.0 667.3 819.7 979.3 981.1 1024.8 1030.7 1031.9 1032.7 1034.3 1028.9 1029.6 1030.1 1031.0 1035.5 758.3 759.2 759.3 759.6 763.0 16423.9 16511.8 16715.0 16891.4 17049.3 16357.4 16486.8 16813.7 16875.0 17093.3 12709.2 13815.4 13950.8 14038.2 14125.2 3403.0 3419.0 3429.2 3430.4 3430.8 89622.6 120409.0 122813.0 123262.0 124995.8 10723.4 11140.9 11876.9 12089.0 12113.1 17691.3 19540.9 23688.9 25049.1 25123.4 7662.4 7829.5 7953.7 7965.4 7967.3 3895.5 3989.4 3989.8 3993.4 3999.8 3494.3 4111.3 4193.4 4199.2 4203.5 862.1 884.5 888.9 891.3 892.1 664.9 672.2 674.2 682.4 690.5 10124.8 10494.5 10874.0 11956.6 11990.6 659.7 663.1 663.7 675.0 679.4 5232.8 5254.0 5419.8 5466.4 5551.7 105454.0 107316.0 108223.5 108289.5 109486.0 69829.6 78420.2 89023.7 94645.5 96354.0 84763.6 85094.0 85761.0 86046.3 86122.3 9469.7 10200.2 10830.8 11154.6 11286.7 31712.0 38009.8 38363.4 41648.0 42457.9 54466.8 54800.5 55162.7 55261.9 55729.0 13681.5 13957.4 14172.3 14194.5 14204.3 12589.6 15269.8 15335.3 15485.9 15539.8 12282.5 12368.2 12478.0 12525.9 12535.7 13837.5 14040.6 14245.9 14377.6 14380.9 13392.7 13624.2 13784.2 13789.1 13963.7 10177.6 10241.9 10292.3 10408.1 10532.3 11456.6 11692.9 11741.6 11751.5 11886.2 04:33:25 INFO - PID 1912 | -------- Summary: end -------- 04:33:25 INFO - PID 1912 | 04:33:26 INFO - TEST-INFO | 1912: exit 0 04:33:26 INFO - TEST-OK | dromaeo_css | took 1119132ms 04:33:26 INFO - TEST-START | kraken 04:33:26 INFO - operating with platform_type : mac_ 04:33:26 INFO - Initialising browser for kraken test... 04:33:26 INFO - TEST-INFO | started process 1917 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/tmpWa9Phk/profile http://localhost:56657/getInfo.html) 04:33:28 INFO - PID 1917 | __metrics Screen width/height:1600/1200 04:33:28 INFO - PID 1917 | colorDepth:24 04:33:28 INFO - PID 1917 | Browser inner width/height: 1024/689 04:33:28 INFO - PID 1917 | __metrics 04:33:28 INFO - PID 1917 | 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:33:28 INFO - PID 1917 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:33:29 INFO - TEST-INFO | 1917: exit 0 04:33:29 INFO - Browser initialized. 04:33:29 INFO - Running cycle 1/1 for kraken test... 04:33:29 INFO - TEST-INFO | started process 1918 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/tmpWa9Phk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:33:41 INFO - PID 1918 | RSS: Main: 241111040 04:33:41 INFO - PID 1918 | 04:33:44 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:56657/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56657/tests/kraken/driver.html?testName=audio-beat-detection) 04:33:45 INFO - PID 1918 | RSS: Main: 309788672 04:33:45 INFO - PID 1918 | 04:33:48 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:56657/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56657/tests/kraken/driver.html?testName=audio-dft) 04:33:48 INFO - PID 1918 | RSS: Main: 293625856 04:33:48 INFO - PID 1918 | 04:33:51 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:56657/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56657/tests/kraken/driver.html?testName=audio-fft) 04:33:52 INFO - PID 1918 | RSS: Main: 386617344 04:33:52 INFO - PID 1918 | 04:33:54 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:56657/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56657/tests/kraken/driver.html?testName=audio-oscillator) 04:33:55 INFO - PID 1918 | RSS: Main: 288600064 04:33:55 INFO - PID 1918 | 04:33:57 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:56657/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56657/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:33:57 INFO - PID 1918 | RSS: Main: 292364288 04:33:57 INFO - PID 1918 | 04:34:00 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:56657/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56657/tests/kraken/driver.html?testName=imaging-darkroom) 04:34:01 INFO - PID 1918 | RSS: Main: 355172352 04:34:01 INFO - PID 1918 | 04:34:04 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:56657/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56657/tests/kraken/driver.html?testName=imaging-desaturate) 04:34:04 INFO - PID 1918 | RSS: Main: 366317568 04:34:04 INFO - PID 1918 | 04:34:07 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:56657/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56657/tests/kraken/driver.html?testName=json-parse-financial) 04:34:08 INFO - PID 1918 | RSS: Main: 369451008 04:34:08 INFO - PID 1918 | 04:34:09 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:56657/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56657/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:34:10 INFO - PID 1918 | RSS: Main: 329703424 04:34:10 INFO - PID 1918 | 04:34:11 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:56657/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56657/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:34:12 INFO - PID 1918 | RSS: Main: 331546624 04:34:12 INFO - PID 1918 | 04:34:14 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:56657/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56657/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:34:15 INFO - PID 1918 | RSS: Main: 333361152 04:34:15 INFO - PID 1918 | 04:34:18 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:56657/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56657/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:34:19 INFO - PID 1918 | RSS: Main: 345210880 04:34:19 INFO - PID 1918 | 04:34:22 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:56657/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56657/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:34:22 INFO - PID 1918 | RSS: Main: 342315008 04:34:22 INFO - PID 1918 | 04:34:24 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:56657/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56657/tests/kraken/driver.html?testName=ai-astar) 04:34:24 INFO - PID 1918 | RSS: Main: 384843776 04:34:24 INFO - PID 1918 | 04:34:24 INFO - PID 1918 | __start_tp_report 04:34:24 INFO - PID 1918 | _x_x_mozilla_page_load 04:34:24 INFO - PID 1918 | _x_x_mozilla_page_load_details 04:34:24 INFO - PID 1918 | |i|pagename|runs| 04:34:24 INFO - PID 1918 | |0;ai-astar;112;112;110;110;111;113;111;110;111;111 04:34:24 INFO - PID 1918 | |1;audio-beat-detection;139;110;106;158;110;105;106;106;134;104 04:34:24 INFO - PID 1918 | |2;audio-dft;188;187;185;186;185;183;184;186;183;182 04:34:24 INFO - PID 1918 | |3;audio-fft;81;57;57;88;61;63;62;58;78;58 04:34:24 INFO - PID 1918 | |4;audio-oscillator;88;64;82;69;69;69;89;69;68;92 04:34:24 INFO - PID 1918 | |5;imaging-gaussian-blur;92;92;92;91;92;92;92;92;92;91 04:34:24 INFO - PID 1918 | |6;imaging-darkroom;96;97;98;97;97;98;98;98;97;96 04:34:24 INFO - PID 1918 | |7;imaging-desaturate;86;83;85;84;85;87;85;85;87;83 04:34:24 INFO - PID 1918 | |8;json-parse-financial;50;50;50;48;48;50;50;50;50;49 04:34:24 INFO - PID 1918 | |9;json-stringify-tinderbox;54;60;60;58;64;59;59;55;65;83 04:34:24 INFO - PID 1918 | |10;stanford-crypto-aes;83;81;90;92;70;100;98;106;71;93 04:34:24 INFO - PID 1918 | |11;stanford-crypto-ccm;139;124;137;146;144;136;135;139;209;180 04:34:24 INFO - PID 1918 | |12;stanford-crypto-pbkdf2;186;186;187;231;206;184;183;175;184;184 04:34:24 INFO - PID 1918 | |13;stanford-crypto-sha256-iterative;68;68;68;67;68;70;77;96;95;77 04:34:24 INFO - PID 1918 | __end_tp_report 04:34:24 INFO - PID 1918 | __start_cc_report 04:34:24 INFO - PID 1918 | _x_x_mozilla_cycle_collect,2124 04:34:24 INFO - PID 1918 | __end_cc_report 04:34:24 INFO - PID 1918 | __startTimestamp1493724864942__endTimestamp 04:34:24 INFO - PID 1918 | 04:34:24 INFO - PID 1918 | ------- Summary: start ------- 04:34:24 INFO - PID 1918 | Number of tests: 14 04:34:24 INFO - PID 1918 | 04:34:24 INFO - PID 1918 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:0.99 (0.9%) stddev-sans-first:1.00 04:34:24 INFO - PID 1918 | Values: 112.0 112.0 110.0 110.0 111.0 113.0 111.0 110.0 111.0 111.0 04:34:24 INFO - PID 1918 | 04:34:24 INFO - PID 1918 | [#1] audio-beat-detection Cycles:10 Average:117.80 Median:110.00 stddev:18.92 (17.2%) stddev-sans-first:18.45 04:34:24 INFO - PID 1918 | Values: 139.0 110.0 106.0 158.0 110.0 105.0 106.0 106.0 134.0 104.0 04:34:24 INFO - PID 1918 | 04:34:24 INFO - PID 1918 | [#2] audio-dft Cycles:10 Average:184.90 Median:185.50 stddev:1.91 (1.0%) stddev-sans-first:1.67 04:34:24 INFO - PID 1918 | Values: 188.0 187.0 185.0 186.0 185.0 183.0 184.0 186.0 183.0 182.0 04:34:24 INFO - PID 1918 | 04:34:24 INFO - PID 1918 | [#3] audio-fft Cycles:10 Average:66.30 Median:62.50 stddev:11.51 (18.4%) stddev-sans-first:10.91 04:34:24 INFO - PID 1918 | Values: 81.0 57.0 57.0 88.0 61.0 63.0 62.0 58.0 78.0 58.0 04:34:24 INFO - PID 1918 | 04:34:24 INFO - PID 1918 | [#4] audio-oscillator Cycles:10 Average:75.90 Median:75.50 stddev:10.59 (14.0%) stddev-sans-first:10.28 04:34:24 INFO - PID 1918 | Values: 88.0 64.0 82.0 69.0 69.0 69.0 89.0 69.0 68.0 92.0 04:34:24 INFO - PID 1918 | 04:34:24 INFO - PID 1918 | [#5] imaging-gaussian-blur Cycles:10 Average:91.80 Median:92.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 04:34:24 INFO - PID 1918 | Values: 92.0 92.0 92.0 91.0 92.0 92.0 92.0 92.0 92.0 91.0 04:34:24 INFO - PID 1918 | 04:34:24 INFO - PID 1918 | [#6] imaging-darkroom Cycles:10 Average:97.20 Median:97.50 stddev:0.79 (0.8%) stddev-sans-first:0.71 04:34:24 INFO - PID 1918 | Values: 96.0 97.0 98.0 97.0 97.0 98.0 98.0 98.0 97.0 96.0 04:34:24 INFO - PID 1918 | 04:34:24 INFO - PID 1918 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:1.41 (1.7%) stddev-sans-first:1.45 04:34:24 INFO - PID 1918 | Values: 86.0 83.0 85.0 84.0 85.0 87.0 85.0 85.0 87.0 83.0 04:34:24 INFO - PID 1918 | 04:34:24 INFO - PID 1918 | [#8] json-parse-financial Cycles:10 Average:49.50 Median:50.00 stddev:0.85 (1.7%) stddev-sans-first:0.88 04:34:24 INFO - PID 1918 | Values: 50.0 50.0 50.0 48.0 48.0 50.0 50.0 50.0 50.0 49.0 04:34:24 INFO - PID 1918 | 04:34:24 INFO - PID 1918 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:60.00 stddev:8.22 (13.7%) stddev-sans-first:8.23 04:34:24 INFO - PID 1918 | Values: 54.0 60.0 60.0 58.0 64.0 59.0 59.0 55.0 65.0 83.0 04:34:24 INFO - PID 1918 | 04:34:24 INFO - PID 1918 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:86.50 stddev:12.01 (13.9%) stddev-sans-first:12.58 04:34:24 INFO - PID 1918 | Values: 83.0 81.0 90.0 92.0 70.0 100.0 98.0 106.0 71.0 93.0 04:34:24 INFO - PID 1918 | 04:34:24 INFO - PID 1918 | [#11] stanford-crypto-ccm Cycles:10 Average:148.90 Median:141.50 stddev:25.67 (18.1%) stddev-sans-first:26.97 04:34:24 INFO - PID 1918 | Values: 139.0 124.0 137.0 146.0 144.0 136.0 135.0 139.0 209.0 180.0 04:34:24 INFO - PID 1918 | 04:34:24 INFO - PID 1918 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.60 Median:186.00 stddev:16.18 (8.7%) stddev-sans-first:17.08 04:34:24 INFO - PID 1918 | Values: 186.0 186.0 187.0 231.0 206.0 184.0 183.0 175.0 184.0 184.0 04:34:24 INFO - PID 1918 | 04:34:24 INFO - PID 1918 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.40 Median:73.50 stddev:11.22 (15.3%) stddev-sans-first:11.57 04:34:24 INFO - PID 1918 | Values: 68.0 68.0 68.0 67.0 68.0 70.0 77.0 96.0 95.0 77.0 04:34:24 INFO - PID 1918 | -------- Summary: end -------- 04:34:24 INFO - PID 1918 | 04:34:26 INFO - TEST-INFO | 1918: exit 0 04:34:26 INFO - TEST-OK | kraken | took 60128ms 04:34:26 INFO - SUITE-END | took 1179s 04:34:26 INFO - Completed test suite (00:19:39) 04:34:26 INFO - javascript benchmark 04:34:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7687.471680794198, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3512.069301635067, 3518.524999125117, 3550.130218096566, 3552.360575096483, 3576.821158942052, 5993.160957465947, 6091.692560820282, 6170.814875553735, 6253.687315634217, 6261.686915654216, 6131.835460087202, 6174.289956654986, 6221.00463925772, 6231.096491008801, 6267.2165979252595, 4864.562189402953, 5161.690298582097, 5352.411234764173, 5383.219433182196, 5397.541208997221, 5402.432744561824, 5404.270423492837, 5482.369527504328, 5483.396826349099, 5484.8354549363585, 5270.077736396153, 5341.412444631087, 5350.625456218067, 5352.973235133838, 5384.273123128406, 5268.657537260104, 5270.49930256625, 5278.313819203518, 5280.313559237313, 5283.735813209324, 5199.1161502544655, 5259.763310650992, 5263.26314315996, 5286.788528458857, 5287.233351164098, 5966.761329546813, 5984.222051133368, 5987.072003839412, 5989.55078369124, 5999.850003749898, 6400.199975003125, 6401.7759378422, 6408.743650253984, 6413.486921046305, 6428.292887782341, 6454.354564543555, 6587.505937054692, 6714.697838597275, 6715.093462382565, 6745.898811517831, 6250.9998400255745, 6298.086777417248, 6313.558050936436, 6338.429541341301, 6347.301796802394, 5664.291963504562, 6850.143732033496, 6855.245922948472, 6865.622390768555, 6893.75871844483, 6353.809385718436, 6396.392342727433, 6401.487880969511, 6457.61254324742, 6555.6066636002, 6636.502262330345, 6678.632675202911, 6683.565568238147, 6687.665616719145, 6699.564528305645, 6566.9343306566325, 6568.441682456949, 6572.671366431755, 6576.736930522726, 6586.407223349922, 6404.039394090923, 6458.935410645928, 6476.740930362827, 6587.143671322698, 6592.143021407186, 5262.158054711228, 5334.759935802898, 5337.306150200449, 5340.492653198017, 5343.385510666245, 4604.355390245369, 4707.552782485658, 4710.199266124767, 4714.0, 4760.880977975578, 6222.315545290015, 6280.214973128359, 6293.024581189923, 6293.622382657055, 6297.748090076438, 6443.5167362448, 6575.210974683068, 6580.177477815273, 6620.503462240351, 6623.4701223901975, 5469.15228139639, 6101.005087479836, 6220.160278362454, 6278.843028924222, 6314.305426403092, 5821.592488525847, 5822.184894114827, 5834.124881267759, 5839.474447299678, 5844.12338149281, 6852.074969879002, 6879.3251301277305, 6922.06552115458, 6926.826829329307, 6946.548474349152, 6451.516136289703, 6529.9020514691365, 6600.8349791255605, 6676.732930682719, 6693.665316734241, 6912.792616221522, 6915.170179578483, 6933.791986240421, 6944.722211111499, 6953.617551034539, 6515.0, 6525.314841941527, 6577.638229897401, 6581.045748366556, 6588.40704336612, 5430.13117901134, 6418.871622567429, 6498.285188629153, 6589.374009469093, 6623.0, 5295.629305948547, 6162.291336496361, 6309.747610095545, 6356.713947872449, 6358.014507751306, 6251.749930002749, 6306.400891915261, 6343.52423568225, 6351.460125889351, 6374.649394283359, 6247.219097612799, 6303.6532990685955, 6319.747210111544, 6334.8733025338315, 6335.556511044367, 6306.716197771203, 6442.742290308523, 6445.12990746262, 6448.871022579616, 6452.387023232785, 5167.354080739908, 6291.559590828598, 6295.087212354091, 6301.054841773587, 6328.746850125944], "value": 6010.858656092305, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [771.6334740998027, 788.5150632361099, 802.8795680647904, 1113.0817075912364, 1119.5633702855887, 26511.4697706046, 26716.732832671667, 26765.197044088683, 26769.0, 26775.598366024526, 26961.92152313905, 37901.86294411165, 38125.618743812556, 38189.85430437084, 38278.4258236126, 8117.39119566032, 8244.010718713733, 8261.13258107899, 8263.710770123047, 8276.255137037666, 5873.941260587403, 8125.4718443301, 8272.090070092285, 8285.171482851696, 8321.583920803936, 6000.129981152752, 7413.481056326059, 8293.295069919064, 8312.085670576233, 8315.916840831605, 8300.958495207546, 8348.457350272212, 8352.206540378655, 8355.498670079754, 8356.164383561656, 8183.877241841377, 8273.83452330956, 8276.048254450756, 8285.95857020717, 8292.253697167283, 25571.61642575363, 25698.743012569823, 25703.61444578333, 25735.356616084562, 36635.0, 3478.7650384113526, 3507.6667716566885, 3509.78941263525, 3510.947335789965, 3513.2797776455764, 30927.0, 30939.690603093906, 30976.225594360098, 30978.0, 31045.689543104505, 3052.8931487397836, 3159.699828516287, 3167.683231676837, 3176.428242916274, 3181.8545323683456, 292885.0, 296850.0, 299760.0, 299802.0, 300422.0, 49175.75412122916, 49263.75368123208, 49326.75336623366, 49372.50627493679, 49403.752981234866, 42405.57594424016, 52516.0, 52522.0, 52575.737121314145, 52628.47371526312, 14002.929985350009, 14145.85854141466, 14148.929255353863, 14166.220857852917, 14173.503927362493, 11475.540978360772, 11488.655340339803, 11494.367809770376, 11496.137789665641, 11503.76992460163, 10876.477293178961, 12651.0, 12809.871901280869, 12898.097133200587, 12906.09657323997, 4634.802985510929, 4895.527758481944, 5808.88382232353, 5963.2844058713235, 5982.222311099529, 1005.5173516711873, 1030.1346868630387, 1032.6592224565875, 1058.327842009623, 1059.2055958031476, 24197.274081777574, 25154.0, 25217.369565760637, 25249.242522724348, 25302.0, 916.876221710074, 928.4614923344444, 1098.3794156301665, 1141.1612464838338, 1143.6111722014555, 10825.891741082645, 12015.459304331325, 12043.518259269706, 12477.688057798629, 12486.625401237978, 305759.0, 306630.0, 307453.0, 307850.0, 309323.0, 53742.46257537375, 53746.7312663442, 53903.0, 53903.0, 54037.45962540403, 1488.739470592642, 1493.2160615676858, 1533.4709525213784, 1534.647031182834, 1566.0681894273116, 24087.51824963456, 24119.276421707378, 24177.0, 24196.39509012289, 24304.635430468203, 39183.608163918, 39273.60726392699, 39296.0, 39310.606893931836, 39311.60688393079, 284724.0, 284918.0, 284978.5751071231, 285869.0, 286170.56914715294, 34127.82936085304, 35061.29877402489, 35537.82231088828, 35701.46447803337, 35787.64212357947, 36875.26249475049, 44649.55350446454, 46373.0, 46443.0, 46501.53498464972, 25750.0, 28877.422451550432, 30618.08145755631, 30935.0, 31602.683973159976, 30828.38343233078, 31106.533401998535, 31603.525947111273, 31697.890573829805, 31782.52326215155, 36449.387722646774, 36734.0, 37979.050523737125, 38153.809230953666, 38353.80823095867, 27356.316092097855, 27516.07387482857, 29802.701972979994, 30302.84848575743, 32434.351312973136, 23268.41828954222, 23547.529049418572, 24201.878990604935, 24244.0, 24433.267001989967], "value": 17000.18577040378, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.4428645604505, 412.4967539601687, 422.12409250804586, 429.51893878855685, 444.32019010913297, 19393.933333666642, 20568.588628227426, 20759.68860467094, 21279.04244309006, 21315.0, 21085.789142108573, 21102.83934383612, 21278.36164915055, 21900.561988760215, 22085.0, 5882.235309409771, 6172.290186628527, 6177.969110154443, 6178.320384757673, 6178.567500274982, 5752.769889204447, 5909.7636094556165, 5966.850828729295, 6000.459958603725, 6094.878102437949, 5928.40715928408, 5944.405559444064, 5946.078357854518, 5947.970260148715, 5949.048152295633, 5685.516731077842, 5900.996830538818, 5940.881182376372, 5973.850653733692, 5981.1028345748055, 5303.071962406563, 5304.124819404794, 5311.229871668586, 5311.681299122065, 5317.0, 25708.357291067685, 26473.073442429424, 26897.924083036654, 27035.864820675968, 27388.863055684793, 2200.515886504966, 2209.414505156135, 2247.426906138924, 2247.8763667998255, 2249.2127755285683, 13938.721225575533, 17247.31010759568, 17601.383951561635, 18020.729689054675, 18107.909460452745, 2074.502119491326, 2101.6532272175073, 2132.6694362373855, 2148.602508535926, 2175.4343870593602, 131986.02020969693, 148426.0, 149516.53384263106, 150279.0, 150820.0, 11375.658730238107, 11893.34586597728, 11906.0, 11938.64184074479, 12009.579664711693, 15875.0, 15882.602934926488, 15908.840911590967, 15912.204389780696, 15918.044917304998, 7045.252351582887, 7239.819004524824, 8624.0, 8922.152395522415, 8958.193762561401, 8388.8741668875, 8415.873761893576, 8432.45189062709, 8574.571271436404, 8574.928133983252, 5990.31111422192, 7456.142543607446, 7465.664045117983, 7491.438142139253, 7498.137714162941, 2014.1377937076686, 2042.0708577597159, 2044.3866839947957, 2045.7623138001593, 2064.9690254646193, 913.620847348343, 924.6393906376519, 931.9207867331218, 941.8445956417252, 970.1123472023161, 18432.354867579572, 20319.0, 20942.47643808917, 20970.790292096885, 21060.47348816292, 943.1370296178919, 964.1611797735875, 968.2012339819677, 999.1806718490913, 1001.6944831826218, 10650.786984260272, 10870.0, 10870.239083264254, 10900.705750821002, 10957.616483423042, 538863.0, 549333.0, 554754.0, 564283.0, 568041.0, 139463.0, 142104.0, 143216.0, 145092.0, 146441.26779366034, 1079.681493959284, 1161.3670549550516, 1173.861354486147, 1174.7767924094394, 1177.252444697606, 18197.727034094765, 18236.544086397946, 18244.361447349278, 18289.26842926268, 18420.0, 55942.24490918317, 56345.71827140838, 56743.71628141833, 57171.14243286437, 58149.709251453474, 76563.0, 77932.61033695022, 78155.0, 78834.0, 79237.81143282971, 8617.784555386166, 8748.343874209333, 8865.335099867407, 8932.151445612917, 9171.724848254564, 13091.672708182372, 14369.0, 14424.0, 14752.852471475577, 15005.324760386027, 9684.852422962424, 11501.884981150082, 11721.706957326134, 11752.882471175179, 11849.407529623657, 11427.0, 11465.082793376676, 11692.123090768056, 11767.941160294144, 11895.345755983504, 12114.939425302817, 12191.939040304742, 12372.876271237532, 12506.37468126572, 12594.370281486072, 8796.560171991247, 8886.357163201543, 9123.27013838878, 9254.583543740413, 9254.953725231331, 10146.391216527032, 10206.285560010729, 11821.586244481401, 11959.103067270164, 12307.69230769238], "value": 10246.187832262736, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1201.8437603111595, 1257.4467234416857, 1476.8375478697342, 1496.790449337093, 1499.7600383938568, 9710.757231069227, 10163.59345626175, 10950.34297942124, 11488.827667584992, 11793.292402455858, 11286.0, 11394.487248073836, 11409.144314176428, 11410.942945285282, 11412.31526108434, 2159.341400872733, 2447.8617442889054, 2458.0782206672543, 2503.9749602504016, 2510.0, 2090.9372718818386, 2184.595849767798, 2449.0, 2543.122622695167, 2554.3741783263126, 2481.1068015514493, 2497.2258599834017, 2504.9980007996764, 2508.3352911478473, 2514.5599520084, 2105.768365479796, 2496.1887386599337, 2499.5875680512695, 2505.8621775802326, 2512.937176570582, 2449.3956458519697, 2461.59383701689, 2488.5271798358253, 2496.3509487533192, 2503.111395454624, 11450.141239407078, 11551.191416600841, 11573.710657233552, 11581.710457238552, 11584.015358694436, 6469.417752402306, 6705.664716764142, 6712.160979877515, 6716.697748601325, 6727.428168605626, 3582.247727977128, 3940.4089386591954, 4124.422580838685, 4283.87148385549, 4305.0098477350075, 1250.7998720204723, 1252.0922331309728, 1276.5978716704208, 1297.7274772297828, 1297.8831905128584, 16319.184040797913, 16401.753973690404, 16409.17954102302, 16421.343146274136, 16425.753613695684, 5664.20701101846, 5929.673867937305, 5942.970285148546, 6055.878882422415, 6107.083937409424, 13850.515231966832, 13868.4452621894, 13868.514601988882, 13869.930650346683, 13872.167669939634, 6790.166655003121, 6801.761938332134, 6811.93188068113, 6813.965930170318, 6816.977453382033, 5213.3222681051975, 6140.232470941132, 6232.781852635136, 6288.874222515524, 6385.680715964183, 3920.3727403615853, 4130.524989626171, 4182.163567286555, 4729.6588188846745, 4729.777004807735, 1304.7847105227531, 1377.9871794231233, 1433.3621538415514, 1455.6943041961094, 1475.7565001774801, 705.3158436316764, 791.0981481111537, 800.4556901307167, 813.1421350475306, 817.7873752824308, 6544.672766361663, 6853.074834897325, 6996.090508233999, 6996.755113571001, 7067.116610423697, 912.2747415804452, 944.244604316544, 952.0812416018575, 954.8185844689486, 959.7648576098901, 3824.0057585028094, 3827.2154208387215, 3905.843766249375, 3973.3642617181113, 3978.522577290744, 13712.0, 15355.385784568716, 15378.231088445533, 15389.076655400711, 15399.384024639114, 13794.172349659053, 13899.332080150245, 15270.31283592241, 15276.847231527765, 15287.0, 8475.74572762818, 8672.696455624024, 8702.825943481095, 8710.390272680852, 8729.258013068833, 6541.476681865534, 6802.285759995129, 6920.30796920304, 6967.372936435745, 7078.256783037707, 12693.873061269638, 13459.663508412368, 13563.86436135626, 13743.656408589864, 13787.96590255755, 13446.731065378834, 13688.315584220949, 13907.165570065828, 13983.580492585239, 14292.0, 9187.678431254873, 9204.677836275967, 9323.72028839136, 9421.81156376855, 9447.244220462484, 9566.808663826823, 9850.507474626384, 9854.753631159278, 10604.204684648528, 10727.517261723397, 7542.509736867086, 9059.36584439083, 9219.677311294072, 9230.676926307548, 9566.61733530651, 8985.326100542356, 9020.81958360816, 9038.0, 9062.139096785795, 9064.592093355946, 8184.590770461572, 8314.210150035737, 8314.542700151549, 8319.459235149938, 8319.708810191614, 6012.669303188367, 6039.577229594062, 6138.324784273637, 6162.907556386568, 6240.625562466266, 5241.947580524146, 5486.588505861996, 6102.542309326907, 6181.165542651865, 6300.831173473889], "value": 5391.7444793050045, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.4212995777221, 394.3690095846646, 400.95751047277065, 402.6879168644301, 407.3604441027586, 5654.660720356782, 5794.696193356498, 5868.2664666916635, 5943.315144610337, 6006.66963317018, 4474.776261186936, 4757.666963312569, 5431.375391829941, 5844.970775146118, 5846.473817356437, 4469.240229161051, 4475.896328725502, 4476.060027394235, 4476.932846007313, 4492.056668099703, 4469.932951005738, 4490.259107247301, 4520.186366454037, 4524.773761311938, 4526.592606665399, 3561.982190089046, 4042.818073186699, 4103.466549348595, 4470.463544374663, 4492.820287188509, 4004.7997600120025, 4427.778611069466, 4429.291313389875, 4453.153900758862, 4457.64338852891, 3103.332783451569, 3900.7907548660005, 3963.1083006323347, 3964.385520244367, 3980.3432433648413, 5552.225685287337, 5723.227364305807, 5745.3105627324985, 5754.021816291241, 5798.681072541009, 5366.350881400646, 5367.677939323653, 5380.569554435636, 5396.271503347037, 5441.29263195782, 5990.652103276771, 6299.9370006299805, 6317.905231421532, 6318.210223722035, 6330.493560515194, 4087.182563487285, 4319.524852266248, 4427.00392411708, 4483.282674772054, 4588.564086411819, 6358.245787562218, 6560.835979100513, 6567.408933195939, 6570.408663220285, 6580.5393622446445, 3704.981475092607, 3904.375299951994, 4092.2224777292217, 4318.1363727254675, 4465.642748580106, 4118.773467459318, 4198.4961804583645, 4531.45622525299, 4681.518795038635, 4705.905881882343, 5340.198970154508, 5386.865328366822, 5387.191921211771, 5393.271908292409, 5401.864953376197, 6031.849203769941, 6334.936650633527, 6338.556301058881, 6344.460720838688, 6368.713407896656, 1243.5958313548133, 1449.4999225267266, 1450.0139904864582, 1458.5332693537966, 1461.7661174212076, 923.2337160157188, 940.5767404667927, 948.4783369147079, 961.4952150121243, 963.3160456076124, 5649.700568869183, 5657.377688454267, 5997.790077347359, 6008.609440386361, 6055.666938318347, 6551.475881929434, 6554.0, 6557.622899191223, 6561.915899527215, 6611.23970743361, 5883.235029491136, 5928.67392293428, 5931.703414829241, 5959.314678811906, 6010.939890601038, 3372.747043971663, 3387.627360990289, 3390.355832391838, 3403.540522029544, 3415.777974431654, 6012.428819262163, 6134.1904138279315, 6611.636360000246, 6659.966700166468, 6803.353681400259, 6649.634270115093, 6691.899621505681, 6699.162604674416, 6699.665016749143, 6786.423154031864, 4724.952750472588, 5966.105084237399, 6216.875662486816, 6767.763128290486, 6804.699720635488, 6089.0, 6327.3356297589935, 6366.299707032315, 6485.481161506974, 6524.445422139172, 6408.038794180724, 6410.551261411656, 6413.294537600954, 6429.8392540185, 6524.347565243438, 5930.695247045643, 6466.224053113657, 6510.804675859732, 6743.0, 6787.253402125861, 4162.62536371728, 4175.390381011867, 4182.372644103287, 4188.434561334303, 4193.140406216779, 6339.2392912850755, 6434.485241180788, 6456.515761317826, 6538.574992625464, 6578.572392794453, 5298.231756395378, 5764.711764411846, 6263.154474145932, 6327.873442531216, 6349.841253968503, 5535.6955367455175, 6043.8186854394435, 6241.3134555197985, 6295.842603934938, 6301.716422761078, 6061.817146339816, 6179.84550386244, 6182.814515564541, 6190.319064902767, 6277.937220627735, 6234.719437625408, 6291.168973961827, 6302.968485157545, 6311.873762524816, 6396.857052887149, 5378.784848606168, 5789.797357092481, 6055.910710804766, 6160.691965401802, 6162.506999439945], "value": 4632.096020959432, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.1914108345941, 857.3055824781924, 860.8837806896067, 865.1348651348651, 883.2801266967423, 12832.294223817698, 17764.46706598804, 18083.638327233464, 18735.06324683767, 18747.343842965463, 14237.430502779902, 17039.659206815857, 17615.91192044038, 17616.383426580072, 17801.554961125945, 946.9668561600346, 958.2669258017587, 964.9758756031121, 966.6665000574826, 966.9081437263449, 655.9836004099888, 667.3360006793248, 819.6557445872718, 979.2508730820928, 981.1267971505366, 1024.8155332040267, 1030.7114008077713, 1031.9380837149758, 1032.6747074671455, 1034.2708390584658, 1028.9073983341461, 1029.613894789454, 1030.0935177044153, 1030.953607087679, 1035.5495359518595, 758.3175142371854, 759.1952530317881, 759.255929189392, 759.5898214963913, 763.0347610273009, 16423.91788041064, 16511.752323715154, 16715.0, 16891.408800691916, 17049.318027278892, 16357.427490037791, 16486.83513164865, 16813.663726725397, 16875.0, 17093.31626734929, 12709.237445753284, 13815.447382104703, 13950.790738138936, 14038.227897465635, 14125.223112728796, 3403.0301364111356, 3419.0, 3429.228423604694, 3430.433978393562, 3430.7598468107244, 89622.55188724014, 120409.0, 122813.0, 123262.0, 124995.75004249932, 10723.356598604109, 11140.944295278634, 11876.94061529704, 12089.03287736979, 12113.091518136, 17691.292348305924, 19540.902295488715, 23688.881555592456, 25049.12328068509, 25123.37191570189, 7662.387009039264, 7829.491083079695, 7953.721619743281, 7965.362770978424, 7967.322777563972, 3895.4935858338235, 3989.4414781930554, 3989.8005099744896, 3993.4409182714444, 3999.8200080996426, 3494.2836718472654, 4111.280525907954, 4193.370994350872, 4199.181159673834, 4203.5376108628025, 862.0603542139098, 884.4516399832145, 888.9288856891433, 891.3315013739696, 892.0856122474386, 664.8902931016328, 672.2202245395416, 674.1775034457953, 682.3892616108556, 690.4717890813532, 10124.797504049879, 10494.527746251437, 10874.0, 11956.58151964677, 11990.580329688419, 659.7394029358377, 663.1147418196762, 663.741140955028, 674.9730010799512, 679.4258851270669, 5232.843014709489, 5254.043587401852, 5419.783208671609, 5466.398696143421, 5551.694656793915, 105454.0, 107316.0, 108223.45888270508, 108289.45855270674, 109486.0, 69829.60340793258, 78420.21579784129, 89023.66464503038, 94645.52677236707, 96354.0, 84763.57618211993, 85094.0, 85761.0, 86046.2790744194, 86122.27755444856, 9469.715908522756, 10200.234982376203, 10830.837537436788, 11154.55381784752, 11286.66140015801, 31712.0, 38009.80995095007, 38363.424548631236, 41647.95880103022, 42457.938551536456, 54466.83429896941, 54800.53397597197, 55162.72418637881, 55261.89476210373, 55729.0, 13681.521146759816, 13957.441702331793, 14172.29138543048, 14194.503192388216, 14204.28978551089, 12589.622311330675, 15269.77095343593, 15335.309911053806, 15485.922570387076, 15539.844601554292, 12282.508699652271, 12368.1960672556, 12478.0, 12525.874741252836, 12535.749285014066, 13837.515686950908, 14040.578782636538, 14245.928770356082, 14377.56867293983, 14380.921430892515, 13392.732145357233, 13624.18254904709, 13784.172949623055, 13789.103708258932, 13963.650908726957, 10177.643782467578, 10241.897581024094, 10292.279540432099, 10408.063274305348, 10532.262741608014, 11456.599019034295, 11692.94153529227, 11741.589044383405, 11751.529938802352, 11886.227395219283], "value": 7892.43976344212, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1444.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 110.0, 110.0, 111.0, 113.0, 111.0, 110.0, 111.0, 111.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 110.0, 106.0, 158.0, 110.0, 105.0, 106.0, 106.0, 134.0, 104.0], "value": 117.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 187.0, 185.0, 186.0, 185.0, 183.0, 184.0, 186.0, 183.0, 182.0], "value": 184.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 57.0, 57.0, 88.0, 61.0, 63.0, 62.0, 58.0, 78.0, 58.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 64.0, 82.0, 69.0, 69.0, 69.0, 89.0, 69.0, 68.0, 92.0], "value": 75.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 92.0, 91.0, 92.0, 92.0, 92.0, 92.0, 92.0, 91.0], "value": 91.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 98.0, 97.0, 97.0, 98.0, 98.0, 98.0, 97.0, 96.0], "value": 97.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 85.0, 84.0, 85.0, 87.0, 85.0, 85.0, 87.0, 83.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 50.0, 48.0, 48.0, 50.0, 50.0, 50.0, 50.0, 49.0], "value": 49.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 60.0, 60.0, 58.0, 64.0, 59.0, 59.0, 55.0, 65.0, 83.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 90.0, 92.0, 70.0, 100.0, 98.0, 106.0, 71.0, 93.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 124.0, 137.0, 146.0, 144.0, 136.0, 135.0, 139.0, 209.0, 180.0], "value": 148.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 186.0, 187.0, 231.0, 206.0, 184.0, 183.0, 175.0, 184.0, 184.0], "value": 190.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 67.0, 68.0, 70.0, 77.0, 96.0, 95.0, 77.0], "value": 75.4, "unit": "score"}]}]} 04:34:26 INFO - Return code: 0 04:34:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:34:26 ERROR - # TBPL SUCCESS # 04:34:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:34:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:34:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:34:26 INFO - 2017-05-02 04:34:26.762 screenresolution[1923:20129] starting screenresolution argv=screenresolution get 04:34:26 INFO - 2017-05-02 04:34:26.764 screenresolution[1923:20129] Display 0: 1600x1200x32@60 04:34:26 INFO - 2017-05-02 04:34:26.771 screenresolution[1924:20132] starting screenresolution argv=screenresolution list 04:34:26 INFO - Available Modes on Display 0 04:34:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:34:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:34:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:34:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:34:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:34:27 INFO - Intel Iris: 04:34:27 INFO - Chipset Model: Intel Iris 04:34:27 INFO - Type: GPU 04:34:27 INFO - Bus: Built-In 04:34:27 INFO - VRAM (Dynamic, Max): 1536 MB 04:34:27 INFO - Vendor: Intel (0x8086) 04:34:27 INFO - Device ID: 0x0a2e 04:34:27 INFO - Revision ID: 0x0009 04:34:27 INFO - Displays: 04:34:27 INFO - Display: 04:34:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:34:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:34:27 INFO - Display Serial Number: 1600x1200 60 04:34:27 INFO - Main Display: Yes 04:34:27 INFO - Mirror: Off 04:34:27 INFO - Online: Yes 04:34:27 INFO - Rotation: Supported 04:34:27 INFO - Return code: 0 04:34:27 INFO - Running post-action listener: _resource_record_post_action 04:34:27 INFO - [mozharness: 2017-05-02 11:34:27.010587Z] Finished run-tests step (success) 04:34:27 INFO - Running post-run listener: _resource_record_post_run 04:34:27 INFO - Total resource usage - Wall time: 1200s; CPU: 53.0%; Read bytes: 147456; Write bytes: 509454336; Read time: 7; Write time: 1544 04:34:27 INFO - TinderboxPrint: CPU usage
53.3% 04:34:27 INFO - TinderboxPrint: I/O read bytes / time
147,456 / 7 04:34:27 INFO - TinderboxPrint: I/O write bytes / time
509,454,336 / 1,544 04:34:27 INFO - TinderboxPrint: CPU idle
2,244.5 (46.7%) 04:34:27 INFO - TinderboxPrint: CPU system
955.5 (19.9%) 04:34:27 INFO - TinderboxPrint: CPU user
1,601.7 (33.4%) 04:34:27 INFO - TinderboxPrint: Swap in / out
208,588,800 / 0 04:34:27 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201089536; Write bytes: 194729984; Read time: 16130; Write time: 392 04:34:27 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 147456; Write bytes: 297877504; Read time: 7; Write time: 1100 04:34:27 INFO - Running post-run listener: _upload_blobber_files 04:34:27 INFO - Blob upload gear active. 04:34:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:34:27 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:34:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:34:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:34:27 INFO - (blobuploader) - INFO - Open directory for files ... 04:34:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:34:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:34:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:28 INFO - (blobuploader) - INFO - Done attempting. 04:34:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:34:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:34:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:29 INFO - (blobuploader) - INFO - Done attempting. 04:34:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:34:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:34:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:30 INFO - (blobuploader) - INFO - Done attempting. 04:34:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:34:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:34:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:33 INFO - (blobuploader) - INFO - Done attempting. 04:34:33 INFO - (blobuploader) - INFO - Iteration through files over. 04:34:33 INFO - Return code: 0 04:34:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:34:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:34:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11bb535c41e1538f2bd9c8de9bde29372336510e8f655093dd3da9378f229c6fc1c41143a30d3ee5456d1f97bda3e73b40cdf8d3c42e6c0f23ca16fbcc950a58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a80c0204bdc9b637910003dea75f97c0986fd0970fc3051a55bb93d2aa30b9a0a2b880e9086ed9fa46398846e7a07f32bad91b38d50de05517b41e5e9e77caa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e682e62fdf38e6ee2e701f495f65022fcc7ff449d92eaed58e66b4d2947eaa4776d1385c49eba3597aa961cb8d24f2e2173f5e3760ca3ec06c831ed2dc0900b3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65aa345f685bf0ed34c55a6e2911d7f58b4713515072f927ee21dbb275b3f38c4a0e24425f37ac3bb678d49c0c5f821450a7adc27321626d3f12e65ab6b73cb6"} 04:34:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:34:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:34:33 INFO - Contents: 04:34:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11bb535c41e1538f2bd9c8de9bde29372336510e8f655093dd3da9378f229c6fc1c41143a30d3ee5456d1f97bda3e73b40cdf8d3c42e6c0f23ca16fbcc950a58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a80c0204bdc9b637910003dea75f97c0986fd0970fc3051a55bb93d2aa30b9a0a2b880e9086ed9fa46398846e7a07f32bad91b38d50de05517b41e5e9e77caa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e682e62fdf38e6ee2e701f495f65022fcc7ff449d92eaed58e66b4d2947eaa4776d1385c49eba3597aa961cb8d24f2e2173f5e3760ca3ec06c831ed2dc0900b3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65aa345f685bf0ed34c55a6e2911d7f58b4713515072f927ee21dbb275b3f38c4a0e24425f37ac3bb678d49c0c5f821450a7adc27321626d3f12e65ab6b73cb6"} 04:34:33 INFO - Running post-run listener: copy_logs_to_upload_dir 04:34:33 INFO - Copying logs to upload dir... 04:34:33 INFO - mkdir: /builds/slave/test/build/upload/logs 04:34:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.186210 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-05-02 04:34:33.369608) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-02 04:34:33.373127) ========= 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.gM5us60eHv/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.odg8H5uu3h/Listeners TMPDIR=/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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/11bb535c41e1538f2bd9c8de9bde29372336510e8f655093dd3da9378f229c6fc1c41143a30d3ee5456d1f97bda3e73b40cdf8d3c42e6c0f23ca16fbcc950a58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a80c0204bdc9b637910003dea75f97c0986fd0970fc3051a55bb93d2aa30b9a0a2b880e9086ed9fa46398846e7a07f32bad91b38d50de05517b41e5e9e77caa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e682e62fdf38e6ee2e701f495f65022fcc7ff449d92eaed58e66b4d2947eaa4776d1385c49eba3597aa961cb8d24f2e2173f5e3760ca3ec06c831ed2dc0900b3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65aa345f685bf0ed34c55a6e2911d7f58b4713515072f927ee21dbb275b3f38c4a0e24425f37ac3bb678d49c0c5f821450a7adc27321626d3f12e65ab6b73cb6"} build_url:https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011147 build_url: 'https://queue.taskcluster.net/v1/task/Ib1rZPuXRC-J1YlHzn2NWQ/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/11bb535c41e1538f2bd9c8de9bde29372336510e8f655093dd3da9378f229c6fc1c41143a30d3ee5456d1f97bda3e73b40cdf8d3c42e6c0f23ca16fbcc950a58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a80c0204bdc9b637910003dea75f97c0986fd0970fc3051a55bb93d2aa30b9a0a2b880e9086ed9fa46398846e7a07f32bad91b38d50de05517b41e5e9e77caa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e682e62fdf38e6ee2e701f495f65022fcc7ff449d92eaed58e66b4d2947eaa4776d1385c49eba3597aa961cb8d24f2e2173f5e3760ca3ec06c831ed2dc0900b3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65aa345f685bf0ed34c55a6e2911d7f58b4713515072f927ee21dbb275b3f38c4a0e24425f37ac3bb678d49c0c5f821450a7adc27321626d3f12e65ab6b73cb6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-02 04:34:33.408179) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 04:34:33.408499) ========= 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.gM5us60eHv/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.odg8H5uu3h/Listeners TMPDIR=/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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.005097 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 04:34:33.456966) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-02 04:34:33.457304) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-02 04:34:33.457757) ========= ========= Total master_lag: 0.84 =========