builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0261 starttime: 1470441538.85 results: success (0) buildid: 20160805144421 builduid: cf4d1e25e288480493c446df9e8405d7 revision: 99ed3a3aa3e82bd75ff3077ff0d1b97c637fa6a1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 16:58:58.854446) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 16:58:58.854977) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 16:58:58.855274) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 16:58:58.878951) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 16:58:58.879515) ========= 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.zfxRS3QCs3/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.ZJkru6Qri8/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-05 16:58: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% 26.5M=0s 2016-08-05 16:58:58 (26.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105638 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 16:58:59.008456) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 16:58:59.008816) ========= 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.zfxRS3QCs3/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.ZJkru6Qri8/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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.025139 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 16:58:59.059681) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-05 16:58:59.060330) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 99ed3a3aa3e82bd75ff3077ff0d1b97c637fa6a1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 99ed3a3aa3e82bd75ff3077ff0d1b97c637fa6a1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zfxRS3QCs3/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.ZJkru6Qri8/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-05 16:58:59,143 truncating revision to first 12 chars 2016-08-05 16:58:59,143 Setting DEBUG logging. 2016-08-05 16:58:59,143 attempt 1/10 2016-08-05 16:58:59,143 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/99ed3a3aa3e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-05 16:59:00,181 unpacking tar archive at: autoland-99ed3a3aa3e8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.289724 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-05 16:59:00.372693) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 16:59:00.373037) ========= script_repo_revision: 99ed3a3aa3e82bd75ff3077ff0d1b97c637fa6a1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 16:59:00.373470) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 16:59:00.373733) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 16:59:00.392619) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-08-05 16:59:00.393012) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zfxRS3QCs3/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.ZJkru6Qri8/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 16:59:00 INFO - MultiFileLogger online at 20160805 16:59:00 in /builds/slave/test 16:59:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 16:59:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:59:00 INFO - {'append_to_log': False, 16:59:00 INFO - 'base_work_dir': '/builds/slave/test', 16:59:00 INFO - 'blob_upload_branch': 'Autoland', 16:59:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:59:00 INFO - 'branch': 'Autoland', 16:59:00 INFO - 'buildbot_json_path': 'buildprops.json', 16:59:00 INFO - 'config_files': ('talos/mac_config.py',), 16:59:00 INFO - 'default_actions': ('clobber', 16:59:00 INFO - 'read-buildbot-config', 16:59:00 INFO - 'download-and-extract', 16:59:00 INFO - 'populate-webroot', 16:59:00 INFO - 'create-virtualenv', 16:59:00 INFO - 'install', 16:59:00 INFO - 'run-tests'), 16:59:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:59:00 INFO - 'download_minidump_stackwalk': True, 16:59:00 INFO - 'download_symbols': 'ondemand', 16:59:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:59:00 INFO - 'tooltool.py': '/tools/tooltool.py', 16:59:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:59:00 INFO - '/tools/misc-python/virtualenv.py')}, 16:59:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:59:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:59:00 INFO - 'installer_path': 'installer.exe', 16:59:00 INFO - 'log_level': 'info', 16:59:00 INFO - 'log_name': 'talos', 16:59:00 INFO - 'log_to_console': True, 16:59:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:59:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:59:00 INFO - 'opt_config_files': (), 16:59:00 INFO - 'pip_index': False, 16:59:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:59:00 INFO - 'cmd': ('bash', 16:59:00 INFO - '-c', 16:59:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:59:00 INFO - 'enabled': True, 16:59:00 INFO - 'halt_on_failure': False, 16:59:00 INFO - 'name': 'check_screen_resolution'},), 16:59:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:59:00 INFO - 'cmd': ('bash', 16:59:00 INFO - '-c', 16:59:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:59:00 INFO - 'enabled': True, 16:59:00 INFO - 'halt_on_failure': False, 16:59:00 INFO - 'name': 'check_screen_resolution'},), 16:59:00 INFO - 'run_cmd_checks_enabled': True, 16:59:00 INFO - 'sps_profile': False, 16:59:00 INFO - 'sps_profile_interval': 0, 16:59:00 INFO - 'suite': 'dromaeojs-e10s', 16:59:00 INFO - 'system_bits': '32', 16:59:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:59:00 INFO - 'title': 't-yosemite-r7-0261', 16:59:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:59:00 INFO - 'use_talos_json': True, 16:59:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:59:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:59:00 INFO - 'work_dir': 'build'} 16:59:00 INFO - [mozharness: 2016-08-05 23:59:00.583136Z] Running clobber step. 16:59:00 INFO - Running pre-action listener: _resource_record_pre_action 16:59:00 INFO - Running main action method: clobber 16:59:00 INFO - rmtree: /builds/slave/test/build 16:59:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:59:02 INFO - Running post-action listener: _resource_record_post_action 16:59:02 INFO - [mozharness: 2016-08-05 23:59:02.641934Z] Finished clobber step (success) 16:59:02 INFO - [mozharness: 2016-08-05 23:59:02.642224Z] Running read-buildbot-config step. 16:59:02 INFO - Running pre-action listener: _resource_record_pre_action 16:59:02 INFO - Running main action method: read_buildbot_config 16:59:02 INFO - Using buildbot properties: 16:59:02 INFO - { 16:59:02 INFO - "project": "", 16:59:02 INFO - "product": "firefox", 16:59:02 INFO - "script_repo_revision": "production", 16:59:02 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 16:59:02 INFO - "repository": "", 16:59:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 16:59:02 INFO - "buildid": "20160805144421", 16:59:02 INFO - "pgo_build": "False", 16:59:02 INFO - "basedir": "/builds/slave/test", 16:59:02 INFO - "buildnumber": 109, 16:59:02 INFO - "slavename": "t-yosemite-r7-0261", 16:59:02 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 16:59:02 INFO - "platform": "yosemite_r7", 16:59:02 INFO - "scheduler": "tests-autoland-macosx64-talos", 16:59:02 INFO - "branch": "autoland", 16:59:02 INFO - "repo_path": "integration/autoland", 16:59:02 INFO - "revision": "99ed3a3aa3e82bd75ff3077ff0d1b97c637fa6a1", 16:59:02 INFO - "stage_platform": "macosx64", 16:59:02 INFO - "builduid": "cf4d1e25e288480493c446df9e8405d7", 16:59:02 INFO - "slavebuilddir": "test" 16:59:02 INFO - } 16:59:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/ELS8nQwmR4CMtnuuGrx9ag/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 16:59:02 INFO - Running post-action listener: _resource_record_post_action 16:59:02 INFO - [mozharness: 2016-08-05 23:59:02.648356Z] Finished read-buildbot-config step (success) 16:59:02 INFO - [mozharness: 2016-08-05 23:59:02.648517Z] Running download-and-extract step. 16:59:02 INFO - Running pre-action listener: _resource_record_pre_action 16:59:02 INFO - Running main action method: download_and_extract 16:59:02 INFO - mkdir: /builds/slave/test/build/tests 16:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:02 INFO - trying https://queue.taskcluster.net/v1/task/ELS8nQwmR4CMtnuuGrx9ag/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 16:59:02 INFO - Downloading https://queue.taskcluster.net/v1/task/ELS8nQwmR4CMtnuuGrx9ag/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 16:59:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ELS8nQwmR4CMtnuuGrx9ag/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 16:59:04 INFO - Downloaded 1199 bytes. 16:59:04 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 16:59:04 INFO - Using the following test package requirements: 16:59:04 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 16:59:04 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:59:04 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 16:59:04 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:59:04 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 16:59:04 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:59:04 INFO - u'jsshell-mac.zip'], 16:59:04 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:59:04 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 16:59:04 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 16:59:04 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:59:04 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 16:59:04 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:59:04 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 16:59:04 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:59:04 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 16:59:04 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:59:04 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 16:59:04 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:59:04 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')]} 16:59:04 INFO - trying https://queue.taskcluster.net/v1/task/ELS8nQwmR4CMtnuuGrx9ag/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 16:59:04 INFO - Downloading https://queue.taskcluster.net/v1/task/ELS8nQwmR4CMtnuuGrx9ag/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 16:59:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ELS8nQwmR4CMtnuuGrx9ag/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 16:59:05 INFO - Downloaded 16320715 bytes. 16:59:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:59:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:59:08 INFO - Return code: 0 16:59:08 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 16:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:08 INFO - trying https://queue.taskcluster.net/v1/task/ELS8nQwmR4CMtnuuGrx9ag/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 16:59:08 INFO - Downloading https://queue.taskcluster.net/v1/task/ELS8nQwmR4CMtnuuGrx9ag/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 16:59:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ELS8nQwmR4CMtnuuGrx9ag/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 16:59:09 INFO - Downloaded 16320715 bytes. 16:59:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:59:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:59:13 INFO - Return code: 0 16:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:13 INFO - trying https://queue.taskcluster.net/v1/task/ELS8nQwmR4CMtnuuGrx9ag/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 16:59:13 INFO - Downloading https://queue.taskcluster.net/v1/task/ELS8nQwmR4CMtnuuGrx9ag/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 16:59:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ELS8nQwmR4CMtnuuGrx9ag/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 16:59:15 INFO - Downloaded 14413723 bytes. 16:59:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:59:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 16:59:15 INFO - Return code: 0 16:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:15 INFO - trying https://queue.taskcluster.net/v1/task/ELS8nQwmR4CMtnuuGrx9ag/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:59:15 INFO - Downloading https://queue.taskcluster.net/v1/task/ELS8nQwmR4CMtnuuGrx9ag/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 16:59:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ELS8nQwmR4CMtnuuGrx9ag/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 16:59:19 INFO - Downloaded 111813615 bytes. 16:59:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ELS8nQwmR4CMtnuuGrx9ag/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:59:19 INFO - mkdir: /builds/slave/test/properties 16:59:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:59:19 INFO - Writing to file /builds/slave/test/properties/build_url 16:59:19 INFO - Contents: 16:59:19 INFO - build_url:https://queue.taskcluster.net/v1/task/ELS8nQwmR4CMtnuuGrx9ag/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:59:20 INFO - Running post-action listener: _resource_record_post_action 16:59:20 INFO - Running post-action listener: set_extra_try_arguments 16:59:20 INFO - [mozharness: 2016-08-05 23:59:20.754839Z] Finished download-and-extract step (success) 16:59:20 INFO - [mozharness: 2016-08-05 23:59:20.754990Z] Running populate-webroot step. 16:59:20 INFO - Running pre-action listener: _resource_record_pre_action 16:59:20 INFO - Running main action method: populate_webroot 16:59:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:59:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:59:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:59:20 INFO - '--tppagecycles', 16:59:20 INFO - '7'], 16:59:20 INFO - 'tests': ['tsvgm']}}, 16:59:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:59:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:59:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:59:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:59:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:59:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:59:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:20 INFO - 'talos_options': ['--disable-e10s'], 16:59:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:59:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:59:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:20 INFO - 'talos_options': ['--disable-e10s'], 16:59:20 INFO - 'tests': ['damp', 'tps']}, 16:59:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:20 INFO - 'tests': ['damp', 'tps']}, 16:59:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:59:20 INFO - 'tests': ['dromaeo_dom']}, 16:59:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:59:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:59:20 INFO - 'tests': ['basic_compositor_video']}, 16:59:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:59:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:59:20 INFO - 'tests': ['a11yr', 16:59:20 INFO - 'ts_paint', 16:59:20 INFO - 'tpaint', 16:59:20 INFO - 'sessionrestore', 16:59:20 INFO - 'sessionrestore_no_auto_restore', 16:59:20 INFO - 'tabpaint']}, 16:59:20 INFO - 'other-e10s': {'tests': ['a11yr', 16:59:20 INFO - 'ts_paint', 16:59:20 INFO - 'tpaint', 16:59:20 INFO - 'sessionrestore', 16:59:20 INFO - 'sessionrestore_no_auto_restore', 16:59:20 INFO - 'tabpaint']}, 16:59:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:59:20 INFO - 'ts_paint', 16:59:20 INFO - 'tpaint', 16:59:20 INFO - 'sessionrestore', 16:59:20 INFO - 'sessionrestore_no_auto_restore', 16:59:20 INFO - 'tabpaint']}, 16:59:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:59:20 INFO - 'ts_paint', 16:59:20 INFO - 'tpaint', 16:59:20 INFO - 'sessionrestore', 16:59:20 INFO - 'sessionrestore_no_auto_restore', 16:59:20 INFO - 'tabpaint']}, 16:59:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:59:20 INFO - 'tests': ['a11yr', 16:59:20 INFO - 'ts_paint', 16:59:20 INFO - 'tpaint', 16:59:20 INFO - 'sessionrestore', 16:59:20 INFO - 'sessionrestore_no_auto_restore', 16:59:20 INFO - 'tabpaint']}, 16:59:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:59:20 INFO - 'tests': ['a11yr', 16:59:20 INFO - 'ts_paint', 16:59:20 INFO - 'tpaint', 16:59:20 INFO - 'sessionrestore', 16:59:20 INFO - 'sessionrestore_no_auto_restore', 16:59:20 INFO - 'tabpaint']}, 16:59:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:59:20 INFO - 'tests': ['tsvgx', 16:59:20 INFO - 'tsvgr_opacity', 16:59:20 INFO - 'tart', 16:59:20 INFO - 'tscrollx', 16:59:20 INFO - 'cart']}, 16:59:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:59:20 INFO - 'tsvgr_opacity', 16:59:20 INFO - 'tart', 16:59:20 INFO - 'tscrollx', 16:59:20 INFO - 'cart']}, 16:59:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:20 INFO - 'talos_options': ['--disable-e10s'], 16:59:20 INFO - 'tests': ['tp5o']}, 16:59:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:20 INFO - 'tests': ['tp5o']}, 16:59:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:20 INFO - 'talos_options': ['--disable-e10s', 16:59:20 INFO - '--xperf_path', 16:59:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:59:20 INFO - 'tests': ['tp5n']}, 16:59:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:20 INFO - 'talos_options': ['--xperf_path', 16:59:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:59:20 INFO - 'tests': ['tp5n']}}, 16:59:20 INFO - 'talos.zip': {'path': '', 16:59:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:59:20 INFO - Running post-action listener: _resource_record_post_action 16:59:20 INFO - [mozharness: 2016-08-05 23:59:20.774157Z] Finished populate-webroot step (success) 16:59:20 INFO - [mozharness: 2016-08-05 23:59:20.774294Z] Running create-virtualenv step. 16:59:20 INFO - Running pre-action listener: _resource_record_pre_action 16:59:20 INFO - Running main action method: create_virtualenv 16:59:20 INFO - Creating virtualenv /builds/slave/test/build/venv 16:59:20 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 16:59:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:59:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:59:20 INFO - Using real prefix '/tools/python27' 16:59:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:59:21 INFO - Installing distribute.............................................................................................................................................................................................done. 16:59:24 INFO - Installing pip.................done. 16:59:24 INFO - Return code: 0 16:59:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:24 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 0x10e7e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e875618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb39a4bed20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e744d30>, '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 0x10e4a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e73cb20>, '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.zfxRS3QCs3/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.ZJkru6Qri8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 16:59:24 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 16:59:24 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 16:59:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zfxRS3QCs3/Render', 16:59:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:59:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:59:24 INFO - 'HOME': '/Users/cltbld', 16:59:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:59:24 INFO - 'LOGNAME': 'cltbld', 16:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:24 INFO - 'MOZ_NO_REMOTE': '1', 16:59:24 INFO - 'NO_EM_RESTART': '1', 16:59:24 INFO - 'PAGER': '/bin/cat', 16:59:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:24 INFO - 'PWD': '/builds/slave/test', 16:59:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:59:24 INFO - 'SHELL': '/bin/bash', 16:59:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJkru6Qri8/Listeners', 16:59:24 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 16:59:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:59:24 INFO - 'USER': 'cltbld', 16:59:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:59:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:24 INFO - 'XPC_FLAGS': '0x0', 16:59:24 INFO - 'XPC_SERVICE_NAME': '0', 16:59:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:24 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 16:59:24 INFO - Cleaning up... 16:59:24 INFO - Return code: 0 16:59:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:24 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 0x10e7e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e875618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb39a4bed20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e744d30>, '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 0x10e4a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e73cb20>, '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.zfxRS3QCs3/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.ZJkru6Qri8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 16:59:24 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 16:59:24 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 16:59:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zfxRS3QCs3/Render', 16:59:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:59:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:59:24 INFO - 'HOME': '/Users/cltbld', 16:59:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:59:24 INFO - 'LOGNAME': 'cltbld', 16:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:24 INFO - 'MOZ_NO_REMOTE': '1', 16:59:24 INFO - 'NO_EM_RESTART': '1', 16:59:24 INFO - 'PAGER': '/bin/cat', 16:59:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:24 INFO - 'PWD': '/builds/slave/test', 16:59:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:59:24 INFO - 'SHELL': '/bin/bash', 16:59:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJkru6Qri8/Listeners', 16:59:24 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 16:59:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:59:24 INFO - 'USER': 'cltbld', 16:59:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:59:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:24 INFO - 'XPC_FLAGS': '0x0', 16:59:24 INFO - 'XPC_SERVICE_NAME': '0', 16:59:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:24 INFO - Downloading/unpacking psutil>=3.1.1 16:59:24 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 16:59:24 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 16:59:24 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 16:59:24 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 16:59:24 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 16:59:24 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 16:59:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:59:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:59:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:59:29 INFO - Installing collected packages: psutil 16:59:29 INFO - Running setup.py install for psutil 16:59:29 INFO - building 'psutil._psutil_osx' extension 16:59: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 16:59: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 16:59: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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 16:59:29 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 16:59:29 INFO - building 'psutil._psutil_posix' extension 16:59:29 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 16:59:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:59:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:59:30 INFO - ^ 16:59:30 INFO - 1 warning generated. 16:59: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 16:59:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:59:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:59:30 INFO - Successfully installed psutil 16:59:30 INFO - Cleaning up... 16:59:30 INFO - Return code: 0 16:59:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:59: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')]} 16:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59: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')]} 16:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59: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 0x10e7e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e875618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb39a4bed20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e744d30>, '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 0x10e4a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e73cb20>, '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.zfxRS3QCs3/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.ZJkru6Qri8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 16:59: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 16:59: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 16:59:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zfxRS3QCs3/Render', 16:59:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:59:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:59:30 INFO - 'HOME': '/Users/cltbld', 16:59:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:59:30 INFO - 'LOGNAME': 'cltbld', 16:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:30 INFO - 'MOZ_NO_REMOTE': '1', 16:59:30 INFO - 'NO_EM_RESTART': '1', 16:59:30 INFO - 'PAGER': '/bin/cat', 16:59:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:30 INFO - 'PWD': '/builds/slave/test', 16:59:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:59:30 INFO - 'SHELL': '/bin/bash', 16:59:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJkru6Qri8/Listeners', 16:59:30 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 16:59:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:59:30 INFO - 'USER': 'cltbld', 16:59:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:59:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:30 INFO - 'XPC_FLAGS': '0x0', 16:59:30 INFO - 'XPC_SERVICE_NAME': '0', 16:59:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:59:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:59:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:59:33 INFO - Installing collected packages: mozsystemmonitor 16:59:33 INFO - Running setup.py install for mozsystemmonitor 16:59:33 INFO - Successfully installed mozsystemmonitor 16:59:33 INFO - Cleaning up... 16:59:33 INFO - Return code: 0 16:59:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:59: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')]} 16:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59: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')]} 16:59:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59: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 0x10e7e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e875618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb39a4bed20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e744d30>, '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 0x10e4a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e73cb20>, '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.zfxRS3QCs3/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.ZJkru6Qri8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 16:59: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 16:59: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 16:59:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zfxRS3QCs3/Render', 16:59:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:59:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:59:33 INFO - 'HOME': '/Users/cltbld', 16:59:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:59:33 INFO - 'LOGNAME': 'cltbld', 16:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:33 INFO - 'MOZ_NO_REMOTE': '1', 16:59:33 INFO - 'NO_EM_RESTART': '1', 16:59:33 INFO - 'PAGER': '/bin/cat', 16:59:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:33 INFO - 'PWD': '/builds/slave/test', 16:59:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:59:33 INFO - 'SHELL': '/bin/bash', 16:59:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJkru6Qri8/Listeners', 16:59:33 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 16:59:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:59:33 INFO - 'USER': 'cltbld', 16:59:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:59:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:33 INFO - 'XPC_FLAGS': '0x0', 16:59:33 INFO - 'XPC_SERVICE_NAME': '0', 16:59:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:33 INFO - Downloading/unpacking jsonschema==2.5.1 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:59:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59:36 INFO - Downloading functools32-3.2.3-2.tar.gz 16:59:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:59:36 INFO - warning: no files found matching '*.txt' 16:59:36 INFO - no previously-included directories found matching 'build' 16:59:36 INFO - no previously-included directories found matching 'dist' 16:59:36 INFO - no previously-included directories found matching '.git*' 16:59:36 INFO - Installing collected packages: jsonschema, functools32 16:59:36 INFO - Running setup.py install for functools32 16:59:36 INFO - warning: no files found matching '*.txt' 16:59:36 INFO - no previously-included directories found matching 'build' 16:59:36 INFO - no previously-included directories found matching 'dist' 16:59:36 INFO - no previously-included directories found matching '.git*' 16:59:36 INFO - Successfully installed jsonschema functools32 16:59:36 INFO - Cleaning up... 16:59:36 INFO - Return code: 0 16:59:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e7e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e875618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb39a4bed20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e744d30>, '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 0x10e4a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e73cb20>, '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.zfxRS3QCs3/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.ZJkru6Qri8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 16:59:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:59:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:59:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zfxRS3QCs3/Render', 16:59:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:59:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:59:36 INFO - 'HOME': '/Users/cltbld', 16:59:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:59:36 INFO - 'LOGNAME': 'cltbld', 16:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:36 INFO - 'MOZ_NO_REMOTE': '1', 16:59:36 INFO - 'NO_EM_RESTART': '1', 16:59:36 INFO - 'PAGER': '/bin/cat', 16:59:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:36 INFO - 'PWD': '/builds/slave/test', 16:59:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:59:36 INFO - 'SHELL': '/bin/bash', 16:59:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJkru6Qri8/Listeners', 16:59:36 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 16:59:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:59:36 INFO - 'USER': 'cltbld', 16:59:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:59:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:36 INFO - 'XPC_FLAGS': '0x0', 16:59:36 INFO - 'XPC_SERVICE_NAME': '0', 16:59:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:59:37 INFO - Cleaning up... 16:59:37 INFO - Return code: 0 16:59:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:59: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')]} 16:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59: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')]} 16:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59: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 0x10e7e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e875618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb39a4bed20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e744d30>, '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 0x10e4a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e73cb20>, '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.zfxRS3QCs3/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.ZJkru6Qri8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 16:59: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 16:59: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 16:59:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zfxRS3QCs3/Render', 16:59:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:59:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:59:37 INFO - 'HOME': '/Users/cltbld', 16:59:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:59:37 INFO - 'LOGNAME': 'cltbld', 16:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:37 INFO - 'MOZ_NO_REMOTE': '1', 16:59:37 INFO - 'NO_EM_RESTART': '1', 16:59:37 INFO - 'PAGER': '/bin/cat', 16:59:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:37 INFO - 'PWD': '/builds/slave/test', 16:59:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:59:37 INFO - 'SHELL': '/bin/bash', 16:59:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJkru6Qri8/Listeners', 16:59:37 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 16:59:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:59:37 INFO - 'USER': 'cltbld', 16:59:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:59:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:37 INFO - 'XPC_FLAGS': '0x0', 16:59:37 INFO - 'XPC_SERVICE_NAME': '0', 16:59:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:37 INFO - Downloading/unpacking blobuploader==1.2.4 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59:39 INFO - Downloading blobuploader-1.2.4.tar.gz 16:59:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:59:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:59:39 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 16:59:39 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 16:59:39 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 16:59:39 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 16:59:39 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 16:59:39 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 16:59:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:59:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59:40 INFO - Downloading docopt-0.6.1.tar.gz 16:59:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:59:41 INFO - Installing collected packages: blobuploader, requests, docopt 16:59:41 INFO - Running setup.py install for blobuploader 16:59:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:59:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:59:41 INFO - Running setup.py install for requests 16:59:41 INFO - Running setup.py install for docopt 16:59:41 INFO - Successfully installed blobuploader requests docopt 16:59:41 INFO - Cleaning up... 16:59:41 INFO - Return code: 0 16:59:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:41 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 0x10e7e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e875618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb39a4bed20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e744d30>, '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 0x10e4a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e73cb20>, '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.zfxRS3QCs3/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.ZJkru6Qri8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 16:59:41 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 16:59:41 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 16:59:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zfxRS3QCs3/Render', 16:59:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:59:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:59:41 INFO - 'HOME': '/Users/cltbld', 16:59:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:59:41 INFO - 'LOGNAME': 'cltbld', 16:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:41 INFO - 'MOZ_NO_REMOTE': '1', 16:59:41 INFO - 'NO_EM_RESTART': '1', 16:59:41 INFO - 'PAGER': '/bin/cat', 16:59:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:41 INFO - 'PWD': '/builds/slave/test', 16:59:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:59:41 INFO - 'SHELL': '/bin/bash', 16:59:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJkru6Qri8/Listeners', 16:59:41 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 16:59:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:59:41 INFO - 'USER': 'cltbld', 16:59:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:59:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:41 INFO - 'XPC_FLAGS': '0x0', 16:59:41 INFO - 'XPC_SERVICE_NAME': '0', 16:59:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:59:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:59:42 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-_ryOh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:59:42 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-vpp7T_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:59:42 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-16Dyfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:59:42 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-DZWmWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:59:42 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-xnCRwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:59:42 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-zGmJ5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:59:42 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-_kClrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:59:42 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-A_IRAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:59:42 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-Wna5pG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:59:43 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-OZMcXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:59:43 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-FjfOgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:59:43 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-kWQJWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:59:43 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-2w4Q3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:59:43 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-7klEnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:59:43 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-bD0nCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:59:43 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-7zkvu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:59:43 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-CjPeHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:59:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:59:43 INFO - Running setup.py install for manifestparser 16:59:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:59:44 INFO - Running setup.py install for mozcrash 16:59:44 INFO - Running setup.py install for mozdebug 16:59:44 INFO - Running setup.py install for mozdevice 16:59:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:59:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:59:44 INFO - Running setup.py install for mozfile 16:59:44 INFO - Running setup.py install for mozhttpd 16:59:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:59:44 INFO - Running setup.py install for mozinfo 16:59:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:59:44 INFO - Running setup.py install for mozInstall 16:59:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:59:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:59:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:59:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:59:45 INFO - Running setup.py install for mozleak 16:59:45 INFO - Running setup.py install for mozlog 16:59:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:59:45 INFO - Running setup.py install for moznetwork 16:59:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:59:45 INFO - Running setup.py install for mozprocess 16:59:45 INFO - Running setup.py install for mozprofile 16:59:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:59:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:59:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:59:45 INFO - Running setup.py install for mozrunner 16:59:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:59:46 INFO - Running setup.py install for mozscreenshot 16:59:46 INFO - Running setup.py install for moztest 16:59:46 INFO - Running setup.py install for mozversion 16:59:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:59:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:59:46 INFO - Cleaning up... 16:59:46 INFO - Return code: 0 16:59:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:59: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')]} 16:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59: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')]} 16:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59: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 0x10e7e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e875618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb39a4bed20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e744d30>, '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 0x10e4a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e73cb20>, '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.zfxRS3QCs3/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.ZJkru6Qri8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 16:59: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 16:59: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 16:59:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zfxRS3QCs3/Render', 16:59:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:59:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:59:46 INFO - 'HOME': '/Users/cltbld', 16:59:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:59:46 INFO - 'LOGNAME': 'cltbld', 16:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:46 INFO - 'MOZ_NO_REMOTE': '1', 16:59:46 INFO - 'NO_EM_RESTART': '1', 16:59:46 INFO - 'PAGER': '/bin/cat', 16:59:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:46 INFO - 'PWD': '/builds/slave/test', 16:59:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:59:46 INFO - 'SHELL': '/bin/bash', 16:59:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJkru6Qri8/Listeners', 16:59:46 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 16:59:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:59:46 INFO - 'USER': 'cltbld', 16:59:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:59:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:46 INFO - 'XPC_FLAGS': '0x0', 16:59:46 INFO - 'XPC_SERVICE_NAME': '0', 16:59:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:59:46 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-6Wni5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:59:46 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)) 16:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:59:46 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-SBbQA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:59:46 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)) 16:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:59:46 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-LH7Jsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:59: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)) 16:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:59:47 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-22FpRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:59: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)) 16:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:59:47 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-Gwu5Ed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:59: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)) 16:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:59:47 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-uMv5CG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:59: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)) 16:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:59:47 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-OiOTxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:59: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)) 16:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:59:47 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-cAy88B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:59: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)) 16:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:59:47 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-KXeOf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:59:47 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)) 16:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:59:47 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-d_tQ66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:59:47 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)) 16:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:59:47 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-m3jAR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:59:47 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)) 16:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:59:47 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-puRxuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:59: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)) 16:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:59:48 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-6r8fbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:59: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)) 16:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:59:48 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-MyZRgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:59: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)) 16:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:59:48 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-ZoOHWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:59: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)) 16:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:59:48 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-eCJf54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:59: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)) 16:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:59:48 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-DhYl4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:59: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)) 16:59: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)) 16:59: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)) 16:59: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)) 16:59: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)) 16:59: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)) 16:59:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59:51 INFO - Downloading blessings-1.6.tar.gz 16:59:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:59:51 INFO - Installing collected packages: blessings 16:59:51 INFO - Running setup.py install for blessings 16:59:51 INFO - Successfully installed blessings 16:59:51 INFO - Cleaning up... 16:59:51 INFO - Return code: 0 16:59:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:59:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:59:51 INFO - Reading from file tmpfile_stdout 16:59:51 INFO - Current package versions: 16:59:51 INFO - blessings == 1.6 16:59:51 INFO - blobuploader == 1.2.4 16:59:51 INFO - docopt == 0.6.1 16:59:51 INFO - functools32 == 3.2.3-2 16:59:51 INFO - jsonschema == 2.5.1 16:59:51 INFO - manifestparser == 1.1 16:59:51 INFO - mozInstall == 1.12 16:59:51 INFO - mozcrash == 0.17 16:59:51 INFO - mozdebug == 0.1 16:59:51 INFO - mozdevice == 0.48 16:59:51 INFO - mozfile == 1.2 16:59:51 INFO - mozhttpd == 0.7 16:59:51 INFO - mozinfo == 0.9 16:59:51 INFO - mozleak == 0.1 16:59:51 INFO - mozlog == 3.3 16:59:51 INFO - moznetwork == 0.27 16:59:51 INFO - mozprocess == 0.23 16:59:51 INFO - mozprofile == 0.28 16:59:51 INFO - mozrunner == 6.12 16:59:51 INFO - mozscreenshot == 0.1 16:59:51 INFO - mozsystemmonitor == 0.3 16:59:51 INFO - moztest == 0.7 16:59:51 INFO - mozversion == 1.4 16:59:51 INFO - psutil == 3.1.1 16:59:51 INFO - requests == 1.2.3 16:59:51 INFO - wsgiref == 0.1.2 16:59:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:59:51 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')]} 16:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:51 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')]} 16:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:51 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 0x10e7e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e875618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb39a4bed20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e744d30>, '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 0x10e4a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e73cb20>, '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.zfxRS3QCs3/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.ZJkru6Qri8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 16:59:51 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 16:59:51 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 16:59:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zfxRS3QCs3/Render', 16:59:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:59:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:59:51 INFO - 'HOME': '/Users/cltbld', 16:59:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:59:51 INFO - 'LOGNAME': 'cltbld', 16:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:51 INFO - 'MOZ_NO_REMOTE': '1', 16:59:51 INFO - 'NO_EM_RESTART': '1', 16:59:51 INFO - 'PAGER': '/bin/cat', 16:59:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:51 INFO - 'PWD': '/builds/slave/test', 16:59:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:59:51 INFO - 'SHELL': '/bin/bash', 16:59:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJkru6Qri8/Listeners', 16:59:51 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 16:59:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:59:51 INFO - 'USER': 'cltbld', 16:59:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:59:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:51 INFO - 'XPC_FLAGS': '0x0', 16:59:51 INFO - 'XPC_SERVICE_NAME': '0', 16:59:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59: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)) 16:59: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)) 16:59: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)) 16:59: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)) 16:59: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)) 16:59: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)) 16:59: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)) 16:59: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)) 16:59: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)) 16:59: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)) 16:59: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)) 16:59:52 INFO - Cleaning up... 16:59:52 INFO - Return code: 0 16:59:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:59: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')]} 16:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59: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')]} 16:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59: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 0x10e7e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e875618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb39a4bed20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e744d30>, '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 0x10e4a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e73cb20>, '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.zfxRS3QCs3/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.ZJkru6Qri8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 16:59: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 16:59: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 16:59:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zfxRS3QCs3/Render', 16:59:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:59:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:59:52 INFO - 'HOME': '/Users/cltbld', 16:59:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:59:52 INFO - 'LOGNAME': 'cltbld', 16:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:52 INFO - 'MOZ_NO_REMOTE': '1', 16:59:52 INFO - 'NO_EM_RESTART': '1', 16:59:52 INFO - 'PAGER': '/bin/cat', 16:59:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:52 INFO - 'PWD': '/builds/slave/test', 16:59:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:59:52 INFO - 'SHELL': '/bin/bash', 16:59:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJkru6Qri8/Listeners', 16:59:52 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 16:59:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:59:52 INFO - 'USER': 'cltbld', 16:59:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:59:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:52 INFO - 'XPC_FLAGS': '0x0', 16:59:52 INFO - 'XPC_SERVICE_NAME': '0', 16:59:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:59:52 INFO - Cleaning up... 16:59:52 INFO - Return code: 0 16:59:52 INFO - Running post-action listener: _resource_record_post_action 16:59:52 INFO - Running post-action listener: _start_resource_monitoring 16:59:52 INFO - Starting resource monitoring. 16:59:52 INFO - [mozharness: 2016-08-05 23:59:52.313646Z] Finished create-virtualenv step (success) 16:59:52 INFO - [mozharness: 2016-08-05 23:59:52.314621Z] Running install step. 16:59:52 INFO - Running pre-action listener: _resource_record_pre_action 16:59:52 INFO - Running main action method: install 16:59:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:59:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:59:52 INFO - Reading from file tmpfile_stdout 16:59:52 INFO - Detecting whether we're running mozinstall >=1.0... 16:59:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:59:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:59:52 INFO - Reading from file tmpfile_stdout 16:59:52 INFO - Output received: 16:59:52 INFO - Usage: mozinstall [options] installer 16:59:52 INFO - Options: 16:59:52 INFO - -h, --help show this help message and exit 16:59:52 INFO - -d DEST, --destination=DEST 16:59:52 INFO - Directory to install application into. [default: 16:59:52 INFO - "/builds/slave/test"] 16:59:52 INFO - --app=APP Application being installed. [default: firefox] 16:59:52 INFO - mkdir: /builds/slave/test/build/application 16:59: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'] 16:59: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 17:00:26 INFO - Reading from file tmpfile_stdout 17:00:26 INFO - Output received: 17:00:26 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:00:26 INFO - Running post-action listener: _resource_record_post_action 17:00:26 INFO - [mozharness: 2016-08-06 00:00:26.786036Z] Finished install step (success) 17:00:26 INFO - [mozharness: 2016-08-06 00:00:26.786164Z] Running run-tests step. 17:00:26 INFO - Running pre-action listener: _resource_record_pre_action 17:00:26 INFO - Running main action method: run_tests 17:00:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:00:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:00:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:00:26 INFO - 2016-08-05 17:00:26.800 screenresolution[1635:7531] starting screenresolution argv=screenresolution get 17:00:26 INFO - 2016-08-05 17:00:26.803 screenresolution[1635:7531] Display 0: 1600x1200x32@60 17:00:26 INFO - 2016-08-05 17:00:26.808 screenresolution[1636:7533] starting screenresolution argv=screenresolution list 17:00:26 INFO - Available Modes on Display 0 17:00:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:00:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:00:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:00:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:00:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:00:27 INFO - Intel Iris: 17:00:27 INFO - Chipset Model: Intel Iris 17:00:27 INFO - Type: GPU 17:00:27 INFO - Bus: Built-In 17:00:27 INFO - VRAM (Dynamic, Max): 1536 MB 17:00:27 INFO - Vendor: Intel (0x8086) 17:00:27 INFO - Device ID: 0x0a2e 17:00:27 INFO - Revision ID: 0x0009 17:00:27 INFO - Displays: 17:00:27 INFO - Display: 17:00:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:00:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:00:27 INFO - Display Serial Number: 1600x1200 60 17:00:27 INFO - Main Display: Yes 17:00:27 INFO - Mirror: Off 17:00:27 INFO - Online: Yes 17:00:27 INFO - Rotation: Supported 17:00:27 INFO - Return code: 0 17:00:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:00:27 INFO - Python 2.7.3 17:00:27 INFO - Return code: 0 17:00:27 INFO - grabbing minidump binary from tooltool 17:00: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')]} 17:00: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 0x10e744d30>, '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 0x10e4a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e73cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:00: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 17:00: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 17:00: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 17:00:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:00:27 INFO - Return code: 0 17:00:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:00:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:00:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:00:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:00:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:00:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ELS8nQwmR4CMtnuuGrx9ag/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0261', '--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 17:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ELS8nQwmR4CMtnuuGrx9ag/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0261 --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 17:00:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zfxRS3QCs3/Render', 17:00:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:00:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:00:27 INFO - 'HOME': '/Users/cltbld', 17:00:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:00:27 INFO - 'LOGNAME': 'cltbld', 17:00:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:00:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:27 INFO - 'MOZ_NO_REMOTE': '1', 17:00:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:00:27 INFO - 'NO_EM_RESTART': '1', 17:00:27 INFO - 'PAGER': '/bin/cat', 17:00:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:27 INFO - 'PWD': '/builds/slave/test', 17:00:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:00:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:00:27 INFO - 'SHELL': '/bin/bash', 17:00:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJkru6Qri8/Listeners', 17:00:27 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 17:00:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:00:27 INFO - 'USER': 'cltbld', 17:00:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:00:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:27 INFO - 'XPC_FLAGS': '0x0', 17:00:27 INFO - 'XPC_SERVICE_NAME': '0', 17:00:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:00:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ELS8nQwmR4CMtnuuGrx9ag/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0261', '--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 17:00:27 INFO - mozversion application_buildid: 20160805144421 17:00:27 INFO - mozversion application_changeset: 99ed3a3aa3e82bd75ff3077ff0d1b97c637fa6a1 17:00:27 INFO - mozversion application_display_name: Nightly 17:00:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:00:27 INFO - mozversion application_name: Firefox 17:00:27 INFO - mozversion application_remotingname: firefox 17:00:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 17:00:27 INFO - mozversion application_vendor: Mozilla 17:00:27 INFO - mozversion application_version: 51.0a1 17:00:27 INFO - mozversion platform_buildid: 20160805144421 17:00:27 INFO - mozversion platform_changeset: 99ed3a3aa3e82bd75ff3077ff0d1b97c637fa6a1 17:00:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 17:00:27 INFO - mozversion platform_version: 51.0a1 17:00:27 INFO - using testdate: 1470441627 17:00:27 INFO - actual date: 1470441627 17:00:27 INFO - starting webserver on 'localhost:49266' 17:00:27 INFO - SUITE-START | Running 2 tests 17:00:27 INFO - TEST-START | dromaeo_css 17:00:27 INFO - operating with platform_type : mac_ 17:00:27 INFO - Initialising browser for dromaeo_css test... 17:00:27 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/tmpHBPBBo/profile http://localhost:49266/getInfo.html) 17:00:30 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 17:00:30 INFO - PROCESS | 1646 | colorDepth:24 17:00:30 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 17:00:30 INFO - PROCESS | 1646 | __metrics 17:00:30 ERROR - PROCESS | 1646 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 17:00:31 INFO - TEST-INFO | 1646: exit 0 17:00:31 INFO - Browser initialized. 17:00:31 INFO - Running cycle 1/1 for dromaeo_css test... 17:00:31 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/tmpHBPBBo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:00:43 INFO - PROCESS | 1649 | RSS: Main: 254672896 17:00:43 INFO - PROCESS | 1649 | 17:01:32 INFO - PROCESS | 1649 | 1470441692809 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] 17:03:45 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 17:03:47 INFO - PROCESS | 1649 | RSS: Main: 267554816 17:03:47 INFO - PROCESS | 1649 | 17:06:49 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 17:06:49 INFO - PROCESS | 1649 | RSS: Main: 279998464 17:06:49 INFO - PROCESS | 1649 | 17:09:51 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 17:09:52 INFO - PROCESS | 1649 | RSS: Main: 287539200 17:09:52 INFO - PROCESS | 1649 | 17:12:54 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 17:12:54 INFO - PROCESS | 1649 | RSS: Main: 286834688 17:12:54 INFO - PROCESS | 1649 | 17:15:57 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 17:15:58 INFO - PROCESS | 1649 | RSS: Main: 291074048 17:15:58 INFO - PROCESS | 1649 | 17:19:00 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 17:19:00 INFO - PROCESS | 1649 | RSS: Main: 292024320 17:19:00 INFO - PROCESS | 1649 | 17:19:00 INFO - PROCESS | 1649 | __start_tp_report 17:19:00 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 17:19:00 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 17:19:00 INFO - PROCESS | 1649 | |i|pagename|runs| 17:19:00 INFO - PROCESS | 1649 | |0;dojo.html;3413.180836599217;3423.3837909176345;3448.603410607779;3457.6196618371973;3467.982660086699;5682.090865461527;5752.884942301157;5782.826515204545;5851.853703657411;5863.355030946593;5708.286464191966;5712.71436428179;5727.341355744091;5770.884582308351;5804.941950580493;5111.591072714193;5251.55361794248;5259.710715910624;5313.256144139824;5355.0896347621;5338.985592737367;5353.544948679367;5388.757505912244;5414.35027796665;5420.7018613976215;4962.15643340633;5146.897062058738;5186.7147306898105;5188.014277287303;5218.269442278084;5276.630635855492;5295.708736019517;5299.178627312773;5310.548603368679;5314.99015187117;5181.922271165936;5267.710275934822;5274.340707411574;5282.894342113136;5321.388040375329;4866.78099485524;5173.4826517347965;5652.8869422611315;5690.5447564194765;5703.372629010805;5749.108888122306;6015.299372307956;6244.781432649881;6285.717142728542;6290.087937249119;6141.449068002053;6187.938120618781;6188.504919606421;6190.288116866528;6212.875742485125;5747.252857128588;5818.679972601548;5836.7957121501395;5861.824145275648;5951.434613711691;6263.655498947602;6276.937230627726;6281.434670879643;6306.779262725874;6325.620462772248;6187.133801267826;6197.411245931629;6208.379162083756;6217.036359364306;6226.315105338409;5979.252593425822;6109.526129009804;6175.413335733098;6180.66006369645;6234.781782637586;5623.746931388097;6238.688065596702;6247.187865577536;6255.311915689271;6265.8120256392385;4816.927746083811;5737.340205876378;6270.811875643738;6286.779962701284;6325.3674632537295;4386.320120381346;4562.771861406983;4732.124556956974;4882;5002.974985125051;4474.485434175112;4484.932726009112;4496.685232033727;4496.7077139985795;4530.048689775184;5743.741531631003;5808.6224395414165;5847.707614619252;5878.3239927408895;5881.617694849821;5744.339400968942;5839.941600583939;6200.56596038273;6236.095766113888;6237.500999919996;5766.711664416763;5771.509421699118;5781.53747700183;5790.36306006339;5820.767169313265;5424.267723857308;5482.643628164236;5494.752736126884;5495.835124946258;5502.972485137549;6167.290761562388;6197;6245.250569931637;6258.561900666909;6323.462505687068;6259.374062593704;6267.122602835698;6275.34108918557;6287.18266625354;6287.559870808999;6297.086922396135;6333.809985700436;6341.682915854281;6344.143540621957;6348.396902294275;6095.226761080104;6166.352532983972;6167;6171.6297022178815;6272.560920735505;5238.659487133325;6231.906521402273;6265.060240963892;6273.62358258506;6290.836195303884;5078.669886457368;6072.423119803611;6237.594556353823;6244.6261822399;6244.843878903063;6077.787277445268;6097.645669838225;6107.175531303217;6142.744345496893;6162.784302549389;5302.992431438014;5626.43735626434;6061.969690151521;6105.297890742621;6107.014746911084;5681.630694004876;5786;6211.2857021443115;6219.657918814328;6232.875342493216;5841.912371314519;5919.260092488439;5950.285965684146;5979.790707325223;6097.329293777592 17:19:00 INFO - PROCESS | 1649 | |1;ext.html;519.4441947116587;533.6237952243667;539.7921800106958;555.231005057995;559.9524040456561;32745.67254327456;40946.38580421292;41060.17879642405;41111.58888411115;41197.764067077995;42250.57749422505;42716.57283427165;42734.78632606832;42760.572394276045;42858.92852678685;9572.521373931293;9764.218862490983;9799.853002204973;9799.95100024499;9815.558299876522;9630.3258771886;9693.70918872435;9718.61125554977;9749.463779492125;9770.511474426286;9740.659076932308;9756.170725488342;9764.658236961708;9790.853137202948;9807.754806129833;9687.903120968806;9738.880028796708;9746.025397460196;9765.023497650249;9774.951125244399;9613.423194608346;9707.854382184272;9710.028997100233;9719.61121555144;9723.951380243125;39932.80201593957;40213;40274.798626006974;40369.39445908314;40382.79808600938;3303.124671961932;3660.7254455915645;3998.280309544281;4086.080631857838;4122.175564887035;25627.48745025089;31579.842100789578;32137.839310803298;32603;32608.347833043208;3218.6298575663864;3351.0617027232415;3372.15696075981;3382.780119292263;3383.661633836621;349329;353929;390665.99999999715;390674.046629765;392201;50141.74929125404;60051;60276.095858562156;60319.69840150771;60362.39637603568;63620;63820.68089659522;64146.35853641404;64212;64483;15810.288537015862;15915;16010.839891601168;16014.19929003545;16037.636800871824;12260.693482663004;12330.260184388966;12332.383380830923;12336.383180840921;12338.691532711575;13223.3388330585;13832.654183645289;15285.617859553378;16874.325026998784;16893.746593801105;6609.306022867626;6668.299828518033;6841.24746277919;6891.655417229119;6903.6548172591165;749.741339237962;796.243568609823;857.0914830279924;986.5757724178528;1059.7880423915249;31657.208569785478;32398.83800580982;32582.185445364055;33318.16704582405;33358.16604584905;966.5602151021268;1071.919606029551;1130.429133287701;1153.9134564907665;1154.7690461907653;15674.529764107096;15855;15914.76127858083;16564.75152872708;17085.572860678334;636183.8190809109;639198;642128;642274;644716;60269;60287.39712602906;60441.093383599284;60679.69660151671;60806.39193608007;1344.5495758920677;1372.8970327225497;1388.5209602687057;1390.1520072755611;1392.2064423278634;24621.63067554024;29908.551371729005;30482.695173047985;31048.68951310458;31296.06111816649;51454;52233.7388313056;52383.95232095413;52753;52773.7361313191;601374;601993;604322;604857;605940;25263.242102736946;25354.492910142064;25535;25599;25670.61494077628;47793.76103119462;48223.5177648219;49857.50142498674;50991.74504127455;52099;33394.83118090855;33953.23990634018;39935;40869.1826163481;41196.1760764789;32111.839440802647;40055.1988960225;40312.59687403088;40528;41060.384094239205;39166.412503811895;39543.80228098841;40164.594239202655;40205.597944020185;40936.79531602323;29879.850600746857;30705.53941690921;34095.65904341024;34761.82619086889;34887.47668785021;22527.5494490106;24406.51186976286;24896.62655060212;24956;27017.45965080727 17:19:00 INFO - PROCESS | 1649 | |2;jquery.html;314.94173577888085;365.2074997255954;377.53940192964586;383.6393789837554;400.8396641343462;16976;20017.699734503993;20823.895880520613;21389.786102138994;21704;20474.385768426935;20542.870142142176;20829;20918.895405522988;21051.2632057878;5919.112133180036;5999.760009599632;6023.518118550527;6032;6107.603005804631;4913.680610760289;5991.610545314563;6043.153958445799;6048.243969503812;6055.182550355689;5925.200097986782;5956.374580669032;6024.307204671475;6031.336552979169;6038.788642397517;5846.21076154718;5906;5919.467247947706;6021.518278537728;6051.273847138327;4358.433403657536;4789.976050119762;5046.21783623539;5162.199859021857;5163.173892177271;25489.980400783945;25507.23478295654;25817.7091145442;26101.216963491126;26245;2087.8642888212216;2185.4099393163915;2192.473806286496;2216.822654187661;2249.5051088760447;15073.321700523393;15191.62020949474;15668.216589170495;15848;16057.956232844828;1860.897650629215;1871.4828555592842;1896.2983696032557;1908.4656296236938;1975.911084001209;110649;111042.88957110487;113922;114180.42909785481;114310;10491.580336786596;10826.834633073417;10882.455877206108;10987.39569323695;11120.443977801078;13617.591472255848;13618;13631.931840340932;13632.93183534076;13644.249566273951;6827.5562088465085;8066;8342.833143337099;8421.157884211652;8470.491770493667;8173.79565510867;8242.29940455056;8277.62750676221;8403.747887563382;8438.957805210935;6619.113552637476;6698.363655452724;6699.76550820719;6706.899396509057;6709.597424154566;1841.4475657302755;1873.3536929759211;1881.1158755384947;1881.6518943995404;1892.1579896946002;734.8052766017009;773.8916551682769;958.1328897347911;992.4491906991544;1064.4884264344494;19881.701774473393;21362.465938351666;21369;21574.244901428374;21576.244831431137;846.289117141604;946.4652471353663;987.6098940918297;995.2535598301274;1023.2581378500528;9311.627534898527;9766.169875560516;10770.192235582363;11504.76990460186;11512.539498420138;452911;594257;595565.0221748863;603271;608851;92480.07519924715;100994;110259.44870275597;111684.44157779159;114080;946.3281070439928;977.8435450327913;996.6113215845826;997.6607953295769;1030.4487099401633;18548.629027419105;19333.936633485293;19440.61118777645;19472.61054778925;19684.015799209697;42272;45544.54455455536;51907.96969636354;52615.68460788358;53199.73400132974;71766.64116679592;72715.63642181756;73452;73633.52732945418;74105;7865.095514015961;7947.046354437504;7971.920280797118;8003.799905002189;8081.232282933112;12578.811317830057;12697.4286157125;12961.15752476086;13065.673358166121;13091.738165236833;10927.672169834917;10952.288101273392;11214.990650841464;11315.547378104784;11340.319580824847;10808.513616887416;11072.003519683267;11166.44167791591;11225.775484490428;11582.826257605973;9113.94176232171;11476;11550.480228389575;11622.128340374336;11679.299242045505;7722.53664780115;8037.638306276114;8037.678492860454;8097.959510202411;8133.0646975598565;10914.126869850234;11030.44847757625;11142.498587563417;11232.3260604364;11393.886061139614 17:19:00 INFO - PROCESS | 1649 | |3;mootools.html;1505.4580351073614;1547.6827250413667;1718.9484315470531;1814;1832.7067669172934;7781.416393770462;8252.752417427471;8328.375371847105;8742.956285218574;8780.780480487983;8509.574521273928;8579.742607721779;8590.914090859089;8603.139686031394;8611.612477438515;1729.6627157704252;1920.9423717288503;2299.781116008514;2330.207729372013;2334.2880421471446;2307.1694190091553;2324.070371851256;2353.670486131943;2362.397588614901;2368.3842201027683;2337.906483740648;2346.8290047045616;2348.5772560939026;2367.0176876596192;2367.0886708617136;2321.210788331958;2348.2250857217077;2348.612478940973;2355.5877721398774;2359.834811563191;2330.382448651109;2332.7900488955906;2336.6495025746103;2342.1919437793936;2344.8475849069755;8665.306775458012;8698.739037828875;8699.130086991314;8717.738467845975;8734.388592798507;5100.2349647553165;5132.897342053138;5159.2003239497935;5280.551153151987;5280.735963201824;3306.1404034950847;3331.267121233325;3334.6331903490595;3353.3796247694013;3523.841427135759;1083.106437189322;1085.2240647936762;1087.7389426537575;1098.5386137822134;1118.3066498770734;11281.435928203557;11310.943445282803;11453.198276120675;11454.599089031844;11465.484053217542;4502.671711845013;4647.488776234612;4738.3840100787365;4738.696858363977;4739.976300118477;9683.176929961031;9738.220942324597;9741.172000380047;9764.609415623438;9775.804483910282;4507.706999045052;5193.143131383279;5245.396779370345;5249.501297376743;5281.815136470282;3550.2721942001826;4637.7449240291435;4741.905161896742;4812.230043193073;4814;3165.6042994625673;3279.4588892832417;3869.96130038696;3872.4772155759174;3981.7013723970817;1270.7585558743808;1273.6815796050987;1274.560276704554;1276.4064709909937;1276.6233960981533;831.3349320543541;899.9910000900038;909.5134103254727;923.5982347678781;938.029139840262;5715.914261286084;5741.311042674905;5921.881562368729;5976.910346344808;6031.306399763996;387.79640688638125;455.07165382619746;461.838356575196;931.5761328595473;1034.6068493972393;3866.74866133706;3972.801359931992;3988.9002774930277;4022.879313620596;4033.824991134221;10248.846267305997;10471.581136754445;10501.737456563647;10597.258191926645;10602.681919542427;10410;10513.737156571147;10559.736006599896;10618.522166502526;10628.734281643021;8106.229908158715;8121.35029197651;8124.22819832115;8158.3065439438315;8212.096669366365;5767.596268261182;5824.592278540462;5874.911876321773;5875.529957603467;5889.939810833919;9581.089796469325;9645.469499177612;9805.313628045968;9863.753406164904;9890.851637225303;9860.359076659994;9921.751956201153;10018.849717254101;10095.394276343442;10099.545520451451;5711.828645140652;6072.787452439144;6646.966765166143;6799.558028728117;6914.343137401939;8153.02163740355;8158.796030099295;8179.877301840358;8234.970628671415;8257.587120643824;7349.669264882986;7465.141508726349;7511.924880751122;7512.887306690294;7567.167611562613;7101.218865924848;7283.380912622486;7307.525010874276;7311.780646580611;7364.410847132323;6467.288598254282;6912.27421120775;7007.194172670004;7065;7088.751893683696;4193.370994350872;4784.6889952153;4821.373221481185;4867.829625963074;4933.77797999098;4905.950940490549;4999.350084488993;5054.702319338753;5063.468335824686;5121.487851214849 17:19:00 INFO - PROCESS | 1649 | |4;prototype.html;290.2468095292716;299.15339588963235;307.1645125259297;307.43278650889107;309.17912941141276;5367.275417818593;5466.289382380295;5609.635373700712;5644.830655080344;5655.246873469222;5471.5896307776875;5524;5562.386907796744;5575.581831362644;5591.049521581331;3501.73736969727;3680.969328588;3863.517060367454;4247.957520424795;4257.340112282601;3634.876283122164;4144.8963775905695;4239.0674051708575;4257.7445353278745;4264.125854199897;4187.476565429321;4192.601702838226;4196;4216.4188429339;4220.3036498977635;3461.619221885603;3669.284489524544;4058.7823652904012;4061.801768478306;4199.706020578561;3119.0330997390656;3486.3027394520946;3689.262147570497;3692.593814680383;3707.8887633370773;4463.107378524276;4666.789994450258;5229.08491014071;5337.199420087018;5358.758855851496;3880.9805950970062;3990.68074554035;4337.306031035051;4563.315502674593;4849.442314133849;4886.389201349832;5558.44415558445;5841.094630332305;5847.356790753056;5959.970200149015;3545.1461573433376;3808.933498620363;3895.9480940146;3991.1618560102124;4075.8369665213354;5245.711485868275;6143.354947730513;6194.876102477971;6197.504199664016;6278.843028924268;4101.364288535282;4105.322621767435;4130.463039804806;4133.855315063958;4147.6267135957905;3556.78659280444;3900.687944964396;3974.6025397460603;4053.858114966021;4120.423140760296;4360.454943132108;4479.440069991251;4777.713337199779;4821.566059054632;4836.95163048365;5143.382794064736;5903.409659034062;5919.668074683162;5948.702564871739;5994.340622531518;1198.8861058199457;1267.4866678995022;1331.3210262766058;1371.6982263901925;1416.6458385403648;824.3652387661467;872.7163671806688;922.9907700923039;960.279790157382;960.5917485068818;4147.771872546979;5229.581633469314;5243.292155559027;5261.027114831938;5281.223924893643;5330.827218012031;5761.596688231867;5858.242527241896;5873.882522349614;5879.941200588025;4485.730856148642;4948.762809297676;4972.776225069881;5189.6886186828915;5287.894242115213;2375.7505461926594;2516.59734442492;2647.007372235412;2657.3755167535614;2663.733626637321;4566.520515345907;4655.627549796008;5184.585233181337;5211.280277508413;5224.4139151120435;4308.4399028126145;4617.884552886205;4791.592714619227;4890.1881418184685;5096.668716533413;4672.925227197696;4883.536064073907;5080.263361812516;5149.712571857036;5205.453427390145;4457.75482348461;4571.3371561122785;4595.816167353402;4721.457032441176;5041.924371134362;3864.9227015460096;4046.020614440185;4331.891702707331;4437.800298986618;5001.974990125026;4224.957750422456;4439.48945871216;4626.976865115653;4890.334767551622;4992.700437973734;3352.9329413411106;3435.2442462658173;3526.7531272810656;3526.8236588171003;3539.9469007964385;4257.8503803972135;4518.051209245964;4775.379200703886;4797.376341075777;4810.993129294191;4838.830640927551;5313.628046036741;5434.967356202467;5785.132230165509;5866.560007999503;4760.047990401864;5339.517124537109;5803.216565763737;5817.88743022481;5822.563307752021;5440.591955603425;5483.204935284281;5679.5172410345585;5710.971445142748;5720.199172115824;5114.872128196825;5580.051391263414;5612.382637909908;5874.353821079763;5880.735366908585;4723.622110231105;4985.775640096132;5263.868403289795;5736.8278951629845;5768.971155144198 17:19:00 INFO - PROCESS | 1649 | |5;yui.html;642.4635429416434;701.2006312803405;728.3481284250596;759.1573353577528;770.6300975531741;15169.696606067871;15370.155581330242;15583.536555019167;16056.51830445087;16083.03501789892;13927.58217253484;14247.572572822806;14256.429742810302;14468.855311446883;14537.78193327101;855.6320782063725;885.420049867338;886.3263919421254;887.0154128916897;887.968921087762;695.1970474102394;776.3595034096865;879.7932485865816;894.0567701075363;896.26058501736;913.5067063785548;920.6041402197086;928.1368327455464;928.8235235305305;931.7950050988771;879.6613303877989;921.8985911549725;924.2698268367981;924.8335299646095;925.5973651461602;658.427168363522;678.199724325296;681.7307163670372;686.5468790598231;688.5868478912662;14746.852531474655;14859.851401485956;14944.476943307041;15080.698386032218;15123.319450624638;13955.441782328695;14549.854501455062;14707.55877323682;14739.83093634863;14801.333939972727;12104.394780260951;12127.09046821492;12132.332721700302;12159.756804863853;12307.138500304982;3245.7078862902217;3338.833058347073;3841.154945911895;3920.901977450558;4073.0021144819707;99116;101113;119960;125236.37381813124;125661.37169314094;9380.765480863032;11490.368029758276;11536.653900383002;11537.596184133516;11931.582394616147;22719.432014199778;22846.885765571067;23185.884070579537;23433.41416464568;23535.646965295535;8080.515169089756;8138.023437187457;8164.101948785629;8232.670693172326;8243.464174828618;4363.52001279859;4450.1989641864775;4454.131444368317;4464.352668862996;4493.168763778712;3568.803715795604;3646.635336466385;3675.650813172744;3688.188598508324;3694.039549717093;620.7672122953892;643.7746788623945;644.1143427786793;648.2642201101689;650.388634683396;495.7446914838861;600.9519238460913;664.7307840324676;687.5393486364148;693.9861202775916;7330.355626167821;7458.328750412489;9364.578593963288;9495.335326527214;9614.326997110275;555.824915151734;592.6503363015842;598.2163365990566;645.9471062168635;676.266251117543;4592.655550833634;4694.507076756891;4697.6241900647865;4722.268048452495;4729;96695;140748.2962585201;159927;160702;165361.3463865346;138833.3058334702;139709;145199;145495;146708.26645866915;77530;78341.60829195818;115039;120762.39618802026;121558;9043.457392556467;9107.907051153905;9115.36192466521;9234.538273086453;9273.25813934897;61756.45608859814;68401.65799170973;69205;70136.29863701502;70852;101451.98548014721;103976;105701.47149264204;106069.46965265124;106811.9318806802;12107.75784484323;12432.316222607482;12521.186122901981;12600.621981340575;12679;13222.603321900358;13333.066685331934;13428.530001449903;13528.72942541124;13721.108127971649;12056.819147712617;12218.26690398579;12592.685182870502;12865.742685146432;12920.030997675023;12115.394230288273;12689.048321375749;12841.165324253894;12924.418401172157;13072.215667060007;11952.402379881145;12091.334976576372;12318.630441086782;12617.053720971147;12730.108892377444;10292.742681433025;10551.577936882439;10776;10965.780684386107;10976.341419514854;7792.688292468238;9436.575354109218;9540.522973851419;10715.732106697084;10830.296030757976 17:19:00 INFO - PROCESS | 1649 | __end_tp_report 17:19:00 INFO - PROCESS | 1649 | __start_cc_report 17:19:00 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,416 17:19:00 INFO - PROCESS | 1649 | __end_cc_report 17:19:00 INFO - PROCESS | 1649 | __startTimestamp1470442740786__endTimestamp 17:19:00 INFO - PROCESS | 1649 | 17:19:00 INFO - PROCESS | 1649 | ------- Summary: start ------- 17:19:00 INFO - PROCESS | 1649 | Number of tests: 6 17:19:00 INFO - PROCESS | 1649 | 17:19:00 INFO - PROCESS | 1649 | [#0] dojo.html Cycles:165 Average:5723.91 Median:5851.85 stddev:635.60 (10.9%) stddev-sans-first:611.16 17:19:00 INFO - PROCESS | 1649 | Values: 3413.2 3423.4 3448.6 3457.6 3468.0 5682.1 5752.9 5782.8 5851.9 5863.4 5708.3 5712.7 5727.3 5770.9 5804.9 5111.6 5251.6 5259.7 5313.3 5355.1 5339.0 5353.5 5388.8 5414.4 5420.7 4962.2 5146.9 5186.7 5188.0 5218.3 5276.6 5295.7 5299.2 5310.5 5315.0 5181.9 5267.7 5274.3 5282.9 5321.4 4866.8 5173.5 5652.9 5690.5 5703.4 5749.1 6015.3 6244.8 6285.7 6290.1 6141.4 6187.9 6188.5 6190.3 6212.9 5747.3 5818.7 5836.8 5861.8 5951.4 6263.7 6276.9 6281.4 6306.8 6325.6 6187.1 6197.4 6208.4 6217.0 6226.3 5979.3 6109.5 6175.4 6180.7 6234.8 5623.7 6238.7 6247.2 6255.3 6265.8 4816.9 5737.3 6270.8 6286.8 6325.4 4386.3 4562.8 4732.1 4882.0 5003.0 4474.5 4484.9 4496.7 4496.7 4530.0 5743.7 5808.6 5847.7 5878.3 5881.6 5744.3 5839.9 6200.6 6236.1 6237.5 5766.7 5771.5 5781.5 5790.4 5820.8 5424.3 5482.6 5494.8 5495.8 5503.0 6167.3 6197.0 6245.3 6258.6 6323.5 6259.4 6267.1 6275.3 6287.2 6287.6 6297.1 6333.8 6341.7 6344.1 6348.4 6095.2 6166.4 6167.0 6171.6 6272.6 5238.7 6231.9 6265.1 6273.6 6290.8 5078.7 6072.4 6237.6 6244.6 6244.8 6077.8 6097.6 6107.2 6142.7 6162.8 5303.0 5626.4 6062.0 6105.3 6107.0 5681.6 5786.0 6211.3 6219.7 6232.9 5841.9 5919.3 5950.3 5979.8 6097.3 17:19:00 INFO - PROCESS | 1649 | 17:19:00 INFO - PROCESS | 1649 | [#1] ext.html Cycles:180 Average:67951.72 Median:22477.63 stddev:147883.16 (657.9%) stddev-sans-first:148211.35 17:19:00 INFO - PROCESS | 1649 | Values: 519.4 533.6 539.8 555.2 560.0 32745.7 40946.4 41060.2 41111.6 41197.8 42250.6 42716.6 42734.8 42760.6 42858.9 9572.5 9764.2 9799.9 9800.0 9815.6 9630.3 9693.7 9718.6 9749.5 9770.5 9740.7 9756.2 9764.7 9790.9 9807.8 9687.9 9738.9 9746.0 9765.0 9775.0 9613.4 9707.9 9710.0 9719.6 9724.0 39932.8 40213.0 40274.8 40369.4 40382.8 3303.1 3660.7 3998.3 4086.1 4122.2 25627.5 31579.8 32137.8 32603.0 32608.3 3218.6 3351.1 3372.2 3382.8 3383.7 349329.0 353929.0 390666.0 390674.0 392201.0 50141.7 60051.0 60276.1 60319.7 60362.4 63620.0 63820.7 64146.4 64212.0 64483.0 15810.3 15915.0 16010.8 16014.2 16037.6 12260.7 12330.3 12332.4 12336.4 12338.7 13223.3 13832.7 15285.6 16874.3 16893.7 6609.3 6668.3 6841.2 6891.7 6903.7 749.7 796.2 857.1 986.6 1059.8 31657.2 32398.8 32582.2 33318.2 33358.2 966.6 1071.9 1130.4 1153.9 1154.8 15674.5 15855.0 15914.8 16564.8 17085.6 636183.8 639198.0 642128.0 642274.0 644716.0 60269.0 60287.4 60441.1 60679.7 60806.4 1344.5 1372.9 1388.5 1390.2 1392.2 24621.6 29908.6 30482.7 31048.7 31296.1 51454.0 52233.7 52384.0 52753.0 52773.7 601374.0 601993.0 604322.0 604857.0 605940.0 25263.2 25354.5 25535.0 25599.0 25670.6 47793.8 48223.5 49857.5 50991.7 52099.0 33394.8 33953.2 39935.0 40869.2 41196.2 32111.8 40055.2 40312.6 40528.0 41060.4 39166.4 39543.8 40164.6 40205.6 40936.8 29879.9 30705.5 34095.7 34761.8 34887.5 22527.5 24406.5 24896.6 24956.0 27017.5 17:19:00 INFO - PROCESS | 1649 | 17:19:00 INFO - PROCESS | 1649 | [#2] jquery.html Cycles:180 Average:33446.75 Median:25662.47 stddev:95305.54 (371.4%) stddev-sans-first:95540.42 17:19:00 INFO - PROCESS | 1649 | Values: 314.9 365.2 377.5 383.6 400.8 16976.0 20017.7 20823.9 21389.8 21704.0 20474.4 20542.9 20829.0 20918.9 21051.3 5919.1 5999.8 6023.5 6032.0 6107.6 4913.7 5991.6 6043.2 6048.2 6055.2 5925.2 5956.4 6024.3 6031.3 6038.8 5846.2 5906.0 5919.5 6021.5 6051.3 4358.4 4790.0 5046.2 5162.2 5163.2 25490.0 25507.2 25817.7 26101.2 26245.0 2087.9 2185.4 2192.5 2216.8 2249.5 15073.3 15191.6 15668.2 15848.0 16058.0 1860.9 1871.5 1896.3 1908.5 1975.9 110649.0 111042.9 113922.0 114180.4 114310.0 10491.6 10826.8 10882.5 10987.4 11120.4 13617.6 13618.0 13631.9 13632.9 13644.2 6827.6 8066.0 8342.8 8421.2 8470.5 8173.8 8242.3 8277.6 8403.7 8439.0 6619.1 6698.4 6699.8 6706.9 6709.6 1841.4 1873.4 1881.1 1881.7 1892.2 734.8 773.9 958.1 992.4 1064.5 19881.7 21362.5 21369.0 21574.2 21576.2 846.3 946.5 987.6 995.3 1023.3 9311.6 9766.2 10770.2 11504.8 11512.5 452911.0 594257.0 595565.0 603271.0 608851.0 92480.1 100994.0 110259.4 111684.4 114080.0 946.3 977.8 996.6 997.7 1030.4 18548.6 19333.9 19440.6 19472.6 19684.0 42272.0 45544.5 51908.0 52615.7 53199.7 71766.6 72715.6 73452.0 73633.5 74105.0 7865.1 7947.0 7971.9 8003.8 8081.2 12578.8 12697.4 12961.2 13065.7 13091.7 10927.7 10952.3 11215.0 11315.5 11340.3 10808.5 11072.0 11166.4 11225.8 11582.8 9113.9 11476.0 11550.5 11622.1 11679.3 7722.5 8037.6 8037.7 8098.0 8133.1 10914.1 11030.4 11142.5 11232.3 11393.9 17:19:00 INFO - PROCESS | 1649 | 17:19:00 INFO - PROCESS | 1649 | [#3] mootools.html Cycles:180 Average:5584.71 Median:4844.60 stddev:3151.44 (65.1%) stddev-sans-first:3145.37 17:19:00 INFO - PROCESS | 1649 | Values: 1505.5 1547.7 1718.9 1814.0 1832.7 7781.4 8252.8 8328.4 8743.0 8780.8 8509.6 8579.7 8590.9 8603.1 8611.6 1729.7 1920.9 2299.8 2330.2 2334.3 2307.2 2324.1 2353.7 2362.4 2368.4 2337.9 2346.8 2348.6 2367.0 2367.1 2321.2 2348.2 2348.6 2355.6 2359.8 2330.4 2332.8 2336.6 2342.2 2344.8 8665.3 8698.7 8699.1 8717.7 8734.4 5100.2 5132.9 5159.2 5280.6 5280.7 3306.1 3331.3 3334.6 3353.4 3523.8 1083.1 1085.2 1087.7 1098.5 1118.3 11281.4 11310.9 11453.2 11454.6 11465.5 4502.7 4647.5 4738.4 4738.7 4740.0 9683.2 9738.2 9741.2 9764.6 9775.8 4507.7 5193.1 5245.4 5249.5 5281.8 3550.3 4637.7 4741.9 4812.2 4814.0 3165.6 3279.5 3870.0 3872.5 3981.7 1270.8 1273.7 1274.6 1276.4 1276.6 831.3 900.0 909.5 923.6 938.0 5715.9 5741.3 5921.9 5976.9 6031.3 387.8 455.1 461.8 931.6 1034.6 3866.7 3972.8 3988.9 4022.9 4033.8 10248.8 10471.6 10501.7 10597.3 10602.7 10410.0 10513.7 10559.7 10618.5 10628.7 8106.2 8121.4 8124.2 8158.3 8212.1 5767.6 5824.6 5874.9 5875.5 5889.9 9581.1 9645.5 9805.3 9863.8 9890.9 9860.4 9921.8 10018.8 10095.4 10099.5 5711.8 6072.8 6647.0 6799.6 6914.3 8153.0 8158.8 8179.9 8235.0 8257.6 7349.7 7465.1 7511.9 7512.9 7567.2 7101.2 7283.4 7307.5 7311.8 7364.4 6467.3 6912.3 7007.2 7065.0 7088.8 4193.4 4784.7 4821.4 4867.8 4933.8 4906.0 4999.4 5054.7 5063.5 5121.5 17:19:00 INFO - PROCESS | 1649 | 17:19:00 INFO - PROCESS | 1649 | [#4] prototype.html Cycles:180 Average:4412.30 Median:4776.55 stddev:1355.47 (28.4%) stddev-sans-first:1323.49 17:19:00 INFO - PROCESS | 1649 | Values: 290.2 299.2 307.2 307.4 309.2 5367.3 5466.3 5609.6 5644.8 5655.2 5471.6 5524.0 5562.4 5575.6 5591.0 3501.7 3681.0 3863.5 4248.0 4257.3 3634.9 4144.9 4239.1 4257.7 4264.1 4187.5 4192.6 4196.0 4216.4 4220.3 3461.6 3669.3 4058.8 4061.8 4199.7 3119.0 3486.3 3689.3 3692.6 3707.9 4463.1 4666.8 5229.1 5337.2 5358.8 3881.0 3990.7 4337.3 4563.3 4849.4 4886.4 5558.4 5841.1 5847.4 5960.0 3545.1 3808.9 3895.9 3991.2 4075.8 5245.7 6143.4 6194.9 6197.5 6278.8 4101.4 4105.3 4130.5 4133.9 4147.6 3556.8 3900.7 3974.6 4053.9 4120.4 4360.5 4479.4 4777.7 4821.6 4837.0 5143.4 5903.4 5919.7 5948.7 5994.3 1198.9 1267.5 1331.3 1371.7 1416.6 824.4 872.7 923.0 960.3 960.6 4147.8 5229.6 5243.3 5261.0 5281.2 5330.8 5761.6 5858.2 5873.9 5879.9 4485.7 4948.8 4972.8 5189.7 5287.9 2375.8 2516.6 2647.0 2657.4 2663.7 4566.5 4655.6 5184.6 5211.3 5224.4 4308.4 4617.9 4791.6 4890.2 5096.7 4672.9 4883.5 5080.3 5149.7 5205.5 4457.8 4571.3 4595.8 4721.5 5041.9 3864.9 4046.0 4331.9 4437.8 5002.0 4225.0 4439.5 4627.0 4890.3 4992.7 3352.9 3435.2 3526.8 3526.8 3539.9 4257.9 4518.1 4775.4 4797.4 4811.0 4838.8 5313.6 5435.0 5785.1 5866.6 4760.0 5339.5 5803.2 5817.9 5822.6 5440.6 5483.2 5679.5 5711.0 5720.2 5114.9 5580.1 5612.4 5874.4 5880.7 4723.6 4985.8 5263.9 5736.8 5769.0 17:19:00 INFO - PROCESS | 1649 | 17:19:00 INFO - PROCESS | 1649 | [#5] yui.html Cycles:180 Average:25464.25 Median:3661.14 stddev:41456.10 (1132.3%) stddev-sans-first:41530.50 17:19:00 INFO - PROCESS | 1649 | Values: 642.5 701.2 728.3 759.2 770.6 15169.7 15370.2 15583.5 16056.5 16083.0 13927.6 14247.6 14256.4 14468.9 14537.8 855.6 885.4 886.3 887.0 888.0 695.2 776.4 879.8 894.1 896.3 913.5 920.6 928.1 928.8 931.8 879.7 921.9 924.3 924.8 925.6 658.4 678.2 681.7 686.5 688.6 14746.9 14859.9 14944.5 15080.7 15123.3 13955.4 14549.9 14707.6 14739.8 14801.3 12104.4 12127.1 12132.3 12159.8 12307.1 3245.7 3338.8 3841.2 3920.9 4073.0 99116.0 101113.0 119960.0 125236.4 125661.4 9380.8 11490.4 11536.7 11537.6 11931.6 22719.4 22846.9 23185.9 23433.4 23535.6 8080.5 8138.0 8164.1 8232.7 8243.5 4363.5 4450.2 4454.1 4464.4 4493.2 3568.8 3646.6 3675.7 3688.2 3694.0 620.8 643.8 644.1 648.3 650.4 495.7 601.0 664.7 687.5 694.0 7330.4 7458.3 9364.6 9495.3 9614.3 555.8 592.7 598.2 645.9 676.3 4592.7 4694.5 4697.6 4722.3 4729.0 96695.0 140748.3 159927.0 160702.0 165361.3 138833.3 139709.0 145199.0 145495.0 146708.3 77530.0 78341.6 115039.0 120762.4 121558.0 9043.5 9107.9 9115.4 9234.5 9273.3 61756.5 68401.7 69205.0 70136.3 70852.0 101452.0 103976.0 105701.5 106069.5 106811.9 12107.8 12432.3 12521.2 12600.6 12679.0 13222.6 13333.1 13428.5 13528.7 13721.1 12056.8 12218.3 12592.7 12865.7 12920.0 12115.4 12689.0 12841.2 12924.4 13072.2 11952.4 12091.3 12318.6 12617.1 12730.1 10292.7 10551.6 10776.0 10965.8 10976.3 7792.7 9436.6 9540.5 10715.7 10830.3 17:19:00 INFO - PROCESS | 1649 | -------- Summary: end -------- 17:19:00 INFO - PROCESS | 1649 | 17:19:01 INFO - TEST-INFO | 1649: exit 0 17:19:01 INFO - TEST-OK | dromaeo_css | took 1113990ms 17:19:01 INFO - TEST-START | kraken 17:19:01 INFO - operating with platform_type : mac_ 17:19:01 INFO - Initialising browser for kraken test... 17:19:01 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/tmp9TdhfW/profile http://localhost:49266/getInfo.html) 17:19:04 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 17:19:04 INFO - PROCESS | 1661 | colorDepth:24 17:19:04 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 17:19:04 INFO - PROCESS | 1661 | __metrics 17:19:04 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 17:19:04 INFO - TEST-INFO | 1661: exit 0 17:19:04 INFO - Browser initialized. 17:19:04 INFO - Running cycle 1/1 for kraken test... 17:19:05 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/tmp9TdhfW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:19:16 INFO - PROCESS | 1663 | RSS: Main: 254595072 17:19:16 INFO - PROCESS | 1663 | 17:19:20 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 17:19:21 INFO - PROCESS | 1663 | RSS: Main: 267862016 17:19:21 INFO - PROCESS | 1663 | 17:19:23 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 17:19:24 INFO - PROCESS | 1663 | RSS: Main: 276721664 17:19:24 INFO - PROCESS | 1663 | 17:19:27 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 17:19:28 INFO - PROCESS | 1663 | RSS: Main: 279646208 17:19:28 INFO - PROCESS | 1663 | 17:19:30 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 17:19:30 INFO - PROCESS | 1663 | RSS: Main: 282091520 17:19:30 INFO - PROCESS | 1663 | 17:19:33 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:19:33 INFO - PROCESS | 1663 | RSS: Main: 282509312 17:19:33 INFO - PROCESS | 1663 | 17:19:36 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 17:19:37 INFO - PROCESS | 1663 | RSS: Main: 282734592 17:19:37 INFO - PROCESS | 1663 | 17:19:40 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 17:19:41 INFO - PROCESS | 1663 | RSS: Main: 283164672 17:19:41 INFO - PROCESS | 1663 | 17:19:44 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 17:19:44 INFO - PROCESS | 1663 | RSS: Main: 282976256 17:19:44 INFO - PROCESS | 1663 | 17:19:46 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:19:47 INFO - PROCESS | 1663 | RSS: Main: 282877952 17:19:47 INFO - PROCESS | 1663 | 17:19:48 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:19:49 INFO - PROCESS | 1663 | RSS: Main: 283054080 17:19:49 INFO - PROCESS | 1663 | 17:19:51 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:19:52 INFO - PROCESS | 1663 | RSS: Main: 283426816 17:19:52 INFO - PROCESS | 1663 | 17:19:55 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:19:56 INFO - PROCESS | 1663 | RSS: Main: 283774976 17:19:56 INFO - PROCESS | 1663 | 17:19:58 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:19:59 INFO - PROCESS | 1663 | RSS: Main: 283398144 17:19:59 INFO - PROCESS | 1663 | 17:20:01 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 17:20:01 INFO - PROCESS | 1663 | RSS: Main: 284553216 17:20:01 INFO - PROCESS | 1663 | 17:20:01 INFO - PROCESS | 1663 | __start_tp_report 17:20:01 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 17:20:01 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 17:20:01 INFO - PROCESS | 1663 | |i|pagename|runs| 17:20:01 INFO - PROCESS | 1663 | |0;ai-astar;121;116;107;118;98;169;93;165;169;167 17:20:01 INFO - PROCESS | 1663 | |1;audio-beat-detection;180;138;147;157;120;164;162;114;156;109 17:20:01 INFO - PROCESS | 1663 | |2;audio-dft;199;208;218;204;202;212;200;201;196;200 17:20:01 INFO - PROCESS | 1663 | |3;audio-fft;71;81;75;140;65;76;83;88;132;60 17:20:01 INFO - PROCESS | 1663 | |4;audio-oscillator;57;94;99;75;106;91;117;69;66;125 17:20:01 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;90;105;123;73;121;82;136;78;137;131 17:20:01 INFO - PROCESS | 1663 | |6;imaging-darkroom;121;140;152;106;152;102;152;151;110;149 17:20:01 INFO - PROCESS | 1663 | |7;imaging-desaturate;92;91;90;92;92;89;93;94;92;89 17:20:01 INFO - PROCESS | 1663 | |8;json-parse-financial;54;57;57;56;57;56;56;57;56;56 17:20:01 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;71;69;71;78;76;79;79;74;71;72 17:20:01 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;85;84;88;111;75;92;107;104;107;84 17:20:01 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;135;140;186;151;136;138;137;138;140;135 17:20:01 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;167;167;166;166;169;167;165;169;169;167 17:20:01 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;64;67;90;86;90;84;68;67;67;68 17:20:01 INFO - PROCESS | 1663 | __end_tp_report 17:20:01 INFO - PROCESS | 1663 | __start_cc_report 17:20:01 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1055 17:20:01 INFO - PROCESS | 1663 | __end_cc_report 17:20:01 INFO - PROCESS | 1663 | __startTimestamp1470442801609__endTimestamp 17:20:01 INFO - PROCESS | 1663 | 17:20:01 INFO - PROCESS | 1663 | ------- Summary: start ------- 17:20:01 INFO - PROCESS | 1663 | Number of tests: 14 17:20:01 INFO - PROCESS | 1663 | 17:20:01 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:132.30 Median:168.00 stddev:31.49 (18.7%) stddev-sans-first:33.14 17:20:01 INFO - PROCESS | 1663 | Values: 121.0 116.0 107.0 118.0 98.0 169.0 93.0 165.0 169.0 167.0 17:20:01 INFO - PROCESS | 1663 | 17:20:01 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:156.50 stddev:23.74 (15.2%) stddev-sans-first:21.48 17:20:01 INFO - PROCESS | 1663 | Values: 180.0 138.0 147.0 157.0 120.0 164.0 162.0 114.0 156.0 109.0 17:20:01 INFO - PROCESS | 1663 | 17:20:01 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:204.00 Median:203.00 stddev:6.75 (3.3%) stddev-sans-first:6.91 17:20:01 INFO - PROCESS | 1663 | Values: 199.0 208.0 218.0 204.0 202.0 212.0 200.0 201.0 196.0 200.0 17:20:01 INFO - PROCESS | 1663 | 17:20:01 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:87.10 Median:75.50 stddev:27.12 (35.9%) stddev-sans-first:28.14 17:20:01 INFO - PROCESS | 1663 | Values: 71.0 81.0 75.0 140.0 65.0 76.0 83.0 88.0 132.0 60.0 17:20:01 INFO - PROCESS | 1663 | 17:20:01 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:72.00 stddev:22.70 (31.5%) stddev-sans-first:20.73 17:20:01 INFO - PROCESS | 1663 | Values: 57.0 94.0 99.0 75.0 106.0 91.0 117.0 69.0 66.0 125.0 17:20:01 INFO - PROCESS | 1663 | 17:20:01 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:107.60 Median:105.00 stddev:25.12 (23.9%) stddev-sans-first:25.83 17:20:01 INFO - PROCESS | 1663 | Values: 90.0 105.0 123.0 73.0 121.0 82.0 136.0 78.0 137.0 131.0 17:20:01 INFO - PROCESS | 1663 | 17:20:01 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:133.50 Median:150.00 stddev:21.27 (14.2%) stddev-sans-first:22.08 17:20:01 INFO - PROCESS | 1663 | Values: 121.0 140.0 152.0 106.0 152.0 102.0 152.0 151.0 110.0 149.0 17:20:01 INFO - PROCESS | 1663 | 17:20:01 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:91.40 Median:92.00 stddev:1.65 (1.8%) stddev-sans-first:1.73 17:20:01 INFO - PROCESS | 1663 | Values: 92.0 91.0 90.0 92.0 92.0 89.0 93.0 94.0 92.0 89.0 17:20:01 INFO - PROCESS | 1663 | 17:20:01 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.50 stddev:0.92 (1.6%) stddev-sans-first:0.53 17:20:01 INFO - PROCESS | 1663 | Values: 54.0 57.0 57.0 56.0 57.0 56.0 56.0 57.0 56.0 56.0 17:20:01 INFO - PROCESS | 1663 | 17:20:01 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:74.00 Median:75.00 stddev:3.74 (5.0%) stddev-sans-first:3.81 17:20:01 INFO - PROCESS | 1663 | Values: 71.0 69.0 71.0 78.0 76.0 79.0 79.0 74.0 71.0 72.0 17:20:01 INFO - PROCESS | 1663 | 17:20:01 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:93.70 Median:84.00 stddev:12.51 (14.9%) stddev-sans-first:12.86 17:20:01 INFO - PROCESS | 1663 | Values: 85.0 84.0 88.0 111.0 75.0 92.0 107.0 104.0 107.0 84.0 17:20:01 INFO - PROCESS | 1663 | 17:20:01 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:143.60 Median:139.00 stddev:15.60 (11.2%) stddev-sans-first:16.23 17:20:01 INFO - PROCESS | 1663 | Values: 135.0 140.0 186.0 151.0 136.0 138.0 137.0 138.0 140.0 135.0 17:20:01 INFO - PROCESS | 1663 | 17:20:01 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.20 Median:167.00 stddev:1.40 (0.8%) stddev-sans-first:1.48 17:20:01 INFO - PROCESS | 1663 | Values: 167.0 167.0 166.0 166.0 169.0 167.0 165.0 169.0 169.0 167.0 17:20:01 INFO - PROCESS | 1663 | 17:20:01 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.10 Median:76.00 stddev:10.87 (14.3%) stddev-sans-first:10.76 17:20:01 INFO - PROCESS | 1663 | Values: 64.0 67.0 90.0 86.0 90.0 84.0 68.0 67.0 67.0 68.0 17:20:01 INFO - PROCESS | 1663 | -------- Summary: end -------- 17:20:01 INFO - PROCESS | 1663 | 17:20:02 INFO - TEST-INFO | 1663: exit 0 17:20:02 INFO - TEST-OK | kraken | took 61176ms 17:20:02 INFO - SUITE-END | took 1175s 17:20:02 INFO - Completed test suite (00:19:35) 17:20:02 INFO - javascript benchmark 17:20:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7292.191344924925, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3413.180836599217, 3423.3837909176345, 3448.603410607779, 3457.6196618371973, 3467.982660086699, 5682.090865461527, 5752.884942301157, 5782.826515204545, 5851.853703657411, 5863.355030946593, 5708.286464191966, 5712.71436428179, 5727.341355744091, 5770.884582308351, 5804.941950580493, 5111.591072714193, 5251.55361794248, 5259.710715910624, 5313.256144139824, 5355.0896347621, 5338.985592737367, 5353.544948679367, 5388.757505912244, 5414.35027796665, 5420.7018613976215, 4962.15643340633, 5146.897062058738, 5186.7147306898105, 5188.014277287303, 5218.269442278084, 5276.630635855492, 5295.708736019517, 5299.178627312773, 5310.548603368679, 5314.99015187117, 5181.922271165936, 5267.710275934822, 5274.340707411574, 5282.894342113136, 5321.388040375329, 4866.78099485524, 5173.4826517347965, 5652.8869422611315, 5690.5447564194765, 5703.372629010805, 5749.108888122306, 6015.299372307956, 6244.781432649881, 6285.717142728542, 6290.087937249119, 6141.449068002053, 6187.938120618781, 6188.504919606421, 6190.288116866528, 6212.875742485125, 5747.252857128588, 5818.679972601548, 5836.7957121501395, 5861.824145275648, 5951.434613711691, 6263.655498947602, 6276.937230627726, 6281.434670879643, 6306.779262725874, 6325.620462772248, 6187.133801267826, 6197.411245931629, 6208.379162083756, 6217.036359364306, 6226.315105338409, 5979.252593425822, 6109.526129009804, 6175.413335733098, 6180.66006369645, 6234.781782637586, 5623.746931388097, 6238.688065596702, 6247.187865577536, 6255.311915689271, 6265.8120256392385, 4816.927746083811, 5737.340205876378, 6270.811875643738, 6286.779962701284, 6325.3674632537295, 4386.320120381346, 4562.771861406983, 4732.124556956974, 4882.0, 5002.974985125051, 4474.485434175112, 4484.932726009112, 4496.685232033727, 4496.7077139985795, 4530.048689775184, 5743.741531631003, 5808.6224395414165, 5847.707614619252, 5878.3239927408895, 5881.617694849821, 5744.339400968942, 5839.941600583939, 6200.56596038273, 6236.095766113888, 6237.500999919996, 5766.711664416763, 5771.509421699118, 5781.53747700183, 5790.36306006339, 5820.767169313265, 5424.267723857308, 5482.643628164236, 5494.752736126884, 5495.835124946258, 5502.972485137549, 6167.290761562388, 6197.0, 6245.250569931637, 6258.561900666909, 6323.462505687068, 6259.374062593704, 6267.122602835698, 6275.34108918557, 6287.18266625354, 6287.559870808999, 6297.086922396135, 6333.809985700436, 6341.682915854281, 6344.143540621957, 6348.396902294275, 6095.226761080104, 6166.352532983972, 6167.0, 6171.6297022178815, 6272.560920735505, 5238.659487133325, 6231.906521402273, 6265.060240963892, 6273.62358258506, 6290.836195303884, 5078.669886457368, 6072.423119803611, 6237.594556353823, 6244.6261822399, 6244.843878903063, 6077.787277445268, 6097.645669838225, 6107.175531303217, 6142.744345496893, 6162.784302549389, 5302.992431438014, 5626.43735626434, 6061.969690151521, 6105.297890742621, 6107.014746911084, 5681.630694004876, 5786.0, 6211.2857021443115, 6219.657918814328, 6232.875342493216, 5841.912371314519, 5919.260092488439, 5950.285965684146, 5979.790707325223, 6097.329293777592], "value": 5686.156254419551, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [519.4441947116587, 533.6237952243667, 539.7921800106958, 555.231005057995, 559.9524040456561, 32745.67254327456, 40946.38580421292, 41060.17879642405, 41111.58888411115, 41197.764067077995, 42250.57749422505, 42716.57283427165, 42734.78632606832, 42760.572394276045, 42858.92852678685, 9572.521373931293, 9764.218862490983, 9799.853002204973, 9799.95100024499, 9815.558299876522, 9630.3258771886, 9693.70918872435, 9718.61125554977, 9749.463779492125, 9770.511474426286, 9740.659076932308, 9756.170725488342, 9764.658236961708, 9790.853137202948, 9807.754806129833, 9687.903120968806, 9738.880028796708, 9746.025397460196, 9765.023497650249, 9774.951125244399, 9613.423194608346, 9707.854382184272, 9710.028997100233, 9719.61121555144, 9723.951380243125, 39932.80201593957, 40213.0, 40274.798626006974, 40369.39445908314, 40382.79808600938, 3303.124671961932, 3660.7254455915645, 3998.280309544281, 4086.080631857838, 4122.175564887035, 25627.48745025089, 31579.842100789578, 32137.839310803298, 32603.0, 32608.347833043208, 3218.6298575663864, 3351.0617027232415, 3372.15696075981, 3382.780119292263, 3383.661633836621, 349329.0, 353929.0, 390665.99999999715, 390674.046629765, 392201.0, 50141.74929125404, 60051.0, 60276.095858562156, 60319.69840150771, 60362.39637603568, 63620.0, 63820.68089659522, 64146.35853641404, 64212.0, 64483.0, 15810.288537015862, 15915.0, 16010.839891601168, 16014.19929003545, 16037.636800871824, 12260.693482663004, 12330.260184388966, 12332.383380830923, 12336.383180840921, 12338.691532711575, 13223.3388330585, 13832.654183645289, 15285.617859553378, 16874.325026998784, 16893.746593801105, 6609.306022867626, 6668.299828518033, 6841.24746277919, 6891.655417229119, 6903.6548172591165, 749.741339237962, 796.243568609823, 857.0914830279924, 986.5757724178528, 1059.7880423915249, 31657.208569785478, 32398.83800580982, 32582.185445364055, 33318.16704582405, 33358.16604584905, 966.5602151021268, 1071.919606029551, 1130.429133287701, 1153.9134564907665, 1154.7690461907653, 15674.529764107096, 15855.0, 15914.76127858083, 16564.75152872708, 17085.572860678334, 636183.8190809109, 639198.0, 642128.0, 642274.0, 644716.0, 60269.0, 60287.39712602906, 60441.093383599284, 60679.69660151671, 60806.39193608007, 1344.5495758920677, 1372.8970327225497, 1388.5209602687057, 1390.1520072755611, 1392.2064423278634, 24621.63067554024, 29908.551371729005, 30482.695173047985, 31048.68951310458, 31296.06111816649, 51454.0, 52233.7388313056, 52383.95232095413, 52753.0, 52773.7361313191, 601374.0, 601993.0, 604322.0, 604857.0, 605940.0, 25263.242102736946, 25354.492910142064, 25535.0, 25599.0, 25670.61494077628, 47793.76103119462, 48223.5177648219, 49857.50142498674, 50991.74504127455, 52099.0, 33394.83118090855, 33953.23990634018, 39935.0, 40869.1826163481, 41196.1760764789, 32111.839440802647, 40055.1988960225, 40312.59687403088, 40528.0, 41060.384094239205, 39166.412503811895, 39543.80228098841, 40164.594239202655, 40205.597944020185, 40936.79531602323, 29879.850600746857, 30705.53941690921, 34095.65904341024, 34761.82619086889, 34887.47668785021, 22527.5494490106, 24406.51186976286, 24896.62655060212, 24956.0, 27017.45965080727], "value": 19891.283973415804, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.94173577888085, 365.2074997255954, 377.53940192964586, 383.6393789837554, 400.8396641343462, 16976.0, 20017.699734503993, 20823.895880520613, 21389.786102138994, 21704.0, 20474.385768426935, 20542.870142142176, 20829.0, 20918.895405522988, 21051.2632057878, 5919.112133180036, 5999.760009599632, 6023.518118550527, 6032.0, 6107.603005804631, 4913.680610760289, 5991.610545314563, 6043.153958445799, 6048.243969503812, 6055.182550355689, 5925.200097986782, 5956.374580669032, 6024.307204671475, 6031.336552979169, 6038.788642397517, 5846.21076154718, 5906.0, 5919.467247947706, 6021.518278537728, 6051.273847138327, 4358.433403657536, 4789.976050119762, 5046.21783623539, 5162.199859021857, 5163.173892177271, 25489.980400783945, 25507.23478295654, 25817.7091145442, 26101.216963491126, 26245.0, 2087.8642888212216, 2185.4099393163915, 2192.473806286496, 2216.822654187661, 2249.5051088760447, 15073.321700523393, 15191.62020949474, 15668.216589170495, 15848.0, 16057.956232844828, 1860.897650629215, 1871.4828555592842, 1896.2983696032557, 1908.4656296236938, 1975.911084001209, 110649.0, 111042.88957110487, 113922.0, 114180.42909785481, 114310.0, 10491.580336786596, 10826.834633073417, 10882.455877206108, 10987.39569323695, 11120.443977801078, 13617.591472255848, 13618.0, 13631.931840340932, 13632.93183534076, 13644.249566273951, 6827.5562088465085, 8066.0, 8342.833143337099, 8421.157884211652, 8470.491770493667, 8173.79565510867, 8242.29940455056, 8277.62750676221, 8403.747887563382, 8438.957805210935, 6619.113552637476, 6698.363655452724, 6699.76550820719, 6706.899396509057, 6709.597424154566, 1841.4475657302755, 1873.3536929759211, 1881.1158755384947, 1881.6518943995404, 1892.1579896946002, 734.8052766017009, 773.8916551682769, 958.1328897347911, 992.4491906991544, 1064.4884264344494, 19881.701774473393, 21362.465938351666, 21369.0, 21574.244901428374, 21576.244831431137, 846.289117141604, 946.4652471353663, 987.6098940918297, 995.2535598301274, 1023.2581378500528, 9311.627534898527, 9766.169875560516, 10770.192235582363, 11504.76990460186, 11512.539498420138, 452911.0, 594257.0, 595565.0221748863, 603271.0, 608851.0, 92480.07519924715, 100994.0, 110259.44870275597, 111684.44157779159, 114080.0, 946.3281070439928, 977.8435450327913, 996.6113215845826, 997.6607953295769, 1030.4487099401633, 18548.629027419105, 19333.936633485293, 19440.61118777645, 19472.61054778925, 19684.015799209697, 42272.0, 45544.54455455536, 51907.96969636354, 52615.68460788358, 53199.73400132974, 71766.64116679592, 72715.63642181756, 73452.0, 73633.52732945418, 74105.0, 7865.095514015961, 7947.046354437504, 7971.920280797118, 8003.799905002189, 8081.232282933112, 12578.811317830057, 12697.4286157125, 12961.15752476086, 13065.673358166121, 13091.738165236833, 10927.672169834917, 10952.288101273392, 11214.990650841464, 11315.547378104784, 11340.319580824847, 10808.513616887416, 11072.003519683267, 11166.44167791591, 11225.775484490428, 11582.826257605973, 9113.94176232171, 11476.0, 11550.480228389575, 11622.128340374336, 11679.299242045505, 7722.53664780115, 8037.638306276114, 8037.678492860454, 8097.959510202411, 8133.0646975598565, 10914.126869850234, 11030.44847757625, 11142.498587563417, 11232.3260604364, 11393.886061139614], "value": 9595.247331610988, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1505.4580351073614, 1547.6827250413667, 1718.9484315470531, 1814.0, 1832.7067669172934, 7781.416393770462, 8252.752417427471, 8328.375371847105, 8742.956285218574, 8780.780480487983, 8509.574521273928, 8579.742607721779, 8590.914090859089, 8603.139686031394, 8611.612477438515, 1729.6627157704252, 1920.9423717288503, 2299.781116008514, 2330.207729372013, 2334.2880421471446, 2307.1694190091553, 2324.070371851256, 2353.670486131943, 2362.397588614901, 2368.3842201027683, 2337.906483740648, 2346.8290047045616, 2348.5772560939026, 2367.0176876596192, 2367.0886708617136, 2321.210788331958, 2348.2250857217077, 2348.612478940973, 2355.5877721398774, 2359.834811563191, 2330.382448651109, 2332.7900488955906, 2336.6495025746103, 2342.1919437793936, 2344.8475849069755, 8665.306775458012, 8698.739037828875, 8699.130086991314, 8717.738467845975, 8734.388592798507, 5100.2349647553165, 5132.897342053138, 5159.2003239497935, 5280.551153151987, 5280.735963201824, 3306.1404034950847, 3331.267121233325, 3334.6331903490595, 3353.3796247694013, 3523.841427135759, 1083.106437189322, 1085.2240647936762, 1087.7389426537575, 1098.5386137822134, 1118.3066498770734, 11281.435928203557, 11310.943445282803, 11453.198276120675, 11454.599089031844, 11465.484053217542, 4502.671711845013, 4647.488776234612, 4738.3840100787365, 4738.696858363977, 4739.976300118477, 9683.176929961031, 9738.220942324597, 9741.172000380047, 9764.609415623438, 9775.804483910282, 4507.706999045052, 5193.143131383279, 5245.396779370345, 5249.501297376743, 5281.815136470282, 3550.2721942001826, 4637.7449240291435, 4741.905161896742, 4812.230043193073, 4814.0, 3165.6042994625673, 3279.4588892832417, 3869.96130038696, 3872.4772155759174, 3981.7013723970817, 1270.7585558743808, 1273.6815796050987, 1274.560276704554, 1276.4064709909937, 1276.6233960981533, 831.3349320543541, 899.9910000900038, 909.5134103254727, 923.5982347678781, 938.029139840262, 5715.914261286084, 5741.311042674905, 5921.881562368729, 5976.910346344808, 6031.306399763996, 387.79640688638125, 455.07165382619746, 461.838356575196, 931.5761328595473, 1034.6068493972393, 3866.74866133706, 3972.801359931992, 3988.9002774930277, 4022.879313620596, 4033.824991134221, 10248.846267305997, 10471.581136754445, 10501.737456563647, 10597.258191926645, 10602.681919542427, 10410.0, 10513.737156571147, 10559.736006599896, 10618.522166502526, 10628.734281643021, 8106.229908158715, 8121.35029197651, 8124.22819832115, 8158.3065439438315, 8212.096669366365, 5767.596268261182, 5824.592278540462, 5874.911876321773, 5875.529957603467, 5889.939810833919, 9581.089796469325, 9645.469499177612, 9805.313628045968, 9863.753406164904, 9890.851637225303, 9860.359076659994, 9921.751956201153, 10018.849717254101, 10095.394276343442, 10099.545520451451, 5711.828645140652, 6072.787452439144, 6646.966765166143, 6799.558028728117, 6914.343137401939, 8153.02163740355, 8158.796030099295, 8179.877301840358, 8234.970628671415, 8257.587120643824, 7349.669264882986, 7465.141508726349, 7511.924880751122, 7512.887306690294, 7567.167611562613, 7101.218865924848, 7283.380912622486, 7307.525010874276, 7311.780646580611, 7364.410847132323, 6467.288598254282, 6912.27421120775, 7007.194172670004, 7065.0, 7088.751893683696, 4193.370994350872, 4784.6889952153, 4821.373221481185, 4867.829625963074, 4933.77797999098, 4905.950940490549, 4999.350084488993, 5054.702319338753, 5063.468335824686, 5121.487851214849], "value": 4460.431930541416, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.2468095292716, 299.15339588963235, 307.1645125259297, 307.43278650889107, 309.17912941141276, 5367.275417818593, 5466.289382380295, 5609.635373700712, 5644.830655080344, 5655.246873469222, 5471.5896307776875, 5524.0, 5562.386907796744, 5575.581831362644, 5591.049521581331, 3501.73736969727, 3680.969328588, 3863.517060367454, 4247.957520424795, 4257.340112282601, 3634.876283122164, 4144.8963775905695, 4239.0674051708575, 4257.7445353278745, 4264.125854199897, 4187.476565429321, 4192.601702838226, 4196.0, 4216.4188429339, 4220.3036498977635, 3461.619221885603, 3669.284489524544, 4058.7823652904012, 4061.801768478306, 4199.706020578561, 3119.0330997390656, 3486.3027394520946, 3689.262147570497, 3692.593814680383, 3707.8887633370773, 4463.107378524276, 4666.789994450258, 5229.08491014071, 5337.199420087018, 5358.758855851496, 3880.9805950970062, 3990.68074554035, 4337.306031035051, 4563.315502674593, 4849.442314133849, 4886.389201349832, 5558.44415558445, 5841.094630332305, 5847.356790753056, 5959.970200149015, 3545.1461573433376, 3808.933498620363, 3895.9480940146, 3991.1618560102124, 4075.8369665213354, 5245.711485868275, 6143.354947730513, 6194.876102477971, 6197.504199664016, 6278.843028924268, 4101.364288535282, 4105.322621767435, 4130.463039804806, 4133.855315063958, 4147.6267135957905, 3556.78659280444, 3900.687944964396, 3974.6025397460603, 4053.858114966021, 4120.423140760296, 4360.454943132108, 4479.440069991251, 4777.713337199779, 4821.566059054632, 4836.95163048365, 5143.382794064736, 5903.409659034062, 5919.668074683162, 5948.702564871739, 5994.340622531518, 1198.8861058199457, 1267.4866678995022, 1331.3210262766058, 1371.6982263901925, 1416.6458385403648, 824.3652387661467, 872.7163671806688, 922.9907700923039, 960.279790157382, 960.5917485068818, 4147.771872546979, 5229.581633469314, 5243.292155559027, 5261.027114831938, 5281.223924893643, 5330.827218012031, 5761.596688231867, 5858.242527241896, 5873.882522349614, 5879.941200588025, 4485.730856148642, 4948.762809297676, 4972.776225069881, 5189.6886186828915, 5287.894242115213, 2375.7505461926594, 2516.59734442492, 2647.007372235412, 2657.3755167535614, 2663.733626637321, 4566.520515345907, 4655.627549796008, 5184.585233181337, 5211.280277508413, 5224.4139151120435, 4308.4399028126145, 4617.884552886205, 4791.592714619227, 4890.1881418184685, 5096.668716533413, 4672.925227197696, 4883.536064073907, 5080.263361812516, 5149.712571857036, 5205.453427390145, 4457.75482348461, 4571.3371561122785, 4595.816167353402, 4721.457032441176, 5041.924371134362, 3864.9227015460096, 4046.020614440185, 4331.891702707331, 4437.800298986618, 5001.974990125026, 4224.957750422456, 4439.48945871216, 4626.976865115653, 4890.334767551622, 4992.700437973734, 3352.9329413411106, 3435.2442462658173, 3526.7531272810656, 3526.8236588171003, 3539.9469007964385, 4257.8503803972135, 4518.051209245964, 4775.379200703886, 4797.376341075777, 4810.993129294191, 4838.830640927551, 5313.628046036741, 5434.967356202467, 5785.132230165509, 5866.560007999503, 4760.047990401864, 5339.517124537109, 5803.216565763737, 5817.88743022481, 5822.563307752021, 5440.591955603425, 5483.204935284281, 5679.5172410345585, 5710.971445142748, 5720.199172115824, 5114.872128196825, 5580.051391263414, 5612.382637909908, 5874.353821079763, 5880.735366908585, 4723.622110231105, 4985.775640096132, 5263.868403289795, 5736.8278951629845, 5768.971155144198], "value": 3987.3968873615554, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.4635429416434, 701.2006312803405, 728.3481284250596, 759.1573353577528, 770.6300975531741, 15169.696606067871, 15370.155581330242, 15583.536555019167, 16056.51830445087, 16083.03501789892, 13927.58217253484, 14247.572572822806, 14256.429742810302, 14468.855311446883, 14537.78193327101, 855.6320782063725, 885.420049867338, 886.3263919421254, 887.0154128916897, 887.968921087762, 695.1970474102394, 776.3595034096865, 879.7932485865816, 894.0567701075363, 896.26058501736, 913.5067063785548, 920.6041402197086, 928.1368327455464, 928.8235235305305, 931.7950050988771, 879.6613303877989, 921.8985911549725, 924.2698268367981, 924.8335299646095, 925.5973651461602, 658.427168363522, 678.199724325296, 681.7307163670372, 686.5468790598231, 688.5868478912662, 14746.852531474655, 14859.851401485956, 14944.476943307041, 15080.698386032218, 15123.319450624638, 13955.441782328695, 14549.854501455062, 14707.55877323682, 14739.83093634863, 14801.333939972727, 12104.394780260951, 12127.09046821492, 12132.332721700302, 12159.756804863853, 12307.138500304982, 3245.7078862902217, 3338.833058347073, 3841.154945911895, 3920.901977450558, 4073.0021144819707, 99116.0, 101113.0, 119960.0, 125236.37381813124, 125661.37169314094, 9380.765480863032, 11490.368029758276, 11536.653900383002, 11537.596184133516, 11931.582394616147, 22719.432014199778, 22846.885765571067, 23185.884070579537, 23433.41416464568, 23535.646965295535, 8080.515169089756, 8138.023437187457, 8164.101948785629, 8232.670693172326, 8243.464174828618, 4363.52001279859, 4450.1989641864775, 4454.131444368317, 4464.352668862996, 4493.168763778712, 3568.803715795604, 3646.635336466385, 3675.650813172744, 3688.188598508324, 3694.039549717093, 620.7672122953892, 643.7746788623945, 644.1143427786793, 648.2642201101689, 650.388634683396, 495.7446914838861, 600.9519238460913, 664.7307840324676, 687.5393486364148, 693.9861202775916, 7330.355626167821, 7458.328750412489, 9364.578593963288, 9495.335326527214, 9614.326997110275, 555.824915151734, 592.6503363015842, 598.2163365990566, 645.9471062168635, 676.266251117543, 4592.655550833634, 4694.507076756891, 4697.6241900647865, 4722.268048452495, 4729.0, 96695.0, 140748.2962585201, 159927.0, 160702.0, 165361.3463865346, 138833.3058334702, 139709.0, 145199.0, 145495.0, 146708.26645866915, 77530.0, 78341.60829195818, 115039.0, 120762.39618802026, 121558.0, 9043.457392556467, 9107.907051153905, 9115.36192466521, 9234.538273086453, 9273.25813934897, 61756.45608859814, 68401.65799170973, 69205.0, 70136.29863701502, 70852.0, 101451.98548014721, 103976.0, 105701.47149264204, 106069.46965265124, 106811.9318806802, 12107.75784484323, 12432.316222607482, 12521.186122901981, 12600.621981340575, 12679.0, 13222.603321900358, 13333.066685331934, 13428.530001449903, 13528.72942541124, 13721.108127971649, 12056.819147712617, 12218.26690398579, 12592.685182870502, 12865.742685146432, 12920.030997675023, 12115.394230288273, 12689.048321375749, 12841.165324253894, 12924.418401172157, 13072.215667060007, 11952.402379881145, 12091.334976576372, 12318.630441086782, 12617.053720971147, 12730.108892377444, 10292.742681433025, 10551.577936882439, 10776.0, 10965.780684386107, 10976.341419514854, 7792.688292468238, 9436.575354109218, 9540.522973851419, 10715.732106697084, 10830.296030757976], "value": 7789.256613322246, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1600.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 116.0, 107.0, 118.0, 98.0, 169.0, 93.0, 165.0, 169.0, 167.0], "value": 132.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 138.0, 147.0, 157.0, 120.0, 164.0, 162.0, 114.0, 156.0, 109.0], "value": 144.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 208.0, 218.0, 204.0, 202.0, 212.0, 200.0, 201.0, 196.0, 200.0], "value": 204.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 81.0, 75.0, 140.0, 65.0, 76.0, 83.0, 88.0, 132.0, 60.0], "value": 87.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 94.0, 99.0, 75.0, 106.0, 91.0, 117.0, 69.0, 66.0, 125.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 105.0, 123.0, 73.0, 121.0, 82.0, 136.0, 78.0, 137.0, 131.0], "value": 107.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 140.0, 152.0, 106.0, 152.0, 102.0, 152.0, 151.0, 110.0, 149.0], "value": 133.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 90.0, 92.0, 92.0, 89.0, 93.0, 94.0, 92.0, 89.0], "value": 91.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 57.0, 56.0, 57.0, 56.0, 56.0, 57.0, 56.0, 56.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 71.0, 78.0, 76.0, 79.0, 79.0, 74.0, 71.0, 72.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 88.0, 111.0, 75.0, 92.0, 107.0, 104.0, 107.0, 84.0], "value": 93.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 140.0, 186.0, 151.0, 136.0, 138.0, 137.0, 138.0, 140.0, 135.0], "value": 143.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 166.0, 166.0, 169.0, 167.0, 165.0, 169.0, 169.0, 167.0], "value": 167.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 90.0, 86.0, 90.0, 84.0, 68.0, 67.0, 67.0, 68.0], "value": 75.1, "unit": "score"}]}]} 17:20:02 INFO - Return code: 0 17:20:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:20:02 ERROR - # TBPL SUCCESS # 17:20:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:20:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:20:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:20:02 INFO - 2016-08-05 17:20:02.910 screenresolution[1668:10416] starting screenresolution argv=screenresolution get 17:20:02 INFO - 2016-08-05 17:20:02.912 screenresolution[1668:10416] Display 0: 1600x1200x32@60 17:20:02 INFO - 2016-08-05 17:20:02.919 screenresolution[1669:10419] starting screenresolution argv=screenresolution list 17:20:02 INFO - Available Modes on Display 0 17:20:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:20:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:20:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:20:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:20:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:20:03 INFO - Intel Iris: 17:20:03 INFO - Chipset Model: Intel Iris 17:20:03 INFO - Type: GPU 17:20:03 INFO - Bus: Built-In 17:20:03 INFO - VRAM (Dynamic, Max): 1536 MB 17:20:03 INFO - Vendor: Intel (0x8086) 17:20:03 INFO - Device ID: 0x0a2e 17:20:03 INFO - Revision ID: 0x0009 17:20:03 INFO - Displays: 17:20:03 INFO - Display: 17:20:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:20:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:20:03 INFO - Display Serial Number: 1600x1200 60 17:20:03 INFO - Main Display: Yes 17:20:03 INFO - Mirror: Off 17:20:03 INFO - Online: Yes 17:20:03 INFO - Rotation: Supported 17:20:03 INFO - Return code: 0 17:20:03 INFO - Running post-action listener: _resource_record_post_action 17:20:03 INFO - [mozharness: 2016-08-06 00:20:03.157325Z] Finished run-tests step (success) 17:20:03 INFO - Running post-run listener: _resource_record_post_run 17:20:03 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 37192704; Write bytes: 706966528; Read time: 236; Write time: 1988 17:20:03 INFO - TinderboxPrint: CPU usage
54.5% 17:20:03 INFO - TinderboxPrint: I/O read bytes / time
37,192,704 / 236 17:20:03 INFO - TinderboxPrint: I/O write bytes / time
706,966,528 / 1,988 17:20:03 INFO - TinderboxPrint: CPU idle
2,205.0 (45.5%) 17:20:03 INFO - TinderboxPrint: CPU system
983.2 (20.3%) 17:20:03 INFO - TinderboxPrint: CPU user
1,653.5 (34.2%) 17:20:03 INFO - TinderboxPrint: Swap in / out
443,961,344 / 0 17:20:03 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 398422528; Write bytes: 392181248; Read time: 29566; Write time: 801 17:20:03 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 35177472; Write bytes: 296984064; Read time: 217; Write time: 1141 17:20:03 INFO - Running post-run listener: _upload_blobber_files 17:20:03 INFO - Blob upload gear active. 17:20:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:20:03 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 17:20:03 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:20:03 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:20:04 INFO - (blobuploader) - INFO - Open directory for files ... 17:20:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:20:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:20:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:05 INFO - (blobuploader) - INFO - Done attempting. 17:20:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:20:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:20:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:06 INFO - (blobuploader) - INFO - Done attempting. 17:20:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:20:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:20:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:08 INFO - (blobuploader) - INFO - Done attempting. 17:20:08 INFO - (blobuploader) - INFO - Iteration through files over. 17:20:08 INFO - Return code: 0 17:20:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:20:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:20:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6eb7f42f30b66ec33242a4967c6a9b8d7d81b1538ee7fe913fa724334ad60b23d3046b8364070e1baf32e5208284eb7f5c48d68518e07a020373ae8d5e17ce8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0eed67b9fdf4f69498c68e44b50c59f08a280bfe5dcf8709d50041131803600af2ea3f5137c4f0efdab84458bbf86df214376e457752c0eaef6b4317ea2126fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6f322e30f191b2fa1077f19579a64fc066986e0921b4060c06e5b170d6ad16f79918803b8edfb4dbd4153f43ed5fb956f099706fae5f023464e3616d3fe43f88"} 17:20:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:20:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:20:08 INFO - Contents: 17:20:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6eb7f42f30b66ec33242a4967c6a9b8d7d81b1538ee7fe913fa724334ad60b23d3046b8364070e1baf32e5208284eb7f5c48d68518e07a020373ae8d5e17ce8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0eed67b9fdf4f69498c68e44b50c59f08a280bfe5dcf8709d50041131803600af2ea3f5137c4f0efdab84458bbf86df214376e457752c0eaef6b4317ea2126fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6f322e30f191b2fa1077f19579a64fc066986e0921b4060c06e5b170d6ad16f79918803b8edfb4dbd4153f43ed5fb956f099706fae5f023464e3616d3fe43f88"} 17:20:08 INFO - Running post-run listener: copy_logs_to_upload_dir 17:20:08 INFO - Copying logs to upload dir... 17:20:08 INFO - mkdir: /builds/slave/test/build/upload/logs 17:20:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.535693 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-08-05 17:20:08.971676) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 17:20:08.975635) ========= 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.zfxRS3QCs3/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.ZJkru6Qri8/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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/Autoland/sha512/6eb7f42f30b66ec33242a4967c6a9b8d7d81b1538ee7fe913fa724334ad60b23d3046b8364070e1baf32e5208284eb7f5c48d68518e07a020373ae8d5e17ce8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0eed67b9fdf4f69498c68e44b50c59f08a280bfe5dcf8709d50041131803600af2ea3f5137c4f0efdab84458bbf86df214376e457752c0eaef6b4317ea2126fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6f322e30f191b2fa1077f19579a64fc066986e0921b4060c06e5b170d6ad16f79918803b8edfb4dbd4153f43ed5fb956f099706fae5f023464e3616d3fe43f88"} build_url:https://queue.taskcluster.net/v1/task/ELS8nQwmR4CMtnuuGrx9ag/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011397 build_url: 'https://queue.taskcluster.net/v1/task/ELS8nQwmR4CMtnuuGrx9ag/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6eb7f42f30b66ec33242a4967c6a9b8d7d81b1538ee7fe913fa724334ad60b23d3046b8364070e1baf32e5208284eb7f5c48d68518e07a020373ae8d5e17ce8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0eed67b9fdf4f69498c68e44b50c59f08a280bfe5dcf8709d50041131803600af2ea3f5137c4f0efdab84458bbf86df214376e457752c0eaef6b4317ea2126fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6f322e30f191b2fa1077f19579a64fc066986e0921b4060c06e5b170d6ad16f79918803b8edfb4dbd4153f43ed5fb956f099706fae5f023464e3616d3fe43f88"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 17:20:09.009171) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 17:20:09.009491) ========= 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.zfxRS3QCs3/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.ZJkru6Qri8/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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.005062 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 17:20:09.058107) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 17:20:09.058456) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 17:20:09.058843) ========= ========= Total master_lag: 0.18 =========