builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0224 starttime: 1470918444.07 results: success (0) buildid: 20160811030201 builduid: 6173cbea8b2e4ff587fd734487ae46da revision: 0502bd9e025edde29777ba1de4280f9b52af4663 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 05:27:24.067828) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 05:27:24.068255) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 05:27:24.068872) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 05:27:24.269350) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 05:27:24.269682) ========= 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.h0jT9yP5rX/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.tWvHb7SAIm/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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-08-11 05:27:24-- 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% 7.62M=0.002s 2016-08-11 05:27:25 (7.62 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.734899 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 05:27:25.040707) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 05:27:25.041081) ========= 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.h0jT9yP5rX/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.tWvHb7SAIm/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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.025772 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 05:27:25.106896) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-11 05:27:25.107241) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0502bd9e025edde29777ba1de4280f9b52af4663 --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 0502bd9e025edde29777ba1de4280f9b52af4663 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.h0jT9yP5rX/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.tWvHb7SAIm/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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-08-11 05:27:25,191 truncating revision to first 12 chars 2016-08-11 05:27:25,191 Setting DEBUG logging. 2016-08-11 05:27:25,191 attempt 1/10 2016-08-11 05:27:25,191 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0502bd9e025e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-11 05:27:26,341 unpacking tar archive at: mozilla-central-0502bd9e025e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.438604 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-11 05:27:26.572791) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 05:27:26.573127) ========= script_repo_revision: 0502bd9e025edde29777ba1de4280f9b52af4663 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 05:27:26.573614) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 05:27:26.573908) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 05:27:26.595451) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-08-11 05:27:26.595844) ========= /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.h0jT9yP5rX/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.tWvHb7SAIm/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 05:27:26 INFO - MultiFileLogger online at 20160811 05:27:26 in /builds/slave/test 05:27:26 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 05:27:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:27:26 INFO - {'append_to_log': False, 05:27:26 INFO - 'base_work_dir': '/builds/slave/test', 05:27:26 INFO - 'blob_upload_branch': 'Firefox', 05:27:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:27:26 INFO - 'branch': 'Firefox', 05:27:26 INFO - 'buildbot_json_path': 'buildprops.json', 05:27:26 INFO - 'config_files': ('talos/mac_config.py',), 05:27:26 INFO - 'default_actions': ('clobber', 05:27:26 INFO - 'read-buildbot-config', 05:27:26 INFO - 'download-and-extract', 05:27:26 INFO - 'populate-webroot', 05:27:26 INFO - 'create-virtualenv', 05:27:26 INFO - 'install', 05:27:26 INFO - 'run-tests'), 05:27:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:27:26 INFO - 'download_minidump_stackwalk': True, 05:27:26 INFO - 'download_symbols': 'ondemand', 05:27:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:27:26 INFO - 'tooltool.py': '/tools/tooltool.py', 05:27:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:27:26 INFO - '/tools/misc-python/virtualenv.py')}, 05:27:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:27:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:27:26 INFO - 'installer_path': 'installer.exe', 05:27:26 INFO - 'log_level': 'info', 05:27:26 INFO - 'log_name': 'talos', 05:27:26 INFO - 'log_to_console': True, 05:27:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:27:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:27:26 INFO - 'opt_config_files': (), 05:27:26 INFO - 'pip_index': False, 05:27:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:27:26 INFO - 'cmd': ('bash', 05:27:26 INFO - '-c', 05:27:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:27:26 INFO - 'enabled': True, 05:27:26 INFO - 'halt_on_failure': False, 05:27:26 INFO - 'name': 'check_screen_resolution'},), 05:27:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:27:26 INFO - 'cmd': ('bash', 05:27:26 INFO - '-c', 05:27:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:27:26 INFO - 'enabled': True, 05:27:26 INFO - 'halt_on_failure': False, 05:27:26 INFO - 'name': 'check_screen_resolution'},), 05:27:26 INFO - 'run_cmd_checks_enabled': True, 05:27:26 INFO - 'sps_profile': False, 05:27:26 INFO - 'sps_profile_interval': 0, 05:27:26 INFO - 'suite': 'dromaeojs-e10s', 05:27:26 INFO - 'system_bits': '32', 05:27:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:27:26 INFO - 'title': 't-yosemite-r7-0224', 05:27:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:27:26 INFO - 'use_talos_json': True, 05:27:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:27:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:27:26 INFO - 'work_dir': 'build'} 05:27:26 INFO - [mozharness: 2016-08-11 12:27:26.795828Z] Running clobber step. 05:27:26 INFO - Running pre-action listener: _resource_record_pre_action 05:27:26 INFO - Running main action method: clobber 05:27:26 INFO - rmtree: /builds/slave/test/build 05:27:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:27:28 INFO - Running post-action listener: _resource_record_post_action 05:27:28 INFO - [mozharness: 2016-08-11 12:27:28.815894Z] Finished clobber step (success) 05:27:28 INFO - [mozharness: 2016-08-11 12:27:28.816046Z] Running read-buildbot-config step. 05:27:28 INFO - Running pre-action listener: _resource_record_pre_action 05:27:28 INFO - Running main action method: read_buildbot_config 05:27:28 INFO - Using buildbot properties: 05:27:28 INFO - { 05:27:28 INFO - "project": "", 05:27:28 INFO - "product": "firefox", 05:27:28 INFO - "script_repo_revision": "production", 05:27:28 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:27:28 INFO - "repository": "", 05:27:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:27:28 INFO - "buildid": "20160811030201", 05:27:28 INFO - "stage_platform": "macosx64", 05:27:28 INFO - "basedir": "/builds/slave/test", 05:27:28 INFO - "nightly_build": "True", 05:27:28 INFO - "buildnumber": 93, 05:27:28 INFO - "slavename": "t-yosemite-r7-0224", 05:27:28 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 05:27:28 INFO - "platform": "yosemite_r7", 05:27:28 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:27:28 INFO - "branch": "mozilla-central", 05:27:28 INFO - "repo_path": "mozilla-central", 05:27:28 INFO - "revision": "0502bd9e025edde29777ba1de4280f9b52af4663", 05:27:28 INFO - "pgo_build": "False", 05:27:28 INFO - "builduid": "6173cbea8b2e4ff587fd734487ae46da", 05:27:28 INFO - "slavebuilddir": "test" 05:27:28 INFO - } 05:27:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/J25iWqDGRxGm-WihsC3Xuw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 05:27:28 INFO - Running post-action listener: _resource_record_post_action 05:27:28 INFO - [mozharness: 2016-08-11 12:27:28.819538Z] Finished read-buildbot-config step (success) 05:27:28 INFO - [mozharness: 2016-08-11 12:27:28.819638Z] Running download-and-extract step. 05:27:28 INFO - Running pre-action listener: _resource_record_pre_action 05:27:28 INFO - Running main action method: download_and_extract 05:27:28 INFO - mkdir: /builds/slave/test/build/tests 05:27: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')]} 05:27:28 INFO - trying https://queue.taskcluster.net/v1/task/J25iWqDGRxGm-WihsC3Xuw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 05:27:28 INFO - Downloading https://queue.taskcluster.net/v1/task/J25iWqDGRxGm-WihsC3Xuw/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 05:27:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J25iWqDGRxGm-WihsC3Xuw/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 05:27:30 INFO - Downloaded 1199 bytes. 05:27:30 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:27:30 INFO - Using the following test package requirements: 05:27:30 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:27:30 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:27:30 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 05:27:30 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:27:30 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 05:27:30 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:27:30 INFO - u'jsshell-mac.zip'], 05:27:30 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:27:30 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 05:27:30 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:27:30 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:27:30 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 05:27:30 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:27:30 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 05:27:30 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:27:30 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 05:27:30 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:27:30 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 05:27:30 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:30 INFO - trying https://queue.taskcluster.net/v1/task/J25iWqDGRxGm-WihsC3Xuw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:27:30 INFO - Downloading https://queue.taskcluster.net/v1/task/J25iWqDGRxGm-WihsC3Xuw/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 05:27:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J25iWqDGRxGm-WihsC3Xuw/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 05:27:31 INFO - Downloaded 16328426 bytes. 05:27:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:27:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:27:34 INFO - Return code: 0 05:27:34 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 05:27:34 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')]} 05:27:34 INFO - trying https://queue.taskcluster.net/v1/task/J25iWqDGRxGm-WihsC3Xuw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:27:34 INFO - Downloading https://queue.taskcluster.net/v1/task/J25iWqDGRxGm-WihsC3Xuw/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 05:27:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J25iWqDGRxGm-WihsC3Xuw/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 05:27:35 INFO - Downloaded 16328426 bytes. 05:27:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:27:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:27:38 INFO - Return code: 0 05:27:38 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')]} 05:27:38 INFO - trying https://queue.taskcluster.net/v1/task/J25iWqDGRxGm-WihsC3Xuw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:27:38 INFO - Downloading https://queue.taskcluster.net/v1/task/J25iWqDGRxGm-WihsC3Xuw/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 05:27:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J25iWqDGRxGm-WihsC3Xuw/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 05:27:39 INFO - Downloaded 14413719 bytes. 05:27:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:27:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:27:40 INFO - Return code: 0 05:27:40 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')]} 05:27:40 INFO - trying https://queue.taskcluster.net/v1/task/J25iWqDGRxGm-WihsC3Xuw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:27:40 INFO - Downloading https://queue.taskcluster.net/v1/task/J25iWqDGRxGm-WihsC3Xuw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 05:27:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J25iWqDGRxGm-WihsC3Xuw/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 05:27:42 INFO - Downloaded 111042540 bytes. 05:27:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J25iWqDGRxGm-WihsC3Xuw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:27:42 INFO - mkdir: /builds/slave/test/properties 05:27:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:27:42 INFO - Writing to file /builds/slave/test/properties/build_url 05:27:42 INFO - Contents: 05:27:42 INFO - build_url:https://queue.taskcluster.net/v1/task/J25iWqDGRxGm-WihsC3Xuw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:27:43 INFO - Running post-action listener: _resource_record_post_action 05:27:43 INFO - Running post-action listener: set_extra_try_arguments 05:27:43 INFO - [mozharness: 2016-08-11 12:27:43.460150Z] Finished download-and-extract step (success) 05:27:43 INFO - [mozharness: 2016-08-11 12:27:43.460300Z] Running populate-webroot step. 05:27:43 INFO - Running pre-action listener: _resource_record_pre_action 05:27:43 INFO - Running main action method: populate_webroot 05:27:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:27:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:27:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:27:43 INFO - '--tppagecycles', 05:27:43 INFO - '7'], 05:27:43 INFO - 'tests': ['tsvgm']}}, 05:27:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:27:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:27:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:27:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:27:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:27:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:27:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:43 INFO - 'talos_options': ['--disable-e10s'], 05:27:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:27:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:27:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:43 INFO - 'talos_options': ['--disable-e10s'], 05:27:43 INFO - 'tests': ['damp', 'tps']}, 05:27:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:43 INFO - 'tests': ['damp', 'tps']}, 05:27:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:27:43 INFO - 'tests': ['dromaeo_dom']}, 05:27:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:27:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:27:43 INFO - 'tests': ['basic_compositor_video']}, 05:27:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:27:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:27:43 INFO - 'tests': ['a11yr', 05:27:43 INFO - 'ts_paint', 05:27:43 INFO - 'tpaint', 05:27:43 INFO - 'sessionrestore', 05:27:43 INFO - 'sessionrestore_no_auto_restore', 05:27:43 INFO - 'tabpaint']}, 05:27:43 INFO - 'other-e10s': {'tests': ['a11yr', 05:27:43 INFO - 'ts_paint', 05:27:43 INFO - 'tpaint', 05:27:43 INFO - 'sessionrestore', 05:27:43 INFO - 'sessionrestore_no_auto_restore', 05:27:43 INFO - 'tabpaint']}, 05:27:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:27:43 INFO - 'ts_paint', 05:27:43 INFO - 'tpaint', 05:27:43 INFO - 'sessionrestore', 05:27:43 INFO - 'sessionrestore_no_auto_restore', 05:27:43 INFO - 'tabpaint']}, 05:27:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:27:43 INFO - 'ts_paint', 05:27:43 INFO - 'tpaint', 05:27:43 INFO - 'sessionrestore', 05:27:43 INFO - 'sessionrestore_no_auto_restore', 05:27:43 INFO - 'tabpaint']}, 05:27:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:27:43 INFO - 'tests': ['a11yr', 05:27:43 INFO - 'ts_paint', 05:27:43 INFO - 'tpaint', 05:27:43 INFO - 'sessionrestore', 05:27:43 INFO - 'sessionrestore_no_auto_restore', 05:27:43 INFO - 'tabpaint']}, 05:27:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:27:43 INFO - 'tests': ['a11yr', 05:27:43 INFO - 'ts_paint', 05:27:43 INFO - 'tpaint', 05:27:43 INFO - 'sessionrestore', 05:27:43 INFO - 'sessionrestore_no_auto_restore', 05:27:43 INFO - 'tabpaint']}, 05:27:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:27:43 INFO - 'tests': ['tsvgx', 05:27:43 INFO - 'tsvgr_opacity', 05:27:43 INFO - 'tart', 05:27:43 INFO - 'tscrollx', 05:27:43 INFO - 'cart']}, 05:27:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:27:43 INFO - 'tsvgr_opacity', 05:27:43 INFO - 'tart', 05:27:43 INFO - 'tscrollx', 05:27:43 INFO - 'cart']}, 05:27:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:43 INFO - 'talos_options': ['--disable-e10s'], 05:27:43 INFO - 'tests': ['tp5o']}, 05:27:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:43 INFO - 'tests': ['tp5o']}, 05:27:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:43 INFO - 'talos_options': ['--disable-e10s', 05:27:43 INFO - '--xperf_path', 05:27:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:27:43 INFO - 'tests': ['tp5n']}, 05:27:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:43 INFO - 'talos_options': ['--xperf_path', 05:27:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:27:43 INFO - 'tests': ['tp5n']}}, 05:27:43 INFO - 'talos.zip': {'path': '', 05:27:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:27:43 INFO - Running post-action listener: _resource_record_post_action 05:27:43 INFO - [mozharness: 2016-08-11 12:27:43.479312Z] Finished populate-webroot step (success) 05:27:43 INFO - [mozharness: 2016-08-11 12:27:43.479443Z] Running create-virtualenv step. 05:27:43 INFO - Running pre-action listener: _resource_record_pre_action 05:27:43 INFO - Running main action method: create_virtualenv 05:27:43 INFO - Creating virtualenv /builds/slave/test/build/venv 05:27:43 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 05:27:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:27:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:27:43 INFO - Using real prefix '/tools/python27' 05:27:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:27:44 INFO - Installing distribute.............................................................................................................................................................................................done. 05:27:47 INFO - Installing pip.................done. 05:27:47 INFO - Return code: 0 05:27:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:27: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')]} 05:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27: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')]} 05:27:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1032a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103336618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd89259cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103205d30>, '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 0x102f6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031fdb20>, '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.h0jT9yP5rX/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.tWvHb7SAIm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 05:27: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', 'pip>=1.5'] in /builds/slave/test/build 05:27: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 pip>=1.5 05:27:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h0jT9yP5rX/Render', 05:27:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:47 INFO - 'HOME': '/Users/cltbld', 05:27:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:47 INFO - 'LOGNAME': 'cltbld', 05:27:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:47 INFO - 'MOZ_NO_REMOTE': '1', 05:27:47 INFO - 'NO_EM_RESTART': '1', 05:27:47 INFO - 'PAGER': '/bin/cat', 05:27:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:47 INFO - 'PWD': '/builds/slave/test', 05:27:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:47 INFO - 'SHELL': '/bin/bash', 05:27:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tWvHb7SAIm/Listeners', 05:27:47 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 05:27:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:47 INFO - 'USER': 'cltbld', 05:27:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:47 INFO - 'XPC_FLAGS': '0x0', 05:27:47 INFO - 'XPC_SERVICE_NAME': '0', 05:27:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:47 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 05:27:47 INFO - Cleaning up... 05:27:47 INFO - Return code: 0 05:27:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:27: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')]} 05:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27: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')]} 05:27:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27: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', '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 0x1032a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103336618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd89259cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103205d30>, '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 0x102f6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031fdb20>, '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.h0jT9yP5rX/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.tWvHb7SAIm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 05:27: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:27: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 psutil>=3.1.1 05:27:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h0jT9yP5rX/Render', 05:27:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:47 INFO - 'HOME': '/Users/cltbld', 05:27:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:47 INFO - 'LOGNAME': 'cltbld', 05:27:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:47 INFO - 'MOZ_NO_REMOTE': '1', 05:27:47 INFO - 'NO_EM_RESTART': '1', 05:27:47 INFO - 'PAGER': '/bin/cat', 05:27:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:47 INFO - 'PWD': '/builds/slave/test', 05:27:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:47 INFO - 'SHELL': '/bin/bash', 05:27:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tWvHb7SAIm/Listeners', 05:27:47 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 05:27:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:47 INFO - 'USER': 'cltbld', 05:27:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:47 INFO - 'XPC_FLAGS': '0x0', 05:27:47 INFO - 'XPC_SERVICE_NAME': '0', 05:27:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:47 INFO - Downloading/unpacking psutil>=3.1.1 05:27:47 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 05:27:47 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 05:27:47 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 05:27:47 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 05:27:47 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 05:27:47 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 05:27:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:27:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:27:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:27:51 INFO - Installing collected packages: psutil 05:27:51 INFO - Running setup.py install for psutil 05:27:51 INFO - building 'psutil._psutil_osx' extension 05:27:51 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 05:27:51 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 05:27:51 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 05:27:51 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 05:27:51 INFO - building 'psutil._psutil_posix' extension 05:27:51 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 05:27:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:27:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:27:51 INFO - ^ 05:27:52 INFO - 1 warning generated. 05:27:52 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 05:27:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:27:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:27:52 INFO - Successfully installed psutil 05:27:52 INFO - Cleaning up... 05:27:52 INFO - Return code: 0 05:27:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:27: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')]} 05:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27: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')]} 05:27:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:52 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 0x1032a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103336618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd89259cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103205d30>, '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 0x102f6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031fdb20>, '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.h0jT9yP5rX/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.tWvHb7SAIm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 05:27:52 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 05:27:52 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 05:27:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h0jT9yP5rX/Render', 05:27:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:52 INFO - 'HOME': '/Users/cltbld', 05:27:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:52 INFO - 'LOGNAME': 'cltbld', 05:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:52 INFO - 'MOZ_NO_REMOTE': '1', 05:27:52 INFO - 'NO_EM_RESTART': '1', 05:27:52 INFO - 'PAGER': '/bin/cat', 05:27:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:52 INFO - 'PWD': '/builds/slave/test', 05:27:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:52 INFO - 'SHELL': '/bin/bash', 05:27:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tWvHb7SAIm/Listeners', 05:27:52 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 05:27:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:52 INFO - 'USER': 'cltbld', 05:27:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:52 INFO - 'XPC_FLAGS': '0x0', 05:27:52 INFO - 'XPC_SERVICE_NAME': '0', 05:27:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:27:52 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 05:27:52 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 05:27:52 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 05:27:52 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 05:27:52 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 05:27:52 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 05:27:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:27:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:27:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:27:55 INFO - Installing collected packages: mozsystemmonitor 05:27:55 INFO - Running setup.py install for mozsystemmonitor 05:27:55 INFO - Successfully installed mozsystemmonitor 05:27:55 INFO - Cleaning up... 05:27:55 INFO - Return code: 0 05:27:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:27:55 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')]} 05:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:55 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')]} 05:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:55 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 0x1032a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103336618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd89259cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103205d30>, '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 0x102f6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031fdb20>, '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.h0jT9yP5rX/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.tWvHb7SAIm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 05:27:55 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 05:27:55 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 05:27:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h0jT9yP5rX/Render', 05:27:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:55 INFO - 'HOME': '/Users/cltbld', 05:27:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:55 INFO - 'LOGNAME': 'cltbld', 05:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:55 INFO - 'MOZ_NO_REMOTE': '1', 05:27:55 INFO - 'NO_EM_RESTART': '1', 05:27:55 INFO - 'PAGER': '/bin/cat', 05:27:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:55 INFO - 'PWD': '/builds/slave/test', 05:27:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:55 INFO - 'SHELL': '/bin/bash', 05:27:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tWvHb7SAIm/Listeners', 05:27:55 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 05:27:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:55 INFO - 'USER': 'cltbld', 05:27:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:55 INFO - 'XPC_FLAGS': '0x0', 05:27:55 INFO - 'XPC_SERVICE_NAME': '0', 05:27:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:55 INFO - Downloading/unpacking jsonschema==2.5.1 05:27:55 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 05:27:55 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 05:27:55 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 05:27:55 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 05:27:55 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 05:27:55 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 05:27:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:27:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:27:57 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 05:27:57 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 05:27:57 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 05:27:57 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 05:27:57 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 05:27:57 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 05:27:58 INFO - Downloading functools32-3.2.3-2.tar.gz 05:27:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:27:58 INFO - warning: no files found matching '*.txt' 05:27:58 INFO - no previously-included directories found matching 'build' 05:27:58 INFO - no previously-included directories found matching 'dist' 05:27:58 INFO - no previously-included directories found matching '.git*' 05:27:58 INFO - Installing collected packages: jsonschema, functools32 05:27:58 INFO - Running setup.py install for functools32 05:27:58 INFO - warning: no files found matching '*.txt' 05:27:58 INFO - no previously-included directories found matching 'build' 05:27:58 INFO - no previously-included directories found matching 'dist' 05:27:58 INFO - no previously-included directories found matching '.git*' 05:27:58 INFO - Successfully installed jsonschema functools32 05:27:58 INFO - Cleaning up... 05:27:58 INFO - Return code: 0 05:27:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:27:58 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')]} 05:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:58 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')]} 05:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:58 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 0x1032a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103336618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd89259cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103205d30>, '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 0x102f6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031fdb20>, '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.h0jT9yP5rX/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.tWvHb7SAIm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 05:27:58 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 05:27:58 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 05:27:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h0jT9yP5rX/Render', 05:27:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:58 INFO - 'HOME': '/Users/cltbld', 05:27:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:58 INFO - 'LOGNAME': 'cltbld', 05:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:58 INFO - 'MOZ_NO_REMOTE': '1', 05:27:58 INFO - 'NO_EM_RESTART': '1', 05:27:58 INFO - 'PAGER': '/bin/cat', 05:27:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:58 INFO - 'PWD': '/builds/slave/test', 05:27:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:58 INFO - 'SHELL': '/bin/bash', 05:27:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tWvHb7SAIm/Listeners', 05:27:58 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 05:27:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:58 INFO - 'USER': 'cltbld', 05:27:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:58 INFO - 'XPC_FLAGS': '0x0', 05:27:58 INFO - 'XPC_SERVICE_NAME': '0', 05:27:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:27:58 INFO - Cleaning up... 05:27:58 INFO - Return code: 0 05:27:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:27:58 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')]} 05:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:58 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')]} 05:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:58 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 0x1032a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103336618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd89259cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103205d30>, '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 0x102f6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031fdb20>, '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.h0jT9yP5rX/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.tWvHb7SAIm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 05:27:58 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 05:27:58 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 05:27:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h0jT9yP5rX/Render', 05:27:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:58 INFO - 'HOME': '/Users/cltbld', 05:27:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:58 INFO - 'LOGNAME': 'cltbld', 05:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:58 INFO - 'MOZ_NO_REMOTE': '1', 05:27:58 INFO - 'NO_EM_RESTART': '1', 05:27:58 INFO - 'PAGER': '/bin/cat', 05:27:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:58 INFO - 'PWD': '/builds/slave/test', 05:27:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:58 INFO - 'SHELL': '/bin/bash', 05:27:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tWvHb7SAIm/Listeners', 05:27:58 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 05:27:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:58 INFO - 'USER': 'cltbld', 05:27:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:58 INFO - 'XPC_FLAGS': '0x0', 05:27:58 INFO - 'XPC_SERVICE_NAME': '0', 05:27:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:59 INFO - Downloading/unpacking blobuploader==1.2.4 05:27: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 05:27: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 05:27: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 05:27: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 05:27: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 05:27: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 05:28:01 INFO - Downloading blobuploader-1.2.4.tar.gz 05:28:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:28:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:28:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:02 INFO - Downloading docopt-0.6.1.tar.gz 05:28:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:28:02 INFO - Installing collected packages: blobuploader, requests, docopt 05:28:02 INFO - Running setup.py install for blobuploader 05:28:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:28:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:28:03 INFO - Running setup.py install for requests 05:28:03 INFO - Running setup.py install for docopt 05:28:03 INFO - Successfully installed blobuploader requests docopt 05:28:03 INFO - Cleaning up... 05:28:03 INFO - Return code: 0 05:28:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:28:03 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')]} 05:28:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:03 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')]} 05:28:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:03 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 0x1032a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103336618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd89259cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103205d30>, '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 0x102f6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031fdb20>, '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.h0jT9yP5rX/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.tWvHb7SAIm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 05:28:03 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 05:28:03 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 05:28:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h0jT9yP5rX/Render', 05:28:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:03 INFO - 'HOME': '/Users/cltbld', 05:28:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:03 INFO - 'LOGNAME': 'cltbld', 05:28:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:03 INFO - 'MOZ_NO_REMOTE': '1', 05:28:03 INFO - 'NO_EM_RESTART': '1', 05:28:03 INFO - 'PAGER': '/bin/cat', 05:28:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:03 INFO - 'PWD': '/builds/slave/test', 05:28:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:03 INFO - 'SHELL': '/bin/bash', 05:28:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tWvHb7SAIm/Listeners', 05:28:03 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 05:28:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:03 INFO - 'USER': 'cltbld', 05:28:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:03 INFO - 'XPC_FLAGS': '0x0', 05:28:03 INFO - 'XPC_SERVICE_NAME': '0', 05:28:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:28:04 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-nucn45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:28:04 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-r_B3hd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:28:04 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-spt1Se-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:28:04 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-zOCZMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:28:04 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-AxgQGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:28:04 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-75cee0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:28:04 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-Sn_TeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:28:04 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-LgPK_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:28:04 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-AnzxrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:28:04 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-HAUdMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:28:05 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-2yAfmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:28:05 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-Od0jkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:28:05 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-M6Vpbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:28:05 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-IZBMLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:05 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-5bzOsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:28:05 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-hZAGwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:28:05 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-xogIZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:28:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:28:05 INFO - Running setup.py install for manifestparser 05:28:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:28:05 INFO - Running setup.py install for mozcrash 05:28:06 INFO - Running setup.py install for mozdebug 05:28:06 INFO - Running setup.py install for mozdevice 05:28:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:28:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:28:06 INFO - Running setup.py install for mozfile 05:28:06 INFO - Running setup.py install for mozhttpd 05:28:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:28:06 INFO - Running setup.py install for mozinfo 05:28:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:28:06 INFO - Running setup.py install for mozInstall 05:28:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:28:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:28:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:28:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:28:06 INFO - Running setup.py install for mozleak 05:28:07 INFO - Running setup.py install for mozlog 05:28:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:28:07 INFO - Running setup.py install for moznetwork 05:28:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:28:07 INFO - Running setup.py install for mozprocess 05:28:07 INFO - Running setup.py install for mozprofile 05:28:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:28:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:28:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:28:07 INFO - Running setup.py install for mozrunner 05:28:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:28:07 INFO - Running setup.py install for mozscreenshot 05:28:08 INFO - Running setup.py install for moztest 05:28:08 INFO - Running setup.py install for mozversion 05:28:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:28:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:28:08 INFO - Cleaning up... 05:28:08 INFO - Return code: 0 05:28:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:28:08 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')]} 05:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:08 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')]} 05:28:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:08 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 0x1032a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103336618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd89259cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103205d30>, '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 0x102f6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031fdb20>, '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.h0jT9yP5rX/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.tWvHb7SAIm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 05:28:08 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 05:28:08 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 05:28:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h0jT9yP5rX/Render', 05:28:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:08 INFO - 'HOME': '/Users/cltbld', 05:28:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:08 INFO - 'LOGNAME': 'cltbld', 05:28:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:08 INFO - 'MOZ_NO_REMOTE': '1', 05:28:08 INFO - 'NO_EM_RESTART': '1', 05:28:08 INFO - 'PAGER': '/bin/cat', 05:28:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:08 INFO - 'PWD': '/builds/slave/test', 05:28:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:08 INFO - 'SHELL': '/bin/bash', 05:28:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tWvHb7SAIm/Listeners', 05:28:08 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 05:28:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:08 INFO - 'USER': 'cltbld', 05:28:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:08 INFO - 'XPC_FLAGS': '0x0', 05:28:08 INFO - 'XPC_SERVICE_NAME': '0', 05:28:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:28:08 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-hYUd3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:28:08 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)) 05:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:28:08 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-m32NIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:28:08 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)) 05:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:28:08 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-jFlCMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:28:08 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)) 05:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:28:09 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-jadXsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:28:09 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)) 05:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:28:09 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-PQdFXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:28:09 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)) 05:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:28:09 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-J1v0Z1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:28:09 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)) 05:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:28:09 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-ksIP5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:28:09 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)) 05:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:28:09 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-lNvCyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:28:09 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)) 05:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:28:09 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-hb_ivX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:28:09 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)) 05:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:28:09 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-fFTCqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:28:09 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)) 05:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:28:09 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-nOMg0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:28:09 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)) 05:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:28:09 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-zxN5JH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:28:09 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)) 05:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:28:09 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-4PLgW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:28:10 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)) 05:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:28:10 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-IgUlRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:28:10 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)) 05:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:10 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-SJNbFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:10 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)) 05:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:28:10 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-uqwTgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:28:10 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)) 05:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:28:10 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-izKzwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:28:10 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)) 05:28:10 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)) 05:28:10 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)) 05:28:10 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)) 05:28:10 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)) 05:28:10 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)) 05:28:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:12 INFO - Downloading blessings-1.6.tar.gz 05:28:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:28:13 INFO - Installing collected packages: blessings 05:28:13 INFO - Running setup.py install for blessings 05:28:13 INFO - Successfully installed blessings 05:28:13 INFO - Cleaning up... 05:28:13 INFO - Return code: 0 05:28:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:28:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:28:13 INFO - Reading from file tmpfile_stdout 05:28:13 INFO - Current package versions: 05:28:13 INFO - blessings == 1.6 05:28:13 INFO - blobuploader == 1.2.4 05:28:13 INFO - docopt == 0.6.1 05:28:13 INFO - functools32 == 3.2.3-2 05:28:13 INFO - jsonschema == 2.5.1 05:28:13 INFO - manifestparser == 1.1 05:28:13 INFO - mozInstall == 1.12 05:28:13 INFO - mozcrash == 0.17 05:28:13 INFO - mozdebug == 0.1 05:28:13 INFO - mozdevice == 0.48 05:28:13 INFO - mozfile == 1.2 05:28:13 INFO - mozhttpd == 0.7 05:28:13 INFO - mozinfo == 0.9 05:28:13 INFO - mozleak == 0.1 05:28:13 INFO - mozlog == 3.3 05:28:13 INFO - moznetwork == 0.27 05:28:13 INFO - mozprocess == 0.23 05:28:13 INFO - mozprofile == 0.28 05:28:13 INFO - mozrunner == 6.12 05:28:13 INFO - mozscreenshot == 0.1 05:28:13 INFO - mozsystemmonitor == 0.3 05:28:13 INFO - moztest == 0.7 05:28:13 INFO - mozversion == 1.4 05:28:13 INFO - psutil == 3.1.1 05:28:13 INFO - requests == 1.2.3 05:28:13 INFO - wsgiref == 0.1.2 05:28:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:28: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')]} 05:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28: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')]} 05:28:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:13 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 0x1032a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103336618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd89259cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103205d30>, '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 0x102f6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031fdb20>, '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.h0jT9yP5rX/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.tWvHb7SAIm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 05:28:13 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 05:28:13 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 05:28:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h0jT9yP5rX/Render', 05:28:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:13 INFO - 'HOME': '/Users/cltbld', 05:28:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:13 INFO - 'LOGNAME': 'cltbld', 05:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:13 INFO - 'MOZ_NO_REMOTE': '1', 05:28:13 INFO - 'NO_EM_RESTART': '1', 05:28:13 INFO - 'PAGER': '/bin/cat', 05:28:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:13 INFO - 'PWD': '/builds/slave/test', 05:28:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:13 INFO - 'SHELL': '/bin/bash', 05:28:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tWvHb7SAIm/Listeners', 05:28:13 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 05:28:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:13 INFO - 'USER': 'cltbld', 05:28:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:13 INFO - 'XPC_FLAGS': '0x0', 05:28:13 INFO - 'XPC_SERVICE_NAME': '0', 05:28:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:13 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)) 05:28:13 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)) 05:28:13 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)) 05:28:13 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)) 05:28:13 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)) 05:28:13 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)) 05:28:13 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)) 05:28:13 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)) 05:28:13 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)) 05:28:13 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)) 05:28:13 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)) 05:28:13 INFO - Cleaning up... 05:28:13 INFO - Return code: 0 05:28:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:28: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')]} 05:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28: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')]} 05:28:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:13 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 0x1032a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103336618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd89259cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103205d30>, '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 0x102f6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031fdb20>, '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.h0jT9yP5rX/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.tWvHb7SAIm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 05:28:13 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 05:28:13 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 05:28:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h0jT9yP5rX/Render', 05:28:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:13 INFO - 'HOME': '/Users/cltbld', 05:28:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:13 INFO - 'LOGNAME': 'cltbld', 05:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:13 INFO - 'MOZ_NO_REMOTE': '1', 05:28:13 INFO - 'NO_EM_RESTART': '1', 05:28:13 INFO - 'PAGER': '/bin/cat', 05:28:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:13 INFO - 'PWD': '/builds/slave/test', 05:28:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:13 INFO - 'SHELL': '/bin/bash', 05:28:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tWvHb7SAIm/Listeners', 05:28:13 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 05:28:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:13 INFO - 'USER': 'cltbld', 05:28:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:13 INFO - 'XPC_FLAGS': '0x0', 05:28:13 INFO - 'XPC_SERVICE_NAME': '0', 05:28:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:28:14 INFO - Cleaning up... 05:28:14 INFO - Return code: 0 05:28:14 INFO - Running post-action listener: _resource_record_post_action 05:28:14 INFO - Running post-action listener: _start_resource_monitoring 05:28:14 INFO - Starting resource monitoring. 05:28:14 INFO - [mozharness: 2016-08-11 12:28:14.096894Z] Finished create-virtualenv step (success) 05:28:14 INFO - [mozharness: 2016-08-11 12:28:14.097860Z] Running install step. 05:28:14 INFO - Running pre-action listener: _resource_record_pre_action 05:28:14 INFO - Running main action method: install 05:28:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:28:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:28:14 INFO - Reading from file tmpfile_stdout 05:28:14 INFO - Detecting whether we're running mozinstall >=1.0... 05:28:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:28:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:28:14 INFO - Reading from file tmpfile_stdout 05:28:14 INFO - Output received: 05:28:14 INFO - Usage: mozinstall [options] installer 05:28:14 INFO - Options: 05:28:14 INFO - -h, --help show this help message and exit 05:28:14 INFO - -d DEST, --destination=DEST 05:28:14 INFO - Directory to install application into. [default: 05:28:14 INFO - "/builds/slave/test"] 05:28:14 INFO - --app=APP Application being installed. [default: firefox] 05:28:14 INFO - mkdir: /builds/slave/test/build/application 05:28:14 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'] 05:28:14 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 05:28:48 INFO - Reading from file tmpfile_stdout 05:28:48 INFO - Output received: 05:28:48 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:28:48 INFO - Running post-action listener: _resource_record_post_action 05:28:48 INFO - [mozharness: 2016-08-11 12:28:48.376543Z] Finished install step (success) 05:28:48 INFO - [mozharness: 2016-08-11 12:28:48.376692Z] Running run-tests step. 05:28:48 INFO - Running pre-action listener: _resource_record_pre_action 05:28:48 INFO - Running main action method: run_tests 05:28:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:28:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:28:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:28:48 INFO - 2016-08-11 05:28:48.391 screenresolution[1646:8795] starting screenresolution argv=screenresolution get 05:28:48 INFO - 2016-08-11 05:28:48.394 screenresolution[1646:8795] Display 0: 1600x1200x32@60 05:28:48 INFO - 2016-08-11 05:28:48.400 screenresolution[1647:8797] starting screenresolution argv=screenresolution list 05:28:48 INFO - Available Modes on Display 0 05:28:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:28:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:28:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:28:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:28:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:28:48 INFO - Intel Iris: 05:28:48 INFO - Chipset Model: Intel Iris 05:28:48 INFO - Type: GPU 05:28:48 INFO - Bus: Built-In 05:28:48 INFO - VRAM (Dynamic, Max): 1536 MB 05:28:48 INFO - Vendor: Intel (0x8086) 05:28:48 INFO - Device ID: 0x0a2e 05:28:48 INFO - Revision ID: 0x0009 05:28:48 INFO - Displays: 05:28:48 INFO - Display: 05:28:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:28:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:28:48 INFO - Display Serial Number: 1600x1200 60 05:28:48 INFO - Main Display: Yes 05:28:48 INFO - Mirror: Off 05:28:48 INFO - Online: Yes 05:28:48 INFO - Rotation: Supported 05:28:48 INFO - Return code: 0 05:28:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:28:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:28:48 INFO - Python 2.7.3 05:28:48 INFO - Return code: 0 05:28:48 INFO - grabbing minidump binary from tooltool 05:28:48 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')]} 05:28:48 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 0x103205d30>, '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 0x102f6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031fdb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:28:48 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 05:28:48 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 05:28:48 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 05:28:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:28:48 INFO - Return code: 0 05:28:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:28:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:28:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:28:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:28:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:28:48 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J25iWqDGRxGm-WihsC3Xuw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0224', '--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 05:28:48 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J25iWqDGRxGm-WihsC3Xuw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0224 --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 05:28:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h0jT9yP5rX/Render', 05:28:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:48 INFO - 'HOME': '/Users/cltbld', 05:28:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:48 INFO - 'LOGNAME': 'cltbld', 05:28:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:28:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:48 INFO - 'MOZ_NO_REMOTE': '1', 05:28:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:28:48 INFO - 'NO_EM_RESTART': '1', 05:28:48 INFO - 'PAGER': '/bin/cat', 05:28:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:48 INFO - 'PWD': '/builds/slave/test', 05:28:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:28:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:48 INFO - 'SHELL': '/bin/bash', 05:28:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tWvHb7SAIm/Listeners', 05:28:48 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 05:28:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:48 INFO - 'USER': 'cltbld', 05:28:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:48 INFO - 'XPC_FLAGS': '0x0', 05:28:48 INFO - 'XPC_SERVICE_NAME': '0', 05:28:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:48 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J25iWqDGRxGm-WihsC3Xuw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0224', '--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 05:28:48 INFO - mozversion application_buildid: 20160811030201 05:28:48 INFO - mozversion application_changeset: 0502bd9e025edde29777ba1de4280f9b52af4663 05:28:48 INFO - mozversion application_display_name: Nightly 05:28:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:28:48 INFO - mozversion application_name: Firefox 05:28:48 INFO - mozversion application_remotingname: firefox 05:28:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:28:48 INFO - mozversion application_vendor: Mozilla 05:28:48 INFO - mozversion application_version: 51.0a1 05:28:48 INFO - mozversion platform_buildid: 20160811030201 05:28:48 INFO - mozversion platform_changeset: 0502bd9e025edde29777ba1de4280f9b52af4663 05:28:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:28:48 INFO - mozversion platform_version: 51.0a1 05:28:48 INFO - using testdate: 1470918528 05:28:48 INFO - actual date: 1470918528 05:28:48 INFO - starting webserver on 'localhost:49266' 05:28:48 INFO - SUITE-START | Running 2 tests 05:28:48 INFO - TEST-START | dromaeo_css 05:28:48 INFO - operating with platform_type : mac_ 05:28:48 INFO - Initialising browser for dromaeo_css test... 05:28:49 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/tmp11j5Mo/profile http://localhost:49266/getInfo.html) 05:28:52 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 05:28:52 INFO - PROCESS | 1657 | colorDepth:24 05:28:52 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 05:28:52 INFO - PROCESS | 1657 | __metrics 05:28:52 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 05:28:53 INFO - TEST-INFO | 1657: exit 0 05:28:53 INFO - Browser initialized. 05:28:53 INFO - Running cycle 1/1 for dromaeo_css test... 05:28:53 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/tmp11j5Mo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:29:05 INFO - PROCESS | 1662 | RSS: Main: 254857216 05:29:05 INFO - PROCESS | 1662 | 05:29:55 INFO - PROCESS | 1662 | 1470918595062 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] 05:32:07 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 05:32:08 INFO - PROCESS | 1662 | RSS: Main: 267767808 05:32:08 INFO - PROCESS | 1662 | 05:35:10 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 05:35:11 INFO - PROCESS | 1662 | RSS: Main: 275656704 05:35:11 INFO - PROCESS | 1662 | 05:38:13 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 05:38:13 INFO - PROCESS | 1662 | RSS: Main: 280592384 05:38:13 INFO - PROCESS | 1662 | 05:41:15 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 05:41:16 INFO - PROCESS | 1662 | RSS: Main: 278843392 05:41:16 INFO - PROCESS | 1662 | 05:44:19 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 05:44:19 INFO - PROCESS | 1662 | RSS: Main: 283123712 05:44:19 INFO - PROCESS | 1662 | 05:47:22 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 05:47:22 INFO - PROCESS | 1662 | RSS: Main: 284991488 05:47:22 INFO - PROCESS | 1662 | 05:47:22 INFO - PROCESS | 1662 | __start_tp_report 05:47:22 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 05:47:22 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 05:47:22 INFO - PROCESS | 1662 | |i|pagename|runs| 05:47:22 INFO - PROCESS | 1662 | |0;dojo.html;3431.6225215226323;3468.687818096372;3493.1092571394292;3501.9649803501966;3526.8941931742042;4890.8777280568;5688.2605261315975;5839.503642190413;5929.644221346717;5943.3165186003625;5690.971545142279;5732.455416735414;5780.393058728836;5799.710014499279;5831.067029275317;5210.505002024811;5333.893322133555;5353.732313384316;5374.596905232103;5406.216098665691;5237.7381130943495;5312.990531798946;5337.412884582693;5376.542993845528;5478.04134276502;5190.195519694454;5276.9736151319385;5292.047431462335;5319.281896943901;5388.541973932221;5252.8686782830355;5346.331708536433;5359.758810853482;5362.570994320445;5369.301990741179;5325.20121981702;5325.334333208349;5349.866253343697;5352.625316227865;5365.248865158881;5012.223105418666;5065.772040258197;5801.3328467225965;5803.303603567557;5809.448102430262;6218.906716399258;6281.9948808190475;6297.685115744194;6311.652859092748;6316.147320111818;6101.065651476885;6164.260288765332;6315.905261421082;6319.8104056878365;6339.8098057057905;5937.139114828369;5989.071693887455;6004.579679422399;6004.669743164168;6053.636781793107;6439.8068057958335;6441.227052753699;6445.387688169616;6447.097406363113;6466.547341686037;5431.2396264522995;6070.544709146831;6096.8780624388155;6212.285587157445;6237.282712488122;5097.9745101275;6210.689465526705;6214.875702485925;6218.595791273553;6224.097505861625;6158.107074474266;6173.47525460332;6173.96913015441;6182.876342473215;6199.194104766351;4941.863371424521;5665.405132461032;6151.384861513813;6158.414950579688;6222.3466536013975;4431.290993441034;4879.536444037811;4986.828095397579;5063.11395505785;5070.974645126751;3692.1692619160476;4482.350059241392;4488.730676159441;4504.301833215857;4543.9776050389055;5730.942690573041;5793.333766616893;5816.970915145397;5828.970855145697;5904.793332233351;6179.783707570214;6202.4417802398;6245.0632405139595;6246.094316324107;6270.372962703693;5839.065749480148;5843.737031833578;5854.590178687451;5862.824115276463;5911.586188966731;5368.302120724359;5479.178123281539;5487.972560137174;5488.69812160327;5511.118221084607;6431;6538.673066346759;6542.182227221598;6551.279359270381;6554.639494827735;6250.843728906813;6266.373362663697;6273.811785646255;6287.591306565058;6300.401461861115;6240.843978900382;6385.45723613498;6491.5131365148745;6494.090827284279;6528.412442880163;6141.670122563672;6279.372062793684;6285.717142728497;6295.5907865988565;6313.842153946188;6256.374362563707;6279.591826531261;6284.748610055546;6289.654069026247;6292.811215663537;6073.514118870391;6152.98475751496;6270;6270.937290627217;6273.74905003813;6163.19878415803;6229.190205273286;6253.656048917172;6256.186695729526;6269.529785266032;4865.854024379274;5935.495482884004;5974.2233509643465;6046.54650901193;6063.484603808549;6028.3971602839365;6151.446369826737;6247.5001999839;6261.123442717932;6276.717547710273;6099.878002440015;6133.334663918993;6136.987397079611;6141.877162456636;6149.77004599073 05:47:22 INFO - PROCESS | 1662 | |1;ext.html;501.63054860231546;530.1226470191832;535.6973310079807;542.6201658838813;543.201493804108;28716.712832871664;41033.79483102588;41081.56214532492;41167.17665646689;41244.38133428001;37501.249975000486;42632.786836065774;42749.78625106878;43302.783486082524;43451;9622.663206787782;9811.264155188353;9823.36148150368;9827.361221520614;9837.754056148618;8343.874841877378;9653.131218190361;9664.565094570726;9668.70993870185;9789;9743.220542356594;9774.755631109208;9784.461854597994;9786.26603004774;9793.951030244874;7881;9735;9743.366681165773;9744.440889457688;9763.90236097637;9641.710748677551;9656.75858103546;9743.317967742261;9757.219422446187;9784.070513301296;41059.178816423504;41290.587094128976;41403;41474.79262603698;41549.753507394824;3347.3472672828807;3365.175531994677;3536.6463353664685;3824.464574959508;4093.5292441369324;30779.538306925413;30852.382952341053;31050.223744406572;31194.22014449657;31696.366072678647;3259.08745551246;3280.311134661724;3296.291297371077;3358.513015612747;3393.5079413485155;481990;497372;497749;498172;498327;62439.063414048826;62819.057714134324;62926.68536657288;62927.6853615729;62992.68503657453;32122.839385802923;32458.83770581179;32539.34921301561;32583.18542036468;32614.67385326164;16748.246328914985;16893.324267029428;16927.915360423365;16972.660546788997;17013.57466063358;12897.613071607866;12934.288614126126;13008.284544349963;13011.21932684023;13078.28069456189;19505.219791208478;19613.50966225827;19683.507912302306;19711.211551538065;19854.00729963496;6860.358761876613;8087.231712987257;8119.914432515607;8127.309178719756;8183.631736571869;852.8507511185518;983.3165949664914;1009.6213919780082;1014.6803756816579;1087.521490544158;30195.69804301929;30292;30345.24136896551;30573.69426305753;30903.381932361226;1062.7980683670078;1156.9942150289194;1160.8548931383577;1171.9589814356457;1242.2981015726086;15948.521544353687;16137.67724645524;16162.353505859634;16456.33518425018;16487;674630;679098;681436;683602;683685;59454.70272648609;59770.40229597735;59799;60096.699516502136;60455.09317360155;1341.7786065299117;1370.4038743146764;1387.1399732166121;1389.2775756606711;1394.6722520207743;29960.587318448266;30249.848750756104;30453.23866903345;30739.538906916863;30946.53580196254;52955.205671914184;53318.466815332904;53331.4666853342;53355.6661083476;53439.465605345;583008;586279;586513;586742;589098;27074.593881091405;27151;27630.171094867186;27647.170584882486;27745.167644970683;40525.79737101414;49336.50663493319;50248.74875625598;52048.47951520588;53137.202941956675;40490.79754601208;40673.983150421474;40811.38782918318;40861.978450538976;42835.57164428316;40490.79754601208;40788.79605601953;40833.79583102065;41059.97350066272;41250.79374603108;38987.41518877162;39607.00982475346;39736.403953940135;39866.60133398629;40027.599724002386;29034.27414314659;29575.964841230452;32123.357532848746;36056.4591531122;36289.27421451609;22526.436839079153;25375.36561585975;26182.73817261803;26242.475150496502;26337.604935925592 05:47:22 INFO - PROCESS | 1662 | |2;jquery.html;323.25812260861323;379.6260683227021;380.65360521925044;396.74608250719524;403.6155984971546;15749.448769293078;19858.40424787255;19962.800371996276;20598.48503787406;20782.68825967608;19801.702974455395;19837.305694300703;20386.69419958702;20694.68957965632;20814.063367148476;5449.972750136254;5544.362398324204;5653.208550802891;5722.170285308649;6129.570930034899;5221;5992.370801065891;6043.365446628107;6109.633421994672;6154.907676384858;5434.103372943459;5488.945110548903;5779.653220806765;6144.969275153618;6161.784337548187;5453.890922181554;5483.177523371486;5495.450454954513;5565.833025009256;5585.692786896719;5339.813106541253;5346.893062138735;5404.756785944642;5426.104692725696;5447.700376479292;10695.358278503238;13461.528846490424;13581;13837.930810345984;13868.861311386858;2302.9654555181687;2353.6234202527685;2355.057976809273;2415.287490190398;2417.9032838686608;10017.899821001769;10202.081812636825;10402.011808878144;11338.829917551244;16598.00411975285;1871.5695390060225;1909.0836398528784;1914.4639500939759;1948.133080779054;1972;120100;123308;124822;126197.99999999908;127646;9174.587143578556;11467.73854875963;11696.824547631792;11727.677658454737;11949.70125746846;14607.415703371746;14626.195559244345;14641.853581464049;14710.485133020293;14717;8365.707200247962;8668.393212475066;8677.52273624944;8779.024719438075;8813.735587932373;8591.785205369792;8616.181462761027;8623.655053797778;8805.515696636747;8823.867641985375;4079.7144199906315;4505.61702255312;4556.703814252063;4655.813767449332;4659.603933665609;1931.169597073244;1967.7835438101797;1989.592133612606;2002.549426379053;2003.4390370696228;912.4160537256162;933.537898740128;982.3467394182788;1009.0716540782498;1037.6938803053117;20754.273600423912;21115.366539003855;21202.257920972694;21325.25361612367;21449;928.6517555916531;928.6656803550717;937.7749340158449;985.571276494727;1003.2776400991274;10875.510602022929;11238;11269.211155219056;11305.660830175108;11320.207585469103;497422;500997;503123;564468;596602;143453;143995;147430;149868;152747.23626381796;880.7930136417937;897.1970086772433;923.930705197113;926.5691453474033;927.096081320707;18307.633847323246;20029.799702002794;20147.899260503604;20213.98930053521;20234.696479553113;49595.53640172402;58659.70670146622;59749.50626234379;61004.47488812815;61360.079598806944;84542.57728711564;86708.56645716731;88249.55875220583;91121.63317550109;91163.54418227867;8057.348243610163;8083;8287.12985136576;8367.205806993861;8442.282405995558;9447.95276023643;12515.937420312841;13164;13573.253471059186;13627.114237574526;11255.7748845021;11313.547458101584;11599.826002610136;11629.011534019703;11728.94439500449;8861.822763544822;11149.888501114885;11195.2723073;11335.829962550733;11522.481488333213;10821.242513024328;11008.229423940247;11476.827847582126;11634.592789252336;11850.940745296219;8083;8310.792230194053;8322.916770832215;8346.666133354598;8576.228139467477;8463.23830855226;10973.890261097287;11206.719832004264;11796.70508237301;11938.761224775282 05:47:22 INFO - PROCESS | 1662 | |3;mootools.html;1510.992445037775;1543.0278924277707;1750.1161913233816;1826.4611939477852;1879.7838248601406;7960.402969777261;8491.278241349484;8661.826763464727;9018.72943811685;9061.773455663611;8688.34837387197;8710;8836.160564746355;8848.247898928583;8852.645894164225;2311.7688231176876;2356.823238257129;2365.1840115160244;2371.8814059296965;2374.157174203159;2295.5867943770113;2328.1036800831635;2345.695059642244;2347.7769611886843;2354.152505098163;2296.8966396512114;2329.37106981115;2337.754535773745;2338.3101984914492;2350.1304517328613;2297.793198612116;2310.36464972134;2318.8840557972117;2330.580495510816;2335.3577766114286;2319.060780383947;2319.8376113672048;2319.8724070176304;2326.162581470669;2328.382978510696;8748.34387420946;8776.254018408443;8796.516191609522;8875.911240887637;8921.776955576097;5200.427952925175;5302.92045619316;5351.57187425005;5356.839294821161;5360.731963401814;3430.485427185917;3473.3053389322235;3562.536870206882;3619.2580520993133;3651.178484840916;1053.3258714422775;1083.5124194112682;1094.1684319916842;1105.9115270778318;1107.058999850129;11633.243839150427;11665.300081995107;11712.472938717692;11761.294322340687;11805.23265987708;4355.5208927018;4483.30508771141;4523.163214805271;4536.954630453719;4606.424196975378;9117.133872282122;10039;10077.69766906994;10117.898821011842;10127.189824814144;4892.48628893961;5338.172583249602;5361.035013697494;5366.892662146814;5381.704006279692;4048.67610591152;4145.751254924714;4286.121345124242;4669.509701481364;4878.02439512099;3685.8341374638208;3779.60314167014;3830.195658911604;3831.942520862189;3866.3813789794062;1106.446776611694;1291.702908331089;1293.2951541409955;1297.9675508112373;1311.9081664283408;764.9885251721229;835.8704400817883;888.2538667519315;924.5562130177418;938.0713094036854;5816.243888294494;5915.3788852170765;6029.276486821609;6055.757769689163;6070.848228794315;920.2591913509555;933.4399360383716;967.8209531236744;994.0904072773476;1027.8406846938738;3937.724359294822;4029.3553031514816;4046.7976601169826;4047.392891066305;4110.588941105925;10548.41983690889;10742.140628749838;10835.620753273597;10841.457927103613;10862;10744.73138171552;10848.67453976382;10873.673789786319;10890.836637450444;10927.125829933586;7845.137034926153;8128.878066829002;8219.671213151527;8327.916720832834;8357.997040355074;5274.208868669731;5921.792737254348;6060.424259695322;6124.908126378197;6125.84685382869;9646.807063858823;9944.651937182163;9973.750656233653;10158.796824063329;10161.745956351151;9809.166220871306;9976.551055202388;10071.194304455772;10164.695059148238;10247.538860751432;7015.649217539205;7371.668274927749;7508.511946723445;7545.886811697719;7679.347255483346;8219.465734727224;8280.83438331218;8358.247757701592;8441.746747597583;8466.74599762008;7385.778426647209;7386.039814824038;7559.622018898923;7626.923730762622;7649.885251721117;7281.235470275757;7435.591042492715;7457.962710186414;7530.209328020479;7553.924460755322;6972.023916651774;7120;7128.964355178191;7133.607651579213;7149.320814522612;4874.122657921608;4901;4910.877228069184;5010.849674509771;5093.643444958965;4496.752678602577;4913.385826771653;5052.3727661616485;5197.948020519746;5254.238135470412 05:47:22 INFO - PROCESS | 1662 | |4;prototype.html;274.95600703887374;288.89744140830004;292.26495364159143;310.3606570464842;319.15901599285877;4574.336721175428;4734.621230301576;5467.425920278373;5528.44715528447;5608.79340494629;5657.603967722261;5675.177099320596;5676.801311954083;5678.233438485813;5715.256676795141;3456.6197718251037;4003.7597744135446;4259.339802330628;4321.719088259269;4339.457567804025;3460.965390346102;3520.119970007498;4276.25165596021;4357.215701173787;4363.258246098171;3893.4549163117185;4069.674426045909;4189.518205406387;4240.745555266679;4258.787060646955;4198.929273035356;4272.585988916252;4275.722078064916;4279.44805811176;4284.5715428457215;3511.508388825541;3688.5020522229424;3698.63013698628;3712.2389910068373;3729.81350932455;4702.8118875244945;5032.597392208614;5115.309433226504;5463.125899856043;5473.480019398151;4030.3954406839207;4541.568550987651;4846.213427279328;4868.245421959602;4890.8288209912835;5090.821821236239;5697;5701.486866182064;5979;6060.515158787331;3152.155988746586;3938.2432297391942;3977.602239776028;3996.6003399659803;3999.920001599952;5815.429833944853;5966.254218222723;5990.580659353847;6096.963516202256;6218.875622487525;3998.540167880673;4070.4911886014247;4071.450354202204;4075.9388609170887;4104.138130992525;2842.7299406556344;3607.3326434609157;4080.5715399882583;4129.607687269705;4140.544540100586;4833.32333473314;4884.389451318585;4886.851589876376;4919.2129259318335;4921.434035085939;4865.878353041202;5096.694198348111;5160.761417259906;5195.4153983034785;5643.943560564342;1132.5277139718332;1310.4365122997012;1358.3767397959343;1377.8288454813328;1417.319686550441;788.7436583110511;907.3603109807569;942.783159873233;943.9575219115156;945.5603144537823;5492.434656122986;5535.6955367454375;5538.86152846174;5553.084185955839;5563.304586926634;5783.566232532577;6080.665563394055;6088.573799833969;6107.389261073857;6136.042252746954;4074.987715475502;4596.5173656765555;4867.975660121677;5338.839834804962;5453.23654688344;2451.007342026482;2495.663085483473;2656.9468610628064;2702.851343176105;2702.8783704733332;4075.347944328893;4410.448693913261;4962.801487940442;5279.548124265781;5336.973315133399;4775.904481910342;5242.277982632374;5541.944580554224;6303.338149494329;6474.4496717778575;5419.403865574784;6026.306974697878;6421.454176395058;6480.1811212122875;6521.934780652133;5035.59715222774;5201.42784293735;5263.5525980292105;6102.511799055976;6293.559450838397;6180.320164781961;6187.443130118311;6209.8201341744925;6238.6880655966115;6241.500679945502;5993.861166378374;6011.849703757441;6044.455998960115;6521.67391630426;6532.771353002622;3823.636754508317;4052.2908491013363;4057.490270915696;4072.5520192779363;4092.746266717907;6014.428629280212;6164.6745949621045;6229.003359462465;6290.528210384331;6308.71610777507;5310.309659744363;5834.708264586839;5944.305872826224;6054.39456054391;6129.448349648553;6065.088757396386;6082.36135205797;6082.635041897501;6106.786262480792;6121.387861213843;5280.838215592564;5670.829875103754;5872;5931.5847890648965;5948.434898684618;5108.489151084862;5831.679257640871;6088.604240724516;6125;6131.505042125946;5668.319801623831;5875.3243377012195;5943.335865957539;5957.940420595912;5986.521078313812 05:47:22 INFO - PROCESS | 1662 | |5;yui.html;728.4172661870504;772.9873865236541;781.7263957614836;825.9628316725747;874.7550685807972;15179.468718594851;15611.999999999985;15974;16031.83968160318;16045.919770401146;14358.425662973468;14379.92810035951;14437.63905902353;14450;14464.059836110646;825.4923222218323;855.9443636163661;878.9384743067988;886.2511178054533;890.0432035561764;738.8780851159552;842.6545116502235;843.582426698785;882.9381943263974;884.2086332732201;912.393258483108;920.9539523023856;925.3476299209075;925.8703781470599;926.9119433653792;876.5179151466732;890.5191196753746;893.3657103456553;905.3210092430677;925.4447331601019;677.711972411728;684.1072400517323;685.4550632247375;693.3794254142565;693.5387967001938;15439;15488.380464781396;15532.844671553254;15541.456049038343;15592.532224033297;14199.432022719078;14293.428262869473;14424.206668633222;14459.78310325346;14609.853901461061;11786.17496775226;11842.868283708929;11933.325728908821;11983.88016119845;12154.453049612788;3855.325318069327;3916.1776027034357;3918.0400801803457;4033.878983630496;4034.930743353014;86808.13191868064;94235.05764942331;96961;120354;123998;11095.778084438267;11100;11203.775924481464;11423.657290281139;11595.014423773904;22262.22082227114;22537;22584.88707556452;22595.661065084038;22604.773952260595;7489.962550187214;8040.437169398086;8135.796605084802;8168.9183108169345;8296.377771667028;4432.312991486325;4560.384348113029;4569.040501494657;4569.840055598104;4572.428446444194;3386.9322613547592;3506.0358401439807;3524.8061356625117;3542.0436482149676;3548.840302186408;633.9651319177398;634.109076747171;636.1729751323354;637.4549759955264;642.325558163926;499.91251530981936;578.3811321885543;618.6071844378762;641.9550631455846;652.7062821730241;8892.59983300753;9045.140711632384;9500.812398450194;10313;10444.68665940023;640.5902156290085;646.4343699263145;662.7050962321721;676.8643587679276;710.1726488640676;4390.3414487827085;4711.740854253049;4721.315409265637;4725.834595789131;4843.128236917319;106183;128727;134702;137212.47485710942;152301;135936.32031839777;137899.62100379067;138092;138874;139192.99999999796;113824.43087784674;115450.42274788741;117244;118994;120752;8872.866906996529;8902.510361930155;8911.821763564822;9067.90932090697;9149.77125571866;41684.79157604193;63057.73884522376;63766;64934.675326623066;66311.66844165749;62456.68771656113;70590.64704676444;77338.61330693311;84574;87366.56316718376;13327.533536326182;13529.391177397238;13538.458461661423;13576;13666.18002919828;14118.364673589507;14465.927670361581;14654.85345146535;14929.552113436614;15288.923555382153;13719.725605487634;13997.790033149307;14050.929745351208;14409.855901440851;14510.274486275433;13772.517961871687;13796.931015344859;14033;14378.424863005781;14532.927335363256;10928;13574.185548867099;13576.728465430439;13958.930205348908;14024.929875350557;11017.614383496539;11178.832317515407;11349.4892729829;11409.486573104396;11643.650690479299;8907.376483646083;9349.439033658002;10160.33957792741;10218.1825453965;10710.678679639623 05:47:22 INFO - PROCESS | 1662 | __end_tp_report 05:47:22 INFO - PROCESS | 1662 | __start_cc_report 05:47:22 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,416 05:47:22 INFO - PROCESS | 1662 | __end_cc_report 05:47:22 INFO - PROCESS | 1662 | __startTimestamp1470919642673__endTimestamp 05:47:22 INFO - PROCESS | 1662 | 05:47:22 INFO - PROCESS | 1662 | ------- Summary: start ------- 05:47:22 INFO - PROCESS | 1662 | Number of tests: 6 05:47:22 INFO - PROCESS | 1662 | 05:47:22 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5787.08 Median:6046.55 stddev:663.12 (11.0%) stddev-sans-first:638.89 05:47:22 INFO - PROCESS | 1662 | Values: 3431.6 3468.7 3493.1 3502.0 3526.9 4890.9 5688.3 5839.5 5929.6 5943.3 5691.0 5732.5 5780.4 5799.7 5831.1 5210.5 5333.9 5353.7 5374.6 5406.2 5237.7 5313.0 5337.4 5376.5 5478.0 5190.2 5277.0 5292.0 5319.3 5388.5 5252.9 5346.3 5359.8 5362.6 5369.3 5325.2 5325.3 5349.9 5352.6 5365.2 5012.2 5065.8 5801.3 5803.3 5809.4 6218.9 6282.0 6297.7 6311.7 6316.1 6101.1 6164.3 6315.9 6319.8 6339.8 5937.1 5989.1 6004.6 6004.7 6053.6 6439.8 6441.2 6445.4 6447.1 6466.5 5431.2 6070.5 6096.9 6212.3 6237.3 5098.0 6210.7 6214.9 6218.6 6224.1 6158.1 6173.5 6174.0 6182.9 6199.2 4941.9 5665.4 6151.4 6158.4 6222.3 4431.3 4879.5 4986.8 5063.1 5071.0 3692.2 4482.4 4488.7 4504.3 4544.0 5730.9 5793.3 5817.0 5829.0 5904.8 6179.8 6202.4 6245.1 6246.1 6270.4 5839.1 5843.7 5854.6 5862.8 5911.6 5368.3 5479.2 5488.0 5488.7 5511.1 6431.0 6538.7 6542.2 6551.3 6554.6 6250.8 6266.4 6273.8 6287.6 6300.4 6240.8 6385.5 6491.5 6494.1 6528.4 6141.7 6279.4 6285.7 6295.6 6313.8 6256.4 6279.6 6284.7 6289.7 6292.8 6073.5 6153.0 6270.0 6270.9 6273.7 6163.2 6229.2 6253.7 6256.2 6269.5 4865.9 5935.5 5974.2 6046.5 6063.5 6028.4 6151.4 6247.5 6261.1 6276.7 6099.9 6133.3 6137.0 6141.9 6149.8 05:47:22 INFO - PROCESS | 1662 | 05:47:22 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:71469.09 Median:40847.89 stddev:158423.65 (387.8%) stddev-sans-first:158778.47 05:47:22 INFO - PROCESS | 1662 | Values: 501.6 530.1 535.7 542.6 543.2 28716.7 41033.8 41081.6 41167.2 41244.4 37501.2 42632.8 42749.8 43302.8 43451.0 9622.7 9811.3 9823.4 9827.4 9837.8 8343.9 9653.1 9664.6 9668.7 9789.0 9743.2 9774.8 9784.5 9786.3 9794.0 7881.0 9735.0 9743.4 9744.4 9763.9 9641.7 9656.8 9743.3 9757.2 9784.1 41059.2 41290.6 41403.0 41474.8 41549.8 3347.3 3365.2 3536.6 3824.5 4093.5 30779.5 30852.4 31050.2 31194.2 31696.4 3259.1 3280.3 3296.3 3358.5 3393.5 481990.0 497372.0 497749.0 498172.0 498327.0 62439.1 62819.1 62926.7 62927.7 62992.7 32122.8 32458.8 32539.3 32583.2 32614.7 16748.2 16893.3 16927.9 16972.7 17013.6 12897.6 12934.3 13008.3 13011.2 13078.3 19505.2 19613.5 19683.5 19711.2 19854.0 6860.4 8087.2 8119.9 8127.3 8183.6 852.9 983.3 1009.6 1014.7 1087.5 30195.7 30292.0 30345.2 30573.7 30903.4 1062.8 1157.0 1160.9 1172.0 1242.3 15948.5 16137.7 16162.4 16456.3 16487.0 674630.0 679098.0 681436.0 683602.0 683685.0 59454.7 59770.4 59799.0 60096.7 60455.1 1341.8 1370.4 1387.1 1389.3 1394.7 29960.6 30249.8 30453.2 30739.5 30946.5 52955.2 53318.5 53331.5 53355.7 53439.5 583008.0 586279.0 586513.0 586742.0 589098.0 27074.6 27151.0 27630.2 27647.2 27745.2 40525.8 49336.5 50248.7 52048.5 53137.2 40490.8 40674.0 40811.4 40862.0 42835.6 40490.8 40788.8 40833.8 41060.0 41250.8 38987.4 39607.0 39736.4 39866.6 40027.6 29034.3 29576.0 32123.4 36056.5 36289.3 22526.4 25375.4 26182.7 26242.5 26337.6 05:47:22 INFO - PROCESS | 1662 | 05:47:22 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:34073.09 Median:2354.34 stddev:90844.12 (3858.6%) stddev-sans-first:91063.62 05:47:22 INFO - PROCESS | 1662 | Values: 323.3 379.6 380.7 396.7 403.6 15749.4 19858.4 19962.8 20598.5 20782.7 19801.7 19837.3 20386.7 20694.7 20814.1 5450.0 5544.4 5653.2 5722.2 6129.6 5221.0 5992.4 6043.4 6109.6 6154.9 5434.1 5488.9 5779.7 6145.0 6161.8 5453.9 5483.2 5495.5 5565.8 5585.7 5339.8 5346.9 5404.8 5426.1 5447.7 10695.4 13461.5 13581.0 13837.9 13868.9 2303.0 2353.6 2355.1 2415.3 2417.9 10017.9 10202.1 10402.0 11338.8 16598.0 1871.6 1909.1 1914.5 1948.1 1972.0 120100.0 123308.0 124822.0 126198.0 127646.0 9174.6 11467.7 11696.8 11727.7 11949.7 14607.4 14626.2 14641.9 14710.5 14717.0 8365.7 8668.4 8677.5 8779.0 8813.7 8591.8 8616.2 8623.7 8805.5 8823.9 4079.7 4505.6 4556.7 4655.8 4659.6 1931.2 1967.8 1989.6 2002.5 2003.4 912.4 933.5 982.3 1009.1 1037.7 20754.3 21115.4 21202.3 21325.3 21449.0 928.7 928.7 937.8 985.6 1003.3 10875.5 11238.0 11269.2 11305.7 11320.2 497422.0 500997.0 503123.0 564468.0 596602.0 143453.0 143995.0 147430.0 149868.0 152747.2 880.8 897.2 923.9 926.6 927.1 18307.6 20029.8 20147.9 20214.0 20234.7 49595.5 58659.7 59749.5 61004.5 61360.1 84542.6 86708.6 88249.6 91121.6 91163.5 8057.3 8083.0 8287.1 8367.2 8442.3 9448.0 12515.9 13164.0 13573.3 13627.1 11255.8 11313.5 11599.8 11629.0 11728.9 8861.8 11149.9 11195.3 11335.8 11522.5 10821.2 11008.2 11476.8 11634.6 11850.9 8083.0 8310.8 8322.9 8346.7 8576.2 8463.2 10973.9 11206.7 11796.7 11938.8 05:47:22 INFO - PROCESS | 1662 | 05:47:22 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5716.24 Median:4876.07 stddev:3221.99 (66.1%) stddev-sans-first:3215.53 05:47:22 INFO - PROCESS | 1662 | Values: 1511.0 1543.0 1750.1 1826.5 1879.8 7960.4 8491.3 8661.8 9018.7 9061.8 8688.3 8710.0 8836.2 8848.2 8852.6 2311.8 2356.8 2365.2 2371.9 2374.2 2295.6 2328.1 2345.7 2347.8 2354.2 2296.9 2329.4 2337.8 2338.3 2350.1 2297.8 2310.4 2318.9 2330.6 2335.4 2319.1 2319.8 2319.9 2326.2 2328.4 8748.3 8776.3 8796.5 8875.9 8921.8 5200.4 5302.9 5351.6 5356.8 5360.7 3430.5 3473.3 3562.5 3619.3 3651.2 1053.3 1083.5 1094.2 1105.9 1107.1 11633.2 11665.3 11712.5 11761.3 11805.2 4355.5 4483.3 4523.2 4537.0 4606.4 9117.1 10039.0 10077.7 10117.9 10127.2 4892.5 5338.2 5361.0 5366.9 5381.7 4048.7 4145.8 4286.1 4669.5 4878.0 3685.8 3779.6 3830.2 3831.9 3866.4 1106.4 1291.7 1293.3 1298.0 1311.9 765.0 835.9 888.3 924.6 938.1 5816.2 5915.4 6029.3 6055.8 6070.8 920.3 933.4 967.8 994.1 1027.8 3937.7 4029.4 4046.8 4047.4 4110.6 10548.4 10742.1 10835.6 10841.5 10862.0 10744.7 10848.7 10873.7 10890.8 10927.1 7845.1 8128.9 8219.7 8327.9 8358.0 5274.2 5921.8 6060.4 6124.9 6125.8 9646.8 9944.7 9973.8 10158.8 10161.7 9809.2 9976.6 10071.2 10164.7 10247.5 7015.6 7371.7 7508.5 7545.9 7679.3 8219.5 8280.8 8358.2 8441.7 8466.7 7385.8 7386.0 7559.6 7626.9 7649.9 7281.2 7435.6 7458.0 7530.2 7553.9 6972.0 7120.0 7129.0 7133.6 7149.3 4874.1 4901.0 4910.9 5010.8 5093.6 4496.8 4913.4 5052.4 5197.9 5254.2 05:47:22 INFO - PROCESS | 1662 | 05:47:22 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:4725.42 Median:5252.92 stddev:1517.39 (28.9%) stddev-sans-first:1484.43 05:47:22 INFO - PROCESS | 1662 | Values: 275.0 288.9 292.3 310.4 319.2 4574.3 4734.6 5467.4 5528.4 5608.8 5657.6 5675.2 5676.8 5678.2 5715.3 3456.6 4003.8 4259.3 4321.7 4339.5 3461.0 3520.1 4276.3 4357.2 4363.3 3893.5 4069.7 4189.5 4240.7 4258.8 4198.9 4272.6 4275.7 4279.4 4284.6 3511.5 3688.5 3698.6 3712.2 3729.8 4702.8 5032.6 5115.3 5463.1 5473.5 4030.4 4541.6 4846.2 4868.2 4890.8 5090.8 5697.0 5701.5 5979.0 6060.5 3152.2 3938.2 3977.6 3996.6 3999.9 5815.4 5966.3 5990.6 6097.0 6218.9 3998.5 4070.5 4071.5 4075.9 4104.1 2842.7 3607.3 4080.6 4129.6 4140.5 4833.3 4884.4 4886.9 4919.2 4921.4 4865.9 5096.7 5160.8 5195.4 5643.9 1132.5 1310.4 1358.4 1377.8 1417.3 788.7 907.4 942.8 944.0 945.6 5492.4 5535.7 5538.9 5553.1 5563.3 5783.6 6080.7 6088.6 6107.4 6136.0 4075.0 4596.5 4868.0 5338.8 5453.2 2451.0 2495.7 2656.9 2702.9 2702.9 4075.3 4410.4 4962.8 5279.5 5337.0 4775.9 5242.3 5541.9 6303.3 6474.4 5419.4 6026.3 6421.5 6480.2 6521.9 5035.6 5201.4 5263.6 6102.5 6293.6 6180.3 6187.4 6209.8 6238.7 6241.5 5993.9 6011.8 6044.5 6521.7 6532.8 3823.6 4052.3 4057.5 4072.6 4092.7 6014.4 6164.7 6229.0 6290.5 6308.7 5310.3 5834.7 5944.3 6054.4 6129.4 6065.1 6082.4 6082.6 6106.8 6121.4 5280.8 5670.8 5872.0 5931.6 5948.4 5108.5 5831.7 6088.6 6125.0 6131.5 5668.3 5875.3 5943.3 5957.9 5986.5 05:47:22 INFO - PROCESS | 1662 | 05:47:22 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:24302.80 Median:3545.44 stddev:38505.55 (1086.1%) stddev-sans-first:38572.88 05:47:22 INFO - PROCESS | 1662 | Values: 728.4 773.0 781.7 826.0 874.8 15179.5 15612.0 15974.0 16031.8 16045.9 14358.4 14379.9 14437.6 14450.0 14464.1 825.5 855.9 878.9 886.3 890.0 738.9 842.7 843.6 882.9 884.2 912.4 921.0 925.3 925.9 926.9 876.5 890.5 893.4 905.3 925.4 677.7 684.1 685.5 693.4 693.5 15439.0 15488.4 15532.8 15541.5 15592.5 14199.4 14293.4 14424.2 14459.8 14609.9 11786.2 11842.9 11933.3 11983.9 12154.5 3855.3 3916.2 3918.0 4033.9 4034.9 86808.1 94235.1 96961.0 120354.0 123998.0 11095.8 11100.0 11203.8 11423.7 11595.0 22262.2 22537.0 22584.9 22595.7 22604.8 7490.0 8040.4 8135.8 8168.9 8296.4 4432.3 4560.4 4569.0 4569.8 4572.4 3386.9 3506.0 3524.8 3542.0 3548.8 634.0 634.1 636.2 637.5 642.3 499.9 578.4 618.6 642.0 652.7 8892.6 9045.1 9500.8 10313.0 10444.7 640.6 646.4 662.7 676.9 710.2 4390.3 4711.7 4721.3 4725.8 4843.1 106183.0 128727.0 134702.0 137212.5 152301.0 135936.3 137899.6 138092.0 138874.0 139193.0 113824.4 115450.4 117244.0 118994.0 120752.0 8872.9 8902.5 8911.8 9067.9 9149.8 41684.8 63057.7 63766.0 64934.7 66311.7 62456.7 70590.6 77338.6 84574.0 87366.6 13327.5 13529.4 13538.5 13576.0 13666.2 14118.4 14465.9 14654.9 14929.6 15288.9 13719.7 13997.8 14050.9 14409.9 14510.3 13772.5 13796.9 14033.0 14378.4 14532.9 10928.0 13574.2 13576.7 13958.9 14024.9 11017.6 11178.8 11349.5 11409.5 11643.7 8907.4 9349.4 10160.3 10218.2 10710.7 05:47:22 INFO - PROCESS | 1662 | -------- Summary: end -------- 05:47:22 INFO - PROCESS | 1662 | 05:47:23 INFO - TEST-INFO | 1662: exit 0 05:47:23 INFO - TEST-OK | dromaeo_css | took 1114417ms 05:47:23 INFO - TEST-START | kraken 05:47:23 INFO - operating with platform_type : mac_ 05:47:23 INFO - Initialising browser for kraken test... 05:47:23 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/tmpbDTFI8/profile http://localhost:49266/getInfo.html) 05:47:26 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 05:47:26 INFO - PROCESS | 1670 | colorDepth:24 05:47:26 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 05:47:26 INFO - PROCESS | 1670 | __metrics 05:47:26 ERROR - PROCESS | 1670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 05:47:26 INFO - TEST-INFO | 1670: exit 0 05:47:26 INFO - Browser initialized. 05:47:26 INFO - Running cycle 1/1 for kraken test... 05:47:26 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/tmpbDTFI8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:47:38 INFO - PROCESS | 1673 | RSS: Main: 254697472 05:47:38 INFO - PROCESS | 1673 | 05:47:41 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 05:47:42 INFO - PROCESS | 1673 | RSS: Main: 267460608 05:47:42 INFO - PROCESS | 1673 | 05:47:45 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 05:47:46 INFO - PROCESS | 1673 | RSS: Main: 276172800 05:47:46 INFO - PROCESS | 1673 | 05:47:49 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 05:47:50 INFO - PROCESS | 1673 | RSS: Main: 279228416 05:47:50 INFO - PROCESS | 1673 | 05:47:52 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 05:47:52 INFO - PROCESS | 1673 | RSS: Main: 280506368 05:47:52 INFO - PROCESS | 1673 | 05:47:54 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:47:55 INFO - PROCESS | 1673 | RSS: Main: 280870912 05:47:55 INFO - PROCESS | 1673 | 05:47:58 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 05:47:59 INFO - PROCESS | 1673 | RSS: Main: 282206208 05:47:59 INFO - PROCESS | 1673 | 05:48:02 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 05:48:02 INFO - PROCESS | 1673 | RSS: Main: 282464256 05:48:02 INFO - PROCESS | 1673 | 05:48:05 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 05:48:06 INFO - PROCESS | 1673 | RSS: Main: 282808320 05:48:06 INFO - PROCESS | 1673 | 05:48:07 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:48:08 INFO - PROCESS | 1673 | RSS: Main: 282382336 05:48:08 INFO - PROCESS | 1673 | 05:48:10 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:48:11 INFO - PROCESS | 1673 | RSS: Main: 282492928 05:48:11 INFO - PROCESS | 1673 | 05:48:13 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:48:14 INFO - PROCESS | 1673 | RSS: Main: 282787840 05:48:14 INFO - PROCESS | 1673 | 05:48:17 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:48:17 INFO - PROCESS | 1673 | RSS: Main: 283013120 05:48:17 INFO - PROCESS | 1673 | 05:48:20 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:48:21 INFO - PROCESS | 1673 | RSS: Main: 283025408 05:48:21 INFO - PROCESS | 1673 | 05:48:23 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 05:48:23 INFO - PROCESS | 1673 | RSS: Main: 284196864 05:48:23 INFO - PROCESS | 1673 | 05:48:23 INFO - PROCESS | 1673 | __start_tp_report 05:48:23 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 05:48:23 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 05:48:23 INFO - PROCESS | 1673 | |i|pagename|runs| 05:48:23 INFO - PROCESS | 1673 | |0;ai-astar;105;119;125;173;177;126;114;105;150;171 05:48:23 INFO - PROCESS | 1673 | |1;audio-beat-detection;173;103;161;186;117;163;156;133;159;116 05:48:23 INFO - PROCESS | 1673 | |2;audio-dft;195;215;237;203;195;196;196;189;273;246 05:48:23 INFO - PROCESS | 1673 | |3;audio-fft;71;83;74;146;82;73;59;62;134;58 05:48:23 INFO - PROCESS | 1673 | |4;audio-oscillator;70;72;116;71;72;101;148;101;103;116 05:48:23 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;100;114;88;87;89;121;90;131;119;87 05:48:23 INFO - PROCESS | 1673 | |6;imaging-darkroom;95;95;94;104;96;94;95;97;95;100 05:48:23 INFO - PROCESS | 1673 | |7;imaging-desaturate;97;88;91;91;93;126;150;126;88;148 05:48:23 INFO - PROCESS | 1673 | |8;json-parse-financial;56;57;57;56;57;57;56;56;59;60 05:48:23 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;68;74;79;78;80;77;84;108;107;110 05:48:23 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;89;100;107;78;86;84;84;86;89;87 05:48:23 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;142;157;146;151;167;163;152;148;150;136 05:48:23 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;170;166;171;171;230;178;236;223;173;169 05:48:23 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;67;73;76;82;76;68;74;85;70;73 05:48:23 INFO - PROCESS | 1673 | __end_tp_report 05:48:23 INFO - PROCESS | 1673 | __start_cc_report 05:48:23 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1053 05:48:23 INFO - PROCESS | 1673 | __end_cc_report 05:48:23 INFO - PROCESS | 1673 | __startTimestamp1470919703634__endTimestamp 05:48:23 INFO - PROCESS | 1673 | 05:48:23 INFO - PROCESS | 1673 | ------- Summary: start ------- 05:48:23 INFO - PROCESS | 1673 | Number of tests: 14 05:48:23 INFO - PROCESS | 1673 | 05:48:23 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:136.50 Median:138.00 stddev:28.64 (20.8%) stddev-sans-first:28.02 05:48:23 INFO - PROCESS | 1673 | Values: 105.0 119.0 125.0 173.0 177.0 126.0 114.0 105.0 150.0 171.0 05:48:23 INFO - PROCESS | 1673 | 05:48:23 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:160.00 stddev:27.62 (17.3%) stddev-sans-first:27.61 05:48:23 INFO - PROCESS | 1673 | Values: 173.0 103.0 161.0 186.0 117.0 163.0 156.0 133.0 159.0 116.0 05:48:23 INFO - PROCESS | 1673 | 05:48:23 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:214.50 Median:209.00 stddev:28.18 (13.5%) stddev-sans-first:29.00 05:48:23 INFO - PROCESS | 1673 | Values: 195.0 215.0 237.0 203.0 195.0 196.0 196.0 189.0 273.0 246.0 05:48:23 INFO - PROCESS | 1673 | 05:48:23 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:84.20 Median:72.00 stddev:30.77 (42.7%) stddev-sans-first:32.27 05:48:23 INFO - PROCESS | 1673 | Values: 71.0 83.0 74.0 146.0 82.0 73.0 59.0 62.0 134.0 58.0 05:48:23 INFO - PROCESS | 1673 | 05:48:23 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:109.00 stddev:25.92 (23.8%) stddev-sans-first:25.58 05:48:23 INFO - PROCESS | 1673 | Values: 70.0 72.0 116.0 71.0 72.0 101.0 148.0 101.0 103.0 116.0 05:48:23 INFO - PROCESS | 1673 | 05:48:23 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:102.60 Median:87.00 stddev:16.98 (19.5%) stddev-sans-first:17.98 05:48:23 INFO - PROCESS | 1673 | Values: 100.0 114.0 88.0 87.0 89.0 121.0 90.0 131.0 119.0 87.0 05:48:23 INFO - PROCESS | 1673 | 05:48:23 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:96.50 Median:95.00 stddev:3.17 (3.3%) stddev-sans-first:3.32 05:48:23 INFO - PROCESS | 1673 | Values: 95.0 95.0 94.0 104.0 96.0 94.0 95.0 97.0 95.0 100.0 05:48:23 INFO - PROCESS | 1673 | 05:48:23 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:109.80 Median:89.50 stddev:25.17 (28.1%) stddev-sans-first:26.27 05:48:23 INFO - PROCESS | 1673 | Values: 97.0 88.0 91.0 91.0 93.0 126.0 150.0 126.0 88.0 148.0 05:48:23 INFO - PROCESS | 1673 | 05:48:23 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:57.00 stddev:1.37 (2.4%) stddev-sans-first:1.39 05:48:23 INFO - PROCESS | 1673 | Values: 56.0 57.0 57.0 56.0 57.0 57.0 56.0 56.0 59.0 60.0 05:48:23 INFO - PROCESS | 1673 | 05:48:23 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:86.50 Median:77.50 stddev:15.64 (20.2%) stddev-sans-first:15.08 05:48:23 INFO - PROCESS | 1673 | Values: 68.0 74.0 79.0 78.0 80.0 77.0 84.0 108.0 107.0 110.0 05:48:23 INFO - PROCESS | 1673 | 05:48:23 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:89.00 Median:86.00 stddev:8.42 (9.8%) stddev-sans-first:8.93 05:48:23 INFO - PROCESS | 1673 | Values: 89.0 100.0 107.0 78.0 86.0 84.0 84.0 86.0 89.0 87.0 05:48:23 INFO - PROCESS | 1673 | 05:48:23 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:151.20 Median:151.50 stddev:9.30 (6.1%) stddev-sans-first:9.24 05:48:23 INFO - PROCESS | 1673 | Values: 142.0 157.0 146.0 151.0 167.0 163.0 152.0 148.0 150.0 136.0 05:48:23 INFO - PROCESS | 1673 | 05:48:23 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.70 Median:175.50 stddev:28.60 (16.3%) stddev-sans-first:29.52 05:48:23 INFO - PROCESS | 1673 | Values: 170.0 166.0 171.0 171.0 230.0 178.0 236.0 223.0 173.0 169.0 05:48:23 INFO - PROCESS | 1673 | 05:48:23 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.40 Median:75.00 stddev:5.72 (7.6%) stddev-sans-first:5.40 05:48:23 INFO - PROCESS | 1673 | Values: 67.0 73.0 76.0 82.0 76.0 68.0 74.0 85.0 70.0 73.0 05:48:23 INFO - PROCESS | 1673 | -------- Summary: end -------- 05:48:23 INFO - PROCESS | 1673 | 05:48:24 INFO - TEST-INFO | 1673: exit 0 05:48:24 INFO - TEST-OK | kraken | took 61037ms 05:48:24 INFO - SUITE-END | took 1175s 05:48:24 INFO - Completed test suite (00:19:35) 05:48:24 INFO - javascript benchmark 05:48:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7426.731386283206, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3431.6225215226323, 3468.687818096372, 3493.1092571394292, 3501.9649803501966, 3526.8941931742042, 4890.8777280568, 5688.2605261315975, 5839.503642190413, 5929.644221346717, 5943.3165186003625, 5690.971545142279, 5732.455416735414, 5780.393058728836, 5799.710014499279, 5831.067029275317, 5210.505002024811, 5333.893322133555, 5353.732313384316, 5374.596905232103, 5406.216098665691, 5237.7381130943495, 5312.990531798946, 5337.412884582693, 5376.542993845528, 5478.04134276502, 5190.195519694454, 5276.9736151319385, 5292.047431462335, 5319.281896943901, 5388.541973932221, 5252.8686782830355, 5346.331708536433, 5359.758810853482, 5362.570994320445, 5369.301990741179, 5325.20121981702, 5325.334333208349, 5349.866253343697, 5352.625316227865, 5365.248865158881, 5012.223105418666, 5065.772040258197, 5801.3328467225965, 5803.303603567557, 5809.448102430262, 6218.906716399258, 6281.9948808190475, 6297.685115744194, 6311.652859092748, 6316.147320111818, 6101.065651476885, 6164.260288765332, 6315.905261421082, 6319.8104056878365, 6339.8098057057905, 5937.139114828369, 5989.071693887455, 6004.579679422399, 6004.669743164168, 6053.636781793107, 6439.8068057958335, 6441.227052753699, 6445.387688169616, 6447.097406363113, 6466.547341686037, 5431.2396264522995, 6070.544709146831, 6096.8780624388155, 6212.285587157445, 6237.282712488122, 5097.9745101275, 6210.689465526705, 6214.875702485925, 6218.595791273553, 6224.097505861625, 6158.107074474266, 6173.47525460332, 6173.96913015441, 6182.876342473215, 6199.194104766351, 4941.863371424521, 5665.405132461032, 6151.384861513813, 6158.414950579688, 6222.3466536013975, 4431.290993441034, 4879.536444037811, 4986.828095397579, 5063.11395505785, 5070.974645126751, 3692.1692619160476, 4482.350059241392, 4488.730676159441, 4504.301833215857, 4543.9776050389055, 5730.942690573041, 5793.333766616893, 5816.970915145397, 5828.970855145697, 5904.793332233351, 6179.783707570214, 6202.4417802398, 6245.0632405139595, 6246.094316324107, 6270.372962703693, 5839.065749480148, 5843.737031833578, 5854.590178687451, 5862.824115276463, 5911.586188966731, 5368.302120724359, 5479.178123281539, 5487.972560137174, 5488.69812160327, 5511.118221084607, 6431.0, 6538.673066346759, 6542.182227221598, 6551.279359270381, 6554.639494827735, 6250.843728906813, 6266.373362663697, 6273.811785646255, 6287.591306565058, 6300.401461861115, 6240.843978900382, 6385.45723613498, 6491.5131365148745, 6494.090827284279, 6528.412442880163, 6141.670122563672, 6279.372062793684, 6285.717142728497, 6295.5907865988565, 6313.842153946188, 6256.374362563707, 6279.591826531261, 6284.748610055546, 6289.654069026247, 6292.811215663537, 6073.514118870391, 6152.98475751496, 6270.0, 6270.937290627217, 6273.74905003813, 6163.19878415803, 6229.190205273286, 6253.656048917172, 6256.186695729526, 6269.529785266032, 4865.854024379274, 5935.495482884004, 5974.2233509643465, 6046.54650901193, 6063.484603808549, 6028.3971602839365, 6151.446369826737, 6247.5001999839, 6261.123442717932, 6276.717547710273, 6099.878002440015, 6133.334663918993, 6136.987397079611, 6141.877162456636, 6149.77004599073], "value": 5746.486752855217, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.63054860231546, 530.1226470191832, 535.6973310079807, 542.6201658838813, 543.201493804108, 28716.712832871664, 41033.79483102588, 41081.56214532492, 41167.17665646689, 41244.38133428001, 37501.249975000486, 42632.786836065774, 42749.78625106878, 43302.783486082524, 43451.0, 9622.663206787782, 9811.264155188353, 9823.36148150368, 9827.361221520614, 9837.754056148618, 8343.874841877378, 9653.131218190361, 9664.565094570726, 9668.70993870185, 9789.0, 9743.220542356594, 9774.755631109208, 9784.461854597994, 9786.26603004774, 9793.951030244874, 7881.0, 9735.0, 9743.366681165773, 9744.440889457688, 9763.90236097637, 9641.710748677551, 9656.75858103546, 9743.317967742261, 9757.219422446187, 9784.070513301296, 41059.178816423504, 41290.587094128976, 41403.0, 41474.79262603698, 41549.753507394824, 3347.3472672828807, 3365.175531994677, 3536.6463353664685, 3824.464574959508, 4093.5292441369324, 30779.538306925413, 30852.382952341053, 31050.223744406572, 31194.22014449657, 31696.366072678647, 3259.08745551246, 3280.311134661724, 3296.291297371077, 3358.513015612747, 3393.5079413485155, 481990.0, 497372.0, 497749.0, 498172.0, 498327.0, 62439.063414048826, 62819.057714134324, 62926.68536657288, 62927.6853615729, 62992.68503657453, 32122.839385802923, 32458.83770581179, 32539.34921301561, 32583.18542036468, 32614.67385326164, 16748.246328914985, 16893.324267029428, 16927.915360423365, 16972.660546788997, 17013.57466063358, 12897.613071607866, 12934.288614126126, 13008.284544349963, 13011.21932684023, 13078.28069456189, 19505.219791208478, 19613.50966225827, 19683.507912302306, 19711.211551538065, 19854.00729963496, 6860.358761876613, 8087.231712987257, 8119.914432515607, 8127.309178719756, 8183.631736571869, 852.8507511185518, 983.3165949664914, 1009.6213919780082, 1014.6803756816579, 1087.521490544158, 30195.69804301929, 30292.0, 30345.24136896551, 30573.69426305753, 30903.381932361226, 1062.7980683670078, 1156.9942150289194, 1160.8548931383577, 1171.9589814356457, 1242.2981015726086, 15948.521544353687, 16137.67724645524, 16162.353505859634, 16456.33518425018, 16487.0, 674630.0, 679098.0, 681436.0, 683602.0, 683685.0, 59454.70272648609, 59770.40229597735, 59799.0, 60096.699516502136, 60455.09317360155, 1341.7786065299117, 1370.4038743146764, 1387.1399732166121, 1389.2775756606711, 1394.6722520207743, 29960.587318448266, 30249.848750756104, 30453.23866903345, 30739.538906916863, 30946.53580196254, 52955.205671914184, 53318.466815332904, 53331.4666853342, 53355.6661083476, 53439.465605345, 583008.0, 586279.0, 586513.0, 586742.0, 589098.0, 27074.593881091405, 27151.0, 27630.171094867186, 27647.170584882486, 27745.167644970683, 40525.79737101414, 49336.50663493319, 50248.74875625598, 52048.47951520588, 53137.202941956675, 40490.79754601208, 40673.983150421474, 40811.38782918318, 40861.978450538976, 42835.57164428316, 40490.79754601208, 40788.79605601953, 40833.79583102065, 41059.97350066272, 41250.79374603108, 38987.41518877162, 39607.00982475346, 39736.403953940135, 39866.60133398629, 40027.599724002386, 29034.27414314659, 29575.964841230452, 32123.357532848746, 36056.4591531122, 36289.27421451609, 22526.436839079153, 25375.36561585975, 26182.73817261803, 26242.475150496502, 26337.604935925592], "value": 20118.015152391137, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.25812260861323, 379.6260683227021, 380.65360521925044, 396.74608250719524, 403.6155984971546, 15749.448769293078, 19858.40424787255, 19962.800371996276, 20598.48503787406, 20782.68825967608, 19801.702974455395, 19837.305694300703, 20386.69419958702, 20694.68957965632, 20814.063367148476, 5449.972750136254, 5544.362398324204, 5653.208550802891, 5722.170285308649, 6129.570930034899, 5221.0, 5992.370801065891, 6043.365446628107, 6109.633421994672, 6154.907676384858, 5434.103372943459, 5488.945110548903, 5779.653220806765, 6144.969275153618, 6161.784337548187, 5453.890922181554, 5483.177523371486, 5495.450454954513, 5565.833025009256, 5585.692786896719, 5339.813106541253, 5346.893062138735, 5404.756785944642, 5426.104692725696, 5447.700376479292, 10695.358278503238, 13461.528846490424, 13581.0, 13837.930810345984, 13868.861311386858, 2302.9654555181687, 2353.6234202527685, 2355.057976809273, 2415.287490190398, 2417.9032838686608, 10017.899821001769, 10202.081812636825, 10402.011808878144, 11338.829917551244, 16598.00411975285, 1871.5695390060225, 1909.0836398528784, 1914.4639500939759, 1948.133080779054, 1972.0, 120100.0, 123308.0, 124822.0, 126197.99999999908, 127646.0, 9174.587143578556, 11467.73854875963, 11696.824547631792, 11727.677658454737, 11949.70125746846, 14607.415703371746, 14626.195559244345, 14641.853581464049, 14710.485133020293, 14717.0, 8365.707200247962, 8668.393212475066, 8677.52273624944, 8779.024719438075, 8813.735587932373, 8591.785205369792, 8616.181462761027, 8623.655053797778, 8805.515696636747, 8823.867641985375, 4079.7144199906315, 4505.61702255312, 4556.703814252063, 4655.813767449332, 4659.603933665609, 1931.169597073244, 1967.7835438101797, 1989.592133612606, 2002.549426379053, 2003.4390370696228, 912.4160537256162, 933.537898740128, 982.3467394182788, 1009.0716540782498, 1037.6938803053117, 20754.273600423912, 21115.366539003855, 21202.257920972694, 21325.25361612367, 21449.0, 928.6517555916531, 928.6656803550717, 937.7749340158449, 985.571276494727, 1003.2776400991274, 10875.510602022929, 11238.0, 11269.211155219056, 11305.660830175108, 11320.207585469103, 497422.0, 500997.0, 503123.0, 564468.0, 596602.0, 143453.0, 143995.0, 147430.0, 149868.0, 152747.23626381796, 880.7930136417937, 897.1970086772433, 923.930705197113, 926.5691453474033, 927.096081320707, 18307.633847323246, 20029.799702002794, 20147.899260503604, 20213.98930053521, 20234.696479553113, 49595.53640172402, 58659.70670146622, 59749.50626234379, 61004.47488812815, 61360.079598806944, 84542.57728711564, 86708.56645716731, 88249.55875220583, 91121.63317550109, 91163.54418227867, 8057.348243610163, 8083.0, 8287.12985136576, 8367.205806993861, 8442.282405995558, 9447.95276023643, 12515.937420312841, 13164.0, 13573.253471059186, 13627.114237574526, 11255.7748845021, 11313.547458101584, 11599.826002610136, 11629.011534019703, 11728.94439500449, 8861.822763544822, 11149.888501114885, 11195.2723073, 11335.829962550733, 11522.481488333213, 10821.242513024328, 11008.229423940247, 11476.827847582126, 11634.592789252336, 11850.940745296219, 8083.0, 8310.792230194053, 8322.916770832215, 8346.666133354598, 8576.228139467477, 8463.23830855226, 10973.890261097287, 11206.719832004264, 11796.70508237301, 11938.761224775282], "value": 9527.583175650441, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1510.992445037775, 1543.0278924277707, 1750.1161913233816, 1826.4611939477852, 1879.7838248601406, 7960.402969777261, 8491.278241349484, 8661.826763464727, 9018.72943811685, 9061.773455663611, 8688.34837387197, 8710.0, 8836.160564746355, 8848.247898928583, 8852.645894164225, 2311.7688231176876, 2356.823238257129, 2365.1840115160244, 2371.8814059296965, 2374.157174203159, 2295.5867943770113, 2328.1036800831635, 2345.695059642244, 2347.7769611886843, 2354.152505098163, 2296.8966396512114, 2329.37106981115, 2337.754535773745, 2338.3101984914492, 2350.1304517328613, 2297.793198612116, 2310.36464972134, 2318.8840557972117, 2330.580495510816, 2335.3577766114286, 2319.060780383947, 2319.8376113672048, 2319.8724070176304, 2326.162581470669, 2328.382978510696, 8748.34387420946, 8776.254018408443, 8796.516191609522, 8875.911240887637, 8921.776955576097, 5200.427952925175, 5302.92045619316, 5351.57187425005, 5356.839294821161, 5360.731963401814, 3430.485427185917, 3473.3053389322235, 3562.536870206882, 3619.2580520993133, 3651.178484840916, 1053.3258714422775, 1083.5124194112682, 1094.1684319916842, 1105.9115270778318, 1107.058999850129, 11633.243839150427, 11665.300081995107, 11712.472938717692, 11761.294322340687, 11805.23265987708, 4355.5208927018, 4483.30508771141, 4523.163214805271, 4536.954630453719, 4606.424196975378, 9117.133872282122, 10039.0, 10077.69766906994, 10117.898821011842, 10127.189824814144, 4892.48628893961, 5338.172583249602, 5361.035013697494, 5366.892662146814, 5381.704006279692, 4048.67610591152, 4145.751254924714, 4286.121345124242, 4669.509701481364, 4878.02439512099, 3685.8341374638208, 3779.60314167014, 3830.195658911604, 3831.942520862189, 3866.3813789794062, 1106.446776611694, 1291.702908331089, 1293.2951541409955, 1297.9675508112373, 1311.9081664283408, 764.9885251721229, 835.8704400817883, 888.2538667519315, 924.5562130177418, 938.0713094036854, 5816.243888294494, 5915.3788852170765, 6029.276486821609, 6055.757769689163, 6070.848228794315, 920.2591913509555, 933.4399360383716, 967.8209531236744, 994.0904072773476, 1027.8406846938738, 3937.724359294822, 4029.3553031514816, 4046.7976601169826, 4047.392891066305, 4110.588941105925, 10548.41983690889, 10742.140628749838, 10835.620753273597, 10841.457927103613, 10862.0, 10744.73138171552, 10848.67453976382, 10873.673789786319, 10890.836637450444, 10927.125829933586, 7845.137034926153, 8128.878066829002, 8219.671213151527, 8327.916720832834, 8357.997040355074, 5274.208868669731, 5921.792737254348, 6060.424259695322, 6124.908126378197, 6125.84685382869, 9646.807063858823, 9944.651937182163, 9973.750656233653, 10158.796824063329, 10161.745956351151, 9809.166220871306, 9976.551055202388, 10071.194304455772, 10164.695059148238, 10247.538860751432, 7015.649217539205, 7371.668274927749, 7508.511946723445, 7545.886811697719, 7679.347255483346, 8219.465734727224, 8280.83438331218, 8358.247757701592, 8441.746747597583, 8466.74599762008, 7385.778426647209, 7386.039814824038, 7559.622018898923, 7626.923730762622, 7649.885251721117, 7281.235470275757, 7435.591042492715, 7457.962710186414, 7530.209328020479, 7553.924460755322, 6972.023916651774, 7120.0, 7128.964355178191, 7133.607651579213, 7149.320814522612, 4874.122657921608, 4901.0, 4910.877228069184, 5010.849674509771, 5093.643444958965, 4496.752678602577, 4913.385826771653, 5052.3727661616485, 5197.948020519746, 5254.238135470412], "value": 4588.077166249857, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [274.95600703887374, 288.89744140830004, 292.26495364159143, 310.3606570464842, 319.15901599285877, 4574.336721175428, 4734.621230301576, 5467.425920278373, 5528.44715528447, 5608.79340494629, 5657.603967722261, 5675.177099320596, 5676.801311954083, 5678.233438485813, 5715.256676795141, 3456.6197718251037, 4003.7597744135446, 4259.339802330628, 4321.719088259269, 4339.457567804025, 3460.965390346102, 3520.119970007498, 4276.25165596021, 4357.215701173787, 4363.258246098171, 3893.4549163117185, 4069.674426045909, 4189.518205406387, 4240.745555266679, 4258.787060646955, 4198.929273035356, 4272.585988916252, 4275.722078064916, 4279.44805811176, 4284.5715428457215, 3511.508388825541, 3688.5020522229424, 3698.63013698628, 3712.2389910068373, 3729.81350932455, 4702.8118875244945, 5032.597392208614, 5115.309433226504, 5463.125899856043, 5473.480019398151, 4030.3954406839207, 4541.568550987651, 4846.213427279328, 4868.245421959602, 4890.8288209912835, 5090.821821236239, 5697.0, 5701.486866182064, 5979.0, 6060.515158787331, 3152.155988746586, 3938.2432297391942, 3977.602239776028, 3996.6003399659803, 3999.920001599952, 5815.429833944853, 5966.254218222723, 5990.580659353847, 6096.963516202256, 6218.875622487525, 3998.540167880673, 4070.4911886014247, 4071.450354202204, 4075.9388609170887, 4104.138130992525, 2842.7299406556344, 3607.3326434609157, 4080.5715399882583, 4129.607687269705, 4140.544540100586, 4833.32333473314, 4884.389451318585, 4886.851589876376, 4919.2129259318335, 4921.434035085939, 4865.878353041202, 5096.694198348111, 5160.761417259906, 5195.4153983034785, 5643.943560564342, 1132.5277139718332, 1310.4365122997012, 1358.3767397959343, 1377.8288454813328, 1417.319686550441, 788.7436583110511, 907.3603109807569, 942.783159873233, 943.9575219115156, 945.5603144537823, 5492.434656122986, 5535.6955367454375, 5538.86152846174, 5553.084185955839, 5563.304586926634, 5783.566232532577, 6080.665563394055, 6088.573799833969, 6107.389261073857, 6136.042252746954, 4074.987715475502, 4596.5173656765555, 4867.975660121677, 5338.839834804962, 5453.23654688344, 2451.007342026482, 2495.663085483473, 2656.9468610628064, 2702.851343176105, 2702.8783704733332, 4075.347944328893, 4410.448693913261, 4962.801487940442, 5279.548124265781, 5336.973315133399, 4775.904481910342, 5242.277982632374, 5541.944580554224, 6303.338149494329, 6474.4496717778575, 5419.403865574784, 6026.306974697878, 6421.454176395058, 6480.1811212122875, 6521.934780652133, 5035.59715222774, 5201.42784293735, 5263.5525980292105, 6102.511799055976, 6293.559450838397, 6180.320164781961, 6187.443130118311, 6209.8201341744925, 6238.6880655966115, 6241.500679945502, 5993.861166378374, 6011.849703757441, 6044.455998960115, 6521.67391630426, 6532.771353002622, 3823.636754508317, 4052.2908491013363, 4057.490270915696, 4072.5520192779363, 4092.746266717907, 6014.428629280212, 6164.6745949621045, 6229.003359462465, 6290.528210384331, 6308.71610777507, 5310.309659744363, 5834.708264586839, 5944.305872826224, 6054.39456054391, 6129.448349648553, 6065.088757396386, 6082.36135205797, 6082.635041897501, 6106.786262480792, 6121.387861213843, 5280.838215592564, 5670.829875103754, 5872.0, 5931.5847890648965, 5948.434898684618, 5108.489151084862, 5831.679257640871, 6088.604240724516, 6125.0, 6131.505042125946, 5668.319801623831, 5875.3243377012195, 5943.335865957539, 5957.940420595912, 5986.521078313812], "value": 4232.931847527322, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.4172661870504, 772.9873865236541, 781.7263957614836, 825.9628316725747, 874.7550685807972, 15179.468718594851, 15611.999999999985, 15974.0, 16031.83968160318, 16045.919770401146, 14358.425662973468, 14379.92810035951, 14437.63905902353, 14450.0, 14464.059836110646, 825.4923222218323, 855.9443636163661, 878.9384743067988, 886.2511178054533, 890.0432035561764, 738.8780851159552, 842.6545116502235, 843.582426698785, 882.9381943263974, 884.2086332732201, 912.393258483108, 920.9539523023856, 925.3476299209075, 925.8703781470599, 926.9119433653792, 876.5179151466732, 890.5191196753746, 893.3657103456553, 905.3210092430677, 925.4447331601019, 677.711972411728, 684.1072400517323, 685.4550632247375, 693.3794254142565, 693.5387967001938, 15439.0, 15488.380464781396, 15532.844671553254, 15541.456049038343, 15592.532224033297, 14199.432022719078, 14293.428262869473, 14424.206668633222, 14459.78310325346, 14609.853901461061, 11786.17496775226, 11842.868283708929, 11933.325728908821, 11983.88016119845, 12154.453049612788, 3855.325318069327, 3916.1776027034357, 3918.0400801803457, 4033.878983630496, 4034.930743353014, 86808.13191868064, 94235.05764942331, 96961.0, 120354.0, 123998.0, 11095.778084438267, 11100.0, 11203.775924481464, 11423.657290281139, 11595.014423773904, 22262.22082227114, 22537.0, 22584.88707556452, 22595.661065084038, 22604.773952260595, 7489.962550187214, 8040.437169398086, 8135.796605084802, 8168.9183108169345, 8296.377771667028, 4432.312991486325, 4560.384348113029, 4569.040501494657, 4569.840055598104, 4572.428446444194, 3386.9322613547592, 3506.0358401439807, 3524.8061356625117, 3542.0436482149676, 3548.840302186408, 633.9651319177398, 634.109076747171, 636.1729751323354, 637.4549759955264, 642.325558163926, 499.91251530981936, 578.3811321885543, 618.6071844378762, 641.9550631455846, 652.7062821730241, 8892.59983300753, 9045.140711632384, 9500.812398450194, 10313.0, 10444.68665940023, 640.5902156290085, 646.4343699263145, 662.7050962321721, 676.8643587679276, 710.1726488640676, 4390.3414487827085, 4711.740854253049, 4721.315409265637, 4725.834595789131, 4843.128236917319, 106183.0, 128727.0, 134702.0, 137212.47485710942, 152301.0, 135936.32031839777, 137899.62100379067, 138092.0, 138874.0, 139192.99999999796, 113824.43087784674, 115450.42274788741, 117244.0, 118994.0, 120752.0, 8872.866906996529, 8902.510361930155, 8911.821763564822, 9067.90932090697, 9149.77125571866, 41684.79157604193, 63057.73884522376, 63766.0, 64934.675326623066, 66311.66844165749, 62456.68771656113, 70590.64704676444, 77338.61330693311, 84574.0, 87366.56316718376, 13327.533536326182, 13529.391177397238, 13538.458461661423, 13576.0, 13666.18002919828, 14118.364673589507, 14465.927670361581, 14654.85345146535, 14929.552113436614, 15288.923555382153, 13719.725605487634, 13997.790033149307, 14050.929745351208, 14409.855901440851, 14510.274486275433, 13772.517961871687, 13796.931015344859, 14033.0, 14378.424863005781, 14532.927335363256, 10928.0, 13574.185548867099, 13576.728465430439, 13958.930205348908, 14024.929875350557, 11017.614383496539, 11178.832317515407, 11349.4892729829, 11409.486573104396, 11643.650690479299, 8907.376483646083, 9349.439033658002, 10160.33957792741, 10218.1825453965, 10710.678679639623], "value": 7843.312535211559, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1634.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 119.0, 125.0, 173.0, 177.0, 126.0, 114.0, 105.0, 150.0, 171.0], "value": 136.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 103.0, 161.0, 186.0, 117.0, 163.0, 156.0, 133.0, 159.0, 116.0], "value": 146.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 215.0, 237.0, 203.0, 195.0, 196.0, 196.0, 189.0, 273.0, 246.0], "value": 214.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 83.0, 74.0, 146.0, 82.0, 73.0, 59.0, 62.0, 134.0, 58.0], "value": 84.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 116.0, 71.0, 72.0, 101.0, 148.0, 101.0, 103.0, 116.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 114.0, 88.0, 87.0, 89.0, 121.0, 90.0, 131.0, 119.0, 87.0], "value": 102.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 104.0, 96.0, 94.0, 95.0, 97.0, 95.0, 100.0], "value": 96.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 88.0, 91.0, 91.0, 93.0, 126.0, 150.0, 126.0, 88.0, 148.0], "value": 109.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 56.0, 57.0, 57.0, 56.0, 56.0, 59.0, 60.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 74.0, 79.0, 78.0, 80.0, 77.0, 84.0, 108.0, 107.0, 110.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 100.0, 107.0, 78.0, 86.0, 84.0, 84.0, 86.0, 89.0, 87.0], "value": 89.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 157.0, 146.0, 151.0, 167.0, 163.0, 152.0, 148.0, 150.0, 136.0], "value": 151.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 166.0, 171.0, 171.0, 230.0, 178.0, 236.0, 223.0, 173.0, 169.0], "value": 188.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 73.0, 76.0, 82.0, 76.0, 68.0, 74.0, 85.0, 70.0, 73.0], "value": 74.4, "unit": "score"}]}]} 05:48:24 INFO - Return code: 0 05:48:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:48:24 ERROR - # TBPL SUCCESS # 05:48:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:48:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:48:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:48:24 INFO - 2016-08-11 05:48:24.965 screenresolution[1678:11438] starting screenresolution argv=screenresolution get 05:48:24 INFO - 2016-08-11 05:48:24.968 screenresolution[1678:11438] Display 0: 1600x1200x32@60 05:48:24 INFO - 2016-08-11 05:48:24.973 screenresolution[1679:11441] starting screenresolution argv=screenresolution list 05:48:24 INFO - Available Modes on Display 0 05:48:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:48:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:48:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:48:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:48:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:48:25 INFO - Intel Iris: 05:48:25 INFO - Chipset Model: Intel Iris 05:48:25 INFO - Type: GPU 05:48:25 INFO - Bus: Built-In 05:48:25 INFO - VRAM (Dynamic, Max): 1536 MB 05:48:25 INFO - Vendor: Intel (0x8086) 05:48:25 INFO - Device ID: 0x0a2e 05:48:25 INFO - Revision ID: 0x0009 05:48:25 INFO - Displays: 05:48:25 INFO - Display: 05:48:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:48:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:48:25 INFO - Display Serial Number: 1600x1200 60 05:48:25 INFO - Main Display: Yes 05:48:25 INFO - Mirror: Off 05:48:25 INFO - Online: Yes 05:48:25 INFO - Rotation: Supported 05:48:25 INFO - Return code: 0 05:48:25 INFO - Running post-action listener: _resource_record_post_action 05:48:25 INFO - [mozharness: 2016-08-11 12:48:25.208983Z] Finished run-tests step (success) 05:48:25 INFO - Running post-run listener: _resource_record_post_run 05:48:25 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 32668672; Write bytes: 706048000; Read time: 200; Write time: 1957 05:48:25 INFO - TinderboxPrint: CPU usage
54.2% 05:48:25 INFO - TinderboxPrint: I/O read bytes / time
32,668,672 / 200 05:48:25 INFO - TinderboxPrint: I/O write bytes / time
706,048,000 / 1,957 05:48:25 INFO - TinderboxPrint: CPU idle
2,215.6 (45.8%) 05:48:25 INFO - TinderboxPrint: CPU system
973.8 (20.1%) 05:48:25 INFO - TinderboxPrint: CPU user
1,652.2 (34.1%) 05:48:25 INFO - TinderboxPrint: Swap in / out
432,517,120 / 0 05:48:25 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 401678848; Write bytes: 397345792; Read time: 29715; Write time: 812 05:48:25 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 30579712; Write bytes: 296909824; Read time: 181; Write time: 1110 05:48:25 INFO - Running post-run listener: _upload_blobber_files 05:48:25 INFO - Blob upload gear active. 05:48:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:48:25 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 05:48:25 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'] 05:48:25 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 05:48:26 INFO - (blobuploader) - INFO - Open directory for files ... 05:48:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:48:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:48:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:48:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:48:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:48:27 INFO - (blobuploader) - INFO - Done attempting. 05:48:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:48:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:48:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:48:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:48:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:48:28 INFO - (blobuploader) - INFO - Done attempting. 05:48:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:48:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:48:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:48:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:48:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:48:30 INFO - (blobuploader) - INFO - Done attempting. 05:48:30 INFO - (blobuploader) - INFO - Iteration through files over. 05:48:30 INFO - Return code: 0 05:48:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:48:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:48:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69d6605dc2fc550c03eaeb5cf6281ef59f40917034d554617faad333c4fa32bc8df9dc05006320a8ae3ffc83d32c30532e1238f81ed6735590d9327de55e04f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4ff78d3961cc524b59f9a071b874afc7760b8af82be4b69148a36d2b451890f33a8d69ae7214f2871dbd0d925ecd8956fa995b3b55cbabab5035258173a274c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b74cdb9817165d3586d889d6e24fe8e104995f9251ecb6e37df9f1c2d5c92cbd54de86b00d8a2e572c40035db6595a6ce06a3deb2d9b6d1718f6fee5e8ff739"} 05:48:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:48:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:48:30 INFO - Contents: 05:48:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69d6605dc2fc550c03eaeb5cf6281ef59f40917034d554617faad333c4fa32bc8df9dc05006320a8ae3ffc83d32c30532e1238f81ed6735590d9327de55e04f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4ff78d3961cc524b59f9a071b874afc7760b8af82be4b69148a36d2b451890f33a8d69ae7214f2871dbd0d925ecd8956fa995b3b55cbabab5035258173a274c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b74cdb9817165d3586d889d6e24fe8e104995f9251ecb6e37df9f1c2d5c92cbd54de86b00d8a2e572c40035db6595a6ce06a3deb2d9b6d1718f6fee5e8ff739"} 05:48:30 INFO - Running post-run listener: copy_logs_to_upload_dir 05:48:30 INFO - Copying logs to upload dir... 05:48:30 INFO - mkdir: /builds/slave/test/build/upload/logs 05:48:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.019072 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-08-11 05:48:30.653846) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 05:48:30.657746) ========= 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.h0jT9yP5rX/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.tWvHb7SAIm/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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/69d6605dc2fc550c03eaeb5cf6281ef59f40917034d554617faad333c4fa32bc8df9dc05006320a8ae3ffc83d32c30532e1238f81ed6735590d9327de55e04f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4ff78d3961cc524b59f9a071b874afc7760b8af82be4b69148a36d2b451890f33a8d69ae7214f2871dbd0d925ecd8956fa995b3b55cbabab5035258173a274c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b74cdb9817165d3586d889d6e24fe8e104995f9251ecb6e37df9f1c2d5c92cbd54de86b00d8a2e572c40035db6595a6ce06a3deb2d9b6d1718f6fee5e8ff739"} build_url:https://queue.taskcluster.net/v1/task/J25iWqDGRxGm-WihsC3Xuw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011069 build_url: 'https://queue.taskcluster.net/v1/task/J25iWqDGRxGm-WihsC3Xuw/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/69d6605dc2fc550c03eaeb5cf6281ef59f40917034d554617faad333c4fa32bc8df9dc05006320a8ae3ffc83d32c30532e1238f81ed6735590d9327de55e04f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4ff78d3961cc524b59f9a071b874afc7760b8af82be4b69148a36d2b451890f33a8d69ae7214f2871dbd0d925ecd8956fa995b3b55cbabab5035258173a274c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b74cdb9817165d3586d889d6e24fe8e104995f9251ecb6e37df9f1c2d5c92cbd54de86b00d8a2e572c40035db6595a6ce06a3deb2d9b6d1718f6fee5e8ff739"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 05:48:30.690993) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 05:48:30.691366) ========= 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.h0jT9yP5rX/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.tWvHb7SAIm/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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.005161 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 05:48:30.740840) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 05:48:30.741201) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 05:48:30.741652) ========= ========= Total master_lag: 0.21 =========