builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0257 starttime: 1470437563.49 results: success (0) buildid: 20160805133321 builduid: 6071a390e3014922a92793306bffd4c5 revision: 43f25602dac0aed6aafd8cfc9f9d45b2d047e791 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 15:52:43.493878) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 15:52:43.494802) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 15:52:43.495481) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 15:52:43.520961) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 15:52:43.521616) ========= 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.53tJXNR2HA/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.XCBYJsWvYi/Listeners TMPDIR=/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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-05 15:52:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.39M=0.001s 2016-08-05 15:52:43 (8.39 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126846 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 15:52:43.674942) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 15:52:43.675673) ========= 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.53tJXNR2HA/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.XCBYJsWvYi/Listeners TMPDIR=/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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.020997 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 15:52:43.728577) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 15:52:43.729359) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 43f25602dac0aed6aafd8cfc9f9d45b2d047e791 --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 43f25602dac0aed6aafd8cfc9f9d45b2d047e791 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.53tJXNR2HA/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.XCBYJsWvYi/Listeners TMPDIR=/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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-05 15:52:43,814 truncating revision to first 12 chars 2016-08-05 15:52:43,814 Setting DEBUG logging. 2016-08-05 15:52:43,814 attempt 1/10 2016-08-05 15:52:43,814 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/43f25602dac0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-05 15:52:44,487 unpacking tar archive at: mozilla-central-43f25602dac0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.936787 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 15:52:44.689745) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 15:52:44.690106) ========= script_repo_revision: 43f25602dac0aed6aafd8cfc9f9d45b2d047e791 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 15:52:44.690554) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 15:52:44.690855) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 15:52:44.710425) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-05 15:52:44.710724) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.53tJXNR2HA/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.XCBYJsWvYi/Listeners TMPDIR=/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 15:52:44 INFO - MultiFileLogger online at 20160805 15:52:44 in /builds/slave/test 15:52:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:52:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:52:44 INFO - {'append_to_log': False, 15:52:44 INFO - 'base_work_dir': '/builds/slave/test', 15:52:44 INFO - 'blob_upload_branch': 'Firefox', 15:52:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:52:44 INFO - 'branch': 'Firefox', 15:52:44 INFO - 'buildbot_json_path': 'buildprops.json', 15:52:44 INFO - 'config_files': ('talos/mac_config.py',), 15:52:44 INFO - 'default_actions': ('clobber', 15:52:44 INFO - 'read-buildbot-config', 15:52:44 INFO - 'download-and-extract', 15:52:44 INFO - 'populate-webroot', 15:52:44 INFO - 'create-virtualenv', 15:52:44 INFO - 'install', 15:52:44 INFO - 'run-tests'), 15:52:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:52:44 INFO - 'download_minidump_stackwalk': True, 15:52:44 INFO - 'download_symbols': 'ondemand', 15:52:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:52:44 INFO - 'tooltool.py': '/tools/tooltool.py', 15:52:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:52:44 INFO - '/tools/misc-python/virtualenv.py')}, 15:52:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:52:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:52:44 INFO - 'installer_path': 'installer.exe', 15:52:44 INFO - 'log_level': 'info', 15:52:44 INFO - 'log_name': 'talos', 15:52:44 INFO - 'log_to_console': True, 15:52:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:52:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:52:44 INFO - 'opt_config_files': (), 15:52:44 INFO - 'pip_index': False, 15:52:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:52:44 INFO - 'cmd': ('bash', 15:52:44 INFO - '-c', 15:52:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:52:44 INFO - 'enabled': True, 15:52:44 INFO - 'halt_on_failure': False, 15:52:44 INFO - 'name': 'check_screen_resolution'},), 15:52:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:52:44 INFO - 'cmd': ('bash', 15:52:44 INFO - '-c', 15:52:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:52:44 INFO - 'enabled': True, 15:52:44 INFO - 'halt_on_failure': False, 15:52:44 INFO - 'name': 'check_screen_resolution'},), 15:52:44 INFO - 'run_cmd_checks_enabled': True, 15:52:44 INFO - 'sps_profile': False, 15:52:44 INFO - 'sps_profile_interval': 0, 15:52:44 INFO - 'suite': 'dromaeojs', 15:52:44 INFO - 'system_bits': '32', 15:52:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:52:44 INFO - 'title': 't-yosemite-r7-0257', 15:52:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:52:44 INFO - 'use_talos_json': True, 15:52:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:52:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:52:44 INFO - 'work_dir': 'build'} 15:52:44 INFO - [mozharness: 2016-08-05 22:52:44.899532Z] Running clobber step. 15:52:44 INFO - Running pre-action listener: _resource_record_pre_action 15:52:44 INFO - Running main action method: clobber 15:52:44 INFO - rmtree: /builds/slave/test/build 15:52:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:52:46 INFO - Running post-action listener: _resource_record_post_action 15:52:46 INFO - [mozharness: 2016-08-05 22:52:46.345233Z] Finished clobber step (success) 15:52:46 INFO - [mozharness: 2016-08-05 22:52:46.345399Z] Running read-buildbot-config step. 15:52:46 INFO - Running pre-action listener: _resource_record_pre_action 15:52:46 INFO - Running main action method: read_buildbot_config 15:52:46 INFO - Using buildbot properties: 15:52:46 INFO - { 15:52:46 INFO - "project": "", 15:52:46 INFO - "product": "firefox", 15:52:46 INFO - "script_repo_revision": "production", 15:52:46 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 15:52:46 INFO - "repository": "", 15:52:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 15:52:46 INFO - "buildid": "20160805133321", 15:52:46 INFO - "pgo_build": "False", 15:52:46 INFO - "basedir": "/builds/slave/test", 15:52:46 INFO - "buildnumber": 34, 15:52:46 INFO - "slavename": "t-yosemite-r7-0257", 15:52:46 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 15:52:46 INFO - "platform": "yosemite_r7", 15:52:46 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:52:46 INFO - "branch": "mozilla-central", 15:52:46 INFO - "repo_path": "mozilla-central", 15:52:46 INFO - "revision": "43f25602dac0aed6aafd8cfc9f9d45b2d047e791", 15:52:46 INFO - "stage_platform": "macosx64", 15:52:46 INFO - "builduid": "6071a390e3014922a92793306bffd4c5", 15:52:46 INFO - "slavebuilddir": "test" 15:52:46 INFO - } 15:52:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 15:52:46 INFO - Running post-action listener: _resource_record_post_action 15:52:46 INFO - [mozharness: 2016-08-05 22:52:46.348769Z] Finished read-buildbot-config step (success) 15:52:46 INFO - [mozharness: 2016-08-05 22:52:46.348913Z] Running download-and-extract step. 15:52:46 INFO - Running pre-action listener: _resource_record_pre_action 15:52:46 INFO - Running main action method: download_and_extract 15:52:46 INFO - mkdir: /builds/slave/test/build/tests 15:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:46 INFO - trying https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 15:52:46 INFO - Downloading https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/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 15:52:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/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 15:52:47 INFO - Downloaded 1199 bytes. 15:52:47 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 15:52:47 INFO - Using the following test package requirements: 15:52:47 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 15:52:47 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:52:47 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 15:52:47 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:52:47 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 15:52:47 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:52:47 INFO - u'jsshell-mac.zip'], 15:52:47 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:52:47 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 15:52:47 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 15:52:47 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:52:47 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 15:52:47 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:52:47 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 15:52:47 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:52:47 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 15:52:47 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:52:47 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 15:52:47 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:52: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')]} 15:52:47 INFO - trying https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 15:52:47 INFO - Downloading https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/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 15:52:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/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 15:52:48 INFO - Downloaded 16321041 bytes. 15:52:48 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 15:52:55 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 15:52: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')]} 15:52:55 INFO - trying https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 15:52:55 INFO - Downloading https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/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 15:52:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/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 15:52:56 INFO - Downloaded 16321041 bytes. 15:52:56 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 15:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:02 INFO - trying https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 15:53:02 INFO - Downloading https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/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 15:53:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/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 15:53:03 INFO - Downloaded 14413723 bytes. 15:53:03 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 15:53: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')]} 15:53:03 INFO - trying https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 15:53:03 INFO - Downloading https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 15:53:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/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 15:53:06 INFO - Downloaded 111875700 bytes. 15:53:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 15:53:06 INFO - mkdir: /builds/slave/test/properties 15:53:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:53:06 INFO - Writing to file /builds/slave/test/properties/build_url 15:53:06 INFO - Contents: 15:53:06 INFO - build_url:https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 15:53:07 INFO - Running post-action listener: _resource_record_post_action 15:53:07 INFO - Running post-action listener: set_extra_try_arguments 15:53:07 INFO - [mozharness: 2016-08-05 22:53:07.382720Z] Finished download-and-extract step (success) 15:53:07 INFO - [mozharness: 2016-08-05 22:53:07.382845Z] Running populate-webroot step. 15:53:07 INFO - Running pre-action listener: _resource_record_pre_action 15:53:07 INFO - Running main action method: populate_webroot 15:53:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:53:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:53:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:53:07 INFO - '--tppagecycles', 15:53:07 INFO - '7'], 15:53:07 INFO - 'tests': ['tsvgm']}}, 15:53:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:53:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:53:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:53:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:53:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:53:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:53:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:07 INFO - 'talos_options': ['--disable-e10s'], 15:53:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:53:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:53:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:07 INFO - 'talos_options': ['--disable-e10s'], 15:53:07 INFO - 'tests': ['damp', 'tps']}, 15:53:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:07 INFO - 'tests': ['damp', 'tps']}, 15:53:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:53:07 INFO - 'tests': ['dromaeo_dom']}, 15:53:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:53:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:53:07 INFO - 'tests': ['basic_compositor_video']}, 15:53:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:53:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:53:07 INFO - 'tests': ['a11yr', 15:53:07 INFO - 'ts_paint', 15:53:07 INFO - 'tpaint', 15:53:07 INFO - 'sessionrestore', 15:53:07 INFO - 'sessionrestore_no_auto_restore', 15:53:07 INFO - 'tabpaint']}, 15:53:07 INFO - 'other-e10s': {'tests': ['a11yr', 15:53:07 INFO - 'ts_paint', 15:53:07 INFO - 'tpaint', 15:53:07 INFO - 'sessionrestore', 15:53:07 INFO - 'sessionrestore_no_auto_restore', 15:53:07 INFO - 'tabpaint']}, 15:53:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:53:07 INFO - 'ts_paint', 15:53:07 INFO - 'tpaint', 15:53:07 INFO - 'sessionrestore', 15:53:07 INFO - 'sessionrestore_no_auto_restore', 15:53:07 INFO - 'tabpaint']}, 15:53:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:53:07 INFO - 'ts_paint', 15:53:07 INFO - 'tpaint', 15:53:07 INFO - 'sessionrestore', 15:53:07 INFO - 'sessionrestore_no_auto_restore', 15:53:07 INFO - 'tabpaint']}, 15:53:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:53:07 INFO - 'tests': ['a11yr', 15:53:07 INFO - 'ts_paint', 15:53:07 INFO - 'tpaint', 15:53:07 INFO - 'sessionrestore', 15:53:07 INFO - 'sessionrestore_no_auto_restore', 15:53:07 INFO - 'tabpaint']}, 15:53:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:53:07 INFO - 'tests': ['a11yr', 15:53:07 INFO - 'ts_paint', 15:53:07 INFO - 'tpaint', 15:53:07 INFO - 'sessionrestore', 15:53:07 INFO - 'sessionrestore_no_auto_restore', 15:53:07 INFO - 'tabpaint']}, 15:53:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:53:07 INFO - 'tests': ['tsvgx', 15:53:07 INFO - 'tsvgr_opacity', 15:53:07 INFO - 'tart', 15:53:07 INFO - 'tscrollx', 15:53:07 INFO - 'cart']}, 15:53:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:53:07 INFO - 'tsvgr_opacity', 15:53:07 INFO - 'tart', 15:53:07 INFO - 'tscrollx', 15:53:07 INFO - 'cart']}, 15:53:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:07 INFO - 'talos_options': ['--disable-e10s'], 15:53:07 INFO - 'tests': ['tp5o']}, 15:53:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:07 INFO - 'tests': ['tp5o']}, 15:53:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:07 INFO - 'talos_options': ['--disable-e10s', 15:53:07 INFO - '--xperf_path', 15:53:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:53:07 INFO - 'tests': ['tp5n']}, 15:53:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:07 INFO - 'talos_options': ['--xperf_path', 15:53:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:53:07 INFO - 'tests': ['tp5n']}}, 15:53:07 INFO - 'talos.zip': {'path': '', 15:53:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:53:07 INFO - Running post-action listener: _resource_record_post_action 15:53:07 INFO - [mozharness: 2016-08-05 22:53:07.401437Z] Finished populate-webroot step (success) 15:53:07 INFO - [mozharness: 2016-08-05 22:53:07.401544Z] Running create-virtualenv step. 15:53:07 INFO - Running pre-action listener: _resource_record_pre_action 15:53:07 INFO - Running main action method: create_virtualenv 15:53:07 INFO - Creating virtualenv /builds/slave/test/build/venv 15:53:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:53:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:53:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:53:07 INFO - Using real prefix '/tools/python27' 15:53:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:53:08 INFO - Installing distribute.............................................................................................................................................................................................done. 15:53:11 INFO - Installing pip.................done. 15:53:11 INFO - Return code: 0 15:53:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:11 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 0x10b2cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b363618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf92488e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b232d30>, '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 0x10af97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b22ab20>, '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.53tJXNR2HA/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.XCBYJsWvYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:53:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:53:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:53:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.53tJXNR2HA/Render', 15:53:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:11 INFO - 'HOME': '/Users/cltbld', 15:53:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:11 INFO - 'LOGNAME': 'cltbld', 15:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:11 INFO - 'MOZ_NO_REMOTE': '1', 15:53:11 INFO - 'NO_EM_RESTART': '1', 15:53:11 INFO - 'PAGER': '/bin/cat', 15:53:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:11 INFO - 'PWD': '/builds/slave/test', 15:53:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:11 INFO - 'SHELL': '/bin/bash', 15:53:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XCBYJsWvYi/Listeners', 15:53:11 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 15:53:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:11 INFO - 'USER': 'cltbld', 15:53:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:11 INFO - 'XPC_FLAGS': '0x0', 15:53:11 INFO - 'XPC_SERVICE_NAME': '0', 15:53:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:53:11 INFO - Cleaning up... 15:53:11 INFO - Return code: 0 15:53:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:11 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 0x10b2cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b363618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf92488e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b232d30>, '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 0x10af97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b22ab20>, '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.53tJXNR2HA/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.XCBYJsWvYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:53:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:53:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:53:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.53tJXNR2HA/Render', 15:53:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:11 INFO - 'HOME': '/Users/cltbld', 15:53:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:11 INFO - 'LOGNAME': 'cltbld', 15:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:11 INFO - 'MOZ_NO_REMOTE': '1', 15:53:11 INFO - 'NO_EM_RESTART': '1', 15:53:11 INFO - 'PAGER': '/bin/cat', 15:53:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:11 INFO - 'PWD': '/builds/slave/test', 15:53:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:11 INFO - 'SHELL': '/bin/bash', 15:53:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XCBYJsWvYi/Listeners', 15:53:11 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 15:53:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:11 INFO - 'USER': 'cltbld', 15:53:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:11 INFO - 'XPC_FLAGS': '0x0', 15:53:11 INFO - 'XPC_SERVICE_NAME': '0', 15:53:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:11 INFO - Downloading/unpacking psutil>=3.1.1 15:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:53:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:53:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:53:15 INFO - Installing collected packages: psutil 15:53:15 INFO - Running setup.py install for psutil 15:53:15 INFO - building 'psutil._psutil_osx' extension 15:53:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 15:53:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:53:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:53:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 15:53:15 INFO - building 'psutil._psutil_posix' extension 15:53:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 15:53:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:53:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:53:15 INFO - ^ 15:53:15 INFO - 1 warning generated. 15:53:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 15:53:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:53:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:53:15 INFO - Successfully installed psutil 15:53:15 INFO - Cleaning up... 15:53:15 INFO - Return code: 0 15:53:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:53:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:15 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 0x10b2cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b363618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf92488e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b232d30>, '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 0x10af97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b22ab20>, '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.53tJXNR2HA/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.XCBYJsWvYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:53:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:53:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:53:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.53tJXNR2HA/Render', 15:53:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:15 INFO - 'HOME': '/Users/cltbld', 15:53:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:15 INFO - 'LOGNAME': 'cltbld', 15:53:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:15 INFO - 'MOZ_NO_REMOTE': '1', 15:53:15 INFO - 'NO_EM_RESTART': '1', 15:53:15 INFO - 'PAGER': '/bin/cat', 15:53:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:15 INFO - 'PWD': '/builds/slave/test', 15:53:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:15 INFO - 'SHELL': '/bin/bash', 15:53:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XCBYJsWvYi/Listeners', 15:53:15 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 15:53:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:15 INFO - 'USER': 'cltbld', 15:53:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:15 INFO - 'XPC_FLAGS': '0x0', 15:53:15 INFO - 'XPC_SERVICE_NAME': '0', 15:53:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:53:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:53:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:53:18 INFO - Installing collected packages: mozsystemmonitor 15:53:18 INFO - Running setup.py install for mozsystemmonitor 15:53:18 INFO - Successfully installed mozsystemmonitor 15:53:18 INFO - Cleaning up... 15:53:18 INFO - Return code: 0 15:53:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:18 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 0x10b2cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b363618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf92488e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b232d30>, '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 0x10af97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b22ab20>, '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.53tJXNR2HA/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.XCBYJsWvYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:53:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:53:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:53:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.53tJXNR2HA/Render', 15:53:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:18 INFO - 'HOME': '/Users/cltbld', 15:53:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:18 INFO - 'LOGNAME': 'cltbld', 15:53:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:18 INFO - 'MOZ_NO_REMOTE': '1', 15:53:18 INFO - 'NO_EM_RESTART': '1', 15:53:18 INFO - 'PAGER': '/bin/cat', 15:53:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:18 INFO - 'PWD': '/builds/slave/test', 15:53:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:18 INFO - 'SHELL': '/bin/bash', 15:53:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XCBYJsWvYi/Listeners', 15:53:18 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 15:53:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:18 INFO - 'USER': 'cltbld', 15:53:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:18 INFO - 'XPC_FLAGS': '0x0', 15:53:18 INFO - 'XPC_SERVICE_NAME': '0', 15:53:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:19 INFO - Downloading/unpacking jsonschema==2.5.1 15:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:53:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:21 INFO - Downloading functools32-3.2.3-2.tar.gz 15:53:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:53:22 INFO - warning: no files found matching '*.txt' 15:53:22 INFO - no previously-included directories found matching 'build' 15:53:22 INFO - no previously-included directories found matching 'dist' 15:53:22 INFO - no previously-included directories found matching '.git*' 15:53:22 INFO - Installing collected packages: jsonschema, functools32 15:53:22 INFO - Running setup.py install for functools32 15:53:22 INFO - warning: no files found matching '*.txt' 15:53:22 INFO - no previously-included directories found matching 'build' 15:53:22 INFO - no previously-included directories found matching 'dist' 15:53:22 INFO - no previously-included directories found matching '.git*' 15:53:22 INFO - Successfully installed jsonschema functools32 15:53:22 INFO - Cleaning up... 15:53:22 INFO - Return code: 0 15:53:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:22 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 0x10b2cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b363618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf92488e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b232d30>, '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 0x10af97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b22ab20>, '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.53tJXNR2HA/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.XCBYJsWvYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:53:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:53:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:53:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.53tJXNR2HA/Render', 15:53:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:22 INFO - 'HOME': '/Users/cltbld', 15:53:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:22 INFO - 'LOGNAME': 'cltbld', 15:53:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:22 INFO - 'MOZ_NO_REMOTE': '1', 15:53:22 INFO - 'NO_EM_RESTART': '1', 15:53:22 INFO - 'PAGER': '/bin/cat', 15:53:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:22 INFO - 'PWD': '/builds/slave/test', 15:53:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:22 INFO - 'SHELL': '/bin/bash', 15:53:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XCBYJsWvYi/Listeners', 15:53:22 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 15:53:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:22 INFO - 'USER': 'cltbld', 15:53:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:22 INFO - 'XPC_FLAGS': '0x0', 15:53:22 INFO - 'XPC_SERVICE_NAME': '0', 15:53:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:53:22 INFO - Cleaning up... 15:53:22 INFO - Return code: 0 15:53:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:22 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 0x10b2cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b363618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf92488e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b232d30>, '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 0x10af97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b22ab20>, '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.53tJXNR2HA/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.XCBYJsWvYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:53:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:53:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:53:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.53tJXNR2HA/Render', 15:53:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:22 INFO - 'HOME': '/Users/cltbld', 15:53:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:22 INFO - 'LOGNAME': 'cltbld', 15:53:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:22 INFO - 'MOZ_NO_REMOTE': '1', 15:53:22 INFO - 'NO_EM_RESTART': '1', 15:53:22 INFO - 'PAGER': '/bin/cat', 15:53:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:22 INFO - 'PWD': '/builds/slave/test', 15:53:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:22 INFO - 'SHELL': '/bin/bash', 15:53:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XCBYJsWvYi/Listeners', 15:53:22 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 15:53:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:22 INFO - 'USER': 'cltbld', 15:53:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:22 INFO - 'XPC_FLAGS': '0x0', 15:53:22 INFO - 'XPC_SERVICE_NAME': '0', 15:53:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:22 INFO - Downloading/unpacking blobuploader==1.2.4 15:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:25 INFO - Downloading blobuploader-1.2.4.tar.gz 15:53:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:53:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:53:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:26 INFO - Downloading docopt-0.6.1.tar.gz 15:53:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:53:26 INFO - Installing collected packages: blobuploader, requests, docopt 15:53:26 INFO - Running setup.py install for blobuploader 15:53:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:53:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:53:26 INFO - Running setup.py install for requests 15:53:27 INFO - Running setup.py install for docopt 15:53:27 INFO - Successfully installed blobuploader requests docopt 15:53:27 INFO - Cleaning up... 15:53:27 INFO - Return code: 0 15:53:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:27 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 0x10b2cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b363618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf92488e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b232d30>, '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 0x10af97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b22ab20>, '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.53tJXNR2HA/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.XCBYJsWvYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:53:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:53:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.53tJXNR2HA/Render', 15:53:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:27 INFO - 'HOME': '/Users/cltbld', 15:53:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:27 INFO - 'LOGNAME': 'cltbld', 15:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:27 INFO - 'MOZ_NO_REMOTE': '1', 15:53:27 INFO - 'NO_EM_RESTART': '1', 15:53:27 INFO - 'PAGER': '/bin/cat', 15:53:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:27 INFO - 'PWD': '/builds/slave/test', 15:53:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:27 INFO - 'SHELL': '/bin/bash', 15:53:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XCBYJsWvYi/Listeners', 15:53:27 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 15:53:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:27 INFO - 'USER': 'cltbld', 15:53:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:27 INFO - 'XPC_FLAGS': '0x0', 15:53:27 INFO - 'XPC_SERVICE_NAME': '0', 15:53:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:53:27 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-vFWlLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:53:27 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-yX0R2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:53:27 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-DqJEJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:53:27 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-pSZdDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:53:28 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-eS7ny0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:53:28 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-ArxSFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:53:28 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-2BJQVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:53:28 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-nvwjce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:53:28 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-YZGM7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:53:28 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-M4qvzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:53:28 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-OfhklC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:53:28 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-999FYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:53:28 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-52kn6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:53:29 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-uh5Ebh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:29 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-NQUvgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:53:29 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-BGN3h1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:53:29 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-iNHrHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:53:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:53:29 INFO - Running setup.py install for manifestparser 15:53:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:53:29 INFO - Running setup.py install for mozcrash 15:53:29 INFO - Running setup.py install for mozdebug 15:53:29 INFO - Running setup.py install for mozdevice 15:53:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:53:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:53:30 INFO - Running setup.py install for mozfile 15:53:30 INFO - Running setup.py install for mozhttpd 15:53:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:53:30 INFO - Running setup.py install for mozinfo 15:53:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:53:30 INFO - Running setup.py install for mozInstall 15:53:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:53:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:53:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:53:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:53:30 INFO - Running setup.py install for mozleak 15:53:30 INFO - Running setup.py install for mozlog 15:53:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:53:30 INFO - Running setup.py install for moznetwork 15:53:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:53:31 INFO - Running setup.py install for mozprocess 15:53:31 INFO - Running setup.py install for mozprofile 15:53:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:53:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:53:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:53:31 INFO - Running setup.py install for mozrunner 15:53:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:53:31 INFO - Running setup.py install for mozscreenshot 15:53:31 INFO - Running setup.py install for moztest 15:53:31 INFO - Running setup.py install for mozversion 15:53:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:53:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:53:32 INFO - Cleaning up... 15:53:32 INFO - Return code: 0 15:53:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:32 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 0x10b2cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b363618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf92488e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b232d30>, '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 0x10af97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b22ab20>, '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.53tJXNR2HA/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.XCBYJsWvYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:53:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:53:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:53:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.53tJXNR2HA/Render', 15:53:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:32 INFO - 'HOME': '/Users/cltbld', 15:53:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:32 INFO - 'LOGNAME': 'cltbld', 15:53:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:32 INFO - 'MOZ_NO_REMOTE': '1', 15:53:32 INFO - 'NO_EM_RESTART': '1', 15:53:32 INFO - 'PAGER': '/bin/cat', 15:53:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:32 INFO - 'PWD': '/builds/slave/test', 15:53:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:32 INFO - 'SHELL': '/bin/bash', 15:53:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XCBYJsWvYi/Listeners', 15:53:32 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 15:53:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:32 INFO - 'USER': 'cltbld', 15:53:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:32 INFO - 'XPC_FLAGS': '0x0', 15:53:32 INFO - 'XPC_SERVICE_NAME': '0', 15:53:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:53:32 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-xb0ylJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:53:32 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-OkYMTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:53:32 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)) 15:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:53:32 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-_Oj5VC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:53:32 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-X1xHmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:53:32 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)) 15:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:53:32 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-BVXYOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:53:32 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-KAJifi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:53:32 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-VFxsiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:53:33 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-iWkwjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:53:33 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-KrWB9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:53:33 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-Zke7to-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:53:33 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)) 15:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:53:33 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-JrdoCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:53:33 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-k9n457-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:53:33 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-YV2K64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:53:33 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-H4Zeg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:53:33 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)) 15:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:33 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-lG87uQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:53:33 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-ZKt_iJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:53:34 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-__CNMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:53:34 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)) 15:53:34 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)) 15:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:53:34 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)) 15:53:34 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)) 15:53:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:36 INFO - Downloading blessings-1.6.tar.gz 15:53:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:53:36 INFO - Installing collected packages: blessings 15:53:36 INFO - Running setup.py install for blessings 15:53:36 INFO - Successfully installed blessings 15:53:36 INFO - Cleaning up... 15:53:36 INFO - Return code: 0 15:53:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:53:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:53:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:53:37 INFO - Reading from file tmpfile_stdout 15:53:37 INFO - Current package versions: 15:53:37 INFO - blessings == 1.6 15:53:37 INFO - blobuploader == 1.2.4 15:53:37 INFO - docopt == 0.6.1 15:53:37 INFO - functools32 == 3.2.3-2 15:53:37 INFO - jsonschema == 2.5.1 15:53:37 INFO - manifestparser == 1.1 15:53:37 INFO - mozInstall == 1.12 15:53:37 INFO - mozcrash == 0.17 15:53:37 INFO - mozdebug == 0.1 15:53:37 INFO - mozdevice == 0.48 15:53:37 INFO - mozfile == 1.2 15:53:37 INFO - mozhttpd == 0.7 15:53:37 INFO - mozinfo == 0.9 15:53:37 INFO - mozleak == 0.1 15:53:37 INFO - mozlog == 3.3 15:53:37 INFO - moznetwork == 0.27 15:53:37 INFO - mozprocess == 0.23 15:53:37 INFO - mozprofile == 0.28 15:53:37 INFO - mozrunner == 6.12 15:53:37 INFO - mozscreenshot == 0.1 15:53:37 INFO - mozsystemmonitor == 0.3 15:53:37 INFO - moztest == 0.7 15:53:37 INFO - mozversion == 1.4 15:53:37 INFO - psutil == 3.1.1 15:53:37 INFO - requests == 1.2.3 15:53:37 INFO - wsgiref == 0.1.2 15:53:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:37 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 0x10b2cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b363618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf92488e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b232d30>, '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 0x10af97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b22ab20>, '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.53tJXNR2HA/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.XCBYJsWvYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:53:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:53:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:53:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.53tJXNR2HA/Render', 15:53:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:37 INFO - 'HOME': '/Users/cltbld', 15:53:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:37 INFO - 'LOGNAME': 'cltbld', 15:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:37 INFO - 'MOZ_NO_REMOTE': '1', 15:53:37 INFO - 'NO_EM_RESTART': '1', 15:53:37 INFO - 'PAGER': '/bin/cat', 15:53:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:37 INFO - 'PWD': '/builds/slave/test', 15:53:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:37 INFO - 'SHELL': '/bin/bash', 15:53:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XCBYJsWvYi/Listeners', 15:53:37 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 15:53:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:37 INFO - 'USER': 'cltbld', 15:53:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:37 INFO - 'XPC_FLAGS': '0x0', 15:53:37 INFO - 'XPC_SERVICE_NAME': '0', 15:53:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:53:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:53:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:53:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:53:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:53:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:53:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:53:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:53:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:53:37 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:53:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:53:37 INFO - Cleaning up... 15:53:37 INFO - Return code: 0 15:53:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:37 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 0x10b2cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b363618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf92488e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b232d30>, '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 0x10af97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b22ab20>, '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.53tJXNR2HA/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.XCBYJsWvYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:53:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:53:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:53:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.53tJXNR2HA/Render', 15:53:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:37 INFO - 'HOME': '/Users/cltbld', 15:53:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:37 INFO - 'LOGNAME': 'cltbld', 15:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:37 INFO - 'MOZ_NO_REMOTE': '1', 15:53:37 INFO - 'NO_EM_RESTART': '1', 15:53:37 INFO - 'PAGER': '/bin/cat', 15:53:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:37 INFO - 'PWD': '/builds/slave/test', 15:53:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:37 INFO - 'SHELL': '/bin/bash', 15:53:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XCBYJsWvYi/Listeners', 15:53:37 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 15:53:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:37 INFO - 'USER': 'cltbld', 15:53:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:37 INFO - 'XPC_FLAGS': '0x0', 15:53:37 INFO - 'XPC_SERVICE_NAME': '0', 15:53:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:53:37 INFO - Cleaning up... 15:53:37 INFO - Return code: 0 15:53:37 INFO - Running post-action listener: _resource_record_post_action 15:53:37 INFO - Running post-action listener: _start_resource_monitoring 15:53:37 INFO - Starting resource monitoring. 15:53:37 INFO - [mozharness: 2016-08-05 22:53:37.852453Z] Finished create-virtualenv step (success) 15:53:37 INFO - [mozharness: 2016-08-05 22:53:37.853452Z] Running install step. 15:53:37 INFO - Running pre-action listener: _resource_record_pre_action 15:53:37 INFO - Running main action method: install 15:53:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:53:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:53:38 INFO - Reading from file tmpfile_stdout 15:53:38 INFO - Detecting whether we're running mozinstall >=1.0... 15:53:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:53:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:53:38 INFO - Reading from file tmpfile_stdout 15:53:38 INFO - Output received: 15:53:38 INFO - Usage: mozinstall [options] installer 15:53:38 INFO - Options: 15:53:38 INFO - -h, --help show this help message and exit 15:53:38 INFO - -d DEST, --destination=DEST 15:53:38 INFO - Directory to install application into. [default: 15:53:38 INFO - "/builds/slave/test"] 15:53:38 INFO - --app=APP Application being installed. [default: firefox] 15:53:38 INFO - mkdir: /builds/slave/test/build/application 15:53:38 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'] 15:53:38 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 15:54:12 INFO - Reading from file tmpfile_stdout 15:54:12 INFO - Output received: 15:54:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:54:12 INFO - Running post-action listener: _resource_record_post_action 15:54:12 INFO - [mozharness: 2016-08-05 22:54:12.209165Z] Finished install step (success) 15:54:12 INFO - [mozharness: 2016-08-05 22:54:12.209293Z] Running run-tests step. 15:54:12 INFO - Running pre-action listener: _resource_record_pre_action 15:54:12 INFO - Running main action method: run_tests 15:54:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:54:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:54:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:54:12 INFO - 2016-08-05 15:54:12.224 screenresolution[7616:128175] starting screenresolution argv=screenresolution get 15:54:12 INFO - 2016-08-05 15:54:12.227 screenresolution[7616:128175] Display 0: 1600x1200x32@60 15:54:12 INFO - 2016-08-05 15:54:12.233 screenresolution[7617:128177] starting screenresolution argv=screenresolution list 15:54:12 INFO - Available Modes on Display 0 15:54:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:54:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:54:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:54:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:54:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:54:12 INFO - Intel Iris: 15:54:12 INFO - Chipset Model: Intel Iris 15:54:12 INFO - Type: GPU 15:54:12 INFO - Bus: Built-In 15:54:12 INFO - VRAM (Dynamic, Max): 1536 MB 15:54:12 INFO - Vendor: Intel (0x8086) 15:54:12 INFO - Device ID: 0x0a2e 15:54:12 INFO - Revision ID: 0x0009 15:54:12 INFO - Displays: 15:54:12 INFO - Display: 15:54:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:54:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:54:12 INFO - Display Serial Number: 1600x1200 60 15:54:12 INFO - Main Display: Yes 15:54:12 INFO - Mirror: Off 15:54:12 INFO - Online: Yes 15:54:12 INFO - Rotation: Supported 15:54:12 INFO - Return code: 0 15:54:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:54:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:54:12 INFO - Python 2.7.3 15:54:12 INFO - Return code: 0 15:54:12 INFO - grabbing minidump binary from tooltool 15:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:54:12 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 0x10b232d30>, '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 0x10af97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b22ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:54:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:54:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 15:54:12 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:54:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:54:12 INFO - Return code: 0 15:54:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:54:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:54:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:54:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:54:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:54:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0257', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:54:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0257 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:54:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.53tJXNR2HA/Render', 15:54:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:54:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:54:12 INFO - 'HOME': '/Users/cltbld', 15:54:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:54:12 INFO - 'LOGNAME': 'cltbld', 15:54:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:54:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:12 INFO - 'MOZ_NO_REMOTE': '1', 15:54:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:54:12 INFO - 'NO_EM_RESTART': '1', 15:54:12 INFO - 'PAGER': '/bin/cat', 15:54:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:12 INFO - 'PWD': '/builds/slave/test', 15:54:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:54:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:54:12 INFO - 'SHELL': '/bin/bash', 15:54:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XCBYJsWvYi/Listeners', 15:54:12 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 15:54:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:54:12 INFO - 'USER': 'cltbld', 15:54:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:54:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:12 INFO - 'XPC_FLAGS': '0x0', 15:54:12 INFO - 'XPC_SERVICE_NAME': '0', 15:54:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:54:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0257', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:54:12 INFO - mozversion application_buildid: 20160805133321 15:54:12 INFO - mozversion application_changeset: 43f25602dac0aed6aafd8cfc9f9d45b2d047e791 15:54:12 INFO - mozversion application_display_name: Nightly 15:54:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:54:12 INFO - mozversion application_name: Firefox 15:54:12 INFO - mozversion application_remotingname: firefox 15:54:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:54:12 INFO - mozversion application_vendor: Mozilla 15:54:12 INFO - mozversion application_version: 51.0a1 15:54:12 INFO - mozversion platform_buildid: 20160805133321 15:54:12 INFO - mozversion platform_changeset: 43f25602dac0aed6aafd8cfc9f9d45b2d047e791 15:54:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:54:12 INFO - mozversion platform_version: 51.0a1 15:54:12 INFO - using testdate: 1470437652 15:54:12 INFO - actual date: 1470437652 15:54:12 INFO - starting webserver on 'localhost:62863' 15:54:12 INFO - SUITE-START | Running 2 tests 15:54:12 INFO - TEST-START | dromaeo_css 15:54:12 INFO - operating with platform_type : mac_ 15:54:12 INFO - Initialising browser for dromaeo_css test... 15:54:12 INFO - TEST-INFO | started process 7627 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/tmp01KJTZ/profile http://localhost:62863/getInfo.html) 15:54:14 INFO - PROCESS | 7627 | __metrics Screen width/height:1600/1200 15:54:14 INFO - PROCESS | 7627 | colorDepth:24 15:54:14 INFO - PROCESS | 7627 | Browser inner width/height: 1024/689 15:54:14 INFO - PROCESS | 7627 | __metrics 15:54:15 INFO - PROCESS | 7627 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:54:15 INFO - PROCESS | 7627 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:54:15 INFO - TEST-INFO | 7627: exit 0 15:54:15 INFO - Browser initialized. 15:54:15 INFO - Running cycle 1/1 for dromaeo_css test... 15:54:15 INFO - TEST-INFO | started process 7629 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/tmp01KJTZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:54:27 INFO - PROCESS | 7629 | RSS: Main: 243490816 15:54:27 INFO - PROCESS | 7629 | 15:55:18 INFO - PROCESS | 7629 | 1470437718982 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:57:31 INFO - PROCESS | 7629 | Cycle 1(1): loaded http://localhost:62863/tests/dromaeo/cssquery-dojo.html (next: http://localhost:62863/tests/dromaeo/cssquery-ext.html) 15:57:32 INFO - PROCESS | 7629 | RSS: Main: 369754112 15:57:32 INFO - PROCESS | 7629 | 16:00:35 INFO - PROCESS | 7629 | Cycle 1(1): loaded http://localhost:62863/tests/dromaeo/cssquery-ext.html (next: http://localhost:62863/tests/dromaeo/cssquery-jquery.html) 16:00:36 INFO - PROCESS | 7629 | RSS: Main: 391507968 16:00:36 INFO - PROCESS | 7629 | 16:03:38 INFO - PROCESS | 7629 | Cycle 1(1): loaded http://localhost:62863/tests/dromaeo/cssquery-jquery.html (next: http://localhost:62863/tests/dromaeo/cssquery-mootools.html) 16:03:38 INFO - PROCESS | 7629 | RSS: Main: 382013440 16:03:38 INFO - PROCESS | 7629 | 16:06:41 INFO - PROCESS | 7629 | Cycle 1(1): loaded http://localhost:62863/tests/dromaeo/cssquery-mootools.html (next: http://localhost:62863/tests/dromaeo/cssquery-prototype.html) 16:06:41 INFO - PROCESS | 7629 | RSS: Main: 374202368 16:06:41 INFO - PROCESS | 7629 | 16:09:45 INFO - PROCESS | 7629 | Cycle 1(1): loaded http://localhost:62863/tests/dromaeo/cssquery-prototype.html (next: http://localhost:62863/tests/dromaeo/cssquery-yui.html) 16:09:45 INFO - PROCESS | 7629 | RSS: Main: 352436224 16:09:45 INFO - PROCESS | 7629 | 16:12:49 INFO - PROCESS | 7629 | Cycle 1(1): loaded http://localhost:62863/tests/dromaeo/cssquery-yui.html (next: http://localhost:62863/tests/dromaeo/cssquery-dojo.html) 16:12:49 INFO - PROCESS | 7629 | RSS: Main: 468885504 16:12:49 INFO - PROCESS | 7629 | 16:12:49 INFO - PROCESS | 7629 | __start_tp_report 16:12:49 INFO - PROCESS | 7629 | _x_x_mozilla_page_load 16:12:49 INFO - PROCESS | 7629 | _x_x_mozilla_page_load_details 16:12:49 INFO - PROCESS | 7629 | |i|pagename|runs| 16:12:49 INFO - PROCESS | 7629 | |0;dojo.html;3273.1980664737143;3293.901182964511;3298.505224216369;3321.385543674422;3366.797992120473;4684.953150468495;5585.8603534911645;5719.113537401699;5730.942690573093;5771.826845194646;5706.800261990821;5733.913991290134;5759.193712880189;5764.510016648579;5765.942340576593;5186.533212010918;5223.686578805265;5259.552938000255;5264.2893209416625;5322.840314790543;4563.520830312803;5256.132738098209;5289.20661900716;5298.0993231150605;5311.442298558653;5179.404368497614;5199.714015729133;5211.921821172686;5211.973940130313;5255.947440525584;5252.606054545924;5265.052290587692;5269.051570717269;5270.6574072685535;5329.0674132027125;5047.570956468705;5061.645684802065;5123.974380128113;5196.636235463519;5200.739963001834;5656.462636049569;5666.433356664301;5670.291213598301;5733.31200255972;5800.129980502916;6216.96891515544;6223.3776622337855;6256.343083976162;6274.027525733519;6278.152449419361;6116.822755456492;6190.3190649028575;6237.469815065725;6247.219097612799;6256.655883926383;5734.311882574076;5784.566157538202;5804;5808.883822323614;5831.88336233273;6235.064740288993;6243.937560624336;6243.937560624336;6257.9687101564205;6263.279722831841;5189.740512974412;6030.758769649253;6098.573099883054;6154.138420621117;6164.660943648053;6144.556029333103;6209.441150296495;6217.222847144107;6244.1570387997945;6248.781292654826;6200.224971878515;6213.347598502182;6222.844428889314;6224.657643829632;6260.060990851318;5626.127950167731;5955.868385006835;6085.269767627913;6170.50635949123;6249.7187626556915;4189.560096189917;4868.561829435368;4885.316055752198;4915.90168196634;4916.852494425173;4380.123975204971;4403.295472724349;4403.779811009436;4408.823647054146;4432.091421258634;5392.056390131711;5600.60795744294;5631.324241091095;5671.943280567141;5688.089905615165;6048.60684055535;6189.907151392733;6227.626342419469;6272.529560282997;6280.968595157086;5644.717764111778;5657.264555607745;5663;5674.744636491368;5706.28671416073;5427.213054107211;5429.321334833146;5445.673259604437;5446.101393270066;5454.672719636835;6127.525510585499;6203.410675985774;6266.27937787142;6276.843078923063;6346.238451385863;6265.937340626718;6266.655333956676;6267.059941008885;6279.843003924939;6286.245650521967;5505.174223866452;6270;6324.367563243639;6325.177726895474;6343.5876668016435;5970.880582388415;6122.001753127661;6132.540059495466;6139.492138333381;6166.044263139221;6212.192414986023;6251.906221406592;6252.499800016079;6254.687265636791;6289.182406287154;6124.112003759519;6144.969275153596;6146.5390095742105;6146.969265153645;6153.846153846011;5910;6035.969820150871;6074.36219196978;6095.878082438415;6128.111423843428;5055.545000949932;6011.128386383863;6012.699365031818;6013.849653758691;6070.878582428415;5752.9712351437975;6106.786262480792;6124.14262003311;6127.754889804358;6163.19878415803;4975.776090076028;5781.797637082682;5867.237259156283;5867.911981320198;5982.4316689914385 16:12:49 INFO - PROCESS | 7629 | |1;ext.html;466.288909413145;524.845170674651;529.2061907139293;537.2371232849353;538.2921458282358;31247;31532.369352612935;32988.50517242243;33005.50491742626;33029.50455743166;33744.49383259253;33942.8302858486;34446.82776586113;34576;37267;9507.714768556954;9882.456464894429;9926.702198934043;9941.502924853765;9964.202863770917;9753.561089750943;9791.902080979171;9834.950825245864;9838.360506567085;9856.162226210781;9849.55676994537;9876.753081172956;9878.308518403715;9880.752981175492;9894.208463322917;9012.41419307743;9757.512124393752;9854.113129818315;9854.260930430246;9891.752706182331;8499;9345.252379809599;9825.656102036395;9827.017298270188;9867.358621689567;40663;40958.79520602408;40974.77075687734;40975.7951210245;41224.96937576555;3478.826058697055;3640.8361623726732;3694.501242332278;3955.4317548746344;4353.62994145498;27683;31737.841310793297;31885.521717174262;33150;33157.33685326304;3274.787138835968;3306.8842590509216;3311.3708395404797;3399.201187720884;3417.043227896193;488709;488834;488987;489608;492782;33534.66465335364;58303.708481457325;58549;58630.706846465495;58644.41355586475;34271.314573708885;35414.46878296827;35641.46537801935;35658.28683426317;35709.46435803465;14862.405503779728;14989.950703450653;15013.924930375497;15021.399144034334;15029.323680434407;12630.179038362478;12653.87346126527;12737.93631031839;12772.297523636104;12788.232706037668;7833.412494062854;7857.1357150713375;7863.37093032556;7927.0883848357025;7943.563104029218;3306.2891478332276;3325.4014277430297;3328.301056778104;3329.8335083245743;3353.178471274505;974.1135566634329;979.1579241852002;1068.8183008888507;1070.9303895246785;1092.639428988432;30879.845600771852;31099.844500777803;31206.53190202149;31775.046748597117;31859.52210716841;1061.9575216991234;1065.733566608348;1082.0802318029612;1087.6954452753241;1176.6293617510457;15824.76262856058;16692.415765448393;16695.666086678197;16826.663466730595;17255.65488690219;678320;687665;691522;693454;698431;60850.695746520985;61447.15658530251;61506.692466538276;61528.38471615316;62116;1342.1142046249429;1388.8611138886233;1414.151509094535;1414.745345837759;1417.666848290651;30310.393792124476;30721.078367649006;31172.220694482818;31250.12499250052;32018.839905800323;52370.73814630903;53282.66793330198;53291.73354133205;53316.933661325784;53379;624816;629522;632389;634977;636420;26304.73695263023;26443;26720.064797731986;26879.328016799736;26893.731062689123;45733.54266457293;46322.53677463182;47133.05733885235;47335;47514.76242618903;38760;38821.61178388293;39255.6074439252;39437.83891348735;40229.79885100556;38598.80700596479;39075.023124422114;39445;39922.401163983144;40125.39811902765;32542;34832.30335393328;37720.868373948826;38359.84920452391;38541.2291754169;33460.163495911824;35730.64269357377;35981.28037439289;36559.40606318738;36594.8170259147;24039.038438462267;24113;25998.870005650606;26070.34824129336;26629.7337026635 16:12:49 INFO - PROCESS | 7629 | |2;jquery.html;362.61562743491885;372.9515163028806;374.44768965775484;384.8518320446628;406.10453949042363;15547.922260388696;16075.678486430279;20804.687929681066;21066.946652667382;21188.682169767464;20675.379738607866;20895.268665596668;20940.685889711665;21262.830544320055;21552.568948621018;5793.551612096976;5836.533077353812;5934.792282270121;6005.579609427342;6096.39036096389;3953.3872249801184;5922.466977971982;5993.640381577097;6034.396560343953;6036.275646922375;5663.5186009189065;6565.671716414184;6609.603423794588;6691.230508491537;6696.46428285736;5774;6077.118817771443;6137.048757442603;6637.966810165966;6656.966715166442;5948.494377977877;5948.494377977877;5956.821295361146;5965.970170149121;5968.194293770329;13334;13359.599212023655;13573.524926627619;13718.314084295846;13723.862761372358;2271.2845453682203;2348.248560460653;2397.091661403338;2564.4999225151105;2901.448724742292;9766.609335626566;9918.107370336704;10009.799804003951;10098.596056157818;10302.948485257526;1733.965320693579;1815.1650240889207;1815.4190658989128;1882.8681992260547;1884.1332986826076;113660;116466.36833939412;125233;126564;127449;11095;11421.257618254953;11500.367479788692;11533.653990380302;11696.590619328283;14550.199739014244;14562;14572.198529081003;14589.416423342947;14597;8260.504369737835;8516.318694504425;8566.871496927552;8605.139486051345;8728.603423452218;8534.359923005799;8561.957190214009;8567.228949394459;8713.91286087131;8749.300055995505;4396.07682386696;4473.776311184428;4478.798454069574;4575.2450845610765;4600.2869555218995;1896.943091707251;1901.153916904059;1904.5809921817179;1923.9230430782611;1954.09134752338;737.8388174717883;858.9871151932726;882.1266945723687;913.7806926337631;917.2249449215535;20494.590108197754;20997.79002209989;21651.67522487164;21663.783362166178;21719.1284497206;853.5262929074423;941.924646028316;943.6555657185078;961.1733908838394;970.5777986575862;9025.32310076747;10846.566137354575;11350.3757293348;11352.829707554394;11355.489002994886;525011;527407.7259227436;531017;554085;609101;117860;122260;123313.36806423464;133975.33012334877;137191.31404343114;930.7114794413753;972.0668158567713;989.8564708117427;991.2070343724992;993.6472552243994;18519;19255;19335.4199374019;19350;19370.8062919369;49853.50146498489;54599.727001364736;54724.452755473525;55389;56032.71983640056;37681;46145.84635384008;75580.62209688916;81261.59369203117;84110.15889841269;7693;7750;8315.501069935823;8354.916450835413;8423.70517031901;9330.346875718906;12449.875501244871;12938.417771200508;13188.538401155913;13748.587542373745;9945.950270248602;11181.72045698864;11519;11915.582954596548;12082.516699331929;10089;11700.414979251174;11830.881691182978;11858.288502689866;12010.939945300217;10468.964000439788;11482.36846973391;11983.520659173884;12012.339321337411;12060.75878482443;7226.963865180641;7733.651985660771;8240.62917168717;8681.6093275804;8715.52064636451;9646.662366817127;10215.897841021495;11168.832467513157;11385.373804440504;11921 16:12:49 INFO - PROCESS | 7629 | |3;mootools.html;1520.1411202670488;1533.5782659768565;1715.2967283413802;1861.5532272254663;1881.717742338649;8349.332053435719;8910.77723056924;8916.554172291384;8921.910780892189;8926.06276340983;6901.378875901168;7743.922560774405;8384.66461341547;8607.354448416378;8732.607032683529;2148.34475484977;2326.9645007971376;2328.4877326988035;2366.503034362786;2367.360812580602;2339.578875802355;2340.0639744102323;2369.8815059247054;2370.5851475991717;2378.4053986503372;2336.614458614335;2353.5528249632603;2359.8702071386065;2363.1847012780563;2369.087901158058;2063.13348393675;2287.348105789842;2321.6401457774073;2333.381653861728;2342.5314937012668;2331.4754180309465;2337.322176568793;2337.7545357737363;2338.777816107467;2343.0510643189536;8704.521251331174;8764.912350876537;8787.340949428819;8791.032986371494;8801.383903126783;4963.478834722338;5106.9489305106845;5270.235815806686;5280.155175171954;5282.735863206863;3436.27838153988;3489.110276879405;3634.83643236055;3637.1452708613456;3654.1363904408677;1059.1950117910367;1095.7863216672752;1097.6322931817851;1111.0500522053608;1114.6823155400673;11415.828762568484;11520.423978801111;11546.59586914454;11547.884521154681;11551.653450396501;4398.604125628709;4405.801738921757;4568;4570.154521413549;4772.236442169236;9782.315237933419;9784.119429251401;9792.902070979342;9801.31390802637;9856.45789481571;5252.763625636855;5267.288915996368;5270.947290527122;5276.129438642658;5278.577713782965;4307.956920430755;4495.685302028826;4677.766111694402;4782.784774685148;4839.975800120977;3812.885613431546;3868.284367391985;3922.4508568800393;3972.960270397317;3976.4035394691027;1084;1262.5002495059832;1273.19152338264;1278.284160869916;1287.575100216926;835.7701632051235;883.9248663863515;903.2954295649404;923.7782932096248;951.8619800128943;5576.33084029919;5585.413531579125;5865.208196893364;5881.117832325185;5998.220231369894;855.6534603485599;904.841652710773;941.651588912107;953.0659953245857;992.270681049428;3972.3644216925154;3990.022444501116;4007.3988901664984;4078.2659121357847;4089.079957009649;9892.208623310118;10517.84223236652;10639.734006649896;10640.627578034731;10643.627473038407;10043.397396156253;10617.416042117758;10625.937406259312;10630;10646.414447205323;7861.2531809478005;8216.46592971455;8218.013838339437;8229.177082291842;8256.091829898827;5651.463111004448;5880.764769409176;6037.939620603738;6088.939110608837;6099.9390006099375;7981.561014144278;9891.060349266809;9892.604295828087;9932.652357167464;9935.65225217114;7984.520928744294;9857.507124643882;9886.060824221688;10058.949705251427;10072.647457338959;6866.210385805696;7077.221505634273;7184.209736929038;7414.518056326321;7570.091589009354;8012.959935200287;8063.435559511013;8208.138145494637;8212.384071194803;8214.3428525719;7229.963850180716;7376.815579610338;7379.114506259283;7470.92529074724;7487.2138425464545;7164.176119746087;7182.676779545038;7217.24218957002;7217.322371405989;7278.344948954619;6797.422219111431;6834.214065382345;6877.793666190022;6903.654817259217;6913.343232392915;4862.516932335671;4888.193448081169;4918.704877707349;4948.8762780930765;5013.972135712097;4330.588594083557;4833.830815921426;4912.557869791736;4973.055119527278;5094.0823561495 16:12:49 INFO - PROCESS | 7629 | |4;prototype.html;300.9503431933731;301.75105537931205;315.93997140543297;319.80332095761116;320.911749268951;4492.955070449295;4562.475315338737;5288.43510897215;5386.91919621206;5448.673079615221;5010.674306170096;5068.417132029817;5201.531862132408;5283.524482796547;5378.193271009351;3118.750499960009;3978.5822488638782;4089.3865920111925;4096.262672718909;4110.835566577333;3582.6417358264093;4081.9386209963927;4130.339145736682;4135.441715368417;4146.543880173193;3873.32216862048;4046.2918989176924;4091.9974606221517;4095.849678918562;4135.77253251071;3924.097457584757;4051.8379264829373;4052.358794688156;4058.7564746115327;4096.651784598298;3498.3353162898966;3501.509788629594;3501.5973163086314;3501.9824900875587;3502.789832610026;4905.705657660516;5191.896162076738;5205.661631993946;5261.447548007481;5280.551153151987;3619.6742293193474;4363.170997510463;4627.768611569408;4649.976750116228;4685.1332503486965;4787.832425865078;5072.949270507284;5204.661696989721;5339.492748188916;5640.407757185519;3303.8182899940493;3513.4554144107706;3622.5109610202812;3828.587989566583;3834.194819087995;4700.529947005306;4923.679960802572;4966.981768737436;5890.587658863881;5958.97020514899;2982.388610334876;3145.025042236914;3574.1779390740276;3863.8068096595057;3879.398693202558;3942.4677668514955;3943.9745666127014;3949.308870947573;3964.7621142731527;3975.900602484961;3773.6792372648633;4466.598006179394;4551.47658019332;4640.280756482751;4650.5349465053905;4298.011457364761;5443.401225865152;5634.802781902614;5670.659760414388;5724.370319264877;1279.9168054076456;1323.1862404621088;1349.3725417680826;1350.419319692522;1355.7152997870558;782.4327362662025;850.6214734443114;875.4309698695898;875.6121547347399;878.508035500122;4808.855734327975;4988;5052.292679024939;5204.375474943031;5283.128283833202;4980.783551319701;5130.769115389817;5738.159610992586;5844.824655260349;5851.736671849777;4644.628429725613;4690.835820746326;5050.343455350854;5244.265802787613;5252.763625636855;2475.7895578875637;2584.37974886026;2681.785457163422;3021.1389753920025;3030.4393687167944;4850.3864620857685;5742.569307301969;5853.619514731528;6045.425684559959;6059.6364218147055;5198.8960220796125;5410.675359478444;5657.57568182388;5906.940930590639;5973.641581505037;5327.733613319241;5347.41178470368;5998.25021872266;6028.5478589106;6050.576459647782;5598.552115830642;5775.6823374714795;5781.797637082682;5784.537237020944;5810.186573879745;4849.442314133778;5269.973650131725;5377.758000890048;5692.573057020657;5736.885262294647;5992.614172992246;6008.7296071676;6023.66869822164;6055.6063855849225;6084.847878803065;3298.8185649788534;3624.800635965047;3859.5842679229645;3865.594112618247;3894;5801.506871915934;5850.912236316543;5856.267966504187;5865.384134665798;5872.647641141545;4952.801887924443;5457.9727101365825;5601.395351161729;5627.662340259598;5671.971640141773;5152.484751524968;5596.384397716167;5596.580256480699;5625.578081643811;5720.2849643794525;4564.726116433025;4793.3851285226165;5189.76646050921;5607.41122182165;5691.857703557279;5713.457221563945;5733.31200255972;5737.368889422244;5748;5759.193712880116;5294.391145018218;5498.395176530658;5562.694051827189;5569.498745112959;5598.916016259678 16:12:49 INFO - PROCESS | 7629 | |5;yui.html;713.4934196720328;736.9484136110472;742.0575868646815;762.9122650895146;770.4683768199942;15491.845081549181;16486.75269870953;16487.505374838744;16501.17494125292;16528.008319500823;14764.704705905902;14847.554573362817;14860.554183374488;14945.476908308212;14953.850461495382;712.6187489693016;725.4196642685856;857.3869683176558;863.5164307987532;881.7531091294447;864.4985908173276;872.415481627308;875.1904488348252;875.5315905990296;881.352206128495;938.366602543284;941.3269512298705;942.6135284533343;943.075785729985;944.6032666280145;744.7728442824937;911.6763548940163;941.2893265584509;944.8015916657511;945.2626950978214;705.7882635209468;705.8764716174649;706.7243774927782;707.536563550875;709.0675761373777;14404.63988400288;14438.855611443856;14444.566663000021;14495.565133046026;14676.266186690622;13688.247146406944;13861.23763193024;14093.365798538987;14138.50515231962;14458.566243012727;10901.890981090168;12283.93858030713;12715.30065846378;12771.233725976379;13313.800292995516;4516.525764794682;4561.087782443491;4663.300504924255;4680.953190468086;4728.172569800271;109222.45388773085;111274.44362778215;111450;111620;111873.44063279712;11096.889031109748;11178.888211117785;11185.384803835705;11188.104951603853;11669.649910502698;21917.232896848534;21959;21986.560268794536;22025;22031.33905982823;7823.765287041398;7932.286094251545;8044.718434854752;8084.8383032339025;8145.755627331071;4359.651227901761;4399.978000110043;4453.1316393303;4511.548845115462;4529.886752831139;3407.8807241746917;3556.395412779834;3559.0212691509523;3589.838457269429;3594.478800573902;653.3433898931638;656.697918957285;661.9933800662028;670.6881300195432;672.2537982839045;503.305438494882;631.4884943196026;635.4154178156015;643.2795269298322;657.3393739291981;7237.819054523574;8782.2096011358;9158.404703694372;9216.493092879957;9427.717168484956;500.624531601299;556.9136783798517;564.3453593831136;631.7599312261311;637.7417146055762;4386;4497.628223391897;4508.850243187966;4564.2012647786505;4649.442066951988;124205;128261;131937.76435649412;133395.3330233362;133833;112301;133076;136801;138770;141516.58483415033;99190.99999999856;115950.42024789822;116898.92775707014;120256.79743202456;126938.36530817472;8688.478691278544;8697.826043479221;8740.994785599483;8872.250165750396;8891.73324800257;56513.15230271631;66067;66394.66802665955;66931;70705.29294706987;72131;88099.1190088091;102736;105536.47231763792;108277;13137.671558211121;13308.600741977756;13475.056746027683;13731.862681373059;13864.653383665085;15228.923855380652;15868.920655396649;16050.438234661731;16127.919360403122;16162;13579.762867820571;14286;14372;14516.98381113312;14698.55904322872;14036.368363423466;14279.42882284697;14417.207053611732;14601.743551045754;14685.516445470505;13701.862981370059;14029.3686784097;14040.227787471787;14188.787168192692;14193.858061419254;10199.235057370579;11333.433328333715;11397.259178153394;11447.542098315975;11456.427178640868;10290.794184116425;11445.942770286096;11668.88331116712;11676.88323116792;11703.824442633537 16:12:49 INFO - PROCESS | 7629 | __end_tp_report 16:12:49 INFO - PROCESS | 7629 | __start_cc_report 16:12:49 INFO - PROCESS | 7629 | _x_x_mozilla_cycle_collect,1232 16:12:49 INFO - PROCESS | 7629 | __end_cc_report 16:12:49 INFO - PROCESS | 7629 | __startTimestamp1470438769572__endTimestamp 16:12:49 INFO - PROCESS | 7629 | 16:12:49 INFO - PROCESS | 7629 | ------- Summary: start ------- 16:12:49 INFO - PROCESS | 7629 | Number of tests: 6 16:12:49 INFO - PROCESS | 7629 | 16:12:49 INFO - PROCESS | 7629 | [#0] dojo.html Cycles:165 Average:5697.87 Median:5867.24 stddev:658.48 (11.2%) stddev-sans-first:632.43 16:12:49 INFO - PROCESS | 7629 | Values: 3273.2 3293.9 3298.5 3321.4 3366.8 4685.0 5585.9 5719.1 5730.9 5771.8 5706.8 5733.9 5759.2 5764.5 5765.9 5186.5 5223.7 5259.6 5264.3 5322.8 4563.5 5256.1 5289.2 5298.1 5311.4 5179.4 5199.7 5211.9 5212.0 5255.9 5252.6 5265.1 5269.1 5270.7 5329.1 5047.6 5061.6 5124.0 5196.6 5200.7 5656.5 5666.4 5670.3 5733.3 5800.1 6217.0 6223.4 6256.3 6274.0 6278.2 6116.8 6190.3 6237.5 6247.2 6256.7 5734.3 5784.6 5804.0 5808.9 5831.9 6235.1 6243.9 6243.9 6258.0 6263.3 5189.7 6030.8 6098.6 6154.1 6164.7 6144.6 6209.4 6217.2 6244.2 6248.8 6200.2 6213.3 6222.8 6224.7 6260.1 5626.1 5955.9 6085.3 6170.5 6249.7 4189.6 4868.6 4885.3 4915.9 4916.9 4380.1 4403.3 4403.8 4408.8 4432.1 5392.1 5600.6 5631.3 5671.9 5688.1 6048.6 6189.9 6227.6 6272.5 6281.0 5644.7 5657.3 5663.0 5674.7 5706.3 5427.2 5429.3 5445.7 5446.1 5454.7 6127.5 6203.4 6266.3 6276.8 6346.2 6265.9 6266.7 6267.1 6279.8 6286.2 5505.2 6270.0 6324.4 6325.2 6343.6 5970.9 6122.0 6132.5 6139.5 6166.0 6212.2 6251.9 6252.5 6254.7 6289.2 6124.1 6145.0 6146.5 6147.0 6153.8 5910.0 6036.0 6074.4 6095.9 6128.1 5055.5 6011.1 6012.7 6013.8 6070.9 5753.0 6106.8 6124.1 6127.8 6163.2 4975.8 5781.8 5867.2 5867.9 5982.4 16:12:49 INFO - PROCESS | 7629 | 16:12:49 INFO - PROCESS | 7629 | [#1] ext.html Cycles:180 Average:71721.29 Median:38450.54 stddev:163571.46 (425.4%) stddev-sans-first:163942.83 16:12:49 INFO - PROCESS | 7629 | Values: 466.3 524.8 529.2 537.2 538.3 31247.0 31532.4 32988.5 33005.5 33029.5 33744.5 33942.8 34446.8 34576.0 37267.0 9507.7 9882.5 9926.7 9941.5 9964.2 9753.6 9791.9 9835.0 9838.4 9856.2 9849.6 9876.8 9878.3 9880.8 9894.2 9012.4 9757.5 9854.1 9854.3 9891.8 8499.0 9345.3 9825.7 9827.0 9867.4 40663.0 40958.8 40974.8 40975.8 41225.0 3478.8 3640.8 3694.5 3955.4 4353.6 27683.0 31737.8 31885.5 33150.0 33157.3 3274.8 3306.9 3311.4 3399.2 3417.0 488709.0 488834.0 488987.0 489608.0 492782.0 33534.7 58303.7 58549.0 58630.7 58644.4 34271.3 35414.5 35641.5 35658.3 35709.5 14862.4 14990.0 15013.9 15021.4 15029.3 12630.2 12653.9 12737.9 12772.3 12788.2 7833.4 7857.1 7863.4 7927.1 7943.6 3306.3 3325.4 3328.3 3329.8 3353.2 974.1 979.2 1068.8 1070.9 1092.6 30879.8 31099.8 31206.5 31775.0 31859.5 1062.0 1065.7 1082.1 1087.7 1176.6 15824.8 16692.4 16695.7 16826.7 17255.7 678320.0 687665.0 691522.0 693454.0 698431.0 60850.7 61447.2 61506.7 61528.4 62116.0 1342.1 1388.9 1414.2 1414.7 1417.7 30310.4 30721.1 31172.2 31250.1 32018.8 52370.7 53282.7 53291.7 53316.9 53379.0 624816.0 629522.0 632389.0 634977.0 636420.0 26304.7 26443.0 26720.1 26879.3 26893.7 45733.5 46322.5 47133.1 47335.0 47514.8 38760.0 38821.6 39255.6 39437.8 40229.8 38598.8 39075.0 39445.0 39922.4 40125.4 32542.0 34832.3 37720.9 38359.8 38541.2 33460.2 35730.6 35981.3 36559.4 36594.8 24039.0 24113.0 25998.9 26070.3 26629.7 16:12:49 INFO - PROCESS | 7629 | 16:12:49 INFO - PROCESS | 7629 | [#2] jquery.html Cycles:180 Average:33142.51 Median:373.70 stddev:92351.20 (24712.7%) stddev-sans-first:92577.47 16:12:49 INFO - PROCESS | 7629 | Values: 362.6 373.0 374.4 384.9 406.1 15547.9 16075.7 20804.7 21066.9 21188.7 20675.4 20895.3 20940.7 21262.8 21552.6 5793.6 5836.5 5934.8 6005.6 6096.4 3953.4 5922.5 5993.6 6034.4 6036.3 5663.5 6565.7 6609.6 6691.2 6696.5 5774.0 6077.1 6137.0 6638.0 6657.0 5948.5 5948.5 5956.8 5966.0 5968.2 13334.0 13359.6 13573.5 13718.3 13723.9 2271.3 2348.2 2397.1 2564.5 2901.4 9766.6 9918.1 10009.8 10098.6 10302.9 1734.0 1815.2 1815.4 1882.9 1884.1 113660.0 116466.4 125233.0 126564.0 127449.0 11095.0 11421.3 11500.4 11533.7 11696.6 14550.2 14562.0 14572.2 14589.4 14597.0 8260.5 8516.3 8566.9 8605.1 8728.6 8534.4 8562.0 8567.2 8713.9 8749.3 4396.1 4473.8 4478.8 4575.2 4600.3 1896.9 1901.2 1904.6 1923.9 1954.1 737.8 859.0 882.1 913.8 917.2 20494.6 20997.8 21651.7 21663.8 21719.1 853.5 941.9 943.7 961.2 970.6 9025.3 10846.6 11350.4 11352.8 11355.5 525011.0 527407.7 531017.0 554085.0 609101.0 117860.0 122260.0 123313.4 133975.3 137191.3 930.7 972.1 989.9 991.2 993.6 18519.0 19255.0 19335.4 19350.0 19370.8 49853.5 54599.7 54724.5 55389.0 56032.7 37681.0 46145.8 75580.6 81261.6 84110.2 7693.0 7750.0 8315.5 8354.9 8423.7 9330.3 12449.9 12938.4 13188.5 13748.6 9946.0 11181.7 11519.0 11915.6 12082.5 10089.0 11700.4 11830.9 11858.3 12010.9 10469.0 11482.4 11983.5 12012.3 12060.8 7227.0 7733.7 8240.6 8681.6 8715.5 9646.7 10215.9 11168.8 11385.4 11921.0 16:12:49 INFO - PROCESS | 7629 | 16:12:49 INFO - PROCESS | 7629 | [#3] mootools.html Cycles:180 Average:5614.98 Median:5054.03 stddev:3119.77 (61.7%) stddev-sans-first:3113.35 16:12:49 INFO - PROCESS | 7629 | Values: 1520.1 1533.6 1715.3 1861.6 1881.7 8349.3 8910.8 8916.6 8921.9 8926.1 6901.4 7743.9 8384.7 8607.4 8732.6 2148.3 2327.0 2328.5 2366.5 2367.4 2339.6 2340.1 2369.9 2370.6 2378.4 2336.6 2353.6 2359.9 2363.2 2369.1 2063.1 2287.3 2321.6 2333.4 2342.5 2331.5 2337.3 2337.8 2338.8 2343.1 8704.5 8764.9 8787.3 8791.0 8801.4 4963.5 5106.9 5270.2 5280.2 5282.7 3436.3 3489.1 3634.8 3637.1 3654.1 1059.2 1095.8 1097.6 1111.1 1114.7 11415.8 11520.4 11546.6 11547.9 11551.7 4398.6 4405.8 4568.0 4570.2 4772.2 9782.3 9784.1 9792.9 9801.3 9856.5 5252.8 5267.3 5270.9 5276.1 5278.6 4308.0 4495.7 4677.8 4782.8 4840.0 3812.9 3868.3 3922.5 3973.0 3976.4 1084.0 1262.5 1273.2 1278.3 1287.6 835.8 883.9 903.3 923.8 951.9 5576.3 5585.4 5865.2 5881.1 5998.2 855.7 904.8 941.7 953.1 992.3 3972.4 3990.0 4007.4 4078.3 4089.1 9892.2 10517.8 10639.7 10640.6 10643.6 10043.4 10617.4 10625.9 10630.0 10646.4 7861.3 8216.5 8218.0 8229.2 8256.1 5651.5 5880.8 6037.9 6088.9 6099.9 7981.6 9891.1 9892.6 9932.7 9935.7 7984.5 9857.5 9886.1 10058.9 10072.6 6866.2 7077.2 7184.2 7414.5 7570.1 8013.0 8063.4 8208.1 8212.4 8214.3 7230.0 7376.8 7379.1 7470.9 7487.2 7164.2 7182.7 7217.2 7217.3 7278.3 6797.4 6834.2 6877.8 6903.7 6913.3 4862.5 4888.2 4918.7 4948.9 5014.0 4330.6 4833.8 4912.6 4973.1 5094.1 16:12:49 INFO - PROCESS | 7629 | 16:12:49 INFO - PROCESS | 7629 | [#4] prototype.html Cycles:180 Average:4517.61 Median:5060.35 stddev:1416.22 (28.0%) stddev-sans-first:1384.38 16:12:49 INFO - PROCESS | 7629 | Values: 301.0 301.8 315.9 319.8 320.9 4493.0 4562.5 5288.4 5386.9 5448.7 5010.7 5068.4 5201.5 5283.5 5378.2 3118.8 3978.6 4089.4 4096.3 4110.8 3582.6 4081.9 4130.3 4135.4 4146.5 3873.3 4046.3 4092.0 4095.8 4135.8 3924.1 4051.8 4052.4 4058.8 4096.7 3498.3 3501.5 3501.6 3502.0 3502.8 4905.7 5191.9 5205.7 5261.4 5280.6 3619.7 4363.2 4627.8 4650.0 4685.1 4787.8 5072.9 5204.7 5339.5 5640.4 3303.8 3513.5 3622.5 3828.6 3834.2 4700.5 4923.7 4967.0 5890.6 5959.0 2982.4 3145.0 3574.2 3863.8 3879.4 3942.5 3944.0 3949.3 3964.8 3975.9 3773.7 4466.6 4551.5 4640.3 4650.5 4298.0 5443.4 5634.8 5670.7 5724.4 1279.9 1323.2 1349.4 1350.4 1355.7 782.4 850.6 875.4 875.6 878.5 4808.9 4988.0 5052.3 5204.4 5283.1 4980.8 5130.8 5738.2 5844.8 5851.7 4644.6 4690.8 5050.3 5244.3 5252.8 2475.8 2584.4 2681.8 3021.1 3030.4 4850.4 5742.6 5853.6 6045.4 6059.6 5198.9 5410.7 5657.6 5906.9 5973.6 5327.7 5347.4 5998.3 6028.5 6050.6 5598.6 5775.7 5781.8 5784.5 5810.2 4849.4 5270.0 5377.8 5692.6 5736.9 5992.6 6008.7 6023.7 6055.6 6084.8 3298.8 3624.8 3859.6 3865.6 3894.0 5801.5 5850.9 5856.3 5865.4 5872.6 4952.8 5458.0 5601.4 5627.7 5672.0 5152.5 5596.4 5596.6 5625.6 5720.3 4564.7 4793.4 5189.8 5607.4 5691.9 5713.5 5733.3 5737.4 5748.0 5759.2 5294.4 5498.4 5562.7 5569.5 5598.9 16:12:49 INFO - PROCESS | 7629 | 16:12:49 INFO - PROCESS | 7629 | [#5] yui.html Cycles:180 Average:24998.71 Median:22028.17 stddev:39135.63 (177.7%) stddev-sans-first:39202.93 16:12:49 INFO - PROCESS | 7629 | Values: 713.5 736.9 742.1 762.9 770.5 15491.8 16486.8 16487.5 16501.2 16528.0 14764.7 14847.6 14860.6 14945.5 14953.9 712.6 725.4 857.4 863.5 881.8 864.5 872.4 875.2 875.5 881.4 938.4 941.3 942.6 943.1 944.6 744.8 911.7 941.3 944.8 945.3 705.8 705.9 706.7 707.5 709.1 14404.6 14438.9 14444.6 14495.6 14676.3 13688.2 13861.2 14093.4 14138.5 14458.6 10901.9 12283.9 12715.3 12771.2 13313.8 4516.5 4561.1 4663.3 4681.0 4728.2 109222.5 111274.4 111450.0 111620.0 111873.4 11096.9 11178.9 11185.4 11188.1 11669.6 21917.2 21959.0 21986.6 22025.0 22031.3 7823.8 7932.3 8044.7 8084.8 8145.8 4359.7 4400.0 4453.1 4511.5 4529.9 3407.9 3556.4 3559.0 3589.8 3594.5 653.3 656.7 662.0 670.7 672.3 503.3 631.5 635.4 643.3 657.3 7237.8 8782.2 9158.4 9216.5 9427.7 500.6 556.9 564.3 631.8 637.7 4386.0 4497.6 4508.9 4564.2 4649.4 124205.0 128261.0 131937.8 133395.3 133833.0 112301.0 133076.0 136801.0 138770.0 141516.6 99191.0 115950.4 116898.9 120256.8 126938.4 8688.5 8697.8 8741.0 8872.3 8891.7 56513.2 66067.0 66394.7 66931.0 70705.3 72131.0 88099.1 102736.0 105536.5 108277.0 13137.7 13308.6 13475.1 13731.9 13864.7 15228.9 15868.9 16050.4 16127.9 16162.0 13579.8 14286.0 14372.0 14517.0 14698.6 14036.4 14279.4 14417.2 14601.7 14685.5 13701.9 14029.4 14040.2 14188.8 14193.9 10199.2 11333.4 11397.3 11447.5 11456.4 10290.8 11445.9 11668.9 11676.9 11703.8 16:12:49 INFO - PROCESS | 7629 | -------- Summary: end -------- 16:12:49 INFO - PROCESS | 7629 | 16:12:50 INFO - TEST-INFO | 7629: exit 0 16:12:50 INFO - TEST-OK | dromaeo_css | took 1117417ms 16:12:50 INFO - TEST-START | kraken 16:12:50 INFO - operating with platform_type : mac_ 16:12:50 INFO - Initialising browser for kraken test... 16:12:50 INFO - TEST-INFO | started process 7631 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/tmpcx7e1n/profile http://localhost:62863/getInfo.html) 16:12:52 INFO - PROCESS | 7631 | __metrics Screen width/height:1600/1200 16:12:52 INFO - PROCESS | 7631 | colorDepth:24 16:12:52 INFO - PROCESS | 7631 | Browser inner width/height: 1024/689 16:12:52 INFO - PROCESS | 7631 | __metrics 16:12:52 INFO - PROCESS | 7631 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:12:52 INFO - PROCESS | 7631 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:12:53 INFO - TEST-INFO | 7631: exit 0 16:12:53 INFO - Browser initialized. 16:12:53 INFO - Running cycle 1/1 for kraken test... 16:12:53 INFO - TEST-INFO | started process 7632 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/tmpcx7e1n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:13:05 INFO - PROCESS | 7632 | RSS: Main: 243597312 16:13:05 INFO - PROCESS | 7632 | 16:13:08 INFO - PROCESS | 7632 | Cycle 1(1): loaded http://localhost:62863/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:62863/tests/kraken/driver.html?testName=audio-beat-detection) 16:13:09 INFO - PROCESS | 7632 | RSS: Main: 294780928 16:13:09 INFO - PROCESS | 7632 | 16:13:11 INFO - PROCESS | 7632 | Cycle 1(1): loaded http://localhost:62863/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:62863/tests/kraken/driver.html?testName=audio-dft) 16:13:12 INFO - PROCESS | 7632 | RSS: Main: 302505984 16:13:12 INFO - PROCESS | 7632 | 16:13:15 INFO - PROCESS | 7632 | Cycle 1(1): loaded http://localhost:62863/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:62863/tests/kraken/driver.html?testName=audio-fft) 16:13:16 INFO - PROCESS | 7632 | RSS: Main: 397656064 16:13:16 INFO - PROCESS | 7632 | 16:13:18 INFO - PROCESS | 7632 | Cycle 1(1): loaded http://localhost:62863/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:62863/tests/kraken/driver.html?testName=audio-oscillator) 16:13:19 INFO - PROCESS | 7632 | RSS: Main: 299036672 16:13:19 INFO - PROCESS | 7632 | 16:13:21 INFO - PROCESS | 7632 | Cycle 1(1): loaded http://localhost:62863/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:62863/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:13:21 INFO - PROCESS | 7632 | RSS: Main: 303169536 16:13:21 INFO - PROCESS | 7632 | 16:13:24 INFO - PROCESS | 7632 | Cycle 1(1): loaded http://localhost:62863/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:62863/tests/kraken/driver.html?testName=imaging-darkroom) 16:13:25 INFO - PROCESS | 7632 | RSS: Main: 342425600 16:13:25 INFO - PROCESS | 7632 | 16:13:28 INFO - PROCESS | 7632 | Cycle 1(1): loaded http://localhost:62863/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:62863/tests/kraken/driver.html?testName=imaging-desaturate) 16:13:28 INFO - PROCESS | 7632 | RSS: Main: 341528576 16:13:28 INFO - PROCESS | 7632 | 16:13:31 INFO - PROCESS | 7632 | Cycle 1(1): loaded http://localhost:62863/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:62863/tests/kraken/driver.html?testName=json-parse-financial) 16:13:32 INFO - PROCESS | 7632 | RSS: Main: 341372928 16:13:32 INFO - PROCESS | 7632 | 16:13:33 INFO - PROCESS | 7632 | Cycle 1(1): loaded http://localhost:62863/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:62863/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:13:34 INFO - PROCESS | 7632 | RSS: Main: 314511360 16:13:34 INFO - PROCESS | 7632 | 16:13:36 INFO - PROCESS | 7632 | Cycle 1(1): loaded http://localhost:62863/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:62863/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:13:36 INFO - PROCESS | 7632 | RSS: Main: 321347584 16:13:36 INFO - PROCESS | 7632 | 16:13:39 INFO - PROCESS | 7632 | Cycle 1(1): loaded http://localhost:62863/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:62863/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:13:39 INFO - PROCESS | 7632 | RSS: Main: 320724992 16:13:39 INFO - PROCESS | 7632 | 16:13:42 INFO - PROCESS | 7632 | Cycle 1(1): loaded http://localhost:62863/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:62863/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:13:43 INFO - PROCESS | 7632 | RSS: Main: 330866688 16:13:43 INFO - PROCESS | 7632 | 16:13:46 INFO - PROCESS | 7632 | Cycle 1(1): loaded http://localhost:62863/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:62863/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:13:47 INFO - PROCESS | 7632 | RSS: Main: 332476416 16:13:47 INFO - PROCESS | 7632 | 16:13:48 INFO - PROCESS | 7632 | Cycle 1(1): loaded http://localhost:62863/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:62863/tests/kraken/driver.html?testName=ai-astar) 16:13:48 INFO - PROCESS | 7632 | RSS: Main: 375988224 16:13:48 INFO - PROCESS | 7632 | 16:13:48 INFO - PROCESS | 7632 | __start_tp_report 16:13:48 INFO - PROCESS | 7632 | _x_x_mozilla_page_load 16:13:48 INFO - PROCESS | 7632 | _x_x_mozilla_page_load_details 16:13:48 INFO - PROCESS | 7632 | |i|pagename|runs| 16:13:48 INFO - PROCESS | 7632 | |0;ai-astar;100;112;116;140;114;112;113;112;111;112 16:13:48 INFO - PROCESS | 7632 | |1;audio-beat-detection;158;126;130;205;133;133;131;107;158;103 16:13:48 INFO - PROCESS | 7632 | |2;audio-dft;188;185;184;184;186;183;184;181;183;185 16:13:48 INFO - PROCESS | 7632 | |3;audio-fft;78;58;57;109;56;76;80;64;84;58 16:13:48 INFO - PROCESS | 7632 | |4;audio-oscillator;87;67;95;71;76;67;95;68;68;99 16:13:48 INFO - PROCESS | 7632 | |5;imaging-gaussian-blur;87;84;86;83;87;83;87;83;86;83 16:13:48 INFO - PROCESS | 7632 | |6;imaging-darkroom;93;92;93;112;148;94;93;92;92;107 16:13:48 INFO - PROCESS | 7632 | |7;imaging-desaturate;87;86;85;86;86;85;87;85;85;91 16:13:48 INFO - PROCESS | 7632 | |8;json-parse-financial;54;52;49;52;52;52;52;52;51;53 16:13:48 INFO - PROCESS | 7632 | |9;json-stringify-tinderbox;67;72;70;83;78;74;71;71;72;73 16:13:48 INFO - PROCESS | 7632 | |10;stanford-crypto-aes;85;82;95;71;82;99;98;97;83;83 16:13:48 INFO - PROCESS | 7632 | |11;stanford-crypto-ccm;144;129;152;144;140;135;135;137;134;139 16:13:48 INFO - PROCESS | 7632 | |12;stanford-crypto-pbkdf2;164;163;160;162;224;222;161;163;162;159 16:13:48 INFO - PROCESS | 7632 | |13;stanford-crypto-sha256-iterative;66;67;66;67;64;68;67;65;65;65 16:13:48 INFO - PROCESS | 7632 | __end_tp_report 16:13:48 INFO - PROCESS | 7632 | __start_cc_report 16:13:48 INFO - PROCESS | 7632 | _x_x_mozilla_cycle_collect,2112 16:13:48 INFO - PROCESS | 7632 | __end_cc_report 16:13:48 INFO - PROCESS | 7632 | __startTimestamp1470438828936__endTimestamp 16:13:48 INFO - PROCESS | 7632 | 16:13:48 INFO - PROCESS | 7632 | ------- Summary: start ------- 16:13:48 INFO - PROCESS | 7632 | Number of tests: 14 16:13:48 INFO - PROCESS | 7632 | 16:13:48 INFO - PROCESS | 7632 | [#0] ai-astar Cycles:10 Average:114.20 Median:112.50 stddev:10.01 (8.9%) stddev-sans-first:9.20 16:13:48 INFO - PROCESS | 7632 | Values: 100.0 112.0 116.0 140.0 114.0 112.0 113.0 112.0 111.0 112.0 16:13:48 INFO - PROCESS | 7632 | 16:13:48 INFO - PROCESS | 7632 | [#1] audio-beat-detection Cycles:10 Average:138.40 Median:133.00 stddev:29.40 (22.1%) stddev-sans-first:30.32 16:13:48 INFO - PROCESS | 7632 | Values: 158.0 126.0 130.0 205.0 133.0 133.0 131.0 107.0 158.0 103.0 16:13:48 INFO - PROCESS | 7632 | 16:13:48 INFO - PROCESS | 7632 | [#2] audio-dft Cycles:10 Average:184.30 Median:184.50 stddev:1.89 (1.0%) stddev-sans-first:1.45 16:13:48 INFO - PROCESS | 7632 | Values: 188.0 185.0 184.0 184.0 186.0 183.0 184.0 181.0 183.0 185.0 16:13:48 INFO - PROCESS | 7632 | 16:13:48 INFO - PROCESS | 7632 | [#3] audio-fft Cycles:10 Average:72.00 Median:70.00 stddev:16.89 (24.1%) stddev-sans-first:17.77 16:13:48 INFO - PROCESS | 7632 | Values: 78.0 58.0 57.0 109.0 56.0 76.0 80.0 64.0 84.0 58.0 16:13:48 INFO - PROCESS | 7632 | 16:13:48 INFO - PROCESS | 7632 | [#4] audio-oscillator Cycles:10 Average:79.30 Median:81.50 stddev:13.24 (16.2%) stddev-sans-first:13.75 16:13:48 INFO - PROCESS | 7632 | Values: 87.0 67.0 95.0 71.0 76.0 67.0 95.0 68.0 68.0 99.0 16:13:48 INFO - PROCESS | 7632 | 16:13:48 INFO - PROCESS | 7632 | [#5] imaging-gaussian-blur Cycles:10 Average:84.90 Median:86.00 stddev:1.85 (2.2%) stddev-sans-first:1.80 16:13:48 INFO - PROCESS | 7632 | Values: 87.0 84.0 86.0 83.0 87.0 83.0 87.0 83.0 86.0 83.0 16:13:48 INFO - PROCESS | 7632 | 16:13:48 INFO - PROCESS | 7632 | [#6] imaging-darkroom Cycles:10 Average:101.60 Median:92.50 stddev:17.78 (19.2%) stddev-sans-first:18.59 16:13:48 INFO - PROCESS | 7632 | Values: 93.0 92.0 93.0 112.0 148.0 94.0 93.0 92.0 92.0 107.0 16:13:48 INFO - PROCESS | 7632 | 16:13:48 INFO - PROCESS | 7632 | [#7] imaging-desaturate Cycles:10 Average:86.30 Median:86.00 stddev:1.83 (2.1%) stddev-sans-first:1.92 16:13:48 INFO - PROCESS | 7632 | Values: 87.0 86.0 85.0 86.0 86.0 85.0 87.0 85.0 85.0 91.0 16:13:48 INFO - PROCESS | 7632 | 16:13:48 INFO - PROCESS | 7632 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:1.29 (2.5%) stddev-sans-first:1.12 16:13:48 INFO - PROCESS | 7632 | Values: 54.0 52.0 49.0 52.0 52.0 52.0 52.0 52.0 51.0 53.0 16:13:48 INFO - PROCESS | 7632 | 16:13:48 INFO - PROCESS | 7632 | [#9] json-stringify-tinderbox Cycles:10 Average:73.10 Median:72.50 stddev:4.48 (6.2%) stddev-sans-first:4.18 16:13:48 INFO - PROCESS | 7632 | Values: 67.0 72.0 70.0 83.0 78.0 74.0 71.0 71.0 72.0 73.0 16:13:48 INFO - PROCESS | 7632 | 16:13:48 INFO - PROCESS | 7632 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:90.00 stddev:9.24 (10.3%) stddev-sans-first:9.76 16:13:48 INFO - PROCESS | 7632 | Values: 85.0 82.0 95.0 71.0 82.0 99.0 98.0 97.0 83.0 83.0 16:13:48 INFO - PROCESS | 7632 | 16:13:48 INFO - PROCESS | 7632 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:139.50 stddev:6.51 (4.7%) stddev-sans-first:6.63 16:13:48 INFO - PROCESS | 7632 | Values: 144.0 129.0 152.0 144.0 140.0 135.0 135.0 137.0 134.0 139.0 16:13:48 INFO - PROCESS | 7632 | 16:13:48 INFO - PROCESS | 7632 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.00 Median:163.00 stddev:25.87 (15.9%) stddev-sans-first:27.19 16:13:48 INFO - PROCESS | 7632 | Values: 164.0 163.0 160.0 162.0 224.0 222.0 161.0 163.0 162.0 159.0 16:13:48 INFO - PROCESS | 7632 | 16:13:48 INFO - PROCESS | 7632 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.50 stddev:1.25 (1.9%) stddev-sans-first:1.32 16:13:48 INFO - PROCESS | 7632 | Values: 66.0 67.0 66.0 67.0 64.0 68.0 67.0 65.0 65.0 65.0 16:13:48 INFO - PROCESS | 7632 | -------- Summary: end -------- 16:13:48 INFO - PROCESS | 7632 | 16:13:49 INFO - TEST-INFO | 7632: exit 0 16:13:49 INFO - TEST-OK | kraken | took 59602ms 16:13:49 INFO - SUITE-END | took 1177s 16:13:50 INFO - Completed test suite (00:19:37) 16:13:50 INFO - javascript benchmark 16:13:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3273.1980664737143, 3293.901182964511, 3298.505224216369, 3321.385543674422, 3366.797992120473, 4684.953150468495, 5585.8603534911645, 5719.113537401699, 5730.942690573093, 5771.826845194646, 5706.800261990821, 5733.913991290134, 5759.193712880189, 5764.510016648579, 5765.942340576593, 5186.533212010918, 5223.686578805265, 5259.552938000255, 5264.2893209416625, 5322.840314790543, 4563.520830312803, 5256.132738098209, 5289.20661900716, 5298.0993231150605, 5311.442298558653, 5179.404368497614, 5199.714015729133, 5211.921821172686, 5211.973940130313, 5255.947440525584, 5252.606054545924, 5265.052290587692, 5269.051570717269, 5270.6574072685535, 5329.0674132027125, 5047.570956468705, 5061.645684802065, 5123.974380128113, 5196.636235463519, 5200.739963001834, 5656.462636049569, 5666.433356664301, 5670.291213598301, 5733.31200255972, 5800.129980502916, 6216.96891515544, 6223.3776622337855, 6256.343083976162, 6274.027525733519, 6278.152449419361, 6116.822755456492, 6190.3190649028575, 6237.469815065725, 6247.219097612799, 6256.655883926383, 5734.311882574076, 5784.566157538202, 5804.0, 5808.883822323614, 5831.88336233273, 6235.064740288993, 6243.937560624336, 6243.937560624336, 6257.9687101564205, 6263.279722831841, 5189.740512974412, 6030.758769649253, 6098.573099883054, 6154.138420621117, 6164.660943648053, 6144.556029333103, 6209.441150296495, 6217.222847144107, 6244.1570387997945, 6248.781292654826, 6200.224971878515, 6213.347598502182, 6222.844428889314, 6224.657643829632, 6260.060990851318, 5626.127950167731, 5955.868385006835, 6085.269767627913, 6170.50635949123, 6249.7187626556915, 4189.560096189917, 4868.561829435368, 4885.316055752198, 4915.90168196634, 4916.852494425173, 4380.123975204971, 4403.295472724349, 4403.779811009436, 4408.823647054146, 4432.091421258634, 5392.056390131711, 5600.60795744294, 5631.324241091095, 5671.943280567141, 5688.089905615165, 6048.60684055535, 6189.907151392733, 6227.626342419469, 6272.529560282997, 6280.968595157086, 5644.717764111778, 5657.264555607745, 5663.0, 5674.744636491368, 5706.28671416073, 5427.213054107211, 5429.321334833146, 5445.673259604437, 5446.101393270066, 5454.672719636835, 6127.525510585499, 6203.410675985774, 6266.27937787142, 6276.843078923063, 6346.238451385863, 6265.937340626718, 6266.655333956676, 6267.059941008885, 6279.843003924939, 6286.245650521967, 5505.174223866452, 6270.0, 6324.367563243639, 6325.177726895474, 6343.5876668016435, 5970.880582388415, 6122.001753127661, 6132.540059495466, 6139.492138333381, 6166.044263139221, 6212.192414986023, 6251.906221406592, 6252.499800016079, 6254.687265636791, 6289.182406287154, 6124.112003759519, 6144.969275153596, 6146.5390095742105, 6146.969265153645, 6153.846153846011, 5910.0, 6035.969820150871, 6074.36219196978, 6095.878082438415, 6128.111423843428, 5055.545000949932, 6011.128386383863, 6012.699365031818, 6013.849653758691, 6070.878582428415, 5752.9712351437975, 6106.786262480792, 6124.14262003311, 6127.754889804358, 6163.19878415803, 4975.776090076028, 5781.797637082682, 5867.237259156283, 5867.911981320198, 5982.4316689914385], "value": 5655.785434219627, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.288909413145, 524.845170674651, 529.2061907139293, 537.2371232849353, 538.2921458282358, 31247.0, 31532.369352612935, 32988.50517242243, 33005.50491742626, 33029.50455743166, 33744.49383259253, 33942.8302858486, 34446.82776586113, 34576.0, 37267.0, 9507.714768556954, 9882.456464894429, 9926.702198934043, 9941.502924853765, 9964.202863770917, 9753.561089750943, 9791.902080979171, 9834.950825245864, 9838.360506567085, 9856.162226210781, 9849.55676994537, 9876.753081172956, 9878.308518403715, 9880.752981175492, 9894.208463322917, 9012.41419307743, 9757.512124393752, 9854.113129818315, 9854.260930430246, 9891.752706182331, 8499.0, 9345.252379809599, 9825.656102036395, 9827.017298270188, 9867.358621689567, 40663.0, 40958.79520602408, 40974.77075687734, 40975.7951210245, 41224.96937576555, 3478.826058697055, 3640.8361623726732, 3694.501242332278, 3955.4317548746344, 4353.62994145498, 27683.0, 31737.841310793297, 31885.521717174262, 33150.0, 33157.33685326304, 3274.787138835968, 3306.8842590509216, 3311.3708395404797, 3399.201187720884, 3417.043227896193, 488709.0, 488834.0, 488987.0, 489608.0, 492782.0, 33534.66465335364, 58303.708481457325, 58549.0, 58630.706846465495, 58644.41355586475, 34271.314573708885, 35414.46878296827, 35641.46537801935, 35658.28683426317, 35709.46435803465, 14862.405503779728, 14989.950703450653, 15013.924930375497, 15021.399144034334, 15029.323680434407, 12630.179038362478, 12653.87346126527, 12737.93631031839, 12772.297523636104, 12788.232706037668, 7833.412494062854, 7857.1357150713375, 7863.37093032556, 7927.0883848357025, 7943.563104029218, 3306.2891478332276, 3325.4014277430297, 3328.301056778104, 3329.8335083245743, 3353.178471274505, 974.1135566634329, 979.1579241852002, 1068.8183008888507, 1070.9303895246785, 1092.639428988432, 30879.845600771852, 31099.844500777803, 31206.53190202149, 31775.046748597117, 31859.52210716841, 1061.9575216991234, 1065.733566608348, 1082.0802318029612, 1087.6954452753241, 1176.6293617510457, 15824.76262856058, 16692.415765448393, 16695.666086678197, 16826.663466730595, 17255.65488690219, 678320.0, 687665.0, 691522.0, 693454.0, 698431.0, 60850.695746520985, 61447.15658530251, 61506.692466538276, 61528.38471615316, 62116.0, 1342.1142046249429, 1388.8611138886233, 1414.151509094535, 1414.745345837759, 1417.666848290651, 30310.393792124476, 30721.078367649006, 31172.220694482818, 31250.12499250052, 32018.839905800323, 52370.73814630903, 53282.66793330198, 53291.73354133205, 53316.933661325784, 53379.0, 624816.0, 629522.0, 632389.0, 634977.0, 636420.0, 26304.73695263023, 26443.0, 26720.064797731986, 26879.328016799736, 26893.731062689123, 45733.54266457293, 46322.53677463182, 47133.05733885235, 47335.0, 47514.76242618903, 38760.0, 38821.61178388293, 39255.6074439252, 39437.83891348735, 40229.79885100556, 38598.80700596479, 39075.023124422114, 39445.0, 39922.401163983144, 40125.39811902765, 32542.0, 34832.30335393328, 37720.868373948826, 38359.84920452391, 38541.2291754169, 33460.163495911824, 35730.64269357377, 35981.28037439289, 36559.40606318738, 36594.8170259147, 24039.038438462267, 24113.0, 25998.870005650606, 26070.34824129336, 26629.7337026635], "value": 18911.459784320923, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.61562743491885, 372.9515163028806, 374.44768965775484, 384.8518320446628, 406.10453949042363, 15547.922260388696, 16075.678486430279, 20804.687929681066, 21066.946652667382, 21188.682169767464, 20675.379738607866, 20895.268665596668, 20940.685889711665, 21262.830544320055, 21552.568948621018, 5793.551612096976, 5836.533077353812, 5934.792282270121, 6005.579609427342, 6096.39036096389, 3953.3872249801184, 5922.466977971982, 5993.640381577097, 6034.396560343953, 6036.275646922375, 5663.5186009189065, 6565.671716414184, 6609.603423794588, 6691.230508491537, 6696.46428285736, 5774.0, 6077.118817771443, 6137.048757442603, 6637.966810165966, 6656.966715166442, 5948.494377977877, 5948.494377977877, 5956.821295361146, 5965.970170149121, 5968.194293770329, 13334.0, 13359.599212023655, 13573.524926627619, 13718.314084295846, 13723.862761372358, 2271.2845453682203, 2348.248560460653, 2397.091661403338, 2564.4999225151105, 2901.448724742292, 9766.609335626566, 9918.107370336704, 10009.799804003951, 10098.596056157818, 10302.948485257526, 1733.965320693579, 1815.1650240889207, 1815.4190658989128, 1882.8681992260547, 1884.1332986826076, 113660.0, 116466.36833939412, 125233.0, 126564.0, 127449.0, 11095.0, 11421.257618254953, 11500.367479788692, 11533.653990380302, 11696.590619328283, 14550.199739014244, 14562.0, 14572.198529081003, 14589.416423342947, 14597.0, 8260.504369737835, 8516.318694504425, 8566.871496927552, 8605.139486051345, 8728.603423452218, 8534.359923005799, 8561.957190214009, 8567.228949394459, 8713.91286087131, 8749.300055995505, 4396.07682386696, 4473.776311184428, 4478.798454069574, 4575.2450845610765, 4600.2869555218995, 1896.943091707251, 1901.153916904059, 1904.5809921817179, 1923.9230430782611, 1954.09134752338, 737.8388174717883, 858.9871151932726, 882.1266945723687, 913.7806926337631, 917.2249449215535, 20494.590108197754, 20997.79002209989, 21651.67522487164, 21663.783362166178, 21719.1284497206, 853.5262929074423, 941.924646028316, 943.6555657185078, 961.1733908838394, 970.5777986575862, 9025.32310076747, 10846.566137354575, 11350.3757293348, 11352.829707554394, 11355.489002994886, 525011.0, 527407.7259227436, 531017.0, 554085.0, 609101.0, 117860.0, 122260.0, 123313.36806423464, 133975.33012334877, 137191.31404343114, 930.7114794413753, 972.0668158567713, 989.8564708117427, 991.2070343724992, 993.6472552243994, 18519.0, 19255.0, 19335.4199374019, 19350.0, 19370.8062919369, 49853.50146498489, 54599.727001364736, 54724.452755473525, 55389.0, 56032.71983640056, 37681.0, 46145.84635384008, 75580.62209688916, 81261.59369203117, 84110.15889841269, 7693.0, 7750.0, 8315.501069935823, 8354.916450835413, 8423.70517031901, 9330.346875718906, 12449.875501244871, 12938.417771200508, 13188.538401155913, 13748.587542373745, 9945.950270248602, 11181.72045698864, 11519.0, 11915.582954596548, 12082.516699331929, 10089.0, 11700.414979251174, 11830.881691182978, 11858.288502689866, 12010.939945300217, 10468.964000439788, 11482.36846973391, 11983.520659173884, 12012.339321337411, 12060.75878482443, 7226.963865180641, 7733.651985660771, 8240.62917168717, 8681.6093275804, 8715.52064636451, 9646.662366817127, 10215.897841021495, 11168.832467513157, 11385.373804440504, 11921.0], "value": 9404.954318894583, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1520.1411202670488, 1533.5782659768565, 1715.2967283413802, 1861.5532272254663, 1881.717742338649, 8349.332053435719, 8910.77723056924, 8916.554172291384, 8921.910780892189, 8926.06276340983, 6901.378875901168, 7743.922560774405, 8384.66461341547, 8607.354448416378, 8732.607032683529, 2148.34475484977, 2326.9645007971376, 2328.4877326988035, 2366.503034362786, 2367.360812580602, 2339.578875802355, 2340.0639744102323, 2369.8815059247054, 2370.5851475991717, 2378.4053986503372, 2336.614458614335, 2353.5528249632603, 2359.8702071386065, 2363.1847012780563, 2369.087901158058, 2063.13348393675, 2287.348105789842, 2321.6401457774073, 2333.381653861728, 2342.5314937012668, 2331.4754180309465, 2337.322176568793, 2337.7545357737363, 2338.777816107467, 2343.0510643189536, 8704.521251331174, 8764.912350876537, 8787.340949428819, 8791.032986371494, 8801.383903126783, 4963.478834722338, 5106.9489305106845, 5270.235815806686, 5280.155175171954, 5282.735863206863, 3436.27838153988, 3489.110276879405, 3634.83643236055, 3637.1452708613456, 3654.1363904408677, 1059.1950117910367, 1095.7863216672752, 1097.6322931817851, 1111.0500522053608, 1114.6823155400673, 11415.828762568484, 11520.423978801111, 11546.59586914454, 11547.884521154681, 11551.653450396501, 4398.604125628709, 4405.801738921757, 4568.0, 4570.154521413549, 4772.236442169236, 9782.315237933419, 9784.119429251401, 9792.902070979342, 9801.31390802637, 9856.45789481571, 5252.763625636855, 5267.288915996368, 5270.947290527122, 5276.129438642658, 5278.577713782965, 4307.956920430755, 4495.685302028826, 4677.766111694402, 4782.784774685148, 4839.975800120977, 3812.885613431546, 3868.284367391985, 3922.4508568800393, 3972.960270397317, 3976.4035394691027, 1084.0, 1262.5002495059832, 1273.19152338264, 1278.284160869916, 1287.575100216926, 835.7701632051235, 883.9248663863515, 903.2954295649404, 923.7782932096248, 951.8619800128943, 5576.33084029919, 5585.413531579125, 5865.208196893364, 5881.117832325185, 5998.220231369894, 855.6534603485599, 904.841652710773, 941.651588912107, 953.0659953245857, 992.270681049428, 3972.3644216925154, 3990.022444501116, 4007.3988901664984, 4078.2659121357847, 4089.079957009649, 9892.208623310118, 10517.84223236652, 10639.734006649896, 10640.627578034731, 10643.627473038407, 10043.397396156253, 10617.416042117758, 10625.937406259312, 10630.0, 10646.414447205323, 7861.2531809478005, 8216.46592971455, 8218.013838339437, 8229.177082291842, 8256.091829898827, 5651.463111004448, 5880.764769409176, 6037.939620603738, 6088.939110608837, 6099.9390006099375, 7981.561014144278, 9891.060349266809, 9892.604295828087, 9932.652357167464, 9935.65225217114, 7984.520928744294, 9857.507124643882, 9886.060824221688, 10058.949705251427, 10072.647457338959, 6866.210385805696, 7077.221505634273, 7184.209736929038, 7414.518056326321, 7570.091589009354, 8012.959935200287, 8063.435559511013, 8208.138145494637, 8212.384071194803, 8214.3428525719, 7229.963850180716, 7376.815579610338, 7379.114506259283, 7470.92529074724, 7487.2138425464545, 7164.176119746087, 7182.676779545038, 7217.24218957002, 7217.322371405989, 7278.344948954619, 6797.422219111431, 6834.214065382345, 6877.793666190022, 6903.654817259217, 6913.343232392915, 4862.516932335671, 4888.193448081169, 4918.704877707349, 4948.8762780930765, 5013.972135712097, 4330.588594083557, 4833.830815921426, 4912.557869791736, 4973.055119527278, 5094.0823561495], "value": 4534.229113246532, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.9503431933731, 301.75105537931205, 315.93997140543297, 319.80332095761116, 320.911749268951, 4492.955070449295, 4562.475315338737, 5288.43510897215, 5386.91919621206, 5448.673079615221, 5010.674306170096, 5068.417132029817, 5201.531862132408, 5283.524482796547, 5378.193271009351, 3118.750499960009, 3978.5822488638782, 4089.3865920111925, 4096.262672718909, 4110.835566577333, 3582.6417358264093, 4081.9386209963927, 4130.339145736682, 4135.441715368417, 4146.543880173193, 3873.32216862048, 4046.2918989176924, 4091.9974606221517, 4095.849678918562, 4135.77253251071, 3924.097457584757, 4051.8379264829373, 4052.358794688156, 4058.7564746115327, 4096.651784598298, 3498.3353162898966, 3501.509788629594, 3501.5973163086314, 3501.9824900875587, 3502.789832610026, 4905.705657660516, 5191.896162076738, 5205.661631993946, 5261.447548007481, 5280.551153151987, 3619.6742293193474, 4363.170997510463, 4627.768611569408, 4649.976750116228, 4685.1332503486965, 4787.832425865078, 5072.949270507284, 5204.661696989721, 5339.492748188916, 5640.407757185519, 3303.8182899940493, 3513.4554144107706, 3622.5109610202812, 3828.587989566583, 3834.194819087995, 4700.529947005306, 4923.679960802572, 4966.981768737436, 5890.587658863881, 5958.97020514899, 2982.388610334876, 3145.025042236914, 3574.1779390740276, 3863.8068096595057, 3879.398693202558, 3942.4677668514955, 3943.9745666127014, 3949.308870947573, 3964.7621142731527, 3975.900602484961, 3773.6792372648633, 4466.598006179394, 4551.47658019332, 4640.280756482751, 4650.5349465053905, 4298.011457364761, 5443.401225865152, 5634.802781902614, 5670.659760414388, 5724.370319264877, 1279.9168054076456, 1323.1862404621088, 1349.3725417680826, 1350.419319692522, 1355.7152997870558, 782.4327362662025, 850.6214734443114, 875.4309698695898, 875.6121547347399, 878.508035500122, 4808.855734327975, 4988.0, 5052.292679024939, 5204.375474943031, 5283.128283833202, 4980.783551319701, 5130.769115389817, 5738.159610992586, 5844.824655260349, 5851.736671849777, 4644.628429725613, 4690.835820746326, 5050.343455350854, 5244.265802787613, 5252.763625636855, 2475.7895578875637, 2584.37974886026, 2681.785457163422, 3021.1389753920025, 3030.4393687167944, 4850.3864620857685, 5742.569307301969, 5853.619514731528, 6045.425684559959, 6059.6364218147055, 5198.8960220796125, 5410.675359478444, 5657.57568182388, 5906.940930590639, 5973.641581505037, 5327.733613319241, 5347.41178470368, 5998.25021872266, 6028.5478589106, 6050.576459647782, 5598.552115830642, 5775.6823374714795, 5781.797637082682, 5784.537237020944, 5810.186573879745, 4849.442314133778, 5269.973650131725, 5377.758000890048, 5692.573057020657, 5736.885262294647, 5992.614172992246, 6008.7296071676, 6023.66869822164, 6055.6063855849225, 6084.847878803065, 3298.8185649788534, 3624.800635965047, 3859.5842679229645, 3865.594112618247, 3894.0, 5801.506871915934, 5850.912236316543, 5856.267966504187, 5865.384134665798, 5872.647641141545, 4952.801887924443, 5457.9727101365825, 5601.395351161729, 5627.662340259598, 5671.971640141773, 5152.484751524968, 5596.384397716167, 5596.580256480699, 5625.578081643811, 5720.2849643794525, 4564.726116433025, 4793.3851285226165, 5189.76646050921, 5607.41122182165, 5691.857703557279, 5713.457221563945, 5733.31200255972, 5737.368889422244, 5748.0, 5759.193712880116, 5294.391145018218, 5498.395176530658, 5562.694051827189, 5569.498745112959, 5598.916016259678], "value": 4068.0028961945613, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.4934196720328, 736.9484136110472, 742.0575868646815, 762.9122650895146, 770.4683768199942, 15491.845081549181, 16486.75269870953, 16487.505374838744, 16501.17494125292, 16528.008319500823, 14764.704705905902, 14847.554573362817, 14860.554183374488, 14945.476908308212, 14953.850461495382, 712.6187489693016, 725.4196642685856, 857.3869683176558, 863.5164307987532, 881.7531091294447, 864.4985908173276, 872.415481627308, 875.1904488348252, 875.5315905990296, 881.352206128495, 938.366602543284, 941.3269512298705, 942.6135284533343, 943.075785729985, 944.6032666280145, 744.7728442824937, 911.6763548940163, 941.2893265584509, 944.8015916657511, 945.2626950978214, 705.7882635209468, 705.8764716174649, 706.7243774927782, 707.536563550875, 709.0675761373777, 14404.63988400288, 14438.855611443856, 14444.566663000021, 14495.565133046026, 14676.266186690622, 13688.247146406944, 13861.23763193024, 14093.365798538987, 14138.50515231962, 14458.566243012727, 10901.890981090168, 12283.93858030713, 12715.30065846378, 12771.233725976379, 13313.800292995516, 4516.525764794682, 4561.087782443491, 4663.300504924255, 4680.953190468086, 4728.172569800271, 109222.45388773085, 111274.44362778215, 111450.0, 111620.0, 111873.44063279712, 11096.889031109748, 11178.888211117785, 11185.384803835705, 11188.104951603853, 11669.649910502698, 21917.232896848534, 21959.0, 21986.560268794536, 22025.0, 22031.33905982823, 7823.765287041398, 7932.286094251545, 8044.718434854752, 8084.8383032339025, 8145.755627331071, 4359.651227901761, 4399.978000110043, 4453.1316393303, 4511.548845115462, 4529.886752831139, 3407.8807241746917, 3556.395412779834, 3559.0212691509523, 3589.838457269429, 3594.478800573902, 653.3433898931638, 656.697918957285, 661.9933800662028, 670.6881300195432, 672.2537982839045, 503.305438494882, 631.4884943196026, 635.4154178156015, 643.2795269298322, 657.3393739291981, 7237.819054523574, 8782.2096011358, 9158.404703694372, 9216.493092879957, 9427.717168484956, 500.624531601299, 556.9136783798517, 564.3453593831136, 631.7599312261311, 637.7417146055762, 4386.0, 4497.628223391897, 4508.850243187966, 4564.2012647786505, 4649.442066951988, 124205.0, 128261.0, 131937.76435649412, 133395.3330233362, 133833.0, 112301.0, 133076.0, 136801.0, 138770.0, 141516.58483415033, 99190.99999999856, 115950.42024789822, 116898.92775707014, 120256.79743202456, 126938.36530817472, 8688.478691278544, 8697.826043479221, 8740.994785599483, 8872.250165750396, 8891.73324800257, 56513.15230271631, 66067.0, 66394.66802665955, 66931.0, 70705.29294706987, 72131.0, 88099.1190088091, 102736.0, 105536.47231763792, 108277.0, 13137.671558211121, 13308.600741977756, 13475.056746027683, 13731.862681373059, 13864.653383665085, 15228.923855380652, 15868.920655396649, 16050.438234661731, 16127.919360403122, 16162.0, 13579.762867820571, 14286.0, 14372.0, 14516.98381113312, 14698.55904322872, 14036.368363423466, 14279.42882284697, 14417.207053611732, 14601.743551045754, 14685.516445470505, 13701.862981370059, 14029.3686784097, 14040.227787471787, 14188.787168192692, 14193.858061419254, 10199.235057370579, 11333.433328333715, 11397.259178153394, 11447.542098315975, 11456.427178640868, 10290.794184116425, 11445.942770286096, 11668.88331116712, 11676.88323116792, 11703.824442633537], "value": 7942.761189206269, "unit": "score"}], "name": "dromaeo_css", "value": 7267.960907061071, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 112.0, 116.0, 140.0, 114.0, 112.0, 113.0, 112.0, 111.0, 112.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 126.0, 130.0, 205.0, 133.0, 133.0, 131.0, 107.0, 158.0, 103.0], "value": 138.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 185.0, 184.0, 184.0, 186.0, 183.0, 184.0, 181.0, 183.0, 185.0], "value": 184.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 58.0, 57.0, 109.0, 56.0, 76.0, 80.0, 64.0, 84.0, 58.0], "value": 72.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 67.0, 95.0, 71.0, 76.0, 67.0, 95.0, 68.0, 68.0, 99.0], "value": 79.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 86.0, 83.0, 87.0, 83.0, 87.0, 83.0, 86.0, 83.0], "value": 84.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 93.0, 112.0, 148.0, 94.0, 93.0, 92.0, 92.0, 107.0], "value": 101.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 85.0, 86.0, 86.0, 85.0, 87.0, 85.0, 85.0, 91.0], "value": 86.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 49.0, 52.0, 52.0, 52.0, 52.0, 52.0, 51.0, 53.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 70.0, 83.0, 78.0, 74.0, 71.0, 71.0, 72.0, 73.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 95.0, 71.0, 82.0, 99.0, 98.0, 97.0, 83.0, 83.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 129.0, 152.0, 144.0, 140.0, 135.0, 135.0, 137.0, 134.0, 139.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 160.0, 162.0, 224.0, 222.0, 161.0, 163.0, 162.0, 159.0], "value": 174.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 67.0, 64.0, 68.0, 67.0, 65.0, 65.0, 65.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1452.4, "alertThreshold": 2.0}]} 16:13:50 INFO - Return code: 0 16:13:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:13:50 INFO - # TBPL SUCCESS # 16:13:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:13:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:13:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:13:50 INFO - 2016-08-05 16:13:50.247 screenresolution[7636:130146] starting screenresolution argv=screenresolution get 16:13:50 INFO - 2016-08-05 16:13:50.250 screenresolution[7636:130146] Display 0: 1600x1200x32@60 16:13:50 INFO - 2016-08-05 16:13:50.256 screenresolution[7637:130149] starting screenresolution argv=screenresolution list 16:13:50 INFO - Available Modes on Display 0 16:13:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:13:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:13:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:13:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:13:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:13:50 INFO - Intel Iris: 16:13:50 INFO - Chipset Model: Intel Iris 16:13:50 INFO - Type: GPU 16:13:50 INFO - Bus: Built-In 16:13:50 INFO - VRAM (Dynamic, Max): 1536 MB 16:13:50 INFO - Vendor: Intel (0x8086) 16:13:50 INFO - Device ID: 0x0a2e 16:13:50 INFO - Revision ID: 0x0009 16:13:50 INFO - Displays: 16:13:50 INFO - Display: 16:13:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:13:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:13:50 INFO - Display Serial Number: 1600x1200 60 16:13:50 INFO - Main Display: Yes 16:13:50 INFO - Mirror: Off 16:13:50 INFO - Online: Yes 16:13:50 INFO - Rotation: Supported 16:13:50 INFO - Return code: 0 16:13:50 INFO - Running post-action listener: _resource_record_post_action 16:13:50 INFO - [mozharness: 2016-08-05 23:13:50.489565Z] Finished run-tests step (success) 16:13:50 INFO - Running post-run listener: _resource_record_post_run 16:13:50 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 827392; Write bytes: 705106944; Read time: 5; Write time: 1935 16:13:50 INFO - TinderboxPrint: CPU usage
53.7% 16:13:50 INFO - TinderboxPrint: I/O read bytes / time
827,392 / 5 16:13:50 INFO - TinderboxPrint: I/O write bytes / time
705,106,944 / 1,935 16:13:50 INFO - TinderboxPrint: CPU idle
2,244.3 (46.3%) 16:13:50 INFO - TinderboxPrint: CPU system
976.6 (20.1%) 16:13:50 INFO - TinderboxPrint: CPU user
1,628.9 (33.6%) 16:13:50 INFO - TinderboxPrint: Swap in / out
406,913,024 / 0 16:13:50 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 402309632; Write bytes: 397076480; Read time: 29804; Write time: 777 16:13:50 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 827392; Write bytes: 294214656; Read time: 5; Write time: 1116 16:13:50 INFO - Running post-run listener: _upload_blobber_files 16:13:50 INFO - Blob upload gear active. 16:13:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:13:50 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:13:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:13:51 INFO - (blobuploader) - INFO - Open directory for files ... 16:13:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:13:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:13:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:52 INFO - (blobuploader) - INFO - Done attempting. 16:13:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:13:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:13:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:53 INFO - (blobuploader) - INFO - Done attempting. 16:13:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:13:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:13:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:55 INFO - (blobuploader) - INFO - Done attempting. 16:13:55 INFO - (blobuploader) - INFO - Iteration through files over. 16:13:55 INFO - Return code: 0 16:13:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:13:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:13:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab9d9fa403baf28987141d9fe99bfff639f6b2303473e78121cdce213ddf869d005cb12b14afcd802f74b403ce3ba1da4603a132dea08fe31ace8efb2080fa9c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d9f30a3608368198d22b562846d3ecc95c788ed7e767e6b3280cd92d3aecb7de5cf16efb0a01c036b2c260411096331480305c784208b38670cd4cd711413f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd651baccd8448b5ad0c96f70da10f22c02dfe6a3552572889daa908f5913011c49f7f75faa4198e5ddd72e5d2b7cc6b0d10ddbd95ab3064ee2b69604252f164"} 16:13:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:13:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:13:55 INFO - Contents: 16:13:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab9d9fa403baf28987141d9fe99bfff639f6b2303473e78121cdce213ddf869d005cb12b14afcd802f74b403ce3ba1da4603a132dea08fe31ace8efb2080fa9c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d9f30a3608368198d22b562846d3ecc95c788ed7e767e6b3280cd92d3aecb7de5cf16efb0a01c036b2c260411096331480305c784208b38670cd4cd711413f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd651baccd8448b5ad0c96f70da10f22c02dfe6a3552572889daa908f5913011c49f7f75faa4198e5ddd72e5d2b7cc6b0d10ddbd95ab3064ee2b69604252f164"} 16:13:55 INFO - Running post-run listener: copy_logs_to_upload_dir 16:13:55 INFO - Copying logs to upload dir... 16:13:55 INFO - mkdir: /builds/slave/test/build/upload/logs 16:13:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.052762 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-05 16:13:55.802235) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 16:13:55.805681) ========= 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.53tJXNR2HA/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.XCBYJsWvYi/Listeners TMPDIR=/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab9d9fa403baf28987141d9fe99bfff639f6b2303473e78121cdce213ddf869d005cb12b14afcd802f74b403ce3ba1da4603a132dea08fe31ace8efb2080fa9c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d9f30a3608368198d22b562846d3ecc95c788ed7e767e6b3280cd92d3aecb7de5cf16efb0a01c036b2c260411096331480305c784208b38670cd4cd711413f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd651baccd8448b5ad0c96f70da10f22c02dfe6a3552572889daa908f5913011c49f7f75faa4198e5ddd72e5d2b7cc6b0d10ddbd95ab3064ee2b69604252f164"} build_url:https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011486 build_url: 'https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab9d9fa403baf28987141d9fe99bfff639f6b2303473e78121cdce213ddf869d005cb12b14afcd802f74b403ce3ba1da4603a132dea08fe31ace8efb2080fa9c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d9f30a3608368198d22b562846d3ecc95c788ed7e767e6b3280cd92d3aecb7de5cf16efb0a01c036b2c260411096331480305c784208b38670cd4cd711413f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd651baccd8448b5ad0c96f70da10f22c02dfe6a3552572889daa908f5913011c49f7f75faa4198e5ddd72e5d2b7cc6b0d10ddbd95ab3064ee2b69604252f164"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 16:13:55.842285) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 16:13:55.842992) ========= 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.53tJXNR2HA/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.XCBYJsWvYi/Listeners TMPDIR=/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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.005451 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 16:13:55.894977) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 16:13:55.895753) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 16:13:55.896523) ========= ========= Total master_lag: 0.19 =========