builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0361 starttime: 1480547192.55 results: success (0) buildid: 20161130125344 builduid: ef5ab7fcfcfe4e8b836d8c561d6c9051 revision: 8f1e420699832d42753c6503aa31861be6f5b186 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 15:06:32.549815) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 15:06:32.550255) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 15:06:32.550548) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 15:06:32.580596) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 15:06:32.580971) ========= 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.4tHBJSOUSP/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.uwyjd0Qh2Y/Listeners TMPDIR=/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/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 --2016-11-30 15:06:32-- 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% 19.2M=0.001s 2016-11-30 15:06:32 (19.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.280618 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 15:06:32.888220) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 15:06:32.888543) ========= 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.4tHBJSOUSP/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.uwyjd0Qh2Y/Listeners TMPDIR=/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/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.026677 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 15:06:32.936845) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-30 15:06:32.937206) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8f1e420699832d42753c6503aa31861be6f5b186 --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 8f1e420699832d42753c6503aa31861be6f5b186 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4tHBJSOUSP/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.uwyjd0Qh2Y/Listeners TMPDIR=/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/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 2016-11-30 15:06:33,044 truncating revision to first 12 chars 2016-11-30 15:06:33,044 Setting DEBUG logging. 2016-11-30 15:06:33,044 attempt 1/10 2016-11-30 15:06:33,044 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8f1e42069983?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-30 15:06:34,923 unpacking tar archive at: mozilla-central-8f1e42069983/testing/mozharness/ program finished with exit code 0 elapsedTime=2.153247 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-30 15:06:35.116515) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 15:06:35.116834) ========= script_repo_revision: 8f1e420699832d42753c6503aa31861be6f5b186 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 15:06:35.117226) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 15:06:35.117490) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 15:06:35.141405) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-11-30 15:06:35.141789) ========= /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.4tHBJSOUSP/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.uwyjd0Qh2Y/Listeners TMPDIR=/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/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 15:06:35 INFO - MultiFileLogger online at 20161130 15:06:35 in /builds/slave/test 15:06:35 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 15:06:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:06:35 INFO - {'append_to_log': False, 15:06:35 INFO - 'base_work_dir': '/builds/slave/test', 15:06:35 INFO - 'blob_upload_branch': 'Firefox', 15:06:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:06:35 INFO - 'branch': 'Firefox', 15:06:35 INFO - 'buildbot_json_path': 'buildprops.json', 15:06:35 INFO - 'config_files': ('talos/mac_config.py',), 15:06:35 INFO - 'default_actions': ('clobber', 15:06:35 INFO - 'read-buildbot-config', 15:06:35 INFO - 'download-and-extract', 15:06:35 INFO - 'populate-webroot', 15:06:35 INFO - 'create-virtualenv', 15:06:35 INFO - 'install', 15:06:35 INFO - 'run-tests'), 15:06:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:06:35 INFO - 'download_minidump_stackwalk': True, 15:06:35 INFO - 'download_symbols': 'ondemand', 15:06:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:06:35 INFO - 'tooltool.py': '/tools/tooltool.py', 15:06:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:06:35 INFO - '/tools/misc-python/virtualenv.py')}, 15:06:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:06:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:06:35 INFO - 'installer_path': 'installer.exe', 15:06:35 INFO - 'log_level': 'info', 15:06:35 INFO - 'log_name': 'talos', 15:06:35 INFO - 'log_to_console': True, 15:06:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:06:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:06:35 INFO - 'opt_config_files': (), 15:06:35 INFO - 'pip_index': False, 15:06:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:06:35 INFO - 'cmd': ('bash', 15:06:35 INFO - '-c', 15:06:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:06:35 INFO - 'enabled': True, 15:06:35 INFO - 'halt_on_failure': False, 15:06:35 INFO - 'name': 'check_screen_resolution'},), 15:06:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:06:35 INFO - 'cmd': ('bash', 15:06:35 INFO - '-c', 15:06:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:06:35 INFO - 'enabled': True, 15:06:35 INFO - 'halt_on_failure': False, 15:06:35 INFO - 'name': 'check_screen_resolution'},), 15:06:35 INFO - 'run_cmd_checks_enabled': True, 15:06:35 INFO - 'sps_profile': False, 15:06:35 INFO - 'sps_profile_interval': 0, 15:06:35 INFO - 'suite': 'dromaeojs', 15:06:35 INFO - 'system_bits': '32', 15:06:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:06:35 INFO - 'title': 't-yosemite-r7-0361', 15:06:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:06:35 INFO - 'use_talos_json': True, 15:06:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:06:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:06:35 INFO - 'work_dir': 'build'} 15:06:35 INFO - [mozharness: 2016-11-30 23:06:35.353360Z] Running clobber step. 15:06:35 INFO - Running pre-action listener: _resource_record_pre_action 15:06:35 INFO - Running main action method: clobber 15:06:35 INFO - rmtree: /builds/slave/test/build 15:06:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:06:37 INFO - Running post-action listener: _resource_record_post_action 15:06:37 INFO - [mozharness: 2016-11-30 23:06:37.526636Z] Finished clobber step (success) 15:06:37 INFO - [mozharness: 2016-11-30 23:06:37.526763Z] Running read-buildbot-config step. 15:06:37 INFO - Running pre-action listener: _resource_record_pre_action 15:06:37 INFO - Running main action method: read_buildbot_config 15:06:37 INFO - Using buildbot properties: 15:06:37 INFO - { 15:06:37 INFO - "project": "", 15:06:37 INFO - "product": "firefox", 15:06:37 INFO - "script_repo_revision": "production", 15:06:37 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 15:06:37 INFO - "repository": "", 15:06:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 15:06:37 INFO - "buildid": "20161130125344", 15:06:37 INFO - "pgo_build": "False", 15:06:37 INFO - "basedir": "/builds/slave/test", 15:06:37 INFO - "buildnumber": 27, 15:06:37 INFO - "slavename": "t-yosemite-r7-0361", 15:06:37 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 15:06:37 INFO - "platform": "yosemite_r7", 15:06:37 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:06:37 INFO - "branch": "mozilla-central", 15:06:37 INFO - "repo_path": "mozilla-central", 15:06:37 INFO - "revision": "8f1e420699832d42753c6503aa31861be6f5b186", 15:06:37 INFO - "stage_platform": "macosx64", 15:06:37 INFO - "builduid": "ef5ab7fcfcfe4e8b836d8c561d6c9051", 15:06:37 INFO - "slavebuilddir": "test" 15:06:37 INFO - } 15:06:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 15:06:37 INFO - Running post-action listener: _resource_record_post_action 15:06:37 INFO - [mozharness: 2016-11-30 23:06:37.529982Z] Finished read-buildbot-config step (success) 15:06:37 INFO - [mozharness: 2016-11-30 23:06:37.530104Z] Running download-and-extract step. 15:06:37 INFO - Running pre-action listener: _resource_record_pre_action 15:06:37 INFO - Running main action method: download_and_extract 15:06:37 INFO - mkdir: /builds/slave/test/build/tests 15:06:37 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')]} 15:06:37 INFO - trying https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 15:06:37 INFO - Downloading https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 15:06:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 15:06:38 INFO - Downloaded 1199 bytes. 15:06:38 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 15:06:38 INFO - Using the following test package requirements: 15:06:38 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 15:06:38 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:06:38 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 15:06:38 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:06:38 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 15:06:38 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:06:38 INFO - u'jsshell-mac.zip'], 15:06:38 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:06:38 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 15:06:38 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 15:06:38 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:06:38 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 15:06:38 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:06:38 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 15:06:38 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:06:38 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 15:06:38 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:06:38 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 15:06:38 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:06:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 15:06:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:06:38 INFO - Fetch https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 15:06:39 INFO - Expected file size: 16275427 15:06:39 INFO - Obtained file size: 16275427 15:06:46 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:06:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 15:06:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:06:46 INFO - Fetch https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 15:06:47 INFO - Expected file size: 16275427 15:06:47 INFO - Obtained file size: 16275427 15:06:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 15:06:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:06:53 INFO - Fetch https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 15:06:54 INFO - Expected file size: 14409702 15:06:54 INFO - Obtained file size: 14409702 15:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:06:54 INFO - trying https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 15:06:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 15:06:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 15:06:57 INFO - Downloaded 107597768 bytes. 15:06:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 15:06:57 INFO - mkdir: /builds/slave/test/properties 15:06:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:06:57 INFO - Writing to file /builds/slave/test/properties/build_url 15:06:57 INFO - Contents: 15:06:57 INFO - build_url:https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 15:06:58 INFO - Running post-action listener: _resource_record_post_action 15:06:58 INFO - Running post-action listener: set_extra_try_arguments 15:06:58 INFO - [mozharness: 2016-11-30 23:06:58.333045Z] Finished download-and-extract step (success) 15:06:58 INFO - [mozharness: 2016-11-30 23:06:58.333169Z] Running populate-webroot step. 15:06:58 INFO - Running pre-action listener: _resource_record_pre_action 15:06:58 INFO - Running main action method: populate_webroot 15:06:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:06:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:06:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:06:58 INFO - '--tppagecycles', 15:06:58 INFO - '7'], 15:06:58 INFO - 'tests': ['tsvgm']}}, 15:06:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:06:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:06:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:06:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:06:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:06:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:06:58 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:06:58 INFO - 'talos_options': ['--disable-e10s'], 15:06:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:06:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:06:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:06:58 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:06:58 INFO - 'talos_options': ['--disable-e10s'], 15:06:58 INFO - 'tests': ['damp', 'tps']}, 15:06:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:06:58 INFO - 'tests': ['damp', 'tps']}, 15:06:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:06:58 INFO - 'tests': ['dromaeo_dom']}, 15:06:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:06:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:06:58 INFO - 'tests': ['basic_compositor_video']}, 15:06:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:06:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:06:58 INFO - 'tests': ['a11yr', 15:06:58 INFO - 'ts_paint', 15:06:58 INFO - 'tpaint', 15:06:58 INFO - 'sessionrestore', 15:06:58 INFO - 'sessionrestore_no_auto_restore', 15:06:58 INFO - 'tabpaint']}, 15:06:58 INFO - 'other-e10s': {'tests': ['a11yr', 15:06:58 INFO - 'ts_paint', 15:06:58 INFO - 'tpaint', 15:06:58 INFO - 'sessionrestore', 15:06:58 INFO - 'sessionrestore_no_auto_restore', 15:06:58 INFO - 'tabpaint']}, 15:06:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:06:58 INFO - 'ts_paint', 15:06:58 INFO - 'tpaint', 15:06:58 INFO - 'sessionrestore', 15:06:58 INFO - 'sessionrestore_no_auto_restore', 15:06:58 INFO - 'tabpaint']}, 15:06:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:06:58 INFO - 'ts_paint', 15:06:58 INFO - 'tpaint', 15:06:58 INFO - 'sessionrestore', 15:06:58 INFO - 'sessionrestore_no_auto_restore', 15:06:58 INFO - 'tabpaint']}, 15:06:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:06:58 INFO - 'tests': ['a11yr', 15:06:58 INFO - 'ts_paint', 15:06:58 INFO - 'tpaint', 15:06:58 INFO - 'sessionrestore', 15:06:58 INFO - 'sessionrestore_no_auto_restore', 15:06:58 INFO - 'tabpaint']}, 15:06:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:06:58 INFO - 'tests': ['a11yr', 15:06:58 INFO - 'ts_paint', 15:06:58 INFO - 'tpaint', 15:06:58 INFO - 'sessionrestore', 15:06:58 INFO - 'sessionrestore_no_auto_restore', 15:06:58 INFO - 'tabpaint']}, 15:06:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:06:58 INFO - 'tests': ['tsvgx', 15:06:58 INFO - 'tsvgr_opacity', 15:06:58 INFO - 'tart', 15:06:58 INFO - 'tscrollx', 15:06:58 INFO - 'cart', 15:06:58 INFO - 'tsvg_static']}, 15:06:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:06:58 INFO - 'tsvgr_opacity', 15:06:58 INFO - 'tart', 15:06:58 INFO - 'tscrollx', 15:06:58 INFO - 'cart', 15:06:58 INFO - 'tsvg_static']}, 15:06:58 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:06:58 INFO - 'talos_options': ['--disable-e10s'], 15:06:58 INFO - 'tests': ['tp5o']}, 15:06:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:06:58 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:06:58 INFO - 'talos_options': ['--disable-e10s', 15:06:58 INFO - '--xperf_path', 15:06:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:06:58 INFO - 'tests': ['tp5n']}, 15:06:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:06:58 INFO - 'talos_options': ['--xperf_path', 15:06:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:06:58 INFO - 'tests': ['tp5n']}}, 15:06:58 INFO - 'talos.zip': {'path': '', 15:06:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:06:58 INFO - Running post-action listener: _resource_record_post_action 15:06:58 INFO - [mozharness: 2016-11-30 23:06:58.351610Z] Finished populate-webroot step (success) 15:06:58 INFO - [mozharness: 2016-11-30 23:06:58.351747Z] Running create-virtualenv step. 15:06:58 INFO - Running pre-action listener: _resource_record_pre_action 15:06:58 INFO - Running main action method: create_virtualenv 15:06:58 INFO - Creating virtualenv /builds/slave/test/build/venv 15:06:58 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 15:06:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:06:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:06:58 INFO - Using real prefix '/tools/python27' 15:06:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:06:59 INFO - Installing distribute.............................................................................................................................................................................................done. 15:07:02 INFO - Installing pip.................done. 15:07:02 INFO - Return code: 0 15:07:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:07:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:07:02 INFO - Reading from file tmpfile_stdout 15:07:02 INFO - Output received: 15:07:02 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) 15:07:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:07:02 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')]} 15:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:02 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')]} 15:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1104a03f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110416570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd33a48f800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102b6d30>, '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 0x11011ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102aeb20>, '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.4tHBJSOUSP/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.uwyjd0Qh2Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/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 15:07:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:07:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:07:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4tHBJSOUSP/Render', 15:07:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:07:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:07:02 INFO - 'HOME': '/Users/cltbld', 15:07:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:07:02 INFO - 'LOGNAME': 'cltbld', 15:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:02 INFO - 'MOZ_NO_REMOTE': '1', 15:07:02 INFO - 'NO_EM_RESTART': '1', 15:07:02 INFO - 'PAGER': '/bin/cat', 15:07:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:02 INFO - 'PWD': '/builds/slave/test', 15:07:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:07:02 INFO - 'SHELL': '/bin/bash', 15:07:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uwyjd0Qh2Y/Listeners', 15:07:02 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 15:07:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:07:02 INFO - 'USER': 'cltbld', 15:07:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:07:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:02 INFO - 'XPC_FLAGS': '0x0', 15:07:02 INFO - 'XPC_SERVICE_NAME': '0', 15:07:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:07:02 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 15:07:02 INFO - Cleaning up... 15:07:02 INFO - Return code: 0 15:07:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:07:02 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')]} 15:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:02 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')]} 15:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1104a03f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110416570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd33a48f800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102b6d30>, '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 0x11011ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102aeb20>, '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.4tHBJSOUSP/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.uwyjd0Qh2Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/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 15:07:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:07:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:07:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4tHBJSOUSP/Render', 15:07:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:07:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:07:02 INFO - 'HOME': '/Users/cltbld', 15:07:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:07:02 INFO - 'LOGNAME': 'cltbld', 15:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:02 INFO - 'MOZ_NO_REMOTE': '1', 15:07:02 INFO - 'NO_EM_RESTART': '1', 15:07:02 INFO - 'PAGER': '/bin/cat', 15:07:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:02 INFO - 'PWD': '/builds/slave/test', 15:07:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:07:02 INFO - 'SHELL': '/bin/bash', 15:07:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uwyjd0Qh2Y/Listeners', 15:07:02 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 15:07:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:07:02 INFO - 'USER': 'cltbld', 15:07:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:07:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:02 INFO - 'XPC_FLAGS': '0x0', 15:07:02 INFO - 'XPC_SERVICE_NAME': '0', 15:07:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:07:02 INFO - Downloading/unpacking psutil>=3.1.1 15:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:07:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:07:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:07:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:07:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:07:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:07:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:07:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:07:06 INFO - Installing collected packages: psutil 15:07:06 INFO - Running setup.py install for psutil 15:07:06 INFO - building 'psutil._psutil_osx' extension 15:07:06 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 15:07:06 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 15:07:07 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 15:07:07 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 15:07:07 INFO - building 'psutil._psutil_posix' extension 15:07:07 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 15:07:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:07:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:07:07 INFO - ^ 15:07:07 INFO - 1 warning generated. 15:07:07 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 15:07:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:07:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:07:07 INFO - Successfully installed psutil 15:07:07 INFO - Cleaning up... 15:07:07 INFO - Return code: 0 15:07:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:07:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1104a03f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110416570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd33a48f800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102b6d30>, '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 0x11011ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102aeb20>, '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.4tHBJSOUSP/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.uwyjd0Qh2Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/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 15:07:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:07:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4tHBJSOUSP/Render', 15:07:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:07:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:07:07 INFO - 'HOME': '/Users/cltbld', 15:07:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:07:07 INFO - 'LOGNAME': 'cltbld', 15:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:07 INFO - 'MOZ_NO_REMOTE': '1', 15:07:07 INFO - 'NO_EM_RESTART': '1', 15:07:07 INFO - 'PAGER': '/bin/cat', 15:07:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:07 INFO - 'PWD': '/builds/slave/test', 15:07:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:07:07 INFO - 'SHELL': '/bin/bash', 15:07:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uwyjd0Qh2Y/Listeners', 15:07:07 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 15:07:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:07:07 INFO - 'USER': 'cltbld', 15:07:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:07:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:07 INFO - 'XPC_FLAGS': '0x0', 15:07:07 INFO - 'XPC_SERVICE_NAME': '0', 15:07:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:07:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:07:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:07:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:07:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:07:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:07:10 INFO - Installing collected packages: mozsystemmonitor 15:07:10 INFO - Running setup.py install for mozsystemmonitor 15:07:10 INFO - Successfully installed mozsystemmonitor 15:07:10 INFO - Cleaning up... 15:07:10 INFO - Return code: 0 15:07:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:07:10 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')]} 15:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:10 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')]} 15:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:10 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 0x1104a03f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110416570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd33a48f800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102b6d30>, '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 0x11011ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102aeb20>, '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.4tHBJSOUSP/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.uwyjd0Qh2Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/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 15:07:10 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 15:07:10 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 15:07:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4tHBJSOUSP/Render', 15:07:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:07:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:07:10 INFO - 'HOME': '/Users/cltbld', 15:07:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:07:10 INFO - 'LOGNAME': 'cltbld', 15:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:10 INFO - 'MOZ_NO_REMOTE': '1', 15:07:10 INFO - 'NO_EM_RESTART': '1', 15:07:10 INFO - 'PAGER': '/bin/cat', 15:07:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:10 INFO - 'PWD': '/builds/slave/test', 15:07:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:07:10 INFO - 'SHELL': '/bin/bash', 15:07:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uwyjd0Qh2Y/Listeners', 15:07:10 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 15:07:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:07:10 INFO - 'USER': 'cltbld', 15:07:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:07:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:10 INFO - 'XPC_FLAGS': '0x0', 15:07:10 INFO - 'XPC_SERVICE_NAME': '0', 15:07:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:07:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:07:10 INFO - Downloading/unpacking jsonschema==2.5.1 15:07: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 15:07: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 15:07: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 15:07: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 15:07: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 15:07: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 15:07:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:07:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:07: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 15:07: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 15:07: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 15:07: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 15:07: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 15:07: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 15:07:13 INFO - Downloading functools32-3.2.3-2.tar.gz 15:07:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:07:14 INFO - warning: no files found matching '*.txt' 15:07:14 INFO - no previously-included directories found matching 'build' 15:07:14 INFO - no previously-included directories found matching 'dist' 15:07:14 INFO - no previously-included directories found matching '.git*' 15:07:14 INFO - Installing collected packages: jsonschema, functools32 15:07:14 INFO - Running setup.py install for functools32 15:07:14 INFO - warning: no files found matching '*.txt' 15:07:14 INFO - no previously-included directories found matching 'build' 15:07:14 INFO - no previously-included directories found matching 'dist' 15:07:14 INFO - no previously-included directories found matching '.git*' 15:07:14 INFO - Successfully installed jsonschema functools32 15:07:14 INFO - Cleaning up... 15:07:14 INFO - Return code: 0 15:07:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:07: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')]} 15:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07: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')]} 15:07:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07: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 0x1104a03f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110416570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd33a48f800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102b6d30>, '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 0x11011ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102aeb20>, '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.4tHBJSOUSP/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.uwyjd0Qh2Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/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 15:07: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 15:07: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 15:07:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4tHBJSOUSP/Render', 15:07:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:07:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:07:14 INFO - 'HOME': '/Users/cltbld', 15:07:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:07:14 INFO - 'LOGNAME': 'cltbld', 15:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:14 INFO - 'MOZ_NO_REMOTE': '1', 15:07:14 INFO - 'NO_EM_RESTART': '1', 15:07:14 INFO - 'PAGER': '/bin/cat', 15:07:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:14 INFO - 'PWD': '/builds/slave/test', 15:07:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:07:14 INFO - 'SHELL': '/bin/bash', 15:07:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uwyjd0Qh2Y/Listeners', 15:07:14 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 15:07:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:07:14 INFO - 'USER': 'cltbld', 15:07:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:07:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:14 INFO - 'XPC_FLAGS': '0x0', 15:07:14 INFO - 'XPC_SERVICE_NAME': '0', 15:07:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:07:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:07:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:07:14 INFO - Cleaning up... 15:07:14 INFO - Return code: 0 15:07:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:07: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')]} 15:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07: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')]} 15:07:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07: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 0x1104a03f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110416570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd33a48f800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102b6d30>, '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 0x11011ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102aeb20>, '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.4tHBJSOUSP/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.uwyjd0Qh2Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/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 15:07: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 15:07: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 15:07:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4tHBJSOUSP/Render', 15:07:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:07:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:07:14 INFO - 'HOME': '/Users/cltbld', 15:07:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:07:14 INFO - 'LOGNAME': 'cltbld', 15:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:14 INFO - 'MOZ_NO_REMOTE': '1', 15:07:14 INFO - 'NO_EM_RESTART': '1', 15:07:14 INFO - 'PAGER': '/bin/cat', 15:07:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:14 INFO - 'PWD': '/builds/slave/test', 15:07:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:07:14 INFO - 'SHELL': '/bin/bash', 15:07:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uwyjd0Qh2Y/Listeners', 15:07:14 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 15:07:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:07:14 INFO - 'USER': 'cltbld', 15:07:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:07:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:14 INFO - 'XPC_FLAGS': '0x0', 15:07:14 INFO - 'XPC_SERVICE_NAME': '0', 15:07:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:07:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:07:14 INFO - Downloading/unpacking blobuploader==1.2.4 15:07: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 15:07: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 15:07: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 15:07: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 15:07: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 15:07: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 15:07:17 INFO - Downloading blobuploader-1.2.4.tar.gz 15:07:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:07:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:07: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 15:07: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 15:07: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 15:07: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 15:07: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 15:07: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 15:07:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:07:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:07:18 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 15:07:18 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 15:07:18 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 15:07:18 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 15:07:18 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 15:07:18 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 15:07:18 INFO - Downloading docopt-0.6.1.tar.gz 15:07:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:07:18 INFO - Installing collected packages: blobuploader, requests, docopt 15:07:18 INFO - Running setup.py install for blobuploader 15:07:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:07:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:07:18 INFO - Running setup.py install for requests 15:07:19 INFO - Running setup.py install for docopt 15:07:19 INFO - Successfully installed blobuploader requests docopt 15:07:19 INFO - Cleaning up... 15:07:19 INFO - Return code: 0 15:07:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:07: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')]} 15:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07: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')]} 15:07:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07: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 0x1104a03f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110416570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd33a48f800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102b6d30>, '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 0x11011ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102aeb20>, '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.4tHBJSOUSP/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.uwyjd0Qh2Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/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 15:07: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 15:07: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 15:07:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4tHBJSOUSP/Render', 15:07:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:07:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:07:19 INFO - 'HOME': '/Users/cltbld', 15:07:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:07:19 INFO - 'LOGNAME': 'cltbld', 15:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:19 INFO - 'MOZ_NO_REMOTE': '1', 15:07:19 INFO - 'NO_EM_RESTART': '1', 15:07:19 INFO - 'PAGER': '/bin/cat', 15:07:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:19 INFO - 'PWD': '/builds/slave/test', 15:07:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:07:19 INFO - 'SHELL': '/bin/bash', 15:07:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uwyjd0Qh2Y/Listeners', 15:07:19 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 15:07:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:07:19 INFO - 'USER': 'cltbld', 15:07:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:07:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:19 INFO - 'XPC_FLAGS': '0x0', 15:07:19 INFO - 'XPC_SERVICE_NAME': '0', 15:07:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:07:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:07:19 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-VGLPjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:07:20 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-uYw2if-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:07:20 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-PCSWFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:07:20 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-iA_mHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:07:20 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-5mZ_X4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:07:20 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-nYQ3Tj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:07:20 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-BYz5Sj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:07:20 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-2KiUmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:07:20 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-X7aO1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:07:20 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-zPbmq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:07:20 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-z8qdQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:07:21 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-ar5MG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:07:21 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-vr4P6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:07:21 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-6_tqo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:07:21 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-3nLwDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:07:21 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-Xf2RAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:07:21 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-RvSjYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:07:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:07:21 INFO - Running setup.py install for manifestparser 15:07:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:07:21 INFO - Running setup.py install for mozcrash 15:07:21 INFO - Running setup.py install for mozdebug 15:07:22 INFO - Running setup.py install for mozdevice 15:07:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:07:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:07:22 INFO - Running setup.py install for mozfile 15:07:22 INFO - Running setup.py install for mozhttpd 15:07:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:07:22 INFO - Running setup.py install for mozinfo 15:07:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:07:22 INFO - Running setup.py install for mozInstall 15:07:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:07:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:07:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:07:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:07:22 INFO - Running setup.py install for mozleak 15:07:22 INFO - Running setup.py install for mozlog 15:07:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:07:23 INFO - Running setup.py install for moznetwork 15:07:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:07:23 INFO - Running setup.py install for mozprocess 15:07:23 INFO - Running setup.py install for mozprofile 15:07:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:07:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:07:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:07:23 INFO - Running setup.py install for mozrunner 15:07:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:07:23 INFO - Running setup.py install for mozscreenshot 15:07:23 INFO - Running setup.py install for moztest 15:07:24 INFO - Running setup.py install for mozversion 15:07:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:07:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:07:24 INFO - Cleaning up... 15:07:24 INFO - Return code: 0 15:07:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:07:24 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')]} 15:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:24 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')]} 15:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:24 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 0x1104a03f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110416570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd33a48f800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102b6d30>, '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 0x11011ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102aeb20>, '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.4tHBJSOUSP/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.uwyjd0Qh2Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/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 15:07:24 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 15:07:24 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 15:07:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4tHBJSOUSP/Render', 15:07:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:07:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:07:24 INFO - 'HOME': '/Users/cltbld', 15:07:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:07:24 INFO - 'LOGNAME': 'cltbld', 15:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:24 INFO - 'MOZ_NO_REMOTE': '1', 15:07:24 INFO - 'NO_EM_RESTART': '1', 15:07:24 INFO - 'PAGER': '/bin/cat', 15:07:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:24 INFO - 'PWD': '/builds/slave/test', 15:07:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:07:24 INFO - 'SHELL': '/bin/bash', 15:07:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uwyjd0Qh2Y/Listeners', 15:07:24 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 15:07:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:07:24 INFO - 'USER': 'cltbld', 15:07:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:07:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:24 INFO - 'XPC_FLAGS': '0x0', 15:07:24 INFO - 'XPC_SERVICE_NAME': '0', 15:07:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:07:24 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-LKZV3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:07: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)) 15:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:07:24 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-I18_7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:07: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)) 15:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:07:24 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-D5XA6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:07: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)) 15:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:07:24 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-Ly5naF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:07:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:07:24 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-Kcxyze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:07:25 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)) 15:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:07:25 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-frYlKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:07:25 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)) 15:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:07:25 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-RCzp1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:07:25 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)) 15:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:07:25 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-E0ufkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:07: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)) 15:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:07:25 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-GJRgPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:07: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)) 15:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:07:25 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-K4OJYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:07: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)) 15:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:07:25 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-ABiXPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:07: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)) 15:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:07:25 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-Z0kjxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 15:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:07:25 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-br57yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:07: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)) 15:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:07:25 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-mth3ne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:07: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)) 15:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:07:25 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-1zuX24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:07:26 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)) 15:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:07:26 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-QFhS7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 15:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:07:26 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-aJGQ8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:07:26 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)) 15:07:26 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)) 15:07:26 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)) 15:07:26 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)) 15:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:07:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:07:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:07:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:07:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:07:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:07:28 INFO - Downloading blessings-1.6.tar.gz 15:07:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:07:28 INFO - Installing collected packages: blessings 15:07:28 INFO - Running setup.py install for blessings 15:07:29 INFO - Successfully installed blessings 15:07:29 INFO - Cleaning up... 15:07:29 INFO - Return code: 0 15:07:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:07:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:07:29 INFO - Reading from file tmpfile_stdout 15:07:29 INFO - Current package versions: 15:07:29 INFO - blessings == 1.6 15:07:29 INFO - blobuploader == 1.2.4 15:07:29 INFO - docopt == 0.6.1 15:07:29 INFO - functools32 == 3.2.3-2 15:07:29 INFO - jsonschema == 2.5.1 15:07:29 INFO - manifestparser == 1.1 15:07:29 INFO - mozInstall == 1.12 15:07:29 INFO - mozcrash == 1.0 15:07:29 INFO - mozdebug == 0.1 15:07:29 INFO - mozdevice == 0.49 15:07:29 INFO - mozfile == 1.2 15:07:29 INFO - mozhttpd == 0.7 15:07:29 INFO - mozinfo == 0.9 15:07:29 INFO - mozleak == 0.1 15:07:29 INFO - mozlog == 3.4 15:07:29 INFO - moznetwork == 0.27 15:07:29 INFO - mozprocess == 0.23 15:07:29 INFO - mozprofile == 0.28 15:07:29 INFO - mozrunner == 6.13 15:07:29 INFO - mozscreenshot == 0.1 15:07:29 INFO - mozsystemmonitor == 0.3 15:07:29 INFO - moztest == 0.7 15:07:29 INFO - mozversion == 1.4 15:07:29 INFO - psutil == 3.1.1 15:07:29 INFO - requests == 1.2.3 15:07:29 INFO - wsgiref == 0.1.2 15:07:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:07: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')]} 15:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07: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')]} 15:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:30 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 0x1104a03f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110416570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd33a48f800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102b6d30>, '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 0x11011ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102aeb20>, '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.4tHBJSOUSP/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.uwyjd0Qh2Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/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 15:07:30 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 15:07:30 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 15:07:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4tHBJSOUSP/Render', 15:07:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:07:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:07:30 INFO - 'HOME': '/Users/cltbld', 15:07:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:07:30 INFO - 'LOGNAME': 'cltbld', 15:07:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:30 INFO - 'MOZ_NO_REMOTE': '1', 15:07:30 INFO - 'NO_EM_RESTART': '1', 15:07:30 INFO - 'PAGER': '/bin/cat', 15:07:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:07:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:30 INFO - 'PWD': '/builds/slave/test', 15:07:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:07:30 INFO - 'SHELL': '/bin/bash', 15:07:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uwyjd0Qh2Y/Listeners', 15:07:30 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 15:07:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:07:30 INFO - 'USER': 'cltbld', 15:07:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:07:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:07:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:30 INFO - 'XPC_FLAGS': '0x0', 15:07:30 INFO - 'XPC_SERVICE_NAME': '0', 15:07:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:07:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:07:30 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)) 15:07:30 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)) 15:07:30 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)) 15:07:30 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)) 15:07:30 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)) 15:07:30 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)) 15:07:30 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)) 15:07:30 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)) 15:07:30 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)) 15:07:30 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)) 15:07:30 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)) 15:07:30 INFO - Cleaning up... 15:07:30 INFO - Return code: 0 15:07:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:07:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:30 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 0x1104a03f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110416570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd33a48f800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102b6d30>, '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 0x11011ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102aeb20>, '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.4tHBJSOUSP/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.uwyjd0Qh2Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/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 15:07:30 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 15:07:30 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 15:07:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4tHBJSOUSP/Render', 15:07:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:07:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:07:30 INFO - 'HOME': '/Users/cltbld', 15:07:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:07:30 INFO - 'LOGNAME': 'cltbld', 15:07:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:30 INFO - 'MOZ_NO_REMOTE': '1', 15:07:30 INFO - 'NO_EM_RESTART': '1', 15:07:30 INFO - 'PAGER': '/bin/cat', 15:07:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:07:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:30 INFO - 'PWD': '/builds/slave/test', 15:07:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:07:30 INFO - 'SHELL': '/bin/bash', 15:07:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uwyjd0Qh2Y/Listeners', 15:07:30 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 15:07:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:07:30 INFO - 'USER': 'cltbld', 15:07:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:07:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:07:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:30 INFO - 'XPC_FLAGS': '0x0', 15:07:30 INFO - 'XPC_SERVICE_NAME': '0', 15:07:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:07:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:07:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:07:31 INFO - Cleaning up... 15:07:31 INFO - Return code: 0 15:07:31 INFO - Running post-action listener: _resource_record_post_action 15:07:31 INFO - Running post-action listener: _start_resource_monitoring 15:07:31 INFO - Starting resource monitoring. 15:07:31 INFO - [mozharness: 2016-11-30 23:07:31.134258Z] Finished create-virtualenv step (success) 15:07:31 INFO - [mozharness: 2016-11-30 23:07:31.135232Z] Running install step. 15:07:31 INFO - Running pre-action listener: _resource_record_pre_action 15:07:31 INFO - Running main action method: install 15:07:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:07:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:07:31 INFO - Reading from file tmpfile_stdout 15:07:31 INFO - Detecting whether we're running mozinstall >=1.0... 15:07:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:07:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:07:31 INFO - Reading from file tmpfile_stdout 15:07:31 INFO - Output received: 15:07:31 INFO - Usage: mozinstall [options] installer 15:07:31 INFO - Options: 15:07:31 INFO - -h, --help show this help message and exit 15:07:31 INFO - -d DEST, --destination=DEST 15:07:31 INFO - Directory to install application into. [default: 15:07:31 INFO - "/builds/slave/test"] 15:07:31 INFO - --app=APP Application being installed. [default: firefox] 15:07:31 INFO - mkdir: /builds/slave/test/build/application 15:07:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:07:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:08:04 INFO - Reading from file tmpfile_stdout 15:08:04 INFO - Output received: 15:08:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:08:04 INFO - Running post-action listener: _resource_record_post_action 15:08:04 INFO - [mozharness: 2016-11-30 23:08:04.631680Z] Finished install step (success) 15:08:04 INFO - [mozharness: 2016-11-30 23:08:04.631831Z] Running run-tests step. 15:08:04 INFO - Running pre-action listener: _resource_record_pre_action 15:08:04 INFO - Running main action method: run_tests 15:08:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:08:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:08:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:08:04 INFO - 2016-11-30 15:08:04.646 screenresolution[1624:7379] starting screenresolution argv=screenresolution get 15:08:04 INFO - 2016-11-30 15:08:04.648 screenresolution[1624:7379] Display 0: 1600x1200x32@60 15:08:04 INFO - 2016-11-30 15:08:04.654 screenresolution[1625:7381] starting screenresolution argv=screenresolution list 15:08:04 INFO - Available Modes on Display 0 15:08:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:08:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:08:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:08:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:08:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:08:04 INFO - Intel Iris: 15:08:04 INFO - Chipset Model: Intel Iris 15:08:04 INFO - Type: GPU 15:08:04 INFO - Bus: Built-In 15:08:04 INFO - VRAM (Dynamic, Max): 1536 MB 15:08:04 INFO - Vendor: Intel (0x8086) 15:08:04 INFO - Device ID: 0x0a2e 15:08:04 INFO - Revision ID: 0x0009 15:08:04 INFO - Displays: 15:08:04 INFO - Display: 15:08:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:08:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:08:04 INFO - Display Serial Number: 1600x1200 60 15:08:04 INFO - Main Display: Yes 15:08:04 INFO - Mirror: Off 15:08:04 INFO - Online: Yes 15:08:04 INFO - Rotation: Supported 15:08:04 INFO - Return code: 0 15:08:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:08:04 INFO - Python 2.7.3 15:08:04 INFO - Return code: 0 15:08:04 INFO - grabbing minidump binary from tooltool 15:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:08:04 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 0x1102b6d30>, '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 0x11011ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102aeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:08:04 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 15:08:04 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 15:08:04 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 15:08:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:08:05 INFO - Return code: 0 15:08:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:08:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:08:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:08:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:08:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:08:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0361', '--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 15:08:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0361 --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 15:08:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4tHBJSOUSP/Render', 15:08:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:08:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:08:05 INFO - 'HOME': '/Users/cltbld', 15:08:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:08:05 INFO - 'LOGNAME': 'cltbld', 15:08:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:08:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:05 INFO - 'MOZ_NO_REMOTE': '1', 15:08:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:08:05 INFO - 'NO_EM_RESTART': '1', 15:08:05 INFO - 'PAGER': '/bin/cat', 15:08:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:05 INFO - 'PWD': '/builds/slave/test', 15:08:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:08:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:08:05 INFO - 'SHELL': '/bin/bash', 15:08:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uwyjd0Qh2Y/Listeners', 15:08:05 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 15:08:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:08:05 INFO - 'USER': 'cltbld', 15:08:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:08:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:05 INFO - 'XPC_FLAGS': '0x0', 15:08:05 INFO - 'XPC_SERVICE_NAME': '0', 15:08:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:08:05 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/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0361', '--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 15:08:05 INFO - mozversion application_buildid: 20161130125344 15:08:05 INFO - mozversion application_changeset: 8f1e420699832d42753c6503aa31861be6f5b186 15:08:05 INFO - mozversion application_display_name: Nightly 15:08:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:08:05 INFO - mozversion application_name: Firefox 15:08:05 INFO - mozversion application_remotingname: firefox 15:08:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:08:05 INFO - mozversion application_vendor: Mozilla 15:08:05 INFO - mozversion application_version: 53.0a1 15:08:05 INFO - mozversion platform_buildid: 20161130125344 15:08:05 INFO - mozversion platform_changeset: 8f1e420699832d42753c6503aa31861be6f5b186 15:08:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:08:05 INFO - mozversion platform_version: 53.0a1 15:08:05 INFO - using testdate: 1480547285 15:08:05 INFO - actual date: 1480547285 15:08:05 INFO - starting webserver on 'localhost:49243' 15:08:05 INFO - SUITE-START | Running 2 tests 15:08:05 INFO - TEST-START | dromaeo_css 15:08:05 INFO - operating with platform_type : mac_ 15:08:05 INFO - Initialising browser for dromaeo_css test... 15:08:05 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/tmpk7rrnP/profile http://localhost:49243/getInfo.html) 15:08:08 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 15:08:08 INFO - PROCESS | 1635 | colorDepth:24 15:08:08 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 15:08:08 INFO - PROCESS | 1635 | __metrics 15:08:08 INFO - PROCESS | 1635 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:08:08 INFO - PROCESS | 1635 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:08:08 INFO - TEST-INFO | 1635: exit 0 15:08:08 INFO - Browser initialized. 15:08:08 INFO - Running cycle 1/1 for dromaeo_css test... 15:08:08 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/tmpk7rrnP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:08:21 INFO - PROCESS | 1637 | RSS: Main: 244998144 15:08:21 INFO - PROCESS | 1637 | 15:09:12 INFO - PROCESS | 1637 | 1480547352715 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:11:25 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 15:11:27 INFO - PROCESS | 1637 | RSS: Main: 419917824 15:11:27 INFO - PROCESS | 1637 | 15:14:30 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 15:14:31 INFO - PROCESS | 1637 | RSS: Main: 372871168 15:14:31 INFO - PROCESS | 1637 | 15:17:33 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 15:17:34 INFO - PROCESS | 1637 | RSS: Main: 341864448 15:17:34 INFO - PROCESS | 1637 | 15:20:36 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 15:20:37 INFO - PROCESS | 1637 | RSS: Main: 340549632 15:20:37 INFO - PROCESS | 1637 | 15:23:40 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 15:23:41 INFO - PROCESS | 1637 | RSS: Main: 325435392 15:23:41 INFO - PROCESS | 1637 | 15:26:44 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 15:26:44 INFO - PROCESS | 1637 | RSS: Main: 423034880 15:26:44 INFO - PROCESS | 1637 | 15:26:44 INFO - PROCESS | 1637 | __start_tp_report 15:26:44 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 15:26:44 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 15:26:44 INFO - PROCESS | 1637 | |i|pagename|runs| 15:26:44 INFO - PROCESS | 1637 | |0;dojo.html;3345.933081338373;3357.798532088075;3371.966280337199;3374.2576633140716;3417.5044618530314;5638.887222255563;5648.152777083435;5692.686902220376;5700.971495142524;5719.799807006755;5700.1449782532645;5719.857003574913;5733.254676892008;5736.1682556029355;5753.050746626802;5179.741012949356;5211.947880521184;5231.215317702337;5244.292020577212;5244.973775131138;5332.226827110087;5334.013207556614;5334.59990500714;5336.359636843584;5344.599155063366;5211.9576084783;5254.054270231357;5288.867778305554;5312;5326.334208223972;5287.550558202557;5293.04725149473;5305.310309659758;5314.601404894648;5379.704116273603;5102.438731739506;5131.563817075553;5154.587632989352;5245.86885327866;5247.816326428595;5632.577556683265;5654.547636189136;5665.971670141664;5692.5161361284345;5747.6551406915305;5140.563052140573;6214.813555593294;6217.0052791553135;6233.719482623293;6236.96881515594;6131.621347939075;6252.718627661766;6341.904871426932;6346.079818426302;6361.141245931786;5765.048766953448;5791.797287094932;5797.797077102281;5801.419858014249;5842.795502157404;6307.053941908659;6329.525285603599;6356.396142366468;6368.904466433008;6376.234851817811;5969.910451343233;6057.091436284504;6120.020796672511;6138.07928810682;6138.263408390932;6122.794608433986;6146.262448506208;6180.845478863064;6224.37756224383;6287.654179020198;6174.845628859314;6183.659898705614;6190.566660333823;6194.752209911553;6210.223722034746;5393.568514518829;6231.781887633911;6233.657148856766;6237.064440333987;6237.5321850860455;4772.0217355442055;4834.154023045953;4848.151573474628;4904.4605093439695;4921.729304888194;4401.053773438726;4416.271315232951;4431.977840110779;4458.353538736865;4485.641148708096;5724.942750572524;5746.310442746897;5771.711414429262;5783.971080144656;5788.652680839163;6131.193168498116;6133.242854861876;6192.938070619236;6204.441600255998;6300.59046161998;5724.112762521816;5738.311402631711;5750.051241545182;5778.046622307273;5796.768129274782;5370.812021579304;5372.62391632582;5377.112776391851;5382.407935127133;5388.08402571556;6260.092286618324;6306.747730090837;6318.241810982711;6318.6840657965995;6322.49420046386;6074.210352654127;6155.045967874987;6221.813345599639;6261.499080073674;6267.1539342188225;6303.590266632654;6303.905441418474;6308.211473565804;6308.432241098323;6319.96840015797;6136.171616831849;6199.349068347939;6199.349068347939;6211.440970312694;6216.129741836056;4453.287474004143;5835.4748072673665;5963.986122359122;6133.693315334304;6169;6042.154098426312;6086;6104.877902441837;6108.22065524731;6111.8956224267595;5465.699386533779;5882.029465138205;5965.821025369246;5971.91042134377;6085.117657939485;5919.556033297434;5931.3772053935445;5933.584649074696;5953.821385358273;5959.195508606283;5845.327787304344;5942.465178133989;5948.048312270016;5982.760689572368;6101.572889897665;5700.458456446797;5793.884122317614;5907.3501914790195;5912.556558258234;5962.135490353961 15:26:44 INFO - PROCESS | 1637 | |1;ext.html;455.56038422921887;511.86691460220356;514.6268955007619;520.5003196930949;551.8234165067175;27118.728812711866;27136.86431567842;31144.99999999997;37699.434508482394;39213.80393098038;39339.0165245869;39530.011749706275;39532.814015579504;39548.40677389834;39715.007124821896;9140.177384035436;9312.441253524776;9313.348065635408;9314.580843862008;9332.72001839946;7131.500794944356;8499.61751721171;9108.817823643556;10795.99999999996;11070.833937490945;10346.224033197503;10791.83812242817;10990.780184396308;11075.556977720922;11114.55541778332;9605.759856003586;10979.1765617579;11023.283486573348;11081.556737730521;11107.222494425394;8275.131111233293;8518.616662250213;10686.305390149615;10938.289011214245;11045.061169800576;36778.63221367806;38031.42952855709;38100.809495952344;38119.8094009531;38144.80927595372;3275.7215636670912;3310.2717402171484;3335.2995870866903;3361.3613413451612;3401.3197360527993;28409.71590284112;29434.558481622793;29486.26284342887;29492.26269343262;29576.669049892593;3187.4173568097935;3241.7082462578483;3264.2165880188822;3306.7850589711593;3317.2370354818286;413173;414473;418634;418920;419094.9045254754;56518.717406413525;56853;56902;56937.86124277491;56962.86074278491;59001.40998590045;59014.81970360569;59033.81932361329;59143;59293;14978.17620030887;15220.162891041098;15222.619434514005;15240.390384384722;15241.847581524265;11774;11821.881781182077;11877;11892.702682433008;11910.940445297718;14190.290485475685;14552.85447145515;14573.125612463286;14892.329845156777;16457;4815.2394391040025;5641.464060914206;5817.970910145422;5879.706014699248;5908.231929849092;870.664794054281;944.9669261575812;985.5367977050774;998.4857798233916;1020.9846852297221;27535.724642753317;28534.571981420297;28830.567541486893;29328.85335573351;29474.410511789643;1051.348164138239;1064.1752641702742;1072.7586293083993;1102.0026875677524;1102.4763237462141;14446.349914253884;14924.209094908463;14957.177355245565;15353.539393818204;15354.003979482595;548563;550873;553174.0873686395;553958;554727;46388.53611463909;47057.52942470532;53160.73419632877;53520;54423;1312.6718320419895;1335.9198448093146;1355.4239448234462;1358.5380970470087;1359.8232229810062;25226.873865630554;27858;29268.56097158587;29325.85337073301;30197.547036794025;47226.819329517035;47697.76151119222;47708.52291477041;47736.761316193195;47857.80355491141;554823;573354.9983751319;575953;657190;691180;24390.902409391267;24573.877130614233;24634.753652463245;24656.137035203683;24720.752792472565;35408;42733.78633106814;43267.56732432635;43541.78229108834;43595.34606980834;34963.65036349604;35054.824725877224;36897.28092145614;38363;39007.609923900396;35659;35704.82147589245;35859.92420227397;36789.44815827818;36928;35909.820450897576;36171.457428139125;36243.46295759272;36435;36675;30090.3981920356;32574.51138232881;32676.50985235176;32773;32828;21057.197991513392;24380;24545.12381702331;24767.876160619802;25171.244862654148 15:26:44 INFO - PROCESS | 1637 | |2;jquery.html;289.3056664006384;349.22123664228786;368.4657246991862;378.5117198813531;400.0977795072112;14629.195394253311;14860.925695371521;16103.677926441464;16941.83058169418;20248.97510248978;18837;19654.410367688994;20193.49516262094;20361.49096272594;20401.4899627509;5707.200991861132;6062.363451837559;6076.118962750398;6077.939220607804;6078.574499785017;4633.9073218535605;5911.320198177222;6580;6625.17185351831;6692.498062645297;6350.87298254037;6615.37153970372;6634.203895532542;6650.268470468244;6654.700538475756;6507.4143327100555;6517.380848819402;6529.1512103426485;6535.117759102508;6553.180852393403;5073.441921388644;5333.120035194188;5398.2982212312145;5683.403242659502;5687.345955215121;12639.93680031594;12904.354782260943;12925.547605833845;12983.805242921364;23687;2204.2946257197705;2259.2544460328054;2380.3097101840444;2576.587745960656;2749.340158361999;9417.670381536613;9431.104045115702;9472.289578281656;9869.802603947952;9948.303618746691;1724.1637805664243;1824.8357647811629;1828.9477599357363;1843.7326587644716;1855.7309190167484;109366.2204181211;114341;114706;114896.85103149028;116588;11056.944715276371;11097.667069987914;11209.383483908463;11264.43677816106;11459;14333.140011599337;14356.210408427427;14365;14377.993540452277;14395.928020360041;7991.920080799117;8147.959260203661;8154.75535733929;8162.653312141993;8282.420230583923;7964.2433968772875;7975.202479751978;8113.229243221885;8135.959320203361;8180.263776260165;4318.870433886988;4405.29515277554;4433.763352752444;4476.328550717419;4498.955010449919;1509.3585226279008;1680.3362671744592;1866.8693191476466;1888.3579582941866;1894.2139012310013;627.9434850863444;719.1585844561876;746.787165657785;778.8091917480141;882.9072947340566;17895.37366192177;19006.43413139236;20112.39662810118;20376.694349584766;20517.974101294876;895.6104094718818;911.2482202183226;934.4907025671025;942.3733217410345;1004.1715584642699;8536;11491.367974761468;11573.88426115745;11878.762424751456;11925.522979080914;431833;437367;440378;511325;518792;117359;119958;125474.1550695825;125898.11152832715;128315;973.4694591447678;997.9800403992025;1004.7940172264814;1004.8392257238806;1028.5217373921162;10821;16690.082045487616;18813.717794233373;19218.61562768709;19243.326483573568;41069;44870.65388038364;49907.75230619263;50285.49714502954;52268.73865630647;70465.64767176131;73780;77257;82357;84191;7936.246056624612;7972.920270797218;8189.918100818915;8191.631376587949;8222.506649601042;11817.409129543317;12631.305278209788;13324.333783310989;13459.160883783718;13550.93224533871;11299.604513841976;11375.033122184706;11656.125790565571;11656.843483955496;11694.356810375171;11079.612213572485;11242.550297988317;11564.306141631529;11569.884301157217;11616.477258523219;11321.377324247245;11658.242214256046;11699.12256580777;11794.52821887115;11804;8080.555569443737;8202.712905048533;8206.794830129056;8282.219322845616;8348.165183481846;10026.448545330077;10699.839502407314;11106.444677766242;11351.489182986621;11566.30602163873 15:26:44 INFO - PROCESS | 1637 | |3;mootools.html;1330.1686445971268;1469.2066284206526;1621.335252546456;1835.35762483131;1851.5000949743562;7880.714592768098;8294.29498492628;8298.377621678368;8299.377546684007;8302.252797248255;6893.172819261683;7399.519031262964;7640.656170472328;7959.880601790977;8204.384671149674;2261.9434514137197;2298.977010229893;2306;2309.226409152936;2310.6649535817296;2300.896459659311;2317.756635553268;2328.4877326988035;2333.101755824003;2333.591621466245;1932.2560814086607;2269.7843704848015;2294.529621427612;2294.8852557372147;2308.0652335804025;2232.263353093483;2252.68462415262;2253.0987604957986;2254.921077762279;2254.9323520294415;2080.5318803269297;2176.09691977829;2269.7503274639776;2305.5965206088867;2305.804006659436;8126.39052071097;8231.135730748245;8234.547099909503;8244;8257.976795685096;4964.304997300381;5140.357455318085;5160.793568257265;5164.2770012198325;5167.224916262553;2805.2425845021935;3425.1265927188656;3502.6847583717586;3503.929921401583;3508.4035713928693;767.3899250096187;1043.7651528406047;1071.807074726549;1083.864516935383;1087.4345340423015;10784.352938823695;10790.892091079146;10814.675559733141;10817.83773243402;10825.24223304369;4495.303227999665;4567.794449249792;4614.492405835355;4658.742139622283;4674.74288914113;9458;9463.242940564876;9472.100150485692;9475.28935329853;9490;5103.132467480537;5162.354705661793;5163.535281824654;5170.302009228706;5172.456892026358;4067.1255680028344;4518.570735780096;4722.669413141047;4749.2876068589985;4752.857414277577;3609.1698909251018;3677.742558020913;3696.852125914987;3732.738708290394;3780.962190378061;1225.332193954297;1234.4198226833373;1243.6704273367566;1248.3147750536702;1252.1172573335778;832.4048305461624;839.2866063845804;862.6894318045498;868.9826203475895;910.0626354854511;5336.46635336471;5519;5584.441555844464;5656.321241451053;5778.133280008033;402.5049189496935;405.99594004060174;410.23695925578403;441.5077188934315;445.91973444779603;3542.4590303218183;3696.500972368696;3822.675072618803;3884.533855937249;3893.7079719021185;9515.333926625208;10084.647037353658;10089.394636321844;10091.747706307255;10110.191184705205;9381;10005;10023.69928902134;10024.248181386425;10026.849597256047;7452.217517160729;7768;7771.805704857311;7773.883391749128;7773.922260777433;5638.464345887134;5666.829995100154;5673.290838645169;5868.559858010752;5994.610350327215;9325.580348884181;9467.384619999679;9469.337146399961;9473.24214062887;9479.28905332089;7692.307692307719;8562.78593035179;8645.26515246211;9011.864822027806;9574.138327550554;6621.437177839937;6946.0622815919205;7131.25121862197;7167;7255.383292419992;7497.62511874415;7779.533228006111;7827.099883513469;7966.721164759206;7974.322182614543;7019.29807019294;7087.433005359456;7096.432285417258;7151.60666163366;7225.494215404871;6977.930220697931;7006.369426751413;7032.12098487689;7055.717771289091;7067.151941766815;6401.903971440339;6593.109930159559;6623.4038936495945;6688.264290927897;6704.122845603239;4740.549647783455;4820.975895120502;4846.927296090632;4896.877578060577;4957.578605818546;4823.517648235148;4898.853034408973;4930.087933732271;4950.480199579137;4954.1825598775795 15:26:44 INFO - PROCESS | 1637 | |4;prototype.html;278.5723913792329;297.6755336683014;304.47326125802357;308.8563817824711;313.557883384428;4633.397658304416;5040.1523139426245;5093.643444958854;5225.111731005729;5322.654027488211;5031.710571689881;5106.540411362977;5251.658642188255;5275.860862786636;5282.947170528303;3231.303565628052;4078.8171430285183;4086.1827634473075;4098.991494167866;4111.301078816593;3855.6722678572355;3954.742941708794;4101.2207680540605;4106.445629839978;4109.157622687342;3420.931581368371;3653.19629681471;3701.518802555664;3793.3930571108626;4014.3777714454304;3300.273939733255;3591.1560783216055;3635.90922723182;3877.39402355809;4062.5937406259286;3252.1300252354754;3303.5705358303267;3497.825108744578;3536.964630353715;3549.3256281306726;4814.494478079821;5041.764767631917;5186.24799404088;5192.287514427165;5212.166053431471;3784.8834593794895;3899.1421887184774;4088.6115818997146;4176.352665336847;4663.27719203524;4651.62786977041;4888.824473109467;4963.677360971526;5589.329280486368;5594.804181853616;3268.199291173654;3763.9059023524355;3929.9017524561827;3937.5668676445566;3966.920661586781;4831.444383895827;5723.103660089582;5771.614812445025;5795.246617939683;5816.440766062919;3314.6519615440034;3511.034465522002;3950.762954222756;3958.693631101787;3974.423708562242;3634.8546058157376;3816.580176180618;3985.143194213258;3989.162275922089;3999.7200195986584;4392.682195341448;4590.638893051614;4596.724196548218;4629.791659375336;4641.419822522184;5232.450592687789;5555.2222688823595;5562.666240025612;5578.637388569811;5604.243427137284;1055.514463346869;1203.1651731110128;1211.1642966353363;1259.9101776963043;1290.9806352904714;819.880862622516;897.3808072430003;901.833160865242;903;907.6324088744069;4940.270905183157;4974.452810190876;5006.4743201964;5044.520770526794;5057.027759173925;4954.603631709527;5020.59835213182;5193;5350.6254562180275;5433.695912980935;4178;4359.016647425414;4645.372874661945;4942.851714448572;5047.4952504749235;2491.3148884057027;2676.585129304961;2843.2181150183865;2852.957205641917;2861.9713802861706;4726.432828060655;5082.872928176751;5479.863003424946;5610.831675049755;5869.853253668693;4699.036697477009;4956.983818317309;5531.8893622128135;5839.357670656224;5962.34414214436;5201.869953251199;5663.688497132614;5949.144410682897;5955.40445955401;6009.519238460913;4620.353150558992;5299.311089558487;5570.44295570456;5835.228266573344;5836.824895253149;5753.798617048383;5772.913406298825;5778.797742079007;5785.4214578541805;5790.449907258803;4898.363212782316;5422.8308676529705;5470.124780035176;5814.732254420864;5988.461038506555;3820.67524260441;3831.9307573909778;3834.811208525366;3866.4200369944733;3891.4746509220895;4828.830990915301;5027.472115427974;5417.85764256738;5724.942750572441;5801.8549536261935;4463.866084017484;4957.752112394438;5274;5289;5593.358261485932;5601.159826026129;5622.3815380307315;5632.605717599892;5637.57718171147;5651.491365777099;4799.328094066903;5236.39781425141;5290.571545682567;5476.795105076877;5546.502444340086;4219.198352313051;5306.018386598492;5370.409254981871;5483.479069488392;5608.85977850557;4270.95729042718;5049.9495005049475;5215.817446389358;5428.4842939920645;5490.752916118864 15:26:44 INFO - PROCESS | 1637 | |5;yui.html;699.6676578625153;721.2318880392378;728.2644529025686;775.4455564271544;838.3293365307754;14787.630309242275;15051.397944082224;15416.768748468754;15531.456399026036;15609.921950390231;13840;14107.294635268247;14290.356933937972;14308.928455357709;14904.329305181265;807.8303556253179;833.6457005772553;834.3825569078898;834.8121672623672;835.340081335744;660.7720336483906;675.6250281093991;681.2029924987752;824.46821799939;832.6378025558871;866.7963028688254;869.3914260017981;871.8822958900562;874.6020560644891;876.9912300877005;864.6887120636566;865.2385900407664;865.6667183134475;866.6923242249005;866.81796822667;508.21480812144955;522.8039485193052;524.0148520780946;524.5462674786321;643.9742410303583;12375;14373.928130359282;15036.022658527161;15063.698726025417;15346;13893.652658683513;13921.23433211173;13955.372008259652;14013.64965875851;14018.719625607533;11565.363904985223;11789;11894;11922.940385298018;12379.071569632224;3628.11111277736;3661.5056967309606;3680.0799800049986;3758.267137908109;3820.9617903820886;96848;102526.97473025323;103187;107041.39437908515;109606.45196774045;10579.84130238047;10717.83923241152;10720.678379648623;10810.837837432446;11075.778484430266;21318.78681213168;21556.245531406326;21599.784002159777;21621.67567486489;21839.344819655118;7579.583122928181;7589.392848572101;7593.924060759322;7646.350060244941;7818.687252509836;3800.980995095062;4293.162833247487;4308.547602501755;4343.478782546114;4474.910501789946;3480.060383696388;3615.728820338485;3617.8914632561064;3620.2397496526023;3623.3296840084668;629.9653519056496;646.2051676438008;654.2508827392704;655.0926966151819;660.841398064461;604.2054698072021;643.0931694812294;656.3829999800173;668.6857177126743;678.8506528563709;8912.598933048028;9260.351775375659;9276.926376054129;9462.90537094634;9636.120956413431;624.3912185618985;629.8834715577633;654.7871941618897;671.090672139254;676.3642176354211;3664.5785734640326;4491.371208030879;4558.33904083906;4562.498125206291;4628.8170635569395;108039;109777.45111274552;110832;115362.6927461446;115639.42180289044;80326;86931;90784.6382304266;95714;96836;87966;89534;91391.62912556317;91671.5416422927;92420;9286.117818807203;9395.812083758423;9715.46564938935;9739.172170365599;9885.209183265466;46101;49413.25880111873;50018;51717;53784.92430151297;69473;71279.64360178166;72393;73229.6338518304;74329.6283518579;12719.98240140805;12890.226586404846;12905.483780649045;13248.20510769357;13264;14515;14630.780538292147;14713.632159196106;14859.851401485847;15583.220838958234;13607.319634018062;13624.795628065389;13752.381142848795;13809.24049177305;14166.291685415894;13687.931560342135;13709.314534273446;13725.588232353046;13784.724305514033;13841.723165536834;13379.799303010657;13543.661408464866;13647.727045458836;13683.86316136826;14333.211673357648;10473.790524189626;10555.841662375224;11059.723506912069;11573.59492417795;11645.243059201124;11209.215354925076;11254.493547790205;11515.30908145514;11589.82615260755;11615.535378584762 15:26:44 INFO - PROCESS | 1637 | __end_tp_report 15:26:44 INFO - PROCESS | 1637 | __start_cc_report 15:26:44 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,2047 15:26:44 INFO - PROCESS | 1637 | __end_cc_report 15:26:44 INFO - PROCESS | 1637 | __startTimestamp1480548404923__endTimestamp 15:26:44 INFO - PROCESS | 1637 | 15:26:44 INFO - PROCESS | 1637 | ------- Summary: start ------- 15:26:44 INFO - PROCESS | 1637 | Number of tests: 6 15:26:44 INFO - PROCESS | 1637 | 15:26:44 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5714.88 Median:5845.33 stddev:630.38 (10.8%) stddev-sans-first:604.30 15:26:44 INFO - PROCESS | 1637 | Values: 3345.9 3357.8 3372.0 3374.3 3417.5 5638.9 5648.2 5692.7 5701.0 5719.8 5700.1 5719.9 5733.3 5736.2 5753.1 5179.7 5211.9 5231.2 5244.3 5245.0 5332.2 5334.0 5334.6 5336.4 5344.6 5212.0 5254.1 5288.9 5312.0 5326.3 5287.6 5293.0 5305.3 5314.6 5379.7 5102.4 5131.6 5154.6 5245.9 5247.8 5632.6 5654.5 5666.0 5692.5 5747.7 5140.6 6214.8 6217.0 6233.7 6237.0 6131.6 6252.7 6341.9 6346.1 6361.1 5765.0 5791.8 5797.8 5801.4 5842.8 6307.1 6329.5 6356.4 6368.9 6376.2 5969.9 6057.1 6120.0 6138.1 6138.3 6122.8 6146.3 6180.8 6224.4 6287.7 6174.8 6183.7 6190.6 6194.8 6210.2 5393.6 6231.8 6233.7 6237.1 6237.5 4772.0 4834.2 4848.2 4904.5 4921.7 4401.1 4416.3 4432.0 4458.4 4485.6 5724.9 5746.3 5771.7 5784.0 5788.7 6131.2 6133.2 6192.9 6204.4 6300.6 5724.1 5738.3 5750.1 5778.0 5796.8 5370.8 5372.6 5377.1 5382.4 5388.1 6260.1 6306.7 6318.2 6318.7 6322.5 6074.2 6155.0 6221.8 6261.5 6267.2 6303.6 6303.9 6308.2 6308.4 6320.0 6136.2 6199.3 6199.3 6211.4 6216.1 4453.3 5835.5 5964.0 6133.7 6169.0 6042.2 6086.0 6104.9 6108.2 6111.9 5465.7 5882.0 5965.8 5971.9 6085.1 5919.6 5931.4 5933.6 5953.8 5959.2 5845.3 5942.5 5948.0 5982.8 6101.6 5700.5 5793.9 5907.4 5912.6 5962.1 15:26:44 INFO - PROCESS | 1637 | 15:26:44 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:65148.60 Median:35533.50 stddev:142705.97 (401.6%) stddev-sans-first:143023.64 15:26:44 INFO - PROCESS | 1637 | Values: 455.6 511.9 514.6 520.5 551.8 27118.7 27136.9 31145.0 37699.4 39213.8 39339.0 39530.0 39532.8 39548.4 39715.0 9140.2 9312.4 9313.3 9314.6 9332.7 7131.5 8499.6 9108.8 10796.0 11070.8 10346.2 10791.8 10990.8 11075.6 11114.6 9605.8 10979.2 11023.3 11081.6 11107.2 8275.1 8518.6 10686.3 10938.3 11045.1 36778.6 38031.4 38100.8 38119.8 38144.8 3275.7 3310.3 3335.3 3361.4 3401.3 28409.7 29434.6 29486.3 29492.3 29576.7 3187.4 3241.7 3264.2 3306.8 3317.2 413173.0 414473.0 418634.0 418920.0 419094.9 56518.7 56853.0 56902.0 56937.9 56962.9 59001.4 59014.8 59033.8 59143.0 59293.0 14978.2 15220.2 15222.6 15240.4 15241.8 11774.0 11821.9 11877.0 11892.7 11910.9 14190.3 14552.9 14573.1 14892.3 16457.0 4815.2 5641.5 5818.0 5879.7 5908.2 870.7 945.0 985.5 998.5 1021.0 27535.7 28534.6 28830.6 29328.9 29474.4 1051.3 1064.2 1072.8 1102.0 1102.5 14446.3 14924.2 14957.2 15353.5 15354.0 548563.0 550873.0 553174.1 553958.0 554727.0 46388.5 47057.5 53160.7 53520.0 54423.0 1312.7 1335.9 1355.4 1358.5 1359.8 25226.9 27858.0 29268.6 29325.9 30197.5 47226.8 47697.8 47708.5 47736.8 47857.8 554823.0 573355.0 575953.0 657190.0 691180.0 24390.9 24573.9 24634.8 24656.1 24720.8 35408.0 42733.8 43267.6 43541.8 43595.3 34963.7 35054.8 36897.3 38363.0 39007.6 35659.0 35704.8 35859.9 36789.4 36928.0 35909.8 36171.5 36243.5 36435.0 36675.0 30090.4 32574.5 32676.5 32773.0 32828.0 21057.2 24380.0 24545.1 24767.9 25171.2 15:26:44 INFO - PROCESS | 1637 | 15:26:44 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:30558.41 Median:2478.45 stddev:79585.42 (3211.1%) stddev-sans-first:79776.23 15:26:44 INFO - PROCESS | 1637 | Values: 289.3 349.2 368.5 378.5 400.1 14629.2 14860.9 16103.7 16941.8 20249.0 18837.0 19654.4 20193.5 20361.5 20401.5 5707.2 6062.4 6076.1 6077.9 6078.6 4633.9 5911.3 6580.0 6625.2 6692.5 6350.9 6615.4 6634.2 6650.3 6654.7 6507.4 6517.4 6529.2 6535.1 6553.2 5073.4 5333.1 5398.3 5683.4 5687.3 12639.9 12904.4 12925.5 12983.8 23687.0 2204.3 2259.3 2380.3 2576.6 2749.3 9417.7 9431.1 9472.3 9869.8 9948.3 1724.2 1824.8 1828.9 1843.7 1855.7 109366.2 114341.0 114706.0 114896.9 116588.0 11056.9 11097.7 11209.4 11264.4 11459.0 14333.1 14356.2 14365.0 14378.0 14395.9 7991.9 8148.0 8154.8 8162.7 8282.4 7964.2 7975.2 8113.2 8136.0 8180.3 4318.9 4405.3 4433.8 4476.3 4499.0 1509.4 1680.3 1866.9 1888.4 1894.2 627.9 719.2 746.8 778.8 882.9 17895.4 19006.4 20112.4 20376.7 20518.0 895.6 911.2 934.5 942.4 1004.2 8536.0 11491.4 11573.9 11878.8 11925.5 431833.0 437367.0 440378.0 511325.0 518792.0 117359.0 119958.0 125474.2 125898.1 128315.0 973.5 998.0 1004.8 1004.8 1028.5 10821.0 16690.1 18813.7 19218.6 19243.3 41069.0 44870.7 49907.8 50285.5 52268.7 70465.6 73780.0 77257.0 82357.0 84191.0 7936.2 7972.9 8189.9 8191.6 8222.5 11817.4 12631.3 13324.3 13459.2 13550.9 11299.6 11375.0 11656.1 11656.8 11694.4 11079.6 11242.6 11564.3 11569.9 11616.5 11321.4 11658.2 11699.1 11794.5 11804.0 8080.6 8202.7 8206.8 8282.2 8348.2 10026.4 10699.8 11106.4 11351.5 11566.3 15:26:44 INFO - PROCESS | 1637 | 15:26:44 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5374.05 Median:4955.88 stddev:2962.86 (59.8%) stddev-sans-first:2955.58 15:26:44 INFO - PROCESS | 1637 | Values: 1330.2 1469.2 1621.3 1835.4 1851.5 7880.7 8294.3 8298.4 8299.4 8302.3 6893.2 7399.5 7640.7 7959.9 8204.4 2261.9 2299.0 2306.0 2309.2 2310.7 2300.9 2317.8 2328.5 2333.1 2333.6 1932.3 2269.8 2294.5 2294.9 2308.1 2232.3 2252.7 2253.1 2254.9 2254.9 2080.5 2176.1 2269.8 2305.6 2305.8 8126.4 8231.1 8234.5 8244.0 8258.0 4964.3 5140.4 5160.8 5164.3 5167.2 2805.2 3425.1 3502.7 3503.9 3508.4 767.4 1043.8 1071.8 1083.9 1087.4 10784.4 10790.9 10814.7 10817.8 10825.2 4495.3 4567.8 4614.5 4658.7 4674.7 9458.0 9463.2 9472.1 9475.3 9490.0 5103.1 5162.4 5163.5 5170.3 5172.5 4067.1 4518.6 4722.7 4749.3 4752.9 3609.2 3677.7 3696.9 3732.7 3781.0 1225.3 1234.4 1243.7 1248.3 1252.1 832.4 839.3 862.7 869.0 910.1 5336.5 5519.0 5584.4 5656.3 5778.1 402.5 406.0 410.2 441.5 445.9 3542.5 3696.5 3822.7 3884.5 3893.7 9515.3 10084.6 10089.4 10091.7 10110.2 9381.0 10005.0 10023.7 10024.2 10026.8 7452.2 7768.0 7771.8 7773.9 7773.9 5638.5 5666.8 5673.3 5868.6 5994.6 9325.6 9467.4 9469.3 9473.2 9479.3 7692.3 8562.8 8645.3 9011.9 9574.1 6621.4 6946.1 7131.3 7167.0 7255.4 7497.6 7779.5 7827.1 7966.7 7974.3 7019.3 7087.4 7096.4 7151.6 7225.5 6977.9 7006.4 7032.1 7055.7 7067.2 6401.9 6593.1 6623.4 6688.3 6704.1 4740.5 4821.0 4846.9 4896.9 4957.6 4823.5 4898.9 4930.1 4950.5 4954.2 15:26:44 INFO - PROCESS | 1637 | 15:26:44 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4421.26 Median:4957.37 stddev:1369.47 (27.6%) stddev-sans-first:1337.55 15:26:44 INFO - PROCESS | 1637 | Values: 278.6 297.7 304.5 308.9 313.6 4633.4 5040.2 5093.6 5225.1 5322.7 5031.7 5106.5 5251.7 5275.9 5282.9 3231.3 4078.8 4086.2 4099.0 4111.3 3855.7 3954.7 4101.2 4106.4 4109.2 3420.9 3653.2 3701.5 3793.4 4014.4 3300.3 3591.2 3635.9 3877.4 4062.6 3252.1 3303.6 3497.8 3537.0 3549.3 4814.5 5041.8 5186.2 5192.3 5212.2 3784.9 3899.1 4088.6 4176.4 4663.3 4651.6 4888.8 4963.7 5589.3 5594.8 3268.2 3763.9 3929.9 3937.6 3966.9 4831.4 5723.1 5771.6 5795.2 5816.4 3314.7 3511.0 3950.8 3958.7 3974.4 3634.9 3816.6 3985.1 3989.2 3999.7 4392.7 4590.6 4596.7 4629.8 4641.4 5232.5 5555.2 5562.7 5578.6 5604.2 1055.5 1203.2 1211.2 1259.9 1291.0 819.9 897.4 901.8 903.0 907.6 4940.3 4974.5 5006.5 5044.5 5057.0 4954.6 5020.6 5193.0 5350.6 5433.7 4178.0 4359.0 4645.4 4942.9 5047.5 2491.3 2676.6 2843.2 2853.0 2862.0 4726.4 5082.9 5479.9 5610.8 5869.9 4699.0 4957.0 5531.9 5839.4 5962.3 5201.9 5663.7 5949.1 5955.4 6009.5 4620.4 5299.3 5570.4 5835.2 5836.8 5753.8 5772.9 5778.8 5785.4 5790.4 4898.4 5422.8 5470.1 5814.7 5988.5 3820.7 3831.9 3834.8 3866.4 3891.5 4828.8 5027.5 5417.9 5724.9 5801.9 4463.9 4957.8 5274.0 5289.0 5593.4 5601.2 5622.4 5632.6 5637.6 5651.5 4799.3 5236.4 5290.6 5476.8 5546.5 4219.2 5306.0 5370.4 5483.5 5608.9 4271.0 5049.9 5215.8 5428.5 5490.8 15:26:44 INFO - PROCESS | 1637 | 15:26:44 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:21159.52 Median:4057.06 stddev:31002.13 (764.2%) stddev-sans-first:31051.03 15:26:44 INFO - PROCESS | 1637 | Values: 699.7 721.2 728.3 775.4 838.3 14787.6 15051.4 15416.8 15531.5 15609.9 13840.0 14107.3 14290.4 14308.9 14904.3 807.8 833.6 834.4 834.8 835.3 660.8 675.6 681.2 824.5 832.6 866.8 869.4 871.9 874.6 877.0 864.7 865.2 865.7 866.7 866.8 508.2 522.8 524.0 524.5 644.0 12375.0 14373.9 15036.0 15063.7 15346.0 13893.7 13921.2 13955.4 14013.6 14018.7 11565.4 11789.0 11894.0 11922.9 12379.1 3628.1 3661.5 3680.1 3758.3 3821.0 96848.0 102527.0 103187.0 107041.4 109606.5 10579.8 10717.8 10720.7 10810.8 11075.8 21318.8 21556.2 21599.8 21621.7 21839.3 7579.6 7589.4 7593.9 7646.4 7818.7 3801.0 4293.2 4308.5 4343.5 4474.9 3480.1 3615.7 3617.9 3620.2 3623.3 630.0 646.2 654.3 655.1 660.8 604.2 643.1 656.4 668.7 678.9 8912.6 9260.4 9276.9 9462.9 9636.1 624.4 629.9 654.8 671.1 676.4 3664.6 4491.4 4558.3 4562.5 4628.8 108039.0 109777.5 110832.0 115362.7 115639.4 80326.0 86931.0 90784.6 95714.0 96836.0 87966.0 89534.0 91391.6 91671.5 92420.0 9286.1 9395.8 9715.5 9739.2 9885.2 46101.0 49413.3 50018.0 51717.0 53784.9 69473.0 71279.6 72393.0 73229.6 74329.6 12720.0 12890.2 12905.5 13248.2 13264.0 14515.0 14630.8 14713.6 14859.9 15583.2 13607.3 13624.8 13752.4 13809.2 14166.3 13687.9 13709.3 13725.6 13784.7 13841.7 13379.8 13543.7 13647.7 13683.9 14333.2 10473.8 10555.8 11059.7 11573.6 11645.2 11209.2 11254.5 11515.3 11589.8 11615.5 15:26:44 INFO - PROCESS | 1637 | -------- Summary: end -------- 15:26:44 INFO - PROCESS | 1637 | 15:26:45 INFO - TEST-INFO | 1637: exit 0 15:26:45 INFO - TEST-OK | dromaeo_css | took 1120381ms 15:26:45 INFO - TEST-START | kraken 15:26:45 INFO - operating with platform_type : mac_ 15:26:45 INFO - Initialising browser for kraken test... 15:26:45 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/tmpHYliIl/profile http://localhost:49243/getInfo.html) 15:26:48 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 15:26:48 INFO - PROCESS | 1646 | colorDepth:24 15:26:48 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 15:26:48 INFO - PROCESS | 1646 | __metrics 15:26:48 INFO - PROCESS | 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:26:48 INFO - PROCESS | 1646 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:26:49 INFO - TEST-INFO | 1646: exit 0 15:26:49 INFO - Browser initialized. 15:26:49 INFO - Running cycle 1/1 for kraken test... 15:26:49 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/tmpHYliIl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:27:01 INFO - PROCESS | 1647 | RSS: Main: 245358592 15:27:01 INFO - PROCESS | 1647 | 15:27:04 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 15:27:05 INFO - PROCESS | 1647 | RSS: Main: 294027264 15:27:05 INFO - PROCESS | 1647 | 15:27:07 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 15:27:08 INFO - PROCESS | 1647 | RSS: Main: 296194048 15:27:08 INFO - PROCESS | 1647 | 15:27:11 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 15:27:12 INFO - PROCESS | 1647 | RSS: Main: 387432448 15:27:12 INFO - PROCESS | 1647 | 15:27:14 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 15:27:14 INFO - PROCESS | 1647 | RSS: Main: 291733504 15:27:14 INFO - PROCESS | 1647 | 15:27:16 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:27:17 INFO - PROCESS | 1647 | RSS: Main: 295489536 15:27:17 INFO - PROCESS | 1647 | 15:27:20 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 15:27:20 INFO - PROCESS | 1647 | RSS: Main: 337022976 15:27:20 INFO - PROCESS | 1647 | 15:27:23 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 15:27:24 INFO - PROCESS | 1647 | RSS: Main: 338386944 15:27:24 INFO - PROCESS | 1647 | 15:27:27 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 15:27:28 INFO - PROCESS | 1647 | RSS: Main: 334655488 15:27:28 INFO - PROCESS | 1647 | 15:27:29 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:27:30 INFO - PROCESS | 1647 | RSS: Main: 310722560 15:27:30 INFO - PROCESS | 1647 | 15:27:32 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:27:32 INFO - PROCESS | 1647 | RSS: Main: 316645376 15:27:32 INFO - PROCESS | 1647 | 15:27:35 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:27:35 INFO - PROCESS | 1647 | RSS: Main: 318676992 15:27:35 INFO - PROCESS | 1647 | 15:27:38 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:27:39 INFO - PROCESS | 1647 | RSS: Main: 333094912 15:27:39 INFO - PROCESS | 1647 | 15:27:42 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:27:43 INFO - PROCESS | 1647 | RSS: Main: 327163904 15:27:43 INFO - PROCESS | 1647 | 15:27:44 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 15:27:45 INFO - PROCESS | 1647 | RSS: Main: 371048448 15:27:45 INFO - PROCESS | 1647 | 15:27:45 INFO - PROCESS | 1647 | __start_tp_report 15:27:45 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 15:27:45 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 15:27:45 INFO - PROCESS | 1647 | |i|pagename|runs| 15:27:45 INFO - PROCESS | 1647 | |0;ai-astar;114;115;115;114;113;114;113;114;114;113 15:27:45 INFO - PROCESS | 1647 | |1;audio-beat-detection;151;114;113;151;117;115;119;114;134;121 15:27:45 INFO - PROCESS | 1647 | |2;audio-dft;179;182;182;184;182;181;179;176;181;182 15:27:45 INFO - PROCESS | 1647 | |3;audio-fft;79;64;82;109;61;59;58;59;74;58 15:27:45 INFO - PROCESS | 1647 | |4;audio-oscillator;85;72;85;69;66;70;82;68;70;82 15:27:45 INFO - PROCESS | 1647 | |5;imaging-gaussian-blur;89;86;89;86;91;126;90;86;88;86 15:27:45 INFO - PROCESS | 1647 | |6;imaging-darkroom;97;95;97;98;97;97;98;97;98;97 15:27:45 INFO - PROCESS | 1647 | |7;imaging-desaturate;107;131;98;85;88;87;84;85;90;101 15:27:45 INFO - PROCESS | 1647 | |8;json-parse-financial;58;58;54;55;55;57;56;56;56;56 15:27:45 INFO - PROCESS | 1647 | |9;json-stringify-tinderbox;68;66;77;77;71;70;69;70;70;70 15:27:45 INFO - PROCESS | 1647 | |10;stanford-crypto-aes;91;87;87;89;87;103;86;76;100;107 15:27:45 INFO - PROCESS | 1647 | |11;stanford-crypto-ccm;149;148;148;147;148;147;161;149;189;161 15:27:45 INFO - PROCESS | 1647 | |12;stanford-crypto-pbkdf2;174;175;170;173;174;174;173;173;173;221 15:27:45 INFO - PROCESS | 1647 | |13;stanford-crypto-sha256-iterative;66;64;67;68;69;69;70;70;69;68 15:27:45 INFO - PROCESS | 1647 | __end_tp_report 15:27:45 INFO - PROCESS | 1647 | __start_cc_report 15:27:45 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,2042 15:27:45 INFO - PROCESS | 1647 | __end_cc_report 15:27:45 INFO - PROCESS | 1647 | __startTimestamp1480548465015__endTimestamp 15:27:45 INFO - PROCESS | 1647 | 15:27:45 INFO - PROCESS | 1647 | ------- Summary: start ------- 15:27:45 INFO - PROCESS | 1647 | Number of tests: 14 15:27:45 INFO - PROCESS | 1647 | 15:27:45 INFO - PROCESS | 1647 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 15:27:45 INFO - PROCESS | 1647 | Values: 114.0 115.0 115.0 114.0 113.0 114.0 113.0 114.0 114.0 113.0 15:27:45 INFO - PROCESS | 1647 | 15:27:45 INFO - PROCESS | 1647 | [#1] audio-beat-detection Cycles:10 Average:124.90 Median:120.00 stddev:15.04 (12.5%) stddev-sans-first:12.64 15:27:45 INFO - PROCESS | 1647 | Values: 151.0 114.0 113.0 151.0 117.0 115.0 119.0 114.0 134.0 121.0 15:27:45 INFO - PROCESS | 1647 | 15:27:45 INFO - PROCESS | 1647 | [#2] audio-dft Cycles:10 Average:180.80 Median:182.00 stddev:2.25 (1.2%) stddev-sans-first:2.29 15:27:45 INFO - PROCESS | 1647 | Values: 179.0 182.0 182.0 184.0 182.0 181.0 179.0 176.0 181.0 182.0 15:27:45 INFO - PROCESS | 1647 | 15:27:45 INFO - PROCESS | 1647 | [#3] audio-fft Cycles:10 Average:70.30 Median:62.50 stddev:16.36 (26.2%) stddev-sans-first:17.04 15:27:45 INFO - PROCESS | 1647 | Values: 79.0 64.0 82.0 109.0 61.0 59.0 58.0 59.0 74.0 58.0 15:27:45 INFO - PROCESS | 1647 | 15:27:45 INFO - PROCESS | 1647 | [#4] audio-oscillator Cycles:10 Average:74.90 Median:77.00 stddev:7.62 (9.9%) stddev-sans-first:7.16 15:27:45 INFO - PROCESS | 1647 | Values: 85.0 72.0 85.0 69.0 66.0 70.0 82.0 68.0 70.0 82.0 15:27:45 INFO - PROCESS | 1647 | 15:27:45 INFO - PROCESS | 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:91.70 Median:88.50 stddev:12.19 (13.8%) stddev-sans-first:12.89 15:27:45 INFO - PROCESS | 1647 | Values: 89.0 86.0 89.0 86.0 91.0 126.0 90.0 86.0 88.0 86.0 15:27:45 INFO - PROCESS | 1647 | 15:27:45 INFO - PROCESS | 1647 | [#6] imaging-darkroom Cycles:10 Average:97.10 Median:97.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 15:27:45 INFO - PROCESS | 1647 | Values: 97.0 95.0 97.0 98.0 97.0 97.0 98.0 97.0 98.0 97.0 15:27:45 INFO - PROCESS | 1647 | 15:27:45 INFO - PROCESS | 1647 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:86.00 stddev:14.68 (17.1%) stddev-sans-first:14.98 15:27:45 INFO - PROCESS | 1647 | Values: 107.0 131.0 98.0 85.0 88.0 87.0 84.0 85.0 90.0 101.0 15:27:45 INFO - PROCESS | 1647 | 15:27:45 INFO - PROCESS | 1647 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:1.29 (2.3%) stddev-sans-first:1.17 15:27:45 INFO - PROCESS | 1647 | Values: 58.0 58.0 54.0 55.0 55.0 57.0 56.0 56.0 56.0 56.0 15:27:45 INFO - PROCESS | 1647 | 15:27:45 INFO - PROCESS | 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:70.00 stddev:3.55 (5.1%) stddev-sans-first:3.62 15:27:45 INFO - PROCESS | 1647 | Values: 68.0 66.0 77.0 77.0 71.0 70.0 69.0 70.0 70.0 70.0 15:27:45 INFO - PROCESS | 1647 | 15:27:45 INFO - PROCESS | 1647 | [#10] stanford-crypto-aes Cycles:10 Average:91.30 Median:87.00 stddev:9.32 (10.7%) stddev-sans-first:9.89 15:27:45 INFO - PROCESS | 1647 | Values: 91.0 87.0 87.0 89.0 87.0 103.0 86.0 76.0 100.0 107.0 15:27:45 INFO - PROCESS | 1647 | 15:27:45 INFO - PROCESS | 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:154.70 Median:149.00 stddev:13.22 (8.9%) stddev-sans-first:13.87 15:27:45 INFO - PROCESS | 1647 | Values: 149.0 148.0 148.0 147.0 148.0 147.0 161.0 149.0 189.0 161.0 15:27:45 INFO - PROCESS | 1647 | 15:27:45 INFO - PROCESS | 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.00 Median:174.00 stddev:15.17 (8.7%) stddev-sans-first:16.02 15:27:45 INFO - PROCESS | 1647 | Values: 174.0 175.0 170.0 173.0 174.0 174.0 173.0 173.0 173.0 221.0 15:27:45 INFO - PROCESS | 1647 | 15:27:45 INFO - PROCESS | 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:69.00 stddev:1.89 (2.7%) stddev-sans-first:1.86 15:27:45 INFO - PROCESS | 1647 | Values: 66.0 64.0 67.0 68.0 69.0 69.0 70.0 70.0 69.0 68.0 15:27:45 INFO - PROCESS | 1647 | -------- Summary: end -------- 15:27:45 INFO - PROCESS | 1647 | 15:27:46 INFO - TEST-INFO | 1647: exit 0 15:27:46 INFO - TEST-OK | kraken | took 60463ms 15:27:46 INFO - SUITE-END | took 1180s 15:27:46 INFO - Completed test suite (00:19:40) 15:27:46 INFO - javascript benchmark 15:27:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3345.933081338373, 3357.798532088075, 3371.966280337199, 3374.2576633140716, 3417.5044618530314, 5638.887222255563, 5648.152777083435, 5692.686902220376, 5700.971495142524, 5719.799807006755, 5700.1449782532645, 5719.857003574913, 5733.254676892008, 5736.1682556029355, 5753.050746626802, 5179.741012949356, 5211.947880521184, 5231.215317702337, 5244.292020577212, 5244.973775131138, 5332.226827110087, 5334.013207556614, 5334.59990500714, 5336.359636843584, 5344.599155063366, 5211.9576084783, 5254.054270231357, 5288.867778305554, 5312.0, 5326.334208223972, 5287.550558202557, 5293.04725149473, 5305.310309659758, 5314.601404894648, 5379.704116273603, 5102.438731739506, 5131.563817075553, 5154.587632989352, 5245.86885327866, 5247.816326428595, 5632.577556683265, 5654.547636189136, 5665.971670141664, 5692.5161361284345, 5747.6551406915305, 5140.563052140573, 6214.813555593294, 6217.0052791553135, 6233.719482623293, 6236.96881515594, 6131.621347939075, 6252.718627661766, 6341.904871426932, 6346.079818426302, 6361.141245931786, 5765.048766953448, 5791.797287094932, 5797.797077102281, 5801.419858014249, 5842.795502157404, 6307.053941908659, 6329.525285603599, 6356.396142366468, 6368.904466433008, 6376.234851817811, 5969.910451343233, 6057.091436284504, 6120.020796672511, 6138.07928810682, 6138.263408390932, 6122.794608433986, 6146.262448506208, 6180.845478863064, 6224.37756224383, 6287.654179020198, 6174.845628859314, 6183.659898705614, 6190.566660333823, 6194.752209911553, 6210.223722034746, 5393.568514518829, 6231.781887633911, 6233.657148856766, 6237.064440333987, 6237.5321850860455, 4772.0217355442055, 4834.154023045953, 4848.151573474628, 4904.4605093439695, 4921.729304888194, 4401.053773438726, 4416.271315232951, 4431.977840110779, 4458.353538736865, 4485.641148708096, 5724.942750572524, 5746.310442746897, 5771.711414429262, 5783.971080144656, 5788.652680839163, 6131.193168498116, 6133.242854861876, 6192.938070619236, 6204.441600255998, 6300.59046161998, 5724.112762521816, 5738.311402631711, 5750.051241545182, 5778.046622307273, 5796.768129274782, 5370.812021579304, 5372.62391632582, 5377.112776391851, 5382.407935127133, 5388.08402571556, 6260.092286618324, 6306.747730090837, 6318.241810982711, 6318.6840657965995, 6322.49420046386, 6074.210352654127, 6155.045967874987, 6221.813345599639, 6261.499080073674, 6267.1539342188225, 6303.590266632654, 6303.905441418474, 6308.211473565804, 6308.432241098323, 6319.96840015797, 6136.171616831849, 6199.349068347939, 6199.349068347939, 6211.440970312694, 6216.129741836056, 4453.287474004143, 5835.4748072673665, 5963.986122359122, 6133.693315334304, 6169.0, 6042.154098426312, 6086.0, 6104.877902441837, 6108.22065524731, 6111.8956224267595, 5465.699386533779, 5882.029465138205, 5965.821025369246, 5971.91042134377, 6085.117657939485, 5919.556033297434, 5931.3772053935445, 5933.584649074696, 5953.821385358273, 5959.195508606283, 5845.327787304344, 5942.465178133989, 5948.048312270016, 5982.760689572368, 6101.572889897665, 5700.458456446797, 5793.884122317614, 5907.3501914790195, 5912.556558258234, 5962.135490353961], "value": 5676.1330368497065, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [455.56038422921887, 511.86691460220356, 514.6268955007619, 520.5003196930949, 551.8234165067175, 27118.728812711866, 27136.86431567842, 31144.99999999997, 37699.434508482394, 39213.80393098038, 39339.0165245869, 39530.011749706275, 39532.814015579504, 39548.40677389834, 39715.007124821896, 9140.177384035436, 9312.441253524776, 9313.348065635408, 9314.580843862008, 9332.72001839946, 7131.500794944356, 8499.61751721171, 9108.817823643556, 10795.99999999996, 11070.833937490945, 10346.224033197503, 10791.83812242817, 10990.780184396308, 11075.556977720922, 11114.55541778332, 9605.759856003586, 10979.1765617579, 11023.283486573348, 11081.556737730521, 11107.222494425394, 8275.131111233293, 8518.616662250213, 10686.305390149615, 10938.289011214245, 11045.061169800576, 36778.63221367806, 38031.42952855709, 38100.809495952344, 38119.8094009531, 38144.80927595372, 3275.7215636670912, 3310.2717402171484, 3335.2995870866903, 3361.3613413451612, 3401.3197360527993, 28409.71590284112, 29434.558481622793, 29486.26284342887, 29492.26269343262, 29576.669049892593, 3187.4173568097935, 3241.7082462578483, 3264.2165880188822, 3306.7850589711593, 3317.2370354818286, 413173.0, 414473.0, 418634.0, 418920.0, 419094.9045254754, 56518.717406413525, 56853.0, 56902.0, 56937.86124277491, 56962.86074278491, 59001.40998590045, 59014.81970360569, 59033.81932361329, 59143.0, 59293.0, 14978.17620030887, 15220.162891041098, 15222.619434514005, 15240.390384384722, 15241.847581524265, 11774.0, 11821.881781182077, 11877.0, 11892.702682433008, 11910.940445297718, 14190.290485475685, 14552.85447145515, 14573.125612463286, 14892.329845156777, 16457.0, 4815.2394391040025, 5641.464060914206, 5817.970910145422, 5879.706014699248, 5908.231929849092, 870.664794054281, 944.9669261575812, 985.5367977050774, 998.4857798233916, 1020.9846852297221, 27535.724642753317, 28534.571981420297, 28830.567541486893, 29328.85335573351, 29474.410511789643, 1051.348164138239, 1064.1752641702742, 1072.7586293083993, 1102.0026875677524, 1102.4763237462141, 14446.349914253884, 14924.209094908463, 14957.177355245565, 15353.539393818204, 15354.003979482595, 548563.0, 550873.0, 553174.0873686395, 553958.0, 554727.0, 46388.53611463909, 47057.52942470532, 53160.73419632877, 53520.0, 54423.0, 1312.6718320419895, 1335.9198448093146, 1355.4239448234462, 1358.5380970470087, 1359.8232229810062, 25226.873865630554, 27858.0, 29268.56097158587, 29325.85337073301, 30197.547036794025, 47226.819329517035, 47697.76151119222, 47708.52291477041, 47736.761316193195, 47857.80355491141, 554823.0, 573354.9983751319, 575953.0, 657190.0, 691180.0, 24390.902409391267, 24573.877130614233, 24634.753652463245, 24656.137035203683, 24720.752792472565, 35408.0, 42733.78633106814, 43267.56732432635, 43541.78229108834, 43595.34606980834, 34963.65036349604, 35054.824725877224, 36897.28092145614, 38363.0, 39007.609923900396, 35659.0, 35704.82147589245, 35859.92420227397, 36789.44815827818, 36928.0, 35909.820450897576, 36171.457428139125, 36243.46295759272, 36435.0, 36675.0, 30090.3981920356, 32574.51138232881, 32676.50985235176, 32773.0, 32828.0, 21057.197991513392, 24380.0, 24545.12381702331, 24767.876160619802, 25171.244862654148], "value": 18902.40527927746, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.3056664006384, 349.22123664228786, 368.4657246991862, 378.5117198813531, 400.0977795072112, 14629.195394253311, 14860.925695371521, 16103.677926441464, 16941.83058169418, 20248.97510248978, 18837.0, 19654.410367688994, 20193.49516262094, 20361.49096272594, 20401.4899627509, 5707.200991861132, 6062.363451837559, 6076.118962750398, 6077.939220607804, 6078.574499785017, 4633.9073218535605, 5911.320198177222, 6580.0, 6625.17185351831, 6692.498062645297, 6350.87298254037, 6615.37153970372, 6634.203895532542, 6650.268470468244, 6654.700538475756, 6507.4143327100555, 6517.380848819402, 6529.1512103426485, 6535.117759102508, 6553.180852393403, 5073.441921388644, 5333.120035194188, 5398.2982212312145, 5683.403242659502, 5687.345955215121, 12639.93680031594, 12904.354782260943, 12925.547605833845, 12983.805242921364, 23687.0, 2204.2946257197705, 2259.2544460328054, 2380.3097101840444, 2576.587745960656, 2749.340158361999, 9417.670381536613, 9431.104045115702, 9472.289578281656, 9869.802603947952, 9948.303618746691, 1724.1637805664243, 1824.8357647811629, 1828.9477599357363, 1843.7326587644716, 1855.7309190167484, 109366.2204181211, 114341.0, 114706.0, 114896.85103149028, 116588.0, 11056.944715276371, 11097.667069987914, 11209.383483908463, 11264.43677816106, 11459.0, 14333.140011599337, 14356.210408427427, 14365.0, 14377.993540452277, 14395.928020360041, 7991.920080799117, 8147.959260203661, 8154.75535733929, 8162.653312141993, 8282.420230583923, 7964.2433968772875, 7975.202479751978, 8113.229243221885, 8135.959320203361, 8180.263776260165, 4318.870433886988, 4405.29515277554, 4433.763352752444, 4476.328550717419, 4498.955010449919, 1509.3585226279008, 1680.3362671744592, 1866.8693191476466, 1888.3579582941866, 1894.2139012310013, 627.9434850863444, 719.1585844561876, 746.787165657785, 778.8091917480141, 882.9072947340566, 17895.37366192177, 19006.43413139236, 20112.39662810118, 20376.694349584766, 20517.974101294876, 895.6104094718818, 911.2482202183226, 934.4907025671025, 942.3733217410345, 1004.1715584642699, 8536.0, 11491.367974761468, 11573.88426115745, 11878.762424751456, 11925.522979080914, 431833.0, 437367.0, 440378.0, 511325.0, 518792.0, 117359.0, 119958.0, 125474.1550695825, 125898.11152832715, 128315.0, 973.4694591447678, 997.9800403992025, 1004.7940172264814, 1004.8392257238806, 1028.5217373921162, 10821.0, 16690.082045487616, 18813.717794233373, 19218.61562768709, 19243.326483573568, 41069.0, 44870.65388038364, 49907.75230619263, 50285.49714502954, 52268.73865630647, 70465.64767176131, 73780.0, 77257.0, 82357.0, 84191.0, 7936.246056624612, 7972.920270797218, 8189.918100818915, 8191.631376587949, 8222.506649601042, 11817.409129543317, 12631.305278209788, 13324.333783310989, 13459.160883783718, 13550.93224533871, 11299.604513841976, 11375.033122184706, 11656.125790565571, 11656.843483955496, 11694.356810375171, 11079.612213572485, 11242.550297988317, 11564.306141631529, 11569.884301157217, 11616.477258523219, 11321.377324247245, 11658.242214256046, 11699.12256580777, 11794.52821887115, 11804.0, 8080.555569443737, 8202.712905048533, 8206.794830129056, 8282.219322845616, 8348.165183481846, 10026.448545330077, 10699.839502407314, 11106.444677766242, 11351.489182986621, 11566.30602163873], "value": 9197.116454831877, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.1686445971268, 1469.2066284206526, 1621.335252546456, 1835.35762483131, 1851.5000949743562, 7880.714592768098, 8294.29498492628, 8298.377621678368, 8299.377546684007, 8302.252797248255, 6893.172819261683, 7399.519031262964, 7640.656170472328, 7959.880601790977, 8204.384671149674, 2261.9434514137197, 2298.977010229893, 2306.0, 2309.226409152936, 2310.6649535817296, 2300.896459659311, 2317.756635553268, 2328.4877326988035, 2333.101755824003, 2333.591621466245, 1932.2560814086607, 2269.7843704848015, 2294.529621427612, 2294.8852557372147, 2308.0652335804025, 2232.263353093483, 2252.68462415262, 2253.0987604957986, 2254.921077762279, 2254.9323520294415, 2080.5318803269297, 2176.09691977829, 2269.7503274639776, 2305.5965206088867, 2305.804006659436, 8126.39052071097, 8231.135730748245, 8234.547099909503, 8244.0, 8257.976795685096, 4964.304997300381, 5140.357455318085, 5160.793568257265, 5164.2770012198325, 5167.224916262553, 2805.2425845021935, 3425.1265927188656, 3502.6847583717586, 3503.929921401583, 3508.4035713928693, 767.3899250096187, 1043.7651528406047, 1071.807074726549, 1083.864516935383, 1087.4345340423015, 10784.352938823695, 10790.892091079146, 10814.675559733141, 10817.83773243402, 10825.24223304369, 4495.303227999665, 4567.794449249792, 4614.492405835355, 4658.742139622283, 4674.74288914113, 9458.0, 9463.242940564876, 9472.100150485692, 9475.28935329853, 9490.0, 5103.132467480537, 5162.354705661793, 5163.535281824654, 5170.302009228706, 5172.456892026358, 4067.1255680028344, 4518.570735780096, 4722.669413141047, 4749.2876068589985, 4752.857414277577, 3609.1698909251018, 3677.742558020913, 3696.852125914987, 3732.738708290394, 3780.962190378061, 1225.332193954297, 1234.4198226833373, 1243.6704273367566, 1248.3147750536702, 1252.1172573335778, 832.4048305461624, 839.2866063845804, 862.6894318045498, 868.9826203475895, 910.0626354854511, 5336.46635336471, 5519.0, 5584.441555844464, 5656.321241451053, 5778.133280008033, 402.5049189496935, 405.99594004060174, 410.23695925578403, 441.5077188934315, 445.91973444779603, 3542.4590303218183, 3696.500972368696, 3822.675072618803, 3884.533855937249, 3893.7079719021185, 9515.333926625208, 10084.647037353658, 10089.394636321844, 10091.747706307255, 10110.191184705205, 9381.0, 10005.0, 10023.69928902134, 10024.248181386425, 10026.849597256047, 7452.217517160729, 7768.0, 7771.805704857311, 7773.883391749128, 7773.922260777433, 5638.464345887134, 5666.829995100154, 5673.290838645169, 5868.559858010752, 5994.610350327215, 9325.580348884181, 9467.384619999679, 9469.337146399961, 9473.24214062887, 9479.28905332089, 7692.307692307719, 8562.78593035179, 8645.26515246211, 9011.864822027806, 9574.138327550554, 6621.437177839937, 6946.0622815919205, 7131.25121862197, 7167.0, 7255.383292419992, 7497.62511874415, 7779.533228006111, 7827.099883513469, 7966.721164759206, 7974.322182614543, 7019.29807019294, 7087.433005359456, 7096.432285417258, 7151.60666163366, 7225.494215404871, 6977.930220697931, 7006.369426751413, 7032.12098487689, 7055.717771289091, 7067.151941766815, 6401.903971440339, 6593.109930159559, 6623.4038936495945, 6688.264290927897, 6704.122845603239, 4740.549647783455, 4820.975895120502, 4846.927296090632, 4896.877578060577, 4957.578605818546, 4823.517648235148, 4898.853034408973, 4930.087933732271, 4950.480199579137, 4954.1825598775795], "value": 4275.698994512921, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.5723913792329, 297.6755336683014, 304.47326125802357, 308.8563817824711, 313.557883384428, 4633.397658304416, 5040.1523139426245, 5093.643444958854, 5225.111731005729, 5322.654027488211, 5031.710571689881, 5106.540411362977, 5251.658642188255, 5275.860862786636, 5282.947170528303, 3231.303565628052, 4078.8171430285183, 4086.1827634473075, 4098.991494167866, 4111.301078816593, 3855.6722678572355, 3954.742941708794, 4101.2207680540605, 4106.445629839978, 4109.157622687342, 3420.931581368371, 3653.19629681471, 3701.518802555664, 3793.3930571108626, 4014.3777714454304, 3300.273939733255, 3591.1560783216055, 3635.90922723182, 3877.39402355809, 4062.5937406259286, 3252.1300252354754, 3303.5705358303267, 3497.825108744578, 3536.964630353715, 3549.3256281306726, 4814.494478079821, 5041.764767631917, 5186.24799404088, 5192.287514427165, 5212.166053431471, 3784.8834593794895, 3899.1421887184774, 4088.6115818997146, 4176.352665336847, 4663.27719203524, 4651.62786977041, 4888.824473109467, 4963.677360971526, 5589.329280486368, 5594.804181853616, 3268.199291173654, 3763.9059023524355, 3929.9017524561827, 3937.5668676445566, 3966.920661586781, 4831.444383895827, 5723.103660089582, 5771.614812445025, 5795.246617939683, 5816.440766062919, 3314.6519615440034, 3511.034465522002, 3950.762954222756, 3958.693631101787, 3974.423708562242, 3634.8546058157376, 3816.580176180618, 3985.143194213258, 3989.162275922089, 3999.7200195986584, 4392.682195341448, 4590.638893051614, 4596.724196548218, 4629.791659375336, 4641.419822522184, 5232.450592687789, 5555.2222688823595, 5562.666240025612, 5578.637388569811, 5604.243427137284, 1055.514463346869, 1203.1651731110128, 1211.1642966353363, 1259.9101776963043, 1290.9806352904714, 819.880862622516, 897.3808072430003, 901.833160865242, 903.0, 907.6324088744069, 4940.270905183157, 4974.452810190876, 5006.4743201964, 5044.520770526794, 5057.027759173925, 4954.603631709527, 5020.59835213182, 5193.0, 5350.6254562180275, 5433.695912980935, 4178.0, 4359.016647425414, 4645.372874661945, 4942.851714448572, 5047.4952504749235, 2491.3148884057027, 2676.585129304961, 2843.2181150183865, 2852.957205641917, 2861.9713802861706, 4726.432828060655, 5082.872928176751, 5479.863003424946, 5610.831675049755, 5869.853253668693, 4699.036697477009, 4956.983818317309, 5531.8893622128135, 5839.357670656224, 5962.34414214436, 5201.869953251199, 5663.688497132614, 5949.144410682897, 5955.40445955401, 6009.519238460913, 4620.353150558992, 5299.311089558487, 5570.44295570456, 5835.228266573344, 5836.824895253149, 5753.798617048383, 5772.913406298825, 5778.797742079007, 5785.4214578541805, 5790.449907258803, 4898.363212782316, 5422.8308676529705, 5470.124780035176, 5814.732254420864, 5988.461038506555, 3820.67524260441, 3831.9307573909778, 3834.811208525366, 3866.4200369944733, 3891.4746509220895, 4828.830990915301, 5027.472115427974, 5417.85764256738, 5724.942750572441, 5801.8549536261935, 4463.866084017484, 4957.752112394438, 5274.0, 5289.0, 5593.358261485932, 5601.159826026129, 5622.3815380307315, 5632.605717599892, 5637.57718171147, 5651.491365777099, 4799.328094066903, 5236.39781425141, 5290.571545682567, 5476.795105076877, 5546.502444340086, 4219.198352313051, 5306.018386598492, 5370.409254981871, 5483.479069488392, 5608.85977850557, 4270.95729042718, 5049.9495005049475, 5215.817446389358, 5428.4842939920645, 5490.752916118864], "value": 3984.8530337202433, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.6676578625153, 721.2318880392378, 728.2644529025686, 775.4455564271544, 838.3293365307754, 14787.630309242275, 15051.397944082224, 15416.768748468754, 15531.456399026036, 15609.921950390231, 13840.0, 14107.294635268247, 14290.356933937972, 14308.928455357709, 14904.329305181265, 807.8303556253179, 833.6457005772553, 834.3825569078898, 834.8121672623672, 835.340081335744, 660.7720336483906, 675.6250281093991, 681.2029924987752, 824.46821799939, 832.6378025558871, 866.7963028688254, 869.3914260017981, 871.8822958900562, 874.6020560644891, 876.9912300877005, 864.6887120636566, 865.2385900407664, 865.6667183134475, 866.6923242249005, 866.81796822667, 508.21480812144955, 522.8039485193052, 524.0148520780946, 524.5462674786321, 643.9742410303583, 12375.0, 14373.928130359282, 15036.022658527161, 15063.698726025417, 15346.0, 13893.652658683513, 13921.23433211173, 13955.372008259652, 14013.64965875851, 14018.719625607533, 11565.363904985223, 11789.0, 11894.0, 11922.940385298018, 12379.071569632224, 3628.11111277736, 3661.5056967309606, 3680.0799800049986, 3758.267137908109, 3820.9617903820886, 96848.0, 102526.97473025323, 103187.0, 107041.39437908515, 109606.45196774045, 10579.84130238047, 10717.83923241152, 10720.678379648623, 10810.837837432446, 11075.778484430266, 21318.78681213168, 21556.245531406326, 21599.784002159777, 21621.67567486489, 21839.344819655118, 7579.583122928181, 7589.392848572101, 7593.924060759322, 7646.350060244941, 7818.687252509836, 3800.980995095062, 4293.162833247487, 4308.547602501755, 4343.478782546114, 4474.910501789946, 3480.060383696388, 3615.728820338485, 3617.8914632561064, 3620.2397496526023, 3623.3296840084668, 629.9653519056496, 646.2051676438008, 654.2508827392704, 655.0926966151819, 660.841398064461, 604.2054698072021, 643.0931694812294, 656.3829999800173, 668.6857177126743, 678.8506528563709, 8912.598933048028, 9260.351775375659, 9276.926376054129, 9462.90537094634, 9636.120956413431, 624.3912185618985, 629.8834715577633, 654.7871941618897, 671.090672139254, 676.3642176354211, 3664.5785734640326, 4491.371208030879, 4558.33904083906, 4562.498125206291, 4628.8170635569395, 108039.0, 109777.45111274552, 110832.0, 115362.6927461446, 115639.42180289044, 80326.0, 86931.0, 90784.6382304266, 95714.0, 96836.0, 87966.0, 89534.0, 91391.62912556317, 91671.5416422927, 92420.0, 9286.117818807203, 9395.812083758423, 9715.46564938935, 9739.172170365599, 9885.209183265466, 46101.0, 49413.25880111873, 50018.0, 51717.0, 53784.92430151297, 69473.0, 71279.64360178166, 72393.0, 73229.6338518304, 74329.6283518579, 12719.98240140805, 12890.226586404846, 12905.483780649045, 13248.20510769357, 13264.0, 14515.0, 14630.780538292147, 14713.632159196106, 14859.851401485847, 15583.220838958234, 13607.319634018062, 13624.795628065389, 13752.381142848795, 13809.24049177305, 14166.291685415894, 13687.931560342135, 13709.314534273446, 13725.588232353046, 13784.724305514033, 13841.723165536834, 13379.799303010657, 13543.661408464866, 13647.727045458836, 13683.86316136826, 14333.211673357648, 10473.790524189626, 10555.841662375224, 11059.723506912069, 11573.59492417795, 11645.243059201124, 11209.215354925076, 11254.493547790205, 11515.30908145514, 11589.82615260755, 11615.535378584762], "value": 7438.820652735533, "unit": "score"}], "name": "dromaeo_css", "value": 7071.833080940133, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 114.0, 113.0, 114.0, 113.0, 114.0, 114.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 114.0, 113.0, 151.0, 117.0, 115.0, 119.0, 114.0, 134.0, 121.0], "value": 124.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 182.0, 182.0, 184.0, 182.0, 181.0, 179.0, 176.0, 181.0, 182.0], "value": 180.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 64.0, 82.0, 109.0, 61.0, 59.0, 58.0, 59.0, 74.0, 58.0], "value": 70.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 72.0, 85.0, 69.0, 66.0, 70.0, 82.0, 68.0, 70.0, 82.0], "value": 74.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 86.0, 91.0, 126.0, 90.0, 86.0, 88.0, 86.0], "value": 91.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 97.0, 98.0, 97.0, 97.0, 98.0, 97.0, 98.0, 97.0], "value": 97.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 131.0, 98.0, 85.0, 88.0, 87.0, 84.0, 85.0, 90.0, 101.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 54.0, 55.0, 55.0, 57.0, 56.0, 56.0, 56.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 77.0, 77.0, 71.0, 70.0, 69.0, 70.0, 70.0, 70.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 87.0, 89.0, 87.0, 103.0, 86.0, 76.0, 100.0, 107.0], "value": 91.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 147.0, 148.0, 147.0, 161.0, 149.0, 189.0, 161.0], "value": 154.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 175.0, 170.0, 173.0, 174.0, 174.0, 173.0, 173.0, 173.0, 221.0], "value": 178.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 67.0, 68.0, 69.0, 69.0, 70.0, 70.0, 69.0, 68.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1468.1000000000001, "alertThreshold": 2.0}]} 15:27:46 INFO - Return code: 0 15:27:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:27:46 INFO - # TBPL SUCCESS # 15:27:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:27:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:27:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:27:46 INFO - 2016-11-30 15:27:46.350 screenresolution[1651:9847] starting screenresolution argv=screenresolution get 15:27:46 INFO - 2016-11-30 15:27:46.353 screenresolution[1651:9847] Display 0: 1600x1200x32@60 15:27:46 INFO - 2016-11-30 15:27:46.359 screenresolution[1652:9850] starting screenresolution argv=screenresolution list 15:27:46 INFO - Available Modes on Display 0 15:27:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:27:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:27:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:27:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:27:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:27:46 INFO - Intel Iris: 15:27:46 INFO - Chipset Model: Intel Iris 15:27:46 INFO - Type: GPU 15:27:46 INFO - Bus: Built-In 15:27:46 INFO - VRAM (Dynamic, Max): 1536 MB 15:27:46 INFO - Vendor: Intel (0x8086) 15:27:46 INFO - Device ID: 0x0a2e 15:27:46 INFO - Revision ID: 0x0009 15:27:46 INFO - Displays: 15:27:46 INFO - Display: 15:27:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:27:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:27:46 INFO - Display Serial Number: 1600x1200 60 15:27:46 INFO - Main Display: Yes 15:27:46 INFO - Mirror: Off 15:27:46 INFO - Online: Yes 15:27:46 INFO - Rotation: Supported 15:27:46 INFO - Return code: 0 15:27:46 INFO - Running post-action listener: _resource_record_post_action 15:27:46 INFO - [mozharness: 2016-11-30 23:27:46.610559Z] Finished run-tests step (success) 15:27:46 INFO - Running post-run listener: _resource_record_post_run 15:27:46 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 48916480; Write bytes: 703739392; Read time: 376; Write time: 2037 15:27:46 INFO - TinderboxPrint: CPU usage
53.5% 15:27:46 INFO - TinderboxPrint: I/O read bytes / time
48,916,480 / 376 15:27:46 INFO - TinderboxPrint: I/O write bytes / time
703,739,392 / 2,037 15:27:46 INFO - TinderboxPrint: CPU idle
2,258.9 (46.5%) 15:27:46 INFO - TinderboxPrint: CPU system
970.2 (20.0%) 15:27:46 INFO - TinderboxPrint: CPU user
1,632.6 (33.6%) 15:27:46 INFO - TinderboxPrint: Swap in / out
425,119,744 / 0 15:27:46 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 374612480; Write bytes: 369337856; Read time: 28340; Write time: 762 15:27:46 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 46921728; Write bytes: 316059648; Read time: 360; Write time: 1227 15:27:47 INFO - Running post-run listener: _upload_blobber_files 15:27:47 INFO - Blob upload gear active. 15:27:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:27:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:27:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:27:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:27:47 INFO - (blobuploader) - INFO - Open directory for files ... 15:27:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:27:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:27:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:27:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:27:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:27:48 INFO - (blobuploader) - INFO - Done attempting. 15:27:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:27:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:27:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:27:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:27:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:27:49 INFO - (blobuploader) - INFO - Done attempting. 15:27:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:27:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:27:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:27:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:27:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:27:51 INFO - (blobuploader) - INFO - Done attempting. 15:27:51 INFO - (blobuploader) - INFO - Iteration through files over. 15:27:51 INFO - Return code: 0 15:27:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:27:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:27:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f552a9cfdc472fd73d679bb5c62619f8654307beb312295e25760c96fba2a031b4f8f0c376fe5c4b0cb5484725a2581579b6b6e68fa1553d98f3e80e1bec1944", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fae87679909e7f13452eff7968a3872affa71d0953beafe9c40be50545f6a563908c307cc0acdd0fe2a68c904ebdc7fddfdd16e04076f974f1eaba4b92ee9ba2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/072fbd26e609ebe2d9651147e9072622ec9eb94175396141a8cf9b2c53cf15f9035069f2be0195433427d0e7a12889790fb75f1cbb3f3b3351a163c2b3b1a43a"} 15:27:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:27:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:27:51 INFO - Contents: 15:27:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f552a9cfdc472fd73d679bb5c62619f8654307beb312295e25760c96fba2a031b4f8f0c376fe5c4b0cb5484725a2581579b6b6e68fa1553d98f3e80e1bec1944", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fae87679909e7f13452eff7968a3872affa71d0953beafe9c40be50545f6a563908c307cc0acdd0fe2a68c904ebdc7fddfdd16e04076f974f1eaba4b92ee9ba2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/072fbd26e609ebe2d9651147e9072622ec9eb94175396141a8cf9b2c53cf15f9035069f2be0195433427d0e7a12889790fb75f1cbb3f3b3351a163c2b3b1a43a"} 15:27:51 INFO - Running post-run listener: copy_logs_to_upload_dir 15:27:51 INFO - Copying logs to upload dir... 15:27:51 INFO - mkdir: /builds/slave/test/build/upload/logs 15:27:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.665540 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-11-30 15:27:51.857964) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 15:27:51.862644) ========= 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.4tHBJSOUSP/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.uwyjd0Qh2Y/Listeners TMPDIR=/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/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/f552a9cfdc472fd73d679bb5c62619f8654307beb312295e25760c96fba2a031b4f8f0c376fe5c4b0cb5484725a2581579b6b6e68fa1553d98f3e80e1bec1944", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fae87679909e7f13452eff7968a3872affa71d0953beafe9c40be50545f6a563908c307cc0acdd0fe2a68c904ebdc7fddfdd16e04076f974f1eaba4b92ee9ba2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/072fbd26e609ebe2d9651147e9072622ec9eb94175396141a8cf9b2c53cf15f9035069f2be0195433427d0e7a12889790fb75f1cbb3f3b3351a163c2b3b1a43a"} build_url:https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011065 build_url: 'https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f552a9cfdc472fd73d679bb5c62619f8654307beb312295e25760c96fba2a031b4f8f0c376fe5c4b0cb5484725a2581579b6b6e68fa1553d98f3e80e1bec1944", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fae87679909e7f13452eff7968a3872affa71d0953beafe9c40be50545f6a563908c307cc0acdd0fe2a68c904ebdc7fddfdd16e04076f974f1eaba4b92ee9ba2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/072fbd26e609ebe2d9651147e9072622ec9eb94175396141a8cf9b2c53cf15f9035069f2be0195433427d0e7a12889790fb75f1cbb3f3b3351a163c2b3b1a43a"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 15:27:51.904673) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 15:27:51.905065) ========= 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.4tHBJSOUSP/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.uwyjd0Qh2Y/Listeners TMPDIR=/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/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.005025 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 15:27:51.954332) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 15:27:51.957566) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 15:27:51.958041) ========= ========= Total master_lag: 0.20 =========