builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0344 starttime: 1492212793.12 results: success (0) buildid: 20170414145706 builduid: 5dffed02ac65475abd7c8f930125f63b revision: 9379831bb9c3d9abfea7dbf8dd06dbdab1d81dc4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-14 16:33:13.123106) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-14 16:33:13.123553) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-14 16:33:13.123844) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-14 16:33:13.150805) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 16:33:13.151197) ========= 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.uxfy5xJwoI/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.IPJpNAvYND/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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-14 16:33:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 66.4M=0s 2017-04-14 16:33:13 (66.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.143618 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 16:33:13.318863) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 16:33:13.319177) ========= 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.uxfy5xJwoI/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.IPJpNAvYND/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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.026915 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 16:33:13.369256) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-14 16:33:13.369861) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9379831bb9c3d9abfea7dbf8dd06dbdab1d81dc4 --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 9379831bb9c3d9abfea7dbf8dd06dbdab1d81dc4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uxfy5xJwoI/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.IPJpNAvYND/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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-14 16:33:13,478 truncating revision to first 12 chars 2017-04-14 16:33:13,478 Setting DEBUG logging. 2017-04-14 16:33:13,478 attempt 1/10 2017-04-14 16:33:13,478 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9379831bb9c3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-14 16:33:14,648 unpacking tar archive at: mozilla-central-9379831bb9c3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.454226 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-14 16:33:14.848615) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-14 16:33:14.848940) ========= script_repo_revision: 9379831bb9c3d9abfea7dbf8dd06dbdab1d81dc4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-14 16:33:14.849320) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-14 16:33:14.849599) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-14 16:33:14.869449) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-14 16:33:14.869856) ========= /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.uxfy5xJwoI/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.IPJpNAvYND/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 16:33:15 INFO - MultiFileLogger online at 20170414 16:33:15 in /builds/slave/test 16:33:15 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 16:33:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:33:15 INFO - {'append_to_log': False, 16:33:15 INFO - 'base_work_dir': '/builds/slave/test', 16:33:15 INFO - 'blob_upload_branch': 'Firefox', 16:33:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:33:15 INFO - 'branch': 'Firefox', 16:33:15 INFO - 'buildbot_json_path': 'buildprops.json', 16:33:15 INFO - 'config_files': ('talos/mac_config.py',), 16:33:15 INFO - 'default_actions': ('clobber', 16:33:15 INFO - 'read-buildbot-config', 16:33:15 INFO - 'download-and-extract', 16:33:15 INFO - 'populate-webroot', 16:33:15 INFO - 'create-virtualenv', 16:33:15 INFO - 'install', 16:33:15 INFO - 'run-tests'), 16:33:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:33:15 INFO - 'download_minidump_stackwalk': True, 16:33:15 INFO - 'download_symbols': 'ondemand', 16:33:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:33:15 INFO - 'tooltool.py': '/tools/tooltool.py', 16:33:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:33:15 INFO - '/tools/misc-python/virtualenv.py')}, 16:33:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:33:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:33:15 INFO - 'gecko_profile': False, 16:33:15 INFO - 'gecko_profile_interval': 0, 16:33:15 INFO - 'installer_path': 'installer.exe', 16:33:15 INFO - 'log_level': 'info', 16:33:15 INFO - 'log_name': 'talos', 16:33:15 INFO - 'log_to_console': True, 16:33:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:33:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:33:15 INFO - 'opt_config_files': (), 16:33:15 INFO - 'pip_index': False, 16:33:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:33:15 INFO - 'cmd': ('bash', 16:33:15 INFO - '-c', 16:33:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:33:15 INFO - 'enabled': True, 16:33:15 INFO - 'halt_on_failure': False, 16:33:15 INFO - 'name': 'check_screen_resolution'},), 16:33:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:33:15 INFO - 'cmd': ('bash', 16:33:15 INFO - '-c', 16:33:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:33:15 INFO - 'enabled': True, 16:33:15 INFO - 'halt_on_failure': False, 16:33:15 INFO - 'name': 'check_screen_resolution'},), 16:33:15 INFO - 'run_cmd_checks_enabled': True, 16:33:15 INFO - 'suite': 'dromaeojs', 16:33:15 INFO - 'system_bits': '32', 16:33:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:33:15 INFO - 'title': 't-yosemite-r7-0344', 16:33:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:33:15 INFO - 'use_talos_json': True, 16:33:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:33:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:33:15 INFO - 'work_dir': 'build'} 16:33:15 INFO - [mozharness: 2017-04-14 23:33:15.078692Z] Running clobber step. 16:33:15 INFO - Running pre-action listener: _resource_record_pre_action 16:33:15 INFO - Running main action method: clobber 16:33:15 INFO - rmtree: /builds/slave/test/build 16:33:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:33:17 INFO - Running post-action listener: _resource_record_post_action 16:33:17 INFO - [mozharness: 2017-04-14 23:33:17.408284Z] Finished clobber step (success) 16:33:17 INFO - [mozharness: 2017-04-14 23:33:17.408449Z] Running read-buildbot-config step. 16:33:17 INFO - Running pre-action listener: _resource_record_pre_action 16:33:17 INFO - Running main action method: read_buildbot_config 16:33:17 INFO - Using buildbot properties: 16:33:17 INFO - { 16:33:17 INFO - "project": "", 16:33:17 INFO - "product": "firefox", 16:33:17 INFO - "script_repo_revision": "production", 16:33:17 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 16:33:17 INFO - "repository": "", 16:33:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 16:33:17 INFO - "buildid": "20170414145706", 16:33:17 INFO - "pgo_build": "False", 16:33:17 INFO - "basedir": "/builds/slave/test", 16:33:17 INFO - "buildnumber": 79, 16:33:17 INFO - "slavename": "t-yosemite-r7-0344", 16:33:17 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 16:33:17 INFO - "platform": "yosemite_r7", 16:33:17 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 16:33:17 INFO - "branch": "mozilla-central", 16:33:17 INFO - "repo_path": "mozilla-central", 16:33:17 INFO - "revision": "9379831bb9c3d9abfea7dbf8dd06dbdab1d81dc4", 16:33:17 INFO - "stage_platform": "macosx64", 16:33:17 INFO - "builduid": "5dffed02ac65475abd7c8f930125f63b", 16:33:17 INFO - "slavebuilddir": "test" 16:33:17 INFO - } 16:33:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/IwQgw9s6RNqyAVuzPGZaJw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 16:33:17 INFO - Running post-action listener: _resource_record_post_action 16:33:17 INFO - [mozharness: 2017-04-14 23:33:17.411847Z] Finished read-buildbot-config step (success) 16:33:17 INFO - [mozharness: 2017-04-14 23:33:17.411957Z] Running download-and-extract step. 16:33:17 INFO - Running pre-action listener: _resource_record_pre_action 16:33:17 INFO - Running main action method: download_and_extract 16:33:17 INFO - mkdir: /builds/slave/test/build/tests 16:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:33:17 INFO - trying https://queue.taskcluster.net/v1/task/IwQgw9s6RNqyAVuzPGZaJw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 16:33:17 INFO - Downloading https://queue.taskcluster.net/v1/task/IwQgw9s6RNqyAVuzPGZaJw/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 16:33:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IwQgw9s6RNqyAVuzPGZaJw/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 16:33:18 INFO - Downloaded 1325 bytes. 16:33:18 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 16:33:18 INFO - Using the following test package requirements: 16:33:18 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:33:18 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 16:33:18 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 16:33:18 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:33:18 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 16:33:18 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:33:18 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 16:33:18 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:33:18 INFO - u'jsshell-mac.zip'], 16:33:18 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:33:18 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 16:33:18 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 16:33:18 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:33:18 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 16:33:18 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:33:18 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 16:33:18 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:33:18 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 16:33:18 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:33:18 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 16:33:18 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:33:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IwQgw9s6RNqyAVuzPGZaJw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 16:33:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IwQgw9s6RNqyAVuzPGZaJw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:33:18 INFO - Fetch https://queue.taskcluster.net/v1/task/IwQgw9s6RNqyAVuzPGZaJw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 16:33:19 INFO - Expected file size: 52596605 16:33:19 INFO - Obtained file size: 52596605 16:33:36 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 16:33:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IwQgw9s6RNqyAVuzPGZaJw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 16:33:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IwQgw9s6RNqyAVuzPGZaJw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:33:36 INFO - Fetch https://queue.taskcluster.net/v1/task/IwQgw9s6RNqyAVuzPGZaJw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 16:33:37 INFO - Expected file size: 52596605 16:33:37 INFO - Obtained file size: 52596605 16:33:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IwQgw9s6RNqyAVuzPGZaJw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 16:33:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IwQgw9s6RNqyAVuzPGZaJw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:33:52 INFO - Fetch https://queue.taskcluster.net/v1/task/IwQgw9s6RNqyAVuzPGZaJw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 16:33:53 INFO - Expected file size: 14408853 16:33:53 INFO - Obtained file size: 14408853 16:33:53 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')]} 16:33:53 INFO - trying https://queue.taskcluster.net/v1/task/IwQgw9s6RNqyAVuzPGZaJw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:33:53 INFO - Downloading https://queue.taskcluster.net/v1/task/IwQgw9s6RNqyAVuzPGZaJw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 16:33:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IwQgw9s6RNqyAVuzPGZaJw/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 16:33:56 INFO - Downloaded 71106976 bytes. 16:33:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IwQgw9s6RNqyAVuzPGZaJw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:33:56 INFO - mkdir: /builds/slave/test/properties 16:33:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:33:56 INFO - Writing to file /builds/slave/test/properties/build_url 16:33:56 INFO - Contents: 16:33:56 INFO - build_url:https://queue.taskcluster.net/v1/task/IwQgw9s6RNqyAVuzPGZaJw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:33:56 INFO - Running post-action listener: _resource_record_post_action 16:33:56 INFO - Running post-action listener: set_extra_try_arguments 16:33:56 INFO - [mozharness: 2017-04-14 23:33:56.684494Z] Finished download-and-extract step (success) 16:33:56 INFO - [mozharness: 2017-04-14 23:33:56.684638Z] Running populate-webroot step. 16:33:56 INFO - Running pre-action listener: _resource_record_pre_action 16:33:56 INFO - Running main action method: populate_webroot 16:33:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:33:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:33:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:33:56 INFO - '--tppagecycles', 16:33:56 INFO - '7'], 16:33:56 INFO - 'tests': ['tsvgm']}}, 16:33:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:33:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:33:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:33:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:33:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:33:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:33:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:33:56 INFO - 'talos_options': ['--disable-e10s'], 16:33:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:33:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:33:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:33:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:33:56 INFO - 'talos_options': ['--disable-e10s'], 16:33:56 INFO - 'tests': ['damp', 'tps']}, 16:33:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:33:56 INFO - 'tests': ['damp', 'tps']}, 16:33:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:33:56 INFO - 'tests': ['dromaeo_dom']}, 16:33:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:33:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:33:56 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:33:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:33:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:33:56 INFO - 'tests': ['a11yr', 16:33:56 INFO - 'ts_paint', 16:33:56 INFO - 'tpaint', 16:33:56 INFO - 'sessionrestore', 16:33:56 INFO - 'sessionrestore_no_auto_restore', 16:33:56 INFO - 'tabpaint']}, 16:33:56 INFO - 'other-e10s': {'tests': ['a11yr', 16:33:56 INFO - 'ts_paint', 16:33:56 INFO - 'tpaint', 16:33:56 INFO - 'sessionrestore', 16:33:56 INFO - 'sessionrestore_no_auto_restore', 16:33:56 INFO - 'tabpaint']}, 16:33:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:33:56 INFO - 'ts_paint', 16:33:56 INFO - 'tpaint', 16:33:56 INFO - 'sessionrestore', 16:33:56 INFO - 'sessionrestore_no_auto_restore', 16:33:56 INFO - 'tabpaint']}, 16:33:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:33:56 INFO - 'ts_paint', 16:33:56 INFO - 'tpaint', 16:33:56 INFO - 'sessionrestore', 16:33:56 INFO - 'sessionrestore_no_auto_restore', 16:33:56 INFO - 'tabpaint']}, 16:33:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:33:56 INFO - 'tests': ['a11yr', 16:33:56 INFO - 'ts_paint', 16:33:56 INFO - 'tpaint', 16:33:56 INFO - 'sessionrestore', 16:33:56 INFO - 'sessionrestore_no_auto_restore', 16:33:56 INFO - 'tabpaint']}, 16:33:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:33:56 INFO - 'tests': ['a11yr', 16:33:56 INFO - 'ts_paint', 16:33:56 INFO - 'tpaint', 16:33:56 INFO - 'sessionrestore', 16:33:56 INFO - 'sessionrestore_no_auto_restore', 16:33:56 INFO - 'tabpaint']}, 16:33:56 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 16:33:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 16:33:56 INFO - 'bloom_basic_ref']}, 16:33:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:33:56 INFO - 'tests': ['tsvgx', 16:33:56 INFO - 'tsvgr_opacity', 16:33:56 INFO - 'tart', 16:33:56 INFO - 'tscrollx', 16:33:56 INFO - 'cart', 16:33:56 INFO - 'tsvg_static']}, 16:33:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:33:56 INFO - 'tsvgr_opacity', 16:33:56 INFO - 'tart', 16:33:56 INFO - 'tscrollx', 16:33:56 INFO - 'cart', 16:33:56 INFO - 'tsvg_static']}, 16:33:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:33:56 INFO - 'talos_options': ['--disable-e10s'], 16:33:56 INFO - 'tests': ['tp5o']}, 16:33:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:33:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:33:56 INFO - 'talos_options': ['--disable-e10s', 16:33:56 INFO - '--xperf_path', 16:33:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:33:56 INFO - 'tests': ['tp5n']}, 16:33:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:33:56 INFO - 'talos_options': ['--xperf_path', 16:33:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:33:56 INFO - 'tests': ['tp5n']}}, 16:33:56 INFO - 'talos.zip': {'path': '', 16:33:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:33:56 INFO - Running post-action listener: _resource_record_post_action 16:33:56 INFO - [mozharness: 2017-04-14 23:33:56.703533Z] Finished populate-webroot step (success) 16:33:56 INFO - [mozharness: 2017-04-14 23:33:56.703618Z] Running create-virtualenv step. 16:33:56 INFO - Running pre-action listener: _resource_record_pre_action 16:33:56 INFO - Running main action method: create_virtualenv 16:33:56 INFO - Creating virtualenv /builds/slave/test/build/venv 16:33:56 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 16:33:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:33:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:33:56 INFO - Using real prefix '/tools/python27' 16:33:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:33:57 INFO - Installing distribute.............................................................................................................................................................................................done. 16:34:00 INFO - Installing pip.................done. 16:34:00 INFO - Return code: 0 16:34:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:34:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:34:00 INFO - Reading from file tmpfile_stdout 16:34:00 INFO - Output received: 16:34:00 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) 16:34:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:34: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')]} 16:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34: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')]} 16:34:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:00 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 0x10ba4eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba51768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeca59ca30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b82cd30>, '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 0x10b752db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b821be8>, '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.uxfy5xJwoI/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.IPJpNAvYND/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 16:34:00 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 16:34:00 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 16:34:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uxfy5xJwoI/Render', 16:34:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:00 INFO - 'HOME': '/Users/cltbld', 16:34:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:00 INFO - 'LOGNAME': 'cltbld', 16:34:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:00 INFO - 'MOZ_NO_REMOTE': '1', 16:34:00 INFO - 'NO_EM_RESTART': '1', 16:34:00 INFO - 'PAGER': '/bin/cat', 16:34:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:00 INFO - 'PWD': '/builds/slave/test', 16:34:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:00 INFO - 'SHELL': '/bin/bash', 16:34:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IPJpNAvYND/Listeners', 16:34:00 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 16:34:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:00 INFO - 'USER': 'cltbld', 16:34:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:00 INFO - 'XPC_FLAGS': '0x0', 16:34:00 INFO - 'XPC_SERVICE_NAME': '0', 16:34:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:01 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 16:34:01 INFO - Cleaning up... 16:34:01 INFO - Return code: 0 16:34:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:34:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:01 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 0x10ba4eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba51768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeca59ca30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b82cd30>, '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 0x10b752db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b821be8>, '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.uxfy5xJwoI/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.IPJpNAvYND/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 16:34:01 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 16:34:01 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 16:34:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uxfy5xJwoI/Render', 16:34:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:01 INFO - 'HOME': '/Users/cltbld', 16:34:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:01 INFO - 'LOGNAME': 'cltbld', 16:34:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:01 INFO - 'MOZ_NO_REMOTE': '1', 16:34:01 INFO - 'NO_EM_RESTART': '1', 16:34:01 INFO - 'PAGER': '/bin/cat', 16:34:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:01 INFO - 'PWD': '/builds/slave/test', 16:34:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:01 INFO - 'SHELL': '/bin/bash', 16:34:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IPJpNAvYND/Listeners', 16:34:01 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 16:34:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:01 INFO - 'USER': 'cltbld', 16:34:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:01 INFO - 'XPC_FLAGS': '0x0', 16:34:01 INFO - 'XPC_SERVICE_NAME': '0', 16:34:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:01 INFO - Downloading/unpacking psutil>=3.1.1 16:34:01 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 16:34:01 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 16:34:01 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 16:34:01 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 16:34:01 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 16:34:01 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 16:34:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:34:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:34:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:34:04 INFO - Installing collected packages: psutil 16:34:04 INFO - Running setup.py install for psutil 16:34:04 INFO - building 'psutil._psutil_osx' extension 16:34:04 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 16:34:05 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 16:34:05 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 16:34:05 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 16:34:05 INFO - building 'psutil._psutil_posix' extension 16:34:05 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 16:34:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:34:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:34:05 INFO - ^ 16:34:05 INFO - 1 warning generated. 16:34:05 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 16:34:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:34:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:34:05 INFO - Successfully installed psutil 16:34:05 INFO - Cleaning up... 16:34:05 INFO - Return code: 0 16:34:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:34:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba4eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba51768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeca59ca30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b82cd30>, '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 0x10b752db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b821be8>, '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.uxfy5xJwoI/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.IPJpNAvYND/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 16:34:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:34:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:34:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uxfy5xJwoI/Render', 16:34:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:06 INFO - 'HOME': '/Users/cltbld', 16:34:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:06 INFO - 'LOGNAME': 'cltbld', 16:34:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:06 INFO - 'MOZ_NO_REMOTE': '1', 16:34:06 INFO - 'NO_EM_RESTART': '1', 16:34:06 INFO - 'PAGER': '/bin/cat', 16:34:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:06 INFO - 'PWD': '/builds/slave/test', 16:34:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:06 INFO - 'SHELL': '/bin/bash', 16:34:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IPJpNAvYND/Listeners', 16:34:06 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 16:34:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:06 INFO - 'USER': 'cltbld', 16:34:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:06 INFO - 'XPC_FLAGS': '0x0', 16:34:06 INFO - 'XPC_SERVICE_NAME': '0', 16:34:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:34:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:34:08 INFO - Installing collected packages: mozsystemmonitor 16:34:08 INFO - Running setup.py install for mozsystemmonitor 16:34:09 INFO - Successfully installed mozsystemmonitor 16:34:09 INFO - Cleaning up... 16:34:09 INFO - Return code: 0 16:34:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ba4eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba51768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeca59ca30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b82cd30>, '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 0x10b752db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b821be8>, '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.uxfy5xJwoI/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.IPJpNAvYND/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 16:34:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:34:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:34:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uxfy5xJwoI/Render', 16:34:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:09 INFO - 'HOME': '/Users/cltbld', 16:34:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:09 INFO - 'LOGNAME': 'cltbld', 16:34:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:09 INFO - 'MOZ_NO_REMOTE': '1', 16:34:09 INFO - 'NO_EM_RESTART': '1', 16:34:09 INFO - 'PAGER': '/bin/cat', 16:34:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:09 INFO - 'PWD': '/builds/slave/test', 16:34:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:09 INFO - 'SHELL': '/bin/bash', 16:34:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IPJpNAvYND/Listeners', 16:34:09 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 16:34:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:09 INFO - 'USER': 'cltbld', 16:34:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:09 INFO - 'XPC_FLAGS': '0x0', 16:34:09 INFO - 'XPC_SERVICE_NAME': '0', 16:34:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:10 INFO - Downloading/unpacking jsonschema==2.5.1 16:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:34:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:13 INFO - Downloading functools32-3.2.3-2.tar.gz 16:34:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:34:13 INFO - warning: no files found matching '*.txt' 16:34:13 INFO - no previously-included directories found matching 'build' 16:34:13 INFO - no previously-included directories found matching 'dist' 16:34:13 INFO - no previously-included directories found matching '.git*' 16:34:13 INFO - Installing collected packages: jsonschema, functools32 16:34:13 INFO - Running setup.py install for functools32 16:34:13 INFO - warning: no files found matching '*.txt' 16:34:13 INFO - no previously-included directories found matching 'build' 16:34:13 INFO - no previously-included directories found matching 'dist' 16:34:13 INFO - no previously-included directories found matching '.git*' 16:34:13 INFO - Successfully installed jsonschema functools32 16:34:13 INFO - Cleaning up... 16:34:14 INFO - Return code: 0 16:34:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:34:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ba4eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba51768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeca59ca30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b82cd30>, '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 0x10b752db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b821be8>, '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.uxfy5xJwoI/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.IPJpNAvYND/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 16:34:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:34:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:34:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uxfy5xJwoI/Render', 16:34:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:14 INFO - 'HOME': '/Users/cltbld', 16:34:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:14 INFO - 'LOGNAME': 'cltbld', 16:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:14 INFO - 'MOZ_NO_REMOTE': '1', 16:34:14 INFO - 'NO_EM_RESTART': '1', 16:34:14 INFO - 'PAGER': '/bin/cat', 16:34:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:14 INFO - 'PWD': '/builds/slave/test', 16:34:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:14 INFO - 'SHELL': '/bin/bash', 16:34:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IPJpNAvYND/Listeners', 16:34:14 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 16:34:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:14 INFO - 'USER': 'cltbld', 16:34:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:14 INFO - 'XPC_FLAGS': '0x0', 16:34:14 INFO - 'XPC_SERVICE_NAME': '0', 16:34:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:34:14 INFO - Cleaning up... 16:34:14 INFO - Return code: 0 16:34:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:34:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ba4eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba51768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeca59ca30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b82cd30>, '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 0x10b752db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b821be8>, '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.uxfy5xJwoI/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.IPJpNAvYND/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 16:34:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:34:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:34:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uxfy5xJwoI/Render', 16:34:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:14 INFO - 'HOME': '/Users/cltbld', 16:34:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:14 INFO - 'LOGNAME': 'cltbld', 16:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:14 INFO - 'MOZ_NO_REMOTE': '1', 16:34:14 INFO - 'NO_EM_RESTART': '1', 16:34:14 INFO - 'PAGER': '/bin/cat', 16:34:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:14 INFO - 'PWD': '/builds/slave/test', 16:34:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:14 INFO - 'SHELL': '/bin/bash', 16:34:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IPJpNAvYND/Listeners', 16:34:14 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 16:34:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:14 INFO - 'USER': 'cltbld', 16:34:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:14 INFO - 'XPC_FLAGS': '0x0', 16:34:14 INFO - 'XPC_SERVICE_NAME': '0', 16:34:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:14 INFO - Downloading/unpacking blobuploader==1.2.4 16:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:17 INFO - Downloading blobuploader-1.2.4.tar.gz 16:34:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:34:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:34:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:18 INFO - Downloading docopt-0.6.1.tar.gz 16:34:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:34:18 INFO - Installing collected packages: blobuploader, requests, docopt 16:34:18 INFO - Running setup.py install for blobuploader 16:34:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:34:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:34:18 INFO - Running setup.py install for requests 16:34:19 INFO - Running setup.py install for docopt 16:34:19 INFO - Successfully installed blobuploader requests docopt 16:34:19 INFO - Cleaning up... 16:34:19 INFO - Return code: 0 16:34:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:34:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:19 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 0x10ba4eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba51768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeca59ca30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b82cd30>, '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 0x10b752db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b821be8>, '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.uxfy5xJwoI/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.IPJpNAvYND/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 16:34:19 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 16:34:19 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 16:34:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uxfy5xJwoI/Render', 16:34:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:19 INFO - 'HOME': '/Users/cltbld', 16:34:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:19 INFO - 'LOGNAME': 'cltbld', 16:34:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:19 INFO - 'MOZ_NO_REMOTE': '1', 16:34:19 INFO - 'NO_EM_RESTART': '1', 16:34:19 INFO - 'PAGER': '/bin/cat', 16:34:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:19 INFO - 'PWD': '/builds/slave/test', 16:34:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:19 INFO - 'SHELL': '/bin/bash', 16:34:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IPJpNAvYND/Listeners', 16:34:19 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 16:34:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:19 INFO - 'USER': 'cltbld', 16:34:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:19 INFO - 'XPC_FLAGS': '0x0', 16:34:19 INFO - 'XPC_SERVICE_NAME': '0', 16:34:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:34:19 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-cE_HAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:34:19 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-xJlWbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:34:19 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-z1LUqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:34:19 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-BFUuoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:34:20 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-3pZRAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:34:20 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-ZjCH4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:34:20 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-jPNyfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:34:20 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-xIKQGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:34:20 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-aXWWZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:34:20 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-92MGUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:34:20 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-nO4wp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:34:20 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-cgGjMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:34:20 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-OIxEIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:34:20 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-PxJOb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:34:21 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-WvVhwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:34:21 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-9dNgLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:34:21 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-Qq4ZHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:34:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:34:21 INFO - Running setup.py install for manifestparser 16:34:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:34:21 INFO - Running setup.py install for mozcrash 16:34:21 INFO - Running setup.py install for mozdebug 16:34:21 INFO - Running setup.py install for mozdevice 16:34:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:34:21 INFO - Running setup.py install for mozfile 16:34:22 INFO - Running setup.py install for mozhttpd 16:34:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:34:22 INFO - Running setup.py install for mozinfo 16:34:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:34:22 INFO - Running setup.py install for mozInstall 16:34:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:34:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:34:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:34:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:34:22 INFO - Running setup.py install for mozleak 16:34:22 INFO - Running setup.py install for mozlog 16:34:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:34:22 INFO - Running setup.py install for moznetwork 16:34:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:34:22 INFO - Running setup.py install for mozprocess 16:34:23 INFO - Running setup.py install for mozprofile 16:34:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:34:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:34:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:34:23 INFO - Running setup.py install for mozrunner 16:34:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:34:23 INFO - Running setup.py install for mozscreenshot 16:34:23 INFO - Running setup.py install for moztest 16:34:23 INFO - Running setup.py install for mozversion 16:34:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:34:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:34:23 INFO - Cleaning up... 16:34:23 INFO - Return code: 0 16:34:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:34:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:23 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 0x10ba4eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba51768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeca59ca30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b82cd30>, '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 0x10b752db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b821be8>, '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.uxfy5xJwoI/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.IPJpNAvYND/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 16:34:23 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 16:34:23 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 16:34:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uxfy5xJwoI/Render', 16:34:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:23 INFO - 'HOME': '/Users/cltbld', 16:34:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:23 INFO - 'LOGNAME': 'cltbld', 16:34:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:23 INFO - 'MOZ_NO_REMOTE': '1', 16:34:23 INFO - 'NO_EM_RESTART': '1', 16:34:23 INFO - 'PAGER': '/bin/cat', 16:34:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:23 INFO - 'PWD': '/builds/slave/test', 16:34:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:23 INFO - 'SHELL': '/bin/bash', 16:34:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IPJpNAvYND/Listeners', 16:34:23 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 16:34:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:23 INFO - 'USER': 'cltbld', 16:34:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:23 INFO - 'XPC_FLAGS': '0x0', 16:34:23 INFO - 'XPC_SERVICE_NAME': '0', 16:34:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:34:24 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-h7Tl6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:34:24 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)) 16:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:34:24 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-n9Wgxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:34:24 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)) 16:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:34:24 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-olzTsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:34:24 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)) 16:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:34:24 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-nbRAu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:34:24 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)) 16:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:34:24 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-x4hCNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:34:24 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)) 16:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:34:24 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-XxLDMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:34:24 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)) 16:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:34:24 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-z22qfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:34:24 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)) 16:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:34:24 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-urBUx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:34:25 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)) 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:34:25 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-u4xJpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:34:25 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)) 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:34:25 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-zfPBm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:34:25 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)) 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:34:25 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-v_xvxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:34:25 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)) 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:34:25 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-0FkNXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:34:25 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)) 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:34:25 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-hTSvKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:34:25 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)) 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:34:25 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-IjWD2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:34:25 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)) 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:34:25 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-xi2P9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:34:25 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)) 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:34:25 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-9LH0IQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:34:25 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)) 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:34:25 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-51MzfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:34:25 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)) 16:34:25 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)) 16:34:25 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)) 16:34:25 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)) 16:34:25 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)) 16:34:25 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)) 16:34:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:28 INFO - Downloading blessings-1.6.tar.gz 16:34:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:34:28 INFO - Installing collected packages: blessings 16:34:28 INFO - Running setup.py install for blessings 16:34:28 INFO - Successfully installed blessings 16:34:28 INFO - Cleaning up... 16:34:28 INFO - Return code: 0 16:34:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:34:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:34:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:34:29 INFO - Reading from file tmpfile_stdout 16:34:29 INFO - Current package versions: 16:34:29 INFO - blessings == 1.6 16:34:29 INFO - blobuploader == 1.2.4 16:34:29 INFO - docopt == 0.6.1 16:34:29 INFO - functools32 == 3.2.3-2 16:34:29 INFO - jsonschema == 2.5.1 16:34:29 INFO - manifestparser == 1.1 16:34:29 INFO - mozInstall == 1.12 16:34:29 INFO - mozcrash == 1.0 16:34:29 INFO - mozdebug == 0.1 16:34:29 INFO - mozdevice == 0.50 16:34:29 INFO - mozfile == 1.2 16:34:29 INFO - mozhttpd == 0.7 16:34:29 INFO - mozinfo == 0.9 16:34:29 INFO - mozleak == 0.1 16:34:29 INFO - mozlog == 3.4 16:34:29 INFO - moznetwork == 0.27 16:34:29 INFO - mozprocess == 0.25 16:34:29 INFO - mozprofile == 0.28 16:34:29 INFO - mozrunner == 6.13 16:34:29 INFO - mozscreenshot == 0.1 16:34:29 INFO - mozsystemmonitor == 0.3 16:34:29 INFO - moztest == 0.8 16:34:29 INFO - mozversion == 1.4 16:34:29 INFO - psutil == 3.1.1 16:34:29 INFO - requests == 1.2.3 16:34:29 INFO - wsgiref == 0.1.2 16:34:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:34:29 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')]} 16:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:29 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')]} 16:34:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:29 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 0x10ba4eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba51768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeca59ca30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b82cd30>, '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 0x10b752db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b821be8>, '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.uxfy5xJwoI/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.IPJpNAvYND/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 16:34:29 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 16:34:29 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 16:34:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uxfy5xJwoI/Render', 16:34:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:29 INFO - 'HOME': '/Users/cltbld', 16:34:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:29 INFO - 'LOGNAME': 'cltbld', 16:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:29 INFO - 'MOZ_NO_REMOTE': '1', 16:34:29 INFO - 'NO_EM_RESTART': '1', 16:34:29 INFO - 'PAGER': '/bin/cat', 16:34:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:29 INFO - 'PWD': '/builds/slave/test', 16:34:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:29 INFO - 'SHELL': '/bin/bash', 16:34:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IPJpNAvYND/Listeners', 16:34:29 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 16:34:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:29 INFO - 'USER': 'cltbld', 16:34:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:29 INFO - 'XPC_FLAGS': '0x0', 16:34:29 INFO - 'XPC_SERVICE_NAME': '0', 16:34:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:29 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)) 16:34:29 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)) 16:34:29 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)) 16:34:29 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)) 16:34:29 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)) 16:34:29 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)) 16:34:29 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)) 16:34:29 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)) 16:34:29 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)) 16:34:29 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)) 16:34:29 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)) 16:34:29 INFO - Cleaning up... 16:34:29 INFO - Return code: 0 16:34:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:34:29 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')]} 16:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:29 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')]} 16:34:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:29 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 0x10ba4eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba51768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeca59ca30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b82cd30>, '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 0x10b752db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b821be8>, '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.uxfy5xJwoI/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.IPJpNAvYND/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 16:34:29 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 16:34:29 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 16:34:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uxfy5xJwoI/Render', 16:34:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:29 INFO - 'HOME': '/Users/cltbld', 16:34:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:29 INFO - 'LOGNAME': 'cltbld', 16:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:29 INFO - 'MOZ_NO_REMOTE': '1', 16:34:29 INFO - 'NO_EM_RESTART': '1', 16:34:29 INFO - 'PAGER': '/bin/cat', 16:34:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:29 INFO - 'PWD': '/builds/slave/test', 16:34:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:29 INFO - 'SHELL': '/bin/bash', 16:34:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IPJpNAvYND/Listeners', 16:34:29 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 16:34:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:29 INFO - 'USER': 'cltbld', 16:34:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:29 INFO - 'XPC_FLAGS': '0x0', 16:34:29 INFO - 'XPC_SERVICE_NAME': '0', 16:34:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:34:29 INFO - Cleaning up... 16:34:29 INFO - Return code: 0 16:34:29 INFO - Running post-action listener: _resource_record_post_action 16:34:29 INFO - Running post-action listener: _start_resource_monitoring 16:34:29 INFO - Starting resource monitoring. 16:34:29 INFO - [mozharness: 2017-04-14 23:34:29.765656Z] Finished create-virtualenv step (success) 16:34:29 INFO - [mozharness: 2017-04-14 23:34:29.766560Z] Running install step. 16:34:29 INFO - Running pre-action listener: _resource_record_pre_action 16:34:29 INFO - Running main action method: install 16:34:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:34:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:34:30 INFO - Reading from file tmpfile_stdout 16:34:30 INFO - Detecting whether we're running mozinstall >=1.0... 16:34:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:34:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:34:30 INFO - Reading from file tmpfile_stdout 16:34:30 INFO - Output received: 16:34:30 INFO - Usage: mozinstall [options] installer 16:34:30 INFO - Options: 16:34:30 INFO - -h, --help show this help message and exit 16:34:30 INFO - -d DEST, --destination=DEST 16:34:30 INFO - Directory to install application into. [default: 16:34:30 INFO - "/builds/slave/test"] 16:34:30 INFO - --app=APP Application being installed. [default: firefox] 16:34:30 INFO - mkdir: /builds/slave/test/build/application 16:34:30 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'] 16:34:30 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 16:34:49 INFO - Reading from file tmpfile_stdout 16:34:49 INFO - Output received: 16:34:49 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:34:49 INFO - Running post-action listener: _resource_record_post_action 16:34:49 INFO - [mozharness: 2017-04-14 23:34:49.699407Z] Finished install step (success) 16:34:49 INFO - [mozharness: 2017-04-14 23:34:49.699581Z] Running run-tests step. 16:34:49 INFO - Running pre-action listener: _resource_record_pre_action 16:34:49 INFO - Running main action method: run_tests 16:34:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:34:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:34:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:34:49 INFO - 2017-04-14 16:34:49.714 screenresolution[1627:7549] starting screenresolution argv=screenresolution get 16:34:49 INFO - 2017-04-14 16:34:49.716 screenresolution[1627:7549] Display 0: 1600x1200x32@60 16:34:49 INFO - 2017-04-14 16:34:49.722 screenresolution[1628:7552] starting screenresolution argv=screenresolution list 16:34:49 INFO - Available Modes on Display 0 16:34:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:34:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:34:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:34:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:34:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:34:49 INFO - Intel Iris: 16:34:49 INFO - Chipset Model: Intel Iris 16:34:49 INFO - Type: GPU 16:34:49 INFO - Bus: Built-In 16:34:49 INFO - VRAM (Dynamic, Max): 1536 MB 16:34:49 INFO - Vendor: Intel (0x8086) 16:34:49 INFO - Device ID: 0x0a2e 16:34:49 INFO - Revision ID: 0x0009 16:34:49 INFO - Displays: 16:34:49 INFO - Display: 16:34:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:34:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:34:49 INFO - Display Serial Number: 1600x1200 60 16:34:49 INFO - Main Display: Yes 16:34:49 INFO - Mirror: Off 16:34:49 INFO - Online: Yes 16:34:49 INFO - Rotation: Supported 16:34:49 INFO - Return code: 0 16:34:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:34:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:34:49 INFO - Python 2.7.3 16:34:49 INFO - Return code: 0 16:34:49 INFO - grabbing minidump binary from tooltool 16:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:49 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 0x10b82cd30>, '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 0x10b752db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b821be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:34:49 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 16:34:49 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 16:34:49 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 16:34:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:34:50 INFO - Return code: 0 16:34:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:34:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:34:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:34:50 INFO - ENV: RUST_BACKTRACE is now 1 16:34:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:34:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:34:50 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/IwQgw9s6RNqyAVuzPGZaJw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0344', '--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 16:34:50 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/IwQgw9s6RNqyAVuzPGZaJw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0344 --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 16:34:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uxfy5xJwoI/Render', 16:34:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:50 INFO - 'HOME': '/Users/cltbld', 16:34:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:50 INFO - 'LOGNAME': 'cltbld', 16:34:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:34:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:50 INFO - 'MOZ_NO_REMOTE': '1', 16:34:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:34:50 INFO - 'NO_EM_RESTART': '1', 16:34:50 INFO - 'PAGER': '/bin/cat', 16:34:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:50 INFO - 'PWD': '/builds/slave/test', 16:34:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:34:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:50 INFO - 'RUST_BACKTRACE': '1', 16:34:50 INFO - 'SHELL': '/bin/bash', 16:34:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IPJpNAvYND/Listeners', 16:34:50 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 16:34:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:50 INFO - 'USER': 'cltbld', 16:34:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:50 INFO - 'XPC_FLAGS': '0x0', 16:34:50 INFO - 'XPC_SERVICE_NAME': '0', 16:34:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:50 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/IwQgw9s6RNqyAVuzPGZaJw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0344', '--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 16:34:50 INFO - mozversion application_buildid: 20170414145706 16:34:50 INFO - mozversion application_changeset: 9379831bb9c3d9abfea7dbf8dd06dbdab1d81dc4 16:34:50 INFO - mozversion application_display_name: Nightly 16:34:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:34:50 INFO - mozversion application_name: Firefox 16:34:50 INFO - mozversion application_remotingname: firefox 16:34:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:34:50 INFO - mozversion application_vendor: Mozilla 16:34:50 INFO - mozversion application_version: 55.0a1 16:34:50 INFO - mozversion platform_buildid: 20170414145706 16:34:50 INFO - mozversion platform_changeset: 9379831bb9c3d9abfea7dbf8dd06dbdab1d81dc4 16:34:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:34:50 INFO - mozversion platform_version: 55.0a1 16:34:50 INFO - using testdate: 1492212890 16:34:50 INFO - actual date: 1492212890 16:34:50 INFO - starting webserver on 'localhost:49241' 16:34:50 INFO - SUITE-START | Running 2 tests 16:34:50 INFO - TEST-START | dromaeo_css 16:34:50 INFO - operating with platform_type : mac_ 16:34:50 INFO - Initialising browser for dromaeo_css test... 16:34:50 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmp5IrmLc/profile http://localhost:49241/getInfo.html) 16:34:53 INFO - PID 1638 | __metrics Screen width/height:1600/1200 16:34:53 INFO - PID 1638 | colorDepth:24 16:34:53 INFO - PID 1638 | Browser inner width/height: 1024/689 16:34:53 INFO - PID 1638 | __metrics 16:34:53 INFO - PID 1638 | 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" 16:34:53 INFO - PID 1638 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:34:54 INFO - TEST-INFO | 1638: exit 0 16:34:54 INFO - Browser initialized. 16:34:54 INFO - Running cycle 1/1 for dromaeo_css test... 16:34:54 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmp5IrmLc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:35:06 INFO - PID 1640 | RSS: Main: 243048448 16:35:06 INFO - PID 1640 | 16:38:11 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 16:38:13 INFO - PID 1640 | RSS: Main: 411443200 16:38:13 INFO - PID 1640 | 16:39:55 INFO - PID 1640 | ************************* 16:39:55 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 16:39:55 INFO - PID 1640 | 16:39:55 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:39:55 INFO - PID 1640 | Full stack: 16:39:55 INFO - PID 1640 | ************************* 16:39:55 INFO - PID 1640 | ************************* 16:39:55 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 16:39:55 INFO - PID 1640 | 16:39:55 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:39:55 INFO - PID 1640 | Full stack: 16:39:55 INFO - PID 1640 | ************************* 16:39:55 INFO - PID 1640 | ************************* 16:39:55 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 16:39:55 INFO - PID 1640 | 16:39:55 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:39:55 INFO - PID 1640 | Full stack: 16:39:55 INFO - PID 1640 | ************************* 16:39:55 INFO - PID 1640 | ************************* 16:39:55 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 16:39:55 INFO - PID 1640 | 16:39:55 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:39:55 INFO - PID 1640 | Full stack: 16:39:55 INFO - PID 1640 | ************************* 16:41:15 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 16:41:16 INFO - PID 1640 | RSS: Main: 368484352 16:41:16 INFO - PID 1640 | 16:44:18 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 16:44:19 INFO - PID 1640 | RSS: Main: 333459456 16:44:19 INFO - PID 1640 | 16:47:21 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 16:47:22 INFO - PID 1640 | RSS: Main: 355045376 16:47:22 INFO - PID 1640 | 16:50:25 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 16:50:26 INFO - PID 1640 | RSS: Main: 342757376 16:50:26 INFO - PID 1640 | 16:53:28 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 16:53:29 INFO - PID 1640 | RSS: Main: 379240448 16:53:29 INFO - PID 1640 | 16:53:29 INFO - PID 1640 | __start_tp_report 16:53:29 INFO - PID 1640 | _x_x_mozilla_page_load 16:53:29 INFO - PID 1640 | _x_x_mozilla_page_load_details 16:53:29 INFO - PID 1640 | |i|pagename|runs| 16:53:29 INFO - PID 1640 | |0;dojo.html;2850.55816348466;3263.918402039949;3491.231928975626;3525.5240542526753;3567.821608919555;5912.320083190434;6074.028155495122;6167.629942203465;6188.102725104857;6189.659568723719;5956.553258505619;6052.576319657625;6053.152558641794;6057.42454466825;6059.0608455689435;5259.31628888244;5275.868103297429;5299.947000530004;5312.73436328184;5387.919181212285;4426.468823741156;5368.463153684639;5390.595705322097;5396.78412863485;5396.892062158754;5368.62419630626;5371.919421208666;5374.865628359303;5375.81184658537;5385.138377859544;5349.277847490578;5351.625386222966;5356.223347614574;5361.276227709248;5383.703896285722;5199.688018718851;5313.681179129265;5314.441983591706;5315.335583052119;5319.255304257407;6181.814545563595;6206.162168107293;6228.065790131472;6240.5319601030105;6243.094751261042;6300.873982520324;6449;6470.450011749007;6470.547061705683;6516.152900122954;5268.710220937847;6398.4561312288515;6510.967445162792;6568.770093046721;6582.3746744059235;6251.3123556408755;6252.218472690914;6263.906041409383;6271.78048768291;6276.058591211309;6742.056112144303;6748;6766.594004359754;6769.356911093439;6769.695363708645;6287.96856015717;6351.936480635134;6352.110704501373;6370.267419246846;6408.359164083555;6474.741010359533;6520.445762110179;6544.640044797487;6545.541812073205;6566.67166641666;6432.067350234283;6444.6133232005295;6471.870562588721;6480.092787009728;6480.935190648128;6347.428731414103;6380.202474690664;6495.837604059936;6500.252470965805;6502.317256687979;4978.228374601942;5243.292155559027;5280.894382112337;5297.947020529746;5299.39057008449;3955.5451123120633;4693.741844198602;4699.506551812011;4711.199096153662;4747.715137091716;6208.937910620926;6228.750849965951;6268.49852011838;6270.498360131179;6273.560850740404;6301.338359472281;6379.489640828722;6473.902891456632;6563.409293163638;6576.309487503839;6191.504679625619;6245.656488893154;6248.812535623939;6254.34329395416;6261.24865016201;5746.913796293059;5775.566832487496;5776.855578610568;5785.595008349459;5802.274715660543;6487.3188315226225;6586;6672.165979252593;6734.292899245705;6757.391834734897;5499.642523235977;6548.541602087998;6555;6607.240167380813;6613.074169616354;6704;6761.560498567577;6775.525713200029;6780.864382712417;6782.050512928293;5867.295924489089;6315.684215789284;6394.840128996812;6502.804915852532;6504.804855854332;5605.495505404533;6384.712687928962;6573.014047892663;6584.078229048033;6599.868002640016;6232.158658581034;6385.10608514799;6389.361063893573;6398.104265402754;6408.647524386203;5526.613137080366;6278;6306.990881458944;6376.93623063782;6387.297397286387;6292.622442653455;6331.5251356147555;6331.620102793847;6334.936650633619;6339.873202536016;5296.470352964827;6226.346233645583;6304.306526282014;6332.651704156316;6390.90413643805;6271.592346497463;6293.685315734287;6310.558260921875;6311.116443697794;6321.462675672436 16:53:29 INFO - PID 1640 | |1;ext.html;753.5252790741832;791.9089304729956;813.2355585749395;1119.5465836336286;1149.7240662241065;27561.173164805063;27939.441211175763;27990;28007;28017.019404320854;28008.299792505197;37326.88019359417;38041.429378559274;38069.809650951705;38088;8442.57787110645;8600.483970961732;8606.139386061375;8613.35399845011;8614.353923455734;8476.533790641512;8625.654973801073;8629.870551941694;8636.611352489123;8660.523671198082;6124.1732366130445;6240.968795156018;6277;6282.811515654537;6292.056191571255;8377.539235342054;8609.741707748746;8611;8616.956915215447;8618.310535157236;8390.496570205807;8452.915470845275;8462;8482.53346065966;8492.78768030798;25647.845846936933;26148;36658.63341366579;37063;37165.25669486595;3574.070741607201;3646.4712616670436;3648.4892115103908;3652.7990960497164;3656.1590834108038;30652;30799.538006929914;30861.691383086105;30881.073567793002;30908;2704.837709737422;3174.4444722173525;3174.6507884132725;3177.9046628601177;3193.3613277344625;305353;310806;311263;311451.99999999773;311462;49729;49897.75051124721;49945.500544994815;50061.99876002532;50069.74825629388;50384;50413;50431.487055388396;50465;50501.49498505041;14178.716425671635;14317.212553309668;14332.925030622746;14338.139711617336;14357.497487587885;11742.94128529369;11748.647540573797;11754.177207595558;11765.882341176479;11794.823077653842;12093.213941093802;12263.816042759367;12285.420061787125;12325.322107284006;12381.319027453397;4072.205919845602;4772.475027746945;4863.975680121577;5420.864478388072;5556.499915007668;1018.7911478146962;1028.275066078413;1035.29082578434;1037.678319720889;1048.9527971241312;22087.582483503364;22203.777962220494;22436.326910192394;24117;24477.38806529851;956.7273327101742;992.4888682328607;993.5082134343402;1157.9652610421701;1162.2329262686587;12340.444679989421;12360.814587781011;12418.503259869503;12424.75150496985;12431.689207769878;301701;302517;302636;302953;303594;52281;52499;52509.949801003764;52573;52606.473935260925;1488.3302513868803;1497.8427265137439;1540.9383624655113;1556.5408204579676;1575.495841330786;19617.31339403114;23413.76586234184;23764.524709505367;23802.880985594962;23816.880915596004;38164.618353816106;38202.61797382102;38216;38218.23563528658;38221.42667859929;286334;286510;286606;286711.3986580406;286862;34479;34521.48217776786;34532.30935381228;34551.65448345484;34604;41803.79098104611;42731.57268427276;44521.88695282644;44561.88595285144;44780.77609611931;24626.87686561556;27323.72676273212;29259.41481170322;29529;30186.54720179243;25100.372490687878;25374.873125634254;27622.20455670375;30157.849210753804;30315.696843031288;35387.82306088453;35453.82273088618;35482.29035419329;36109.63890361063;36133.81933090318;21244.787552124282;29501.557476638296;29855.701442985293;30491;30838;22245.110195591995;23167.53664926726;23246.883765581064;23437.882810585837;23598.410039749142 16:53:29 INFO - PID 1640 | |2;jquery.html;430.21056361576507;435.6819521749125;443.5254277922623;444.69093979684123;457.7047804166311;19404.932728699914;20581.897090514543;21242.150313987462;21419.678704819442;21444;21615.567688646257;21697.457563560918;22015.669764953538;22303.55392892141;22662.886685566547;5990.430909063632;6259.123722678829;6262.0919966604815;6268.811935641916;6274.247090349165;5808.941910580904;6155.26136863577;6221.7822376216845;6228.470580000705;6238.750449981995;5595.244641973322;5611.551075913917;6164.167837341969;6209.192804935375;6213.409726076015;5965.671888046156;6110.052941794029;6117.632942023492;6130.2030736004035;6136.294326152482;5192.428832828386;5302.125149350352;5387.919181212285;5396.91904621431;5414.133738601805;26980.460390792075;27135.1859444217;27963.440731185263;28998;29195.854020729974;2169.6528555431214;2251.1783199132365;2251.977480225193;2252.358077947777;2254.966175507352;17836.643267134714;17940.282388704436;18342.90828545862;18434.170462329228;18580.070996450122;2138.9144434222767;2139.326112274644;2193.813525850305;2195.2536137713096;2206.900689468978;132408;162035;162204;163590;166857.99999999878;11740.706482337839;12323.50705971751;12361.814572781415;12365.443555040045;12368.505259789688;13664;16585.91707041457;16588.170591470378;16590.917045414695;16613.335466581444;8809.69166079197;9007.324450666227;9022.097790221056;9086.045965173695;9157.679481218125;8567.74296771098;8575.442596231225;8609.397342186112;8773.649054037767;8785.385023048453;7485.139208991036;7624.504407213513;7624.58064806441;7633.732819351296;7660.348870345972;1745.3978377459755;2076.7092607034724;2080.9271675491286;2086.7182930304216;2270.23946977761;840.9159084091664;918.8483900156533;975.9707208783748;987.827130252203;1002.734275417015;20392.286269980777;21313.934303285085;22937.770622293898;27196;27212.31969200786;956.660385563129;998.6169155719381;1005.5726316315537;1037.3412882819464;1043.5982146873357;7605.6577454014705;10645.893541064645;10666.839997400046;10691.893081069245;10736.194785391126;585015.1987840963;585077;590174;591460;600803;139419.30290348484;139733;140467;141839;143252;1172.865120511135;1200.9759804803855;1236.9053387751903;1239.2936026465009;1242.1553343726173;18311.35910243135;21814.89092554527;22072.779272207714;22178.33464995988;22213.66679499841;59825.40174598198;60703.392966069776;60709.69645151746;60720.96395180135;60824;83344.58327708322;83739.5813020931;85314;86046.56976715077;86786.58560972723;8609.741707748777;8793.208611224765;8895.644174232959;8924.330675199515;9159.038300978302;14170.433182672577;14357.707806297483;14363.856361436252;14439.422423103379;14594.635134121307;11553.653390398302;11678.6496405108;11998.820017699916;12019.699507512032;12090.75818483643;9382.014888436615;9505.524723763923;10260.640877569249;10925.016748492673;10928;9539.427634341962;11956.923876851126;11999.76000479968;12068.577599784317;12085.577004804789;8840.469571825712;8846.867296990422;8849.867251991096;8974.955125224593;9336.719898403058;9780.559874805793;10238.795224095327;12088.274703517816;12244.938775306067;12275.570355037531 16:53:29 INFO - PID 1640 | |3;mootools.html;1159.4492616007396;1172.466527729883;1413.491143188452;1430.2419717549703;1436.9712605747886;9894.455804930725;10367.222458315628;11732.00277976372;12046.457909394076;12143.149979501439;11711.707207319821;11821.763564728722;11824.822627660593;11837.230580012314;11858.932696057353;2492.2274095030552;2534.1510593950957;2537.5051864886354;2538;2541.4917016596664;2136.241634219853;2231.6764069209953;2458.8770561471943;2568.7174410814796;2570.575854983925;2506.1103308325555;2507.1976967370447;2539.1874600127967;2541.9237422877345;2546.3379521324496;2171.695962565242;2513.321403221129;2523.659305993686;2523.823332366735;2525.356034211264;2447.559439300925;2448.3879030242438;2480.218731099698;2480.9255722328357;2483.70195576532;11716.121290903131;11844.46699898498;11851.992580630571;11854.822177667342;11908.88091119095;6482.578632388927;6734.8316292092595;6751.189857217117;6753.3246675332075;6762.560433571802;4007;4163.125743593849;4365.301551751704;4386.8903277418;4392.407025051641;1260.2249616485888;1267.0813660096449;1290.1742884553894;1305.575687901436;1314.4413624209672;16882.15589220534;16886.83113168865;16888;16899.901506402046;16907.239174237187;5771.826845194651;5921.644701317935;5952.404759524013;6043.425874541911;6064.4541991221;14118.294085295694;14127.71744565103;14153;14157.292135393394;14171.66965763045;6811.489138314646;6844.5208835381045;6847.486438517131;6920.273371296042;6939.6877140528795;5213.45258747826;5775.393583673654;5995.400459953969;6231.376862313823;6240.937590624036;4165.875023749292;4283.485981682218;4284.357346398003;4285.357196420499;4289.120730250291;1330.60081975407;1351.9391627376792;1422.1538184780245;1474.9115053096848;1484.7995520604795;797.7726347990795;802.3701394405364;825.2201669422338;825.6697321071499;848.2747251100344;5743.942560574341;6529.804105876831;6776.457883369319;6990.4757143214465;7018.684159212848;939.4311499795358;943.4527973775193;945.4988855906381;945.6926498887889;946.5503885654259;3913.9217215655526;3920.8039598019986;3962.3660214365564;3974.7813870236837;3978.562358140602;14880.404783808526;14890.329935152944;15373.538793836204;15378.000429972017;15407.537773866801;14963;15198.164100974553;15271.61820954485;15372.231388430533;15398.846011539965;8419.158084191531;8491.915080849236;8564.186402291773;8617.784555386292;8618.05201427855;6337.96831015842;6621.50338724588;6656.334366563498;6685.799426017227;6705.899411508929;12323.075769317158;13568.525101621395;13653.453861845812;13694.863051369757;14001.43994240219;11519;13400.664983375493;13610.59168224955;13853.238071906142;13946.023778335419;7575.431842611716;9512.667056652985;9519.90480095218;9568.186704130227;9682.75793105178;10593.2584719072;10695.839562406414;10700.143988480748;10701.518431670438;10745.462726863781;8978.371513993958;9202.355835091746;9240.122188392092;9309.953450232706;9412.435253884789;8998.59506322204;9033.096690330914;9053.502057386908;9135.2235060018;9162.862557061517;8169.754907352789;8198.918010819816;8284.295834854105;8289.295409890226;8302.501849889026;5967.910481342697;5969.611975221596;6116.969415152896;6120.7551697931585;6204.255489341308;6109.297430795337;6176.66028368444;6229.345918678474;6273.811785646438;6315.652639104894 16:53:29 INFO - PID 1640 | |4;prototype.html;383.8541354285371;390.86515152272466;405.49313358302123;407.89190864420914;409.1693861461235;5166.4316925138255;5668.858278543038;5867.735951882165;5983.371745966676;6065.178937269525;4788.736619485927;5471.699056551888;5713.371529131792;5745.6265342752795;5796.797112101077;3881.9029524261837;4385.298352263639;4492.39352687388;4500.369948207253;4501.482329532105;3627.927441451169;3697.7226707996874;4096.467459230296;4326.891827704301;4550.294704320836;4293.184294983958;4304.332828411586;4312.0380226996795;4314.072474418;4334.414853994702;4144.280123748641;4180.331147016463;4231.428757117796;4273.92714533451;4277.700560960734;3085.41377138343;3746.8875933722034;3754.8310326035394;3755.924881502382;3757.830897609587;4917.7786999585105;5449.700266485342;5690.687012214326;5706.3152421709665;5718.370979192286;4837.419509658864;5011.020646844512;5056.129232184078;5111.2333150027425;5147.922781158286;6180.443760061571;6198.6280823150755;6201.5348848836065;6217.409346112112;6221.564490485668;4209.431726716884;4223.155368926227;4230.132822771325;4234.703570750049;4258.446401967724;5417.404085550586;6292.465140463066;6630.436412904909;6646.83382915431;6665.533412661067;4279.893002674958;4297.806598703066;4301;4308.504521980012;4324.610785029363;3643.599204087548;4370.191514569815;4379.211741886427;4379.934300985487;4387.802548885308;4351.43431353922;4879;5030.245463180479;5045.41977672565;5080.644354895196;5971.462568368781;6116.113163591343;6281.842953926189;6312.715927783261;6344.333844946306;1364.740699267136;1409.8449170591227;1411.4918629293445;1422.1680317014454;1436.1813766153193;839.7396806989852;921.0697195832124;995.3878364805737;997.8674204777485;1005.2410430125354;4296.004328767955;4930.260460930889;5705.74324155414;5960.85097872548;6005.039193728982;4883.951160488421;6449.871002579922;6480.189976252968;6502.284748677642;6580.736770529221;5326.721586819135;5501.889962200814;5938.545056461195;5942.851428714317;5965.373635768268;2815.662560283849;3200.6713018461005;3271.8896311878707;3391.253924136686;3412.6075501317664;5718;6618.974059020859;6732.697028633724;6751.797446076625;6796.592204467748;5297.443768404339;6319.9368006320265;6721.966390168018;6723.58804651019;6724.66376681164;6716.227633822173;6724.529282950244;6740.764073257413;6752.122224110933;6752.8649427010205;5529.921665275233;6528.151340325917;6528.510361722985;6561.048647946117;6574.145361103026;5049.57078648319;6186.226721659793;6260.436560709558;6293.874122517615;6480.092787009917;6734.831629209309;6759.5606285591275;6759.898601521079;6775.796726098225;6799.898001529882;4126.030382859965;4225.661947044167;4264.637505812041;4281.721688090264;4296.591823776736;5639.379668236573;6510.707018184098;6510.804675859732;6513.609183449008;6515.641639709862;5183.585313175013;6035.547333949883;6279.717412716347;6291.685415729104;6305.477808876302;5451.4276001019325;5838.095095260242;6015.428534289235;6175.610487640245;6268.341824108403;5364.409914909279;6157.538184636081;6183.227096612924;6192.845178870564;6303.338149494421;6173.475254603409;6302.873942521032;6328.683565821599;6330.651814150266;6340.873182536416;5652.180433837153;5875.177475153397;6124.663143527148;6161.44546990773;6192.721327540181 16:53:29 INFO - PID 1640 | |5;yui.html;719.8488317453334;800.2437696376924;871.7123349294737;875.9707343870954;885.5926273914001;13618.999999999987;18045.368412105578;18308.26766929321;18800.62398752024;18870.905645471772;17484.562885927826;17722.46832595021;18144.81855181448;18152.092395380245;18175.63648727028;957.2342126298968;986.2701600815417;987.3680844259679;988.3427520698763;988.7429268390198;683.0880774166494;706.0045336076133;968.3657204531008;998.5456617239175;1001.2640709078858;1050.0759331788054;1053.5048527192207;1054.5360041581719;1054.9367037977709;1056.028453822485;1055.192777525186;1055.6938487838518;1056.3767377247461;1060.3849767135043;1060.8620879285681;796.8565658181583;797.6809276289473;797.7088362747613;799.5242830515892;801.5070731500085;16736.66526669472;16850.578735531588;17060.402885898933;17248.741268880978;17483.213255403538;17238.965662060316;17405.477835664824;17573.29706811726;17712.734308985247;17784.199711013036;14051.64870878226;14226.075305105134;14323.57029289123;14398.208098554574;14423.350949207312;3426.3489936912156;3454.032870796181;3454.29187016661;3454.792712437262;3455.153487395579;114037;125696.37151814182;127465.36267318697;127474.3626281872;130738;11338.773224535464;11725.296482211095;12310.692232694075;12325.50697972089;12329.938350308192;19923.302684405975;24775;25423;25849.870750646125;25885.611715824278;7848.686052557948;7953.602319883983;8039.758807235792;8042;8042.839143217103;3898.863539776094;4060;4069.4302797608357;4069.959300406958;4074.1647962167685;4254.7659878706345;4343.630791382768;4352.869413917588;4360.825566977349;4361.978190109029;776.8601651702635;894.5259012723267;914.6707185413246;917.6421195733669;919.3886065766325;661.4047357378302;680.1498127340824;680.4961036110252;687.7283473028126;707.9504434689522;9439.952800236093;11692.47383867728;12013.759724805455;13289.601311960463;13376.933115334361;664.5182242873877;671.9428848547831;672.525869262169;684.6131935456451;706.2407911495163;5610.214569960209;5701.4013528579735;6085.330613632497;6103.877922441527;6157.630542167484;103047.45428818573;103784;104410;106094.4085838713;106104.46947765212;91679;92139;93095;93169.06830931603;96477;71565.6421717888;73824.63087684527;74325.62837185888;77104;83375.583122084;11166.625904056293;12194.207376520499;12777.93611031976;12816.295103769382;12909.096363254483;33328.83335583306;40053.599464006154;40602.9849253771;40793.368265269055;41590;40046.798596042165;52251.73874130605;53104.46895530995;53146.468535314154;53849;14588.34352454121;15417.306221219847;16041.759373609639;16249;16363.754543682093;18159.18283677264;18353.990530520416;18404.35584754527;18500.629987400447;18523.629527409106;13702.86297137016;16283.104429256504;16565.00609963406;16721.832781672027;16771;16331.510054698378;16396.508104756875;16479.91760041192;16515.33938642441;16715.080670563235;16067.839321607102;16069;16095.919520402324;16293.185340733153;16368.345266189219;11796.76406471883;11984.700382490508;12065;12180.817287740869;12232.938835305766;12335.766423357592;12568.120231583702;12643;12888.291143987171;12900.225986440844 16:53:29 INFO - PID 1640 | __end_tp_report 16:53:29 INFO - PID 1640 | __start_cc_report 16:53:29 INFO - PID 1640 | _x_x_mozilla_cycle_collect,1711 16:53:29 INFO - PID 1640 | __end_cc_report 16:53:29 INFO - PID 1640 | __startTimestamp1492214009238__endTimestamp 16:53:29 INFO - PID 1640 | 16:53:29 INFO - PID 1640 | ------- Summary: start ------- 16:53:29 INFO - PID 1640 | Number of tests: 6 16:53:29 INFO - PID 1640 | 16:53:29 INFO - PID 1640 | [#0] dojo.html Cycles:165 Average:5999.32 Median:6273.56 stddev:727.89 (11.6%) stddev-sans-first:686.93 16:53:29 INFO - PID 1640 | Values: 2850.6 3263.9 3491.2 3525.5 3567.8 5912.3 6074.0 6167.6 6188.1 6189.7 5956.6 6052.6 6053.2 6057.4 6059.1 5259.3 5275.9 5299.9 5312.7 5387.9 4426.5 5368.5 5390.6 5396.8 5396.9 5368.6 5371.9 5374.9 5375.8 5385.1 5349.3 5351.6 5356.2 5361.3 5383.7 5199.7 5313.7 5314.4 5315.3 5319.3 6181.8 6206.2 6228.1 6240.5 6243.1 6300.9 6449.0 6470.5 6470.5 6516.2 5268.7 6398.5 6511.0 6568.8 6582.4 6251.3 6252.2 6263.9 6271.8 6276.1 6742.1 6748.0 6766.6 6769.4 6769.7 6288.0 6351.9 6352.1 6370.3 6408.4 6474.7 6520.4 6544.6 6545.5 6566.7 6432.1 6444.6 6471.9 6480.1 6480.9 6347.4 6380.2 6495.8 6500.3 6502.3 4978.2 5243.3 5280.9 5297.9 5299.4 3955.5 4693.7 4699.5 4711.2 4747.7 6208.9 6228.8 6268.5 6270.5 6273.6 6301.3 6379.5 6473.9 6563.4 6576.3 6191.5 6245.7 6248.8 6254.3 6261.2 5746.9 5775.6 5776.9 5785.6 5802.3 6487.3 6586.0 6672.2 6734.3 6757.4 5499.6 6548.5 6555.0 6607.2 6613.1 6704.0 6761.6 6775.5 6780.9 6782.1 5867.3 6315.7 6394.8 6502.8 6504.8 5605.5 6384.7 6573.0 6584.1 6599.9 6232.2 6385.1 6389.4 6398.1 6408.6 5526.6 6278.0 6307.0 6376.9 6387.3 6292.6 6331.5 6331.6 6334.9 6339.9 5296.5 6226.3 6304.3 6332.7 6390.9 6271.6 6293.7 6310.6 6311.1 6321.5 16:53:29 INFO - PID 1640 | 16:53:29 INFO - PID 1640 | [#1] ext.html Cycles:180 Average:44230.02 Median:311357.50 stddev:78791.17 (25.3%) stddev-sans-first:78944.58 16:53:29 INFO - PID 1640 | Values: 753.5 791.9 813.2 1119.5 1149.7 27561.2 27939.4 27990.0 28007.0 28017.0 28008.3 37326.9 38041.4 38069.8 38088.0 8442.6 8600.5 8606.1 8613.4 8614.4 8476.5 8625.7 8629.9 8636.6 8660.5 6124.2 6241.0 6277.0 6282.8 6292.1 8377.5 8609.7 8611.0 8617.0 8618.3 8390.5 8452.9 8462.0 8482.5 8492.8 25647.8 26148.0 36658.6 37063.0 37165.3 3574.1 3646.5 3648.5 3652.8 3656.2 30652.0 30799.5 30861.7 30881.1 30908.0 2704.8 3174.4 3174.7 3177.9 3193.4 305353.0 310806.0 311263.0 311452.0 311462.0 49729.0 49897.8 49945.5 50062.0 50069.7 50384.0 50413.0 50431.5 50465.0 50501.5 14178.7 14317.2 14332.9 14338.1 14357.5 11742.9 11748.6 11754.2 11765.9 11794.8 12093.2 12263.8 12285.4 12325.3 12381.3 4072.2 4772.5 4864.0 5420.9 5556.5 1018.8 1028.3 1035.3 1037.7 1049.0 22087.6 22203.8 22436.3 24117.0 24477.4 956.7 992.5 993.5 1158.0 1162.2 12340.4 12360.8 12418.5 12424.8 12431.7 301701.0 302517.0 302636.0 302953.0 303594.0 52281.0 52499.0 52509.9 52573.0 52606.5 1488.3 1497.8 1540.9 1556.5 1575.5 19617.3 23413.8 23764.5 23802.9 23816.9 38164.6 38202.6 38216.0 38218.2 38221.4 286334.0 286510.0 286606.0 286711.4 286862.0 34479.0 34521.5 34532.3 34551.7 34604.0 41803.8 42731.6 44521.9 44561.9 44780.8 24626.9 27323.7 29259.4 29529.0 30186.5 25100.4 25374.9 27622.2 30157.8 30315.7 35387.8 35453.8 35482.3 36109.6 36133.8 21244.8 29501.6 29855.7 30491.0 30838.0 22245.1 23167.5 23246.9 23437.9 23598.4 16:53:29 INFO - PID 1640 | 16:53:29 INFO - PID 1640 | [#2] jquery.html Cycles:180 Average:37480.99 Median:12604.01 stddev:100102.31 (794.2%) stddev-sans-first:100344.47 16:53:29 INFO - PID 1640 | Values: 430.2 435.7 443.5 444.7 457.7 19404.9 20581.9 21242.2 21419.7 21444.0 21615.6 21697.5 22015.7 22303.6 22662.9 5990.4 6259.1 6262.1 6268.8 6274.2 5808.9 6155.3 6221.8 6228.5 6238.8 5595.2 5611.6 6164.2 6209.2 6213.4 5965.7 6110.1 6117.6 6130.2 6136.3 5192.4 5302.1 5387.9 5396.9 5414.1 26980.5 27135.2 27963.4 28998.0 29195.9 2169.7 2251.2 2252.0 2252.4 2255.0 17836.6 17940.3 18342.9 18434.2 18580.1 2138.9 2139.3 2193.8 2195.3 2206.9 132408.0 162035.0 162204.0 163590.0 166858.0 11740.7 12323.5 12361.8 12365.4 12368.5 13664.0 16585.9 16588.2 16590.9 16613.3 8809.7 9007.3 9022.1 9086.0 9157.7 8567.7 8575.4 8609.4 8773.6 8785.4 7485.1 7624.5 7624.6 7633.7 7660.3 1745.4 2076.7 2080.9 2086.7 2270.2 840.9 918.8 976.0 987.8 1002.7 20392.3 21313.9 22937.8 27196.0 27212.3 956.7 998.6 1005.6 1037.3 1043.6 7605.7 10645.9 10666.8 10691.9 10736.2 585015.2 585077.0 590174.0 591460.0 600803.0 139419.3 139733.0 140467.0 141839.0 143252.0 1172.9 1201.0 1236.9 1239.3 1242.2 18311.4 21814.9 22072.8 22178.3 22213.7 59825.4 60703.4 60709.7 60721.0 60824.0 83344.6 83739.6 85314.0 86046.6 86786.6 8609.7 8793.2 8895.6 8924.3 9159.0 14170.4 14357.7 14363.9 14439.4 14594.6 11553.7 11678.6 11998.8 12019.7 12090.8 9382.0 9505.5 10260.6 10925.0 10928.0 9539.4 11956.9 11999.8 12068.6 12085.6 8840.5 8846.9 8849.9 8975.0 9336.7 9780.6 10238.8 12088.3 12244.9 12275.6 16:53:29 INFO - PID 1640 | 16:53:29 INFO - PID 1640 | [#3] mootools.html Cycles:180 Average:7210.30 Median:3941.58 stddev:4620.43 (117.2%) stddev-sans-first:4611.02 16:53:29 INFO - PID 1640 | Values: 1159.4 1172.5 1413.5 1430.2 1437.0 9894.5 10367.2 11732.0 12046.5 12143.1 11711.7 11821.8 11824.8 11837.2 11858.9 2492.2 2534.2 2537.5 2538.0 2541.5 2136.2 2231.7 2458.9 2568.7 2570.6 2506.1 2507.2 2539.2 2541.9 2546.3 2171.7 2513.3 2523.7 2523.8 2525.4 2447.6 2448.4 2480.2 2480.9 2483.7 11716.1 11844.5 11852.0 11854.8 11908.9 6482.6 6734.8 6751.2 6753.3 6762.6 4007.0 4163.1 4365.3 4386.9 4392.4 1260.2 1267.1 1290.2 1305.6 1314.4 16882.2 16886.8 16888.0 16899.9 16907.2 5771.8 5921.6 5952.4 6043.4 6064.5 14118.3 14127.7 14153.0 14157.3 14171.7 6811.5 6844.5 6847.5 6920.3 6939.7 5213.5 5775.4 5995.4 6231.4 6240.9 4165.9 4283.5 4284.4 4285.4 4289.1 1330.6 1351.9 1422.2 1474.9 1484.8 797.8 802.4 825.2 825.7 848.3 5743.9 6529.8 6776.5 6990.5 7018.7 939.4 943.5 945.5 945.7 946.6 3913.9 3920.8 3962.4 3974.8 3978.6 14880.4 14890.3 15373.5 15378.0 15407.5 14963.0 15198.2 15271.6 15372.2 15398.8 8419.2 8491.9 8564.2 8617.8 8618.1 6338.0 6621.5 6656.3 6685.8 6705.9 12323.1 13568.5 13653.5 13694.9 14001.4 11519.0 13400.7 13610.6 13853.2 13946.0 7575.4 9512.7 9519.9 9568.2 9682.8 10593.3 10695.8 10700.1 10701.5 10745.5 8978.4 9202.4 9240.1 9310.0 9412.4 8998.6 9033.1 9053.5 9135.2 9162.9 8169.8 8198.9 8284.3 8289.3 8302.5 5967.9 5969.6 6117.0 6120.8 6204.3 6109.3 6176.7 6229.3 6273.8 6315.7 16:53:29 INFO - PID 1640 | 16:53:29 INFO - PID 1640 | [#4] prototype.html Cycles:180 Average:5046.37 Median:5679.77 stddev:1603.75 (28.2%) stddev-sans-first:1569.60 16:53:29 INFO - PID 1640 | Values: 383.9 390.9 405.5 407.9 409.2 5166.4 5668.9 5867.7 5983.4 6065.2 4788.7 5471.7 5713.4 5745.6 5796.8 3881.9 4385.3 4492.4 4500.4 4501.5 3627.9 3697.7 4096.5 4326.9 4550.3 4293.2 4304.3 4312.0 4314.1 4334.4 4144.3 4180.3 4231.4 4273.9 4277.7 3085.4 3746.9 3754.8 3755.9 3757.8 4917.8 5449.7 5690.7 5706.3 5718.4 4837.4 5011.0 5056.1 5111.2 5147.9 6180.4 6198.6 6201.5 6217.4 6221.6 4209.4 4223.2 4230.1 4234.7 4258.4 5417.4 6292.5 6630.4 6646.8 6665.5 4279.9 4297.8 4301.0 4308.5 4324.6 3643.6 4370.2 4379.2 4379.9 4387.8 4351.4 4879.0 5030.2 5045.4 5080.6 5971.5 6116.1 6281.8 6312.7 6344.3 1364.7 1409.8 1411.5 1422.2 1436.2 839.7 921.1 995.4 997.9 1005.2 4296.0 4930.3 5705.7 5960.9 6005.0 4884.0 6449.9 6480.2 6502.3 6580.7 5326.7 5501.9 5938.5 5942.9 5965.4 2815.7 3200.7 3271.9 3391.3 3412.6 5718.0 6619.0 6732.7 6751.8 6796.6 5297.4 6319.9 6722.0 6723.6 6724.7 6716.2 6724.5 6740.8 6752.1 6752.9 5529.9 6528.2 6528.5 6561.0 6574.1 5049.6 6186.2 6260.4 6293.9 6480.1 6734.8 6759.6 6759.9 6775.8 6799.9 4126.0 4225.7 4264.6 4281.7 4296.6 5639.4 6510.7 6510.8 6513.6 6515.6 5183.6 6035.5 6279.7 6291.7 6305.5 5451.4 5838.1 6015.4 6175.6 6268.3 5364.4 6157.5 6183.2 6192.8 6303.3 6173.5 6302.9 6328.7 6330.7 6340.9 5652.2 5875.2 6124.7 6161.4 6192.7 16:53:29 INFO - PID 1640 | 16:53:29 INFO - PID 1640 | [#5] yui.html Cycles:180 Average:21529.10 Median:18452.49 stddev:30316.75 (164.3%) stddev-sans-first:30361.53 16:53:29 INFO - PID 1640 | Values: 719.8 800.2 871.7 876.0 885.6 13619.0 18045.4 18308.3 18800.6 18870.9 17484.6 17722.5 18144.8 18152.1 18175.6 957.2 986.3 987.4 988.3 988.7 683.1 706.0 968.4 998.5 1001.3 1050.1 1053.5 1054.5 1054.9 1056.0 1055.2 1055.7 1056.4 1060.4 1060.9 796.9 797.7 797.7 799.5 801.5 16736.7 16850.6 17060.4 17248.7 17483.2 17239.0 17405.5 17573.3 17712.7 17784.2 14051.6 14226.1 14323.6 14398.2 14423.4 3426.3 3454.0 3454.3 3454.8 3455.2 114037.0 125696.4 127465.4 127474.4 130738.0 11338.8 11725.3 12310.7 12325.5 12329.9 19923.3 24775.0 25423.0 25849.9 25885.6 7848.7 7953.6 8039.8 8042.0 8042.8 3898.9 4060.0 4069.4 4070.0 4074.2 4254.8 4343.6 4352.9 4360.8 4362.0 776.9 894.5 914.7 917.6 919.4 661.4 680.1 680.5 687.7 708.0 9440.0 11692.5 12013.8 13289.6 13376.9 664.5 671.9 672.5 684.6 706.2 5610.2 5701.4 6085.3 6103.9 6157.6 103047.5 103784.0 104410.0 106094.4 106104.5 91679.0 92139.0 93095.0 93169.1 96477.0 71565.6 73824.6 74325.6 77104.0 83375.6 11166.6 12194.2 12777.9 12816.3 12909.1 33328.8 40053.6 40603.0 40793.4 41590.0 40046.8 52251.7 53104.5 53146.5 53849.0 14588.3 15417.3 16041.8 16249.0 16363.8 18159.2 18354.0 18404.4 18500.6 18523.6 13702.9 16283.1 16565.0 16721.8 16771.0 16331.5 16396.5 16479.9 16515.3 16715.1 16067.8 16069.0 16095.9 16293.2 16368.3 11796.8 11984.7 12065.0 12180.8 12232.9 12335.8 12568.1 12643.0 12888.3 12900.2 16:53:29 INFO - PID 1640 | -------- Summary: end -------- 16:53:29 INFO - PID 1640 | 16:53:29 INFO - TEST-INFO | 1640: exit 0 16:53:30 INFO - TEST-OK | dromaeo_css | took 1119710ms 16:53:30 INFO - TEST-START | kraken 16:53:30 INFO - operating with platform_type : mac_ 16:53:30 INFO - Initialising browser for kraken test... 16:53:30 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmpEklSpU/profile http://localhost:49241/getInfo.html) 16:53:32 INFO - PID 1650 | __metrics Screen width/height:1600/1200 16:53:32 INFO - PID 1650 | colorDepth:24 16:53:32 INFO - PID 1650 | Browser inner width/height: 1024/689 16:53:32 INFO - PID 1650 | __metrics 16:53:33 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" 16:53:33 INFO - PID 1650 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:53:34 INFO - TEST-INFO | 1650: exit 0 16:53:34 INFO - Browser initialized. 16:53:34 INFO - Running cycle 1/1 for kraken test... 16:53:34 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmpEklSpU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:53:46 INFO - PID 1651 | RSS: Main: 244006912 16:53:46 INFO - PID 1651 | 16:53:48 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 16:53:49 INFO - PID 1651 | RSS: Main: 312643584 16:53:49 INFO - PID 1651 | 16:53:52 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 16:53:53 INFO - PID 1651 | RSS: Main: 293765120 16:53:53 INFO - PID 1651 | 16:53:56 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 16:53:57 INFO - PID 1651 | RSS: Main: 386588672 16:53:57 INFO - PID 1651 | 16:53:59 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 16:53:59 INFO - PID 1651 | RSS: Main: 290705408 16:53:59 INFO - PID 1651 | 16:54:01 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:54:02 INFO - PID 1651 | RSS: Main: 292982784 16:54:02 INFO - PID 1651 | 16:54:05 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 16:54:05 INFO - PID 1651 | RSS: Main: 355532800 16:54:05 INFO - PID 1651 | 16:54:08 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 16:54:09 INFO - PID 1651 | RSS: Main: 369463296 16:54:09 INFO - PID 1651 | 16:54:12 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 16:54:13 INFO - PID 1651 | RSS: Main: 376385536 16:54:13 INFO - PID 1651 | 16:54:14 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:54:15 INFO - PID 1651 | RSS: Main: 317718528 16:54:15 INFO - PID 1651 | 16:54:17 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:54:17 INFO - PID 1651 | RSS: Main: 338505728 16:54:17 INFO - PID 1651 | 16:54:19 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:54:20 INFO - PID 1651 | RSS: Main: 320380928 16:54:20 INFO - PID 1651 | 16:54:23 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:54:24 INFO - PID 1651 | RSS: Main: 335163392 16:54:24 INFO - PID 1651 | 16:54:27 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:54:28 INFO - PID 1651 | RSS: Main: 345079808 16:54:28 INFO - PID 1651 | 16:54:29 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 16:54:30 INFO - PID 1651 | RSS: Main: 387887104 16:54:30 INFO - PID 1651 | 16:54:30 INFO - PID 1651 | __start_tp_report 16:54:30 INFO - PID 1651 | _x_x_mozilla_page_load 16:54:30 INFO - PID 1651 | _x_x_mozilla_page_load_details 16:54:30 INFO - PID 1651 | |i|pagename|runs| 16:54:30 INFO - PID 1651 | |0;ai-astar;111;111;111;112;113;111;111;112;112;111 16:54:30 INFO - PID 1651 | |1;audio-beat-detection;141;109;109;150;114;93;123;143;158;119 16:54:30 INFO - PID 1651 | |2;audio-dft;185;184;185;184;184;185;183;184;182;184 16:54:30 INFO - PID 1651 | |3;audio-fft;80;58;59;99;52;59;50;75;89;84 16:54:30 INFO - PID 1651 | |4;audio-oscillator;91;70;87;70;69;69;90;70;68;91 16:54:30 INFO - PID 1651 | |5;imaging-gaussian-blur;87;85;87;86;87;86;85;87;87;86 16:54:30 INFO - PID 1651 | |6;imaging-darkroom;150;124;94;94;94;93;94;94;94;93 16:54:30 INFO - PID 1651 | |7;imaging-desaturate;84;84;84;83;89;134;126;85;84;82 16:54:30 INFO - PID 1651 | |8;json-parse-financial;49;47;50;47;47;48;50;48;49;49 16:54:30 INFO - PID 1651 | |9;json-stringify-tinderbox;54;65;53;54;61;63;58;57;58;58 16:54:30 INFO - PID 1651 | |10;stanford-crypto-aes;81;84;81;86;84;84;81;81;85;104 16:54:30 INFO - PID 1651 | |11;stanford-crypto-ccm;145;132;116;141;145;153;151;136;178;148 16:54:30 INFO - PID 1651 | |12;stanford-crypto-pbkdf2;186;178;184;186;189;226;202;183;182;184 16:54:30 INFO - PID 1651 | |13;stanford-crypto-sha256-iterative;70;67;68;68;66;68;69;68;67;66 16:54:30 INFO - PID 1651 | __end_tp_report 16:54:30 INFO - PID 1651 | __start_cc_report 16:54:30 INFO - PID 1651 | _x_x_mozilla_cycle_collect,2240 16:54:30 INFO - PID 1651 | __end_cc_report 16:54:30 INFO - PID 1651 | __startTimestamp1492214070107__endTimestamp 16:54:30 INFO - PID 1651 | 16:54:30 INFO - PID 1651 | ------- Summary: start ------- 16:54:30 INFO - PID 1651 | Number of tests: 14 16:54:30 INFO - PID 1651 | 16:54:30 INFO - PID 1651 | [#0] ai-astar Cycles:10 Average:111.50 Median:111.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 16:54:30 INFO - PID 1651 | Values: 111.0 111.0 111.0 112.0 113.0 111.0 111.0 112.0 112.0 111.0 16:54:30 INFO - PID 1651 | 16:54:30 INFO - PID 1651 | [#1] audio-beat-detection Cycles:10 Average:125.90 Median:142.00 stddev:21.04 (14.8%) stddev-sans-first:21.59 16:54:30 INFO - PID 1651 | Values: 141.0 109.0 109.0 150.0 114.0 93.0 123.0 143.0 158.0 119.0 16:54:30 INFO - PID 1651 | 16:54:30 INFO - PID 1651 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.00 stddev:0.94 (0.5%) stddev-sans-first:0.93 16:54:30 INFO - PID 1651 | Values: 185.0 184.0 185.0 184.0 184.0 185.0 183.0 184.0 182.0 184.0 16:54:30 INFO - PID 1651 | 16:54:30 INFO - PID 1651 | [#3] audio-fft Cycles:10 Average:70.50 Median:77.50 stddev:17.10 (22.1%) stddev-sans-first:17.78 16:54:30 INFO - PID 1651 | Values: 80.0 58.0 59.0 99.0 52.0 59.0 50.0 75.0 89.0 84.0 16:54:30 INFO - PID 1651 | 16:54:30 INFO - PID 1651 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:78.50 stddev:10.62 (13.5%) stddev-sans-first:10.07 16:54:30 INFO - PID 1651 | Values: 91.0 70.0 87.0 70.0 69.0 69.0 90.0 70.0 68.0 91.0 16:54:30 INFO - PID 1651 | 16:54:30 INFO - PID 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:87.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 16:54:30 INFO - PID 1651 | Values: 87.0 85.0 87.0 86.0 87.0 86.0 85.0 87.0 87.0 86.0 16:54:30 INFO - PID 1651 | 16:54:30 INFO - PID 1651 | [#6] imaging-darkroom Cycles:10 Average:102.40 Median:94.00 stddev:19.24 (20.5%) stddev-sans-first:10.09 16:54:30 INFO - PID 1651 | Values: 150.0 124.0 94.0 94.0 94.0 93.0 94.0 94.0 94.0 93.0 16:54:30 INFO - PID 1651 | 16:54:30 INFO - PID 1651 | [#7] imaging-desaturate Cycles:10 Average:93.50 Median:84.00 stddev:19.42 (23.1%) stddev-sans-first:20.29 16:54:30 INFO - PID 1651 | Values: 84.0 84.0 84.0 83.0 89.0 134.0 126.0 85.0 84.0 82.0 16:54:30 INFO - PID 1651 | 16:54:30 INFO - PID 1651 | [#8] json-parse-financial Cycles:10 Average:48.40 Median:49.00 stddev:1.17 (2.4%) stddev-sans-first:1.22 16:54:30 INFO - PID 1651 | Values: 49.0 47.0 50.0 47.0 47.0 48.0 50.0 48.0 49.0 49.0 16:54:30 INFO - PID 1651 | 16:54:30 INFO - PID 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:58.00 stddev:3.96 (6.8%) stddev-sans-first:3.91 16:54:30 INFO - PID 1651 | Values: 54.0 65.0 53.0 54.0 61.0 63.0 58.0 57.0 58.0 58.0 16:54:30 INFO - PID 1651 | 16:54:30 INFO - PID 1651 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:84.00 stddev:6.90 (8.2%) stddev-sans-first:7.16 16:54:30 INFO - PID 1651 | Values: 81.0 84.0 81.0 86.0 84.0 84.0 81.0 81.0 85.0 104.0 16:54:30 INFO - PID 1651 | 16:54:30 INFO - PID 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:144.50 Median:146.50 stddev:15.99 (10.9%) stddev-sans-first:16.96 16:54:30 INFO - PID 1651 | Values: 145.0 132.0 116.0 141.0 145.0 153.0 151.0 136.0 178.0 148.0 16:54:30 INFO - PID 1651 | 16:54:30 INFO - PID 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.00 Median:186.00 stddev:14.15 (7.6%) stddev-sans-first:14.93 16:54:30 INFO - PID 1651 | Values: 186.0 178.0 184.0 186.0 189.0 226.0 202.0 183.0 182.0 184.0 16:54:30 INFO - PID 1651 | 16:54:30 INFO - PID 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.25 (1.8%) stddev-sans-first:1.01 16:54:30 INFO - PID 1651 | Values: 70.0 67.0 68.0 68.0 66.0 68.0 69.0 68.0 67.0 66.0 16:54:30 INFO - PID 1651 | -------- Summary: end -------- 16:54:30 INFO - PID 1651 | 16:54:31 INFO - TEST-INFO | 1651: exit 0 16:54:31 INFO - TEST-OK | kraken | took 61280ms 16:54:31 INFO - SUITE-END | took 1180s 16:54:31 INFO - Completed test suite (00:19:41) 16:54:31 INFO - javascript benchmark 16:54:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7759.360171010593, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2850.55816348466, 3263.918402039949, 3491.231928975626, 3525.5240542526753, 3567.821608919555, 5912.320083190434, 6074.028155495122, 6167.629942203465, 6188.102725104857, 6189.659568723719, 5956.553258505619, 6052.576319657625, 6053.152558641794, 6057.42454466825, 6059.0608455689435, 5259.31628888244, 5275.868103297429, 5299.947000530004, 5312.73436328184, 5387.919181212285, 4426.468823741156, 5368.463153684639, 5390.595705322097, 5396.78412863485, 5396.892062158754, 5368.62419630626, 5371.919421208666, 5374.865628359303, 5375.81184658537, 5385.138377859544, 5349.277847490578, 5351.625386222966, 5356.223347614574, 5361.276227709248, 5383.703896285722, 5199.688018718851, 5313.681179129265, 5314.441983591706, 5315.335583052119, 5319.255304257407, 6181.814545563595, 6206.162168107293, 6228.065790131472, 6240.5319601030105, 6243.094751261042, 6300.873982520324, 6449.0, 6470.450011749007, 6470.547061705683, 6516.152900122954, 5268.710220937847, 6398.4561312288515, 6510.967445162792, 6568.770093046721, 6582.3746744059235, 6251.3123556408755, 6252.218472690914, 6263.906041409383, 6271.78048768291, 6276.058591211309, 6742.056112144303, 6748.0, 6766.594004359754, 6769.356911093439, 6769.695363708645, 6287.96856015717, 6351.936480635134, 6352.110704501373, 6370.267419246846, 6408.359164083555, 6474.741010359533, 6520.445762110179, 6544.640044797487, 6545.541812073205, 6566.67166641666, 6432.067350234283, 6444.6133232005295, 6471.870562588721, 6480.092787009728, 6480.935190648128, 6347.428731414103, 6380.202474690664, 6495.837604059936, 6500.252470965805, 6502.317256687979, 4978.228374601942, 5243.292155559027, 5280.894382112337, 5297.947020529746, 5299.39057008449, 3955.5451123120633, 4693.741844198602, 4699.506551812011, 4711.199096153662, 4747.715137091716, 6208.937910620926, 6228.750849965951, 6268.49852011838, 6270.498360131179, 6273.560850740404, 6301.338359472281, 6379.489640828722, 6473.902891456632, 6563.409293163638, 6576.309487503839, 6191.504679625619, 6245.656488893154, 6248.812535623939, 6254.34329395416, 6261.24865016201, 5746.913796293059, 5775.566832487496, 5776.855578610568, 5785.595008349459, 5802.274715660543, 6487.3188315226225, 6586.0, 6672.165979252593, 6734.292899245705, 6757.391834734897, 5499.642523235977, 6548.541602087998, 6555.0, 6607.240167380813, 6613.074169616354, 6704.0, 6761.560498567577, 6775.525713200029, 6780.864382712417, 6782.050512928293, 5867.295924489089, 6315.684215789284, 6394.840128996812, 6502.804915852532, 6504.804855854332, 5605.495505404533, 6384.712687928962, 6573.014047892663, 6584.078229048033, 6599.868002640016, 6232.158658581034, 6385.10608514799, 6389.361063893573, 6398.104265402754, 6408.647524386203, 5526.613137080366, 6278.0, 6306.990881458944, 6376.93623063782, 6387.297397286387, 6292.622442653455, 6331.5251356147555, 6331.620102793847, 6334.936650633619, 6339.873202536016, 5296.470352964827, 6226.346233645583, 6304.306526282014, 6332.651704156316, 6390.90413643805, 6271.592346497463, 6293.685315734287, 6310.558260921875, 6311.116443697794, 6321.462675672436], "value": 5949.739219088179, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.5252790741832, 791.9089304729956, 813.2355585749395, 1119.5465836336286, 1149.7240662241065, 27561.173164805063, 27939.441211175763, 27990.0, 28007.0, 28017.019404320854, 28008.299792505197, 37326.88019359417, 38041.429378559274, 38069.809650951705, 38088.0, 8442.57787110645, 8600.483970961732, 8606.139386061375, 8613.35399845011, 8614.353923455734, 8476.533790641512, 8625.654973801073, 8629.870551941694, 8636.611352489123, 8660.523671198082, 6124.1732366130445, 6240.968795156018, 6277.0, 6282.811515654537, 6292.056191571255, 8377.539235342054, 8609.741707748746, 8611.0, 8616.956915215447, 8618.310535157236, 8390.496570205807, 8452.915470845275, 8462.0, 8482.53346065966, 8492.78768030798, 25647.845846936933, 26148.0, 36658.63341366579, 37063.0, 37165.25669486595, 3574.070741607201, 3646.4712616670436, 3648.4892115103908, 3652.7990960497164, 3656.1590834108038, 30652.0, 30799.538006929914, 30861.691383086105, 30881.073567793002, 30908.0, 2704.837709737422, 3174.4444722173525, 3174.6507884132725, 3177.9046628601177, 3193.3613277344625, 305353.0, 310806.0, 311263.0, 311451.99999999773, 311462.0, 49729.0, 49897.75051124721, 49945.500544994815, 50061.99876002532, 50069.74825629388, 50384.0, 50413.0, 50431.487055388396, 50465.0, 50501.49498505041, 14178.716425671635, 14317.212553309668, 14332.925030622746, 14338.139711617336, 14357.497487587885, 11742.94128529369, 11748.647540573797, 11754.177207595558, 11765.882341176479, 11794.823077653842, 12093.213941093802, 12263.816042759367, 12285.420061787125, 12325.322107284006, 12381.319027453397, 4072.205919845602, 4772.475027746945, 4863.975680121577, 5420.864478388072, 5556.499915007668, 1018.7911478146962, 1028.275066078413, 1035.29082578434, 1037.678319720889, 1048.9527971241312, 22087.582483503364, 22203.777962220494, 22436.326910192394, 24117.0, 24477.38806529851, 956.7273327101742, 992.4888682328607, 993.5082134343402, 1157.9652610421701, 1162.2329262686587, 12340.444679989421, 12360.814587781011, 12418.503259869503, 12424.75150496985, 12431.689207769878, 301701.0, 302517.0, 302636.0, 302953.0, 303594.0, 52281.0, 52499.0, 52509.949801003764, 52573.0, 52606.473935260925, 1488.3302513868803, 1497.8427265137439, 1540.9383624655113, 1556.5408204579676, 1575.495841330786, 19617.31339403114, 23413.76586234184, 23764.524709505367, 23802.880985594962, 23816.880915596004, 38164.618353816106, 38202.61797382102, 38216.0, 38218.23563528658, 38221.42667859929, 286334.0, 286510.0, 286606.0, 286711.3986580406, 286862.0, 34479.0, 34521.48217776786, 34532.30935381228, 34551.65448345484, 34604.0, 41803.79098104611, 42731.57268427276, 44521.88695282644, 44561.88595285144, 44780.77609611931, 24626.87686561556, 27323.72676273212, 29259.41481170322, 29529.0, 30186.54720179243, 25100.372490687878, 25374.873125634254, 27622.20455670375, 30157.849210753804, 30315.696843031288, 35387.82306088453, 35453.82273088618, 35482.29035419329, 36109.63890361063, 36133.81933090318, 21244.787552124282, 29501.557476638296, 29855.701442985293, 30491.0, 30838.0, 22245.110195591995, 23167.53664926726, 23246.883765581064, 23437.882810585837, 23598.410039749142], "value": 16856.92942329601, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.21056361576507, 435.6819521749125, 443.5254277922623, 444.69093979684123, 457.7047804166311, 19404.932728699914, 20581.897090514543, 21242.150313987462, 21419.678704819442, 21444.0, 21615.567688646257, 21697.457563560918, 22015.669764953538, 22303.55392892141, 22662.886685566547, 5990.430909063632, 6259.123722678829, 6262.0919966604815, 6268.811935641916, 6274.247090349165, 5808.941910580904, 6155.26136863577, 6221.7822376216845, 6228.470580000705, 6238.750449981995, 5595.244641973322, 5611.551075913917, 6164.167837341969, 6209.192804935375, 6213.409726076015, 5965.671888046156, 6110.052941794029, 6117.632942023492, 6130.2030736004035, 6136.294326152482, 5192.428832828386, 5302.125149350352, 5387.919181212285, 5396.91904621431, 5414.133738601805, 26980.460390792075, 27135.1859444217, 27963.440731185263, 28998.0, 29195.854020729974, 2169.6528555431214, 2251.1783199132365, 2251.977480225193, 2252.358077947777, 2254.966175507352, 17836.643267134714, 17940.282388704436, 18342.90828545862, 18434.170462329228, 18580.070996450122, 2138.9144434222767, 2139.326112274644, 2193.813525850305, 2195.2536137713096, 2206.900689468978, 132408.0, 162035.0, 162204.0, 163590.0, 166857.99999999878, 11740.706482337839, 12323.50705971751, 12361.814572781415, 12365.443555040045, 12368.505259789688, 13664.0, 16585.91707041457, 16588.170591470378, 16590.917045414695, 16613.335466581444, 8809.69166079197, 9007.324450666227, 9022.097790221056, 9086.045965173695, 9157.679481218125, 8567.74296771098, 8575.442596231225, 8609.397342186112, 8773.649054037767, 8785.385023048453, 7485.139208991036, 7624.504407213513, 7624.58064806441, 7633.732819351296, 7660.348870345972, 1745.3978377459755, 2076.7092607034724, 2080.9271675491286, 2086.7182930304216, 2270.23946977761, 840.9159084091664, 918.8483900156533, 975.9707208783748, 987.827130252203, 1002.734275417015, 20392.286269980777, 21313.934303285085, 22937.770622293898, 27196.0, 27212.31969200786, 956.660385563129, 998.6169155719381, 1005.5726316315537, 1037.3412882819464, 1043.5982146873357, 7605.6577454014705, 10645.893541064645, 10666.839997400046, 10691.893081069245, 10736.194785391126, 585015.1987840963, 585077.0, 590174.0, 591460.0, 600803.0, 139419.30290348484, 139733.0, 140467.0, 141839.0, 143252.0, 1172.865120511135, 1200.9759804803855, 1236.9053387751903, 1239.2936026465009, 1242.1553343726173, 18311.35910243135, 21814.89092554527, 22072.779272207714, 22178.33464995988, 22213.66679499841, 59825.40174598198, 60703.392966069776, 60709.69645151746, 60720.96395180135, 60824.0, 83344.58327708322, 83739.5813020931, 85314.0, 86046.56976715077, 86786.58560972723, 8609.741707748777, 8793.208611224765, 8895.644174232959, 8924.330675199515, 9159.038300978302, 14170.433182672577, 14357.707806297483, 14363.856361436252, 14439.422423103379, 14594.635134121307, 11553.653390398302, 11678.6496405108, 11998.820017699916, 12019.699507512032, 12090.75818483643, 9382.014888436615, 9505.524723763923, 10260.640877569249, 10925.016748492673, 10928.0, 9539.427634341962, 11956.923876851126, 11999.76000479968, 12068.577599784317, 12085.577004804789, 8840.469571825712, 8846.867296990422, 8849.867251991096, 8974.955125224593, 9336.719898403058, 9780.559874805793, 10238.795224095327, 12088.274703517816, 12244.938775306067, 12275.570355037531], "value": 10533.17150439569, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1159.4492616007396, 1172.466527729883, 1413.491143188452, 1430.2419717549703, 1436.9712605747886, 9894.455804930725, 10367.222458315628, 11732.00277976372, 12046.457909394076, 12143.149979501439, 11711.707207319821, 11821.763564728722, 11824.822627660593, 11837.230580012314, 11858.932696057353, 2492.2274095030552, 2534.1510593950957, 2537.5051864886354, 2538.0, 2541.4917016596664, 2136.241634219853, 2231.6764069209953, 2458.8770561471943, 2568.7174410814796, 2570.575854983925, 2506.1103308325555, 2507.1976967370447, 2539.1874600127967, 2541.9237422877345, 2546.3379521324496, 2171.695962565242, 2513.321403221129, 2523.659305993686, 2523.823332366735, 2525.356034211264, 2447.559439300925, 2448.3879030242438, 2480.218731099698, 2480.9255722328357, 2483.70195576532, 11716.121290903131, 11844.46699898498, 11851.992580630571, 11854.822177667342, 11908.88091119095, 6482.578632388927, 6734.8316292092595, 6751.189857217117, 6753.3246675332075, 6762.560433571802, 4007.0, 4163.125743593849, 4365.301551751704, 4386.8903277418, 4392.407025051641, 1260.2249616485888, 1267.0813660096449, 1290.1742884553894, 1305.575687901436, 1314.4413624209672, 16882.15589220534, 16886.83113168865, 16888.0, 16899.901506402046, 16907.239174237187, 5771.826845194651, 5921.644701317935, 5952.404759524013, 6043.425874541911, 6064.4541991221, 14118.294085295694, 14127.71744565103, 14153.0, 14157.292135393394, 14171.66965763045, 6811.489138314646, 6844.5208835381045, 6847.486438517131, 6920.273371296042, 6939.6877140528795, 5213.45258747826, 5775.393583673654, 5995.400459953969, 6231.376862313823, 6240.937590624036, 4165.875023749292, 4283.485981682218, 4284.357346398003, 4285.357196420499, 4289.120730250291, 1330.60081975407, 1351.9391627376792, 1422.1538184780245, 1474.9115053096848, 1484.7995520604795, 797.7726347990795, 802.3701394405364, 825.2201669422338, 825.6697321071499, 848.2747251100344, 5743.942560574341, 6529.804105876831, 6776.457883369319, 6990.4757143214465, 7018.684159212848, 939.4311499795358, 943.4527973775193, 945.4988855906381, 945.6926498887889, 946.5503885654259, 3913.9217215655526, 3920.8039598019986, 3962.3660214365564, 3974.7813870236837, 3978.562358140602, 14880.404783808526, 14890.329935152944, 15373.538793836204, 15378.000429972017, 15407.537773866801, 14963.0, 15198.164100974553, 15271.61820954485, 15372.231388430533, 15398.846011539965, 8419.158084191531, 8491.915080849236, 8564.186402291773, 8617.784555386292, 8618.05201427855, 6337.96831015842, 6621.50338724588, 6656.334366563498, 6685.799426017227, 6705.899411508929, 12323.075769317158, 13568.525101621395, 13653.453861845812, 13694.863051369757, 14001.43994240219, 11519.0, 13400.664983375493, 13610.59168224955, 13853.238071906142, 13946.023778335419, 7575.431842611716, 9512.667056652985, 9519.90480095218, 9568.186704130227, 9682.75793105178, 10593.2584719072, 10695.839562406414, 10700.143988480748, 10701.518431670438, 10745.462726863781, 8978.371513993958, 9202.355835091746, 9240.122188392092, 9309.953450232706, 9412.435253884789, 8998.59506322204, 9033.096690330914, 9053.502057386908, 9135.2235060018, 9162.862557061517, 8169.754907352789, 8198.918010819816, 8284.295834854105, 8289.295409890226, 8302.501849889026, 5967.910481342697, 5969.611975221596, 6116.969415152896, 6120.7551697931585, 6204.255489341308, 6109.297430795337, 6176.66028368444, 6229.345918678474, 6273.811785646438, 6315.652639104894], "value": 5436.557583935322, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.8541354285371, 390.86515152272466, 405.49313358302123, 407.89190864420914, 409.1693861461235, 5166.4316925138255, 5668.858278543038, 5867.735951882165, 5983.371745966676, 6065.178937269525, 4788.736619485927, 5471.699056551888, 5713.371529131792, 5745.6265342752795, 5796.797112101077, 3881.9029524261837, 4385.298352263639, 4492.39352687388, 4500.369948207253, 4501.482329532105, 3627.927441451169, 3697.7226707996874, 4096.467459230296, 4326.891827704301, 4550.294704320836, 4293.184294983958, 4304.332828411586, 4312.0380226996795, 4314.072474418, 4334.414853994702, 4144.280123748641, 4180.331147016463, 4231.428757117796, 4273.92714533451, 4277.700560960734, 3085.41377138343, 3746.8875933722034, 3754.8310326035394, 3755.924881502382, 3757.830897609587, 4917.7786999585105, 5449.700266485342, 5690.687012214326, 5706.3152421709665, 5718.370979192286, 4837.419509658864, 5011.020646844512, 5056.129232184078, 5111.2333150027425, 5147.922781158286, 6180.443760061571, 6198.6280823150755, 6201.5348848836065, 6217.409346112112, 6221.564490485668, 4209.431726716884, 4223.155368926227, 4230.132822771325, 4234.703570750049, 4258.446401967724, 5417.404085550586, 6292.465140463066, 6630.436412904909, 6646.83382915431, 6665.533412661067, 4279.893002674958, 4297.806598703066, 4301.0, 4308.504521980012, 4324.610785029363, 3643.599204087548, 4370.191514569815, 4379.211741886427, 4379.934300985487, 4387.802548885308, 4351.43431353922, 4879.0, 5030.245463180479, 5045.41977672565, 5080.644354895196, 5971.462568368781, 6116.113163591343, 6281.842953926189, 6312.715927783261, 6344.333844946306, 1364.740699267136, 1409.8449170591227, 1411.4918629293445, 1422.1680317014454, 1436.1813766153193, 839.7396806989852, 921.0697195832124, 995.3878364805737, 997.8674204777485, 1005.2410430125354, 4296.004328767955, 4930.260460930889, 5705.74324155414, 5960.85097872548, 6005.039193728982, 4883.951160488421, 6449.871002579922, 6480.189976252968, 6502.284748677642, 6580.736770529221, 5326.721586819135, 5501.889962200814, 5938.545056461195, 5942.851428714317, 5965.373635768268, 2815.662560283849, 3200.6713018461005, 3271.8896311878707, 3391.253924136686, 3412.6075501317664, 5718.0, 6618.974059020859, 6732.697028633724, 6751.797446076625, 6796.592204467748, 5297.443768404339, 6319.9368006320265, 6721.966390168018, 6723.58804651019, 6724.66376681164, 6716.227633822173, 6724.529282950244, 6740.764073257413, 6752.122224110933, 6752.8649427010205, 5529.921665275233, 6528.151340325917, 6528.510361722985, 6561.048647946117, 6574.145361103026, 5049.57078648319, 6186.226721659793, 6260.436560709558, 6293.874122517615, 6480.092787009917, 6734.831629209309, 6759.5606285591275, 6759.898601521079, 6775.796726098225, 6799.898001529882, 4126.030382859965, 4225.661947044167, 4264.637505812041, 4281.721688090264, 4296.591823776736, 5639.379668236573, 6510.707018184098, 6510.804675859732, 6513.609183449008, 6515.641639709862, 5183.585313175013, 6035.547333949883, 6279.717412716347, 6291.685415729104, 6305.477808876302, 5451.4276001019325, 5838.095095260242, 6015.428534289235, 6175.610487640245, 6268.341824108403, 5364.409914909279, 6157.538184636081, 6183.227096612924, 6192.845178870564, 6303.338149494421, 6173.475254603409, 6302.873942521032, 6328.683565821599, 6330.651814150266, 6340.873182536416, 5652.180433837153, 5875.177475153397, 6124.663143527148, 6161.44546990773, 6192.721327540181], "value": 4550.63867006323, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.8488317453334, 800.2437696376924, 871.7123349294737, 875.9707343870954, 885.5926273914001, 13618.999999999987, 18045.368412105578, 18308.26766929321, 18800.62398752024, 18870.905645471772, 17484.562885927826, 17722.46832595021, 18144.81855181448, 18152.092395380245, 18175.63648727028, 957.2342126298968, 986.2701600815417, 987.3680844259679, 988.3427520698763, 988.7429268390198, 683.0880774166494, 706.0045336076133, 968.3657204531008, 998.5456617239175, 1001.2640709078858, 1050.0759331788054, 1053.5048527192207, 1054.5360041581719, 1054.9367037977709, 1056.028453822485, 1055.192777525186, 1055.6938487838518, 1056.3767377247461, 1060.3849767135043, 1060.8620879285681, 796.8565658181583, 797.6809276289473, 797.7088362747613, 799.5242830515892, 801.5070731500085, 16736.66526669472, 16850.578735531588, 17060.402885898933, 17248.741268880978, 17483.213255403538, 17238.965662060316, 17405.477835664824, 17573.29706811726, 17712.734308985247, 17784.199711013036, 14051.64870878226, 14226.075305105134, 14323.57029289123, 14398.208098554574, 14423.350949207312, 3426.3489936912156, 3454.032870796181, 3454.29187016661, 3454.792712437262, 3455.153487395579, 114037.0, 125696.37151814182, 127465.36267318697, 127474.3626281872, 130738.0, 11338.773224535464, 11725.296482211095, 12310.692232694075, 12325.50697972089, 12329.938350308192, 19923.302684405975, 24775.0, 25423.0, 25849.870750646125, 25885.611715824278, 7848.686052557948, 7953.602319883983, 8039.758807235792, 8042.0, 8042.839143217103, 3898.863539776094, 4060.0, 4069.4302797608357, 4069.959300406958, 4074.1647962167685, 4254.7659878706345, 4343.630791382768, 4352.869413917588, 4360.825566977349, 4361.978190109029, 776.8601651702635, 894.5259012723267, 914.6707185413246, 917.6421195733669, 919.3886065766325, 661.4047357378302, 680.1498127340824, 680.4961036110252, 687.7283473028126, 707.9504434689522, 9439.952800236093, 11692.47383867728, 12013.759724805455, 13289.601311960463, 13376.933115334361, 664.5182242873877, 671.9428848547831, 672.525869262169, 684.6131935456451, 706.2407911495163, 5610.214569960209, 5701.4013528579735, 6085.330613632497, 6103.877922441527, 6157.630542167484, 103047.45428818573, 103784.0, 104410.0, 106094.4085838713, 106104.46947765212, 91679.0, 92139.0, 93095.0, 93169.06830931603, 96477.0, 71565.6421717888, 73824.63087684527, 74325.62837185888, 77104.0, 83375.583122084, 11166.625904056293, 12194.207376520499, 12777.93611031976, 12816.295103769382, 12909.096363254483, 33328.83335583306, 40053.599464006154, 40602.9849253771, 40793.368265269055, 41590.0, 40046.798596042165, 52251.73874130605, 53104.46895530995, 53146.468535314154, 53849.0, 14588.34352454121, 15417.306221219847, 16041.759373609639, 16249.0, 16363.754543682093, 18159.18283677264, 18353.990530520416, 18404.35584754527, 18500.629987400447, 18523.629527409106, 13702.86297137016, 16283.104429256504, 16565.00609963406, 16721.832781672027, 16771.0, 16331.510054698378, 16396.508104756875, 16479.91760041192, 16515.33938642441, 16715.080670563235, 16067.839321607102, 16069.0, 16095.919520402324, 16293.185340733153, 16368.345266189219, 11796.76406471883, 11984.700382490508, 12065.0, 12180.817287740869, 12232.938835305766, 12335.766423357592, 12568.120231583702, 12643.0, 12888.291143987171, 12900.225986440844], "value": 8350.107728994362, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1445.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 111.0, 112.0, 113.0, 111.0, 111.0, 112.0, 112.0, 111.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 109.0, 109.0, 150.0, 114.0, 93.0, 123.0, 143.0, 158.0, 119.0], "value": 125.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 185.0, 184.0, 184.0, 185.0, 183.0, 184.0, 182.0, 184.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 59.0, 99.0, 52.0, 59.0, 50.0, 75.0, 89.0, 84.0], "value": 70.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 70.0, 87.0, 70.0, 69.0, 69.0, 90.0, 70.0, 68.0, 91.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 86.0, 87.0, 86.0, 85.0, 87.0, 87.0, 86.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 124.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 93.0], "value": 102.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 83.0, 89.0, 134.0, 126.0, 85.0, 84.0, 82.0], "value": 93.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 47.0, 50.0, 47.0, 47.0, 48.0, 50.0, 48.0, 49.0, 49.0], "value": 48.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 65.0, 53.0, 54.0, 61.0, 63.0, 58.0, 57.0, 58.0, 58.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 81.0, 86.0, 84.0, 84.0, 81.0, 81.0, 85.0, 104.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 132.0, 116.0, 141.0, 145.0, 153.0, 151.0, 136.0, 178.0, 148.0], "value": 144.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 178.0, 184.0, 186.0, 189.0, 226.0, 202.0, 183.0, 182.0, 184.0], "value": 190.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 68.0, 68.0, 66.0, 68.0, 69.0, 68.0, 67.0, 66.0], "value": 67.7, "unit": "score"}]}]} 16:54:31 INFO - Return code: 0 16:54:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:54:31 ERROR - # TBPL SUCCESS # 16:54:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:54:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:54:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:54:31 INFO - 2017-04-14 16:54:31.928 screenresolution[1656:9944] starting screenresolution argv=screenresolution get 16:54:31 INFO - 2017-04-14 16:54:31.930 screenresolution[1656:9944] Display 0: 1600x1200x32@60 16:54:31 INFO - 2017-04-14 16:54:31.936 screenresolution[1657:9947] starting screenresolution argv=screenresolution list 16:54:31 INFO - Available Modes on Display 0 16:54:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:54:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:54:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:54:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:54:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:54:32 INFO - Intel Iris: 16:54:32 INFO - Chipset Model: Intel Iris 16:54:32 INFO - Type: GPU 16:54:32 INFO - Bus: Built-In 16:54:32 INFO - VRAM (Dynamic, Max): 1536 MB 16:54:32 INFO - Vendor: Intel (0x8086) 16:54:32 INFO - Device ID: 0x0a2e 16:54:32 INFO - Revision ID: 0x0009 16:54:32 INFO - Displays: 16:54:32 INFO - Display: 16:54:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:54:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:54:32 INFO - Display Serial Number: 1600x1200 60 16:54:32 INFO - Main Display: Yes 16:54:32 INFO - Mirror: Off 16:54:32 INFO - Online: Yes 16:54:32 INFO - Rotation: Supported 16:54:32 INFO - Return code: 0 16:54:32 INFO - Running post-action listener: _resource_record_post_action 16:54:32 INFO - [mozharness: 2017-04-14 23:54:32.172337Z] Finished run-tests step (success) 16:54:32 INFO - Running post-run listener: _resource_record_post_run 16:54:32 INFO - Total resource usage - Wall time: 1201s; CPU: 53.0%; Read bytes: 38405632; Write bytes: 514974720; Read time: 246; Write time: 1569 16:54:32 INFO - TinderboxPrint: CPU usage
53.3% 16:54:32 INFO - TinderboxPrint: I/O read bytes / time
38,405,632 / 246 16:54:32 INFO - TinderboxPrint: I/O write bytes / time
514,974,720 / 1,569 16:54:32 INFO - TinderboxPrint: CPU idle
2,245.4 (46.7%) 16:54:32 INFO - TinderboxPrint: CPU system
955.4 (19.9%) 16:54:32 INFO - TinderboxPrint: CPU user
1,605.0 (33.4%) 16:54:32 INFO - TinderboxPrint: Swap in / out
246,083,584 / 0 16:54:32 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 194595328; Write bytes: 194885632; Read time: 15092; Write time: 403 16:54:32 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 37443072; Write bytes: 303246336; Read time: 233; Write time: 1116 16:54:32 INFO - Running post-run listener: _upload_blobber_files 16:54:32 INFO - Blob upload gear active. 16:54:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:54:32 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 16:54:32 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'] 16:54:32 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 16:54:33 INFO - (blobuploader) - INFO - Open directory for files ... 16:54:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:54:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:54:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:54:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:54:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:54:33 INFO - (blobuploader) - INFO - Done attempting. 16:54:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:54:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:54:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:54:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:54:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:54:34 INFO - (blobuploader) - INFO - Done attempting. 16:54:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:54:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:54:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:54:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:54:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:54:35 INFO - (blobuploader) - INFO - Done attempting. 16:54:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:54:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:54:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:54:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:54:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:54:38 INFO - (blobuploader) - INFO - Done attempting. 16:54:38 INFO - (blobuploader) - INFO - Iteration through files over. 16:54:38 INFO - Return code: 0 16:54:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:54:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:54:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a46b20be9fdb77499850ff5c7d3f749bb81b61c799c0bf36fa99a63aab938e5eaea45d4eeccfb7078cfd604ec55bd5ca9c949f06b2b16259cb2e51702aae830", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52a6763dc17ecacb67be2e5bdebab00c23eeed84b56e16f8176942a325f8d74af5895e822b5a1f7d51eb36ebdc1139287e0dc9300f3571638cbf5b91e637c889", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e7fa6c69f3ba4d0ea1d5ca0f0101c4828020e81166699aed210f13d16363df840d37ef1fabe97b9fb52a80c72f21868c2fec96ad376b65569b69677523e17ca", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8dcfd54f472f21f757da46a73287e6a3c70850734925d5af30efe4fb7bbe51c2ba43306483a2f6d5726d1b4c0e87b4825c2b4e4ae1cd689fbec69f927950f407"} 16:54:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:54:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:54:38 INFO - Contents: 16:54:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a46b20be9fdb77499850ff5c7d3f749bb81b61c799c0bf36fa99a63aab938e5eaea45d4eeccfb7078cfd604ec55bd5ca9c949f06b2b16259cb2e51702aae830", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52a6763dc17ecacb67be2e5bdebab00c23eeed84b56e16f8176942a325f8d74af5895e822b5a1f7d51eb36ebdc1139287e0dc9300f3571638cbf5b91e637c889", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e7fa6c69f3ba4d0ea1d5ca0f0101c4828020e81166699aed210f13d16363df840d37ef1fabe97b9fb52a80c72f21868c2fec96ad376b65569b69677523e17ca", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8dcfd54f472f21f757da46a73287e6a3c70850734925d5af30efe4fb7bbe51c2ba43306483a2f6d5726d1b4c0e87b4825c2b4e4ae1cd689fbec69f927950f407"} 16:54:38 INFO - Running post-run listener: copy_logs_to_upload_dir 16:54:38 INFO - Copying logs to upload dir... 16:54:38 INFO - mkdir: /builds/slave/test/build/upload/logs 16:54:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.233263 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-14 16:54:38.150271) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-14 16:54:38.154030) ========= 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.uxfy5xJwoI/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.IPJpNAvYND/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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/0a46b20be9fdb77499850ff5c7d3f749bb81b61c799c0bf36fa99a63aab938e5eaea45d4eeccfb7078cfd604ec55bd5ca9c949f06b2b16259cb2e51702aae830", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52a6763dc17ecacb67be2e5bdebab00c23eeed84b56e16f8176942a325f8d74af5895e822b5a1f7d51eb36ebdc1139287e0dc9300f3571638cbf5b91e637c889", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e7fa6c69f3ba4d0ea1d5ca0f0101c4828020e81166699aed210f13d16363df840d37ef1fabe97b9fb52a80c72f21868c2fec96ad376b65569b69677523e17ca", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8dcfd54f472f21f757da46a73287e6a3c70850734925d5af30efe4fb7bbe51c2ba43306483a2f6d5726d1b4c0e87b4825c2b4e4ae1cd689fbec69f927950f407"} build_url:https://queue.taskcluster.net/v1/task/IwQgw9s6RNqyAVuzPGZaJw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010522 build_url: 'https://queue.taskcluster.net/v1/task/IwQgw9s6RNqyAVuzPGZaJw/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/0a46b20be9fdb77499850ff5c7d3f749bb81b61c799c0bf36fa99a63aab938e5eaea45d4eeccfb7078cfd604ec55bd5ca9c949f06b2b16259cb2e51702aae830", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52a6763dc17ecacb67be2e5bdebab00c23eeed84b56e16f8176942a325f8d74af5895e822b5a1f7d51eb36ebdc1139287e0dc9300f3571638cbf5b91e637c889", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e7fa6c69f3ba4d0ea1d5ca0f0101c4828020e81166699aed210f13d16363df840d37ef1fabe97b9fb52a80c72f21868c2fec96ad376b65569b69677523e17ca", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8dcfd54f472f21f757da46a73287e6a3c70850734925d5af30efe4fb7bbe51c2ba43306483a2f6d5726d1b4c0e87b4825c2b4e4ae1cd689fbec69f927950f407"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-14 16:54:38.187321) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 16:54:38.187696) ========= 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.uxfy5xJwoI/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.IPJpNAvYND/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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.005308 ========= master_lag: 0.36 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 16:54:38.549696) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-14 16:54:38.550006) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-14 16:54:38.550373) ========= ========= Total master_lag: 0.50 =========