builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0201 starttime: 1472851928.17 results: success (0) buildid: 20160902125250 builduid: 029b55efca37490f850b817d667c992d revision: 38d0defa2db77fa8bf209cf60bde4232896660cc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 14:32:08.170578) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 14:32:08.171013) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 14:32:08.171287) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 14:32:08.193660) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 14:32:08.193929) ========= 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.e5yFP6mb3M/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.m3I0bgzXvj/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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-02 14:32:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.13M=0.001s 2016-09-02 14:32:08 (8.13 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100489 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 14:32:08.316823) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 14:32:08.317215) ========= 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.e5yFP6mb3M/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.m3I0bgzXvj/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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.020583 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 14:32:08.366238) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-02 14:32:08.366602) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 38d0defa2db77fa8bf209cf60bde4232896660cc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 38d0defa2db77fa8bf209cf60bde4232896660cc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.e5yFP6mb3M/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.m3I0bgzXvj/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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-02 14:32:08,450 truncating revision to first 12 chars 2016-09-02 14:32:08,450 Setting DEBUG logging. 2016-09-02 14:32:08,450 attempt 1/10 2016-09-02 14:32:08,450 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/38d0defa2db7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-02 14:32:10,343 unpacking tar archive at: mozilla-central-38d0defa2db7/testing/mozharness/ program finished with exit code 0 elapsedTime=2.172555 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-02 14:32:10.561477) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 14:32:10.561806) ========= script_repo_revision: 38d0defa2db77fa8bf209cf60bde4232896660cc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 14:32:10.562210) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 14:32:10.562495) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 14:32:10.582522) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-09-02 14:32:10.582967) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.e5yFP6mb3M/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.m3I0bgzXvj/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 14:32:10 INFO - MultiFileLogger online at 20160902 14:32:10 in /builds/slave/test 14:32:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 14:32:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:32:10 INFO - {'append_to_log': False, 14:32:10 INFO - 'base_work_dir': '/builds/slave/test', 14:32:10 INFO - 'blob_upload_branch': 'Firefox', 14:32:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:32:10 INFO - 'branch': 'Firefox', 14:32:10 INFO - 'buildbot_json_path': 'buildprops.json', 14:32:10 INFO - 'config_files': ('talos/mac_config.py',), 14:32:10 INFO - 'default_actions': ('clobber', 14:32:10 INFO - 'read-buildbot-config', 14:32:10 INFO - 'download-and-extract', 14:32:10 INFO - 'populate-webroot', 14:32:10 INFO - 'create-virtualenv', 14:32:10 INFO - 'install', 14:32:10 INFO - 'run-tests'), 14:32:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:32:10 INFO - 'download_minidump_stackwalk': True, 14:32:10 INFO - 'download_symbols': 'ondemand', 14:32:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:32:10 INFO - 'tooltool.py': '/tools/tooltool.py', 14:32:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:32:10 INFO - '/tools/misc-python/virtualenv.py')}, 14:32:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:32:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:32:10 INFO - 'installer_path': 'installer.exe', 14:32:10 INFO - 'log_level': 'info', 14:32:10 INFO - 'log_name': 'talos', 14:32:10 INFO - 'log_to_console': True, 14:32:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:32:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:32:10 INFO - 'opt_config_files': (), 14:32:10 INFO - 'pip_index': False, 14:32:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:32:10 INFO - 'cmd': ('bash', 14:32:10 INFO - '-c', 14:32:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:32:10 INFO - 'enabled': True, 14:32:10 INFO - 'halt_on_failure': False, 14:32:10 INFO - 'name': 'check_screen_resolution'},), 14:32:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:32:10 INFO - 'cmd': ('bash', 14:32:10 INFO - '-c', 14:32:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:32:10 INFO - 'enabled': True, 14:32:10 INFO - 'halt_on_failure': False, 14:32:10 INFO - 'name': 'check_screen_resolution'},), 14:32:10 INFO - 'run_cmd_checks_enabled': True, 14:32:10 INFO - 'sps_profile': False, 14:32:10 INFO - 'sps_profile_interval': 0, 14:32:10 INFO - 'suite': 'dromaeojs-e10s', 14:32:10 INFO - 'system_bits': '32', 14:32:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:32:10 INFO - 'title': 't-yosemite-r7-0201', 14:32:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:32:10 INFO - 'use_talos_json': True, 14:32:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:32:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:32:10 INFO - 'work_dir': 'build'} 14:32:10 INFO - [mozharness: 2016-09-02 21:32:10.788031Z] Running clobber step. 14:32:10 INFO - Running pre-action listener: _resource_record_pre_action 14:32:10 INFO - Running main action method: clobber 14:32:10 INFO - rmtree: /builds/slave/test/build 14:32:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:32:11 INFO - Running post-action listener: _resource_record_post_action 14:32:11 INFO - [mozharness: 2016-09-02 21:32:11.827827Z] Finished clobber step (success) 14:32:11 INFO - [mozharness: 2016-09-02 21:32:11.827953Z] Running read-buildbot-config step. 14:32:11 INFO - Running pre-action listener: _resource_record_pre_action 14:32:11 INFO - Running main action method: read_buildbot_config 14:32:11 INFO - Using buildbot properties: 14:32:11 INFO - { 14:32:11 INFO - "project": "", 14:32:11 INFO - "product": "firefox", 14:32:11 INFO - "script_repo_revision": "production", 14:32:11 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 14:32:11 INFO - "repository": "", 14:32:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 14:32:11 INFO - "buildid": "20160902125250", 14:32:11 INFO - "pgo_build": "False", 14:32:11 INFO - "basedir": "/builds/slave/test", 14:32:11 INFO - "buildnumber": 26, 14:32:11 INFO - "slavename": "t-yosemite-r7-0201", 14:32:11 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 14:32:11 INFO - "platform": "yosemite_r7", 14:32:11 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 14:32:11 INFO - "branch": "mozilla-central", 14:32:11 INFO - "repo_path": "mozilla-central", 14:32:11 INFO - "revision": "38d0defa2db77fa8bf209cf60bde4232896660cc", 14:32:11 INFO - "stage_platform": "macosx64", 14:32:11 INFO - "builduid": "029b55efca37490f850b817d667c992d", 14:32:11 INFO - "slavebuilddir": "test" 14:32:11 INFO - } 14:32:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/CbULK_3QQEa6oY9iUd-svA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 14:32:11 INFO - Running post-action listener: _resource_record_post_action 14:32:11 INFO - [mozharness: 2016-09-02 21:32:11.831210Z] Finished read-buildbot-config step (success) 14:32:11 INFO - [mozharness: 2016-09-02 21:32:11.831332Z] Running download-and-extract step. 14:32:11 INFO - Running pre-action listener: _resource_record_pre_action 14:32:11 INFO - Running main action method: download_and_extract 14:32:11 INFO - mkdir: /builds/slave/test/build/tests 14:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:11 INFO - trying https://queue.taskcluster.net/v1/task/CbULK_3QQEa6oY9iUd-svA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 14:32:11 INFO - Downloading https://queue.taskcluster.net/v1/task/CbULK_3QQEa6oY9iUd-svA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 14:32:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CbULK_3QQEa6oY9iUd-svA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 14:32:13 INFO - Downloaded 1199 bytes. 14:32:13 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 14:32:13 INFO - Using the following test package requirements: 14:32:13 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 14:32:13 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:32:13 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 14:32:13 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:32:13 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 14:32:13 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:32:13 INFO - u'jsshell-mac.zip'], 14:32:13 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:32:13 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 14:32:13 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 14:32:13 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:32:13 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 14:32:13 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:32:13 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 14:32:13 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:32:13 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 14:32:13 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:32:13 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 14:32:13 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:32:13 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')]} 14:32:13 INFO - trying https://queue.taskcluster.net/v1/task/CbULK_3QQEa6oY9iUd-svA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:32:13 INFO - Downloading https://queue.taskcluster.net/v1/task/CbULK_3QQEa6oY9iUd-svA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:32:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CbULK_3QQEa6oY9iUd-svA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:32:14 INFO - Downloaded 16399325 bytes. 14:32:14 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 14:32:20 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:20 INFO - trying https://queue.taskcluster.net/v1/task/CbULK_3QQEa6oY9iUd-svA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:32:20 INFO - Downloading https://queue.taskcluster.net/v1/task/CbULK_3QQEa6oY9iUd-svA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:32:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CbULK_3QQEa6oY9iUd-svA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:32:21 INFO - Downloaded 16399325 bytes. 14:32:21 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 14:32:28 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')]} 14:32:28 INFO - trying https://queue.taskcluster.net/v1/task/CbULK_3QQEa6oY9iUd-svA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 14:32:28 INFO - Downloading https://queue.taskcluster.net/v1/task/CbULK_3QQEa6oY9iUd-svA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 14:32:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CbULK_3QQEa6oY9iUd-svA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:32:29 INFO - Downloaded 14413998 bytes. 14:32:29 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 14:32:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:29 INFO - trying https://queue.taskcluster.net/v1/task/CbULK_3QQEa6oY9iUd-svA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:32:29 INFO - Downloading https://queue.taskcluster.net/v1/task/CbULK_3QQEa6oY9iUd-svA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 14:32:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CbULK_3QQEa6oY9iUd-svA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 14:32:32 INFO - Downloaded 111615437 bytes. 14:32:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CbULK_3QQEa6oY9iUd-svA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:32:32 INFO - mkdir: /builds/slave/test/properties 14:32:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:32:32 INFO - Writing to file /builds/slave/test/properties/build_url 14:32:32 INFO - Contents: 14:32:32 INFO - build_url:https://queue.taskcluster.net/v1/task/CbULK_3QQEa6oY9iUd-svA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:32:32 INFO - Running post-action listener: _resource_record_post_action 14:32:32 INFO - Running post-action listener: set_extra_try_arguments 14:32:32 INFO - [mozharness: 2016-09-02 21:32:32.863933Z] Finished download-and-extract step (success) 14:32:32 INFO - [mozharness: 2016-09-02 21:32:32.864047Z] Running populate-webroot step. 14:32:32 INFO - Running pre-action listener: _resource_record_pre_action 14:32:32 INFO - Running main action method: populate_webroot 14:32:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:32:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:32:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:32:32 INFO - '--tppagecycles', 14:32:32 INFO - '7'], 14:32:32 INFO - 'tests': ['tsvgm']}}, 14:32:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:32:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:32:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:32:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:32:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:32:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:32:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:32 INFO - 'talos_options': ['--disable-e10s'], 14:32:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:32:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:32:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:32 INFO - 'talos_options': ['--disable-e10s'], 14:32:32 INFO - 'tests': ['damp', 'tps']}, 14:32:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:32 INFO - 'tests': ['damp', 'tps']}, 14:32:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:32:32 INFO - 'tests': ['dromaeo_dom']}, 14:32:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:32:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:32:32 INFO - 'tests': ['basic_compositor_video']}, 14:32:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:32:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:32:32 INFO - 'tests': ['a11yr', 14:32:32 INFO - 'ts_paint', 14:32:32 INFO - 'tpaint', 14:32:32 INFO - 'sessionrestore', 14:32:32 INFO - 'sessionrestore_no_auto_restore', 14:32:32 INFO - 'tabpaint']}, 14:32:32 INFO - 'other-e10s': {'tests': ['a11yr', 14:32:32 INFO - 'ts_paint', 14:32:32 INFO - 'tpaint', 14:32:32 INFO - 'sessionrestore', 14:32:32 INFO - 'sessionrestore_no_auto_restore', 14:32:32 INFO - 'tabpaint']}, 14:32:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:32:32 INFO - 'ts_paint', 14:32:32 INFO - 'tpaint', 14:32:32 INFO - 'sessionrestore', 14:32:32 INFO - 'sessionrestore_no_auto_restore', 14:32:32 INFO - 'tabpaint']}, 14:32:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:32:32 INFO - 'ts_paint', 14:32:32 INFO - 'tpaint', 14:32:32 INFO - 'sessionrestore', 14:32:32 INFO - 'sessionrestore_no_auto_restore', 14:32:32 INFO - 'tabpaint']}, 14:32:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:32:32 INFO - 'tests': ['a11yr', 14:32:32 INFO - 'ts_paint', 14:32:32 INFO - 'tpaint', 14:32:32 INFO - 'sessionrestore', 14:32:32 INFO - 'sessionrestore_no_auto_restore', 14:32:32 INFO - 'tabpaint']}, 14:32:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:32:32 INFO - 'tests': ['a11yr', 14:32:32 INFO - 'ts_paint', 14:32:32 INFO - 'tpaint', 14:32:32 INFO - 'sessionrestore', 14:32:32 INFO - 'sessionrestore_no_auto_restore', 14:32:32 INFO - 'tabpaint']}, 14:32:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:32:32 INFO - 'tests': ['tsvgx', 14:32:32 INFO - 'tsvgr_opacity', 14:32:32 INFO - 'tart', 14:32:32 INFO - 'tscrollx', 14:32:32 INFO - 'cart']}, 14:32:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:32:32 INFO - 'tsvgr_opacity', 14:32:32 INFO - 'tart', 14:32:32 INFO - 'tscrollx', 14:32:32 INFO - 'cart']}, 14:32:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:32 INFO - 'talos_options': ['--disable-e10s'], 14:32:32 INFO - 'tests': ['tp5o']}, 14:32:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:32 INFO - 'tests': ['tp5o']}, 14:32:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:32 INFO - 'talos_options': ['--disable-e10s', 14:32:32 INFO - '--xperf_path', 14:32:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:32:32 INFO - 'tests': ['tp5n']}, 14:32:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:32 INFO - 'talos_options': ['--xperf_path', 14:32:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:32:32 INFO - 'tests': ['tp5n']}}, 14:32:32 INFO - 'talos.zip': {'path': '', 14:32:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:32:32 INFO - Running post-action listener: _resource_record_post_action 14:32:32 INFO - [mozharness: 2016-09-02 21:32:32.883065Z] Finished populate-webroot step (success) 14:32:32 INFO - [mozharness: 2016-09-02 21:32:32.883204Z] Running create-virtualenv step. 14:32:32 INFO - Running pre-action listener: _resource_record_pre_action 14:32:32 INFO - Running main action method: create_virtualenv 14:32:32 INFO - Creating virtualenv /builds/slave/test/build/venv 14:32:32 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 14:32:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:32:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:32:33 INFO - Using real prefix '/tools/python27' 14:32:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:32:33 INFO - Installing distribute.............................................................................................................................................................................................done. 14:32:36 INFO - Installing pip.................done. 14:32:36 INFO - Return code: 0 14:32:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:32: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')]} 14:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32: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')]} 14:32:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a068a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0fd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38afa81e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fccd30>, '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 0x109d31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fc4b20>, '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.e5yFP6mb3M/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.m3I0bgzXvj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 14:32:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:32:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:32:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e5yFP6mb3M/Render', 14:32:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:36 INFO - 'HOME': '/Users/cltbld', 14:32:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:36 INFO - 'LOGNAME': 'cltbld', 14:32:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:36 INFO - 'MOZ_NO_REMOTE': '1', 14:32:36 INFO - 'NO_EM_RESTART': '1', 14:32:36 INFO - 'PAGER': '/bin/cat', 14:32:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:36 INFO - 'PWD': '/builds/slave/test', 14:32:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:36 INFO - 'SHELL': '/bin/bash', 14:32:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m3I0bgzXvj/Listeners', 14:32:36 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 14:32:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:36 INFO - 'USER': 'cltbld', 14:32:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:36 INFO - 'XPC_FLAGS': '0x0', 14:32:36 INFO - 'XPC_SERVICE_NAME': '0', 14:32:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:36 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 14:32:36 INFO - Cleaning up... 14:32:36 INFO - Return code: 0 14:32:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:32: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')]} 14:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32: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')]} 14:32:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a068a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0fd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38afa81e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fccd30>, '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 0x109d31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fc4b20>, '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.e5yFP6mb3M/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.m3I0bgzXvj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 14:32:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:32:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:32:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e5yFP6mb3M/Render', 14:32:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:36 INFO - 'HOME': '/Users/cltbld', 14:32:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:36 INFO - 'LOGNAME': 'cltbld', 14:32:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:36 INFO - 'MOZ_NO_REMOTE': '1', 14:32:36 INFO - 'NO_EM_RESTART': '1', 14:32:36 INFO - 'PAGER': '/bin/cat', 14:32:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:36 INFO - 'PWD': '/builds/slave/test', 14:32:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:36 INFO - 'SHELL': '/bin/bash', 14:32:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m3I0bgzXvj/Listeners', 14:32:36 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 14:32:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:36 INFO - 'USER': 'cltbld', 14:32:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:36 INFO - 'XPC_FLAGS': '0x0', 14:32:36 INFO - 'XPC_SERVICE_NAME': '0', 14:32:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:37 INFO - Downloading/unpacking psutil>=3.1.1 14:32:37 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 14:32:37 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 14:32:37 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 14:32:37 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 14:32:37 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 14:32:37 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 14:32:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:32:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:32:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:32:40 INFO - Installing collected packages: psutil 14:32:40 INFO - Running setup.py install for psutil 14:32:40 INFO - building 'psutil._psutil_osx' extension 14:32:40 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 14:32:40 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 14:32:40 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 14:32:40 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 14:32:40 INFO - building 'psutil._psutil_posix' extension 14:32:40 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 14:32:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:32:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:32:40 INFO - ^ 14:32:40 INFO - 1 warning generated. 14:32:40 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 14:32:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:32:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:32:40 INFO - Successfully installed psutil 14:32:40 INFO - Cleaning up... 14:32:41 INFO - Return code: 0 14:32:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:32: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')]} 14:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32: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')]} 14:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:41 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 0x10a068a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0fd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38afa81e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fccd30>, '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 0x109d31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fc4b20>, '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.e5yFP6mb3M/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.m3I0bgzXvj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 14:32:41 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 14:32:41 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 14:32:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e5yFP6mb3M/Render', 14:32:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:41 INFO - 'HOME': '/Users/cltbld', 14:32:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:41 INFO - 'LOGNAME': 'cltbld', 14:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:41 INFO - 'MOZ_NO_REMOTE': '1', 14:32:41 INFO - 'NO_EM_RESTART': '1', 14:32:41 INFO - 'PAGER': '/bin/cat', 14:32:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:41 INFO - 'PWD': '/builds/slave/test', 14:32:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:41 INFO - 'SHELL': '/bin/bash', 14:32:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m3I0bgzXvj/Listeners', 14:32:41 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 14:32:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:41 INFO - 'USER': 'cltbld', 14:32:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:41 INFO - 'XPC_FLAGS': '0x0', 14:32:41 INFO - 'XPC_SERVICE_NAME': '0', 14:32:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:32:41 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 14:32:41 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 14:32:41 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 14:32:41 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 14:32:41 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 14:32:41 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 14:32:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:32:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:32:43 INFO - Installing collected packages: mozsystemmonitor 14:32:43 INFO - Running setup.py install for mozsystemmonitor 14:32:43 INFO - Successfully installed mozsystemmonitor 14:32:43 INFO - Cleaning up... 14:32:43 INFO - Return code: 0 14:32:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:32:43 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')]} 14:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:43 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')]} 14:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:43 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 0x10a068a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0fd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38afa81e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fccd30>, '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 0x109d31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fc4b20>, '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.e5yFP6mb3M/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.m3I0bgzXvj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 14:32:43 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 14:32:43 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 14:32:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e5yFP6mb3M/Render', 14:32:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:43 INFO - 'HOME': '/Users/cltbld', 14:32:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:43 INFO - 'LOGNAME': 'cltbld', 14:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:43 INFO - 'MOZ_NO_REMOTE': '1', 14:32:43 INFO - 'NO_EM_RESTART': '1', 14:32:43 INFO - 'PAGER': '/bin/cat', 14:32:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:43 INFO - 'PWD': '/builds/slave/test', 14:32:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:43 INFO - 'SHELL': '/bin/bash', 14:32:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m3I0bgzXvj/Listeners', 14:32:43 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 14:32:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:43 INFO - 'USER': 'cltbld', 14:32:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:43 INFO - 'XPC_FLAGS': '0x0', 14:32:43 INFO - 'XPC_SERVICE_NAME': '0', 14:32:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:44 INFO - Downloading/unpacking jsonschema==2.5.1 14:32:44 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 14:32:44 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 14:32:44 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 14:32:44 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 14:32:44 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 14:32:44 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 14:32:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:32:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:32:46 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 14:32:46 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 14:32:46 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 14:32:46 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 14:32:46 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 14:32:46 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 14:32:47 INFO - Downloading functools32-3.2.3-2.tar.gz 14:32:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:32:47 INFO - warning: no files found matching '*.txt' 14:32:47 INFO - no previously-included directories found matching 'build' 14:32:47 INFO - no previously-included directories found matching 'dist' 14:32:47 INFO - no previously-included directories found matching '.git*' 14:32:47 INFO - Installing collected packages: jsonschema, functools32 14:32:47 INFO - Running setup.py install for functools32 14:32:47 INFO - warning: no files found matching '*.txt' 14:32:47 INFO - no previously-included directories found matching 'build' 14:32:47 INFO - no previously-included directories found matching 'dist' 14:32:47 INFO - no previously-included directories found matching '.git*' 14:32:47 INFO - Successfully installed jsonschema functools32 14:32:47 INFO - Cleaning up... 14:32:47 INFO - Return code: 0 14:32:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:32:47 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')]} 14:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:47 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')]} 14:32:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:47 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 0x10a068a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0fd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38afa81e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fccd30>, '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 0x109d31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fc4b20>, '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.e5yFP6mb3M/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.m3I0bgzXvj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 14:32:47 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 14:32:47 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 14:32:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e5yFP6mb3M/Render', 14:32:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:47 INFO - 'HOME': '/Users/cltbld', 14:32:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:47 INFO - 'LOGNAME': 'cltbld', 14:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:47 INFO - 'MOZ_NO_REMOTE': '1', 14:32:47 INFO - 'NO_EM_RESTART': '1', 14:32:47 INFO - 'PAGER': '/bin/cat', 14:32:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:47 INFO - 'PWD': '/builds/slave/test', 14:32:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:47 INFO - 'SHELL': '/bin/bash', 14:32:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m3I0bgzXvj/Listeners', 14:32:47 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 14:32:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:47 INFO - 'USER': 'cltbld', 14:32:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:47 INFO - 'XPC_FLAGS': '0x0', 14:32:47 INFO - 'XPC_SERVICE_NAME': '0', 14:32:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:32:47 INFO - Cleaning up... 14:32:47 INFO - Return code: 0 14:32:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:32:47 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')]} 14:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:47 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')]} 14:32:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:47 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 0x10a068a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0fd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38afa81e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fccd30>, '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 0x109d31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fc4b20>, '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.e5yFP6mb3M/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.m3I0bgzXvj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 14:32:47 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 14:32:47 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 14:32:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e5yFP6mb3M/Render', 14:32:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:47 INFO - 'HOME': '/Users/cltbld', 14:32:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:47 INFO - 'LOGNAME': 'cltbld', 14:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:47 INFO - 'MOZ_NO_REMOTE': '1', 14:32:47 INFO - 'NO_EM_RESTART': '1', 14:32:47 INFO - 'PAGER': '/bin/cat', 14:32:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:47 INFO - 'PWD': '/builds/slave/test', 14:32:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:47 INFO - 'SHELL': '/bin/bash', 14:32:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m3I0bgzXvj/Listeners', 14:32:47 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 14:32:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:47 INFO - 'USER': 'cltbld', 14:32:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:47 INFO - 'XPC_FLAGS': '0x0', 14:32:47 INFO - 'XPC_SERVICE_NAME': '0', 14:32:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:48 INFO - Downloading/unpacking blobuploader==1.2.4 14:32:48 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 14:32:48 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 14:32:48 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 14:32:48 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 14:32:48 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 14:32:48 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 14:32:50 INFO - Downloading blobuploader-1.2.4.tar.gz 14:32:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:32:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:32:50 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 14:32:50 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 14:32:50 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 14:32:50 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 14:32:50 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 14:32:50 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 14:32:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:32:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:32:51 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 14:32:51 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 14:32:51 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 14:32:51 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 14:32:51 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 14:32:51 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 14:32:51 INFO - Downloading docopt-0.6.1.tar.gz 14:32:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:32:51 INFO - Installing collected packages: blobuploader, requests, docopt 14:32:51 INFO - Running setup.py install for blobuploader 14:32:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:32:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:32:51 INFO - Running setup.py install for requests 14:32:52 INFO - Running setup.py install for docopt 14:32:52 INFO - Successfully installed blobuploader requests docopt 14:32:52 INFO - Cleaning up... 14:32:52 INFO - Return code: 0 14:32:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:32:52 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')]} 14:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:52 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')]} 14:32:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:52 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 0x10a068a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0fd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38afa81e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fccd30>, '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 0x109d31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fc4b20>, '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.e5yFP6mb3M/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.m3I0bgzXvj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 14:32:52 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 14:32:52 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 14:32:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e5yFP6mb3M/Render', 14:32:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:52 INFO - 'HOME': '/Users/cltbld', 14:32:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:52 INFO - 'LOGNAME': 'cltbld', 14:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:52 INFO - 'MOZ_NO_REMOTE': '1', 14:32:52 INFO - 'NO_EM_RESTART': '1', 14:32:52 INFO - 'PAGER': '/bin/cat', 14:32:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:52 INFO - 'PWD': '/builds/slave/test', 14:32:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:52 INFO - 'SHELL': '/bin/bash', 14:32:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m3I0bgzXvj/Listeners', 14:32:52 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 14:32:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:52 INFO - 'USER': 'cltbld', 14:32:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:52 INFO - 'XPC_FLAGS': '0x0', 14:32:52 INFO - 'XPC_SERVICE_NAME': '0', 14:32:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:32:52 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-r2fBYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:32:52 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-7UHtLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:32:53 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-Kboi6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:32:53 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-aCGPp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:32:53 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-9zWD4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:32:53 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-aN2K_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:32:53 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-4UZXkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:32:53 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-zXZXdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:32:53 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-Uf7F7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:32:53 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-IcWStN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:32:53 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-6HvIgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:32:53 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-4f_9XY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:32:54 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-2aScZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:32:54 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-MJ7sJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:54 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-_Euy43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:32:54 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-evMqv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:32:54 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-HrHI1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:32:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:32:54 INFO - Running setup.py install for manifestparser 14:32:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:32:54 INFO - Running setup.py install for mozcrash 14:32:54 INFO - Running setup.py install for mozdebug 14:32:55 INFO - Running setup.py install for mozdevice 14:32:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:32:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:32:55 INFO - Running setup.py install for mozfile 14:32:55 INFO - Running setup.py install for mozhttpd 14:32:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:32:55 INFO - Running setup.py install for mozinfo 14:32:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:32:55 INFO - Running setup.py install for mozInstall 14:32:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:32:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:32:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:32:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:32:55 INFO - Running setup.py install for mozleak 14:32:55 INFO - Running setup.py install for mozlog 14:32:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:32:56 INFO - Running setup.py install for moznetwork 14:32:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:32:56 INFO - Running setup.py install for mozprocess 14:32:56 INFO - Running setup.py install for mozprofile 14:32:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:32:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:32:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:32:56 INFO - Running setup.py install for mozrunner 14:32:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:32:56 INFO - Running setup.py install for mozscreenshot 14:32:56 INFO - Running setup.py install for moztest 14:32:57 INFO - Running setup.py install for mozversion 14:32:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:32:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:32:57 INFO - Cleaning up... 14:32:57 INFO - Return code: 0 14:32:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:57 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 0x10a068a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0fd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38afa81e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fccd30>, '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 0x109d31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fc4b20>, '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.e5yFP6mb3M/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.m3I0bgzXvj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 14:32:57 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 14:32:57 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 14:32:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e5yFP6mb3M/Render', 14:32:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:57 INFO - 'HOME': '/Users/cltbld', 14:32:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:57 INFO - 'LOGNAME': 'cltbld', 14:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:57 INFO - 'MOZ_NO_REMOTE': '1', 14:32:57 INFO - 'NO_EM_RESTART': '1', 14:32:57 INFO - 'PAGER': '/bin/cat', 14:32:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:57 INFO - 'PWD': '/builds/slave/test', 14:32:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:57 INFO - 'SHELL': '/bin/bash', 14:32:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m3I0bgzXvj/Listeners', 14:32:57 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 14:32:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:57 INFO - 'USER': 'cltbld', 14:32:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:57 INFO - 'XPC_FLAGS': '0x0', 14:32:57 INFO - 'XPC_SERVICE_NAME': '0', 14:32:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:32:57 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-wd2vHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:32:57 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)) 14:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:32:57 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-EzRzaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:32:57 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)) 14:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:32:57 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-gXKmtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:32:57 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)) 14:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:32:57 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-P5Svvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:32:57 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)) 14:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:32:57 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-5IDWx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:32:58 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)) 14:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:32:58 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-o32Nwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:32:58 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)) 14:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:32:58 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-CepVSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:32:58 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)) 14:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:32:58 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-84f0m5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:32:58 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)) 14:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:32:58 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-Ml2KqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:32:58 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)) 14:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:32:58 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-1mZvo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 14:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:32:58 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-vsfBJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:32:58 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)) 14:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:32:58 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-XES97Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:32:58 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)) 14:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:32:58 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-Vw4cJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:32:58 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)) 14:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:32:58 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-UvaT7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:32:59 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)) 14:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:59 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-OQ44Ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:59 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)) 14:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:32:59 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-c1ICRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:32:59 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)) 14:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:32:59 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-FH4tn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:32:59 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)) 14:32:59 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)) 14:32:59 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)) 14:32:59 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)) 14:32:59 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)) 14:32:59 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)) 14:32:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:32:59 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 14:32:59 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 14:32:59 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 14:32:59 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 14:32:59 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 14:32:59 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 14:33:01 INFO - Downloading blessings-1.6.tar.gz 14:33:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:33:01 INFO - Installing collected packages: blessings 14:33:01 INFO - Running setup.py install for blessings 14:33:01 INFO - Successfully installed blessings 14:33:01 INFO - Cleaning up... 14:33:02 INFO - Return code: 0 14:33:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:33:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:33:02 INFO - Reading from file tmpfile_stdout 14:33:02 INFO - Current package versions: 14:33:02 INFO - blessings == 1.6 14:33:02 INFO - blobuploader == 1.2.4 14:33:02 INFO - docopt == 0.6.1 14:33:02 INFO - functools32 == 3.2.3-2 14:33:02 INFO - jsonschema == 2.5.1 14:33:02 INFO - manifestparser == 1.1 14:33:02 INFO - mozInstall == 1.12 14:33:02 INFO - mozcrash == 0.17 14:33:02 INFO - mozdebug == 0.1 14:33:02 INFO - mozdevice == 0.48 14:33:02 INFO - mozfile == 1.2 14:33:02 INFO - mozhttpd == 0.7 14:33:02 INFO - mozinfo == 0.9 14:33:02 INFO - mozleak == 0.1 14:33:02 INFO - mozlog == 3.3 14:33:02 INFO - moznetwork == 0.27 14:33:02 INFO - mozprocess == 0.23 14:33:02 INFO - mozprofile == 0.28 14:33:02 INFO - mozrunner == 6.12 14:33:02 INFO - mozscreenshot == 0.1 14:33:02 INFO - mozsystemmonitor == 0.3 14:33:02 INFO - moztest == 0.7 14:33:02 INFO - mozversion == 1.4 14:33:02 INFO - psutil == 3.1.1 14:33:02 INFO - requests == 1.2.3 14:33:02 INFO - wsgiref == 0.1.2 14:33:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:02 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 0x10a068a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0fd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38afa81e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fccd30>, '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 0x109d31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fc4b20>, '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.e5yFP6mb3M/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.m3I0bgzXvj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 14:33:02 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 14:33:02 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 14:33:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e5yFP6mb3M/Render', 14:33:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:02 INFO - 'HOME': '/Users/cltbld', 14:33:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:02 INFO - 'LOGNAME': 'cltbld', 14:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:02 INFO - 'MOZ_NO_REMOTE': '1', 14:33:02 INFO - 'NO_EM_RESTART': '1', 14:33:02 INFO - 'PAGER': '/bin/cat', 14:33:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:02 INFO - 'PWD': '/builds/slave/test', 14:33:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:02 INFO - 'SHELL': '/bin/bash', 14:33:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m3I0bgzXvj/Listeners', 14:33:02 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 14:33:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:02 INFO - 'USER': 'cltbld', 14:33:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:02 INFO - 'XPC_FLAGS': '0x0', 14:33:02 INFO - 'XPC_SERVICE_NAME': '0', 14:33:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:02 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)) 14:33:02 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)) 14:33:02 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)) 14:33:02 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)) 14:33:02 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)) 14:33:02 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)) 14:33:02 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)) 14:33:02 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)) 14:33:02 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)) 14:33:02 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)) 14:33:02 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)) 14:33:02 INFO - Cleaning up... 14:33:02 INFO - Return code: 0 14:33:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a068a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0fd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38afa81e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fccd30>, '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 0x109d31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fc4b20>, '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.e5yFP6mb3M/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.m3I0bgzXvj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 14:33:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:33:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e5yFP6mb3M/Render', 14:33:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:02 INFO - 'HOME': '/Users/cltbld', 14:33:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:02 INFO - 'LOGNAME': 'cltbld', 14:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:02 INFO - 'MOZ_NO_REMOTE': '1', 14:33:02 INFO - 'NO_EM_RESTART': '1', 14:33:02 INFO - 'PAGER': '/bin/cat', 14:33:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:02 INFO - 'PWD': '/builds/slave/test', 14:33:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:02 INFO - 'SHELL': '/bin/bash', 14:33:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m3I0bgzXvj/Listeners', 14:33:02 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 14:33:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:02 INFO - 'USER': 'cltbld', 14:33:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:02 INFO - 'XPC_FLAGS': '0x0', 14:33:02 INFO - 'XPC_SERVICE_NAME': '0', 14:33:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:33:02 INFO - Cleaning up... 14:33:02 INFO - Return code: 0 14:33:02 INFO - Running post-action listener: _resource_record_post_action 14:33:02 INFO - Running post-action listener: _start_resource_monitoring 14:33:02 INFO - Starting resource monitoring. 14:33:02 INFO - [mozharness: 2016-09-02 21:33:02.916099Z] Finished create-virtualenv step (success) 14:33:02 INFO - [mozharness: 2016-09-02 21:33:02.917120Z] Running install step. 14:33:02 INFO - Running pre-action listener: _resource_record_pre_action 14:33:02 INFO - Running main action method: install 14:33:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:33:03 INFO - Reading from file tmpfile_stdout 14:33:03 INFO - Detecting whether we're running mozinstall >=1.0... 14:33:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:33:03 INFO - Reading from file tmpfile_stdout 14:33:03 INFO - Output received: 14:33:03 INFO - Usage: mozinstall [options] installer 14:33:03 INFO - Options: 14:33:03 INFO - -h, --help show this help message and exit 14:33:03 INFO - -d DEST, --destination=DEST 14:33:03 INFO - Directory to install application into. [default: 14:33:03 INFO - "/builds/slave/test"] 14:33:03 INFO - --app=APP Application being installed. [default: firefox] 14:33:03 INFO - mkdir: /builds/slave/test/build/application 14:33:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:33:37 INFO - Reading from file tmpfile_stdout 14:33:37 INFO - Output received: 14:33:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:33:37 INFO - Running post-action listener: _resource_record_post_action 14:33:37 INFO - [mozharness: 2016-09-02 21:33:37.588697Z] Finished install step (success) 14:33:37 INFO - [mozharness: 2016-09-02 21:33:37.588858Z] Running run-tests step. 14:33:37 INFO - Running pre-action listener: _resource_record_pre_action 14:33:37 INFO - Running main action method: run_tests 14:33:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:33:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:33:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:33:37 INFO - 2016-09-02 14:33:37.603 screenresolution[1928:14403] starting screenresolution argv=screenresolution get 14:33:37 INFO - 2016-09-02 14:33:37.606 screenresolution[1928:14403] Display 0: 1600x1200x32@60 14:33:37 INFO - 2016-09-02 14:33:37.612 screenresolution[1929:14405] starting screenresolution argv=screenresolution list 14:33:37 INFO - Available Modes on Display 0 14:33:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:33:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:33:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:33:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:33:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:33:37 INFO - Intel Iris: 14:33:37 INFO - Chipset Model: Intel Iris 14:33:37 INFO - Type: GPU 14:33:37 INFO - Bus: Built-In 14:33:37 INFO - VRAM (Dynamic, Max): 1536 MB 14:33:37 INFO - Vendor: Intel (0x8086) 14:33:37 INFO - Device ID: 0x0a2e 14:33:37 INFO - Revision ID: 0x0009 14:33:37 INFO - Displays: 14:33:37 INFO - Display: 14:33:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:33:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:33:37 INFO - Display Serial Number: 1600x1200 60 14:33:37 INFO - Main Display: Yes 14:33:37 INFO - Mirror: Off 14:33:37 INFO - Online: Yes 14:33:37 INFO - Rotation: Supported 14:33:37 INFO - Return code: 0 14:33:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:33:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:33:37 INFO - Python 2.7.3 14:33:37 INFO - Return code: 0 14:33:37 INFO - grabbing minidump binary from tooltool 14:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:37 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 0x109fccd30>, '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 0x109d31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fc4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:33:37 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 14:33:37 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 14:33:37 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 14:33:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:33:37 INFO - Return code: 0 14:33:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:33:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:33:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:33:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:33:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:33:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CbULK_3QQEa6oY9iUd-svA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0201', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:33:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CbULK_3QQEa6oY9iUd-svA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0201 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:33:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e5yFP6mb3M/Render', 14:33:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:37 INFO - 'HOME': '/Users/cltbld', 14:33:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:37 INFO - 'LOGNAME': 'cltbld', 14:33:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:33:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:37 INFO - 'MOZ_NO_REMOTE': '1', 14:33:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:33:37 INFO - 'NO_EM_RESTART': '1', 14:33:37 INFO - 'PAGER': '/bin/cat', 14:33:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:37 INFO - 'PWD': '/builds/slave/test', 14:33:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:33:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:37 INFO - 'SHELL': '/bin/bash', 14:33:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m3I0bgzXvj/Listeners', 14:33:37 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 14:33:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:37 INFO - 'USER': 'cltbld', 14:33:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:37 INFO - 'XPC_FLAGS': '0x0', 14:33:37 INFO - 'XPC_SERVICE_NAME': '0', 14:33:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CbULK_3QQEa6oY9iUd-svA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0201', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:33:38 INFO - mozversion application_buildid: 20160902125250 14:33:38 INFO - mozversion application_changeset: 38d0defa2db77fa8bf209cf60bde4232896660cc 14:33:38 INFO - mozversion application_display_name: Nightly 14:33:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:33:38 INFO - mozversion application_name: Firefox 14:33:38 INFO - mozversion application_remotingname: firefox 14:33:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:33:38 INFO - mozversion application_vendor: Mozilla 14:33:38 INFO - mozversion application_version: 51.0a1 14:33:38 INFO - mozversion platform_buildid: 20160902125250 14:33:38 INFO - mozversion platform_changeset: 38d0defa2db77fa8bf209cf60bde4232896660cc 14:33:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:33:38 INFO - mozversion platform_version: 51.0a1 14:33:38 INFO - using testdate: 1472852018 14:33:38 INFO - actual date: 1472852018 14:33:38 INFO - starting webserver on 'localhost:49440' 14:33:38 INFO - SUITE-START | Running 2 tests 14:33:38 INFO - TEST-START | dromaeo_css 14:33:38 INFO - operating with platform_type : mac_ 14:33:38 INFO - Initialising browser for dromaeo_css test... 14:33:38 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/tmp_rIK8l/profile http://localhost:49440/getInfo.html) 14:33:41 INFO - PROCESS | 1939 | __metrics Screen width/height:1600/1200 14:33:41 INFO - PROCESS | 1939 | colorDepth:24 14:33:41 INFO - PROCESS | 1939 | Browser inner width/height: 1024/689 14:33:41 INFO - PROCESS | 1939 | __metrics 14:33:41 ERROR - PROCESS | 1939 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 14:33:41 INFO - TEST-INFO | 1939: exit 0 14:33:41 INFO - Browser initialized. 14:33:41 INFO - Running cycle 1/1 for dromaeo_css test... 14:33:41 INFO - TEST-INFO | started process 1942 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/tmp_rIK8l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:33:53 INFO - PROCESS | 1942 | RSS: Main: 245215232 14:33:53 INFO - PROCESS | 1942 | 14:34:43 INFO - PROCESS | 1942 | 1472852083352 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] 14:36:56 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49440/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49440/tests/dromaeo/cssquery-ext.html) 14:36:57 INFO - PROCESS | 1942 | RSS: Main: 263643136 14:36:57 INFO - PROCESS | 1942 | 14:40:00 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49440/tests/dromaeo/cssquery-ext.html (next: http://localhost:49440/tests/dromaeo/cssquery-jquery.html) 14:40:00 INFO - PROCESS | 1942 | RSS: Main: 271683584 14:40:00 INFO - PROCESS | 1942 | 14:43:02 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49440/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49440/tests/dromaeo/cssquery-mootools.html) 14:43:03 INFO - PROCESS | 1942 | RSS: Main: 275374080 14:43:03 INFO - PROCESS | 1942 | 14:46:05 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49440/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49440/tests/dromaeo/cssquery-prototype.html) 14:46:05 INFO - PROCESS | 1942 | RSS: Main: 269574144 14:46:05 INFO - PROCESS | 1942 | 14:49:08 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49440/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49440/tests/dromaeo/cssquery-yui.html) 14:49:09 INFO - PROCESS | 1942 | RSS: Main: 274964480 14:49:09 INFO - PROCESS | 1942 | 14:52:12 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49440/tests/dromaeo/cssquery-yui.html (next: http://localhost:49440/tests/dromaeo/cssquery-dojo.html) 14:52:12 INFO - PROCESS | 1942 | RSS: Main: 278024192 14:52:12 INFO - PROCESS | 1942 | 14:52:12 INFO - PROCESS | 1942 | __start_tp_report 14:52:12 INFO - PROCESS | 1942 | _x_x_mozilla_page_load 14:52:12 INFO - PROCESS | 1942 | _x_x_mozilla_page_load_details 14:52:12 INFO - PROCESS | 1942 | |i|pagename|runs| 14:52:12 INFO - PROCESS | 1942 | |0;dojo.html;2686.4089900221957;3125.4686703260445;3393.762436629434;3426.5545479087714;3453.7409694272937;5452.591055670826;5629.690367029812;5728.112142617896;5789.913151302729;5850.824475265749;4993.6766756809475;5773.336066352371;5865.70671466426;5869.1196320551935;5899.941000589993;4134.917301653965;5318.521333080022;5328.8401347959625;5385.35375754908;5399.19012148179;5387.19192121183;5412.485813847678;5446.400895901447;5479.506844384005;5485.917711234335;5168.53483186515;5228.2680424740565;5296.602754793406;5308.177232528945;5327.121025030865;5253.238280449352;5254.290670759437;5280.551153151987;5306.70813105279;5357.705326207057;5231.738413079331;5262;5274.878913466828;5321.600879934021;5338.599605029638;5332.093544097474;5463.426340234258;5716.114002329646;5752.942470575283;5803.448672376117;6208.937910620926;6250.468710159642;6284.057391391282;6291.402316779899;6298.527610429236;6259.0924315973925;6283.654399008053;6297.6536290504;6299.8740025199695;6303.55875088744;5799.710014499258;5911.231539899872;5971;5978.1929439525975;6058.485028772604;6270.561060725797;6327.841803954938;6343.238811342669;6351.650659213788;6481.319461456479;6274.027525733519;6277.905831412532;6281.309056003927;6298.1812364392335;6317.905231421532;6117.9187529241;6154.5384096192965;6247.9062814057825;6266.091416744546;6297.149884765498;5333.773232156548;6175.536834737412;6218.751249949952;6222;6223.595466294676;6192.442680158807;6264.342244064399;6293.527985401021;6308.179936608303;6339.778107766206;4913.606911447076;4968.751562421937;4993.500649934977;5051.848444546596;5066.569341606005;4483.910321793611;4508.616767574727;4520.276755719069;4533.569310915458;4566.041131362451;5844.503217226498;5891.823245302648;5922.585419020627;5967.134765459071;5975.731092100866;6203.410675985774;6234.625922444668;6242.250929888442;6284.497240220863;6303.212098487689;5984.820455386345;5985.371535988658;6005.369436209223;6006.969965150233;6052.970994930873;5489.752961116759;5517.613767036269;5527.39198688144;5552.167174923713;5552.3892371839065;6196.721147548281;6233.252009758858;6241.812745617639;6352.792969335811;6357.713902874381;5092.949070509248;6274.560780745304;6284.811455656338;6309.810705678837;6318.399752023551;4916.0905232532095;5285.705002274467;5722.198892155185;6274.937250627435;6349.460295874902;5696.20253164549;6132.478739307209;6147.784827531015;6173.660448675187;6260.217472815898;5979.880402392015;6215.9378406215355;6248.4064013918605;6256.749730010749;6274.46667033289;6246;6252.843678908063;6261.436470717657;6264.091706702594;6273.466755325849;6072;6122.510199184144;6139.754409823557;6211.09939058843;6257.342978987141;6013.977623803877;6098.664573448503;6101.4290607115445;6109.908351374822;6110.816675499742;6166.136740856194;6166.260048794174;6185.226846644169;6188.690565471798;6189.164462797465;5951.761929522944;6069.878602427839;6095.329513753572;6105.5420843437805;6112.969435152973 14:52:12 INFO - PROCESS | 1942 | |1;ext.html;476.5187160967423;529.2088327949715;535.4377903201637;538.1953978801693;569.4419468920461;37034.81482592587;39435.60564394355;39438.60561394385;39457.80271098644;39480.802595987014;40581.39127913084;40864.387034194435;40933.38599920996;41050.38424423636;41078.79460602693;9598.328117031811;9812.50937453128;9818.45998470084;9872.111509964101;9933.403995760278;9618.807623847519;9693.17608003317;9726.902730972706;9727.562259698296;9743.976882427349;9644.903550964471;9726.9513652432;9759.02409759022;9762.560684769167;9763.755906102333;9692.70921872345;9709.126178643955;9715.07706767856;9719.46542940138;9734.902650973541;9656.37233579815;9717.271204659679;9759.707208783748;9775.31572789905;9780.755481112958;38823.8058809707;39221.60778392208;39277;39322;39429.80285098585;3282.6717328267223;3324.734021278292;3347.966520334814;3375.662433756629;3834.635709607611;30096.548551771742;30309.090727278217;30883.536746948816;31003.534946975815;31653.52519712206;3235.4014507315987;3257.2833976525126;3263.2494526258856;3340.916477088092;3417.4361230396953;444756;475212;479500;480792;481422;31903.969122933286;32921.67078329234;57495.82537571555;57735.42264577385;57886.42113578894;33640.831795840866;33911.66088339134;34034.31931361408;34084.659153408145;34166.48750268748;14045.438182472792;14090.85909140916;14203.721665050196;14243.715125697428;14252.501162459264;11796.29222246668;11869.46587403569;11920.642380728592;11924.46339914706;11954.701132471584;7553.697852085965;7599.962000190074;7661.195574464712;7669.501482403626;7673.232676732394;2750.917472475829;2825.39254060378;3269.7711160219033;3278.164068162603;3284.653292150207;938.4088024544493;960.7790208252142;963.6241865672393;964.0583587228512;1002.218269749582;25007.456009543836;29336.413271734873;29625.85187074094;29788.851055745017;29845.701542984727;925.7500474871747;992.4045572656493;1010.1716592394166;1082.7239054041327;1141.9950443609737;14802.555923322318;15100.411238863182;15168.848311516964;15437.0737755735;15487.922560387125;587198;625057;629443.7611862691;630038;633390;50687.73280668013;54241.72879135579;54294.64263393447;54365.1845222322;54398.45601543934;1350.068452767607;1383.3359987205997;1405.3184205660248;1408.1058527834693;1412.9049986260525;24872.632005239884;26278.554679492812;26756.59865101986;28153.577696334163;29855.402891942475;46559.30161047655;46968.530314696414;47312.290315644605;47357.76321118372;47400;465291.42959992477;468213;468829;470722;470837;25241.24276271715;25455.87272063628;25721.742782571935;25735.356616084;25777.871110644326;33961.66038339684;45194.54805451904;45220.54779452163;45415.318770219135;45540;34024.82987585046;36483.635163648025;37089.25821483609;37403.81298093492;38041.809790950865;37108.814455927546;37128.443073354465;37986.810065949496;38103.618963810004;38146.85559433221;36087.819560902026;36664.26671466503;36834.815825921774;37101.25797484089;37683.62316376801;27181.04866329669;31719;33670.49494257539;33684;33714.662853371156;24852.130175443774;24939.376515587257;25194.496110078064;25422.618660719734;25446 14:52:12 INFO - PROCESS | 1942 | |2;jquery.html;322.3649410660998;330.54219905430983;342.47259220799964;359.7967148561063;379.1771855074488;14957.850421495781;18029.278828846847;20524.179032838707;20731.378058658265;20986.790132098675;17385;19739.70390444141;19970.00149992502;20546.589068218625;20954.16183352668;5854.795082172125;6183.9381606183815;6183.969080154593;6185.536084793636;6194.318624951252;5771.682557459338;5826.563007774413;6060.939390606081;6107.725152368132;6139.171211886405;4867.269909513584;5915.053591425372;6068.937935861229;6073.301570319403;6074.179985701918;7620.276073772982;7878;8047.275745182932;8092.595370231524;8094.352451803841;7506.174320824705;7698.191689872595;7764.107127680332;7870.0949390820215;7873.606319683993;28374.716252837414;28692.426151477062;28827.85586072077;29009.56485652717;29823.10530684083;2534.2270607464716;2576.8196226264167;2591.4428397894353;2592.8444293342272;2618.1491015420065;16697.49907502777;16717.247723852455;17028.148592570324;17264.223109960083;17623.38318158871;1761.8502427293695;1976.377441106047;2017.1729590867674;2076.9169233230655;2156.13754498202;105974.47012764963;134523;134782;137409;138737;20407.795922040885;21713.240036598643;21750.89124554367;21759.34721958312;21916.246700263942;35154.12114697102;35485.29029419397;35653.46519802205;35661;35689.1077723059;10250.487475626189;10420.218483613759;10601.57593696259;10669.466526673636;10695.83956240657;8433.620487078097;8472.703455379155;8492.278156356655;8604.956975215084;8611.492988726948;7923.762287131395;7973.481723687942;9472.479013654178;9666.323357364918;9854.605815767289;3804.714646401531;3812.313783518993;3818.255440189192;3818.2745278397015;3901.902452438712;365.413511314342;816.2286639125969;877.1316396767282;886.059529630108;887.3167660901199;10945.945270273598;11593.6521904343;11730.530778768754;11846.111541634413;11864.050875929905;403.8061730369439;417.8015442664771;428.27621319969154;434.2877680603812;435.3991491741377;5679.971600141973;5926.205529866964;6021.277446706424;6056.697165141725;6096.481799047042;548714;558937;560754;564552;573955;113227;129260;132784;135201.12787593357;140004;961.1397798969883;990.0643891522586;1004.9899501005043;1005.7686732051669;1015.5683834370363;18236.817631823513;19103.235870565022;19114.426567203005;19222.7116593254;19269.4219173425;49700.27847354495;53352.1997170035;53578;54164.1252287296;54870.90258194734;60359.69820150871;77116;77523.44953101019;78019;78584.21415785768;5995.940040599538;7665.6933722650465;7839.294463498312;8056;8185.345172386075;10802;11997.520099195934;12367.196132251374;12422.440990155284;12818.935905320413;10674.039336459757;10873.565057397616;11101;11163.609273675707;11351.943240283746;9368.765780855532;10828.458577070958;10940.39827809478;11146.777064458827;11194.944025279821;10214.693559193236;11056.834147487954;11099.833502497631;11355.205135640426;11509.366984815915;7692.230776922263;7824.300616287372;7893.17121702213;8107.432479726598;8124.7562573122905;10055.29612927088;10613.469326533488;10811.945940270249;10951.780964380509;11097.556097756 14:52:12 INFO - PROCESS | 1942 | |3;mootools.html;1447.5874375802891;1481.6221863424828;1513.0770230159603;1791.6595846789116;1840.4662647832129;7387.298206670371;8002.919970800291;8691.739247822576;8932.419392739475;8962.686305979283;8672.959244890606;8904.065073167321;8918.866217006735;8930.91069089309;8934.240589549896;2374.252110585169;2417.371483414316;2418.6855708757835;2423.878806059699;2425.842320249178;2053.691946208073;2380.976190238093;2382.309130352196;2426.575349313872;2440.0601521790218;2376.3227480168157;2401.4836810085826;2410.662507248978;2414.2757172848164;2423.8060955123547;1979.6436641404541;2369.5497855407416;2369.9052037918464;2381.9285421437385;2421.83047186697;2008.3673642802617;2375.45364566149;2388.9641655375185;2402.447437089462;2415.0098459631467;8922.10778922109;8944.23973962214;9000.459972401612;9047.140521650499;9077.137671921157;5340.572754179695;5511.421300763443;5518.448155184449;5530.806421775219;5534.529564986981;3558.893233202982;3706.5181526401666;3728.328900797855;3733.6453036961443;3790.753601015925;1110.8833572474934;1112.1047556716921;1121.0527104596604;1121.506537123663;1129.6215767717824;11592.942035289854;11636.360000199986;11723.062155027577;11740.999999999915;11750.412479375997;4407.779611019436;4502.842400515966;4663.160631086369;4677.859664210079;4691.50739172382;9178.265738741018;9234.86147707785;9260.444373337621;9261.583228754722;9269.536523173949;5361.865953351119;5364.1417373220875;5367.597430192751;5371.973140134352;5380.300560927054;4475.462944446622;4839.395075615548;4964.255361695775;4983.5763960063805;5028.446870844205;2944.617199764017;3273.623533293654;3755.962440375616;3785.564660064073;3900.1224724436775;1035.5081336365167;1177.605502156787;1182.0956967919549;1186.0511590727383;1189.4587962477053;782.8943092682529;881.2685471059006;912.7033714042963;917.9393843475582;933.2813733425224;5739.684317362502;5747.281589801275;5971.79098731551;6011.879762404727;6017.518598512109;432.1939582678345;444.9265871131292;446.7319608235033;986.5313975861409;1006.3509036671306;3293.818839963825;4009.0578714002186;4045.8786236412957;4056.6551843093075;4102.097538541516;10527.684169474927;10727.785444291227;10861.294015888941;10939.781204375868;10941.617043403601;10679.14566834667;10701.571937122584;10778.838317425245;10851.240413171003;10925.344479331265;7016.4563795964805;7897.960510197412;8144.511329320259;8150.858879756839;8466.788330291793;6000.249968753906;6021.277446706424;6023.46401667572;6120.17377654011;6260.655663938527;9963.352382095141;10077.69766906994;10114.241431892784;10244.180465562886;10271.383716977005;9984.750381240237;10104.545295461576;10272.972702729667;10385.844212336971;10416.427096509764;8044.2760151586635;8279.793005174919;8434.831303374021;8467.364947629076;8475.237228649452;7655.0813902332075;8000;8120.1473845247765;8357.749267521984;8410.831783364421;7463.514871533333;7512.924870751222;7637.694492220471;7680;7787.415943804351;7339.412846972336;7449.404047676281;7459.216782237787;7467.02928619276;7528;7003.614801185984;7113;7117.75087871922;7127.89517624769;7145.035420218412;4931.852044438672;4951.331570237971;4960.404751429707;5102.260172275073;5188.299579556711;4378.846740364072;4659.347691323285;4751.168545504592;5171.146760784429;5225.372955245243 14:52:12 INFO - PROCESS | 1942 | |4;prototype.html;282.3407343852105;305.0436880380008;309.67020123568403;313.3857639027506;315.0548354935194;4252.681048921331;4482.887927801802;5472;5489.423610520887;5503.6147469677135;4398.868033958986;4659.068186362732;4715.265146215195;5003.949170674163;5513.393526712059;3087.6912308769056;4099.631033207011;4120.567340429257;4172.895677608069;4188.350805625133;3534.6995505382074;4007.675548182062;4147.502299724022;4159.712158312916;4178.323075693401;3993.5423570396742;4162.500499940012;4163.666906647476;4164.916701665965;4168.43726096976;2844.431113777253;3997.760134391917;4041.827869917706;4086.346184610448;4188.476440444944;3054.7322861012653;3291.8024918504725;3444.517767512525;3458.394780913355;3475.6176820549717;4137.648299894482;4865.489123642002;5228.268042474018;5266.894662106774;5300.761465734013;3621.8913432597064;4411.470623525165;4456.420665313489;4676.246407597151;4686.000959385996;4396.714213576107;4652.441706995149;5002.82490112848;5664.291963504562;5679.432056794329;3181.411438883814;3203.8878639247746;3402.9829850850588;3825.158465137665;3840.2895464339185;5464.562834973192;5776.884462310731;5997.880042399128;6003.519718422559;6014.548908831812;3780.716446266541;3833.1375440525658;3895.8831235062994;3919.6864250859862;3923.2938071146896;3517.0503963929596;3800.5439347278502;3942.9802850986134;3952.7430717003303;3980.2238563480423;4660.650451216173;4676.532346765364;4686.835960741358;4694.248920172756;4695.389599352131;5498.285222920995;5773.826785196451;5795.275590551181;5822.970885145632;5848.064309710426;1331.7070244546185;1349.7907824287054;1355.9728805423836;1360.2110775750239;1360.7006458579096;729.8321386081232;774.5159275452842;784.172697803811;814.9649944570363;822.7408366364576;4676.579107880307;5406.59450541211;5414.133738601805;5430.425176698713;5444.91832622511;5881.705914704247;5892.646441213541;5901.881962360729;5936.7031648417405;5944.286685597756;5192.92210616841;5278.709670968057;5346.625736198429;5363.463653634605;5389.895071510331;2646.801489888266;3063.571100045951;3069.664695857309;3070.9078727638207;3078.9076327710204;5974.803480138105;6067.332593414721;6069.361272456412;6075;6079.908801367983;4739.4075740532435;4766.118268120339;5508.03609368359;5785.4214578541805;6026.789062382795;5331.573474122061;5857.648541087548;6075.483583895419;6103.908441373472;6136.9079463808075;4396.164728701664;5635.746391412315;5786.103154011135;5839.5036421904615;5867.8289033056335;5120.897582048413;5860.853478663067;5878.764849405976;5943.791967281124;5980.611260268069;5064.848054558369;6203.069539569101;6277.96861015692;6300.306966233619;6327.778527751507;3686.4470329450796;3869.941950870683;3919.627635374635;3927.823247953792;3966.821493032878;5508.944910550843;5858.882822343615;6056.667533142701;6077.331493535619;6098.237720284965;4803.150786946981;5023.321851549994;5839.854003649943;5849.034909239927;5892.882142357214;5693.658380497183;5775.27809023872;5798.217240672624;5805.390434004369;5826.533877289722;5652.830415087554;5674.801381951612;5674.971625141848;5676;5738.53667314832;4964.046392396663;5132.432959093394;5262.394824595221;5316.4582271140935;5486.835394938158;5141.53726164647;5657.4908258256955;5682.573806964577;5702.885942281048;5711.657300561979 14:52:12 INFO - PROCESS | 1942 | |5;yui.html;706.8266677315654;723.7141329174975;747.5327920049968;753.7550296153748;781.7185813107283;15192.392304307828;16289.348426062943;16296.75554866675;16357.345706171738;16390.42633507826;12318.706535813722;14761.114333139993;14818.110913345206;14860.405583776635;14901.552953411388;665.7703092433103;753.6947536247801;768.6164903174292;811.7483580090191;844.7507985144397;848.995755021224;858.0647094666812;861.6725644255174;861.7414775567336;863.9006514250848;914.4833169259347;916.4959272400187;916.7066538707617;917.8623206519009;918.1186061381082;805.569020573993;850.9235816691889;911.0843602179767;911.1344222988188;912.3567884641345;620.6493331267819;647.6729251727847;673.8955461903413;675.9357861003197;677.7966610017024;14689.485867994568;15024.549263522113;15045.172515511642;15049.473268435662;15067.09597424158;12106.39468026604;14579.635509112251;14605.92697036508;14698.186187617683;14899.47851825181;12002;12013.459394327188;12027.278363298143;12081.45633446497;12117.151799374047;3825.8087095645105;3840.1935593525395;3840.9231815363537;3878.26313000529;3987.860424885115;99498.502507487;115208.27187592193;119319.99999999913;120272;122250.38874805658;11230.719232019264;11272.323660580392;11364;11517.942410287895;11591.582941401426;17403;23838.88080559586;23974.760252397253;23983.160589379288;24065.676387798838;7994.80012999668;8003.399745019147;8083.110857805636;8083.514989100673;8303;4186.853460128881;4433.844815431445;4459.769658064444;4487.573680500347;4507.977460112678;3657.341678497896;3754.305453491113;3774.8678796241998;3781.8487260509273;3783.243351329745;620.2061361457252;639.9328070552525;666.6899891550453;679.1985457160598;694.350782018814;657.3984803904374;667.4160109903834;667.9899801502982;678.6538865178794;688.4870771275432;7597.430192735567;9619.663311784054;9628.229741620793;9672.70981870545;9680.612775489042;628.9937100629027;638.3233772201388;656.5961933411013;669.387510427953;672.2672287206871;3810.333191691443;3828.3874580067054;4601.539846015438;4742.715437073718;4791.965709233783;119470;120269;135641.3217933904;158773;160530.53898801788;140393;141373;142529;142624.5737542632;144838.2758086224;119888;120773.39613301877;120774;123421;124744;7498.962505187439;8655.394122411371;9057.592408341772;9088.04575519561;9253.167214950687;55099.898002040536;64301.67849160724;65451.45485451607;66025;66664.66670666462;64474.67762661157;95599;96972.51513742386;98049;100953;10363.430011349448;12123.908848203704;12156.270623762603;12291.56979505713;12588;13167.67080822987;13177.802332965204;13211.933940330237;13251;13251.734965300833;12058.372119763719;12072.3360215189;12209.877901220874;12341.568045118378;12726.427310770852;11857.16999810005;12162.574309899112;12198.085143614087;12309.138360314691;12671.239725616493;12010.939945300217;12252.264864107825;12359.876401235873;12611.68470788201;12641.747165056831;10066.899331006596;10191.7452063699;10278.280520363503;10432.791344173225;10685.786284274427;10094.545745441326;10200.234982376203;10450.895491045296;10795.19036072282;10812.729681758019 14:52:12 INFO - PROCESS | 1942 | __end_tp_report 14:52:12 INFO - PROCESS | 1942 | __start_cc_report 14:52:12 INFO - PROCESS | 1942 | _x_x_mozilla_cycle_collect,382 14:52:12 INFO - PROCESS | 1942 | __end_cc_report 14:52:12 INFO - PROCESS | 1942 | __startTimestamp1472853132373__endTimestamp 14:52:12 INFO - PROCESS | 1942 | 14:52:12 INFO - PROCESS | 1942 | ------- Summary: start ------- 14:52:12 INFO - PROCESS | 1942 | Number of tests: 6 14:52:12 INFO - PROCESS | 1942 | 14:52:12 INFO - PROCESS | 1942 | [#0] dojo.html Cycles:165 Average:5775.06 Median:6052.97 stddev:668.39 (11.0%) stddev-sans-first:624.98 14:52:12 INFO - PROCESS | 1942 | Values: 2686.4 3125.5 3393.8 3426.6 3453.7 5452.6 5629.7 5728.1 5789.9 5850.8 4993.7 5773.3 5865.7 5869.1 5899.9 4134.9 5318.5 5328.8 5385.4 5399.2 5387.2 5412.5 5446.4 5479.5 5485.9 5168.5 5228.3 5296.6 5308.2 5327.1 5253.2 5254.3 5280.6 5306.7 5357.7 5231.7 5262.0 5274.9 5321.6 5338.6 5332.1 5463.4 5716.1 5752.9 5803.4 6208.9 6250.5 6284.1 6291.4 6298.5 6259.1 6283.7 6297.7 6299.9 6303.6 5799.7 5911.2 5971.0 5978.2 6058.5 6270.6 6327.8 6343.2 6351.7 6481.3 6274.0 6277.9 6281.3 6298.2 6317.9 6117.9 6154.5 6247.9 6266.1 6297.1 5333.8 6175.5 6218.8 6222.0 6223.6 6192.4 6264.3 6293.5 6308.2 6339.8 4913.6 4968.8 4993.5 5051.8 5066.6 4483.9 4508.6 4520.3 4533.6 4566.0 5844.5 5891.8 5922.6 5967.1 5975.7 6203.4 6234.6 6242.3 6284.5 6303.2 5984.8 5985.4 6005.4 6007.0 6053.0 5489.8 5517.6 5527.4 5552.2 5552.4 6196.7 6233.3 6241.8 6352.8 6357.7 5092.9 6274.6 6284.8 6309.8 6318.4 4916.1 5285.7 5722.2 6274.9 6349.5 5696.2 6132.5 6147.8 6173.7 6260.2 5979.9 6215.9 6248.4 6256.7 6274.5 6246.0 6252.8 6261.4 6264.1 6273.5 6072.0 6122.5 6139.8 6211.1 6257.3 6014.0 6098.7 6101.4 6109.9 6110.8 6166.1 6166.3 6185.2 6188.7 6189.2 5951.8 6069.9 6095.3 6105.5 6113.0 14:52:12 INFO - PROCESS | 1942 | 14:52:12 INFO - PROCESS | 1942 | [#1] ext.html Cycles:180 Average:63847.46 Median:38125.24 stddev:140593.42 (368.8%) stddev-sans-first:140907.31 14:52:12 INFO - PROCESS | 1942 | Values: 476.5 529.2 535.4 538.2 569.4 37034.8 39435.6 39438.6 39457.8 39480.8 40581.4 40864.4 40933.4 41050.4 41078.8 9598.3 9812.5 9818.5 9872.1 9933.4 9618.8 9693.2 9726.9 9727.6 9744.0 9644.9 9727.0 9759.0 9762.6 9763.8 9692.7 9709.1 9715.1 9719.5 9734.9 9656.4 9717.3 9759.7 9775.3 9780.8 38823.8 39221.6 39277.0 39322.0 39429.8 3282.7 3324.7 3348.0 3375.7 3834.6 30096.5 30309.1 30883.5 31003.5 31653.5 3235.4 3257.3 3263.2 3340.9 3417.4 444756.0 475212.0 479500.0 480792.0 481422.0 31904.0 32921.7 57495.8 57735.4 57886.4 33640.8 33911.7 34034.3 34084.7 34166.5 14045.4 14090.9 14203.7 14243.7 14252.5 11796.3 11869.5 11920.6 11924.5 11954.7 7553.7 7600.0 7661.2 7669.5 7673.2 2750.9 2825.4 3269.8 3278.2 3284.7 938.4 960.8 963.6 964.1 1002.2 25007.5 29336.4 29625.9 29788.9 29845.7 925.8 992.4 1010.2 1082.7 1142.0 14802.6 15100.4 15168.8 15437.1 15487.9 587198.0 625057.0 629443.8 630038.0 633390.0 50687.7 54241.7 54294.6 54365.2 54398.5 1350.1 1383.3 1405.3 1408.1 1412.9 24872.6 26278.6 26756.6 28153.6 29855.4 46559.3 46968.5 47312.3 47357.8 47400.0 465291.4 468213.0 468829.0 470722.0 470837.0 25241.2 25455.9 25721.7 25735.4 25777.9 33961.7 45194.5 45220.5 45415.3 45540.0 34024.8 36483.6 37089.3 37403.8 38041.8 37108.8 37128.4 37986.8 38103.6 38146.9 36087.8 36664.3 36834.8 37101.3 37683.6 27181.0 31719.0 33670.5 33684.0 33714.7 24852.1 24939.4 25194.5 25422.6 25446.0 14:52:12 INFO - PROCESS | 1942 | 14:52:12 INFO - PROCESS | 1942 | [#2] jquery.html Cycles:180 Average:35310.45 Median:35319.71 stddev:94287.95 (267.0%) stddev-sans-first:94515.86 14:52:12 INFO - PROCESS | 1942 | Values: 322.4 330.5 342.5 359.8 379.2 14957.9 18029.3 20524.2 20731.4 20986.8 17385.0 19739.7 19970.0 20546.6 20954.2 5854.8 6183.9 6184.0 6185.5 6194.3 5771.7 5826.6 6060.9 6107.7 6139.2 4867.3 5915.1 6068.9 6073.3 6074.2 7620.3 7878.0 8047.3 8092.6 8094.4 7506.2 7698.2 7764.1 7870.1 7873.6 28374.7 28692.4 28827.9 29009.6 29823.1 2534.2 2576.8 2591.4 2592.8 2618.1 16697.5 16717.2 17028.1 17264.2 17623.4 1761.9 1976.4 2017.2 2076.9 2156.1 105974.5 134523.0 134782.0 137409.0 138737.0 20407.8 21713.2 21750.9 21759.3 21916.2 35154.1 35485.3 35653.5 35661.0 35689.1 10250.5 10420.2 10601.6 10669.5 10695.8 8433.6 8472.7 8492.3 8605.0 8611.5 7923.8 7973.5 9472.5 9666.3 9854.6 3804.7 3812.3 3818.3 3818.3 3901.9 365.4 816.2 877.1 886.1 887.3 10945.9 11593.7 11730.5 11846.1 11864.1 403.8 417.8 428.3 434.3 435.4 5680.0 5926.2 6021.3 6056.7 6096.5 548714.0 558937.0 560754.0 564552.0 573955.0 113227.0 129260.0 132784.0 135201.1 140004.0 961.1 990.1 1005.0 1005.8 1015.6 18236.8 19103.2 19114.4 19222.7 19269.4 49700.3 53352.2 53578.0 54164.1 54870.9 60359.7 77116.0 77523.4 78019.0 78584.2 5995.9 7665.7 7839.3 8056.0 8185.3 10802.0 11997.5 12367.2 12422.4 12818.9 10674.0 10873.6 11101.0 11163.6 11351.9 9368.8 10828.5 10940.4 11146.8 11194.9 10214.7 11056.8 11099.8 11355.2 11509.4 7692.2 7824.3 7893.2 8107.4 8124.8 10055.3 10613.5 10811.9 10951.8 11097.6 14:52:12 INFO - PROCESS | 1942 | 14:52:12 INFO - PROCESS | 1942 | [#3] mootools.html Cycles:180 Average:5727.81 Median:4795.28 stddev:3235.68 (67.5%) stddev-sans-first:3228.77 14:52:12 INFO - PROCESS | 1942 | Values: 1447.6 1481.6 1513.1 1791.7 1840.5 7387.3 8002.9 8691.7 8932.4 8962.7 8673.0 8904.1 8918.9 8930.9 8934.2 2374.3 2417.4 2418.7 2423.9 2425.8 2053.7 2381.0 2382.3 2426.6 2440.1 2376.3 2401.5 2410.7 2414.3 2423.8 1979.6 2369.5 2369.9 2381.9 2421.8 2008.4 2375.5 2389.0 2402.4 2415.0 8922.1 8944.2 9000.5 9047.1 9077.1 5340.6 5511.4 5518.4 5530.8 5534.5 3558.9 3706.5 3728.3 3733.6 3790.8 1110.9 1112.1 1121.1 1121.5 1129.6 11592.9 11636.4 11723.1 11741.0 11750.4 4407.8 4502.8 4663.2 4677.9 4691.5 9178.3 9234.9 9260.4 9261.6 9269.5 5361.9 5364.1 5367.6 5372.0 5380.3 4475.5 4839.4 4964.3 4983.6 5028.4 2944.6 3273.6 3756.0 3785.6 3900.1 1035.5 1177.6 1182.1 1186.1 1189.5 782.9 881.3 912.7 917.9 933.3 5739.7 5747.3 5971.8 6011.9 6017.5 432.2 444.9 446.7 986.5 1006.4 3293.8 4009.1 4045.9 4056.7 4102.1 10527.7 10727.8 10861.3 10939.8 10941.6 10679.1 10701.6 10778.8 10851.2 10925.3 7016.5 7898.0 8144.5 8150.9 8466.8 6000.2 6021.3 6023.5 6120.2 6260.7 9963.4 10077.7 10114.2 10244.2 10271.4 9984.8 10104.5 10273.0 10385.8 10416.4 8044.3 8279.8 8434.8 8467.4 8475.2 7655.1 8000.0 8120.1 8357.7 8410.8 7463.5 7512.9 7637.7 7680.0 7787.4 7339.4 7449.4 7459.2 7467.0 7528.0 7003.6 7113.0 7117.8 7127.9 7145.0 4931.9 4951.3 4960.4 5102.3 5188.3 4378.8 4659.3 4751.2 5171.1 5225.4 14:52:12 INFO - PROCESS | 1942 | 14:52:12 INFO - PROCESS | 1942 | [#4] prototype.html Cycles:180 Average:4586.99 Median:5136.99 stddev:1464.41 (28.5%) stddev-sans-first:1432.44 14:52:12 INFO - PROCESS | 1942 | Values: 282.3 305.0 309.7 313.4 315.1 4252.7 4482.9 5472.0 5489.4 5503.6 4398.9 4659.1 4715.3 5003.9 5513.4 3087.7 4099.6 4120.6 4172.9 4188.4 3534.7 4007.7 4147.5 4159.7 4178.3 3993.5 4162.5 4163.7 4164.9 4168.4 2844.4 3997.8 4041.8 4086.3 4188.5 3054.7 3291.8 3444.5 3458.4 3475.6 4137.6 4865.5 5228.3 5266.9 5300.8 3621.9 4411.5 4456.4 4676.2 4686.0 4396.7 4652.4 5002.8 5664.3 5679.4 3181.4 3203.9 3403.0 3825.2 3840.3 5464.6 5776.9 5997.9 6003.5 6014.5 3780.7 3833.1 3895.9 3919.7 3923.3 3517.1 3800.5 3943.0 3952.7 3980.2 4660.7 4676.5 4686.8 4694.2 4695.4 5498.3 5773.8 5795.3 5823.0 5848.1 1331.7 1349.8 1356.0 1360.2 1360.7 729.8 774.5 784.2 815.0 822.7 4676.6 5406.6 5414.1 5430.4 5444.9 5881.7 5892.6 5901.9 5936.7 5944.3 5192.9 5278.7 5346.6 5363.5 5389.9 2646.8 3063.6 3069.7 3070.9 3078.9 5974.8 6067.3 6069.4 6075.0 6079.9 4739.4 4766.1 5508.0 5785.4 6026.8 5331.6 5857.6 6075.5 6103.9 6136.9 4396.2 5635.7 5786.1 5839.5 5867.8 5120.9 5860.9 5878.8 5943.8 5980.6 5064.8 6203.1 6278.0 6300.3 6327.8 3686.4 3869.9 3919.6 3927.8 3966.8 5508.9 5858.9 6056.7 6077.3 6098.2 4803.2 5023.3 5839.9 5849.0 5892.9 5693.7 5775.3 5798.2 5805.4 5826.5 5652.8 5674.8 5675.0 5676.0 5738.5 4964.0 5132.4 5262.4 5316.5 5486.8 5141.5 5657.5 5682.6 5702.9 5711.7 14:52:12 INFO - PROCESS | 1942 | 14:52:12 INFO - PROCESS | 1942 | [#5] yui.html Cycles:180 Average:25305.21 Median:3705.82 stddev:41141.82 (1110.2%) stddev-sans-first:41215.78 14:52:12 INFO - PROCESS | 1942 | Values: 706.8 723.7 747.5 753.8 781.7 15192.4 16289.3 16296.8 16357.3 16390.4 12318.7 14761.1 14818.1 14860.4 14901.6 665.8 753.7 768.6 811.7 844.8 849.0 858.1 861.7 861.7 863.9 914.5 916.5 916.7 917.9 918.1 805.6 850.9 911.1 911.1 912.4 620.6 647.7 673.9 675.9 677.8 14689.5 15024.5 15045.2 15049.5 15067.1 12106.4 14579.6 14605.9 14698.2 14899.5 12002.0 12013.5 12027.3 12081.5 12117.2 3825.8 3840.2 3840.9 3878.3 3987.9 99498.5 115208.3 119320.0 120272.0 122250.4 11230.7 11272.3 11364.0 11517.9 11591.6 17403.0 23838.9 23974.8 23983.2 24065.7 7994.8 8003.4 8083.1 8083.5 8303.0 4186.9 4433.8 4459.8 4487.6 4508.0 3657.3 3754.3 3774.9 3781.8 3783.2 620.2 639.9 666.7 679.2 694.4 657.4 667.4 668.0 678.7 688.5 7597.4 9619.7 9628.2 9672.7 9680.6 629.0 638.3 656.6 669.4 672.3 3810.3 3828.4 4601.5 4742.7 4792.0 119470.0 120269.0 135641.3 158773.0 160530.5 140393.0 141373.0 142529.0 142624.6 144838.3 119888.0 120773.4 120774.0 123421.0 124744.0 7499.0 8655.4 9057.6 9088.0 9253.2 55099.9 64301.7 65451.5 66025.0 66664.7 64474.7 95599.0 96972.5 98049.0 100953.0 10363.4 12123.9 12156.3 12291.6 12588.0 13167.7 13177.8 13211.9 13251.0 13251.7 12058.4 12072.3 12209.9 12341.6 12726.4 11857.2 12162.6 12198.1 12309.1 12671.2 12010.9 12252.3 12359.9 12611.7 12641.7 10066.9 10191.7 10278.3 10432.8 10685.8 10094.5 10200.2 10450.9 10795.2 10812.7 14:52:12 INFO - PROCESS | 1942 | -------- Summary: end -------- 14:52:12 INFO - PROCESS | 1942 | 14:52:12 INFO - TEST-INFO | 1942: exit 0 14:52:12 INFO - TEST-OK | dromaeo_css | took 1114782ms 14:52:12 INFO - TEST-START | kraken 14:52:12 INFO - operating with platform_type : mac_ 14:52:12 INFO - Initialising browser for kraken test... 14:52:12 INFO - TEST-INFO | started process 1947 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/tmpzlO2JX/profile http://localhost:49440/getInfo.html) 14:52:15 INFO - PROCESS | 1947 | __metrics Screen width/height:1600/1200 14:52:15 INFO - PROCESS | 1947 | colorDepth:24 14:52:15 INFO - PROCESS | 1947 | Browser inner width/height: 1024/689 14:52:15 INFO - PROCESS | 1947 | __metrics 14:52:15 ERROR - PROCESS | 1947 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 14:52:16 INFO - TEST-INFO | 1947: exit 0 14:52:16 INFO - Browser initialized. 14:52:16 INFO - Running cycle 1/1 for kraken test... 14:52:16 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/tmpzlO2JX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:52:28 INFO - PROCESS | 1949 | RSS: Main: 245587968 14:52:28 INFO - PROCESS | 1949 | 14:52:31 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49440/tests/kraken/driver.html?testName=audio-beat-detection) 14:52:32 INFO - PROCESS | 1949 | RSS: Main: 258338816 14:52:32 INFO - PROCESS | 1949 | 14:52:34 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49440/tests/kraken/driver.html?testName=audio-dft) 14:52:35 INFO - PROCESS | 1949 | RSS: Main: 266997760 14:52:35 INFO - PROCESS | 1949 | 14:52:38 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49440/tests/kraken/driver.html?testName=audio-fft) 14:52:39 INFO - PROCESS | 1949 | RSS: Main: 265633792 14:52:39 INFO - PROCESS | 1949 | 14:52:41 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49440/tests/kraken/driver.html?testName=audio-oscillator) 14:52:42 INFO - PROCESS | 1949 | RSS: Main: 268013568 14:52:42 INFO - PROCESS | 1949 | 14:52:44 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49440/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:52:45 INFO - PROCESS | 1949 | RSS: Main: 268378112 14:52:45 INFO - PROCESS | 1949 | 14:52:48 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49440/tests/kraken/driver.html?testName=imaging-darkroom) 14:52:48 INFO - PROCESS | 1949 | RSS: Main: 268939264 14:52:48 INFO - PROCESS | 1949 | 14:52:52 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49440/tests/kraken/driver.html?testName=imaging-desaturate) 14:52:52 INFO - PROCESS | 1949 | RSS: Main: 269524992 14:52:52 INFO - PROCESS | 1949 | 14:52:55 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49440/tests/kraken/driver.html?testName=json-parse-financial) 14:52:56 INFO - PROCESS | 1949 | RSS: Main: 269533184 14:52:56 INFO - PROCESS | 1949 | 14:52:57 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49440/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:52:58 INFO - PROCESS | 1949 | RSS: Main: 268722176 14:52:58 INFO - PROCESS | 1949 | 14:53:00 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:53:01 INFO - PROCESS | 1949 | RSS: Main: 269123584 14:53:01 INFO - PROCESS | 1949 | 14:53:03 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:53:04 INFO - PROCESS | 1949 | RSS: Main: 269467648 14:53:04 INFO - PROCESS | 1949 | 14:53:07 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:53:07 INFO - PROCESS | 1949 | RSS: Main: 269471744 14:53:07 INFO - PROCESS | 1949 | 14:53:10 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:53:11 INFO - PROCESS | 1949 | RSS: Main: 269496320 14:53:11 INFO - PROCESS | 1949 | 14:53:13 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49440/tests/kraken/driver.html?testName=ai-astar) 14:53:13 INFO - PROCESS | 1949 | RSS: Main: 271552512 14:53:13 INFO - PROCESS | 1949 | 14:53:13 INFO - PROCESS | 1949 | __start_tp_report 14:53:13 INFO - PROCESS | 1949 | _x_x_mozilla_page_load 14:53:13 INFO - PROCESS | 1949 | _x_x_mozilla_page_load_details 14:53:13 INFO - PROCESS | 1949 | |i|pagename|runs| 14:53:13 INFO - PROCESS | 1949 | |0;ai-astar;89;152;173;163;116;117;115;125;116;132 14:53:13 INFO - PROCESS | 1949 | |1;audio-beat-detection;145;112;141;156;110;133;131;112;156;110 14:53:13 INFO - PROCESS | 1949 | |2;audio-dft;199;242;218;212;197;201;199;199;201;220 14:53:13 INFO - PROCESS | 1949 | |3;audio-fft;66;79;99;150;72;82;70;52;147;67 14:53:13 INFO - PROCESS | 1949 | |4;audio-oscillator;73;102;154;60;101;133;106;75;103;143 14:53:13 INFO - PROCESS | 1949 | |5;imaging-gaussian-blur;92;86;136;96;86;86;125;129;91;132 14:53:13 INFO - PROCESS | 1949 | |6;imaging-darkroom;157;101;100;137;114;172;106;127;167;162 14:53:13 INFO - PROCESS | 1949 | |7;imaging-desaturate;93;102;151;146;93;91;93;96;101;142 14:53:13 INFO - PROCESS | 1949 | |8;json-parse-financial;59;61;59;58;57;60;61;59;59;60 14:53:13 INFO - PROCESS | 1949 | |9;json-stringify-tinderbox;67;70;69;82;71;76;75;75;72;73 14:53:13 INFO - PROCESS | 1949 | |10;stanford-crypto-aes;87;88;89;89;92;87;85;87;89;85 14:53:13 INFO - PROCESS | 1949 | |11;stanford-crypto-ccm;141;154;171;159;155;159;153;150;192;163 14:53:13 INFO - PROCESS | 1949 | |12;stanford-crypto-pbkdf2;179;214;172;173;246;173;187;152;233;192 14:53:13 INFO - PROCESS | 1949 | |13;stanford-crypto-sha256-iterative;66;69;69;70;69;68;69;69;70;68 14:53:13 INFO - PROCESS | 1949 | __end_tp_report 14:53:13 INFO - PROCESS | 1949 | __start_cc_report 14:53:13 INFO - PROCESS | 1949 | _x_x_mozilla_cycle_collect,973 14:53:13 INFO - PROCESS | 1949 | __end_cc_report 14:53:13 INFO - PROCESS | 1949 | __startTimestamp1472853193452__endTimestamp 14:53:13 INFO - PROCESS | 1949 | 14:53:13 INFO - PROCESS | 1949 | ------- Summary: start ------- 14:53:13 INFO - PROCESS | 1949 | Number of tests: 14 14:53:13 INFO - PROCESS | 1949 | 14:53:13 INFO - PROCESS | 1949 | [#0] ai-astar Cycles:10 Average:129.80 Median:142.00 stddev:25.64 (18.1%) stddev-sans-first:22.55 14:53:13 INFO - PROCESS | 1949 | Values: 89.0 152.0 173.0 163.0 116.0 117.0 115.0 125.0 116.0 132.0 14:53:13 INFO - PROCESS | 1949 | 14:53:13 INFO - PROCESS | 1949 | [#1] audio-beat-detection Cycles:10 Average:130.60 Median:137.00 stddev:18.72 (13.7%) stddev-sans-first:19.11 14:53:13 INFO - PROCESS | 1949 | Values: 145.0 112.0 141.0 156.0 110.0 133.0 131.0 112.0 156.0 110.0 14:53:13 INFO - PROCESS | 1949 | 14:53:13 INFO - PROCESS | 1949 | [#2] audio-dft Cycles:10 Average:208.80 Median:206.50 stddev:14.42 (7.0%) stddev-sans-first:14.85 14:53:13 INFO - PROCESS | 1949 | Values: 199.0 242.0 218.0 212.0 197.0 201.0 199.0 199.0 201.0 220.0 14:53:13 INFO - PROCESS | 1949 | 14:53:13 INFO - PROCESS | 1949 | [#3] audio-fft Cycles:10 Average:88.40 Median:71.00 stddev:33.93 (47.8%) stddev-sans-first:35.01 14:53:13 INFO - PROCESS | 1949 | Values: 66.0 79.0 99.0 150.0 72.0 82.0 70.0 52.0 147.0 67.0 14:53:13 INFO - PROCESS | 1949 | 14:53:13 INFO - PROCESS | 1949 | [#4] audio-oscillator Cycles:10 Average:105.00 Median:148.50 stddev:30.93 (20.8%) stddev-sans-first:30.56 14:53:13 INFO - PROCESS | 1949 | Values: 73.0 102.0 154.0 60.0 101.0 133.0 106.0 75.0 103.0 143.0 14:53:13 INFO - PROCESS | 1949 | 14:53:13 INFO - PROCESS | 1949 | [#5] imaging-gaussian-blur Cycles:10 Average:105.90 Median:86.00 stddev:21.57 (25.1%) stddev-sans-first:22.28 14:53:13 INFO - PROCESS | 1949 | Values: 92.0 86.0 136.0 96.0 86.0 86.0 125.0 129.0 91.0 132.0 14:53:13 INFO - PROCESS | 1949 | 14:53:13 INFO - PROCESS | 1949 | [#6] imaging-darkroom Cycles:10 Average:134.30 Median:147.00 stddev:28.54 (19.4%) stddev-sans-first:29.07 14:53:13 INFO - PROCESS | 1949 | Values: 157.0 101.0 100.0 137.0 114.0 172.0 106.0 127.0 167.0 162.0 14:53:13 INFO - PROCESS | 1949 | 14:53:13 INFO - PROCESS | 1949 | [#7] imaging-desaturate Cycles:10 Average:110.80 Median:92.00 stddev:24.86 (27.0%) stddev-sans-first:25.52 14:53:13 INFO - PROCESS | 1949 | Values: 93.0 102.0 151.0 146.0 93.0 91.0 93.0 96.0 101.0 142.0 14:53:13 INFO - PROCESS | 1949 | 14:53:13 INFO - PROCESS | 1949 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:59.50 stddev:1.25 (2.1%) stddev-sans-first:1.32 14:53:13 INFO - PROCESS | 1949 | Values: 59.0 61.0 59.0 58.0 57.0 60.0 61.0 59.0 59.0 60.0 14:53:13 INFO - PROCESS | 1949 | 14:53:13 INFO - PROCESS | 1949 | [#9] json-stringify-tinderbox Cycles:10 Average:73.00 Median:74.00 stddev:4.27 (5.8%) stddev-sans-first:3.94 14:53:13 INFO - PROCESS | 1949 | Values: 67.0 70.0 69.0 82.0 71.0 76.0 75.0 75.0 72.0 73.0 14:53:13 INFO - PROCESS | 1949 | 14:53:13 INFO - PROCESS | 1949 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:88.50 stddev:2.10 (2.4%) stddev-sans-first:2.20 14:53:13 INFO - PROCESS | 1949 | Values: 87.0 88.0 89.0 89.0 92.0 87.0 85.0 87.0 89.0 85.0 14:53:13 INFO - PROCESS | 1949 | 14:53:13 INFO - PROCESS | 1949 | [#11] stanford-crypto-ccm Cycles:10 Average:159.70 Median:159.00 stddev:13.85 (8.7%) stddev-sans-first:12.93 14:53:13 INFO - PROCESS | 1949 | Values: 141.0 154.0 171.0 159.0 155.0 159.0 153.0 150.0 192.0 163.0 14:53:13 INFO - PROCESS | 1949 | 14:53:13 INFO - PROCESS | 1949 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.10 Median:189.50 stddev:29.81 (15.7%) stddev-sans-first:31.24 14:53:13 INFO - PROCESS | 1949 | Values: 179.0 214.0 172.0 173.0 246.0 173.0 187.0 152.0 233.0 192.0 14:53:13 INFO - PROCESS | 1949 | 14:53:13 INFO - PROCESS | 1949 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.16 (1.7%) stddev-sans-first:0.71 14:53:13 INFO - PROCESS | 1949 | Values: 66.0 69.0 69.0 70.0 69.0 68.0 69.0 69.0 70.0 68.0 14:53:13 INFO - PROCESS | 1949 | -------- Summary: end -------- 14:53:13 INFO - PROCESS | 1949 | 14:53:14 INFO - TEST-INFO | 1949: exit 0 14:53:14 INFO - TEST-OK | kraken | took 61328ms 14:53:14 INFO - SUITE-END | took 1176s 14:53:14 INFO - Completed test suite (00:19:36) 14:53:14 INFO - javascript benchmark 14:53:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7308.35569516745, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2686.4089900221957, 3125.4686703260445, 3393.762436629434, 3426.5545479087714, 3453.7409694272937, 5452.591055670826, 5629.690367029812, 5728.112142617896, 5789.913151302729, 5850.824475265749, 4993.6766756809475, 5773.336066352371, 5865.70671466426, 5869.1196320551935, 5899.941000589993, 4134.917301653965, 5318.521333080022, 5328.8401347959625, 5385.35375754908, 5399.19012148179, 5387.19192121183, 5412.485813847678, 5446.400895901447, 5479.506844384005, 5485.917711234335, 5168.53483186515, 5228.2680424740565, 5296.602754793406, 5308.177232528945, 5327.121025030865, 5253.238280449352, 5254.290670759437, 5280.551153151987, 5306.70813105279, 5357.705326207057, 5231.738413079331, 5262.0, 5274.878913466828, 5321.600879934021, 5338.599605029638, 5332.093544097474, 5463.426340234258, 5716.114002329646, 5752.942470575283, 5803.448672376117, 6208.937910620926, 6250.468710159642, 6284.057391391282, 6291.402316779899, 6298.527610429236, 6259.0924315973925, 6283.654399008053, 6297.6536290504, 6299.8740025199695, 6303.55875088744, 5799.710014499258, 5911.231539899872, 5971.0, 5978.1929439525975, 6058.485028772604, 6270.561060725797, 6327.841803954938, 6343.238811342669, 6351.650659213788, 6481.319461456479, 6274.027525733519, 6277.905831412532, 6281.309056003927, 6298.1812364392335, 6317.905231421532, 6117.9187529241, 6154.5384096192965, 6247.9062814057825, 6266.091416744546, 6297.149884765498, 5333.773232156548, 6175.536834737412, 6218.751249949952, 6222.0, 6223.595466294676, 6192.442680158807, 6264.342244064399, 6293.527985401021, 6308.179936608303, 6339.778107766206, 4913.606911447076, 4968.751562421937, 4993.500649934977, 5051.848444546596, 5066.569341606005, 4483.910321793611, 4508.616767574727, 4520.276755719069, 4533.569310915458, 4566.041131362451, 5844.503217226498, 5891.823245302648, 5922.585419020627, 5967.134765459071, 5975.731092100866, 6203.410675985774, 6234.625922444668, 6242.250929888442, 6284.497240220863, 6303.212098487689, 5984.820455386345, 5985.371535988658, 6005.369436209223, 6006.969965150233, 6052.970994930873, 5489.752961116759, 5517.613767036269, 5527.39198688144, 5552.167174923713, 5552.3892371839065, 6196.721147548281, 6233.252009758858, 6241.812745617639, 6352.792969335811, 6357.713902874381, 5092.949070509248, 6274.560780745304, 6284.811455656338, 6309.810705678837, 6318.399752023551, 4916.0905232532095, 5285.705002274467, 5722.198892155185, 6274.937250627435, 6349.460295874902, 5696.20253164549, 6132.478739307209, 6147.784827531015, 6173.660448675187, 6260.217472815898, 5979.880402392015, 6215.9378406215355, 6248.4064013918605, 6256.749730010749, 6274.46667033289, 6246.0, 6252.843678908063, 6261.436470717657, 6264.091706702594, 6273.466755325849, 6072.0, 6122.510199184144, 6139.754409823557, 6211.09939058843, 6257.342978987141, 6013.977623803877, 6098.664573448503, 6101.4290607115445, 6109.908351374822, 6110.816675499742, 6166.136740856194, 6166.260048794174, 6185.226846644169, 6188.690565471798, 6189.164462797465, 5951.761929522944, 6069.878602427839, 6095.329513753572, 6105.5420843437805, 6112.969435152973], "value": 5731.72014632625, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.5187160967423, 529.2088327949715, 535.4377903201637, 538.1953978801693, 569.4419468920461, 37034.81482592587, 39435.60564394355, 39438.60561394385, 39457.80271098644, 39480.802595987014, 40581.39127913084, 40864.387034194435, 40933.38599920996, 41050.38424423636, 41078.79460602693, 9598.328117031811, 9812.50937453128, 9818.45998470084, 9872.111509964101, 9933.403995760278, 9618.807623847519, 9693.17608003317, 9726.902730972706, 9727.562259698296, 9743.976882427349, 9644.903550964471, 9726.9513652432, 9759.02409759022, 9762.560684769167, 9763.755906102333, 9692.70921872345, 9709.126178643955, 9715.07706767856, 9719.46542940138, 9734.902650973541, 9656.37233579815, 9717.271204659679, 9759.707208783748, 9775.31572789905, 9780.755481112958, 38823.8058809707, 39221.60778392208, 39277.0, 39322.0, 39429.80285098585, 3282.6717328267223, 3324.734021278292, 3347.966520334814, 3375.662433756629, 3834.635709607611, 30096.548551771742, 30309.090727278217, 30883.536746948816, 31003.534946975815, 31653.52519712206, 3235.4014507315987, 3257.2833976525126, 3263.2494526258856, 3340.916477088092, 3417.4361230396953, 444756.0, 475212.0, 479500.0, 480792.0, 481422.0, 31903.969122933286, 32921.67078329234, 57495.82537571555, 57735.42264577385, 57886.42113578894, 33640.831795840866, 33911.66088339134, 34034.31931361408, 34084.659153408145, 34166.48750268748, 14045.438182472792, 14090.85909140916, 14203.721665050196, 14243.715125697428, 14252.501162459264, 11796.29222246668, 11869.46587403569, 11920.642380728592, 11924.46339914706, 11954.701132471584, 7553.697852085965, 7599.962000190074, 7661.195574464712, 7669.501482403626, 7673.232676732394, 2750.917472475829, 2825.39254060378, 3269.7711160219033, 3278.164068162603, 3284.653292150207, 938.4088024544493, 960.7790208252142, 963.6241865672393, 964.0583587228512, 1002.218269749582, 25007.456009543836, 29336.413271734873, 29625.85187074094, 29788.851055745017, 29845.701542984727, 925.7500474871747, 992.4045572656493, 1010.1716592394166, 1082.7239054041327, 1141.9950443609737, 14802.555923322318, 15100.411238863182, 15168.848311516964, 15437.0737755735, 15487.922560387125, 587198.0, 625057.0, 629443.7611862691, 630038.0, 633390.0, 50687.73280668013, 54241.72879135579, 54294.64263393447, 54365.1845222322, 54398.45601543934, 1350.068452767607, 1383.3359987205997, 1405.3184205660248, 1408.1058527834693, 1412.9049986260525, 24872.632005239884, 26278.554679492812, 26756.59865101986, 28153.577696334163, 29855.402891942475, 46559.30161047655, 46968.530314696414, 47312.290315644605, 47357.76321118372, 47400.0, 465291.42959992477, 468213.0, 468829.0, 470722.0, 470837.0, 25241.24276271715, 25455.87272063628, 25721.742782571935, 25735.356616084, 25777.871110644326, 33961.66038339684, 45194.54805451904, 45220.54779452163, 45415.318770219135, 45540.0, 34024.82987585046, 36483.635163648025, 37089.25821483609, 37403.81298093492, 38041.809790950865, 37108.814455927546, 37128.443073354465, 37986.810065949496, 38103.618963810004, 38146.85559433221, 36087.819560902026, 36664.26671466503, 36834.815825921774, 37101.25797484089, 37683.62316376801, 27181.04866329669, 31719.0, 33670.49494257539, 33684.0, 33714.662853371156, 24852.130175443774, 24939.376515587257, 25194.496110078064, 25422.618660719734, 25446.0], "value": 18041.05310096434, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.3649410660998, 330.54219905430983, 342.47259220799964, 359.7967148561063, 379.1771855074488, 14957.850421495781, 18029.278828846847, 20524.179032838707, 20731.378058658265, 20986.790132098675, 17385.0, 19739.70390444141, 19970.00149992502, 20546.589068218625, 20954.16183352668, 5854.795082172125, 6183.9381606183815, 6183.969080154593, 6185.536084793636, 6194.318624951252, 5771.682557459338, 5826.563007774413, 6060.939390606081, 6107.725152368132, 6139.171211886405, 4867.269909513584, 5915.053591425372, 6068.937935861229, 6073.301570319403, 6074.179985701918, 7620.276073772982, 7878.0, 8047.275745182932, 8092.595370231524, 8094.352451803841, 7506.174320824705, 7698.191689872595, 7764.107127680332, 7870.0949390820215, 7873.606319683993, 28374.716252837414, 28692.426151477062, 28827.85586072077, 29009.56485652717, 29823.10530684083, 2534.2270607464716, 2576.8196226264167, 2591.4428397894353, 2592.8444293342272, 2618.1491015420065, 16697.49907502777, 16717.247723852455, 17028.148592570324, 17264.223109960083, 17623.38318158871, 1761.8502427293695, 1976.377441106047, 2017.1729590867674, 2076.9169233230655, 2156.13754498202, 105974.47012764963, 134523.0, 134782.0, 137409.0, 138737.0, 20407.795922040885, 21713.240036598643, 21750.89124554367, 21759.34721958312, 21916.246700263942, 35154.12114697102, 35485.29029419397, 35653.46519802205, 35661.0, 35689.1077723059, 10250.487475626189, 10420.218483613759, 10601.57593696259, 10669.466526673636, 10695.83956240657, 8433.620487078097, 8472.703455379155, 8492.278156356655, 8604.956975215084, 8611.492988726948, 7923.762287131395, 7973.481723687942, 9472.479013654178, 9666.323357364918, 9854.605815767289, 3804.714646401531, 3812.313783518993, 3818.255440189192, 3818.2745278397015, 3901.902452438712, 365.413511314342, 816.2286639125969, 877.1316396767282, 886.059529630108, 887.3167660901199, 10945.945270273598, 11593.6521904343, 11730.530778768754, 11846.111541634413, 11864.050875929905, 403.8061730369439, 417.8015442664771, 428.27621319969154, 434.2877680603812, 435.3991491741377, 5679.971600141973, 5926.205529866964, 6021.277446706424, 6056.697165141725, 6096.481799047042, 548714.0, 558937.0, 560754.0, 564552.0, 573955.0, 113227.0, 129260.0, 132784.0, 135201.12787593357, 140004.0, 961.1397798969883, 990.0643891522586, 1004.9899501005043, 1005.7686732051669, 1015.5683834370363, 18236.817631823513, 19103.235870565022, 19114.426567203005, 19222.7116593254, 19269.4219173425, 49700.27847354495, 53352.1997170035, 53578.0, 54164.1252287296, 54870.90258194734, 60359.69820150871, 77116.0, 77523.44953101019, 78019.0, 78584.21415785768, 5995.940040599538, 7665.6933722650465, 7839.294463498312, 8056.0, 8185.345172386075, 10802.0, 11997.520099195934, 12367.196132251374, 12422.440990155284, 12818.935905320413, 10674.039336459757, 10873.565057397616, 11101.0, 11163.609273675707, 11351.943240283746, 9368.765780855532, 10828.458577070958, 10940.39827809478, 11146.777064458827, 11194.944025279821, 10214.693559193236, 11056.834147487954, 11099.833502497631, 11355.205135640426, 11509.366984815915, 7692.230776922263, 7824.300616287372, 7893.17121702213, 8107.432479726598, 8124.7562573122905, 10055.29612927088, 10613.469326533488, 10811.945940270249, 10951.780964380509, 11097.556097756], "value": 10141.415787877806, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1447.5874375802891, 1481.6221863424828, 1513.0770230159603, 1791.6595846789116, 1840.4662647832129, 7387.298206670371, 8002.919970800291, 8691.739247822576, 8932.419392739475, 8962.686305979283, 8672.959244890606, 8904.065073167321, 8918.866217006735, 8930.91069089309, 8934.240589549896, 2374.252110585169, 2417.371483414316, 2418.6855708757835, 2423.878806059699, 2425.842320249178, 2053.691946208073, 2380.976190238093, 2382.309130352196, 2426.575349313872, 2440.0601521790218, 2376.3227480168157, 2401.4836810085826, 2410.662507248978, 2414.2757172848164, 2423.8060955123547, 1979.6436641404541, 2369.5497855407416, 2369.9052037918464, 2381.9285421437385, 2421.83047186697, 2008.3673642802617, 2375.45364566149, 2388.9641655375185, 2402.447437089462, 2415.0098459631467, 8922.10778922109, 8944.23973962214, 9000.459972401612, 9047.140521650499, 9077.137671921157, 5340.572754179695, 5511.421300763443, 5518.448155184449, 5530.806421775219, 5534.529564986981, 3558.893233202982, 3706.5181526401666, 3728.328900797855, 3733.6453036961443, 3790.753601015925, 1110.8833572474934, 1112.1047556716921, 1121.0527104596604, 1121.506537123663, 1129.6215767717824, 11592.942035289854, 11636.360000199986, 11723.062155027577, 11740.999999999915, 11750.412479375997, 4407.779611019436, 4502.842400515966, 4663.160631086369, 4677.859664210079, 4691.50739172382, 9178.265738741018, 9234.86147707785, 9260.444373337621, 9261.583228754722, 9269.536523173949, 5361.865953351119, 5364.1417373220875, 5367.597430192751, 5371.973140134352, 5380.300560927054, 4475.462944446622, 4839.395075615548, 4964.255361695775, 4983.5763960063805, 5028.446870844205, 2944.617199764017, 3273.623533293654, 3755.962440375616, 3785.564660064073, 3900.1224724436775, 1035.5081336365167, 1177.605502156787, 1182.0956967919549, 1186.0511590727383, 1189.4587962477053, 782.8943092682529, 881.2685471059006, 912.7033714042963, 917.9393843475582, 933.2813733425224, 5739.684317362502, 5747.281589801275, 5971.79098731551, 6011.879762404727, 6017.518598512109, 432.1939582678345, 444.9265871131292, 446.7319608235033, 986.5313975861409, 1006.3509036671306, 3293.818839963825, 4009.0578714002186, 4045.8786236412957, 4056.6551843093075, 4102.097538541516, 10527.684169474927, 10727.785444291227, 10861.294015888941, 10939.781204375868, 10941.617043403601, 10679.14566834667, 10701.571937122584, 10778.838317425245, 10851.240413171003, 10925.344479331265, 7016.4563795964805, 7897.960510197412, 8144.511329320259, 8150.858879756839, 8466.788330291793, 6000.249968753906, 6021.277446706424, 6023.46401667572, 6120.17377654011, 6260.655663938527, 9963.352382095141, 10077.69766906994, 10114.241431892784, 10244.180465562886, 10271.383716977005, 9984.750381240237, 10104.545295461576, 10272.972702729667, 10385.844212336971, 10416.427096509764, 8044.2760151586635, 8279.793005174919, 8434.831303374021, 8467.364947629076, 8475.237228649452, 7655.0813902332075, 8000.0, 8120.1473845247765, 8357.749267521984, 8410.831783364421, 7463.514871533333, 7512.924870751222, 7637.694492220471, 7680.0, 7787.415943804351, 7339.412846972336, 7449.404047676281, 7459.216782237787, 7467.02928619276, 7528.0, 7003.614801185984, 7113.0, 7117.75087871922, 7127.89517624769, 7145.035420218412, 4931.852044438672, 4951.331570237971, 4960.404751429707, 5102.260172275073, 5188.299579556711, 4378.846740364072, 4659.347691323285, 4751.168545504592, 5171.146760784429, 5225.372955245243], "value": 4551.142218803437, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.3407343852105, 305.0436880380008, 309.67020123568403, 313.3857639027506, 315.0548354935194, 4252.681048921331, 4482.887927801802, 5472.0, 5489.423610520887, 5503.6147469677135, 4398.868033958986, 4659.068186362732, 4715.265146215195, 5003.949170674163, 5513.393526712059, 3087.6912308769056, 4099.631033207011, 4120.567340429257, 4172.895677608069, 4188.350805625133, 3534.6995505382074, 4007.675548182062, 4147.502299724022, 4159.712158312916, 4178.323075693401, 3993.5423570396742, 4162.500499940012, 4163.666906647476, 4164.916701665965, 4168.43726096976, 2844.431113777253, 3997.760134391917, 4041.827869917706, 4086.346184610448, 4188.476440444944, 3054.7322861012653, 3291.8024918504725, 3444.517767512525, 3458.394780913355, 3475.6176820549717, 4137.648299894482, 4865.489123642002, 5228.268042474018, 5266.894662106774, 5300.761465734013, 3621.8913432597064, 4411.470623525165, 4456.420665313489, 4676.246407597151, 4686.000959385996, 4396.714213576107, 4652.441706995149, 5002.82490112848, 5664.291963504562, 5679.432056794329, 3181.411438883814, 3203.8878639247746, 3402.9829850850588, 3825.158465137665, 3840.2895464339185, 5464.562834973192, 5776.884462310731, 5997.880042399128, 6003.519718422559, 6014.548908831812, 3780.716446266541, 3833.1375440525658, 3895.8831235062994, 3919.6864250859862, 3923.2938071146896, 3517.0503963929596, 3800.5439347278502, 3942.9802850986134, 3952.7430717003303, 3980.2238563480423, 4660.650451216173, 4676.532346765364, 4686.835960741358, 4694.248920172756, 4695.389599352131, 5498.285222920995, 5773.826785196451, 5795.275590551181, 5822.970885145632, 5848.064309710426, 1331.7070244546185, 1349.7907824287054, 1355.9728805423836, 1360.2110775750239, 1360.7006458579096, 729.8321386081232, 774.5159275452842, 784.172697803811, 814.9649944570363, 822.7408366364576, 4676.579107880307, 5406.59450541211, 5414.133738601805, 5430.425176698713, 5444.91832622511, 5881.705914704247, 5892.646441213541, 5901.881962360729, 5936.7031648417405, 5944.286685597756, 5192.92210616841, 5278.709670968057, 5346.625736198429, 5363.463653634605, 5389.895071510331, 2646.801489888266, 3063.571100045951, 3069.664695857309, 3070.9078727638207, 3078.9076327710204, 5974.803480138105, 6067.332593414721, 6069.361272456412, 6075.0, 6079.908801367983, 4739.4075740532435, 4766.118268120339, 5508.03609368359, 5785.4214578541805, 6026.789062382795, 5331.573474122061, 5857.648541087548, 6075.483583895419, 6103.908441373472, 6136.9079463808075, 4396.164728701664, 5635.746391412315, 5786.103154011135, 5839.5036421904615, 5867.8289033056335, 5120.897582048413, 5860.853478663067, 5878.764849405976, 5943.791967281124, 5980.611260268069, 5064.848054558369, 6203.069539569101, 6277.96861015692, 6300.306966233619, 6327.778527751507, 3686.4470329450796, 3869.941950870683, 3919.627635374635, 3927.823247953792, 3966.821493032878, 5508.944910550843, 5858.882822343615, 6056.667533142701, 6077.331493535619, 6098.237720284965, 4803.150786946981, 5023.321851549994, 5839.854003649943, 5849.034909239927, 5892.882142357214, 5693.658380497183, 5775.27809023872, 5798.217240672624, 5805.390434004369, 5826.533877289722, 5652.830415087554, 5674.801381951612, 5674.971625141848, 5676.0, 5738.53667314832, 4964.046392396663, 5132.432959093394, 5262.394824595221, 5316.4582271140935, 5486.835394938158, 5141.53726164647, 5657.4908258256955, 5682.573806964577, 5702.885942281048, 5711.657300561979], "value": 4114.573499237816, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.8266677315654, 723.7141329174975, 747.5327920049968, 753.7550296153748, 781.7185813107283, 15192.392304307828, 16289.348426062943, 16296.75554866675, 16357.345706171738, 16390.42633507826, 12318.706535813722, 14761.114333139993, 14818.110913345206, 14860.405583776635, 14901.552953411388, 665.7703092433103, 753.6947536247801, 768.6164903174292, 811.7483580090191, 844.7507985144397, 848.995755021224, 858.0647094666812, 861.6725644255174, 861.7414775567336, 863.9006514250848, 914.4833169259347, 916.4959272400187, 916.7066538707617, 917.8623206519009, 918.1186061381082, 805.569020573993, 850.9235816691889, 911.0843602179767, 911.1344222988188, 912.3567884641345, 620.6493331267819, 647.6729251727847, 673.8955461903413, 675.9357861003197, 677.7966610017024, 14689.485867994568, 15024.549263522113, 15045.172515511642, 15049.473268435662, 15067.09597424158, 12106.39468026604, 14579.635509112251, 14605.92697036508, 14698.186187617683, 14899.47851825181, 12002.0, 12013.459394327188, 12027.278363298143, 12081.45633446497, 12117.151799374047, 3825.8087095645105, 3840.1935593525395, 3840.9231815363537, 3878.26313000529, 3987.860424885115, 99498.502507487, 115208.27187592193, 119319.99999999913, 120272.0, 122250.38874805658, 11230.719232019264, 11272.323660580392, 11364.0, 11517.942410287895, 11591.582941401426, 17403.0, 23838.88080559586, 23974.760252397253, 23983.160589379288, 24065.676387798838, 7994.80012999668, 8003.399745019147, 8083.110857805636, 8083.514989100673, 8303.0, 4186.853460128881, 4433.844815431445, 4459.769658064444, 4487.573680500347, 4507.977460112678, 3657.341678497896, 3754.305453491113, 3774.8678796241998, 3781.8487260509273, 3783.243351329745, 620.2061361457252, 639.9328070552525, 666.6899891550453, 679.1985457160598, 694.350782018814, 657.3984803904374, 667.4160109903834, 667.9899801502982, 678.6538865178794, 688.4870771275432, 7597.430192735567, 9619.663311784054, 9628.229741620793, 9672.70981870545, 9680.612775489042, 628.9937100629027, 638.3233772201388, 656.5961933411013, 669.387510427953, 672.2672287206871, 3810.333191691443, 3828.3874580067054, 4601.539846015438, 4742.715437073718, 4791.965709233783, 119470.0, 120269.0, 135641.3217933904, 158773.0, 160530.53898801788, 140393.0, 141373.0, 142529.0, 142624.5737542632, 144838.2758086224, 119888.0, 120773.39613301877, 120774.0, 123421.0, 124744.0, 7498.962505187439, 8655.394122411371, 9057.592408341772, 9088.04575519561, 9253.167214950687, 55099.898002040536, 64301.67849160724, 65451.45485451607, 66025.0, 66664.66670666462, 64474.67762661157, 95599.0, 96972.51513742386, 98049.0, 100953.0, 10363.430011349448, 12123.908848203704, 12156.270623762603, 12291.56979505713, 12588.0, 13167.67080822987, 13177.802332965204, 13211.933940330237, 13251.0, 13251.734965300833, 12058.372119763719, 12072.3360215189, 12209.877901220874, 12341.568045118378, 12726.427310770852, 11857.16999810005, 12162.574309899112, 12198.085143614087, 12309.138360314691, 12671.239725616493, 12010.939945300217, 12252.264864107825, 12359.876401235873, 12611.68470788201, 12641.747165056831, 10066.899331006596, 10191.7452063699, 10278.280520363503, 10432.791344173225, 10685.786284274427, 10094.545745441326, 10200.234982376203, 10450.895491045296, 10795.19036072282, 10812.729681758019], "value": 7758.617008576434, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1654.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 152.0, 173.0, 163.0, 116.0, 117.0, 115.0, 125.0, 116.0, 132.0], "value": 129.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 112.0, 141.0, 156.0, 110.0, 133.0, 131.0, 112.0, 156.0, 110.0], "value": 130.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 242.0, 218.0, 212.0, 197.0, 201.0, 199.0, 199.0, 201.0, 220.0], "value": 208.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 79.0, 99.0, 150.0, 72.0, 82.0, 70.0, 52.0, 147.0, 67.0], "value": 88.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 102.0, 154.0, 60.0, 101.0, 133.0, 106.0, 75.0, 103.0, 143.0], "value": 105.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 86.0, 136.0, 96.0, 86.0, 86.0, 125.0, 129.0, 91.0, 132.0], "value": 105.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 101.0, 100.0, 137.0, 114.0, 172.0, 106.0, 127.0, 167.0, 162.0], "value": 134.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 102.0, 151.0, 146.0, 93.0, 91.0, 93.0, 96.0, 101.0, 142.0], "value": 110.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 59.0, 58.0, 57.0, 60.0, 61.0, 59.0, 59.0, 60.0], "value": 59.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 69.0, 82.0, 71.0, 76.0, 75.0, 75.0, 72.0, 73.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 89.0, 89.0, 92.0, 87.0, 85.0, 87.0, 89.0, 85.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 154.0, 171.0, 159.0, 155.0, 159.0, 153.0, 150.0, 192.0, 163.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 214.0, 172.0, 173.0, 246.0, 173.0, 187.0, 152.0, 233.0, 192.0], "value": 192.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 69.0, 70.0, 69.0, 68.0, 69.0, 69.0, 70.0, 68.0], "value": 68.7, "unit": "score"}]}]} 14:53:14 INFO - Return code: 0 14:53:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:53:14 ERROR - # TBPL SUCCESS # 14:53:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:53:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:53:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:53:14 INFO - 2016-09-02 14:53:14.763 screenresolution[1954:17055] starting screenresolution argv=screenresolution get 14:53:14 INFO - 2016-09-02 14:53:14.765 screenresolution[1954:17055] Display 0: 1600x1200x32@60 14:53:14 INFO - 2016-09-02 14:53:14.772 screenresolution[1955:17058] starting screenresolution argv=screenresolution list 14:53:14 INFO - Available Modes on Display 0 14:53:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:53:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:53:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:53:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:53:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:53:15 INFO - Intel Iris: 14:53:15 INFO - Chipset Model: Intel Iris 14:53:15 INFO - Type: GPU 14:53:15 INFO - Bus: Built-In 14:53:15 INFO - VRAM (Dynamic, Max): 1536 MB 14:53:15 INFO - Vendor: Intel (0x8086) 14:53:15 INFO - Device ID: 0x0a2e 14:53:15 INFO - Revision ID: 0x0009 14:53:15 INFO - Displays: 14:53:15 INFO - Display: 14:53:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:53:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:53:15 INFO - Display Serial Number: 1600x1200 60 14:53:15 INFO - Main Display: Yes 14:53:15 INFO - Mirror: Off 14:53:15 INFO - Online: Yes 14:53:15 INFO - Rotation: Supported 14:53:15 INFO - Return code: 0 14:53:15 INFO - Running post-action listener: _resource_record_post_action 14:53:15 INFO - [mozharness: 2016-09-02 21:53:15.007102Z] Finished run-tests step (success) 14:53:15 INFO - Running post-run listener: _resource_record_post_run 14:53:15 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 1044480; Write bytes: 705590784; Read time: 12; Write time: 1995 14:53:15 INFO - TinderboxPrint: CPU usage
54.5% 14:53:15 INFO - TinderboxPrint: I/O read bytes / time
1,044,480 / 12 14:53:15 INFO - TinderboxPrint: I/O write bytes / time
705,590,784 / 1,995 14:53:15 INFO - TinderboxPrint: CPU idle
2,206.7 (45.5%) 14:53:15 INFO - TinderboxPrint: CPU system
984.2 (20.3%) 14:53:15 INFO - TinderboxPrint: CPU user
1,654.7 (34.1%) 14:53:15 INFO - TinderboxPrint: Swap in / out
407,707,648 / 0 14:53:15 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 394424832; Write bytes: 388929024; Read time: 29521; Write time: 788 14:53:15 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 1040384; Write bytes: 295874560; Read time: 11; Write time: 1153 14:53:15 INFO - Running post-run listener: _upload_blobber_files 14:53:15 INFO - Blob upload gear active. 14:53:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:53:15 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 14:53:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:53:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:53:15 INFO - (blobuploader) - INFO - Open directory for files ... 14:53:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:53:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:53:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:53:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:53:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:53:16 INFO - (blobuploader) - INFO - Done attempting. 14:53:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:53:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:53:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:53:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:53:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:53:17 INFO - (blobuploader) - INFO - Done attempting. 14:53:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:53:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:53:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:53:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:53:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:53:20 INFO - (blobuploader) - INFO - Done attempting. 14:53:20 INFO - (blobuploader) - INFO - Iteration through files over. 14:53:20 INFO - Return code: 0 14:53:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:53:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:53:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35bc5bb9cfc0702d78e69f54e8fe5af35dabd59f04498fed40f64ae9da6207c31321ecd55b5e593201377f2bd39f48853b75fdb85e7a34da31838d44be877b01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70fbaf0ba8c9b45632ff461817920f311f7045ad3865baaa46e1cfd7f3a0d91e8888f54621da1fe39e3faca00907f2f00ef41e1d61abf59c65050ea6df4a0ed1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5c2ad402ae88d54754719f9160cf07ea8282a3cc45ffb7f613d86bc56c50af48a0fbb0006b6e5fcd27383f564b15aa8ba31dfa4da99df5737da2fd3f6b4c755"} 14:53:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:53:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:53:20 INFO - Contents: 14:53:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35bc5bb9cfc0702d78e69f54e8fe5af35dabd59f04498fed40f64ae9da6207c31321ecd55b5e593201377f2bd39f48853b75fdb85e7a34da31838d44be877b01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70fbaf0ba8c9b45632ff461817920f311f7045ad3865baaa46e1cfd7f3a0d91e8888f54621da1fe39e3faca00907f2f00ef41e1d61abf59c65050ea6df4a0ed1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5c2ad402ae88d54754719f9160cf07ea8282a3cc45ffb7f613d86bc56c50af48a0fbb0006b6e5fcd27383f564b15aa8ba31dfa4da99df5737da2fd3f6b4c755"} 14:53:20 INFO - Running post-run listener: copy_logs_to_upload_dir 14:53:20 INFO - Copying logs to upload dir... 14:53:20 INFO - mkdir: /builds/slave/test/build/upload/logs 14:53:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.669075 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-09-02 14:53:20.291491) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 14:53:20.294734) ========= 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.e5yFP6mb3M/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.m3I0bgzXvj/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35bc5bb9cfc0702d78e69f54e8fe5af35dabd59f04498fed40f64ae9da6207c31321ecd55b5e593201377f2bd39f48853b75fdb85e7a34da31838d44be877b01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70fbaf0ba8c9b45632ff461817920f311f7045ad3865baaa46e1cfd7f3a0d91e8888f54621da1fe39e3faca00907f2f00ef41e1d61abf59c65050ea6df4a0ed1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5c2ad402ae88d54754719f9160cf07ea8282a3cc45ffb7f613d86bc56c50af48a0fbb0006b6e5fcd27383f564b15aa8ba31dfa4da99df5737da2fd3f6b4c755"} build_url:https://queue.taskcluster.net/v1/task/CbULK_3QQEa6oY9iUd-svA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011487 build_url: 'https://queue.taskcluster.net/v1/task/CbULK_3QQEa6oY9iUd-svA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35bc5bb9cfc0702d78e69f54e8fe5af35dabd59f04498fed40f64ae9da6207c31321ecd55b5e593201377f2bd39f48853b75fdb85e7a34da31838d44be877b01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70fbaf0ba8c9b45632ff461817920f311f7045ad3865baaa46e1cfd7f3a0d91e8888f54621da1fe39e3faca00907f2f00ef41e1d61abf59c65050ea6df4a0ed1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5c2ad402ae88d54754719f9160cf07ea8282a3cc45ffb7f613d86bc56c50af48a0fbb0006b6e5fcd27383f564b15aa8ba31dfa4da99df5737da2fd3f6b4c755"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 14:53:20.328684) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 14:53:20.329026) ========= 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.e5yFP6mb3M/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.m3I0bgzXvj/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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.005261 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 14:53:20.377358) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 14:53:20.377686) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 14:53:20.378020) ========= ========= Total master_lag: 0.18 =========