builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0089 starttime: 1471373703.09 results: success (0) buildid: 20160816091017 builduid: 366b7a4e0c0a40c2b9e1440e546cdc97 revision: af4cc6c04573fca495450725de702f7188dab6ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 11:55:03.094275) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 11:55:03.095026) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 11:55:03.095489) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 11:55:03.122415) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 11:55:03.122954) ========= 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.yGFydPe1NU/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.S1fHOO2M4l/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-16 11:55:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.62M=0.001s 2016-08-16 11:55:03 (9.62 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108357 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 11:55:03.256287) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 11:55:03.256798) ========= 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.yGFydPe1NU/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.S1fHOO2M4l/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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.028035 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 11:55:03.308085) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-16 11:55:03.308786) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev af4cc6c04573fca495450725de702f7188dab6ea --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev af4cc6c04573fca495450725de702f7188dab6ea --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yGFydPe1NU/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.S1fHOO2M4l/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-16 11:55:03,386 truncating revision to first 12 chars 2016-08-16 11:55:03,386 Setting DEBUG logging. 2016-08-16 11:55:03,386 attempt 1/10 2016-08-16 11:55:03,386 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/af4cc6c04573?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 11:55:04,487 unpacking tar archive at: fx-team-af4cc6c04573/testing/mozharness/ program finished with exit code 0 elapsedTime=1.349722 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-16 11:55:04.681156) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 11:55:04.681471) ========= script_repo_revision: af4cc6c04573fca495450725de702f7188dab6ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 11:55:04.681876) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 11:55:04.682141) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 11:55:04.701175) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-16 11:55:04.701508) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yGFydPe1NU/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.S1fHOO2M4l/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 11:55:04 INFO - MultiFileLogger online at 20160816 11:55:04 in /builds/slave/test 11:55:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:55:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:55:04 INFO - {'append_to_log': False, 11:55:04 INFO - 'base_work_dir': '/builds/slave/test', 11:55:04 INFO - 'blob_upload_branch': 'Fx-Team', 11:55:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:55:04 INFO - 'branch': 'Fx-Team', 11:55:04 INFO - 'buildbot_json_path': 'buildprops.json', 11:55:04 INFO - 'config_files': ('talos/mac_config.py',), 11:55:04 INFO - 'default_actions': ('clobber', 11:55:04 INFO - 'read-buildbot-config', 11:55:04 INFO - 'download-and-extract', 11:55:04 INFO - 'populate-webroot', 11:55:04 INFO - 'create-virtualenv', 11:55:04 INFO - 'install', 11:55:04 INFO - 'run-tests'), 11:55:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:55:04 INFO - 'download_minidump_stackwalk': True, 11:55:04 INFO - 'download_symbols': 'ondemand', 11:55:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:55:04 INFO - 'tooltool.py': '/tools/tooltool.py', 11:55:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:55:04 INFO - '/tools/misc-python/virtualenv.py')}, 11:55:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:55:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:55:04 INFO - 'installer_path': 'installer.exe', 11:55:04 INFO - 'log_level': 'info', 11:55:04 INFO - 'log_name': 'talos', 11:55:04 INFO - 'log_to_console': True, 11:55:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:55:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:55:04 INFO - 'opt_config_files': (), 11:55:04 INFO - 'pip_index': False, 11:55:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:55:04 INFO - 'cmd': ('bash', 11:55:04 INFO - '-c', 11:55:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:55:04 INFO - 'enabled': True, 11:55:04 INFO - 'halt_on_failure': False, 11:55:04 INFO - 'name': 'check_screen_resolution'},), 11:55:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:55:04 INFO - 'cmd': ('bash', 11:55:04 INFO - '-c', 11:55:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:55:04 INFO - 'enabled': True, 11:55:04 INFO - 'halt_on_failure': False, 11:55:04 INFO - 'name': 'check_screen_resolution'},), 11:55:04 INFO - 'run_cmd_checks_enabled': True, 11:55:04 INFO - 'sps_profile': False, 11:55:04 INFO - 'sps_profile_interval': 0, 11:55:04 INFO - 'suite': 'dromaeojs', 11:55:04 INFO - 'system_bits': '32', 11:55:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:55:04 INFO - 'title': 't-yosemite-r7-0089', 11:55:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:55:04 INFO - 'use_talos_json': True, 11:55:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:55:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:55:04 INFO - 'work_dir': 'build'} 11:55:04 INFO - [mozharness: 2016-08-16 18:55:04.899962Z] Running clobber step. 11:55:04 INFO - Running pre-action listener: _resource_record_pre_action 11:55:04 INFO - Running main action method: clobber 11:55:04 INFO - rmtree: /builds/slave/test/build 11:55:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:55:07 INFO - Running post-action listener: _resource_record_post_action 11:55:07 INFO - [mozharness: 2016-08-16 18:55:07.082004Z] Finished clobber step (success) 11:55:07 INFO - [mozharness: 2016-08-16 18:55:07.082204Z] Running read-buildbot-config step. 11:55:07 INFO - Running pre-action listener: _resource_record_pre_action 11:55:07 INFO - Running main action method: read_buildbot_config 11:55:07 INFO - Using buildbot properties: 11:55:07 INFO - { 11:55:07 INFO - "project": "", 11:55:07 INFO - "product": "firefox", 11:55:07 INFO - "script_repo_revision": "production", 11:55:07 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 11:55:07 INFO - "repository": "", 11:55:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 11:55:07 INFO - "buildid": "20160816091017", 11:55:07 INFO - "pgo_build": "False", 11:55:07 INFO - "basedir": "/builds/slave/test", 11:55:07 INFO - "buildnumber": 815, 11:55:07 INFO - "slavename": "t-yosemite-r7-0089", 11:55:07 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 11:55:07 INFO - "platform": "yosemite_r7", 11:55:07 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 11:55:07 INFO - "branch": "fx-team", 11:55:07 INFO - "repo_path": "integration/fx-team", 11:55:07 INFO - "revision": "af4cc6c04573fca495450725de702f7188dab6ea", 11:55:07 INFO - "stage_platform": "macosx64", 11:55:07 INFO - "builduid": "366b7a4e0c0a40c2b9e1440e546cdc97", 11:55:07 INFO - "slavebuilddir": "test" 11:55:07 INFO - } 11:55:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 11:55:07 INFO - Running post-action listener: _resource_record_post_action 11:55:07 INFO - [mozharness: 2016-08-16 18:55:07.086200Z] Finished read-buildbot-config step (success) 11:55:07 INFO - [mozharness: 2016-08-16 18:55:07.086334Z] Running download-and-extract step. 11:55:07 INFO - Running pre-action listener: _resource_record_pre_action 11:55:07 INFO - Running main action method: download_and_extract 11:55:07 INFO - mkdir: /builds/slave/test/build/tests 11:55:07 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')]} 11:55:07 INFO - trying https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 11:55:07 INFO - Downloading https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/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 11:55:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/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 11:55:08 INFO - Downloaded 1199 bytes. 11:55:08 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 11:55:08 INFO - Using the following test package requirements: 11:55:08 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:55:08 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:55:08 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 11:55:08 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:55:08 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 11:55:08 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:55:08 INFO - u'jsshell-mac.zip'], 11:55:08 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:55:08 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 11:55:08 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:55:08 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:55:08 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 11:55:08 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:55:08 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 11:55:08 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:55:08 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 11:55:08 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:55:08 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 11:55:08 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:55: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')]} 11:55:08 INFO - trying https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:55:08 INFO - Downloading https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/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 11:55:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/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 11:55:09 INFO - Downloaded 16332066 bytes. 11:55:09 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 11:55:16 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 11:55:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:16 INFO - trying https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:55:16 INFO - Downloading https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/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 11:55:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/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 11:55:17 INFO - Downloaded 16332066 bytes. 11:55:17 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 11:55:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:23 INFO - trying https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 11:55:23 INFO - Downloading https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/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 11:55:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/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 11:55:24 INFO - Downloaded 14413719 bytes. 11:55:24 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 11:55:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:25 INFO - trying https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:55:25 INFO - Downloading https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 11:55:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/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 11:55:28 INFO - Downloaded 111108485 bytes. 11:55:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:55:28 INFO - mkdir: /builds/slave/test/properties 11:55:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:55:28 INFO - Writing to file /builds/slave/test/properties/build_url 11:55:28 INFO - Contents: 11:55:28 INFO - build_url:https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:55:28 INFO - Running post-action listener: _resource_record_post_action 11:55:28 INFO - Running post-action listener: set_extra_try_arguments 11:55:28 INFO - [mozharness: 2016-08-16 18:55:28.742150Z] Finished download-and-extract step (success) 11:55:28 INFO - [mozharness: 2016-08-16 18:55:28.742296Z] Running populate-webroot step. 11:55:28 INFO - Running pre-action listener: _resource_record_pre_action 11:55:28 INFO - Running main action method: populate_webroot 11:55:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:55:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:55:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:55:28 INFO - '--tppagecycles', 11:55:28 INFO - '7'], 11:55:28 INFO - 'tests': ['tsvgm']}}, 11:55:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:55:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:55:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:55:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:55:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:55:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:55:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:28 INFO - 'talos_options': ['--disable-e10s'], 11:55:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:55:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:55:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:28 INFO - 'talos_options': ['--disable-e10s'], 11:55:28 INFO - 'tests': ['damp', 'tps']}, 11:55:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:28 INFO - 'tests': ['damp', 'tps']}, 11:55:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:55:28 INFO - 'tests': ['dromaeo_dom']}, 11:55:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:55:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:55:28 INFO - 'tests': ['basic_compositor_video']}, 11:55:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:55:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:55:28 INFO - 'tests': ['a11yr', 11:55:28 INFO - 'ts_paint', 11:55:28 INFO - 'tpaint', 11:55:28 INFO - 'sessionrestore', 11:55:28 INFO - 'sessionrestore_no_auto_restore', 11:55:28 INFO - 'tabpaint']}, 11:55:28 INFO - 'other-e10s': {'tests': ['a11yr', 11:55:28 INFO - 'ts_paint', 11:55:28 INFO - 'tpaint', 11:55:28 INFO - 'sessionrestore', 11:55:28 INFO - 'sessionrestore_no_auto_restore', 11:55:28 INFO - 'tabpaint']}, 11:55:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:55:28 INFO - 'ts_paint', 11:55:28 INFO - 'tpaint', 11:55:28 INFO - 'sessionrestore', 11:55:28 INFO - 'sessionrestore_no_auto_restore', 11:55:28 INFO - 'tabpaint']}, 11:55:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:55:28 INFO - 'ts_paint', 11:55:28 INFO - 'tpaint', 11:55:28 INFO - 'sessionrestore', 11:55:28 INFO - 'sessionrestore_no_auto_restore', 11:55:28 INFO - 'tabpaint']}, 11:55:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:55:28 INFO - 'tests': ['a11yr', 11:55:28 INFO - 'ts_paint', 11:55:28 INFO - 'tpaint', 11:55:28 INFO - 'sessionrestore', 11:55:28 INFO - 'sessionrestore_no_auto_restore', 11:55:28 INFO - 'tabpaint']}, 11:55:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:55:28 INFO - 'tests': ['a11yr', 11:55:28 INFO - 'ts_paint', 11:55:28 INFO - 'tpaint', 11:55:28 INFO - 'sessionrestore', 11:55:28 INFO - 'sessionrestore_no_auto_restore', 11:55:28 INFO - 'tabpaint']}, 11:55:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:55:28 INFO - 'tests': ['tsvgx', 11:55:28 INFO - 'tsvgr_opacity', 11:55:28 INFO - 'tart', 11:55:28 INFO - 'tscrollx', 11:55:28 INFO - 'cart']}, 11:55:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:55:28 INFO - 'tsvgr_opacity', 11:55:28 INFO - 'tart', 11:55:28 INFO - 'tscrollx', 11:55:28 INFO - 'cart']}, 11:55:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:28 INFO - 'talos_options': ['--disable-e10s'], 11:55:28 INFO - 'tests': ['tp5o']}, 11:55:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:28 INFO - 'tests': ['tp5o']}, 11:55:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:28 INFO - 'talos_options': ['--disable-e10s', 11:55:28 INFO - '--xperf_path', 11:55:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:55:28 INFO - 'tests': ['tp5n']}, 11:55:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:28 INFO - 'talos_options': ['--xperf_path', 11:55:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:55:28 INFO - 'tests': ['tp5n']}}, 11:55:28 INFO - 'talos.zip': {'path': '', 11:55:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:55:28 INFO - Running post-action listener: _resource_record_post_action 11:55:28 INFO - [mozharness: 2016-08-16 18:55:28.761492Z] Finished populate-webroot step (success) 11:55:28 INFO - [mozharness: 2016-08-16 18:55:28.761628Z] Running create-virtualenv step. 11:55:28 INFO - Running pre-action listener: _resource_record_pre_action 11:55:28 INFO - Running main action method: create_virtualenv 11:55:28 INFO - Creating virtualenv /builds/slave/test/build/venv 11:55:28 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 11:55:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:55:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:55:28 INFO - Using real prefix '/tools/python27' 11:55:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:55:29 INFO - Installing distribute.............................................................................................................................................................................................done. 11:55:32 INFO - Installing pip.................done. 11:55:32 INFO - Return code: 0 11:55:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:32 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 0x10794da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079e2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc88b5647a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078b1d30>, '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 0x107616db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078a9b20>, '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.yGFydPe1NU/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.S1fHOO2M4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 11:55:32 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 11:55:32 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 11:55:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yGFydPe1NU/Render', 11:55:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:32 INFO - 'HOME': '/Users/cltbld', 11:55:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:32 INFO - 'LOGNAME': 'cltbld', 11:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:32 INFO - 'MOZ_NO_REMOTE': '1', 11:55:32 INFO - 'NO_EM_RESTART': '1', 11:55:32 INFO - 'PAGER': '/bin/cat', 11:55:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:32 INFO - 'PWD': '/builds/slave/test', 11:55:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:32 INFO - 'SHELL': '/bin/bash', 11:55:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S1fHOO2M4l/Listeners', 11:55:32 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 11:55:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:32 INFO - 'USER': 'cltbld', 11:55:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:32 INFO - 'XPC_FLAGS': '0x0', 11:55:32 INFO - 'XPC_SERVICE_NAME': '0', 11:55:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:32 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 11:55:32 INFO - Cleaning up... 11:55:32 INFO - Return code: 0 11:55:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:32 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 0x10794da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079e2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc88b5647a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078b1d30>, '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 0x107616db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078a9b20>, '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.yGFydPe1NU/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.S1fHOO2M4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 11:55:32 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 11:55:32 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 11:55:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yGFydPe1NU/Render', 11:55:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:32 INFO - 'HOME': '/Users/cltbld', 11:55:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:32 INFO - 'LOGNAME': 'cltbld', 11:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:32 INFO - 'MOZ_NO_REMOTE': '1', 11:55:32 INFO - 'NO_EM_RESTART': '1', 11:55:32 INFO - 'PAGER': '/bin/cat', 11:55:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:32 INFO - 'PWD': '/builds/slave/test', 11:55:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:32 INFO - 'SHELL': '/bin/bash', 11:55:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S1fHOO2M4l/Listeners', 11:55:32 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 11:55:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:32 INFO - 'USER': 'cltbld', 11:55:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:32 INFO - 'XPC_FLAGS': '0x0', 11:55:32 INFO - 'XPC_SERVICE_NAME': '0', 11:55:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:32 INFO - Downloading/unpacking psutil>=3.1.1 11:55:32 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 11:55:32 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 11:55:32 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 11:55:32 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 11:55:32 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 11:55:32 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 11:55:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:55:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:55:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:55:36 INFO - Installing collected packages: psutil 11:55:36 INFO - Running setup.py install for psutil 11:55:36 INFO - building 'psutil._psutil_osx' extension 11:55:36 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 11:55:36 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 11:55:37 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 11:55:37 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 11:55:37 INFO - building 'psutil._psutil_posix' extension 11:55:37 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 11:55:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:55:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:55:37 INFO - ^ 11:55:37 INFO - 1 warning generated. 11:55:37 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 11:55:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:55:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:55:37 INFO - Successfully installed psutil 11:55:37 INFO - Cleaning up... 11:55:37 INFO - Return code: 0 11:55:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:55: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')]} 11:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55: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')]} 11:55:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10794da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079e2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc88b5647a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078b1d30>, '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 0x107616db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078a9b20>, '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.yGFydPe1NU/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.S1fHOO2M4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 11:55: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:55: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 mozsystemmonitor==0.3 11:55:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yGFydPe1NU/Render', 11:55:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:37 INFO - 'HOME': '/Users/cltbld', 11:55:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:37 INFO - 'LOGNAME': 'cltbld', 11:55:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:37 INFO - 'MOZ_NO_REMOTE': '1', 11:55:37 INFO - 'NO_EM_RESTART': '1', 11:55:37 INFO - 'PAGER': '/bin/cat', 11:55:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:37 INFO - 'PWD': '/builds/slave/test', 11:55:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:37 INFO - 'SHELL': '/bin/bash', 11:55:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S1fHOO2M4l/Listeners', 11:55:37 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 11:55:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:37 INFO - 'USER': 'cltbld', 11:55:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:37 INFO - 'XPC_FLAGS': '0x0', 11:55:37 INFO - 'XPC_SERVICE_NAME': '0', 11:55:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:55: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 11:55: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 11:55: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 11:55: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 11:55: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 11:55: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 11:55:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:55:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:55:40 INFO - Installing collected packages: mozsystemmonitor 11:55:40 INFO - Running setup.py install for mozsystemmonitor 11:55:40 INFO - Successfully installed mozsystemmonitor 11:55:40 INFO - Cleaning up... 11:55:40 INFO - Return code: 0 11:55:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:55:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:40 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 0x10794da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079e2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc88b5647a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078b1d30>, '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 0x107616db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078a9b20>, '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.yGFydPe1NU/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.S1fHOO2M4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 11:55:40 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 11:55:40 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 11:55:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yGFydPe1NU/Render', 11:55:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:40 INFO - 'HOME': '/Users/cltbld', 11:55:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:40 INFO - 'LOGNAME': 'cltbld', 11:55:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:40 INFO - 'MOZ_NO_REMOTE': '1', 11:55:40 INFO - 'NO_EM_RESTART': '1', 11:55:40 INFO - 'PAGER': '/bin/cat', 11:55:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:40 INFO - 'PWD': '/builds/slave/test', 11:55:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:40 INFO - 'SHELL': '/bin/bash', 11:55:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S1fHOO2M4l/Listeners', 11:55:40 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 11:55:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:40 INFO - 'USER': 'cltbld', 11:55:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:40 INFO - 'XPC_FLAGS': '0x0', 11:55:40 INFO - 'XPC_SERVICE_NAME': '0', 11:55:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:40 INFO - Downloading/unpacking jsonschema==2.5.1 11:55: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 11:55: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 11:55: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 11:55: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 11:55: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 11:55: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 11:55:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:55:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:55:43 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 11:55:43 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 11:55:43 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 11:55:43 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 11:55:43 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 11:55:43 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 11:55:43 INFO - Downloading functools32-3.2.3-2.tar.gz 11:55:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:55:43 INFO - warning: no files found matching '*.txt' 11:55:43 INFO - no previously-included directories found matching 'build' 11:55:43 INFO - no previously-included directories found matching 'dist' 11:55:43 INFO - no previously-included directories found matching '.git*' 11:55:43 INFO - Installing collected packages: jsonschema, functools32 11:55:43 INFO - Running setup.py install for functools32 11:55:43 INFO - warning: no files found matching '*.txt' 11:55:43 INFO - no previously-included directories found matching 'build' 11:55:43 INFO - no previously-included directories found matching 'dist' 11:55:43 INFO - no previously-included directories found matching '.git*' 11:55:43 INFO - Successfully installed jsonschema functools32 11:55:43 INFO - Cleaning up... 11:55:43 INFO - Return code: 0 11:55:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:43 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 0x10794da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079e2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc88b5647a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078b1d30>, '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 0x107616db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078a9b20>, '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.yGFydPe1NU/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.S1fHOO2M4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 11:55:43 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 11:55:43 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 11:55:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yGFydPe1NU/Render', 11:55:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:43 INFO - 'HOME': '/Users/cltbld', 11:55:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:43 INFO - 'LOGNAME': 'cltbld', 11:55:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:43 INFO - 'MOZ_NO_REMOTE': '1', 11:55:43 INFO - 'NO_EM_RESTART': '1', 11:55:43 INFO - 'PAGER': '/bin/cat', 11:55:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:43 INFO - 'PWD': '/builds/slave/test', 11:55:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:43 INFO - 'SHELL': '/bin/bash', 11:55:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S1fHOO2M4l/Listeners', 11:55:43 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 11:55:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:43 INFO - 'USER': 'cltbld', 11:55:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:43 INFO - 'XPC_FLAGS': '0x0', 11:55:43 INFO - 'XPC_SERVICE_NAME': '0', 11:55:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:55:44 INFO - Cleaning up... 11:55:44 INFO - Return code: 0 11:55:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:55:44 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')]} 11:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:44 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')]} 11:55:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:44 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 0x10794da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079e2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc88b5647a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078b1d30>, '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 0x107616db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078a9b20>, '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.yGFydPe1NU/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.S1fHOO2M4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 11:55:44 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 11:55:44 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 11:55:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yGFydPe1NU/Render', 11:55:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:44 INFO - 'HOME': '/Users/cltbld', 11:55:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:44 INFO - 'LOGNAME': 'cltbld', 11:55:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:44 INFO - 'MOZ_NO_REMOTE': '1', 11:55:44 INFO - 'NO_EM_RESTART': '1', 11:55:44 INFO - 'PAGER': '/bin/cat', 11:55:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:44 INFO - 'PWD': '/builds/slave/test', 11:55:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:44 INFO - 'SHELL': '/bin/bash', 11:55:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S1fHOO2M4l/Listeners', 11:55:44 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 11:55:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:44 INFO - 'USER': 'cltbld', 11:55:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:44 INFO - 'XPC_FLAGS': '0x0', 11:55:44 INFO - 'XPC_SERVICE_NAME': '0', 11:55:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:44 INFO - Downloading/unpacking blobuploader==1.2.4 11:55:44 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 11:55:44 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 11:55:44 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 11:55:44 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 11:55:44 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 11:55:44 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 11:55:46 INFO - Downloading blobuploader-1.2.4.tar.gz 11:55:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:55:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:55:46 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 11:55:46 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 11:55:46 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 11:55:46 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 11:55:46 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 11:55:46 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 11:55:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:55:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:48 INFO - Downloading docopt-0.6.1.tar.gz 11:55:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:55:48 INFO - Installing collected packages: blobuploader, requests, docopt 11:55:48 INFO - Running setup.py install for blobuploader 11:55:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:55:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:55:48 INFO - Running setup.py install for requests 11:55:48 INFO - Running setup.py install for docopt 11:55:48 INFO - Successfully installed blobuploader requests docopt 11:55:48 INFO - Cleaning up... 11:55:49 INFO - Return code: 0 11:55:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55:49 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')]} 11:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:49 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')]} 11:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:49 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 0x10794da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079e2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc88b5647a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078b1d30>, '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 0x107616db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078a9b20>, '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.yGFydPe1NU/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.S1fHOO2M4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 11:55:49 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 11:55:49 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 11:55:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yGFydPe1NU/Render', 11:55:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:49 INFO - 'HOME': '/Users/cltbld', 11:55:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:49 INFO - 'LOGNAME': 'cltbld', 11:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:49 INFO - 'MOZ_NO_REMOTE': '1', 11:55:49 INFO - 'NO_EM_RESTART': '1', 11:55:49 INFO - 'PAGER': '/bin/cat', 11:55:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:49 INFO - 'PWD': '/builds/slave/test', 11:55:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:49 INFO - 'SHELL': '/bin/bash', 11:55:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S1fHOO2M4l/Listeners', 11:55:49 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 11:55:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:49 INFO - 'USER': 'cltbld', 11:55:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:49 INFO - 'XPC_FLAGS': '0x0', 11:55:49 INFO - 'XPC_SERVICE_NAME': '0', 11:55:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:55:49 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-B9na7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:55:49 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-3UdiV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:55:49 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-IAPSls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:55:49 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-Yxyma4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:55:49 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-a7vx3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:55:49 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-tjIoU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:55:49 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-BYvfMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:55:50 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-MxX0JH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:55:50 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-f0eLs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:55:50 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-U5Jdoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:55:50 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-40QD_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:55:50 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-UfDN0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:55:50 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-qG5NEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:55:50 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-jiFW43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:50 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-eiomSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:55:50 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-5GGe8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:55:51 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-mudR6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:55:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:55:51 INFO - Running setup.py install for manifestparser 11:55:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:55:51 INFO - Running setup.py install for mozcrash 11:55:51 INFO - Running setup.py install for mozdebug 11:55:51 INFO - Running setup.py install for mozdevice 11:55:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:55:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:55:51 INFO - Running setup.py install for mozfile 11:55:51 INFO - Running setup.py install for mozhttpd 11:55:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:55:52 INFO - Running setup.py install for mozinfo 11:55:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:55:52 INFO - Running setup.py install for mozInstall 11:55:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:55:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:55:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:55:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:55:52 INFO - Running setup.py install for mozleak 11:55:52 INFO - Running setup.py install for mozlog 11:55:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:55:52 INFO - Running setup.py install for moznetwork 11:55:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:55:52 INFO - Running setup.py install for mozprocess 11:55:52 INFO - Running setup.py install for mozprofile 11:55:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:55:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:55:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:55:53 INFO - Running setup.py install for mozrunner 11:55:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:55:53 INFO - Running setup.py install for mozscreenshot 11:55:53 INFO - Running setup.py install for moztest 11:55:53 INFO - Running setup.py install for mozversion 11:55:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:55:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:55:53 INFO - Cleaning up... 11:55:53 INFO - Return code: 0 11:55:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55:53 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')]} 11:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:53 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')]} 11:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:53 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 0x10794da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079e2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc88b5647a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078b1d30>, '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 0x107616db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078a9b20>, '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.yGFydPe1NU/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.S1fHOO2M4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 11:55:53 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 11:55:53 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 11:55:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yGFydPe1NU/Render', 11:55:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:53 INFO - 'HOME': '/Users/cltbld', 11:55:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:53 INFO - 'LOGNAME': 'cltbld', 11:55:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:53 INFO - 'MOZ_NO_REMOTE': '1', 11:55:53 INFO - 'NO_EM_RESTART': '1', 11:55:53 INFO - 'PAGER': '/bin/cat', 11:55:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:53 INFO - 'PWD': '/builds/slave/test', 11:55:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:53 INFO - 'SHELL': '/bin/bash', 11:55:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S1fHOO2M4l/Listeners', 11:55:53 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 11:55:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:53 INFO - 'USER': 'cltbld', 11:55:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:53 INFO - 'XPC_FLAGS': '0x0', 11:55:53 INFO - 'XPC_SERVICE_NAME': '0', 11:55:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:55:53 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-pzWlb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:55:54 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)) 11:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:55:54 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-lF6DLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:55:54 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)) 11:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:55:54 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-FoWBBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:55:54 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)) 11:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:55:54 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-wr2V_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:55:54 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)) 11:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:55:54 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-FvD6On-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:55:54 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)) 11:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:55:54 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-MDXSSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:55:54 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)) 11:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:55:54 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-4mKuKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:55:54 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)) 11:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:55:54 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-ieFmB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:55:54 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)) 11:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:55:54 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-LrEuXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:55:54 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)) 11:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:55:54 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-u_p16P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:55:55 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)) 11:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:55:55 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-zzT2dN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:55:55 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)) 11:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:55:55 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-9Yz0en-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:55:55 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)) 11:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:55:55 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-f0uyoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:55:55 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)) 11:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:55:55 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-mQKll_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:55:55 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)) 11:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:55 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-B4PU6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:55 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)) 11:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:55:55 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-7ot3BE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:55:55 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)) 11:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:55:55 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-Hu8_2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:55:55 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)) 11:55:55 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)) 11:55:55 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)) 11:55:55 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)) 11:55:55 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)) 11:55:55 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)) 11:55:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:58 INFO - Downloading blessings-1.6.tar.gz 11:55:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:55:58 INFO - Installing collected packages: blessings 11:55:58 INFO - Running setup.py install for blessings 11:55:58 INFO - Successfully installed blessings 11:55:58 INFO - Cleaning up... 11:55:58 INFO - Return code: 0 11:55:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:55:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:55:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:55:58 INFO - Reading from file tmpfile_stdout 11:55:58 INFO - Current package versions: 11:55:58 INFO - blessings == 1.6 11:55:58 INFO - blobuploader == 1.2.4 11:55:58 INFO - docopt == 0.6.1 11:55:58 INFO - functools32 == 3.2.3-2 11:55:58 INFO - jsonschema == 2.5.1 11:55:58 INFO - manifestparser == 1.1 11:55:58 INFO - mozInstall == 1.12 11:55:58 INFO - mozcrash == 0.17 11:55:58 INFO - mozdebug == 0.1 11:55:58 INFO - mozdevice == 0.48 11:55:58 INFO - mozfile == 1.2 11:55:58 INFO - mozhttpd == 0.7 11:55:58 INFO - mozinfo == 0.9 11:55:58 INFO - mozleak == 0.1 11:55:58 INFO - mozlog == 3.3 11:55:58 INFO - moznetwork == 0.27 11:55:58 INFO - mozprocess == 0.23 11:55:58 INFO - mozprofile == 0.28 11:55:58 INFO - mozrunner == 6.12 11:55:58 INFO - mozscreenshot == 0.1 11:55:58 INFO - mozsystemmonitor == 0.3 11:55:58 INFO - moztest == 0.7 11:55:58 INFO - mozversion == 1.4 11:55:58 INFO - psutil == 3.1.1 11:55:58 INFO - requests == 1.2.3 11:55:58 INFO - wsgiref == 0.1.2 11:55:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:58 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 0x10794da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079e2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc88b5647a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078b1d30>, '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 0x107616db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078a9b20>, '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.yGFydPe1NU/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.S1fHOO2M4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 11:55:58 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 11:55:58 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 11:55:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yGFydPe1NU/Render', 11:55:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:58 INFO - 'HOME': '/Users/cltbld', 11:55:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:58 INFO - 'LOGNAME': 'cltbld', 11:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:58 INFO - 'MOZ_NO_REMOTE': '1', 11:55:58 INFO - 'NO_EM_RESTART': '1', 11:55:58 INFO - 'PAGER': '/bin/cat', 11:55:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:58 INFO - 'PWD': '/builds/slave/test', 11:55:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:58 INFO - 'SHELL': '/bin/bash', 11:55:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S1fHOO2M4l/Listeners', 11:55:58 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 11:55:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:58 INFO - 'USER': 'cltbld', 11:55:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:58 INFO - 'XPC_FLAGS': '0x0', 11:55:58 INFO - 'XPC_SERVICE_NAME': '0', 11:55:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:59 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)) 11:55:59 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)) 11:55:59 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)) 11:55:59 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)) 11:55:59 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)) 11:55:59 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)) 11:55:59 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)) 11:55:59 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)) 11:55:59 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)) 11:55:59 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)) 11:55:59 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)) 11:55:59 INFO - Cleaning up... 11:55:59 INFO - Return code: 0 11:55:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:55:59 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')]} 11:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:59 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')]} 11:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:59 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 0x10794da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079e2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc88b5647a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078b1d30>, '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 0x107616db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078a9b20>, '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.yGFydPe1NU/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.S1fHOO2M4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 11:55:59 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 11:55:59 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 11:55:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yGFydPe1NU/Render', 11:55:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:59 INFO - 'HOME': '/Users/cltbld', 11:55:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:59 INFO - 'LOGNAME': 'cltbld', 11:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:59 INFO - 'MOZ_NO_REMOTE': '1', 11:55:59 INFO - 'NO_EM_RESTART': '1', 11:55:59 INFO - 'PAGER': '/bin/cat', 11:55:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:59 INFO - 'PWD': '/builds/slave/test', 11:55:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:59 INFO - 'SHELL': '/bin/bash', 11:55:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S1fHOO2M4l/Listeners', 11:55:59 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 11:55:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:59 INFO - 'USER': 'cltbld', 11:55:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:59 INFO - 'XPC_FLAGS': '0x0', 11:55:59 INFO - 'XPC_SERVICE_NAME': '0', 11:55:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:55:59 INFO - Cleaning up... 11:55:59 INFO - Return code: 0 11:55:59 INFO - Running post-action listener: _resource_record_post_action 11:55:59 INFO - Running post-action listener: _start_resource_monitoring 11:55:59 INFO - Starting resource monitoring. 11:55:59 INFO - [mozharness: 2016-08-16 18:55:59.484515Z] Finished create-virtualenv step (success) 11:55:59 INFO - [mozharness: 2016-08-16 18:55:59.485568Z] Running install step. 11:55:59 INFO - Running pre-action listener: _resource_record_pre_action 11:55:59 INFO - Running main action method: install 11:55:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:55:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:55:59 INFO - Reading from file tmpfile_stdout 11:55:59 INFO - Detecting whether we're running mozinstall >=1.0... 11:55:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:55:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:55:59 INFO - Reading from file tmpfile_stdout 11:55:59 INFO - Output received: 11:55:59 INFO - Usage: mozinstall [options] installer 11:55:59 INFO - Options: 11:55:59 INFO - -h, --help show this help message and exit 11:55:59 INFO - -d DEST, --destination=DEST 11:55:59 INFO - Directory to install application into. [default: 11:55:59 INFO - "/builds/slave/test"] 11:55:59 INFO - --app=APP Application being installed. [default: firefox] 11:55:59 INFO - mkdir: /builds/slave/test/build/application 11:55:59 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'] 11:55:59 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 11:56:34 INFO - Reading from file tmpfile_stdout 11:56:34 INFO - Output received: 11:56:34 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:56:34 INFO - Running post-action listener: _resource_record_post_action 11:56:34 INFO - [mozharness: 2016-08-16 18:56:34.444415Z] Finished install step (success) 11:56:34 INFO - [mozharness: 2016-08-16 18:56:34.444567Z] Running run-tests step. 11:56:34 INFO - Running pre-action listener: _resource_record_pre_action 11:56:34 INFO - Running main action method: run_tests 11:56:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:56:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:56:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:56:34 INFO - 2016-08-16 11:56:34.459 screenresolution[1631:7488] starting screenresolution argv=screenresolution get 11:56:34 INFO - 2016-08-16 11:56:34.461 screenresolution[1631:7488] Display 0: 1600x1200x32@60 11:56:34 INFO - 2016-08-16 11:56:34.467 screenresolution[1632:7490] starting screenresolution argv=screenresolution list 11:56:34 INFO - Available Modes on Display 0 11:56:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:56:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:56:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:56:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:56:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:56:34 INFO - Intel Iris: 11:56:34 INFO - Chipset Model: Intel Iris 11:56:34 INFO - Type: GPU 11:56:34 INFO - Bus: Built-In 11:56:34 INFO - VRAM (Dynamic, Max): 1536 MB 11:56:34 INFO - Vendor: Intel (0x8086) 11:56:34 INFO - Device ID: 0x0a2e 11:56:34 INFO - Revision ID: 0x0009 11:56:34 INFO - Displays: 11:56:34 INFO - Display: 11:56:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:56:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:56:34 INFO - Display Serial Number: 1600x1200 60 11:56:34 INFO - Main Display: Yes 11:56:34 INFO - Mirror: Off 11:56:34 INFO - Online: Yes 11:56:34 INFO - Rotation: Supported 11:56:34 INFO - Return code: 0 11:56:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:56:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:56:34 INFO - Python 2.7.3 11:56:34 INFO - Return code: 0 11:56:34 INFO - grabbing minidump binary from tooltool 11:56:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:34 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 0x1078b1d30>, '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 0x107616db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078a9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:56:34 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 11:56:34 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 11:56:34 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 11:56:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:56:34 INFO - Return code: 0 11:56:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:56:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:56:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:56:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:56:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:56:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0089', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:56:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0089 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:56:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yGFydPe1NU/Render', 11:56:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:56:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:56:34 INFO - 'HOME': '/Users/cltbld', 11:56:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:56:34 INFO - 'LOGNAME': 'cltbld', 11:56:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:56:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:56:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:34 INFO - 'MOZ_NO_REMOTE': '1', 11:56:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:56:34 INFO - 'NO_EM_RESTART': '1', 11:56:34 INFO - 'PAGER': '/bin/cat', 11:56:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:56:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:34 INFO - 'PWD': '/builds/slave/test', 11:56:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:56:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:56:34 INFO - 'SHELL': '/bin/bash', 11:56:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S1fHOO2M4l/Listeners', 11:56:34 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 11:56:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:56:34 INFO - 'USER': 'cltbld', 11:56:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:56:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:56:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:34 INFO - 'XPC_FLAGS': '0x0', 11:56:34 INFO - 'XPC_SERVICE_NAME': '0', 11:56:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:56:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0089', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:56:35 INFO - mozversion application_buildid: 20160816091017 11:56:35 INFO - mozversion application_changeset: af4cc6c04573fca495450725de702f7188dab6ea 11:56:35 INFO - mozversion application_display_name: Nightly 11:56:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:56:35 INFO - mozversion application_name: Firefox 11:56:35 INFO - mozversion application_remotingname: firefox 11:56:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:56:35 INFO - mozversion application_vendor: Mozilla 11:56:35 INFO - mozversion application_version: 51.0a1 11:56:35 INFO - mozversion platform_buildid: 20160816091017 11:56:35 INFO - mozversion platform_changeset: af4cc6c04573fca495450725de702f7188dab6ea 11:56:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:56:35 INFO - mozversion platform_version: 51.0a1 11:56:35 INFO - using testdate: 1471373795 11:56:35 INFO - actual date: 1471373795 11:56:35 INFO - starting webserver on 'localhost:49266' 11:56:35 INFO - SUITE-START | Running 2 tests 11:56:35 INFO - TEST-START | dromaeo_css 11:56:35 INFO - operating with platform_type : mac_ 11:56:35 INFO - Initialising browser for dromaeo_css test... 11:56:35 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/tmpLDZvZG/profile http://localhost:49266/getInfo.html) 11:56:37 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 11:56:37 INFO - PROCESS | 1642 | colorDepth:24 11:56:37 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 11:56:37 INFO - PROCESS | 1642 | __metrics 11:56:37 INFO - PROCESS | 1642 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:56:37 INFO - PROCESS | 1642 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:56:38 INFO - TEST-INFO | 1642: exit 0 11:56:38 INFO - Browser initialized. 11:56:38 INFO - Running cycle 1/1 for dromaeo_css test... 11:56:38 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/tmpLDZvZG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:56:50 INFO - PROCESS | 1644 | RSS: Main: 228220928 11:56:50 INFO - PROCESS | 1644 | 11:57:41 INFO - PROCESS | 1644 | 1471373861573 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] 11:59:53 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 11:59:54 INFO - PROCESS | 1644 | RSS: Main: 378560512 11:59:54 INFO - PROCESS | 1644 | 12:02:57 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 12:02:58 INFO - PROCESS | 1644 | RSS: Main: 370810880 12:02:58 INFO - PROCESS | 1644 | 12:06:00 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 12:06:01 INFO - PROCESS | 1644 | RSS: Main: 346697728 12:06:01 INFO - PROCESS | 1644 | 12:09:03 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 12:09:04 INFO - PROCESS | 1644 | RSS: Main: 334987264 12:09:04 INFO - PROCESS | 1644 | 12:12:07 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 12:12:08 INFO - PROCESS | 1644 | RSS: Main: 327774208 12:12:08 INFO - PROCESS | 1644 | 12:15:11 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 12:15:12 INFO - PROCESS | 1644 | RSS: Main: 410951680 12:15:12 INFO - PROCESS | 1644 | 12:15:12 INFO - PROCESS | 1644 | __start_tp_report 12:15:12 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 12:15:12 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 12:15:12 INFO - PROCESS | 1644 | |i|pagename|runs| 12:15:12 INFO - PROCESS | 1644 | |0;dojo.html;3388.69501744843;3416.436288012478;3427.400204964131;3442.7590068695204;3456.3951308521005;5691.516221121199;5712.22884910537;5796.333421656505;5867.677277749722;5879.265091863517;5840.707964601764;5866.413358664142;5937.940620593793;5958.940410595893;5978.6412815231115;4406.845760398387;5258.158694608864;5283.867903302429;5292;5403.351597808269;5409.107497262947;5409.350877894658;5414.133738601825;5423.457654234585;5447.645903016311;5210.635255532115;5258.474152584749;5264.815731449381;5284.603654725892;5337.386200586904;5226.451222621608;5243.973780131113;5270.209468579706;5298.708571028592;5304.681719096867;5194.792208311701;5214.765335559909;5239.449857764956;5298.417174110845;5298.682079075229;5734.827955161351;5873.1190321451695;5939.168516407706;5964.791232306892;5981.132735753335;6097.664628445434;6105.114758360013;6108.450239478469;6115.240341084353;6131.87736245277;6128.846778830521;6162.876742465126;6175.228096487939;6213.502919766408;6221.440070393641;5742;5938.940610593882;5939.3763654816485;5943.70281485924;5958.612690175125;6160.691965401712;6243.906341404882;6295.496360291166;6306.400891915261;6388.105665206875;6163.106349579376;6176.258848938156;6179.5056395488255;6183;6183.628982261079;6140.258857967725;6169.722362493699;6201.255849298113;6201.937980620226;6231.283402408781;6107.206063211843;6122.204113465221;6129.754809807647;6130.153553065376;6144.402455361638;6123.221615589998;6153.2000839890525;6164.167837341902;6168.938310616836;6171.105189747551;4961.578265847444;4974.7263900485095;4989.326440930428;4989.60083193351;5014.52362025607;4398.3842262083335;4414.536473670282;4444.200043992112;4501;4516.322551617283;5826.883462330729;5847.239858818326;5903.085021821625;5934.258217722785;5940.287165540163;6242.719077641517;6260.874782504416;6270.090836828635;6271.843203919939;6275.152854364603;5672.886542269214;5724.942750572524;5729;5890.646561206341;5902.557308201816;5352.652077614943;5450.127979523258;5454.236406903036;5481.698506582096;5484.698341591171;6390.808275751735;6407.711652975628;6412.679366031586;6413.743450261937;6417.165768450258;6190.102435146969;6236.532260080603;6245.406686364788;6254.155688981929;6261.906071409024;6213.2233470816145;6282.623042617458;6319.652419116993;6321.178246828067;6363.172787537591;6215.9378406217165;6220.440160385587;6223.502119830312;6224.968875155776;6240.843978900564;6235.033569796688;6241.656708881055;6264.59280146789;6271.31015588294;6286.559940804283;4634.814607415666;5205.696913423084;6101.701646049799;6102.307478454422;6179.84550386244;4939.160342741814;5437.211604317431;6205.906911396423;6224.564280500322;6232.657203853832;6106.6946652668075;6110.725017374318;6123.755049797958;6132.448079672851;6135.6932153393045;6124.969375153096;6136.6011209271255;6149.046897730859;6171.197744293213;6222.968885155546;5952.107183922446;6006.279246490449;6041.942660034564;6045.244344456943;6084.361142080018 12:15:12 INFO - PROCESS | 1644 | |1;ext.html;499.0667451865013;507.40633458853137;511.09791218499333;547.3759913698384;558.0624550754732;30721;40871.18257634845;42429.78785106074;42697.14605707884;44969;43023;43508.56491435085;43545.2100268971;43577.47478838242;43721.562784372145;8973.46159230445;9746.70759877203;9947;9954.253430992669;9967.302288839785;8878.644854205857;9106.998230194673;9119.954400227989;9121.817563648723;12069.577564785235;12300;12351.444185011696;12353.567625133122;12364.690882727959;12379.25724456531;12163.939180304085;12184.939075304655;12187.695307617336;12196.634100976986;12280.201786883825;9300.813983720287;11105.944470277678;11674.94925456713;12054;12077.818832717516;40538;40878.59121408778;40911.7954410226;40955;40995.590044099474;3485.442329227337;3488.5639295088113;3675.3568125577917;3684.1158122050515;3904.902377440558;30678;30954.38091238185;31543.053708388787;31549.684503154906;32079.51880721791;3200.2319443333663;3238.9028329150165;3249.7562682798884;3325.467925131967;3336.6162891267572;453314;456361;457152.9999999967;457386;460125;50056.24915626268;60219.69890150521;60337.39662603405;60497.69751151216;60510.39489605136;34389.65610343915;35013.649863501545;35242.82378588091;64064.71870562563;64322;16540.83459165417;16707.91646041762;16711.080890551137;16711.498655040366;16728.41450549225;12737.617871463872;12837;12845.9723222142;12857.614271571867;12858.0999330046;14111.929440352733;16743.07913064793;16788.412405565745;17035.592881423763;18651.533711657317;6701.932980670228;7565.659545320474;8025.122818229053;8066.556339401389;8108.878366824502;786.7639708087665;895.2524641924066;946.6828612414918;1024.774549599087;1059.3220338983058;24132.63801042986;29653.703462965095;30257;30493.23766905845;30860.0741977741;924.7225832250298;1065.6376831877199;1088.0968795899385;1100.2298391126244;1123.6685177872548;15153.318100685496;15617.062976221463;15832.68334633301;15872;16141.950773199704;494533;634006.659933404;640295;640647;640817.4896388928;58186.418135818945;58488;58501;58532.536686583175;58656.41343586509;1339.1028011232497;1369.3427154965473;1375.931203439844;1379.5654368873772;1381.7512847687512;28305.292367690974;29221.415571688023;29736.553951690308;30290.99481003088;30756;50946;51117.74441127771;51296.74351628218;51311.973760525325;51537.484625153265;541977;542032;543623;543885;544845;23557;26332.8683356582;26483.337916552242;26805.731942680322;27086.864565677046;40181.397279040255;47163.292550611084;47535.286970694775;48186.03627927492;48823;38346;38778.80610597042;39369.71660242864;39685;39850.60522881685;38488.80755596204;38578.6142138575;38811.671299722104;39564.80217599009;39805.60680376173;29617.851910740308;33216.335673286885;37731.62268377281;38717.6128238714;39611.80194099011;32784.83607581947;32823.83588082044;33440;34530;34767.9569612912;21876.01557929929;22570.77429225687;22616.66075008909;25078.37304067413;25736.356591085372 12:15:12 INFO - PROCESS | 1644 | |2;jquery.html;319.6819164930893;350.7912791888825;367.9632036796322;373.3783250887272;405.53971242639614;15376.615584610376;15580.922095389522;15865;17758.200880960354;18925.432237032877;20393.49016274594;20562.48593785156;20572.588548229065;20689.586208275825;20814.89592552035;5591.133374326976;6082.239720034996;6117.174181485487;6121.846953826145;6134.110553969694;5865.618734782247;5914.585978981473;5988.700564971734;6093;6097.115918191882;6017.037274036155;6025.728842202089;6031.215941927543;6036.305824830157;6036.3661815509395;5882.735276912549;5965.105234214859;6005.789797357093;6020.6688632125215;6059.848503787396;5229.843104706865;5230.424653288135;5230.97384513075;5233.738313084331;5241.9737901310245;24468.632970505456;24596.631050534255;24708.752912471005;24773;25102;2361.9527609447714;2731.4537092581563;3137.592113025315;3150.2754366495606;3228.8224147671867;6738.865222695567;6858.965705171492;7307.4884758066955;14830.442803505584;15512.301946412439;1799.9190036448392;1905.3997990632906;1932.8163824436656;1946.1047917957756;1993.272455553727;111596;118753;121103.39448302702;122443;123357;10298.330608510423;10379.481025948673;10445.634402795866;10658.626948056935;10890.346579205274;11814.46834892432;12147.817782733266;12474.376281186085;12804.295763733084;12812.679683008;6736.932630673728;6971.268016858156;8098.554579498066;8170.428070035159;8385.6226469809;8316.293115085286;8324.958375208085;8328.417010809186;8462.36532260083;8476.194761497647;6321;6458.870822583616;6467.773627923;6468.223813142453;6587.571807832475;1828.1864570266105;1877.1740434208905;1887.8112188781013;1888.518427800902;1916.1281616864294;931.2736065868634;963.2438535749403;1009.6819501856892;1012.2863381316155;1016.501914062119;20227;20634.27780027692;20870;21434.57130857374;21748.565028699337;892.6743785478559;926.7396340976267;927.7634203278121;928.0672923711761;966.183574879226;10584.629537966135;10940.671779846618;10965.83551246716;11086.334819910831;11090.5563777448;522824;525641;526753;536999;660596;144252;147016;148962.25518872554;156645.43354566535;159306;967.9903200968041;1000.9049140331657;1013.6857574151888;1015.669907280137;1030.304544432505;17097.658046839242;18732.906335468237;18820;18842;18904.52738681544;52183;59953.10070348861;60171.39828601833;60445;60861.69569152303;78341.60829195818;87065.56467217623;87549;87790.56104719435;87876;7912.604369781603;8033.277005069572;8127.471714338785;8184.672613095648;8243.670253189804;11365.659030229106;12760.361981901053;12791.232526048467;13035.15271507349;13145.60563183106;11032.669019929415;11038;11074.058705010164;11111.222214445235;11190.32858028521;9202.53987300619;10761.246712730033;10935.781284374109;11118.833217501582;11246.66260012201;9112.633105034298;10843.415501551324;10912.96326848948;11254.155938304497;11436.771264574829;7789.337906277803;8019.278264956182;8078.959605201936;8106.8783968241705;8157.306628936607;8122.918770812453;9305.906940930505;10774;11014.946505668466;11190.048845848194 12:15:12 INFO - PROCESS | 1644 | |3;mootools.html;1383.3913078245578;1533.432629926927;1559.4775750123708;1716.2963185094106;1862.0038279520459;7699.1146018207855;8488.278496327812;8689.26141277992;8701.303895688337;8826.955865220665;8595.527246001468;8673.60968756406;8674.219320261176;8686.913130868705;8699.782505437368;2313.780190881868;2338.707661542307;2342.3090188394463;2347.1315613223132;2351.870647114408;2295.988520057397;2342.96485552716;2358.9528209435803;2360.8111351091957;2362.728286247078;2314.733805612351;2324.2213858357386;2335.8948847301913;2354.811615070799;2364.302530753423;2298.425393651587;2321.442853715113;2332.4635333873134;2336.544373847109;2340.7659234076627;1964.2437661500426;2328.080408238753;2328.8136949044037;2329.5340931813535;2330.93007209784;8597;8605.354598405145;8667.089955554638;8727.258183054448;8746.125387461267;5046.697198168085;5248.973755131238;5249.790008399659;5254.65844720092;5286.550643195333;3316.5369669141455;3335.5830521184853;3363.697267245935;3379.239671074013;3517.736169787276;1068.759529105945;1077.2620754783;1082.3343643659093;1087.1140020882956;1103.1395511501041;11402.315861048364;11462.369569673665;11538.999999999916;11553.30680159193;11580.594679186188;3686.594474607791;4380.78096095194;4601.861944141681;4617.12274667812;4623.86128416148;8996.460212387277;9004.36969412135;9010.189082982562;9010.96373917008;9015.594298256594;5160.535551800356;5201.713905735145;5209.661372010807;5216.217567364925;5220.347456567929;4232.91534169321;4275.679324050647;4398.450193725785;4557.225271703752;4869.805207791649;3706.1105334720014;3783.7729736215915;3816.580176180618;3817.5418949725654;3823.636754508317;1161.96514104577;1165.4289398194992;1180.7756526260155;1181.757739663367;1186.4186548591128;853.4026181672854;865.7792262972902;898.7303808857316;905.9365844390829;956.0630582029511;5674.319081710221;5737.713114344266;5995.670238136944;6030.487408570233;6092.1775560299675;917.3991385033027;967.9128878400978;968.9370190937567;975.453745902297;1026.1431704526653;3614.8734794282072;3797.1646237827636;4090.3046482098116;4102.220578090153;4259.574042595716;10769.676909692722;10816.729581760519;10968.506417211245;10971.890281097247;10980.560777568968;10896.18278629106;10901.182411319025;10905.34567925927;10909.781804364027;10922.945385273022;8096.51420914747;8332.916670833336;8345.332373410112;8349.540775257297;8349.791255218668;5625.831225063254;5915.408459154222;6046.486048685735;6081.513478921587;6109.419605137505;9519.333646644945;9918.851217231891;10149.949250253701;10172.440515771408;10180.338278012201;9253.491057991874;10002.24983126283;10184.541695623862;10203.84694229602;10212.795744084928;6284.183056202664;6937.618430986344;7169.211386747558;7176.282371762782;7196.280371962762;7582.658780354787;8072.354211662935;8171.305439037511;8173.305269052197;8176.591170441573;7327.157376901511;7436.628168591441;7486.962565187139;7554.584497852671;7560.9621951889885;6179.969100154471;7247.9637601811655;7269.45479089081;7290.9635451822405;7330.596817174894;6914.377706006484;6916.204636466669;6939.063226464363;6946.201186863374;7042.471814613822;4864.781084851119;4866.853994380174;4924.384451943507;4975.577075948585;5047.419546752024;4850.417949846041;4922.926156107733;4927.655064145475;5027.4218464877;5063.880591099852 12:15:12 INFO - PROCESS | 1644 | |4;prototype.html;279.92508766337266;295.70724982267564;309.4769838972138;311.3710305183529;315.99842000789994;4618.237990731525;4687.929681054783;5277.762500687469;5311.468853114687;5332.680039197651;4206.443615862127;4852.175130227861;5120.8975820483665;5191.402988656306;5357.330333708286;4015.819288132041;4061.87814365568;4069.450624165744;4069.9621596492852;4099.61053699898;3265.9836700816463;3325.5177999190105;3913.8043097845134;4056.1482088761395;4076.30702780528;3529.852797840712;3901.761537923531;3938.113924367023;4029.697772667047;4044.3933409988445;4053.655439287664;4061.472008638858;4063.045184381668;4063.598058669754;4071.2671719090554;2921.3865088331477;3085.938281234363;3203.855826487814;3426.588809342895;3575.535180426528;5236.690827293177;5237;5239;5246.501582349671;5301.549368303698;4053.209624123297;4122.515894278057;4631.930521042187;4636.327732478771;4658.883527911796;4887.7311747853855;5602.887942241173;5627.539063475932;5664.348599910981;5668.404817494145;3446.052335607703;3827.2728181645675;3844.5770965193806;3849.711271654637;3882.9223415531815;5752.791606338854;5784.334801497839;5847.210626565402;5895.201963401204;5896.38088000758;3423.7089847363254;3579.552555930509;3748.7188460865545;3759.9660093474513;3903.941440878389;3380;3940.3503865438483;3958.188571342868;3968.8412463501136;3975.224831157954;4369.868903932887;4520.95479045212;4581.65637577183;4608.746518941491;4609.539046095364;4863.732494712754;5056.308894506957;5578.386377498472;5646.435356464321;5712.714364281769;1156.727599640389;1185.7569198314325;1277.2208952538945;1320.8216890719823;1325.9005574581945;748.7865958201886;754.3135746470795;814.3363159025494;884.730157302029;900.7252787899622;5181.559567436735;5209.661372010807;5212.817551385683;5272.6309158358545;5281.471852814688;5443.346798384219;5505.009098362253;5768.625039372428;5776.942230577641;5799.623024503394;4388.780560971939;4572.702774319725;4948.257761335828;5247.376311844078;5279.973600132052;2696.501147287758;2745.6156138140677;2770.5013097642213;2952.852357382122;3018.7321325043094;5147.047796157723;5622.184783206412;5886.499647529922;6104.26748790148;6130.908036379458;5301.814436494704;5606.664034899229;5649.265595472562;5961;5966.49284810796;5541.972290138604;5583.497485226268;6038.909416358846;6050.304215015241;6083.969580152071;5044.823431180038;5061.974690126526;5756.7409466574945;5809.680467574324;5825.533957283492;5252.923150754163;5622.971885140548;5704.062407860039;5771.8557036074435;5787.797427090031;5250.448702886142;5819.955131183787;6052.757889684363;6158.261008678808;6221.222347206599;3688.9117710274995;3778.282126395976;3817.4655548222718;4014.1971605678395;4033.4756481657196;5767.279090113736;5768.94231057684;5770.6249093808765;5773.336066352255;5952.404759524013;5518.2826232591115;5527.364353099284;5712.285964254468;5734.709690319812;5737.91393129095;4559.635229181591;4722.858314250578;5006.6495345325475;5636.464535869086;5686.91948529778;5256.448072952285;5489.902019596177;5519.144532597294;5530.866172434561;5542.418046105101;4521.615662668579;5382.0043291991105;5524.281843360337;5573.721313934206;5582.720863956867;5490.890182196414;5493.615446918837;5524.806631767869;5525.585581081355;5542.2795036644975 12:15:12 INFO - PROCESS | 1644 | |5;yui.html;713.243961400915;743.5390058163943;767.6583920155531;777.5606782168074;833.9124391938842;15925;16886.408975685852;16903.154842257867;16945.915270423662;16967.406140785075;14936.029158104715;15138.318775655094;15148.621284467894;15163.92418037911;15217.239138043109;683.0642020432015;707.6461769115442;842.759813453166;847.9194476524735;865.2558799432483;723.938465230456;856.9400141990063;871.5729292646589;874.6807415293435;875.4747151708988;933.2673851026946;934.8317302885512;935.6725146198844;939.0937745076001;943.306669597845;721.8015045862377;753.7437271327775;762.2872614105829;936.204226407555;942.0155937045804;552.5634748548641;667.5727534378002;688.2051230828401;697.9476539259576;700.4886432903958;15157.317920693595;15176.165310907896;15186.696266074616;15200;15209.163496007715;14080.295985200699;14102.083364581373;14137.434502619883;14426.134431934117;14481.927590362086;13114.278714670689;13193.472261109544;13321.200727956353;13534.59396218115;13755.518556850462;4576.588107070346;4691.483936766953;4722.3152642866935;4764.714117152982;4773.260144677581;109261.9999999992;111969.44015279954;112029;112240;112330;10362.326448780805;10612.900188790423;10827.783444331228;10957.726056848642;11127.276727012719;21304.680429793567;21567.029483673272;21591.784082158978;21635.242766503095;21648.567028659654;7555.697772089165;7682.807929801688;7782.236264526575;7835.6473958671995;7909.960450197712;4371.1039236956985;4438.911221775611;4459.710118842265;4500;4504.774761261924;3543.1319326765106;3656.2321912398693;3665.376885929398;3709.4435834625024;3712.5916149223563;635.8950773122383;640.9647469389135;648.5233353485185;653.5523166630873;657.2441692054176;589.7817807411285;632.9585595969767;633.689492148853;673.3905815237218;711.5695004522292;7898.249666281694;8725.996510401385;9519.286053545873;9620.086091821266;9725.221982241404;639.3223183425583;688.5937296994797;693.836948317145;703.3318347569829;704.2992222738408;3726.403775395978;4146.3365861462025;4655.790489427984;4661.766911654404;4663.556962088596;86150;86308;104840;155903;159673;79580;138372;139146.304268478;141995;145192.27403862914;74520;75169.6241518778;101485.98514014913;103406;104636;8188.918110819054;9370.312608648122;9735.123838854537;9776.413415195111;10009.149222316184;41105;60310.698446507486;62745.68627157018;63554.41113972188;63698.68150659217;59484.70257648684;84103.15896841198;85832;92783.53608231916;97062;12966.935165324114;13442.529511467052;13463.259520726455;13900.304984750519;13938.860611393757;14868;15257.694846103237;15441.305141268895;15850.048997059752;15979.440719574759;11471.369074700971;13876.653083672989;14000.229987350793;14193.858061419254;14250.073745206942;11523.884761152281;14016.78974815399;14124.78812817829;14188.148711077369;14408.20754858493;13609.659758506117;13671.589852304447;13829.723405532035;13922.51271205503;13924.4430222794;10962.967386814391;11126.276792008493;11537.307761534335;11657.53369865196;11728.648140555797;11158.386288754196;11304.943475282571;11384;11606.129540284344;11620.477078531318 12:15:12 INFO - PROCESS | 1644 | __end_tp_report 12:15:12 INFO - PROCESS | 1644 | __start_cc_report 12:15:12 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,1477 12:15:12 INFO - PROCESS | 1644 | __end_cc_report 12:15:12 INFO - PROCESS | 1644 | __startTimestamp1471374912121__endTimestamp 12:15:12 INFO - PROCESS | 1644 | 12:15:12 INFO - PROCESS | 1644 | ------- Summary: start ------- 12:15:12 INFO - PROCESS | 1644 | Number of tests: 6 12:15:12 INFO - PROCESS | 1644 | 12:15:12 INFO - PROCESS | 1644 | [#0] dojo.html Cycles:165 Average:5773.05 Median:6045.24 stddev:636.65 (10.5%) stddev-sans-first:610.50 12:15:12 INFO - PROCESS | 1644 | Values: 3388.7 3416.4 3427.4 3442.8 3456.4 5691.5 5712.2 5796.3 5867.7 5879.3 5840.7 5866.4 5937.9 5958.9 5978.6 4406.8 5258.2 5283.9 5292.0 5403.4 5409.1 5409.4 5414.1 5423.5 5447.6 5210.6 5258.5 5264.8 5284.6 5337.4 5226.5 5244.0 5270.2 5298.7 5304.7 5194.8 5214.8 5239.4 5298.4 5298.7 5734.8 5873.1 5939.2 5964.8 5981.1 6097.7 6105.1 6108.5 6115.2 6131.9 6128.8 6162.9 6175.2 6213.5 6221.4 5742.0 5938.9 5939.4 5943.7 5958.6 6160.7 6243.9 6295.5 6306.4 6388.1 6163.1 6176.3 6179.5 6183.0 6183.6 6140.3 6169.7 6201.3 6201.9 6231.3 6107.2 6122.2 6129.8 6130.2 6144.4 6123.2 6153.2 6164.2 6168.9 6171.1 4961.6 4974.7 4989.3 4989.6 5014.5 4398.4 4414.5 4444.2 4501.0 4516.3 5826.9 5847.2 5903.1 5934.3 5940.3 6242.7 6260.9 6270.1 6271.8 6275.2 5672.9 5724.9 5729.0 5890.6 5902.6 5352.7 5450.1 5454.2 5481.7 5484.7 6390.8 6407.7 6412.7 6413.7 6417.2 6190.1 6236.5 6245.4 6254.2 6261.9 6213.2 6282.6 6319.7 6321.2 6363.2 6215.9 6220.4 6223.5 6225.0 6240.8 6235.0 6241.7 6264.6 6271.3 6286.6 4634.8 5205.7 6101.7 6102.3 6179.8 4939.2 5437.2 6205.9 6224.6 6232.7 6106.7 6110.7 6123.8 6132.4 6135.7 6125.0 6136.6 6149.0 6171.2 6223.0 5952.1 6006.3 6041.9 6045.2 6084.4 12:15:12 INFO - PROCESS | 1644 | 12:15:12 INFO - PROCESS | 1644 | [#1] ext.html Cycles:180 Average:67191.80 Median:20707.87 stddev:144469.85 (697.7%) stddev-sans-first:144788.34 12:15:12 INFO - PROCESS | 1644 | Values: 499.1 507.4 511.1 547.4 558.1 30721.0 40871.2 42429.8 42697.1 44969.0 43023.0 43508.6 43545.2 43577.5 43721.6 8973.5 9746.7 9947.0 9954.3 9967.3 8878.6 9107.0 9120.0 9121.8 12069.6 12300.0 12351.4 12353.6 12364.7 12379.3 12163.9 12184.9 12187.7 12196.6 12280.2 9300.8 11105.9 11674.9 12054.0 12077.8 40538.0 40878.6 40911.8 40955.0 40995.6 3485.4 3488.6 3675.4 3684.1 3904.9 30678.0 30954.4 31543.1 31549.7 32079.5 3200.2 3238.9 3249.8 3325.5 3336.6 453314.0 456361.0 457153.0 457386.0 460125.0 50056.2 60219.7 60337.4 60497.7 60510.4 34389.7 35013.6 35242.8 64064.7 64322.0 16540.8 16707.9 16711.1 16711.5 16728.4 12737.6 12837.0 12846.0 12857.6 12858.1 14111.9 16743.1 16788.4 17035.6 18651.5 6701.9 7565.7 8025.1 8066.6 8108.9 786.8 895.3 946.7 1024.8 1059.3 24132.6 29653.7 30257.0 30493.2 30860.1 924.7 1065.6 1088.1 1100.2 1123.7 15153.3 15617.1 15832.7 15872.0 16142.0 494533.0 634006.7 640295.0 640647.0 640817.5 58186.4 58488.0 58501.0 58532.5 58656.4 1339.1 1369.3 1375.9 1379.6 1381.8 28305.3 29221.4 29736.6 30291.0 30756.0 50946.0 51117.7 51296.7 51312.0 51537.5 541977.0 542032.0 543623.0 543885.0 544845.0 23557.0 26332.9 26483.3 26805.7 27086.9 40181.4 47163.3 47535.3 48186.0 48823.0 38346.0 38778.8 39369.7 39685.0 39850.6 38488.8 38578.6 38811.7 39564.8 39805.6 29617.9 33216.3 37731.6 38717.6 39611.8 32784.8 32823.8 33440.0 34530.0 34768.0 21876.0 22570.8 22616.7 25078.4 25736.4 12:15:12 INFO - PROCESS | 1644 | 12:15:12 INFO - PROCESS | 1644 | [#2] jquery.html Cycles:180 Average:34677.17 Median:13916.73 stddev:94367.87 (678.1%) stddev-sans-first:94597.33 12:15:12 INFO - PROCESS | 1644 | Values: 319.7 350.8 368.0 373.4 405.5 15376.6 15580.9 15865.0 17758.2 18925.4 20393.5 20562.5 20572.6 20689.6 20814.9 5591.1 6082.2 6117.2 6121.8 6134.1 5865.6 5914.6 5988.7 6093.0 6097.1 6017.0 6025.7 6031.2 6036.3 6036.4 5882.7 5965.1 6005.8 6020.7 6059.8 5229.8 5230.4 5231.0 5233.7 5242.0 24468.6 24596.6 24708.8 24773.0 25102.0 2362.0 2731.5 3137.6 3150.3 3228.8 6738.9 6859.0 7307.5 14830.4 15512.3 1799.9 1905.4 1932.8 1946.1 1993.3 111596.0 118753.0 121103.4 122443.0 123357.0 10298.3 10379.5 10445.6 10658.6 10890.3 11814.5 12147.8 12474.4 12804.3 12812.7 6736.9 6971.3 8098.6 8170.4 8385.6 8316.3 8325.0 8328.4 8462.4 8476.2 6321.0 6458.9 6467.8 6468.2 6587.6 1828.2 1877.2 1887.8 1888.5 1916.1 931.3 963.2 1009.7 1012.3 1016.5 20227.0 20634.3 20870.0 21434.6 21748.6 892.7 926.7 927.8 928.1 966.2 10584.6 10940.7 10965.8 11086.3 11090.6 522824.0 525641.0 526753.0 536999.0 660596.0 144252.0 147016.0 148962.3 156645.4 159306.0 968.0 1000.9 1013.7 1015.7 1030.3 17097.7 18732.9 18820.0 18842.0 18904.5 52183.0 59953.1 60171.4 60445.0 60861.7 78341.6 87065.6 87549.0 87790.6 87876.0 7912.6 8033.3 8127.5 8184.7 8243.7 11365.7 12760.4 12791.2 13035.2 13145.6 11032.7 11038.0 11074.1 11111.2 11190.3 9202.5 10761.2 10935.8 11118.8 11246.7 9112.6 10843.4 10913.0 11254.2 11436.8 7789.3 8019.3 8079.0 8106.9 8157.3 8122.9 9305.9 10774.0 11014.9 11190.0 12:15:12 INFO - PROCESS | 1644 | 12:15:12 INFO - PROCESS | 1644 | [#3] mootools.html Cycles:180 Average:5621.67 Median:4896.37 stddev:3171.50 (64.8%) stddev-sans-first:3164.40 12:15:12 INFO - PROCESS | 1644 | Values: 1383.4 1533.4 1559.5 1716.3 1862.0 7699.1 8488.3 8689.3 8701.3 8827.0 8595.5 8673.6 8674.2 8686.9 8699.8 2313.8 2338.7 2342.3 2347.1 2351.9 2296.0 2343.0 2359.0 2360.8 2362.7 2314.7 2324.2 2335.9 2354.8 2364.3 2298.4 2321.4 2332.5 2336.5 2340.8 1964.2 2328.1 2328.8 2329.5 2330.9 8597.0 8605.4 8667.1 8727.3 8746.1 5046.7 5249.0 5249.8 5254.7 5286.6 3316.5 3335.6 3363.7 3379.2 3517.7 1068.8 1077.3 1082.3 1087.1 1103.1 11402.3 11462.4 11539.0 11553.3 11580.6 3686.6 4380.8 4601.9 4617.1 4623.9 8996.5 9004.4 9010.2 9011.0 9015.6 5160.5 5201.7 5209.7 5216.2 5220.3 4232.9 4275.7 4398.5 4557.2 4869.8 3706.1 3783.8 3816.6 3817.5 3823.6 1162.0 1165.4 1180.8 1181.8 1186.4 853.4 865.8 898.7 905.9 956.1 5674.3 5737.7 5995.7 6030.5 6092.2 917.4 967.9 968.9 975.5 1026.1 3614.9 3797.2 4090.3 4102.2 4259.6 10769.7 10816.7 10968.5 10971.9 10980.6 10896.2 10901.2 10905.3 10909.8 10922.9 8096.5 8332.9 8345.3 8349.5 8349.8 5625.8 5915.4 6046.5 6081.5 6109.4 9519.3 9918.9 10149.9 10172.4 10180.3 9253.5 10002.2 10184.5 10203.8 10212.8 6284.2 6937.6 7169.2 7176.3 7196.3 7582.7 8072.4 8171.3 8173.3 8176.6 7327.2 7436.6 7487.0 7554.6 7561.0 6180.0 7248.0 7269.5 7291.0 7330.6 6914.4 6916.2 6939.1 6946.2 7042.5 4864.8 4866.9 4924.4 4975.6 5047.4 4850.4 4922.9 4927.7 5027.4 5063.9 12:15:12 INFO - PROCESS | 1644 | 12:15:12 INFO - PROCESS | 1644 | [#4] prototype.html Cycles:180 Average:4535.49 Median:5211.24 stddev:1430.27 (27.4%) stddev-sans-first:1398.16 12:15:12 INFO - PROCESS | 1644 | Values: 279.9 295.7 309.5 311.4 316.0 4618.2 4687.9 5277.8 5311.5 5332.7 4206.4 4852.2 5120.9 5191.4 5357.3 4015.8 4061.9 4069.5 4070.0 4099.6 3266.0 3325.5 3913.8 4056.1 4076.3 3529.9 3901.8 3938.1 4029.7 4044.4 4053.7 4061.5 4063.0 4063.6 4071.3 2921.4 3085.9 3203.9 3426.6 3575.5 5236.7 5237.0 5239.0 5246.5 5301.5 4053.2 4122.5 4631.9 4636.3 4658.9 4887.7 5602.9 5627.5 5664.3 5668.4 3446.1 3827.3 3844.6 3849.7 3882.9 5752.8 5784.3 5847.2 5895.2 5896.4 3423.7 3579.6 3748.7 3760.0 3903.9 3380.0 3940.4 3958.2 3968.8 3975.2 4369.9 4521.0 4581.7 4608.7 4609.5 4863.7 5056.3 5578.4 5646.4 5712.7 1156.7 1185.8 1277.2 1320.8 1325.9 748.8 754.3 814.3 884.7 900.7 5181.6 5209.7 5212.8 5272.6 5281.5 5443.3 5505.0 5768.6 5776.9 5799.6 4388.8 4572.7 4948.3 5247.4 5280.0 2696.5 2745.6 2770.5 2952.9 3018.7 5147.0 5622.2 5886.5 6104.3 6130.9 5301.8 5606.7 5649.3 5961.0 5966.5 5542.0 5583.5 6038.9 6050.3 6084.0 5044.8 5062.0 5756.7 5809.7 5825.5 5252.9 5623.0 5704.1 5771.9 5787.8 5250.4 5820.0 6052.8 6158.3 6221.2 3688.9 3778.3 3817.5 4014.2 4033.5 5767.3 5768.9 5770.6 5773.3 5952.4 5518.3 5527.4 5712.3 5734.7 5737.9 4559.6 4722.9 5006.6 5636.5 5686.9 5256.4 5489.9 5519.1 5530.9 5542.4 4521.6 5382.0 5524.3 5573.7 5582.7 5490.9 5493.6 5524.8 5525.6 5542.3 12:15:12 INFO - PROCESS | 1644 | 12:15:12 INFO - PROCESS | 1644 | [#5] yui.html Cycles:180 Average:23418.43 Median:3719.50 stddev:36470.81 (980.5%) stddev-sans-first:36533.27 12:15:12 INFO - PROCESS | 1644 | Values: 713.2 743.5 767.7 777.6 833.9 15925.0 16886.4 16903.2 16945.9 16967.4 14936.0 15138.3 15148.6 15163.9 15217.2 683.1 707.6 842.8 847.9 865.3 723.9 856.9 871.6 874.7 875.5 933.3 934.8 935.7 939.1 943.3 721.8 753.7 762.3 936.2 942.0 552.6 667.6 688.2 697.9 700.5 15157.3 15176.2 15186.7 15200.0 15209.2 14080.3 14102.1 14137.4 14426.1 14481.9 13114.3 13193.5 13321.2 13534.6 13755.5 4576.6 4691.5 4722.3 4764.7 4773.3 109262.0 111969.4 112029.0 112240.0 112330.0 10362.3 10612.9 10827.8 10957.7 11127.3 21304.7 21567.0 21591.8 21635.2 21648.6 7555.7 7682.8 7782.2 7835.6 7910.0 4371.1 4438.9 4459.7 4500.0 4504.8 3543.1 3656.2 3665.4 3709.4 3712.6 635.9 641.0 648.5 653.6 657.2 589.8 633.0 633.7 673.4 711.6 7898.2 8726.0 9519.3 9620.1 9725.2 639.3 688.6 693.8 703.3 704.3 3726.4 4146.3 4655.8 4661.8 4663.6 86150.0 86308.0 104840.0 155903.0 159673.0 79580.0 138372.0 139146.3 141995.0 145192.3 74520.0 75169.6 101486.0 103406.0 104636.0 8188.9 9370.3 9735.1 9776.4 10009.1 41105.0 60310.7 62745.7 63554.4 63698.7 59484.7 84103.2 85832.0 92783.5 97062.0 12966.9 13442.5 13463.3 13900.3 13938.9 14868.0 15257.7 15441.3 15850.0 15979.4 11471.4 13876.7 14000.2 14193.9 14250.1 11523.9 14016.8 14124.8 14188.1 14408.2 13609.7 13671.6 13829.7 13922.5 13924.4 10963.0 11126.3 11537.3 11657.5 11728.6 11158.4 11304.9 11384.0 11606.1 11620.5 12:15:12 INFO - PROCESS | 1644 | -------- Summary: end -------- 12:15:12 INFO - PROCESS | 1644 | 12:15:12 INFO - TEST-INFO | 1644: exit 0 12:15:12 INFO - TEST-OK | dromaeo_css | took 1117701ms 12:15:12 INFO - TEST-START | kraken 12:15:12 INFO - operating with platform_type : mac_ 12:15:12 INFO - Initialising browser for kraken test... 12:15:12 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/tmpu2Func/profile http://localhost:49266/getInfo.html) 12:15:14 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 12:15:14 INFO - PROCESS | 1654 | colorDepth:24 12:15:14 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 12:15:14 INFO - PROCESS | 1654 | __metrics 12:15:15 INFO - PROCESS | 1654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:15:15 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:15:15 INFO - TEST-INFO | 1654: exit 0 12:15:15 INFO - Browser initialized. 12:15:15 INFO - Running cycle 1/1 for kraken test... 12:15:15 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/tmpu2Func/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:15:27 INFO - PROCESS | 1655 | RSS: Main: 228368384 12:15:27 INFO - PROCESS | 1655 | 12:15:30 INFO - PROCESS | 1655 | 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) 12:15:31 INFO - PROCESS | 1655 | RSS: Main: 285343744 12:15:31 INFO - PROCESS | 1655 | 12:15:33 INFO - PROCESS | 1655 | 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) 12:15:34 INFO - PROCESS | 1655 | RSS: Main: 291819520 12:15:34 INFO - PROCESS | 1655 | 12:15:37 INFO - PROCESS | 1655 | 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) 12:15:38 INFO - PROCESS | 1655 | RSS: Main: 385851392 12:15:38 INFO - PROCESS | 1655 | 12:15:40 INFO - PROCESS | 1655 | 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) 12:15:41 INFO - PROCESS | 1655 | RSS: Main: 288256000 12:15:41 INFO - PROCESS | 1655 | 12:15:43 INFO - PROCESS | 1655 | 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) 12:15:43 INFO - PROCESS | 1655 | RSS: Main: 293965824 12:15:43 INFO - PROCESS | 1655 | 12:15:46 INFO - PROCESS | 1655 | 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) 12:15:47 INFO - PROCESS | 1655 | RSS: Main: 328458240 12:15:47 INFO - PROCESS | 1655 | 12:15:50 INFO - PROCESS | 1655 | 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) 12:15:50 INFO - PROCESS | 1655 | RSS: Main: 331743232 12:15:50 INFO - PROCESS | 1655 | 12:15:53 INFO - PROCESS | 1655 | 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) 12:15:54 INFO - PROCESS | 1655 | RSS: Main: 332607488 12:15:54 INFO - PROCESS | 1655 | 12:15:55 INFO - PROCESS | 1655 | 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) 12:15:56 INFO - PROCESS | 1655 | RSS: Main: 301744128 12:15:56 INFO - PROCESS | 1655 | 12:15:58 INFO - PROCESS | 1655 | 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) 12:15:58 INFO - PROCESS | 1655 | RSS: Main: 308355072 12:15:58 INFO - PROCESS | 1655 | 12:16:00 INFO - PROCESS | 1655 | 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) 12:16:01 INFO - PROCESS | 1655 | RSS: Main: 301019136 12:16:01 INFO - PROCESS | 1655 | 12:16:04 INFO - PROCESS | 1655 | 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) 12:16:05 INFO - PROCESS | 1655 | RSS: Main: 312238080 12:16:05 INFO - PROCESS | 1655 | 12:16:08 INFO - PROCESS | 1655 | 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) 12:16:08 INFO - PROCESS | 1655 | RSS: Main: 314474496 12:16:08 INFO - PROCESS | 1655 | 12:16:10 INFO - PROCESS | 1655 | 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) 12:16:11 INFO - PROCESS | 1655 | RSS: Main: 357380096 12:16:11 INFO - PROCESS | 1655 | 12:16:11 INFO - PROCESS | 1655 | __start_tp_report 12:16:11 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 12:16:11 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 12:16:11 INFO - PROCESS | 1655 | |i|pagename|runs| 12:16:11 INFO - PROCESS | 1655 | |0;ai-astar;105;113;114;113;107;113;112;112;113;113 12:16:11 INFO - PROCESS | 1655 | |1;audio-beat-detection;141;106;121;203;138;107;130;105;142;107 12:16:11 INFO - PROCESS | 1655 | |2;audio-dft;181;185;181;183;184;180;181;179;182;183 12:16:11 INFO - PROCESS | 1655 | |3;audio-fft;77;57;59;88;59;56;65;63;83;56 12:16:11 INFO - PROCESS | 1655 | |4;audio-oscillator;83;69;101;71;73;69;95;70;68;103 12:16:11 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;88;85;87;86;87;84;89;86;89;85 12:16:11 INFO - PROCESS | 1655 | |6;imaging-darkroom;93;96;112;93;93;94;94;94;93;92 12:16:11 INFO - PROCESS | 1655 | |7;imaging-desaturate;84;84;84;83;84;87;85;83;85;85 12:16:11 INFO - PROCESS | 1655 | |8;json-parse-financial;55;50;54;52;52;54;51;52;55;52 12:16:11 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;65;71;67;75;71;69;68;71;70;72 12:16:11 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;85;85;83;87;85;83;83;84;83;84 12:16:11 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;151;148;136;133;150;149;144;153;222;149 12:16:11 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;165;167;168;169;166;166;178;165;234;211 12:16:11 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;67;67;67;69;80;85;87;82;72;66 12:16:11 INFO - PROCESS | 1655 | __end_tp_report 12:16:11 INFO - PROCESS | 1655 | __start_cc_report 12:16:11 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,2013 12:16:11 INFO - PROCESS | 1655 | __end_cc_report 12:16:11 INFO - PROCESS | 1655 | __startTimestamp1471374971012__endTimestamp 12:16:11 INFO - PROCESS | 1655 | 12:16:11 INFO - PROCESS | 1655 | ------- Summary: start ------- 12:16:11 INFO - PROCESS | 1655 | Number of tests: 14 12:16:11 INFO - PROCESS | 1655 | 12:16:11 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:111.50 Median:113.00 stddev:2.99 (2.6%) stddev-sans-first:2.05 12:16:11 INFO - PROCESS | 1655 | Values: 105.0 113.0 114.0 113.0 107.0 113.0 112.0 112.0 113.0 113.0 12:16:11 INFO - PROCESS | 1655 | 12:16:11 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:130.00 Median:134.00 stddev:29.81 (22.2%) stddev-sans-first:31.35 12:16:11 INFO - PROCESS | 1655 | Values: 141.0 106.0 121.0 203.0 138.0 107.0 130.0 105.0 142.0 107.0 12:16:11 INFO - PROCESS | 1655 | 12:16:11 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:181.90 Median:182.50 stddev:1.85 (1.0%) stddev-sans-first:1.94 12:16:11 INFO - PROCESS | 1655 | Values: 181.0 185.0 181.0 183.0 184.0 180.0 181.0 179.0 182.0 183.0 12:16:11 INFO - PROCESS | 1655 | 12:16:11 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:66.30 Median:64.00 stddev:11.94 (18.6%) stddev-sans-first:12.02 12:16:11 INFO - PROCESS | 1655 | Values: 77.0 57.0 59.0 88.0 59.0 56.0 65.0 63.0 83.0 56.0 12:16:11 INFO - PROCESS | 1655 | 12:16:11 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:80.20 Median:70.50 stddev:14.22 (20.2%) stddev-sans-first:15.05 12:16:11 INFO - PROCESS | 1655 | Values: 83.0 69.0 101.0 71.0 73.0 69.0 95.0 70.0 68.0 103.0 12:16:11 INFO - PROCESS | 1655 | 12:16:11 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:86.60 Median:87.00 stddev:1.71 (2.0%) stddev-sans-first:1.74 12:16:11 INFO - PROCESS | 1655 | Values: 88.0 85.0 87.0 86.0 87.0 84.0 89.0 86.0 89.0 85.0 12:16:11 INFO - PROCESS | 1655 | 12:16:11 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:95.40 Median:93.50 stddev:5.93 (6.3%) stddev-sans-first:6.22 12:16:11 INFO - PROCESS | 1655 | Values: 93.0 96.0 112.0 93.0 93.0 94.0 94.0 94.0 93.0 92.0 12:16:11 INFO - PROCESS | 1655 | 12:16:11 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:1.17 (1.4%) stddev-sans-first:1.24 12:16:11 INFO - PROCESS | 1655 | Values: 84.0 84.0 84.0 83.0 84.0 87.0 85.0 83.0 85.0 85.0 12:16:11 INFO - PROCESS | 1655 | 12:16:11 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:1.70 (3.2%) stddev-sans-first:1.59 12:16:11 INFO - PROCESS | 1655 | Values: 55.0 50.0 54.0 52.0 52.0 54.0 51.0 52.0 55.0 52.0 12:16:11 INFO - PROCESS | 1655 | 12:16:11 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:71.00 stddev:2.81 (4.0%) stddev-sans-first:2.35 12:16:11 INFO - PROCESS | 1655 | Values: 65.0 71.0 67.0 75.0 71.0 69.0 68.0 71.0 70.0 72.0 12:16:11 INFO - PROCESS | 1655 | 12:16:11 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.50 stddev:1.32 (1.6%) stddev-sans-first:1.36 12:16:11 INFO - PROCESS | 1655 | Values: 85.0 85.0 83.0 87.0 85.0 83.0 83.0 84.0 83.0 84.0 12:16:11 INFO - PROCESS | 1655 | 12:16:11 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:153.50 Median:149.50 stddev:24.94 (16.7%) stddev-sans-first:26.44 12:16:11 INFO - PROCESS | 1655 | Values: 151.0 148.0 136.0 133.0 150.0 149.0 144.0 153.0 222.0 149.0 12:16:11 INFO - PROCESS | 1655 | 12:16:11 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.90 Median:168.50 stddev:23.91 (14.2%) stddev-sans-first:24.82 12:16:11 INFO - PROCESS | 1655 | Values: 165.0 167.0 168.0 169.0 166.0 166.0 178.0 165.0 234.0 211.0 12:16:11 INFO - PROCESS | 1655 | 12:16:11 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.20 Median:76.00 stddev:8.36 (11.0%) stddev-sans-first:8.46 12:16:11 INFO - PROCESS | 1655 | Values: 67.0 67.0 67.0 69.0 80.0 85.0 87.0 82.0 72.0 66.0 12:16:11 INFO - PROCESS | 1655 | -------- Summary: end -------- 12:16:11 INFO - PROCESS | 1655 | 12:16:11 INFO - TEST-INFO | 1655: exit 0 12:16:11 INFO - TEST-OK | kraken | took 59104ms 12:16:11 INFO - SUITE-END | took 1176s 12:16:12 INFO - Completed test suite (00:19:37) 12:16:12 INFO - javascript benchmark 12:16:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3388.69501744843, 3416.436288012478, 3427.400204964131, 3442.7590068695204, 3456.3951308521005, 5691.516221121199, 5712.22884910537, 5796.333421656505, 5867.677277749722, 5879.265091863517, 5840.707964601764, 5866.413358664142, 5937.940620593793, 5958.940410595893, 5978.6412815231115, 4406.845760398387, 5258.158694608864, 5283.867903302429, 5292.0, 5403.351597808269, 5409.107497262947, 5409.350877894658, 5414.133738601825, 5423.457654234585, 5447.645903016311, 5210.635255532115, 5258.474152584749, 5264.815731449381, 5284.603654725892, 5337.386200586904, 5226.451222621608, 5243.973780131113, 5270.209468579706, 5298.708571028592, 5304.681719096867, 5194.792208311701, 5214.765335559909, 5239.449857764956, 5298.417174110845, 5298.682079075229, 5734.827955161351, 5873.1190321451695, 5939.168516407706, 5964.791232306892, 5981.132735753335, 6097.664628445434, 6105.114758360013, 6108.450239478469, 6115.240341084353, 6131.87736245277, 6128.846778830521, 6162.876742465126, 6175.228096487939, 6213.502919766408, 6221.440070393641, 5742.0, 5938.940610593882, 5939.3763654816485, 5943.70281485924, 5958.612690175125, 6160.691965401712, 6243.906341404882, 6295.496360291166, 6306.400891915261, 6388.105665206875, 6163.106349579376, 6176.258848938156, 6179.5056395488255, 6183.0, 6183.628982261079, 6140.258857967725, 6169.722362493699, 6201.255849298113, 6201.937980620226, 6231.283402408781, 6107.206063211843, 6122.204113465221, 6129.754809807647, 6130.153553065376, 6144.402455361638, 6123.221615589998, 6153.2000839890525, 6164.167837341902, 6168.938310616836, 6171.105189747551, 4961.578265847444, 4974.7263900485095, 4989.326440930428, 4989.60083193351, 5014.52362025607, 4398.3842262083335, 4414.536473670282, 4444.200043992112, 4501.0, 4516.322551617283, 5826.883462330729, 5847.239858818326, 5903.085021821625, 5934.258217722785, 5940.287165540163, 6242.719077641517, 6260.874782504416, 6270.090836828635, 6271.843203919939, 6275.152854364603, 5672.886542269214, 5724.942750572524, 5729.0, 5890.646561206341, 5902.557308201816, 5352.652077614943, 5450.127979523258, 5454.236406903036, 5481.698506582096, 5484.698341591171, 6390.808275751735, 6407.711652975628, 6412.679366031586, 6413.743450261937, 6417.165768450258, 6190.102435146969, 6236.532260080603, 6245.406686364788, 6254.155688981929, 6261.906071409024, 6213.2233470816145, 6282.623042617458, 6319.652419116993, 6321.178246828067, 6363.172787537591, 6215.9378406217165, 6220.440160385587, 6223.502119830312, 6224.968875155776, 6240.843978900564, 6235.033569796688, 6241.656708881055, 6264.59280146789, 6271.31015588294, 6286.559940804283, 4634.814607415666, 5205.696913423084, 6101.701646049799, 6102.307478454422, 6179.84550386244, 4939.160342741814, 5437.211604317431, 6205.906911396423, 6224.564280500322, 6232.657203853832, 6106.6946652668075, 6110.725017374318, 6123.755049797958, 6132.448079672851, 6135.6932153393045, 6124.969375153096, 6136.6011209271255, 6149.046897730859, 6171.197744293213, 6222.968885155546, 5952.107183922446, 6006.279246490449, 6041.942660034564, 6045.244344456943, 6084.361142080018], "value": 5734.005029809578, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.0667451865013, 507.40633458853137, 511.09791218499333, 547.3759913698384, 558.0624550754732, 30721.0, 40871.18257634845, 42429.78785106074, 42697.14605707884, 44969.0, 43023.0, 43508.56491435085, 43545.2100268971, 43577.47478838242, 43721.562784372145, 8973.46159230445, 9746.70759877203, 9947.0, 9954.253430992669, 9967.302288839785, 8878.644854205857, 9106.998230194673, 9119.954400227989, 9121.817563648723, 12069.577564785235, 12300.0, 12351.444185011696, 12353.567625133122, 12364.690882727959, 12379.25724456531, 12163.939180304085, 12184.939075304655, 12187.695307617336, 12196.634100976986, 12280.201786883825, 9300.813983720287, 11105.944470277678, 11674.94925456713, 12054.0, 12077.818832717516, 40538.0, 40878.59121408778, 40911.7954410226, 40955.0, 40995.590044099474, 3485.442329227337, 3488.5639295088113, 3675.3568125577917, 3684.1158122050515, 3904.902377440558, 30678.0, 30954.38091238185, 31543.053708388787, 31549.684503154906, 32079.51880721791, 3200.2319443333663, 3238.9028329150165, 3249.7562682798884, 3325.467925131967, 3336.6162891267572, 453314.0, 456361.0, 457152.9999999967, 457386.0, 460125.0, 50056.24915626268, 60219.69890150521, 60337.39662603405, 60497.69751151216, 60510.39489605136, 34389.65610343915, 35013.649863501545, 35242.82378588091, 64064.71870562563, 64322.0, 16540.83459165417, 16707.91646041762, 16711.080890551137, 16711.498655040366, 16728.41450549225, 12737.617871463872, 12837.0, 12845.9723222142, 12857.614271571867, 12858.0999330046, 14111.929440352733, 16743.07913064793, 16788.412405565745, 17035.592881423763, 18651.533711657317, 6701.932980670228, 7565.659545320474, 8025.122818229053, 8066.556339401389, 8108.878366824502, 786.7639708087665, 895.2524641924066, 946.6828612414918, 1024.774549599087, 1059.3220338983058, 24132.63801042986, 29653.703462965095, 30257.0, 30493.23766905845, 30860.0741977741, 924.7225832250298, 1065.6376831877199, 1088.0968795899385, 1100.2298391126244, 1123.6685177872548, 15153.318100685496, 15617.062976221463, 15832.68334633301, 15872.0, 16141.950773199704, 494533.0, 634006.659933404, 640295.0, 640647.0, 640817.4896388928, 58186.418135818945, 58488.0, 58501.0, 58532.536686583175, 58656.41343586509, 1339.1028011232497, 1369.3427154965473, 1375.931203439844, 1379.5654368873772, 1381.7512847687512, 28305.292367690974, 29221.415571688023, 29736.553951690308, 30290.99481003088, 30756.0, 50946.0, 51117.74441127771, 51296.74351628218, 51311.973760525325, 51537.484625153265, 541977.0, 542032.0, 543623.0, 543885.0, 544845.0, 23557.0, 26332.8683356582, 26483.337916552242, 26805.731942680322, 27086.864565677046, 40181.397279040255, 47163.292550611084, 47535.286970694775, 48186.03627927492, 48823.0, 38346.0, 38778.80610597042, 39369.71660242864, 39685.0, 39850.60522881685, 38488.80755596204, 38578.6142138575, 38811.671299722104, 39564.80217599009, 39805.60680376173, 29617.851910740308, 33216.335673286885, 37731.62268377281, 38717.6128238714, 39611.80194099011, 32784.83607581947, 32823.83588082044, 33440.0, 34530.0, 34767.9569612912, 21876.01557929929, 22570.77429225687, 22616.66075008909, 25078.37304067413, 25736.356591085372], "value": 20042.131181938686, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.6819164930893, 350.7912791888825, 367.9632036796322, 373.3783250887272, 405.53971242639614, 15376.615584610376, 15580.922095389522, 15865.0, 17758.200880960354, 18925.432237032877, 20393.49016274594, 20562.48593785156, 20572.588548229065, 20689.586208275825, 20814.89592552035, 5591.133374326976, 6082.239720034996, 6117.174181485487, 6121.846953826145, 6134.110553969694, 5865.618734782247, 5914.585978981473, 5988.700564971734, 6093.0, 6097.115918191882, 6017.037274036155, 6025.728842202089, 6031.215941927543, 6036.305824830157, 6036.3661815509395, 5882.735276912549, 5965.105234214859, 6005.789797357093, 6020.6688632125215, 6059.848503787396, 5229.843104706865, 5230.424653288135, 5230.97384513075, 5233.738313084331, 5241.9737901310245, 24468.632970505456, 24596.631050534255, 24708.752912471005, 24773.0, 25102.0, 2361.9527609447714, 2731.4537092581563, 3137.592113025315, 3150.2754366495606, 3228.8224147671867, 6738.865222695567, 6858.965705171492, 7307.4884758066955, 14830.442803505584, 15512.301946412439, 1799.9190036448392, 1905.3997990632906, 1932.8163824436656, 1946.1047917957756, 1993.272455553727, 111596.0, 118753.0, 121103.39448302702, 122443.0, 123357.0, 10298.330608510423, 10379.481025948673, 10445.634402795866, 10658.626948056935, 10890.346579205274, 11814.46834892432, 12147.817782733266, 12474.376281186085, 12804.295763733084, 12812.679683008, 6736.932630673728, 6971.268016858156, 8098.554579498066, 8170.428070035159, 8385.6226469809, 8316.293115085286, 8324.958375208085, 8328.417010809186, 8462.36532260083, 8476.194761497647, 6321.0, 6458.870822583616, 6467.773627923, 6468.223813142453, 6587.571807832475, 1828.1864570266105, 1877.1740434208905, 1887.8112188781013, 1888.518427800902, 1916.1281616864294, 931.2736065868634, 963.2438535749403, 1009.6819501856892, 1012.2863381316155, 1016.501914062119, 20227.0, 20634.27780027692, 20870.0, 21434.57130857374, 21748.565028699337, 892.6743785478559, 926.7396340976267, 927.7634203278121, 928.0672923711761, 966.183574879226, 10584.629537966135, 10940.671779846618, 10965.83551246716, 11086.334819910831, 11090.5563777448, 522824.0, 525641.0, 526753.0, 536999.0, 660596.0, 144252.0, 147016.0, 148962.25518872554, 156645.43354566535, 159306.0, 967.9903200968041, 1000.9049140331657, 1013.6857574151888, 1015.669907280137, 1030.304544432505, 17097.658046839242, 18732.906335468237, 18820.0, 18842.0, 18904.52738681544, 52183.0, 59953.10070348861, 60171.39828601833, 60445.0, 60861.69569152303, 78341.60829195818, 87065.56467217623, 87549.0, 87790.56104719435, 87876.0, 7912.604369781603, 8033.277005069572, 8127.471714338785, 8184.672613095648, 8243.670253189804, 11365.659030229106, 12760.361981901053, 12791.232526048467, 13035.15271507349, 13145.60563183106, 11032.669019929415, 11038.0, 11074.058705010164, 11111.222214445235, 11190.32858028521, 9202.53987300619, 10761.246712730033, 10935.781284374109, 11118.833217501582, 11246.66260012201, 9112.633105034298, 10843.415501551324, 10912.96326848948, 11254.155938304497, 11436.771264574829, 7789.337906277803, 8019.278264956182, 8078.959605201936, 8106.8783968241705, 8157.306628936607, 8122.918770812453, 9305.906940930505, 10774.0, 11014.946505668466, 11190.048845848194], "value": 9628.305903142518, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1383.3913078245578, 1533.432629926927, 1559.4775750123708, 1716.2963185094106, 1862.0038279520459, 7699.1146018207855, 8488.278496327812, 8689.26141277992, 8701.303895688337, 8826.955865220665, 8595.527246001468, 8673.60968756406, 8674.219320261176, 8686.913130868705, 8699.782505437368, 2313.780190881868, 2338.707661542307, 2342.3090188394463, 2347.1315613223132, 2351.870647114408, 2295.988520057397, 2342.96485552716, 2358.9528209435803, 2360.8111351091957, 2362.728286247078, 2314.733805612351, 2324.2213858357386, 2335.8948847301913, 2354.811615070799, 2364.302530753423, 2298.425393651587, 2321.442853715113, 2332.4635333873134, 2336.544373847109, 2340.7659234076627, 1964.2437661500426, 2328.080408238753, 2328.8136949044037, 2329.5340931813535, 2330.93007209784, 8597.0, 8605.354598405145, 8667.089955554638, 8727.258183054448, 8746.125387461267, 5046.697198168085, 5248.973755131238, 5249.790008399659, 5254.65844720092, 5286.550643195333, 3316.5369669141455, 3335.5830521184853, 3363.697267245935, 3379.239671074013, 3517.736169787276, 1068.759529105945, 1077.2620754783, 1082.3343643659093, 1087.1140020882956, 1103.1395511501041, 11402.315861048364, 11462.369569673665, 11538.999999999916, 11553.30680159193, 11580.594679186188, 3686.594474607791, 4380.78096095194, 4601.861944141681, 4617.12274667812, 4623.86128416148, 8996.460212387277, 9004.36969412135, 9010.189082982562, 9010.96373917008, 9015.594298256594, 5160.535551800356, 5201.713905735145, 5209.661372010807, 5216.217567364925, 5220.347456567929, 4232.91534169321, 4275.679324050647, 4398.450193725785, 4557.225271703752, 4869.805207791649, 3706.1105334720014, 3783.7729736215915, 3816.580176180618, 3817.5418949725654, 3823.636754508317, 1161.96514104577, 1165.4289398194992, 1180.7756526260155, 1181.757739663367, 1186.4186548591128, 853.4026181672854, 865.7792262972902, 898.7303808857316, 905.9365844390829, 956.0630582029511, 5674.319081710221, 5737.713114344266, 5995.670238136944, 6030.487408570233, 6092.1775560299675, 917.3991385033027, 967.9128878400978, 968.9370190937567, 975.453745902297, 1026.1431704526653, 3614.8734794282072, 3797.1646237827636, 4090.3046482098116, 4102.220578090153, 4259.574042595716, 10769.676909692722, 10816.729581760519, 10968.506417211245, 10971.890281097247, 10980.560777568968, 10896.18278629106, 10901.182411319025, 10905.34567925927, 10909.781804364027, 10922.945385273022, 8096.51420914747, 8332.916670833336, 8345.332373410112, 8349.540775257297, 8349.791255218668, 5625.831225063254, 5915.408459154222, 6046.486048685735, 6081.513478921587, 6109.419605137505, 9519.333646644945, 9918.851217231891, 10149.949250253701, 10172.440515771408, 10180.338278012201, 9253.491057991874, 10002.24983126283, 10184.541695623862, 10203.84694229602, 10212.795744084928, 6284.183056202664, 6937.618430986344, 7169.211386747558, 7176.282371762782, 7196.280371962762, 7582.658780354787, 8072.354211662935, 8171.305439037511, 8173.305269052197, 8176.591170441573, 7327.157376901511, 7436.628168591441, 7486.962565187139, 7554.584497852671, 7560.9621951889885, 6179.969100154471, 7247.9637601811655, 7269.45479089081, 7290.9635451822405, 7330.596817174894, 6914.377706006484, 6916.204636466669, 6939.063226464363, 6946.201186863374, 7042.471814613822, 4864.781084851119, 4866.853994380174, 4924.384451943507, 4975.577075948585, 5047.419546752024, 4850.417949846041, 4922.926156107733, 4927.655064145475, 5027.4218464877, 5063.880591099852], "value": 4516.223636958364, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.92508766337266, 295.70724982267564, 309.4769838972138, 311.3710305183529, 315.99842000789994, 4618.237990731525, 4687.929681054783, 5277.762500687469, 5311.468853114687, 5332.680039197651, 4206.443615862127, 4852.175130227861, 5120.8975820483665, 5191.402988656306, 5357.330333708286, 4015.819288132041, 4061.87814365568, 4069.450624165744, 4069.9621596492852, 4099.61053699898, 3265.9836700816463, 3325.5177999190105, 3913.8043097845134, 4056.1482088761395, 4076.30702780528, 3529.852797840712, 3901.761537923531, 3938.113924367023, 4029.697772667047, 4044.3933409988445, 4053.655439287664, 4061.472008638858, 4063.045184381668, 4063.598058669754, 4071.2671719090554, 2921.3865088331477, 3085.938281234363, 3203.855826487814, 3426.588809342895, 3575.535180426528, 5236.690827293177, 5237.0, 5239.0, 5246.501582349671, 5301.549368303698, 4053.209624123297, 4122.515894278057, 4631.930521042187, 4636.327732478771, 4658.883527911796, 4887.7311747853855, 5602.887942241173, 5627.539063475932, 5664.348599910981, 5668.404817494145, 3446.052335607703, 3827.2728181645675, 3844.5770965193806, 3849.711271654637, 3882.9223415531815, 5752.791606338854, 5784.334801497839, 5847.210626565402, 5895.201963401204, 5896.38088000758, 3423.7089847363254, 3579.552555930509, 3748.7188460865545, 3759.9660093474513, 3903.941440878389, 3380.0, 3940.3503865438483, 3958.188571342868, 3968.8412463501136, 3975.224831157954, 4369.868903932887, 4520.95479045212, 4581.65637577183, 4608.746518941491, 4609.539046095364, 4863.732494712754, 5056.308894506957, 5578.386377498472, 5646.435356464321, 5712.714364281769, 1156.727599640389, 1185.7569198314325, 1277.2208952538945, 1320.8216890719823, 1325.9005574581945, 748.7865958201886, 754.3135746470795, 814.3363159025494, 884.730157302029, 900.7252787899622, 5181.559567436735, 5209.661372010807, 5212.817551385683, 5272.6309158358545, 5281.471852814688, 5443.346798384219, 5505.009098362253, 5768.625039372428, 5776.942230577641, 5799.623024503394, 4388.780560971939, 4572.702774319725, 4948.257761335828, 5247.376311844078, 5279.973600132052, 2696.501147287758, 2745.6156138140677, 2770.5013097642213, 2952.852357382122, 3018.7321325043094, 5147.047796157723, 5622.184783206412, 5886.499647529922, 6104.26748790148, 6130.908036379458, 5301.814436494704, 5606.664034899229, 5649.265595472562, 5961.0, 5966.49284810796, 5541.972290138604, 5583.497485226268, 6038.909416358846, 6050.304215015241, 6083.969580152071, 5044.823431180038, 5061.974690126526, 5756.7409466574945, 5809.680467574324, 5825.533957283492, 5252.923150754163, 5622.971885140548, 5704.062407860039, 5771.8557036074435, 5787.797427090031, 5250.448702886142, 5819.955131183787, 6052.757889684363, 6158.261008678808, 6221.222347206599, 3688.9117710274995, 3778.282126395976, 3817.4655548222718, 4014.1971605678395, 4033.4756481657196, 5767.279090113736, 5768.94231057684, 5770.6249093808765, 5773.336066352255, 5952.404759524013, 5518.2826232591115, 5527.364353099284, 5712.285964254468, 5734.709690319812, 5737.91393129095, 4559.635229181591, 4722.858314250578, 5006.6495345325475, 5636.464535869086, 5686.91948529778, 5256.448072952285, 5489.902019596177, 5519.144532597294, 5530.866172434561, 5542.418046105101, 4521.615662668579, 5382.0043291991105, 5524.281843360337, 5573.721313934206, 5582.720863956867, 5490.890182196414, 5493.615446918837, 5524.806631767869, 5525.585581081355, 5542.2795036644975], "value": 4069.870058632496, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.243961400915, 743.5390058163943, 767.6583920155531, 777.5606782168074, 833.9124391938842, 15925.0, 16886.408975685852, 16903.154842257867, 16945.915270423662, 16967.406140785075, 14936.029158104715, 15138.318775655094, 15148.621284467894, 15163.92418037911, 15217.239138043109, 683.0642020432015, 707.6461769115442, 842.759813453166, 847.9194476524735, 865.2558799432483, 723.938465230456, 856.9400141990063, 871.5729292646589, 874.6807415293435, 875.4747151708988, 933.2673851026946, 934.8317302885512, 935.6725146198844, 939.0937745076001, 943.306669597845, 721.8015045862377, 753.7437271327775, 762.2872614105829, 936.204226407555, 942.0155937045804, 552.5634748548641, 667.5727534378002, 688.2051230828401, 697.9476539259576, 700.4886432903958, 15157.317920693595, 15176.165310907896, 15186.696266074616, 15200.0, 15209.163496007715, 14080.295985200699, 14102.083364581373, 14137.434502619883, 14426.134431934117, 14481.927590362086, 13114.278714670689, 13193.472261109544, 13321.200727956353, 13534.59396218115, 13755.518556850462, 4576.588107070346, 4691.483936766953, 4722.3152642866935, 4764.714117152982, 4773.260144677581, 109261.9999999992, 111969.44015279954, 112029.0, 112240.0, 112330.0, 10362.326448780805, 10612.900188790423, 10827.783444331228, 10957.726056848642, 11127.276727012719, 21304.680429793567, 21567.029483673272, 21591.784082158978, 21635.242766503095, 21648.567028659654, 7555.697772089165, 7682.807929801688, 7782.236264526575, 7835.6473958671995, 7909.960450197712, 4371.1039236956985, 4438.911221775611, 4459.710118842265, 4500.0, 4504.774761261924, 3543.1319326765106, 3656.2321912398693, 3665.376885929398, 3709.4435834625024, 3712.5916149223563, 635.8950773122383, 640.9647469389135, 648.5233353485185, 653.5523166630873, 657.2441692054176, 589.7817807411285, 632.9585595969767, 633.689492148853, 673.3905815237218, 711.5695004522292, 7898.249666281694, 8725.996510401385, 9519.286053545873, 9620.086091821266, 9725.221982241404, 639.3223183425583, 688.5937296994797, 693.836948317145, 703.3318347569829, 704.2992222738408, 3726.403775395978, 4146.3365861462025, 4655.790489427984, 4661.766911654404, 4663.556962088596, 86150.0, 86308.0, 104840.0, 155903.0, 159673.0, 79580.0, 138372.0, 139146.304268478, 141995.0, 145192.27403862914, 74520.0, 75169.6241518778, 101485.98514014913, 103406.0, 104636.0, 8188.918110819054, 9370.312608648122, 9735.123838854537, 9776.413415195111, 10009.149222316184, 41105.0, 60310.698446507486, 62745.68627157018, 63554.41113972188, 63698.68150659217, 59484.70257648684, 84103.15896841198, 85832.0, 92783.53608231916, 97062.0, 12966.935165324114, 13442.529511467052, 13463.259520726455, 13900.304984750519, 13938.860611393757, 14868.0, 15257.694846103237, 15441.305141268895, 15850.048997059752, 15979.440719574759, 11471.369074700971, 13876.653083672989, 14000.229987350793, 14193.858061419254, 14250.073745206942, 11523.884761152281, 14016.78974815399, 14124.78812817829, 14188.148711077369, 14408.20754858493, 13609.659758506117, 13671.589852304447, 13829.723405532035, 13922.51271205503, 13924.4430222794, 10962.967386814391, 11126.276792008493, 11537.307761534335, 11657.53369865196, 11728.648140555797, 11158.386288754196, 11304.943475282571, 11384.0, 11606.129540284344, 11620.477078531318], "value": 7833.606848084813, "unit": "score"}], "name": "dromaeo_css", "value": 7362.965286261798, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 114.0, 113.0, 107.0, 113.0, 112.0, 112.0, 113.0, 113.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 106.0, 121.0, 203.0, 138.0, 107.0, 130.0, 105.0, 142.0, 107.0], "value": 130.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 185.0, 181.0, 183.0, 184.0, 180.0, 181.0, 179.0, 182.0, 183.0], "value": 181.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 57.0, 59.0, 88.0, 59.0, 56.0, 65.0, 63.0, 83.0, 56.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 69.0, 101.0, 71.0, 73.0, 69.0, 95.0, 70.0, 68.0, 103.0], "value": 80.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 87.0, 86.0, 87.0, 84.0, 89.0, 86.0, 89.0, 85.0], "value": 86.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 96.0, 112.0, 93.0, 93.0, 94.0, 94.0, 94.0, 93.0, 92.0], "value": 95.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 83.0, 84.0, 87.0, 85.0, 83.0, 85.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 50.0, 54.0, 52.0, 52.0, 54.0, 51.0, 52.0, 55.0, 52.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 67.0, 75.0, 71.0, 69.0, 68.0, 71.0, 70.0, 72.0], "value": 69.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 83.0, 87.0, 85.0, 83.0, 83.0, 84.0, 83.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 148.0, 136.0, 133.0, 150.0, 149.0, 144.0, 153.0, 222.0, 149.0], "value": 153.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 168.0, 169.0, 166.0, 166.0, 178.0, 165.0, 234.0, 211.0], "value": 178.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 69.0, 80.0, 85.0, 87.0, 82.0, 72.0, 66.0], "value": 74.2, "unit": "score"}], "name": "kraken", "value": 1449.7, "alertThreshold": 2.0}]} 12:16:12 INFO - Return code: 0 12:16:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:16:12 INFO - # TBPL SUCCESS # 12:16:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:16:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:16:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:16:12 INFO - 2016-08-16 12:16:12.348 screenresolution[1659:10036] starting screenresolution argv=screenresolution get 12:16:12 INFO - 2016-08-16 12:16:12.350 screenresolution[1659:10036] Display 0: 1600x1200x32@60 12:16:12 INFO - 2016-08-16 12:16:12.356 screenresolution[1660:10039] starting screenresolution argv=screenresolution list 12:16:12 INFO - Available Modes on Display 0 12:16:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:16:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:16:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:16:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:16:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:16:12 INFO - Intel Iris: 12:16:12 INFO - Chipset Model: Intel Iris 12:16:12 INFO - Type: GPU 12:16:12 INFO - Bus: Built-In 12:16:12 INFO - VRAM (Dynamic, Max): 1536 MB 12:16:12 INFO - Vendor: Intel (0x8086) 12:16:12 INFO - Device ID: 0x0a2e 12:16:12 INFO - Revision ID: 0x0009 12:16:12 INFO - Displays: 12:16:12 INFO - Display: 12:16:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:16:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:16:12 INFO - Display Serial Number: 1600x1200 60 12:16:12 INFO - Main Display: Yes 12:16:12 INFO - Mirror: Off 12:16:12 INFO - Online: Yes 12:16:12 INFO - Rotation: Supported 12:16:12 INFO - Return code: 0 12:16:12 INFO - Running post-action listener: _resource_record_post_action 12:16:12 INFO - [mozharness: 2016-08-16 19:16:12.592822Z] Finished run-tests step (success) 12:16:12 INFO - Running post-run listener: _resource_record_post_run 12:16:12 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 38032384; Write bytes: 704127488; Read time: 378; Write time: 1881 12:16:12 INFO - TinderboxPrint: CPU usage
53.6% 12:16:12 INFO - TinderboxPrint: I/O read bytes / time
38,032,384 / 378 12:16:12 INFO - TinderboxPrint: I/O write bytes / time
704,127,488 / 1,881 12:16:12 INFO - TinderboxPrint: CPU idle
2,249.5 (46.4%) 12:16:12 INFO - TinderboxPrint: CPU system
973.7 (20.1%) 12:16:12 INFO - TinderboxPrint: CPU user
1,626.6 (33.5%) 12:16:12 INFO - TinderboxPrint: Swap in / out
442,933,248 / 0 12:16:12 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 383803904; Write bytes: 377845248; Read time: 29660; Write time: 723 12:16:12 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 37078016; Write bytes: 296627200; Read time: 363; Write time: 1096 12:16:13 INFO - Running post-run listener: _upload_blobber_files 12:16:13 INFO - Blob upload gear active. 12:16:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:16:13 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 12:16:13 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:16:13 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:16:13 INFO - (blobuploader) - INFO - Open directory for files ... 12:16:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:16:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:16:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:16:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:16:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:16:14 INFO - (blobuploader) - INFO - Done attempting. 12:16:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:16:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:16:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:16:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:16:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:16:15 INFO - (blobuploader) - INFO - Done attempting. 12:16:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:16:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:16:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:16:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:16:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:16:18 INFO - (blobuploader) - INFO - Done attempting. 12:16:18 INFO - (blobuploader) - INFO - Iteration through files over. 12:16:18 INFO - Return code: 0 12:16:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:16:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:16:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/52e7b52d9fad726a6206d3f1984ece623d0d8f21053dd3218c156d7099549448831435d3fe2692d2e79d3761c6d94d50cb24633d9492b966badde0af7c3a60d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/589e749530454167a3115b05cdff65ec5391a7d5b745176b1c9ed74c148521848624a0ef9f62e2632736afb89508143819afacbbffd0d022a0b76c7fdb45f756", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1fb4c492c58f381c99a17ec3f9d5235e0743faa834c5f35121ca88a8c485c9df2d136efe1b521407ff4a2e07b7a7d6071ccd29b9cf17f4d308f490249bc28a2"} 12:16:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:16:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:16:18 INFO - Contents: 12:16:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/52e7b52d9fad726a6206d3f1984ece623d0d8f21053dd3218c156d7099549448831435d3fe2692d2e79d3761c6d94d50cb24633d9492b966badde0af7c3a60d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/589e749530454167a3115b05cdff65ec5391a7d5b745176b1c9ed74c148521848624a0ef9f62e2632736afb89508143819afacbbffd0d022a0b76c7fdb45f756", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1fb4c492c58f381c99a17ec3f9d5235e0743faa834c5f35121ca88a8c485c9df2d136efe1b521407ff4a2e07b7a7d6071ccd29b9cf17f4d308f490249bc28a2"} 12:16:18 INFO - Running post-run listener: copy_logs_to_upload_dir 12:16:18 INFO - Copying logs to upload dir... 12:16:18 INFO - mkdir: /builds/slave/test/build/upload/logs 12:16:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.600905 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-16 12:16:18.347723) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 12:16:18.351300) ========= 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.yGFydPe1NU/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.S1fHOO2M4l/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/52e7b52d9fad726a6206d3f1984ece623d0d8f21053dd3218c156d7099549448831435d3fe2692d2e79d3761c6d94d50cb24633d9492b966badde0af7c3a60d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/589e749530454167a3115b05cdff65ec5391a7d5b745176b1c9ed74c148521848624a0ef9f62e2632736afb89508143819afacbbffd0d022a0b76c7fdb45f756", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1fb4c492c58f381c99a17ec3f9d5235e0743faa834c5f35121ca88a8c485c9df2d136efe1b521407ff4a2e07b7a7d6071ccd29b9cf17f4d308f490249bc28a2"} build_url:https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010621 build_url: 'https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/52e7b52d9fad726a6206d3f1984ece623d0d8f21053dd3218c156d7099549448831435d3fe2692d2e79d3761c6d94d50cb24633d9492b966badde0af7c3a60d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/589e749530454167a3115b05cdff65ec5391a7d5b745176b1c9ed74c148521848624a0ef9f62e2632736afb89508143819afacbbffd0d022a0b76c7fdb45f756", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1fb4c492c58f381c99a17ec3f9d5235e0743faa834c5f35121ca88a8c485c9df2d136efe1b521407ff4a2e07b7a7d6071ccd29b9cf17f4d308f490249bc28a2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 12:16:18.384138) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 12:16:18.384527) ========= 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.yGFydPe1NU/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.S1fHOO2M4l/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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.005184 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 12:16:18.435274) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 12:16:18.436089) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 12:16:18.436940) ========= ========= Total master_lag: 0.18 =========