builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0141 starttime: 1472543731.02 results: success (0) buildid: 20160829213422 builduid: f0faef083a7a4bdf9f0a42a6cb8003f9 revision: 26e22af660e543ebb69930f082188b69ec756185 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 00:55:31.019060) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 00:55:31.019750) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 00:55:31.020191) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 00:55:31.175547) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 00:55:31.176158) ========= 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.FeHhb2wfG1/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.3ET1RgBnuY/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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-30 00:55:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 181M=0s 2016-08-30 00:55:31 (181 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.617747 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 00:55:31.822917) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 00:55:31.823493) ========= 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.FeHhb2wfG1/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.3ET1RgBnuY/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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.027843 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 00:55:31.877778) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-30 00:55:31.878532) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 26e22af660e543ebb69930f082188b69ec756185 --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 26e22af660e543ebb69930f082188b69ec756185 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FeHhb2wfG1/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.3ET1RgBnuY/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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-30 00:55:31,953 truncating revision to first 12 chars 2016-08-30 00:55:31,953 Setting DEBUG logging. 2016-08-30 00:55:31,953 attempt 1/10 2016-08-30 00:55:31,953 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/26e22af660e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-30 00:55:33,057 unpacking tar archive at: fx-team-26e22af660e5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.349625 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-30 00:55:33.258521) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 00:55:33.259294) ========= script_repo_revision: 26e22af660e543ebb69930f082188b69ec756185 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 00:55:33.260303) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 00:55:33.261045) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 00:55:33.283418) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-30 00:55:33.284168) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.FeHhb2wfG1/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.3ET1RgBnuY/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 00:55:33 INFO - MultiFileLogger online at 20160830 00:55:33 in /builds/slave/test 00:55:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 00:55:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:55:33 INFO - {'append_to_log': False, 00:55:33 INFO - 'base_work_dir': '/builds/slave/test', 00:55:33 INFO - 'blob_upload_branch': 'Fx-Team', 00:55:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:55:33 INFO - 'branch': 'Fx-Team', 00:55:33 INFO - 'buildbot_json_path': 'buildprops.json', 00:55:33 INFO - 'config_files': ('talos/mac_config.py',), 00:55:33 INFO - 'default_actions': ('clobber', 00:55:33 INFO - 'read-buildbot-config', 00:55:33 INFO - 'download-and-extract', 00:55:33 INFO - 'populate-webroot', 00:55:33 INFO - 'create-virtualenv', 00:55:33 INFO - 'install', 00:55:33 INFO - 'run-tests'), 00:55:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:55:33 INFO - 'download_minidump_stackwalk': True, 00:55:33 INFO - 'download_symbols': 'ondemand', 00:55:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:55:33 INFO - 'tooltool.py': '/tools/tooltool.py', 00:55:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:55:33 INFO - '/tools/misc-python/virtualenv.py')}, 00:55:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:55:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:55:33 INFO - 'installer_path': 'installer.exe', 00:55:33 INFO - 'log_level': 'info', 00:55:33 INFO - 'log_name': 'talos', 00:55:33 INFO - 'log_to_console': True, 00:55:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:55:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:55:33 INFO - 'opt_config_files': (), 00:55:33 INFO - 'pip_index': False, 00:55:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:55:33 INFO - 'cmd': ('bash', 00:55:33 INFO - '-c', 00:55:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:55:33 INFO - 'enabled': True, 00:55:33 INFO - 'halt_on_failure': False, 00:55:33 INFO - 'name': 'check_screen_resolution'},), 00:55:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:55:33 INFO - 'cmd': ('bash', 00:55:33 INFO - '-c', 00:55:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:55:33 INFO - 'enabled': True, 00:55:33 INFO - 'halt_on_failure': False, 00:55:33 INFO - 'name': 'check_screen_resolution'},), 00:55:33 INFO - 'run_cmd_checks_enabled': True, 00:55:33 INFO - 'sps_profile': False, 00:55:33 INFO - 'sps_profile_interval': 0, 00:55:33 INFO - 'suite': 'dromaeojs-e10s', 00:55:33 INFO - 'system_bits': '32', 00:55:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:55:33 INFO - 'title': 't-yosemite-r7-0141', 00:55:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:55:33 INFO - 'use_talos_json': True, 00:55:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:55:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:55:33 INFO - 'work_dir': 'build'} 00:55:33 INFO - [mozharness: 2016-08-30 07:55:33.490651Z] Running clobber step. 00:55:33 INFO - Running pre-action listener: _resource_record_pre_action 00:55:33 INFO - Running main action method: clobber 00:55:33 INFO - rmtree: /builds/slave/test/build 00:55:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:55:35 INFO - Running post-action listener: _resource_record_post_action 00:55:35 INFO - [mozharness: 2016-08-30 07:55:35.639846Z] Finished clobber step (success) 00:55:35 INFO - [mozharness: 2016-08-30 07:55:35.639998Z] Running read-buildbot-config step. 00:55:35 INFO - Running pre-action listener: _resource_record_pre_action 00:55:35 INFO - Running main action method: read_buildbot_config 00:55:35 INFO - Using buildbot properties: 00:55:35 INFO - { 00:55:35 INFO - "project": "", 00:55:35 INFO - "product": "firefox", 00:55:35 INFO - "script_repo_revision": "production", 00:55:35 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 00:55:35 INFO - "repository": "", 00:55:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 00:55:35 INFO - "buildid": "20160829213422", 00:55:35 INFO - "pgo_build": "False", 00:55:35 INFO - "basedir": "/builds/slave/test", 00:55:35 INFO - "buildnumber": 105, 00:55:35 INFO - "slavename": "t-yosemite-r7-0141", 00:55:35 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 00:55:35 INFO - "platform": "yosemite_r7", 00:55:35 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 00:55:35 INFO - "branch": "fx-team", 00:55:35 INFO - "repo_path": "integration/fx-team", 00:55:35 INFO - "revision": "26e22af660e543ebb69930f082188b69ec756185", 00:55:35 INFO - "stage_platform": "macosx64", 00:55:35 INFO - "builduid": "f0faef083a7a4bdf9f0a42a6cb8003f9", 00:55:35 INFO - "slavebuilddir": "test" 00:55:35 INFO - } 00:55:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/bHvsR6g7RmCy14w2acRrZg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 00:55:35 INFO - Running post-action listener: _resource_record_post_action 00:55:35 INFO - [mozharness: 2016-08-30 07:55:35.643518Z] Finished read-buildbot-config step (success) 00:55:35 INFO - [mozharness: 2016-08-30 07:55:35.643632Z] Running download-and-extract step. 00:55:35 INFO - Running pre-action listener: _resource_record_pre_action 00:55:35 INFO - Running main action method: download_and_extract 00:55:35 INFO - mkdir: /builds/slave/test/build/tests 00:55:35 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')]} 00:55:35 INFO - trying https://queue.taskcluster.net/v1/task/bHvsR6g7RmCy14w2acRrZg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 00:55:35 INFO - Downloading https://queue.taskcluster.net/v1/task/bHvsR6g7RmCy14w2acRrZg/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 00:55:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bHvsR6g7RmCy14w2acRrZg/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 00:55:36 INFO - Downloaded 1199 bytes. 00:55:36 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 00:55:36 INFO - Using the following test package requirements: 00:55:36 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 00:55:36 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:55:36 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 00:55:36 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:55:36 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 00:55:36 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:55:36 INFO - u'jsshell-mac.zip'], 00:55:36 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:55:36 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 00:55:36 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 00:55:36 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:55:36 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 00:55:36 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:55:36 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 00:55:36 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:55:36 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 00:55:36 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:55:36 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 00:55:36 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 00:55:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:36 INFO - trying https://queue.taskcluster.net/v1/task/bHvsR6g7RmCy14w2acRrZg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 00:55:36 INFO - Downloading https://queue.taskcluster.net/v1/task/bHvsR6g7RmCy14w2acRrZg/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 00:55:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bHvsR6g7RmCy14w2acRrZg/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 00:55:37 INFO - Downloaded 16380506 bytes. 00:55:37 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 00:55:44 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 00: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')]} 00:55:44 INFO - trying https://queue.taskcluster.net/v1/task/bHvsR6g7RmCy14w2acRrZg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 00:55:44 INFO - Downloading https://queue.taskcluster.net/v1/task/bHvsR6g7RmCy14w2acRrZg/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 00:55:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bHvsR6g7RmCy14w2acRrZg/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 00:55:45 INFO - Downloaded 16380506 bytes. 00:55:45 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 00:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:52 INFO - trying https://queue.taskcluster.net/v1/task/bHvsR6g7RmCy14w2acRrZg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 00:55:52 INFO - Downloading https://queue.taskcluster.net/v1/task/bHvsR6g7RmCy14w2acRrZg/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 00:55:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bHvsR6g7RmCy14w2acRrZg/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 00:55:53 INFO - Downloaded 14413998 bytes. 00:55:53 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 00: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')]} 00:55:53 INFO - trying https://queue.taskcluster.net/v1/task/bHvsR6g7RmCy14w2acRrZg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 00:55:53 INFO - Downloading https://queue.taskcluster.net/v1/task/bHvsR6g7RmCy14w2acRrZg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 00:55:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bHvsR6g7RmCy14w2acRrZg/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 00:55:56 INFO - Downloaded 111551627 bytes. 00:55:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bHvsR6g7RmCy14w2acRrZg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 00:55:56 INFO - mkdir: /builds/slave/test/properties 00:55:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:55:56 INFO - Writing to file /builds/slave/test/properties/build_url 00:55:56 INFO - Contents: 00:55:56 INFO - build_url:https://queue.taskcluster.net/v1/task/bHvsR6g7RmCy14w2acRrZg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 00:55:57 INFO - Running post-action listener: _resource_record_post_action 00:55:57 INFO - Running post-action listener: set_extra_try_arguments 00:55:57 INFO - [mozharness: 2016-08-30 07:55:57.062462Z] Finished download-and-extract step (success) 00:55:57 INFO - [mozharness: 2016-08-30 07:55:57.062590Z] Running populate-webroot step. 00:55:57 INFO - Running pre-action listener: _resource_record_pre_action 00:55:57 INFO - Running main action method: populate_webroot 00:55:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:55:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:55:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:55:57 INFO - '--tppagecycles', 00:55:57 INFO - '7'], 00:55:57 INFO - 'tests': ['tsvgm']}}, 00:55:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:55:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:55:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:55:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:55:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:55:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:55:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:55:57 INFO - 'talos_options': ['--disable-e10s'], 00:55:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:55:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:55:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:55:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:55:57 INFO - 'talos_options': ['--disable-e10s'], 00:55:57 INFO - 'tests': ['damp', 'tps']}, 00:55:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:55:57 INFO - 'tests': ['damp', 'tps']}, 00:55:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:55:57 INFO - 'tests': ['dromaeo_dom']}, 00:55:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:55:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:55:57 INFO - 'tests': ['basic_compositor_video']}, 00:55:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:55:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:55:57 INFO - 'tests': ['a11yr', 00:55:57 INFO - 'ts_paint', 00:55:57 INFO - 'tpaint', 00:55:57 INFO - 'sessionrestore', 00:55:57 INFO - 'sessionrestore_no_auto_restore', 00:55:57 INFO - 'tabpaint']}, 00:55:57 INFO - 'other-e10s': {'tests': ['a11yr', 00:55:57 INFO - 'ts_paint', 00:55:57 INFO - 'tpaint', 00:55:57 INFO - 'sessionrestore', 00:55:57 INFO - 'sessionrestore_no_auto_restore', 00:55:57 INFO - 'tabpaint']}, 00:55:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:55:57 INFO - 'ts_paint', 00:55:57 INFO - 'tpaint', 00:55:57 INFO - 'sessionrestore', 00:55:57 INFO - 'sessionrestore_no_auto_restore', 00:55:57 INFO - 'tabpaint']}, 00:55:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:55:57 INFO - 'ts_paint', 00:55:57 INFO - 'tpaint', 00:55:57 INFO - 'sessionrestore', 00:55:57 INFO - 'sessionrestore_no_auto_restore', 00:55:57 INFO - 'tabpaint']}, 00:55:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:55:57 INFO - 'tests': ['a11yr', 00:55:57 INFO - 'ts_paint', 00:55:57 INFO - 'tpaint', 00:55:57 INFO - 'sessionrestore', 00:55:57 INFO - 'sessionrestore_no_auto_restore', 00:55:57 INFO - 'tabpaint']}, 00:55:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:55:57 INFO - 'tests': ['a11yr', 00:55:57 INFO - 'ts_paint', 00:55:57 INFO - 'tpaint', 00:55:57 INFO - 'sessionrestore', 00:55:57 INFO - 'sessionrestore_no_auto_restore', 00:55:57 INFO - 'tabpaint']}, 00:55:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:55:57 INFO - 'tests': ['tsvgx', 00:55:57 INFO - 'tsvgr_opacity', 00:55:57 INFO - 'tart', 00:55:57 INFO - 'tscrollx', 00:55:57 INFO - 'cart']}, 00:55:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:55:57 INFO - 'tsvgr_opacity', 00:55:57 INFO - 'tart', 00:55:57 INFO - 'tscrollx', 00:55:57 INFO - 'cart']}, 00:55:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:55:57 INFO - 'talos_options': ['--disable-e10s'], 00:55:57 INFO - 'tests': ['tp5o']}, 00:55:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:55:57 INFO - 'tests': ['tp5o']}, 00:55:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:55:57 INFO - 'talos_options': ['--disable-e10s', 00:55:57 INFO - '--xperf_path', 00:55:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:55:57 INFO - 'tests': ['tp5n']}, 00:55:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:55:57 INFO - 'talos_options': ['--xperf_path', 00:55:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:55:57 INFO - 'tests': ['tp5n']}}, 00:55:57 INFO - 'talos.zip': {'path': '', 00:55:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:55:57 INFO - Running post-action listener: _resource_record_post_action 00:55:57 INFO - [mozharness: 2016-08-30 07:55:57.079264Z] Finished populate-webroot step (success) 00:55:57 INFO - [mozharness: 2016-08-30 07:55:57.079366Z] Running create-virtualenv step. 00:55:57 INFO - Running pre-action listener: _resource_record_pre_action 00:55:57 INFO - Running main action method: create_virtualenv 00:55:57 INFO - Creating virtualenv /builds/slave/test/build/venv 00:55:57 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 00:55:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:55:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:55:57 INFO - Using real prefix '/tools/python27' 00:55:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:55:57 INFO - Installing distribute.............................................................................................................................................................................................done. 00:56:00 INFO - Installing pip.................done. 00:56:00 INFO - Return code: 0 00:56:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d7a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d837618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facba479080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d706d30>, '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 0x10d46bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6feb20>, '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.FeHhb2wfG1/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.3ET1RgBnuY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 00:56:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:56:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:56:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FeHhb2wfG1/Render', 00:56:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:56:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:56:00 INFO - 'HOME': '/Users/cltbld', 00:56:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:56:00 INFO - 'LOGNAME': 'cltbld', 00:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:00 INFO - 'MOZ_NO_REMOTE': '1', 00:56:00 INFO - 'NO_EM_RESTART': '1', 00:56:00 INFO - 'PAGER': '/bin/cat', 00:56:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:00 INFO - 'PWD': '/builds/slave/test', 00:56:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:56:00 INFO - 'SHELL': '/bin/bash', 00:56:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3ET1RgBnuY/Listeners', 00:56:00 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 00:56:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:56:00 INFO - 'USER': 'cltbld', 00:56:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:56:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:00 INFO - 'XPC_FLAGS': '0x0', 00:56:00 INFO - 'XPC_SERVICE_NAME': '0', 00:56:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:01 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 00:56:01 INFO - Cleaning up... 00:56:01 INFO - Return code: 0 00:56:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:01 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 0x10d7a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d837618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facba479080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d706d30>, '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 0x10d46bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6feb20>, '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.FeHhb2wfG1/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.3ET1RgBnuY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 00:56:01 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 00:56:01 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 00:56:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FeHhb2wfG1/Render', 00:56:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:56:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:56:01 INFO - 'HOME': '/Users/cltbld', 00:56:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:56:01 INFO - 'LOGNAME': 'cltbld', 00:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:01 INFO - 'MOZ_NO_REMOTE': '1', 00:56:01 INFO - 'NO_EM_RESTART': '1', 00:56:01 INFO - 'PAGER': '/bin/cat', 00:56:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:01 INFO - 'PWD': '/builds/slave/test', 00:56:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:56:01 INFO - 'SHELL': '/bin/bash', 00:56:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3ET1RgBnuY/Listeners', 00:56:01 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 00:56:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:56:01 INFO - 'USER': 'cltbld', 00:56:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:56:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:01 INFO - 'XPC_FLAGS': '0x0', 00:56:01 INFO - 'XPC_SERVICE_NAME': '0', 00:56:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:01 INFO - Downloading/unpacking psutil>=3.1.1 00:56:01 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 00:56:01 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 00:56:01 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 00:56:01 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 00:56:01 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 00:56:01 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 00:56:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:56:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:56:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:56:05 INFO - Installing collected packages: psutil 00:56:05 INFO - Running setup.py install for psutil 00:56:05 INFO - building 'psutil._psutil_osx' extension 00:56:05 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 00:56:05 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 00:56:05 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 00:56:06 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 00:56:06 INFO - building 'psutil._psutil_posix' extension 00:56:06 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 00:56:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:56:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:56:06 INFO - ^ 00:56:06 INFO - 1 warning generated. 00:56:06 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 00:56:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:56:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:56:06 INFO - Successfully installed psutil 00:56:06 INFO - Cleaning up... 00:56:06 INFO - Return code: 0 00:56:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:56:06 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')]} 00:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:06 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')]} 00:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:06 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 0x10d7a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d837618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facba479080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d706d30>, '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 0x10d46bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6feb20>, '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.FeHhb2wfG1/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.3ET1RgBnuY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 00:56:06 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 00:56:06 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 00:56:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FeHhb2wfG1/Render', 00:56:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:56:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:56:06 INFO - 'HOME': '/Users/cltbld', 00:56:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:56:06 INFO - 'LOGNAME': 'cltbld', 00:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:06 INFO - 'MOZ_NO_REMOTE': '1', 00:56:06 INFO - 'NO_EM_RESTART': '1', 00:56:06 INFO - 'PAGER': '/bin/cat', 00:56:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:06 INFO - 'PWD': '/builds/slave/test', 00:56:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:56:06 INFO - 'SHELL': '/bin/bash', 00:56:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3ET1RgBnuY/Listeners', 00:56:06 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 00:56:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:56:06 INFO - 'USER': 'cltbld', 00:56:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:56:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:06 INFO - 'XPC_FLAGS': '0x0', 00:56:06 INFO - 'XPC_SERVICE_NAME': '0', 00:56:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:56:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:56:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:56:09 INFO - Installing collected packages: mozsystemmonitor 00:56:09 INFO - Running setup.py install for mozsystemmonitor 00:56:09 INFO - Successfully installed mozsystemmonitor 00:56:09 INFO - Cleaning up... 00:56:09 INFO - Return code: 0 00:56:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:56:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:09 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 0x10d7a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d837618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facba479080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d706d30>, '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 0x10d46bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6feb20>, '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.FeHhb2wfG1/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.3ET1RgBnuY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 00:56:09 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 00:56:09 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 00:56:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FeHhb2wfG1/Render', 00:56:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:56:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:56:09 INFO - 'HOME': '/Users/cltbld', 00:56:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:56:09 INFO - 'LOGNAME': 'cltbld', 00:56:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:09 INFO - 'MOZ_NO_REMOTE': '1', 00:56:09 INFO - 'NO_EM_RESTART': '1', 00:56:09 INFO - 'PAGER': '/bin/cat', 00:56:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:56:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:09 INFO - 'PWD': '/builds/slave/test', 00:56:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:56:09 INFO - 'SHELL': '/bin/bash', 00:56:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3ET1RgBnuY/Listeners', 00:56:09 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 00:56:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:56:09 INFO - 'USER': 'cltbld', 00:56:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:56:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:09 INFO - 'XPC_FLAGS': '0x0', 00:56:09 INFO - 'XPC_SERVICE_NAME': '0', 00:56:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:56:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:09 INFO - Downloading/unpacking jsonschema==2.5.1 00:56:09 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 00:56:09 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 00:56:09 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 00:56:09 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 00:56:09 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 00:56:09 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 00:56:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:56:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:56:12 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 00:56:12 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 00:56:12 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 00:56:12 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 00:56:12 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 00:56:12 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 00:56:12 INFO - Downloading functools32-3.2.3-2.tar.gz 00:56:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:56:12 INFO - warning: no files found matching '*.txt' 00:56:12 INFO - no previously-included directories found matching 'build' 00:56:12 INFO - no previously-included directories found matching 'dist' 00:56:12 INFO - no previously-included directories found matching '.git*' 00:56:12 INFO - Installing collected packages: jsonschema, functools32 00:56:12 INFO - Running setup.py install for functools32 00:56:12 INFO - warning: no files found matching '*.txt' 00:56:12 INFO - no previously-included directories found matching 'build' 00:56:12 INFO - no previously-included directories found matching 'dist' 00:56:12 INFO - no previously-included directories found matching '.git*' 00:56:12 INFO - Successfully installed jsonschema functools32 00:56:12 INFO - Cleaning up... 00:56:12 INFO - Return code: 0 00:56:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:56:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:56:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:12 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 0x10d7a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d837618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facba479080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d706d30>, '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 0x10d46bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6feb20>, '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.FeHhb2wfG1/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.3ET1RgBnuY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 00:56:12 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 00:56:12 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 00:56:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FeHhb2wfG1/Render', 00:56:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:56:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:56:12 INFO - 'HOME': '/Users/cltbld', 00:56:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:56:12 INFO - 'LOGNAME': 'cltbld', 00:56:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:12 INFO - 'MOZ_NO_REMOTE': '1', 00:56:12 INFO - 'NO_EM_RESTART': '1', 00:56:12 INFO - 'PAGER': '/bin/cat', 00:56:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:56:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:12 INFO - 'PWD': '/builds/slave/test', 00:56:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:56:12 INFO - 'SHELL': '/bin/bash', 00:56:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3ET1RgBnuY/Listeners', 00:56:12 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 00:56:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:56:12 INFO - 'USER': 'cltbld', 00:56:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:56:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:56:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:12 INFO - 'XPC_FLAGS': '0x0', 00:56:12 INFO - 'XPC_SERVICE_NAME': '0', 00:56:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:56:13 INFO - Cleaning up... 00:56:13 INFO - Return code: 0 00:56:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:13 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 0x10d7a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d837618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facba479080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d706d30>, '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 0x10d46bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6feb20>, '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.FeHhb2wfG1/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.3ET1RgBnuY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 00:56:13 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 00:56:13 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 00:56:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FeHhb2wfG1/Render', 00:56:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:56:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:56:13 INFO - 'HOME': '/Users/cltbld', 00:56:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:56:13 INFO - 'LOGNAME': 'cltbld', 00:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:13 INFO - 'MOZ_NO_REMOTE': '1', 00:56:13 INFO - 'NO_EM_RESTART': '1', 00:56:13 INFO - 'PAGER': '/bin/cat', 00:56:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:13 INFO - 'PWD': '/builds/slave/test', 00:56:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:56:13 INFO - 'SHELL': '/bin/bash', 00:56:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3ET1RgBnuY/Listeners', 00:56:13 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 00:56:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:56:13 INFO - 'USER': 'cltbld', 00:56:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:56:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:13 INFO - 'XPC_FLAGS': '0x0', 00:56:13 INFO - 'XPC_SERVICE_NAME': '0', 00:56:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:13 INFO - Downloading/unpacking blobuploader==1.2.4 00:56:13 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 00:56:13 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 00:56:13 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 00:56:13 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 00:56:13 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 00:56:13 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 00:56:15 INFO - Downloading blobuploader-1.2.4.tar.gz 00:56:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:56:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:56:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:17 INFO - Downloading docopt-0.6.1.tar.gz 00:56:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:56:17 INFO - Installing collected packages: blobuploader, requests, docopt 00:56:17 INFO - Running setup.py install for blobuploader 00:56:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:56:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:56:17 INFO - Running setup.py install for requests 00:56:17 INFO - Running setup.py install for docopt 00:56:18 INFO - Successfully installed blobuploader requests docopt 00:56:18 INFO - Cleaning up... 00:56:18 INFO - Return code: 0 00:56:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:56:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:56:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:18 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 0x10d7a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d837618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facba479080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d706d30>, '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 0x10d46bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6feb20>, '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.FeHhb2wfG1/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.3ET1RgBnuY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 00:56:18 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 00:56:18 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 00:56:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FeHhb2wfG1/Render', 00:56:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:56:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:56:18 INFO - 'HOME': '/Users/cltbld', 00:56:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:56:18 INFO - 'LOGNAME': 'cltbld', 00:56:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:18 INFO - 'MOZ_NO_REMOTE': '1', 00:56:18 INFO - 'NO_EM_RESTART': '1', 00:56:18 INFO - 'PAGER': '/bin/cat', 00:56:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:56:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:18 INFO - 'PWD': '/builds/slave/test', 00:56:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:56:18 INFO - 'SHELL': '/bin/bash', 00:56:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3ET1RgBnuY/Listeners', 00:56:18 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 00:56:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:56:18 INFO - 'USER': 'cltbld', 00:56:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:56:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:56:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:18 INFO - 'XPC_FLAGS': '0x0', 00:56:18 INFO - 'XPC_SERVICE_NAME': '0', 00:56:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:56:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:56:18 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-MBD9aS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:56:18 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-ukcSmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:56:18 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-7DOW9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:56:18 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-E9fkdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:56:18 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-7e_p83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:56:18 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-pkS3jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:56:19 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-pUA1pT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:56:19 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-QJIxjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:56:19 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-zx6agv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:56:19 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-frs2Rw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:56:19 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-tawjMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:56:19 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-iG3sPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:56:19 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-re2d3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:56:19 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-8EDObA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:56:19 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-FTG4ZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:56:19 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-5Plgtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:56:20 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-ODNJuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:56:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:56:20 INFO - Running setup.py install for manifestparser 00:56:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:56:20 INFO - Running setup.py install for mozcrash 00:56:20 INFO - Running setup.py install for mozdebug 00:56:20 INFO - Running setup.py install for mozdevice 00:56:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:56:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:56:20 INFO - Running setup.py install for mozfile 00:56:20 INFO - Running setup.py install for mozhttpd 00:56:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:56:21 INFO - Running setup.py install for mozinfo 00:56:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:56:21 INFO - Running setup.py install for mozInstall 00:56:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:56:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:56:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:56:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:56:21 INFO - Running setup.py install for mozleak 00:56:21 INFO - Running setup.py install for mozlog 00:56:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:56:21 INFO - Running setup.py install for moznetwork 00:56:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:56:21 INFO - Running setup.py install for mozprocess 00:56:21 INFO - Running setup.py install for mozprofile 00:56:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:56:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:56:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:56:22 INFO - Running setup.py install for mozrunner 00:56:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:56:22 INFO - Running setup.py install for mozscreenshot 00:56:22 INFO - Running setup.py install for moztest 00:56:22 INFO - Running setup.py install for mozversion 00:56:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:56:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:56:22 INFO - Cleaning up... 00:56:22 INFO - Return code: 0 00:56:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:56:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:22 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 0x10d7a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d837618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facba479080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d706d30>, '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 0x10d46bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6feb20>, '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.FeHhb2wfG1/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.3ET1RgBnuY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 00:56:22 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 00:56:22 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 00:56:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FeHhb2wfG1/Render', 00:56:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:56:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:56:22 INFO - 'HOME': '/Users/cltbld', 00:56:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:56:22 INFO - 'LOGNAME': 'cltbld', 00:56:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:22 INFO - 'MOZ_NO_REMOTE': '1', 00:56:22 INFO - 'NO_EM_RESTART': '1', 00:56:22 INFO - 'PAGER': '/bin/cat', 00:56:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:56:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:22 INFO - 'PWD': '/builds/slave/test', 00:56:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:56:22 INFO - 'SHELL': '/bin/bash', 00:56:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3ET1RgBnuY/Listeners', 00:56:22 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 00:56:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:56:22 INFO - 'USER': 'cltbld', 00:56:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:56:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:56:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:22 INFO - 'XPC_FLAGS': '0x0', 00:56:22 INFO - 'XPC_SERVICE_NAME': '0', 00:56:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:56:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:56:23 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-TQAnkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:56:23 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)) 00:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:56:23 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-TeRuYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:56:23 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)) 00:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:56:23 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-KIgmtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:56:23 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)) 00:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:56:23 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-zuwY6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:56:23 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)) 00:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:56:23 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-GOur7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:56:23 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)) 00:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:56:23 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-tMuVow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:56:23 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)) 00:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:56:23 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-qarnvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:56:23 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)) 00:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:56:23 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-LekElU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:56:23 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)) 00:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:56:23 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-7AhPVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:56:23 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)) 00:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:56:23 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-fGWkiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:56:24 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)) 00:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:56:24 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-q6Zros-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:56:24 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)) 00:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:56:24 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-_3aUbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:56:24 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)) 00:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:56:24 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-_ldmlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:56:24 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)) 00:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:56:24 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-jBaurm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:56:24 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)) 00:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:56:24 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-pILiq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:56:24 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)) 00:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:56:24 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-APJmMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:56:24 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)) 00:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:56:24 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-1scD67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:56:24 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)) 00:56:24 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)) 00:56:24 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)) 00:56:24 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)) 00:56:24 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)) 00:56:24 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)) 00:56:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:27 INFO - Downloading blessings-1.6.tar.gz 00:56:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:56:27 INFO - Installing collected packages: blessings 00:56:27 INFO - Running setup.py install for blessings 00:56:27 INFO - Successfully installed blessings 00:56:27 INFO - Cleaning up... 00:56:27 INFO - Return code: 0 00:56:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:56:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:56:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:56:27 INFO - Reading from file tmpfile_stdout 00:56:27 INFO - Current package versions: 00:56:27 INFO - blessings == 1.6 00:56:27 INFO - blobuploader == 1.2.4 00:56:27 INFO - docopt == 0.6.1 00:56:27 INFO - functools32 == 3.2.3-2 00:56:27 INFO - jsonschema == 2.5.1 00:56:27 INFO - manifestparser == 1.1 00:56:27 INFO - mozInstall == 1.12 00:56:27 INFO - mozcrash == 0.17 00:56:27 INFO - mozdebug == 0.1 00:56:27 INFO - mozdevice == 0.48 00:56:27 INFO - mozfile == 1.2 00:56:27 INFO - mozhttpd == 0.7 00:56:27 INFO - mozinfo == 0.9 00:56:27 INFO - mozleak == 0.1 00:56:27 INFO - mozlog == 3.3 00:56:27 INFO - moznetwork == 0.27 00:56:27 INFO - mozprocess == 0.23 00:56:27 INFO - mozprofile == 0.28 00:56:27 INFO - mozrunner == 6.12 00:56:27 INFO - mozscreenshot == 0.1 00:56:27 INFO - mozsystemmonitor == 0.3 00:56:27 INFO - moztest == 0.7 00:56:27 INFO - mozversion == 1.4 00:56:27 INFO - psutil == 3.1.1 00:56:27 INFO - requests == 1.2.3 00:56:27 INFO - wsgiref == 0.1.2 00:56:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:56:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:27 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 0x10d7a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d837618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facba479080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d706d30>, '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 0x10d46bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6feb20>, '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.FeHhb2wfG1/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.3ET1RgBnuY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 00:56:27 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 00:56:27 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 00:56:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FeHhb2wfG1/Render', 00:56:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:56:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:56:27 INFO - 'HOME': '/Users/cltbld', 00:56:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:56:27 INFO - 'LOGNAME': 'cltbld', 00:56:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:27 INFO - 'MOZ_NO_REMOTE': '1', 00:56:27 INFO - 'NO_EM_RESTART': '1', 00:56:27 INFO - 'PAGER': '/bin/cat', 00:56:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:56:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:27 INFO - 'PWD': '/builds/slave/test', 00:56:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:56:27 INFO - 'SHELL': '/bin/bash', 00:56:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3ET1RgBnuY/Listeners', 00:56:27 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 00:56:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:56:27 INFO - 'USER': 'cltbld', 00:56:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:56:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:56:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:27 INFO - 'XPC_FLAGS': '0x0', 00:56:27 INFO - 'XPC_SERVICE_NAME': '0', 00:56:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:56:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:28 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)) 00:56:28 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)) 00:56:28 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)) 00:56:28 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)) 00:56:28 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)) 00:56:28 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)) 00:56:28 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)) 00:56:28 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)) 00:56:28 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)) 00:56:28 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)) 00:56:28 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)) 00:56:28 INFO - Cleaning up... 00:56:28 INFO - Return code: 0 00:56:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:56:28 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')]} 00:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:28 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')]} 00:56:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:28 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 0x10d7a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d837618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facba479080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d706d30>, '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 0x10d46bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6feb20>, '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.FeHhb2wfG1/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.3ET1RgBnuY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 00:56:28 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 00:56:28 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 00:56:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FeHhb2wfG1/Render', 00:56:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:56:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:56:28 INFO - 'HOME': '/Users/cltbld', 00:56:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:56:28 INFO - 'LOGNAME': 'cltbld', 00:56:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:28 INFO - 'MOZ_NO_REMOTE': '1', 00:56:28 INFO - 'NO_EM_RESTART': '1', 00:56:28 INFO - 'PAGER': '/bin/cat', 00:56:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:56:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:28 INFO - 'PWD': '/builds/slave/test', 00:56:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:56:28 INFO - 'SHELL': '/bin/bash', 00:56:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3ET1RgBnuY/Listeners', 00:56:28 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 00:56:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:56:28 INFO - 'USER': 'cltbld', 00:56:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:56:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:56:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:28 INFO - 'XPC_FLAGS': '0x0', 00:56:28 INFO - 'XPC_SERVICE_NAME': '0', 00:56:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:56:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:56:28 INFO - Cleaning up... 00:56:28 INFO - Return code: 0 00:56:28 INFO - Running post-action listener: _resource_record_post_action 00:56:28 INFO - Running post-action listener: _start_resource_monitoring 00:56:28 INFO - Starting resource monitoring. 00:56:28 INFO - [mozharness: 2016-08-30 07:56:28.429972Z] Finished create-virtualenv step (success) 00:56:28 INFO - [mozharness: 2016-08-30 07:56:28.430948Z] Running install step. 00:56:28 INFO - Running pre-action listener: _resource_record_pre_action 00:56:28 INFO - Running main action method: install 00:56:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:56:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:56:28 INFO - Reading from file tmpfile_stdout 00:56:28 INFO - Detecting whether we're running mozinstall >=1.0... 00:56:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:56:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:56:28 INFO - Reading from file tmpfile_stdout 00:56:28 INFO - Output received: 00:56:28 INFO - Usage: mozinstall [options] installer 00:56:28 INFO - Options: 00:56:28 INFO - -h, --help show this help message and exit 00:56:28 INFO - -d DEST, --destination=DEST 00:56:28 INFO - Directory to install application into. [default: 00:56:28 INFO - "/builds/slave/test"] 00:56:28 INFO - --app=APP Application being installed. [default: firefox] 00:56:28 INFO - mkdir: /builds/slave/test/build/application 00:56:28 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'] 00:56:28 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 00:57:02 INFO - Reading from file tmpfile_stdout 00:57:02 INFO - Output received: 00:57:02 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 00:57:02 INFO - Running post-action listener: _resource_record_post_action 00:57:02 INFO - [mozharness: 2016-08-30 07:57:02.730656Z] Finished install step (success) 00:57:02 INFO - [mozharness: 2016-08-30 07:57:02.730794Z] Running run-tests step. 00:57:02 INFO - Running pre-action listener: _resource_record_pre_action 00:57:02 INFO - Running main action method: run_tests 00:57:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:57:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:57:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:57:02 INFO - 2016-08-30 00:57:02.745 screenresolution[1644:8471] starting screenresolution argv=screenresolution get 00:57:02 INFO - 2016-08-30 00:57:02.748 screenresolution[1644:8471] Display 0: 1600x1200x32@60 00:57:02 INFO - 2016-08-30 00:57:02.754 screenresolution[1645:8473] starting screenresolution argv=screenresolution list 00:57:02 INFO - Available Modes on Display 0 00:57:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:57:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:57:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:57:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:57:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:57:02 INFO - Intel Iris: 00:57:02 INFO - Chipset Model: Intel Iris 00:57:02 INFO - Type: GPU 00:57:02 INFO - Bus: Built-In 00:57:02 INFO - VRAM (Dynamic, Max): 1536 MB 00:57:02 INFO - Vendor: Intel (0x8086) 00:57:02 INFO - Device ID: 0x0a2e 00:57:02 INFO - Revision ID: 0x0009 00:57:02 INFO - Displays: 00:57:02 INFO - Display: 00:57:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:57:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:57:02 INFO - Display Serial Number: 1600x1200 60 00:57:02 INFO - Main Display: Yes 00:57:02 INFO - Mirror: Off 00:57:02 INFO - Online: Yes 00:57:02 INFO - Rotation: Supported 00:57:02 INFO - Return code: 0 00:57:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:57:02 INFO - Python 2.7.3 00:57:02 INFO - Return code: 0 00:57:02 INFO - grabbing minidump binary from tooltool 00:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:57:02 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 0x10d706d30>, '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 0x10d46bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6feb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:57:02 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 00:57:02 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 00:57:02 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 00:57:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:57:03 INFO - Return code: 0 00:57:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:57:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:57:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:57:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:57:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:57:03 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bHvsR6g7RmCy14w2acRrZg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0141', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 00:57:03 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-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bHvsR6g7RmCy14w2acRrZg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0141 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 00:57:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FeHhb2wfG1/Render', 00:57:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:57:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:57:03 INFO - 'HOME': '/Users/cltbld', 00:57:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:57:03 INFO - 'LOGNAME': 'cltbld', 00:57:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:57:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:57:03 INFO - 'MOZ_NO_REMOTE': '1', 00:57:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:57:03 INFO - 'NO_EM_RESTART': '1', 00:57:03 INFO - 'PAGER': '/bin/cat', 00:57:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:57:03 INFO - 'PWD': '/builds/slave/test', 00:57:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:57:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:57:03 INFO - 'SHELL': '/bin/bash', 00:57:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3ET1RgBnuY/Listeners', 00:57:03 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 00:57:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:57:03 INFO - 'USER': 'cltbld', 00:57:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:57:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:57:03 INFO - 'XPC_FLAGS': '0x0', 00:57:03 INFO - 'XPC_SERVICE_NAME': '0', 00:57:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:57:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bHvsR6g7RmCy14w2acRrZg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0141', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 00:57:03 INFO - mozversion application_buildid: 20160829213422 00:57:03 INFO - mozversion application_changeset: 26e22af660e543ebb69930f082188b69ec756185 00:57:03 INFO - mozversion application_display_name: Nightly 00:57:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:57:03 INFO - mozversion application_name: Firefox 00:57:03 INFO - mozversion application_remotingname: firefox 00:57:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:57:03 INFO - mozversion application_vendor: Mozilla 00:57:03 INFO - mozversion application_version: 51.0a1 00:57:03 INFO - mozversion platform_buildid: 20160829213422 00:57:03 INFO - mozversion platform_changeset: 26e22af660e543ebb69930f082188b69ec756185 00:57:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:57:03 INFO - mozversion platform_version: 51.0a1 00:57:03 INFO - using testdate: 1472543823 00:57:03 INFO - actual date: 1472543823 00:57:03 INFO - starting webserver on 'localhost:49268' 00:57:03 INFO - SUITE-START | Running 2 tests 00:57:03 INFO - TEST-START | dromaeo_css 00:57:03 INFO - operating with platform_type : mac_ 00:57:03 INFO - Initialising browser for dromaeo_css test... 00:57:03 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/tmpGrV7im/profile http://localhost:49268/getInfo.html) 00:57:06 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 00:57:06 INFO - PROCESS | 1655 | colorDepth:24 00:57:06 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 00:57:06 INFO - PROCESS | 1655 | __metrics 00:57:06 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 00:57:07 INFO - TEST-INFO | 1655: exit 0 00:57:07 INFO - Browser initialized. 00:57:07 INFO - Running cycle 1/1 for dromaeo_css test... 00:57:07 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/tmpGrV7im/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:57:18 INFO - PROCESS | 1659 | RSS: Main: 243761152 00:57:18 INFO - PROCESS | 1659 | 00:58:08 INFO - PROCESS | 1659 | 1472543888609 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] 01:00:20 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49268/tests/dromaeo/cssquery-ext.html) 01:00:21 INFO - PROCESS | 1659 | RSS: Main: 261922816 01:00:21 INFO - PROCESS | 1659 | 01:03:24 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-ext.html (next: http://localhost:49268/tests/dromaeo/cssquery-jquery.html) 01:03:24 INFO - PROCESS | 1659 | RSS: Main: 267964416 01:03:24 INFO - PROCESS | 1659 | 01:06:26 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49268/tests/dromaeo/cssquery-mootools.html) 01:06:27 INFO - PROCESS | 1659 | RSS: Main: 275369984 01:06:27 INFO - PROCESS | 1659 | 01:09:29 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49268/tests/dromaeo/cssquery-prototype.html) 01:09:29 INFO - PROCESS | 1659 | RSS: Main: 270442496 01:09:29 INFO - PROCESS | 1659 | 01:12:32 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49268/tests/dromaeo/cssquery-yui.html) 01:12:33 INFO - PROCESS | 1659 | RSS: Main: 275853312 01:12:33 INFO - PROCESS | 1659 | 01:15:35 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-yui.html (next: http://localhost:49268/tests/dromaeo/cssquery-dojo.html) 01:15:36 INFO - PROCESS | 1659 | RSS: Main: 279126016 01:15:36 INFO - PROCESS | 1659 | 01:15:36 INFO - PROCESS | 1659 | __start_tp_report 01:15:36 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 01:15:36 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 01:15:36 INFO - PROCESS | 1659 | |i|pagename|runs| 01:15:36 INFO - PROCESS | 1659 | |0;dojo.html;3314.4365457872145;3342.264701765611;3354.4800555913835;3355.2115252915546;3356.27840014397;5431.945680543194;5565.777368905239;5572.9999999999945;5582.637128586639;5669.63147395419;5531.502164805167;5590.245316882219;5604.075327570946;5656.547476201904;5658.943410565893;4286.421333120035;4351.564843515639;5032.245163225509;5119.974400128012;5129.53834154926;5098.668586541881;5180.715060671661;5220.765065572058;5245.898361344122;5287.49768771968;5038.924416133779;5121.974390128063;5162.974185129088;5215.400228973679;5220.582353411718;5122.871928201787;5129.615278854101;5152.58779297659;5181.274621552948;5231.659942103789;4994.250862370637;5016.147254966628;5047.419546752134;5048.469910659364;5068.189089745623;5494.972525137388;5643.576731745095;5647.955128301277;5650.886982260373;5743.597948143632;6146.416090471398;6211.161493198406;6234.594751341194;6235.251769787609;6255.968720156416;6069.696515174223;6274;6290.056491526262;6321;6332.936670633281;5674.092145256739;5727.1695604137585;5730.7421166047625;5749.88500229993;5810.12848072784;6296.252088804007;6315.715792789244;6327.050942358683;6329.778457753957;6340.524460665376;4675.929861052087;5856.1508581255475;6004.489618382487;6082.75668973245;6095.299040610298;6083.7566497340495;6106.673025714385;6154.446099851035;6204;6219.036049412258;6089.421504957022;6139.522803442322;6142.253225532421;6191.473724733448;6198;6159.384061593805;6203.2556093268195;6208.099825525273;6220.875582488325;6233.75064997395;4802.615790736732;4910.607151427877;4920.6555541111775;4929.137400954819;5006.949930500648;4335.566443355639;4382.583654552813;4416.183006143874;4422.248217802981;4437.955620443754;5588.385277619459;5624.662520248717;5626.493615574618;5674.233978412862;5680.233168522279;6023.879522409527;6137.560853825989;6200.937990620036;6290.968545157245;6295.118683384329;5667.574931880125;5689.516391106719;5689.743961521742;5694.373618901917;5730.19777231188;5409.5131438169965;5412.431694672082;5412.539934105645;5419.918701219485;5433.456654334614;6226.034964580497;6269.467095296951;6294.622322660655;6357.300696923335;6376.553641245068;6275.901717199563;6285.96857015712;6300.9684951574945;6308.306086330408;6316.684165791784;6309.968450157903;6339.714712838026;6341.8097457076365;6345.302016778059;6347.333529979471;5925.111233315038;6064.666443345658;6084.11780291864;6147.508199344131;6149.723262453111;6242.843928901813;6252.562320637694;6256.061590761422;6258.998560230341;6287.088372185916;6049.30433000193;6066.757329706762;6080.513558915188;6103.877922441615;6108.908366374419;5860.853478663067;5981.611195272293;6012.1582978382185;6059.787907423219;6075.848103797441;5803.158542011301;5823.505002074871;5894.852628684145;5909.734061967308;5948.8810223796145;5554.722263886709;5568.888622227451;5938.881222375442;6013.939860601513;6052.606580572248;5687.687177205294;5823.301203855564;5856.619319744203;5861.9706901466925;5875.294964604275 01:15:36 INFO - PROCESS | 1659 | |1;ext.html;493.1320875259543;502.5577491807209;514.9742512874358;517.2964767915637;526.9394019687735;37684.62315376845;39886;39952.001199970015;40066.399004014966;40103.59896401035;40619.78140655785;40964.38553421701;41028.58971410285;41081.17837643245;41269;8260.793480162998;9646.517674116301;9731.172850307732;9768.90231097687;9790;9624;9690;9764.609415623367;9777.853332200022;9803.950980245088;9708.077732615426;9753.463559504224;9758.853617195713;9766.07222313879;9769.462679552622;9723;9742.1719153872;9742.782152230971;9767.999999999964;9784.217262618973;9665.275104367201;9769.169620582188;9774.16919561838;9781.853272200922;9791.46146961924;32241.1939701507;37646.623533764585;38921.805390973146;39160.41259381112;39257;2578.8065895057944;3373.3927892979254;3484.6341134181052;3488.982555087234;3618.5672551124926;28529.429411411864;30084;31138.221544461343;31582.052538423883;32057.358852823047;3225.6774322567558;3303.151828120237;3307.603087629476;3433.2446861690637;3435.175557866119;408792;497281;508603;515245;519737;63649.045264321074;64864.243327151176;65017.67491162514;65075.34924650693;65085.67457162684;32521.51217731736;35186.47220291698;36059.39406059373;37056.25887482235;37259.4411083834;16803.915980420265;16976.32094716222;16981.490555283362;17001;17006.659866802842;12928.288944108164;13016.958643308513;13040.54358097462;13056.934715326362;13067.803982940264;16908.492745217663;20352.982350882397;20413.081411336527;20578.897105514377;20593.588128237352;8574.528400938008;8576.828463430697;8629;8665.783355416164;8683.652653893774;833.7623777223462;864.6757465950269;924.4776701163955;961.5240455974338;990.9009099090177;28531.857340713163;29385.85307073451;29750.25624359365;29824.956126535468;30567.38865222683;913.4701872913827;990.232569758443;1127.2503784982894;1147.4090843215752;1165.8691069662414;13574.796378054338;14547.154423027217;15391;15568.688626227413;15905.761413578806;675092;696534;697161;698528.50735746;702186;56625.71687141538;56716.71641641765;57125;57524;57583.424165758646;1356.1488568104467;1358.4023029866828;1410.6825964157777;1415.6177831985306;1424.8575142485668;26322.86838565795;29779;30044.849775750983;30835.537466938462;30942.071737847902;51071.74464127656;51691.483085168664;51730;51750.48249517457;51753.482465174864;541712;547926;547997;548071;548131;35220.64779352173;40894.9776255596;41606.79196603998;41633;41814.37278440765;45760;46199.61401157971;46468.767656162854;46637;47324.816879578284;38561.421578676905;38760.418593720555;38843.611563884;39782.2043559133;39976.20047598974;33269.502872370314;35221;37887.242255155295;39297;39371.409428858016;27623.30941726473;30739.846300768353;36708;36814;37993;33016.66983330136;33547.664523354455;34475.82762086173;34580.96257112291;34609;23344.53310933738;25242.621360679237;25688;25870.87064564665;26064.609030864933 01:15:36 INFO - PROCESS | 1659 | |2;jquery.html;317.950717638766;364.52793632246255;371.42058388913307;380.02713054580295;396.1087553005737;19335.323263685776;20293.695594566092;20914;21183.258585949494;21311.36065918021;20415.183392664312;20696.586068278662;20722.585548289062;20821.479463013395;20931.476713082142;5570.637908535932;5674.631148975303;5883;5973.6260660048;5980.282366116072;5870.765169393219;5961.344252132284;5964.314103878044;5968.970155149218;5969.224000879901;5623.718814059301;5819.912701309484;5851.4148585141575;5851.888141253169;5904.409559044104;5610.579206559483;5786.913196302038;5802.274715660543;5830.650160990312;5875.441833025877;5113.948860511385;5159.045576568309;5170.146925757245;5175.482451754794;5176.456472070454;25005.49989000228;25314.114006009884;25345.85943632541;25545.361365965815;25671.486570268677;2247.1236217875044;2382.987230427079;2520.621906713989;2703.418764965542;2756.1593713917246;15485.690286194325;15510.30203640839;15626.921865390714;15655.914831188918;16030.83969160305;1601.2794242590764;1865.8897955716327;1932.9130189141522;1943.9611207775906;1971.467703720002;114508.42745786301;128664.71335286714;132508.02750575595;132645;134695;8508.532030738244;9708.417494950325;10322.22583306255;11309.60416385439;11470.426478676032;11705.414729263674;14046.859531404556;14104.506342277971;14115.364808583638;14179.85820141806;8095.635696393676;8199.549024803573;8380.539070351067;8398.874016889751;8582.742517724353;7358.484906056632;8413.705520306883;8470.237678608955;8582.013068497203;8615.569221538897;4333.43665323506;4417.823287068545;4422.402975598317;4439.8002089905385;4500.527444618333;1660.435451946344;1908.5228692826793;1944.9805501945082;1964.1652297773676;1987.4037788663632;793.8769490728831;834.929031032369;848.554508882829;881.3874357321728;894.8568229083315;20113.19547218095;20964.371068867957;21027.26404575863;21031.78968210329;21121.89439052795;854.7820305821975;900.869373940775;915.377543270569;946.5078159357233;949.1505102932974;10386.636467723594;11006.669799906016;11027.338359698444;11046.232602783677;11052.67893742323;582848;595139;596984;598324;605961;130417.34791326172;134805.32597337148;136364;141698;148060;812.7114874219685;975.9951200243953;991.2367477042637;993.7664648807524;1006.9144122749649;18588;19159.712604311226;19187.520311991753;19275.61448771045;19285.132169052707;43776.56223437725;55813;56197.446434105485;56579.43420565906;58233.971315777;71124.64437677778;81609;83825;86215.13784862071;87857.56071219603;11723.589674361356;12159.939200303941;12431.067669924973;12525.06062045332;12605.87394126047;12236.449359778653;12639.241645501299;13214.27321497327;13688.110272832235;13835.584932452042;7279.672414741455;7423.257674232749;10704.839427408438;11597.594084207012;11914.940425297818;7262.62010218078;7497.137829149718;7505.174430812715;8047.114817369968;8105.6584228924985;7959.681612735426;8310.459820111673;8340.87488687658;8459.365547583833;8484.769708392125;9060.456372617664;10358.5338659762;10993.230473866752;11700.70748231301;11760.411979401168;8466.407351485337;10884.074853637212;11938.64184074479;12004.75990480168;12071.551413830397 01:15:36 INFO - PROCESS | 1659 | |3;mootools.html;1469.963250918727;1485.353871066086;1639.6720655868821;1790.5344610401291;1812.673718730628;7957.602119893997;8336.124706905772;8556.486610803357;8918.77703057424;8947.55262236888;8573.056963733985;8791.560421978891;8794.736157915273;8801.823963520726;8814.294856411489;2351.976480235197;2387.7612238776155;2388.7252965908883;2392.964105538418;2398.0887262840097;2330.9300720978313;2368.8578685278853;2371.715394152704;2378.0250097460043;2389.7132344118645;2355.305184970438;2369.514249578841;2375.928722138339;2378.5361854438393;2382.261498935327;2335.2293743064747;2339.9181028664;2354.6114891042957;2356.8199415540644;2367.9881600592057;1807.4487281379174;2074.2532688232222;2343.308723926446;2350.341904266808;2353.2351985604746;8770.517621530813;8809.515476648781;8878.955605221932;8881.555922203928;8889.555522223864;5051.545360917498;5162.845114646567;5178.14560597501;5194.4026436959475;5201.349831271091;3321.1199032256472;3428.9485657715154;3519.1202199450136;3549.893503194908;3558.7864728116397;1046.4966192400507;1072.2976450424985;1088.0479580367178;1098.1983152298867;1101.4162493878257;10774.138068954464;10777.784444311148;10869.45652717361;10876.129909607213;10895.564177432972;4315.093830295673;4405.911881762347;4546.249868771615;4558.0428110097255;4568.931466028012;9376.67181648639;9450.102240287162;9460.479673618018;9460.716178514656;9462.52687365629;5104.259882317043;5115.462876397999;5124.666896651705;5129.948700513021;5144.742762861917;4385.6710746694125;4661.440627124767;4675.251959686434;4759.214729569651;4791.448983366888;3590.533230679995;3774.735768496234;3843.6348546888003;3902.3951287550476;3948.289307924601;982.4694664881027;1069.8823129455754;1071.9494895002786;1135.6195674448986;1238.1642391385778;715.9355657990806;781.7107670162077;833.5748768128177;882.1311008656468;906.8141031088611;5554.91667624986;5809.564282678816;5917.171595976567;5936.910946335808;6123.173371594778;880.2825697056878;888.9599168972318;935.6397786852111;967.0716112531908;967.8886928003229;3811.923761524754;4023.8591649292134;4083.8570650027104;4123.257813593582;4225.809838557272;10382.480875956324;10612.416317102634;10791.406472643923;10815.891841081488;11003.944980275048;10478.580856765644;10739.087177589836;10744;10754.892451075546;10776;8027.438079334391;8038.070862992957;8043.276105150448;8210.425270231026;8248.13394593571;5926.318473375444;6014.6391216527145;6108.297545782292;6118.632882027093;6136.815895523141;9819.55811988448;9880;9907.356021858555;9917.900820991987;9941.105300522988;9915.752106197115;10071.194304455772;10113.342632728849;10204.2346823987;10300;6925.480588955949;7503.512271702322;7563.054618172729;7853.646585903533;8154.673813047411;8145.8370832584205;8342.499450033018;8432.53621050848;8435.95782021086;8445.1977062179;7376.631168441664;7430.628468576441;7475.588842613708;7477.813054673677;7490;7275;7307;7338.70645174187;7351.522151060164;7442.590657513672;6895.6552172390175;6914.0320355151325;6985.196702379291;6987.790366289019;6991.615461149686;4646.140464014168;4858.489858564941;4883.584895283799;4918.311436398979;4968.577670898014;4525;4580.106879158532;4605.562471565196;4697.906041879211;4758.214894542361 01:15:36 INFO - PROCESS | 1659 | |4;prototype.html;284.8945890020692;300.41868983516883;312.1774125180151;312.37369075004614;312.8607769542553;5388.568914486841;5499.7250137493065;5566.860828479285;5641.915371269434;5680.602357834948;4757.333973243749;5422.728863556826;5557.138643510262;5562.666240025601;5617.8033768818095;3806.2387522495474;4209.389638502423;4221.620054195122;4224.260754367973;4238.618524332809;3360.8823691170815;3613.662944710461;3665.0654083208747;3938.7045971552106;4198.769067701275;3457.0147507960237;3811.4854494643146;3993.542357039689;4048.7773172475504;4161.354989976543;3491.9524142757073;4183.644390226835;4191.087194399894;4194.538600753915;4210.831566737327;3054.7403470705017;3554.875579354736;3663.5054267674054;3672.989927769858;3700.2414505026404;5424.349078110613;5426.290718423684;5451.209574611698;5454.4545545445535;5475.508643567167;4378.9562104378865;4642.816081899128;4721.433427988663;4909.263610458424;4940.802367905279;5315.548178404841;5367.409584945653;5795.507381872546;5949.702514874239;6004.318790738556;3687.1519550503535;3970.583088775666;4100.630943215125;4109.404136400235;4111.753294802322;5354.384245811703;6257.2491301044165;6272.2786879508985;6301.212348456397;6325.240971083454;3404.6084700259294;3664.9083772905356;4059.4722686051214;4121.216968775923;4134.421181034658;4240;4245.702800803914;4249.363994861938;4249.766262855511;4269.978650106792;4291.721038132511;4295.634871035934;4924.236743304794;4935.457099719028;4935.827246046443;4956.727379994063;5729.942700573024;5875.324337701134;6003.729832157564;6016.278046634345;1234.3519652182677;1276;1383.9238841863794;1388;1436.2603259321459;858.4891989266376;941.7662861651258;959.7840485890619;978.6476868327396;979.2655508368723;4877.171060852181;5384.380796208407;5471.151971444432;5477.959187754314;5495.587830912697;5252.921206181911;5515.380194407624;6028.021505806235;6040.375774535244;6054.788082417094;4382.474103107584;4568.74871882043;5092.719900405513;5364.7585858635675;5448.45515448452;2249.8650080995194;2349.5300939812105;2671.906483273076;2716.2258756254373;2730.9180724578296;4611.279345186289;4669.41632295963;4910.361652985089;5295.867603309871;5320.015797077553;5239.790408383622;5262.079750585762;5749.252597162425;5764.4523770242595;6364.745410183541;6438.291787903327;6441.871162576722;6447;6457.062036773351;6457.61254324742;5140.7429628517675;6006.117063809309;6206.689665516616;6214.285357183981;6216.658083805434;5607;6053.848653783691;6091.482224011009;6135.785247516315;6148.569600128127;5353.866153346197;5522.530584900329;5548.1427065062335;6385.010323399881;6499.895017846883;3160.972683877703;3263.2052371195273;3445.8277086146095;3449.6377880323207;3638.94470603522;5377.064256867447;5478.808241711521;5976.910346344721;6018.488428483628;6260.937390626035;4971.751412429437;5962.731677074456;5985.700714964148;6030.155778191144;6037.426444487766;5352.4915133062295;5771.422857714195;5975.521958243417;5996.670183139795;6002.799440111908;5569.721513924206;5801.448862358069;5836.118980877669;5858.853528661817;5865.237519122486;5791.89953908756;5964.045752679551;5991.191189189403;5999.970000149971;6048.45764330093;5526.91709624364;5550.139728342114;5619.550435965195;5896.410358964069;5905.940940590711 01:15:36 INFO - PROCESS | 1659 | |5;yui.html;737.3327138939255;738.9593572353525;741.6440108747801;790.5217343507179;818.5866137600513;15118.244087795607;15771.60570985726;15830.76253856193;16145.19274036298;16192.109433981126;14716.337764800583;14781.039232449883;14879.032862863905;14893.404263829434;14903.701925961474;675.6858061001633;817.9591020448984;831.5925196653626;834.04501845387;838.4466252273501;839.5046922315832;850.5577099908044;852.3224036890656;857.5240741388527;861.1431625532604;700.726716580534;873.4148120759106;895.2703546609492;896.6727144592243;899.2895612466144;889.0931250124901;889.297455010541;891.0510306523531;891.9955400223022;893.3835653399166;644.4522156167267;649.1528555235416;653.5653790229492;656.7340227207989;657.4247533408268;15746.68506629861;15877.36490540377;15995.840041599551;16016.519504414886;16029.519114426586;10927.289726167774;14496.42014319426;14615.853841461556;14681.77977330341;14799.630009249748;11869.050475961989;11973.221740586834;11993.580224692094;12010.339431331273;12091;3788.747994615882;3799.704280001167;3828.942565861514;3866.0528170598104;3892.5912779158066;124155;125782.37108814398;126024.36987815003;126922;127063;11217;11259.437028148559;11317.773644527064;11354.318740875575;11554.595589154507;23408.882955585454;23611.40971475727;23637.409064773517;23921.52156956851;23996.64005039891;8011.519308841488;8077.192280771876;8083.919160808434;8115.147909469539;8272.214139656722;4386.890327741832;4419.049904270597;4420.093880754438;4429.623482004065;4485.551444855553;3559.4660800880074;3675.1914578793157;3690.686291665185;3691.5201023866725;3700.2229531798625;550.2159422822461;636.6053047110821;641.7497176101324;643.1670986073046;646.3859333633068;548.56937304216;592.5792687192142;637.5664548107239;673.1417442760421;683.5078743304912;8548.016978047479;9308.44149351041;9385.296102792317;9451.621935122517;9706.495493198565;519.3508114856429;520.9843704688866;555.9722013899288;654.3848782144769;669.568128557078;3556.982215088908;4439.467263928284;4559.475660299042;4633.86098417048;4646.744429056367;123605.38197308956;153331;162325;167800;168949;129302.35348823195;131696;134704;134772.3261383687;137218;112958.43520782508;114909;115132;115707.42146289384;119234.4038279803;8929.330300227639;8937.419067760575;8956.910430895608;9068.093190680878;9211;60920.39079609147;66597.00208993738;67036.6648166756;68995.96506052313;70398;70374;72469.91295130683;83512;84695.07134500526;93836;13178.934105329796;13190.80213796813;13276.601701948957;13508.324583770576;13857.030007899753;13492.797608035691;14650.34073466718;14808.037477563925;15300.77048844246;15570.455034073753;13276;13440.663983400493;13708.066199493225;13869.445222191403;14244.623615851402;11028.613998510335;13600.234332722805;13616.795748063589;13785.241811700453;13933;13319.200847949154;13401.262930538915;13403.597892063253;13525.120867143603;14043.859561404664;10972.122230221723;11134.88865111371;11329.263597866113;11646.010089142517;11699;9799.167070799062;10237.436940968319;10698.89301106979;11316.98147166759;11562.653120406401 01:15:36 INFO - PROCESS | 1659 | __end_tp_report 01:15:36 INFO - PROCESS | 1659 | __start_cc_report 01:15:36 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,385 01:15:36 INFO - PROCESS | 1659 | __end_cc_report 01:15:36 INFO - PROCESS | 1659 | __startTimestamp1472544936046__endTimestamp 01:15:36 INFO - PROCESS | 1659 | 01:15:36 INFO - PROCESS | 1659 | ------- Summary: start ------- 01:15:36 INFO - PROCESS | 1659 | Number of tests: 6 01:15:36 INFO - PROCESS | 1659 | 01:15:36 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5679.15 Median:5856.15 stddev:662.43 (11.3%) stddev-sans-first:637.96 01:15:36 INFO - PROCESS | 1659 | Values: 3314.4 3342.3 3354.5 3355.2 3356.3 5431.9 5565.8 5573.0 5582.6 5669.6 5531.5 5590.2 5604.1 5656.5 5658.9 4286.4 4351.6 5032.2 5120.0 5129.5 5098.7 5180.7 5220.8 5245.9 5287.5 5038.9 5122.0 5163.0 5215.4 5220.6 5122.9 5129.6 5152.6 5181.3 5231.7 4994.3 5016.1 5047.4 5048.5 5068.2 5495.0 5643.6 5648.0 5650.9 5743.6 6146.4 6211.2 6234.6 6235.3 6256.0 6069.7 6274.0 6290.1 6321.0 6332.9 5674.1 5727.2 5730.7 5749.9 5810.1 6296.3 6315.7 6327.1 6329.8 6340.5 4675.9 5856.2 6004.5 6082.8 6095.3 6083.8 6106.7 6154.4 6204.0 6219.0 6089.4 6139.5 6142.3 6191.5 6198.0 6159.4 6203.3 6208.1 6220.9 6233.8 4802.6 4910.6 4920.7 4929.1 5006.9 4335.6 4382.6 4416.2 4422.2 4438.0 5588.4 5624.7 5626.5 5674.2 5680.2 6023.9 6137.6 6200.9 6291.0 6295.1 5667.6 5689.5 5689.7 5694.4 5730.2 5409.5 5412.4 5412.5 5419.9 5433.5 6226.0 6269.5 6294.6 6357.3 6376.6 6275.9 6286.0 6301.0 6308.3 6316.7 6310.0 6339.7 6341.8 6345.3 6347.3 5925.1 6064.7 6084.1 6147.5 6149.7 6242.8 6252.6 6256.1 6259.0 6287.1 6049.3 6066.8 6080.5 6103.9 6108.9 5860.9 5981.6 6012.2 6059.8 6075.8 5803.2 5823.5 5894.9 5909.7 5948.9 5554.7 5568.9 5938.9 6013.9 6052.6 5687.7 5823.3 5856.6 5862.0 5875.3 01:15:36 INFO - PROCESS | 1659 | 01:15:36 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:70445.22 Median:39964.10 stddev:156219.92 (390.9%) stddev-sans-first:156569.87 01:15:36 INFO - PROCESS | 1659 | Values: 493.1 502.6 515.0 517.3 526.9 37684.6 39886.0 39952.0 40066.4 40103.6 40619.8 40964.4 41028.6 41081.2 41269.0 8260.8 9646.5 9731.2 9768.9 9790.0 9624.0 9690.0 9764.6 9777.9 9804.0 9708.1 9753.5 9758.9 9766.1 9769.5 9723.0 9742.2 9742.8 9768.0 9784.2 9665.3 9769.2 9774.2 9781.9 9791.5 32241.2 37646.6 38921.8 39160.4 39257.0 2578.8 3373.4 3484.6 3489.0 3618.6 28529.4 30084.0 31138.2 31582.1 32057.4 3225.7 3303.2 3307.6 3433.2 3435.2 408792.0 497281.0 508603.0 515245.0 519737.0 63649.0 64864.2 65017.7 65075.3 65085.7 32521.5 35186.5 36059.4 37056.3 37259.4 16803.9 16976.3 16981.5 17001.0 17006.7 12928.3 13017.0 13040.5 13056.9 13067.8 16908.5 20353.0 20413.1 20578.9 20593.6 8574.5 8576.8 8629.0 8665.8 8683.7 833.8 864.7 924.5 961.5 990.9 28531.9 29385.9 29750.3 29825.0 30567.4 913.5 990.2 1127.3 1147.4 1165.9 13574.8 14547.2 15391.0 15568.7 15905.8 675092.0 696534.0 697161.0 698528.5 702186.0 56625.7 56716.7 57125.0 57524.0 57583.4 1356.1 1358.4 1410.7 1415.6 1424.9 26322.9 29779.0 30044.8 30835.5 30942.1 51071.7 51691.5 51730.0 51750.5 51753.5 541712.0 547926.0 547997.0 548071.0 548131.0 35220.6 40895.0 41606.8 41633.0 41814.4 45760.0 46199.6 46468.8 46637.0 47324.8 38561.4 38760.4 38843.6 39782.2 39976.2 33269.5 35221.0 37887.2 39297.0 39371.4 27623.3 30739.8 36708.0 36814.0 37993.0 33016.7 33547.7 34475.8 34581.0 34609.0 23344.5 25242.6 25688.0 25870.9 26064.6 01:15:36 INFO - PROCESS | 1659 | 01:15:36 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:35778.94 Median:341.24 stddev:100080.92 (29328.7%) stddev-sans-first:100326.25 01:15:36 INFO - PROCESS | 1659 | Values: 318.0 364.5 371.4 380.0 396.1 19335.3 20293.7 20914.0 21183.3 21311.4 20415.2 20696.6 20722.6 20821.5 20931.5 5570.6 5674.6 5883.0 5973.6 5980.3 5870.8 5961.3 5964.3 5969.0 5969.2 5623.7 5819.9 5851.4 5851.9 5904.4 5610.6 5786.9 5802.3 5830.7 5875.4 5113.9 5159.0 5170.1 5175.5 5176.5 25005.5 25314.1 25345.9 25545.4 25671.5 2247.1 2383.0 2520.6 2703.4 2756.2 15485.7 15510.3 15626.9 15655.9 16030.8 1601.3 1865.9 1932.9 1944.0 1971.5 114508.4 128664.7 132508.0 132645.0 134695.0 8508.5 9708.4 10322.2 11309.6 11470.4 11705.4 14046.9 14104.5 14115.4 14179.9 8095.6 8199.5 8380.5 8398.9 8582.7 7358.5 8413.7 8470.2 8582.0 8615.6 4333.4 4417.8 4422.4 4439.8 4500.5 1660.4 1908.5 1945.0 1964.2 1987.4 793.9 834.9 848.6 881.4 894.9 20113.2 20964.4 21027.3 21031.8 21121.9 854.8 900.9 915.4 946.5 949.2 10386.6 11006.7 11027.3 11046.2 11052.7 582848.0 595139.0 596984.0 598324.0 605961.0 130417.3 134805.3 136364.0 141698.0 148060.0 812.7 976.0 991.2 993.8 1006.9 18588.0 19159.7 19187.5 19275.6 19285.1 43776.6 55813.0 56197.4 56579.4 58234.0 71124.6 81609.0 83825.0 86215.1 87857.6 11723.6 12159.9 12431.1 12525.1 12605.9 12236.4 12639.2 13214.3 13688.1 13835.6 7279.7 7423.3 10704.8 11597.6 11914.9 7262.6 7497.1 7505.2 8047.1 8105.7 7959.7 8310.5 8340.9 8459.4 8484.8 9060.5 10358.5 10993.2 11700.7 11760.4 8466.4 10884.1 11938.6 12004.8 12071.6 01:15:36 INFO - PROCESS | 1659 | 01:15:36 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5641.33 Median:4900.95 stddev:3162.86 (64.5%) stddev-sans-first:3156.20 01:15:36 INFO - PROCESS | 1659 | Values: 1470.0 1485.4 1639.7 1790.5 1812.7 7957.6 8336.1 8556.5 8918.8 8947.6 8573.1 8791.6 8794.7 8801.8 8814.3 2352.0 2387.8 2388.7 2393.0 2398.1 2330.9 2368.9 2371.7 2378.0 2389.7 2355.3 2369.5 2375.9 2378.5 2382.3 2335.2 2339.9 2354.6 2356.8 2368.0 1807.4 2074.3 2343.3 2350.3 2353.2 8770.5 8809.5 8879.0 8881.6 8889.6 5051.5 5162.8 5178.1 5194.4 5201.3 3321.1 3428.9 3519.1 3549.9 3558.8 1046.5 1072.3 1088.0 1098.2 1101.4 10774.1 10777.8 10869.5 10876.1 10895.6 4315.1 4405.9 4546.2 4558.0 4568.9 9376.7 9450.1 9460.5 9460.7 9462.5 5104.3 5115.5 5124.7 5129.9 5144.7 4385.7 4661.4 4675.3 4759.2 4791.4 3590.5 3774.7 3843.6 3902.4 3948.3 982.5 1069.9 1071.9 1135.6 1238.2 715.9 781.7 833.6 882.1 906.8 5554.9 5809.6 5917.2 5936.9 6123.2 880.3 889.0 935.6 967.1 967.9 3811.9 4023.9 4083.9 4123.3 4225.8 10382.5 10612.4 10791.4 10815.9 11003.9 10478.6 10739.1 10744.0 10754.9 10776.0 8027.4 8038.1 8043.3 8210.4 8248.1 5926.3 6014.6 6108.3 6118.6 6136.8 9819.6 9880.0 9907.4 9917.9 9941.1 9915.8 10071.2 10113.3 10204.2 10300.0 6925.5 7503.5 7563.1 7853.6 8154.7 8145.8 8342.5 8432.5 8436.0 8445.2 7376.6 7430.6 7475.6 7477.8 7490.0 7275.0 7307.0 7338.7 7351.5 7442.6 6895.7 6914.0 6985.2 6987.8 6991.6 4646.1 4858.5 4883.6 4918.3 4968.6 4525.0 4580.1 4605.6 4697.9 4758.2 01:15:36 INFO - PROCESS | 1659 | 01:15:36 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4699.95 Median:5366.08 stddev:1515.54 (28.2%) stddev-sans-first:1483.12 01:15:36 INFO - PROCESS | 1659 | Values: 284.9 300.4 312.2 312.4 312.9 5388.6 5499.7 5566.9 5641.9 5680.6 4757.3 5422.7 5557.1 5562.7 5617.8 3806.2 4209.4 4221.6 4224.3 4238.6 3360.9 3613.7 3665.1 3938.7 4198.8 3457.0 3811.5 3993.5 4048.8 4161.4 3492.0 4183.6 4191.1 4194.5 4210.8 3054.7 3554.9 3663.5 3673.0 3700.2 5424.3 5426.3 5451.2 5454.5 5475.5 4379.0 4642.8 4721.4 4909.3 4940.8 5315.5 5367.4 5795.5 5949.7 6004.3 3687.2 3970.6 4100.6 4109.4 4111.8 5354.4 6257.2 6272.3 6301.2 6325.2 3404.6 3664.9 4059.5 4121.2 4134.4 4240.0 4245.7 4249.4 4249.8 4270.0 4291.7 4295.6 4924.2 4935.5 4935.8 4956.7 5729.9 5875.3 6003.7 6016.3 1234.4 1276.0 1383.9 1388.0 1436.3 858.5 941.8 959.8 978.6 979.3 4877.2 5384.4 5471.2 5478.0 5495.6 5252.9 5515.4 6028.0 6040.4 6054.8 4382.5 4568.7 5092.7 5364.8 5448.5 2249.9 2349.5 2671.9 2716.2 2730.9 4611.3 4669.4 4910.4 5295.9 5320.0 5239.8 5262.1 5749.3 5764.5 6364.7 6438.3 6441.9 6447.0 6457.1 6457.6 5140.7 6006.1 6206.7 6214.3 6216.7 5607.0 6053.8 6091.5 6135.8 6148.6 5353.9 5522.5 5548.1 6385.0 6499.9 3161.0 3263.2 3445.8 3449.6 3638.9 5377.1 5478.8 5976.9 6018.5 6260.9 4971.8 5962.7 5985.7 6030.2 6037.4 5352.5 5771.4 5975.5 5996.7 6002.8 5569.7 5801.4 5836.1 5858.9 5865.2 5791.9 5964.0 5991.2 6000.0 6048.5 5526.9 5550.1 5619.6 5896.4 5905.9 01:15:36 INFO - PROCESS | 1659 | 01:15:36 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:25712.56 Median:3617.33 stddev:41614.79 (1150.4%) stddev-sans-first:41689.28 01:15:36 INFO - PROCESS | 1659 | Values: 737.3 739.0 741.6 790.5 818.6 15118.2 15771.6 15830.8 16145.2 16192.1 14716.3 14781.0 14879.0 14893.4 14903.7 675.7 818.0 831.6 834.0 838.4 839.5 850.6 852.3 857.5 861.1 700.7 873.4 895.3 896.7 899.3 889.1 889.3 891.1 892.0 893.4 644.5 649.2 653.6 656.7 657.4 15746.7 15877.4 15995.8 16016.5 16029.5 10927.3 14496.4 14615.9 14681.8 14799.6 11869.1 11973.2 11993.6 12010.3 12091.0 3788.7 3799.7 3828.9 3866.1 3892.6 124155.0 125782.4 126024.4 126922.0 127063.0 11217.0 11259.4 11317.8 11354.3 11554.6 23408.9 23611.4 23637.4 23921.5 23996.6 8011.5 8077.2 8083.9 8115.1 8272.2 4386.9 4419.0 4420.1 4429.6 4485.6 3559.5 3675.2 3690.7 3691.5 3700.2 550.2 636.6 641.7 643.2 646.4 548.6 592.6 637.6 673.1 683.5 8548.0 9308.4 9385.3 9451.6 9706.5 519.4 521.0 556.0 654.4 669.6 3557.0 4439.5 4559.5 4633.9 4646.7 123605.4 153331.0 162325.0 167800.0 168949.0 129302.4 131696.0 134704.0 134772.3 137218.0 112958.4 114909.0 115132.0 115707.4 119234.4 8929.3 8937.4 8956.9 9068.1 9211.0 60920.4 66597.0 67036.7 68996.0 70398.0 70374.0 72469.9 83512.0 84695.1 93836.0 13178.9 13190.8 13276.6 13508.3 13857.0 13492.8 14650.3 14808.0 15300.8 15570.5 13276.0 13440.7 13708.1 13869.4 14244.6 11028.6 13600.2 13616.8 13785.2 13933.0 13319.2 13401.3 13403.6 13525.1 14043.9 10972.1 11134.9 11329.3 11646.0 11699.0 9799.2 10237.4 10698.9 11317.0 11562.7 01:15:36 INFO - PROCESS | 1659 | -------- Summary: end -------- 01:15:36 INFO - PROCESS | 1659 | 01:15:36 INFO - TEST-INFO | 1659: exit 0 01:15:36 INFO - TEST-OK | dromaeo_css | took 1113297ms 01:15:36 INFO - TEST-START | kraken 01:15:36 INFO - operating with platform_type : mac_ 01:15:36 INFO - Initialising browser for kraken test... 01:15:36 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/tmpWtjMk8/profile http://localhost:49268/getInfo.html) 01:15:39 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 01:15:39 INFO - PROCESS | 1669 | colorDepth:24 01:15:39 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 01:15:39 INFO - PROCESS | 1669 | __metrics 01:15:39 ERROR - PROCESS | 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 01:15:39 INFO - TEST-INFO | 1669: exit 0 01:15:39 INFO - Browser initialized. 01:15:39 INFO - Running cycle 1/1 for kraken test... 01:15:40 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/tmpWtjMk8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:15:51 INFO - PROCESS | 1671 | RSS: Main: 244011008 01:15:51 INFO - PROCESS | 1671 | 01:15:54 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection) 01:15:55 INFO - PROCESS | 1671 | RSS: Main: 256782336 01:15:55 INFO - PROCESS | 1671 | 01:15:58 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-dft) 01:15:58 INFO - PROCESS | 1671 | RSS: Main: 265428992 01:15:58 INFO - PROCESS | 1671 | 01:16:02 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-fft) 01:16:02 INFO - PROCESS | 1671 | RSS: Main: 263065600 01:16:02 INFO - PROCESS | 1671 | 01:16:04 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator) 01:16:05 INFO - PROCESS | 1671 | RSS: Main: 264507392 01:16:05 INFO - PROCESS | 1671 | 01:16:07 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:16:08 INFO - PROCESS | 1671 | RSS: Main: 264822784 01:16:08 INFO - PROCESS | 1671 | 01:16:10 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom) 01:16:11 INFO - PROCESS | 1671 | RSS: Main: 266817536 01:16:11 INFO - PROCESS | 1671 | 01:16:14 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate) 01:16:15 INFO - PROCESS | 1671 | RSS: Main: 266661888 01:16:15 INFO - PROCESS | 1671 | 01:16:17 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial) 01:16:18 INFO - PROCESS | 1671 | RSS: Main: 267096064 01:16:18 INFO - PROCESS | 1671 | 01:16:20 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:16:20 INFO - PROCESS | 1671 | RSS: Main: 266915840 01:16:20 INFO - PROCESS | 1671 | 01:16:22 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:16:23 INFO - PROCESS | 1671 | RSS: Main: 266514432 01:16:23 INFO - PROCESS | 1671 | 01:16:25 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:16:26 INFO - PROCESS | 1671 | RSS: Main: 266416128 01:16:26 INFO - PROCESS | 1671 | 01:16:29 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:16:30 INFO - PROCESS | 1671 | RSS: Main: 266567680 01:16:30 INFO - PROCESS | 1671 | 01:16:33 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:16:33 INFO - PROCESS | 1671 | RSS: Main: 266813440 01:16:33 INFO - PROCESS | 1671 | 01:16:35 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49268/tests/kraken/driver.html?testName=ai-astar) 01:16:35 INFO - PROCESS | 1671 | RSS: Main: 268541952 01:16:35 INFO - PROCESS | 1671 | 01:16:35 INFO - PROCESS | 1671 | __start_tp_report 01:16:35 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 01:16:35 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 01:16:35 INFO - PROCESS | 1671 | |i|pagename|runs| 01:16:35 INFO - PROCESS | 1671 | |0;ai-astar;116;110;116;117;116;95;118;117;118;116 01:16:35 INFO - PROCESS | 1671 | |1;audio-beat-detection;164;139;138;159;111;129;126;112;166;141 01:16:35 INFO - PROCESS | 1671 | |2;audio-dft;196;197;201;200;251;279;243;202;209;256 01:16:35 INFO - PROCESS | 1671 | |3;audio-fft;67;81;76;149;59;62;57;65;135;60 01:16:35 INFO - PROCESS | 1671 | |4;audio-oscillator;69;72;119;71;69;81;111;72;102;109 01:16:35 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;88;85;90;86;89;85;89;86;89;86 01:16:35 INFO - PROCESS | 1671 | |6;imaging-darkroom;95;118;124;95;94;94;94;95;95;118 01:16:35 INFO - PROCESS | 1671 | |7;imaging-desaturate;93;94;91;92;101;90;107;129;91;99 01:16:35 INFO - PROCESS | 1671 | |8;json-parse-financial;56;59;59;62;83;89;89;90;85;56 01:16:35 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;56;60;76;117;104;106;76;73;71;105 01:16:35 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;86;85;91;88;87;87;84;87;88;86 01:16:35 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;140;182;127;154;168;133;153;151;197;166 01:16:35 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;171;174;229;167;171;172;172;173;168;170 01:16:35 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;69;69;66;67;67;71;68;61;90;58 01:16:35 INFO - PROCESS | 1671 | __end_tp_report 01:16:35 INFO - PROCESS | 1671 | __start_cc_report 01:16:35 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,964 01:16:35 INFO - PROCESS | 1671 | __end_cc_report 01:16:35 INFO - PROCESS | 1671 | __startTimestamp1472544995672__endTimestamp 01:16:35 INFO - PROCESS | 1671 | 01:16:35 INFO - PROCESS | 1671 | ------- Summary: start ------- 01:16:35 INFO - PROCESS | 1671 | Number of tests: 14 01:16:35 INFO - PROCESS | 1671 | 01:16:35 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:113.90 Median:117.00 stddev:7.02 (6.0%) stddev-sans-first:7.40 01:16:35 INFO - PROCESS | 1671 | Values: 116.0 110.0 116.0 117.0 116.0 95.0 118.0 117.0 118.0 116.0 01:16:35 INFO - PROCESS | 1671 | 01:16:35 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:138.50 Median:140.00 stddev:19.83 (14.2%) stddev-sans-first:18.76 01:16:35 INFO - PROCESS | 1671 | Values: 164.0 139.0 138.0 159.0 111.0 129.0 126.0 112.0 166.0 141.0 01:16:35 INFO - PROCESS | 1671 | 01:16:35 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:223.40 Median:226.00 stddev:30.66 (13.6%) stddev-sans-first:30.88 01:16:35 INFO - PROCESS | 1671 | Values: 196.0 197.0 201.0 200.0 251.0 279.0 243.0 202.0 209.0 256.0 01:16:35 INFO - PROCESS | 1671 | 01:16:35 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:81.10 Median:63.50 stddev:33.13 (52.2%) stddev-sans-first:34.75 01:16:35 INFO - PROCESS | 1671 | Values: 67.0 81.0 76.0 149.0 59.0 62.0 57.0 65.0 135.0 60.0 01:16:35 INFO - PROCESS | 1671 | 01:16:35 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:87.50 Median:70.00 stddev:20.27 (29.0%) stddev-sans-first:20.36 01:16:35 INFO - PROCESS | 1671 | Values: 69.0 72.0 119.0 71.0 69.0 81.0 111.0 72.0 102.0 109.0 01:16:35 INFO - PROCESS | 1671 | 01:16:35 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:87.30 Median:88.50 stddev:1.89 (2.1%) stddev-sans-first:1.99 01:16:35 INFO - PROCESS | 1671 | Values: 88.0 85.0 90.0 86.0 89.0 85.0 89.0 86.0 89.0 86.0 01:16:35 INFO - PROCESS | 1671 | 01:16:35 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:102.20 Median:94.50 stddev:12.40 (13.1%) stddev-sans-first:12.87 01:16:35 INFO - PROCESS | 1671 | Values: 95.0 118.0 124.0 95.0 94.0 94.0 94.0 95.0 95.0 118.0 01:16:35 INFO - PROCESS | 1671 | 01:16:35 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:98.70 Median:91.50 stddev:11.95 (13.1%) stddev-sans-first:12.50 01:16:35 INFO - PROCESS | 1671 | Values: 93.0 94.0 91.0 92.0 101.0 90.0 107.0 129.0 91.0 99.0 01:16:35 INFO - PROCESS | 1671 | 01:16:35 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:72.80 Median:84.00 stddev:15.40 (18.3%) stddev-sans-first:15.09 01:16:35 INFO - PROCESS | 1671 | Values: 56.0 59.0 59.0 62.0 83.0 89.0 89.0 90.0 85.0 56.0 01:16:35 INFO - PROCESS | 1671 | 01:16:35 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:84.40 Median:65.50 stddev:21.58 (32.9%) stddev-sans-first:20.29 01:16:35 INFO - PROCESS | 1671 | Values: 56.0 60.0 76.0 117.0 104.0 106.0 76.0 73.0 71.0 105.0 01:16:35 INFO - PROCESS | 1671 | 01:16:35 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:87.00 stddev:1.91 (2.2%) stddev-sans-first:2.00 01:16:35 INFO - PROCESS | 1671 | Values: 86.0 85.0 91.0 88.0 87.0 87.0 84.0 87.0 88.0 86.0 01:16:35 INFO - PROCESS | 1671 | 01:16:35 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:157.10 Median:160.00 stddev:21.74 (13.6%) stddev-sans-first:22.16 01:16:35 INFO - PROCESS | 1671 | Values: 140.0 182.0 127.0 154.0 168.0 133.0 153.0 151.0 197.0 166.0 01:16:35 INFO - PROCESS | 1671 | 01:16:35 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.70 Median:172.00 stddev:18.50 (10.8%) stddev-sans-first:19.51 01:16:35 INFO - PROCESS | 1671 | Values: 171.0 174.0 229.0 167.0 171.0 172.0 172.0 173.0 168.0 170.0 01:16:35 INFO - PROCESS | 1671 | 01:16:35 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.50 stddev:8.47 (12.4%) stddev-sans-first:8.99 01:16:35 INFO - PROCESS | 1671 | Values: 69.0 69.0 66.0 67.0 67.0 71.0 68.0 61.0 90.0 58.0 01:16:35 INFO - PROCESS | 1671 | -------- Summary: end -------- 01:16:35 INFO - PROCESS | 1671 | 01:16:36 INFO - TEST-INFO | 1671: exit 0 01:16:36 INFO - TEST-OK | kraken | took 60074ms 01:16:36 INFO - SUITE-END | took 1173s 01:16:36 INFO - Completed test suite (00:19:33) 01:16:36 INFO - javascript benchmark 01:16:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7383.2128864223005, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3314.4365457872145, 3342.264701765611, 3354.4800555913835, 3355.2115252915546, 3356.27840014397, 5431.945680543194, 5565.777368905239, 5572.9999999999945, 5582.637128586639, 5669.63147395419, 5531.502164805167, 5590.245316882219, 5604.075327570946, 5656.547476201904, 5658.943410565893, 4286.421333120035, 4351.564843515639, 5032.245163225509, 5119.974400128012, 5129.53834154926, 5098.668586541881, 5180.715060671661, 5220.765065572058, 5245.898361344122, 5287.49768771968, 5038.924416133779, 5121.974390128063, 5162.974185129088, 5215.400228973679, 5220.582353411718, 5122.871928201787, 5129.615278854101, 5152.58779297659, 5181.274621552948, 5231.659942103789, 4994.250862370637, 5016.147254966628, 5047.419546752134, 5048.469910659364, 5068.189089745623, 5494.972525137388, 5643.576731745095, 5647.955128301277, 5650.886982260373, 5743.597948143632, 6146.416090471398, 6211.161493198406, 6234.594751341194, 6235.251769787609, 6255.968720156416, 6069.696515174223, 6274.0, 6290.056491526262, 6321.0, 6332.936670633281, 5674.092145256739, 5727.1695604137585, 5730.7421166047625, 5749.88500229993, 5810.12848072784, 6296.252088804007, 6315.715792789244, 6327.050942358683, 6329.778457753957, 6340.524460665376, 4675.929861052087, 5856.1508581255475, 6004.489618382487, 6082.75668973245, 6095.299040610298, 6083.7566497340495, 6106.673025714385, 6154.446099851035, 6204.0, 6219.036049412258, 6089.421504957022, 6139.522803442322, 6142.253225532421, 6191.473724733448, 6198.0, 6159.384061593805, 6203.2556093268195, 6208.099825525273, 6220.875582488325, 6233.75064997395, 4802.615790736732, 4910.607151427877, 4920.6555541111775, 4929.137400954819, 5006.949930500648, 4335.566443355639, 4382.583654552813, 4416.183006143874, 4422.248217802981, 4437.955620443754, 5588.385277619459, 5624.662520248717, 5626.493615574618, 5674.233978412862, 5680.233168522279, 6023.879522409527, 6137.560853825989, 6200.937990620036, 6290.968545157245, 6295.118683384329, 5667.574931880125, 5689.516391106719, 5689.743961521742, 5694.373618901917, 5730.19777231188, 5409.5131438169965, 5412.431694672082, 5412.539934105645, 5419.918701219485, 5433.456654334614, 6226.034964580497, 6269.467095296951, 6294.622322660655, 6357.300696923335, 6376.553641245068, 6275.901717199563, 6285.96857015712, 6300.9684951574945, 6308.306086330408, 6316.684165791784, 6309.968450157903, 6339.714712838026, 6341.8097457076365, 6345.302016778059, 6347.333529979471, 5925.111233315038, 6064.666443345658, 6084.11780291864, 6147.508199344131, 6149.723262453111, 6242.843928901813, 6252.562320637694, 6256.061590761422, 6258.998560230341, 6287.088372185916, 6049.30433000193, 6066.757329706762, 6080.513558915188, 6103.877922441615, 6108.908366374419, 5860.853478663067, 5981.611195272293, 6012.1582978382185, 6059.787907423219, 6075.848103797441, 5803.158542011301, 5823.505002074871, 5894.852628684145, 5909.734061967308, 5948.8810223796145, 5554.722263886709, 5568.888622227451, 5938.881222375442, 6013.939860601513, 6052.606580572248, 5687.687177205294, 5823.301203855564, 5856.619319744203, 5861.9706901466925, 5875.294964604275], "value": 5635.831857348554, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.1320875259543, 502.5577491807209, 514.9742512874358, 517.2964767915637, 526.9394019687735, 37684.62315376845, 39886.0, 39952.001199970015, 40066.399004014966, 40103.59896401035, 40619.78140655785, 40964.38553421701, 41028.58971410285, 41081.17837643245, 41269.0, 8260.793480162998, 9646.517674116301, 9731.172850307732, 9768.90231097687, 9790.0, 9624.0, 9690.0, 9764.609415623367, 9777.853332200022, 9803.950980245088, 9708.077732615426, 9753.463559504224, 9758.853617195713, 9766.07222313879, 9769.462679552622, 9723.0, 9742.1719153872, 9742.782152230971, 9767.999999999964, 9784.217262618973, 9665.275104367201, 9769.169620582188, 9774.16919561838, 9781.853272200922, 9791.46146961924, 32241.1939701507, 37646.623533764585, 38921.805390973146, 39160.41259381112, 39257.0, 2578.8065895057944, 3373.3927892979254, 3484.6341134181052, 3488.982555087234, 3618.5672551124926, 28529.429411411864, 30084.0, 31138.221544461343, 31582.052538423883, 32057.358852823047, 3225.6774322567558, 3303.151828120237, 3307.603087629476, 3433.2446861690637, 3435.175557866119, 408792.0, 497281.0, 508603.0, 515245.0, 519737.0, 63649.045264321074, 64864.243327151176, 65017.67491162514, 65075.34924650693, 65085.67457162684, 32521.51217731736, 35186.47220291698, 36059.39406059373, 37056.25887482235, 37259.4411083834, 16803.915980420265, 16976.32094716222, 16981.490555283362, 17001.0, 17006.659866802842, 12928.288944108164, 13016.958643308513, 13040.54358097462, 13056.934715326362, 13067.803982940264, 16908.492745217663, 20352.982350882397, 20413.081411336527, 20578.897105514377, 20593.588128237352, 8574.528400938008, 8576.828463430697, 8629.0, 8665.783355416164, 8683.652653893774, 833.7623777223462, 864.6757465950269, 924.4776701163955, 961.5240455974338, 990.9009099090177, 28531.857340713163, 29385.85307073451, 29750.25624359365, 29824.956126535468, 30567.38865222683, 913.4701872913827, 990.232569758443, 1127.2503784982894, 1147.4090843215752, 1165.8691069662414, 13574.796378054338, 14547.154423027217, 15391.0, 15568.688626227413, 15905.761413578806, 675092.0, 696534.0, 697161.0, 698528.50735746, 702186.0, 56625.71687141538, 56716.71641641765, 57125.0, 57524.0, 57583.424165758646, 1356.1488568104467, 1358.4023029866828, 1410.6825964157777, 1415.6177831985306, 1424.8575142485668, 26322.86838565795, 29779.0, 30044.849775750983, 30835.537466938462, 30942.071737847902, 51071.74464127656, 51691.483085168664, 51730.0, 51750.48249517457, 51753.482465174864, 541712.0, 547926.0, 547997.0, 548071.0, 548131.0, 35220.64779352173, 40894.9776255596, 41606.79196603998, 41633.0, 41814.37278440765, 45760.0, 46199.61401157971, 46468.767656162854, 46637.0, 47324.816879578284, 38561.421578676905, 38760.418593720555, 38843.611563884, 39782.2043559133, 39976.20047598974, 33269.502872370314, 35221.0, 37887.242255155295, 39297.0, 39371.409428858016, 27623.30941726473, 30739.846300768353, 36708.0, 36814.0, 37993.0, 33016.66983330136, 33547.664523354455, 34475.82762086173, 34580.96257112291, 34609.0, 23344.53310933738, 25242.621360679237, 25688.0, 25870.87064564665, 26064.609030864933], "value": 19931.390181971303, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.950717638766, 364.52793632246255, 371.42058388913307, 380.02713054580295, 396.1087553005737, 19335.323263685776, 20293.695594566092, 20914.0, 21183.258585949494, 21311.36065918021, 20415.183392664312, 20696.586068278662, 20722.585548289062, 20821.479463013395, 20931.476713082142, 5570.637908535932, 5674.631148975303, 5883.0, 5973.6260660048, 5980.282366116072, 5870.765169393219, 5961.344252132284, 5964.314103878044, 5968.970155149218, 5969.224000879901, 5623.718814059301, 5819.912701309484, 5851.4148585141575, 5851.888141253169, 5904.409559044104, 5610.579206559483, 5786.913196302038, 5802.274715660543, 5830.650160990312, 5875.441833025877, 5113.948860511385, 5159.045576568309, 5170.146925757245, 5175.482451754794, 5176.456472070454, 25005.49989000228, 25314.114006009884, 25345.85943632541, 25545.361365965815, 25671.486570268677, 2247.1236217875044, 2382.987230427079, 2520.621906713989, 2703.418764965542, 2756.1593713917246, 15485.690286194325, 15510.30203640839, 15626.921865390714, 15655.914831188918, 16030.83969160305, 1601.2794242590764, 1865.8897955716327, 1932.9130189141522, 1943.9611207775906, 1971.467703720002, 114508.42745786301, 128664.71335286714, 132508.02750575595, 132645.0, 134695.0, 8508.532030738244, 9708.417494950325, 10322.22583306255, 11309.60416385439, 11470.426478676032, 11705.414729263674, 14046.859531404556, 14104.506342277971, 14115.364808583638, 14179.85820141806, 8095.635696393676, 8199.549024803573, 8380.539070351067, 8398.874016889751, 8582.742517724353, 7358.484906056632, 8413.705520306883, 8470.237678608955, 8582.013068497203, 8615.569221538897, 4333.43665323506, 4417.823287068545, 4422.402975598317, 4439.8002089905385, 4500.527444618333, 1660.435451946344, 1908.5228692826793, 1944.9805501945082, 1964.1652297773676, 1987.4037788663632, 793.8769490728831, 834.929031032369, 848.554508882829, 881.3874357321728, 894.8568229083315, 20113.19547218095, 20964.371068867957, 21027.26404575863, 21031.78968210329, 21121.89439052795, 854.7820305821975, 900.869373940775, 915.377543270569, 946.5078159357233, 949.1505102932974, 10386.636467723594, 11006.669799906016, 11027.338359698444, 11046.232602783677, 11052.67893742323, 582848.0, 595139.0, 596984.0, 598324.0, 605961.0, 130417.34791326172, 134805.32597337148, 136364.0, 141698.0, 148060.0, 812.7114874219685, 975.9951200243953, 991.2367477042637, 993.7664648807524, 1006.9144122749649, 18588.0, 19159.712604311226, 19187.520311991753, 19275.61448771045, 19285.132169052707, 43776.56223437725, 55813.0, 56197.446434105485, 56579.43420565906, 58233.971315777, 71124.64437677778, 81609.0, 83825.0, 86215.13784862071, 87857.56071219603, 11723.589674361356, 12159.939200303941, 12431.067669924973, 12525.06062045332, 12605.87394126047, 12236.449359778653, 12639.241645501299, 13214.27321497327, 13688.110272832235, 13835.584932452042, 7279.672414741455, 7423.257674232749, 10704.839427408438, 11597.594084207012, 11914.940425297818, 7262.62010218078, 7497.137829149718, 7505.174430812715, 8047.114817369968, 8105.6584228924985, 7959.681612735426, 8310.459820111673, 8340.87488687658, 8459.365547583833, 8484.769708392125, 9060.456372617664, 10358.5338659762, 10993.230473866752, 11700.70748231301, 11760.411979401168, 8466.407351485337, 10884.074853637212, 11938.64184074479, 12004.75990480168, 12071.551413830397], "value": 9632.79245013109, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1469.963250918727, 1485.353871066086, 1639.6720655868821, 1790.5344610401291, 1812.673718730628, 7957.602119893997, 8336.124706905772, 8556.486610803357, 8918.77703057424, 8947.55262236888, 8573.056963733985, 8791.560421978891, 8794.736157915273, 8801.823963520726, 8814.294856411489, 2351.976480235197, 2387.7612238776155, 2388.7252965908883, 2392.964105538418, 2398.0887262840097, 2330.9300720978313, 2368.8578685278853, 2371.715394152704, 2378.0250097460043, 2389.7132344118645, 2355.305184970438, 2369.514249578841, 2375.928722138339, 2378.5361854438393, 2382.261498935327, 2335.2293743064747, 2339.9181028664, 2354.6114891042957, 2356.8199415540644, 2367.9881600592057, 1807.4487281379174, 2074.2532688232222, 2343.308723926446, 2350.341904266808, 2353.2351985604746, 8770.517621530813, 8809.515476648781, 8878.955605221932, 8881.555922203928, 8889.555522223864, 5051.545360917498, 5162.845114646567, 5178.14560597501, 5194.4026436959475, 5201.349831271091, 3321.1199032256472, 3428.9485657715154, 3519.1202199450136, 3549.893503194908, 3558.7864728116397, 1046.4966192400507, 1072.2976450424985, 1088.0479580367178, 1098.1983152298867, 1101.4162493878257, 10774.138068954464, 10777.784444311148, 10869.45652717361, 10876.129909607213, 10895.564177432972, 4315.093830295673, 4405.911881762347, 4546.249868771615, 4558.0428110097255, 4568.931466028012, 9376.67181648639, 9450.102240287162, 9460.479673618018, 9460.716178514656, 9462.52687365629, 5104.259882317043, 5115.462876397999, 5124.666896651705, 5129.948700513021, 5144.742762861917, 4385.6710746694125, 4661.440627124767, 4675.251959686434, 4759.214729569651, 4791.448983366888, 3590.533230679995, 3774.735768496234, 3843.6348546888003, 3902.3951287550476, 3948.289307924601, 982.4694664881027, 1069.8823129455754, 1071.9494895002786, 1135.6195674448986, 1238.1642391385778, 715.9355657990806, 781.7107670162077, 833.5748768128177, 882.1311008656468, 906.8141031088611, 5554.91667624986, 5809.564282678816, 5917.171595976567, 5936.910946335808, 6123.173371594778, 880.2825697056878, 888.9599168972318, 935.6397786852111, 967.0716112531908, 967.8886928003229, 3811.923761524754, 4023.8591649292134, 4083.8570650027104, 4123.257813593582, 4225.809838557272, 10382.480875956324, 10612.416317102634, 10791.406472643923, 10815.891841081488, 11003.944980275048, 10478.580856765644, 10739.087177589836, 10744.0, 10754.892451075546, 10776.0, 8027.438079334391, 8038.070862992957, 8043.276105150448, 8210.425270231026, 8248.13394593571, 5926.318473375444, 6014.6391216527145, 6108.297545782292, 6118.632882027093, 6136.815895523141, 9819.55811988448, 9880.0, 9907.356021858555, 9917.900820991987, 9941.105300522988, 9915.752106197115, 10071.194304455772, 10113.342632728849, 10204.2346823987, 10300.0, 6925.480588955949, 7503.512271702322, 7563.054618172729, 7853.646585903533, 8154.673813047411, 8145.8370832584205, 8342.499450033018, 8432.53621050848, 8435.95782021086, 8445.1977062179, 7376.631168441664, 7430.628468576441, 7475.588842613708, 7477.813054673677, 7490.0, 7275.0, 7307.0, 7338.70645174187, 7351.522151060164, 7442.590657513672, 6895.6552172390175, 6914.0320355151325, 6985.196702379291, 6987.790366289019, 6991.615461149686, 4646.140464014168, 4858.489858564941, 4883.584895283799, 4918.311436398979, 4968.577670898014, 4525.0, 4580.106879158532, 4605.562471565196, 4697.906041879211, 4758.214894542361], "value": 4515.670340996139, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.8945890020692, 300.41868983516883, 312.1774125180151, 312.37369075004614, 312.8607769542553, 5388.568914486841, 5499.7250137493065, 5566.860828479285, 5641.915371269434, 5680.602357834948, 4757.333973243749, 5422.728863556826, 5557.138643510262, 5562.666240025601, 5617.8033768818095, 3806.2387522495474, 4209.389638502423, 4221.620054195122, 4224.260754367973, 4238.618524332809, 3360.8823691170815, 3613.662944710461, 3665.0654083208747, 3938.7045971552106, 4198.769067701275, 3457.0147507960237, 3811.4854494643146, 3993.542357039689, 4048.7773172475504, 4161.354989976543, 3491.9524142757073, 4183.644390226835, 4191.087194399894, 4194.538600753915, 4210.831566737327, 3054.7403470705017, 3554.875579354736, 3663.5054267674054, 3672.989927769858, 3700.2414505026404, 5424.349078110613, 5426.290718423684, 5451.209574611698, 5454.4545545445535, 5475.508643567167, 4378.9562104378865, 4642.816081899128, 4721.433427988663, 4909.263610458424, 4940.802367905279, 5315.548178404841, 5367.409584945653, 5795.507381872546, 5949.702514874239, 6004.318790738556, 3687.1519550503535, 3970.583088775666, 4100.630943215125, 4109.404136400235, 4111.753294802322, 5354.384245811703, 6257.2491301044165, 6272.2786879508985, 6301.212348456397, 6325.240971083454, 3404.6084700259294, 3664.9083772905356, 4059.4722686051214, 4121.216968775923, 4134.421181034658, 4240.0, 4245.702800803914, 4249.363994861938, 4249.766262855511, 4269.978650106792, 4291.721038132511, 4295.634871035934, 4924.236743304794, 4935.457099719028, 4935.827246046443, 4956.727379994063, 5729.942700573024, 5875.324337701134, 6003.729832157564, 6016.278046634345, 1234.3519652182677, 1276.0, 1383.9238841863794, 1388.0, 1436.2603259321459, 858.4891989266376, 941.7662861651258, 959.7840485890619, 978.6476868327396, 979.2655508368723, 4877.171060852181, 5384.380796208407, 5471.151971444432, 5477.959187754314, 5495.587830912697, 5252.921206181911, 5515.380194407624, 6028.021505806235, 6040.375774535244, 6054.788082417094, 4382.474103107584, 4568.74871882043, 5092.719900405513, 5364.7585858635675, 5448.45515448452, 2249.8650080995194, 2349.5300939812105, 2671.906483273076, 2716.2258756254373, 2730.9180724578296, 4611.279345186289, 4669.41632295963, 4910.361652985089, 5295.867603309871, 5320.015797077553, 5239.790408383622, 5262.079750585762, 5749.252597162425, 5764.4523770242595, 6364.745410183541, 6438.291787903327, 6441.871162576722, 6447.0, 6457.062036773351, 6457.61254324742, 5140.7429628517675, 6006.117063809309, 6206.689665516616, 6214.285357183981, 6216.658083805434, 5607.0, 6053.848653783691, 6091.482224011009, 6135.785247516315, 6148.569600128127, 5353.866153346197, 5522.530584900329, 5548.1427065062335, 6385.010323399881, 6499.895017846883, 3160.972683877703, 3263.2052371195273, 3445.8277086146095, 3449.6377880323207, 3638.94470603522, 5377.064256867447, 5478.808241711521, 5976.910346344721, 6018.488428483628, 6260.937390626035, 4971.751412429437, 5962.731677074456, 5985.700714964148, 6030.155778191144, 6037.426444487766, 5352.4915133062295, 5771.422857714195, 5975.521958243417, 5996.670183139795, 6002.799440111908, 5569.721513924206, 5801.448862358069, 5836.118980877669, 5858.853528661817, 5865.237519122486, 5791.89953908756, 5964.045752679551, 5991.191189189403, 5999.970000149971, 6048.45764330093, 5526.91709624364, 5550.139728342114, 5619.550435965195, 5896.410358964069, 5905.940940590711], "value": 4213.447481812174, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.3327138939255, 738.9593572353525, 741.6440108747801, 790.5217343507179, 818.5866137600513, 15118.244087795607, 15771.60570985726, 15830.76253856193, 16145.19274036298, 16192.109433981126, 14716.337764800583, 14781.039232449883, 14879.032862863905, 14893.404263829434, 14903.701925961474, 675.6858061001633, 817.9591020448984, 831.5925196653626, 834.04501845387, 838.4466252273501, 839.5046922315832, 850.5577099908044, 852.3224036890656, 857.5240741388527, 861.1431625532604, 700.726716580534, 873.4148120759106, 895.2703546609492, 896.6727144592243, 899.2895612466144, 889.0931250124901, 889.297455010541, 891.0510306523531, 891.9955400223022, 893.3835653399166, 644.4522156167267, 649.1528555235416, 653.5653790229492, 656.7340227207989, 657.4247533408268, 15746.68506629861, 15877.36490540377, 15995.840041599551, 16016.519504414886, 16029.519114426586, 10927.289726167774, 14496.42014319426, 14615.853841461556, 14681.77977330341, 14799.630009249748, 11869.050475961989, 11973.221740586834, 11993.580224692094, 12010.339431331273, 12091.0, 3788.747994615882, 3799.704280001167, 3828.942565861514, 3866.0528170598104, 3892.5912779158066, 124155.0, 125782.37108814398, 126024.36987815003, 126922.0, 127063.0, 11217.0, 11259.437028148559, 11317.773644527064, 11354.318740875575, 11554.595589154507, 23408.882955585454, 23611.40971475727, 23637.409064773517, 23921.52156956851, 23996.64005039891, 8011.519308841488, 8077.192280771876, 8083.919160808434, 8115.147909469539, 8272.214139656722, 4386.890327741832, 4419.049904270597, 4420.093880754438, 4429.623482004065, 4485.551444855553, 3559.4660800880074, 3675.1914578793157, 3690.686291665185, 3691.5201023866725, 3700.2229531798625, 550.2159422822461, 636.6053047110821, 641.7497176101324, 643.1670986073046, 646.3859333633068, 548.56937304216, 592.5792687192142, 637.5664548107239, 673.1417442760421, 683.5078743304912, 8548.016978047479, 9308.44149351041, 9385.296102792317, 9451.621935122517, 9706.495493198565, 519.3508114856429, 520.9843704688866, 555.9722013899288, 654.3848782144769, 669.568128557078, 3556.982215088908, 4439.467263928284, 4559.475660299042, 4633.86098417048, 4646.744429056367, 123605.38197308956, 153331.0, 162325.0, 167800.0, 168949.0, 129302.35348823195, 131696.0, 134704.0, 134772.3261383687, 137218.0, 112958.43520782508, 114909.0, 115132.0, 115707.42146289384, 119234.4038279803, 8929.330300227639, 8937.419067760575, 8956.910430895608, 9068.093190680878, 9211.0, 60920.39079609147, 66597.00208993738, 67036.6648166756, 68995.96506052313, 70398.0, 70374.0, 72469.91295130683, 83512.0, 84695.07134500526, 93836.0, 13178.934105329796, 13190.80213796813, 13276.601701948957, 13508.324583770576, 13857.030007899753, 13492.797608035691, 14650.34073466718, 14808.037477563925, 15300.77048844246, 15570.455034073753, 13276.0, 13440.663983400493, 13708.066199493225, 13869.445222191403, 14244.623615851402, 11028.613998510335, 13600.234332722805, 13616.795748063589, 13785.241811700453, 13933.0, 13319.200847949154, 13401.262930538915, 13403.597892063253, 13525.120867143603, 14043.859561404664, 10972.122230221723, 11134.88865111371, 11329.263597866113, 11646.010089142517, 11699.0, 9799.167070799062, 10237.436940968319, 10698.89301106979, 11316.98147166759, 11562.653120406401], "value": 7867.183271012186, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1579.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 110.0, 116.0, 117.0, 116.0, 95.0, 118.0, 117.0, 118.0, 116.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 139.0, 138.0, 159.0, 111.0, 129.0, 126.0, 112.0, 166.0, 141.0], "value": 138.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 197.0, 201.0, 200.0, 251.0, 279.0, 243.0, 202.0, 209.0, 256.0], "value": 223.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 81.0, 76.0, 149.0, 59.0, 62.0, 57.0, 65.0, 135.0, 60.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 119.0, 71.0, 69.0, 81.0, 111.0, 72.0, 102.0, 109.0], "value": 87.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 90.0, 86.0, 89.0, 85.0, 89.0, 86.0, 89.0, 86.0], "value": 87.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 118.0, 124.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 118.0], "value": 102.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 91.0, 92.0, 101.0, 90.0, 107.0, 129.0, 91.0, 99.0], "value": 98.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 59.0, 59.0, 62.0, 83.0, 89.0, 89.0, 90.0, 85.0, 56.0], "value": 72.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 60.0, 76.0, 117.0, 104.0, 106.0, 76.0, 73.0, 71.0, 105.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 91.0, 88.0, 87.0, 87.0, 84.0, 87.0, 88.0, 86.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 182.0, 127.0, 154.0, 168.0, 133.0, 153.0, 151.0, 197.0, 166.0], "value": 157.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 174.0, 229.0, 167.0, 171.0, 172.0, 172.0, 173.0, 168.0, 170.0], "value": 176.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 66.0, 67.0, 67.0, 71.0, 68.0, 61.0, 90.0, 58.0], "value": 68.6, "unit": "score"}]}]} 01:16:36 INFO - Return code: 0 01:16:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:16:36 ERROR - # TBPL SUCCESS # 01:16:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:16:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:16:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:16:36 INFO - 2016-08-30 01:16:36.989 screenresolution[1676:11346] starting screenresolution argv=screenresolution get 01:16:36 INFO - 2016-08-30 01:16:36.992 screenresolution[1676:11346] Display 0: 1600x1200x32@60 01:16:36 INFO - 2016-08-30 01:16:36.998 screenresolution[1677:11348] starting screenresolution argv=screenresolution list 01:16:37 INFO - Available Modes on Display 0 01:16:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:16:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:16:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:16:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:16:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:16:37 INFO - Intel Iris: 01:16:37 INFO - Chipset Model: Intel Iris 01:16:37 INFO - Type: GPU 01:16:37 INFO - Bus: Built-In 01:16:37 INFO - VRAM (Dynamic, Max): 1536 MB 01:16:37 INFO - Vendor: Intel (0x8086) 01:16:37 INFO - Device ID: 0x0a2e 01:16:37 INFO - Revision ID: 0x0009 01:16:37 INFO - Displays: 01:16:37 INFO - Display: 01:16:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:16:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:16:37 INFO - Display Serial Number: 1600x1200 60 01:16:37 INFO - Main Display: Yes 01:16:37 INFO - Mirror: Off 01:16:37 INFO - Online: Yes 01:16:37 INFO - Rotation: Supported 01:16:37 INFO - Return code: 0 01:16:37 INFO - Running post-action listener: _resource_record_post_action 01:16:37 INFO - [mozharness: 2016-08-30 08:16:37.244054Z] Finished run-tests step (success) 01:16:37 INFO - Running post-run listener: _resource_record_post_run 01:16:37 INFO - Total resource usage - Wall time: 1208s; CPU: 55.0%; Read bytes: 32988160; Write bytes: 710074880; Read time: 310; Write time: 1862 01:16:37 INFO - TinderboxPrint: CPU usage
54.6% 01:16:37 INFO - TinderboxPrint: I/O read bytes / time
32,988,160 / 310 01:16:37 INFO - TinderboxPrint: I/O write bytes / time
710,074,880 / 1,862 01:16:37 INFO - TinderboxPrint: CPU idle
2,194.7 (45.4%) 01:16:37 INFO - TinderboxPrint: CPU system
979.6 (20.3%) 01:16:37 INFO - TinderboxPrint: CPU user
1,659.5 (34.3%) 01:16:37 INFO - TinderboxPrint: Swap in / out
435,630,080 / 0 01:16:37 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 402885120; Write bytes: 396576256; Read time: 29883; Write time: 711 01:16:37 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 30899200; Write bytes: 300768256; Read time: 287; Write time: 1117 01:16:37 INFO - Running post-run listener: _upload_blobber_files 01:16:37 INFO - Blob upload gear active. 01:16:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:16:37 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 01:16:37 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'] 01:16:37 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 01:16:38 INFO - (blobuploader) - INFO - Open directory for files ... 01:16:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:16:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:16:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:16:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:16:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:16:39 INFO - (blobuploader) - INFO - Done attempting. 01:16:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:16:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:16:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:16:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:16:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:16:40 INFO - (blobuploader) - INFO - Done attempting. 01:16:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:16:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:16:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:16:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:16:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:16:42 INFO - (blobuploader) - INFO - Done attempting. 01:16:42 INFO - (blobuploader) - INFO - Iteration through files over. 01:16:42 INFO - Return code: 0 01:16:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:16:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:16:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9920a7f142bcec4aa3b172c52265a98acdd85175bf4f2473867b17ea8c04d1922227e632ca5f72d4908d8c3803cd1cc6d3667606fe5c1d9dfdb88bb205e9c997", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a673b67a89061af5e1560019b748fdf2a2f6e35a89d6cbdc922d9c04d7c8ae448a67413dce50bbf3aaa97392aa46fc02ec9fe711f15fec703626543a106d80dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7fcbfbb6d87f985983dfca05977adfd6281060b49fb8a68036025f2e7e436a699fbe048ab8bc8aeaa37eb71b570aeff9e04cd5b3f0cb1e9fa8999b0996ff9eab"} 01:16:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:16:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:16:42 INFO - Contents: 01:16:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9920a7f142bcec4aa3b172c52265a98acdd85175bf4f2473867b17ea8c04d1922227e632ca5f72d4908d8c3803cd1cc6d3667606fe5c1d9dfdb88bb205e9c997", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a673b67a89061af5e1560019b748fdf2a2f6e35a89d6cbdc922d9c04d7c8ae448a67413dce50bbf3aaa97392aa46fc02ec9fe711f15fec703626543a106d80dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7fcbfbb6d87f985983dfca05977adfd6281060b49fb8a68036025f2e7e436a699fbe048ab8bc8aeaa37eb71b570aeff9e04cd5b3f0cb1e9fa8999b0996ff9eab"} 01:16:42 INFO - Running post-run listener: copy_logs_to_upload_dir 01:16:42 INFO - Copying logs to upload dir... 01:16:42 INFO - mkdir: /builds/slave/test/build/upload/logs 01:16:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.209056 ========= master_lag: 3.68 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-30 01:16:46.177973) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 01:16:46.181021) ========= 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.FeHhb2wfG1/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.3ET1RgBnuY/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9920a7f142bcec4aa3b172c52265a98acdd85175bf4f2473867b17ea8c04d1922227e632ca5f72d4908d8c3803cd1cc6d3667606fe5c1d9dfdb88bb205e9c997", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a673b67a89061af5e1560019b748fdf2a2f6e35a89d6cbdc922d9c04d7c8ae448a67413dce50bbf3aaa97392aa46fc02ec9fe711f15fec703626543a106d80dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7fcbfbb6d87f985983dfca05977adfd6281060b49fb8a68036025f2e7e436a699fbe048ab8bc8aeaa37eb71b570aeff9e04cd5b3f0cb1e9fa8999b0996ff9eab"} build_url:https://queue.taskcluster.net/v1/task/bHvsR6g7RmCy14w2acRrZg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010974 build_url: 'https://queue.taskcluster.net/v1/task/bHvsR6g7RmCy14w2acRrZg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9920a7f142bcec4aa3b172c52265a98acdd85175bf4f2473867b17ea8c04d1922227e632ca5f72d4908d8c3803cd1cc6d3667606fe5c1d9dfdb88bb205e9c997", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a673b67a89061af5e1560019b748fdf2a2f6e35a89d6cbdc922d9c04d7c8ae448a67413dce50bbf3aaa97392aa46fc02ec9fe711f15fec703626543a106d80dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7fcbfbb6d87f985983dfca05977adfd6281060b49fb8a68036025f2e7e436a699fbe048ab8bc8aeaa37eb71b570aeff9e04cd5b3f0cb1e9fa8999b0996ff9eab"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 01:16:46.219312) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 01:16:46.219718) ========= 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.FeHhb2wfG1/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.3ET1RgBnuY/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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.005203 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 01:16:46.271434) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 01:16:46.272174) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 01:16:46.272946) ========= ========= Total master_lag: 3.84 =========