builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0183 starttime: 1471400758.21 results: success (0) buildid: 20160816163815 builduid: d4db7cea77864916975f0634444bd236 revision: 52be5024e34261bcd08d68fda65379ed0ffd363d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 19:25:58.208223) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 19:25:58.208863) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 19:25:58.209321) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 19:25:58.236633) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 19:25:58.237222) ========= 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.0JvcEfpM5T/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.6qNLO1sFO1/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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-16 19:25:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.1M=0.001s 2016-08-16 19:25:58 (13.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158785 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 19:25:58.424754) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 19:25:58.425456) ========= 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.0JvcEfpM5T/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.6qNLO1sFO1/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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.020581 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 19:25:58.479547) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 19:25:58.483033) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 52be5024e34261bcd08d68fda65379ed0ffd363d --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 52be5024e34261bcd08d68fda65379ed0ffd363d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0JvcEfpM5T/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.6qNLO1sFO1/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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-16 19:25:58,563 truncating revision to first 12 chars 2016-08-16 19:25:58,563 Setting DEBUG logging. 2016-08-16 19:25:58,563 attempt 1/10 2016-08-16 19:25:58,563 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/52be5024e342?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 19:25:59,121 unpacking tar archive at: mozilla-central-52be5024e342/testing/mozharness/ program finished with exit code 0 elapsedTime=0.824552 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 19:25:59.333945) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 19:25:59.334701) ========= script_repo_revision: 52be5024e34261bcd08d68fda65379ed0ffd363d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 19:25:59.335663) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 19:25:59.336320) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 19:25:59.357147) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-16 19:25:59.357889) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0JvcEfpM5T/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.6qNLO1sFO1/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 19:25:59 INFO - MultiFileLogger online at 20160816 19:25:59 in /builds/slave/test 19:25:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:25:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:25:59 INFO - {'append_to_log': False, 19:25:59 INFO - 'base_work_dir': '/builds/slave/test', 19:25:59 INFO - 'blob_upload_branch': 'Firefox', 19:25:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:25:59 INFO - 'branch': 'Firefox', 19:25:59 INFO - 'buildbot_json_path': 'buildprops.json', 19:25:59 INFO - 'config_files': ('talos/mac_config.py',), 19:25:59 INFO - 'default_actions': ('clobber', 19:25:59 INFO - 'read-buildbot-config', 19:25:59 INFO - 'download-and-extract', 19:25:59 INFO - 'populate-webroot', 19:25:59 INFO - 'create-virtualenv', 19:25:59 INFO - 'install', 19:25:59 INFO - 'run-tests'), 19:25:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:25:59 INFO - 'download_minidump_stackwalk': True, 19:25:59 INFO - 'download_symbols': 'ondemand', 19:25:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:25:59 INFO - 'tooltool.py': '/tools/tooltool.py', 19:25:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:25:59 INFO - '/tools/misc-python/virtualenv.py')}, 19:25:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:25:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:25:59 INFO - 'installer_path': 'installer.exe', 19:25:59 INFO - 'log_level': 'info', 19:25:59 INFO - 'log_name': 'talos', 19:25:59 INFO - 'log_to_console': True, 19:25:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:25:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:25:59 INFO - 'opt_config_files': (), 19:25:59 INFO - 'pip_index': False, 19:25:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:25:59 INFO - 'cmd': ('bash', 19:25:59 INFO - '-c', 19:25:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:25:59 INFO - 'enabled': True, 19:25:59 INFO - 'halt_on_failure': False, 19:25:59 INFO - 'name': 'check_screen_resolution'},), 19:25:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:25:59 INFO - 'cmd': ('bash', 19:25:59 INFO - '-c', 19:25:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:25:59 INFO - 'enabled': True, 19:25:59 INFO - 'halt_on_failure': False, 19:25:59 INFO - 'name': 'check_screen_resolution'},), 19:25:59 INFO - 'run_cmd_checks_enabled': True, 19:25:59 INFO - 'sps_profile': False, 19:25:59 INFO - 'sps_profile_interval': 0, 19:25:59 INFO - 'suite': 'dromaeojs-e10s', 19:25:59 INFO - 'system_bits': '32', 19:25:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:25:59 INFO - 'title': 't-yosemite-r7-0183', 19:25:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:25:59 INFO - 'use_talos_json': True, 19:25:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:25:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:25:59 INFO - 'work_dir': 'build'} 19:25:59 INFO - [mozharness: 2016-08-17 02:25:59.554348Z] Running clobber step. 19:25:59 INFO - Running pre-action listener: _resource_record_pre_action 19:25:59 INFO - Running main action method: clobber 19:25:59 INFO - rmtree: /builds/slave/test/build 19:25:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:26:00 INFO - Running post-action listener: _resource_record_post_action 19:26:00 INFO - [mozharness: 2016-08-17 02:26:00.434774Z] Finished clobber step (success) 19:26:00 INFO - [mozharness: 2016-08-17 02:26:00.434989Z] Running read-buildbot-config step. 19:26:00 INFO - Running pre-action listener: _resource_record_pre_action 19:26:00 INFO - Running main action method: read_buildbot_config 19:26:00 INFO - Using buildbot properties: 19:26:00 INFO - { 19:26:00 INFO - "project": "", 19:26:00 INFO - "product": "firefox", 19:26:00 INFO - "script_repo_revision": "production", 19:26:00 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 19:26:00 INFO - "repository": "", 19:26:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 19:26:00 INFO - "buildid": "20160816163815", 19:26:00 INFO - "pgo_build": "False", 19:26:00 INFO - "basedir": "/builds/slave/test", 19:26:00 INFO - "buildnumber": 24, 19:26:00 INFO - "slavename": "t-yosemite-r7-0183", 19:26:00 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 19:26:00 INFO - "platform": "yosemite_r7", 19:26:00 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:26:00 INFO - "branch": "mozilla-central", 19:26:00 INFO - "repo_path": "mozilla-central", 19:26:00 INFO - "revision": "52be5024e34261bcd08d68fda65379ed0ffd363d", 19:26:00 INFO - "stage_platform": "macosx64", 19:26:00 INFO - "builduid": "d4db7cea77864916975f0634444bd236", 19:26:00 INFO - "slavebuilddir": "test" 19:26:00 INFO - } 19:26:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/cxbgc7tOQMuVWBXcWkgn9g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 19:26:00 INFO - Running post-action listener: _resource_record_post_action 19:26:00 INFO - [mozharness: 2016-08-17 02:26:00.440427Z] Finished read-buildbot-config step (success) 19:26:00 INFO - [mozharness: 2016-08-17 02:26:00.440653Z] Running download-and-extract step. 19:26:00 INFO - Running pre-action listener: _resource_record_pre_action 19:26:00 INFO - Running main action method: download_and_extract 19:26:00 INFO - mkdir: /builds/slave/test/build/tests 19:26: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')]} 19:26:00 INFO - trying https://queue.taskcluster.net/v1/task/cxbgc7tOQMuVWBXcWkgn9g/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 19:26:00 INFO - Downloading https://queue.taskcluster.net/v1/task/cxbgc7tOQMuVWBXcWkgn9g/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 19:26:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cxbgc7tOQMuVWBXcWkgn9g/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 19:26:01 INFO - Downloaded 1199 bytes. 19:26:01 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 19:26:01 INFO - Using the following test package requirements: 19:26:01 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 19:26:01 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:26:01 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 19:26:01 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:26:01 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 19:26:01 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:26:01 INFO - u'jsshell-mac.zip'], 19:26:01 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:26:01 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 19:26:01 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 19:26:01 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:26:01 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 19:26:01 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:26:01 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 19:26:01 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:26:01 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 19:26:01 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:26:01 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 19:26:01 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:26:01 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')]} 19:26:01 INFO - trying https://queue.taskcluster.net/v1/task/cxbgc7tOQMuVWBXcWkgn9g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 19:26:01 INFO - Downloading https://queue.taskcluster.net/v1/task/cxbgc7tOQMuVWBXcWkgn9g/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 19:26:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cxbgc7tOQMuVWBXcWkgn9g/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 19:26:02 INFO - Downloaded 16333000 bytes. 19:26:02 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 19:26:09 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 19:26:09 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')]} 19:26:09 INFO - trying https://queue.taskcluster.net/v1/task/cxbgc7tOQMuVWBXcWkgn9g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 19:26:09 INFO - Downloading https://queue.taskcluster.net/v1/task/cxbgc7tOQMuVWBXcWkgn9g/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 19:26:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cxbgc7tOQMuVWBXcWkgn9g/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 19:26:10 INFO - Downloaded 16333000 bytes. 19:26:10 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 19:26:16 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')]} 19:26:16 INFO - trying https://queue.taskcluster.net/v1/task/cxbgc7tOQMuVWBXcWkgn9g/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 19:26:16 INFO - Downloading https://queue.taskcluster.net/v1/task/cxbgc7tOQMuVWBXcWkgn9g/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 19:26:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cxbgc7tOQMuVWBXcWkgn9g/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 19:26:17 INFO - Downloaded 14413719 bytes. 19:26:17 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 19:26: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')]} 19:26:18 INFO - trying https://queue.taskcluster.net/v1/task/cxbgc7tOQMuVWBXcWkgn9g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:26:18 INFO - Downloading https://queue.taskcluster.net/v1/task/cxbgc7tOQMuVWBXcWkgn9g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 19:26:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cxbgc7tOQMuVWBXcWkgn9g/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 19:26:21 INFO - Downloaded 111015212 bytes. 19:26:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cxbgc7tOQMuVWBXcWkgn9g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:26:21 INFO - mkdir: /builds/slave/test/properties 19:26:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:26:21 INFO - Writing to file /builds/slave/test/properties/build_url 19:26:21 INFO - Contents: 19:26:21 INFO - build_url:https://queue.taskcluster.net/v1/task/cxbgc7tOQMuVWBXcWkgn9g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:26:21 INFO - Running post-action listener: _resource_record_post_action 19:26:21 INFO - Running post-action listener: set_extra_try_arguments 19:26:21 INFO - [mozharness: 2016-08-17 02:26:21.807143Z] Finished download-and-extract step (success) 19:26:21 INFO - [mozharness: 2016-08-17 02:26:21.807270Z] Running populate-webroot step. 19:26:21 INFO - Running pre-action listener: _resource_record_pre_action 19:26:21 INFO - Running main action method: populate_webroot 19:26:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:26:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:26:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:26:21 INFO - '--tppagecycles', 19:26:21 INFO - '7'], 19:26:21 INFO - 'tests': ['tsvgm']}}, 19:26:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:26:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:26:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:26:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:26:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:26:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:26:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:21 INFO - 'talos_options': ['--disable-e10s'], 19:26:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:26:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:26:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:21 INFO - 'talos_options': ['--disable-e10s'], 19:26:21 INFO - 'tests': ['damp', 'tps']}, 19:26:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:21 INFO - 'tests': ['damp', 'tps']}, 19:26:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:26:21 INFO - 'tests': ['dromaeo_dom']}, 19:26:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:26:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:26:21 INFO - 'tests': ['basic_compositor_video']}, 19:26:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:26:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:26:21 INFO - 'tests': ['a11yr', 19:26:21 INFO - 'ts_paint', 19:26:21 INFO - 'tpaint', 19:26:21 INFO - 'sessionrestore', 19:26:21 INFO - 'sessionrestore_no_auto_restore', 19:26:21 INFO - 'tabpaint']}, 19:26:21 INFO - 'other-e10s': {'tests': ['a11yr', 19:26:21 INFO - 'ts_paint', 19:26:21 INFO - 'tpaint', 19:26:21 INFO - 'sessionrestore', 19:26:21 INFO - 'sessionrestore_no_auto_restore', 19:26:21 INFO - 'tabpaint']}, 19:26:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:26:21 INFO - 'ts_paint', 19:26:21 INFO - 'tpaint', 19:26:21 INFO - 'sessionrestore', 19:26:21 INFO - 'sessionrestore_no_auto_restore', 19:26:21 INFO - 'tabpaint']}, 19:26:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:26:21 INFO - 'ts_paint', 19:26:21 INFO - 'tpaint', 19:26:21 INFO - 'sessionrestore', 19:26:21 INFO - 'sessionrestore_no_auto_restore', 19:26:21 INFO - 'tabpaint']}, 19:26:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:26:21 INFO - 'tests': ['a11yr', 19:26:21 INFO - 'ts_paint', 19:26:21 INFO - 'tpaint', 19:26:21 INFO - 'sessionrestore', 19:26:21 INFO - 'sessionrestore_no_auto_restore', 19:26:21 INFO - 'tabpaint']}, 19:26:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:26:21 INFO - 'tests': ['a11yr', 19:26:21 INFO - 'ts_paint', 19:26:21 INFO - 'tpaint', 19:26:21 INFO - 'sessionrestore', 19:26:21 INFO - 'sessionrestore_no_auto_restore', 19:26:21 INFO - 'tabpaint']}, 19:26:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:26:21 INFO - 'tests': ['tsvgx', 19:26:21 INFO - 'tsvgr_opacity', 19:26:21 INFO - 'tart', 19:26:21 INFO - 'tscrollx', 19:26:21 INFO - 'cart']}, 19:26:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:26:21 INFO - 'tsvgr_opacity', 19:26:21 INFO - 'tart', 19:26:21 INFO - 'tscrollx', 19:26:21 INFO - 'cart']}, 19:26:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:21 INFO - 'talos_options': ['--disable-e10s'], 19:26:21 INFO - 'tests': ['tp5o']}, 19:26:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:21 INFO - 'tests': ['tp5o']}, 19:26:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:21 INFO - 'talos_options': ['--disable-e10s', 19:26:21 INFO - '--xperf_path', 19:26:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:26:21 INFO - 'tests': ['tp5n']}, 19:26:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:21 INFO - 'talos_options': ['--xperf_path', 19:26:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:26:21 INFO - 'tests': ['tp5n']}}, 19:26:21 INFO - 'talos.zip': {'path': '', 19:26:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:26:21 INFO - Running post-action listener: _resource_record_post_action 19:26:21 INFO - [mozharness: 2016-08-17 02:26:21.827420Z] Finished populate-webroot step (success) 19:26:21 INFO - [mozharness: 2016-08-17 02:26:21.827559Z] Running create-virtualenv step. 19:26:21 INFO - Running pre-action listener: _resource_record_pre_action 19:26:21 INFO - Running main action method: create_virtualenv 19:26:21 INFO - Creating virtualenv /builds/slave/test/build/venv 19:26:21 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 19:26:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:26:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:26:21 INFO - Using real prefix '/tools/python27' 19:26:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:26:22 INFO - Installing distribute.............................................................................................................................................................................................done. 19:26:25 INFO - Installing pip.................done. 19:26:25 INFO - Return code: 0 19:26:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:26:25 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')]} 19:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:25 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')]} 19:26:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:25 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 0x100a80a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b15618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87abd6fcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009e4d30>, '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 0x100749db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009dcb20>, '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.0JvcEfpM5T/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.6qNLO1sFO1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 19:26:25 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 19:26:25 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 19:26:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0JvcEfpM5T/Render', 19:26:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:26:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:26:25 INFO - 'HOME': '/Users/cltbld', 19:26:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:26:25 INFO - 'LOGNAME': 'cltbld', 19:26:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:25 INFO - 'MOZ_NO_REMOTE': '1', 19:26:25 INFO - 'NO_EM_RESTART': '1', 19:26:25 INFO - 'PAGER': '/bin/cat', 19:26:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:26:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:25 INFO - 'PWD': '/builds/slave/test', 19:26:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:26:25 INFO - 'SHELL': '/bin/bash', 19:26:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qNLO1sFO1/Listeners', 19:26:25 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 19:26:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:26:25 INFO - 'USER': 'cltbld', 19:26:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:26:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:26:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:25 INFO - 'XPC_FLAGS': '0x0', 19:26:25 INFO - 'XPC_SERVICE_NAME': '0', 19:26:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:26:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:25 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 19:26:25 INFO - Cleaning up... 19:26:25 INFO - Return code: 0 19:26:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:26:25 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')]} 19:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:25 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')]} 19:26:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:25 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 0x100a80a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b15618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87abd6fcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009e4d30>, '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 0x100749db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009dcb20>, '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.0JvcEfpM5T/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.6qNLO1sFO1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 19:26:25 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 19:26:25 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 19:26:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0JvcEfpM5T/Render', 19:26:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:26:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:26:25 INFO - 'HOME': '/Users/cltbld', 19:26:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:26:25 INFO - 'LOGNAME': 'cltbld', 19:26:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:25 INFO - 'MOZ_NO_REMOTE': '1', 19:26:25 INFO - 'NO_EM_RESTART': '1', 19:26:25 INFO - 'PAGER': '/bin/cat', 19:26:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:26:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:25 INFO - 'PWD': '/builds/slave/test', 19:26:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:26:25 INFO - 'SHELL': '/bin/bash', 19:26:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qNLO1sFO1/Listeners', 19:26:25 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 19:26:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:26:25 INFO - 'USER': 'cltbld', 19:26:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:26:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:26:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:25 INFO - 'XPC_FLAGS': '0x0', 19:26:25 INFO - 'XPC_SERVICE_NAME': '0', 19:26:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:26:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:26 INFO - Downloading/unpacking psutil>=3.1.1 19:26:26 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 19:26:26 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 19:26:26 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 19:26:26 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 19:26:26 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 19:26:26 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 19:26:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:26:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:26:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:26:29 INFO - Installing collected packages: psutil 19:26:29 INFO - Running setup.py install for psutil 19:26:29 INFO - building 'psutil._psutil_osx' extension 19:26:29 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 19:26:29 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 19:26:30 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 19:26:30 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 19:26:30 INFO - building 'psutil._psutil_posix' extension 19:26:30 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 19:26:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:26:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:26:30 INFO - ^ 19:26:30 INFO - 1 warning generated. 19:26:30 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 19:26:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:26:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:26:30 INFO - Successfully installed psutil 19:26:30 INFO - Cleaning up... 19:26:30 INFO - Return code: 0 19:26:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:26:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:26:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:30 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 0x100a80a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b15618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87abd6fcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009e4d30>, '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 0x100749db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009dcb20>, '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.0JvcEfpM5T/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.6qNLO1sFO1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 19:26:30 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 19:26:30 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 19:26:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0JvcEfpM5T/Render', 19:26:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:26:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:26:30 INFO - 'HOME': '/Users/cltbld', 19:26:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:26:30 INFO - 'LOGNAME': 'cltbld', 19:26:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:30 INFO - 'MOZ_NO_REMOTE': '1', 19:26:30 INFO - 'NO_EM_RESTART': '1', 19:26:30 INFO - 'PAGER': '/bin/cat', 19:26:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:26:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:30 INFO - 'PWD': '/builds/slave/test', 19:26:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:26:30 INFO - 'SHELL': '/bin/bash', 19:26:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qNLO1sFO1/Listeners', 19:26:30 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 19:26:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:26:30 INFO - 'USER': 'cltbld', 19:26:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:26:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:26:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:30 INFO - 'XPC_FLAGS': '0x0', 19:26:30 INFO - 'XPC_SERVICE_NAME': '0', 19:26:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:26:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:26:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:26:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:26:33 INFO - Installing collected packages: mozsystemmonitor 19:26:33 INFO - Running setup.py install for mozsystemmonitor 19:26:33 INFO - Successfully installed mozsystemmonitor 19:26:33 INFO - Cleaning up... 19:26:33 INFO - Return code: 0 19:26:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:26:33 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')]} 19:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:33 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')]} 19:26:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:33 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 0x100a80a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b15618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87abd6fcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009e4d30>, '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 0x100749db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009dcb20>, '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.0JvcEfpM5T/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.6qNLO1sFO1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 19:26:33 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 19:26:33 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 19:26:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0JvcEfpM5T/Render', 19:26:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:26:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:26:33 INFO - 'HOME': '/Users/cltbld', 19:26:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:26:33 INFO - 'LOGNAME': 'cltbld', 19:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:33 INFO - 'MOZ_NO_REMOTE': '1', 19:26:33 INFO - 'NO_EM_RESTART': '1', 19:26:33 INFO - 'PAGER': '/bin/cat', 19:26:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:33 INFO - 'PWD': '/builds/slave/test', 19:26:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:26:33 INFO - 'SHELL': '/bin/bash', 19:26:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qNLO1sFO1/Listeners', 19:26:33 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 19:26:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:26:33 INFO - 'USER': 'cltbld', 19:26:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:26:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:33 INFO - 'XPC_FLAGS': '0x0', 19:26:33 INFO - 'XPC_SERVICE_NAME': '0', 19:26:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:26:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:33 INFO - Downloading/unpacking jsonschema==2.5.1 19:26:33 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 19:26:33 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 19:26:33 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 19:26:33 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 19:26:33 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 19:26:33 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 19:26:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:26:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:26:36 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 19:26:36 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 19:26:36 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 19:26:36 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 19:26:36 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 19:26:36 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 19:26:36 INFO - Downloading functools32-3.2.3-2.tar.gz 19:26:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:26:36 INFO - warning: no files found matching '*.txt' 19:26:36 INFO - no previously-included directories found matching 'build' 19:26:36 INFO - no previously-included directories found matching 'dist' 19:26:36 INFO - no previously-included directories found matching '.git*' 19:26:36 INFO - Installing collected packages: jsonschema, functools32 19:26:36 INFO - Running setup.py install for functools32 19:26:36 INFO - warning: no files found matching '*.txt' 19:26:36 INFO - no previously-included directories found matching 'build' 19:26:36 INFO - no previously-included directories found matching 'dist' 19:26:36 INFO - no previously-included directories found matching '.git*' 19:26:36 INFO - Successfully installed jsonschema functools32 19:26:36 INFO - Cleaning up... 19:26:37 INFO - Return code: 0 19:26:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:26:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100a80a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b15618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87abd6fcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009e4d30>, '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 0x100749db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009dcb20>, '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.0JvcEfpM5T/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.6qNLO1sFO1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 19:26:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:26:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:26:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0JvcEfpM5T/Render', 19:26:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:26:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:26:37 INFO - 'HOME': '/Users/cltbld', 19:26:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:26:37 INFO - 'LOGNAME': 'cltbld', 19:26:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:37 INFO - 'MOZ_NO_REMOTE': '1', 19:26:37 INFO - 'NO_EM_RESTART': '1', 19:26:37 INFO - 'PAGER': '/bin/cat', 19:26:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:26:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:37 INFO - 'PWD': '/builds/slave/test', 19:26:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:26:37 INFO - 'SHELL': '/bin/bash', 19:26:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qNLO1sFO1/Listeners', 19:26:37 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 19:26:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:26:37 INFO - 'USER': 'cltbld', 19:26:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:26:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:26:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:37 INFO - 'XPC_FLAGS': '0x0', 19:26:37 INFO - 'XPC_SERVICE_NAME': '0', 19:26:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:26:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:26:37 INFO - Cleaning up... 19:26:37 INFO - Return code: 0 19:26:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:26:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100a80a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b15618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87abd6fcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009e4d30>, '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 0x100749db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009dcb20>, '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.0JvcEfpM5T/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.6qNLO1sFO1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 19:26:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:26:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:26:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0JvcEfpM5T/Render', 19:26:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:26:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:26:37 INFO - 'HOME': '/Users/cltbld', 19:26:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:26:37 INFO - 'LOGNAME': 'cltbld', 19:26:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:37 INFO - 'MOZ_NO_REMOTE': '1', 19:26:37 INFO - 'NO_EM_RESTART': '1', 19:26:37 INFO - 'PAGER': '/bin/cat', 19:26:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:26:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:37 INFO - 'PWD': '/builds/slave/test', 19:26:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:26:37 INFO - 'SHELL': '/bin/bash', 19:26:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qNLO1sFO1/Listeners', 19:26:37 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 19:26:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:26:37 INFO - 'USER': 'cltbld', 19:26:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:26:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:26:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:37 INFO - 'XPC_FLAGS': '0x0', 19:26:37 INFO - 'XPC_SERVICE_NAME': '0', 19:26:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:26:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:37 INFO - Downloading/unpacking blobuploader==1.2.4 19:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:40 INFO - Downloading blobuploader-1.2.4.tar.gz 19:26:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:26:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:26:40 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 19:26:40 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 19:26:40 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 19:26:40 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 19:26:40 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 19:26:40 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 19:26:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:26:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:26:40 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 19:26:40 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 19:26:40 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 19:26:40 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 19:26:40 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 19:26:40 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 19:26:41 INFO - Downloading docopt-0.6.1.tar.gz 19:26:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:26:41 INFO - Installing collected packages: blobuploader, requests, docopt 19:26:41 INFO - Running setup.py install for blobuploader 19:26:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:26:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:26:41 INFO - Running setup.py install for requests 19:26:41 INFO - Running setup.py install for docopt 19:26:42 INFO - Successfully installed blobuploader requests docopt 19:26:42 INFO - Cleaning up... 19:26:42 INFO - Return code: 0 19:26:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:26:42 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')]} 19:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:42 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')]} 19:26:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:42 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 0x100a80a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b15618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87abd6fcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009e4d30>, '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 0x100749db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009dcb20>, '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.0JvcEfpM5T/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.6qNLO1sFO1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 19:26:42 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 19:26:42 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 19:26:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0JvcEfpM5T/Render', 19:26:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:26:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:26:42 INFO - 'HOME': '/Users/cltbld', 19:26:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:26:42 INFO - 'LOGNAME': 'cltbld', 19:26:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:42 INFO - 'MOZ_NO_REMOTE': '1', 19:26:42 INFO - 'NO_EM_RESTART': '1', 19:26:42 INFO - 'PAGER': '/bin/cat', 19:26:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:26:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:42 INFO - 'PWD': '/builds/slave/test', 19:26:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:26:42 INFO - 'SHELL': '/bin/bash', 19:26:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qNLO1sFO1/Listeners', 19:26:42 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 19:26:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:26:42 INFO - 'USER': 'cltbld', 19:26:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:26:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:26:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:42 INFO - 'XPC_FLAGS': '0x0', 19:26:42 INFO - 'XPC_SERVICE_NAME': '0', 19:26:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:26:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:26:42 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-sMYpgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:26:42 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-RNsNmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:26:42 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-5kZ304-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:26:42 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-5S2C47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:26:42 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-M6KwVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:26:43 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-q4Dyrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:26:43 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-kxDZ8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:26:43 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-UJtVnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:26:43 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-DULkQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:26:43 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-eiGem3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:26:43 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-nBvH0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:26:43 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-76pzFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:26:43 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-FWrYtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:26:43 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-QYvMYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:26:43 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-d6ftXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:26:44 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-8n7A77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:26:44 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-sXf1d1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:26:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:26:44 INFO - Running setup.py install for manifestparser 19:26:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:26:44 INFO - Running setup.py install for mozcrash 19:26:44 INFO - Running setup.py install for mozdebug 19:26:44 INFO - Running setup.py install for mozdevice 19:26:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:26:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:26:44 INFO - Running setup.py install for mozfile 19:26:45 INFO - Running setup.py install for mozhttpd 19:26:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:26:45 INFO - Running setup.py install for mozinfo 19:26:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:26:45 INFO - Running setup.py install for mozInstall 19:26:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:26:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:26:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:26:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:26:45 INFO - Running setup.py install for mozleak 19:26:45 INFO - Running setup.py install for mozlog 19:26:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:26:45 INFO - Running setup.py install for moznetwork 19:26:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:26:45 INFO - Running setup.py install for mozprocess 19:26:46 INFO - Running setup.py install for mozprofile 19:26:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:26:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:26:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:26:46 INFO - Running setup.py install for mozrunner 19:26:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:26:46 INFO - Running setup.py install for mozscreenshot 19:26:46 INFO - Running setup.py install for moztest 19:26:46 INFO - Running setup.py install for mozversion 19:26:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:26:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:26:46 INFO - Cleaning up... 19:26:46 INFO - Return code: 0 19:26:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:26:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:46 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 0x100a80a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b15618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87abd6fcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009e4d30>, '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 0x100749db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009dcb20>, '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.0JvcEfpM5T/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.6qNLO1sFO1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 19:26:46 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 19:26:46 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 19:26:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0JvcEfpM5T/Render', 19:26:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:26:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:26:46 INFO - 'HOME': '/Users/cltbld', 19:26:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:26:46 INFO - 'LOGNAME': 'cltbld', 19:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:46 INFO - 'MOZ_NO_REMOTE': '1', 19:26:46 INFO - 'NO_EM_RESTART': '1', 19:26:46 INFO - 'PAGER': '/bin/cat', 19:26:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:46 INFO - 'PWD': '/builds/slave/test', 19:26:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:26:46 INFO - 'SHELL': '/bin/bash', 19:26:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qNLO1sFO1/Listeners', 19:26:46 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 19:26:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:26:46 INFO - 'USER': 'cltbld', 19:26:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:26:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:46 INFO - 'XPC_FLAGS': '0x0', 19:26:46 INFO - 'XPC_SERVICE_NAME': '0', 19:26:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:26:47 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-sTk6oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:26:47 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)) 19:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:26:47 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-1bCP37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:26:47 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)) 19:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:26:47 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-jb7B0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:26:47 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)) 19:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:26:47 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-5i09oU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:26:47 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)) 19:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:26:47 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-p1kATs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:26:47 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)) 19:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:26:47 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-YxBmii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:26:47 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)) 19:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:26:47 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-ruy6Gx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:26:47 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)) 19:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:26:47 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-IjR3Ip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:26:47 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)) 19:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:26:47 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-DDqiov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:26:48 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)) 19:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:26:48 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-qFMOIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:26:48 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)) 19:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:26:48 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-2wsxBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:26:48 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)) 19:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:26:48 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-Ljzu63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:26:48 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)) 19:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:26:48 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-mZXJkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:26:48 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)) 19:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:26:48 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-O__D20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:26:48 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)) 19:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:26:48 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-kW0Tc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:26:48 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)) 19:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:26:48 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-HsWlIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:26:48 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)) 19:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:26:48 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-K6dl94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:26:48 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)) 19:26:48 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)) 19:26:48 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)) 19:26:48 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)) 19:26:48 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)) 19:26:48 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)) 19:26:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:51 INFO - Downloading blessings-1.6.tar.gz 19:26:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:26:51 INFO - Installing collected packages: blessings 19:26:51 INFO - Running setup.py install for blessings 19:26:51 INFO - Successfully installed blessings 19:26:51 INFO - Cleaning up... 19:26:51 INFO - Return code: 0 19:26:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:26:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:26:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:26:52 INFO - Reading from file tmpfile_stdout 19:26:52 INFO - Current package versions: 19:26:52 INFO - blessings == 1.6 19:26:52 INFO - blobuploader == 1.2.4 19:26:52 INFO - docopt == 0.6.1 19:26:52 INFO - functools32 == 3.2.3-2 19:26:52 INFO - jsonschema == 2.5.1 19:26:52 INFO - manifestparser == 1.1 19:26:52 INFO - mozInstall == 1.12 19:26:52 INFO - mozcrash == 0.17 19:26:52 INFO - mozdebug == 0.1 19:26:52 INFO - mozdevice == 0.48 19:26:52 INFO - mozfile == 1.2 19:26:52 INFO - mozhttpd == 0.7 19:26:52 INFO - mozinfo == 0.9 19:26:52 INFO - mozleak == 0.1 19:26:52 INFO - mozlog == 3.3 19:26:52 INFO - moznetwork == 0.27 19:26:52 INFO - mozprocess == 0.23 19:26:52 INFO - mozprofile == 0.28 19:26:52 INFO - mozrunner == 6.12 19:26:52 INFO - mozscreenshot == 0.1 19:26:52 INFO - mozsystemmonitor == 0.3 19:26:52 INFO - moztest == 0.7 19:26:52 INFO - mozversion == 1.4 19:26:52 INFO - psutil == 3.1.1 19:26:52 INFO - requests == 1.2.3 19:26:52 INFO - wsgiref == 0.1.2 19:26:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:26: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')]} 19:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26: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')]} 19:26:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:52 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 0x100a80a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b15618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87abd6fcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009e4d30>, '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 0x100749db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009dcb20>, '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.0JvcEfpM5T/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.6qNLO1sFO1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 19:26:52 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 19:26:52 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 19:26:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0JvcEfpM5T/Render', 19:26:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:26:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:26:52 INFO - 'HOME': '/Users/cltbld', 19:26:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:26:52 INFO - 'LOGNAME': 'cltbld', 19:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:52 INFO - 'MOZ_NO_REMOTE': '1', 19:26:52 INFO - 'NO_EM_RESTART': '1', 19:26:52 INFO - 'PAGER': '/bin/cat', 19:26:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:52 INFO - 'PWD': '/builds/slave/test', 19:26:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:26:52 INFO - 'SHELL': '/bin/bash', 19:26:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qNLO1sFO1/Listeners', 19:26:52 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 19:26:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:26:52 INFO - 'USER': 'cltbld', 19:26:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:26:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:52 INFO - 'XPC_FLAGS': '0x0', 19:26:52 INFO - 'XPC_SERVICE_NAME': '0', 19:26:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:52 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)) 19:26:52 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)) 19:26:52 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)) 19:26:52 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)) 19:26:52 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)) 19:26:52 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)) 19:26:52 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)) 19:26:52 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)) 19:26:52 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)) 19:26:52 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)) 19:26:52 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)) 19:26:52 INFO - Cleaning up... 19:26:52 INFO - Return code: 0 19:26:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:26: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')]} 19:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26: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')]} 19:26:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100a80a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b15618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87abd6fcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009e4d30>, '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 0x100749db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009dcb20>, '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.0JvcEfpM5T/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.6qNLO1sFO1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 19:26: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', 'jsonschema'] in /builds/slave/test/build 19:26: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 jsonschema 19:26:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0JvcEfpM5T/Render', 19:26:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:26:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:26:52 INFO - 'HOME': '/Users/cltbld', 19:26:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:26:52 INFO - 'LOGNAME': 'cltbld', 19:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:52 INFO - 'MOZ_NO_REMOTE': '1', 19:26:52 INFO - 'NO_EM_RESTART': '1', 19:26:52 INFO - 'PAGER': '/bin/cat', 19:26:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:52 INFO - 'PWD': '/builds/slave/test', 19:26:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:26:52 INFO - 'SHELL': '/bin/bash', 19:26:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qNLO1sFO1/Listeners', 19:26:52 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 19:26:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:26:52 INFO - 'USER': 'cltbld', 19:26:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:26:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:52 INFO - 'XPC_FLAGS': '0x0', 19:26:52 INFO - 'XPC_SERVICE_NAME': '0', 19:26:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:26:52 INFO - Cleaning up... 19:26:52 INFO - Return code: 0 19:26:52 INFO - Running post-action listener: _resource_record_post_action 19:26:52 INFO - Running post-action listener: _start_resource_monitoring 19:26:52 INFO - Starting resource monitoring. 19:26:52 INFO - [mozharness: 2016-08-17 02:26:52.584893Z] Finished create-virtualenv step (success) 19:26:52 INFO - [mozharness: 2016-08-17 02:26:52.585921Z] Running install step. 19:26:52 INFO - Running pre-action listener: _resource_record_pre_action 19:26:52 INFO - Running main action method: install 19:26:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:26:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:26:52 INFO - Reading from file tmpfile_stdout 19:26:52 INFO - Detecting whether we're running mozinstall >=1.0... 19:26:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:26:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:26:52 INFO - Reading from file tmpfile_stdout 19:26:52 INFO - Output received: 19:26:52 INFO - Usage: mozinstall [options] installer 19:26:52 INFO - Options: 19:26:52 INFO - -h, --help show this help message and exit 19:26:52 INFO - -d DEST, --destination=DEST 19:26:52 INFO - Directory to install application into. [default: 19:26:52 INFO - "/builds/slave/test"] 19:26:52 INFO - --app=APP Application being installed. [default: firefox] 19:26:52 INFO - mkdir: /builds/slave/test/build/application 19:26:52 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'] 19:26:52 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 19:27:27 INFO - Reading from file tmpfile_stdout 19:27:27 INFO - Output received: 19:27:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:27:27 INFO - Running post-action listener: _resource_record_post_action 19:27:27 INFO - [mozharness: 2016-08-17 02:27:27.173673Z] Finished install step (success) 19:27:27 INFO - [mozharness: 2016-08-17 02:27:27.173886Z] Running run-tests step. 19:27:27 INFO - Running pre-action listener: _resource_record_pre_action 19:27:27 INFO - Running main action method: run_tests 19:27:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:27:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:27:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:27:27 INFO - 2016-08-16 19:27:27.188 screenresolution[1914:14412] starting screenresolution argv=screenresolution get 19:27:27 INFO - 2016-08-16 19:27:27.191 screenresolution[1914:14412] Display 0: 1600x1200x32@60 19:27:27 INFO - 2016-08-16 19:27:27.197 screenresolution[1915:14414] starting screenresolution argv=screenresolution list 19:27:27 INFO - Available Modes on Display 0 19:27:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:27:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:27:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:27:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:27:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:27:27 INFO - Intel Iris: 19:27:27 INFO - Chipset Model: Intel Iris 19:27:27 INFO - Type: GPU 19:27:27 INFO - Bus: Built-In 19:27:27 INFO - VRAM (Dynamic, Max): 1536 MB 19:27:27 INFO - Vendor: Intel (0x8086) 19:27:27 INFO - Device ID: 0x0a2e 19:27:27 INFO - Revision ID: 0x0009 19:27:27 INFO - Displays: 19:27:27 INFO - Display: 19:27:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:27:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:27:27 INFO - Display Serial Number: 1600x1200 60 19:27:27 INFO - Main Display: Yes 19:27:27 INFO - Mirror: Off 19:27:27 INFO - Online: Yes 19:27:27 INFO - Rotation: Supported 19:27:27 INFO - Return code: 0 19:27:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:27:27 INFO - Python 2.7.3 19:27:27 INFO - Return code: 0 19:27:27 INFO - grabbing minidump binary from tooltool 19:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:27 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 0x1009e4d30>, '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 0x100749db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009dcb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:27:27 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 19:27:27 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 19:27:27 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 19:27:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:27:27 INFO - Return code: 0 19:27:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:27:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:27:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:27:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:27:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:27:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cxbgc7tOQMuVWBXcWkgn9g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0183', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cxbgc7tOQMuVWBXcWkgn9g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0183 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:27:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0JvcEfpM5T/Render', 19:27:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:27 INFO - 'HOME': '/Users/cltbld', 19:27:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:27 INFO - 'LOGNAME': 'cltbld', 19:27:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:27:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:27:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:27 INFO - 'MOZ_NO_REMOTE': '1', 19:27:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:27:27 INFO - 'NO_EM_RESTART': '1', 19:27:27 INFO - 'PAGER': '/bin/cat', 19:27:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:27 INFO - 'PWD': '/builds/slave/test', 19:27:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:27:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:27 INFO - 'SHELL': '/bin/bash', 19:27:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qNLO1sFO1/Listeners', 19:27:27 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 19:27:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:27 INFO - 'USER': 'cltbld', 19:27:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:27 INFO - 'XPC_FLAGS': '0x0', 19:27:27 INFO - 'XPC_SERVICE_NAME': '0', 19:27:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cxbgc7tOQMuVWBXcWkgn9g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0183', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:27:27 INFO - mozversion application_buildid: 20160816163815 19:27:27 INFO - mozversion application_changeset: 52be5024e34261bcd08d68fda65379ed0ffd363d 19:27:27 INFO - mozversion application_display_name: Nightly 19:27:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:27:27 INFO - mozversion application_name: Firefox 19:27:27 INFO - mozversion application_remotingname: firefox 19:27:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:27:27 INFO - mozversion application_vendor: Mozilla 19:27:27 INFO - mozversion application_version: 51.0a1 19:27:27 INFO - mozversion platform_buildid: 20160816163815 19:27:27 INFO - mozversion platform_changeset: 52be5024e34261bcd08d68fda65379ed0ffd363d 19:27:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:27:27 INFO - mozversion platform_version: 51.0a1 19:27:27 INFO - using testdate: 1471400847 19:27:27 INFO - actual date: 1471400847 19:27:27 INFO - starting webserver on 'localhost:49430' 19:27:27 INFO - SUITE-START | Running 2 tests 19:27:27 INFO - TEST-START | dromaeo_css 19:27:27 INFO - operating with platform_type : mac_ 19:27:27 INFO - Initialising browser for dromaeo_css test... 19:27:27 INFO - TEST-INFO | started process 1925 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/tmp0rD4Du/profile http://localhost:49430/getInfo.html) 19:27:30 INFO - PROCESS | 1925 | __metrics Screen width/height:1600/1200 19:27:30 INFO - PROCESS | 1925 | colorDepth:24 19:27:30 INFO - PROCESS | 1925 | Browser inner width/height: 1024/689 19:27:30 INFO - PROCESS | 1925 | __metrics 19:27:30 ERROR - PROCESS | 1925 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 19:27:31 INFO - TEST-INFO | 1925: exit 0 19:27:31 INFO - Browser initialized. 19:27:31 INFO - Running cycle 1/1 for dromaeo_css test... 19:27:31 INFO - TEST-INFO | started process 1928 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/tmp0rD4Du/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:27:43 INFO - PROCESS | 1928 | RSS: Main: 239284224 19:27:43 INFO - PROCESS | 1928 | 19:28:33 INFO - PROCESS | 1928 | 1471400913245 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] 19:30:45 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:49430/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49430/tests/dromaeo/cssquery-ext.html) 19:30:46 INFO - PROCESS | 1928 | RSS: Main: 254070784 19:30:46 INFO - PROCESS | 1928 | 19:33:49 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:49430/tests/dromaeo/cssquery-ext.html (next: http://localhost:49430/tests/dromaeo/cssquery-jquery.html) 19:33:49 INFO - PROCESS | 1928 | RSS: Main: 265789440 19:33:49 INFO - PROCESS | 1928 | 19:36:51 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:49430/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49430/tests/dromaeo/cssquery-mootools.html) 19:36:52 INFO - PROCESS | 1928 | RSS: Main: 271015936 19:36:52 INFO - PROCESS | 1928 | 19:39:54 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:49430/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49430/tests/dromaeo/cssquery-prototype.html) 19:39:54 INFO - PROCESS | 1928 | RSS: Main: 270618624 19:39:54 INFO - PROCESS | 1928 | 19:42:57 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:49430/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49430/tests/dromaeo/cssquery-yui.html) 19:42:58 INFO - PROCESS | 1928 | RSS: Main: 276496384 19:42:58 INFO - PROCESS | 1928 | 19:46:01 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:49430/tests/dromaeo/cssquery-yui.html (next: http://localhost:49430/tests/dromaeo/cssquery-dojo.html) 19:46:01 INFO - PROCESS | 1928 | RSS: Main: 279130112 19:46:01 INFO - PROCESS | 1928 | 19:46:01 INFO - PROCESS | 1928 | __start_tp_report 19:46:01 INFO - PROCESS | 1928 | _x_x_mozilla_page_load 19:46:01 INFO - PROCESS | 1928 | _x_x_mozilla_page_load_details 19:46:01 INFO - PROCESS | 1928 | |i|pagename|runs| 19:46:01 INFO - PROCESS | 1928 | |0;dojo.html;3300.900972970812;3314.154890502922;3335.182880194351;3344.331133773246;3388.9661103388967;5506.256655351522;5514.889702205954;5518.862028449291;5563.582731295159;5594.748236329365;4522.253828118365;5362.1420572708375;5578.693171875545;5624.943750562493;5631.324241091064;4966.701997880121;5058.595312375001;5141.177411614142;5162.277281180619;5170.767315470794;5033.0688822567945;5216.7913283468615;5253;5260.053190425722;5301.549368303698;3827;5044.2937988681615;5094.414142373637;5121.235891619656;5133.101707201244;5092.28707980883;5132.076226279269;5136.4606716295;5139.563137133348;5172.094883395428;5062.417821950486;5073.34046573943;5083.6441449098575;5084.237364395333;5117.948820511821;4218.346156345771;5388.73056347185;5445.53712934401;5501.367342755594;5569.192467092249;6016.127661489103;6054.394560543955;6113.296970848321;6115.633062016249;6130.785422510191;6128.877422451571;6151.815445536641;6165.445109940082;6183.474404675608;6188.721507532126;5528.502434780889;5601.187827764951;5647.6893770843;5660.518855897254;5667.234923285345;6193.473554747897;6209.813705588839;6215.316315205324;6215.440610345091;6227.439530442282;5980.970095149496;6005.519558435315;6017.247844019497;6032.155498230251;6037.426444487766;5870.677112758839;6032.39676032402;6071.119687645267;6109.938900611026;6130.908036379458;5858.326292476335;5912.763489460373;5916.704164791743;5973.163757074013;6029.186059881948;6019.217501724747;6072.423119803611;6106.297775755845;6106.45041946227;6122.295935967331;4769.546893045155;4806.4712881583;4827.348307978448;4838.0082083172865;4866.270059491105;4252.468441444819;4302.94577828434;4344.196323680129;4386.2762644163995;4395.27477966132;4009.7594144351433;4030.576789437067;4960.90078198434;5678.716064196857;5745.827625171251;5118.692878427306;5987.101934709741;6151.446369826737;6166.167567378437;6190.876182476415;5501.972490137524;5673.978683836866;5678.432156784289;5697.601167918206;5698.31620205578;4403.383526306319;4443.844465443759;5233.947660523346;5301.522862942354;5363.490468405495;6173.59871608344;6181.629102253789;6214.720337584819;6216.409441103088;6244.843878902973;4457.888552786077;5903.350631430453;6126.938730612636;6161.168242287234;6164.691765411621;6168.568200225941;6182.505399568114;6183.84540386494;6246.219222597176;6248.875022499616;6035.155078288955;6063.605865618721;6064.221688615873;6091.177691011657;6099.573029887865;6006.399360063959;6099.84750381244;6108.938910610837;6139.754409823557;6140.5701600887505;5937.584369094122;5980.461758441761;5989.251343582052;6041.456268935817;6056.182415373868;5109.5912327013;5916.437938395846;5962.821115366546;5969.134475501115;6044.184035155374;4869.732164730974;4886.3647725796845;5536.197251398444;5702.657840529581;5824.737886795019;4878.292647566154;5983.700814959322;6002.729877155626;6011.789587364597;6022.096685497036;4947.960928205117;5709;5800.4489573490455;5808.332041815245;5809.099589563624 19:46:01 INFO - PROCESS | 1928 | |1;ext.html;438.34467471130654;457.66133061534464;466.454248529221;498.1108720933135;539.099703495163;33218.00345989618;38021.61978380219;40440.79779601098;40505;40630.79684601573;40519;41050.79474602623;41076.178476430454;41147.38278925811;41224;9647.324687271876;9835.31152819303;9857.802843943116;9861.852072218922;9900.851487227697;9634.229261659051;9721.659741909034;9735.75660608487;9741.659041933533;9756.560954757053;9676.516174191298;9686.903130968705;9688.982656821003;9691.418514889094;9698.224142068653;9666.226701863834;9672.177864881494;9706.514674266295;9737.756556086084;9739.951300243525;9586.856197157049;9633.855492167622;9644.373115747454;9666.323357364987;9686.07982241686;39307.80346098251;39717.41130354782;39828.402573961124;39860.60139398627;40108.799456002824;3055.7097075777765;3406.199543107368;3458.6892602524454;3675.9891029966707;4107.63031327179;31226;31484;32109.839450802596;32147;32228.194295142574;2873.7642813590146;2937.7649788016906;3230.8707651693903;3392.71161951232;3441.6730410610953;425747;467421;474652;474802;475063;52554.948901021766;55843.441565583824;58927;59145.81708365808;59241.111383329284;60862.695686521285;61243.77512449726;61346.079808802904;61400.38599614036;61409;15777.211139442981;15845.920770396075;15897.28462219203;16031.759523606923;16060.43788467398;12359.443825027894;12457;12503.062270329761;12507.874921250854;12533.74932501363;15668.138252396227;16003.279852406436;16103.114328712034;16279.883615129957;16373.754393684105;6102;6395.904061439082;6947.4789390795895;7439.925600744032;7614.466987310835;871.694906782621;879.9428037177563;1009.0766948242423;1065.1319174872453;1099.9285046471953;29797.702022979494;30001.249968750955;30200.54699179514;30504.389912202074;30948.916787912764;999.715081201854;1048.9737756556146;1057.799018186542;1084.2410312781085;1170.7365842685329;14999.17504537239;16676.16619169037;17072.975621462752;17079.65840683204;17112.401065962633;624487;628559;630762;633591;634929;58004.70997644985;58726;58947;59051;59090;1157.432857899623;1367.282176857158;1371.7530844448095;1386.7226554689103;1391.812105365803;29940.70059299379;30625.54061689121;31076;31273.218169545944;31356;51260.487395127064;51557.48442515527;51610;51627.74186129045;51628.74185629198;562814;564849;566447;566646;568631;23856.926438310664;26407.735922640528;27123.457530849668;27193.59209611897;28078.017269395474;47795;47863.76068119637;48161.5183848157;48632.5136748628;49215.75392123016;39195.21609567736;39270;39486.605133948295;40735.38896916608;41246.793766030976;36144.63855361518;36430;36656.45015324825;39797.40303895502;39808.60191398049;38051;38743;39022;39189.02027449336;40376.59623403846;30191.547126792677;31153.68846311508;35331.29337413289;35521;35933;25463;25713.10004149846;25726.228213153634;25995.610065849407;26549.734502654726 19:46:01 INFO - PROCESS | 1928 | |2;jquery.html;340.52496767010024;374.1133513572835;382.5791629207871;388.2119297825412;403.65084202165116;19863.50341241468;21871;22545;22676.773232267693;22822.31533054007;15992.680146397066;17747;21192.4701882453;21284.255051073178;21632.3510294691;5907.0043905435805;5959.731812068457;6035.577509574332;6045.576809623328;6077.392260773931;4188.937165942513;5961.672108034057;6066.908996365058;6078.756849726005;6080;5893.793717219898;6259.593126446789;6777.288384719607;6832.6925288362145;6849.897251541231;5828.271466066742;6109.205803245594;6164.599301045418;6521.347865213488;6786.253512113663;5509.421510741355;5747.2241247431475;6026.608270462406;6036.909446358264;6063.666498342589;23275.4181145471;24888.37779055538;25158;26401.603975940376;26471.735282647118;2293.415179129328;2330.568844763707;2400.615901455759;2612.242449689588;2712.823666461674;7950.443468957175;9996.600135994551;10189.89810101897;10495.79008419835;10528.36829790215;1887.6790945539292;1891.8297353238138;1915.5019694879293;1925.9325923592608;1931.401265607652;113570.43214783956;115733.26400104005;124859;125321;126971.36514317461;10279.94860025695;10452;10468.057874791306;10558.683239502674;10710.410927398912;12754.76791561473;12757.362131893367;12770.169938954125;12790.232586044867;12826.80759788604;7912.802179945547;8082.797930051795;8170.714025009215;8223.712170074139;8302.211289927447;8235.38234632405;8263.710770123016;8312.33501319893;8338.749837504885;8502.659893604186;3255.4302996975434;4069.89825254371;4102.405151253051;4175.832966681299;4177.895552611209;1573.968520629581;1875.5686192175876;1913.598144389666;1948.5615736459183;1951.8828870267546;768.7578412800062;842.3598065470287;855.362754747717;875.916787905148;965.9420434773796;14823.851761482247;20288.898555507425;21419.785802141778;21585.460363491038;21654.783452165593;887.8679683403712;918.8392031394613;920.4845286639503;991.9008099190023;1022.8772547294373;11136.665900023012;11360.545578176945;11426.314421134592;11462.598809041643;11467.369294688706;575681;606959;618617;619589;628716;78676.42647147024;81432;124399;138677;153080;985.6747273399761;993.6720882108887;1015.8069966706155;1020.7346090016649;1020.8009438159636;18444.723329150343;18651.626967460303;19285.4214373569;19482;19503.317383892063;53847.65380865509;54205.18692219541;56852.71573642105;56923.43076569181;57136.42863571477;60016.69991650014;78835.60582197053;80496;83983.16016839753;87102.69345959942;10909.890901091205;11720.88279117198;11906.214067889885;12192.939035304767;12522.436490357773;13223.140495867738;13236.602901912958;13373.39819708135;13410.463581456632;13772.380242889294;11277.266977646426;11410.201285909907;11622.70943226426;11738.647840564796;11759.412029398667;8780.385373023826;9165.54172291396;11103.555857765921;11698.94150529242;11749.823752643888;9327.860082098638;11564.363959982282;11923.10576706733;12007.939960300142;12127.514899403925;11854.644360669194;11893.881061189277;12129;12163.574274900337;12254.20347677398;9743;11402.030827379765;11729.882701172879;11796.4691588877;11992.220505667105 19:46:01 INFO - PROCESS | 1928 | |3;mootools.html;1304.6607881950692;1535.3628244278625;1700.9404670836516;1857.3777784442211;1870.298638010746;8085.353171746261;8683.261922736567;8716.04123546411;9138.406003609769;9202;8737.563121843914;8910.242629376511;8929.374943753939;8932.95533522333;8935.151160639745;2365.3849999000213;2368.2184878989933;2374.9406264843433;2383.95232095358;2393.270052633946;2365.4559451326204;2367.0886708617136;2402.5675378431874;2413.5655581995234;2418.407490164912;2371.2886134159685;2387.7254115776736;2398.8605412429133;2409.662647229389;2411.3007227903886;2233.7542870284256;2251.0545570860277;2294.1740973249616;2297.9540409191804;2300.298408985259;2358.929232123039;2358.9528209435716;2364.5152743687504;2375.311159763684;2375.6911601491697;6967.407770339477;9031.81936361269;9038.683646072355;9044.8643270351;9051.637934482613;5365.195220716884;5431.076716958127;5493.505584497414;5512.614117011811;5515.227868098469;3229.54786329914;3674.1365779041903;3702.1670124222105;3710.664160902073;3725.5715592706915;1118.6588090632354;1121.9214654974155;1122.2032357026521;1138.2203190814319;1152.8847115288488;11728.413579321;11820.172587918849;11921;11954.983826374855;12004.2197257178;4185.0374413884365;4586.4266966629175;4717.150912835723;4806.4712881583;4899.681520701214;9297.442153470813;10107.7473063174;10142.949285253526;10147.847782283272;10171.4914254287;5430.56555475561;5457.727113644302;5459.590530710213;5461.481159289861;5469.261649677323;3964.4053391990856;4058.24922389353;4428.1365133799245;4951.257311403247;4991.875203119878;3421.9315613687586;3953.5453422856162;3971.3050216212623;4031.677465802729;4057.046594050396;1098.7143342730947;1321.5044358365612;1325.8872995795466;1330.767115754739;1330.8735670111323;838.7567605394489;916.7341470973477;933.6918816790443;940.116290686766;960.1406740966795;4842.951570484321;5082.84329307056;5476;5704.22992895962;6027.342976025397;400.24353970994844;425.53616557951364;439.3519558651028;442.61934736126904;444.9065696203769;3974.423708562242;4023.4367188593037;4035.5964403559997;4083.448734420815;4104.0970986382945;8886.333524985652;9270.655754915635;9958.302918795614;10998.450077496092;11051.613193538187;9289.396189247676;10916.945415273032;10940.343579385262;10948.507317170586;10974.231803773659;8134.227248411392;8399.95800020996;8403.579821008803;8421.157884211652;8433.746987590383;5029.396472423333;5542.8337149885565;5909.113632955091;5949.25634295713;5999.430054144849;9966.352187107816;10302.948485257526;10344.069033786995;10400.11599014062;10472.26694131434;10059.798804023732;10169.084782369622;10479.371237725762;10508.632197873038;10548.525316360936;7076.398506127037;7563.886541701989;7576.128745194374;7784.92215077842;7800.180980996914;8550;8573.31413486932;8612.138786121337;8615.22462978335;8616.65533378683;7538.3592394644875;7643.7324693635455;7679.116901556169;7794.2985131338455;7827.647755850887;7463.2163622818825;7588.127365353055;7593.544387336557;7612.391008719178;7615.390768738377;7137.393321567725;7214.675339609626;7228.674709637974;7278.126624805057;7279;5024.397072351341;5034.723090230073;5065.265536497113;5110.131277682877;5158.535731784157;5088.287639730367;5146.228065790161;5162.664426812245;5264.52619264268;5271.393789714079 19:46:01 INFO - PROCESS | 1928 | |4;prototype.html;305.7462306285783;306.4575701009214;312.05914168781123;312.82169163576754;314.6208818373857;4825.73458459785;5564.579407957542;5582.5254853337465;5649.435056494359;5720.370759216483;5483.670979741219;5489.231507588941;5542.972285138579;5576.386597474285;5676.16191904048;4026.8187931543002;4140.896477588054;4187.267228235047;4216.325387937931;4242.787860606973;3681.9815900920457;4209.621134097931;4235.745855248695;4247.978760106195;4253.787310634471;3838.905911815133;3888.300105980922;4247.405363249132;4250.596193361625;4282.914341713164;3470.670286322795;3854.3447613905705;4095.484670671841;4237.2161150187;4300.247456695081;3241.1410976091356;3437.2438063626214;3582.247727977128;3635.509206257148;3685.1339935115225;4414.735115893057;4660.347551342815;4684.976575117136;5450.836474905759;5461.863453413656;4452.955470445287;4597.37935378723;4812.566868981773;4877.780499877514;4884.780184891652;5287.4448182941005;5820.068788993783;5843.298804143487;5862.570396318159;5902.8819423611285;3517.4899639552123;4065.8170382332864;4066.593340665939;4077.97961010196;4093.3655283431117;4876.804927802884;5192.896752701924;6011.9699401503585;6131.6934153292605;6195.1946246988055;4059.65492933104;4069.6744260459686;4107.363358679409;4108.67130629549;4117.1678603021965;4167.4790651168605;4169.749075277466;4221.535631080578;4229.767362795076;4240.279152544013;4579.473360563511;4772.665913386099;4855.975720121377;4869.610431165498;4882.218844984785;5501.257330260443;5794.362620111784;5798.449147330997;5814.651120932757;5835.795747148914;1404;1436.956891293263;1439.6113049476792;1442.314900422312;1447.6163816588612;753.3483536740789;880.2737741363401;887.4956947973252;891.6255172827427;901.3375169250595;4566.406367172246;5253.8423847283875;5485.61600687948;5519.337679478488;5561.888762224733;5210.400803907523;5636.097409833938;6131.816045518642;6142.385761423822;6175.197224360804;5303.416624171338;5467.972660136674;5505.2933590587045;5544.168374743821;5547.472990065938;2688.6639170103736;3010.0217429335116;3100.682210060715;3187.8724851006164;3192.3455691583636;5794.942050579524;5986.042233242661;6097.542684298695;6243.751249750068;6360.681965901686;6168.506519478431;6185.659788711574;6197.932023648323;6207;6232.096346029891;6298.559100862987;6299.244090709144;6334.3665633436285;6336.6831658416895;6388.840278993062;4737;4799.400074990626;5891.675957822189;6063.636181829104;6076.696165191811;5328.282575886248;5404.702741349263;5687.289088863892;5916.467517923407;5918.585699001029;5055.469175736494;6104.38956104386;6147.385261473817;6235.3452887446165;6388.8083357499345;3489.633588473174;3570.7143428526174;3823.2735780201674;4032.516098068133;4051.736637118578;4967.552920237196;4991.600671946163;5205.505476979681;5983.012802887475;6107.389261073857;4994.654650453983;5221.921671175011;5462.617616766947;5871.500922421642;5879.911801323069;4917.655764096479;5091.6181286402925;5367.35591728995;5758.337791153904;5789.247397838422;5322.760475778522;5422.376426710979;5535.142052981794;5577.888442231214;5643.858903527281;4660.440747110369;5206.167013277857;5642.23829782974;5825.475707186373;5939.4357536034;4985.401751789808;4987.775550100182;5390.51485366319;5699.458551437607;5782.335031471266 19:46:01 INFO - PROCESS | 1928 | |5;yui.html;580.2851828890267;666.9066330713698;701.0955866931662;786.866232740434;804.2078552625662;15248.923755381222;15850.920745396286;15864.365425383;15866.889317747748;15909.44316948907;14371.64070898228;14456.638584035405;14487.855121448782;14507.057041292308;14525.27373631317;677.7898851356096;823.9752807415757;831.4803247970034;843.6751850537556;854.4830377621543;851.1105894340429;851.7061613743249;852.799592095857;852.957352132394;856.0583358305845;903.1465265324272;904.1320332480826;907.7458311672709;908.6002159049997;909.3407279722214;897.5781382750097;904.1771987491417;904.7692838326218;905.0135352465778;905.8595917632778;655.5673255651247;663.2041550139852;674.7874419557872;675.0111087257143;676.370974993256;14612.926935365254;14876.033057851206;14906.403743850233;15060.096394216382;15064;14744.336504857307;14754.188519631416;14766.778498322534;14797.40810367584;14977.251137443192;11962.760744785055;12176.81734773979;12371.75256494874;12376.443060062318;12543.184692994926;3216.630087539916;3876.8061596920043;3985.7807820569856;4043.4945631796027;4107.8973025674295;115456.84543154544;117815.41092294484;118391.4080429601;118560;123075;10005.399676019317;10014.64948726791;11091.44542772858;11402.600908968312;11509.76980460386;21235.46911327198;23526.176583819826;23757.762422375556;23781;23806;6541.836454088686;7203.963980180066;7401.5189012714;7986.920130798734;7989.680412783424;4519.435070616173;4634.165850146938;4636.374089497875;4640.164770341304;4658.231391820312;3488.7383446241633;3599.802010889374;3617.620149884277;3632.0738211755834;3731.104534911656;588.9146073819358;674.6053558668234;699.8180473077036;707.4835370179695;711.0542977839461;500.52200148857753;559.6865755177114;582.4932308891292;596.3946594206883;675.7364627795065;9467.431954082776;9719.17387022111;9769.85345219808;9786.608535658494;9986.450745209084;598.6587645042284;623.6027184716288;631.908373285871;672.7409947170374;687.2440315652742;4525.298578720303;4739.928901066418;4866.46468888422;4878.536539028786;4909.263610458388;97194.51402743082;98453;119147;164368;167832.4825127624;87774;89619;127219;137550;137998;95846;121665.56668866573;123772.38113809374;124744.7525524733;127028.99999999815;9228.492432916253;9247.213986810928;9251.86122208154;9254.398464099811;9381.859272110787;46805.2979205319;51612.96774064573;61808.38191618026;62741;65136.34863651303;62766;65032.37419064372;86112.56943715242;102054.48972755088;105520;13120.60638180856;13589.456421743414;13631.182129072287;13729.588112356645;13758;13566.304211973504;14436.855631443972;15374.38502459889;15571.91364909429;15633.296501657225;14036.578902632937;14219.786703199667;14434.855651443351;14960.775588366401;15042.548723538312;13910.930445347709;14138.717225655635;14436.711265774837;14806.555803325917;14919.403223870924;13970.091944023607;14080.507182248572;14115.435382584581;14143.717125657635;14471.27643617794;11090.44547772592;11329.320240785579;11448.885511144781;11509.597164099216;12014.819777703517;9171.974522292941;10309.278350515391;10566;11555.2489088209;11803.586874459354 19:46:01 INFO - PROCESS | 1928 | __end_tp_report 19:46:01 INFO - PROCESS | 1928 | __start_cc_report 19:46:01 INFO - PROCESS | 1928 | _x_x_mozilla_cycle_collect,404 19:46:01 INFO - PROCESS | 1928 | __end_cc_report 19:46:01 INFO - PROCESS | 1928 | __startTimestamp1471401961642__endTimestamp 19:46:01 INFO - PROCESS | 1928 | 19:46:01 INFO - PROCESS | 1928 | ------- Summary: start ------- 19:46:01 INFO - PROCESS | 1928 | Number of tests: 6 19:46:01 INFO - PROCESS | 1928 | 19:46:01 INFO - PROCESS | 1928 | [#0] dojo.html Cycles:165 Average:5528.93 Median:5702.66 stddev:692.86 (12.1%) stddev-sans-first:672.57 19:46:01 INFO - PROCESS | 1928 | Values: 3300.9 3314.2 3335.2 3344.3 3389.0 5506.3 5514.9 5518.9 5563.6 5594.7 4522.3 5362.1 5578.7 5624.9 5631.3 4966.7 5058.6 5141.2 5162.3 5170.8 5033.1 5216.8 5253.0 5260.1 5301.5 3827.0 5044.3 5094.4 5121.2 5133.1 5092.3 5132.1 5136.5 5139.6 5172.1 5062.4 5073.3 5083.6 5084.2 5117.9 4218.3 5388.7 5445.5 5501.4 5569.2 6016.1 6054.4 6113.3 6115.6 6130.8 6128.9 6151.8 6165.4 6183.5 6188.7 5528.5 5601.2 5647.7 5660.5 5667.2 6193.5 6209.8 6215.3 6215.4 6227.4 5981.0 6005.5 6017.2 6032.2 6037.4 5870.7 6032.4 6071.1 6109.9 6130.9 5858.3 5912.8 5916.7 5973.2 6029.2 6019.2 6072.4 6106.3 6106.5 6122.3 4769.5 4806.5 4827.3 4838.0 4866.3 4252.5 4302.9 4344.2 4386.3 4395.3 4009.8 4030.6 4960.9 5678.7 5745.8 5118.7 5987.1 6151.4 6166.2 6190.9 5502.0 5674.0 5678.4 5697.6 5698.3 4403.4 4443.8 5233.9 5301.5 5363.5 6173.6 6181.6 6214.7 6216.4 6244.8 4457.9 5903.4 6126.9 6161.2 6164.7 6168.6 6182.5 6183.8 6246.2 6248.9 6035.2 6063.6 6064.2 6091.2 6099.6 6006.4 6099.8 6108.9 6139.8 6140.6 5937.6 5980.5 5989.3 6041.5 6056.2 5109.6 5916.4 5962.8 5969.1 6044.2 4869.7 4886.4 5536.2 5702.7 5824.7 4878.3 5983.7 6002.7 6011.8 6022.1 4948.0 5709.0 5800.4 5808.3 5809.1 19:46:01 INFO - PROCESS | 1928 | 19:46:01 INFO - PROCESS | 1928 | [#1] ext.html Cycles:180 Average:68867.63 Median:40408.70 stddev:148914.71 (368.5%) stddev-sans-first:149243.82 19:46:01 INFO - PROCESS | 1928 | Values: 438.3 457.7 466.5 498.1 539.1 33218.0 38021.6 40440.8 40505.0 40630.8 40519.0 41050.8 41076.2 41147.4 41224.0 9647.3 9835.3 9857.8 9861.9 9900.9 9634.2 9721.7 9735.8 9741.7 9756.6 9676.5 9686.9 9689.0 9691.4 9698.2 9666.2 9672.2 9706.5 9737.8 9740.0 9586.9 9633.9 9644.4 9666.3 9686.1 39307.8 39717.4 39828.4 39860.6 40108.8 3055.7 3406.2 3458.7 3676.0 4107.6 31226.0 31484.0 32109.8 32147.0 32228.2 2873.8 2937.8 3230.9 3392.7 3441.7 425747.0 467421.0 474652.0 474802.0 475063.0 52554.9 55843.4 58927.0 59145.8 59241.1 60862.7 61243.8 61346.1 61400.4 61409.0 15777.2 15845.9 15897.3 16031.8 16060.4 12359.4 12457.0 12503.1 12507.9 12533.7 15668.1 16003.3 16103.1 16279.9 16373.8 6102.0 6395.9 6947.5 7439.9 7614.5 871.7 879.9 1009.1 1065.1 1099.9 29797.7 30001.2 30200.5 30504.4 30948.9 999.7 1049.0 1057.8 1084.2 1170.7 14999.2 16676.2 17073.0 17079.7 17112.4 624487.0 628559.0 630762.0 633591.0 634929.0 58004.7 58726.0 58947.0 59051.0 59090.0 1157.4 1367.3 1371.8 1386.7 1391.8 29940.7 30625.5 31076.0 31273.2 31356.0 51260.5 51557.5 51610.0 51627.7 51628.7 562814.0 564849.0 566447.0 566646.0 568631.0 23856.9 26407.7 27123.5 27193.6 28078.0 47795.0 47863.8 48161.5 48632.5 49215.8 39195.2 39270.0 39486.6 40735.4 41246.8 36144.6 36430.0 36656.5 39797.4 39808.6 38051.0 38743.0 39022.0 39189.0 40376.6 30191.5 31153.7 35331.3 35521.0 35933.0 25463.0 25713.1 25726.2 25995.6 26549.7 19:46:01 INFO - PROCESS | 1928 | 19:46:01 INFO - PROCESS | 1928 | [#2] jquery.html Cycles:180 Average:35358.82 Median:12557.87 stddev:101616.14 (809.2%) stddev-sans-first:101867.18 19:46:01 INFO - PROCESS | 1928 | Values: 340.5 374.1 382.6 388.2 403.7 19863.5 21871.0 22545.0 22676.8 22822.3 15992.7 17747.0 21192.5 21284.3 21632.4 5907.0 5959.7 6035.6 6045.6 6077.4 4188.9 5961.7 6066.9 6078.8 6080.0 5893.8 6259.6 6777.3 6832.7 6849.9 5828.3 6109.2 6164.6 6521.3 6786.3 5509.4 5747.2 6026.6 6036.9 6063.7 23275.4 24888.4 25158.0 26401.6 26471.7 2293.4 2330.6 2400.6 2612.2 2712.8 7950.4 9996.6 10189.9 10495.8 10528.4 1887.7 1891.8 1915.5 1925.9 1931.4 113570.4 115733.3 124859.0 125321.0 126971.4 10279.9 10452.0 10468.1 10558.7 10710.4 12754.8 12757.4 12770.2 12790.2 12826.8 7912.8 8082.8 8170.7 8223.7 8302.2 8235.4 8263.7 8312.3 8338.7 8502.7 3255.4 4069.9 4102.4 4175.8 4177.9 1574.0 1875.6 1913.6 1948.6 1951.9 768.8 842.4 855.4 875.9 965.9 14823.9 20288.9 21419.8 21585.5 21654.8 887.9 918.8 920.5 991.9 1022.9 11136.7 11360.5 11426.3 11462.6 11467.4 575681.0 606959.0 618617.0 619589.0 628716.0 78676.4 81432.0 124399.0 138677.0 153080.0 985.7 993.7 1015.8 1020.7 1020.8 18444.7 18651.6 19285.4 19482.0 19503.3 53847.7 54205.2 56852.7 56923.4 57136.4 60016.7 78835.6 80496.0 83983.2 87102.7 10909.9 11720.9 11906.2 12192.9 12522.4 13223.1 13236.6 13373.4 13410.5 13772.4 11277.3 11410.2 11622.7 11738.6 11759.4 8780.4 9165.5 11103.6 11698.9 11749.8 9327.9 11564.4 11923.1 12007.9 12127.5 11854.6 11893.9 12129.0 12163.6 12254.2 9743.0 11402.0 11729.9 11796.5 11992.2 19:46:01 INFO - PROCESS | 1928 | 19:46:01 INFO - PROCESS | 1928 | [#3] mootools.html Cycles:180 Average:5739.61 Median:4824.71 stddev:3254.25 (67.4%) stddev-sans-first:3246.31 19:46:01 INFO - PROCESS | 1928 | Values: 1304.7 1535.4 1700.9 1857.4 1870.3 8085.4 8683.3 8716.0 9138.4 9202.0 8737.6 8910.2 8929.4 8933.0 8935.2 2365.4 2368.2 2374.9 2384.0 2393.3 2365.5 2367.1 2402.6 2413.6 2418.4 2371.3 2387.7 2398.9 2409.7 2411.3 2233.8 2251.1 2294.2 2298.0 2300.3 2358.9 2359.0 2364.5 2375.3 2375.7 6967.4 9031.8 9038.7 9044.9 9051.6 5365.2 5431.1 5493.5 5512.6 5515.2 3229.5 3674.1 3702.2 3710.7 3725.6 1118.7 1121.9 1122.2 1138.2 1152.9 11728.4 11820.2 11921.0 11955.0 12004.2 4185.0 4586.4 4717.2 4806.5 4899.7 9297.4 10107.7 10142.9 10147.8 10171.5 5430.6 5457.7 5459.6 5461.5 5469.3 3964.4 4058.2 4428.1 4951.3 4991.9 3421.9 3953.5 3971.3 4031.7 4057.0 1098.7 1321.5 1325.9 1330.8 1330.9 838.8 916.7 933.7 940.1 960.1 4843.0 5082.8 5476.0 5704.2 6027.3 400.2 425.5 439.4 442.6 444.9 3974.4 4023.4 4035.6 4083.4 4104.1 8886.3 9270.7 9958.3 10998.5 11051.6 9289.4 10916.9 10940.3 10948.5 10974.2 8134.2 8400.0 8403.6 8421.2 8433.7 5029.4 5542.8 5909.1 5949.3 5999.4 9966.4 10302.9 10344.1 10400.1 10472.3 10059.8 10169.1 10479.4 10508.6 10548.5 7076.4 7563.9 7576.1 7784.9 7800.2 8550.0 8573.3 8612.1 8615.2 8616.7 7538.4 7643.7 7679.1 7794.3 7827.6 7463.2 7588.1 7593.5 7612.4 7615.4 7137.4 7214.7 7228.7 7278.1 7279.0 5024.4 5034.7 5065.3 5110.1 5158.5 5088.3 5146.2 5162.7 5264.5 5271.4 19:46:01 INFO - PROCESS | 1928 | 19:46:01 INFO - PROCESS | 1928 | [#4] prototype.html Cycles:180 Average:4702.19 Median:5216.16 stddev:1450.97 (27.8%) stddev-sans-first:1417.02 19:46:01 INFO - PROCESS | 1928 | Values: 305.7 306.5 312.1 312.8 314.6 4825.7 5564.6 5582.5 5649.4 5720.4 5483.7 5489.2 5543.0 5576.4 5676.2 4026.8 4140.9 4187.3 4216.3 4242.8 3682.0 4209.6 4235.7 4248.0 4253.8 3838.9 3888.3 4247.4 4250.6 4282.9 3470.7 3854.3 4095.5 4237.2 4300.2 3241.1 3437.2 3582.2 3635.5 3685.1 4414.7 4660.3 4685.0 5450.8 5461.9 4453.0 4597.4 4812.6 4877.8 4884.8 5287.4 5820.1 5843.3 5862.6 5902.9 3517.5 4065.8 4066.6 4078.0 4093.4 4876.8 5192.9 6012.0 6131.7 6195.2 4059.7 4069.7 4107.4 4108.7 4117.2 4167.5 4169.7 4221.5 4229.8 4240.3 4579.5 4772.7 4856.0 4869.6 4882.2 5501.3 5794.4 5798.4 5814.7 5835.8 1404.0 1437.0 1439.6 1442.3 1447.6 753.3 880.3 887.5 891.6 901.3 4566.4 5253.8 5485.6 5519.3 5561.9 5210.4 5636.1 6131.8 6142.4 6175.2 5303.4 5468.0 5505.3 5544.2 5547.5 2688.7 3010.0 3100.7 3187.9 3192.3 5794.9 5986.0 6097.5 6243.8 6360.7 6168.5 6185.7 6197.9 6207.0 6232.1 6298.6 6299.2 6334.4 6336.7 6388.8 4737.0 4799.4 5891.7 6063.6 6076.7 5328.3 5404.7 5687.3 5916.5 5918.6 5055.5 6104.4 6147.4 6235.3 6388.8 3489.6 3570.7 3823.3 4032.5 4051.7 4967.6 4991.6 5205.5 5983.0 6107.4 4994.7 5221.9 5462.6 5871.5 5879.9 4917.7 5091.6 5367.4 5758.3 5789.2 5322.8 5422.4 5535.1 5577.9 5643.9 4660.4 5206.2 5642.2 5825.5 5939.4 4985.4 4987.8 5390.5 5699.5 5782.3 19:46:01 INFO - PROCESS | 1928 | 19:46:01 INFO - PROCESS | 1928 | [#5] yui.html Cycles:180 Average:24297.09 Median:3681.59 stddev:38407.26 (1043.2%) stddev-sans-first:38473.72 19:46:01 INFO - PROCESS | 1928 | Values: 580.3 666.9 701.1 786.9 804.2 15248.9 15850.9 15864.4 15866.9 15909.4 14371.6 14456.6 14487.9 14507.1 14525.3 677.8 824.0 831.5 843.7 854.5 851.1 851.7 852.8 853.0 856.1 903.1 904.1 907.7 908.6 909.3 897.6 904.2 904.8 905.0 905.9 655.6 663.2 674.8 675.0 676.4 14612.9 14876.0 14906.4 15060.1 15064.0 14744.3 14754.2 14766.8 14797.4 14977.3 11962.8 12176.8 12371.8 12376.4 12543.2 3216.6 3876.8 3985.8 4043.5 4107.9 115456.8 117815.4 118391.4 118560.0 123075.0 10005.4 10014.6 11091.4 11402.6 11509.8 21235.5 23526.2 23757.8 23781.0 23806.0 6541.8 7204.0 7401.5 7986.9 7989.7 4519.4 4634.2 4636.4 4640.2 4658.2 3488.7 3599.8 3617.6 3632.1 3731.1 588.9 674.6 699.8 707.5 711.1 500.5 559.7 582.5 596.4 675.7 9467.4 9719.2 9769.9 9786.6 9986.5 598.7 623.6 631.9 672.7 687.2 4525.3 4739.9 4866.5 4878.5 4909.3 97194.5 98453.0 119147.0 164368.0 167832.5 87774.0 89619.0 127219.0 137550.0 137998.0 95846.0 121665.6 123772.4 124744.8 127029.0 9228.5 9247.2 9251.9 9254.4 9381.9 46805.3 51613.0 61808.4 62741.0 65136.3 62766.0 65032.4 86112.6 102054.5 105520.0 13120.6 13589.5 13631.2 13729.6 13758.0 13566.3 14436.9 15374.4 15571.9 15633.3 14036.6 14219.8 14434.9 14960.8 15042.5 13910.9 14138.7 14436.7 14806.6 14919.4 13970.1 14080.5 14115.4 14143.7 14471.3 11090.4 11329.3 11448.9 11509.6 12014.8 9172.0 10309.3 10566.0 11555.2 11803.6 19:46:01 INFO - PROCESS | 1928 | -------- Summary: end -------- 19:46:01 INFO - PROCESS | 1928 | 19:46:02 INFO - TEST-INFO | 1928: exit 0 19:46:02 INFO - TEST-OK | dromaeo_css | took 1114535ms 19:46:02 INFO - TEST-START | kraken 19:46:02 INFO - operating with platform_type : mac_ 19:46:02 INFO - Initialising browser for kraken test... 19:46:02 INFO - TEST-INFO | started process 1934 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/tmp6_0kEB/profile http://localhost:49430/getInfo.html) 19:46:05 INFO - PROCESS | 1934 | __metrics Screen width/height:1600/1200 19:46:05 INFO - PROCESS | 1934 | colorDepth:24 19:46:05 INFO - PROCESS | 1934 | Browser inner width/height: 1024/689 19:46:05 INFO - PROCESS | 1934 | __metrics 19:46:05 ERROR - PROCESS | 1934 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 19:46:06 INFO - TEST-INFO | 1934: exit 0 19:46:06 INFO - Browser initialized. 19:46:06 INFO - Running cycle 1/1 for kraken test... 19:46:06 INFO - TEST-INFO | started process 1936 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/tmp6_0kEB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:46:18 INFO - PROCESS | 1936 | RSS: Main: 239271936 19:46:18 INFO - PROCESS | 1936 | 19:46:21 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49430/tests/kraken/driver.html?testName=audio-beat-detection) 19:46:22 INFO - PROCESS | 1936 | RSS: Main: 252088320 19:46:22 INFO - PROCESS | 1936 | 19:46:24 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49430/tests/kraken/driver.html?testName=audio-dft) 19:46:25 INFO - PROCESS | 1936 | RSS: Main: 260722688 19:46:25 INFO - PROCESS | 1936 | 19:46:29 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49430/tests/kraken/driver.html?testName=audio-fft) 19:46:29 INFO - PROCESS | 1936 | RSS: Main: 263475200 19:46:29 INFO - PROCESS | 1936 | 19:46:31 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49430/tests/kraken/driver.html?testName=audio-oscillator) 19:46:32 INFO - PROCESS | 1936 | RSS: Main: 265854976 19:46:32 INFO - PROCESS | 1936 | 19:46:34 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49430/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:46:35 INFO - PROCESS | 1936 | RSS: Main: 266276864 19:46:35 INFO - PROCESS | 1936 | 19:46:38 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49430/tests/kraken/driver.html?testName=imaging-darkroom) 19:46:38 INFO - PROCESS | 1936 | RSS: Main: 267358208 19:46:38 INFO - PROCESS | 1936 | 19:46:42 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49430/tests/kraken/driver.html?testName=imaging-desaturate) 19:46:42 INFO - PROCESS | 1936 | RSS: Main: 267776000 19:46:42 INFO - PROCESS | 1936 | 19:46:45 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49430/tests/kraken/driver.html?testName=json-parse-financial) 19:46:46 INFO - PROCESS | 1936 | RSS: Main: 267771904 19:46:46 INFO - PROCESS | 1936 | 19:46:47 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49430/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:46:48 INFO - PROCESS | 1936 | RSS: Main: 267829248 19:46:48 INFO - PROCESS | 1936 | 19:46:50 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49430/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:46:50 INFO - PROCESS | 1936 | RSS: Main: 266948608 19:46:50 INFO - PROCESS | 1936 | 19:46:53 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49430/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:46:53 INFO - PROCESS | 1936 | RSS: Main: 267022336 19:46:53 INFO - PROCESS | 1936 | 19:46:56 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49430/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:46:57 INFO - PROCESS | 1936 | RSS: Main: 267046912 19:46:57 INFO - PROCESS | 1936 | 19:47:00 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49430/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:47:01 INFO - PROCESS | 1936 | RSS: Main: 267071488 19:47:01 INFO - PROCESS | 1936 | 19:47:02 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49430/tests/kraken/driver.html?testName=ai-astar) 19:47:02 INFO - PROCESS | 1936 | RSS: Main: 268181504 19:47:02 INFO - PROCESS | 1936 | 19:47:02 INFO - PROCESS | 1936 | __start_tp_report 19:47:02 INFO - PROCESS | 1936 | _x_x_mozilla_page_load 19:47:02 INFO - PROCESS | 1936 | _x_x_mozilla_page_load_details 19:47:02 INFO - PROCESS | 1936 | |i|pagename|runs| 19:47:02 INFO - PROCESS | 1936 | |0;ai-astar;155;161;110;117;144;178;149;117;100;172 19:47:02 INFO - PROCESS | 1936 | |1;audio-beat-detection;139;116;168;190;110;131;131;111;162;140 19:47:02 INFO - PROCESS | 1936 | |2;audio-dft;251;291;279;259;199;200;200;197;199;198 19:47:02 INFO - PROCESS | 1936 | |3;audio-fft;72;72;94;183;61;60;60;63;139;59 19:47:02 INFO - PROCESS | 1936 | |4;audio-oscillator;71;73;125;74;76;80;138;101;101;150 19:47:02 INFO - PROCESS | 1936 | |5;imaging-gaussian-blur;90;89;89;88;90;86;92;88;116;130 19:47:02 INFO - PROCESS | 1936 | |6;imaging-darkroom;96;106;98;121;105;151;152;97;121;151 19:47:02 INFO - PROCESS | 1936 | |7;imaging-desaturate;91;92;92;93;92;90;92;94;91;92 19:47:02 INFO - PROCESS | 1936 | |8;json-parse-financial;58;59;62;59;59;59;57;57;62;91 19:47:02 INFO - PROCESS | 1936 | |9;json-stringify-tinderbox;68;69;70;72;74;80;76;76;69;71 19:47:02 INFO - PROCESS | 1936 | |10;stanford-crypto-aes;91;87;90;90;89;85;95;112;90;88 19:47:02 INFO - PROCESS | 1936 | |11;stanford-crypto-ccm;145;184;130;154;155;153;151;162;177;154 19:47:02 INFO - PROCESS | 1936 | |12;stanford-crypto-pbkdf2;174;179;174;171;172;176;174;174;177;178 19:47:02 INFO - PROCESS | 1936 | |13;stanford-crypto-sha256-iterative;69;67;72;70;70;67;70;73;64;68 19:47:02 INFO - PROCESS | 1936 | __end_tp_report 19:47:02 INFO - PROCESS | 1936 | __start_cc_report 19:47:02 INFO - PROCESS | 1936 | _x_x_mozilla_cycle_collect,1060 19:47:02 INFO - PROCESS | 1936 | __end_cc_report 19:47:02 INFO - PROCESS | 1936 | __startTimestamp1471402022958__endTimestamp 19:47:02 INFO - PROCESS | 1936 | 19:47:02 INFO - PROCESS | 1936 | ------- Summary: start ------- 19:47:02 INFO - PROCESS | 1936 | Number of tests: 14 19:47:02 INFO - PROCESS | 1936 | 19:47:02 INFO - PROCESS | 1936 | [#0] ai-astar Cycles:10 Average:140.30 Median:152.00 stddev:27.46 (18.1%) stddev-sans-first:28.61 19:47:02 INFO - PROCESS | 1936 | Values: 155.0 161.0 110.0 117.0 144.0 178.0 149.0 117.0 100.0 172.0 19:47:02 INFO - PROCESS | 1936 | 19:47:02 INFO - PROCESS | 1936 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:139.50 stddev:26.35 (18.9%) stddev-sans-first:27.94 19:47:02 INFO - PROCESS | 1936 | Values: 139.0 116.0 168.0 190.0 110.0 131.0 131.0 111.0 162.0 140.0 19:47:02 INFO - PROCESS | 1936 | 19:47:02 INFO - PROCESS | 1936 | [#2] audio-dft Cycles:10 Average:227.30 Median:225.50 stddev:38.25 (17.0%) stddev-sans-first:39.59 19:47:02 INFO - PROCESS | 1936 | Values: 251.0 291.0 279.0 259.0 199.0 200.0 200.0 197.0 199.0 198.0 19:47:02 INFO - PROCESS | 1936 | 19:47:02 INFO - PROCESS | 1936 | [#3] audio-fft Cycles:10 Average:86.30 Median:62.00 stddev:42.04 (67.8%) stddev-sans-first:44.27 19:47:02 INFO - PROCESS | 1936 | Values: 72.0 72.0 94.0 183.0 61.0 60.0 60.0 63.0 139.0 59.0 19:47:02 INFO - PROCESS | 1936 | 19:47:02 INFO - PROCESS | 1936 | [#4] audio-oscillator Cycles:10 Average:98.90 Median:72.00 stddev:29.40 (40.8%) stddev-sans-first:29.40 19:47:02 INFO - PROCESS | 1936 | Values: 71.0 73.0 125.0 74.0 76.0 80.0 138.0 101.0 101.0 150.0 19:47:02 INFO - PROCESS | 1936 | 19:47:02 INFO - PROCESS | 1936 | [#5] imaging-gaussian-blur Cycles:10 Average:95.80 Median:89.00 stddev:14.79 (16.6%) stddev-sans-first:15.54 19:47:02 INFO - PROCESS | 1936 | Values: 90.0 89.0 89.0 88.0 90.0 86.0 92.0 88.0 116.0 130.0 19:47:02 INFO - PROCESS | 1936 | 19:47:02 INFO - PROCESS | 1936 | [#6] imaging-darkroom Cycles:10 Average:119.80 Median:151.50 stddev:23.47 (15.5%) stddev-sans-first:23.26 19:47:02 INFO - PROCESS | 1936 | Values: 96.0 106.0 98.0 121.0 105.0 151.0 152.0 97.0 121.0 151.0 19:47:02 INFO - PROCESS | 1936 | 19:47:02 INFO - PROCESS | 1936 | [#7] imaging-desaturate Cycles:10 Average:91.90 Median:92.00 stddev:1.10 (1.2%) stddev-sans-first:1.12 19:47:02 INFO - PROCESS | 1936 | Values: 91.0 92.0 92.0 93.0 92.0 90.0 92.0 94.0 91.0 92.0 19:47:02 INFO - PROCESS | 1936 | 19:47:02 INFO - PROCESS | 1936 | [#8] json-parse-financial Cycles:10 Average:62.30 Median:59.00 stddev:10.23 (17.3%) stddev-sans-first:10.73 19:47:02 INFO - PROCESS | 1936 | Values: 58.0 59.0 62.0 59.0 59.0 59.0 57.0 57.0 62.0 91.0 19:47:02 INFO - PROCESS | 1936 | 19:47:02 INFO - PROCESS | 1936 | [#9] json-stringify-tinderbox Cycles:10 Average:72.50 Median:73.00 stddev:3.89 (5.3%) stddev-sans-first:3.77 19:47:02 INFO - PROCESS | 1936 | Values: 68.0 69.0 70.0 72.0 74.0 80.0 76.0 76.0 69.0 71.0 19:47:02 INFO - PROCESS | 1936 | 19:47:02 INFO - PROCESS | 1936 | [#10] stanford-crypto-aes Cycles:10 Average:91.70 Median:90.00 stddev:7.60 (8.4%) stddev-sans-first:8.06 19:47:02 INFO - PROCESS | 1936 | Values: 91.0 87.0 90.0 90.0 89.0 85.0 95.0 112.0 90.0 88.0 19:47:02 INFO - PROCESS | 1936 | 19:47:02 INFO - PROCESS | 1936 | [#11] stanford-crypto-ccm Cycles:10 Average:156.50 Median:154.50 stddev:15.27 (9.9%) stddev-sans-first:15.62 19:47:02 INFO - PROCESS | 1936 | Values: 145.0 184.0 130.0 154.0 155.0 153.0 151.0 162.0 177.0 154.0 19:47:02 INFO - PROCESS | 1936 | 19:47:02 INFO - PROCESS | 1936 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:175.00 stddev:2.56 (1.5%) stddev-sans-first:2.69 19:47:02 INFO - PROCESS | 1936 | Values: 174.0 179.0 174.0 171.0 172.0 176.0 174.0 174.0 177.0 178.0 19:47:02 INFO - PROCESS | 1936 | 19:47:02 INFO - PROCESS | 1936 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:70.00 stddev:2.62 (3.7%) stddev-sans-first:2.78 19:47:02 INFO - PROCESS | 1936 | Values: 69.0 67.0 72.0 70.0 70.0 67.0 70.0 73.0 64.0 68.0 19:47:02 INFO - PROCESS | 1936 | -------- Summary: end -------- 19:47:02 INFO - PROCESS | 1936 | 19:47:03 INFO - TEST-INFO | 1936: exit 0 19:47:03 INFO - TEST-OK | kraken | took 61509ms 19:47:03 INFO - SUITE-END | took 1176s 19:47:04 INFO - Completed test suite (00:19:36) 19:47:04 INFO - javascript benchmark 19:47:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7369.1803759896575, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3300.900972970812, 3314.154890502922, 3335.182880194351, 3344.331133773246, 3388.9661103388967, 5506.256655351522, 5514.889702205954, 5518.862028449291, 5563.582731295159, 5594.748236329365, 4522.253828118365, 5362.1420572708375, 5578.693171875545, 5624.943750562493, 5631.324241091064, 4966.701997880121, 5058.595312375001, 5141.177411614142, 5162.277281180619, 5170.767315470794, 5033.0688822567945, 5216.7913283468615, 5253.0, 5260.053190425722, 5301.549368303698, 3827.0, 5044.2937988681615, 5094.414142373637, 5121.235891619656, 5133.101707201244, 5092.28707980883, 5132.076226279269, 5136.4606716295, 5139.563137133348, 5172.094883395428, 5062.417821950486, 5073.34046573943, 5083.6441449098575, 5084.237364395333, 5117.948820511821, 4218.346156345771, 5388.73056347185, 5445.53712934401, 5501.367342755594, 5569.192467092249, 6016.127661489103, 6054.394560543955, 6113.296970848321, 6115.633062016249, 6130.785422510191, 6128.877422451571, 6151.815445536641, 6165.445109940082, 6183.474404675608, 6188.721507532126, 5528.502434780889, 5601.187827764951, 5647.6893770843, 5660.518855897254, 5667.234923285345, 6193.473554747897, 6209.813705588839, 6215.316315205324, 6215.440610345091, 6227.439530442282, 5980.970095149496, 6005.519558435315, 6017.247844019497, 6032.155498230251, 6037.426444487766, 5870.677112758839, 6032.39676032402, 6071.119687645267, 6109.938900611026, 6130.908036379458, 5858.326292476335, 5912.763489460373, 5916.704164791743, 5973.163757074013, 6029.186059881948, 6019.217501724747, 6072.423119803611, 6106.297775755845, 6106.45041946227, 6122.295935967331, 4769.546893045155, 4806.4712881583, 4827.348307978448, 4838.0082083172865, 4866.270059491105, 4252.468441444819, 4302.94577828434, 4344.196323680129, 4386.2762644163995, 4395.27477966132, 4009.7594144351433, 4030.576789437067, 4960.90078198434, 5678.716064196857, 5745.827625171251, 5118.692878427306, 5987.101934709741, 6151.446369826737, 6166.167567378437, 6190.876182476415, 5501.972490137524, 5673.978683836866, 5678.432156784289, 5697.601167918206, 5698.31620205578, 4403.383526306319, 4443.844465443759, 5233.947660523346, 5301.522862942354, 5363.490468405495, 6173.59871608344, 6181.629102253789, 6214.720337584819, 6216.409441103088, 6244.843878902973, 4457.888552786077, 5903.350631430453, 6126.938730612636, 6161.168242287234, 6164.691765411621, 6168.568200225941, 6182.505399568114, 6183.84540386494, 6246.219222597176, 6248.875022499616, 6035.155078288955, 6063.605865618721, 6064.221688615873, 6091.177691011657, 6099.573029887865, 6006.399360063959, 6099.84750381244, 6108.938910610837, 6139.754409823557, 6140.5701600887505, 5937.584369094122, 5980.461758441761, 5989.251343582052, 6041.456268935817, 6056.182415373868, 5109.5912327013, 5916.437938395846, 5962.821115366546, 5969.134475501115, 6044.184035155374, 4869.732164730974, 4886.3647725796845, 5536.197251398444, 5702.657840529581, 5824.737886795019, 4878.292647566154, 5983.700814959322, 6002.729877155626, 6011.789587364597, 6022.096685497036, 4947.960928205117, 5709.0, 5800.4489573490455, 5808.332041815245, 5809.099589563624], "value": 5487.917147862361, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [438.34467471130654, 457.66133061534464, 466.454248529221, 498.1108720933135, 539.099703495163, 33218.00345989618, 38021.61978380219, 40440.79779601098, 40505.0, 40630.79684601573, 40519.0, 41050.79474602623, 41076.178476430454, 41147.38278925811, 41224.0, 9647.324687271876, 9835.31152819303, 9857.802843943116, 9861.852072218922, 9900.851487227697, 9634.229261659051, 9721.659741909034, 9735.75660608487, 9741.659041933533, 9756.560954757053, 9676.516174191298, 9686.903130968705, 9688.982656821003, 9691.418514889094, 9698.224142068653, 9666.226701863834, 9672.177864881494, 9706.514674266295, 9737.756556086084, 9739.951300243525, 9586.856197157049, 9633.855492167622, 9644.373115747454, 9666.323357364987, 9686.07982241686, 39307.80346098251, 39717.41130354782, 39828.402573961124, 39860.60139398627, 40108.799456002824, 3055.7097075777765, 3406.199543107368, 3458.6892602524454, 3675.9891029966707, 4107.63031327179, 31226.0, 31484.0, 32109.839450802596, 32147.0, 32228.194295142574, 2873.7642813590146, 2937.7649788016906, 3230.8707651693903, 3392.71161951232, 3441.6730410610953, 425747.0, 467421.0, 474652.0, 474802.0, 475063.0, 52554.948901021766, 55843.441565583824, 58927.0, 59145.81708365808, 59241.111383329284, 60862.695686521285, 61243.77512449726, 61346.079808802904, 61400.38599614036, 61409.0, 15777.211139442981, 15845.920770396075, 15897.28462219203, 16031.759523606923, 16060.43788467398, 12359.443825027894, 12457.0, 12503.062270329761, 12507.874921250854, 12533.74932501363, 15668.138252396227, 16003.279852406436, 16103.114328712034, 16279.883615129957, 16373.754393684105, 6102.0, 6395.904061439082, 6947.4789390795895, 7439.925600744032, 7614.466987310835, 871.694906782621, 879.9428037177563, 1009.0766948242423, 1065.1319174872453, 1099.9285046471953, 29797.702022979494, 30001.249968750955, 30200.54699179514, 30504.389912202074, 30948.916787912764, 999.715081201854, 1048.9737756556146, 1057.799018186542, 1084.2410312781085, 1170.7365842685329, 14999.17504537239, 16676.16619169037, 17072.975621462752, 17079.65840683204, 17112.401065962633, 624487.0, 628559.0, 630762.0, 633591.0, 634929.0, 58004.70997644985, 58726.0, 58947.0, 59051.0, 59090.0, 1157.432857899623, 1367.282176857158, 1371.7530844448095, 1386.7226554689103, 1391.812105365803, 29940.70059299379, 30625.54061689121, 31076.0, 31273.218169545944, 31356.0, 51260.487395127064, 51557.48442515527, 51610.0, 51627.74186129045, 51628.74185629198, 562814.0, 564849.0, 566447.0, 566646.0, 568631.0, 23856.926438310664, 26407.735922640528, 27123.457530849668, 27193.59209611897, 28078.017269395474, 47795.0, 47863.76068119637, 48161.5183848157, 48632.5136748628, 49215.75392123016, 39195.21609567736, 39270.0, 39486.605133948295, 40735.38896916608, 41246.793766030976, 36144.63855361518, 36430.0, 36656.45015324825, 39797.40303895502, 39808.60191398049, 38051.0, 38743.0, 39022.0, 39189.02027449336, 40376.59623403846, 30191.547126792677, 31153.68846311508, 35331.29337413289, 35521.0, 35933.0, 25463.0, 25713.10004149846, 25726.228213153634, 25995.610065849407, 26549.734502654726], "value": 19848.702136454554, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.52496767010024, 374.1133513572835, 382.5791629207871, 388.2119297825412, 403.65084202165116, 19863.50341241468, 21871.0, 22545.0, 22676.773232267693, 22822.31533054007, 15992.680146397066, 17747.0, 21192.4701882453, 21284.255051073178, 21632.3510294691, 5907.0043905435805, 5959.731812068457, 6035.577509574332, 6045.576809623328, 6077.392260773931, 4188.937165942513, 5961.672108034057, 6066.908996365058, 6078.756849726005, 6080.0, 5893.793717219898, 6259.593126446789, 6777.288384719607, 6832.6925288362145, 6849.897251541231, 5828.271466066742, 6109.205803245594, 6164.599301045418, 6521.347865213488, 6786.253512113663, 5509.421510741355, 5747.2241247431475, 6026.608270462406, 6036.909446358264, 6063.666498342589, 23275.4181145471, 24888.37779055538, 25158.0, 26401.603975940376, 26471.735282647118, 2293.415179129328, 2330.568844763707, 2400.615901455759, 2612.242449689588, 2712.823666461674, 7950.443468957175, 9996.600135994551, 10189.89810101897, 10495.79008419835, 10528.36829790215, 1887.6790945539292, 1891.8297353238138, 1915.5019694879293, 1925.9325923592608, 1931.401265607652, 113570.43214783956, 115733.26400104005, 124859.0, 125321.0, 126971.36514317461, 10279.94860025695, 10452.0, 10468.057874791306, 10558.683239502674, 10710.410927398912, 12754.76791561473, 12757.362131893367, 12770.169938954125, 12790.232586044867, 12826.80759788604, 7912.802179945547, 8082.797930051795, 8170.714025009215, 8223.712170074139, 8302.211289927447, 8235.38234632405, 8263.710770123016, 8312.33501319893, 8338.749837504885, 8502.659893604186, 3255.4302996975434, 4069.89825254371, 4102.405151253051, 4175.832966681299, 4177.895552611209, 1573.968520629581, 1875.5686192175876, 1913.598144389666, 1948.5615736459183, 1951.8828870267546, 768.7578412800062, 842.3598065470287, 855.362754747717, 875.916787905148, 965.9420434773796, 14823.851761482247, 20288.898555507425, 21419.785802141778, 21585.460363491038, 21654.783452165593, 887.8679683403712, 918.8392031394613, 920.4845286639503, 991.9008099190023, 1022.8772547294373, 11136.665900023012, 11360.545578176945, 11426.314421134592, 11462.598809041643, 11467.369294688706, 575681.0, 606959.0, 618617.0, 619589.0, 628716.0, 78676.42647147024, 81432.0, 124399.0, 138677.0, 153080.0, 985.6747273399761, 993.6720882108887, 1015.8069966706155, 1020.7346090016649, 1020.8009438159636, 18444.723329150343, 18651.626967460303, 19285.4214373569, 19482.0, 19503.317383892063, 53847.65380865509, 54205.18692219541, 56852.71573642105, 56923.43076569181, 57136.42863571477, 60016.69991650014, 78835.60582197053, 80496.0, 83983.16016839753, 87102.69345959942, 10909.890901091205, 11720.88279117198, 11906.214067889885, 12192.939035304767, 12522.436490357773, 13223.140495867738, 13236.602901912958, 13373.39819708135, 13410.463581456632, 13772.380242889294, 11277.266977646426, 11410.201285909907, 11622.70943226426, 11738.647840564796, 11759.412029398667, 8780.385373023826, 9165.54172291396, 11103.555857765921, 11698.94150529242, 11749.823752643888, 9327.860082098638, 11564.363959982282, 11923.10576706733, 12007.939960300142, 12127.514899403925, 11854.644360669194, 11893.881061189277, 12129.0, 12163.574274900337, 12254.20347677398, 9743.0, 11402.030827379765, 11729.882701172879, 11796.4691588877, 11992.220505667105], "value": 9758.987252151144, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1304.6607881950692, 1535.3628244278625, 1700.9404670836516, 1857.3777784442211, 1870.298638010746, 8085.353171746261, 8683.261922736567, 8716.04123546411, 9138.406003609769, 9202.0, 8737.563121843914, 8910.242629376511, 8929.374943753939, 8932.95533522333, 8935.151160639745, 2365.3849999000213, 2368.2184878989933, 2374.9406264843433, 2383.95232095358, 2393.270052633946, 2365.4559451326204, 2367.0886708617136, 2402.5675378431874, 2413.5655581995234, 2418.407490164912, 2371.2886134159685, 2387.7254115776736, 2398.8605412429133, 2409.662647229389, 2411.3007227903886, 2233.7542870284256, 2251.0545570860277, 2294.1740973249616, 2297.9540409191804, 2300.298408985259, 2358.929232123039, 2358.9528209435716, 2364.5152743687504, 2375.311159763684, 2375.6911601491697, 6967.407770339477, 9031.81936361269, 9038.683646072355, 9044.8643270351, 9051.637934482613, 5365.195220716884, 5431.076716958127, 5493.505584497414, 5512.614117011811, 5515.227868098469, 3229.54786329914, 3674.1365779041903, 3702.1670124222105, 3710.664160902073, 3725.5715592706915, 1118.6588090632354, 1121.9214654974155, 1122.2032357026521, 1138.2203190814319, 1152.8847115288488, 11728.413579321, 11820.172587918849, 11921.0, 11954.983826374855, 12004.2197257178, 4185.0374413884365, 4586.4266966629175, 4717.150912835723, 4806.4712881583, 4899.681520701214, 9297.442153470813, 10107.7473063174, 10142.949285253526, 10147.847782283272, 10171.4914254287, 5430.56555475561, 5457.727113644302, 5459.590530710213, 5461.481159289861, 5469.261649677323, 3964.4053391990856, 4058.24922389353, 4428.1365133799245, 4951.257311403247, 4991.875203119878, 3421.9315613687586, 3953.5453422856162, 3971.3050216212623, 4031.677465802729, 4057.046594050396, 1098.7143342730947, 1321.5044358365612, 1325.8872995795466, 1330.767115754739, 1330.8735670111323, 838.7567605394489, 916.7341470973477, 933.6918816790443, 940.116290686766, 960.1406740966795, 4842.951570484321, 5082.84329307056, 5476.0, 5704.22992895962, 6027.342976025397, 400.24353970994844, 425.53616557951364, 439.3519558651028, 442.61934736126904, 444.9065696203769, 3974.423708562242, 4023.4367188593037, 4035.5964403559997, 4083.448734420815, 4104.0970986382945, 8886.333524985652, 9270.655754915635, 9958.302918795614, 10998.450077496092, 11051.613193538187, 9289.396189247676, 10916.945415273032, 10940.343579385262, 10948.507317170586, 10974.231803773659, 8134.227248411392, 8399.95800020996, 8403.579821008803, 8421.157884211652, 8433.746987590383, 5029.396472423333, 5542.8337149885565, 5909.113632955091, 5949.25634295713, 5999.430054144849, 9966.352187107816, 10302.948485257526, 10344.069033786995, 10400.11599014062, 10472.26694131434, 10059.798804023732, 10169.084782369622, 10479.371237725762, 10508.632197873038, 10548.525316360936, 7076.398506127037, 7563.886541701989, 7576.128745194374, 7784.92215077842, 7800.180980996914, 8550.0, 8573.31413486932, 8612.138786121337, 8615.22462978335, 8616.65533378683, 7538.3592394644875, 7643.7324693635455, 7679.116901556169, 7794.2985131338455, 7827.647755850887, 7463.2163622818825, 7588.127365353055, 7593.544387336557, 7612.391008719178, 7615.390768738377, 7137.393321567725, 7214.675339609626, 7228.674709637974, 7278.126624805057, 7279.0, 5024.397072351341, 5034.723090230073, 5065.265536497113, 5110.131277682877, 5158.535731784157, 5088.287639730367, 5146.228065790161, 5162.664426812245, 5264.52619264268, 5271.393789714079], "value": 4528.786426938436, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.7462306285783, 306.4575701009214, 312.05914168781123, 312.82169163576754, 314.6208818373857, 4825.73458459785, 5564.579407957542, 5582.5254853337465, 5649.435056494359, 5720.370759216483, 5483.670979741219, 5489.231507588941, 5542.972285138579, 5576.386597474285, 5676.16191904048, 4026.8187931543002, 4140.896477588054, 4187.267228235047, 4216.325387937931, 4242.787860606973, 3681.9815900920457, 4209.621134097931, 4235.745855248695, 4247.978760106195, 4253.787310634471, 3838.905911815133, 3888.300105980922, 4247.405363249132, 4250.596193361625, 4282.914341713164, 3470.670286322795, 3854.3447613905705, 4095.484670671841, 4237.2161150187, 4300.247456695081, 3241.1410976091356, 3437.2438063626214, 3582.247727977128, 3635.509206257148, 3685.1339935115225, 4414.735115893057, 4660.347551342815, 4684.976575117136, 5450.836474905759, 5461.863453413656, 4452.955470445287, 4597.37935378723, 4812.566868981773, 4877.780499877514, 4884.780184891652, 5287.4448182941005, 5820.068788993783, 5843.298804143487, 5862.570396318159, 5902.8819423611285, 3517.4899639552123, 4065.8170382332864, 4066.593340665939, 4077.97961010196, 4093.3655283431117, 4876.804927802884, 5192.896752701924, 6011.9699401503585, 6131.6934153292605, 6195.1946246988055, 4059.65492933104, 4069.6744260459686, 4107.363358679409, 4108.67130629549, 4117.1678603021965, 4167.4790651168605, 4169.749075277466, 4221.535631080578, 4229.767362795076, 4240.279152544013, 4579.473360563511, 4772.665913386099, 4855.975720121377, 4869.610431165498, 4882.218844984785, 5501.257330260443, 5794.362620111784, 5798.449147330997, 5814.651120932757, 5835.795747148914, 1404.0, 1436.956891293263, 1439.6113049476792, 1442.314900422312, 1447.6163816588612, 753.3483536740789, 880.2737741363401, 887.4956947973252, 891.6255172827427, 901.3375169250595, 4566.406367172246, 5253.8423847283875, 5485.61600687948, 5519.337679478488, 5561.888762224733, 5210.400803907523, 5636.097409833938, 6131.816045518642, 6142.385761423822, 6175.197224360804, 5303.416624171338, 5467.972660136674, 5505.2933590587045, 5544.168374743821, 5547.472990065938, 2688.6639170103736, 3010.0217429335116, 3100.682210060715, 3187.8724851006164, 3192.3455691583636, 5794.942050579524, 5986.042233242661, 6097.542684298695, 6243.751249750068, 6360.681965901686, 6168.506519478431, 6185.659788711574, 6197.932023648323, 6207.0, 6232.096346029891, 6298.559100862987, 6299.244090709144, 6334.3665633436285, 6336.6831658416895, 6388.840278993062, 4737.0, 4799.400074990626, 5891.675957822189, 6063.636181829104, 6076.696165191811, 5328.282575886248, 5404.702741349263, 5687.289088863892, 5916.467517923407, 5918.585699001029, 5055.469175736494, 6104.38956104386, 6147.385261473817, 6235.3452887446165, 6388.8083357499345, 3489.633588473174, 3570.7143428526174, 3823.2735780201674, 4032.516098068133, 4051.736637118578, 4967.552920237196, 4991.600671946163, 5205.505476979681, 5983.012802887475, 6107.389261073857, 4994.654650453983, 5221.921671175011, 5462.617616766947, 5871.500922421642, 5879.911801323069, 4917.655764096479, 5091.6181286402925, 5367.35591728995, 5758.337791153904, 5789.247397838422, 5322.760475778522, 5422.376426710979, 5535.142052981794, 5577.888442231214, 5643.858903527281, 4660.440747110369, 5206.167013277857, 5642.23829782974, 5825.475707186373, 5939.4357536034, 4985.401751789808, 4987.775550100182, 5390.51485366319, 5699.458551437607, 5782.335031471266], "value": 4236.473298906824, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.2851828890267, 666.9066330713698, 701.0955866931662, 786.866232740434, 804.2078552625662, 15248.923755381222, 15850.920745396286, 15864.365425383, 15866.889317747748, 15909.44316948907, 14371.64070898228, 14456.638584035405, 14487.855121448782, 14507.057041292308, 14525.27373631317, 677.7898851356096, 823.9752807415757, 831.4803247970034, 843.6751850537556, 854.4830377621543, 851.1105894340429, 851.7061613743249, 852.799592095857, 852.957352132394, 856.0583358305845, 903.1465265324272, 904.1320332480826, 907.7458311672709, 908.6002159049997, 909.3407279722214, 897.5781382750097, 904.1771987491417, 904.7692838326218, 905.0135352465778, 905.8595917632778, 655.5673255651247, 663.2041550139852, 674.7874419557872, 675.0111087257143, 676.370974993256, 14612.926935365254, 14876.033057851206, 14906.403743850233, 15060.096394216382, 15064.0, 14744.336504857307, 14754.188519631416, 14766.778498322534, 14797.40810367584, 14977.251137443192, 11962.760744785055, 12176.81734773979, 12371.75256494874, 12376.443060062318, 12543.184692994926, 3216.630087539916, 3876.8061596920043, 3985.7807820569856, 4043.4945631796027, 4107.8973025674295, 115456.84543154544, 117815.41092294484, 118391.4080429601, 118560.0, 123075.0, 10005.399676019317, 10014.64948726791, 11091.44542772858, 11402.600908968312, 11509.76980460386, 21235.46911327198, 23526.176583819826, 23757.762422375556, 23781.0, 23806.0, 6541.836454088686, 7203.963980180066, 7401.5189012714, 7986.920130798734, 7989.680412783424, 4519.435070616173, 4634.165850146938, 4636.374089497875, 4640.164770341304, 4658.231391820312, 3488.7383446241633, 3599.802010889374, 3617.620149884277, 3632.0738211755834, 3731.104534911656, 588.9146073819358, 674.6053558668234, 699.8180473077036, 707.4835370179695, 711.0542977839461, 500.52200148857753, 559.6865755177114, 582.4932308891292, 596.3946594206883, 675.7364627795065, 9467.431954082776, 9719.17387022111, 9769.85345219808, 9786.608535658494, 9986.450745209084, 598.6587645042284, 623.6027184716288, 631.908373285871, 672.7409947170374, 687.2440315652742, 4525.298578720303, 4739.928901066418, 4866.46468888422, 4878.536539028786, 4909.263610458388, 97194.51402743082, 98453.0, 119147.0, 164368.0, 167832.4825127624, 87774.0, 89619.0, 127219.0, 137550.0, 137998.0, 95846.0, 121665.56668866573, 123772.38113809374, 124744.7525524733, 127028.99999999815, 9228.492432916253, 9247.213986810928, 9251.86122208154, 9254.398464099811, 9381.859272110787, 46805.2979205319, 51612.96774064573, 61808.38191618026, 62741.0, 65136.34863651303, 62766.0, 65032.37419064372, 86112.56943715242, 102054.48972755088, 105520.0, 13120.60638180856, 13589.456421743414, 13631.182129072287, 13729.588112356645, 13758.0, 13566.304211973504, 14436.855631443972, 15374.38502459889, 15571.91364909429, 15633.296501657225, 14036.578902632937, 14219.786703199667, 14434.855651443351, 14960.775588366401, 15042.548723538312, 13910.930445347709, 14138.717225655635, 14436.711265774837, 14806.555803325917, 14919.403223870924, 13970.091944023607, 14080.507182248572, 14115.435382584581, 14143.717125657635, 14471.27643617794, 11090.44547772592, 11329.320240785579, 11448.885511144781, 11509.597164099216, 12014.819777703517, 9171.974522292941, 10309.278350515391, 10566.0, 11555.2489088209, 11803.586874459354], "value": 7851.249310704354, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1627.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 161.0, 110.0, 117.0, 144.0, 178.0, 149.0, 117.0, 100.0, 172.0], "value": 140.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 116.0, 168.0, 190.0, 110.0, 131.0, 131.0, 111.0, 162.0, 140.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [251.0, 291.0, 279.0, 259.0, 199.0, 200.0, 200.0, 197.0, 199.0, 198.0], "value": 227.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 94.0, 183.0, 61.0, 60.0, 60.0, 63.0, 139.0, 59.0], "value": 86.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 125.0, 74.0, 76.0, 80.0, 138.0, 101.0, 101.0, 150.0], "value": 98.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 89.0, 88.0, 90.0, 86.0, 92.0, 88.0, 116.0, 130.0], "value": 95.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 106.0, 98.0, 121.0, 105.0, 151.0, 152.0, 97.0, 121.0, 151.0], "value": 119.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 92.0, 93.0, 92.0, 90.0, 92.0, 94.0, 91.0, 92.0], "value": 91.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 62.0, 59.0, 59.0, 59.0, 57.0, 57.0, 62.0, 91.0], "value": 62.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 70.0, 72.0, 74.0, 80.0, 76.0, 76.0, 69.0, 71.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 90.0, 90.0, 89.0, 85.0, 95.0, 112.0, 90.0, 88.0], "value": 91.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 184.0, 130.0, 154.0, 155.0, 153.0, 151.0, 162.0, 177.0, 154.0], "value": 156.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 179.0, 174.0, 171.0, 172.0, 176.0, 174.0, 174.0, 177.0, 178.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 72.0, 70.0, 70.0, 67.0, 70.0, 73.0, 64.0, 68.0], "value": 69.0, "unit": "score"}]}]} 19:47:04 INFO - Return code: 0 19:47:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:47:04 ERROR - # TBPL SUCCESS # 19:47:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:47:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:47:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:47:04 INFO - 2016-08-16 19:47:04.290 screenresolution[1941:17098] starting screenresolution argv=screenresolution get 19:47:04 INFO - 2016-08-16 19:47:04.292 screenresolution[1941:17098] Display 0: 1600x1200x32@60 19:47:04 INFO - 2016-08-16 19:47:04.298 screenresolution[1942:17101] starting screenresolution argv=screenresolution list 19:47:04 INFO - Available Modes on Display 0 19:47:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:47:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:47:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:47:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:47:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:47:04 INFO - Intel Iris: 19:47:04 INFO - Chipset Model: Intel Iris 19:47:04 INFO - Type: GPU 19:47:04 INFO - Bus: Built-In 19:47:04 INFO - VRAM (Dynamic, Max): 1536 MB 19:47:04 INFO - Vendor: Intel (0x8086) 19:47:04 INFO - Device ID: 0x0a2e 19:47:04 INFO - Revision ID: 0x0009 19:47:04 INFO - Displays: 19:47:04 INFO - Display: 19:47:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:47:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:47:04 INFO - Display Serial Number: 1600x1200 60 19:47:04 INFO - Main Display: Yes 19:47:04 INFO - Mirror: Off 19:47:04 INFO - Online: Yes 19:47:04 INFO - Rotation: Supported 19:47:04 INFO - Return code: 0 19:47:04 INFO - Running post-action listener: _resource_record_post_action 19:47:04 INFO - [mozharness: 2016-08-17 02:47:04.531567Z] Finished run-tests step (success) 19:47:04 INFO - Running post-run listener: _resource_record_post_run 19:47:04 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 1056768; Write bytes: 708148224; Read time: 13; Write time: 1955 19:47:04 INFO - TinderboxPrint: CPU usage
54.4% 19:47:04 INFO - TinderboxPrint: I/O read bytes / time
1,056,768 / 13 19:47:04 INFO - TinderboxPrint: I/O write bytes / time
708,148,224 / 1,955 19:47:04 INFO - TinderboxPrint: CPU idle
2,211.9 (45.6%) 19:47:04 INFO - TinderboxPrint: CPU system
978.5 (20.2%) 19:47:04 INFO - TinderboxPrint: CPU user
1,655.3 (34.2%) 19:47:04 INFO - TinderboxPrint: Swap in / out
406,511,616 / 0 19:47:04 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 396077568; Write bytes: 392786944; Read time: 29513; Write time: 732 19:47:04 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 1056768; Write bytes: 297445376; Read time: 13; Write time: 1178 19:47:05 INFO - Running post-run listener: _upload_blobber_files 19:47:05 INFO - Blob upload gear active. 19:47:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:47:05 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 19:47:05 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'] 19:47:05 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 19:47:05 INFO - (blobuploader) - INFO - Open directory for files ... 19:47:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:47:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:47:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:47:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:47:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:47:06 INFO - (blobuploader) - INFO - Done attempting. 19:47:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:47:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:47:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:47:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:47:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:47:07 INFO - (blobuploader) - INFO - Done attempting. 19:47:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:47:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:47:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:47:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:47:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:47:10 INFO - (blobuploader) - INFO - Done attempting. 19:47:10 INFO - (blobuploader) - INFO - Iteration through files over. 19:47:10 INFO - Return code: 0 19:47:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:47:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:47:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64ca8650f0680cf404a4fc55cc43a36e85781666e34ffde9a248499790e16146b7d9e5aa8fc9be861f5188fa9a1ea880b2067b11769bded26332a1274e71a5ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e146cc0264acc97da07b9cd001f37602a76a8b9cc1a37785c979de5c8a74acdae378f43e5153159fe02ead4f796279f9f30e7657cdc28ac7e0dd5d1c092668d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/364f3f5c3b5a36979eb09608038fcd7f10acdf9c6b324d5910be70deae7c32adf973b8fe83d26eb82bfaa336839b67c44e24f4171a5e520f66a3d619ca00ec68"} 19:47:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:47:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:47:10 INFO - Contents: 19:47:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64ca8650f0680cf404a4fc55cc43a36e85781666e34ffde9a248499790e16146b7d9e5aa8fc9be861f5188fa9a1ea880b2067b11769bded26332a1274e71a5ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e146cc0264acc97da07b9cd001f37602a76a8b9cc1a37785c979de5c8a74acdae378f43e5153159fe02ead4f796279f9f30e7657cdc28ac7e0dd5d1c092668d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/364f3f5c3b5a36979eb09608038fcd7f10acdf9c6b324d5910be70deae7c32adf973b8fe83d26eb82bfaa336839b67c44e24f4171a5e520f66a3d619ca00ec68"} 19:47:10 INFO - Running post-run listener: copy_logs_to_upload_dir 19:47:10 INFO - Copying logs to upload dir... 19:47:10 INFO - mkdir: /builds/slave/test/build/upload/logs 19:47:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.919497 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-16 19:47:10.317032) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 19:47:10.320927) ========= 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.0JvcEfpM5T/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.6qNLO1sFO1/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64ca8650f0680cf404a4fc55cc43a36e85781666e34ffde9a248499790e16146b7d9e5aa8fc9be861f5188fa9a1ea880b2067b11769bded26332a1274e71a5ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e146cc0264acc97da07b9cd001f37602a76a8b9cc1a37785c979de5c8a74acdae378f43e5153159fe02ead4f796279f9f30e7657cdc28ac7e0dd5d1c092668d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/364f3f5c3b5a36979eb09608038fcd7f10acdf9c6b324d5910be70deae7c32adf973b8fe83d26eb82bfaa336839b67c44e24f4171a5e520f66a3d619ca00ec68"} build_url:https://queue.taskcluster.net/v1/task/cxbgc7tOQMuVWBXcWkgn9g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011146 build_url: 'https://queue.taskcluster.net/v1/task/cxbgc7tOQMuVWBXcWkgn9g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64ca8650f0680cf404a4fc55cc43a36e85781666e34ffde9a248499790e16146b7d9e5aa8fc9be861f5188fa9a1ea880b2067b11769bded26332a1274e71a5ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e146cc0264acc97da07b9cd001f37602a76a8b9cc1a37785c979de5c8a74acdae378f43e5153159fe02ead4f796279f9f30e7657cdc28ac7e0dd5d1c092668d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/364f3f5c3b5a36979eb09608038fcd7f10acdf9c6b324d5910be70deae7c32adf973b8fe83d26eb82bfaa336839b67c44e24f4171a5e520f66a3d619ca00ec68"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 19:47:10.353454) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 19:47:10.353788) ========= 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.0JvcEfpM5T/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.6qNLO1sFO1/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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.005191 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 19:47:10.402583) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 19:47:10.402895) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 19:47:10.403303) ========= ========= Total master_lag: 0.19 =========