builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0248 starttime: 1472736997.8 results: success (0) buildid: 20160901053821 builduid: 0dbbe95f11c54603b9f542742e9e69ef revision: cba87d584348ee62004f8d7893529c9b37a6bded ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 06:36:37.799703) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 06:36:37.805423) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 06:36:37.805767) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 06:36:37.947322) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:36:37.947627) ========= 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.s7Y8XVTt4n/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.N7UmSSKCVS/Listeners TMPDIR=/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/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-09-01 06:36:37-- 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% 20.9M=0.001s 2016-09-01 06:36:38 (20.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.858135 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:36:38.829723) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:36:38.830050) ========= 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.s7Y8XVTt4n/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.N7UmSSKCVS/Listeners TMPDIR=/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/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.026643 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:36:38.879127) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-01 06:36:38.879500) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cba87d584348ee62004f8d7893529c9b37a6bded --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 cba87d584348ee62004f8d7893529c9b37a6bded --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.s7Y8XVTt4n/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.N7UmSSKCVS/Listeners TMPDIR=/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/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-09-01 06:36:38,960 truncating revision to first 12 chars 2016-09-01 06:36:38,960 Setting DEBUG logging. 2016-09-01 06:36:38,960 attempt 1/10 2016-09-01 06:36:38,961 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cba87d584348?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 06:36:40,056 unpacking tar archive at: fx-team-cba87d584348/testing/mozharness/ program finished with exit code 0 elapsedTime=1.362044 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-01 06:36:40.263712) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 06:36:40.264015) ========= script_repo_revision: cba87d584348ee62004f8d7893529c9b37a6bded ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 06:36:40.264486) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 06:36:40.265116) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 06:36:40.285041) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-09-01 06:36:40.285661) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.s7Y8XVTt4n/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.N7UmSSKCVS/Listeners TMPDIR=/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/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 06:36:40 INFO - MultiFileLogger online at 20160901 06:36:40 in /builds/slave/test 06:36:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:36:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:36:40 INFO - {'append_to_log': False, 06:36:40 INFO - 'base_work_dir': '/builds/slave/test', 06:36:40 INFO - 'blob_upload_branch': 'Fx-Team', 06:36:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:36:40 INFO - 'branch': 'Fx-Team', 06:36:40 INFO - 'buildbot_json_path': 'buildprops.json', 06:36:40 INFO - 'config_files': ('talos/mac_config.py',), 06:36:40 INFO - 'default_actions': ('clobber', 06:36:40 INFO - 'read-buildbot-config', 06:36:40 INFO - 'download-and-extract', 06:36:40 INFO - 'populate-webroot', 06:36:40 INFO - 'create-virtualenv', 06:36:40 INFO - 'install', 06:36:40 INFO - 'run-tests'), 06:36:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:36:40 INFO - 'download_minidump_stackwalk': True, 06:36:40 INFO - 'download_symbols': 'ondemand', 06:36:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:36:40 INFO - 'tooltool.py': '/tools/tooltool.py', 06:36:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:36:40 INFO - '/tools/misc-python/virtualenv.py')}, 06:36:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:36:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:36:40 INFO - 'installer_path': 'installer.exe', 06:36:40 INFO - 'log_level': 'info', 06:36:40 INFO - 'log_name': 'talos', 06:36:40 INFO - 'log_to_console': True, 06:36:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:36:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:36:40 INFO - 'opt_config_files': (), 06:36:40 INFO - 'pip_index': False, 06:36:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:36:40 INFO - 'cmd': ('bash', 06:36:40 INFO - '-c', 06:36:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:36:40 INFO - 'enabled': True, 06:36:40 INFO - 'halt_on_failure': False, 06:36:40 INFO - 'name': 'check_screen_resolution'},), 06:36:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:36:40 INFO - 'cmd': ('bash', 06:36:40 INFO - '-c', 06:36:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:36:40 INFO - 'enabled': True, 06:36:40 INFO - 'halt_on_failure': False, 06:36:40 INFO - 'name': 'check_screen_resolution'},), 06:36:40 INFO - 'run_cmd_checks_enabled': True, 06:36:40 INFO - 'sps_profile': False, 06:36:40 INFO - 'sps_profile_interval': 0, 06:36:40 INFO - 'suite': 'dromaeojs', 06:36:40 INFO - 'system_bits': '32', 06:36:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:36:40 INFO - 'title': 't-yosemite-r7-0248', 06:36:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:36:40 INFO - 'use_talos_json': True, 06:36:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:36:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:36:40 INFO - 'work_dir': 'build'} 06:36:40 INFO - [mozharness: 2016-09-01 13:36:40.478531Z] Running clobber step. 06:36:40 INFO - Running pre-action listener: _resource_record_pre_action 06:36:40 INFO - Running main action method: clobber 06:36:40 INFO - rmtree: /builds/slave/test/build 06:36:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:36:42 INFO - Running post-action listener: _resource_record_post_action 06:36:42 INFO - [mozharness: 2016-09-01 13:36:42.605368Z] Finished clobber step (success) 06:36:42 INFO - [mozharness: 2016-09-01 13:36:42.605492Z] Running read-buildbot-config step. 06:36:42 INFO - Running pre-action listener: _resource_record_pre_action 06:36:42 INFO - Running main action method: read_buildbot_config 06:36:42 INFO - Using buildbot properties: 06:36:42 INFO - { 06:36:42 INFO - "project": "", 06:36:42 INFO - "product": "firefox", 06:36:42 INFO - "script_repo_revision": "production", 06:36:42 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 06:36:42 INFO - "repository": "", 06:36:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 06:36:42 INFO - "buildid": "20160901053821", 06:36:42 INFO - "pgo_build": "False", 06:36:42 INFO - "basedir": "/builds/slave/test", 06:36:42 INFO - "buildnumber": 11, 06:36:42 INFO - "slavename": "t-yosemite-r7-0248", 06:36:42 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 06:36:42 INFO - "platform": "yosemite_r7", 06:36:42 INFO - "scheduler": "tests-fx-team-macosx64-talos", 06:36:42 INFO - "branch": "fx-team", 06:36:42 INFO - "repo_path": "integration/fx-team", 06:36:42 INFO - "revision": "cba87d584348ee62004f8d7893529c9b37a6bded", 06:36:42 INFO - "stage_platform": "macosx64", 06:36:42 INFO - "builduid": "0dbbe95f11c54603b9f542742e9e69ef", 06:36:42 INFO - "slavebuilddir": "test" 06:36:42 INFO - } 06:36:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 06:36:42 INFO - Running post-action listener: _resource_record_post_action 06:36:42 INFO - [mozharness: 2016-09-01 13:36:42.608390Z] Finished read-buildbot-config step (success) 06:36:42 INFO - [mozharness: 2016-09-01 13:36:42.608497Z] Running download-and-extract step. 06:36:42 INFO - Running pre-action listener: _resource_record_pre_action 06:36:42 INFO - Running main action method: download_and_extract 06:36:42 INFO - mkdir: /builds/slave/test/build/tests 06:36:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:42 INFO - trying https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 06:36:42 INFO - Downloading https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/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 06:36:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/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 06:36:44 INFO - Downloaded 1199 bytes. 06:36:44 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 06:36:44 INFO - Using the following test package requirements: 06:36:44 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 06:36:44 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:36:44 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 06:36:44 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:36:44 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 06:36:44 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:36:44 INFO - u'jsshell-mac.zip'], 06:36:44 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:36:44 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 06:36:44 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 06:36:44 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:36:44 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 06:36:44 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:36:44 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 06:36:44 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:36:44 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 06:36:44 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:36:44 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 06:36:44 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:36: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')]} 06:36:44 INFO - trying https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 06:36:44 INFO - Downloading https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/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 06:36:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/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 06:36:44 INFO - Downloaded 16399883 bytes. 06:36:44 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 06:36:52 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 06:36: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')]} 06:36:52 INFO - trying https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 06:36:52 INFO - Downloading https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/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 06:36:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/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 06:36:52 INFO - Downloaded 16399883 bytes. 06:36:52 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 06:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:59 INFO - trying https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 06:36:59 INFO - Downloading https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/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 06:36:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/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 06:37:00 INFO - Downloaded 14413998 bytes. 06:37:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 06:37: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')]} 06:37:00 INFO - trying https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 06:37:00 INFO - Downloading https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 06:37:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/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 06:37:04 INFO - Downloaded 111596273 bytes. 06:37:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 06:37:04 INFO - mkdir: /builds/slave/test/properties 06:37:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:37:04 INFO - Writing to file /builds/slave/test/properties/build_url 06:37:04 INFO - Contents: 06:37:04 INFO - build_url:https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 06:37:04 INFO - Running post-action listener: _resource_record_post_action 06:37:04 INFO - Running post-action listener: set_extra_try_arguments 06:37:04 INFO - [mozharness: 2016-09-01 13:37:04.850457Z] Finished download-and-extract step (success) 06:37:04 INFO - [mozharness: 2016-09-01 13:37:04.850602Z] Running populate-webroot step. 06:37:04 INFO - Running pre-action listener: _resource_record_pre_action 06:37:04 INFO - Running main action method: populate_webroot 06:37:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:37:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:37:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:37:04 INFO - '--tppagecycles', 06:37:04 INFO - '7'], 06:37:04 INFO - 'tests': ['tsvgm']}}, 06:37:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:37:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:37:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:37:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:37:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:37:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:37:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:04 INFO - 'talos_options': ['--disable-e10s'], 06:37:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:37:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:37:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:04 INFO - 'talos_options': ['--disable-e10s'], 06:37:04 INFO - 'tests': ['damp', 'tps']}, 06:37:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:04 INFO - 'tests': ['damp', 'tps']}, 06:37:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:37:04 INFO - 'tests': ['dromaeo_dom']}, 06:37:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:37:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:37:04 INFO - 'tests': ['basic_compositor_video']}, 06:37:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:37:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:37:04 INFO - 'tests': ['a11yr', 06:37:04 INFO - 'ts_paint', 06:37:04 INFO - 'tpaint', 06:37:04 INFO - 'sessionrestore', 06:37:04 INFO - 'sessionrestore_no_auto_restore', 06:37:04 INFO - 'tabpaint']}, 06:37:04 INFO - 'other-e10s': {'tests': ['a11yr', 06:37:04 INFO - 'ts_paint', 06:37:04 INFO - 'tpaint', 06:37:04 INFO - 'sessionrestore', 06:37:04 INFO - 'sessionrestore_no_auto_restore', 06:37:04 INFO - 'tabpaint']}, 06:37:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:37:04 INFO - 'ts_paint', 06:37:04 INFO - 'tpaint', 06:37:04 INFO - 'sessionrestore', 06:37:04 INFO - 'sessionrestore_no_auto_restore', 06:37:04 INFO - 'tabpaint']}, 06:37:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:37:04 INFO - 'ts_paint', 06:37:04 INFO - 'tpaint', 06:37:04 INFO - 'sessionrestore', 06:37:04 INFO - 'sessionrestore_no_auto_restore', 06:37:04 INFO - 'tabpaint']}, 06:37:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:37:04 INFO - 'tests': ['a11yr', 06:37:04 INFO - 'ts_paint', 06:37:04 INFO - 'tpaint', 06:37:04 INFO - 'sessionrestore', 06:37:04 INFO - 'sessionrestore_no_auto_restore', 06:37:04 INFO - 'tabpaint']}, 06:37:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:37:04 INFO - 'tests': ['a11yr', 06:37:04 INFO - 'ts_paint', 06:37:04 INFO - 'tpaint', 06:37:04 INFO - 'sessionrestore', 06:37:04 INFO - 'sessionrestore_no_auto_restore', 06:37:04 INFO - 'tabpaint']}, 06:37:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:37:04 INFO - 'tests': ['tsvgx', 06:37:04 INFO - 'tsvgr_opacity', 06:37:04 INFO - 'tart', 06:37:04 INFO - 'tscrollx', 06:37:04 INFO - 'cart']}, 06:37:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:37:04 INFO - 'tsvgr_opacity', 06:37:04 INFO - 'tart', 06:37:04 INFO - 'tscrollx', 06:37:04 INFO - 'cart']}, 06:37:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:04 INFO - 'talos_options': ['--disable-e10s'], 06:37:04 INFO - 'tests': ['tp5o']}, 06:37:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:04 INFO - 'tests': ['tp5o']}, 06:37:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:04 INFO - 'talos_options': ['--disable-e10s', 06:37:04 INFO - '--xperf_path', 06:37:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:37:04 INFO - 'tests': ['tp5n']}, 06:37:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:04 INFO - 'talos_options': ['--xperf_path', 06:37:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:37:04 INFO - 'tests': ['tp5n']}}, 06:37:04 INFO - 'talos.zip': {'path': '', 06:37:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:37:04 INFO - Running post-action listener: _resource_record_post_action 06:37:04 INFO - [mozharness: 2016-09-01 13:37:04.869144Z] Finished populate-webroot step (success) 06:37:04 INFO - [mozharness: 2016-09-01 13:37:04.869279Z] Running create-virtualenv step. 06:37:04 INFO - Running pre-action listener: _resource_record_pre_action 06:37:04 INFO - Running main action method: create_virtualenv 06:37:04 INFO - Creating virtualenv /builds/slave/test/build/venv 06:37:04 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 06:37:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:37:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:37:04 INFO - Using real prefix '/tools/python27' 06:37:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:37:05 INFO - Installing distribute.............................................................................................................................................................................................done. 06:37:08 INFO - Installing pip.................done. 06:37:08 INFO - Return code: 0 06:37:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:08 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 0x100833a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008c8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b535b6780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100797d30>, '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 0x1004fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10078fb20>, '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.s7Y8XVTt4n/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.N7UmSSKCVS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/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 06:37:08 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 06:37:08 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 06:37:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s7Y8XVTt4n/Render', 06:37:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:08 INFO - 'HOME': '/Users/cltbld', 06:37:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:08 INFO - 'LOGNAME': 'cltbld', 06:37:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:08 INFO - 'MOZ_NO_REMOTE': '1', 06:37:08 INFO - 'NO_EM_RESTART': '1', 06:37:08 INFO - 'PAGER': '/bin/cat', 06:37:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:08 INFO - 'PWD': '/builds/slave/test', 06:37:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:08 INFO - 'SHELL': '/bin/bash', 06:37:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N7UmSSKCVS/Listeners', 06:37:08 INFO - 'TMPDIR': '/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/', 06:37:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:08 INFO - 'USER': 'cltbld', 06:37:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:08 INFO - 'XPC_FLAGS': '0x0', 06:37:08 INFO - 'XPC_SERVICE_NAME': '0', 06:37:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:08 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 06:37:08 INFO - Cleaning up... 06:37:08 INFO - Return code: 0 06:37:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:08 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 0x100833a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008c8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b535b6780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100797d30>, '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 0x1004fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10078fb20>, '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.s7Y8XVTt4n/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.N7UmSSKCVS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/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 06:37:08 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 06:37:08 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 06:37:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s7Y8XVTt4n/Render', 06:37:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:08 INFO - 'HOME': '/Users/cltbld', 06:37:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:08 INFO - 'LOGNAME': 'cltbld', 06:37:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:08 INFO - 'MOZ_NO_REMOTE': '1', 06:37:08 INFO - 'NO_EM_RESTART': '1', 06:37:08 INFO - 'PAGER': '/bin/cat', 06:37:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:08 INFO - 'PWD': '/builds/slave/test', 06:37:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:08 INFO - 'SHELL': '/bin/bash', 06:37:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N7UmSSKCVS/Listeners', 06:37:08 INFO - 'TMPDIR': '/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/', 06:37:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:08 INFO - 'USER': 'cltbld', 06:37:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:08 INFO - 'XPC_FLAGS': '0x0', 06:37:08 INFO - 'XPC_SERVICE_NAME': '0', 06:37:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:09 INFO - Downloading/unpacking psutil>=3.1.1 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:37:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:37:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:37:12 INFO - Installing collected packages: psutil 06:37:12 INFO - Running setup.py install for psutil 06:37:12 INFO - building 'psutil._psutil_osx' extension 06:37:12 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 06:37:13 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 06:37:13 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 06:37:13 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 06:37:13 INFO - building 'psutil._psutil_posix' extension 06:37:13 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 06:37:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:37:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:37:13 INFO - ^ 06:37:13 INFO - 1 warning generated. 06:37:13 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 06:37:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:37:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:37:13 INFO - Successfully installed psutil 06:37:13 INFO - Cleaning up... 06:37:13 INFO - Return code: 0 06:37:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:37: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')]} 06:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37: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')]} 06:37:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100833a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008c8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b535b6780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100797d30>, '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 0x1004fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10078fb20>, '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.s7Y8XVTt4n/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.N7UmSSKCVS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/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 06:37: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:37: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 mozsystemmonitor==0.3 06:37:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s7Y8XVTt4n/Render', 06:37:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:13 INFO - 'HOME': '/Users/cltbld', 06:37:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:13 INFO - 'LOGNAME': 'cltbld', 06:37:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:13 INFO - 'MOZ_NO_REMOTE': '1', 06:37:13 INFO - 'NO_EM_RESTART': '1', 06:37:13 INFO - 'PAGER': '/bin/cat', 06:37:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:13 INFO - 'PWD': '/builds/slave/test', 06:37:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:13 INFO - 'SHELL': '/bin/bash', 06:37:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N7UmSSKCVS/Listeners', 06:37:13 INFO - 'TMPDIR': '/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/', 06:37:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:13 INFO - 'USER': 'cltbld', 06:37:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:13 INFO - 'XPC_FLAGS': '0x0', 06:37:13 INFO - 'XPC_SERVICE_NAME': '0', 06:37:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:37:14 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 06:37:14 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 06:37:14 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 06:37:14 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 06:37:14 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 06:37:14 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 06:37:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:37:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:37:16 INFO - Installing collected packages: mozsystemmonitor 06:37:16 INFO - Running setup.py install for mozsystemmonitor 06:37:16 INFO - Successfully installed mozsystemmonitor 06:37:16 INFO - Cleaning up... 06:37:16 INFO - Return code: 0 06:37:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:37:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:16 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 0x100833a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008c8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b535b6780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100797d30>, '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 0x1004fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10078fb20>, '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.s7Y8XVTt4n/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.N7UmSSKCVS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/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 06:37:16 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 06:37:16 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 06:37:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s7Y8XVTt4n/Render', 06:37:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:16 INFO - 'HOME': '/Users/cltbld', 06:37:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:16 INFO - 'LOGNAME': 'cltbld', 06:37:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:16 INFO - 'MOZ_NO_REMOTE': '1', 06:37:16 INFO - 'NO_EM_RESTART': '1', 06:37:16 INFO - 'PAGER': '/bin/cat', 06:37:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:16 INFO - 'PWD': '/builds/slave/test', 06:37:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:16 INFO - 'SHELL': '/bin/bash', 06:37:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N7UmSSKCVS/Listeners', 06:37:16 INFO - 'TMPDIR': '/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/', 06:37:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:16 INFO - 'USER': 'cltbld', 06:37:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:16 INFO - 'XPC_FLAGS': '0x0', 06:37:16 INFO - 'XPC_SERVICE_NAME': '0', 06:37:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:17 INFO - Downloading/unpacking jsonschema==2.5.1 06:37:17 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 06:37:17 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 06:37:17 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 06:37:17 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 06:37:17 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 06:37:17 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 06:37:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:37:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:37:19 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 06:37:19 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 06:37:19 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 06:37:19 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 06:37:19 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 06:37:19 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 06:37:19 INFO - Downloading functools32-3.2.3-2.tar.gz 06:37:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:37:19 INFO - warning: no files found matching '*.txt' 06:37:19 INFO - no previously-included directories found matching 'build' 06:37:19 INFO - no previously-included directories found matching 'dist' 06:37:19 INFO - no previously-included directories found matching '.git*' 06:37:19 INFO - Installing collected packages: jsonschema, functools32 06:37:20 INFO - Running setup.py install for functools32 06:37:20 INFO - warning: no files found matching '*.txt' 06:37:20 INFO - no previously-included directories found matching 'build' 06:37:20 INFO - no previously-included directories found matching 'dist' 06:37:20 INFO - no previously-included directories found matching '.git*' 06:37:20 INFO - Successfully installed jsonschema functools32 06:37:20 INFO - Cleaning up... 06:37:20 INFO - Return code: 0 06:37:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:37:20 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')]} 06:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:20 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')]} 06:37:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:20 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 0x100833a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008c8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b535b6780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100797d30>, '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 0x1004fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10078fb20>, '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.s7Y8XVTt4n/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.N7UmSSKCVS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/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 06:37:20 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 06:37:20 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 06:37:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s7Y8XVTt4n/Render', 06:37:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:20 INFO - 'HOME': '/Users/cltbld', 06:37:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:20 INFO - 'LOGNAME': 'cltbld', 06:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:20 INFO - 'MOZ_NO_REMOTE': '1', 06:37:20 INFO - 'NO_EM_RESTART': '1', 06:37:20 INFO - 'PAGER': '/bin/cat', 06:37:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:20 INFO - 'PWD': '/builds/slave/test', 06:37:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:20 INFO - 'SHELL': '/bin/bash', 06:37:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N7UmSSKCVS/Listeners', 06:37:20 INFO - 'TMPDIR': '/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/', 06:37:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:20 INFO - 'USER': 'cltbld', 06:37:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:20 INFO - 'XPC_FLAGS': '0x0', 06:37:20 INFO - 'XPC_SERVICE_NAME': '0', 06:37:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:37:20 INFO - Cleaning up... 06:37:20 INFO - Return code: 0 06:37:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:37:20 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')]} 06:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:20 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')]} 06:37:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:20 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 0x100833a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008c8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b535b6780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100797d30>, '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 0x1004fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10078fb20>, '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.s7Y8XVTt4n/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.N7UmSSKCVS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/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 06:37:20 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 06:37:20 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 06:37:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s7Y8XVTt4n/Render', 06:37:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:20 INFO - 'HOME': '/Users/cltbld', 06:37:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:20 INFO - 'LOGNAME': 'cltbld', 06:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:20 INFO - 'MOZ_NO_REMOTE': '1', 06:37:20 INFO - 'NO_EM_RESTART': '1', 06:37:20 INFO - 'PAGER': '/bin/cat', 06:37:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:20 INFO - 'PWD': '/builds/slave/test', 06:37:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:20 INFO - 'SHELL': '/bin/bash', 06:37:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N7UmSSKCVS/Listeners', 06:37:20 INFO - 'TMPDIR': '/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/', 06:37:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:20 INFO - 'USER': 'cltbld', 06:37:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:20 INFO - 'XPC_FLAGS': '0x0', 06:37:20 INFO - 'XPC_SERVICE_NAME': '0', 06:37:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:20 INFO - Downloading/unpacking blobuploader==1.2.4 06:37:20 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 06:37:20 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 06:37:20 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 06:37:20 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 06:37:20 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 06:37:20 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 06:37:23 INFO - Downloading blobuploader-1.2.4.tar.gz 06:37:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:37:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:37:23 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 06:37:23 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 06:37:23 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 06:37:23 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 06:37:23 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 06:37:23 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 06:37:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:37:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:37:23 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 06:37:23 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 06:37:23 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 06:37:23 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 06:37:23 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 06:37:23 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 06:37:24 INFO - Downloading docopt-0.6.1.tar.gz 06:37:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:37:24 INFO - Installing collected packages: blobuploader, requests, docopt 06:37:24 INFO - Running setup.py install for blobuploader 06:37:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:37:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:37:24 INFO - Running setup.py install for requests 06:37:25 INFO - Running setup.py install for docopt 06:37:25 INFO - Successfully installed blobuploader requests docopt 06:37:25 INFO - Cleaning up... 06:37:25 INFO - Return code: 0 06:37:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:25 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 0x100833a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008c8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b535b6780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100797d30>, '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 0x1004fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10078fb20>, '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.s7Y8XVTt4n/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.N7UmSSKCVS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/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 06:37:25 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 06:37:25 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 06:37:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s7Y8XVTt4n/Render', 06:37:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:25 INFO - 'HOME': '/Users/cltbld', 06:37:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:25 INFO - 'LOGNAME': 'cltbld', 06:37:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:25 INFO - 'MOZ_NO_REMOTE': '1', 06:37:25 INFO - 'NO_EM_RESTART': '1', 06:37:25 INFO - 'PAGER': '/bin/cat', 06:37:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:25 INFO - 'PWD': '/builds/slave/test', 06:37:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:25 INFO - 'SHELL': '/bin/bash', 06:37:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N7UmSSKCVS/Listeners', 06:37:25 INFO - 'TMPDIR': '/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/', 06:37:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:25 INFO - 'USER': 'cltbld', 06:37:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:25 INFO - 'XPC_FLAGS': '0x0', 06:37:25 INFO - 'XPC_SERVICE_NAME': '0', 06:37:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:37:25 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-n5FRCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:37:25 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-fi5YTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:37:25 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-wAKj5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:37:25 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-A6E5Tc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:37:26 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-OJk6U2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:37:26 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-3XbG9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:37:26 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-kfG1bW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:37:26 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-8dOIS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:37:26 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-TNxjHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:37:26 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-uXIn8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:37:26 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-Ypkyxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:37:26 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-rBVm7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:37:26 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-K6ic_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:37:26 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-eYwj47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:27 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-TnQCRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:37:27 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-fDVml3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:37:27 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-mYQfMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:37:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:37:27 INFO - Running setup.py install for manifestparser 06:37:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:37:27 INFO - Running setup.py install for mozcrash 06:37:27 INFO - Running setup.py install for mozdebug 06:37:27 INFO - Running setup.py install for mozdevice 06:37:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:37:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:37:27 INFO - Running setup.py install for mozfile 06:37:28 INFO - Running setup.py install for mozhttpd 06:37:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:37:28 INFO - Running setup.py install for mozinfo 06:37:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:37:28 INFO - Running setup.py install for mozInstall 06:37:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:37:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:37:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:37:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:37:28 INFO - Running setup.py install for mozleak 06:37:28 INFO - Running setup.py install for mozlog 06:37:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:37:28 INFO - Running setup.py install for moznetwork 06:37:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:37:29 INFO - Running setup.py install for mozprocess 06:37:29 INFO - Running setup.py install for mozprofile 06:37:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:37:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:37:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:37:29 INFO - Running setup.py install for mozrunner 06:37:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:37:29 INFO - Running setup.py install for mozscreenshot 06:37:29 INFO - Running setup.py install for moztest 06:37:29 INFO - Running setup.py install for mozversion 06:37:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:37:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:37:29 INFO - Cleaning up... 06:37:29 INFO - Return code: 0 06:37:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37:29 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')]} 06:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:29 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')]} 06:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:29 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 0x100833a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008c8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b535b6780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100797d30>, '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 0x1004fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10078fb20>, '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.s7Y8XVTt4n/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.N7UmSSKCVS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/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 06:37:29 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 06:37:29 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 06:37:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s7Y8XVTt4n/Render', 06:37:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:29 INFO - 'HOME': '/Users/cltbld', 06:37:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:29 INFO - 'LOGNAME': 'cltbld', 06:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:29 INFO - 'MOZ_NO_REMOTE': '1', 06:37:29 INFO - 'NO_EM_RESTART': '1', 06:37:29 INFO - 'PAGER': '/bin/cat', 06:37:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:29 INFO - 'PWD': '/builds/slave/test', 06:37:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:29 INFO - 'SHELL': '/bin/bash', 06:37:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N7UmSSKCVS/Listeners', 06:37:29 INFO - 'TMPDIR': '/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/', 06:37:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:29 INFO - 'USER': 'cltbld', 06:37:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:29 INFO - 'XPC_FLAGS': '0x0', 06:37:29 INFO - 'XPC_SERVICE_NAME': '0', 06:37:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:37:30 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-6r4yfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:37:30 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)) 06:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:37:30 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-WHkcYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:37:30 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)) 06:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:37:30 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-6UAfUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:37:30 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)) 06:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:37:30 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-3ROos_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:37:30 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)) 06:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:37:30 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-OdVZte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:37:30 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)) 06:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:37:30 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-UhESqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:37:30 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)) 06:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:37:30 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-hqQMhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:37:30 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)) 06:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:37:30 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-602nWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:37:31 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)) 06:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:37:31 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-LqtUgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:37:31 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)) 06:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:37:31 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-w0p6wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:37:31 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)) 06:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:37:31 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-BhQ3Pp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:37:31 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)) 06:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:37:31 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-4BHMZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:37:31 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)) 06:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:37:31 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-jmKfyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:37:31 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)) 06:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:37:31 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-GkBPXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:37:31 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)) 06:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:31 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-o2mP0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:31 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)) 06:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:37:31 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-O5QpOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:37:31 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)) 06:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:37:31 INFO - Running setup.py (path:/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/pip-xLfWB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:37:32 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)) 06:37:32 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)) 06:37:32 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)) 06:37:32 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)) 06:37:32 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)) 06:37:32 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)) 06:37:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:34 INFO - Downloading blessings-1.6.tar.gz 06:37:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:37:34 INFO - Installing collected packages: blessings 06:37:34 INFO - Running setup.py install for blessings 06:37:34 INFO - Successfully installed blessings 06:37:34 INFO - Cleaning up... 06:37:34 INFO - Return code: 0 06:37:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:37:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:37:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:37:35 INFO - Reading from file tmpfile_stdout 06:37:35 INFO - Current package versions: 06:37:35 INFO - blessings == 1.6 06:37:35 INFO - blobuploader == 1.2.4 06:37:35 INFO - docopt == 0.6.1 06:37:35 INFO - functools32 == 3.2.3-2 06:37:35 INFO - jsonschema == 2.5.1 06:37:35 INFO - manifestparser == 1.1 06:37:35 INFO - mozInstall == 1.12 06:37:35 INFO - mozcrash == 0.17 06:37:35 INFO - mozdebug == 0.1 06:37:35 INFO - mozdevice == 0.48 06:37:35 INFO - mozfile == 1.2 06:37:35 INFO - mozhttpd == 0.7 06:37:35 INFO - mozinfo == 0.9 06:37:35 INFO - mozleak == 0.1 06:37:35 INFO - mozlog == 3.3 06:37:35 INFO - moznetwork == 0.27 06:37:35 INFO - mozprocess == 0.23 06:37:35 INFO - mozprofile == 0.28 06:37:35 INFO - mozrunner == 6.12 06:37:35 INFO - mozscreenshot == 0.1 06:37:35 INFO - mozsystemmonitor == 0.3 06:37:35 INFO - moztest == 0.7 06:37:35 INFO - mozversion == 1.4 06:37:35 INFO - psutil == 3.1.1 06:37:35 INFO - requests == 1.2.3 06:37:35 INFO - wsgiref == 0.1.2 06:37:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37: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')]} 06:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37: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')]} 06:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:35 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 0x100833a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008c8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b535b6780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100797d30>, '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 0x1004fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10078fb20>, '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.s7Y8XVTt4n/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.N7UmSSKCVS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/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 06:37:35 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 06:37:35 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 06:37:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s7Y8XVTt4n/Render', 06:37:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:35 INFO - 'HOME': '/Users/cltbld', 06:37:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:35 INFO - 'LOGNAME': 'cltbld', 06:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:35 INFO - 'MOZ_NO_REMOTE': '1', 06:37:35 INFO - 'NO_EM_RESTART': '1', 06:37:35 INFO - 'PAGER': '/bin/cat', 06:37:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:35 INFO - 'PWD': '/builds/slave/test', 06:37:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:35 INFO - 'SHELL': '/bin/bash', 06:37:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N7UmSSKCVS/Listeners', 06:37:35 INFO - 'TMPDIR': '/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/', 06:37:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:35 INFO - 'USER': 'cltbld', 06:37:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:35 INFO - 'XPC_FLAGS': '0x0', 06:37:35 INFO - 'XPC_SERVICE_NAME': '0', 06:37:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:35 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)) 06:37:35 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)) 06:37:35 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)) 06:37:35 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)) 06:37:35 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)) 06:37:35 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)) 06:37:35 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)) 06:37:35 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)) 06:37:35 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)) 06:37:35 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)) 06:37:35 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)) 06:37:35 INFO - Cleaning up... 06:37:35 INFO - Return code: 0 06:37:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:37: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')]} 06:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37: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')]} 06:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:35 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 0x100833a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008c8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b535b6780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100797d30>, '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 0x1004fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10078fb20>, '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.s7Y8XVTt4n/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.N7UmSSKCVS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/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 06:37:35 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 06:37:35 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 06:37:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s7Y8XVTt4n/Render', 06:37:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:35 INFO - 'HOME': '/Users/cltbld', 06:37:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:35 INFO - 'LOGNAME': 'cltbld', 06:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:35 INFO - 'MOZ_NO_REMOTE': '1', 06:37:35 INFO - 'NO_EM_RESTART': '1', 06:37:35 INFO - 'PAGER': '/bin/cat', 06:37:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:35 INFO - 'PWD': '/builds/slave/test', 06:37:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:35 INFO - 'SHELL': '/bin/bash', 06:37:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N7UmSSKCVS/Listeners', 06:37:35 INFO - 'TMPDIR': '/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/', 06:37:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:35 INFO - 'USER': 'cltbld', 06:37:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:35 INFO - 'XPC_FLAGS': '0x0', 06:37:35 INFO - 'XPC_SERVICE_NAME': '0', 06:37:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:37:35 INFO - Cleaning up... 06:37:35 INFO - Return code: 0 06:37:35 INFO - Running post-action listener: _resource_record_post_action 06:37:35 INFO - Running post-action listener: _start_resource_monitoring 06:37:35 INFO - Starting resource monitoring. 06:37:35 INFO - [mozharness: 2016-09-01 13:37:35.712088Z] Finished create-virtualenv step (success) 06:37:35 INFO - [mozharness: 2016-09-01 13:37:35.713081Z] Running install step. 06:37:35 INFO - Running pre-action listener: _resource_record_pre_action 06:37:35 INFO - Running main action method: install 06:37:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:37:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:37:35 INFO - Reading from file tmpfile_stdout 06:37:35 INFO - Detecting whether we're running mozinstall >=1.0... 06:37:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:37:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:37:36 INFO - Reading from file tmpfile_stdout 06:37:36 INFO - Output received: 06:37:36 INFO - Usage: mozinstall [options] installer 06:37:36 INFO - Options: 06:37:36 INFO - -h, --help show this help message and exit 06:37:36 INFO - -d DEST, --destination=DEST 06:37:36 INFO - Directory to install application into. [default: 06:37:36 INFO - "/builds/slave/test"] 06:37:36 INFO - --app=APP Application being installed. [default: firefox] 06:37:36 INFO - mkdir: /builds/slave/test/build/application 06:37:36 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'] 06:37:36 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 06:38:10 INFO - Reading from file tmpfile_stdout 06:38:10 INFO - Output received: 06:38:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:38:10 INFO - Running post-action listener: _resource_record_post_action 06:38:10 INFO - [mozharness: 2016-09-01 13:38:10.595479Z] Finished install step (success) 06:38:10 INFO - [mozharness: 2016-09-01 13:38:10.595638Z] Running run-tests step. 06:38:10 INFO - Running pre-action listener: _resource_record_pre_action 06:38:10 INFO - Running main action method: run_tests 06:38:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:38:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:38:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:38:10 INFO - 2016-09-01 06:38:10.610 screenresolution[1638:8169] starting screenresolution argv=screenresolution get 06:38:10 INFO - 2016-09-01 06:38:10.612 screenresolution[1638:8169] Display 0: 1600x1200x32@60 06:38:10 INFO - 2016-09-01 06:38:10.618 screenresolution[1639:8171] starting screenresolution argv=screenresolution list 06:38:10 INFO - Available Modes on Display 0 06:38:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:38:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:38:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:38:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:38:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:38:10 INFO - Intel Iris: 06:38:10 INFO - Chipset Model: Intel Iris 06:38:10 INFO - Type: GPU 06:38:10 INFO - Bus: Built-In 06:38:10 INFO - VRAM (Dynamic, Max): 1536 MB 06:38:10 INFO - Vendor: Intel (0x8086) 06:38:10 INFO - Device ID: 0x0a2e 06:38:10 INFO - Revision ID: 0x0009 06:38:10 INFO - Displays: 06:38:10 INFO - Display: 06:38:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:38:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:38:10 INFO - Display Serial Number: 1600x1200 60 06:38:10 INFO - Main Display: Yes 06:38:10 INFO - Mirror: Off 06:38:10 INFO - Online: Yes 06:38:10 INFO - Rotation: Supported 06:38:10 INFO - Return code: 0 06:38:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:38:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:38:10 INFO - Python 2.7.3 06:38:10 INFO - Return code: 0 06:38:10 INFO - grabbing minidump binary from tooltool 06:38:10 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')]} 06:38:10 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 0x100797d30>, '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 0x1004fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10078fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:38:10 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 06:38:10 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 06:38:10 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 06:38:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:38:10 INFO - Return code: 0 06:38:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:38:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:38:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:38:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:38:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:38:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0248', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:38:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0248 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:38:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s7Y8XVTt4n/Render', 06:38:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:38:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:38:10 INFO - 'HOME': '/Users/cltbld', 06:38:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:38:10 INFO - 'LOGNAME': 'cltbld', 06:38:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:38:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:10 INFO - 'MOZ_NO_REMOTE': '1', 06:38:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:38:10 INFO - 'NO_EM_RESTART': '1', 06:38:10 INFO - 'PAGER': '/bin/cat', 06:38:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:10 INFO - 'PWD': '/builds/slave/test', 06:38:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:38:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:38:10 INFO - 'SHELL': '/bin/bash', 06:38:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N7UmSSKCVS/Listeners', 06:38:10 INFO - 'TMPDIR': '/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/', 06:38:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:38:10 INFO - 'USER': 'cltbld', 06:38:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:38:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:10 INFO - 'XPC_FLAGS': '0x0', 06:38:10 INFO - 'XPC_SERVICE_NAME': '0', 06:38:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:38:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0248', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:38:11 INFO - mozversion application_buildid: 20160901053821 06:38:11 INFO - mozversion application_changeset: cba87d584348ee62004f8d7893529c9b37a6bded 06:38:11 INFO - mozversion application_display_name: Nightly 06:38:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:38:11 INFO - mozversion application_name: Firefox 06:38:11 INFO - mozversion application_remotingname: firefox 06:38:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:38:11 INFO - mozversion application_vendor: Mozilla 06:38:11 INFO - mozversion application_version: 51.0a1 06:38:11 INFO - mozversion platform_buildid: 20160901053821 06:38:11 INFO - mozversion platform_changeset: cba87d584348ee62004f8d7893529c9b37a6bded 06:38:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:38:11 INFO - mozversion platform_version: 51.0a1 06:38:11 INFO - using testdate: 1472737091 06:38:11 INFO - actual date: 1472737091 06:38:11 INFO - starting webserver on 'localhost:49262' 06:38:11 INFO - SUITE-START | Running 2 tests 06:38:11 INFO - TEST-START | dromaeo_css 06:38:11 INFO - operating with platform_type : mac_ 06:38:11 INFO - Initialising browser for dromaeo_css test... 06:38:11 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/tmpnAxIc7/profile http://localhost:49262/getInfo.html) 06:38:13 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 06:38:13 INFO - PROCESS | 1649 | colorDepth:24 06:38:13 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 06:38:13 INFO - PROCESS | 1649 | __metrics 06:38:13 INFO - PROCESS | 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:38:13 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:38:14 INFO - TEST-INFO | 1649: exit 0 06:38:14 INFO - Browser initialized. 06:38:14 INFO - Running cycle 1/1 for dromaeo_css test... 06:38:14 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/tmpnAxIc7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:38:26 INFO - PROCESS | 1652 | RSS: Main: 234307584 06:38:26 INFO - PROCESS | 1652 | 06:39:18 INFO - PROCESS | 1652 | 1472737158036 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] 06:41:30 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49262/tests/dromaeo/cssquery-ext.html) 06:41:31 INFO - PROCESS | 1652 | RSS: Main: 350302208 06:41:31 INFO - PROCESS | 1652 | 06:44:34 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-ext.html (next: http://localhost:49262/tests/dromaeo/cssquery-jquery.html) 06:44:35 INFO - PROCESS | 1652 | RSS: Main: 370036736 06:44:35 INFO - PROCESS | 1652 | 06:47:37 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49262/tests/dromaeo/cssquery-mootools.html) 06:47:38 INFO - PROCESS | 1652 | RSS: Main: 345972736 06:47:38 INFO - PROCESS | 1652 | 06:50:40 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49262/tests/dromaeo/cssquery-prototype.html) 06:50:41 INFO - PROCESS | 1652 | RSS: Main: 337121280 06:50:41 INFO - PROCESS | 1652 | 06:53:44 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49262/tests/dromaeo/cssquery-yui.html) 06:53:45 INFO - PROCESS | 1652 | RSS: Main: 324694016 06:53:45 INFO - PROCESS | 1652 | 06:56:48 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-yui.html (next: http://localhost:49262/tests/dromaeo/cssquery-dojo.html) 06:56:48 INFO - PROCESS | 1652 | RSS: Main: 491511808 06:56:48 INFO - PROCESS | 1652 | 06:56:48 INFO - PROCESS | 1652 | __start_tp_report 06:56:48 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 06:56:48 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 06:56:48 INFO - PROCESS | 1652 | |i|pagename|runs| 06:56:48 INFO - PROCESS | 1652 | |0;dojo.html;3290.555774970379;3309.619393769716;3311.668833116687;3341.682540158684;3356.2951780126173;5578.386377498472;5611.635243709156;5677.744501497432;5737.627054241477;5738.053221218499;5650.208970744099;5687.744051517671;5757.654540727559;5784.074548072309;5790.04464263396;5117.974410127944;5124.231365295217;5178.6892786432745;5200.349956255468;5301.045811753883;5289.497497737709;5302.44324345942;5311.415744268127;5328.493793089669;5343.465653434664;5157.432682404932;5192.636515443921;5193.376794784631;5198.428172900978;5198.92201616976;5197.584193264567;5213.739313034371;5220.634555581111;5226.764795584169;5229.5293423591675;5138.511841375101;5182.559482443997;5183.352080989876;5193.221016847466;5210.452902445264;5640.464155905182;5683.175939488751;5694.572907031989;5694.886102277931;5702.600817942745;6132.69336533176;6141.785037523665;6161.383861613847;6171.660558669271;6203.720832562545;6142.8771424571705;6286.622802631857;6288;6290.308066112724;6291.968540157316;5598.524125449382;5701.828945131652;5759.3376761672525;5767.163761254595;5768.307803063659;6205.317415084337;6243.344448832807;6254.718537665816;6263.968680156661;6320.652364119926;6037.849053773691;6043.305019922677;6048.274207095089;6050.21347224858;6051.788187413419;6215.192025036807;6230.127782110508;6234.251889773165;6234.345393733593;6241.500679945593;5989.221401217814;6036.3058248302;6036.728347224385;6078.3617720138745;6081.300650425169;6179.3202747697715;6183.876322473526;6188.44304012641;6206.782762603287;6212.813615591449;4849.466558678613;4865.635077369211;4891.975540122347;4894.828680996219;4921.483244259372;4339.132173565299;4362.672799540047;4380.737155770664;4380.890477738082;4425.114977004612;5704.686242256716;5715.657060576379;5727.570432217601;5759.078547432391;5764.279465066867;6275.780347687901;6286.308506064329;6288.591241569284;6289.119523266746;6300.27546832111;5569.805056822992;5681.517071049007;5692.37383887772;5697.259356283656;5708.115242137475;5169.870753231124;5438.401775804658;5441.564674826083;5455.481729235717;5482.314710661168;5719.685417302088;6272.655003974825;6324.494040476843;6333.6516491591565;6342.778002769881;5145.176771716508;6175.62946223228;6176.1970943778815;6221.813345599639;6280.937190628035;6298.496120310272;6335.461485773577;6343.809685709436;6347.650879201504;6365.14070600463;6138.263408391022;6157.753689852356;6172.382761723971;6175.382461753788;6175.5677102602385;6079.787207447718;6108.1903020305945;6144.126041557368;6247.875042499216;6250.906236406367;5935.2877654681715;5980.611260268069;5993.370696077023;6006.579539432372;6045.969770151121;5925.496332811759;5957.16599676037;5962.522998160223;5966.2840459143445;5971.193888824953;5648.237487939075;5697.401772813961;5826.329972053268;5826.76692932278;5827.59206855533;6003.0695242237525;6006.849828754316;6009.278886533644;6031.185789918305;6048.032314829607;5840.591158618856;5845.006348920779;5850.882982340244;5866.823995280149;5877 06:56:48 INFO - PROCESS | 1652 | |1;ext.html;514.8764296568825;520.606941758972;520.9270702101704;521.9947800521994;529.8331025726895;25915.222543323707;30624.08127756168;39664.206715865665;40640;40765;41695.16609667813;41838.790806046;41982.95042623936;42035;42035.57964420362;9699.36954097985;9880.110790028895;9881.308308418413;9885;9901.55443005063;8841;9049.3665443419;9685.612575496973;11856.940715296412;12144.3320617366;10513.947430262877;12030.157888947777;12052.276863388224;12065.09511786615;12066.57766978156;11950.581729639465;11984.52061917531;12012.519499220021;12016.098792590547;12033.39833008346;8681.435706679045;11720.238184517979;11939.701507462296;11998.220115692538;12201.877981220163;39773.80678579647;40154.795356139366;40246;40353.78938631846;40388.79805600953;3334.199792049915;3358.580177477815;3382.5433566468705;3385;3432.9485057724155;28832.71167288321;28991.275218119506;31102;31403;31424.37151256962;3235.7573182011206;3329.5671562696934;3360.7647464677484;3427.880024199141;3428.6057103433177;485603;488787;489145;490067;490531;56082.71958640181;56265.59336016632;56355.71822140945;56607.150892736645;56624.43375566274;55263.89472210533;55366.89266214734;55368.61578460571;55469.44530554723;55511.72244138754;15715.371385144466;15951.361945522049;15984.280707368196;16006.919965400331;16065.678686426207;11124.443777811077;12506.437210325557;12542.24746515212;12599.5590154346;12607;13385.129966552144;13788.310584470737;13795.310234488235;13812.654683632989;13838.930805345908;4729.215808982774;6187.319394866561;6198.194234749454;6201.317855035943;6220.471259942865;880.7842078690762;968.4528241543505;972.2270794718216;973.776031512756;987.2644879564771;28163.71836281611;28229.294267643472;29080.854595726887;29546.986820617636;30110.09669709912;1080.2276372393776;1083.1930211992117;1087.923845330835;1123.0341905961031;1136.1876258475065;11368.54525818958;15166.924165379103;15362.308696108701;15404.437088389781;15548.455804046804;635038.824805873;638702;639618;639716;640162;55802.44197557973;55920.72039639776;56061.71969140128;56115.71942140263;56296.43703562994;1318.064174436142;1351.6620844788804;1378.3383975691524;1378.9517366892312;1385.9722805543834;28125;28271.717282827733;28795.28011799722;29196.416071678024;29816.403671926008;47816.7609161952;48265;48360.03279934452;48385;48390.516094838604;518303;520940.6730091389;521150;521434;521826;32765.508517372735;33497;37992;38836.22327553377;39184;42395.40899765127;45160;45811.77094114508;46333.07333853237;46650.53349466598;30546.625401856527;37388.6261137396;37902.86291411262;38174;39097;37401.6259837409;37974.050648734;38491;39012;39149.8042509797;36233.63766362303;36809;37320.44019339766;37351.25297494089;37630.43554346632;28802.711972880003;32397.676023239466;33341.999740007835;33835.83082084574;34101;23480.060797567905;25024.37439064038;25388.365290867878;25393.32678412085;25395 06:56:48 INFO - PROCESS | 1652 | |2;jquery.html;354.2684356803203;366.74144727966785;377.99811000944993;386.78533413955245;407.4906367041198;15528.922355388222;15973.440929567467;17549.561260968483;20179.697304540445;20782.16871325149;19996.60006799867;20215.696764548542;20577.897110514426;20859.791402085975;20905;5184.274201611777;5801.535877129841;5955.821325360246;6063.393660633946;6080.2703675559;5936.347001829795;6051.515878729691;6054.515638748911;6055.364186760393;6083.726232319534;5612.354579223401;5913.822585322426;5955.136505206742;5996.700164991755;6009.1286763419275;5876.529877609781;5914.674692891911;5914.940850591482;5923.17075609415;5932.406759324033;4972.776225069881;5524.226608274845;5776.4801167894675;5792.623479473821;5805.622634528742;12963.28701921394;13173;15387.692246155126;24282.90726917293;24662.13682521121;2201.1415547936317;2203.46015226269;2242.820574354048;2554.8083893707862;2613.372790530278;9669.613215471443;10182.745431364201;10214.948925255401;10226.948865255627;10234.641787537475;1503.6992601479749;1520.6046427928707;1819.245013319471;1854.7403363529118;1943.3586916317722;100498;116159.25761113505;117963.89523519127;119159;119938;11058.281211721212;11207.439628018567;11207.775844483065;11230.270032447865;11411.828822567668;14123.435062597586;14126.788098178535;14127.929360353339;14151;14156.716865662629;8030.5181689098845;8301;8332.125126861714;8432.873506897402;8465.915340846514;8136.1050284468665;8167.673293068211;8176.141505141994;8286.337093032544;8369.539675317794;4361.389405483234;4368.322909948899;4381.539938306496;4390.824367025347;4453.576910193527;1833.8532917366579;1874.9625007499774;1881.9273014381945;1885.0207282353474;1889.3198448558508;864.6454953469173;957.7653474898694;971.7667759737753;1006.854006169116;1021.2391768132788;19523.8047619522;20786.856722880388;20924.408811224417;20940.267090651752;21254;888.320434867327;903.3856977255398;957.411192116857;968.2157452463528;968.3076600230869;8935.642574296955;9080.500572468445;10438.37369757817;10963.50664220112;10964.56141754321;538439;591558.0422097949;592344;602388;609138.4060036084;109004.54977251265;120268.39865800615;135583;136999;137967;931.8089791592707;953.3850666320185;970.0929630795229;970.3207754571828;972.5817898303798;15470.613234669223;17533.597312215246;18618.627627447648;18634.627307454048;19011.619767604294;53778;54094;54412.45587544074;54785.72607136939;54937;78516.1854768154;78538;78688.60655696684;79556.20443795488;79581.2041879597;5256.606999145153;6832.555883867732;7632.8473430532185;7728.729494467667;7959.960200199193;9902;10094;12113.939430302793;12203.511859525519;12211.26732396059;10232.897671023195;10247.692569222638;10426.739331516772;10569.471526423802;10582.788344232918;8436.578171091543;10081.193504519768;10097.29318947696;10194.643187488402;10318.48407579603;10265.024822641837;10472.371657700258;10582.206334525095;10600.766766136403;10676.679699608714;7551.660175292015;7595.658195381111;7764.184760600056;7784.883226751716;7790.766277011699;7850.528968261694;8943.686970955985;9953.253505987224;10369.896301036893;10615.150787936793 06:56:48 INFO - PROCESS | 1652 | |3;mootools.html;1320.6302235374098;1486.1528928510747;1527.7020980908721;1722.7846519185102;1920.2606996306426;7779.611019449027;8326.458780179284;8708.869366959485;8719.171678690522;8758.167974042472;8430.620622072007;8604.053554109043;8646.092160323155;8675.219230269275;8684.8697269541;2358.599038163512;2405.254371144942;2408.7350391456926;2410.710714714237;2412.0592968742203;2021.9292324768637;2400.075970751265;2408.5303365843665;2411.5297516984197;2422.0432928993037;2343.2267351773876;2366.100881664965;2379.4289370551114;2384.7376788553247;2386.689730335063;2346.9295921122393;2377.215518878766;2390.199283240108;2390.8326417150806;2391.4021494626345;2341.2976107167783;2379.8334116611845;2389.2832150355;2391.629297458897;2407.963880541793;8295.087540370554;8602.2688071514;8747.125287471266;8768.473891566462;8771.692990745358;4718.41019872516;5178.559822415099;5345.01117293302;5400.29796126505;5400.83797486076;3263.216827961296;3492.6553276988543;3573.6426357364317;3657.963420365789;3671.4125739881492;1088.983665245022;1089.3246187363807;1095.3482677806692;1096.4627332607045;1111.833225016246;11392;11505.424728763528;11641.243319184226;11647.068234541217;11655.592054278144;4007.859724909614;4732.219183834698;4832.106060378841;4838.395200599925;4846.328016834186;10113.190944724405;10114.443705596115;10115.696529104138;10123.1901447884;10130.138938190335;5377.085895397791;5387.0841956867425;5389.892202155935;5391.838244852661;5406.324209473816;4371.934420983688;4535.138323718483;4688.179568575486;4801.303810947393;4887.584555312838;3928.823202955874;3976.324024915771;4041.0301527633155;4098.897527561835;4105.096878686684;1266.2212739165348;1285.68500717323;1286.3439645780531;1289.278004317585;1306.2162702378687;884.5577211394303;915.2357781252729;916.3402350307767;928.5473875942965;949.4777872170279;5559.430108598202;5765.682887441231;6004.909926351108;6007.309159446632;6161.784337548254;376.7456966547624;438.38407038111507;447.34240666220603;447.50997657564915;452.805293723702;3685.3366394048794;4062.695297852673;4073.45008423859;4088.5911408858874;4157.5240789519285;10423.791524169474;10484.790304194026;10728.195385346131;10793.02862742357;10823.945880270705;10582.788344233073;10710.928907109226;10713.35719856811;10736.946315268373;10749.570017199225;6677.399034086956;8027.83944321122;8095.311898488694;8135.6745730171315;8180.509169449852;5312.946870531246;5930.881382372415;5977.372375900468;6029.939700602938;6188.195534580475;8218.547979861165;8711.695090671796;9694.46680432583;10023.097921187129;10128.392296462236;9509.096635819586;9908.207343412365;9910.603575856885;10161;10163.644272450429;6913.274106218774;7109.466789990668;7305.671244794104;7410.221926697619;7616;8173.264406203471;8436.873446898424;8437.493750374997;8445.1977062179;8457.323414126979;7379.631018448948;7482.887756683763;7497.925020749941;7563.281488258606;7631.3131818136635;7255.963720181366;7332.41340692754;7385.741499047507;7399.48203625741;7494.437917156126;6947.201071876799;7102.18324892644;7102.5028248022145;7112.679929403293;7143.214246432784;4928.67963582366;5003.624728145331;5036.546710796046;5092.796288148433;5143.768530416065;4263.55232700562;4970.602351811919;5148.794048238178;5182.637215395037;5246.97376513115 06:56:48 INFO - PROCESS | 1652 | |4;prototype.html;300.16104986562556;300.8285277391887;309.6423630706534;315.39916459145337;317.68866510819396;4449.621782148517;4615.2846308822145;5372.597055220855;5409.026375252453;5418.322709661293;4683.50823163568;4971;5084.593232541397;5176.498815343555;5311.9468805311935;3912.784796836187;4008.2384346974054;4015.867623253852;4064.654504367132;4082.4080508326424;4036.979815100935;4059.9797001014954;4063.8577649782264;4092.4884389451317;4125.401816736571;3420.914477138079;3774.905627359324;4034.495688038995;4054.5337286212166;4069.552349241596;3392.677695618937;3995.7802320872343;4019.537753158366;4047.5547689753957;4054.9594504054876;3471.687548120656;3472.201393679468;3480.443129099332;3481.8085005324697;3503.3343664703625;4735.887066539361;4803.903921921542;5072.467390923936;5248;5274.736263186864;3929.2141571685493;4065.540348089393;4584.7936842842155;4636.4899861015265;4659.510751371125;5613.635113717595;5622.4979883951655;5646.887062258732;5692.117721753093;5700.030994730906;3280.966495553917;3472.2013936794424;3839.4816699745734;3849.595792441781;3860.208657225262;4930.950690493085;5629.043062679354;5904.350521442638;5966.403359664042;5974.61165024272;3853.807309634507;3872.903177420587;3881.301365754135;3885.494885664902;3887.941680874789;3956.40653901917;3961.187956468917;3965.762054276695;3970.861019864291;3975.642192202658;3727.3163322407822;4554.63562914966;4590.013147173374;4634.354804044583;4653.906921861611;4743.150171433143;5645.125005624135;5717.456841600041;5729.455701708331;5784.855378615568;1258.4966013594453;1270.0982302565283;1272.5164437513686;1328.847182573997;1362.7547041532619;777.9260970207935;885.588201486312;893.2987604730256;900.7387857521377;915.2312057871287;4573.81704731807;4641.675082744243;5358.490943360374;5362.892742145214;5392.568594512508;5681.9431805681415;5752.856178595485;5785.537157027427;5851.61964472308;5940;4559.316102584573;5039.496050394931;5282.683039017671;5367.865803354869;5370.409254981949;2721.4557088582364;2867.44084903446;3040.9543856842165;3048.1465189746905;3071.3396619726864;5056.544910958031;5550.555955523549;5634.3802181759975;6004;6106.168149555116;4956.677815941952;5920.111983202554;5931.970340148272;5956.195913551615;6007.27912650476;5360.517553420211;5986.790462333797;5997.790077347272;6073.271207455134;6077.817665470043;5446.397793864178;5811.989727088296;5827.737751801264;5837;5904.427821168131;5054.2671312660195;5804.21643078179;5828.5919985602295;5853.487907255612;5915.733791979457;5853.473187413153;6050.124461416975;6207.685658467321;6213.596116252429;6217.129601855653;3305.4215512285737;3420.7263418926923;3804.6575808177395;3821.828017739153;3897.5517815451585;5449.182622606482;5844.444777746107;5874.236349274567;5906.350301466749;5964.642121472725;5048.444671086251;5516.813885014741;5592.664440133605;5679.74441150141;5760.798372056958;5635.464630860061;5643.435656434323;5659.377468478382;5673.6879971223;5680.68756218412;4627.490975992706;5507.889842203213;5507.917381239365;5553.305836770403;5584.636998595241;5489.39616642177;5632.971835140798;5640.435956404327;5692.544596432358;5704.971475142764;5268.631195816256;5498.855446375836;5531.446855314436;5545.72271386421;5553.667119891116 06:56:48 INFO - PROCESS | 1652 | |5;yui.html;690.3165865792866;715.1525442350815;722.5195245161967;725.902003229564;763.088109708898;15058.924705376472;15460.3042863071;15638.609034774136;15657.765133522978;15692.52922412328;13495;14206;14239.216843073627;14268.215248161372;14294.428222871098;844.2359664503634;865.8008658008662;867.1155421470097;868.9695860644879;869.1742844297911;671.7816709569385;691.0187533702154;691.5746815708328;692.9029935808991;696.2480521037293;893.2095095840195;908.7728067983004;912.3476714149382;912.9954350228239;913.4427998920653;908.4004556992353;909.2226146644656;909.5952301225957;910.3400034974657;912.9543522823832;525.5480286953256;675.425887995205;675.8242856857253;676.4047638078508;677.9423748981343;12424.130310878241;12515;12525.812112818316;14169.149851008973;14717.190554519497;14136.575902722934;14722.55832325032;14735.263236838222;14768.852311476856;14963.551093467213;11632.302061876315;11950.940245298805;11962.282263064244;12174.756504869853;12279.2018518796;3743.1577894973684;3754.436834474823;3784.3944968805135;3785.5646600641003;3910.706696997708;103736;103892.48053759758;109185.45407272992;109738.45130774294;110288.4485577567;10872.61945831892;10928.672139835817;11155.888441115485;11359.829602555968;11448.771024579462;21713.45716357072;22005.33983980483;22006.229781957554;22022.559548808935;22025.00887460068;7331.450141239428;7375.741849035258;7617.428692848059;7789.454738168274;8049.235322644339;4402.669799765031;4469.865904022885;4489.595936365743;4543.409356783597;4656.440092569027;3582.17609949713;3667.5965643779164;3700.611435799256;3731.1791405890663;3741.102135487518;672.8830141964413;687.3573209049555;688.6281408039703;694.6318451220861;696.738722978883;569.8404446754915;580.9810907097801;615.9990016223636;650.8600650860088;672.6838385958591;8443.282321002784;8658;9303.581338839633;9368.578413971387;9427.528623568795;513.6096566609403;582.5950964080008;613.0711971363388;633.0693879996398;655.4330504113907;4281.272183728711;4283.164782867373;4457.955420445754;4606.723596584216;4667.183242932473;125853.37073314757;125921;129494;132563.33718331347;158482;112358;117987.41006294913;119518;121943.78056219501;122528;59992.70003649954;97786;101543.98456015493;102430.4635430484;107446;7443.739469118555;9827.164691001344;9915;9921.65274215399;9940.751481213027;59682.3619394214;60738.08892866699;60864.69567652133;61154.4711382219;62074.689626551575;80328.6275173293;90539.54730226306;90805.2815510689;90922.54538727528;91783.08216917745;12043.638690839289;12488.625341239778;12711.936440317739;13219;13474.730505390033;14844.40622375136;14895.329710162852;15068.698626027637;15136.621584460476;15694.372225110868;13510.98084955767;13612.591622251348;13914.234717090658;13948.442062317394;14258;13710.17738935667;13793.655158620713;13814;14189.432422702976;14408.855911441171;13684.44543628686;13726.794098088736;13938.512152074629;14004.929975350466;14227.359768810222;11161.274517156358;11452.01196776083;11507.194496385173;11507.367094809866;12034.819477707666;9866.210703143588;10499.632512862014;10522.473876306001;11672.941635291769;11681.591144309908 06:56:48 INFO - PROCESS | 1652 | __end_tp_report 06:56:48 INFO - PROCESS | 1652 | __start_cc_report 06:56:48 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1142 06:56:48 INFO - PROCESS | 1652 | __end_cc_report 06:56:48 INFO - PROCESS | 1652 | __startTimestamp1472738208797__endTimestamp 06:56:48 INFO - PROCESS | 1652 | 06:56:48 INFO - PROCESS | 1652 | ------- Summary: start ------- 06:56:48 INFO - PROCESS | 1652 | Number of tests: 6 06:56:48 INFO - PROCESS | 1652 | 06:56:48 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5703.58 Median:5840.59 stddev:630.75 (10.8%) stddev-sans-first:603.61 06:56:48 INFO - PROCESS | 1652 | Values: 3290.6 3309.6 3311.7 3341.7 3356.3 5578.4 5611.6 5677.7 5737.6 5738.1 5650.2 5687.7 5757.7 5784.1 5790.0 5118.0 5124.2 5178.7 5200.3 5301.0 5289.5 5302.4 5311.4 5328.5 5343.5 5157.4 5192.6 5193.4 5198.4 5198.9 5197.6 5213.7 5220.6 5226.8 5229.5 5138.5 5182.6 5183.4 5193.2 5210.5 5640.5 5683.2 5694.6 5694.9 5702.6 6132.7 6141.8 6161.4 6171.7 6203.7 6142.9 6286.6 6288.0 6290.3 6292.0 5598.5 5701.8 5759.3 5767.2 5768.3 6205.3 6243.3 6254.7 6264.0 6320.7 6037.8 6043.3 6048.3 6050.2 6051.8 6215.2 6230.1 6234.3 6234.3 6241.5 5989.2 6036.3 6036.7 6078.4 6081.3 6179.3 6183.9 6188.4 6206.8 6212.8 4849.5 4865.6 4892.0 4894.8 4921.5 4339.1 4362.7 4380.7 4380.9 4425.1 5704.7 5715.7 5727.6 5759.1 5764.3 6275.8 6286.3 6288.6 6289.1 6300.3 5569.8 5681.5 5692.4 5697.3 5708.1 5169.9 5438.4 5441.6 5455.5 5482.3 5719.7 6272.7 6324.5 6333.7 6342.8 5145.2 6175.6 6176.2 6221.8 6280.9 6298.5 6335.5 6343.8 6347.7 6365.1 6138.3 6157.8 6172.4 6175.4 6175.6 6079.8 6108.2 6144.1 6247.9 6250.9 5935.3 5980.6 5993.4 6006.6 6046.0 5925.5 5957.2 5962.5 5966.3 5971.2 5648.2 5697.4 5826.3 5826.8 5827.6 6003.1 6006.8 6009.3 6031.2 6048.0 5840.6 5845.0 5850.9 5866.8 5877.0 06:56:48 INFO - PROCESS | 1652 | 06:56:48 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:68046.76 Median:37395.13 stddev:147705.11 (395.0%) stddev-sans-first:148032.43 06:56:48 INFO - PROCESS | 1652 | Values: 514.9 520.6 520.9 522.0 529.8 25915.2 30624.1 39664.2 40640.0 40765.0 41695.2 41838.8 41983.0 42035.0 42035.6 9699.4 9880.1 9881.3 9885.0 9901.6 8841.0 9049.4 9685.6 11856.9 12144.3 10513.9 12030.2 12052.3 12065.1 12066.6 11950.6 11984.5 12012.5 12016.1 12033.4 8681.4 11720.2 11939.7 11998.2 12201.9 39773.8 40154.8 40246.0 40353.8 40388.8 3334.2 3358.6 3382.5 3385.0 3432.9 28832.7 28991.3 31102.0 31403.0 31424.4 3235.8 3329.6 3360.8 3427.9 3428.6 485603.0 488787.0 489145.0 490067.0 490531.0 56082.7 56265.6 56355.7 56607.2 56624.4 55263.9 55366.9 55368.6 55469.4 55511.7 15715.4 15951.4 15984.3 16006.9 16065.7 11124.4 12506.4 12542.2 12599.6 12607.0 13385.1 13788.3 13795.3 13812.7 13838.9 4729.2 6187.3 6198.2 6201.3 6220.5 880.8 968.5 972.2 973.8 987.3 28163.7 28229.3 29080.9 29547.0 30110.1 1080.2 1083.2 1087.9 1123.0 1136.2 11368.5 15166.9 15362.3 15404.4 15548.5 635038.8 638702.0 639618.0 639716.0 640162.0 55802.4 55920.7 56061.7 56115.7 56296.4 1318.1 1351.7 1378.3 1379.0 1386.0 28125.0 28271.7 28795.3 29196.4 29816.4 47816.8 48265.0 48360.0 48385.0 48390.5 518303.0 520940.7 521150.0 521434.0 521826.0 32765.5 33497.0 37992.0 38836.2 39184.0 42395.4 45160.0 45811.8 46333.1 46650.5 30546.6 37388.6 37902.9 38174.0 39097.0 37401.6 37974.1 38491.0 39012.0 39149.8 36233.6 36809.0 37320.4 37351.3 37630.4 28802.7 32397.7 33342.0 33835.8 34101.0 23480.1 25024.4 25388.4 25393.3 25395.0 06:56:48 INFO - PROCESS | 1652 | 06:56:48 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:34147.48 Median:372.37 stddev:98202.87 (26372.4%) stddev-sans-first:98445.58 06:56:48 INFO - PROCESS | 1652 | Values: 354.3 366.7 378.0 386.8 407.5 15528.9 15973.4 17549.6 20179.7 20782.2 19996.6 20215.7 20577.9 20859.8 20905.0 5184.3 5801.5 5955.8 6063.4 6080.3 5936.3 6051.5 6054.5 6055.4 6083.7 5612.4 5913.8 5955.1 5996.7 6009.1 5876.5 5914.7 5914.9 5923.2 5932.4 4972.8 5524.2 5776.5 5792.6 5805.6 12963.3 13173.0 15387.7 24282.9 24662.1 2201.1 2203.5 2242.8 2554.8 2613.4 9669.6 10182.7 10214.9 10226.9 10234.6 1503.7 1520.6 1819.2 1854.7 1943.4 100498.0 116159.3 117963.9 119159.0 119938.0 11058.3 11207.4 11207.8 11230.3 11411.8 14123.4 14126.8 14127.9 14151.0 14156.7 8030.5 8301.0 8332.1 8432.9 8465.9 8136.1 8167.7 8176.1 8286.3 8369.5 4361.4 4368.3 4381.5 4390.8 4453.6 1833.9 1875.0 1881.9 1885.0 1889.3 864.6 957.8 971.8 1006.9 1021.2 19523.8 20786.9 20924.4 20940.3 21254.0 888.3 903.4 957.4 968.2 968.3 8935.6 9080.5 10438.4 10963.5 10964.6 538439.0 591558.0 592344.0 602388.0 609138.4 109004.5 120268.4 135583.0 136999.0 137967.0 931.8 953.4 970.1 970.3 972.6 15470.6 17533.6 18618.6 18634.6 19011.6 53778.0 54094.0 54412.5 54785.7 54937.0 78516.2 78538.0 78688.6 79556.2 79581.2 5256.6 6832.6 7632.8 7728.7 7960.0 9902.0 10094.0 12113.9 12203.5 12211.3 10232.9 10247.7 10426.7 10569.5 10582.8 8436.6 10081.2 10097.3 10194.6 10318.5 10265.0 10472.4 10582.2 10600.8 10676.7 7551.7 7595.7 7764.2 7784.9 7790.8 7850.5 8943.7 9953.3 10369.9 10615.2 06:56:48 INFO - PROCESS | 1652 | 06:56:48 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5665.17 Median:4766.76 stddev:3174.74 (66.6%) stddev-sans-first:3166.86 06:56:48 INFO - PROCESS | 1652 | Values: 1320.6 1486.2 1527.7 1722.8 1920.3 7779.6 8326.5 8708.9 8719.2 8758.2 8430.6 8604.1 8646.1 8675.2 8684.9 2358.6 2405.3 2408.7 2410.7 2412.1 2021.9 2400.1 2408.5 2411.5 2422.0 2343.2 2366.1 2379.4 2384.7 2386.7 2346.9 2377.2 2390.2 2390.8 2391.4 2341.3 2379.8 2389.3 2391.6 2408.0 8295.1 8602.3 8747.1 8768.5 8771.7 4718.4 5178.6 5345.0 5400.3 5400.8 3263.2 3492.7 3573.6 3658.0 3671.4 1089.0 1089.3 1095.3 1096.5 1111.8 11392.0 11505.4 11641.2 11647.1 11655.6 4007.9 4732.2 4832.1 4838.4 4846.3 10113.2 10114.4 10115.7 10123.2 10130.1 5377.1 5387.1 5389.9 5391.8 5406.3 4371.9 4535.1 4688.2 4801.3 4887.6 3928.8 3976.3 4041.0 4098.9 4105.1 1266.2 1285.7 1286.3 1289.3 1306.2 884.6 915.2 916.3 928.5 949.5 5559.4 5765.7 6004.9 6007.3 6161.8 376.7 438.4 447.3 447.5 452.8 3685.3 4062.7 4073.5 4088.6 4157.5 10423.8 10484.8 10728.2 10793.0 10823.9 10582.8 10710.9 10713.4 10736.9 10749.6 6677.4 8027.8 8095.3 8135.7 8180.5 5312.9 5930.9 5977.4 6029.9 6188.2 8218.5 8711.7 9694.5 10023.1 10128.4 9509.1 9908.2 9910.6 10161.0 10163.6 6913.3 7109.5 7305.7 7410.2 7616.0 8173.3 8436.9 8437.5 8445.2 8457.3 7379.6 7482.9 7497.9 7563.3 7631.3 7256.0 7332.4 7385.7 7399.5 7494.4 6947.2 7102.2 7102.5 7112.7 7143.2 4928.7 5003.6 5036.5 5092.8 5143.8 4263.6 4970.6 5148.8 5182.6 5247.0 06:56:48 INFO - PROCESS | 1652 | 06:56:48 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4585.00 Median:5258.32 stddev:1439.30 (27.4%) stddev-sans-first:1406.94 06:56:48 INFO - PROCESS | 1652 | Values: 300.2 300.8 309.6 315.4 317.7 4449.6 4615.3 5372.6 5409.0 5418.3 4683.5 4971.0 5084.6 5176.5 5311.9 3912.8 4008.2 4015.9 4064.7 4082.4 4037.0 4060.0 4063.9 4092.5 4125.4 3420.9 3774.9 4034.5 4054.5 4069.6 3392.7 3995.8 4019.5 4047.6 4055.0 3471.7 3472.2 3480.4 3481.8 3503.3 4735.9 4803.9 5072.5 5248.0 5274.7 3929.2 4065.5 4584.8 4636.5 4659.5 5613.6 5622.5 5646.9 5692.1 5700.0 3281.0 3472.2 3839.5 3849.6 3860.2 4931.0 5629.0 5904.4 5966.4 5974.6 3853.8 3872.9 3881.3 3885.5 3887.9 3956.4 3961.2 3965.8 3970.9 3975.6 3727.3 4554.6 4590.0 4634.4 4653.9 4743.2 5645.1 5717.5 5729.5 5784.9 1258.5 1270.1 1272.5 1328.8 1362.8 777.9 885.6 893.3 900.7 915.2 4573.8 4641.7 5358.5 5362.9 5392.6 5681.9 5752.9 5785.5 5851.6 5940.0 4559.3 5039.5 5282.7 5367.9 5370.4 2721.5 2867.4 3041.0 3048.1 3071.3 5056.5 5550.6 5634.4 6004.0 6106.2 4956.7 5920.1 5932.0 5956.2 6007.3 5360.5 5986.8 5997.8 6073.3 6077.8 5446.4 5812.0 5827.7 5837.0 5904.4 5054.3 5804.2 5828.6 5853.5 5915.7 5853.5 6050.1 6207.7 6213.6 6217.1 3305.4 3420.7 3804.7 3821.8 3897.6 5449.2 5844.4 5874.2 5906.4 5964.6 5048.4 5516.8 5592.7 5679.7 5760.8 5635.5 5643.4 5659.4 5673.7 5680.7 4627.5 5507.9 5507.9 5553.3 5584.6 5489.4 5633.0 5640.4 5692.5 5705.0 5268.6 5498.9 5531.4 5545.7 5553.7 06:56:48 INFO - PROCESS | 1652 | 06:56:48 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:23560.74 Median:3736.14 stddev:36526.95 (977.7%) stddev-sans-first:36589.06 06:56:48 INFO - PROCESS | 1652 | Values: 690.3 715.2 722.5 725.9 763.1 15058.9 15460.3 15638.6 15657.8 15692.5 13495.0 14206.0 14239.2 14268.2 14294.4 844.2 865.8 867.1 869.0 869.2 671.8 691.0 691.6 692.9 696.2 893.2 908.8 912.3 913.0 913.4 908.4 909.2 909.6 910.3 913.0 525.5 675.4 675.8 676.4 677.9 12424.1 12515.0 12525.8 14169.1 14717.2 14136.6 14722.6 14735.3 14768.9 14963.6 11632.3 11950.9 11962.3 12174.8 12279.2 3743.2 3754.4 3784.4 3785.6 3910.7 103736.0 103892.5 109185.5 109738.5 110288.4 10872.6 10928.7 11155.9 11359.8 11448.8 21713.5 22005.3 22006.2 22022.6 22025.0 7331.5 7375.7 7617.4 7789.5 8049.2 4402.7 4469.9 4489.6 4543.4 4656.4 3582.2 3667.6 3700.6 3731.2 3741.1 672.9 687.4 688.6 694.6 696.7 569.8 581.0 616.0 650.9 672.7 8443.3 8658.0 9303.6 9368.6 9427.5 513.6 582.6 613.1 633.1 655.4 4281.3 4283.2 4458.0 4606.7 4667.2 125853.4 125921.0 129494.0 132563.3 158482.0 112358.0 117987.4 119518.0 121943.8 122528.0 59992.7 97786.0 101544.0 102430.5 107446.0 7443.7 9827.2 9915.0 9921.7 9940.8 59682.4 60738.1 60864.7 61154.5 62074.7 80328.6 90539.5 90805.3 90922.5 91783.1 12043.6 12488.6 12711.9 13219.0 13474.7 14844.4 14895.3 15068.7 15136.6 15694.4 13511.0 13612.6 13914.2 13948.4 14258.0 13710.2 13793.7 13814.0 14189.4 14408.9 13684.4 13726.8 13938.5 14004.9 14227.4 11161.3 11452.0 11507.2 11507.4 12034.8 9866.2 10499.6 10522.5 11672.9 11681.6 06:56:48 INFO - PROCESS | 1652 | -------- Summary: end -------- 06:56:48 INFO - PROCESS | 1652 | 06:56:49 INFO - TEST-INFO | 1652: exit 0 06:56:49 INFO - TEST-OK | dromaeo_css | took 1118241ms 06:56:49 INFO - TEST-START | kraken 06:56:49 INFO - operating with platform_type : mac_ 06:56:49 INFO - Initialising browser for kraken test... 06:56:49 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/tmp68nueh/profile http://localhost:49262/getInfo.html) 06:56:51 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 06:56:51 INFO - PROCESS | 1659 | colorDepth:24 06:56:51 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 06:56:51 INFO - PROCESS | 1659 | __metrics 06:56:51 INFO - PROCESS | 1659 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:56:51 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:56:52 INFO - TEST-INFO | 1659: exit 0 06:56:52 INFO - Browser initialized. 06:56:52 INFO - Running cycle 1/1 for kraken test... 06:56:52 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/tmp68nueh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:57:04 INFO - PROCESS | 1660 | RSS: Main: 234131456 06:57:04 INFO - PROCESS | 1660 | 06:57:07 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection) 06:57:07 INFO - PROCESS | 1660 | RSS: Main: 293040128 06:57:07 INFO - PROCESS | 1660 | 06:57:10 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-dft) 06:57:11 INFO - PROCESS | 1660 | RSS: Main: 289099776 06:57:11 INFO - PROCESS | 1660 | 06:57:14 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-fft) 06:57:15 INFO - PROCESS | 1660 | RSS: Main: 381300736 06:57:15 INFO - PROCESS | 1660 | 06:57:17 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator) 06:57:18 INFO - PROCESS | 1660 | RSS: Main: 282877952 06:57:18 INFO - PROCESS | 1660 | 06:57:20 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:57:20 INFO - PROCESS | 1660 | RSS: Main: 285880320 06:57:20 INFO - PROCESS | 1660 | 06:57:23 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom) 06:57:24 INFO - PROCESS | 1660 | RSS: Main: 324968448 06:57:24 INFO - PROCESS | 1660 | 06:57:27 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate) 06:57:27 INFO - PROCESS | 1660 | RSS: Main: 324894720 06:57:27 INFO - PROCESS | 1660 | 06:57:30 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial) 06:57:31 INFO - PROCESS | 1660 | RSS: Main: 321855488 06:57:31 INFO - PROCESS | 1660 | 06:57:32 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:57:33 INFO - PROCESS | 1660 | RSS: Main: 297463808 06:57:33 INFO - PROCESS | 1660 | 06:57:35 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:57:36 INFO - PROCESS | 1660 | RSS: Main: 304316416 06:57:36 INFO - PROCESS | 1660 | 06:57:38 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:57:38 INFO - PROCESS | 1660 | RSS: Main: 305016832 06:57:38 INFO - PROCESS | 1660 | 06:57:41 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:57:42 INFO - PROCESS | 1660 | RSS: Main: 320561152 06:57:42 INFO - PROCESS | 1660 | 06:57:45 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:57:45 INFO - PROCESS | 1660 | RSS: Main: 316858368 06:57:45 INFO - PROCESS | 1660 | 06:57:47 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49262/tests/kraken/driver.html?testName=ai-astar) 06:57:47 INFO - PROCESS | 1660 | RSS: Main: 360636416 06:57:47 INFO - PROCESS | 1660 | 06:57:47 INFO - PROCESS | 1660 | __start_tp_report 06:57:47 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 06:57:47 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 06:57:47 INFO - PROCESS | 1660 | |i|pagename|runs| 06:57:47 INFO - PROCESS | 1660 | |0;ai-astar;115;114;117;114;114;114;113;113;113;122 06:57:47 INFO - PROCESS | 1660 | |1;audio-beat-detection;144;114;129;162;106;129;127;109;156;106 06:57:47 INFO - PROCESS | 1660 | |2;audio-dft;205;262;201;184;183;183;181;185;183;184 06:57:47 INFO - PROCESS | 1660 | |3;audio-fft;76;74;74;183;80;78;58;61;144;57 06:57:47 INFO - PROCESS | 1660 | |4;audio-oscillator;82;84;132;71;69;95;147;96;99;110 06:57:47 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;88;86;90;87;89;86;88;87;90;84 06:57:47 INFO - PROCESS | 1660 | |6;imaging-darkroom;94;95;104;144;94;94;95;96;95;95 06:57:47 INFO - PROCESS | 1660 | |7;imaging-desaturate;84;84;84;84;84;87;86;83;84;84 06:57:47 INFO - PROCESS | 1660 | |8;json-parse-financial;55;52;54;54;54;53;54;54;54;54 06:57:47 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;67;66;70;105;112;73;71;70;71;70 06:57:47 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;85;86;85;86;85;87;83;87;88;86 06:57:47 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;138;140;134;136;139;131;156;167;185;124 06:57:47 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;168;169;223;176;170;167;168;170;169;166 06:57:47 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;66;65;67;65;66;68;66;67;66;66 06:57:47 INFO - PROCESS | 1660 | __end_tp_report 06:57:47 INFO - PROCESS | 1660 | __start_cc_report 06:57:47 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,2050 06:57:47 INFO - PROCESS | 1660 | __end_cc_report 06:57:47 INFO - PROCESS | 1660 | __startTimestamp1472738267947__endTimestamp 06:57:47 INFO - PROCESS | 1660 | 06:57:47 INFO - PROCESS | 1660 | ------- Summary: start ------- 06:57:47 INFO - PROCESS | 1660 | Number of tests: 14 06:57:47 INFO - PROCESS | 1660 | 06:57:47 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:114.90 Median:114.00 stddev:2.77 (2.4%) stddev-sans-first:2.93 06:57:47 INFO - PROCESS | 1660 | Values: 115.0 114.0 117.0 114.0 114.0 114.0 113.0 113.0 113.0 122.0 06:57:47 INFO - PROCESS | 1660 | 06:57:47 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:128.20 Median:129.00 stddev:20.34 (15.8%) stddev-sans-first:20.76 06:57:47 INFO - PROCESS | 1660 | Values: 144.0 114.0 129.0 162.0 106.0 129.0 127.0 109.0 156.0 106.0 06:57:47 INFO - PROCESS | 1660 | 06:57:47 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:195.10 Median:184.50 stddev:24.93 (13.5%) stddev-sans-first:26.19 06:57:47 INFO - PROCESS | 1660 | Values: 205.0 262.0 201.0 184.0 183.0 183.0 181.0 185.0 183.0 184.0 06:57:47 INFO - PROCESS | 1660 | 06:57:47 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:88.50 Median:74.00 stddev:41.43 (56.0%) stddev-sans-first:43.70 06:57:47 INFO - PROCESS | 1660 | Values: 76.0 74.0 74.0 183.0 80.0 78.0 58.0 61.0 144.0 57.0 06:57:47 INFO - PROCESS | 1660 | 06:57:47 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:98.50 Median:83.00 stddev:25.24 (30.4%) stddev-sans-first:26.06 06:57:47 INFO - PROCESS | 1660 | Values: 82.0 84.0 132.0 71.0 69.0 95.0 147.0 96.0 99.0 110.0 06:57:47 INFO - PROCESS | 1660 | 06:57:47 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:87.50 Median:88.00 stddev:1.90 (2.2%) stddev-sans-first:2.01 06:57:47 INFO - PROCESS | 1660 | Values: 88.0 86.0 90.0 87.0 89.0 86.0 88.0 87.0 90.0 84.0 06:57:47 INFO - PROCESS | 1660 | 06:57:47 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:100.60 Median:95.00 stddev:15.54 (16.4%) stddev-sans-first:16.29 06:57:47 INFO - PROCESS | 1660 | Values: 94.0 95.0 104.0 144.0 94.0 94.0 95.0 96.0 95.0 95.0 06:57:47 INFO - PROCESS | 1660 | 06:57:47 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.00 stddev:1.17 (1.4%) stddev-sans-first:1.24 06:57:47 INFO - PROCESS | 1660 | Values: 84.0 84.0 84.0 84.0 84.0 87.0 86.0 83.0 84.0 84.0 06:57:47 INFO - PROCESS | 1660 | 06:57:47 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:0.79 (1.5%) stddev-sans-first:0.71 06:57:47 INFO - PROCESS | 1660 | Values: 55.0 52.0 54.0 54.0 54.0 53.0 54.0 54.0 54.0 54.0 06:57:47 INFO - PROCESS | 1660 | 06:57:47 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:77.50 Median:70.00 stddev:16.54 (23.6%) stddev-sans-first:17.10 06:57:47 INFO - PROCESS | 1660 | Values: 67.0 66.0 70.0 105.0 112.0 73.0 71.0 70.0 71.0 70.0 06:57:47 INFO - PROCESS | 1660 | 06:57:47 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:86.00 stddev:1.40 (1.6%) stddev-sans-first:1.45 06:57:47 INFO - PROCESS | 1660 | Values: 85.0 86.0 85.0 86.0 85.0 87.0 83.0 87.0 88.0 86.0 06:57:47 INFO - PROCESS | 1660 | 06:57:47 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:145.00 Median:139.50 stddev:18.72 (13.4%) stddev-sans-first:19.68 06:57:47 INFO - PROCESS | 1660 | Values: 138.0 140.0 134.0 136.0 139.0 131.0 156.0 167.0 185.0 124.0 06:57:47 INFO - PROCESS | 1660 | 06:57:47 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.60 Median:169.50 stddev:17.22 (10.2%) stddev-sans-first:18.10 06:57:47 INFO - PROCESS | 1660 | Values: 168.0 169.0 223.0 176.0 170.0 167.0 168.0 170.0 169.0 166.0 06:57:47 INFO - PROCESS | 1660 | 06:57:47 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 06:57:47 INFO - PROCESS | 1660 | Values: 66.0 65.0 67.0 65.0 66.0 68.0 66.0 67.0 66.0 66.0 06:57:47 INFO - PROCESS | 1660 | -------- Summary: end -------- 06:57:47 INFO - PROCESS | 1660 | 06:57:48 INFO - TEST-INFO | 1660: exit 0 06:57:48 INFO - TEST-OK | kraken | took 59358ms 06:57:48 INFO - SUITE-END | took 1177s 06:57:49 INFO - Completed test suite (00:19:37) 06:57:49 INFO - javascript benchmark 06:57:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3290.555774970379, 3309.619393769716, 3311.668833116687, 3341.682540158684, 3356.2951780126173, 5578.386377498472, 5611.635243709156, 5677.744501497432, 5737.627054241477, 5738.053221218499, 5650.208970744099, 5687.744051517671, 5757.654540727559, 5784.074548072309, 5790.04464263396, 5117.974410127944, 5124.231365295217, 5178.6892786432745, 5200.349956255468, 5301.045811753883, 5289.497497737709, 5302.44324345942, 5311.415744268127, 5328.493793089669, 5343.465653434664, 5157.432682404932, 5192.636515443921, 5193.376794784631, 5198.428172900978, 5198.92201616976, 5197.584193264567, 5213.739313034371, 5220.634555581111, 5226.764795584169, 5229.5293423591675, 5138.511841375101, 5182.559482443997, 5183.352080989876, 5193.221016847466, 5210.452902445264, 5640.464155905182, 5683.175939488751, 5694.572907031989, 5694.886102277931, 5702.600817942745, 6132.69336533176, 6141.785037523665, 6161.383861613847, 6171.660558669271, 6203.720832562545, 6142.8771424571705, 6286.622802631857, 6288.0, 6290.308066112724, 6291.968540157316, 5598.524125449382, 5701.828945131652, 5759.3376761672525, 5767.163761254595, 5768.307803063659, 6205.317415084337, 6243.344448832807, 6254.718537665816, 6263.968680156661, 6320.652364119926, 6037.849053773691, 6043.305019922677, 6048.274207095089, 6050.21347224858, 6051.788187413419, 6215.192025036807, 6230.127782110508, 6234.251889773165, 6234.345393733593, 6241.500679945593, 5989.221401217814, 6036.3058248302, 6036.728347224385, 6078.3617720138745, 6081.300650425169, 6179.3202747697715, 6183.876322473526, 6188.44304012641, 6206.782762603287, 6212.813615591449, 4849.466558678613, 4865.635077369211, 4891.975540122347, 4894.828680996219, 4921.483244259372, 4339.132173565299, 4362.672799540047, 4380.737155770664, 4380.890477738082, 4425.114977004612, 5704.686242256716, 5715.657060576379, 5727.570432217601, 5759.078547432391, 5764.279465066867, 6275.780347687901, 6286.308506064329, 6288.591241569284, 6289.119523266746, 6300.27546832111, 5569.805056822992, 5681.517071049007, 5692.37383887772, 5697.259356283656, 5708.115242137475, 5169.870753231124, 5438.401775804658, 5441.564674826083, 5455.481729235717, 5482.314710661168, 5719.685417302088, 6272.655003974825, 6324.494040476843, 6333.6516491591565, 6342.778002769881, 5145.176771716508, 6175.62946223228, 6176.1970943778815, 6221.813345599639, 6280.937190628035, 6298.496120310272, 6335.461485773577, 6343.809685709436, 6347.650879201504, 6365.14070600463, 6138.263408391022, 6157.753689852356, 6172.382761723971, 6175.382461753788, 6175.5677102602385, 6079.787207447718, 6108.1903020305945, 6144.126041557368, 6247.875042499216, 6250.906236406367, 5935.2877654681715, 5980.611260268069, 5993.370696077023, 6006.579539432372, 6045.969770151121, 5925.496332811759, 5957.16599676037, 5962.522998160223, 5966.2840459143445, 5971.193888824953, 5648.237487939075, 5697.401772813961, 5826.329972053268, 5826.76692932278, 5827.59206855533, 6003.0695242237525, 6006.849828754316, 6009.278886533644, 6031.185789918305, 6048.032314829607, 5840.591158618856, 5845.006348920779, 5850.882982340244, 5866.823995280149, 5877.0], "value": 5662.88395066168, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [514.8764296568825, 520.606941758972, 520.9270702101704, 521.9947800521994, 529.8331025726895, 25915.222543323707, 30624.08127756168, 39664.206715865665, 40640.0, 40765.0, 41695.16609667813, 41838.790806046, 41982.95042623936, 42035.0, 42035.57964420362, 9699.36954097985, 9880.110790028895, 9881.308308418413, 9885.0, 9901.55443005063, 8841.0, 9049.3665443419, 9685.612575496973, 11856.940715296412, 12144.3320617366, 10513.947430262877, 12030.157888947777, 12052.276863388224, 12065.09511786615, 12066.57766978156, 11950.581729639465, 11984.52061917531, 12012.519499220021, 12016.098792590547, 12033.39833008346, 8681.435706679045, 11720.238184517979, 11939.701507462296, 11998.220115692538, 12201.877981220163, 39773.80678579647, 40154.795356139366, 40246.0, 40353.78938631846, 40388.79805600953, 3334.199792049915, 3358.580177477815, 3382.5433566468705, 3385.0, 3432.9485057724155, 28832.71167288321, 28991.275218119506, 31102.0, 31403.0, 31424.37151256962, 3235.7573182011206, 3329.5671562696934, 3360.7647464677484, 3427.880024199141, 3428.6057103433177, 485603.0, 488787.0, 489145.0, 490067.0, 490531.0, 56082.71958640181, 56265.59336016632, 56355.71822140945, 56607.150892736645, 56624.43375566274, 55263.89472210533, 55366.89266214734, 55368.61578460571, 55469.44530554723, 55511.72244138754, 15715.371385144466, 15951.361945522049, 15984.280707368196, 16006.919965400331, 16065.678686426207, 11124.443777811077, 12506.437210325557, 12542.24746515212, 12599.5590154346, 12607.0, 13385.129966552144, 13788.310584470737, 13795.310234488235, 13812.654683632989, 13838.930805345908, 4729.215808982774, 6187.319394866561, 6198.194234749454, 6201.317855035943, 6220.471259942865, 880.7842078690762, 968.4528241543505, 972.2270794718216, 973.776031512756, 987.2644879564771, 28163.71836281611, 28229.294267643472, 29080.854595726887, 29546.986820617636, 30110.09669709912, 1080.2276372393776, 1083.1930211992117, 1087.923845330835, 1123.0341905961031, 1136.1876258475065, 11368.54525818958, 15166.924165379103, 15362.308696108701, 15404.437088389781, 15548.455804046804, 635038.824805873, 638702.0, 639618.0, 639716.0, 640162.0, 55802.44197557973, 55920.72039639776, 56061.71969140128, 56115.71942140263, 56296.43703562994, 1318.064174436142, 1351.6620844788804, 1378.3383975691524, 1378.9517366892312, 1385.9722805543834, 28125.0, 28271.717282827733, 28795.28011799722, 29196.416071678024, 29816.403671926008, 47816.7609161952, 48265.0, 48360.03279934452, 48385.0, 48390.516094838604, 518303.0, 520940.6730091389, 521150.0, 521434.0, 521826.0, 32765.508517372735, 33497.0, 37992.0, 38836.22327553377, 39184.0, 42395.40899765127, 45160.0, 45811.77094114508, 46333.07333853237, 46650.53349466598, 30546.625401856527, 37388.6261137396, 37902.86291411262, 38174.0, 39097.0, 37401.6259837409, 37974.050648734, 38491.0, 39012.0, 39149.8042509797, 36233.63766362303, 36809.0, 37320.44019339766, 37351.25297494089, 37630.43554346632, 28802.711972880003, 32397.676023239466, 33341.999740007835, 33835.83082084574, 34101.0, 23480.060797567905, 25024.37439064038, 25388.365290867878, 25393.32678412085, 25395.0], "value": 19784.35544935597, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.2684356803203, 366.74144727966785, 377.99811000944993, 386.78533413955245, 407.4906367041198, 15528.922355388222, 15973.440929567467, 17549.561260968483, 20179.697304540445, 20782.16871325149, 19996.60006799867, 20215.696764548542, 20577.897110514426, 20859.791402085975, 20905.0, 5184.274201611777, 5801.535877129841, 5955.821325360246, 6063.393660633946, 6080.2703675559, 5936.347001829795, 6051.515878729691, 6054.515638748911, 6055.364186760393, 6083.726232319534, 5612.354579223401, 5913.822585322426, 5955.136505206742, 5996.700164991755, 6009.1286763419275, 5876.529877609781, 5914.674692891911, 5914.940850591482, 5923.17075609415, 5932.406759324033, 4972.776225069881, 5524.226608274845, 5776.4801167894675, 5792.623479473821, 5805.622634528742, 12963.28701921394, 13173.0, 15387.692246155126, 24282.90726917293, 24662.13682521121, 2201.1415547936317, 2203.46015226269, 2242.820574354048, 2554.8083893707862, 2613.372790530278, 9669.613215471443, 10182.745431364201, 10214.948925255401, 10226.948865255627, 10234.641787537475, 1503.6992601479749, 1520.6046427928707, 1819.245013319471, 1854.7403363529118, 1943.3586916317722, 100498.0, 116159.25761113505, 117963.89523519127, 119159.0, 119938.0, 11058.281211721212, 11207.439628018567, 11207.775844483065, 11230.270032447865, 11411.828822567668, 14123.435062597586, 14126.788098178535, 14127.929360353339, 14151.0, 14156.716865662629, 8030.5181689098845, 8301.0, 8332.125126861714, 8432.873506897402, 8465.915340846514, 8136.1050284468665, 8167.673293068211, 8176.141505141994, 8286.337093032544, 8369.539675317794, 4361.389405483234, 4368.322909948899, 4381.539938306496, 4390.824367025347, 4453.576910193527, 1833.8532917366579, 1874.9625007499774, 1881.9273014381945, 1885.0207282353474, 1889.3198448558508, 864.6454953469173, 957.7653474898694, 971.7667759737753, 1006.854006169116, 1021.2391768132788, 19523.8047619522, 20786.856722880388, 20924.408811224417, 20940.267090651752, 21254.0, 888.320434867327, 903.3856977255398, 957.411192116857, 968.2157452463528, 968.3076600230869, 8935.642574296955, 9080.500572468445, 10438.37369757817, 10963.50664220112, 10964.56141754321, 538439.0, 591558.0422097949, 592344.0, 602388.0, 609138.4060036084, 109004.54977251265, 120268.39865800615, 135583.0, 136999.0, 137967.0, 931.8089791592707, 953.3850666320185, 970.0929630795229, 970.3207754571828, 972.5817898303798, 15470.613234669223, 17533.597312215246, 18618.627627447648, 18634.627307454048, 19011.619767604294, 53778.0, 54094.0, 54412.45587544074, 54785.72607136939, 54937.0, 78516.1854768154, 78538.0, 78688.60655696684, 79556.20443795488, 79581.2041879597, 5256.606999145153, 6832.555883867732, 7632.8473430532185, 7728.729494467667, 7959.960200199193, 9902.0, 10094.0, 12113.939430302793, 12203.511859525519, 12211.26732396059, 10232.897671023195, 10247.692569222638, 10426.739331516772, 10569.471526423802, 10582.788344232918, 8436.578171091543, 10081.193504519768, 10097.29318947696, 10194.643187488402, 10318.48407579603, 10265.024822641837, 10472.371657700258, 10582.206334525095, 10600.766766136403, 10676.679699608714, 7551.660175292015, 7595.658195381111, 7764.184760600056, 7784.883226751716, 7790.766277011699, 7850.528968261694, 8943.686970955985, 9953.253505987224, 10369.896301036893, 10615.150787936793], "value": 9193.272655936717, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.6302235374098, 1486.1528928510747, 1527.7020980908721, 1722.7846519185102, 1920.2606996306426, 7779.611019449027, 8326.458780179284, 8708.869366959485, 8719.171678690522, 8758.167974042472, 8430.620622072007, 8604.053554109043, 8646.092160323155, 8675.219230269275, 8684.8697269541, 2358.599038163512, 2405.254371144942, 2408.7350391456926, 2410.710714714237, 2412.0592968742203, 2021.9292324768637, 2400.075970751265, 2408.5303365843665, 2411.5297516984197, 2422.0432928993037, 2343.2267351773876, 2366.100881664965, 2379.4289370551114, 2384.7376788553247, 2386.689730335063, 2346.9295921122393, 2377.215518878766, 2390.199283240108, 2390.8326417150806, 2391.4021494626345, 2341.2976107167783, 2379.8334116611845, 2389.2832150355, 2391.629297458897, 2407.963880541793, 8295.087540370554, 8602.2688071514, 8747.125287471266, 8768.473891566462, 8771.692990745358, 4718.41019872516, 5178.559822415099, 5345.01117293302, 5400.29796126505, 5400.83797486076, 3263.216827961296, 3492.6553276988543, 3573.6426357364317, 3657.963420365789, 3671.4125739881492, 1088.983665245022, 1089.3246187363807, 1095.3482677806692, 1096.4627332607045, 1111.833225016246, 11392.0, 11505.424728763528, 11641.243319184226, 11647.068234541217, 11655.592054278144, 4007.859724909614, 4732.219183834698, 4832.106060378841, 4838.395200599925, 4846.328016834186, 10113.190944724405, 10114.443705596115, 10115.696529104138, 10123.1901447884, 10130.138938190335, 5377.085895397791, 5387.0841956867425, 5389.892202155935, 5391.838244852661, 5406.324209473816, 4371.934420983688, 4535.138323718483, 4688.179568575486, 4801.303810947393, 4887.584555312838, 3928.823202955874, 3976.324024915771, 4041.0301527633155, 4098.897527561835, 4105.096878686684, 1266.2212739165348, 1285.68500717323, 1286.3439645780531, 1289.278004317585, 1306.2162702378687, 884.5577211394303, 915.2357781252729, 916.3402350307767, 928.5473875942965, 949.4777872170279, 5559.430108598202, 5765.682887441231, 6004.909926351108, 6007.309159446632, 6161.784337548254, 376.7456966547624, 438.38407038111507, 447.34240666220603, 447.50997657564915, 452.805293723702, 3685.3366394048794, 4062.695297852673, 4073.45008423859, 4088.5911408858874, 4157.5240789519285, 10423.791524169474, 10484.790304194026, 10728.195385346131, 10793.02862742357, 10823.945880270705, 10582.788344233073, 10710.928907109226, 10713.35719856811, 10736.946315268373, 10749.570017199225, 6677.399034086956, 8027.83944321122, 8095.311898488694, 8135.6745730171315, 8180.509169449852, 5312.946870531246, 5930.881382372415, 5977.372375900468, 6029.939700602938, 6188.195534580475, 8218.547979861165, 8711.695090671796, 9694.46680432583, 10023.097921187129, 10128.392296462236, 9509.096635819586, 9908.207343412365, 9910.603575856885, 10161.0, 10163.644272450429, 6913.274106218774, 7109.466789990668, 7305.671244794104, 7410.221926697619, 7616.0, 8173.264406203471, 8436.873446898424, 8437.493750374997, 8445.1977062179, 8457.323414126979, 7379.631018448948, 7482.887756683763, 7497.925020749941, 7563.281488258606, 7631.3131818136635, 7255.963720181366, 7332.41340692754, 7385.741499047507, 7399.48203625741, 7494.437917156126, 6947.201071876799, 7102.18324892644, 7102.5028248022145, 7112.679929403293, 7143.214246432784, 4928.67963582366, 5003.624728145331, 5036.546710796046, 5092.796288148433, 5143.768530416065, 4263.55232700562, 4970.602351811919, 5148.794048238178, 5182.637215395037, 5246.97376513115], "value": 4487.910863987903, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.16104986562556, 300.8285277391887, 309.6423630706534, 315.39916459145337, 317.68866510819396, 4449.621782148517, 4615.2846308822145, 5372.597055220855, 5409.026375252453, 5418.322709661293, 4683.50823163568, 4971.0, 5084.593232541397, 5176.498815343555, 5311.9468805311935, 3912.784796836187, 4008.2384346974054, 4015.867623253852, 4064.654504367132, 4082.4080508326424, 4036.979815100935, 4059.9797001014954, 4063.8577649782264, 4092.4884389451317, 4125.401816736571, 3420.914477138079, 3774.905627359324, 4034.495688038995, 4054.5337286212166, 4069.552349241596, 3392.677695618937, 3995.7802320872343, 4019.537753158366, 4047.5547689753957, 4054.9594504054876, 3471.687548120656, 3472.201393679468, 3480.443129099332, 3481.8085005324697, 3503.3343664703625, 4735.887066539361, 4803.903921921542, 5072.467390923936, 5248.0, 5274.736263186864, 3929.2141571685493, 4065.540348089393, 4584.7936842842155, 4636.4899861015265, 4659.510751371125, 5613.635113717595, 5622.4979883951655, 5646.887062258732, 5692.117721753093, 5700.030994730906, 3280.966495553917, 3472.2013936794424, 3839.4816699745734, 3849.595792441781, 3860.208657225262, 4930.950690493085, 5629.043062679354, 5904.350521442638, 5966.403359664042, 5974.61165024272, 3853.807309634507, 3872.903177420587, 3881.301365754135, 3885.494885664902, 3887.941680874789, 3956.40653901917, 3961.187956468917, 3965.762054276695, 3970.861019864291, 3975.642192202658, 3727.3163322407822, 4554.63562914966, 4590.013147173374, 4634.354804044583, 4653.906921861611, 4743.150171433143, 5645.125005624135, 5717.456841600041, 5729.455701708331, 5784.855378615568, 1258.4966013594453, 1270.0982302565283, 1272.5164437513686, 1328.847182573997, 1362.7547041532619, 777.9260970207935, 885.588201486312, 893.2987604730256, 900.7387857521377, 915.2312057871287, 4573.81704731807, 4641.675082744243, 5358.490943360374, 5362.892742145214, 5392.568594512508, 5681.9431805681415, 5752.856178595485, 5785.537157027427, 5851.61964472308, 5940.0, 4559.316102584573, 5039.496050394931, 5282.683039017671, 5367.865803354869, 5370.409254981949, 2721.4557088582364, 2867.44084903446, 3040.9543856842165, 3048.1465189746905, 3071.3396619726864, 5056.544910958031, 5550.555955523549, 5634.3802181759975, 6004.0, 6106.168149555116, 4956.677815941952, 5920.111983202554, 5931.970340148272, 5956.195913551615, 6007.27912650476, 5360.517553420211, 5986.790462333797, 5997.790077347272, 6073.271207455134, 6077.817665470043, 5446.397793864178, 5811.989727088296, 5827.737751801264, 5837.0, 5904.427821168131, 5054.2671312660195, 5804.21643078179, 5828.5919985602295, 5853.487907255612, 5915.733791979457, 5853.473187413153, 6050.124461416975, 6207.685658467321, 6213.596116252429, 6217.129601855653, 3305.4215512285737, 3420.7263418926923, 3804.6575808177395, 3821.828017739153, 3897.5517815451585, 5449.182622606482, 5844.444777746107, 5874.236349274567, 5906.350301466749, 5964.642121472725, 5048.444671086251, 5516.813885014741, 5592.664440133605, 5679.74441150141, 5760.798372056958, 5635.464630860061, 5643.435656434323, 5659.377468478382, 5673.6879971223, 5680.68756218412, 4627.490975992706, 5507.889842203213, 5507.917381239365, 5553.305836770403, 5584.636998595241, 5489.39616642177, 5632.971835140798, 5640.435956404327, 5692.544596432358, 5704.971475142764, 5268.631195816256, 5498.855446375836, 5531.446855314436, 5545.72271386421, 5553.667119891116], "value": 4123.441071025757, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.3165865792866, 715.1525442350815, 722.5195245161967, 725.902003229564, 763.088109708898, 15058.924705376472, 15460.3042863071, 15638.609034774136, 15657.765133522978, 15692.52922412328, 13495.0, 14206.0, 14239.216843073627, 14268.215248161372, 14294.428222871098, 844.2359664503634, 865.8008658008662, 867.1155421470097, 868.9695860644879, 869.1742844297911, 671.7816709569385, 691.0187533702154, 691.5746815708328, 692.9029935808991, 696.2480521037293, 893.2095095840195, 908.7728067983004, 912.3476714149382, 912.9954350228239, 913.4427998920653, 908.4004556992353, 909.2226146644656, 909.5952301225957, 910.3400034974657, 912.9543522823832, 525.5480286953256, 675.425887995205, 675.8242856857253, 676.4047638078508, 677.9423748981343, 12424.130310878241, 12515.0, 12525.812112818316, 14169.149851008973, 14717.190554519497, 14136.575902722934, 14722.55832325032, 14735.263236838222, 14768.852311476856, 14963.551093467213, 11632.302061876315, 11950.940245298805, 11962.282263064244, 12174.756504869853, 12279.2018518796, 3743.1577894973684, 3754.436834474823, 3784.3944968805135, 3785.5646600641003, 3910.706696997708, 103736.0, 103892.48053759758, 109185.45407272992, 109738.45130774294, 110288.4485577567, 10872.61945831892, 10928.672139835817, 11155.888441115485, 11359.829602555968, 11448.771024579462, 21713.45716357072, 22005.33983980483, 22006.229781957554, 22022.559548808935, 22025.00887460068, 7331.450141239428, 7375.741849035258, 7617.428692848059, 7789.454738168274, 8049.235322644339, 4402.669799765031, 4469.865904022885, 4489.595936365743, 4543.409356783597, 4656.440092569027, 3582.17609949713, 3667.5965643779164, 3700.611435799256, 3731.1791405890663, 3741.102135487518, 672.8830141964413, 687.3573209049555, 688.6281408039703, 694.6318451220861, 696.738722978883, 569.8404446754915, 580.9810907097801, 615.9990016223636, 650.8600650860088, 672.6838385958591, 8443.282321002784, 8658.0, 9303.581338839633, 9368.578413971387, 9427.528623568795, 513.6096566609403, 582.5950964080008, 613.0711971363388, 633.0693879996398, 655.4330504113907, 4281.272183728711, 4283.164782867373, 4457.955420445754, 4606.723596584216, 4667.183242932473, 125853.37073314757, 125921.0, 129494.0, 132563.33718331347, 158482.0, 112358.0, 117987.41006294913, 119518.0, 121943.78056219501, 122528.0, 59992.70003649954, 97786.0, 101543.98456015493, 102430.4635430484, 107446.0, 7443.739469118555, 9827.164691001344, 9915.0, 9921.65274215399, 9940.751481213027, 59682.3619394214, 60738.08892866699, 60864.69567652133, 61154.4711382219, 62074.689626551575, 80328.6275173293, 90539.54730226306, 90805.2815510689, 90922.54538727528, 91783.08216917745, 12043.638690839289, 12488.625341239778, 12711.936440317739, 13219.0, 13474.730505390033, 14844.40622375136, 14895.329710162852, 15068.698626027637, 15136.621584460476, 15694.372225110868, 13510.98084955767, 13612.591622251348, 13914.234717090658, 13948.442062317394, 14258.0, 13710.17738935667, 13793.655158620713, 13814.0, 14189.432422702976, 14408.855911441171, 13684.44543628686, 13726.794098088736, 13938.512152074629, 14004.929975350466, 14227.359768810222, 11161.274517156358, 11452.01196776083, 11507.194496385173, 11507.367094809866, 12034.819477707666, 9866.210703143588, 10499.632512862014, 10522.473876306001, 11672.941635291769, 11681.591144309908], "value": 7686.102446977442, "unit": "score"}], "name": "dromaeo_css", "value": 7260.7404555312305, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 117.0, 114.0, 114.0, 114.0, 113.0, 113.0, 113.0, 122.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 114.0, 129.0, 162.0, 106.0, 129.0, 127.0, 109.0, 156.0, 106.0], "value": 128.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 262.0, 201.0, 184.0, 183.0, 183.0, 181.0, 185.0, 183.0, 184.0], "value": 195.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 74.0, 183.0, 80.0, 78.0, 58.0, 61.0, 144.0, 57.0], "value": 88.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 132.0, 71.0, 69.0, 95.0, 147.0, 96.0, 99.0, 110.0], "value": 98.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 90.0, 87.0, 89.0, 86.0, 88.0, 87.0, 90.0, 84.0], "value": 87.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 104.0, 144.0, 94.0, 94.0, 95.0, 96.0, 95.0, 95.0], "value": 100.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 84.0, 84.0, 87.0, 86.0, 83.0, 84.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 54.0, 54.0, 54.0, 53.0, 54.0, 54.0, 54.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 70.0, 105.0, 112.0, 73.0, 71.0, 70.0, 71.0, 70.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 86.0, 85.0, 87.0, 83.0, 87.0, 88.0, 86.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 140.0, 134.0, 136.0, 139.0, 131.0, 156.0, 167.0, 185.0, 124.0], "value": 145.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 169.0, 223.0, 176.0, 170.0, 167.0, 168.0, 170.0, 169.0, 166.0], "value": 174.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 65.0, 66.0, 68.0, 66.0, 67.0, 66.0, 66.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1500.6, "alertThreshold": 2.0}]} 06:57:49 INFO - Return code: 0 06:57:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:57:49 INFO - # TBPL SUCCESS # 06:57:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:57:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:57:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:57:49 INFO - 2016-09-01 06:57:49.279 screenresolution[1664:10526] starting screenresolution argv=screenresolution get 06:57:49 INFO - 2016-09-01 06:57:49.282 screenresolution[1664:10526] Display 0: 1600x1200x32@60 06:57:49 INFO - 2016-09-01 06:57:49.288 screenresolution[1665:10529] starting screenresolution argv=screenresolution list 06:57:49 INFO - Available Modes on Display 0 06:57:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:57:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:57:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:57:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:57:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:57:49 INFO - Intel Iris: 06:57:49 INFO - Chipset Model: Intel Iris 06:57:49 INFO - Type: GPU 06:57:49 INFO - Bus: Built-In 06:57:49 INFO - VRAM (Dynamic, Max): 1536 MB 06:57:49 INFO - Vendor: Intel (0x8086) 06:57:49 INFO - Device ID: 0x0a2e 06:57:49 INFO - Revision ID: 0x0009 06:57:49 INFO - Displays: 06:57:49 INFO - Display: 06:57:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:57:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:57:49 INFO - Display Serial Number: 1600x1200 60 06:57:49 INFO - Main Display: Yes 06:57:49 INFO - Mirror: Off 06:57:49 INFO - Online: Yes 06:57:49 INFO - Rotation: Supported 06:57:49 INFO - Return code: 0 06:57:49 INFO - Running post-action listener: _resource_record_post_action 06:57:49 INFO - [mozharness: 2016-09-01 13:57:49.520512Z] Finished run-tests step (success) 06:57:49 INFO - Running post-run listener: _resource_record_post_run 06:57:49 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 31022080; Write bytes: 707662848; Read time: 192; Write time: 1953 06:57:49 INFO - TinderboxPrint: CPU usage
54.0% 06:57:49 INFO - TinderboxPrint: I/O read bytes / time
31,022,080 / 192 06:57:49 INFO - TinderboxPrint: I/O write bytes / time
707,662,848 / 1,953 06:57:49 INFO - TinderboxPrint: CPU idle
2,233.3 (46.0%) 06:57:49 INFO - TinderboxPrint: CPU system
979.3 (20.2%) 06:57:49 INFO - TinderboxPrint: CPU user
1,641.1 (33.8%) 06:57:49 INFO - TinderboxPrint: Swap in / out
434,049,024 / 0 06:57:49 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 388377088; Write bytes: 383617024; Read time: 29225; Write time: 780 06:57:49 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 30100480; Write bytes: 297806848; Read time: 181; Write time: 1110 06:57:50 INFO - Running post-run listener: _upload_blobber_files 06:57:50 INFO - Blob upload gear active. 06:57:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:57:50 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 06:57:50 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'] 06:57:50 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 06:57:50 INFO - (blobuploader) - INFO - Open directory for files ... 06:57:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:57:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:57:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:57:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:57:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:57:51 INFO - (blobuploader) - INFO - Done attempting. 06:57:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:57:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:57:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:57:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:57:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:57:52 INFO - (blobuploader) - INFO - Done attempting. 06:57:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:57:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:57:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:57:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:57:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:57:54 INFO - (blobuploader) - INFO - Done attempting. 06:57:54 INFO - (blobuploader) - INFO - Iteration through files over. 06:57:54 INFO - Return code: 0 06:57:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:57:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:57:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b2837c732f088f73231f4de41b2b7baaa9e39a7c594d8445487b3b3f6bb7eb7956c2004d10037384d3faceb6bbfbde0f08ad12a8ee16eba010fa99965e376e11", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b1797a31d118042e3eb75b67fa06f7dceb05684976a7993741c5c6df489fc91af2f3993a660d66fb8ac7dbea65870174009bdc6e7b3eec8fa107fc95b1e4efb2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f122c9d76823c6704290fe6d0401f0f7d51c227f6d20679ce1a7be7b6d952dcd678ee5d26d95fff71eba95a68e78d477a89d42022709e166b23026974ab6fed4"} 06:57:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:57:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:57:54 INFO - Contents: 06:57:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b2837c732f088f73231f4de41b2b7baaa9e39a7c594d8445487b3b3f6bb7eb7956c2004d10037384d3faceb6bbfbde0f08ad12a8ee16eba010fa99965e376e11", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b1797a31d118042e3eb75b67fa06f7dceb05684976a7993741c5c6df489fc91af2f3993a660d66fb8ac7dbea65870174009bdc6e7b3eec8fa107fc95b1e4efb2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f122c9d76823c6704290fe6d0401f0f7d51c227f6d20679ce1a7be7b6d952dcd678ee5d26d95fff71eba95a68e78d477a89d42022709e166b23026974ab6fed4"} 06:57:54 INFO - Running post-run listener: copy_logs_to_upload_dir 06:57:54 INFO - Copying logs to upload dir... 06:57:54 INFO - mkdir: /builds/slave/test/build/upload/logs 06:57:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.605316 ========= master_lag: 1.57 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-09-01 06:57:56.457485) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 06:57:56.458995) ========= 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.s7Y8XVTt4n/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.N7UmSSKCVS/Listeners TMPDIR=/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b2837c732f088f73231f4de41b2b7baaa9e39a7c594d8445487b3b3f6bb7eb7956c2004d10037384d3faceb6bbfbde0f08ad12a8ee16eba010fa99965e376e11", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b1797a31d118042e3eb75b67fa06f7dceb05684976a7993741c5c6df489fc91af2f3993a660d66fb8ac7dbea65870174009bdc6e7b3eec8fa107fc95b1e4efb2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f122c9d76823c6704290fe6d0401f0f7d51c227f6d20679ce1a7be7b6d952dcd678ee5d26d95fff71eba95a68e78d477a89d42022709e166b23026974ab6fed4"} build_url:https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011148 build_url: 'https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b2837c732f088f73231f4de41b2b7baaa9e39a7c594d8445487b3b3f6bb7eb7956c2004d10037384d3faceb6bbfbde0f08ad12a8ee16eba010fa99965e376e11", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b1797a31d118042e3eb75b67fa06f7dceb05684976a7993741c5c6df489fc91af2f3993a660d66fb8ac7dbea65870174009bdc6e7b3eec8fa107fc95b1e4efb2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f122c9d76823c6704290fe6d0401f0f7d51c227f6d20679ce1a7be7b6d952dcd678ee5d26d95fff71eba95a68e78d477a89d42022709e166b23026974ab6fed4"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 06:57:56.500281) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:57:56.500624) ========= 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.s7Y8XVTt4n/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.N7UmSSKCVS/Listeners TMPDIR=/var/folders/qj/8bxn99110qxb41zzcmfgldl000000w/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.004969 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:57:56.549060) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 06:57:56.549394) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 06:57:56.549726) ========= ========= Total master_lag: 1.71 =========