builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0177 starttime: 1471097239.48 results: success (0) buildid: 20160813044816 builduid: 3fdab888aa854f8eb812eb2ea9c327c5 revision: 6e191a55c3d23e83e6a2e72e4e80c1dc21516493 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-13 07:07:19.477044) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-13 07:07:19.477547) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-13 07:07:19.477888) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-13 07:07:19.638397) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 07:07:19.638762) ========= 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.sBTiOXe6jm/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.lACK6OUpvv/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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-13 07:07:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.30M=0.001s 2016-08-13 07:07:20 (8.30 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.470085 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 07:07:20.134203) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 07:07:20.134887) ========= 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.sBTiOXe6jm/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.lACK6OUpvv/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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.020405 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 07:07:20.185377) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-13 07:07:20.185743) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6e191a55c3d23e83e6a2e72e4e80c1dc21516493 --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 6e191a55c3d23e83e6a2e72e4e80c1dc21516493 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sBTiOXe6jm/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.lACK6OUpvv/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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-13 07:07:20,260 truncating revision to first 12 chars 2016-08-13 07:07:20,261 Setting DEBUG logging. 2016-08-13 07:07:20,261 attempt 1/10 2016-08-13 07:07:20,261 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6e191a55c3d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-13 07:07:21,269 unpacking tar archive at: mozilla-central-6e191a55c3d2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.296255 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-13 07:07:21.504539) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-13 07:07:21.504883) ========= script_repo_revision: 6e191a55c3d23e83e6a2e72e4e80c1dc21516493 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-13 07:07:21.505329) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-13 07:07:21.505646) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-13 07:07:21.524745) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-08-13 07:07:21.525107) ========= /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.sBTiOXe6jm/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.lACK6OUpvv/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 07:07:21 INFO - MultiFileLogger online at 20160813 07:07:21 in /builds/slave/test 07:07:21 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 07:07:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:07:21 INFO - {'append_to_log': False, 07:07:21 INFO - 'base_work_dir': '/builds/slave/test', 07:07:21 INFO - 'blob_upload_branch': 'Firefox', 07:07:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:07:21 INFO - 'branch': 'Firefox', 07:07:21 INFO - 'buildbot_json_path': 'buildprops.json', 07:07:21 INFO - 'config_files': ('talos/mac_config.py',), 07:07:21 INFO - 'default_actions': ('clobber', 07:07:21 INFO - 'read-buildbot-config', 07:07:21 INFO - 'download-and-extract', 07:07:21 INFO - 'populate-webroot', 07:07:21 INFO - 'create-virtualenv', 07:07:21 INFO - 'install', 07:07:21 INFO - 'run-tests'), 07:07:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:07:21 INFO - 'download_minidump_stackwalk': True, 07:07:21 INFO - 'download_symbols': 'ondemand', 07:07:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:07:21 INFO - 'tooltool.py': '/tools/tooltool.py', 07:07:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:07:21 INFO - '/tools/misc-python/virtualenv.py')}, 07:07:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:07:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:07:21 INFO - 'installer_path': 'installer.exe', 07:07:21 INFO - 'log_level': 'info', 07:07:21 INFO - 'log_name': 'talos', 07:07:21 INFO - 'log_to_console': True, 07:07:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:07:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:07:21 INFO - 'opt_config_files': (), 07:07:21 INFO - 'pip_index': False, 07:07:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:07:21 INFO - 'cmd': ('bash', 07:07:21 INFO - '-c', 07:07:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:07:21 INFO - 'enabled': True, 07:07:21 INFO - 'halt_on_failure': False, 07:07:21 INFO - 'name': 'check_screen_resolution'},), 07:07:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:07:21 INFO - 'cmd': ('bash', 07:07:21 INFO - '-c', 07:07:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:07:21 INFO - 'enabled': True, 07:07:21 INFO - 'halt_on_failure': False, 07:07:21 INFO - 'name': 'check_screen_resolution'},), 07:07:21 INFO - 'run_cmd_checks_enabled': True, 07:07:21 INFO - 'sps_profile': False, 07:07:21 INFO - 'sps_profile_interval': 0, 07:07:21 INFO - 'suite': 'dromaeojs', 07:07:21 INFO - 'system_bits': '32', 07:07:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:07:21 INFO - 'title': 't-yosemite-r7-0177', 07:07:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:07:21 INFO - 'use_talos_json': True, 07:07:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:07:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:07:21 INFO - 'work_dir': 'build'} 07:07:21 INFO - [mozharness: 2016-08-13 14:07:21.729366Z] Running clobber step. 07:07:21 INFO - Running pre-action listener: _resource_record_pre_action 07:07:21 INFO - Running main action method: clobber 07:07:21 INFO - rmtree: /builds/slave/test/build 07:07:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:07:23 INFO - Running post-action listener: _resource_record_post_action 07:07:23 INFO - [mozharness: 2016-08-13 14:07:23.978876Z] Finished clobber step (success) 07:07:23 INFO - [mozharness: 2016-08-13 14:07:23.979032Z] Running read-buildbot-config step. 07:07:23 INFO - Running pre-action listener: _resource_record_pre_action 07:07:23 INFO - Running main action method: read_buildbot_config 07:07:23 INFO - Using buildbot properties: 07:07:23 INFO - { 07:07:23 INFO - "project": "", 07:07:23 INFO - "product": "firefox", 07:07:23 INFO - "script_repo_revision": "production", 07:07:23 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 07:07:23 INFO - "repository": "", 07:07:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 07:07:23 INFO - "buildid": "20160813044816", 07:07:23 INFO - "pgo_build": "False", 07:07:23 INFO - "basedir": "/builds/slave/test", 07:07:23 INFO - "buildnumber": 35, 07:07:23 INFO - "slavename": "t-yosemite-r7-0177", 07:07:23 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 07:07:23 INFO - "platform": "yosemite_r7", 07:07:23 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:07:23 INFO - "branch": "mozilla-central", 07:07:23 INFO - "repo_path": "mozilla-central", 07:07:23 INFO - "revision": "6e191a55c3d23e83e6a2e72e4e80c1dc21516493", 07:07:23 INFO - "stage_platform": "macosx64", 07:07:23 INFO - "builduid": "3fdab888aa854f8eb812eb2ea9c327c5", 07:07:23 INFO - "slavebuilddir": "test" 07:07:23 INFO - } 07:07:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 07:07:23 INFO - Running post-action listener: _resource_record_post_action 07:07:23 INFO - [mozharness: 2016-08-13 14:07:23.982295Z] Finished read-buildbot-config step (success) 07:07:23 INFO - [mozharness: 2016-08-13 14:07:23.982415Z] Running download-and-extract step. 07:07:23 INFO - Running pre-action listener: _resource_record_pre_action 07:07:23 INFO - Running main action method: download_and_extract 07:07:23 INFO - mkdir: /builds/slave/test/build/tests 07:07:23 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')]} 07:07:23 INFO - trying https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 07:07:23 INFO - Downloading https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/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 07:07:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/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 07:07:24 INFO - Downloaded 1199 bytes. 07:07:24 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 07:07:24 INFO - Using the following test package requirements: 07:07:24 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 07:07:24 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:07:24 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 07:07:24 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:07:24 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 07:07:24 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:07:24 INFO - u'jsshell-mac.zip'], 07:07:24 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:07:24 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 07:07:24 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 07:07:24 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:07:24 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 07:07:24 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:07:24 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 07:07:24 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:07:24 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 07:07:24 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:07:24 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 07:07:24 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:24 INFO - trying https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 07:07:24 INFO - Downloading https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/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 07:07:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/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 07:07:25 INFO - Downloaded 16330538 bytes. 07:07:25 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 07:07:32 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 07:07: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')]} 07:07:32 INFO - trying https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 07:07:32 INFO - Downloading https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/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 07:07:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/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 07:07:33 INFO - Downloaded 16330538 bytes. 07:07:33 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 07:07:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:40 INFO - trying https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 07:07:40 INFO - Downloading https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/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 07:07:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/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 07:07:43 INFO - Downloaded 14413719 bytes. 07:07:43 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 07:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:43 INFO - trying https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:07:43 INFO - Downloading https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 07:07:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/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 07:07:47 INFO - Downloaded 111051637 bytes. 07:07:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:07:47 INFO - mkdir: /builds/slave/test/properties 07:07:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:07:47 INFO - Writing to file /builds/slave/test/properties/build_url 07:07:47 INFO - Contents: 07:07:47 INFO - build_url:https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:07:48 INFO - Running post-action listener: _resource_record_post_action 07:07:48 INFO - Running post-action listener: set_extra_try_arguments 07:07:48 INFO - [mozharness: 2016-08-13 14:07:48.591244Z] Finished download-and-extract step (success) 07:07:48 INFO - [mozharness: 2016-08-13 14:07:48.591405Z] Running populate-webroot step. 07:07:48 INFO - Running pre-action listener: _resource_record_pre_action 07:07:48 INFO - Running main action method: populate_webroot 07:07:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:07:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:07:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:07:48 INFO - '--tppagecycles', 07:07:48 INFO - '7'], 07:07:48 INFO - 'tests': ['tsvgm']}}, 07:07:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:07:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:07:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:07:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:07:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:07:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:07:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:48 INFO - 'talos_options': ['--disable-e10s'], 07:07:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:07:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:07:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:48 INFO - 'talos_options': ['--disable-e10s'], 07:07:48 INFO - 'tests': ['damp', 'tps']}, 07:07:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:48 INFO - 'tests': ['damp', 'tps']}, 07:07:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:07:48 INFO - 'tests': ['dromaeo_dom']}, 07:07:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:07:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:07:48 INFO - 'tests': ['basic_compositor_video']}, 07:07:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:07:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:07:48 INFO - 'tests': ['a11yr', 07:07:48 INFO - 'ts_paint', 07:07:48 INFO - 'tpaint', 07:07:48 INFO - 'sessionrestore', 07:07:48 INFO - 'sessionrestore_no_auto_restore', 07:07:48 INFO - 'tabpaint']}, 07:07:48 INFO - 'other-e10s': {'tests': ['a11yr', 07:07:48 INFO - 'ts_paint', 07:07:48 INFO - 'tpaint', 07:07:48 INFO - 'sessionrestore', 07:07:48 INFO - 'sessionrestore_no_auto_restore', 07:07:48 INFO - 'tabpaint']}, 07:07:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:07:48 INFO - 'ts_paint', 07:07:48 INFO - 'tpaint', 07:07:48 INFO - 'sessionrestore', 07:07:48 INFO - 'sessionrestore_no_auto_restore', 07:07:48 INFO - 'tabpaint']}, 07:07:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:07:48 INFO - 'ts_paint', 07:07:48 INFO - 'tpaint', 07:07:48 INFO - 'sessionrestore', 07:07:48 INFO - 'sessionrestore_no_auto_restore', 07:07:48 INFO - 'tabpaint']}, 07:07:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:07:48 INFO - 'tests': ['a11yr', 07:07:48 INFO - 'ts_paint', 07:07:48 INFO - 'tpaint', 07:07:48 INFO - 'sessionrestore', 07:07:48 INFO - 'sessionrestore_no_auto_restore', 07:07:48 INFO - 'tabpaint']}, 07:07:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:07:48 INFO - 'tests': ['a11yr', 07:07:48 INFO - 'ts_paint', 07:07:48 INFO - 'tpaint', 07:07:48 INFO - 'sessionrestore', 07:07:48 INFO - 'sessionrestore_no_auto_restore', 07:07:48 INFO - 'tabpaint']}, 07:07:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:07:48 INFO - 'tests': ['tsvgx', 07:07:48 INFO - 'tsvgr_opacity', 07:07:48 INFO - 'tart', 07:07:48 INFO - 'tscrollx', 07:07:48 INFO - 'cart']}, 07:07:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:07:48 INFO - 'tsvgr_opacity', 07:07:48 INFO - 'tart', 07:07:48 INFO - 'tscrollx', 07:07:48 INFO - 'cart']}, 07:07:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:48 INFO - 'talos_options': ['--disable-e10s'], 07:07:48 INFO - 'tests': ['tp5o']}, 07:07:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:48 INFO - 'tests': ['tp5o']}, 07:07:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:48 INFO - 'talos_options': ['--disable-e10s', 07:07:48 INFO - '--xperf_path', 07:07:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:07:48 INFO - 'tests': ['tp5n']}, 07:07:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:48 INFO - 'talos_options': ['--xperf_path', 07:07:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:07:48 INFO - 'tests': ['tp5n']}}, 07:07:48 INFO - 'talos.zip': {'path': '', 07:07:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:07:48 INFO - Running post-action listener: _resource_record_post_action 07:07:48 INFO - [mozharness: 2016-08-13 14:07:48.610319Z] Finished populate-webroot step (success) 07:07:48 INFO - [mozharness: 2016-08-13 14:07:48.610403Z] Running create-virtualenv step. 07:07:48 INFO - Running pre-action listener: _resource_record_pre_action 07:07:48 INFO - Running main action method: create_virtualenv 07:07:48 INFO - Creating virtualenv /builds/slave/test/build/venv 07:07:48 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 07:07:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:07:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:07:48 INFO - Using real prefix '/tools/python27' 07:07:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:07:49 INFO - Installing distribute.............................................................................................................................................................................................done. 07:07:52 INFO - Installing pip.................done. 07:07:52 INFO - Return code: 0 07:07:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102861a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8249d990f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027c5d30>, '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 0x10252adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027bdb20>, '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.sBTiOXe6jm/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.lACK6OUpvv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 07:07:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:07:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sBTiOXe6jm/Render', 07:07:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:07:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:07:52 INFO - 'HOME': '/Users/cltbld', 07:07:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:07:52 INFO - 'LOGNAME': 'cltbld', 07:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:52 INFO - 'MOZ_NO_REMOTE': '1', 07:07:52 INFO - 'NO_EM_RESTART': '1', 07:07:52 INFO - 'PAGER': '/bin/cat', 07:07:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:52 INFO - 'PWD': '/builds/slave/test', 07:07:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:07:52 INFO - 'SHELL': '/bin/bash', 07:07:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lACK6OUpvv/Listeners', 07:07:52 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 07:07:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:07:52 INFO - 'USER': 'cltbld', 07:07:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:07:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:52 INFO - 'XPC_FLAGS': '0x0', 07:07:52 INFO - 'XPC_SERVICE_NAME': '0', 07:07:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:52 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 07:07:52 INFO - Cleaning up... 07:07:52 INFO - Return code: 0 07:07:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102861a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8249d990f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027c5d30>, '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 0x10252adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027bdb20>, '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.sBTiOXe6jm/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.lACK6OUpvv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 07:07:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:07:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sBTiOXe6jm/Render', 07:07:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:07:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:07:52 INFO - 'HOME': '/Users/cltbld', 07:07:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:07:52 INFO - 'LOGNAME': 'cltbld', 07:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:52 INFO - 'MOZ_NO_REMOTE': '1', 07:07:52 INFO - 'NO_EM_RESTART': '1', 07:07:52 INFO - 'PAGER': '/bin/cat', 07:07:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:52 INFO - 'PWD': '/builds/slave/test', 07:07:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:07:52 INFO - 'SHELL': '/bin/bash', 07:07:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lACK6OUpvv/Listeners', 07:07:52 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 07:07:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:07:52 INFO - 'USER': 'cltbld', 07:07:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:07:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:52 INFO - 'XPC_FLAGS': '0x0', 07:07:52 INFO - 'XPC_SERVICE_NAME': '0', 07:07:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:52 INFO - Downloading/unpacking psutil>=3.1.1 07:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:07:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:07:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:07:56 INFO - Installing collected packages: psutil 07:07:56 INFO - Running setup.py install for psutil 07:07:56 INFO - building 'psutil._psutil_osx' extension 07:07:56 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 07:07:56 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 07:07:56 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 07:07:56 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 07:07:56 INFO - building 'psutil._psutil_posix' extension 07:07:56 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 07:07:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:07:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:07:56 INFO - ^ 07:07:56 INFO - 1 warning generated. 07:07:56 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 07:07:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:07:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:07:57 INFO - Successfully installed psutil 07:07:57 INFO - Cleaning up... 07:07:57 INFO - Return code: 0 07:07:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:57 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 0x102861a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8249d990f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027c5d30>, '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 0x10252adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027bdb20>, '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.sBTiOXe6jm/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.lACK6OUpvv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 07:07:57 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 07:07:57 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 07:07:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sBTiOXe6jm/Render', 07:07:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:07:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:07:57 INFO - 'HOME': '/Users/cltbld', 07:07:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:07:57 INFO - 'LOGNAME': 'cltbld', 07:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:57 INFO - 'MOZ_NO_REMOTE': '1', 07:07:57 INFO - 'NO_EM_RESTART': '1', 07:07:57 INFO - 'PAGER': '/bin/cat', 07:07:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:57 INFO - 'PWD': '/builds/slave/test', 07:07:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:07:57 INFO - 'SHELL': '/bin/bash', 07:07:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lACK6OUpvv/Listeners', 07:07:57 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 07:07:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:07:57 INFO - 'USER': 'cltbld', 07:07:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:07:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:57 INFO - 'XPC_FLAGS': '0x0', 07:07:57 INFO - 'XPC_SERVICE_NAME': '0', 07:07:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:07:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:07:59 INFO - Installing collected packages: mozsystemmonitor 07:07:59 INFO - Running setup.py install for mozsystemmonitor 07:08:00 INFO - Successfully installed mozsystemmonitor 07:08:00 INFO - Cleaning up... 07:08:00 INFO - Return code: 0 07:08:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:08:00 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')]} 07:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:00 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')]} 07:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:00 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 0x102861a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8249d990f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027c5d30>, '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 0x10252adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027bdb20>, '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.sBTiOXe6jm/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.lACK6OUpvv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 07:08:00 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 07:08:00 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 07:08:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sBTiOXe6jm/Render', 07:08:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:08:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:08:00 INFO - 'HOME': '/Users/cltbld', 07:08:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:08:00 INFO - 'LOGNAME': 'cltbld', 07:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:00 INFO - 'MOZ_NO_REMOTE': '1', 07:08:00 INFO - 'NO_EM_RESTART': '1', 07:08:00 INFO - 'PAGER': '/bin/cat', 07:08:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:00 INFO - 'PWD': '/builds/slave/test', 07:08:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:08:00 INFO - 'SHELL': '/bin/bash', 07:08:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lACK6OUpvv/Listeners', 07:08:00 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 07:08:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:08:00 INFO - 'USER': 'cltbld', 07:08:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:08:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:00 INFO - 'XPC_FLAGS': '0x0', 07:08:00 INFO - 'XPC_SERVICE_NAME': '0', 07:08:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:00 INFO - Downloading/unpacking jsonschema==2.5.1 07:08:00 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 07:08:00 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 07:08:00 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 07:08:00 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 07:08:00 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 07:08:00 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 07:08:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:08:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:03 INFO - Downloading functools32-3.2.3-2.tar.gz 07:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:08:03 INFO - warning: no files found matching '*.txt' 07:08:03 INFO - no previously-included directories found matching 'build' 07:08:03 INFO - no previously-included directories found matching 'dist' 07:08:03 INFO - no previously-included directories found matching '.git*' 07:08:03 INFO - Installing collected packages: jsonschema, functools32 07:08:03 INFO - Running setup.py install for functools32 07:08:03 INFO - warning: no files found matching '*.txt' 07:08:03 INFO - no previously-included directories found matching 'build' 07:08:03 INFO - no previously-included directories found matching 'dist' 07:08:03 INFO - no previously-included directories found matching '.git*' 07:08:03 INFO - Successfully installed jsonschema functools32 07:08:03 INFO - Cleaning up... 07:08:03 INFO - Return code: 0 07:08:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:08: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')]} 07:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08: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')]} 07:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:03 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 0x102861a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8249d990f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027c5d30>, '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 0x10252adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027bdb20>, '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.sBTiOXe6jm/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.lACK6OUpvv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 07:08:03 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 07:08:03 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 07:08:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sBTiOXe6jm/Render', 07:08:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:08:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:08:03 INFO - 'HOME': '/Users/cltbld', 07:08:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:08:03 INFO - 'LOGNAME': 'cltbld', 07:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:03 INFO - 'MOZ_NO_REMOTE': '1', 07:08:03 INFO - 'NO_EM_RESTART': '1', 07:08:03 INFO - 'PAGER': '/bin/cat', 07:08:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:03 INFO - 'PWD': '/builds/slave/test', 07:08:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:08:03 INFO - 'SHELL': '/bin/bash', 07:08:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lACK6OUpvv/Listeners', 07:08:03 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 07:08:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:08:03 INFO - 'USER': 'cltbld', 07:08:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:08:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:03 INFO - 'XPC_FLAGS': '0x0', 07:08:03 INFO - 'XPC_SERVICE_NAME': '0', 07:08:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:08:03 INFO - Cleaning up... 07:08:03 INFO - Return code: 0 07:08:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:08: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')]} 07:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08: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')]} 07:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:03 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 0x102861a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8249d990f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027c5d30>, '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 0x10252adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027bdb20>, '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.sBTiOXe6jm/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.lACK6OUpvv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 07:08:03 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 07:08:03 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 07:08:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sBTiOXe6jm/Render', 07:08:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:08:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:08:03 INFO - 'HOME': '/Users/cltbld', 07:08:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:08:03 INFO - 'LOGNAME': 'cltbld', 07:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:03 INFO - 'MOZ_NO_REMOTE': '1', 07:08:03 INFO - 'NO_EM_RESTART': '1', 07:08:03 INFO - 'PAGER': '/bin/cat', 07:08:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:03 INFO - 'PWD': '/builds/slave/test', 07:08:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:08:03 INFO - 'SHELL': '/bin/bash', 07:08:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lACK6OUpvv/Listeners', 07:08:03 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 07:08:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:08:03 INFO - 'USER': 'cltbld', 07:08:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:08:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:03 INFO - 'XPC_FLAGS': '0x0', 07:08:03 INFO - 'XPC_SERVICE_NAME': '0', 07:08:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:04 INFO - Downloading/unpacking blobuploader==1.2.4 07:08:04 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 07:08:04 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 07:08:04 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 07:08:04 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 07:08:04 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 07:08:04 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 07:08:06 INFO - Downloading blobuploader-1.2.4.tar.gz 07:08:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:08:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:08:06 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 07:08:06 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 07:08:06 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 07:08:06 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 07:08:06 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 07:08:06 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 07:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:08:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:07 INFO - Downloading docopt-0.6.1.tar.gz 07:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:08:07 INFO - Installing collected packages: blobuploader, requests, docopt 07:08:07 INFO - Running setup.py install for blobuploader 07:08:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:08:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:08:08 INFO - Running setup.py install for requests 07:08:08 INFO - Running setup.py install for docopt 07:08:08 INFO - Successfully installed blobuploader requests docopt 07:08:08 INFO - Cleaning up... 07:08:08 INFO - Return code: 0 07:08:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:08 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 0x102861a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8249d990f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027c5d30>, '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 0x10252adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027bdb20>, '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.sBTiOXe6jm/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.lACK6OUpvv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 07:08:08 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 07:08:08 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 07:08:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sBTiOXe6jm/Render', 07:08:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:08:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:08:08 INFO - 'HOME': '/Users/cltbld', 07:08:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:08:08 INFO - 'LOGNAME': 'cltbld', 07:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:08 INFO - 'MOZ_NO_REMOTE': '1', 07:08:08 INFO - 'NO_EM_RESTART': '1', 07:08:08 INFO - 'PAGER': '/bin/cat', 07:08:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:08 INFO - 'PWD': '/builds/slave/test', 07:08:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:08:08 INFO - 'SHELL': '/bin/bash', 07:08:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lACK6OUpvv/Listeners', 07:08:08 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 07:08:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:08:08 INFO - 'USER': 'cltbld', 07:08:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:08:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:08 INFO - 'XPC_FLAGS': '0x0', 07:08:08 INFO - 'XPC_SERVICE_NAME': '0', 07:08:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:08:09 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-ttxekO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:08:09 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-6dYWRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:08:09 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-zJ17dO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:08:09 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-9MRDv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:08:09 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-fdoU6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:08:09 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-kkSM7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:08:09 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-6hxtV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:08:09 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-0qTGrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:08:09 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-yKsvX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:08:09 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-Ss4BFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:08:10 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-11Ooz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:08:10 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-RILMLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:08:10 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-FRruwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:08:10 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-yx9Djb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:10 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-9rN6e6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:08:10 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-xnQOs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:08:10 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-gsQKH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:08:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:08:10 INFO - Running setup.py install for manifestparser 07:08:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:08:10 INFO - Running setup.py install for mozcrash 07:08:11 INFO - Running setup.py install for mozdebug 07:08:11 INFO - Running setup.py install for mozdevice 07:08:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:08:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:08:11 INFO - Running setup.py install for mozfile 07:08:11 INFO - Running setup.py install for mozhttpd 07:08:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:08:11 INFO - Running setup.py install for mozinfo 07:08:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:08:11 INFO - Running setup.py install for mozInstall 07:08:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:08:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:08:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:08:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:08:11 INFO - Running setup.py install for mozleak 07:08:12 INFO - Running setup.py install for mozlog 07:08:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:08:12 INFO - Running setup.py install for moznetwork 07:08:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:08:12 INFO - Running setup.py install for mozprocess 07:08:12 INFO - Running setup.py install for mozprofile 07:08:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:08:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:08:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:08:12 INFO - Running setup.py install for mozrunner 07:08:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:08:12 INFO - Running setup.py install for mozscreenshot 07:08:13 INFO - Running setup.py install for moztest 07:08:13 INFO - Running setup.py install for mozversion 07:08:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:08:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:08:13 INFO - Cleaning up... 07:08:13 INFO - Return code: 0 07:08:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:08:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:13 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 0x102861a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8249d990f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027c5d30>, '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 0x10252adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027bdb20>, '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.sBTiOXe6jm/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.lACK6OUpvv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 07:08:13 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 07:08:13 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 07:08:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sBTiOXe6jm/Render', 07:08:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:08:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:08:13 INFO - 'HOME': '/Users/cltbld', 07:08:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:08:13 INFO - 'LOGNAME': 'cltbld', 07:08:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:13 INFO - 'MOZ_NO_REMOTE': '1', 07:08:13 INFO - 'NO_EM_RESTART': '1', 07:08:13 INFO - 'PAGER': '/bin/cat', 07:08:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:08:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:13 INFO - 'PWD': '/builds/slave/test', 07:08:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:08:13 INFO - 'SHELL': '/bin/bash', 07:08:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lACK6OUpvv/Listeners', 07:08:13 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 07:08:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:08:13 INFO - 'USER': 'cltbld', 07:08:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:08:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:08:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:13 INFO - 'XPC_FLAGS': '0x0', 07:08:13 INFO - 'XPC_SERVICE_NAME': '0', 07:08:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:08:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:08:13 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-5eGBO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:08:13 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)) 07:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:08:13 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-oLLURv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:08:13 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)) 07:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:08:13 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-MatniP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:08:13 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)) 07:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:08:13 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-ESr_Ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:08:14 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)) 07:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:08:14 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-GnFlub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:08:14 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)) 07:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:08:14 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-RTq09O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:08:14 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)) 07:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:08:14 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-ukgGIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:08:14 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)) 07:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:08:14 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-J5UZO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:08:14 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)) 07:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:08:14 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-vzNqIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:08:14 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)) 07:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:08:14 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-ycTOBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:08:14 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)) 07:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:08:14 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-wR5HUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:08:14 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)) 07:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:08:14 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-rG5Y8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:08:14 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)) 07:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:08:14 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-3DAmsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:08:15 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)) 07:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:08:15 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-Qwf8Hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:08:15 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)) 07:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:15 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-DTDnWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:15 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)) 07:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:08:15 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-aw8G5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:08:15 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)) 07:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:08:15 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-iQUM0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:08:15 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)) 07:08:15 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)) 07:08:15 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)) 07:08:15 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)) 07:08:15 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)) 07:08:15 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)) 07:08:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:08:15 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 07:08:15 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 07:08:15 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 07:08:15 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 07:08:15 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 07:08:15 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 07:08:17 INFO - Downloading blessings-1.6.tar.gz 07:08:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:08:17 INFO - Installing collected packages: blessings 07:08:17 INFO - Running setup.py install for blessings 07:08:18 INFO - Successfully installed blessings 07:08:18 INFO - Cleaning up... 07:08:18 INFO - Return code: 0 07:08:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:08:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:08:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:08:18 INFO - Reading from file tmpfile_stdout 07:08:18 INFO - Current package versions: 07:08:18 INFO - blessings == 1.6 07:08:18 INFO - blobuploader == 1.2.4 07:08:18 INFO - docopt == 0.6.1 07:08:18 INFO - functools32 == 3.2.3-2 07:08:18 INFO - jsonschema == 2.5.1 07:08:18 INFO - manifestparser == 1.1 07:08:18 INFO - mozInstall == 1.12 07:08:18 INFO - mozcrash == 0.17 07:08:18 INFO - mozdebug == 0.1 07:08:18 INFO - mozdevice == 0.48 07:08:18 INFO - mozfile == 1.2 07:08:18 INFO - mozhttpd == 0.7 07:08:18 INFO - mozinfo == 0.9 07:08:18 INFO - mozleak == 0.1 07:08:18 INFO - mozlog == 3.3 07:08:18 INFO - moznetwork == 0.27 07:08:18 INFO - mozprocess == 0.23 07:08:18 INFO - mozprofile == 0.28 07:08:18 INFO - mozrunner == 6.12 07:08:18 INFO - mozscreenshot == 0.1 07:08:18 INFO - mozsystemmonitor == 0.3 07:08:18 INFO - moztest == 0.7 07:08:18 INFO - mozversion == 1.4 07:08:18 INFO - psutil == 3.1.1 07:08:18 INFO - requests == 1.2.3 07:08:18 INFO - wsgiref == 0.1.2 07:08:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:08: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')]} 07:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08: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')]} 07:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:18 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 0x102861a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8249d990f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027c5d30>, '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 0x10252adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027bdb20>, '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.sBTiOXe6jm/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.lACK6OUpvv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 07:08:18 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 07:08:18 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 07:08:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sBTiOXe6jm/Render', 07:08:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:08:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:08:18 INFO - 'HOME': '/Users/cltbld', 07:08:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:08:18 INFO - 'LOGNAME': 'cltbld', 07:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:18 INFO - 'MOZ_NO_REMOTE': '1', 07:08:18 INFO - 'NO_EM_RESTART': '1', 07:08:18 INFO - 'PAGER': '/bin/cat', 07:08:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:18 INFO - 'PWD': '/builds/slave/test', 07:08:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:08:18 INFO - 'SHELL': '/bin/bash', 07:08:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lACK6OUpvv/Listeners', 07:08:18 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 07:08:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:08:18 INFO - 'USER': 'cltbld', 07:08:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:08:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:18 INFO - 'XPC_FLAGS': '0x0', 07:08:18 INFO - 'XPC_SERVICE_NAME': '0', 07:08:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:18 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)) 07:08:18 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)) 07:08:18 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)) 07:08:18 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)) 07:08:18 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)) 07:08:18 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)) 07:08:18 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)) 07:08:18 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)) 07:08:18 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)) 07:08:18 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)) 07:08:18 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)) 07:08:18 INFO - Cleaning up... 07:08:18 INFO - Return code: 0 07:08:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:08: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')]} 07:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08: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')]} 07:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102861a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8249d990f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027c5d30>, '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 0x10252adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027bdb20>, '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.sBTiOXe6jm/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.lACK6OUpvv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 07:08: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'] in /builds/slave/test/build 07:08: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 07:08:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sBTiOXe6jm/Render', 07:08:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:08:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:08:18 INFO - 'HOME': '/Users/cltbld', 07:08:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:08:18 INFO - 'LOGNAME': 'cltbld', 07:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:18 INFO - 'MOZ_NO_REMOTE': '1', 07:08:18 INFO - 'NO_EM_RESTART': '1', 07:08:18 INFO - 'PAGER': '/bin/cat', 07:08:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:18 INFO - 'PWD': '/builds/slave/test', 07:08:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:08:18 INFO - 'SHELL': '/bin/bash', 07:08:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lACK6OUpvv/Listeners', 07:08:18 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 07:08:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:08:18 INFO - 'USER': 'cltbld', 07:08:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:08:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:18 INFO - 'XPC_FLAGS': '0x0', 07:08:18 INFO - 'XPC_SERVICE_NAME': '0', 07:08:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:08:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:08:19 INFO - Cleaning up... 07:08:19 INFO - Return code: 0 07:08:19 INFO - Running post-action listener: _resource_record_post_action 07:08:19 INFO - Running post-action listener: _start_resource_monitoring 07:08:19 INFO - Starting resource monitoring. 07:08:19 INFO - [mozharness: 2016-08-13 14:08:19.052387Z] Finished create-virtualenv step (success) 07:08:19 INFO - [mozharness: 2016-08-13 14:08:19.053332Z] Running install step. 07:08:19 INFO - Running pre-action listener: _resource_record_pre_action 07:08:19 INFO - Running main action method: install 07:08:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:08:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:08:19 INFO - Reading from file tmpfile_stdout 07:08:19 INFO - Detecting whether we're running mozinstall >=1.0... 07:08:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:08:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:08:19 INFO - Reading from file tmpfile_stdout 07:08:19 INFO - Output received: 07:08:19 INFO - Usage: mozinstall [options] installer 07:08:19 INFO - Options: 07:08:19 INFO - -h, --help show this help message and exit 07:08:19 INFO - -d DEST, --destination=DEST 07:08:19 INFO - Directory to install application into. [default: 07:08:19 INFO - "/builds/slave/test"] 07:08:19 INFO - --app=APP Application being installed. [default: firefox] 07:08:19 INFO - mkdir: /builds/slave/test/build/application 07:08:19 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'] 07:08:19 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 07:08:54 INFO - Reading from file tmpfile_stdout 07:08:54 INFO - Output received: 07:08:54 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:08:54 INFO - Running post-action listener: _resource_record_post_action 07:08:54 INFO - [mozharness: 2016-08-13 14:08:54.161969Z] Finished install step (success) 07:08:54 INFO - [mozharness: 2016-08-13 14:08:54.162104Z] Running run-tests step. 07:08:54 INFO - Running pre-action listener: _resource_record_pre_action 07:08:54 INFO - Running main action method: run_tests 07:08:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:08:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:08:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:08:54 INFO - 2016-08-13 07:08:54.177 screenresolution[2089:72786] starting screenresolution argv=screenresolution get 07:08:54 INFO - 2016-08-13 07:08:54.179 screenresolution[2089:72786] Display 0: 1600x1200x32@60 07:08:54 INFO - 2016-08-13 07:08:54.185 screenresolution[2090:72789] starting screenresolution argv=screenresolution list 07:08:54 INFO - Available Modes on Display 0 07:08:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:08:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:08:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:08:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:08:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:08:54 INFO - Intel Iris: 07:08:54 INFO - Chipset Model: Intel Iris 07:08:54 INFO - Type: GPU 07:08:54 INFO - Bus: Built-In 07:08:54 INFO - VRAM (Dynamic, Max): 1536 MB 07:08:54 INFO - Vendor: Intel (0x8086) 07:08:54 INFO - Device ID: 0x0a2e 07:08:54 INFO - Revision ID: 0x0009 07:08:54 INFO - Displays: 07:08:54 INFO - Display: 07:08:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:08:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:08:54 INFO - Display Serial Number: 1600x1200 60 07:08:54 INFO - Main Display: Yes 07:08:54 INFO - Mirror: Off 07:08:54 INFO - Online: Yes 07:08:54 INFO - Rotation: Supported 07:08:54 INFO - Return code: 0 07:08:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:08:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:08:54 INFO - Python 2.7.3 07:08:54 INFO - Return code: 0 07:08:54 INFO - grabbing minidump binary from tooltool 07:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:08:54 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 0x1027c5d30>, '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 0x10252adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027bdb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:08:54 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 07:08:54 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 07:08:54 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 07:08:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:08:54 INFO - Return code: 0 07:08:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:08:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:08:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:08:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:08:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:08:54 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/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0177', '--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 07:08:54 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/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0177 --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 07:08:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sBTiOXe6jm/Render', 07:08:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:08:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:08:54 INFO - 'HOME': '/Users/cltbld', 07:08:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:08:54 INFO - 'LOGNAME': 'cltbld', 07:08:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:08:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:54 INFO - 'MOZ_NO_REMOTE': '1', 07:08:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:08:54 INFO - 'NO_EM_RESTART': '1', 07:08:54 INFO - 'PAGER': '/bin/cat', 07:08:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:54 INFO - 'PWD': '/builds/slave/test', 07:08:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:08:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:08:54 INFO - 'SHELL': '/bin/bash', 07:08:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lACK6OUpvv/Listeners', 07:08:54 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 07:08:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:08:54 INFO - 'USER': 'cltbld', 07:08:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:08:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:54 INFO - 'XPC_FLAGS': '0x0', 07:08:54 INFO - 'XPC_SERVICE_NAME': '0', 07:08:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:08:54 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/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0177', '--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 07:08:54 INFO - mozversion application_buildid: 20160813044816 07:08:54 INFO - mozversion application_changeset: 6e191a55c3d23e83e6a2e72e4e80c1dc21516493 07:08:54 INFO - mozversion application_display_name: Nightly 07:08:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:08:54 INFO - mozversion application_name: Firefox 07:08:54 INFO - mozversion application_remotingname: firefox 07:08:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:08:54 INFO - mozversion application_vendor: Mozilla 07:08:54 INFO - mozversion application_version: 51.0a1 07:08:54 INFO - mozversion platform_buildid: 20160813044816 07:08:54 INFO - mozversion platform_changeset: 6e191a55c3d23e83e6a2e72e4e80c1dc21516493 07:08:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:08:54 INFO - mozversion platform_version: 51.0a1 07:08:54 INFO - using testdate: 1471097334 07:08:54 INFO - actual date: 1471097334 07:08:54 INFO - starting webserver on 'localhost:50979' 07:08:54 INFO - SUITE-START | Running 2 tests 07:08:54 INFO - TEST-START | dromaeo_css 07:08:54 INFO - operating with platform_type : mac_ 07:08:54 INFO - Initialising browser for dromaeo_css test... 07:08:54 INFO - TEST-INFO | started process 2100 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmpioWNtQ/profile http://localhost:50979/getInfo.html) 07:08:57 INFO - PROCESS | 2100 | __metrics Screen width/height:1600/1200 07:08:57 INFO - PROCESS | 2100 | colorDepth:24 07:08:57 INFO - PROCESS | 2100 | Browser inner width/height: 1024/689 07:08:57 INFO - PROCESS | 2100 | __metrics 07:08:57 INFO - PROCESS | 2100 | 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" 07:08:57 INFO - PROCESS | 2100 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:08:58 INFO - TEST-INFO | 2100: exit 0 07:08:58 INFO - Browser initialized. 07:08:58 INFO - Running cycle 1/1 for dromaeo_css test... 07:08:58 INFO - TEST-INFO | started process 2102 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmpioWNtQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:09:10 INFO - PROCESS | 2102 | RSS: Main: 228556800 07:09:10 INFO - PROCESS | 2102 | 07:10:01 INFO - PROCESS | 2102 | 1471097401863 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] 07:12:12 INFO - PROCESS | 2102 | Cycle 1(1): loaded http://localhost:50979/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50979/tests/dromaeo/cssquery-ext.html) 07:12:14 INFO - PROCESS | 2102 | RSS: Main: 377360384 07:12:14 INFO - PROCESS | 2102 | 07:15:17 INFO - PROCESS | 2102 | Cycle 1(1): loaded http://localhost:50979/tests/dromaeo/cssquery-ext.html (next: http://localhost:50979/tests/dromaeo/cssquery-jquery.html) 07:15:18 INFO - PROCESS | 2102 | RSS: Main: 373182464 07:15:18 INFO - PROCESS | 2102 | 07:18:20 INFO - PROCESS | 2102 | Cycle 1(1): loaded http://localhost:50979/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50979/tests/dromaeo/cssquery-mootools.html) 07:18:21 INFO - PROCESS | 2102 | RSS: Main: 341807104 07:18:21 INFO - PROCESS | 2102 | 07:21:23 INFO - PROCESS | 2102 | Cycle 1(1): loaded http://localhost:50979/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50979/tests/dromaeo/cssquery-prototype.html) 07:21:24 INFO - PROCESS | 2102 | RSS: Main: 331960320 07:21:24 INFO - PROCESS | 2102 | 07:24:27 INFO - PROCESS | 2102 | Cycle 1(1): loaded http://localhost:50979/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50979/tests/dromaeo/cssquery-yui.html) 07:24:28 INFO - PROCESS | 2102 | RSS: Main: 330092544 07:24:28 INFO - PROCESS | 2102 | 07:27:31 INFO - PROCESS | 2102 | Cycle 1(1): loaded http://localhost:50979/tests/dromaeo/cssquery-yui.html (next: http://localhost:50979/tests/dromaeo/cssquery-dojo.html) 07:27:32 INFO - PROCESS | 2102 | RSS: Main: 434991104 07:27:32 INFO - PROCESS | 2102 | 07:27:32 INFO - PROCESS | 2102 | __start_tp_report 07:27:32 INFO - PROCESS | 2102 | _x_x_mozilla_page_load 07:27:32 INFO - PROCESS | 2102 | _x_x_mozilla_page_load_details 07:27:32 INFO - PROCESS | 2102 | |i|pagename|runs| 07:27:32 INFO - PROCESS | 2102 | |0;dojo.html;3308.7683862129647;3309.917252068698;3335.7498187635924;3338.7662863599544;3343.6154842193155;5610.663360198391;5664.461876121762;5679.403662615423;5744.138379243115;5752.453516915897;5691.658500489973;5694.202811606378;5794.333651630064;5804.738786754596;5809.3609702932645;5098.464661210575;5100.387953445592;5181.4300426953005;5193.091209038422;5265.341832270966;5252.579793616521;5284.788608455677;5286.656367336111;5302.390225124122;5333.626646134772;5129.333186685744;5157.5616072633875;5176.327077479904;5195.532402083812;5221.582273418156;5141.408737995141;5171.405288391846;5211.348581427322;5232.92150617741;5296.708681022542;5116.309298244763;5140.511651393112;5149;5217.373915130171;5234.685918844843;5711.657300561979;5741.741621627037;5785.566082543826;5794.855128621818;5798.855028624276;6132.69336533176;6149.600275982047;6216.720247588869;6238.87522249557;6259.71831267594;6175.722092505848;6220.098085777582;6227.719752611098;6234.220722409699;6244.188255526798;5837.3287071986415;5872.354041055438;5874.882502349929;5876.324222714443;5895.764169433218;6217.4715149212825;6221.657808820558;6279.183706118175;6288.434040936338;6292.811215663537;6114.206128133723;6126.326104128631;6127.417895299939;6130.172426722335;6136.110264011782;6272.090546870678;6287.025511045796;6287.559870808999;6293.622382657055;6308.274548426898;6088.178095957078;6114.449440885101;6142.355052719489;6181.876362472725;6204.348543402968;5233.293505376725;6205.503559715212;6218.657973811484;6252.499800015988;6275.215598050244;4900.313956046157;4923.606111511071;4930.2851086592245;4930.654854160174;4986.576141027981;4368.956310436855;4383.473983121982;4400.339949007611;4463.285874260103;4481.439820022497;5756.740946657411;5760.913586296209;5764.250647415809;5800.970995144998;5806.941930580725;6224.138703686101;6289.182406287154;6295.401936815995;6305.022721478178;6305.621662700252;5610.943890561124;5707.315122185281;5722.484976352148;5787.971060144757;5799.739011744397;5418.756155972991;5423;5425.457454254622;5460.726963651801;5469.753861076261;6303.054541818764;6313.684315784192;6324.683765811599;6324.810255692337;6330.113784070142;6148.78479253224;6234.438900498795;6285.308616052139;6303.086052522451;6310.842228944313;6242.719077641608;6259.34276900937;6291.528135389773;6291.622502649856;6318.210223722035;6168.290646575701;6188.597741146811;6220.098085777628;6221.440070393686;6233.438990490697;6229.12792209082;6277.372262773869;6286.37136286386;6286.6856657166045;6301.149344838572;4905.288733133747;6028.246469191351;6079.3008803988105;6096.055111457731;6120.7857724981195;6033.698315084141;6062.090686397076;6064;6066.241719785027;6087.421694938974;4513.977430112828;5908.1137829324225;5920;5931.733072011856;5949.1076338549565;5910.290765108214;5998.580099393001;6035.426634469718;6069.848253793691;6077.939220607915;5884.676342801187;5942.1383899335215;5944.167816505606;5960.403959604005;5963.4334738199805 07:27:32 INFO - PROCESS | 2102 | |1;ext.html;459.39360044740954;499.4044029326304;516.9508896654818;541.610040770645;548.1202669715107;31090.222744431372;41681.3747793783;42021.73934781957;42199.15601687964;42247.155056898846;38401;40301.59698403015;42797.358039629355;43047.569524304745;43291.13417731643;9650.372725772837;9851.95074024629;9861.70414887551;9862.704118876445;9863.260255480867;7863.93836832029;8478.109798471134;9044.321675874302;9170.770730731718;9172.12864777845;8946.507942063185;11930.821037684398;12156.939215303912;12163.878361216362;12385.752284954295;11595.94202028993;11800.704982375424;11873.584424545099;11885.930266276077;11893.643190704206;10495.527701253463;12068.577599784054;12077.57728479499;12082.879171208264;12092.153549251556;40029.59970400288;40358.79820600907;40368.39447408291;40523.7973810132;40558.18883622311;3442.569678790151;3668.0279725872665;3686.963130368689;3899.1032062625754;4099.7745124018165;30821.383572328654;31311.37377252465;31686;31700;32378.514322285184;3214.8231847248394;3246.253361726816;3274.4106060909025;3360.260742636616;3398.167448974992;371451;463643;463719;464716;465267;32790.83604581962;33553.496697549555;56216.15675764867;56440.87118257612;56532;34902.476462853076;35040.64959350425;35061.47407788885;35113.648863511036;35162.648373515935;12155.088368372408;14728.926355368154;14733.336999835034;14738.336774845158;14738.336774845158;12531.310777907303;12626.558070467674;12659.556915508098;12677.366131693563;12688.873111268953;6057.697115144225;7370.152432470228;7644.388448924073;7750.341220996165;7855.685772569033;3171.809691418522;3217.549543063973;3250.2524419383203;3262.3964566555264;3286.145602143412;951.2390087929767;955.3121752338305;955.9808803823885;988.6342053440274;1046.2728403759465;26440.603390949153;27848.582271265946;28028;30091.539472960452;30413;959.5250351076262;1069.657709532942;1090.345792524479;1091.247039542713;1114.8272017837248;15194.848051519564;15576;15579.14314712679;15588.454404095803;15592.844071559366;648905;691455;693439;693846;694095;51362.74318628383;52067.218991715155;58230.83538329294;59073.70463147743;59524;1035.3477309295097;1321.3459337627935;1322.6428864206418;1328.9867101329057;1353.4653811744504;24853.378665533506;30938.0718578443;31400.842995784875;31721.36557268888;31812.5228121583;51089.74455127701;51328.74335628298;51363.2295515575;51429.48570514247;51579.22631160461;498217;501528;501931;885518.5724071339;909996;43043.20219185743;43668;43815.9046023852;43830.34254486122;44254.55745442504;47956;48456.75771621119;48786.756066219445;48791.5120848787;49084.75457622689;39061;39066;39259.41110883282;39967;40983.385249220686;37225;38155.42766858444;39128.608713912494;39226.2154756909;40734.59265407308;38311.23377532378;38722.804351303654;38865.61134388733;38943.221135577696;39149.6085039146;29340;31758.523622145225;34683;34818.30363392668;35003.47494787631;21581.784182158604;24242.87878560596;24819.883105259945;25436.618450723625;25710.485790284463 07:27:32 INFO - PROCESS | 2102 | |2;jquery.html;357.207000458981;369.38497401825975;376.85679441812107;382.1725963289479;403.68310875962356;12242.510299588017;17142.82857171428;20890;21583.46041348967;21685.783142168573;15184.696306073873;20369.87965661888;20767.688484672704;21122.788772112275;22340.329790106283;5426.21319908615;5728.914066289009;5963.612365196259;6239.688015599225;6245.531585131111;4224.5353011168745;6075.422834830684;6169.876602467948;6182.196314479112;6187.35032821554;6505.251896031946;6849.315068493136;6862.142232220973;6939.097917270773;6948.062011628442;6638.4689224861895;6804.76183333581;6852.6916288767125;6871.14110736158;6937.861242775141;5690.118031705092;5916.852078698024;5919.644821310692;5948.7323070461935;5952.791652292192;27772.166834994983;28095.438091238266;28162;28359.57460638092;28434.71565284362;2300.5628930503317;2447.192426499251;2511.510255500178;2607.465469578751;3210.5184222366597;16849.915750421293;16993.15034248295;17293.30826766928;17921.103944802708;18230;2002.1991203518564;2023.706562548437;2036.9592608147755;2061.7628972668185;2082.739657542807;95818.87586682756;113820;135756;153631;154130.22934885253;19865.503362416057;21357.78642213589;21397.823119728564;21471.46321341979;21633.891830540746;35658.10854728652;35733.64266357355;35762;35862.46206306908;35874;10749.62376316825;10954.287971282001;11052.778944421227;11123.27698699582;11286.379249141377;8332.541710205876;8369.121242269473;9077.68228112013;9132.726018219464;9277.721668349961;9332.626694932127;9636.903630963741;9736.853947190797;9797;9809.607615695293;2983.3585779057607;3436.7766095203733;3628.26446856218;3659.3116323410045;3755.8309876055096;819.9016118065871;929.8651695504115;951.7477868364889;956.9521523923916;1005.9396436213705;21755.67366489504;22346.441338966655;22427.551448970928;22632.321030369116;22664.773352266595;938.596403546468;944.9244060475146;966.4201479112617;999.4453078541334;1040.5681642118586;11466.54133834654;11566.190366674253;11692.824607630891;11716.94141529304;11740.647780566596;581193;604712;604987;622338;624063;67138.66430667815;74003;89497.55251223702;110385;127237;961.7691753978995;1016.7813920007234;1037.9429131397847;1041.1358572384902;1042.2652030318607;18364.72452913234;20350;20509.794902050788;20526.281580144623;20549.38351849447;50918.98162036664;57089;57380.426195737506;58587.535311617554;59044;56791;79843.20156798357;82031;83839;87527.56236218777;7930.682772689028;8168.142345053921;8233.670653173805;8261.504309741435;8329.208725171098;9707.66023189185;12744.74510509803;12858.292793896426;13149.53976610814;13251.337433128112;10786.568537258421;11033.613823516138;11331.150163737588;11456.94271528637;11599.88400115988;10236.590536378759;10557.260991730505;10861.619843305762;11092.778144437227;11223.831642525533;9964.60141594357;10467.639206903053;11204.439778010903;11640.650780476599;11794.646160615195;6793.796186114425;8110.716124935599;8113.553754543556;8224.671013159406;8455.74632761018;8334.416590838826;10155.339902906288;11103.389313587508;11489.54041838317;11554.94222528882 07:27:32 INFO - PROCESS | 2102 | |3;mootools.html;1485.2202593638335;1533.2563706602298;1678.3538337739967;1811.9637607247846;1830.0758117150845;8378.539180345078;8916.242119419858;8917.15287047731;8927.776805579855;8931.464112153268;7858.882116768253;8036.638351274192;8366.95816520918;8587.270082043018;8706.347023973212;2344.0623750499767;2378.5480758655885;2378.702662167229;2378.8096952243777;2383.177803657744;2337.824663150262;2360.421696684306;2361.929142125739;2382.356763673807;2384.6661467394492;2312.2369618026096;2324.1168356024687;2356.658284548748;2368.5973384524673;2372.7627237276306;2331.6852224949585;2341.531693661266;2342.9648555271683;2346.612808886549;2348.6946696929376;2343.414146463384;2344.5076533927895;2347.295811256616;2348.1429278313294;2353.164626557582;8632.784180395478;8818.691345802867;8824.249938755149;8827.558622068871;8828.293736501064;5167.147420675584;5334.893302133974;5339.279197308352;5344.545713614348;5349.224362467459;3347.1799409144674;3413.9658603413895;3563.9109022274392;3567.1973805893726;3576.5529308836394;1047.4710271312938;1053.467998660679;1061.5382308695741;1074.2856000759487;1077.4343469678404;11507.424628768527;11652.76694466106;11672.766544669144;11675.649730508097;11685;4555.476120246148;4607.815687372467;4769.976150119227;4806.086843499724;4817.927731084036;9910.108090271766;9920.255980801468;9921.900780992242;9923.1069203772;9928.602855885829;5314.388845282765;5326.121190003606;5326.387465441524;5336.91994620081;5339.839804805862;4121.155163191538;4396.428464299621;4520.728756274634;4898.804047838046;4912.803487860517;3883.514560679915;4005.6595189408645;4025.4766880305374;4027.456293400412;4036.616521430459;1067.8238090714945;1246.1308037943086;1290.2387591321165;1300.5318085489216;1303.67408147963;680.7175022365662;779.5556532776263;838.2078935406105;892.4422236102436;918.6417297254076;5722.370539240764;5737.655740655574;5976.970115149396;6117.877642447215;6168.9691551542855;378.4947095627313;412.91122408682276;424.98300067997553;443.9311906654409;447.73583585684605;3975.1254723960683;3985.043589538548;4056.1684854604737;4069.8372065117064;4124.195781822576;10231.94884025575;10736.033756961755;10747.40889251083;10754.247202695893;10765.730856728644;10672.25294229412;10696.62561810333;10725.51735171919;10729.83905241422;10746.677599672023;8033.477823941425;8045.396595255379;8078.515289082674;8170.714025009215;8172.6322315495945;5513.393526711979;5786.132080188006;5845.152452894392;5903.7048147593305;5927.496162826035;9674.419534827934;9948.950255248677;10014.048665376778;10037.146842518176;10056.296059276074;9228.769280768034;9516.095970882756;9630.036996300594;9990.10089091956;10104;7091.2554181810165;7233.746818861315;7246.130464344313;7254.202037775946;7372.299631534996;8187.959060204661;8309;8309.00291964968;8370.16298370158;8387.706430274911;7551.924480755122;7590.734324298623;7599.848003040019;7659.808504787425;7677.884831727641;7292.525985810906;7344.48588598793;7440.255974402517;7500.774976750707;7522.285382888617;6911.239763626098;6923.757668481579;7062.435005199469;7064.752733654297;7067.717291308496;4881.463039065771;4966.428860680923;4969.726665033458;5045.84862454127;5174.560162386239;4961.734757636779;4995.8001679932395;5076.517730815566;5095.796168153232;5165.276861239355 07:27:32 INFO - PROCESS | 2102 | |4;prototype.html;260.96216048672943;296.64254573239265;310.6718777227353;314.52192667145925;316.8225793555609;5209.739513024348;5223.71269580173;5255.421903590612;5266.339893773828;5280.762365693543;4422.845200417986;4870.050340183666;4937.494064310384;5155.4586768389345;5217.426083130853;3460.394430974582;3966.206758648275;3976.8210430530694;4011.9197616047663;4035.6367926886574;3563.4832949222478;3969.5831937646562;4017.9598204018025;4027.234825383168;4031.560905652082;3042.600403814237;3743.7566558173767;3843.577206507296;3940.349842276021;4007.799610019502;3482.5820901491984;3817.5609804872515;3920.961100227894;3934.7442416243;3952.5454572724075;2856.985715071432;3035.514317709156;3445.43150380187;3455.3241677786255;3462.601800792916;4803.351547541072;4920.729359885205;5001.949980500185;5010.849674509771;5028.874278143039;3765.35988881888;4500.662450316239;4506.7070640408265;4512.819487220508;4540.387047748578;5345.144776835727;5360.705161216131;5370.409254981949;5417.106177480711;5418.214358917974;3164.5095010273444;3262.771605987582;3783.5838057813617;3785.5646600641003;3797.810109494514;3996.760194388317;5609.411011843779;5623.465770751731;5650.576206784508;5724.685142317213;3512.3677738007405;3750.924981500409;3751.9437208441896;3789.787268074245;3790.7156963227867;3800;3810.8094595270127;3813.7902415366866;3826.234753049401;3834.539855217392;4225.746455212697;4422.778861056934;4481.977590112028;4514.480834703985;4557.316402539645;4236.195122926634;5293.470652934676;5424.294841670558;5440.483154100354;5594.104943209149;1291.754566632337;1301.6420484366686;1312.2061153002487;1316.6898935558988;1326.7611829870523;750.9636701352208;760.9391248700091;792.7383963292215;814.4950130918868;862.4868203418956;4717.160307480085;4833.3958255218095;4851.671197824993;4996.350474438373;5030.924536131961;4512.706674066175;4831.4202295724735;4995.425526064549;5380.408155102936;5456.399796022434;4583.816647334136;4885.5847252983185;4895.951040489549;4924.926126108111;4995.475475075137;2788.776897848167;2881.6253886994555;2884.7259510346485;2889.7399234068616;2890.9710902891125;5273.31446911899;5622.690752008679;5644.322681278273;5651.8304450866535;5666.546676265972;4404.955950440519;4752.667313288037;4824.662273640882;5560.833175004756;5677.403872593318;5146.6911985281;5374.527717250109;5417.864553386197;5681.517071049007;5687.516561092353;5222.817201397933;5480.3971563127225;5485.232067510472;5486.890262194814;5491.670499770026;4107.609777071173;4785.588251465756;5291.682499050069;5331.3868905076415;5408.405075441777;4277.272863613131;4898.7550622468025;5344.4922732340365;5667.846218436967;5681.687507187145;3182.8038653329127;3278.311554573471;3457.0320310313155;3712.6658600726064;3721.6650501455;4843.782029808737;5259.211118332128;5452.073147565003;5668.894565559841;5790.971045144747;4939.753012349296;5071.670341427795;5442.836714898401;5596.552275817843;5609.943900560942;5274.551663108678;5498.542886135097;5502.257195278747;5502.972485137549;5566.944330556805;4754.7399939015495;4777.378940737821;4985.205326082535;5382.596305277041;5418.756155973069;4909.901801963869;5008.023435430056;5441.863953401196;5455.590830687794;5455.672659640434;4114.526829414655;4792.832250871203;5180.704823794052;5363.651362661414;5425.972870135624 07:27:32 INFO - PROCESS | 2102 | |5;yui.html;700.9369156775889;703.349401803332;716.4411758828115;747.1109379837992;833.395788053661;15600.765988510168;16623.83376166238;16624.58438539037;16626.66746665066;16634.251458684357;14863.479778207766;15046.54860354191;15065;15068.849311506881;15141.924290378533;679.37497502298;706.6678661029333;834.0825092398344;853.406882216858;866.5797088412147;840.197611281228;855.7304449098546;856.87146927961;857.498363457375;857.8541647919837;763.9847203055936;910.2172131966504;910.2172131966504;912.0286894457381;912.7444315591612;711.8184862859989;738.5753191914671;740.9444291678145;901.9188273055423;910.3945875992457;552.9281193444866;553.3000754046135;658.108263303222;684.4524380495633;688.198249039868;15380.30788614515;15450.304736286782;15457.5362739118;15462.072275663497;15479;14042.36809343582;14208.44209335332;14248;14295.857041429557;14337.56987290383;12833.230006199658;12938.223706577635;12999.415026323744;13025.413856376392;13110.606681799562;4515.435570553681;4555.2256116460285;4636.582707556337;4639.393080682285;4684.852211208242;110621.44689276502;113305.43347283211;113332.86667133306;113680.61076030115;114055.85944140618;10227.43749093807;10695.197860160519;10841.295315804606;10907.881279354884;11479.483423245974;21470;21563.921803909743;21686.45783855416;21760.782392176192;21882.671759923614;6908.274631163656;7583.810404739926;7709.2290770922455;7747;7815.882761758578;4282.729978611256;4337.783110844445;4366.257736184856;4384.912301753947;4483.574060464251;3559.18138828071;3673.3204357194004;3680.208755117609;3685.2076803486843;3689.317476266899;558.4889825809339;670.2258890980925;679.2053297641771;680.3196803196803;681.3322943515383;481.9253015782559;590.6928397233414;601.3235110500686;613.362103412455;635.3455940381415;8549.401541892132;8962.731118066338;9060.728178154666;9183.173514383738;9273.814523709489;574.1387918122816;591.3642833953517;603.5352778360638;621.7812144598875;624.4411251929498;4386.188555117314;4461.643068554507;4494.303382975644;4509.120721459284;4531.660125490535;100597.72357399983;127877;128659;156121;162161.3257462319;88575;136591;143975;144768;146282.2685886585;98610;113617.43191284157;115742;121839.39080304542;122944;8281.710140145065;8392.531307021125;8568.57157142153;8765.031799719365;8952;55038.724806375714;68721.46687045383;68844;71396.28603714104;72589;67185.66407167933;85938;89315;89843;103860.48069759602;10747.677569672922;10798;10811.081058110149;10887.564497420015;11218.55125794959;12361.567345142877;12931.870681293443;14428.495002674856;14809.111453312837;15209.543713688607;13780.448782048607;13917.373718182504;13951.790723138958;13982.370793314121;14189.503367382093;13827.861721382658;13909.930450347683;14034.719305614035;14170.645733856736;14607.853921461074;13134.474621015435;13369.66575835612;13560.254186019863;13704.862951370758;13742.781682259661;10810.783784324427;11218.214724969173;11299.322040677585;11329.490172942402;11688.064954803425;10746.408947507962;11336.659900203007;11351.205415620827;11493.712657183638;11509.482073306888 07:27:32 INFO - PROCESS | 2102 | __end_tp_report 07:27:32 INFO - PROCESS | 2102 | __start_cc_report 07:27:32 INFO - PROCESS | 2102 | _x_x_mozilla_cycle_collect,1446 07:27:32 INFO - PROCESS | 2102 | __end_cc_report 07:27:32 INFO - PROCESS | 2102 | __startTimestamp1471098452048__endTimestamp 07:27:32 INFO - PROCESS | 2102 | 07:27:32 INFO - PROCESS | 2102 | ------- Summary: start ------- 07:27:32 INFO - PROCESS | 2102 | Number of tests: 6 07:27:32 INFO - PROCESS | 2102 | 07:27:32 INFO - PROCESS | 2102 | [#0] dojo.html Cycles:165 Average:5731.59 Median:5931.73 stddev:650.41 (11.0%) stddev-sans-first:624.02 07:27:32 INFO - PROCESS | 2102 | Values: 3308.8 3309.9 3335.7 3338.8 3343.6 5610.7 5664.5 5679.4 5744.1 5752.5 5691.7 5694.2 5794.3 5804.7 5809.4 5098.5 5100.4 5181.4 5193.1 5265.3 5252.6 5284.8 5286.7 5302.4 5333.6 5129.3 5157.6 5176.3 5195.5 5221.6 5141.4 5171.4 5211.3 5232.9 5296.7 5116.3 5140.5 5149.0 5217.4 5234.7 5711.7 5741.7 5785.6 5794.9 5798.9 6132.7 6149.6 6216.7 6238.9 6259.7 6175.7 6220.1 6227.7 6234.2 6244.2 5837.3 5872.4 5874.9 5876.3 5895.8 6217.5 6221.7 6279.2 6288.4 6292.8 6114.2 6126.3 6127.4 6130.2 6136.1 6272.1 6287.0 6287.6 6293.6 6308.3 6088.2 6114.4 6142.4 6181.9 6204.3 5233.3 6205.5 6218.7 6252.5 6275.2 4900.3 4923.6 4930.3 4930.7 4986.6 4369.0 4383.5 4400.3 4463.3 4481.4 5756.7 5760.9 5764.3 5801.0 5806.9 6224.1 6289.2 6295.4 6305.0 6305.6 5610.9 5707.3 5722.5 5788.0 5799.7 5418.8 5423.0 5425.5 5460.7 5469.8 6303.1 6313.7 6324.7 6324.8 6330.1 6148.8 6234.4 6285.3 6303.1 6310.8 6242.7 6259.3 6291.5 6291.6 6318.2 6168.3 6188.6 6220.1 6221.4 6233.4 6229.1 6277.4 6286.4 6286.7 6301.1 4905.3 6028.2 6079.3 6096.1 6120.8 6033.7 6062.1 6064.0 6066.2 6087.4 4514.0 5908.1 5920.0 5931.7 5949.1 5910.3 5998.6 6035.4 6069.8 6077.9 5884.7 5942.1 5944.2 5960.4 5963.4 07:27:32 INFO - PROCESS | 2102 | 07:27:32 INFO - PROCESS | 2102 | [#1] ext.html Cycles:180 Average:71551.22 Median:38794.21 stddev:165968.24 (427.8%) stddev-sans-first:166347.99 07:27:32 INFO - PROCESS | 2102 | Values: 459.4 499.4 517.0 541.6 548.1 31090.2 41681.4 42021.7 42199.2 42247.2 38401.0 40301.6 42797.4 43047.6 43291.1 9650.4 9852.0 9861.7 9862.7 9863.3 7863.9 8478.1 9044.3 9170.8 9172.1 8946.5 11930.8 12156.9 12163.9 12385.8 11595.9 11800.7 11873.6 11885.9 11893.6 10495.5 12068.6 12077.6 12082.9 12092.2 40029.6 40358.8 40368.4 40523.8 40558.2 3442.6 3668.0 3687.0 3899.1 4099.8 30821.4 31311.4 31686.0 31700.0 32378.5 3214.8 3246.3 3274.4 3360.3 3398.2 371451.0 463643.0 463719.0 464716.0 465267.0 32790.8 33553.5 56216.2 56440.9 56532.0 34902.5 35040.6 35061.5 35113.6 35162.6 12155.1 14728.9 14733.3 14738.3 14738.3 12531.3 12626.6 12659.6 12677.4 12688.9 6057.7 7370.2 7644.4 7750.3 7855.7 3171.8 3217.5 3250.3 3262.4 3286.1 951.2 955.3 956.0 988.6 1046.3 26440.6 27848.6 28028.0 30091.5 30413.0 959.5 1069.7 1090.3 1091.2 1114.8 15194.8 15576.0 15579.1 15588.5 15592.8 648905.0 691455.0 693439.0 693846.0 694095.0 51362.7 52067.2 58230.8 59073.7 59524.0 1035.3 1321.3 1322.6 1329.0 1353.5 24853.4 30938.1 31400.8 31721.4 31812.5 51089.7 51328.7 51363.2 51429.5 51579.2 498217.0 501528.0 501931.0 885518.6 909996.0 43043.2 43668.0 43815.9 43830.3 44254.6 47956.0 48456.8 48786.8 48791.5 49084.8 39061.0 39066.0 39259.4 39967.0 40983.4 37225.0 38155.4 39128.6 39226.2 40734.6 38311.2 38722.8 38865.6 38943.2 39149.6 29340.0 31758.5 34683.0 34818.3 35003.5 21581.8 24242.9 24819.9 25436.6 25710.5 07:27:32 INFO - PROCESS | 2102 | 07:27:32 INFO - PROCESS | 2102 | [#2] jquery.html Cycles:180 Average:36274.41 Median:19547.44 stddev:100843.07 (515.9%) stddev-sans-first:101089.90 07:27:32 INFO - PROCESS | 2102 | Values: 357.2 369.4 376.9 382.2 403.7 12242.5 17142.8 20890.0 21583.5 21685.8 15184.7 20369.9 20767.7 21122.8 22340.3 5426.2 5728.9 5963.6 6239.7 6245.5 4224.5 6075.4 6169.9 6182.2 6187.4 6505.3 6849.3 6862.1 6939.1 6948.1 6638.5 6804.8 6852.7 6871.1 6937.9 5690.1 5916.9 5919.6 5948.7 5952.8 27772.2 28095.4 28162.0 28359.6 28434.7 2300.6 2447.2 2511.5 2607.5 3210.5 16849.9 16993.2 17293.3 17921.1 18230.0 2002.2 2023.7 2037.0 2061.8 2082.7 95818.9 113820.0 135756.0 153631.0 154130.2 19865.5 21357.8 21397.8 21471.5 21633.9 35658.1 35733.6 35762.0 35862.5 35874.0 10749.6 10954.3 11052.8 11123.3 11286.4 8332.5 8369.1 9077.7 9132.7 9277.7 9332.6 9636.9 9736.9 9797.0 9809.6 2983.4 3436.8 3628.3 3659.3 3755.8 819.9 929.9 951.7 957.0 1005.9 21755.7 22346.4 22427.6 22632.3 22664.8 938.6 944.9 966.4 999.4 1040.6 11466.5 11566.2 11692.8 11716.9 11740.6 581193.0 604712.0 604987.0 622338.0 624063.0 67138.7 74003.0 89497.6 110385.0 127237.0 961.8 1016.8 1037.9 1041.1 1042.3 18364.7 20350.0 20509.8 20526.3 20549.4 50919.0 57089.0 57380.4 58587.5 59044.0 56791.0 79843.2 82031.0 83839.0 87527.6 7930.7 8168.1 8233.7 8261.5 8329.2 9707.7 12744.7 12858.3 13149.5 13251.3 10786.6 11033.6 11331.2 11456.9 11599.9 10236.6 10557.3 10861.6 11092.8 11223.8 9964.6 10467.6 11204.4 11640.7 11794.6 6793.8 8110.7 8113.6 8224.7 8455.7 8334.4 10155.3 11103.4 11489.5 11554.9 07:27:32 INFO - PROCESS | 2102 | 07:27:32 INFO - PROCESS | 2102 | [#3] mootools.html Cycles:180 Average:5678.13 Median:4964.08 stddev:3196.80 (64.4%) stddev-sans-first:3190.24 07:27:32 INFO - PROCESS | 2102 | Values: 1485.2 1533.3 1678.4 1812.0 1830.1 8378.5 8916.2 8917.2 8927.8 8931.5 7858.9 8036.6 8367.0 8587.3 8706.3 2344.1 2378.5 2378.7 2378.8 2383.2 2337.8 2360.4 2361.9 2382.4 2384.7 2312.2 2324.1 2356.7 2368.6 2372.8 2331.7 2341.5 2343.0 2346.6 2348.7 2343.4 2344.5 2347.3 2348.1 2353.2 8632.8 8818.7 8824.2 8827.6 8828.3 5167.1 5334.9 5339.3 5344.5 5349.2 3347.2 3414.0 3563.9 3567.2 3576.6 1047.5 1053.5 1061.5 1074.3 1077.4 11507.4 11652.8 11672.8 11675.6 11685.0 4555.5 4607.8 4770.0 4806.1 4817.9 9910.1 9920.3 9921.9 9923.1 9928.6 5314.4 5326.1 5326.4 5336.9 5339.8 4121.2 4396.4 4520.7 4898.8 4912.8 3883.5 4005.7 4025.5 4027.5 4036.6 1067.8 1246.1 1290.2 1300.5 1303.7 680.7 779.6 838.2 892.4 918.6 5722.4 5737.7 5977.0 6117.9 6169.0 378.5 412.9 425.0 443.9 447.7 3975.1 3985.0 4056.2 4069.8 4124.2 10231.9 10736.0 10747.4 10754.2 10765.7 10672.3 10696.6 10725.5 10729.8 10746.7 8033.5 8045.4 8078.5 8170.7 8172.6 5513.4 5786.1 5845.2 5903.7 5927.5 9674.4 9949.0 10014.0 10037.1 10056.3 9228.8 9516.1 9630.0 9990.1 10104.0 7091.3 7233.7 7246.1 7254.2 7372.3 8188.0 8309.0 8309.0 8370.2 8387.7 7551.9 7590.7 7599.8 7659.8 7677.9 7292.5 7344.5 7440.3 7500.8 7522.3 6911.2 6923.8 7062.4 7064.8 7067.7 4881.5 4966.4 4969.7 5045.8 5174.6 4961.7 4995.8 5076.5 5095.8 5165.3 07:27:32 INFO - PROCESS | 2102 | 07:27:32 INFO - PROCESS | 2102 | [#4] prototype.html Cycles:180 Average:4339.25 Median:4860.86 stddev:1331.49 (27.4%) stddev-sans-first:1299.56 07:27:32 INFO - PROCESS | 2102 | Values: 261.0 296.6 310.7 314.5 316.8 5209.7 5223.7 5255.4 5266.3 5280.8 4422.8 4870.1 4937.5 5155.5 5217.4 3460.4 3966.2 3976.8 4011.9 4035.6 3563.5 3969.6 4018.0 4027.2 4031.6 3042.6 3743.8 3843.6 3940.3 4007.8 3482.6 3817.6 3921.0 3934.7 3952.5 2857.0 3035.5 3445.4 3455.3 3462.6 4803.4 4920.7 5001.9 5010.8 5028.9 3765.4 4500.7 4506.7 4512.8 4540.4 5345.1 5360.7 5370.4 5417.1 5418.2 3164.5 3262.8 3783.6 3785.6 3797.8 3996.8 5609.4 5623.5 5650.6 5724.7 3512.4 3750.9 3751.9 3789.8 3790.7 3800.0 3810.8 3813.8 3826.2 3834.5 4225.7 4422.8 4482.0 4514.5 4557.3 4236.2 5293.5 5424.3 5440.5 5594.1 1291.8 1301.6 1312.2 1316.7 1326.8 751.0 760.9 792.7 814.5 862.5 4717.2 4833.4 4851.7 4996.4 5030.9 4512.7 4831.4 4995.4 5380.4 5456.4 4583.8 4885.6 4896.0 4924.9 4995.5 2788.8 2881.6 2884.7 2889.7 2891.0 5273.3 5622.7 5644.3 5651.8 5666.5 4405.0 4752.7 4824.7 5560.8 5677.4 5146.7 5374.5 5417.9 5681.5 5687.5 5222.8 5480.4 5485.2 5486.9 5491.7 4107.6 4785.6 5291.7 5331.4 5408.4 4277.3 4898.8 5344.5 5667.8 5681.7 3182.8 3278.3 3457.0 3712.7 3721.7 4843.8 5259.2 5452.1 5668.9 5791.0 4939.8 5071.7 5442.8 5596.6 5609.9 5274.6 5498.5 5502.3 5503.0 5566.9 4754.7 4777.4 4985.2 5382.6 5418.8 4909.9 5008.0 5441.9 5455.6 5455.7 4114.5 4792.8 5180.7 5363.7 5426.0 07:27:32 INFO - PROCESS | 2102 | 07:27:32 INFO - PROCESS | 2102 | [#5] yui.html Cycles:180 Average:24822.31 Median:3676.76 stddev:39512.11 (1074.6%) stddev-sans-first:39581.44 07:27:32 INFO - PROCESS | 2102 | Values: 700.9 703.3 716.4 747.1 833.4 15600.8 16623.8 16624.6 16626.7 16634.3 14863.5 15046.5 15065.0 15068.8 15141.9 679.4 706.7 834.1 853.4 866.6 840.2 855.7 856.9 857.5 857.9 764.0 910.2 910.2 912.0 912.7 711.8 738.6 740.9 901.9 910.4 552.9 553.3 658.1 684.5 688.2 15380.3 15450.3 15457.5 15462.1 15479.0 14042.4 14208.4 14248.0 14295.9 14337.6 12833.2 12938.2 12999.4 13025.4 13110.6 4515.4 4555.2 4636.6 4639.4 4684.9 110621.4 113305.4 113332.9 113680.6 114055.9 10227.4 10695.2 10841.3 10907.9 11479.5 21470.0 21563.9 21686.5 21760.8 21882.7 6908.3 7583.8 7709.2 7747.0 7815.9 4282.7 4337.8 4366.3 4384.9 4483.6 3559.2 3673.3 3680.2 3685.2 3689.3 558.5 670.2 679.2 680.3 681.3 481.9 590.7 601.3 613.4 635.3 8549.4 8962.7 9060.7 9183.2 9273.8 574.1 591.4 603.5 621.8 624.4 4386.2 4461.6 4494.3 4509.1 4531.7 100597.7 127877.0 128659.0 156121.0 162161.3 88575.0 136591.0 143975.0 144768.0 146282.3 98610.0 113617.4 115742.0 121839.4 122944.0 8281.7 8392.5 8568.6 8765.0 8952.0 55038.7 68721.5 68844.0 71396.3 72589.0 67185.7 85938.0 89315.0 89843.0 103860.5 10747.7 10798.0 10811.1 10887.6 11218.6 12361.6 12931.9 14428.5 14809.1 15209.5 13780.4 13917.4 13951.8 13982.4 14189.5 13827.9 13909.9 14034.7 14170.6 14607.9 13134.5 13369.7 13560.3 13704.9 13742.8 10810.8 11218.2 11299.3 11329.5 11688.1 10746.4 11336.7 11351.2 11493.7 11509.5 07:27:32 INFO - PROCESS | 2102 | -------- Summary: end -------- 07:27:32 INFO - PROCESS | 2102 | 07:27:32 INFO - TEST-INFO | 2102: exit 0 07:27:32 INFO - TEST-OK | dromaeo_css | took 1117971ms 07:27:32 INFO - TEST-START | kraken 07:27:32 INFO - operating with platform_type : mac_ 07:27:32 INFO - Initialising browser for kraken test... 07:27:32 INFO - TEST-INFO | started process 2104 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmpikMTox/profile http://localhost:50979/getInfo.html) 07:27:35 INFO - PROCESS | 2104 | __metrics Screen width/height:1600/1200 07:27:35 INFO - PROCESS | 2104 | colorDepth:24 07:27:35 INFO - PROCESS | 2104 | Browser inner width/height: 1024/689 07:27:35 INFO - PROCESS | 2104 | __metrics 07:27:35 INFO - PROCESS | 2104 | 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" 07:27:35 INFO - PROCESS | 2104 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:27:35 INFO - TEST-INFO | 2104: exit 0 07:27:35 INFO - Browser initialized. 07:27:35 INFO - Running cycle 1/1 for kraken test... 07:27:35 INFO - TEST-INFO | started process 2105 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmpikMTox/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:27:47 INFO - PROCESS | 2105 | RSS: Main: 228847616 07:27:47 INFO - PROCESS | 2105 | 07:27:50 INFO - PROCESS | 2105 | Cycle 1(1): loaded http://localhost:50979/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50979/tests/kraken/driver.html?testName=audio-beat-detection) 07:27:51 INFO - PROCESS | 2105 | RSS: Main: 285663232 07:27:51 INFO - PROCESS | 2105 | 07:27:53 INFO - PROCESS | 2105 | Cycle 1(1): loaded http://localhost:50979/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50979/tests/kraken/driver.html?testName=audio-dft) 07:27:54 INFO - PROCESS | 2105 | RSS: Main: 294748160 07:27:54 INFO - PROCESS | 2105 | 07:27:58 INFO - PROCESS | 2105 | Cycle 1(1): loaded http://localhost:50979/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50979/tests/kraken/driver.html?testName=audio-fft) 07:27:58 INFO - PROCESS | 2105 | RSS: Main: 388468736 07:27:58 INFO - PROCESS | 2105 | 07:28:00 INFO - PROCESS | 2105 | Cycle 1(1): loaded http://localhost:50979/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50979/tests/kraken/driver.html?testName=audio-oscillator) 07:28:01 INFO - PROCESS | 2105 | RSS: Main: 290172928 07:28:01 INFO - PROCESS | 2105 | 07:28:03 INFO - PROCESS | 2105 | Cycle 1(1): loaded http://localhost:50979/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50979/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:28:04 INFO - PROCESS | 2105 | RSS: Main: 294600704 07:28:04 INFO - PROCESS | 2105 | 07:28:06 INFO - PROCESS | 2105 | Cycle 1(1): loaded http://localhost:50979/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50979/tests/kraken/driver.html?testName=imaging-darkroom) 07:28:07 INFO - PROCESS | 2105 | RSS: Main: 331898880 07:28:07 INFO - PROCESS | 2105 | 07:28:10 INFO - PROCESS | 2105 | Cycle 1(1): loaded http://localhost:50979/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50979/tests/kraken/driver.html?testName=imaging-desaturate) 07:28:10 INFO - PROCESS | 2105 | RSS: Main: 331886592 07:28:10 INFO - PROCESS | 2105 | 07:28:13 INFO - PROCESS | 2105 | Cycle 1(1): loaded http://localhost:50979/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50979/tests/kraken/driver.html?testName=json-parse-financial) 07:28:14 INFO - PROCESS | 2105 | RSS: Main: 331587584 07:28:14 INFO - PROCESS | 2105 | 07:28:16 INFO - PROCESS | 2105 | Cycle 1(1): loaded http://localhost:50979/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50979/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:28:16 INFO - PROCESS | 2105 | RSS: Main: 301318144 07:28:16 INFO - PROCESS | 2105 | 07:28:18 INFO - PROCESS | 2105 | Cycle 1(1): loaded http://localhost:50979/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50979/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:28:19 INFO - PROCESS | 2105 | RSS: Main: 307445760 07:28:19 INFO - PROCESS | 2105 | 07:28:21 INFO - PROCESS | 2105 | Cycle 1(1): loaded http://localhost:50979/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50979/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:28:22 INFO - PROCESS | 2105 | RSS: Main: 311603200 07:28:22 INFO - PROCESS | 2105 | 07:28:24 INFO - PROCESS | 2105 | Cycle 1(1): loaded http://localhost:50979/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50979/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:28:25 INFO - PROCESS | 2105 | RSS: Main: 314535936 07:28:25 INFO - PROCESS | 2105 | 07:28:28 INFO - PROCESS | 2105 | Cycle 1(1): loaded http://localhost:50979/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50979/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:28:29 INFO - PROCESS | 2105 | RSS: Main: 315871232 07:28:29 INFO - PROCESS | 2105 | 07:28:30 INFO - PROCESS | 2105 | Cycle 1(1): loaded http://localhost:50979/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50979/tests/kraken/driver.html?testName=ai-astar) 07:28:31 INFO - PROCESS | 2105 | RSS: Main: 359374848 07:28:31 INFO - PROCESS | 2105 | 07:28:31 INFO - PROCESS | 2105 | __start_tp_report 07:28:31 INFO - PROCESS | 2105 | _x_x_mozilla_page_load 07:28:31 INFO - PROCESS | 2105 | _x_x_mozilla_page_load_details 07:28:31 INFO - PROCESS | 2105 | |i|pagename|runs| 07:28:31 INFO - PROCESS | 2105 | |0;ai-astar;102;113;111;112;106;112;115;113;111;112 07:28:31 INFO - PROCESS | 2105 | |1;audio-beat-detection;146;107;106;169;118;135;163;110;162;106 07:28:31 INFO - PROCESS | 2105 | |2;audio-dft;185;184;185;183;184;180;183;229;252;182 07:28:31 INFO - PROCESS | 2105 | |3;audio-fft;75;57;61;87;57;59;65;63;84;57 07:28:31 INFO - PROCESS | 2105 | |4;audio-oscillator;84;69;102;70;71;69;98;71;68;105 07:28:31 INFO - PROCESS | 2105 | |5;imaging-gaussian-blur;87;84;88;93;88;84;86;84;87;84 07:28:31 INFO - PROCESS | 2105 | |6;imaging-darkroom;92;91;93;92;94;92;93;94;94;93 07:28:31 INFO - PROCESS | 2105 | |7;imaging-desaturate;86;87;84;84;82;85;103;131;132;86 07:28:31 INFO - PROCESS | 2105 | |8;json-parse-financial;56;55;57;57;56;56;55;56;57;55 07:28:31 INFO - PROCESS | 2105 | |9;json-stringify-tinderbox;64;64;74;69;76;72;72;69;70;73 07:28:31 INFO - PROCESS | 2105 | |10;stanford-crypto-aes;85;87;84;88;87;88;86;85;89;119 07:28:31 INFO - PROCESS | 2105 | |11;stanford-crypto-ccm;138;140;140;138;140;138;139;135;153;136 07:28:31 INFO - PROCESS | 2105 | |12;stanford-crypto-pbkdf2;169;169;167;169;230;219;167;168;168;166 07:28:31 INFO - PROCESS | 2105 | |13;stanford-crypto-sha256-iterative;67;68;68;69;67;66;67;67;67;66 07:28:31 INFO - PROCESS | 2105 | __end_tp_report 07:28:31 INFO - PROCESS | 2105 | __start_cc_report 07:28:31 INFO - PROCESS | 2105 | _x_x_mozilla_cycle_collect,2001 07:28:31 INFO - PROCESS | 2105 | __end_cc_report 07:28:31 INFO - PROCESS | 2105 | __startTimestamp1471098511047__endTimestamp 07:28:31 INFO - PROCESS | 2105 | 07:28:31 INFO - PROCESS | 2105 | ------- Summary: start ------- 07:28:31 INFO - PROCESS | 2105 | Number of tests: 14 07:28:31 INFO - PROCESS | 2105 | 07:28:31 INFO - PROCESS | 2105 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:3.83 (3.4%) stddev-sans-first:2.45 07:28:31 INFO - PROCESS | 2105 | Values: 102.0 113.0 111.0 112.0 106.0 112.0 115.0 113.0 111.0 112.0 07:28:31 INFO - PROCESS | 2105 | 07:28:31 INFO - PROCESS | 2105 | [#1] audio-beat-detection Cycles:10 Average:132.20 Median:140.50 stddev:26.02 (18.5%) stddev-sans-first:27.11 07:28:31 INFO - PROCESS | 2105 | Values: 146.0 107.0 106.0 169.0 118.0 135.0 163.0 110.0 162.0 106.0 07:28:31 INFO - PROCESS | 2105 | 07:28:31 INFO - PROCESS | 2105 | [#2] audio-dft Cycles:10 Average:194.70 Median:184.50 stddev:24.78 (13.4%) stddev-sans-first:26.04 07:28:31 INFO - PROCESS | 2105 | Values: 185.0 184.0 185.0 183.0 184.0 180.0 183.0 229.0 252.0 182.0 07:28:31 INFO - PROCESS | 2105 | 07:28:31 INFO - PROCESS | 2105 | [#3] audio-fft Cycles:10 Average:66.50 Median:64.00 stddev:11.40 (17.8%) stddev-sans-first:11.67 07:28:31 INFO - PROCESS | 2105 | Values: 75.0 57.0 61.0 87.0 57.0 59.0 65.0 63.0 84.0 57.0 07:28:31 INFO - PROCESS | 2105 | 07:28:31 INFO - PROCESS | 2105 | [#4] audio-oscillator Cycles:10 Average:80.70 Median:70.50 stddev:15.25 (21.6%) stddev-sans-first:16.12 07:28:31 INFO - PROCESS | 2105 | Values: 84.0 69.0 102.0 70.0 71.0 69.0 98.0 71.0 68.0 105.0 07:28:31 INFO - PROCESS | 2105 | 07:28:31 INFO - PROCESS | 2105 | [#5] imaging-gaussian-blur Cycles:10 Average:86.50 Median:87.00 stddev:2.84 (3.3%) stddev-sans-first:3.00 07:28:31 INFO - PROCESS | 2105 | Values: 87.0 84.0 88.0 93.0 88.0 84.0 86.0 84.0 87.0 84.0 07:28:31 INFO - PROCESS | 2105 | 07:28:31 INFO - PROCESS | 2105 | [#6] imaging-darkroom Cycles:10 Average:92.80 Median:93.00 stddev:1.03 (1.1%) stddev-sans-first:1.05 07:28:31 INFO - PROCESS | 2105 | Values: 92.0 91.0 93.0 92.0 94.0 92.0 93.0 94.0 94.0 93.0 07:28:31 INFO - PROCESS | 2105 | 07:28:31 INFO - PROCESS | 2105 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:84.50 stddev:19.60 (23.2%) stddev-sans-first:20.45 07:28:31 INFO - PROCESS | 2105 | Values: 86.0 87.0 84.0 84.0 82.0 85.0 103.0 131.0 132.0 86.0 07:28:31 INFO - PROCESS | 2105 | 07:28:31 INFO - PROCESS | 2105 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:0.82 (1.5%) stddev-sans-first:0.87 07:28:31 INFO - PROCESS | 2105 | Values: 56.0 55.0 57.0 57.0 56.0 56.0 55.0 56.0 57.0 55.0 07:28:31 INFO - PROCESS | 2105 | 07:28:31 INFO - PROCESS | 2105 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:72.00 stddev:3.97 (5.5%) stddev-sans-first:3.50 07:28:31 INFO - PROCESS | 2105 | Values: 64.0 64.0 74.0 69.0 76.0 72.0 72.0 69.0 70.0 73.0 07:28:31 INFO - PROCESS | 2105 | 07:28:31 INFO - PROCESS | 2105 | [#10] stanford-crypto-aes Cycles:10 Average:89.80 Median:87.00 stddev:10.38 (11.9%) stddev-sans-first:10.86 07:28:31 INFO - PROCESS | 2105 | Values: 85.0 87.0 84.0 88.0 87.0 88.0 86.0 85.0 89.0 119.0 07:28:31 INFO - PROCESS | 2105 | 07:28:31 INFO - PROCESS | 2105 | [#11] stanford-crypto-ccm Cycles:10 Average:139.70 Median:139.50 stddev:4.97 (3.6%) stddev-sans-first:5.23 07:28:31 INFO - PROCESS | 2105 | Values: 138.0 140.0 140.0 138.0 140.0 138.0 139.0 135.0 153.0 136.0 07:28:31 INFO - PROCESS | 2105 | 07:28:31 INFO - PROCESS | 2105 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.20 Median:169.00 stddev:24.04 (14.2%) stddev-sans-first:25.21 07:28:31 INFO - PROCESS | 2105 | Values: 169.0 169.0 167.0 169.0 230.0 219.0 167.0 168.0 168.0 166.0 07:28:31 INFO - PROCESS | 2105 | 07:28:31 INFO - PROCESS | 2105 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 07:28:31 INFO - PROCESS | 2105 | Values: 67.0 68.0 68.0 69.0 67.0 66.0 67.0 67.0 67.0 66.0 07:28:31 INFO - PROCESS | 2105 | -------- Summary: end -------- 07:28:31 INFO - PROCESS | 2105 | 07:28:31 INFO - TEST-INFO | 2105: exit 0 07:28:31 INFO - TEST-OK | kraken | took 59207ms 07:28:31 INFO - SUITE-END | took 1177s 07:28:32 INFO - Completed test suite (00:19:37) 07:28:32 INFO - javascript benchmark 07:28:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3308.7683862129647, 3309.917252068698, 3335.7498187635924, 3338.7662863599544, 3343.6154842193155, 5610.663360198391, 5664.461876121762, 5679.403662615423, 5744.138379243115, 5752.453516915897, 5691.658500489973, 5694.202811606378, 5794.333651630064, 5804.738786754596, 5809.3609702932645, 5098.464661210575, 5100.387953445592, 5181.4300426953005, 5193.091209038422, 5265.341832270966, 5252.579793616521, 5284.788608455677, 5286.656367336111, 5302.390225124122, 5333.626646134772, 5129.333186685744, 5157.5616072633875, 5176.327077479904, 5195.532402083812, 5221.582273418156, 5141.408737995141, 5171.405288391846, 5211.348581427322, 5232.92150617741, 5296.708681022542, 5116.309298244763, 5140.511651393112, 5149.0, 5217.373915130171, 5234.685918844843, 5711.657300561979, 5741.741621627037, 5785.566082543826, 5794.855128621818, 5798.855028624276, 6132.69336533176, 6149.600275982047, 6216.720247588869, 6238.87522249557, 6259.71831267594, 6175.722092505848, 6220.098085777582, 6227.719752611098, 6234.220722409699, 6244.188255526798, 5837.3287071986415, 5872.354041055438, 5874.882502349929, 5876.324222714443, 5895.764169433218, 6217.4715149212825, 6221.657808820558, 6279.183706118175, 6288.434040936338, 6292.811215663537, 6114.206128133723, 6126.326104128631, 6127.417895299939, 6130.172426722335, 6136.110264011782, 6272.090546870678, 6287.025511045796, 6287.559870808999, 6293.622382657055, 6308.274548426898, 6088.178095957078, 6114.449440885101, 6142.355052719489, 6181.876362472725, 6204.348543402968, 5233.293505376725, 6205.503559715212, 6218.657973811484, 6252.499800015988, 6275.215598050244, 4900.313956046157, 4923.606111511071, 4930.2851086592245, 4930.654854160174, 4986.576141027981, 4368.956310436855, 4383.473983121982, 4400.339949007611, 4463.285874260103, 4481.439820022497, 5756.740946657411, 5760.913586296209, 5764.250647415809, 5800.970995144998, 5806.941930580725, 6224.138703686101, 6289.182406287154, 6295.401936815995, 6305.022721478178, 6305.621662700252, 5610.943890561124, 5707.315122185281, 5722.484976352148, 5787.971060144757, 5799.739011744397, 5418.756155972991, 5423.0, 5425.457454254622, 5460.726963651801, 5469.753861076261, 6303.054541818764, 6313.684315784192, 6324.683765811599, 6324.810255692337, 6330.113784070142, 6148.78479253224, 6234.438900498795, 6285.308616052139, 6303.086052522451, 6310.842228944313, 6242.719077641608, 6259.34276900937, 6291.528135389773, 6291.622502649856, 6318.210223722035, 6168.290646575701, 6188.597741146811, 6220.098085777628, 6221.440070393686, 6233.438990490697, 6229.12792209082, 6277.372262773869, 6286.37136286386, 6286.6856657166045, 6301.149344838572, 4905.288733133747, 6028.246469191351, 6079.3008803988105, 6096.055111457731, 6120.7857724981195, 6033.698315084141, 6062.090686397076, 6064.0, 6066.241719785027, 6087.421694938974, 4513.977430112828, 5908.1137829324225, 5920.0, 5931.733072011856, 5949.1076338549565, 5910.290765108214, 5998.580099393001, 6035.426634469718, 6069.848253793691, 6077.939220607915, 5884.676342801187, 5942.1383899335215, 5944.167816505606, 5960.403959604005, 5963.4334738199805], "value": 5689.958475920102, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [459.39360044740954, 499.4044029326304, 516.9508896654818, 541.610040770645, 548.1202669715107, 31090.222744431372, 41681.3747793783, 42021.73934781957, 42199.15601687964, 42247.155056898846, 38401.0, 40301.59698403015, 42797.358039629355, 43047.569524304745, 43291.13417731643, 9650.372725772837, 9851.95074024629, 9861.70414887551, 9862.704118876445, 9863.260255480867, 7863.93836832029, 8478.109798471134, 9044.321675874302, 9170.770730731718, 9172.12864777845, 8946.507942063185, 11930.821037684398, 12156.939215303912, 12163.878361216362, 12385.752284954295, 11595.94202028993, 11800.704982375424, 11873.584424545099, 11885.930266276077, 11893.643190704206, 10495.527701253463, 12068.577599784054, 12077.57728479499, 12082.879171208264, 12092.153549251556, 40029.59970400288, 40358.79820600907, 40368.39447408291, 40523.7973810132, 40558.18883622311, 3442.569678790151, 3668.0279725872665, 3686.963130368689, 3899.1032062625754, 4099.7745124018165, 30821.383572328654, 31311.37377252465, 31686.0, 31700.0, 32378.514322285184, 3214.8231847248394, 3246.253361726816, 3274.4106060909025, 3360.260742636616, 3398.167448974992, 371451.0, 463643.0, 463719.0, 464716.0, 465267.0, 32790.83604581962, 33553.496697549555, 56216.15675764867, 56440.87118257612, 56532.0, 34902.476462853076, 35040.64959350425, 35061.47407788885, 35113.648863511036, 35162.648373515935, 12155.088368372408, 14728.926355368154, 14733.336999835034, 14738.336774845158, 14738.336774845158, 12531.310777907303, 12626.558070467674, 12659.556915508098, 12677.366131693563, 12688.873111268953, 6057.697115144225, 7370.152432470228, 7644.388448924073, 7750.341220996165, 7855.685772569033, 3171.809691418522, 3217.549543063973, 3250.2524419383203, 3262.3964566555264, 3286.145602143412, 951.2390087929767, 955.3121752338305, 955.9808803823885, 988.6342053440274, 1046.2728403759465, 26440.603390949153, 27848.582271265946, 28028.0, 30091.539472960452, 30413.0, 959.5250351076262, 1069.657709532942, 1090.345792524479, 1091.247039542713, 1114.8272017837248, 15194.848051519564, 15576.0, 15579.14314712679, 15588.454404095803, 15592.844071559366, 648905.0, 691455.0, 693439.0, 693846.0, 694095.0, 51362.74318628383, 52067.218991715155, 58230.83538329294, 59073.70463147743, 59524.0, 1035.3477309295097, 1321.3459337627935, 1322.6428864206418, 1328.9867101329057, 1353.4653811744504, 24853.378665533506, 30938.0718578443, 31400.842995784875, 31721.36557268888, 31812.5228121583, 51089.74455127701, 51328.74335628298, 51363.2295515575, 51429.48570514247, 51579.22631160461, 498217.0, 501528.0, 501931.0, 885518.5724071339, 909996.0, 43043.20219185743, 43668.0, 43815.9046023852, 43830.34254486122, 44254.55745442504, 47956.0, 48456.75771621119, 48786.756066219445, 48791.5120848787, 49084.75457622689, 39061.0, 39066.0, 39259.41110883282, 39967.0, 40983.385249220686, 37225.0, 38155.42766858444, 39128.608713912494, 39226.2154756909, 40734.59265407308, 38311.23377532378, 38722.804351303654, 38865.61134388733, 38943.221135577696, 39149.6085039146, 29340.0, 31758.523622145225, 34683.0, 34818.30363392668, 35003.47494787631, 21581.784182158604, 24242.87878560596, 24819.883105259945, 25436.618450723625, 25710.485790284463], "value": 19126.675524247385, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.207000458981, 369.38497401825975, 376.85679441812107, 382.1725963289479, 403.68310875962356, 12242.510299588017, 17142.82857171428, 20890.0, 21583.46041348967, 21685.783142168573, 15184.696306073873, 20369.87965661888, 20767.688484672704, 21122.788772112275, 22340.329790106283, 5426.21319908615, 5728.914066289009, 5963.612365196259, 6239.688015599225, 6245.531585131111, 4224.5353011168745, 6075.422834830684, 6169.876602467948, 6182.196314479112, 6187.35032821554, 6505.251896031946, 6849.315068493136, 6862.142232220973, 6939.097917270773, 6948.062011628442, 6638.4689224861895, 6804.76183333581, 6852.6916288767125, 6871.14110736158, 6937.861242775141, 5690.118031705092, 5916.852078698024, 5919.644821310692, 5948.7323070461935, 5952.791652292192, 27772.166834994983, 28095.438091238266, 28162.0, 28359.57460638092, 28434.71565284362, 2300.5628930503317, 2447.192426499251, 2511.510255500178, 2607.465469578751, 3210.5184222366597, 16849.915750421293, 16993.15034248295, 17293.30826766928, 17921.103944802708, 18230.0, 2002.1991203518564, 2023.706562548437, 2036.9592608147755, 2061.7628972668185, 2082.739657542807, 95818.87586682756, 113820.0, 135756.0, 153631.0, 154130.22934885253, 19865.503362416057, 21357.78642213589, 21397.823119728564, 21471.46321341979, 21633.891830540746, 35658.10854728652, 35733.64266357355, 35762.0, 35862.46206306908, 35874.0, 10749.62376316825, 10954.287971282001, 11052.778944421227, 11123.27698699582, 11286.379249141377, 8332.541710205876, 8369.121242269473, 9077.68228112013, 9132.726018219464, 9277.721668349961, 9332.626694932127, 9636.903630963741, 9736.853947190797, 9797.0, 9809.607615695293, 2983.3585779057607, 3436.7766095203733, 3628.26446856218, 3659.3116323410045, 3755.8309876055096, 819.9016118065871, 929.8651695504115, 951.7477868364889, 956.9521523923916, 1005.9396436213705, 21755.67366489504, 22346.441338966655, 22427.551448970928, 22632.321030369116, 22664.773352266595, 938.596403546468, 944.9244060475146, 966.4201479112617, 999.4453078541334, 1040.5681642118586, 11466.54133834654, 11566.190366674253, 11692.824607630891, 11716.94141529304, 11740.647780566596, 581193.0, 604712.0, 604987.0, 622338.0, 624063.0, 67138.66430667815, 74003.0, 89497.55251223702, 110385.0, 127237.0, 961.7691753978995, 1016.7813920007234, 1037.9429131397847, 1041.1358572384902, 1042.2652030318607, 18364.72452913234, 20350.0, 20509.794902050788, 20526.281580144623, 20549.38351849447, 50918.98162036664, 57089.0, 57380.426195737506, 58587.535311617554, 59044.0, 56791.0, 79843.20156798357, 82031.0, 83839.0, 87527.56236218777, 7930.682772689028, 8168.142345053921, 8233.670653173805, 8261.504309741435, 8329.208725171098, 9707.66023189185, 12744.74510509803, 12858.292793896426, 13149.53976610814, 13251.337433128112, 10786.568537258421, 11033.613823516138, 11331.150163737588, 11456.94271528637, 11599.88400115988, 10236.590536378759, 10557.260991730505, 10861.619843305762, 11092.778144437227, 11223.831642525533, 9964.60141594357, 10467.639206903053, 11204.439778010903, 11640.650780476599, 11794.646160615195, 6793.796186114425, 8110.716124935599, 8113.553754543556, 8224.671013159406, 8455.74632761018, 8334.416590838826, 10155.339902906288, 11103.389313587508, 11489.54041838317, 11554.94222528882], "value": 10793.105053937767, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1485.2202593638335, 1533.2563706602298, 1678.3538337739967, 1811.9637607247846, 1830.0758117150845, 8378.539180345078, 8916.242119419858, 8917.15287047731, 8927.776805579855, 8931.464112153268, 7858.882116768253, 8036.638351274192, 8366.95816520918, 8587.270082043018, 8706.347023973212, 2344.0623750499767, 2378.5480758655885, 2378.702662167229, 2378.8096952243777, 2383.177803657744, 2337.824663150262, 2360.421696684306, 2361.929142125739, 2382.356763673807, 2384.6661467394492, 2312.2369618026096, 2324.1168356024687, 2356.658284548748, 2368.5973384524673, 2372.7627237276306, 2331.6852224949585, 2341.531693661266, 2342.9648555271683, 2346.612808886549, 2348.6946696929376, 2343.414146463384, 2344.5076533927895, 2347.295811256616, 2348.1429278313294, 2353.164626557582, 8632.784180395478, 8818.691345802867, 8824.249938755149, 8827.558622068871, 8828.293736501064, 5167.147420675584, 5334.893302133974, 5339.279197308352, 5344.545713614348, 5349.224362467459, 3347.1799409144674, 3413.9658603413895, 3563.9109022274392, 3567.1973805893726, 3576.5529308836394, 1047.4710271312938, 1053.467998660679, 1061.5382308695741, 1074.2856000759487, 1077.4343469678404, 11507.424628768527, 11652.76694466106, 11672.766544669144, 11675.649730508097, 11685.0, 4555.476120246148, 4607.815687372467, 4769.976150119227, 4806.086843499724, 4817.927731084036, 9910.108090271766, 9920.255980801468, 9921.900780992242, 9923.1069203772, 9928.602855885829, 5314.388845282765, 5326.121190003606, 5326.387465441524, 5336.91994620081, 5339.839804805862, 4121.155163191538, 4396.428464299621, 4520.728756274634, 4898.804047838046, 4912.803487860517, 3883.514560679915, 4005.6595189408645, 4025.4766880305374, 4027.456293400412, 4036.616521430459, 1067.8238090714945, 1246.1308037943086, 1290.2387591321165, 1300.5318085489216, 1303.67408147963, 680.7175022365662, 779.5556532776263, 838.2078935406105, 892.4422236102436, 918.6417297254076, 5722.370539240764, 5737.655740655574, 5976.970115149396, 6117.877642447215, 6168.9691551542855, 378.4947095627313, 412.91122408682276, 424.98300067997553, 443.9311906654409, 447.73583585684605, 3975.1254723960683, 3985.043589538548, 4056.1684854604737, 4069.8372065117064, 4124.195781822576, 10231.94884025575, 10736.033756961755, 10747.40889251083, 10754.247202695893, 10765.730856728644, 10672.25294229412, 10696.62561810333, 10725.51735171919, 10729.83905241422, 10746.677599672023, 8033.477823941425, 8045.396595255379, 8078.515289082674, 8170.714025009215, 8172.6322315495945, 5513.393526711979, 5786.132080188006, 5845.152452894392, 5903.7048147593305, 5927.496162826035, 9674.419534827934, 9948.950255248677, 10014.048665376778, 10037.146842518176, 10056.296059276074, 9228.769280768034, 9516.095970882756, 9630.036996300594, 9990.10089091956, 10104.0, 7091.2554181810165, 7233.746818861315, 7246.130464344313, 7254.202037775946, 7372.299631534996, 8187.959060204661, 8309.0, 8309.00291964968, 8370.16298370158, 8387.706430274911, 7551.924480755122, 7590.734324298623, 7599.848003040019, 7659.808504787425, 7677.884831727641, 7292.525985810906, 7344.48588598793, 7440.255974402517, 7500.774976750707, 7522.285382888617, 6911.239763626098, 6923.757668481579, 7062.435005199469, 7064.752733654297, 7067.717291308496, 4881.463039065771, 4966.428860680923, 4969.726665033458, 5045.84862454127, 5174.560162386239, 4961.734757636779, 4995.8001679932395, 5076.517730815566, 5095.796168153232, 5165.276861239355], "value": 4472.2388326389555, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [260.96216048672943, 296.64254573239265, 310.6718777227353, 314.52192667145925, 316.8225793555609, 5209.739513024348, 5223.71269580173, 5255.421903590612, 5266.339893773828, 5280.762365693543, 4422.845200417986, 4870.050340183666, 4937.494064310384, 5155.4586768389345, 5217.426083130853, 3460.394430974582, 3966.206758648275, 3976.8210430530694, 4011.9197616047663, 4035.6367926886574, 3563.4832949222478, 3969.5831937646562, 4017.9598204018025, 4027.234825383168, 4031.560905652082, 3042.600403814237, 3743.7566558173767, 3843.577206507296, 3940.349842276021, 4007.799610019502, 3482.5820901491984, 3817.5609804872515, 3920.961100227894, 3934.7442416243, 3952.5454572724075, 2856.985715071432, 3035.514317709156, 3445.43150380187, 3455.3241677786255, 3462.601800792916, 4803.351547541072, 4920.729359885205, 5001.949980500185, 5010.849674509771, 5028.874278143039, 3765.35988881888, 4500.662450316239, 4506.7070640408265, 4512.819487220508, 4540.387047748578, 5345.144776835727, 5360.705161216131, 5370.409254981949, 5417.106177480711, 5418.214358917974, 3164.5095010273444, 3262.771605987582, 3783.5838057813617, 3785.5646600641003, 3797.810109494514, 3996.760194388317, 5609.411011843779, 5623.465770751731, 5650.576206784508, 5724.685142317213, 3512.3677738007405, 3750.924981500409, 3751.9437208441896, 3789.787268074245, 3790.7156963227867, 3800.0, 3810.8094595270127, 3813.7902415366866, 3826.234753049401, 3834.539855217392, 4225.746455212697, 4422.778861056934, 4481.977590112028, 4514.480834703985, 4557.316402539645, 4236.195122926634, 5293.470652934676, 5424.294841670558, 5440.483154100354, 5594.104943209149, 1291.754566632337, 1301.6420484366686, 1312.2061153002487, 1316.6898935558988, 1326.7611829870523, 750.9636701352208, 760.9391248700091, 792.7383963292215, 814.4950130918868, 862.4868203418956, 4717.160307480085, 4833.3958255218095, 4851.671197824993, 4996.350474438373, 5030.924536131961, 4512.706674066175, 4831.4202295724735, 4995.425526064549, 5380.408155102936, 5456.399796022434, 4583.816647334136, 4885.5847252983185, 4895.951040489549, 4924.926126108111, 4995.475475075137, 2788.776897848167, 2881.6253886994555, 2884.7259510346485, 2889.7399234068616, 2890.9710902891125, 5273.31446911899, 5622.690752008679, 5644.322681278273, 5651.8304450866535, 5666.546676265972, 4404.955950440519, 4752.667313288037, 4824.662273640882, 5560.833175004756, 5677.403872593318, 5146.6911985281, 5374.527717250109, 5417.864553386197, 5681.517071049007, 5687.516561092353, 5222.817201397933, 5480.3971563127225, 5485.232067510472, 5486.890262194814, 5491.670499770026, 4107.609777071173, 4785.588251465756, 5291.682499050069, 5331.3868905076415, 5408.405075441777, 4277.272863613131, 4898.7550622468025, 5344.4922732340365, 5667.846218436967, 5681.687507187145, 3182.8038653329127, 3278.311554573471, 3457.0320310313155, 3712.6658600726064, 3721.6650501455, 4843.782029808737, 5259.211118332128, 5452.073147565003, 5668.894565559841, 5790.971045144747, 4939.753012349296, 5071.670341427795, 5442.836714898401, 5596.552275817843, 5609.943900560942, 5274.551663108678, 5498.542886135097, 5502.257195278747, 5502.972485137549, 5566.944330556805, 4754.7399939015495, 4777.378940737821, 4985.205326082535, 5382.596305277041, 5418.756155973069, 4909.901801963869, 5008.023435430056, 5441.863953401196, 5455.590830687794, 5455.672659640434, 4114.526829414655, 4792.832250871203, 5180.704823794052, 5363.651362661414, 5425.972870135624], "value": 3915.9779607279957, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.9369156775889, 703.349401803332, 716.4411758828115, 747.1109379837992, 833.395788053661, 15600.765988510168, 16623.83376166238, 16624.58438539037, 16626.66746665066, 16634.251458684357, 14863.479778207766, 15046.54860354191, 15065.0, 15068.849311506881, 15141.924290378533, 679.37497502298, 706.6678661029333, 834.0825092398344, 853.406882216858, 866.5797088412147, 840.197611281228, 855.7304449098546, 856.87146927961, 857.498363457375, 857.8541647919837, 763.9847203055936, 910.2172131966504, 910.2172131966504, 912.0286894457381, 912.7444315591612, 711.8184862859989, 738.5753191914671, 740.9444291678145, 901.9188273055423, 910.3945875992457, 552.9281193444866, 553.3000754046135, 658.108263303222, 684.4524380495633, 688.198249039868, 15380.30788614515, 15450.304736286782, 15457.5362739118, 15462.072275663497, 15479.0, 14042.36809343582, 14208.44209335332, 14248.0, 14295.857041429557, 14337.56987290383, 12833.230006199658, 12938.223706577635, 12999.415026323744, 13025.413856376392, 13110.606681799562, 4515.435570553681, 4555.2256116460285, 4636.582707556337, 4639.393080682285, 4684.852211208242, 110621.44689276502, 113305.43347283211, 113332.86667133306, 113680.61076030115, 114055.85944140618, 10227.43749093807, 10695.197860160519, 10841.295315804606, 10907.881279354884, 11479.483423245974, 21470.0, 21563.921803909743, 21686.45783855416, 21760.782392176192, 21882.671759923614, 6908.274631163656, 7583.810404739926, 7709.2290770922455, 7747.0, 7815.882761758578, 4282.729978611256, 4337.783110844445, 4366.257736184856, 4384.912301753947, 4483.574060464251, 3559.18138828071, 3673.3204357194004, 3680.208755117609, 3685.2076803486843, 3689.317476266899, 558.4889825809339, 670.2258890980925, 679.2053297641771, 680.3196803196803, 681.3322943515383, 481.9253015782559, 590.6928397233414, 601.3235110500686, 613.362103412455, 635.3455940381415, 8549.401541892132, 8962.731118066338, 9060.728178154666, 9183.173514383738, 9273.814523709489, 574.1387918122816, 591.3642833953517, 603.5352778360638, 621.7812144598875, 624.4411251929498, 4386.188555117314, 4461.643068554507, 4494.303382975644, 4509.120721459284, 4531.660125490535, 100597.72357399983, 127877.0, 128659.0, 156121.0, 162161.3257462319, 88575.0, 136591.0, 143975.0, 144768.0, 146282.2685886585, 98610.0, 113617.43191284157, 115742.0, 121839.39080304542, 122944.0, 8281.710140145065, 8392.531307021125, 8568.57157142153, 8765.031799719365, 8952.0, 55038.724806375714, 68721.46687045383, 68844.0, 71396.28603714104, 72589.0, 67185.66407167933, 85938.0, 89315.0, 89843.0, 103860.48069759602, 10747.677569672922, 10798.0, 10811.081058110149, 10887.564497420015, 11218.55125794959, 12361.567345142877, 12931.870681293443, 14428.495002674856, 14809.111453312837, 15209.543713688607, 13780.448782048607, 13917.373718182504, 13951.790723138958, 13982.370793314121, 14189.503367382093, 13827.861721382658, 13909.930450347683, 14034.719305614035, 14170.645733856736, 14607.853921461074, 13134.474621015435, 13369.66575835612, 13560.254186019863, 13704.862951370758, 13742.781682259661, 10810.783784324427, 11218.214724969173, 11299.322040677585, 11329.490172942402, 11688.064954803425, 10746.408947507962, 11336.659900203007, 11351.205415620827, 11493.712657183638, 11509.482073306888], "value": 7771.037420648079, "unit": "score"}], "name": "dromaeo_css", "value": 7367.126245054638, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 111.0, 112.0, 106.0, 112.0, 115.0, 113.0, 111.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 107.0, 106.0, 169.0, 118.0, 135.0, 163.0, 110.0, 162.0, 106.0], "value": 132.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 185.0, 183.0, 184.0, 180.0, 183.0, 229.0, 252.0, 182.0], "value": 194.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 57.0, 61.0, 87.0, 57.0, 59.0, 65.0, 63.0, 84.0, 57.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 69.0, 102.0, 70.0, 71.0, 69.0, 98.0, 71.0, 68.0, 105.0], "value": 80.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 88.0, 93.0, 88.0, 84.0, 86.0, 84.0, 87.0, 84.0], "value": 86.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 93.0, 92.0, 94.0, 92.0, 93.0, 94.0, 94.0, 93.0], "value": 92.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 84.0, 84.0, 82.0, 85.0, 103.0, 131.0, 132.0, 86.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 57.0, 57.0, 56.0, 56.0, 55.0, 56.0, 57.0, 55.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 74.0, 69.0, 76.0, 72.0, 72.0, 69.0, 70.0, 73.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 84.0, 88.0, 87.0, 88.0, 86.0, 85.0, 89.0, 119.0], "value": 89.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 140.0, 140.0, 138.0, 140.0, 138.0, 139.0, 135.0, 153.0, 136.0], "value": 139.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 167.0, 169.0, 230.0, 219.0, 167.0, 168.0, 168.0, 166.0], "value": 179.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 69.0, 67.0, 66.0, 67.0, 67.0, 67.0, 66.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1462.3, "alertThreshold": 2.0}]} 07:28:32 INFO - Return code: 0 07:28:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:28:32 INFO - # TBPL SUCCESS # 07:28:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:28:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:28:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:28:32 INFO - 2016-08-13 07:28:32.358 screenresolution[2109:74816] starting screenresolution argv=screenresolution get 07:28:32 INFO - 2016-08-13 07:28:32.362 screenresolution[2109:74816] Display 0: 1600x1200x32@60 07:28:32 INFO - 2016-08-13 07:28:32.368 screenresolution[2110:74819] starting screenresolution argv=screenresolution list 07:28:32 INFO - Available Modes on Display 0 07:28:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:28:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:28:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:28:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:28:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:28:32 INFO - Intel Iris: 07:28:32 INFO - Chipset Model: Intel Iris 07:28:32 INFO - Type: GPU 07:28:32 INFO - Bus: Built-In 07:28:32 INFO - VRAM (Dynamic, Max): 1536 MB 07:28:32 INFO - Vendor: Intel (0x8086) 07:28:32 INFO - Device ID: 0x0a2e 07:28:32 INFO - Revision ID: 0x0009 07:28:32 INFO - Displays: 07:28:32 INFO - Display: 07:28:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:28:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:28:32 INFO - Display Serial Number: 1600x1200 60 07:28:32 INFO - Main Display: Yes 07:28:32 INFO - Mirror: Off 07:28:32 INFO - Online: Yes 07:28:32 INFO - Rotation: Supported 07:28:32 INFO - Return code: 0 07:28:32 INFO - Running post-action listener: _resource_record_post_action 07:28:32 INFO - [mozharness: 2016-08-13 14:28:32.604986Z] Finished run-tests step (success) 07:28:32 INFO - Running post-run listener: _resource_record_post_run 07:28:32 INFO - Total resource usage - Wall time: 1213s; CPU: 53.0%; Read bytes: 24576; Write bytes: 706823168; Read time: 1; Write time: 2158 07:28:32 INFO - TinderboxPrint: CPU usage
53.4% 07:28:32 INFO - TinderboxPrint: I/O read bytes / time
24,576 / 1 07:28:32 INFO - TinderboxPrint: I/O write bytes / time
706,823,168 / 2,158 07:28:32 INFO - TinderboxPrint: CPU idle
2,262.0 (46.6%) 07:28:32 INFO - TinderboxPrint: CPU system
971.4 (20.0%) 07:28:32 INFO - TinderboxPrint: CPU user
1,620.2 (33.4%) 07:28:32 INFO - TinderboxPrint: Swap in / out
404,131,840 / 0 07:28:32 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 405582336; Write bytes: 408613888; Read time: 30291; Write time: 811 07:28:32 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 8192; Write bytes: 293054976; Read time: 1; Write time: 1321 07:28:33 INFO - Running post-run listener: _upload_blobber_files 07:28:33 INFO - Blob upload gear active. 07:28:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:28:33 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 07:28:33 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'] 07:28:33 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 07:28:33 INFO - (blobuploader) - INFO - Open directory for files ... 07:28:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:28:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:28:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:28:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:28:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:28:34 INFO - (blobuploader) - INFO - Done attempting. 07:28:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:28:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:28:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:28:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:28:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:28:35 INFO - (blobuploader) - INFO - Done attempting. 07:28:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:28:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:28:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:28:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:28:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:28:37 INFO - (blobuploader) - INFO - Done attempting. 07:28:37 INFO - (blobuploader) - INFO - Iteration through files over. 07:28:37 INFO - Return code: 0 07:28:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:28:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:28:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f15f8dc2d0d2b302ea41c2061d715655e62cb4c21805caa33f8d2033406388dd43294d78dfde5db572d2a0a767fab7372c335448b26555429814b4e796f56f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d7c3e38293525beaa7ccb635c615614370a0d597b6b943a54bb04f77e46bab1f816dbd0defaa6c7a678dddeff7f58ef9e127c9730db360f4b7b01ce888cac73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8940a9ef425799b772581c55db3c06adc7267ed7dadda1cdf635c2872e73e93946a3fcca787e3129270b01c6f6cf79110ff722403c8f8b1e44bacbf771464bd5"} 07:28:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:28:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:28:37 INFO - Contents: 07:28:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f15f8dc2d0d2b302ea41c2061d715655e62cb4c21805caa33f8d2033406388dd43294d78dfde5db572d2a0a767fab7372c335448b26555429814b4e796f56f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d7c3e38293525beaa7ccb635c615614370a0d597b6b943a54bb04f77e46bab1f816dbd0defaa6c7a678dddeff7f58ef9e127c9730db360f4b7b01ce888cac73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8940a9ef425799b772581c55db3c06adc7267ed7dadda1cdf635c2872e73e93946a3fcca787e3129270b01c6f6cf79110ff722403c8f8b1e44bacbf771464bd5"} 07:28:37 INFO - Running post-run listener: copy_logs_to_upload_dir 07:28:37 INFO - Copying logs to upload dir... 07:28:37 INFO - mkdir: /builds/slave/test/build/upload/logs 07:28:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.432174 ========= master_lag: 0.88 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-08-13 07:28:38.841598) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-13 07:28:38.845893) ========= 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.sBTiOXe6jm/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.lACK6OUpvv/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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/7f15f8dc2d0d2b302ea41c2061d715655e62cb4c21805caa33f8d2033406388dd43294d78dfde5db572d2a0a767fab7372c335448b26555429814b4e796f56f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d7c3e38293525beaa7ccb635c615614370a0d597b6b943a54bb04f77e46bab1f816dbd0defaa6c7a678dddeff7f58ef9e127c9730db360f4b7b01ce888cac73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8940a9ef425799b772581c55db3c06adc7267ed7dadda1cdf635c2872e73e93946a3fcca787e3129270b01c6f6cf79110ff722403c8f8b1e44bacbf771464bd5"} build_url:https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011293 build_url: 'https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/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/7f15f8dc2d0d2b302ea41c2061d715655e62cb4c21805caa33f8d2033406388dd43294d78dfde5db572d2a0a767fab7372c335448b26555429814b4e796f56f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d7c3e38293525beaa7ccb635c615614370a0d597b6b943a54bb04f77e46bab1f816dbd0defaa6c7a678dddeff7f58ef9e127c9730db360f4b7b01ce888cac73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8940a9ef425799b772581c55db3c06adc7267ed7dadda1cdf635c2872e73e93946a3fcca787e3129270b01c6f6cf79110ff722403c8f8b1e44bacbf771464bd5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-13 07:28:38.881500) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 07:28:38.881841) ========= 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.sBTiOXe6jm/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.lACK6OUpvv/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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.005218 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 07:28:38.930290) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-13 07:28:38.933657) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-13 07:28:38.933989) ========= ========= Total master_lag: 1.03 =========