builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0177 starttime: 1492616898.25 results: success (0) buildid: 20170419080320 builduid: ba30df0b5e954c42ac2dd7e05233b4b7 revision: ef8d16ae0d0d5d5dc09c7a0d2463bde16b31b174 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-19 08:48:18.246675) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-19 08:48:18.247129) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-19 08:48:18.247421) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-19 08:48:18.273975) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 08:48:18.274339) ========= 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.oJ9OREoQV7/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.OwQFuaNehi/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-19 08:48:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 135M=0s 2017-04-19 08:48:18 (135 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.138767 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 08:48:18.437136) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 08:48:18.437460) ========= 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.oJ9OREoQV7/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.OwQFuaNehi/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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.032434 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 08:48:18.492368) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 08:48:18.492718) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ef8d16ae0d0d5d5dc09c7a0d2463bde16b31b174 --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 ef8d16ae0d0d5d5dc09c7a0d2463bde16b31b174 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oJ9OREoQV7/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.OwQFuaNehi/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-19 08:48:18,596 truncating revision to first 12 chars 2017-04-19 08:48:18,596 Setting DEBUG logging. 2017-04-19 08:48:18,596 attempt 1/10 2017-04-19 08:48:18,596 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ef8d16ae0d0d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-19 08:48:19,048 unpacking tar archive at: mozilla-central-ef8d16ae0d0d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.733106 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 08:48:19.251278) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-19 08:48:19.251828) ========= script_repo_revision: ef8d16ae0d0d5d5dc09c7a0d2463bde16b31b174 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-19 08:48:19.252988) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-19 08:48:19.253536) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-19 08:48:19.275499) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-04-19 08:48:19.275891) ========= /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.oJ9OREoQV7/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.OwQFuaNehi/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:48:19 INFO - MultiFileLogger online at 20170419 08:48:19 in /builds/slave/test 08:48:19 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 08:48:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:48:19 INFO - {'append_to_log': False, 08:48:19 INFO - 'base_work_dir': '/builds/slave/test', 08:48:19 INFO - 'blob_upload_branch': 'Firefox', 08:48:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:48:19 INFO - 'branch': 'Firefox', 08:48:19 INFO - 'buildbot_json_path': 'buildprops.json', 08:48:19 INFO - 'config_files': ('talos/mac_config.py',), 08:48:19 INFO - 'default_actions': ('clobber', 08:48:19 INFO - 'read-buildbot-config', 08:48:19 INFO - 'download-and-extract', 08:48:19 INFO - 'populate-webroot', 08:48:19 INFO - 'create-virtualenv', 08:48:19 INFO - 'install', 08:48:19 INFO - 'run-tests'), 08:48:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:48:19 INFO - 'download_minidump_stackwalk': True, 08:48:19 INFO - 'download_symbols': 'ondemand', 08:48:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:48:19 INFO - 'tooltool.py': '/tools/tooltool.py', 08:48:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:48:19 INFO - '/tools/misc-python/virtualenv.py')}, 08:48:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:48:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:48:19 INFO - 'gecko_profile': False, 08:48:19 INFO - 'gecko_profile_interval': 0, 08:48:19 INFO - 'installer_path': 'installer.exe', 08:48:19 INFO - 'log_level': 'info', 08:48:19 INFO - 'log_name': 'talos', 08:48:19 INFO - 'log_to_console': True, 08:48:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:48:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:48:19 INFO - 'opt_config_files': (), 08:48:19 INFO - 'pip_index': False, 08:48:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:48:19 INFO - 'cmd': ('bash', 08:48:19 INFO - '-c', 08:48:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:48:19 INFO - 'enabled': True, 08:48:19 INFO - 'halt_on_failure': False, 08:48:19 INFO - 'name': 'check_screen_resolution'},), 08:48:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:48:19 INFO - 'cmd': ('bash', 08:48:19 INFO - '-c', 08:48:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:48:19 INFO - 'enabled': True, 08:48:19 INFO - 'halt_on_failure': False, 08:48:19 INFO - 'name': 'check_screen_resolution'},), 08:48:19 INFO - 'run_cmd_checks_enabled': True, 08:48:19 INFO - 'suite': 'dromaeojs', 08:48:19 INFO - 'system_bits': '32', 08:48:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:48:19 INFO - 'title': 't-yosemite-r7-0177', 08:48:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:48:19 INFO - 'use_talos_json': True, 08:48:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:48:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:48:19 INFO - 'work_dir': 'build'} 08:48:19 INFO - [mozharness: 2017-04-19 15:48:19.496772Z] Running clobber step. 08:48:19 INFO - Running pre-action listener: _resource_record_pre_action 08:48:19 INFO - Running main action method: clobber 08:48:19 INFO - rmtree: /builds/slave/test/build 08:48:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:48:21 INFO - Running post-action listener: _resource_record_post_action 08:48:21 INFO - [mozharness: 2017-04-19 15:48:21.956696Z] Finished clobber step (success) 08:48:21 INFO - [mozharness: 2017-04-19 15:48:21.956861Z] Running read-buildbot-config step. 08:48:21 INFO - Running pre-action listener: _resource_record_pre_action 08:48:21 INFO - Running main action method: read_buildbot_config 08:48:21 INFO - Using buildbot properties: 08:48:21 INFO - { 08:48:21 INFO - "project": "", 08:48:21 INFO - "product": "firefox", 08:48:21 INFO - "script_repo_revision": "production", 08:48:21 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:48:21 INFO - "repository": "", 08:48:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:48:21 INFO - "buildid": "20170419080320", 08:48:21 INFO - "pgo_build": "False", 08:48:21 INFO - "basedir": "/builds/slave/test", 08:48:21 INFO - "buildnumber": 23, 08:48:21 INFO - "slavename": "t-yosemite-r7-0177", 08:48:21 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 08:48:21 INFO - "platform": "yosemite_r7", 08:48:21 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:48:21 INFO - "branch": "mozilla-central", 08:48:21 INFO - "repo_path": "mozilla-central", 08:48:21 INFO - "revision": "ef8d16ae0d0d5d5dc09c7a0d2463bde16b31b174", 08:48:21 INFO - "stage_platform": "macosx64", 08:48:21 INFO - "builduid": "ba30df0b5e954c42ac2dd7e05233b4b7", 08:48:21 INFO - "slavebuilddir": "test" 08:48:21 INFO - } 08:48:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zz5A3NYiSL2WYZw1pYWyWA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 08:48:21 INFO - Running post-action listener: _resource_record_post_action 08:48:21 INFO - [mozharness: 2017-04-19 15:48:21.960280Z] Finished read-buildbot-config step (success) 08:48:21 INFO - [mozharness: 2017-04-19 15:48:21.960426Z] Running download-and-extract step. 08:48:21 INFO - Running pre-action listener: _resource_record_pre_action 08:48:21 INFO - Running main action method: download_and_extract 08:48:21 INFO - mkdir: /builds/slave/test/build/tests 08:48:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:21 INFO - trying https://queue.taskcluster.net/v1/task/Zz5A3NYiSL2WYZw1pYWyWA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 08:48:21 INFO - Downloading https://queue.taskcluster.net/v1/task/Zz5A3NYiSL2WYZw1pYWyWA/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 08:48:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zz5A3NYiSL2WYZw1pYWyWA/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 08:48:23 INFO - Downloaded 1325 bytes. 08:48:23 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 08:48:23 INFO - Using the following test package requirements: 08:48:23 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:48:23 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 08:48:23 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 08:48:23 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:48:23 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 08:48:23 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:48:23 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 08:48:23 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:48:23 INFO - u'jsshell-mac.zip'], 08:48:23 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:48:23 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 08:48:23 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 08:48:23 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:48:23 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 08:48:23 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:48:23 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 08:48:23 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:48:23 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 08:48:23 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:48:23 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 08:48:23 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:48:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zz5A3NYiSL2WYZw1pYWyWA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 08:48:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zz5A3NYiSL2WYZw1pYWyWA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:48:23 INFO - Fetch https://queue.taskcluster.net/v1/task/Zz5A3NYiSL2WYZw1pYWyWA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 08:48:24 INFO - Expected file size: 52612719 08:48:24 INFO - Obtained file size: 52612719 08:48:41 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 08:48:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zz5A3NYiSL2WYZw1pYWyWA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 08:48:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zz5A3NYiSL2WYZw1pYWyWA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:48:41 INFO - Fetch https://queue.taskcluster.net/v1/task/Zz5A3NYiSL2WYZw1pYWyWA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 08:48:43 INFO - Expected file size: 52612719 08:48:43 INFO - Obtained file size: 52612719 08:48:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zz5A3NYiSL2WYZw1pYWyWA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 08:48:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zz5A3NYiSL2WYZw1pYWyWA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:48:58 INFO - Fetch https://queue.taskcluster.net/v1/task/Zz5A3NYiSL2WYZw1pYWyWA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 08:49:00 INFO - Expected file size: 14408802 08:49:00 INFO - Obtained file size: 14408802 08:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:00 INFO - trying https://queue.taskcluster.net/v1/task/Zz5A3NYiSL2WYZw1pYWyWA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:49:00 INFO - Downloading https://queue.taskcluster.net/v1/task/Zz5A3NYiSL2WYZw1pYWyWA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 08:49:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zz5A3NYiSL2WYZw1pYWyWA/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 08:49:02 INFO - Downloaded 71005026 bytes. 08:49:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zz5A3NYiSL2WYZw1pYWyWA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:49:02 INFO - mkdir: /builds/slave/test/properties 08:49:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:49:02 INFO - Writing to file /builds/slave/test/properties/build_url 08:49:02 INFO - Contents: 08:49:02 INFO - build_url:https://queue.taskcluster.net/v1/task/Zz5A3NYiSL2WYZw1pYWyWA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:49:03 INFO - Running post-action listener: _resource_record_post_action 08:49:03 INFO - Running post-action listener: set_extra_try_arguments 08:49:03 INFO - [mozharness: 2017-04-19 15:49:03.099172Z] Finished download-and-extract step (success) 08:49:03 INFO - [mozharness: 2017-04-19 15:49:03.099324Z] Running populate-webroot step. 08:49:03 INFO - Running pre-action listener: _resource_record_pre_action 08:49:03 INFO - Running main action method: populate_webroot 08:49:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:49:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:49:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:49:03 INFO - '--tppagecycles', 08:49:03 INFO - '7'], 08:49:03 INFO - 'tests': ['tsvgm']}}, 08:49:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:49:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:49:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:49:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:49:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:49:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:49:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:49:03 INFO - 'talos_options': ['--disable-e10s'], 08:49:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:49:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:49:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:49:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:49:03 INFO - 'talos_options': ['--disable-e10s'], 08:49:03 INFO - 'tests': ['damp', 'tps']}, 08:49:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:49:03 INFO - 'tests': ['damp', 'tps']}, 08:49:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:49:03 INFO - 'tests': ['dromaeo_dom']}, 08:49:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:49:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:49:03 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:49:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:49:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:49:03 INFO - 'tests': ['a11yr', 08:49:03 INFO - 'ts_paint', 08:49:03 INFO - 'tpaint', 08:49:03 INFO - 'sessionrestore', 08:49:03 INFO - 'sessionrestore_no_auto_restore', 08:49:03 INFO - 'tabpaint']}, 08:49:03 INFO - 'other-e10s': {'tests': ['a11yr', 08:49:03 INFO - 'ts_paint', 08:49:03 INFO - 'tpaint', 08:49:03 INFO - 'sessionrestore', 08:49:03 INFO - 'sessionrestore_no_auto_restore', 08:49:03 INFO - 'tabpaint']}, 08:49:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:49:03 INFO - 'ts_paint', 08:49:03 INFO - 'tpaint', 08:49:03 INFO - 'sessionrestore', 08:49:03 INFO - 'sessionrestore_no_auto_restore', 08:49:03 INFO - 'tabpaint']}, 08:49:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:49:03 INFO - 'ts_paint', 08:49:03 INFO - 'tpaint', 08:49:03 INFO - 'sessionrestore', 08:49:03 INFO - 'sessionrestore_no_auto_restore', 08:49:03 INFO - 'tabpaint']}, 08:49:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:49:03 INFO - 'tests': ['a11yr', 08:49:03 INFO - 'ts_paint', 08:49:03 INFO - 'tpaint', 08:49:03 INFO - 'sessionrestore', 08:49:03 INFO - 'sessionrestore_no_auto_restore', 08:49:03 INFO - 'tabpaint']}, 08:49:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:49:03 INFO - 'tests': ['a11yr', 08:49:03 INFO - 'ts_paint', 08:49:03 INFO - 'tpaint', 08:49:03 INFO - 'sessionrestore', 08:49:03 INFO - 'sessionrestore_no_auto_restore', 08:49:03 INFO - 'tabpaint']}, 08:49:03 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 08:49:03 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 08:49:03 INFO - 'bloom_basic_ref']}, 08:49:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:49:03 INFO - 'tests': ['tsvgx', 08:49:03 INFO - 'tsvgr_opacity', 08:49:03 INFO - 'tart', 08:49:03 INFO - 'tscrollx', 08:49:03 INFO - 'cart', 08:49:03 INFO - 'tsvg_static']}, 08:49:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:49:03 INFO - 'tsvgr_opacity', 08:49:03 INFO - 'tart', 08:49:03 INFO - 'tscrollx', 08:49:03 INFO - 'cart', 08:49:03 INFO - 'tsvg_static']}, 08:49:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:49:03 INFO - 'talos_options': ['--disable-e10s'], 08:49:03 INFO - 'tests': ['tp5o']}, 08:49:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:49:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:49:03 INFO - 'talos_options': ['--disable-e10s', 08:49:03 INFO - '--xperf_path', 08:49:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:49:03 INFO - 'tests': ['tp5n']}, 08:49:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:49:03 INFO - 'talos_options': ['--xperf_path', 08:49:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:49:03 INFO - 'tests': ['tp5n']}}, 08:49:03 INFO - 'talos.zip': {'path': '', 08:49:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:49:03 INFO - Running post-action listener: _resource_record_post_action 08:49:03 INFO - [mozharness: 2017-04-19 15:49:03.118575Z] Finished populate-webroot step (success) 08:49:03 INFO - [mozharness: 2017-04-19 15:49:03.118708Z] Running create-virtualenv step. 08:49:03 INFO - Running pre-action listener: _resource_record_pre_action 08:49:03 INFO - Running main action method: create_virtualenv 08:49:03 INFO - Creating virtualenv /builds/slave/test/build/venv 08:49:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:49:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:49:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:49:03 INFO - Using real prefix '/tools/python27' 08:49:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:49:03 INFO - Installing distribute.............................................................................................................................................................................................done. 08:49:06 INFO - Installing pip.................done. 08:49:06 INFO - Return code: 0 08:49:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:49:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:49:07 INFO - Reading from file tmpfile_stdout 08:49:07 INFO - Output received: 08:49:07 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:49:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:07 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 0x1103fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110400768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff601d6ae60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101dbd30>, '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 0x110101db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101d0be8>, '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.oJ9OREoQV7/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.OwQFuaNehi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:49:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:49:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:49:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJ9OREoQV7/Render', 08:49:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:07 INFO - 'HOME': '/Users/cltbld', 08:49:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:07 INFO - 'LOGNAME': 'cltbld', 08:49:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:07 INFO - 'MOZ_NO_REMOTE': '1', 08:49:07 INFO - 'NO_EM_RESTART': '1', 08:49:07 INFO - 'PAGER': '/bin/cat', 08:49:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:07 INFO - 'PWD': '/builds/slave/test', 08:49:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:07 INFO - 'SHELL': '/bin/bash', 08:49:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OwQFuaNehi/Listeners', 08:49:07 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 08:49:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:07 INFO - 'USER': 'cltbld', 08:49:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:07 INFO - 'XPC_FLAGS': '0x0', 08:49:07 INFO - 'XPC_SERVICE_NAME': '0', 08:49:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:49:07 INFO - Cleaning up... 08:49:07 INFO - Return code: 0 08:49:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:07 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 0x1103fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110400768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff601d6ae60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101dbd30>, '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 0x110101db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101d0be8>, '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.oJ9OREoQV7/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.OwQFuaNehi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:49:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:49:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:49:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJ9OREoQV7/Render', 08:49:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:07 INFO - 'HOME': '/Users/cltbld', 08:49:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:07 INFO - 'LOGNAME': 'cltbld', 08:49:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:07 INFO - 'MOZ_NO_REMOTE': '1', 08:49:07 INFO - 'NO_EM_RESTART': '1', 08:49:07 INFO - 'PAGER': '/bin/cat', 08:49:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:07 INFO - 'PWD': '/builds/slave/test', 08:49:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:07 INFO - 'SHELL': '/bin/bash', 08:49:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OwQFuaNehi/Listeners', 08:49:07 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 08:49:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:07 INFO - 'USER': 'cltbld', 08:49:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:07 INFO - 'XPC_FLAGS': '0x0', 08:49:07 INFO - 'XPC_SERVICE_NAME': '0', 08:49:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:07 INFO - Downloading/unpacking psutil>=3.1.1 08:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:49:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:49:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:49:11 INFO - Installing collected packages: psutil 08:49:11 INFO - Running setup.py install for psutil 08:49:11 INFO - building 'psutil._psutil_osx' extension 08:49:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:49:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:49:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:49:11 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:49:12 INFO - building 'psutil._psutil_posix' extension 08:49:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:49:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:49:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:49:12 INFO - ^ 08:49:12 INFO - 1 warning generated. 08:49:12 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:49:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:49:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:49:12 INFO - Successfully installed psutil 08:49:12 INFO - Cleaning up... 08:49:12 INFO - Return code: 0 08:49:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:12 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 0x1103fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110400768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff601d6ae60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101dbd30>, '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 0x110101db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101d0be8>, '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.oJ9OREoQV7/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.OwQFuaNehi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:49:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:49:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:49:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJ9OREoQV7/Render', 08:49:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:12 INFO - 'HOME': '/Users/cltbld', 08:49:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:12 INFO - 'LOGNAME': 'cltbld', 08:49:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:12 INFO - 'MOZ_NO_REMOTE': '1', 08:49:12 INFO - 'NO_EM_RESTART': '1', 08:49:12 INFO - 'PAGER': '/bin/cat', 08:49:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:12 INFO - 'PWD': '/builds/slave/test', 08:49:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:12 INFO - 'SHELL': '/bin/bash', 08:49:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OwQFuaNehi/Listeners', 08:49:12 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 08:49:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:12 INFO - 'USER': 'cltbld', 08:49:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:12 INFO - 'XPC_FLAGS': '0x0', 08:49:12 INFO - 'XPC_SERVICE_NAME': '0', 08:49:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:49: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 08:49: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 08:49: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 08:49: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 08:49: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 08:49: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 08:49:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:49:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:49:15 INFO - Installing collected packages: mozsystemmonitor 08:49:15 INFO - Running setup.py install for mozsystemmonitor 08:49:15 INFO - Successfully installed mozsystemmonitor 08:49:15 INFO - Cleaning up... 08:49:15 INFO - Return code: 0 08:49:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:49: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')]} 08:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:16 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 0x1103fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110400768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff601d6ae60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101dbd30>, '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 0x110101db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101d0be8>, '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.oJ9OREoQV7/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.OwQFuaNehi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:49:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:49:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:49:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJ9OREoQV7/Render', 08:49:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:16 INFO - 'HOME': '/Users/cltbld', 08:49:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:16 INFO - 'LOGNAME': 'cltbld', 08:49:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:16 INFO - 'MOZ_NO_REMOTE': '1', 08:49:16 INFO - 'NO_EM_RESTART': '1', 08:49:16 INFO - 'PAGER': '/bin/cat', 08:49:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:16 INFO - 'PWD': '/builds/slave/test', 08:49:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:16 INFO - 'SHELL': '/bin/bash', 08:49:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OwQFuaNehi/Listeners', 08:49:16 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 08:49:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:16 INFO - 'USER': 'cltbld', 08:49:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:16 INFO - 'XPC_FLAGS': '0x0', 08:49:16 INFO - 'XPC_SERVICE_NAME': '0', 08:49:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:16 INFO - Downloading/unpacking jsonschema==2.5.1 08:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:49:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:20 INFO - Downloading functools32-3.2.3-2.tar.gz 08:49:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:49:20 INFO - warning: no files found matching '*.txt' 08:49:20 INFO - no previously-included directories found matching 'build' 08:49:20 INFO - no previously-included directories found matching 'dist' 08:49:20 INFO - no previously-included directories found matching '.git*' 08:49:20 INFO - Installing collected packages: jsonschema, functools32 08:49:20 INFO - Running setup.py install for functools32 08:49:20 INFO - warning: no files found matching '*.txt' 08:49:20 INFO - no previously-included directories found matching 'build' 08:49:20 INFO - no previously-included directories found matching 'dist' 08:49:20 INFO - no previously-included directories found matching '.git*' 08:49:20 INFO - Successfully installed jsonschema functools32 08:49:20 INFO - Cleaning up... 08:49:20 INFO - Return code: 0 08:49:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:20 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 0x1103fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110400768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff601d6ae60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101dbd30>, '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 0x110101db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101d0be8>, '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.oJ9OREoQV7/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.OwQFuaNehi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:49:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:49:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJ9OREoQV7/Render', 08:49:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:20 INFO - 'HOME': '/Users/cltbld', 08:49:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:20 INFO - 'LOGNAME': 'cltbld', 08:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:20 INFO - 'MOZ_NO_REMOTE': '1', 08:49:20 INFO - 'NO_EM_RESTART': '1', 08:49:20 INFO - 'PAGER': '/bin/cat', 08:49:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:20 INFO - 'PWD': '/builds/slave/test', 08:49:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:20 INFO - 'SHELL': '/bin/bash', 08:49:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OwQFuaNehi/Listeners', 08:49:20 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 08:49:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:20 INFO - 'USER': 'cltbld', 08:49:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:20 INFO - 'XPC_FLAGS': '0x0', 08:49:20 INFO - 'XPC_SERVICE_NAME': '0', 08:49:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:49:20 INFO - Cleaning up... 08:49:20 INFO - Return code: 0 08:49:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:20 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 0x1103fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110400768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff601d6ae60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101dbd30>, '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 0x110101db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101d0be8>, '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.oJ9OREoQV7/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.OwQFuaNehi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:49:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:49:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJ9OREoQV7/Render', 08:49:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:20 INFO - 'HOME': '/Users/cltbld', 08:49:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:20 INFO - 'LOGNAME': 'cltbld', 08:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:20 INFO - 'MOZ_NO_REMOTE': '1', 08:49:20 INFO - 'NO_EM_RESTART': '1', 08:49:20 INFO - 'PAGER': '/bin/cat', 08:49:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:20 INFO - 'PWD': '/builds/slave/test', 08:49:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:20 INFO - 'SHELL': '/bin/bash', 08:49:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OwQFuaNehi/Listeners', 08:49:20 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 08:49:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:20 INFO - 'USER': 'cltbld', 08:49:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:20 INFO - 'XPC_FLAGS': '0x0', 08:49:20 INFO - 'XPC_SERVICE_NAME': '0', 08:49:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:21 INFO - Downloading/unpacking blobuploader==1.2.4 08:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:23 INFO - Downloading blobuploader-1.2.4.tar.gz 08:49:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:49:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:49:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:24 INFO - Downloading docopt-0.6.1.tar.gz 08:49:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:49:24 INFO - Installing collected packages: blobuploader, requests, docopt 08:49:24 INFO - Running setup.py install for blobuploader 08:49:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:49:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:49:25 INFO - Running setup.py install for requests 08:49:25 INFO - Running setup.py install for docopt 08:49:25 INFO - Successfully installed blobuploader requests docopt 08:49:25 INFO - Cleaning up... 08:49:25 INFO - Return code: 0 08:49:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49: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')]} 08:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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')]} 08:49:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:25 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 0x1103fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110400768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff601d6ae60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101dbd30>, '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 0x110101db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101d0be8>, '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.oJ9OREoQV7/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.OwQFuaNehi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:49:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:49:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:49:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJ9OREoQV7/Render', 08:49:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:25 INFO - 'HOME': '/Users/cltbld', 08:49:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:25 INFO - 'LOGNAME': 'cltbld', 08:49:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:25 INFO - 'MOZ_NO_REMOTE': '1', 08:49:25 INFO - 'NO_EM_RESTART': '1', 08:49:25 INFO - 'PAGER': '/bin/cat', 08:49:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:25 INFO - 'PWD': '/builds/slave/test', 08:49:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:25 INFO - 'SHELL': '/bin/bash', 08:49:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OwQFuaNehi/Listeners', 08:49:25 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 08:49:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:25 INFO - 'USER': 'cltbld', 08:49:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:25 INFO - 'XPC_FLAGS': '0x0', 08:49:25 INFO - 'XPC_SERVICE_NAME': '0', 08:49:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:49:26 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-3h8gFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:49:26 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-Sqm_eH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:49:26 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-YX2NER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:49:26 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-z23GOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:49:26 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-hBMqy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:49:26 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-ShhVRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:49:26 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-TORKbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:49:26 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-kvw1Jx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:49:27 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-RciZK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:49:27 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-LsoS4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:49:27 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-hWYDcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:49:27 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-NGHiA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:49:27 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-zuLo_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:49:27 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-0JD4xt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:27 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-GNJLo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:49:27 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-JVAtSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:49:27 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-sZMjUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:49:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:49:27 INFO - Running setup.py install for manifestparser 08:49:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:49:28 INFO - Running setup.py install for mozcrash 08:49:28 INFO - Running setup.py install for mozdebug 08:49:28 INFO - Running setup.py install for mozdevice 08:49:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:49:28 INFO - Running setup.py install for mozfile 08:49:28 INFO - Running setup.py install for mozhttpd 08:49:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:49:28 INFO - Running setup.py install for mozinfo 08:49:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:49:28 INFO - Running setup.py install for mozInstall 08:49:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:49:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:49:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:49:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:49:29 INFO - Running setup.py install for mozleak 08:49:29 INFO - Running setup.py install for mozlog 08:49:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:49:29 INFO - Running setup.py install for moznetwork 08:49:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:49:29 INFO - Running setup.py install for mozprocess 08:49:29 INFO - Running setup.py install for mozprofile 08:49:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:49:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:49:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:49:29 INFO - Running setup.py install for mozrunner 08:49:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:49:30 INFO - Running setup.py install for mozscreenshot 08:49:30 INFO - Running setup.py install for moztest 08:49:30 INFO - Running setup.py install for mozversion 08:49:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:49:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:49:30 INFO - Cleaning up... 08:49:30 INFO - Return code: 0 08:49:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:30 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 0x1103fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110400768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff601d6ae60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101dbd30>, '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 0x110101db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101d0be8>, '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.oJ9OREoQV7/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.OwQFuaNehi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:49:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:49:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:49:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJ9OREoQV7/Render', 08:49:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:30 INFO - 'HOME': '/Users/cltbld', 08:49:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:30 INFO - 'LOGNAME': 'cltbld', 08:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:30 INFO - 'MOZ_NO_REMOTE': '1', 08:49:30 INFO - 'NO_EM_RESTART': '1', 08:49:30 INFO - 'PAGER': '/bin/cat', 08:49:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:30 INFO - 'PWD': '/builds/slave/test', 08:49:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:30 INFO - 'SHELL': '/bin/bash', 08:49:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OwQFuaNehi/Listeners', 08:49:30 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 08:49:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:30 INFO - 'USER': 'cltbld', 08:49:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:30 INFO - 'XPC_FLAGS': '0x0', 08:49:30 INFO - 'XPC_SERVICE_NAME': '0', 08:49:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:49:30 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-I5NCrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:49:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:49:30 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-9TNmgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:49:31 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-Eac3Bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:49:31 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-IpNdQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:49:31 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)) 08:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:49:31 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-k4DwoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:49:31 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-23TmCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:49:31 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-62U7we-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:49:31 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-b2YClz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:49:31 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-wnr5cn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:49:31 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-HKg12O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:49:31 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-UWAzqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:49:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:49:32 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-pPY0q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:49:32 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)) 08:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:49:32 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-VI_fQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:49:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:49:32 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-6Qn8YG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:49:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:32 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-hR81cO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:49:32 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-tDvpfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:49:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:49:32 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-FxNw0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:49:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:49:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:49:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:49:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:49:32 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)) 08:49:32 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)) 08:49:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:35 INFO - Downloading blessings-1.6.tar.gz 08:49:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:49:35 INFO - Installing collected packages: blessings 08:49:35 INFO - Running setup.py install for blessings 08:49:35 INFO - Successfully installed blessings 08:49:35 INFO - Cleaning up... 08:49:35 INFO - Return code: 0 08:49:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:49:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:49:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:49:35 INFO - Reading from file tmpfile_stdout 08:49:35 INFO - Current package versions: 08:49:35 INFO - blessings == 1.6 08:49:35 INFO - blobuploader == 1.2.4 08:49:35 INFO - docopt == 0.6.1 08:49:35 INFO - functools32 == 3.2.3-2 08:49:35 INFO - jsonschema == 2.5.1 08:49:35 INFO - manifestparser == 1.1 08:49:35 INFO - mozInstall == 1.12 08:49:35 INFO - mozcrash == 1.0 08:49:35 INFO - mozdebug == 0.1 08:49:35 INFO - mozdevice == 0.50 08:49:35 INFO - mozfile == 1.2 08:49:35 INFO - mozhttpd == 0.7 08:49:35 INFO - mozinfo == 0.9 08:49:35 INFO - mozleak == 0.1 08:49:35 INFO - mozlog == 3.4 08:49:35 INFO - moznetwork == 0.27 08:49:35 INFO - mozprocess == 0.25 08:49:35 INFO - mozprofile == 0.28 08:49:35 INFO - mozrunner == 6.13 08:49:35 INFO - mozscreenshot == 0.1 08:49:35 INFO - mozsystemmonitor == 0.3 08:49:35 INFO - moztest == 0.8 08:49:35 INFO - mozversion == 1.4 08:49:35 INFO - psutil == 3.1.1 08:49:35 INFO - requests == 1.2.3 08:49:35 INFO - wsgiref == 0.1.2 08:49:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:35 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 0x1103fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110400768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff601d6ae60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101dbd30>, '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 0x110101db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101d0be8>, '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.oJ9OREoQV7/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.OwQFuaNehi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:49:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:49:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:49:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJ9OREoQV7/Render', 08:49:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:35 INFO - 'HOME': '/Users/cltbld', 08:49:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:35 INFO - 'LOGNAME': 'cltbld', 08:49:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:35 INFO - 'MOZ_NO_REMOTE': '1', 08:49:35 INFO - 'NO_EM_RESTART': '1', 08:49:35 INFO - 'PAGER': '/bin/cat', 08:49:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:35 INFO - 'PWD': '/builds/slave/test', 08:49:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:35 INFO - 'SHELL': '/bin/bash', 08:49:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OwQFuaNehi/Listeners', 08:49:35 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 08:49:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:35 INFO - 'USER': 'cltbld', 08:49:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:35 INFO - 'XPC_FLAGS': '0x0', 08:49:35 INFO - 'XPC_SERVICE_NAME': '0', 08:49:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:49:36 INFO - Cleaning up... 08:49:36 INFO - Return code: 0 08:49:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:36 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 0x1103fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110400768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff601d6ae60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101dbd30>, '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 0x110101db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101d0be8>, '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.oJ9OREoQV7/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.OwQFuaNehi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:49:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:49:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJ9OREoQV7/Render', 08:49:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:36 INFO - 'HOME': '/Users/cltbld', 08:49:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:36 INFO - 'LOGNAME': 'cltbld', 08:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:36 INFO - 'MOZ_NO_REMOTE': '1', 08:49:36 INFO - 'NO_EM_RESTART': '1', 08:49:36 INFO - 'PAGER': '/bin/cat', 08:49:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:36 INFO - 'PWD': '/builds/slave/test', 08:49:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:36 INFO - 'SHELL': '/bin/bash', 08:49:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OwQFuaNehi/Listeners', 08:49:36 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 08:49:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:36 INFO - 'USER': 'cltbld', 08:49:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:36 INFO - 'XPC_FLAGS': '0x0', 08:49:36 INFO - 'XPC_SERVICE_NAME': '0', 08:49:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:49:36 INFO - Cleaning up... 08:49:36 INFO - Return code: 0 08:49:36 INFO - Running post-action listener: _resource_record_post_action 08:49:36 INFO - Running post-action listener: _start_resource_monitoring 08:49:36 INFO - Starting resource monitoring. 08:49:36 INFO - [mozharness: 2017-04-19 15:49:36.533920Z] Finished create-virtualenv step (success) 08:49:36 INFO - [mozharness: 2017-04-19 15:49:36.534895Z] Running install step. 08:49:36 INFO - Running pre-action listener: _resource_record_pre_action 08:49:36 INFO - Running main action method: install 08:49:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:49:36 INFO - Reading from file tmpfile_stdout 08:49:36 INFO - Detecting whether we're running mozinstall >=1.0... 08:49:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:49:36 INFO - Reading from file tmpfile_stdout 08:49:36 INFO - Output received: 08:49:36 INFO - Usage: mozinstall [options] installer 08:49:36 INFO - Options: 08:49:36 INFO - -h, --help show this help message and exit 08:49:36 INFO - -d DEST, --destination=DEST 08:49:36 INFO - Directory to install application into. [default: 08:49:36 INFO - "/builds/slave/test"] 08:49:36 INFO - --app=APP Application being installed. [default: firefox] 08:49:36 INFO - mkdir: /builds/slave/test/build/application 08:49:36 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'] 08:49:36 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 08:49:56 INFO - Reading from file tmpfile_stdout 08:49:56 INFO - Output received: 08:49:56 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:49:56 INFO - Running post-action listener: _resource_record_post_action 08:49:56 INFO - [mozharness: 2017-04-19 15:49:56.793723Z] Finished install step (success) 08:49:56 INFO - [mozharness: 2017-04-19 15:49:56.793872Z] Running run-tests step. 08:49:56 INFO - Running pre-action listener: _resource_record_pre_action 08:49:56 INFO - Running main action method: run_tests 08:49:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:49:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:49:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:49:56 INFO - 2017-04-19 08:49:56.808 screenresolution[1626:7372] starting screenresolution argv=screenresolution get 08:49:56 INFO - 2017-04-19 08:49:56.811 screenresolution[1626:7372] Display 0: 1600x1200x32@60 08:49:56 INFO - 2017-04-19 08:49:56.817 screenresolution[1627:7375] starting screenresolution argv=screenresolution list 08:49:56 INFO - Available Modes on Display 0 08:49:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:49:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:49:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:49:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:49:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:49:57 INFO - Intel Iris: 08:49:57 INFO - Chipset Model: Intel Iris 08:49:57 INFO - Type: GPU 08:49:57 INFO - Bus: Built-In 08:49:57 INFO - VRAM (Dynamic, Max): 1536 MB 08:49:57 INFO - Vendor: Intel (0x8086) 08:49:57 INFO - Device ID: 0x0a2e 08:49:57 INFO - Revision ID: 0x0009 08:49:57 INFO - Displays: 08:49:57 INFO - Display: 08:49:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:49:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:49:57 INFO - Display Serial Number: 1600x1200 60 08:49:57 INFO - Main Display: Yes 08:49:57 INFO - Mirror: Off 08:49:57 INFO - Online: Yes 08:49:57 INFO - Rotation: Supported 08:49:57 INFO - Return code: 0 08:49:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:49:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:49:57 INFO - Python 2.7.3 08:49:57 INFO - Return code: 0 08:49:57 INFO - grabbing minidump binary from tooltool 08:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:57 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 0x1101dbd30>, '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 0x110101db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101d0be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:49:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:49:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:49:57 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:49:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:49:57 INFO - Return code: 0 08:49:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:49:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:49:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:49:57 INFO - ENV: RUST_BACKTRACE is now 1 08:49:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:49:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:49:57 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/Zz5A3NYiSL2WYZw1pYWyWA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0177', '--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 08:49:57 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/Zz5A3NYiSL2WYZw1pYWyWA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0177 --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 08:49:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJ9OREoQV7/Render', 08:49:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:57 INFO - 'HOME': '/Users/cltbld', 08:49:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:57 INFO - 'LOGNAME': 'cltbld', 08:49:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:49:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:57 INFO - 'MOZ_NO_REMOTE': '1', 08:49:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:49:57 INFO - 'NO_EM_RESTART': '1', 08:49:57 INFO - 'PAGER': '/bin/cat', 08:49:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:57 INFO - 'PWD': '/builds/slave/test', 08:49:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:49:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:57 INFO - 'RUST_BACKTRACE': '1', 08:49:57 INFO - 'SHELL': '/bin/bash', 08:49:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OwQFuaNehi/Listeners', 08:49:57 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 08:49:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:57 INFO - 'USER': 'cltbld', 08:49:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:57 INFO - 'XPC_FLAGS': '0x0', 08:49:57 INFO - 'XPC_SERVICE_NAME': '0', 08:49:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:57 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/Zz5A3NYiSL2WYZw1pYWyWA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0177', '--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 08:49:57 INFO - mozversion application_buildid: 20170419080320 08:49:57 INFO - mozversion application_changeset: ef8d16ae0d0d5d5dc09c7a0d2463bde16b31b174 08:49:57 INFO - mozversion application_display_name: Nightly 08:49:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:49:57 INFO - mozversion application_name: Firefox 08:49:57 INFO - mozversion application_remotingname: firefox 08:49:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:49:57 INFO - mozversion application_vendor: Mozilla 08:49:57 INFO - mozversion application_version: 55.0a1 08:49:57 INFO - mozversion platform_buildid: 20170419080320 08:49:57 INFO - mozversion platform_changeset: ef8d16ae0d0d5d5dc09c7a0d2463bde16b31b174 08:49:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:49:57 INFO - mozversion platform_version: 55.0a1 08:49:57 INFO - using testdate: 1492616997 08:49:57 INFO - actual date: 1492616997 08:49:57 INFO - starting webserver on 'localhost:49251' 08:49:57 INFO - SUITE-START | Running 2 tests 08:49:57 INFO - TEST-START | dromaeo_css 08:49:57 INFO - operating with platform_type : mac_ 08:49:57 INFO - Initialising browser for dromaeo_css test... 08:49:57 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmp6VE3dw/profile http://localhost:49251/getInfo.html) 08:50:00 INFO - PID 1637 | __metrics Screen width/height:1600/1200 08:50:00 INFO - PID 1637 | colorDepth:24 08:50:00 INFO - PID 1637 | Browser inner width/height: 1024/689 08:50:00 INFO - PID 1637 | __metrics 08:50:00 INFO - PID 1637 | 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" 08:50:00 INFO - PID 1637 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:50:01 INFO - TEST-INFO | 1637: exit 0 08:50:01 INFO - Browser initialized. 08:50:01 INFO - Running cycle 1/1 for dromaeo_css test... 08:50:01 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmp6VE3dw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:50:13 INFO - PID 1639 | RSS: Main: 240910336 08:50:13 INFO - PID 1639 | 08:53:18 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49251/tests/dromaeo/cssquery-ext.html) 08:53:20 INFO - PID 1639 | RSS: Main: 417951744 08:53:20 INFO - PID 1639 | 08:55:03 INFO - PID 1639 | ************************* 08:55:03 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 08:55:03 INFO - PID 1639 | 08:55:03 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:55:03 INFO - PID 1639 | Full stack: 08:55:03 INFO - PID 1639 | ************************* 08:55:03 INFO - PID 1639 | ************************* 08:55:03 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 08:55:03 INFO - PID 1639 | 08:55:03 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:55:03 INFO - PID 1639 | Full stack: 08:55:03 INFO - PID 1639 | ************************* 08:55:03 INFO - PID 1639 | ************************* 08:55:03 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 08:55:03 INFO - PID 1639 | 08:55:03 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:55:03 INFO - PID 1639 | Full stack: 08:55:03 INFO - PID 1639 | ************************* 08:55:03 INFO - PID 1639 | ************************* 08:55:03 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 08:55:03 INFO - PID 1639 | 08:55:03 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:55:03 INFO - PID 1639 | Full stack: 08:55:03 INFO - PID 1639 | ************************* 08:56:23 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-ext.html (next: http://localhost:49251/tests/dromaeo/cssquery-jquery.html) 08:56:23 INFO - PID 1639 | RSS: Main: 367157248 08:56:23 INFO - PID 1639 | 08:59:26 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49251/tests/dromaeo/cssquery-mootools.html) 08:59:26 INFO - PID 1639 | RSS: Main: 335417344 08:59:26 INFO - PID 1639 | 09:02:29 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49251/tests/dromaeo/cssquery-prototype.html) 09:02:29 INFO - PID 1639 | RSS: Main: 330420224 09:02:29 INFO - PID 1639 | 09:05:33 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49251/tests/dromaeo/cssquery-yui.html) 09:05:34 INFO - PID 1639 | RSS: Main: 340721664 09:05:34 INFO - PID 1639 | 09:08:36 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-yui.html (next: http://localhost:49251/tests/dromaeo/cssquery-dojo.html) 09:08:36 INFO - PID 1639 | RSS: Main: 376967168 09:08:36 INFO - PID 1639 | 09:08:36 INFO - PID 1639 | __start_tp_report 09:08:36 INFO - PID 1639 | _x_x_mozilla_page_load 09:08:36 INFO - PID 1639 | _x_x_mozilla_page_load_details 09:08:36 INFO - PID 1639 | |i|pagename|runs| 09:08:36 INFO - PID 1639 | |0;dojo.html;2950.77869159813;3533.939818054583;3546.538949936508;3565.750397472178;3590.910227244319;5383.757730902109;5661.8584535386635;6160.784372546962;6185.474234690051;6209.813705588834;6048.0625503047095;6100.511959043277;6101.877962440749;6112.205413296277;6137.846553836156;5248.763805628737;5270.1040823060175;5278.366596008465;5290.894182116355;5380.21986811912;5347;5368.0605893968595;5371.919421208685;5382.9730851345685;5385.542228910547;5348.064088784447;5357.955198736248;5361.276227709268;5366.382865970424;5373.086575282192;4481.395011673415;5358.223057656618;5361.973190134044;5369.436209198017;5373.489518495776;5198.9740051299505;5310.097283461821;5324.520793128637;5412.431694672042;5414.3232095988005;6134.9079763803575;6178.38216178383;6180.042093475474;6193.814185574395;6203.782867599657;6291.653959032252;6474.967625161891;6502.154719886432;6521.02184672303;6533.444657204143;6070.327552986512;6391.744330226786;6399.520035997319;6408.423241908251;6687.732490700366;6217.3471785462325;6221.4089661482085;6230.968845155745;6237.87524249517;6246.562740608159;6828.726850926007;6831.04365388846;6846.075779769667;6847.315268473113;6855.862882742417;6249.75000999964;6277.968610157011;6450.064740612679;6451.774187903401;6468.353164683494;6524.412802847672;6570.737170513126;6633.900491492632;6659.600423974577;6661.633610151392;5825.533957283407;6093.939060609426;6512.153420055362;6521.47828173745;6540.542162048706;6244.968775156186;6476.805695829133;6523.347665233534;6523.836904077436;6536.673166341664;5135.640505164677;5236.423993360727;5294.073537130987;5307.8142265021315;5339.279197308314;4641;4646.628269738413;4666;4668.323093151474;4702.388689470347;6075.696215189223;6256.937430625727;6258.468030217391;6262.655553944577;6268.49852011838;6285.617164223863;6544;6577.473802095821;6614.239362473281;6628.96685516579;6270.435660790551;6278.215223097113;6284.685765711696;6285;6295.874082518324;5044.722540260247;5779.88440231193;5807.767689292466;5823.4467725565155;5828.795992140254;6524.543281970216;6594.340565943367;6742.797716068526;6815.318468153343;6826.624535650389;6614.5039122067;6627.3372662733345;6631.303713110054;6637.103990961158;6642.667866606747;6802.3537763912345;6808.625525595941;6855.040294358893;6860.725570977304;6860.897086543606;5476.069068258326;6240.126382306572;6346.3019067903415;6460.12788273577;6475.09348691193;6200.131981522681;6587.242467116152;6600.867982640224;6616.768413105518;6648.800535983928;6223.626582405071;6286.836935167009;6426.839329016812;6429.38920802523;6433.035044743326;5412.945870541244;6216.44052035319;6384.61692298445;6454.935450645621;6472.579282346633;6340.270868849957;6349.365063493614;6361.077643741724;6361.777337793155;6372.968135159294;6443.871122577616;6446.355364463516;6465.191851018622;6470.191226096738;6472;6110.528382738247;6145.0028740660355;6182.752689892533;6195.039768835838;6203.627782333075 09:08:36 INFO - PID 1639 | |1;ext.html;689.7585844954267;743.9367653749432;753.5591678867863;1100.108911781457;1101.6419663609329;26316.078937237176;36130.81934590327;36192.63807361922;36313.63686363136;36382.27235455289;38104.809475952585;38463;38508.614913850855;38568.80715596418;38582.228355432875;5945.464908158265;8321.375896807749;8495.617697203641;8500.362472814533;8501.95749021254;5974.581779275452;6056.636601803883;6064.151018857364;6069.241344831896;6072.149899014142;8302.211289927447;8464.576771161448;8467.237948584627;8474.025487069004;8504.829903401927;8421.15788421159;8453.450525715809;8468.745937621881;8482;8483.151684831499;8247.546384948826;8306.626201820933;8316.667333306661;8318.500889946623;8330.62512186953;36341.454878176846;36530.8173459131;36563.81718091419;36638.81680591607;36656.81671591652;3590.622984586633;3620.438831981021;3623.4927110204594;3623.5289412376487;3636.7636103653176;25011.62482562763;29632.851835740683;30109.247268818235;30229.69770302291;30294.69705302941;3102.4260511805387;3142.4500712375243;3148.307372378073;3156.526521021842;3168.5088811234295;293582.5320873382;299929.500352499;300028;300309;300655.9016147574;47557.762211189416;47582.28626570604;47618;47724.76137619359;47790.283145752845;49617;49680.75159624179;49744.25383619249;49772;49854.750726246864;13540.59378218655;13607.931960340135;13649;13655.590332290047;13657.658558536115;11147.940945610155;11152.609658661908;11172.776544469227;11180.832287515694;11222.551097956153;10174.796504070026;10229.641962531276;10231.897681023243;11715.531378744925;12001.519939202333;5094.872628184325;5202.557782588522;5204.609654275944;5205.973970130125;5234.790608375699;950.6910254167424;1015.674984005126;1016.8576399304103;1023.5905637744961;1064.1061508332882;21624.459388515414;21690.783092169193;23176;24101.879490602434;24283.90922386603;960.9711708648751;1108.844761733358;1133.586241022021;1134.9319040857574;1137.1528211482332;11646.41767911601;12225;12251.14242003069;12267.325297108566;12269.141160118885;305689;307053;307579;307876;308640;51951.48048519542;52071.73964130155;52120.21819672708;52217.73891130596;52331.953360932566;1437.252628633105;1475.7786332050064;1518.916459594711;1518.9924050379677;1536.8539988701054;19261.518462038563;22848.65727014063;23188.072477101403;23199.76800231976;23227;36061.45907811332;36110.09724756902;36134.457983129745;36178.4573231407;36299.91100266996;285740;286196;286884;286966.5651671812;287097.5645121761;32478.512822308156;32489.35021299608;32501.674983249864;32557;32566.86015989429;35829;36634.45048324331;42362.788186058875;42452.787736061124;42829.78585107055;29028.274293141996;29072.52883504926;29494.705052949197;29626;29910.401791964476;26441.206763797116;29521.26196845096;29561.113166605035;29683.257918552208;29743.55384669275;34994.47508287428;35622.82188589041;35635.64364356427;35668.82165589155;35785.46321805123;25246.368840779127;27319;29084.854575726986;29758.95843645462;29809.701902980694;18952.336668216547;19667.606647866676;21999.450013749785;23164;23852.211084168408 09:08:36 INFO - PID 1639 | |2;jquery.html;387.97478163919345;394.43201789423244;417.7222147272062;439.1655853877633;449.94825595056557;13274.269915154675;15085.094894306336;20943.266985655504;21994.780052199472;22270.443238919033;19145.90427047863;20854.165833366686;21240.681389779165;21840.672389914125;23847.28458146254;5725.227094342263;5971.492423144038;6131.969340153293;6237.875242495147;6245.46913512352;3617.457381392786;6035.064564992434;6168.1364608954555;6175.907361389583;6183.752649893999;3513.5783705955323;3743.513343265385;6186.876262474748;6197.659128747917;6202.906956395657;5879.118132280149;6127.846803829918;6145.525073982257;6161.3838616138255;6182.350853160443;5418.45815418455;5483.369412517572;5484.095124304485;5491.258680078178;5496.972515137439;26669.665841893442;27762.750676219417;27957;27978;28406.857965710245;2176.858504197222;2207.293666026872;2212.5906707259046;2215.2135991722866;2217.81148602369;15793.447229347033;15886.205689715467;17712.557186070324;17754.112294385228;17954.281828726835;2075.8962051897342;2113.9154433822628;2145.099058395462;2145.4207364011786;2151.7740637233023;162936;172516.2748372513;173122.99999999875;173825;174026;12428.514297140608;12489.50041998328;12638.684032899251;12641.988640908889;12860.03549733755;16763.49709508717;16769;16797.41209057677;16798.908070975347;16811.41160059392;8557.743267701979;8891.510966896753;8898.688545900863;9032.412893161923;9086.363954523253;6926.61903595297;8445.366597505212;8448.11294814048;8651.847113385611;8655.221030107195;7699.692012319557;7810.218978102258;7870.5924682178165;7880.684772609032;7889.289963903277;2061.6082944240547;2084.5622419292117;2084.9061792219386;2088.6762551804495;2232.3860938242115;942.6276620734772;951.6439074319068;955.3694561589457;974.5711886769799;989.8317286061387;21206.893965530075;21659.70041797466;21780.237691680715;21816.127354905628;22024;859.1666083898608;960.9471479068578;978.2369751593768;1008.1581879131007;1009.7374682582581;10715.517801698943;11005.834912476319;11012.724681882857;11016.504257308441;11021.118310535137;543112;549539;559590.6573079772;560812;565122.1743891337;132754.7158491539;134405.32797336148;138252;138547;140541;1106.950187241576;1108.9944550277196;1146.358039497884;1147.036489348951;1150.8676502202354;13852.722945541234;17730.91134544319;17820.376286829898;18010;18281;54507.454925450234;55136.172957404866;56771.71614141903;57054.71472642776;57687.71156144192;74722;75059.87410188961;76531.87744980499;77257.3896612231;77428.45143097219;6654;7569.924300757142;8761.605727742139;8908.510031948304;9040.954795225982;12162.391880405767;13673.86326136726;13772.10481318711;14003.089799163023;14427.91790615687;10412.375257484575;11407.600733974272;11471.598494052669;11979.28124312544;12015.038796896053;10575.841362379417;11432.82850757256;11568.24806387582;11684.766304674029;11942.34317112567;11570.19008669385;11729.824052639387;12067.97422219086;12105.636830894735;12162.209456385306;8650.221480066824;8678.609462574073;9009.81980360376;9131;9156.771080723036;8414.410991230556;10753.784924301313;11030.338179709242;11386.146039046938;11475.196736228383 09:08:36 INFO - PID 1639 | |3;mootools.html;1242.931638759868;1441.084911081463;1465.9340329685162;1471.9852801471982;1489.5978085916809;11152.940470655285;11688.941555292211;11697.59058432955;11717.824232636507;11717.882821171786;11356.205065645408;11372.317660940349;11568.305901645906;11653.650390488277;11716.121290903173;2477.925662230136;2507.3731567108225;2508.147229941819;2516.55960206964;2517.748225177477;2443.389152711822;2452.288836237489;2497.67530221071;2502.5495410826134;2503.2740505253455;2117.2272120676;2425.527022230666;2514.3085651445817;2523.83595066321;2526.103233352161;2444.9877750611313;2452.36238577971;2480.578301688708;2500.599904015367;2504.6743923290037;2452.791512721421;2464.3592665906995;2478.281298423455;2485.7762801347785;2494.0896572750817;11591.246568973074;11664.825027624593;11698.005669518101;11715.882841171564;11743.236689615147;6457.16056912603;6693.163354580677;6704.597724136567;6710.966445167743;6711.127553418073;3766.9264259686133;4195;4284.3145096784365;4316.913661726748;4351.630111440531;1128.9774204515945;1220.0788404754442;1237.4802582915108;1271.4024408527978;1287.9484820607165;14830;15209.847901521065;15211;15750;16243.106629135393;5338.733063346817;5498.780048798083;5630.859228519238;5634.746436410372;5642.069058605366;12022.398880055962;12049.638510844688;12081.275123492444;12097.274163550215;12116.636500904988;5484.972575137099;6455.806325810139;6461.8061458156335;6461.967690161613;6470.708818103197;5989.371116032841;6011.428914253139;6162.784302549389;6180.289266734293;6262.906056409158;4142;4282.89292767677;4300.548442413501;4334.133173365277;4369.191699535596;1270.9046821488425;1272.4210484229654;1272.8154417609394;1287.311288460669;1288.4266501406785;781.3124450483651;787.7439832054605;797.7885860247039;802.6388125343618;803.2048272210469;6541.34586541342;6806.353396427331;6947.305269473113;6952.66345938129;7003.4747393944635;922.7646950027835;942.6370847223731;943.5423819447562;945.8202941441104;951.191487235844;4114.136031433432;4224.936625950613;4301.65586753059;4353.978230108893;4401.427814384109;12310.75378492425;14218.573442796733;14988.700225995419;15040.172790496628;15040.32318545668;14155.575332740034;14739.336729847182;14923.850761492246;14926.179060151795;14945.850541494447;8334.833303333899;8550.401471897032;8579.485230886166;8591.65633374658;8591.828163436696;5665.915011274752;6788.9660551696925;6889.138857642794;7066.929330706833;7101.502894797522;12569.622911312676;12672.366381681064;12733.108682392143;12752.553660621834;12789.808152877527;12671.80992285098;12828.55100071493;13097.607071787861;13133.080684352004;13154;9350.158485736316;9351;9553.18797902186;9553.283503737386;9573.138417542455;8857.64569417216;10430.478476076318;10438.53026613789;10524.421156836448;10549.630762923261;8702.04277529484;8812.559372031244;8871.379003469954;8934.4192627479;9002.549872506479;8548.273396761346;8662.263707584674;8696.17386348296;8743.912560874563;8760.12398760119;6152.723127459186;7965.8406831864195;7969.840603187788;7970.4420690553425;7998.720044798404;4919.3358896549935;5406.83779486616;5520.558355331644;5976.701164941823;6099.84750381244;5256.922330922228;5358.919616205838;5929.377415371324;5973.1338955852025;6074.301455332693 09:08:36 INFO - PID 1639 | |4;prototype.html;390.81436317749075;392.14903659059837;398.11816825731;401.85131501344506;402.0511592641364;5893.351731309558;5951.70241487925;5974.1337506061645;5975.671338076404;5978.252718410199;4931.679440836352;5661.716914154296;5763.452472015152;5807.216025836511;5845.415458454163;3545.840437180333;4297.753651441094;4464.486584042844;4478.55214478552;4497.797599108048;4467.285234362503;4499.370088187657;4507.504174540798;4518.43519560055;4531.728096314215;3722.3485889969284;3931.958031121755;3963.4451176835264;4497.391512922513;4516.683832131752;3545.521354617132;3567.4648802679544;3744.3821769408014;4313.223619748444;4317.805698743564;3756.868509602178;3771.0949372150762;3771.7359784815076;3774.5281839770028;3786.7917264550438;4627.9074418511445;5442.2380866678695;5757.0788673811985;5819.970900145515;5861.238039054938;5065.949340506585;5109.4379618241965;5129.615278854101;5138.713272593697;5143.996920600484;6228.626282423069;6290.056491526262;6290.811275661692;6291.7797877074545;6314.494840412756;3367.579052618423;3653.7394598863616;4155.210510003089;4277.401163837066;4279.465066866642;5448.863778405532;6303.149074874879;6420.422162005442;6455.257645370749;6497.252815926135;3572.5355703758346;4200.978995105066;4270.871873843789;4275.187714334266;4288.849890253826;4331.761753103547;4342;4346.891327716832;4373.387725718402;4404.735715856995;4214.304639734471;4572.359869618256;4739.549742774431;4881.341018962395;4964.329815474937;5521.641093328921;5637.915431268534;6233.2208473940755;6304.275008374004;6305.243370795534;1428.328685517805;1470.5882352941082;1481.7110663420528;1484.6733718581895;1495.588713103905;962.5091203486272;995.4475266227313;997.9800403992025;1002.9569247982017;1006.713086770267;5113.7698803553185;5660.613149778248;5930.673812940244;6006.336134957673;6018.699065046818;5662.745176467069;6429.260635026938;6429.9678501607195;6462.3537646235;6470.547061705635;4937.259411088366;5899.76400943966;5902.321233058167;5985.34161242263;6003.969980150158;2362.4802543440414;3112.8287944162835;3113.688631136868;3379.5437615921537;3399.181437930695;5568.9443105569235;5805.983952808242;6214.892553723138;6692.19693636757;6717.798466046026;5507.421720719347;5648.587853036741;6360.554761166766;6651.23510796255;6741.258461569223;5196.480351964773;5793.8841223175305;5831.620944638585;6717.630530320879;6781.728730850809;5692.5730570208225;5951.970240148771;6177.4749146323065;6411.871762564816;6528.902066469102;6407.533099756721;6443.162388889415;6474.320196379501;6474.352564743488;6505;6392.552521323462;6573.506986976092;6584.7036883341325;6642.070110184674;6691.665416729242;3986.402039694069;4103.753774773523;4256.765877876746;4260.91478170441;4265.95734042668;6247.562670613013;6442.420182183626;6500.837479063061;6505.544611877123;6515.869682606227;5591.832245032656;6227.750889964351;6259.405356491126;6260.8730428521485;6284.622922624657;5303.515015795583;5429.701366424884;6285;6299.685015749286;6430.903536446864;4662.393888794435;5503.642263252876;6122.448979591737;6122.5408094392205;6124.693765311806;6239.284196845903;6245.687715614292;6269.435750782452;6271.811845644638;6278.372162783685;5031.9245211322595;5851.6008436540815;6073.696315184135;6110.144579758926;6124.29570599369 09:08:36 INFO - PID 1639 | |5;yui.html;704.1514974455781;780.1769133564089;850.413214881732;857.6569372251099;866.0213958227203;12432.813507797391;17682.46952591421;17810.28758849646;18287.08564571771;18325.175367108477;17175.656486870288;17289.827101728977;17388.304467821305;17485.650286994252;17486.125693715327;955.5795450001995;970.8058388322364;974.532224532225;974.9853752193723;975.5073687787657;665.7104159690526;678.4063944048958;950.410745337888;987.9506024698773;998.6005597760881;1045.8588090607784;1046.5552140340362;1047.2145890582065;1047.9633212837552;1050.9842352364722;1041.9426931518763;1043.5408420295084;1044.5195210203315;1051.7212938571247;1053.963111291101;770.7803276066351;771.0785611194625;771.1247733822096;771.5178013741412;782.9334506566948;13884.375203115884;16056.197190140447;16498.67002659952;16511.752323715154;16768.832311676848;16548.75176872348;16633.83366166335;16772.83227167725;17032.744508832377;17071.317147314094;11195.328280303127;13426.530071447452;13909.721805563933;14053.5081272156;14129.929350353183;3408.1479630092476;3417.333619944112;3439.6560343965652;3442.1050526862946;3452.205992621686;118571;120261;120867.18699219519;121239;123091;9775.413475191512;10749.516271767789;11704.35626040559;11998.340091294887;12052.156349055658;18842.246310147715;24354;24377.51244975126;24433.511329773304;24436.755632443805;7644.503107298008;7785.948896898846;7788.805279868048;7790.571518566533;7797.181295963956;3816.1413681921345;3891.2217556488818;3911.2373087247715;3913.0804260998643;3915.334393153171;4182.707210495236;4321.848735294249;4322.092360604245;4334.28484300087;4344.066025804404;887.0641473245659;927.2859897878595;931.1154403316876;932.38462614674;933.1321870660215;615.4980006274569;621.6798348850346;629.3706293706293;635.7202830754453;656.4223483334634;9374.484403357881;10543.84184237237;10773.407462589475;11053.28153670009;11095.223334366518;613.1477246627192;613.7882430561449;622.5642050564622;635.1203583037434;645.3868824616633;4609.2394754865745;4691.3432119503295;4862.854114376574;5325.147976323769;5333.759980800874;99602.50198749105;102645.48677256715;103382.48308758409;103415;106199;83033;83381.3323733522;84240.57879710685;84987.57506212429;92112;66792.66603667047;74250;78521.60739196268;79149.60425197837;79384.20615793768;11329.150313726339;11462.484188211718;11669.183157178915;11681.123915706527;11699.356535390636;33257.66742332546;36627.90116296515;37237.62762372341;37764.81117594504;37892.43161352527;65121.02318465132;65514.34485655273;67396.6630166846;67547.66226168838;67583.32416675967;13809.447622095004;13952;13974.58076257714;14008.859911400756;14022.368993395527;16317.347306107622;16836;16845.41041063557;16855.831441685426;16876.915615421844;14822.777658334919;14841.777373339624;14901.552953411416;14905.627359316104;15151.166685831944;15100.320485578395;15164.848351516785;15333.463328783439;15365.846341536888;15442.45951391696;14755.409783608535;14855.40578376896;14875.884308677108;15037.924810375878;15084.472043478425;10262.846057308998;10433.26967112295;10592.523336450033;10658.467076645982;10659.840102398626;11642.825357619473;11769.646910592695;12088.939555302168;12176.756464870476;12565.811512827133 09:08:36 INFO - PID 1639 | __end_tp_report 09:08:36 INFO - PID 1639 | __start_cc_report 09:08:36 INFO - PID 1639 | _x_x_mozilla_cycle_collect,1875 09:08:36 INFO - PID 1639 | __end_cc_report 09:08:36 INFO - PID 1639 | __startTimestamp1492618116858__endTimestamp 09:08:36 INFO - PID 1639 | 09:08:36 INFO - PID 1639 | ------- Summary: start ------- 09:08:36 INFO - PID 1639 | Number of tests: 6 09:08:36 INFO - PID 1639 | 09:08:36 INFO - PID 1639 | [#0] dojo.html Cycles:165 Average:6027.72 Median:6256.94 stddev:723.63 (11.6%) stddev-sans-first:684.41 09:08:36 INFO - PID 1639 | Values: 2950.8 3533.9 3546.5 3565.8 3590.9 5383.8 5661.9 6160.8 6185.5 6209.8 6048.1 6100.5 6101.9 6112.2 6137.8 5248.8 5270.1 5278.4 5290.9 5380.2 5347.0 5368.1 5371.9 5383.0 5385.5 5348.1 5358.0 5361.3 5366.4 5373.1 4481.4 5358.2 5362.0 5369.4 5373.5 5199.0 5310.1 5324.5 5412.4 5414.3 6134.9 6178.4 6180.0 6193.8 6203.8 6291.7 6475.0 6502.2 6521.0 6533.4 6070.3 6391.7 6399.5 6408.4 6687.7 6217.3 6221.4 6231.0 6237.9 6246.6 6828.7 6831.0 6846.1 6847.3 6855.9 6249.8 6278.0 6450.1 6451.8 6468.4 6524.4 6570.7 6633.9 6659.6 6661.6 5825.5 6093.9 6512.2 6521.5 6540.5 6245.0 6476.8 6523.3 6523.8 6536.7 5135.6 5236.4 5294.1 5307.8 5339.3 4641.0 4646.6 4666.0 4668.3 4702.4 6075.7 6256.9 6258.5 6262.7 6268.5 6285.6 6544.0 6577.5 6614.2 6629.0 6270.4 6278.2 6284.7 6285.0 6295.9 5044.7 5779.9 5807.8 5823.4 5828.8 6524.5 6594.3 6742.8 6815.3 6826.6 6614.5 6627.3 6631.3 6637.1 6642.7 6802.4 6808.6 6855.0 6860.7 6860.9 5476.1 6240.1 6346.3 6460.1 6475.1 6200.1 6587.2 6600.9 6616.8 6648.8 6223.6 6286.8 6426.8 6429.4 6433.0 5412.9 6216.4 6384.6 6454.9 6472.6 6340.3 6349.4 6361.1 6361.8 6373.0 6443.9 6446.4 6465.2 6470.2 6472.0 6110.5 6145.0 6182.8 6195.0 6203.6 09:08:36 INFO - PID 1639 | 09:08:36 INFO - PID 1639 | [#1] ext.html Cycles:180 Average:43941.05 Median:17823.51 stddev:78203.91 (438.8%) stddev-sans-first:78355.87 09:08:36 INFO - PID 1639 | Values: 689.8 743.9 753.6 1100.1 1101.6 26316.1 36130.8 36192.6 36313.6 36382.3 38104.8 38463.0 38508.6 38568.8 38582.2 5945.5 8321.4 8495.6 8500.4 8502.0 5974.6 6056.6 6064.2 6069.2 6072.1 8302.2 8464.6 8467.2 8474.0 8504.8 8421.2 8453.5 8468.7 8482.0 8483.2 8247.5 8306.6 8316.7 8318.5 8330.6 36341.5 36530.8 36563.8 36638.8 36656.8 3590.6 3620.4 3623.5 3623.5 3636.8 25011.6 29632.9 30109.2 30229.7 30294.7 3102.4 3142.5 3148.3 3156.5 3168.5 293582.5 299929.5 300028.0 300309.0 300655.9 47557.8 47582.3 47618.0 47724.8 47790.3 49617.0 49680.8 49744.3 49772.0 49854.8 13540.6 13607.9 13649.0 13655.6 13657.7 11147.9 11152.6 11172.8 11180.8 11222.6 10174.8 10229.6 10231.9 11715.5 12001.5 5094.9 5202.6 5204.6 5206.0 5234.8 950.7 1015.7 1016.9 1023.6 1064.1 21624.5 21690.8 23176.0 24101.9 24283.9 961.0 1108.8 1133.6 1134.9 1137.2 11646.4 12225.0 12251.1 12267.3 12269.1 305689.0 307053.0 307579.0 307876.0 308640.0 51951.5 52071.7 52120.2 52217.7 52332.0 1437.3 1475.8 1518.9 1519.0 1536.9 19261.5 22848.7 23188.1 23199.8 23227.0 36061.5 36110.1 36134.5 36178.5 36299.9 285740.0 286196.0 286884.0 286966.6 287097.6 32478.5 32489.4 32501.7 32557.0 32566.9 35829.0 36634.5 42362.8 42452.8 42829.8 29028.3 29072.5 29494.7 29626.0 29910.4 26441.2 29521.3 29561.1 29683.3 29743.6 34994.5 35622.8 35635.6 35668.8 35785.5 25246.4 27319.0 29084.9 29759.0 29809.7 18952.3 19667.6 21999.5 23164.0 23852.2 09:08:36 INFO - PID 1639 | 09:08:36 INFO - PID 1639 | [#2] jquery.html Cycles:180 Average:36105.09 Median:2213.90 stddev:95044.97 (4293.1%) stddev-sans-first:95273.76 09:08:36 INFO - PID 1639 | Values: 388.0 394.4 417.7 439.2 449.9 13274.3 15085.1 20943.3 21994.8 22270.4 19145.9 20854.2 21240.7 21840.7 23847.3 5725.2 5971.5 6132.0 6237.9 6245.5 3617.5 6035.1 6168.1 6175.9 6183.8 3513.6 3743.5 6186.9 6197.7 6202.9 5879.1 6127.8 6145.5 6161.4 6182.4 5418.5 5483.4 5484.1 5491.3 5497.0 26669.7 27762.8 27957.0 27978.0 28406.9 2176.9 2207.3 2212.6 2215.2 2217.8 15793.4 15886.2 17712.6 17754.1 17954.3 2075.9 2113.9 2145.1 2145.4 2151.8 162936.0 172516.3 173123.0 173825.0 174026.0 12428.5 12489.5 12638.7 12642.0 12860.0 16763.5 16769.0 16797.4 16798.9 16811.4 8557.7 8891.5 8898.7 9032.4 9086.4 6926.6 8445.4 8448.1 8651.8 8655.2 7699.7 7810.2 7870.6 7880.7 7889.3 2061.6 2084.6 2084.9 2088.7 2232.4 942.6 951.6 955.4 974.6 989.8 21206.9 21659.7 21780.2 21816.1 22024.0 859.2 960.9 978.2 1008.2 1009.7 10715.5 11005.8 11012.7 11016.5 11021.1 543112.0 549539.0 559590.7 560812.0 565122.2 132754.7 134405.3 138252.0 138547.0 140541.0 1107.0 1109.0 1146.4 1147.0 1150.9 13852.7 17730.9 17820.4 18010.0 18281.0 54507.5 55136.2 56771.7 57054.7 57687.7 74722.0 75059.9 76531.9 77257.4 77428.5 6654.0 7569.9 8761.6 8908.5 9041.0 12162.4 13673.9 13772.1 14003.1 14427.9 10412.4 11407.6 11471.6 11979.3 12015.0 10575.8 11432.8 11568.2 11684.8 11942.3 11570.2 11729.8 12068.0 12105.6 12162.2 8650.2 8678.6 9009.8 9131.0 9156.8 8414.4 10753.8 11030.3 11386.1 11475.2 09:08:36 INFO - PID 1639 | 09:08:36 INFO - PID 1639 | [#3] mootools.html Cycles:180 Average:6961.57 Median:4128.07 stddev:4344.94 (105.3%) stddev-sans-first:4335.87 09:08:36 INFO - PID 1639 | Values: 1242.9 1441.1 1465.9 1472.0 1489.6 11152.9 11688.9 11697.6 11717.8 11717.9 11356.2 11372.3 11568.3 11653.7 11716.1 2477.9 2507.4 2508.1 2516.6 2517.7 2443.4 2452.3 2497.7 2502.5 2503.3 2117.2 2425.5 2514.3 2523.8 2526.1 2445.0 2452.4 2480.6 2500.6 2504.7 2452.8 2464.4 2478.3 2485.8 2494.1 11591.2 11664.8 11698.0 11715.9 11743.2 6457.2 6693.2 6704.6 6711.0 6711.1 3766.9 4195.0 4284.3 4316.9 4351.6 1129.0 1220.1 1237.5 1271.4 1287.9 14830.0 15209.8 15211.0 15750.0 16243.1 5338.7 5498.8 5630.9 5634.7 5642.1 12022.4 12049.6 12081.3 12097.3 12116.6 5485.0 6455.8 6461.8 6462.0 6470.7 5989.4 6011.4 6162.8 6180.3 6262.9 4142.0 4282.9 4300.5 4334.1 4369.2 1270.9 1272.4 1272.8 1287.3 1288.4 781.3 787.7 797.8 802.6 803.2 6541.3 6806.4 6947.3 6952.7 7003.5 922.8 942.6 943.5 945.8 951.2 4114.1 4224.9 4301.7 4354.0 4401.4 12310.8 14218.6 14988.7 15040.2 15040.3 14155.6 14739.3 14923.9 14926.2 14945.9 8334.8 8550.4 8579.5 8591.7 8591.8 5665.9 6789.0 6889.1 7066.9 7101.5 12569.6 12672.4 12733.1 12752.6 12789.8 12671.8 12828.6 13097.6 13133.1 13154.0 9350.2 9351.0 9553.2 9553.3 9573.1 8857.6 10430.5 10438.5 10524.4 10549.6 8702.0 8812.6 8871.4 8934.4 9002.5 8548.3 8662.3 8696.2 8743.9 8760.1 6152.7 7965.8 7969.8 7970.4 7998.7 4919.3 5406.8 5520.6 5976.7 6099.8 5256.9 5358.9 5929.4 5973.1 6074.3 09:08:36 INFO - PID 1639 | 09:08:36 INFO - PID 1639 | [#4] prototype.html Cycles:180 Average:5005.50 Median:5661.17 stddev:1583.13 (28.0%) stddev-sans-first:1549.22 09:08:36 INFO - PID 1639 | Values: 390.8 392.1 398.1 401.9 402.1 5893.4 5951.7 5974.1 5975.7 5978.3 4931.7 5661.7 5763.5 5807.2 5845.4 3545.8 4297.8 4464.5 4478.6 4497.8 4467.3 4499.4 4507.5 4518.4 4531.7 3722.3 3932.0 3963.4 4497.4 4516.7 3545.5 3567.5 3744.4 4313.2 4317.8 3756.9 3771.1 3771.7 3774.5 3786.8 4627.9 5442.2 5757.1 5820.0 5861.2 5065.9 5109.4 5129.6 5138.7 5144.0 6228.6 6290.1 6290.8 6291.8 6314.5 3367.6 3653.7 4155.2 4277.4 4279.5 5448.9 6303.1 6420.4 6455.3 6497.3 3572.5 4201.0 4270.9 4275.2 4288.8 4331.8 4342.0 4346.9 4373.4 4404.7 4214.3 4572.4 4739.5 4881.3 4964.3 5521.6 5637.9 6233.2 6304.3 6305.2 1428.3 1470.6 1481.7 1484.7 1495.6 962.5 995.4 998.0 1003.0 1006.7 5113.8 5660.6 5930.7 6006.3 6018.7 5662.7 6429.3 6430.0 6462.4 6470.5 4937.3 5899.8 5902.3 5985.3 6004.0 2362.5 3112.8 3113.7 3379.5 3399.2 5568.9 5806.0 6214.9 6692.2 6717.8 5507.4 5648.6 6360.6 6651.2 6741.3 5196.5 5793.9 5831.6 6717.6 6781.7 5692.6 5952.0 6177.5 6411.9 6528.9 6407.5 6443.2 6474.3 6474.4 6505.0 6392.6 6573.5 6584.7 6642.1 6691.7 3986.4 4103.8 4256.8 4260.9 4266.0 6247.6 6442.4 6500.8 6505.5 6515.9 5591.8 6227.8 6259.4 6260.9 6284.6 5303.5 5429.7 6285.0 6299.7 6430.9 4662.4 5503.6 6122.4 6122.5 6124.7 6239.3 6245.7 6269.4 6271.8 6278.4 5031.9 5851.6 6073.7 6110.1 6124.3 09:08:36 INFO - PID 1639 | 09:08:36 INFO - PID 1639 | [#5] yui.html Cycles:180 Average:20991.64 Median:18306.13 stddev:29890.85 (163.3%) stddev-sans-first:29935.89 09:08:36 INFO - PID 1639 | Values: 704.2 780.2 850.4 857.7 866.0 12432.8 17682.5 17810.3 18287.1 18325.2 17175.7 17289.8 17388.3 17485.7 17486.1 955.6 970.8 974.5 975.0 975.5 665.7 678.4 950.4 988.0 998.6 1045.9 1046.6 1047.2 1048.0 1051.0 1041.9 1043.5 1044.5 1051.7 1054.0 770.8 771.1 771.1 771.5 782.9 13884.4 16056.2 16498.7 16511.8 16768.8 16548.8 16633.8 16772.8 17032.7 17071.3 11195.3 13426.5 13909.7 14053.5 14129.9 3408.1 3417.3 3439.7 3442.1 3452.2 118571.0 120261.0 120867.2 121239.0 123091.0 9775.4 10749.5 11704.4 11998.3 12052.2 18842.2 24354.0 24377.5 24433.5 24436.8 7644.5 7785.9 7788.8 7790.6 7797.2 3816.1 3891.2 3911.2 3913.1 3915.3 4182.7 4321.8 4322.1 4334.3 4344.1 887.1 927.3 931.1 932.4 933.1 615.5 621.7 629.4 635.7 656.4 9374.5 10543.8 10773.4 11053.3 11095.2 613.1 613.8 622.6 635.1 645.4 4609.2 4691.3 4862.9 5325.1 5333.8 99602.5 102645.5 103382.5 103415.0 106199.0 83033.0 83381.3 84240.6 84987.6 92112.0 66792.7 74250.0 78521.6 79149.6 79384.2 11329.2 11462.5 11669.2 11681.1 11699.4 33257.7 36627.9 37237.6 37764.8 37892.4 65121.0 65514.3 67396.7 67547.7 67583.3 13809.4 13952.0 13974.6 14008.9 14022.4 16317.3 16836.0 16845.4 16855.8 16876.9 14822.8 14841.8 14901.6 14905.6 15151.2 15100.3 15164.8 15333.5 15365.8 15442.5 14755.4 14855.4 14875.9 15037.9 15084.5 10262.8 10433.3 10592.5 10658.5 10659.8 11642.8 11769.6 12088.9 12176.8 12565.8 09:08:36 INFO - PID 1639 | -------- Summary: end -------- 09:08:36 INFO - PID 1639 | 09:08:37 INFO - TEST-INFO | 1639: exit 0 09:08:37 INFO - TEST-OK | dromaeo_css | took 1120192ms 09:08:37 INFO - TEST-START | kraken 09:08:37 INFO - operating with platform_type : mac_ 09:08:37 INFO - Initialising browser for kraken test... 09:08:37 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmpYPDbc1/profile http://localhost:49251/getInfo.html) 09:08:40 INFO - PID 1650 | __metrics Screen width/height:1600/1200 09:08:40 INFO - PID 1650 | colorDepth:24 09:08:40 INFO - PID 1650 | Browser inner width/height: 1024/689 09:08:40 INFO - PID 1650 | __metrics 09:08:40 INFO - PID 1650 | 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" 09:08:40 INFO - PID 1650 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:08:41 INFO - TEST-INFO | 1650: exit 0 09:08:41 INFO - Browser initialized. 09:08:41 INFO - Running cycle 1/1 for kraken test... 09:08:41 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmpYPDbc1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:08:53 INFO - PID 1651 | RSS: Main: 241344512 09:08:53 INFO - PID 1651 | 09:08:56 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-beat-detection) 09:08:57 INFO - PID 1651 | RSS: Main: 311816192 09:08:57 INFO - PID 1651 | 09:08:59 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-dft) 09:09:00 INFO - PID 1651 | RSS: Main: 293457920 09:09:00 INFO - PID 1651 | 09:09:03 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-fft) 09:09:04 INFO - PID 1651 | RSS: Main: 386367488 09:09:04 INFO - PID 1651 | 09:09:06 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-oscillator) 09:09:06 INFO - PID 1651 | RSS: Main: 289173504 09:09:06 INFO - PID 1651 | 09:09:08 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:09:09 INFO - PID 1651 | RSS: Main: 291741696 09:09:09 INFO - PID 1651 | 09:09:12 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-darkroom) 09:09:12 INFO - PID 1651 | RSS: Main: 354897920 09:09:12 INFO - PID 1651 | 09:09:15 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-desaturate) 09:09:16 INFO - PID 1651 | RSS: Main: 371785728 09:09:16 INFO - PID 1651 | 09:09:19 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49251/tests/kraken/driver.html?testName=json-parse-financial) 09:09:20 INFO - PID 1651 | RSS: Main: 377688064 09:09:20 INFO - PID 1651 | 09:09:21 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49251/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:09:22 INFO - PID 1651 | RSS: Main: 331534336 09:09:22 INFO - PID 1651 | 09:09:23 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:09:24 INFO - PID 1651 | RSS: Main: 333459456 09:09:24 INFO - PID 1651 | 09:09:26 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:09:27 INFO - PID 1651 | RSS: Main: 317358080 09:09:27 INFO - PID 1651 | 09:09:30 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:09:31 INFO - PID 1651 | RSS: Main: 351989760 09:09:31 INFO - PID 1651 | 09:09:34 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:09:34 INFO - PID 1651 | RSS: Main: 343855104 09:09:34 INFO - PID 1651 | 09:09:36 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49251/tests/kraken/driver.html?testName=ai-astar) 09:09:36 INFO - PID 1651 | RSS: Main: 386486272 09:09:36 INFO - PID 1651 | 09:09:36 INFO - PID 1651 | __start_tp_report 09:09:36 INFO - PID 1651 | _x_x_mozilla_page_load 09:09:36 INFO - PID 1651 | _x_x_mozilla_page_load_details 09:09:36 INFO - PID 1651 | |i|pagename|runs| 09:09:36 INFO - PID 1651 | |0;ai-astar;112;111;110;112;110;113;111;111;111;111 09:09:36 INFO - PID 1651 | |1;audio-beat-detection;141;110;108;152;112;112;109;108;136;111 09:09:36 INFO - PID 1651 | |2;audio-dft;185;188;184;185;187;185;186;185;188;183 09:09:36 INFO - PID 1651 | |3;audio-fft;84;58;62;86;60;59;64;70;96;70 09:09:36 INFO - PID 1651 | |4;audio-oscillator;91;70;87;70;68;68;92;69;69;90 09:09:36 INFO - PID 1651 | |5;imaging-gaussian-blur;90;89;90;91;119;89;90;90;91;90 09:09:36 INFO - PID 1651 | |6;imaging-darkroom;97;97;96;96;96;96;97;97;96;95 09:09:36 INFO - PID 1651 | |7;imaging-desaturate;86;85;88;85;118;128;86;84;86;84 09:09:36 INFO - PID 1651 | |8;json-parse-financial;52;48;48;49;49;49;50;49;49;48 09:09:36 INFO - PID 1651 | |9;json-stringify-tinderbox;55;54;59;56;66;59;56;57;58;56 09:09:36 INFO - PID 1651 | |10;stanford-crypto-aes;83;83;80;83;83;83;95;105;107;80 09:09:36 INFO - PID 1651 | |11;stanford-crypto-ccm;137;148;135;135;138;131;139;148;179;143 09:09:36 INFO - PID 1651 | |12;stanford-crypto-pbkdf2;178;187;184;184;207;181;183;185;185;180 09:09:36 INFO - PID 1651 | |13;stanford-crypto-sha256-iterative;60;96;89;67;65;68;66;70;67;68 09:09:36 INFO - PID 1651 | __end_tp_report 09:09:36 INFO - PID 1651 | __start_cc_report 09:09:36 INFO - PID 1651 | _x_x_mozilla_cycle_collect,2212 09:09:36 INFO - PID 1651 | __end_cc_report 09:09:36 INFO - PID 1651 | __startTimestamp1492618176852__endTimestamp 09:09:36 INFO - PID 1651 | 09:09:36 INFO - PID 1651 | ------- Summary: start ------- 09:09:36 INFO - PID 1651 | Number of tests: 14 09:09:36 INFO - PID 1651 | 09:09:36 INFO - PID 1651 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 09:09:36 INFO - PID 1651 | Values: 112.0 111.0 110.0 112.0 110.0 113.0 111.0 111.0 111.0 111.0 09:09:36 INFO - PID 1651 | 09:09:36 INFO - PID 1651 | [#1] audio-beat-detection Cycles:10 Average:119.90 Median:112.00 stddev:16.46 (14.7%) stddev-sans-first:15.59 09:09:36 INFO - PID 1651 | Values: 141.0 110.0 108.0 152.0 112.0 112.0 109.0 108.0 136.0 111.0 09:09:36 INFO - PID 1651 | 09:09:36 INFO - PID 1651 | [#2] audio-dft Cycles:10 Average:185.60 Median:185.50 stddev:1.65 (0.9%) stddev-sans-first:1.73 09:09:36 INFO - PID 1651 | Values: 185.0 188.0 184.0 185.0 187.0 185.0 186.0 185.0 188.0 183.0 09:09:36 INFO - PID 1651 | 09:09:36 INFO - PID 1651 | [#3] audio-fft Cycles:10 Average:70.90 Median:70.00 stddev:13.27 (19.0%) stddev-sans-first:13.20 09:09:36 INFO - PID 1651 | Values: 84.0 58.0 62.0 86.0 60.0 59.0 64.0 70.0 96.0 70.0 09:09:36 INFO - PID 1651 | 09:09:36 INFO - PID 1651 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:78.50 stddev:10.94 (13.9%) stddev-sans-first:10.43 09:09:36 INFO - PID 1651 | Values: 91.0 70.0 87.0 70.0 68.0 68.0 92.0 69.0 69.0 90.0 09:09:36 INFO - PID 1651 | 09:09:36 INFO - PID 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:92.90 Median:90.00 stddev:9.19 (10.2%) stddev-sans-first:9.69 09:09:36 INFO - PID 1651 | Values: 90.0 89.0 90.0 91.0 119.0 89.0 90.0 90.0 91.0 90.0 09:09:36 INFO - PID 1651 | 09:09:36 INFO - PID 1651 | [#6] imaging-darkroom Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 09:09:36 INFO - PID 1651 | Values: 97.0 97.0 96.0 96.0 96.0 96.0 97.0 97.0 96.0 95.0 09:09:36 INFO - PID 1651 | 09:09:36 INFO - PID 1651 | [#7] imaging-desaturate Cycles:10 Average:93.00 Median:85.50 stddev:16.03 (18.7%) stddev-sans-first:16.80 09:09:36 INFO - PID 1651 | Values: 86.0 85.0 88.0 85.0 118.0 128.0 86.0 84.0 86.0 84.0 09:09:36 INFO - PID 1651 | 09:09:36 INFO - PID 1651 | [#8] json-parse-financial Cycles:10 Average:49.10 Median:49.00 stddev:1.20 (2.4%) stddev-sans-first:0.67 09:09:36 INFO - PID 1651 | Values: 52.0 48.0 48.0 49.0 49.0 49.0 50.0 49.0 49.0 48.0 09:09:36 INFO - PID 1651 | 09:09:36 INFO - PID 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:57.60 Median:57.50 stddev:3.37 (5.9%) stddev-sans-first:3.44 09:09:36 INFO - PID 1651 | Values: 55.0 54.0 59.0 56.0 66.0 59.0 56.0 57.0 58.0 56.0 09:09:36 INFO - PID 1651 | 09:09:36 INFO - PID 1651 | [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:83.00 stddev:10.28 (12.4%) stddev-sans-first:10.73 09:09:36 INFO - PID 1651 | Values: 83.0 83.0 80.0 83.0 83.0 83.0 95.0 105.0 107.0 80.0 09:09:36 INFO - PID 1651 | 09:09:36 INFO - PID 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:143.30 Median:141.00 stddev:13.72 (9.7%) stddev-sans-first:14.36 09:09:36 INFO - PID 1651 | Values: 137.0 148.0 135.0 135.0 138.0 131.0 139.0 148.0 179.0 143.0 09:09:36 INFO - PID 1651 | 09:09:36 INFO - PID 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.40 Median:184.50 stddev:8.04 (4.4%) stddev-sans-first:8.07 09:09:36 INFO - PID 1651 | Values: 178.0 187.0 184.0 184.0 207.0 181.0 183.0 185.0 185.0 180.0 09:09:36 INFO - PID 1651 | 09:09:36 INFO - PID 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:68.00 stddev:11.44 (16.8%) stddev-sans-first:11.34 09:09:36 INFO - PID 1651 | Values: 60.0 96.0 89.0 67.0 65.0 68.0 66.0 70.0 67.0 68.0 09:09:36 INFO - PID 1651 | -------- Summary: end -------- 09:09:36 INFO - PID 1651 | 09:09:37 INFO - TEST-INFO | 1651: exit 0 09:09:38 INFO - TEST-OK | kraken | took 60436ms 09:09:38 INFO - SUITE-END | took 1180s 09:09:38 INFO - Completed test suite (00:19:41) 09:09:38 INFO - javascript benchmark 09:09:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7617.532045506624, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2950.77869159813, 3533.939818054583, 3546.538949936508, 3565.750397472178, 3590.910227244319, 5383.757730902109, 5661.8584535386635, 6160.784372546962, 6185.474234690051, 6209.813705588834, 6048.0625503047095, 6100.511959043277, 6101.877962440749, 6112.205413296277, 6137.846553836156, 5248.763805628737, 5270.1040823060175, 5278.366596008465, 5290.894182116355, 5380.21986811912, 5347.0, 5368.0605893968595, 5371.919421208685, 5382.9730851345685, 5385.542228910547, 5348.064088784447, 5357.955198736248, 5361.276227709268, 5366.382865970424, 5373.086575282192, 4481.395011673415, 5358.223057656618, 5361.973190134044, 5369.436209198017, 5373.489518495776, 5198.9740051299505, 5310.097283461821, 5324.520793128637, 5412.431694672042, 5414.3232095988005, 6134.9079763803575, 6178.38216178383, 6180.042093475474, 6193.814185574395, 6203.782867599657, 6291.653959032252, 6474.967625161891, 6502.154719886432, 6521.02184672303, 6533.444657204143, 6070.327552986512, 6391.744330226786, 6399.520035997319, 6408.423241908251, 6687.732490700366, 6217.3471785462325, 6221.4089661482085, 6230.968845155745, 6237.87524249517, 6246.562740608159, 6828.726850926007, 6831.04365388846, 6846.075779769667, 6847.315268473113, 6855.862882742417, 6249.75000999964, 6277.968610157011, 6450.064740612679, 6451.774187903401, 6468.353164683494, 6524.412802847672, 6570.737170513126, 6633.900491492632, 6659.600423974577, 6661.633610151392, 5825.533957283407, 6093.939060609426, 6512.153420055362, 6521.47828173745, 6540.542162048706, 6244.968775156186, 6476.805695829133, 6523.347665233534, 6523.836904077436, 6536.673166341664, 5135.640505164677, 5236.423993360727, 5294.073537130987, 5307.8142265021315, 5339.279197308314, 4641.0, 4646.628269738413, 4666.0, 4668.323093151474, 4702.388689470347, 6075.696215189223, 6256.937430625727, 6258.468030217391, 6262.655553944577, 6268.49852011838, 6285.617164223863, 6544.0, 6577.473802095821, 6614.239362473281, 6628.96685516579, 6270.435660790551, 6278.215223097113, 6284.685765711696, 6285.0, 6295.874082518324, 5044.722540260247, 5779.88440231193, 5807.767689292466, 5823.4467725565155, 5828.795992140254, 6524.543281970216, 6594.340565943367, 6742.797716068526, 6815.318468153343, 6826.624535650389, 6614.5039122067, 6627.3372662733345, 6631.303713110054, 6637.103990961158, 6642.667866606747, 6802.3537763912345, 6808.625525595941, 6855.040294358893, 6860.725570977304, 6860.897086543606, 5476.069068258326, 6240.126382306572, 6346.3019067903415, 6460.12788273577, 6475.09348691193, 6200.131981522681, 6587.242467116152, 6600.867982640224, 6616.768413105518, 6648.800535983928, 6223.626582405071, 6286.836935167009, 6426.839329016812, 6429.38920802523, 6433.035044743326, 5412.945870541244, 6216.44052035319, 6384.61692298445, 6454.935450645621, 6472.579282346633, 6340.270868849957, 6349.365063493614, 6361.077643741724, 6361.777337793155, 6372.968135159294, 6443.871122577616, 6446.355364463516, 6465.191851018622, 6470.191226096738, 6472.0, 6110.528382738247, 6145.0028740660355, 6182.752689892533, 6195.039768835838, 6203.627782333075], "value": 5978.938065273592, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.7585844954267, 743.9367653749432, 753.5591678867863, 1100.108911781457, 1101.6419663609329, 26316.078937237176, 36130.81934590327, 36192.63807361922, 36313.63686363136, 36382.27235455289, 38104.809475952585, 38463.0, 38508.614913850855, 38568.80715596418, 38582.228355432875, 5945.464908158265, 8321.375896807749, 8495.617697203641, 8500.362472814533, 8501.95749021254, 5974.581779275452, 6056.636601803883, 6064.151018857364, 6069.241344831896, 6072.149899014142, 8302.211289927447, 8464.576771161448, 8467.237948584627, 8474.025487069004, 8504.829903401927, 8421.15788421159, 8453.450525715809, 8468.745937621881, 8482.0, 8483.151684831499, 8247.546384948826, 8306.626201820933, 8316.667333306661, 8318.500889946623, 8330.62512186953, 36341.454878176846, 36530.8173459131, 36563.81718091419, 36638.81680591607, 36656.81671591652, 3590.622984586633, 3620.438831981021, 3623.4927110204594, 3623.5289412376487, 3636.7636103653176, 25011.62482562763, 29632.851835740683, 30109.247268818235, 30229.69770302291, 30294.69705302941, 3102.4260511805387, 3142.4500712375243, 3148.307372378073, 3156.526521021842, 3168.5088811234295, 293582.5320873382, 299929.500352499, 300028.0, 300309.0, 300655.9016147574, 47557.762211189416, 47582.28626570604, 47618.0, 47724.76137619359, 47790.283145752845, 49617.0, 49680.75159624179, 49744.25383619249, 49772.0, 49854.750726246864, 13540.59378218655, 13607.931960340135, 13649.0, 13655.590332290047, 13657.658558536115, 11147.940945610155, 11152.609658661908, 11172.776544469227, 11180.832287515694, 11222.551097956153, 10174.796504070026, 10229.641962531276, 10231.897681023243, 11715.531378744925, 12001.519939202333, 5094.872628184325, 5202.557782588522, 5204.609654275944, 5205.973970130125, 5234.790608375699, 950.6910254167424, 1015.674984005126, 1016.8576399304103, 1023.5905637744961, 1064.1061508332882, 21624.459388515414, 21690.783092169193, 23176.0, 24101.879490602434, 24283.90922386603, 960.9711708648751, 1108.844761733358, 1133.586241022021, 1134.9319040857574, 1137.1528211482332, 11646.41767911601, 12225.0, 12251.14242003069, 12267.325297108566, 12269.141160118885, 305689.0, 307053.0, 307579.0, 307876.0, 308640.0, 51951.48048519542, 52071.73964130155, 52120.21819672708, 52217.73891130596, 52331.953360932566, 1437.252628633105, 1475.7786332050064, 1518.916459594711, 1518.9924050379677, 1536.8539988701054, 19261.518462038563, 22848.65727014063, 23188.072477101403, 23199.76800231976, 23227.0, 36061.45907811332, 36110.09724756902, 36134.457983129745, 36178.4573231407, 36299.91100266996, 285740.0, 286196.0, 286884.0, 286966.5651671812, 287097.5645121761, 32478.512822308156, 32489.35021299608, 32501.674983249864, 32557.0, 32566.86015989429, 35829.0, 36634.45048324331, 42362.788186058875, 42452.787736061124, 42829.78585107055, 29028.274293141996, 29072.52883504926, 29494.705052949197, 29626.0, 29910.401791964476, 26441.206763797116, 29521.26196845096, 29561.113166605035, 29683.257918552208, 29743.55384669275, 34994.47508287428, 35622.82188589041, 35635.64364356427, 35668.82165589155, 35785.46321805123, 25246.368840779127, 27319.0, 29084.854575726986, 29758.95843645462, 29809.701902980694, 18952.336668216547, 19667.606647866676, 21999.450013749785, 23164.0, 23852.211084168408], "value": 16683.058497490187, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.97478163919345, 394.43201789423244, 417.7222147272062, 439.1655853877633, 449.94825595056557, 13274.269915154675, 15085.094894306336, 20943.266985655504, 21994.780052199472, 22270.443238919033, 19145.90427047863, 20854.165833366686, 21240.681389779165, 21840.672389914125, 23847.28458146254, 5725.227094342263, 5971.492423144038, 6131.969340153293, 6237.875242495147, 6245.46913512352, 3617.457381392786, 6035.064564992434, 6168.1364608954555, 6175.907361389583, 6183.752649893999, 3513.5783705955323, 3743.513343265385, 6186.876262474748, 6197.659128747917, 6202.906956395657, 5879.118132280149, 6127.846803829918, 6145.525073982257, 6161.3838616138255, 6182.350853160443, 5418.45815418455, 5483.369412517572, 5484.095124304485, 5491.258680078178, 5496.972515137439, 26669.665841893442, 27762.750676219417, 27957.0, 27978.0, 28406.857965710245, 2176.858504197222, 2207.293666026872, 2212.5906707259046, 2215.2135991722866, 2217.81148602369, 15793.447229347033, 15886.205689715467, 17712.557186070324, 17754.112294385228, 17954.281828726835, 2075.8962051897342, 2113.9154433822628, 2145.099058395462, 2145.4207364011786, 2151.7740637233023, 162936.0, 172516.2748372513, 173122.99999999875, 173825.0, 174026.0, 12428.514297140608, 12489.50041998328, 12638.684032899251, 12641.988640908889, 12860.03549733755, 16763.49709508717, 16769.0, 16797.41209057677, 16798.908070975347, 16811.41160059392, 8557.743267701979, 8891.510966896753, 8898.688545900863, 9032.412893161923, 9086.363954523253, 6926.61903595297, 8445.366597505212, 8448.11294814048, 8651.847113385611, 8655.221030107195, 7699.692012319557, 7810.218978102258, 7870.5924682178165, 7880.684772609032, 7889.289963903277, 2061.6082944240547, 2084.5622419292117, 2084.9061792219386, 2088.6762551804495, 2232.3860938242115, 942.6276620734772, 951.6439074319068, 955.3694561589457, 974.5711886769799, 989.8317286061387, 21206.893965530075, 21659.70041797466, 21780.237691680715, 21816.127354905628, 22024.0, 859.1666083898608, 960.9471479068578, 978.2369751593768, 1008.1581879131007, 1009.7374682582581, 10715.517801698943, 11005.834912476319, 11012.724681882857, 11016.504257308441, 11021.118310535137, 543112.0, 549539.0, 559590.6573079772, 560812.0, 565122.1743891337, 132754.7158491539, 134405.32797336148, 138252.0, 138547.0, 140541.0, 1106.950187241576, 1108.9944550277196, 1146.358039497884, 1147.036489348951, 1150.8676502202354, 13852.722945541234, 17730.91134544319, 17820.376286829898, 18010.0, 18281.0, 54507.454925450234, 55136.172957404866, 56771.71614141903, 57054.71472642776, 57687.71156144192, 74722.0, 75059.87410188961, 76531.87744980499, 77257.3896612231, 77428.45143097219, 6654.0, 7569.924300757142, 8761.605727742139, 8908.510031948304, 9040.954795225982, 12162.391880405767, 13673.86326136726, 13772.10481318711, 14003.089799163023, 14427.91790615687, 10412.375257484575, 11407.600733974272, 11471.598494052669, 11979.28124312544, 12015.038796896053, 10575.841362379417, 11432.82850757256, 11568.24806387582, 11684.766304674029, 11942.34317112567, 11570.19008669385, 11729.824052639387, 12067.97422219086, 12105.636830894735, 12162.209456385306, 8650.221480066824, 8678.609462574073, 9009.81980360376, 9131.0, 9156.771080723036, 8414.410991230556, 10753.784924301313, 11030.338179709242, 11386.146039046938, 11475.196736228383], "value": 10223.44458937367, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1242.931638759868, 1441.084911081463, 1465.9340329685162, 1471.9852801471982, 1489.5978085916809, 11152.940470655285, 11688.941555292211, 11697.59058432955, 11717.824232636507, 11717.882821171786, 11356.205065645408, 11372.317660940349, 11568.305901645906, 11653.650390488277, 11716.121290903173, 2477.925662230136, 2507.3731567108225, 2508.147229941819, 2516.55960206964, 2517.748225177477, 2443.389152711822, 2452.288836237489, 2497.67530221071, 2502.5495410826134, 2503.2740505253455, 2117.2272120676, 2425.527022230666, 2514.3085651445817, 2523.83595066321, 2526.103233352161, 2444.9877750611313, 2452.36238577971, 2480.578301688708, 2500.599904015367, 2504.6743923290037, 2452.791512721421, 2464.3592665906995, 2478.281298423455, 2485.7762801347785, 2494.0896572750817, 11591.246568973074, 11664.825027624593, 11698.005669518101, 11715.882841171564, 11743.236689615147, 6457.16056912603, 6693.163354580677, 6704.597724136567, 6710.966445167743, 6711.127553418073, 3766.9264259686133, 4195.0, 4284.3145096784365, 4316.913661726748, 4351.630111440531, 1128.9774204515945, 1220.0788404754442, 1237.4802582915108, 1271.4024408527978, 1287.9484820607165, 14830.0, 15209.847901521065, 15211.0, 15750.0, 16243.106629135393, 5338.733063346817, 5498.780048798083, 5630.859228519238, 5634.746436410372, 5642.069058605366, 12022.398880055962, 12049.638510844688, 12081.275123492444, 12097.274163550215, 12116.636500904988, 5484.972575137099, 6455.806325810139, 6461.8061458156335, 6461.967690161613, 6470.708818103197, 5989.371116032841, 6011.428914253139, 6162.784302549389, 6180.289266734293, 6262.906056409158, 4142.0, 4282.89292767677, 4300.548442413501, 4334.133173365277, 4369.191699535596, 1270.9046821488425, 1272.4210484229654, 1272.8154417609394, 1287.311288460669, 1288.4266501406785, 781.3124450483651, 787.7439832054605, 797.7885860247039, 802.6388125343618, 803.2048272210469, 6541.34586541342, 6806.353396427331, 6947.305269473113, 6952.66345938129, 7003.4747393944635, 922.7646950027835, 942.6370847223731, 943.5423819447562, 945.8202941441104, 951.191487235844, 4114.136031433432, 4224.936625950613, 4301.65586753059, 4353.978230108893, 4401.427814384109, 12310.75378492425, 14218.573442796733, 14988.700225995419, 15040.172790496628, 15040.32318545668, 14155.575332740034, 14739.336729847182, 14923.850761492246, 14926.179060151795, 14945.850541494447, 8334.833303333899, 8550.401471897032, 8579.485230886166, 8591.65633374658, 8591.828163436696, 5665.915011274752, 6788.9660551696925, 6889.138857642794, 7066.929330706833, 7101.502894797522, 12569.622911312676, 12672.366381681064, 12733.108682392143, 12752.553660621834, 12789.808152877527, 12671.80992285098, 12828.55100071493, 13097.607071787861, 13133.080684352004, 13154.0, 9350.158485736316, 9351.0, 9553.18797902186, 9553.283503737386, 9573.138417542455, 8857.64569417216, 10430.478476076318, 10438.53026613789, 10524.421156836448, 10549.630762923261, 8702.04277529484, 8812.559372031244, 8871.379003469954, 8934.4192627479, 9002.549872506479, 8548.273396761346, 8662.263707584674, 8696.17386348296, 8743.912560874563, 8760.12398760119, 6152.723127459186, 7965.8406831864195, 7969.840603187788, 7970.4420690553425, 7998.720044798404, 4919.3358896549935, 5406.83779486616, 5520.558355331644, 5976.701164941823, 6099.84750381244, 5256.922330922228, 5358.919616205838, 5929.377415371324, 5973.1338955852025, 6074.301455332693], "value": 5302.02228884494, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.81436317749075, 392.14903659059837, 398.11816825731, 401.85131501344506, 402.0511592641364, 5893.351731309558, 5951.70241487925, 5974.1337506061645, 5975.671338076404, 5978.252718410199, 4931.679440836352, 5661.716914154296, 5763.452472015152, 5807.216025836511, 5845.415458454163, 3545.840437180333, 4297.753651441094, 4464.486584042844, 4478.55214478552, 4497.797599108048, 4467.285234362503, 4499.370088187657, 4507.504174540798, 4518.43519560055, 4531.728096314215, 3722.3485889969284, 3931.958031121755, 3963.4451176835264, 4497.391512922513, 4516.683832131752, 3545.521354617132, 3567.4648802679544, 3744.3821769408014, 4313.223619748444, 4317.805698743564, 3756.868509602178, 3771.0949372150762, 3771.7359784815076, 3774.5281839770028, 3786.7917264550438, 4627.9074418511445, 5442.2380866678695, 5757.0788673811985, 5819.970900145515, 5861.238039054938, 5065.949340506585, 5109.4379618241965, 5129.615278854101, 5138.713272593697, 5143.996920600484, 6228.626282423069, 6290.056491526262, 6290.811275661692, 6291.7797877074545, 6314.494840412756, 3367.579052618423, 3653.7394598863616, 4155.210510003089, 4277.401163837066, 4279.465066866642, 5448.863778405532, 6303.149074874879, 6420.422162005442, 6455.257645370749, 6497.252815926135, 3572.5355703758346, 4200.978995105066, 4270.871873843789, 4275.187714334266, 4288.849890253826, 4331.761753103547, 4342.0, 4346.891327716832, 4373.387725718402, 4404.735715856995, 4214.304639734471, 4572.359869618256, 4739.549742774431, 4881.341018962395, 4964.329815474937, 5521.641093328921, 5637.915431268534, 6233.2208473940755, 6304.275008374004, 6305.243370795534, 1428.328685517805, 1470.5882352941082, 1481.7110663420528, 1484.6733718581895, 1495.588713103905, 962.5091203486272, 995.4475266227313, 997.9800403992025, 1002.9569247982017, 1006.713086770267, 5113.7698803553185, 5660.613149778248, 5930.673812940244, 6006.336134957673, 6018.699065046818, 5662.745176467069, 6429.260635026938, 6429.9678501607195, 6462.3537646235, 6470.547061705635, 4937.259411088366, 5899.76400943966, 5902.321233058167, 5985.34161242263, 6003.969980150158, 2362.4802543440414, 3112.8287944162835, 3113.688631136868, 3379.5437615921537, 3399.181437930695, 5568.9443105569235, 5805.983952808242, 6214.892553723138, 6692.19693636757, 6717.798466046026, 5507.421720719347, 5648.587853036741, 6360.554761166766, 6651.23510796255, 6741.258461569223, 5196.480351964773, 5793.8841223175305, 5831.620944638585, 6717.630530320879, 6781.728730850809, 5692.5730570208225, 5951.970240148771, 6177.4749146323065, 6411.871762564816, 6528.902066469102, 6407.533099756721, 6443.162388889415, 6474.320196379501, 6474.352564743488, 6505.0, 6392.552521323462, 6573.506986976092, 6584.7036883341325, 6642.070110184674, 6691.665416729242, 3986.402039694069, 4103.753774773523, 4256.765877876746, 4260.91478170441, 4265.95734042668, 6247.562670613013, 6442.420182183626, 6500.837479063061, 6505.544611877123, 6515.869682606227, 5591.832245032656, 6227.750889964351, 6259.405356491126, 6260.8730428521485, 6284.622922624657, 5303.515015795583, 5429.701366424884, 6285.0, 6299.685015749286, 6430.903536446864, 4662.393888794435, 5503.642263252876, 6122.448979591737, 6122.5408094392205, 6124.693765311806, 6239.284196845903, 6245.687715614292, 6269.435750782452, 6271.811845644638, 6278.372162783685, 5031.9245211322595, 5851.6008436540815, 6073.696315184135, 6110.144579758926, 6124.29570599369], "value": 4522.527413546318, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.1514974455781, 780.1769133564089, 850.413214881732, 857.6569372251099, 866.0213958227203, 12432.813507797391, 17682.46952591421, 17810.28758849646, 18287.08564571771, 18325.175367108477, 17175.656486870288, 17289.827101728977, 17388.304467821305, 17485.650286994252, 17486.125693715327, 955.5795450001995, 970.8058388322364, 974.532224532225, 974.9853752193723, 975.5073687787657, 665.7104159690526, 678.4063944048958, 950.410745337888, 987.9506024698773, 998.6005597760881, 1045.8588090607784, 1046.5552140340362, 1047.2145890582065, 1047.9633212837552, 1050.9842352364722, 1041.9426931518763, 1043.5408420295084, 1044.5195210203315, 1051.7212938571247, 1053.963111291101, 770.7803276066351, 771.0785611194625, 771.1247733822096, 771.5178013741412, 782.9334506566948, 13884.375203115884, 16056.197190140447, 16498.67002659952, 16511.752323715154, 16768.832311676848, 16548.75176872348, 16633.83366166335, 16772.83227167725, 17032.744508832377, 17071.317147314094, 11195.328280303127, 13426.530071447452, 13909.721805563933, 14053.5081272156, 14129.929350353183, 3408.1479630092476, 3417.333619944112, 3439.6560343965652, 3442.1050526862946, 3452.205992621686, 118571.0, 120261.0, 120867.18699219519, 121239.0, 123091.0, 9775.413475191512, 10749.516271767789, 11704.35626040559, 11998.340091294887, 12052.156349055658, 18842.246310147715, 24354.0, 24377.51244975126, 24433.511329773304, 24436.755632443805, 7644.503107298008, 7785.948896898846, 7788.805279868048, 7790.571518566533, 7797.181295963956, 3816.1413681921345, 3891.2217556488818, 3911.2373087247715, 3913.0804260998643, 3915.334393153171, 4182.707210495236, 4321.848735294249, 4322.092360604245, 4334.28484300087, 4344.066025804404, 887.0641473245659, 927.2859897878595, 931.1154403316876, 932.38462614674, 933.1321870660215, 615.4980006274569, 621.6798348850346, 629.3706293706293, 635.7202830754453, 656.4223483334634, 9374.484403357881, 10543.84184237237, 10773.407462589475, 11053.28153670009, 11095.223334366518, 613.1477246627192, 613.7882430561449, 622.5642050564622, 635.1203583037434, 645.3868824616633, 4609.2394754865745, 4691.3432119503295, 4862.854114376574, 5325.147976323769, 5333.759980800874, 99602.50198749105, 102645.48677256715, 103382.48308758409, 103415.0, 106199.0, 83033.0, 83381.3323733522, 84240.57879710685, 84987.57506212429, 92112.0, 66792.66603667047, 74250.0, 78521.60739196268, 79149.60425197837, 79384.20615793768, 11329.150313726339, 11462.484188211718, 11669.183157178915, 11681.123915706527, 11699.356535390636, 33257.66742332546, 36627.90116296515, 37237.62762372341, 37764.81117594504, 37892.43161352527, 65121.02318465132, 65514.34485655273, 67396.6630166846, 67547.66226168838, 67583.32416675967, 13809.447622095004, 13952.0, 13974.58076257714, 14008.859911400756, 14022.368993395527, 16317.347306107622, 16836.0, 16845.41041063557, 16855.831441685426, 16876.915615421844, 14822.777658334919, 14841.777373339624, 14901.552953411416, 14905.627359316104, 15151.166685831944, 15100.320485578395, 15164.848351516785, 15333.463328783439, 15365.846341536888, 15442.45951391696, 14755.409783608535, 14855.40578376896, 14875.884308677108, 15037.924810375878, 15084.472043478425, 10262.846057308998, 10433.26967112295, 10592.523336450033, 10658.467076645982, 10659.840102398626, 11642.825357619473, 11769.646910592695, 12088.939555302168, 12176.756464870476, 12565.811512827133], "value": 7989.77674907434, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1442.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 110.0, 112.0, 110.0, 113.0, 111.0, 111.0, 111.0, 111.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 110.0, 108.0, 152.0, 112.0, 112.0, 109.0, 108.0, 136.0, 111.0], "value": 119.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 188.0, 184.0, 185.0, 187.0, 185.0, 186.0, 185.0, 188.0, 183.0], "value": 185.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 58.0, 62.0, 86.0, 60.0, 59.0, 64.0, 70.0, 96.0, 70.0], "value": 70.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 70.0, 87.0, 70.0, 68.0, 68.0, 92.0, 69.0, 69.0, 90.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 90.0, 91.0, 119.0, 89.0, 90.0, 90.0, 91.0, 90.0], "value": 92.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0, 95.0], "value": 96.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 88.0, 85.0, 118.0, 128.0, 86.0, 84.0, 86.0, 84.0], "value": 93.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 48.0, 48.0, 49.0, 49.0, 49.0, 50.0, 49.0, 49.0, 48.0], "value": 49.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 59.0, 56.0, 66.0, 59.0, 56.0, 57.0, 58.0, 56.0], "value": 57.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 80.0, 83.0, 83.0, 83.0, 95.0, 105.0, 107.0, 80.0], "value": 88.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 148.0, 135.0, 135.0, 138.0, 131.0, 139.0, 148.0, 179.0, 143.0], "value": 143.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 187.0, 184.0, 184.0, 207.0, 181.0, 183.0, 185.0, 185.0, 180.0], "value": 185.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 96.0, 89.0, 67.0, 65.0, 68.0, 66.0, 70.0, 67.0, 68.0], "value": 71.6, "unit": "score"}]}]} 09:09:38 INFO - Return code: 0 09:09:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:09:38 ERROR - # TBPL SUCCESS # 09:09:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:09:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:09:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:09:38 INFO - 2017-04-19 09:09:38.695 screenresolution[1656:9811] starting screenresolution argv=screenresolution get 09:09:38 INFO - 2017-04-19 09:09:38.698 screenresolution[1656:9811] Display 0: 1600x1200x32@60 09:09:38 INFO - 2017-04-19 09:09:38.704 screenresolution[1657:9814] starting screenresolution argv=screenresolution list 09:09:38 INFO - Available Modes on Display 0 09:09:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:09:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:09:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:09:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:09:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:09:38 INFO - Intel Iris: 09:09:38 INFO - Chipset Model: Intel Iris 09:09:38 INFO - Type: GPU 09:09:38 INFO - Bus: Built-In 09:09:38 INFO - VRAM (Dynamic, Max): 1536 MB 09:09:38 INFO - Vendor: Intel (0x8086) 09:09:38 INFO - Device ID: 0x0a2e 09:09:38 INFO - Revision ID: 0x0009 09:09:38 INFO - Displays: 09:09:38 INFO - Display: 09:09:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:09:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:09:38 INFO - Display Serial Number: 1600x1200 60 09:09:38 INFO - Main Display: Yes 09:09:38 INFO - Mirror: Off 09:09:38 INFO - Online: Yes 09:09:38 INFO - Rotation: Supported 09:09:38 INFO - Return code: 0 09:09:38 INFO - Running post-action listener: _resource_record_post_action 09:09:38 INFO - [mozharness: 2017-04-19 16:09:38.940414Z] Finished run-tests step (success) 09:09:38 INFO - Running post-run listener: _resource_record_post_run 09:09:39 INFO - Total resource usage - Wall time: 1201s; CPU: 53.0%; Read bytes: 36746752; Write bytes: 515539968; Read time: 374; Write time: 1608 09:09:39 INFO - TinderboxPrint: CPU usage
53.4% 09:09:39 INFO - TinderboxPrint: I/O read bytes / time
36,746,752 / 374 09:09:39 INFO - TinderboxPrint: I/O write bytes / time
515,539,968 / 1,608 09:09:39 INFO - TinderboxPrint: CPU idle
2,239.6 (46.6%) 09:09:39 INFO - TinderboxPrint: CPU system
959.9 (20.0%) 09:09:39 INFO - TinderboxPrint: CPU user
1,606.2 (33.4%) 09:09:39 INFO - TinderboxPrint: Swap in / out
244,617,216 / 0 09:09:39 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205419008; Write bytes: 204576768; Read time: 15859; Write time: 454 09:09:39 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 34522624; Write bytes: 303787008; Read time: 349; Write time: 1126 09:09:39 INFO - Running post-run listener: _upload_blobber_files 09:09:39 INFO - Blob upload gear active. 09:09:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:09:39 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:09:39 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'] 09:09:39 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 09:09:39 INFO - (blobuploader) - INFO - Open directory for files ... 09:09:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:09:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:09:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:40 INFO - (blobuploader) - INFO - Done attempting. 09:09:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:09:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:09:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:42 INFO - (blobuploader) - INFO - Done attempting. 09:09:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:09:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:09:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:43 INFO - (blobuploader) - INFO - Done attempting. 09:09:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:09:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:09:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:45 INFO - (blobuploader) - INFO - Done attempting. 09:09:45 INFO - (blobuploader) - INFO - Iteration through files over. 09:09:45 INFO - Return code: 0 09:09:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:09:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:09:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d78ff8697de975e4d6de57096ac116137e0cfec0c1579f17da9a596ef20eb3d64247305c8fcdae025d8354c5711ba1c4d88d6fd541a54569ce7c6a1dcf5459a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1421a5efd017575004947509bf02acd1ac95c59260e87d0768d048d7109434e6764d82e911d04c57cee53be278c79eacde482a1b09fc5596bbca5d24a117721a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47f591289db723fef4e262d738f02315324150b1dfe5251e14c82b13e1dcda7ab934f47d84d0f1c2ead7cbf1c02ce2c03068990e5e1b533f8591f9cd9860348c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6328052dedd76cfcc3c0f2691c47ea364f63539f4f0b168ed144c7a958b1bfc4dbb7206ce3834e36829f12fc611b22830c94883ddd06d1a0d5f5100e65c73ec"} 09:09:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:09:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:09:45 INFO - Contents: 09:09:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d78ff8697de975e4d6de57096ac116137e0cfec0c1579f17da9a596ef20eb3d64247305c8fcdae025d8354c5711ba1c4d88d6fd541a54569ce7c6a1dcf5459a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1421a5efd017575004947509bf02acd1ac95c59260e87d0768d048d7109434e6764d82e911d04c57cee53be278c79eacde482a1b09fc5596bbca5d24a117721a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47f591289db723fef4e262d738f02315324150b1dfe5251e14c82b13e1dcda7ab934f47d84d0f1c2ead7cbf1c02ce2c03068990e5e1b533f8591f9cd9860348c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6328052dedd76cfcc3c0f2691c47ea364f63539f4f0b168ed144c7a958b1bfc4dbb7206ce3834e36829f12fc611b22830c94883ddd06d1a0d5f5100e65c73ec"} 09:09:45 INFO - Running post-run listener: copy_logs_to_upload_dir 09:09:45 INFO - Copying logs to upload dir... 09:09:45 INFO - mkdir: /builds/slave/test/build/upload/logs 09:09:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.228502 ========= master_lag: 0.55 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-04-19 09:09:46.051898) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-19 09:09:46.055768) ========= 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.oJ9OREoQV7/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.OwQFuaNehi/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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/d78ff8697de975e4d6de57096ac116137e0cfec0c1579f17da9a596ef20eb3d64247305c8fcdae025d8354c5711ba1c4d88d6fd541a54569ce7c6a1dcf5459a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1421a5efd017575004947509bf02acd1ac95c59260e87d0768d048d7109434e6764d82e911d04c57cee53be278c79eacde482a1b09fc5596bbca5d24a117721a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47f591289db723fef4e262d738f02315324150b1dfe5251e14c82b13e1dcda7ab934f47d84d0f1c2ead7cbf1c02ce2c03068990e5e1b533f8591f9cd9860348c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6328052dedd76cfcc3c0f2691c47ea364f63539f4f0b168ed144c7a958b1bfc4dbb7206ce3834e36829f12fc611b22830c94883ddd06d1a0d5f5100e65c73ec"} build_url:https://queue.taskcluster.net/v1/task/Zz5A3NYiSL2WYZw1pYWyWA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011670 build_url: 'https://queue.taskcluster.net/v1/task/Zz5A3NYiSL2WYZw1pYWyWA/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/d78ff8697de975e4d6de57096ac116137e0cfec0c1579f17da9a596ef20eb3d64247305c8fcdae025d8354c5711ba1c4d88d6fd541a54569ce7c6a1dcf5459a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1421a5efd017575004947509bf02acd1ac95c59260e87d0768d048d7109434e6764d82e911d04c57cee53be278c79eacde482a1b09fc5596bbca5d24a117721a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47f591289db723fef4e262d738f02315324150b1dfe5251e14c82b13e1dcda7ab934f47d84d0f1c2ead7cbf1c02ce2c03068990e5e1b533f8591f9cd9860348c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6328052dedd76cfcc3c0f2691c47ea364f63539f4f0b168ed144c7a958b1bfc4dbb7206ce3834e36829f12fc611b22830c94883ddd06d1a0d5f5100e65c73ec"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-19 09:09:46.095042) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 09:09:46.095800) ========= 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.oJ9OREoQV7/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.OwQFuaNehi/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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.005259 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 09:09:46.147306) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-19 09:09:46.148011) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-19 09:09:46.148669) ========= ========= Total master_lag: 0.69 =========