builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0104 starttime: 1475111631.05 results: success (0) buildid: 20160928162821 builduid: 9d9a112db65e4fc38b069ef3b1cf444c revision: 1795346935ff752add935af6f082bef916d12706 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 18:13:51.053872) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 18:13:51.054336) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 18:13:51.054711) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 18:13:51.136354) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 18:13:51.136704) ========= 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.8FraE7q3sX/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.J7LQh7LqG2/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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-09-28 18:13:51-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.42M=0.001s 2016-09-28 18:13:51 (9.42 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119920 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 18:13:51.280012) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 18:13:51.280340) ========= 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.8FraE7q3sX/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.J7LQh7LqG2/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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.028673 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 18:13:51.346603) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 18:13:51.346990) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1795346935ff752add935af6f082bef916d12706 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1795346935ff752add935af6f082bef916d12706 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8FraE7q3sX/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.J7LQh7LqG2/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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-09-28 18:13:51,416 truncating revision to first 12 chars 2016-09-28 18:13:51,416 Setting DEBUG logging. 2016-09-28 18:13:51,416 attempt 1/10 2016-09-28 18:13:51,416 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1795346935ff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 18:13:52,066 unpacking tar archive at: mozilla-aurora-1795346935ff/testing/mozharness/ program finished with exit code 0 elapsedTime=0.922907 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 18:13:52.290753) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 18:13:52.291107) ========= script_repo_revision: 1795346935ff752add935af6f082bef916d12706 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 18:13:52.291598) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 18:13:52.291910) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 18:13:52.310161) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-09-28 18:13:52.310502) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8FraE7q3sX/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.J7LQh7LqG2/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 18:13:52 INFO - MultiFileLogger online at 20160928 18:13:52 in /builds/slave/test 18:13:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 18:13:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:13:52 INFO - {'append_to_log': False, 18:13:52 INFO - 'base_work_dir': '/builds/slave/test', 18:13:52 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:13:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:13:52 INFO - 'branch': 'Mozilla-Aurora', 18:13:52 INFO - 'buildbot_json_path': 'buildprops.json', 18:13:52 INFO - 'config_files': ('talos/mac_config.py',), 18:13:52 INFO - 'default_actions': ('clobber', 18:13:52 INFO - 'read-buildbot-config', 18:13:52 INFO - 'download-and-extract', 18:13:52 INFO - 'populate-webroot', 18:13:52 INFO - 'create-virtualenv', 18:13:52 INFO - 'install', 18:13:52 INFO - 'run-tests'), 18:13:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:13:52 INFO - 'download_minidump_stackwalk': True, 18:13:52 INFO - 'download_symbols': 'ondemand', 18:13:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:13:52 INFO - 'tooltool.py': '/tools/tooltool.py', 18:13:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:13:52 INFO - '/tools/misc-python/virtualenv.py')}, 18:13:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:13:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:13:52 INFO - 'installer_path': 'installer.exe', 18:13:52 INFO - 'log_level': 'info', 18:13:52 INFO - 'log_name': 'talos', 18:13:52 INFO - 'log_to_console': True, 18:13:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:13:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:13:52 INFO - 'opt_config_files': (), 18:13:52 INFO - 'pip_index': False, 18:13:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:13:52 INFO - 'cmd': ('bash', 18:13:52 INFO - '-c', 18:13:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:13:52 INFO - 'enabled': True, 18:13:52 INFO - 'halt_on_failure': False, 18:13:52 INFO - 'name': 'check_screen_resolution'},), 18:13:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:13:52 INFO - 'cmd': ('bash', 18:13:52 INFO - '-c', 18:13:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:13:52 INFO - 'enabled': True, 18:13:52 INFO - 'halt_on_failure': False, 18:13:52 INFO - 'name': 'check_screen_resolution'},), 18:13:52 INFO - 'run_cmd_checks_enabled': True, 18:13:52 INFO - 'sps_profile': False, 18:13:52 INFO - 'sps_profile_interval': 0, 18:13:52 INFO - 'suite': 'dromaeojs', 18:13:52 INFO - 'system_bits': '32', 18:13:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:13:52 INFO - 'title': 't-yosemite-r7-0104', 18:13:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:13:52 INFO - 'use_talos_json': True, 18:13:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:13:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:13:52 INFO - 'work_dir': 'build'} 18:13:52 INFO - [mozharness: 2016-09-29 01:13:52.504733Z] Running clobber step. 18:13:52 INFO - Running pre-action listener: _resource_record_pre_action 18:13:52 INFO - Running main action method: clobber 18:13:52 INFO - rmtree: /builds/slave/test/build 18:13:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:13:54 INFO - Running post-action listener: _resource_record_post_action 18:13:54 INFO - [mozharness: 2016-09-29 01:13:54.678593Z] Finished clobber step (success) 18:13:54 INFO - [mozharness: 2016-09-29 01:13:54.678857Z] Running read-buildbot-config step. 18:13:54 INFO - Running pre-action listener: _resource_record_pre_action 18:13:54 INFO - Running main action method: read_buildbot_config 18:13:54 INFO - Using buildbot properties: 18:13:54 INFO - { 18:13:54 INFO - "project": "", 18:13:54 INFO - "product": "firefox", 18:13:54 INFO - "script_repo_revision": "production", 18:13:54 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 18:13:54 INFO - "repository": "", 18:13:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 18:13:54 INFO - "buildid": "20160928162821", 18:13:54 INFO - "pgo_build": "False", 18:13:54 INFO - "basedir": "/builds/slave/test", 18:13:54 INFO - "buildnumber": 139, 18:13:54 INFO - "slavename": "t-yosemite-r7-0104", 18:13:54 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 18:13:54 INFO - "platform": "yosemite_r7", 18:13:54 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 18:13:54 INFO - "branch": "mozilla-aurora", 18:13:54 INFO - "repo_path": "releases/mozilla-aurora", 18:13:54 INFO - "revision": "1795346935ff752add935af6f082bef916d12706", 18:13:54 INFO - "stage_platform": "macosx64", 18:13:54 INFO - "builduid": "9d9a112db65e4fc38b069ef3b1cf444c", 18:13:54 INFO - "slavebuilddir": "test" 18:13:54 INFO - } 18:13:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/VqSyd-l6SPGE5wiqjk7obg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 18:13:54 INFO - Running post-action listener: _resource_record_post_action 18:13:54 INFO - [mozharness: 2016-09-29 01:13:54.684283Z] Finished read-buildbot-config step (success) 18:13:54 INFO - [mozharness: 2016-09-29 01:13:54.684468Z] Running download-and-extract step. 18:13:54 INFO - Running pre-action listener: _resource_record_pre_action 18:13:54 INFO - Running main action method: download_and_extract 18:13:54 INFO - mkdir: /builds/slave/test/build/tests 18:13: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')]} 18:13:54 INFO - trying https://queue.taskcluster.net/v1/task/VqSyd-l6SPGE5wiqjk7obg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 18:13:54 INFO - Downloading https://queue.taskcluster.net/v1/task/VqSyd-l6SPGE5wiqjk7obg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 18:13:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VqSyd-l6SPGE5wiqjk7obg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 18:13:55 INFO - Downloaded 1199 bytes. 18:13:55 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 18:13:55 INFO - Using the following test package requirements: 18:13:55 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 18:13:55 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:13:55 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 18:13:55 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:13:55 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 18:13:55 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:13:55 INFO - u'jsshell-mac.zip'], 18:13:55 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:13:55 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 18:13:55 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 18:13:55 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:13:55 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 18:13:55 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:13:55 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 18:13:55 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:13:55 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 18:13:55 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:13:55 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 18:13:55 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 18:13:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VqSyd-l6SPGE5wiqjk7obg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 18:13:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VqSyd-l6SPGE5wiqjk7obg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 18:13:55 INFO - Fetch https://queue.taskcluster.net/v1/task/VqSyd-l6SPGE5wiqjk7obg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 18:13:56 INFO - Expected file size: 16432373 18:14:03 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 18:14:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VqSyd-l6SPGE5wiqjk7obg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 18:14:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VqSyd-l6SPGE5wiqjk7obg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 18:14:03 INFO - Fetch https://queue.taskcluster.net/v1/task/VqSyd-l6SPGE5wiqjk7obg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 18:14:03 INFO - Expected file size: 16432373 18:14:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VqSyd-l6SPGE5wiqjk7obg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 18:14:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VqSyd-l6SPGE5wiqjk7obg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 18:14:10 INFO - Fetch https://queue.taskcluster.net/v1/task/VqSyd-l6SPGE5wiqjk7obg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 18:14:11 INFO - Expected file size: 14414059 18:14:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:12 INFO - trying https://queue.taskcluster.net/v1/task/VqSyd-l6SPGE5wiqjk7obg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 18:14:12 INFO - Downloading https://queue.taskcluster.net/v1/task/VqSyd-l6SPGE5wiqjk7obg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 18:14:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VqSyd-l6SPGE5wiqjk7obg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 18:14:14 INFO - Downloaded 115282996 bytes. 18:14:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VqSyd-l6SPGE5wiqjk7obg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 18:14:14 INFO - mkdir: /builds/slave/test/properties 18:14:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:14:14 INFO - Writing to file /builds/slave/test/properties/build_url 18:14:14 INFO - Contents: 18:14:14 INFO - build_url:https://queue.taskcluster.net/v1/task/VqSyd-l6SPGE5wiqjk7obg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 18:14:15 INFO - Running post-action listener: _resource_record_post_action 18:14:15 INFO - Running post-action listener: set_extra_try_arguments 18:14:15 INFO - [mozharness: 2016-09-29 01:14:15.668493Z] Finished download-and-extract step (success) 18:14:15 INFO - [mozharness: 2016-09-29 01:14:15.668656Z] Running populate-webroot step. 18:14:15 INFO - Running pre-action listener: _resource_record_pre_action 18:14:15 INFO - Running main action method: populate_webroot 18:14:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:14:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:14:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:14:15 INFO - '--tppagecycles', 18:14:15 INFO - '7'], 18:14:15 INFO - 'tests': ['tsvgm']}}, 18:14:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:14:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:14:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:14:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:14:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:14:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:14:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:15 INFO - 'talos_options': ['--disable-e10s'], 18:14:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:14:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:14:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:15 INFO - 'talos_options': ['--disable-e10s'], 18:14:15 INFO - 'tests': ['damp', 'tps']}, 18:14:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:15 INFO - 'tests': ['damp', 'tps']}, 18:14:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:14:15 INFO - 'tests': ['dromaeo_dom']}, 18:14:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:14:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:14:15 INFO - 'tests': ['basic_compositor_video']}, 18:14:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:14:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:14:15 INFO - 'tests': ['a11yr', 18:14:15 INFO - 'ts_paint', 18:14:15 INFO - 'tpaint', 18:14:15 INFO - 'sessionrestore', 18:14:15 INFO - 'sessionrestore_no_auto_restore', 18:14:15 INFO - 'tabpaint']}, 18:14:15 INFO - 'other-e10s': {'tests': ['a11yr', 18:14:15 INFO - 'ts_paint', 18:14:15 INFO - 'tpaint', 18:14:15 INFO - 'sessionrestore', 18:14:15 INFO - 'sessionrestore_no_auto_restore', 18:14:15 INFO - 'tabpaint']}, 18:14:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:14:15 INFO - 'ts_paint', 18:14:15 INFO - 'tpaint', 18:14:15 INFO - 'sessionrestore', 18:14:15 INFO - 'sessionrestore_no_auto_restore', 18:14:15 INFO - 'tabpaint']}, 18:14:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:14:15 INFO - 'ts_paint', 18:14:15 INFO - 'tpaint', 18:14:15 INFO - 'sessionrestore', 18:14:15 INFO - 'sessionrestore_no_auto_restore', 18:14:15 INFO - 'tabpaint']}, 18:14:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:14:15 INFO - 'tests': ['a11yr', 18:14:15 INFO - 'ts_paint', 18:14:15 INFO - 'tpaint', 18:14:15 INFO - 'sessionrestore', 18:14:15 INFO - 'sessionrestore_no_auto_restore', 18:14:15 INFO - 'tabpaint']}, 18:14:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:14:15 INFO - 'tests': ['a11yr', 18:14:15 INFO - 'ts_paint', 18:14:15 INFO - 'tpaint', 18:14:15 INFO - 'sessionrestore', 18:14:15 INFO - 'sessionrestore_no_auto_restore', 18:14:15 INFO - 'tabpaint']}, 18:14:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:14:15 INFO - 'tests': ['tsvgx', 18:14:15 INFO - 'tsvgr_opacity', 18:14:15 INFO - 'tart', 18:14:15 INFO - 'tscrollx', 18:14:15 INFO - 'cart']}, 18:14:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:14:15 INFO - 'tsvgr_opacity', 18:14:15 INFO - 'tart', 18:14:15 INFO - 'tscrollx', 18:14:15 INFO - 'cart']}, 18:14:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:15 INFO - 'talos_options': ['--disable-e10s'], 18:14:15 INFO - 'tests': ['tp5o']}, 18:14:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:15 INFO - 'tests': ['tp5o']}, 18:14:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:15 INFO - 'talos_options': ['--disable-e10s', 18:14:15 INFO - '--xperf_path', 18:14:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:14:15 INFO - 'tests': ['tp5n']}, 18:14:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:15 INFO - 'talos_options': ['--xperf_path', 18:14:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:14:15 INFO - 'tests': ['tp5n']}}, 18:14:15 INFO - 'talos.zip': {'path': '', 18:14:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:14:15 INFO - Running post-action listener: _resource_record_post_action 18:14:15 INFO - [mozharness: 2016-09-29 01:14:15.687398Z] Finished populate-webroot step (success) 18:14:15 INFO - [mozharness: 2016-09-29 01:14:15.687521Z] Running create-virtualenv step. 18:14:15 INFO - Running pre-action listener: _resource_record_pre_action 18:14:15 INFO - Running main action method: create_virtualenv 18:14:15 INFO - Creating virtualenv /builds/slave/test/build/venv 18:14:15 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 18:14:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:14:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:14:15 INFO - Using real prefix '/tools/python27' 18:14:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:14:16 INFO - Installing distribute.............................................................................................................................................................................................done. 18:14:19 INFO - Installing pip.................done. 18:14:19 INFO - Return code: 0 18:14:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:19 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 0x100ebd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e33570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8735611b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cd1d30>, '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 0x100b37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cc9b20>, '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.8FraE7q3sX/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.J7LQh7LqG2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 18:14:19 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 18:14:19 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 18:14:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8FraE7q3sX/Render', 18:14:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:14:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:14:19 INFO - 'HOME': '/Users/cltbld', 18:14:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:14:19 INFO - 'LOGNAME': 'cltbld', 18:14:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:19 INFO - 'MOZ_NO_REMOTE': '1', 18:14:19 INFO - 'NO_EM_RESTART': '1', 18:14:19 INFO - 'PAGER': '/bin/cat', 18:14:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:14:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:19 INFO - 'PWD': '/builds/slave/test', 18:14:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:14:19 INFO - 'SHELL': '/bin/bash', 18:14:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J7LQh7LqG2/Listeners', 18:14:19 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 18:14:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:14:19 INFO - 'USER': 'cltbld', 18:14:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:14:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:14:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:19 INFO - 'XPC_FLAGS': '0x0', 18:14:19 INFO - 'XPC_SERVICE_NAME': '0', 18:14:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:14:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:19 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 18:14:19 INFO - Cleaning up... 18:14:19 INFO - Return code: 0 18:14:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:19 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 0x100ebd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e33570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8735611b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cd1d30>, '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 0x100b37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cc9b20>, '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.8FraE7q3sX/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.J7LQh7LqG2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 18:14:19 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 18:14:19 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 18:14:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8FraE7q3sX/Render', 18:14:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:14:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:14:19 INFO - 'HOME': '/Users/cltbld', 18:14:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:14:19 INFO - 'LOGNAME': 'cltbld', 18:14:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:19 INFO - 'MOZ_NO_REMOTE': '1', 18:14:19 INFO - 'NO_EM_RESTART': '1', 18:14:19 INFO - 'PAGER': '/bin/cat', 18:14:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:14:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:19 INFO - 'PWD': '/builds/slave/test', 18:14:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:14:19 INFO - 'SHELL': '/bin/bash', 18:14:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J7LQh7LqG2/Listeners', 18:14:19 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 18:14:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:14:19 INFO - 'USER': 'cltbld', 18:14:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:14:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:14:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:19 INFO - 'XPC_FLAGS': '0x0', 18:14:19 INFO - 'XPC_SERVICE_NAME': '0', 18:14:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:14:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:19 INFO - Downloading/unpacking psutil>=3.1.1 18:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:14:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:14:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:14:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:14:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:14:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:14:23 INFO - Installing collected packages: psutil 18:14:23 INFO - Running setup.py install for psutil 18:14:23 INFO - building 'psutil._psutil_osx' extension 18:14:23 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 18:14:24 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 18:14:24 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 18:14:24 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 18:14:24 INFO - building 'psutil._psutil_posix' extension 18:14:24 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 18:14:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:14:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:14:24 INFO - ^ 18:14:24 INFO - 1 warning generated. 18:14:24 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 18:14:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:14:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:14:24 INFO - Successfully installed psutil 18:14:24 INFO - Cleaning up... 18:14:24 INFO - Return code: 0 18:14:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:14: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')]} 18:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14: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')]} 18:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:24 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 0x100ebd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e33570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8735611b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cd1d30>, '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 0x100b37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cc9b20>, '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.8FraE7q3sX/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.J7LQh7LqG2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 18:14:24 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 18:14:24 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 18:14:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8FraE7q3sX/Render', 18:14:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:14:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:14:24 INFO - 'HOME': '/Users/cltbld', 18:14:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:14:24 INFO - 'LOGNAME': 'cltbld', 18:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:24 INFO - 'MOZ_NO_REMOTE': '1', 18:14:24 INFO - 'NO_EM_RESTART': '1', 18:14:24 INFO - 'PAGER': '/bin/cat', 18:14:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:24 INFO - 'PWD': '/builds/slave/test', 18:14:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:14:24 INFO - 'SHELL': '/bin/bash', 18:14:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J7LQh7LqG2/Listeners', 18:14:24 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 18:14:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:14:24 INFO - 'USER': 'cltbld', 18:14:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:14:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:24 INFO - 'XPC_FLAGS': '0x0', 18:14:24 INFO - 'XPC_SERVICE_NAME': '0', 18:14:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:14:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:14:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:14:27 INFO - Installing collected packages: mozsystemmonitor 18:14:27 INFO - Running setup.py install for mozsystemmonitor 18:14:27 INFO - Successfully installed mozsystemmonitor 18:14:27 INFO - Cleaning up... 18:14:27 INFO - Return code: 0 18:14:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:14:27 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')]} 18:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:27 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')]} 18:14:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:27 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 0x100ebd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e33570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8735611b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cd1d30>, '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 0x100b37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cc9b20>, '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.8FraE7q3sX/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.J7LQh7LqG2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 18:14:27 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 18:14:27 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 18:14:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8FraE7q3sX/Render', 18:14:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:14:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:14:27 INFO - 'HOME': '/Users/cltbld', 18:14:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:14:27 INFO - 'LOGNAME': 'cltbld', 18:14:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:27 INFO - 'MOZ_NO_REMOTE': '1', 18:14:27 INFO - 'NO_EM_RESTART': '1', 18:14:27 INFO - 'PAGER': '/bin/cat', 18:14:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:14:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:27 INFO - 'PWD': '/builds/slave/test', 18:14:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:14:27 INFO - 'SHELL': '/bin/bash', 18:14:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J7LQh7LqG2/Listeners', 18:14:27 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 18:14:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:14:27 INFO - 'USER': 'cltbld', 18:14:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:14:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:14:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:27 INFO - 'XPC_FLAGS': '0x0', 18:14:27 INFO - 'XPC_SERVICE_NAME': '0', 18:14:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:14:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:28 INFO - Downloading/unpacking jsonschema==2.5.1 18:14:28 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 18:14:28 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 18:14:28 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 18:14:28 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 18:14:28 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 18:14:28 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 18:14:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:14:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:14:30 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 18:14:30 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 18:14:30 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 18:14:30 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 18:14:30 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 18:14:30 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 18:14:31 INFO - Downloading functools32-3.2.3-2.tar.gz 18:14:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:14:31 INFO - warning: no files found matching '*.txt' 18:14:31 INFO - no previously-included directories found matching 'build' 18:14:31 INFO - no previously-included directories found matching 'dist' 18:14:31 INFO - no previously-included directories found matching '.git*' 18:14:31 INFO - Installing collected packages: jsonschema, functools32 18:14:31 INFO - Running setup.py install for functools32 18:14:31 INFO - warning: no files found matching '*.txt' 18:14:31 INFO - no previously-included directories found matching 'build' 18:14:31 INFO - no previously-included directories found matching 'dist' 18:14:31 INFO - no previously-included directories found matching '.git*' 18:14:31 INFO - Successfully installed jsonschema functools32 18:14:31 INFO - Cleaning up... 18:14:31 INFO - Return code: 0 18:14:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:14:31 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')]} 18:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:31 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')]} 18:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:31 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 0x100ebd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e33570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8735611b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cd1d30>, '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 0x100b37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cc9b20>, '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.8FraE7q3sX/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.J7LQh7LqG2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 18:14:31 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 18:14:31 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 18:14:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8FraE7q3sX/Render', 18:14:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:14:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:14:31 INFO - 'HOME': '/Users/cltbld', 18:14:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:14:31 INFO - 'LOGNAME': 'cltbld', 18:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:31 INFO - 'MOZ_NO_REMOTE': '1', 18:14:31 INFO - 'NO_EM_RESTART': '1', 18:14:31 INFO - 'PAGER': '/bin/cat', 18:14:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:31 INFO - 'PWD': '/builds/slave/test', 18:14:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:14:31 INFO - 'SHELL': '/bin/bash', 18:14:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J7LQh7LqG2/Listeners', 18:14:31 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 18:14:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:14:31 INFO - 'USER': 'cltbld', 18:14:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:14:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:31 INFO - 'XPC_FLAGS': '0x0', 18:14:31 INFO - 'XPC_SERVICE_NAME': '0', 18:14:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:14:31 INFO - Cleaning up... 18:14:31 INFO - Return code: 0 18:14:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:14:31 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')]} 18:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:31 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')]} 18:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:31 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 0x100ebd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e33570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8735611b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cd1d30>, '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 0x100b37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cc9b20>, '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.8FraE7q3sX/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.J7LQh7LqG2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 18:14:31 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 18:14:31 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 18:14:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8FraE7q3sX/Render', 18:14:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:14:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:14:31 INFO - 'HOME': '/Users/cltbld', 18:14:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:14:31 INFO - 'LOGNAME': 'cltbld', 18:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:31 INFO - 'MOZ_NO_REMOTE': '1', 18:14:31 INFO - 'NO_EM_RESTART': '1', 18:14:31 INFO - 'PAGER': '/bin/cat', 18:14:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:31 INFO - 'PWD': '/builds/slave/test', 18:14:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:14:31 INFO - 'SHELL': '/bin/bash', 18:14:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J7LQh7LqG2/Listeners', 18:14:31 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 18:14:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:14:31 INFO - 'USER': 'cltbld', 18:14:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:14:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:31 INFO - 'XPC_FLAGS': '0x0', 18:14:31 INFO - 'XPC_SERVICE_NAME': '0', 18:14:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:31 INFO - Downloading/unpacking blobuploader==1.2.4 18:14:31 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 18:14:31 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 18:14:31 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 18:14:31 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 18:14:31 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 18:14:31 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 18:14:34 INFO - Downloading blobuploader-1.2.4.tar.gz 18:14:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:14:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:14:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:14:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:14:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:14:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:14:35 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 18:14:35 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 18:14:35 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 18:14:35 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 18:14:35 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 18:14:35 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 18:14:35 INFO - Downloading docopt-0.6.1.tar.gz 18:14:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:14:35 INFO - Installing collected packages: blobuploader, requests, docopt 18:14:35 INFO - Running setup.py install for blobuploader 18:14:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:14:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:14:35 INFO - Running setup.py install for requests 18:14:36 INFO - Running setup.py install for docopt 18:14:36 INFO - Successfully installed blobuploader requests docopt 18:14:36 INFO - Cleaning up... 18:14:36 INFO - Return code: 0 18:14:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:36 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 0x100ebd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e33570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8735611b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cd1d30>, '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 0x100b37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cc9b20>, '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.8FraE7q3sX/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.J7LQh7LqG2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 18:14:36 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 18:14:36 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 18:14:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8FraE7q3sX/Render', 18:14:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:14:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:14:36 INFO - 'HOME': '/Users/cltbld', 18:14:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:14:36 INFO - 'LOGNAME': 'cltbld', 18:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:36 INFO - 'MOZ_NO_REMOTE': '1', 18:14:36 INFO - 'NO_EM_RESTART': '1', 18:14:36 INFO - 'PAGER': '/bin/cat', 18:14:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:36 INFO - 'PWD': '/builds/slave/test', 18:14:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:14:36 INFO - 'SHELL': '/bin/bash', 18:14:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J7LQh7LqG2/Listeners', 18:14:36 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 18:14:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:14:36 INFO - 'USER': 'cltbld', 18:14:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:14:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:36 INFO - 'XPC_FLAGS': '0x0', 18:14:36 INFO - 'XPC_SERVICE_NAME': '0', 18:14:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:14:36 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-xwH5ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:14:36 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-KSKn4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:14:37 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-4O0fOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:14:37 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-zDJ13B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:14:37 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-tRPwv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:14:37 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-vvkjsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:14:37 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-V8obZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:14:37 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-W6eZLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:14:37 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-lFDue4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:14:37 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-uq8wj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:14:37 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-gPFrMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:14:38 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-4g3NiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:14:38 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-CVDTBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:14:38 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-WqsRxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:14:38 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-UAASZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:14:38 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-1Yye1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:14:38 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-k59ELT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:14:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:14:38 INFO - Running setup.py install for manifestparser 18:14:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:14:38 INFO - Running setup.py install for mozcrash 18:14:38 INFO - Running setup.py install for mozdebug 18:14:39 INFO - Running setup.py install for mozdevice 18:14:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:14:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:14:39 INFO - Running setup.py install for mozfile 18:14:39 INFO - Running setup.py install for mozhttpd 18:14:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:14:39 INFO - Running setup.py install for mozinfo 18:14:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:14:39 INFO - Running setup.py install for mozInstall 18:14:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:14:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:14:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:14:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:14:39 INFO - Running setup.py install for mozleak 18:14:39 INFO - Running setup.py install for mozlog 18:14:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:14:40 INFO - Running setup.py install for moznetwork 18:14:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:14:40 INFO - Running setup.py install for mozprocess 18:14:40 INFO - Running setup.py install for mozprofile 18:14:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:14:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:14:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:14:40 INFO - Running setup.py install for mozrunner 18:14:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:14:40 INFO - Running setup.py install for mozscreenshot 18:14:40 INFO - Running setup.py install for moztest 18:14:41 INFO - Running setup.py install for mozversion 18:14:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:14:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:14:41 INFO - Cleaning up... 18:14:41 INFO - Return code: 0 18:14:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:14:41 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')]} 18:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:41 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')]} 18:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:41 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 0x100ebd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e33570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8735611b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cd1d30>, '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 0x100b37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cc9b20>, '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.8FraE7q3sX/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.J7LQh7LqG2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 18:14:41 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 18:14:41 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 18:14:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8FraE7q3sX/Render', 18:14:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:14:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:14:41 INFO - 'HOME': '/Users/cltbld', 18:14:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:14:41 INFO - 'LOGNAME': 'cltbld', 18:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:41 INFO - 'MOZ_NO_REMOTE': '1', 18:14:41 INFO - 'NO_EM_RESTART': '1', 18:14:41 INFO - 'PAGER': '/bin/cat', 18:14:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:41 INFO - 'PWD': '/builds/slave/test', 18:14:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:14:41 INFO - 'SHELL': '/bin/bash', 18:14:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J7LQh7LqG2/Listeners', 18:14:41 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 18:14:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:14:41 INFO - 'USER': 'cltbld', 18:14:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:14:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:41 INFO - 'XPC_FLAGS': '0x0', 18:14:41 INFO - 'XPC_SERVICE_NAME': '0', 18:14:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:14:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:14:41 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-UV6O9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:14:41 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)) 18:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:14:41 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-hdsV3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 18:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:14:41 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-_xO77d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:14:41 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)) 18:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:14:41 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-UgrcWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 18:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:14:41 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-ElpQ2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:14:42 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)) 18:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:14:42 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-hkUT4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:14:42 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)) 18:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:14:42 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-JyxKdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:14:42 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)) 18:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:14:42 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-lKiYQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:14:42 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)) 18:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:14:42 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-48Hcxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:14:42 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)) 18:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:14:42 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-N2n7kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:14:42 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)) 18:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:14:42 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-qOecPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:14:42 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)) 18:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:14:42 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-XjoQPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:14:42 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)) 18:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:14:42 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-zlnwkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:14:42 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)) 18:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:14:42 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-XcuwXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 18:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:14:43 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-wSRoEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:14:43 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)) 18:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:14:43 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-T6stMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:14:43 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)) 18:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:14:43 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-6A0Rmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:14:43 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)) 18:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:14:43 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)) 18:14:43 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:14:43 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:14:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:14:43 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 18:14:43 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 18:14:43 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 18:14:43 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 18:14:43 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 18:14:43 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 18:14:45 INFO - Downloading blessings-1.6.tar.gz 18:14:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:14:45 INFO - Installing collected packages: blessings 18:14:45 INFO - Running setup.py install for blessings 18:14:46 INFO - Successfully installed blessings 18:14:46 INFO - Cleaning up... 18:14:46 INFO - Return code: 0 18:14:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:14:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:14:46 INFO - Reading from file tmpfile_stdout 18:14:46 INFO - Current package versions: 18:14:46 INFO - blessings == 1.6 18:14:46 INFO - blobuploader == 1.2.4 18:14:46 INFO - docopt == 0.6.1 18:14:46 INFO - functools32 == 3.2.3-2 18:14:46 INFO - jsonschema == 2.5.1 18:14:46 INFO - manifestparser == 1.1 18:14:46 INFO - mozInstall == 1.12 18:14:46 INFO - mozcrash == 0.17 18:14:46 INFO - mozdebug == 0.1 18:14:46 INFO - mozdevice == 0.48 18:14:46 INFO - mozfile == 1.2 18:14:46 INFO - mozhttpd == 0.7 18:14:46 INFO - mozinfo == 0.9 18:14:46 INFO - mozleak == 0.1 18:14:46 INFO - mozlog == 3.4 18:14:46 INFO - moznetwork == 0.27 18:14:46 INFO - mozprocess == 0.23 18:14:46 INFO - mozprofile == 0.28 18:14:46 INFO - mozrunner == 6.12 18:14:46 INFO - mozscreenshot == 0.1 18:14:46 INFO - mozsystemmonitor == 0.3 18:14:46 INFO - moztest == 0.7 18:14:46 INFO - mozversion == 1.4 18:14:46 INFO - psutil == 3.1.1 18:14:46 INFO - requests == 1.2.3 18:14:46 INFO - wsgiref == 0.1.2 18:14:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:46 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 0x100ebd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e33570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8735611b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cd1d30>, '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 0x100b37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cc9b20>, '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.8FraE7q3sX/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.J7LQh7LqG2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 18:14:46 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 18:14:46 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 18:14:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8FraE7q3sX/Render', 18:14:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:14:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:14:46 INFO - 'HOME': '/Users/cltbld', 18:14:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:14:46 INFO - 'LOGNAME': 'cltbld', 18:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:46 INFO - 'MOZ_NO_REMOTE': '1', 18:14:46 INFO - 'NO_EM_RESTART': '1', 18:14:46 INFO - 'PAGER': '/bin/cat', 18:14:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:46 INFO - 'PWD': '/builds/slave/test', 18:14:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:14:46 INFO - 'SHELL': '/bin/bash', 18:14:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J7LQh7LqG2/Listeners', 18:14:46 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 18:14:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:14:46 INFO - 'USER': 'cltbld', 18:14:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:14:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:46 INFO - 'XPC_FLAGS': '0x0', 18:14:46 INFO - 'XPC_SERVICE_NAME': '0', 18:14:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:46 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)) 18:14:46 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)) 18:14:46 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)) 18:14:46 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)) 18:14:46 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)) 18:14:46 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)) 18:14:46 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)) 18:14:46 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)) 18:14:46 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)) 18:14:46 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)) 18:14:46 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)) 18:14:46 INFO - Cleaning up... 18:14:46 INFO - Return code: 0 18:14:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:46 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 0x100ebd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e33570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8735611b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cd1d30>, '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 0x100b37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cc9b20>, '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.8FraE7q3sX/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.J7LQh7LqG2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 18:14:46 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 18:14:46 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 18:14:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8FraE7q3sX/Render', 18:14:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:14:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:14:46 INFO - 'HOME': '/Users/cltbld', 18:14:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:14:46 INFO - 'LOGNAME': 'cltbld', 18:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:46 INFO - 'MOZ_NO_REMOTE': '1', 18:14:46 INFO - 'NO_EM_RESTART': '1', 18:14:46 INFO - 'PAGER': '/bin/cat', 18:14:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:46 INFO - 'PWD': '/builds/slave/test', 18:14:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:14:46 INFO - 'SHELL': '/bin/bash', 18:14:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J7LQh7LqG2/Listeners', 18:14:46 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 18:14:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:14:46 INFO - 'USER': 'cltbld', 18:14:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:14:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:46 INFO - 'XPC_FLAGS': '0x0', 18:14:46 INFO - 'XPC_SERVICE_NAME': '0', 18:14:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:14:46 INFO - Cleaning up... 18:14:46 INFO - Return code: 0 18:14:46 INFO - Running post-action listener: _resource_record_post_action 18:14:46 INFO - Running post-action listener: _start_resource_monitoring 18:14:46 INFO - Starting resource monitoring. 18:14:46 INFO - [mozharness: 2016-09-29 01:14:46.946679Z] Finished create-virtualenv step (success) 18:14:46 INFO - [mozharness: 2016-09-29 01:14:46.947714Z] Running install step. 18:14:46 INFO - Running pre-action listener: _resource_record_pre_action 18:14:46 INFO - Running main action method: install 18:14:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:14:47 INFO - Reading from file tmpfile_stdout 18:14:47 INFO - Detecting whether we're running mozinstall >=1.0... 18:14:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:14:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:14:47 INFO - Reading from file tmpfile_stdout 18:14:47 INFO - Output received: 18:14:47 INFO - Usage: mozinstall [options] installer 18:14:47 INFO - Options: 18:14:47 INFO - -h, --help show this help message and exit 18:14:47 INFO - -d DEST, --destination=DEST 18:14:47 INFO - Directory to install application into. [default: 18:14:47 INFO - "/builds/slave/test"] 18:14:47 INFO - --app=APP Application being installed. [default: firefox] 18:14:47 INFO - mkdir: /builds/slave/test/build/application 18:14:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:14:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 18:15:19 INFO - Reading from file tmpfile_stdout 18:15:19 INFO - Output received: 18:15:19 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 18:15:19 INFO - Running post-action listener: _resource_record_post_action 18:15:19 INFO - [mozharness: 2016-09-29 01:15:19.623255Z] Finished install step (success) 18:15:19 INFO - [mozharness: 2016-09-29 01:15:19.623401Z] Running run-tests step. 18:15:19 INFO - Running pre-action listener: _resource_record_pre_action 18:15:19 INFO - Running main action method: run_tests 18:15:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:15:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:15:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:15:19 INFO - 2016-09-28 18:15:19.638 screenresolution[1637:7972] starting screenresolution argv=screenresolution get 18:15:19 INFO - 2016-09-28 18:15:19.641 screenresolution[1637:7972] Display 0: 1600x1200x32@60 18:15:19 INFO - 2016-09-28 18:15:19.647 screenresolution[1638:7974] starting screenresolution argv=screenresolution list 18:15:19 INFO - Available Modes on Display 0 18:15:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:15:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:15:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:15:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:15:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:15:19 INFO - Intel Iris: 18:15:19 INFO - Chipset Model: Intel Iris 18:15:19 INFO - Type: GPU 18:15:19 INFO - Bus: Built-In 18:15:19 INFO - VRAM (Dynamic, Max): 1536 MB 18:15:19 INFO - Vendor: Intel (0x8086) 18:15:19 INFO - Device ID: 0x0a2e 18:15:19 INFO - Revision ID: 0x0009 18:15:19 INFO - Displays: 18:15:19 INFO - Display: 18:15:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:15:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:15:19 INFO - Display Serial Number: 1600x1200 60 18:15:19 INFO - Main Display: Yes 18:15:19 INFO - Mirror: Off 18:15:19 INFO - Online: Yes 18:15:19 INFO - Rotation: Supported 18:15:19 INFO - Return code: 0 18:15:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:15:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:15:19 INFO - Python 2.7.3 18:15:19 INFO - Return code: 0 18:15:19 INFO - grabbing minidump binary from tooltool 18:15: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')]} 18:15:19 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 0x100cd1d30>, '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 0x100b37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cc9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:15:19 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 18:15:19 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 18:15:19 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 18:15:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:15:20 INFO - Return code: 0 18:15:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:15:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:15:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:15:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:15:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:15:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VqSyd-l6SPGE5wiqjk7obg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0104', '--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 18:15:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VqSyd-l6SPGE5wiqjk7obg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0104 --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 18:15:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8FraE7q3sX/Render', 18:15:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:15:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:15:20 INFO - 'HOME': '/Users/cltbld', 18:15:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:15:20 INFO - 'LOGNAME': 'cltbld', 18:15:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:15:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:15:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:15:20 INFO - 'MOZ_NO_REMOTE': '1', 18:15:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:15:20 INFO - 'NO_EM_RESTART': '1', 18:15:20 INFO - 'PAGER': '/bin/cat', 18:15:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:15:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:15:20 INFO - 'PWD': '/builds/slave/test', 18:15:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:15:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:15:20 INFO - 'SHELL': '/bin/bash', 18:15:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J7LQh7LqG2/Listeners', 18:15:20 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 18:15:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:15:20 INFO - 'USER': 'cltbld', 18:15:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:15:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:15:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:15:20 INFO - 'XPC_FLAGS': '0x0', 18:15:20 INFO - 'XPC_SERVICE_NAME': '0', 18:15:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:15:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VqSyd-l6SPGE5wiqjk7obg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0104', '--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 18:15:20 INFO - mozversion application_buildid: 20160928162821 18:15:20 INFO - mozversion application_changeset: 1795346935ff752add935af6f082bef916d12706 18:15:20 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:15:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:15:20 INFO - mozversion application_name: Firefox 18:15:20 INFO - mozversion application_remotingname: firefox-dev 18:15:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:15:20 INFO - mozversion application_vendor: Mozilla 18:15:20 INFO - mozversion application_version: 51.0a2 18:15:20 INFO - mozversion platform_buildid: 20160928162821 18:15:20 INFO - mozversion platform_changeset: 1795346935ff752add935af6f082bef916d12706 18:15:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:15:20 INFO - mozversion platform_version: 51.0a2 18:15:20 INFO - using testdate: 1475111720 18:15:20 INFO - actual date: 1475111720 18:15:20 INFO - starting webserver on 'localhost:49272' 18:15:20 INFO - SUITE-START | Running 2 tests 18:15:20 INFO - TEST-START | dromaeo_css 18:15:20 INFO - operating with platform_type : mac_ 18:15:20 INFO - Initialising browser for dromaeo_css test... 18:15:20 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmpiRecPF/profile http://localhost:49272/getInfo.html) 18:15:22 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 18:15:22 INFO - PROCESS | 1648 | colorDepth:24 18:15:22 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 18:15:22 INFO - PROCESS | 1648 | __metrics 18:15:22 INFO - PROCESS | 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:15:22 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:15:23 INFO - TEST-INFO | 1648: exit 0 18:15:23 INFO - Browser initialized. 18:15:23 INFO - Running cycle 1/1 for dromaeo_css test... 18:15:23 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmpiRecPF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:15:35 INFO - PROCESS | 1651 | RSS: Main: 219455488 18:15:35 INFO - PROCESS | 1651 | 18:16:27 INFO - PROCESS | 1651 | 1475111787011 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] 18:18:39 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 18:18:40 INFO - PROCESS | 1651 | RSS: Main: 356315136 18:18:40 INFO - PROCESS | 1651 | 18:21:43 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 18:21:44 INFO - PROCESS | 1651 | RSS: Main: 350961664 18:21:44 INFO - PROCESS | 1651 | 18:24:46 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 18:24:47 INFO - PROCESS | 1651 | RSS: Main: 316059648 18:24:47 INFO - PROCESS | 1651 | 18:27:49 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 18:27:50 INFO - PROCESS | 1651 | RSS: Main: 320663552 18:27:50 INFO - PROCESS | 1651 | 18:30:53 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 18:30:53 INFO - PROCESS | 1651 | RSS: Main: 307437568 18:30:53 INFO - PROCESS | 1651 | 18:33:57 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 18:33:57 INFO - PROCESS | 1651 | RSS: Main: 467820544 18:33:57 INFO - PROCESS | 1651 | 18:33:57 INFO - PROCESS | 1651 | __start_tp_report 18:33:57 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 18:33:57 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 18:33:57 INFO - PROCESS | 1651 | |i|pagename|runs| 18:33:57 INFO - PROCESS | 1651 | |0;dojo.html;3284.211789170599;3303.43841546937;3353.882614108505;3361.2941282330708;3392.660733926606;4624.676272660911;5698.772049118035;5717.171010203529;5717.342505611856;5751.626144300622;5557.972210138953;5589.888202235953;5680.914786278209;5682.659040457565;5748.568857335696;5085.771140298695;5170.741462926858;5183.989122121188;5208.661437006602;5219.347581552306;5146.073706732786;5146.176611742122;5148.3564554430695;5321.866953326159;5364;5160.974195129038;5226.608004399666;5244.344456942882;5253.080710875582;5256.526912577867;5188.195829646373;5216.217567364888;5232;5232.529072383485;5238.319018527605;5097.337346144977;5206.088934436459;5221.738913054332;5255.86860328491;5287.762050707727;5562.221289019541;5588.4411558844195;5620.156976453564;5683.54531637468;5720.056190728525;5241.95160967808;6125.449118208391;6174.320824709278;6211.068339749028;6278.4035516625845;6284.7486100555925;6293.087502312139;6338.239411270631;6348.206474190726;6359.713812878432;4489.842855500042;5698.686572238566;5746.913796293059;5822.243108395882;5851.912221316684;6306.24325080984;6355.205599300088;6368;6369;6418.101465794793;6147.815565533041;6157.815265542041;6161;6178.351273116258;6179.16581261524;6252.030935205051;6265.279492858289;6292.2134733158355;6319.24169099711;6351.68241587928;6042.848928776728;6085.2393450818645;6093.66484843329;6115.575014303891;6197.4732147767045;6185.134081228632;6264.968675156686;6270.7805226816845;6273.8745225095245;6293.118963345135;4936.111499929975;4938.333325001151;4941.1847045237855;4954.578860796801;4960.603151747851;4327.156204540147;4349.956500435019;4354.9782251088545;4361.498427680857;4424.557544245614;5613.270274864323;5621.184928185472;5640.182173584889;5671.971640141773;5697.544196464273;6311.431971122621;6328.082428047907;6340.080688300171;6345.555811093272;6349.52378571609;5523.1163013918385;5544.500994910478;5691.174779657009;5702.572307076985;5704.1443783432815;5352.545033672103;5355.169948657965;5368.32895888014;5373.032854086224;5378.51593356592;6357.205349331333;6364.459020983269;6374.235091789015;6376.9043464349;6395.616263024233;6274.341194174728;6322.083297921684;6345.555811093179;6350.7777227796805;6369.968150159405;6284.151639528605;6338.207724034496;6340.334264902303;6344.460720838781;6414.134091897721;5982.4316689914385;6101.054336577838;6121.483458747687;6122.571420000735;6135;6024.3975602439405;6241.843953901007;6244.687765611792;6272.153259309935;6277.089821975879;5832.562557808096;5873.3832947539895;6051.364606716232;6069.787557435468;6116.082587611894;5898.203742494708;5975.970120149372;5979.372165922516;6007.759689612367;6054.515638748978;5126.512981266774;5962.433568810956;5982.7307771149535;6018.759249629966;6023.036314189709;5679.914801278067;6117.571769976059;6138.3861613840045;6163.044728067157;6182.258129024546;5695.8860822784145;5785.913211301918;5788.855278618068;5881.382454842351;5954.047352423591 18:33:57 INFO - PROCESS | 1651 | |1;ext.html;502.63810056759144;519.9315406838946;532.4489153725895;534.6364472158933;571.5170680774744;30281;39705.2058958821;40978.18043639129;41170;43621.345679814825;42981;43215.567844321544;43229.35155972663;43333.13333733323;43357;8259.380546459024;8624.396292259544;9946.154576860976;9969.950150249239;9970.25223108266;8691.39160258782;11868.10989175811;12132.878671213308;12166.51333946641;12488.81266780999;12039.036877049859;12130.93934530326;12133.150679452441;12143.878561214407;12179.51281948721;12043.217190882653;12195.756084878298;12285.754284914252;12296.954758845508;12337.506499739955;11660.30038197711;11974.940125299318;12028.759424811542;12039.81940270888;12044.518219271218;40205.79897100496;40226;40405;40493.39259911104;40533.18933621341;3340.4154273002127;3423.4180189367867;3452.585689717225;3466.636003219651;3776.678982286509;29351;30964.69035309663;31330.06009819709;31421.528677069862;31800.840995795104;3138.6547479777205;3265.9836700816345;3288.5067239914206;3290.128116049249;3339.31544033475;479425;480010;484376;484592;487549;61490;62075;62117.37882621116;62184;62358.688206558676;34373.65626343704;34526.136846578534;35385.46921796175;36268.274634507165;64617.67691161514;16754.4135955241;16873.493795186165;16906.239219234918;16908.661826763397;16941;11570.19008669385;11766.88233117675;12887.968962482979;13009.804852927213;13034.283114428797;16483.83516164823;16505.752413713803;16619.41832035873;16687.749683754755;18718.344857929907;7358.521696089844;7561.508501947355;7823.530588164728;8000.559969201633;8102.675892964333;864.2955990867548;946.3422921069928;989.366805244644;1058.5183741397645;1060.607575197182;29197.708022919498;29961;29984.70015299819;30697.84651076775;30758;1061.7770268243755;1081.859358283418;1082.4641802307908;1107.839363292318;1110.955561777536;15322.770158447409;15643.921780391252;15648.530544083696;16034.278457469441;16109.27508262131;638675.8066209732;672441;699569;709021;999758.0012099893;46866;47405;55841;56776;57005;1374.4639590559689;1398.930053497321;1416.7449859025269;1419.822522184727;1421.0265967812081;30026.099217023526;30775;31029;31749.841250793597;32137.67862321347;55504.16743748766;56181.59546011382;56243.718781405834;56261.71869140792;56293.71853140708;658761;665923;667546;667713;669185;26701;27149.59275610907;27172.864135679985;42870.785646072814;43526.56473435352;44907;47003.52996470128;47550.76224618855;47974.28038579494;48079.75960120177;37142.44286335653;38652.17111101228;38880;39458;39806.402903957045;32669;38699.80650096844;38827;39828.800855995534;40233.1953360937;37644.81177594094;37856.86429407122;38544.6145538541;38819.805900970314;38837.80581097189;31533.52699709552;33436.83281583576;33672;33863.15342116368;33948.83025584856;21269;25022;25302;25747;26149.73850261473 18:33:57 INFO - PROCESS | 1651 | |2;jquery.html;333.60634451347414;355.51294726225075;374.195479718605;381.3250546532638;397.8965468978067;15340.923295383522;15442.69114617707;16606.169691515406;20903;21336.679949800728;19510.219591216333;20295.49261268469;20840.270590529333;20975.58048839026;21028.474288142803;4727.550882666158;5956.166136740849;6202.472789812871;6213.782517611885;6217.59585626935;5583.469570390806;6015.458608725214;6021.879562408749;6209.75160993562;6216.2851272103835;5250.6324557281005;5900;6149.3235744068115;6167.444929956303;6232.719527621268;6196.78311259106;6234.906476402857;6237.282712488077;6241.719122639447;6247.500199983991;5723.713814309268;5785.48688110661;5817.563682723812;5819.156222347779;5833.445822646841;13145.014123940648;13318.467261309634;13482.730345393038;20174.99125043742;25314.74685253142;2206.6689996500495;2216.4348091236793;2225.9554808903895;2251.6397376419695;2293.3693234360517;9950.910308835153;10111.696649100539;10368.948155259252;10598.735031624194;10650.786984260272;1537.3005282596391;1906.389955214332;1917.7986311437237;1959.4317647882096;1964.5481539246055;125737.37131314285;125876;126497;129123.35438322749;131640;9371.718848434557;9800.852987205197;9889.159421449114;9968.900310996942;11616.186866919235;12560.74878502443;12616.55842045524;12637;12646.873531264753;12654.987600991899;8105.230003149692;8169.42814003026;8184;8203;8209.71266005687;8612.655493780305;8624.482531048157;8626.956865215634;8794.560271986375;8834;3892.708046896494;3898.1229223424502;3908.8241029153755;3970.642642162219;3971.900702482403;1905.9428217153506;1916.6645836978473;1920.9423717288503;1927.9036048197815;1967.517958100246;803.3854101612271;851.199872120205;858.4934888415739;866.3978534918172;994.6469003503652;20278.087486063163;21793.94290682501;21834.196476775083;21851.021661316805;21931.01310441034;829.7344849648055;935.5228833294932;955.6273053509137;960.9807803843884;977.4575110813424;9646.324757266924;11220.775584488265;11406.08751299894;11463.770724585629;11557.13321500874;646076;649012;652273;664979.0506284819;667637;87686;116530.41734791441;119108.99999999827;136764;144190;891.6477991193442;920.7099763574453;950.7575568230058;951.3863558005048;980.8970058143935;19334.8066519333;19427.4171774847;19992.20031198736;20052.498687532345;20101.798982009994;57668;58139.837203256546;58196.12705809331;58473.415265848496;58645.70677146587;83553;83679.5816020916;83907;85520;86713.26573468621;7789.298963093349;7857.724979625686;7944.245296696805;8160.755177344689;8413.990321161255;11344.886551134383;12601.306928119042;12838.55065072718;12861.614151575468;13033;10681.359118452918;10717.070927233173;11041.282316649393;11216.495257713259;11219.71950701239;9798.902010980084;10148.695539133543;10902.073323767569;11188.104951604015;11619.709507262387;9657.517124143906;11409.25839820409;11483.081353491534;11520.135989800967;11697.122715796178;8199.262066414052;8281.751547453587;8394.832103357776;8422.368322375723;8430.6206220719;7317.2316906726155;7795.64919578609;7877.291043805856;7928.643211055632;8224.136465671018 18:33:57 INFO - PROCESS | 1651 | |3;mootools.html;1509.554681368996;1517.9772303415448;1729.3947118508515;1866.3281218761251;1909.8949557774317;8568.186022327876;9075.273978081754;9095.90904090959;9114.04302548232;9119.221751758401;8071;8284.171582841713;8297.128801475848;8739.213470787628;8946.91053089469;2398.7721166489155;2441.7802397784194;2442;2443.376938880583;2450.264920523836;2108.7153234313323;2386.427257458206;2404.6873906392143;2433.0875921529428;2460.458699086198;2037.4295197344768;2430.769076937688;2453.239495756321;2468.9259322220273;2470.2465747946867;2412.5777988852055;2445.72822132491;2447.0089613706386;2448.877556122187;2454.3373289211813;2415.1426243683413;2436.8050555955483;2442.413820683041;2446.510697860417;2448.26552034389;7607.543547387175;9070.591823367964;9196.448213107167;9217.986021537625;9234.584443700049;5334.706591137486;5505.944940550583;5518.034343989826;5525.088360420566;5573.442655734435;3592.4431713084514;3663.3772258715817;3732.5894151643297;3738.2337070567855;3746.68153206975;1111.5164903267105;1115.1691989467818;1124.730064784454;1129.0064743026085;1137.7895089408487;12131.150819442642;12140.757184856253;12229.93885030578;12231.571894983721;12256.632301030893;4470.664700147502;4602.654800889946;4724.622030237572;4730.574248317668;4739.478657347689;9246.214071803837;9422.670206542738;9439.103285187895;9443.10290522413;9451.196648284835;5359.624826262124;5373.946260537423;5375.731213439312;5378.354597448253;5394.757235924393;4506;4621.214393553104;4652.604528615038;5009.148444764399;5046.697198168048;3769.509963704701;3794.4498047782918;3872;3915.804209789499;3919.8824035278985;1172.1853311948114;1184.6505280942142;1184.8163534652142;1195.0917302849896;1199.0886925936352;794.6463823598559;886.4858382138344;902.7788191893028;919.8114386550741;936.4007035497287;5880.764769409261;5984.311804142492;5998.220231369894;6026.186464827279;6081.391860813972;906.1844340093836;910.7540963939832;927.3925578745932;944.2493217891792;981.6122631560494;3220.710136087763;4008.07814202735;4058.9594104058583;4111.712180147361;4195.119025004722;10629.73425664349;10766.461676916122;10993.450327483593;11054.502547385388;11307.94346028281;10976.725581860357;11227.55089796399;11229.438528073564;11244.831327530093;11255.380954047607;8129.593520323961;8556.40105192643;8586.270167035871;8589.484630922165;8590.570471476402;5983.282006159288;6049;6096.603720758137;6185;6250.281217659845;9178.449293042439;9512.239020878174;10347.223958203014;10421.322614030063;10647;10498.265121441425;10638.89361106379;10644.84032739494;10663.200259980378;10677.039066484054;7196.352328290479;7218.314260145278;7718.498297610638;7765.107012693386;7777.92222077772;8542.974843018877;8647.481151130953;8711.303095752452;8745.825083498421;8808.942926848818;7637.923620763943;7669.69321227167;7710.190430004769;7825.295723384923;7904.0119985001875;6430.228372595318;7430.777076687708;7501.774946751606;7567.091948966159;7616.20029896875;7118.644067796693;7288.198298187089;7290.05229320185;7290.9635451822405;7301.671424785791;4955.870008989771;4981.476944920876;5065.4174769900455;5104.2343648453025;5169.793208271777;4959.231319145538;4971.328870602422;5110.591152707849;5157.793688252428;5163.044836705071 18:33:57 INFO - PROCESS | 1651 | |4;prototype.html;303.89819410497483;305.9724624783769;312.30979535227146;318.37121684672786;318.6176588094286;4882.755862206889;5137.6403651744395;5450.983136239587;5462.754176062077;5557.194206840006;5118.795248190068;5124.718140502271;5153.046686363025;5293.338332708411;5328.387235467912;3190.5533225348413;4128.277551428503;4169.72896761711;4170.291050521419;4320.142338794317;3479.965200348002;4137.1518838638;4158.625723684868;4160.43834082398;4173.666106711471;3360;3428.6057103433177;3998.9400158997637;4074.5314288856866;4149.190907772985;3848.5183204466343;3869.2648396804516;4132.574261879647;4136.896577585554;4151.83392664293;3194.9201269968203;3467.6185619581825;3609.8736544221088;3620.438831981021;3629.491871138043;3795.411711184771;4260.68044896634;4343.435353404069;5287;5296.867578310535;4165.563674686449;4506.616937560311;4587.747673877935;4807.966287248259;4832.9758351208375;5023.648344615878;5502.872845365975;5608.317504748559;5700.344460387067;5774.249347584787;3648.981755091234;3881.7088718346236;3982.900427489336;3996.3805610130476;4023.2355852387955;4988.653063672824;5158.819441319573;5724.227229324071;6002.819915402545;6056.455603821041;4059.4316795648633;4065.2276067547073;4066.410370496321;4066.9796651017145;4071.3892916062237;3468.739844511672;3715.851365945332;3969.6030396960073;4170.436991006175;4181.477315335583;3832.463455116286;4441.422615060022;4623.53764623535;4674.929876051862;4696.7651617419;5378.332716857786;5730.882477916766;5747.971260143672;5767.307923049177;5822;1088.90199882011;1129.7796929598815;1263.564070395712;1276.8572127945622;1359.9728005439836;811.4157806379397;862.9299668411251;892.6563273139888;916.927195181639;929.1080562659787;4654.115718013567;5306.469353064663;5319.521243088141;5319.867003324948;5404.78380864761;5109;5635.408282130399;5871.442212989759;5897.882042359129;5931.139984702194;4340;4415.425994620743;4763.118568165624;5317.840464785985;5343.385510666245;2549.961750573743;2586.883590238444;3059.2198989257595;3074.9077527674203;3076;4878.341423907727;5851.034579294369;6011.789587364421;6046.848828779316;6100.206973093469;4770.713757174581;5938.703064846741;5950.67271300074;5999.880002400015;6016.578839481282;4948.925766113583;5199.948000519947;5784.074548072288;5906.7637294508595;6070.878582428327;5604.4532088565265;5728.598998070262;5747.683877386617;5811.169481613279;5834.649921004583;5172.663776854492;5640.956423061747;5699.173619825019;5732.742026608729;5783.421657834183;5663.292088488939;5816.73824677882;6000.249968753906;6060.454559089703;6061.999310341409;3851.9614803851605;3901.317269477773;3907.003714053012;3909.667678247381;3917.139358804545;5211.218317252443;5450.836474905759;5613.382527922007;5809.2738407699035;5814.476697097281;5460.426655201147;5487.945120548743;5524.91712624319;5630.85922851932;5703.289013296077;5552.7778888845605;5557.36090349615;5569.972150139223;5571.637843540157;5586.190002449704;5304.363476382859;5461.945380546303;5481.232627432242;5528.917066243929;5550.7779688812;4846.303793672187;5584.682356822036;5700.572457065654;5737.799177028784;5749.425057494217;4761.476237613929;5592.133219351007;5607.43925607436;5613.017721898733;5626.465485778845 18:33:57 INFO - PROCESS | 1651 | |5;yui.html;717.2218143314503;752.6199269368968;777.8501693465362;811.2090711556237;842.8537189422384;14970.92514537427;16054.357825686973;16124.677506449863;16332;16793.328266869343;14909.403623855032;15204.695906081899;15252.161131137784;15258.618534536614;15268.618284542892;663.7875879718492;829.8215883585028;853.5988085599789;853.9316854651613;854.4104567848196;676.1581830620884;820.1265652080515;838.7022606974527;841.9158084191563;859.3468963587655;902.5532361481077;904.1817155474306;904.6517090919978;905.7871400220976;907.3648446087732;896.9596368163383;897.6319708919377;897.989761518292;899.1952202778509;901.6123067081153;515.9561437277836;529.5684017525704;533.4985113992834;534.6604905884752;535.2586667465549;14729.410823567045;15341.232938353038;15354.53936381899;15550.688986220326;15571.688566228726;14568.854311456962;14958.62603434912;15013.3244004019;15065.09609423438;15247.618809529851;11474.94262528682;11530.250533715365;11769.999550038257;11957.342346170957;12364.44360003802;3864.3237433449035;3900;3949.308870947573;3995.5604883462797;4040.070783719761;105219.47390263;107882.46058769735;110129.89870101276;111162.77674446466;111651;11246.044086252596;11561.30632162073;11563.190576659554;11650.242734222249;11681.941590291994;23566.528669426516;23735.40661483442;23745.7625423747;23945.760542394702;23990.04039838387;7777.144514103444;7799.922000780033;7832.4908880923695;7833.707438272735;7835.6473958671995;4395.846145384896;4423.889402764892;4455.866324010285;4520.88697782558;4628.282616194495;3083.922901927425;3788.052986753312;3789.3558095123894;3790.5830358660523;3793.506844110248;656.829224401659;663.3101574362609;672.176583684982;679.0459404536535;679.296927679849;556.3240662594967;566.3883006353128;641.7112299465259;656.9967150164218;686.8351595617116;9160.587773550205;9264.351495395258;9334.113259240361;9378.343515953955;9617.16293693362;640.6604499615119;656.6421300391298;668.9264180940093;668.9966550167218;675.1054852320694;4050.473438453041;4488.798004089824;4503.752293623882;4516.458025037016;4598.908021839611;98496.50751746196;102975;106425;134356.32821835828;180652;128565;146908;147647.2617636905;149519.9134156149;152210;85384.99999999876;109040;112812.43593782143;113626;115111.42444287725;8986.101389860962;9705.369151005161;9771.218302535637;9775.560099795668;9777.902220977983;59034.70482647731;61921.9750716202;62290.68854655698;63736;64395.678021609594;59857;62469;86580.56709716411;87555.1244487547;89771.10228897627;11146.49840757184;13032;13079.692030797225;13460.394282257126;13677.931610341884;14276.785848212492;14287;14316.642083947985;14935.402583896523;15794.36822527086;13459.461621535029;13880.853101370742;14308.284585770878;14840.257987100385;14854.034487758261;13619.114757540729;13947.16317020982;14377.424903003763;14634.780478293047;14852.925735371255;12766.106372553832;12989.675258118623;13873;14223.573292801233;14271.71456570842;10479.528421220912;11836.82244766312;12008.159428839897;12063.879361206276;12235.571754988532;8463.49219046859;9818.950905245429;10111.533827595105;11617.926735768864;11803.291802491878 18:33:57 INFO - PROCESS | 1651 | __end_tp_report 18:33:57 INFO - PROCESS | 1651 | __start_cc_report 18:33:57 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1218 18:33:57 INFO - PROCESS | 1651 | __end_cc_report 18:33:57 INFO - PROCESS | 1651 | __startTimestamp1475112837289__endTimestamp 18:33:57 INFO - PROCESS | 1651 | 18:33:57 INFO - PROCESS | 1651 | ------- Summary: start ------- 18:33:57 INFO - PROCESS | 1651 | Number of tests: 6 18:33:57 INFO - PROCESS | 1651 | 18:33:57 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5713.68 Median:5873.38 stddev:665.79 (11.3%) stddev-sans-first:639.97 18:33:57 INFO - PROCESS | 1651 | Values: 3284.2 3303.4 3353.9 3361.3 3392.7 4624.7 5698.8 5717.2 5717.3 5751.6 5558.0 5589.9 5680.9 5682.7 5748.6 5085.8 5170.7 5184.0 5208.7 5219.3 5146.1 5146.2 5148.4 5321.9 5364.0 5161.0 5226.6 5244.3 5253.1 5256.5 5188.2 5216.2 5232.0 5232.5 5238.3 5097.3 5206.1 5221.7 5255.9 5287.8 5562.2 5588.4 5620.2 5683.5 5720.1 5242.0 6125.4 6174.3 6211.1 6278.4 6284.7 6293.1 6338.2 6348.2 6359.7 4489.8 5698.7 5746.9 5822.2 5851.9 6306.2 6355.2 6368.0 6369.0 6418.1 6147.8 6157.8 6161.0 6178.4 6179.2 6252.0 6265.3 6292.2 6319.2 6351.7 6042.8 6085.2 6093.7 6115.6 6197.5 6185.1 6265.0 6270.8 6273.9 6293.1 4936.1 4938.3 4941.2 4954.6 4960.6 4327.2 4350.0 4355.0 4361.5 4424.6 5613.3 5621.2 5640.2 5672.0 5697.5 6311.4 6328.1 6340.1 6345.6 6349.5 5523.1 5544.5 5691.2 5702.6 5704.1 5352.5 5355.2 5368.3 5373.0 5378.5 6357.2 6364.5 6374.2 6376.9 6395.6 6274.3 6322.1 6345.6 6350.8 6370.0 6284.2 6338.2 6340.3 6344.5 6414.1 5982.4 6101.1 6121.5 6122.6 6135.0 6024.4 6241.8 6244.7 6272.2 6277.1 5832.6 5873.4 6051.4 6069.8 6116.1 5898.2 5976.0 5979.4 6007.8 6054.5 5126.5 5962.4 5982.7 6018.8 6023.0 5679.9 6117.6 6138.4 6163.0 6182.3 5695.9 5785.9 5788.9 5881.4 5954.0 18:33:57 INFO - PROCESS | 1651 | 18:33:57 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:75315.47 Median:18996.39 stddev:173185.40 (911.7%) stddev-sans-first:173580.14 18:33:57 INFO - PROCESS | 1651 | Values: 502.6 519.9 532.4 534.6 571.5 30281.0 39705.2 40978.2 41170.0 43621.3 42981.0 43215.6 43229.4 43333.1 43357.0 8259.4 8624.4 9946.2 9970.0 9970.3 8691.4 11868.1 12132.9 12166.5 12488.8 12039.0 12130.9 12133.2 12143.9 12179.5 12043.2 12195.8 12285.8 12297.0 12337.5 11660.3 11974.9 12028.8 12039.8 12044.5 40205.8 40226.0 40405.0 40493.4 40533.2 3340.4 3423.4 3452.6 3466.6 3776.7 29351.0 30964.7 31330.1 31421.5 31800.8 3138.7 3266.0 3288.5 3290.1 3339.3 479425.0 480010.0 484376.0 484592.0 487549.0 61490.0 62075.0 62117.4 62184.0 62358.7 34373.7 34526.1 35385.5 36268.3 64617.7 16754.4 16873.5 16906.2 16908.7 16941.0 11570.2 11766.9 12888.0 13009.8 13034.3 16483.8 16505.8 16619.4 16687.7 18718.3 7358.5 7561.5 7823.5 8000.6 8102.7 864.3 946.3 989.4 1058.5 1060.6 29197.7 29961.0 29984.7 30697.8 30758.0 1061.8 1081.9 1082.5 1107.8 1111.0 15322.8 15643.9 15648.5 16034.3 16109.3 638675.8 672441.0 699569.0 709021.0 999758.0 46866.0 47405.0 55841.0 56776.0 57005.0 1374.5 1398.9 1416.7 1419.8 1421.0 30026.1 30775.0 31029.0 31749.8 32137.7 55504.2 56181.6 56243.7 56261.7 56293.7 658761.0 665923.0 667546.0 667713.0 669185.0 26701.0 27149.6 27172.9 42870.8 43526.6 44907.0 47003.5 47550.8 47974.3 48079.8 37142.4 38652.2 38880.0 39458.0 39806.4 32669.0 38699.8 38827.0 39828.8 40233.2 37644.8 37856.9 38544.6 38819.8 38837.8 31533.5 33436.8 33672.0 33863.2 33948.8 21269.0 25022.0 25302.0 25747.0 26149.7 18:33:57 INFO - PROCESS | 1651 | 18:33:57 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:36608.85 Median:4349.73 stddev:109279.13 (2512.3%) stddev-sans-first:109551.74 18:33:57 INFO - PROCESS | 1651 | Values: 333.6 355.5 374.2 381.3 397.9 15340.9 15442.7 16606.2 20903.0 21336.7 19510.2 20295.5 20840.3 20975.6 21028.5 4727.6 5956.2 6202.5 6213.8 6217.6 5583.5 6015.5 6021.9 6209.8 6216.3 5250.6 5900.0 6149.3 6167.4 6232.7 6196.8 6234.9 6237.3 6241.7 6247.5 5723.7 5785.5 5817.6 5819.2 5833.4 13145.0 13318.5 13482.7 20175.0 25314.7 2206.7 2216.4 2226.0 2251.6 2293.4 9950.9 10111.7 10368.9 10598.7 10650.8 1537.3 1906.4 1917.8 1959.4 1964.5 125737.4 125876.0 126497.0 129123.4 131640.0 9371.7 9800.9 9889.2 9968.9 11616.2 12560.7 12616.6 12637.0 12646.9 12655.0 8105.2 8169.4 8184.0 8203.0 8209.7 8612.7 8624.5 8627.0 8794.6 8834.0 3892.7 3898.1 3908.8 3970.6 3971.9 1905.9 1916.7 1920.9 1927.9 1967.5 803.4 851.2 858.5 866.4 994.6 20278.1 21793.9 21834.2 21851.0 21931.0 829.7 935.5 955.6 961.0 977.5 9646.3 11220.8 11406.1 11463.8 11557.1 646076.0 649012.0 652273.0 664979.1 667637.0 87686.0 116530.4 119109.0 136764.0 144190.0 891.6 920.7 950.8 951.4 980.9 19334.8 19427.4 19992.2 20052.5 20101.8 57668.0 58139.8 58196.1 58473.4 58645.7 83553.0 83679.6 83907.0 85520.0 86713.3 7789.3 7857.7 7944.2 8160.8 8414.0 11344.9 12601.3 12838.6 12861.6 13033.0 10681.4 10717.1 11041.3 11216.5 11219.7 9798.9 10148.7 10902.1 11188.1 11619.7 9657.5 11409.3 11483.1 11520.1 11697.1 8199.3 8281.8 8394.8 8422.4 8430.6 7317.2 7795.6 7877.3 7928.6 8224.1 18:33:57 INFO - PROCESS | 1651 | 18:33:57 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5822.75 Median:5027.92 stddev:3285.60 (65.3%) stddev-sans-first:3278.83 18:33:57 INFO - PROCESS | 1651 | Values: 1509.6 1518.0 1729.4 1866.3 1909.9 8568.2 9075.3 9095.9 9114.0 9119.2 8071.0 8284.2 8297.1 8739.2 8946.9 2398.8 2441.8 2442.0 2443.4 2450.3 2108.7 2386.4 2404.7 2433.1 2460.5 2037.4 2430.8 2453.2 2468.9 2470.2 2412.6 2445.7 2447.0 2448.9 2454.3 2415.1 2436.8 2442.4 2446.5 2448.3 7607.5 9070.6 9196.4 9218.0 9234.6 5334.7 5505.9 5518.0 5525.1 5573.4 3592.4 3663.4 3732.6 3738.2 3746.7 1111.5 1115.2 1124.7 1129.0 1137.8 12131.2 12140.8 12229.9 12231.6 12256.6 4470.7 4602.7 4724.6 4730.6 4739.5 9246.2 9422.7 9439.1 9443.1 9451.2 5359.6 5373.9 5375.7 5378.4 5394.8 4506.0 4621.2 4652.6 5009.1 5046.7 3769.5 3794.4 3872.0 3915.8 3919.9 1172.2 1184.7 1184.8 1195.1 1199.1 794.6 886.5 902.8 919.8 936.4 5880.8 5984.3 5998.2 6026.2 6081.4 906.2 910.8 927.4 944.2 981.6 3220.7 4008.1 4059.0 4111.7 4195.1 10629.7 10766.5 10993.5 11054.5 11307.9 10976.7 11227.6 11229.4 11244.8 11255.4 8129.6 8556.4 8586.3 8589.5 8590.6 5983.3 6049.0 6096.6 6185.0 6250.3 9178.4 9512.2 10347.2 10421.3 10647.0 10498.3 10638.9 10644.8 10663.2 10677.0 7196.4 7218.3 7718.5 7765.1 7777.9 8543.0 8647.5 8711.3 8745.8 8808.9 7637.9 7669.7 7710.2 7825.3 7904.0 6430.2 7430.8 7501.8 7567.1 7616.2 7118.6 7288.2 7290.1 7291.0 7301.7 4955.9 4981.5 5065.4 5104.2 5169.8 4959.2 4971.3 5110.6 5157.8 5163.0 18:33:57 INFO - PROCESS | 1651 | 18:33:57 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4571.44 Median:5165.74 stddev:1421.26 (27.5%) stddev-sans-first:1388.68 18:33:57 INFO - PROCESS | 1651 | Values: 303.9 306.0 312.3 318.4 318.6 4882.8 5137.6 5451.0 5462.8 5557.2 5118.8 5124.7 5153.0 5293.3 5328.4 3190.6 4128.3 4169.7 4170.3 4320.1 3480.0 4137.2 4158.6 4160.4 4173.7 3360.0 3428.6 3998.9 4074.5 4149.2 3848.5 3869.3 4132.6 4136.9 4151.8 3194.9 3467.6 3609.9 3620.4 3629.5 3795.4 4260.7 4343.4 5287.0 5296.9 4165.6 4506.6 4587.7 4808.0 4833.0 5023.6 5502.9 5608.3 5700.3 5774.2 3649.0 3881.7 3982.9 3996.4 4023.2 4988.7 5158.8 5724.2 6002.8 6056.5 4059.4 4065.2 4066.4 4067.0 4071.4 3468.7 3715.9 3969.6 4170.4 4181.5 3832.5 4441.4 4623.5 4674.9 4696.8 5378.3 5730.9 5748.0 5767.3 5822.0 1088.9 1129.8 1263.6 1276.9 1360.0 811.4 862.9 892.7 916.9 929.1 4654.1 5306.5 5319.5 5319.9 5404.8 5109.0 5635.4 5871.4 5897.9 5931.1 4340.0 4415.4 4763.1 5317.8 5343.4 2550.0 2586.9 3059.2 3074.9 3076.0 4878.3 5851.0 6011.8 6046.8 6100.2 4770.7 5938.7 5950.7 5999.9 6016.6 4948.9 5199.9 5784.1 5906.8 6070.9 5604.5 5728.6 5747.7 5811.2 5834.6 5172.7 5641.0 5699.2 5732.7 5783.4 5663.3 5816.7 6000.2 6060.5 6062.0 3852.0 3901.3 3907.0 3909.7 3917.1 5211.2 5450.8 5613.4 5809.3 5814.5 5460.4 5487.9 5524.9 5630.9 5703.3 5552.8 5557.4 5570.0 5571.6 5586.2 5304.4 5461.9 5481.2 5528.9 5550.8 4846.3 5584.7 5700.6 5737.8 5749.4 4761.5 5592.1 5607.4 5613.0 5626.5 18:33:57 INFO - PROCESS | 1651 | 18:33:57 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:24333.01 Median:3828.92 stddev:38523.82 (1006.1%) stddev-sans-first:38591.08 18:33:57 INFO - PROCESS | 1651 | Values: 717.2 752.6 777.9 811.2 842.9 14970.9 16054.4 16124.7 16332.0 16793.3 14909.4 15204.7 15252.2 15258.6 15268.6 663.8 829.8 853.6 853.9 854.4 676.2 820.1 838.7 841.9 859.3 902.6 904.2 904.7 905.8 907.4 897.0 897.6 898.0 899.2 901.6 516.0 529.6 533.5 534.7 535.3 14729.4 15341.2 15354.5 15550.7 15571.7 14568.9 14958.6 15013.3 15065.1 15247.6 11474.9 11530.3 11770.0 11957.3 12364.4 3864.3 3900.0 3949.3 3995.6 4040.1 105219.5 107882.5 110129.9 111162.8 111651.0 11246.0 11561.3 11563.2 11650.2 11681.9 23566.5 23735.4 23745.8 23945.8 23990.0 7777.1 7799.9 7832.5 7833.7 7835.6 4395.8 4423.9 4455.9 4520.9 4628.3 3083.9 3788.1 3789.4 3790.6 3793.5 656.8 663.3 672.2 679.0 679.3 556.3 566.4 641.7 657.0 686.8 9160.6 9264.4 9334.1 9378.3 9617.2 640.7 656.6 668.9 669.0 675.1 4050.5 4488.8 4503.8 4516.5 4598.9 98496.5 102975.0 106425.0 134356.3 180652.0 128565.0 146908.0 147647.3 149519.9 152210.0 85385.0 109040.0 112812.4 113626.0 115111.4 8986.1 9705.4 9771.2 9775.6 9777.9 59034.7 61922.0 62290.7 63736.0 64395.7 59857.0 62469.0 86580.6 87555.1 89771.1 11146.5 13032.0 13079.7 13460.4 13677.9 14276.8 14287.0 14316.6 14935.4 15794.4 13459.5 13880.9 14308.3 14840.3 14854.0 13619.1 13947.2 14377.4 14634.8 14852.9 12766.1 12989.7 13873.0 14223.6 14271.7 10479.5 11836.8 12008.2 12063.9 12235.6 8463.5 9819.0 10111.5 11617.9 11803.3 18:33:57 INFO - PROCESS | 1651 | -------- Summary: end -------- 18:33:57 INFO - PROCESS | 1651 | 18:33:57 INFO - TEST-INFO | 1651: exit 0 18:33:57 INFO - TEST-OK | dromaeo_css | took 1117692ms 18:33:57 INFO - TEST-START | kraken 18:33:57 INFO - operating with platform_type : mac_ 18:33:57 INFO - Initialising browser for kraken test... 18:33:57 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmpzci9Mk/profile http://localhost:49272/getInfo.html) 18:34:00 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 18:34:00 INFO - PROCESS | 1657 | colorDepth:24 18:34:00 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 18:34:00 INFO - PROCESS | 1657 | __metrics 18:34:00 INFO - PROCESS | 1657 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:34:00 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:34:01 INFO - TEST-INFO | 1657: exit 0 18:34:01 INFO - Browser initialized. 18:34:01 INFO - Running cycle 1/1 for kraken test... 18:34:01 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmpzci9Mk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:34:13 INFO - PROCESS | 1658 | RSS: Main: 219254784 18:34:13 INFO - PROCESS | 1658 | 18:34:16 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 18:34:16 INFO - PROCESS | 1658 | RSS: Main: 269258752 18:34:16 INFO - PROCESS | 1658 | 18:34:19 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 18:34:20 INFO - PROCESS | 1658 | RSS: Main: 280477696 18:34:20 INFO - PROCESS | 1658 | 18:34:23 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 18:34:23 INFO - PROCESS | 1658 | RSS: Main: 376995840 18:34:23 INFO - PROCESS | 1658 | 18:34:25 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 18:34:26 INFO - PROCESS | 1658 | RSS: Main: 279621632 18:34:26 INFO - PROCESS | 1658 | 18:34:28 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:34:29 INFO - PROCESS | 1658 | RSS: Main: 280576000 18:34:29 INFO - PROCESS | 1658 | 18:34:31 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 18:34:32 INFO - PROCESS | 1658 | RSS: Main: 316325888 18:34:32 INFO - PROCESS | 1658 | 18:34:35 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 18:34:36 INFO - PROCESS | 1658 | RSS: Main: 318369792 18:34:36 INFO - PROCESS | 1658 | 18:34:38 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 18:34:39 INFO - PROCESS | 1658 | RSS: Main: 316116992 18:34:39 INFO - PROCESS | 1658 | 18:34:41 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:34:41 INFO - PROCESS | 1658 | RSS: Main: 289792000 18:34:41 INFO - PROCESS | 1658 | 18:34:43 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:34:44 INFO - PROCESS | 1658 | RSS: Main: 295104512 18:34:44 INFO - PROCESS | 1658 | 18:34:46 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:34:47 INFO - PROCESS | 1658 | RSS: Main: 299548672 18:34:47 INFO - PROCESS | 1658 | 18:34:50 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:34:50 INFO - PROCESS | 1658 | RSS: Main: 313716736 18:34:50 INFO - PROCESS | 1658 | 18:34:53 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:34:54 INFO - PROCESS | 1658 | RSS: Main: 310030336 18:34:54 INFO - PROCESS | 1658 | 18:34:56 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 18:34:56 INFO - PROCESS | 1658 | RSS: Main: 353136640 18:34:56 INFO - PROCESS | 1658 | 18:34:56 INFO - PROCESS | 1658 | __start_tp_report 18:34:56 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 18:34:56 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 18:34:56 INFO - PROCESS | 1658 | |i|pagename|runs| 18:34:56 INFO - PROCESS | 1658 | |0;ai-astar;115;112;114;112;112;112;113;112;111;113 18:34:56 INFO - PROCESS | 1658 | |1;audio-beat-detection;141;109;112;176;140;111;110;108;140;107 18:34:56 INFO - PROCESS | 1658 | |2;audio-dft;180;184;183;184;182;184;182;183;183;183 18:34:56 INFO - PROCESS | 1658 | |3;audio-fft;77;55;60;88;64;59;60;59;83;58 18:34:56 INFO - PROCESS | 1658 | |4;audio-oscillator;88;70;96;97;54;76;117;100;99;103 18:34:56 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;87;84;87;84;86;83;87;83;86;84 18:34:56 INFO - PROCESS | 1658 | |6;imaging-darkroom;95;95;95;95;94;95;95;96;95;95 18:34:56 INFO - PROCESS | 1658 | |7;imaging-desaturate;87;83;84;82;86;84;83;83;84;83 18:34:56 INFO - PROCESS | 1658 | |8;json-parse-financial;58;53;52;51;53;55;77;88;87;88 18:34:56 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;71;73;66;76;71;69;71;70;71;72 18:34:56 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;84;82;86;83;85;85;82;84;90;89 18:34:56 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;143;146;154;137;154;142;157;155;193;132 18:34:56 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;163;167;226;204;165;164;163;161;164;164 18:34:56 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;67;67;68;68;67;66;67;69;70;77 18:34:56 INFO - PROCESS | 1658 | __end_tp_report 18:34:56 INFO - PROCESS | 1658 | __start_cc_report 18:34:56 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1991 18:34:56 INFO - PROCESS | 1658 | __end_cc_report 18:34:56 INFO - PROCESS | 1658 | __startTimestamp1475112896479__endTimestamp 18:34:56 INFO - PROCESS | 1658 | 18:34:56 INFO - PROCESS | 1658 | ------- Summary: start ------- 18:34:56 INFO - PROCESS | 1658 | Number of tests: 14 18:34:56 INFO - PROCESS | 1658 | 18:34:56 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:112.60 Median:112.50 stddev:1.17 (1.0%) stddev-sans-first:0.87 18:34:56 INFO - PROCESS | 1658 | Values: 115.0 112.0 114.0 112.0 112.0 112.0 113.0 112.0 111.0 113.0 18:34:56 INFO - PROCESS | 1658 | 18:34:56 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:125.40 Median:126.00 stddev:23.01 (18.3%) stddev-sans-first:23.70 18:34:56 INFO - PROCESS | 1658 | Values: 141.0 109.0 112.0 176.0 140.0 111.0 110.0 108.0 140.0 107.0 18:34:56 INFO - PROCESS | 1658 | 18:34:56 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:182.80 Median:183.00 stddev:1.23 (0.7%) stddev-sans-first:0.78 18:34:56 INFO - PROCESS | 1658 | Values: 180.0 184.0 183.0 184.0 182.0 184.0 182.0 183.0 183.0 183.0 18:34:56 INFO - PROCESS | 1658 | 18:34:56 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:66.30 Median:62.00 stddev:11.80 (19.0%) stddev-sans-first:11.86 18:34:56 INFO - PROCESS | 1658 | Values: 77.0 55.0 60.0 88.0 64.0 59.0 60.0 59.0 83.0 58.0 18:34:56 INFO - PROCESS | 1658 | 18:34:56 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:82.00 stddev:18.44 (22.5%) stddev-sans-first:19.54 18:34:56 INFO - PROCESS | 1658 | Values: 88.0 70.0 96.0 97.0 54.0 76.0 117.0 100.0 99.0 103.0 18:34:56 INFO - PROCESS | 1658 | 18:34:56 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:85.10 Median:86.00 stddev:1.66 (1.9%) stddev-sans-first:1.62 18:34:56 INFO - PROCESS | 1658 | Values: 87.0 84.0 87.0 84.0 86.0 83.0 87.0 83.0 86.0 84.0 18:34:56 INFO - PROCESS | 1658 | 18:34:56 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 18:34:56 INFO - PROCESS | 1658 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 96.0 95.0 95.0 18:34:56 INFO - PROCESS | 1658 | 18:34:56 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:83.90 Median:84.00 stddev:1.52 (1.8%) stddev-sans-first:1.13 18:34:56 INFO - PROCESS | 1658 | Values: 87.0 83.0 84.0 82.0 86.0 84.0 83.0 83.0 84.0 83.0 18:34:56 INFO - PROCESS | 1658 | 18:34:56 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:66.20 Median:67.50 stddev:16.58 (24.6%) stddev-sans-first:17.32 18:34:56 INFO - PROCESS | 1658 | Values: 58.0 53.0 52.0 51.0 53.0 55.0 77.0 88.0 87.0 88.0 18:34:56 INFO - PROCESS | 1658 | 18:34:56 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:71.00 stddev:2.58 (3.6%) stddev-sans-first:2.74 18:34:56 INFO - PROCESS | 1658 | Values: 71.0 73.0 66.0 76.0 71.0 69.0 71.0 70.0 71.0 72.0 18:34:56 INFO - PROCESS | 1658 | 18:34:56 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.00 stddev:2.71 (3.2%) stddev-sans-first:2.85 18:34:56 INFO - PROCESS | 1658 | Values: 84.0 82.0 86.0 83.0 85.0 85.0 82.0 84.0 90.0 89.0 18:34:56 INFO - PROCESS | 1658 | 18:34:56 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:151.30 Median:154.00 stddev:16.87 (11.0%) stddev-sans-first:17.62 18:34:56 INFO - PROCESS | 1658 | Values: 143.0 146.0 154.0 137.0 154.0 142.0 157.0 155.0 193.0 132.0 18:34:56 INFO - PROCESS | 1658 | 18:34:56 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.10 Median:164.50 stddev:22.22 (13.5%) stddev-sans-first:23.21 18:34:56 INFO - PROCESS | 1658 | Values: 163.0 167.0 226.0 204.0 165.0 164.0 163.0 161.0 164.0 164.0 18:34:56 INFO - PROCESS | 1658 | 18:34:56 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.00 stddev:3.17 (4.7%) stddev-sans-first:3.31 18:34:56 INFO - PROCESS | 1658 | Values: 67.0 67.0 68.0 68.0 67.0 66.0 67.0 69.0 70.0 77.0 18:34:56 INFO - PROCESS | 1658 | -------- Summary: end -------- 18:34:56 INFO - PROCESS | 1658 | 18:34:57 INFO - TEST-INFO | 1658: exit 0 18:34:57 INFO - TEST-OK | kraken | took 59389ms 18:34:57 INFO - SUITE-END | took 1177s 18:34:57 INFO - Completed test suite (00:19:37) 18:34:57 INFO - javascript benchmark 18:34:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3284.211789170599, 3303.43841546937, 3353.882614108505, 3361.2941282330708, 3392.660733926606, 4624.676272660911, 5698.772049118035, 5717.171010203529, 5717.342505611856, 5751.626144300622, 5557.972210138953, 5589.888202235953, 5680.914786278209, 5682.659040457565, 5748.568857335696, 5085.771140298695, 5170.741462926858, 5183.989122121188, 5208.661437006602, 5219.347581552306, 5146.073706732786, 5146.176611742122, 5148.3564554430695, 5321.866953326159, 5364.0, 5160.974195129038, 5226.608004399666, 5244.344456942882, 5253.080710875582, 5256.526912577867, 5188.195829646373, 5216.217567364888, 5232.0, 5232.529072383485, 5238.319018527605, 5097.337346144977, 5206.088934436459, 5221.738913054332, 5255.86860328491, 5287.762050707727, 5562.221289019541, 5588.4411558844195, 5620.156976453564, 5683.54531637468, 5720.056190728525, 5241.95160967808, 6125.449118208391, 6174.320824709278, 6211.068339749028, 6278.4035516625845, 6284.7486100555925, 6293.087502312139, 6338.239411270631, 6348.206474190726, 6359.713812878432, 4489.842855500042, 5698.686572238566, 5746.913796293059, 5822.243108395882, 5851.912221316684, 6306.24325080984, 6355.205599300088, 6368.0, 6369.0, 6418.101465794793, 6147.815565533041, 6157.815265542041, 6161.0, 6178.351273116258, 6179.16581261524, 6252.030935205051, 6265.279492858289, 6292.2134733158355, 6319.24169099711, 6351.68241587928, 6042.848928776728, 6085.2393450818645, 6093.66484843329, 6115.575014303891, 6197.4732147767045, 6185.134081228632, 6264.968675156686, 6270.7805226816845, 6273.8745225095245, 6293.118963345135, 4936.111499929975, 4938.333325001151, 4941.1847045237855, 4954.578860796801, 4960.603151747851, 4327.156204540147, 4349.956500435019, 4354.9782251088545, 4361.498427680857, 4424.557544245614, 5613.270274864323, 5621.184928185472, 5640.182173584889, 5671.971640141773, 5697.544196464273, 6311.431971122621, 6328.082428047907, 6340.080688300171, 6345.555811093272, 6349.52378571609, 5523.1163013918385, 5544.500994910478, 5691.174779657009, 5702.572307076985, 5704.1443783432815, 5352.545033672103, 5355.169948657965, 5368.32895888014, 5373.032854086224, 5378.51593356592, 6357.205349331333, 6364.459020983269, 6374.235091789015, 6376.9043464349, 6395.616263024233, 6274.341194174728, 6322.083297921684, 6345.555811093179, 6350.7777227796805, 6369.968150159405, 6284.151639528605, 6338.207724034496, 6340.334264902303, 6344.460720838781, 6414.134091897721, 5982.4316689914385, 6101.054336577838, 6121.483458747687, 6122.571420000735, 6135.0, 6024.3975602439405, 6241.843953901007, 6244.687765611792, 6272.153259309935, 6277.089821975879, 5832.562557808096, 5873.3832947539895, 6051.364606716232, 6069.787557435468, 6116.082587611894, 5898.203742494708, 5975.970120149372, 5979.372165922516, 6007.759689612367, 6054.515638748978, 5126.512981266774, 5962.433568810956, 5982.7307771149535, 6018.759249629966, 6023.036314189709, 5679.914801278067, 6117.571769976059, 6138.3861613840045, 6163.044728067157, 6182.258129024546, 5695.8860822784145, 5785.913211301918, 5788.855278618068, 5881.382454842351, 5954.047352423591], "value": 5670.802820732765, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.63810056759144, 519.9315406838946, 532.4489153725895, 534.6364472158933, 571.5170680774744, 30281.0, 39705.2058958821, 40978.18043639129, 41170.0, 43621.345679814825, 42981.0, 43215.567844321544, 43229.35155972663, 43333.13333733323, 43357.0, 8259.380546459024, 8624.396292259544, 9946.154576860976, 9969.950150249239, 9970.25223108266, 8691.39160258782, 11868.10989175811, 12132.878671213308, 12166.51333946641, 12488.81266780999, 12039.036877049859, 12130.93934530326, 12133.150679452441, 12143.878561214407, 12179.51281948721, 12043.217190882653, 12195.756084878298, 12285.754284914252, 12296.954758845508, 12337.506499739955, 11660.30038197711, 11974.940125299318, 12028.759424811542, 12039.81940270888, 12044.518219271218, 40205.79897100496, 40226.0, 40405.0, 40493.39259911104, 40533.18933621341, 3340.4154273002127, 3423.4180189367867, 3452.585689717225, 3466.636003219651, 3776.678982286509, 29351.0, 30964.69035309663, 31330.06009819709, 31421.528677069862, 31800.840995795104, 3138.6547479777205, 3265.9836700816345, 3288.5067239914206, 3290.128116049249, 3339.31544033475, 479425.0, 480010.0, 484376.0, 484592.0, 487549.0, 61490.0, 62075.0, 62117.37882621116, 62184.0, 62358.688206558676, 34373.65626343704, 34526.136846578534, 35385.46921796175, 36268.274634507165, 64617.67691161514, 16754.4135955241, 16873.493795186165, 16906.239219234918, 16908.661826763397, 16941.0, 11570.19008669385, 11766.88233117675, 12887.968962482979, 13009.804852927213, 13034.283114428797, 16483.83516164823, 16505.752413713803, 16619.41832035873, 16687.749683754755, 18718.344857929907, 7358.521696089844, 7561.508501947355, 7823.530588164728, 8000.559969201633, 8102.675892964333, 864.2955990867548, 946.3422921069928, 989.366805244644, 1058.5183741397645, 1060.607575197182, 29197.708022919498, 29961.0, 29984.70015299819, 30697.84651076775, 30758.0, 1061.7770268243755, 1081.859358283418, 1082.4641802307908, 1107.839363292318, 1110.955561777536, 15322.770158447409, 15643.921780391252, 15648.530544083696, 16034.278457469441, 16109.27508262131, 638675.8066209732, 672441.0, 699569.0, 709021.0, 999758.0012099893, 46866.0, 47405.0, 55841.0, 56776.0, 57005.0, 1374.4639590559689, 1398.930053497321, 1416.7449859025269, 1419.822522184727, 1421.0265967812081, 30026.099217023526, 30775.0, 31029.0, 31749.841250793597, 32137.67862321347, 55504.16743748766, 56181.59546011382, 56243.718781405834, 56261.71869140792, 56293.71853140708, 658761.0, 665923.0, 667546.0, 667713.0, 669185.0, 26701.0, 27149.59275610907, 27172.864135679985, 42870.785646072814, 43526.56473435352, 44907.0, 47003.52996470128, 47550.76224618855, 47974.28038579494, 48079.75960120177, 37142.44286335653, 38652.17111101228, 38880.0, 39458.0, 39806.402903957045, 32669.0, 38699.80650096844, 38827.0, 39828.800855995534, 40233.1953360937, 37644.81177594094, 37856.86429407122, 38544.6145538541, 38819.805900970314, 38837.80581097189, 31533.52699709552, 33436.83281583576, 33672.0, 33863.15342116368, 33948.83025584856, 21269.0, 25022.0, 25302.0, 25747.0, 26149.73850261473], "value": 20604.343632802083, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.60634451347414, 355.51294726225075, 374.195479718605, 381.3250546532638, 397.8965468978067, 15340.923295383522, 15442.69114617707, 16606.169691515406, 20903.0, 21336.679949800728, 19510.219591216333, 20295.49261268469, 20840.270590529333, 20975.58048839026, 21028.474288142803, 4727.550882666158, 5956.166136740849, 6202.472789812871, 6213.782517611885, 6217.59585626935, 5583.469570390806, 6015.458608725214, 6021.879562408749, 6209.75160993562, 6216.2851272103835, 5250.6324557281005, 5900.0, 6149.3235744068115, 6167.444929956303, 6232.719527621268, 6196.78311259106, 6234.906476402857, 6237.282712488077, 6241.719122639447, 6247.500199983991, 5723.713814309268, 5785.48688110661, 5817.563682723812, 5819.156222347779, 5833.445822646841, 13145.014123940648, 13318.467261309634, 13482.730345393038, 20174.99125043742, 25314.74685253142, 2206.6689996500495, 2216.4348091236793, 2225.9554808903895, 2251.6397376419695, 2293.3693234360517, 9950.910308835153, 10111.696649100539, 10368.948155259252, 10598.735031624194, 10650.786984260272, 1537.3005282596391, 1906.389955214332, 1917.7986311437237, 1959.4317647882096, 1964.5481539246055, 125737.37131314285, 125876.0, 126497.0, 129123.35438322749, 131640.0, 9371.718848434557, 9800.852987205197, 9889.159421449114, 9968.900310996942, 11616.186866919235, 12560.74878502443, 12616.55842045524, 12637.0, 12646.873531264753, 12654.987600991899, 8105.230003149692, 8169.42814003026, 8184.0, 8203.0, 8209.71266005687, 8612.655493780305, 8624.482531048157, 8626.956865215634, 8794.560271986375, 8834.0, 3892.708046896494, 3898.1229223424502, 3908.8241029153755, 3970.642642162219, 3971.900702482403, 1905.9428217153506, 1916.6645836978473, 1920.9423717288503, 1927.9036048197815, 1967.517958100246, 803.3854101612271, 851.199872120205, 858.4934888415739, 866.3978534918172, 994.6469003503652, 20278.087486063163, 21793.94290682501, 21834.196476775083, 21851.021661316805, 21931.01310441034, 829.7344849648055, 935.5228833294932, 955.6273053509137, 960.9807803843884, 977.4575110813424, 9646.324757266924, 11220.775584488265, 11406.08751299894, 11463.770724585629, 11557.13321500874, 646076.0, 649012.0, 652273.0, 664979.0506284819, 667637.0, 87686.0, 116530.41734791441, 119108.99999999827, 136764.0, 144190.0, 891.6477991193442, 920.7099763574453, 950.7575568230058, 951.3863558005048, 980.8970058143935, 19334.8066519333, 19427.4171774847, 19992.20031198736, 20052.498687532345, 20101.798982009994, 57668.0, 58139.837203256546, 58196.12705809331, 58473.415265848496, 58645.70677146587, 83553.0, 83679.5816020916, 83907.0, 85520.0, 86713.26573468621, 7789.298963093349, 7857.724979625686, 7944.245296696805, 8160.755177344689, 8413.990321161255, 11344.886551134383, 12601.306928119042, 12838.55065072718, 12861.614151575468, 13033.0, 10681.359118452918, 10717.070927233173, 11041.282316649393, 11216.495257713259, 11219.71950701239, 9798.902010980084, 10148.695539133543, 10902.073323767569, 11188.104951604015, 11619.709507262387, 9657.517124143906, 11409.25839820409, 11483.081353491534, 11520.135989800967, 11697.122715796178, 8199.262066414052, 8281.751547453587, 8394.832103357776, 8422.368322375723, 8430.6206220719, 7317.2316906726155, 7795.64919578609, 7877.291043805856, 7928.643211055632, 8224.136465671018], "value": 9326.385921236926, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1509.554681368996, 1517.9772303415448, 1729.3947118508515, 1866.3281218761251, 1909.8949557774317, 8568.186022327876, 9075.273978081754, 9095.90904090959, 9114.04302548232, 9119.221751758401, 8071.0, 8284.171582841713, 8297.128801475848, 8739.213470787628, 8946.91053089469, 2398.7721166489155, 2441.7802397784194, 2442.0, 2443.376938880583, 2450.264920523836, 2108.7153234313323, 2386.427257458206, 2404.6873906392143, 2433.0875921529428, 2460.458699086198, 2037.4295197344768, 2430.769076937688, 2453.239495756321, 2468.9259322220273, 2470.2465747946867, 2412.5777988852055, 2445.72822132491, 2447.0089613706386, 2448.877556122187, 2454.3373289211813, 2415.1426243683413, 2436.8050555955483, 2442.413820683041, 2446.510697860417, 2448.26552034389, 7607.543547387175, 9070.591823367964, 9196.448213107167, 9217.986021537625, 9234.584443700049, 5334.706591137486, 5505.944940550583, 5518.034343989826, 5525.088360420566, 5573.442655734435, 3592.4431713084514, 3663.3772258715817, 3732.5894151643297, 3738.2337070567855, 3746.68153206975, 1111.5164903267105, 1115.1691989467818, 1124.730064784454, 1129.0064743026085, 1137.7895089408487, 12131.150819442642, 12140.757184856253, 12229.93885030578, 12231.571894983721, 12256.632301030893, 4470.664700147502, 4602.654800889946, 4724.622030237572, 4730.574248317668, 4739.478657347689, 9246.214071803837, 9422.670206542738, 9439.103285187895, 9443.10290522413, 9451.196648284835, 5359.624826262124, 5373.946260537423, 5375.731213439312, 5378.354597448253, 5394.757235924393, 4506.0, 4621.214393553104, 4652.604528615038, 5009.148444764399, 5046.697198168048, 3769.509963704701, 3794.4498047782918, 3872.0, 3915.804209789499, 3919.8824035278985, 1172.1853311948114, 1184.6505280942142, 1184.8163534652142, 1195.0917302849896, 1199.0886925936352, 794.6463823598559, 886.4858382138344, 902.7788191893028, 919.8114386550741, 936.4007035497287, 5880.764769409261, 5984.311804142492, 5998.220231369894, 6026.186464827279, 6081.391860813972, 906.1844340093836, 910.7540963939832, 927.3925578745932, 944.2493217891792, 981.6122631560494, 3220.710136087763, 4008.07814202735, 4058.9594104058583, 4111.712180147361, 4195.119025004722, 10629.73425664349, 10766.461676916122, 10993.450327483593, 11054.502547385388, 11307.94346028281, 10976.725581860357, 11227.55089796399, 11229.438528073564, 11244.831327530093, 11255.380954047607, 8129.593520323961, 8556.40105192643, 8586.270167035871, 8589.484630922165, 8590.570471476402, 5983.282006159288, 6049.0, 6096.603720758137, 6185.0, 6250.281217659845, 9178.449293042439, 9512.239020878174, 10347.223958203014, 10421.322614030063, 10647.0, 10498.265121441425, 10638.89361106379, 10644.84032739494, 10663.200259980378, 10677.039066484054, 7196.352328290479, 7218.314260145278, 7718.498297610638, 7765.107012693386, 7777.92222077772, 8542.974843018877, 8647.481151130953, 8711.303095752452, 8745.825083498421, 8808.942926848818, 7637.923620763943, 7669.69321227167, 7710.190430004769, 7825.295723384923, 7904.0119985001875, 6430.228372595318, 7430.777076687708, 7501.774946751606, 7567.091948966159, 7616.20029896875, 7118.644067796693, 7288.198298187089, 7290.05229320185, 7290.9635451822405, 7301.671424785791, 4955.870008989771, 4981.476944920876, 5065.4174769900455, 5104.2343648453025, 5169.793208271777, 4959.231319145538, 4971.328870602422, 5110.591152707849, 5157.793688252428, 5163.044836705071], "value": 4667.047171767463, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.89819410497483, 305.9724624783769, 312.30979535227146, 318.37121684672786, 318.6176588094286, 4882.755862206889, 5137.6403651744395, 5450.983136239587, 5462.754176062077, 5557.194206840006, 5118.795248190068, 5124.718140502271, 5153.046686363025, 5293.338332708411, 5328.387235467912, 3190.5533225348413, 4128.277551428503, 4169.72896761711, 4170.291050521419, 4320.142338794317, 3479.965200348002, 4137.1518838638, 4158.625723684868, 4160.43834082398, 4173.666106711471, 3360.0, 3428.6057103433177, 3998.9400158997637, 4074.5314288856866, 4149.190907772985, 3848.5183204466343, 3869.2648396804516, 4132.574261879647, 4136.896577585554, 4151.83392664293, 3194.9201269968203, 3467.6185619581825, 3609.8736544221088, 3620.438831981021, 3629.491871138043, 3795.411711184771, 4260.68044896634, 4343.435353404069, 5287.0, 5296.867578310535, 4165.563674686449, 4506.616937560311, 4587.747673877935, 4807.966287248259, 4832.9758351208375, 5023.648344615878, 5502.872845365975, 5608.317504748559, 5700.344460387067, 5774.249347584787, 3648.981755091234, 3881.7088718346236, 3982.900427489336, 3996.3805610130476, 4023.2355852387955, 4988.653063672824, 5158.819441319573, 5724.227229324071, 6002.819915402545, 6056.455603821041, 4059.4316795648633, 4065.2276067547073, 4066.410370496321, 4066.9796651017145, 4071.3892916062237, 3468.739844511672, 3715.851365945332, 3969.6030396960073, 4170.436991006175, 4181.477315335583, 3832.463455116286, 4441.422615060022, 4623.53764623535, 4674.929876051862, 4696.7651617419, 5378.332716857786, 5730.882477916766, 5747.971260143672, 5767.307923049177, 5822.0, 1088.90199882011, 1129.7796929598815, 1263.564070395712, 1276.8572127945622, 1359.9728005439836, 811.4157806379397, 862.9299668411251, 892.6563273139888, 916.927195181639, 929.1080562659787, 4654.115718013567, 5306.469353064663, 5319.521243088141, 5319.867003324948, 5404.78380864761, 5109.0, 5635.408282130399, 5871.442212989759, 5897.882042359129, 5931.139984702194, 4340.0, 4415.425994620743, 4763.118568165624, 5317.840464785985, 5343.385510666245, 2549.961750573743, 2586.883590238444, 3059.2198989257595, 3074.9077527674203, 3076.0, 4878.341423907727, 5851.034579294369, 6011.789587364421, 6046.848828779316, 6100.206973093469, 4770.713757174581, 5938.703064846741, 5950.67271300074, 5999.880002400015, 6016.578839481282, 4948.925766113583, 5199.948000519947, 5784.074548072288, 5906.7637294508595, 6070.878582428327, 5604.4532088565265, 5728.598998070262, 5747.683877386617, 5811.169481613279, 5834.649921004583, 5172.663776854492, 5640.956423061747, 5699.173619825019, 5732.742026608729, 5783.421657834183, 5663.292088488939, 5816.73824677882, 6000.249968753906, 6060.454559089703, 6061.999310341409, 3851.9614803851605, 3901.317269477773, 3907.003714053012, 3909.667678247381, 3917.139358804545, 5211.218317252443, 5450.836474905759, 5613.382527922007, 5809.2738407699035, 5814.476697097281, 5460.426655201147, 5487.945120548743, 5524.91712624319, 5630.85922851932, 5703.289013296077, 5552.7778888845605, 5557.36090349615, 5569.972150139223, 5571.637843540157, 5586.190002449704, 5304.363476382859, 5461.945380546303, 5481.232627432242, 5528.917066243929, 5550.7779688812, 4846.303793672187, 5584.682356822036, 5700.572457065654, 5737.799177028784, 5749.425057494217, 4761.476237613929, 5592.133219351007, 5607.43925607436, 5613.017721898733, 5626.465485778845], "value": 4115.204770089605, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.2218143314503, 752.6199269368968, 777.8501693465362, 811.2090711556237, 842.8537189422384, 14970.92514537427, 16054.357825686973, 16124.677506449863, 16332.0, 16793.328266869343, 14909.403623855032, 15204.695906081899, 15252.161131137784, 15258.618534536614, 15268.618284542892, 663.7875879718492, 829.8215883585028, 853.5988085599789, 853.9316854651613, 854.4104567848196, 676.1581830620884, 820.1265652080515, 838.7022606974527, 841.9158084191563, 859.3468963587655, 902.5532361481077, 904.1817155474306, 904.6517090919978, 905.7871400220976, 907.3648446087732, 896.9596368163383, 897.6319708919377, 897.989761518292, 899.1952202778509, 901.6123067081153, 515.9561437277836, 529.5684017525704, 533.4985113992834, 534.6604905884752, 535.2586667465549, 14729.410823567045, 15341.232938353038, 15354.53936381899, 15550.688986220326, 15571.688566228726, 14568.854311456962, 14958.62603434912, 15013.3244004019, 15065.09609423438, 15247.618809529851, 11474.94262528682, 11530.250533715365, 11769.999550038257, 11957.342346170957, 12364.44360003802, 3864.3237433449035, 3900.0, 3949.308870947573, 3995.5604883462797, 4040.070783719761, 105219.47390263, 107882.46058769735, 110129.89870101276, 111162.77674446466, 111651.0, 11246.044086252596, 11561.30632162073, 11563.190576659554, 11650.242734222249, 11681.941590291994, 23566.528669426516, 23735.40661483442, 23745.7625423747, 23945.760542394702, 23990.04039838387, 7777.144514103444, 7799.922000780033, 7832.4908880923695, 7833.707438272735, 7835.6473958671995, 4395.846145384896, 4423.889402764892, 4455.866324010285, 4520.88697782558, 4628.282616194495, 3083.922901927425, 3788.052986753312, 3789.3558095123894, 3790.5830358660523, 3793.506844110248, 656.829224401659, 663.3101574362609, 672.176583684982, 679.0459404536535, 679.296927679849, 556.3240662594967, 566.3883006353128, 641.7112299465259, 656.9967150164218, 686.8351595617116, 9160.587773550205, 9264.351495395258, 9334.113259240361, 9378.343515953955, 9617.16293693362, 640.6604499615119, 656.6421300391298, 668.9264180940093, 668.9966550167218, 675.1054852320694, 4050.473438453041, 4488.798004089824, 4503.752293623882, 4516.458025037016, 4598.908021839611, 98496.50751746196, 102975.0, 106425.0, 134356.32821835828, 180652.0, 128565.0, 146908.0, 147647.2617636905, 149519.9134156149, 152210.0, 85384.99999999876, 109040.0, 112812.43593782143, 113626.0, 115111.42444287725, 8986.101389860962, 9705.369151005161, 9771.218302535637, 9775.560099795668, 9777.902220977983, 59034.70482647731, 61921.9750716202, 62290.68854655698, 63736.0, 64395.678021609594, 59857.0, 62469.0, 86580.56709716411, 87555.1244487547, 89771.10228897627, 11146.49840757184, 13032.0, 13079.692030797225, 13460.394282257126, 13677.931610341884, 14276.785848212492, 14287.0, 14316.642083947985, 14935.402583896523, 15794.36822527086, 13459.461621535029, 13880.853101370742, 14308.284585770878, 14840.257987100385, 14854.034487758261, 13619.114757540729, 13947.16317020982, 14377.424903003763, 14634.780478293047, 14852.925735371255, 12766.106372553832, 12989.675258118623, 13873.0, 14223.573292801233, 14271.71456570842, 10479.528421220912, 11836.82244766312, 12008.159428839897, 12063.879361206276, 12235.571754988532, 8463.49219046859, 9818.950905245429, 10111.533827595105, 11617.926735768864, 11803.291802491878], "value": 7823.739134364534, "unit": "score"}], "name": "dromaeo_css", "value": 7396.650929491321, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 112.0, 114.0, 112.0, 112.0, 112.0, 113.0, 112.0, 111.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 109.0, 112.0, 176.0, 140.0, 111.0, 110.0, 108.0, 140.0, 107.0], "value": 125.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 184.0, 183.0, 184.0, 182.0, 184.0, 182.0, 183.0, 183.0, 183.0], "value": 182.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 55.0, 60.0, 88.0, 64.0, 59.0, 60.0, 59.0, 83.0, 58.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 96.0, 97.0, 54.0, 76.0, 117.0, 100.0, 99.0, 103.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 84.0, 86.0, 83.0, 87.0, 83.0, 86.0, 84.0], "value": 85.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 84.0, 82.0, 86.0, 84.0, 83.0, 83.0, 84.0, 83.0], "value": 83.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 53.0, 52.0, 51.0, 53.0, 55.0, 77.0, 88.0, 87.0, 88.0], "value": 66.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 66.0, 76.0, 71.0, 69.0, 71.0, 70.0, 71.0, 72.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 86.0, 83.0, 85.0, 85.0, 82.0, 84.0, 90.0, 89.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 146.0, 154.0, 137.0, 154.0, 142.0, 157.0, 155.0, 193.0, 132.0], "value": 151.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 167.0, 226.0, 204.0, 165.0, 164.0, 163.0, 161.0, 164.0, 164.0], "value": 174.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 68.0, 67.0, 66.0, 67.0, 69.0, 70.0, 77.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1457.3, "alertThreshold": 2.0}]} 18:34:57 INFO - Return code: 0 18:34:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:34:57 INFO - # TBPL SUCCESS # 18:34:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:34:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:34:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:34:57 INFO - 2016-09-28 18:34:57.820 screenresolution[1662:10367] starting screenresolution argv=screenresolution get 18:34:57 INFO - 2016-09-28 18:34:57.823 screenresolution[1662:10367] Display 0: 1600x1200x32@60 18:34:57 INFO - 2016-09-28 18:34:57.829 screenresolution[1663:10370] starting screenresolution argv=screenresolution list 18:34:57 INFO - Available Modes on Display 0 18:34:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:34:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:34:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:34:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:34:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:34:58 INFO - Intel Iris: 18:34:58 INFO - Chipset Model: Intel Iris 18:34:58 INFO - Type: GPU 18:34:58 INFO - Bus: Built-In 18:34:58 INFO - VRAM (Dynamic, Max): 1536 MB 18:34:58 INFO - Vendor: Intel (0x8086) 18:34:58 INFO - Device ID: 0x0a2e 18:34:58 INFO - Revision ID: 0x0009 18:34:58 INFO - Displays: 18:34:58 INFO - Display: 18:34:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:34:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:34:58 INFO - Display Serial Number: 1600x1200 60 18:34:58 INFO - Main Display: Yes 18:34:58 INFO - Mirror: Off 18:34:58 INFO - Online: Yes 18:34:58 INFO - Rotation: Supported 18:34:58 INFO - Return code: 0 18:34:58 INFO - Running post-action listener: _resource_record_post_action 18:34:58 INFO - [mozharness: 2016-09-29 01:34:58.064329Z] Finished run-tests step (success) 18:34:58 INFO - Running post-run listener: _resource_record_post_run 18:34:58 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 33065984; Write bytes: 665245696; Read time: 311; Write time: 2091 18:34:58 INFO - TinderboxPrint: CPU usage
53.3% 18:34:58 INFO - TinderboxPrint: I/O read bytes / time
33,065,984 / 311 18:34:58 INFO - TinderboxPrint: I/O write bytes / time
665,245,696 / 2,091 18:34:58 INFO - TinderboxPrint: CPU idle
2,259.9 (46.7%) 18:34:58 INFO - TinderboxPrint: CPU system
965.3 (19.9%) 18:34:58 INFO - TinderboxPrint: CPU user
1,616.6 (33.4%) 18:34:58 INFO - TinderboxPrint: Swap in / out
391,593,984 / 0 18:34:58 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 355967488; Write bytes: 356415488; Read time: 27345; Write time: 739 18:34:58 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 31296512; Write bytes: 297811968; Read time: 293; Write time: 1316 18:34:58 INFO - Running post-run listener: _upload_blobber_files 18:34:58 INFO - Blob upload gear active. 18:34:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:34:58 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 18:34:58 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:34:58 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:34:58 INFO - (blobuploader) - INFO - Open directory for files ... 18:34:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:34:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:34:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:34:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:34:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:34:59 INFO - (blobuploader) - INFO - Done attempting. 18:34:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:34:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:34:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:35:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:35:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:35:01 INFO - (blobuploader) - INFO - Done attempting. 18:35:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:35:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:35:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:35:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:35:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:35:05 INFO - (blobuploader) - INFO - Done attempting. 18:35:05 INFO - (blobuploader) - INFO - Iteration through files over. 18:35:06 INFO - Return code: 0 18:35:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:35:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:35:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68f40d3f38ea4704c70ee34671355145608f084b1a9a177d4a04358d5fca9e571b65cb170c7ca007506de5b1b7aeebb03237210c3393847675dfa5ce8e00b6d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a5b4f3741d94666839ec7ed80b32e072a5fa64dbf5cbe9887cdfd2431629c02f21b6656229a50f2588af62f0770d25906a57386adbdbc913c581c4225c6dd0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/084222da1114af9ef25aa86d418f4f62fa837e076c3a92fabd3d1758e80c4378c7074c48cb6f02973511ef63ac6b0082dd5214a134eedd39c7754edd32927d77"} 18:35:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:35:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:35:06 INFO - Contents: 18:35:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68f40d3f38ea4704c70ee34671355145608f084b1a9a177d4a04358d5fca9e571b65cb170c7ca007506de5b1b7aeebb03237210c3393847675dfa5ce8e00b6d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a5b4f3741d94666839ec7ed80b32e072a5fa64dbf5cbe9887cdfd2431629c02f21b6656229a50f2588af62f0770d25906a57386adbdbc913c581c4225c6dd0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/084222da1114af9ef25aa86d418f4f62fa837e076c3a92fabd3d1758e80c4378c7074c48cb6f02973511ef63ac6b0082dd5214a134eedd39c7754edd32927d77"} 18:35:06 INFO - Running post-run listener: copy_logs_to_upload_dir 18:35:06 INFO - Copying logs to upload dir... 18:35:06 INFO - mkdir: /builds/slave/test/build/upload/logs 18:35:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.727801 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-09-28 18:35:06.083843) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 18:35:06.086917) ========= 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.8FraE7q3sX/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.J7LQh7LqG2/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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/Mozilla-Aurora/sha512/68f40d3f38ea4704c70ee34671355145608f084b1a9a177d4a04358d5fca9e571b65cb170c7ca007506de5b1b7aeebb03237210c3393847675dfa5ce8e00b6d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a5b4f3741d94666839ec7ed80b32e072a5fa64dbf5cbe9887cdfd2431629c02f21b6656229a50f2588af62f0770d25906a57386adbdbc913c581c4225c6dd0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/084222da1114af9ef25aa86d418f4f62fa837e076c3a92fabd3d1758e80c4378c7074c48cb6f02973511ef63ac6b0082dd5214a134eedd39c7754edd32927d77"} build_url:https://queue.taskcluster.net/v1/task/VqSyd-l6SPGE5wiqjk7obg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/VqSyd-l6SPGE5wiqjk7obg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68f40d3f38ea4704c70ee34671355145608f084b1a9a177d4a04358d5fca9e571b65cb170c7ca007506de5b1b7aeebb03237210c3393847675dfa5ce8e00b6d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a5b4f3741d94666839ec7ed80b32e072a5fa64dbf5cbe9887cdfd2431629c02f21b6656229a50f2588af62f0770d25906a57386adbdbc913c581c4225c6dd0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/084222da1114af9ef25aa86d418f4f62fa837e076c3a92fabd3d1758e80c4378c7074c48cb6f02973511ef63ac6b0082dd5214a134eedd39c7754edd32927d77"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 18:35:06.120325) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 18:35:06.121891) ========= 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.8FraE7q3sX/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.J7LQh7LqG2/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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.005341 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 18:35:06.170096) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 18:35:06.170405) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 18:35:06.170700) ========= ========= Total master_lag: 0.19 =========