builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0144 starttime: 1471411586.87 results: success (0) buildid: 20160816184814 builduid: 592a826c55c74914a83e942fc46db73c revision: d128f7f11636168460f27bf300658b1f3ed40fc2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 22:26:26.871917) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 22:26:26.873153) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 22:26:26.873973) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 22:26:26.901311) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 22:26:26.901916) ========= 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.TqTY2CJhIk/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.dqxKPEy9Xw/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-16 22:26:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.6M=0.001s 2016-08-16 22:26:27 (14.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129827 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 22:26:27.060012) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 22:26:27.060753) ========= 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.TqTY2CJhIk/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.dqxKPEy9Xw/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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.027556 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 22:26:27.114179) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-16 22:26:27.115056) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d128f7f11636168460f27bf300658b1f3ed40fc2 --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 d128f7f11636168460f27bf300658b1f3ed40fc2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TqTY2CJhIk/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.dqxKPEy9Xw/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-16 22:26:27,187 truncating revision to first 12 chars 2016-08-16 22:26:27,187 Setting DEBUG logging. 2016-08-16 22:26:27,187 attempt 1/10 2016-08-16 22:26:27,187 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d128f7f11636?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 22:26:28,930 unpacking tar archive at: fx-team-d128f7f11636/testing/mozharness/ program finished with exit code 0 elapsedTime=2.014604 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-16 22:26:29.157541) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 22:26:29.158329) ========= script_repo_revision: d128f7f11636168460f27bf300658b1f3ed40fc2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 22:26:29.159250) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 22:26:29.159672) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 22:26:29.179113) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-16 22:26:29.179708) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TqTY2CJhIk/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.dqxKPEy9Xw/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 22:26:29 INFO - MultiFileLogger online at 20160816 22:26:29 in /builds/slave/test 22:26:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:26:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:26:29 INFO - {'append_to_log': False, 22:26:29 INFO - 'base_work_dir': '/builds/slave/test', 22:26:29 INFO - 'blob_upload_branch': 'Fx-Team', 22:26:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:26:29 INFO - 'branch': 'Fx-Team', 22:26:29 INFO - 'buildbot_json_path': 'buildprops.json', 22:26:29 INFO - 'config_files': ('talos/mac_config.py',), 22:26:29 INFO - 'default_actions': ('clobber', 22:26:29 INFO - 'read-buildbot-config', 22:26:29 INFO - 'download-and-extract', 22:26:29 INFO - 'populate-webroot', 22:26:29 INFO - 'create-virtualenv', 22:26:29 INFO - 'install', 22:26:29 INFO - 'run-tests'), 22:26:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:26:29 INFO - 'download_minidump_stackwalk': True, 22:26:29 INFO - 'download_symbols': 'ondemand', 22:26:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:26:29 INFO - 'tooltool.py': '/tools/tooltool.py', 22:26:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:26:29 INFO - '/tools/misc-python/virtualenv.py')}, 22:26:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:26:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:26:29 INFO - 'installer_path': 'installer.exe', 22:26:29 INFO - 'log_level': 'info', 22:26:29 INFO - 'log_name': 'talos', 22:26:29 INFO - 'log_to_console': True, 22:26:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:26:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:26:29 INFO - 'opt_config_files': (), 22:26:29 INFO - 'pip_index': False, 22:26:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:26:29 INFO - 'cmd': ('bash', 22:26:29 INFO - '-c', 22:26:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:26:29 INFO - 'enabled': True, 22:26:29 INFO - 'halt_on_failure': False, 22:26:29 INFO - 'name': 'check_screen_resolution'},), 22:26:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:26:29 INFO - 'cmd': ('bash', 22:26:29 INFO - '-c', 22:26:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:26:29 INFO - 'enabled': True, 22:26:29 INFO - 'halt_on_failure': False, 22:26:29 INFO - 'name': 'check_screen_resolution'},), 22:26:29 INFO - 'run_cmd_checks_enabled': True, 22:26:29 INFO - 'sps_profile': False, 22:26:29 INFO - 'sps_profile_interval': 0, 22:26:29 INFO - 'suite': 'dromaeojs-e10s', 22:26:29 INFO - 'system_bits': '32', 22:26:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:26:29 INFO - 'title': 't-yosemite-r7-0144', 22:26:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:26:29 INFO - 'use_talos_json': True, 22:26:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:26:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:26:29 INFO - 'work_dir': 'build'} 22:26:29 INFO - [mozharness: 2016-08-17 05:26:29.374356Z] Running clobber step. 22:26:29 INFO - Running pre-action listener: _resource_record_pre_action 22:26:29 INFO - Running main action method: clobber 22:26:29 INFO - rmtree: /builds/slave/test/build 22:26:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:26:31 INFO - Running post-action listener: _resource_record_post_action 22:26:31 INFO - [mozharness: 2016-08-17 05:26:31.424442Z] Finished clobber step (success) 22:26:31 INFO - [mozharness: 2016-08-17 05:26:31.424570Z] Running read-buildbot-config step. 22:26:31 INFO - Running pre-action listener: _resource_record_pre_action 22:26:31 INFO - Running main action method: read_buildbot_config 22:26:31 INFO - Using buildbot properties: 22:26:31 INFO - { 22:26:31 INFO - "project": "", 22:26:31 INFO - "product": "firefox", 22:26:31 INFO - "script_repo_revision": "production", 22:26:31 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 22:26:31 INFO - "repository": "", 22:26:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 22:26:31 INFO - "buildid": "20160816184814", 22:26:31 INFO - "pgo_build": "False", 22:26:31 INFO - "basedir": "/builds/slave/test", 22:26:31 INFO - "buildnumber": 90, 22:26:31 INFO - "slavename": "t-yosemite-r7-0144", 22:26:31 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 22:26:31 INFO - "platform": "yosemite_r7", 22:26:31 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 22:26:31 INFO - "branch": "fx-team", 22:26:31 INFO - "repo_path": "integration/fx-team", 22:26:31 INFO - "revision": "d128f7f11636168460f27bf300658b1f3ed40fc2", 22:26:31 INFO - "stage_platform": "macosx64", 22:26:31 INFO - "builduid": "592a826c55c74914a83e942fc46db73c", 22:26:31 INFO - "slavebuilddir": "test" 22:26:31 INFO - } 22:26:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/U0j5oMbGRFqxKR6TpX-SXw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 22:26:31 INFO - Running post-action listener: _resource_record_post_action 22:26:31 INFO - [mozharness: 2016-08-17 05:26:31.428137Z] Finished read-buildbot-config step (success) 22:26:31 INFO - [mozharness: 2016-08-17 05:26:31.428271Z] Running download-and-extract step. 22:26:31 INFO - Running pre-action listener: _resource_record_pre_action 22:26:31 INFO - Running main action method: download_and_extract 22:26:31 INFO - mkdir: /builds/slave/test/build/tests 22:26:31 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')]} 22:26:31 INFO - trying https://queue.taskcluster.net/v1/task/U0j5oMbGRFqxKR6TpX-SXw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 22:26:31 INFO - Downloading https://queue.taskcluster.net/v1/task/U0j5oMbGRFqxKR6TpX-SXw/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 22:26:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U0j5oMbGRFqxKR6TpX-SXw/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 22:26:32 INFO - Downloaded 1199 bytes. 22:26:32 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 22:26:32 INFO - Using the following test package requirements: 22:26:32 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 22:26:32 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 22:26:32 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 22:26:32 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 22:26:32 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 22:26:32 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 22:26:32 INFO - u'jsshell-mac.zip'], 22:26:32 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 22:26:32 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 22:26:32 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 22:26:32 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 22:26:32 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 22:26:32 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 22:26:32 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 22:26:32 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 22:26:32 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 22:26:32 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 22:26:32 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 22:26:32 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:26:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:26:32 INFO - trying https://queue.taskcluster.net/v1/task/U0j5oMbGRFqxKR6TpX-SXw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 22:26:32 INFO - Downloading https://queue.taskcluster.net/v1/task/U0j5oMbGRFqxKR6TpX-SXw/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 22:26:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U0j5oMbGRFqxKR6TpX-SXw/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 22:26:33 INFO - Downloaded 16332153 bytes. 22:26:33 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 22:26:40 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 22:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:26:40 INFO - trying https://queue.taskcluster.net/v1/task/U0j5oMbGRFqxKR6TpX-SXw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 22:26:40 INFO - Downloading https://queue.taskcluster.net/v1/task/U0j5oMbGRFqxKR6TpX-SXw/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 22:26:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U0j5oMbGRFqxKR6TpX-SXw/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 22:26:41 INFO - Downloaded 16332153 bytes. 22:26:41 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 22:26:48 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')]} 22:26:48 INFO - trying https://queue.taskcluster.net/v1/task/U0j5oMbGRFqxKR6TpX-SXw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 22:26:48 INFO - Downloading https://queue.taskcluster.net/v1/task/U0j5oMbGRFqxKR6TpX-SXw/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 22:26:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U0j5oMbGRFqxKR6TpX-SXw/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 22:26:49 INFO - Downloaded 14413981 bytes. 22:26:49 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 22:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:26:49 INFO - trying https://queue.taskcluster.net/v1/task/U0j5oMbGRFqxKR6TpX-SXw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 22:26:49 INFO - Downloading https://queue.taskcluster.net/v1/task/U0j5oMbGRFqxKR6TpX-SXw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 22:26:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U0j5oMbGRFqxKR6TpX-SXw/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 22:26:52 INFO - Downloaded 111085620 bytes. 22:26:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U0j5oMbGRFqxKR6TpX-SXw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 22:26:52 INFO - mkdir: /builds/slave/test/properties 22:26:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:26:52 INFO - Writing to file /builds/slave/test/properties/build_url 22:26:52 INFO - Contents: 22:26:52 INFO - build_url:https://queue.taskcluster.net/v1/task/U0j5oMbGRFqxKR6TpX-SXw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 22:26:53 INFO - Running post-action listener: _resource_record_post_action 22:26:53 INFO - Running post-action listener: set_extra_try_arguments 22:26:53 INFO - [mozharness: 2016-08-17 05:26:53.184492Z] Finished download-and-extract step (success) 22:26:53 INFO - [mozharness: 2016-08-17 05:26:53.184631Z] Running populate-webroot step. 22:26:53 INFO - Running pre-action listener: _resource_record_pre_action 22:26:53 INFO - Running main action method: populate_webroot 22:26:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:26:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:26:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:26:53 INFO - '--tppagecycles', 22:26:53 INFO - '7'], 22:26:53 INFO - 'tests': ['tsvgm']}}, 22:26:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:26:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:26:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:26:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:26:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:26:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:26:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:53 INFO - 'talos_options': ['--disable-e10s'], 22:26:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:26:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:26:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:53 INFO - 'talos_options': ['--disable-e10s'], 22:26:53 INFO - 'tests': ['damp', 'tps']}, 22:26:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:53 INFO - 'tests': ['damp', 'tps']}, 22:26:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:26:53 INFO - 'tests': ['dromaeo_dom']}, 22:26:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:26:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:26:53 INFO - 'tests': ['basic_compositor_video']}, 22:26:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:26:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:26:53 INFO - 'tests': ['a11yr', 22:26:53 INFO - 'ts_paint', 22:26:53 INFO - 'tpaint', 22:26:53 INFO - 'sessionrestore', 22:26:53 INFO - 'sessionrestore_no_auto_restore', 22:26:53 INFO - 'tabpaint']}, 22:26:53 INFO - 'other-e10s': {'tests': ['a11yr', 22:26:53 INFO - 'ts_paint', 22:26:53 INFO - 'tpaint', 22:26:53 INFO - 'sessionrestore', 22:26:53 INFO - 'sessionrestore_no_auto_restore', 22:26:53 INFO - 'tabpaint']}, 22:26:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:26:53 INFO - 'ts_paint', 22:26:53 INFO - 'tpaint', 22:26:53 INFO - 'sessionrestore', 22:26:53 INFO - 'sessionrestore_no_auto_restore', 22:26:53 INFO - 'tabpaint']}, 22:26:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:26:53 INFO - 'ts_paint', 22:26:53 INFO - 'tpaint', 22:26:53 INFO - 'sessionrestore', 22:26:53 INFO - 'sessionrestore_no_auto_restore', 22:26:53 INFO - 'tabpaint']}, 22:26:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:26:53 INFO - 'tests': ['a11yr', 22:26:53 INFO - 'ts_paint', 22:26:53 INFO - 'tpaint', 22:26:53 INFO - 'sessionrestore', 22:26:53 INFO - 'sessionrestore_no_auto_restore', 22:26:53 INFO - 'tabpaint']}, 22:26:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:26:53 INFO - 'tests': ['a11yr', 22:26:53 INFO - 'ts_paint', 22:26:53 INFO - 'tpaint', 22:26:53 INFO - 'sessionrestore', 22:26:53 INFO - 'sessionrestore_no_auto_restore', 22:26:53 INFO - 'tabpaint']}, 22:26:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:26:53 INFO - 'tests': ['tsvgx', 22:26:53 INFO - 'tsvgr_opacity', 22:26:53 INFO - 'tart', 22:26:53 INFO - 'tscrollx', 22:26:53 INFO - 'cart']}, 22:26:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:26:53 INFO - 'tsvgr_opacity', 22:26:53 INFO - 'tart', 22:26:53 INFO - 'tscrollx', 22:26:53 INFO - 'cart']}, 22:26:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:53 INFO - 'talos_options': ['--disable-e10s'], 22:26:53 INFO - 'tests': ['tp5o']}, 22:26:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:53 INFO - 'tests': ['tp5o']}, 22:26:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:53 INFO - 'talos_options': ['--disable-e10s', 22:26:53 INFO - '--xperf_path', 22:26:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:26:53 INFO - 'tests': ['tp5n']}, 22:26:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:53 INFO - 'talos_options': ['--xperf_path', 22:26:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:26:53 INFO - 'tests': ['tp5n']}}, 22:26:53 INFO - 'talos.zip': {'path': '', 22:26:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:26:53 INFO - Running post-action listener: _resource_record_post_action 22:26:53 INFO - [mozharness: 2016-08-17 05:26:53.203319Z] Finished populate-webroot step (success) 22:26:53 INFO - [mozharness: 2016-08-17 05:26:53.203455Z] Running create-virtualenv step. 22:26:53 INFO - Running pre-action listener: _resource_record_pre_action 22:26:53 INFO - Running main action method: create_virtualenv 22:26:53 INFO - Creating virtualenv /builds/slave/test/build/venv 22:26:53 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 22:26:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:26:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:26:53 INFO - Using real prefix '/tools/python27' 22:26:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:26:54 INFO - Installing distribute.............................................................................................................................................................................................done. 22:26:56 INFO - Installing pip.................done. 22:26:56 INFO - Return code: 0 22:26:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:26:56 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')]} 22:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:56 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')]} 22:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:56 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 0x1074f3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107588618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1434a4320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107457d30>, '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 0x1071bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10744fb20>, '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.TqTY2CJhIk/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.dqxKPEy9Xw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 22:26:56 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 22:26:56 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 22:26:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TqTY2CJhIk/Render', 22:26:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:26:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:26:56 INFO - 'HOME': '/Users/cltbld', 22:26:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:26:56 INFO - 'LOGNAME': 'cltbld', 22:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:56 INFO - 'MOZ_NO_REMOTE': '1', 22:26:56 INFO - 'NO_EM_RESTART': '1', 22:26:56 INFO - 'PAGER': '/bin/cat', 22:26:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:26:56 INFO - 'PWD': '/builds/slave/test', 22:26:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:26:56 INFO - 'SHELL': '/bin/bash', 22:26:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dqxKPEy9Xw/Listeners', 22:26:56 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 22:26:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:26:56 INFO - 'USER': 'cltbld', 22:26:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:26:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:56 INFO - 'XPC_FLAGS': '0x0', 22:26:56 INFO - 'XPC_SERVICE_NAME': '0', 22:26:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:57 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 22:26:57 INFO - Cleaning up... 22:26:57 INFO - Return code: 0 22:26:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:26:57 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')]} 22:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:57 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')]} 22:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:57 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 0x1074f3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107588618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1434a4320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107457d30>, '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 0x1071bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10744fb20>, '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.TqTY2CJhIk/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.dqxKPEy9Xw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 22:26:57 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 22:26:57 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 22:26:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TqTY2CJhIk/Render', 22:26:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:26:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:26:57 INFO - 'HOME': '/Users/cltbld', 22:26:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:26:57 INFO - 'LOGNAME': 'cltbld', 22:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:57 INFO - 'MOZ_NO_REMOTE': '1', 22:26:57 INFO - 'NO_EM_RESTART': '1', 22:26:57 INFO - 'PAGER': '/bin/cat', 22:26:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:26:57 INFO - 'PWD': '/builds/slave/test', 22:26:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:26:57 INFO - 'SHELL': '/bin/bash', 22:26:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dqxKPEy9Xw/Listeners', 22:26:57 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 22:26:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:26:57 INFO - 'USER': 'cltbld', 22:26:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:26:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:57 INFO - 'XPC_FLAGS': '0x0', 22:26:57 INFO - 'XPC_SERVICE_NAME': '0', 22:26:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:57 INFO - Downloading/unpacking psutil>=3.1.1 22:26:57 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 22:26:57 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 22:26:57 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 22:26:57 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 22:26:57 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 22:26:57 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 22:27:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:27:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:27:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:27:00 INFO - Installing collected packages: psutil 22:27:00 INFO - Running setup.py install for psutil 22:27:00 INFO - building 'psutil._psutil_osx' extension 22:27:00 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 22:27:01 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 22:27:01 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 22:27:01 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 22:27:01 INFO - building 'psutil._psutil_posix' extension 22:27:01 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 22:27:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:27:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:27:01 INFO - ^ 22:27:01 INFO - 1 warning generated. 22:27:01 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 22:27:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:27:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:27:02 INFO - Successfully installed psutil 22:27:02 INFO - Cleaning up... 22:27:02 INFO - Return code: 0 22:27:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:27:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:02 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 0x1074f3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107588618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1434a4320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107457d30>, '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 0x1071bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10744fb20>, '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.TqTY2CJhIk/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.dqxKPEy9Xw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 22:27:02 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 22:27:02 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 22:27:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TqTY2CJhIk/Render', 22:27:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:27:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:27:02 INFO - 'HOME': '/Users/cltbld', 22:27:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:27:02 INFO - 'LOGNAME': 'cltbld', 22:27:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:02 INFO - 'MOZ_NO_REMOTE': '1', 22:27:02 INFO - 'NO_EM_RESTART': '1', 22:27:02 INFO - 'PAGER': '/bin/cat', 22:27:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:27:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:02 INFO - 'PWD': '/builds/slave/test', 22:27:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:27:02 INFO - 'SHELL': '/bin/bash', 22:27:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dqxKPEy9Xw/Listeners', 22:27:02 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 22:27:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:27:02 INFO - 'USER': 'cltbld', 22:27:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:27:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:27:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:02 INFO - 'XPC_FLAGS': '0x0', 22:27:02 INFO - 'XPC_SERVICE_NAME': '0', 22:27:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:27:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:27:02 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 22:27:02 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 22:27:02 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 22:27:02 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 22:27:02 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 22:27:02 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 22:27:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:27:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:27:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:27:04 INFO - Installing collected packages: mozsystemmonitor 22:27:04 INFO - Running setup.py install for mozsystemmonitor 22:27:04 INFO - Successfully installed mozsystemmonitor 22:27:04 INFO - Cleaning up... 22:27:05 INFO - Return code: 0 22:27:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:27:05 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')]} 22:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:05 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')]} 22:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:05 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 0x1074f3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107588618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1434a4320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107457d30>, '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 0x1071bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10744fb20>, '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.TqTY2CJhIk/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.dqxKPEy9Xw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 22:27:05 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 22:27:05 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 22:27:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TqTY2CJhIk/Render', 22:27:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:27:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:27:05 INFO - 'HOME': '/Users/cltbld', 22:27:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:27:05 INFO - 'LOGNAME': 'cltbld', 22:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:05 INFO - 'MOZ_NO_REMOTE': '1', 22:27:05 INFO - 'NO_EM_RESTART': '1', 22:27:05 INFO - 'PAGER': '/bin/cat', 22:27:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:05 INFO - 'PWD': '/builds/slave/test', 22:27:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:27:05 INFO - 'SHELL': '/bin/bash', 22:27:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dqxKPEy9Xw/Listeners', 22:27:05 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 22:27:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:27:05 INFO - 'USER': 'cltbld', 22:27:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:27:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:05 INFO - 'XPC_FLAGS': '0x0', 22:27:05 INFO - 'XPC_SERVICE_NAME': '0', 22:27:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:05 INFO - Downloading/unpacking jsonschema==2.5.1 22:27:05 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 22:27:05 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 22:27:05 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 22:27:05 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 22:27:05 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 22:27:05 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 22:27:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:27:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:27:07 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 22:27:07 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 22:27:07 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 22:27:07 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 22:27:07 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 22:27:07 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 22:27:08 INFO - Downloading functools32-3.2.3-2.tar.gz 22:27:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:27:08 INFO - warning: no files found matching '*.txt' 22:27:08 INFO - no previously-included directories found matching 'build' 22:27:08 INFO - no previously-included directories found matching 'dist' 22:27:08 INFO - no previously-included directories found matching '.git*' 22:27:08 INFO - Installing collected packages: jsonschema, functools32 22:27:08 INFO - Running setup.py install for functools32 22:27:08 INFO - warning: no files found matching '*.txt' 22:27:08 INFO - no previously-included directories found matching 'build' 22:27:08 INFO - no previously-included directories found matching 'dist' 22:27:08 INFO - no previously-included directories found matching '.git*' 22:27:08 INFO - Successfully installed jsonschema functools32 22:27:08 INFO - Cleaning up... 22:27:08 INFO - Return code: 0 22:27:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:27: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')]} 22:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27: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')]} 22:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27: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', '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 0x1074f3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107588618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1434a4320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107457d30>, '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 0x1071bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10744fb20>, '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.TqTY2CJhIk/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.dqxKPEy9Xw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 22:27: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:27: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 functools32==3.2.3-2 22:27:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TqTY2CJhIk/Render', 22:27:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:27:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:27:08 INFO - 'HOME': '/Users/cltbld', 22:27:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:27:08 INFO - 'LOGNAME': 'cltbld', 22:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:08 INFO - 'MOZ_NO_REMOTE': '1', 22:27:08 INFO - 'NO_EM_RESTART': '1', 22:27:08 INFO - 'PAGER': '/bin/cat', 22:27:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:08 INFO - 'PWD': '/builds/slave/test', 22:27:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:27:08 INFO - 'SHELL': '/bin/bash', 22:27:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dqxKPEy9Xw/Listeners', 22:27:08 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 22:27:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:27:08 INFO - 'USER': 'cltbld', 22:27:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:27:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:08 INFO - 'XPC_FLAGS': '0x0', 22:27:08 INFO - 'XPC_SERVICE_NAME': '0', 22:27:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:27:08 INFO - Cleaning up... 22:27:08 INFO - Return code: 0 22:27:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:27: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')]} 22:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27: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')]} 22:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27: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', '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 0x1074f3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107588618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1434a4320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107457d30>, '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 0x1071bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10744fb20>, '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.TqTY2CJhIk/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.dqxKPEy9Xw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 22:27: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:27: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 blobuploader==1.2.4 22:27:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TqTY2CJhIk/Render', 22:27:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:27:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:27:08 INFO - 'HOME': '/Users/cltbld', 22:27:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:27:08 INFO - 'LOGNAME': 'cltbld', 22:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:08 INFO - 'MOZ_NO_REMOTE': '1', 22:27:08 INFO - 'NO_EM_RESTART': '1', 22:27:08 INFO - 'PAGER': '/bin/cat', 22:27:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:08 INFO - 'PWD': '/builds/slave/test', 22:27:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:27:08 INFO - 'SHELL': '/bin/bash', 22:27:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dqxKPEy9Xw/Listeners', 22:27:08 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 22:27:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:27:08 INFO - 'USER': 'cltbld', 22:27:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:27:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:08 INFO - 'XPC_FLAGS': '0x0', 22:27:08 INFO - 'XPC_SERVICE_NAME': '0', 22:27:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:09 INFO - Downloading/unpacking blobuploader==1.2.4 22:27: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 22:27: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 22:27: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 22:27: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 22:27: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 22:27: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 22:27:11 INFO - Downloading blobuploader-1.2.4.tar.gz 22:27:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:27:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:27:11 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 22:27:11 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 22:27:11 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 22:27:11 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 22:27:11 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 22:27:11 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 22:27:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:27:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:12 INFO - Downloading docopt-0.6.1.tar.gz 22:27:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:27:12 INFO - Installing collected packages: blobuploader, requests, docopt 22:27:12 INFO - Running setup.py install for blobuploader 22:27:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:27:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:27:12 INFO - Running setup.py install for requests 22:27:13 INFO - Running setup.py install for docopt 22:27:13 INFO - Successfully installed blobuploader requests docopt 22:27:13 INFO - Cleaning up... 22:27:13 INFO - Return code: 0 22:27:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:27: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')]} 22:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27: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')]} 22:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:13 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 0x1074f3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107588618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1434a4320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107457d30>, '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 0x1071bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10744fb20>, '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.TqTY2CJhIk/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.dqxKPEy9Xw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 22:27:13 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 22:27:13 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 22:27:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TqTY2CJhIk/Render', 22:27:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:27:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:27:13 INFO - 'HOME': '/Users/cltbld', 22:27:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:27:13 INFO - 'LOGNAME': 'cltbld', 22:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:13 INFO - 'MOZ_NO_REMOTE': '1', 22:27:13 INFO - 'NO_EM_RESTART': '1', 22:27:13 INFO - 'PAGER': '/bin/cat', 22:27:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:13 INFO - 'PWD': '/builds/slave/test', 22:27:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:27:13 INFO - 'SHELL': '/bin/bash', 22:27:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dqxKPEy9Xw/Listeners', 22:27:13 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 22:27:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:27:13 INFO - 'USER': 'cltbld', 22:27:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:27:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:13 INFO - 'XPC_FLAGS': '0x0', 22:27:13 INFO - 'XPC_SERVICE_NAME': '0', 22:27:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:27:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:27:13 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-E5T_HO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:27:14 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-PTenMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:27:14 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-APpvy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:27:14 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-D_6B9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:27:14 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-26oMyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:27:14 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-8zIBp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:27:14 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-DD6aiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:27:14 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-RkTlJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:27:14 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-Zum1uZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:27:14 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-pEFQ1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:27:14 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-CPFVBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:27:15 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-B8aw1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:27:15 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-cSmANS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:27:15 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-1gH32B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:27:15 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-Uxeabw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:27:15 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-rNUqvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:27:15 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-e2HAAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:27:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:27:15 INFO - Running setup.py install for manifestparser 22:27:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:27:15 INFO - Running setup.py install for mozcrash 22:27:15 INFO - Running setup.py install for mozdebug 22:27:16 INFO - Running setup.py install for mozdevice 22:27:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:27:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:27:16 INFO - Running setup.py install for mozfile 22:27:16 INFO - Running setup.py install for mozhttpd 22:27:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:27:16 INFO - Running setup.py install for mozinfo 22:27:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:27:16 INFO - Running setup.py install for mozInstall 22:27:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:27:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:27:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:27:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:27:16 INFO - Running setup.py install for mozleak 22:27:17 INFO - Running setup.py install for mozlog 22:27:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:27:17 INFO - Running setup.py install for moznetwork 22:27:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:27:17 INFO - Running setup.py install for mozprocess 22:27:17 INFO - Running setup.py install for mozprofile 22:27:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:27:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:27:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:27:17 INFO - Running setup.py install for mozrunner 22:27:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:27:17 INFO - Running setup.py install for mozscreenshot 22:27:17 INFO - Running setup.py install for moztest 22:27:18 INFO - Running setup.py install for mozversion 22:27:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:27:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:27:18 INFO - Cleaning up... 22:27:18 INFO - Return code: 0 22:27:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:27:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:18 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 0x1074f3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107588618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1434a4320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107457d30>, '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 0x1071bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10744fb20>, '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.TqTY2CJhIk/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.dqxKPEy9Xw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 22:27:18 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 22:27:18 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 22:27:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TqTY2CJhIk/Render', 22:27:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:27:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:27:18 INFO - 'HOME': '/Users/cltbld', 22:27:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:27:18 INFO - 'LOGNAME': 'cltbld', 22:27:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:18 INFO - 'MOZ_NO_REMOTE': '1', 22:27:18 INFO - 'NO_EM_RESTART': '1', 22:27:18 INFO - 'PAGER': '/bin/cat', 22:27:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:27:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:18 INFO - 'PWD': '/builds/slave/test', 22:27:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:27:18 INFO - 'SHELL': '/bin/bash', 22:27:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dqxKPEy9Xw/Listeners', 22:27:18 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 22:27:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:27:18 INFO - 'USER': 'cltbld', 22:27:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:27:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:27:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:18 INFO - 'XPC_FLAGS': '0x0', 22:27:18 INFO - 'XPC_SERVICE_NAME': '0', 22:27:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:27:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:27:18 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-exY8TW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:27:19 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)) 22:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:27:19 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-qTnvjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:27:19 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)) 22:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:27:19 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-plIijA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:27:19 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)) 22:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:27:19 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-MEKNnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:27:19 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)) 22:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:27:19 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-ee0DZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:27:19 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)) 22:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:27:19 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-xFaXJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:27:19 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)) 22:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:27:19 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-XQ6CAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:27:19 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)) 22:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:27:19 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-PgJHPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:27:19 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)) 22:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:27:19 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-ZHHf9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:27:19 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)) 22:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:27:19 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-tan_cL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:27:20 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)) 22:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:27:20 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-EkarfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:27:20 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)) 22:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:27:20 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-4hGUbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:27:20 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)) 22:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:27:20 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-tWGRPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:27:20 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)) 22:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:27:20 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-zGRzdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:27:20 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)) 22:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:27:20 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-vXLI6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:27:20 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)) 22:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:27:20 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-UAkyxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:27:20 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)) 22:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:27:20 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-eFzyJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:27:20 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)) 22:27:20 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)) 22:27:20 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)) 22:27:20 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)) 22:27:20 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)) 22:27:20 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)) 22:27:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:27: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 22:27: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 22:27: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 22:27: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 22:27: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 22:27: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 22:27:23 INFO - Downloading blessings-1.6.tar.gz 22:27:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:27:23 INFO - Installing collected packages: blessings 22:27:23 INFO - Running setup.py install for blessings 22:27:23 INFO - Successfully installed blessings 22:27:23 INFO - Cleaning up... 22:27:23 INFO - Return code: 0 22:27:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:27:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:27:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:27:24 INFO - Reading from file tmpfile_stdout 22:27:24 INFO - Current package versions: 22:27:24 INFO - blessings == 1.6 22:27:24 INFO - blobuploader == 1.2.4 22:27:24 INFO - docopt == 0.6.1 22:27:24 INFO - functools32 == 3.2.3-2 22:27:24 INFO - jsonschema == 2.5.1 22:27:24 INFO - manifestparser == 1.1 22:27:24 INFO - mozInstall == 1.12 22:27:24 INFO - mozcrash == 0.17 22:27:24 INFO - mozdebug == 0.1 22:27:24 INFO - mozdevice == 0.48 22:27:24 INFO - mozfile == 1.2 22:27:24 INFO - mozhttpd == 0.7 22:27:24 INFO - mozinfo == 0.9 22:27:24 INFO - mozleak == 0.1 22:27:24 INFO - mozlog == 3.3 22:27:24 INFO - moznetwork == 0.27 22:27:24 INFO - mozprocess == 0.23 22:27:24 INFO - mozprofile == 0.28 22:27:24 INFO - mozrunner == 6.12 22:27:24 INFO - mozscreenshot == 0.1 22:27:24 INFO - mozsystemmonitor == 0.3 22:27:24 INFO - moztest == 0.7 22:27:24 INFO - mozversion == 1.4 22:27:24 INFO - psutil == 3.1.1 22:27:24 INFO - requests == 1.2.3 22:27:24 INFO - wsgiref == 0.1.2 22:27:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:24 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 0x1074f3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107588618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1434a4320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107457d30>, '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 0x1071bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10744fb20>, '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.TqTY2CJhIk/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.dqxKPEy9Xw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 22:27:24 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 22:27:24 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 22:27:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TqTY2CJhIk/Render', 22:27:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:27:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:27:24 INFO - 'HOME': '/Users/cltbld', 22:27:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:27:24 INFO - 'LOGNAME': 'cltbld', 22:27:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:24 INFO - 'MOZ_NO_REMOTE': '1', 22:27:24 INFO - 'NO_EM_RESTART': '1', 22:27:24 INFO - 'PAGER': '/bin/cat', 22:27:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:27:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:24 INFO - 'PWD': '/builds/slave/test', 22:27:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:27:24 INFO - 'SHELL': '/bin/bash', 22:27:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dqxKPEy9Xw/Listeners', 22:27:24 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 22:27:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:27:24 INFO - 'USER': 'cltbld', 22:27:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:27:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:27:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:24 INFO - 'XPC_FLAGS': '0x0', 22:27:24 INFO - 'XPC_SERVICE_NAME': '0', 22:27:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:27:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:24 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)) 22:27:24 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)) 22:27:24 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)) 22:27:24 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)) 22:27:24 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)) 22:27:24 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)) 22:27:24 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)) 22:27:24 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)) 22:27:24 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)) 22:27:24 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)) 22:27:24 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)) 22:27:24 INFO - Cleaning up... 22:27:24 INFO - Return code: 0 22:27:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1074f3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107588618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1434a4320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107457d30>, '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 0x1071bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10744fb20>, '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.TqTY2CJhIk/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.dqxKPEy9Xw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 22:27:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:27:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:27:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TqTY2CJhIk/Render', 22:27:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:27:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:27:24 INFO - 'HOME': '/Users/cltbld', 22:27:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:27:24 INFO - 'LOGNAME': 'cltbld', 22:27:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:24 INFO - 'MOZ_NO_REMOTE': '1', 22:27:24 INFO - 'NO_EM_RESTART': '1', 22:27:24 INFO - 'PAGER': '/bin/cat', 22:27:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:27:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:24 INFO - 'PWD': '/builds/slave/test', 22:27:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:27:24 INFO - 'SHELL': '/bin/bash', 22:27:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dqxKPEy9Xw/Listeners', 22:27:24 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 22:27:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:27:24 INFO - 'USER': 'cltbld', 22:27:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:27:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:27:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:24 INFO - 'XPC_FLAGS': '0x0', 22:27:24 INFO - 'XPC_SERVICE_NAME': '0', 22:27:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:27:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:27:24 INFO - Cleaning up... 22:27:24 INFO - Return code: 0 22:27:24 INFO - Running post-action listener: _resource_record_post_action 22:27:24 INFO - Running post-action listener: _start_resource_monitoring 22:27:24 INFO - Starting resource monitoring. 22:27:24 INFO - [mozharness: 2016-08-17 05:27:24.802065Z] Finished create-virtualenv step (success) 22:27:24 INFO - [mozharness: 2016-08-17 05:27:24.803104Z] Running install step. 22:27:24 INFO - Running pre-action listener: _resource_record_pre_action 22:27:24 INFO - Running main action method: install 22:27:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:27:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:27:25 INFO - Reading from file tmpfile_stdout 22:27:25 INFO - Detecting whether we're running mozinstall >=1.0... 22:27:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:27:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:27:25 INFO - Reading from file tmpfile_stdout 22:27:25 INFO - Output received: 22:27:25 INFO - Usage: mozinstall [options] installer 22:27:25 INFO - Options: 22:27:25 INFO - -h, --help show this help message and exit 22:27:25 INFO - -d DEST, --destination=DEST 22:27:25 INFO - Directory to install application into. [default: 22:27:25 INFO - "/builds/slave/test"] 22:27:25 INFO - --app=APP Application being installed. [default: firefox] 22:27:25 INFO - mkdir: /builds/slave/test/build/application 22:27:25 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'] 22:27:25 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 22:27:59 INFO - Reading from file tmpfile_stdout 22:27:59 INFO - Output received: 22:27:59 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:27:59 INFO - Running post-action listener: _resource_record_post_action 22:27:59 INFO - [mozharness: 2016-08-17 05:27:59.235059Z] Finished install step (success) 22:27:59 INFO - [mozharness: 2016-08-17 05:27:59.235210Z] Running run-tests step. 22:27:59 INFO - Running pre-action listener: _resource_record_pre_action 22:27:59 INFO - Running main action method: run_tests 22:27:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:27:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:27:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:27:59 INFO - 2016-08-16 22:27:59.249 screenresolution[1626:7453] starting screenresolution argv=screenresolution get 22:27:59 INFO - 2016-08-16 22:27:59.252 screenresolution[1626:7453] Display 0: 1600x1200x32@60 22:27:59 INFO - 2016-08-16 22:27:59.258 screenresolution[1627:7455] starting screenresolution argv=screenresolution list 22:27:59 INFO - Available Modes on Display 0 22:27:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:27:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:27:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:27:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:27:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:27:59 INFO - Intel Iris: 22:27:59 INFO - Chipset Model: Intel Iris 22:27:59 INFO - Type: GPU 22:27:59 INFO - Bus: Built-In 22:27:59 INFO - VRAM (Dynamic, Max): 1536 MB 22:27:59 INFO - Vendor: Intel (0x8086) 22:27:59 INFO - Device ID: 0x0a2e 22:27:59 INFO - Revision ID: 0x0009 22:27:59 INFO - Displays: 22:27:59 INFO - Display: 22:27:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:27:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:27:59 INFO - Display Serial Number: 1600x1200 60 22:27:59 INFO - Main Display: Yes 22:27:59 INFO - Mirror: Off 22:27:59 INFO - Online: Yes 22:27:59 INFO - Rotation: Supported 22:27:59 INFO - Return code: 0 22:27:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:27:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:27:59 INFO - Python 2.7.3 22:27:59 INFO - Return code: 0 22:27:59 INFO - grabbing minidump binary from tooltool 22:27: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')]} 22:27:59 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 0x107457d30>, '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 0x1071bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10744fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:27:59 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 22:27:59 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 22:27:59 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 22:27:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:27:59 INFO - Return code: 0 22:27:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:27:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:27:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:27:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:27:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:27:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U0j5oMbGRFqxKR6TpX-SXw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0144', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:27:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U0j5oMbGRFqxKR6TpX-SXw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0144 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:27:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TqTY2CJhIk/Render', 22:27:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:27:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:27:59 INFO - 'HOME': '/Users/cltbld', 22:27:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:27:59 INFO - 'LOGNAME': 'cltbld', 22:27:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:27:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:59 INFO - 'MOZ_NO_REMOTE': '1', 22:27:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:27:59 INFO - 'NO_EM_RESTART': '1', 22:27:59 INFO - 'PAGER': '/bin/cat', 22:27:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:59 INFO - 'PWD': '/builds/slave/test', 22:27:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:27:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:27:59 INFO - 'SHELL': '/bin/bash', 22:27:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dqxKPEy9Xw/Listeners', 22:27:59 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 22:27:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:27:59 INFO - 'USER': 'cltbld', 22:27:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:27:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:59 INFO - 'XPC_FLAGS': '0x0', 22:27:59 INFO - 'XPC_SERVICE_NAME': '0', 22:27:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:27:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U0j5oMbGRFqxKR6TpX-SXw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0144', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:27:59 INFO - mozversion application_buildid: 20160816184814 22:27:59 INFO - mozversion application_changeset: d128f7f11636168460f27bf300658b1f3ed40fc2 22:27:59 INFO - mozversion application_display_name: Nightly 22:27:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:27:59 INFO - mozversion application_name: Firefox 22:27:59 INFO - mozversion application_remotingname: firefox 22:27:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:27:59 INFO - mozversion application_vendor: Mozilla 22:27:59 INFO - mozversion application_version: 51.0a1 22:27:59 INFO - mozversion platform_buildid: 20160816184814 22:27:59 INFO - mozversion platform_changeset: d128f7f11636168460f27bf300658b1f3ed40fc2 22:27:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:27:59 INFO - mozversion platform_version: 51.0a1 22:27:59 INFO - using testdate: 1471411679 22:27:59 INFO - actual date: 1471411679 22:27:59 INFO - starting webserver on 'localhost:49266' 22:27:59 INFO - SUITE-START | Running 2 tests 22:27:59 INFO - TEST-START | dromaeo_css 22:27:59 INFO - operating with platform_type : mac_ 22:27:59 INFO - Initialising browser for dromaeo_css test... 22:27:59 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmpj32wez/profile http://localhost:49266/getInfo.html) 22:28:02 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 22:28:02 INFO - PROCESS | 1637 | colorDepth:24 22:28:02 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 22:28:02 INFO - PROCESS | 1637 | __metrics 22:28:02 ERROR - PROCESS | 1637 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 22:28:03 INFO - TEST-INFO | 1637: exit 0 22:28:03 INFO - Browser initialized. 22:28:03 INFO - Running cycle 1/1 for dromaeo_css test... 22:28:03 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmpj32wez/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:28:15 INFO - PROCESS | 1640 | RSS: Main: 236642304 22:28:15 INFO - PROCESS | 1640 | 22:29:04 INFO - PROCESS | 1640 | 1471411744970 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] 22:31:17 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 22:31:18 INFO - PROCESS | 1640 | RSS: Main: 253399040 22:31:18 INFO - PROCESS | 1640 | 22:34:21 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 22:34:21 INFO - PROCESS | 1640 | RSS: Main: 264413184 22:34:21 INFO - PROCESS | 1640 | 22:37:23 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 22:37:24 INFO - PROCESS | 1640 | RSS: Main: 268513280 22:37:24 INFO - PROCESS | 1640 | 22:40:26 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 22:40:26 INFO - PROCESS | 1640 | RSS: Main: 268161024 22:40:26 INFO - PROCESS | 1640 | 22:43:29 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 22:43:30 INFO - PROCESS | 1640 | RSS: Main: 274378752 22:43:30 INFO - PROCESS | 1640 | 22:46:32 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 22:46:33 INFO - PROCESS | 1640 | RSS: Main: 276963328 22:46:33 INFO - PROCESS | 1640 | 22:46:33 INFO - PROCESS | 1640 | __start_tp_report 22:46:33 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 22:46:33 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 22:46:33 INFO - PROCESS | 1640 | |i|pagename|runs| 22:46:33 INFO - PROCESS | 1640 | |0;dojo.html;3422.8459719312627;3424.640412756659;3461.567304086989;3482.7387945904056;3500.2299494111317;5742.167385729067;5786.218860453842;5795.71021448928;5824.068149096145;5877.441643043904;5741.995150848606;5817.331006934204;5863.882722345551;5911.261092363455;5964.582479226456;5215.921761173586;5245.10833158364;5284.44513326101;5326.067938110835;5366;4703.247480403119;5256.816011439581;5334.866628334304;5369;5422.05114105032;5151.330327057496;5183.663061900965;5316.893662126736;5321.1752178412025;5333.653312534673;5195.376554813409;5220.425753167148;5235.55497782689;5236.842894713165;5307.73461326936;5154.4587818278915;5206.088934436459;5230.424653288135;5329.467053294639;5346.572274218053;5112.309838171836;5788.739506722208;5870.794522191745;5871.500922421599;5911.940880591182;6128.804883047807;6150.600210986317;6164.6917654117115;6182.350853160398;6199.535034872402;6241.3446588108045;6241.438270555672;6247.969085100998;6257;6261.812145635638;4915.336429581961;5768.625039372428;5855.765769369263;5912.9113063304085;5928.881422371528;6386.776462823872;6390.392912673288;6391.360863913572;6398.968005160037;6412.839679008062;6151.200343955346;6171.105189747551;6188.1027251048345;6192.0711893215475;6197.194364732646;4651.883702907455;6059.303180134253;6137.232845894263;6194.690265486708;6229.813105606839;5077.8730531737;6140.785072522441;6246.875062498724;6250.874982500415;6254.530910181755;6110.694465276719;6142.600730952474;6188.659623720649;6189.319174890758;6262.718177682015;4871.926921096187;4911.582515486152;4926;4984;5025.698458092526;3662.359087159736;4311.2239796836875;4416.11677664462;4493.88765280864;4520.932186017212;5830.562707796932;5864.765409383662;5879.52963762898;5896.557758168069;5899.380565040609;6115.635867915819;6145.385461453909;6153.661548614869;6240.875182496416;6254.718537665816;5890.204822349014;5910.586258961831;5912.142739302777;5919.763209471573;5975.223220981245;5480.698561579072;5499.422560631157;5508.256385387921;5508.641938274;5526.50261476461;6184.5052395809125;6344.30212676596;6374.139491168633;6416.486681065504;6440.098386225932;6252.968735156295;6255.249370075438;6267.185265915402;6273.341299163522;6273.341299163522;6429.58207716497;6476.287608362982;6477.514186435942;6484;6485.189351331083;6074.605150665193;6131.386861313833;6142.222533142175;6194.504439644727;6207.720652570735;5886.805230502716;6154.230721159855;6199.659018754011;6247.375262473716;6263.74945002213;6127.111568822406;6129.938700612936;6167.105769663463;6214.316425193316;6220.098085777628;6001.939980600138;6061.515078793774;6090.9390906090375;6199.039148931923;6206.255249370104;5443.891122177455;5758.856028599319;6016.127661488972;6089.756409743561;6138.6009909357535;6158.846028849314;6160.44555989963;6172.969135154295;6186.752529898754;6212.565120441525;5801.274840644919;5851.824445266649;5914.822555323347;6062.181605483203;6067.453929146398 22:46:33 INFO - PROCESS | 1640 | |1;ext.html;496.2531390257662;511.81770111043494;545.4926917966292;562.3561022629087;570.1561688700723;38468.61531384689;41633.58366416335;41813.58186418139;41985.58014419859;42092.789536052354;42550.93622659435;42573.14853702924;42981.785091074504;43080;43122.92192695184;9701.85447218294;9852.211823054138;9889.554970026331;9912.207023438108;9933.801323973552;9757.902420975806;9759.707208783748;9774.951125244364;9873.308868379216;9878.950605246999;9739.220862331033;9832.950835245814;9843.70468885931;9860.21118310537;9863.753406164831;9036.638534458647;9239.399439036475;9820.067093626094;9839.163671087967;9885.25860560461;8292.460990035628;9657.275704322205;9774.218062554979;9775.120239178437;9791.314607977445;39791.8010409949;39955.40066898999;40186.19627607431;40218.39672404887;40346.394804077965;2537.8857951392233;3154.952675709866;3364.899053028413;3448.9482657760154;3856.9421458678144;30480.695193048006;30519.69480305191;30531.93138240173;30682.693173068208;30928.845355773075;2709.566469364912;3092.072378286505;3127.390158919012;3146.716795488394;3210.213497693057;122878.15682764766;167473;167726;167809;168262;32995.67004329974;33130.834345828116;33387;33454;33474.82838100655;30121.849390752905;30974.380512389627;34651;34859;35126.12184695403;15392;15818.97176683535;15828.683426331409;15881.682366352608;15891.205439727968;12021.699457513632;12023.579174728842;12056.397180141134;12095.818562721566;12135.271883687006;18823.152958116916;18940.905295473436;19121.330753423565;19228.903855480632;19295.51761205953;6675.833104172338;7124;7406.556066360248;8109.026916770025;8157.009494615628;772.6947855597008;965.8458142519621;1012.2559918460073;1042.8122937871103;1095.8137116690182;28364.00725974581;30395.936142234914;30878;31186.220344491114;31344.715325927853;992.93545919515;1004.6570556124714;1007.6926537406162;1049.9370037797758;1131.338167172197;15071.773923391158;15593.220338983005;15669.60825979337;15874.920625396799;16054.27755750994;691194;697367;697951;699500;700370;58091.70954145202;58398.12402813961;58527.41472585305;59384;59396.40603593995;1326.409747662281;1333.1334632488765;1361.101672895884;1363.379662253692;1363.5977386670957;24583.754162458146;26566.203013909613;29848.403031938804;30215.395692086477;30563.694363056973;50516.49483505265;50877.745611271705;51241.48758512516;51286.23070654018;51315;626337;626527;626709;627890;629341;26639.334016648965;26676.466470670865;27029.324266893484;27079.323016923947;27094.72905270922;46970.76514617405;47644.285335720684;48181;48336;49025;39378.40932385959;39628.2074358517;39914.80042599768;40449.39325910055;40841.79579102086;39173.41239881347;39494;39976.800115999235;40389.294403893924;40750.79624601858;38871.6112838868;39216;39362.2127557453;39779.80110099431;40283;33149;35085.122871928404;35731.821340893126;35881.1029724259;35894.28211435809;25930.611040834025;26179.214623561325;26434.339141520846;26563.203103906915;27128.186154415398 22:46:33 INFO - PROCESS | 1640 | |2;jquery.html;371.18154469395006;374.7788804605283;377.68840706417205;383.55890725665466;400.2834925483385;15531.92234038831;18720.149960615392;19792.703109453334;20778.16887324509;20988.26541071061;19714.704279435784;19890;20057.197712091536;20080.39758807238;20328.69506957397;5297.788088476456;5762.481376676109;5928.170056192136;5967.313758917737;6065.029595264758;4981.701097934118;5015.297858299841;5636.605437619368;5812.941870581303;6032.577719559633;5921.082232254007;6022.6687532185715;6041.818745437644;6042.637441753487;6056.666883321415;5919.526437884981;5962.582619216657;5998.670073145975;6032.728527216286;6044.244469441298;5660.150977353389;5838.9124163137585;5859.033259512175;5940.881182376328;5943.554233432466;12903.483860645563;13174.934125329311;13211.273379964097;19709.901450492798;25511;2322.3149170994598;2719.428919926818;2960.5559166125254;2965.4069186162637;2972.390659914734;8097.838043239161;9919.107280344804;10098.949505252427;10166.237532185041;10219.79560408795;1843.7050071988551;1877.8216069473378;1885.4532185666278;1905.6474552207885;1974.9605007899904;106971;112815.30777038352;114091;116072;116275.4186229072;11044.502997365138;11260.887391126147;11302.717432064099;11344.886551134383;11390.25963312382;11032.172587056002;12376.381180940916;14188.787168192486;14193.148411095368;14202.431902723982;7587.620618969029;7861.2531809478005;8103.10865804761;8117.79705507367;8213.137620549876;7935.563544005136;7989.520628762293;7997.7600671979935;8128.431009829255;8141.307988820898;4348.369486424451;4464.441944756905;4467.530909254547;4511.8195272189405;4524.728516289033;1669;1894.7157926310888;1971.5268335599353;2006.1173083843355;2008.7489063867017;826.6114925984778;863.9913600863911;887.8535041718044;940.1961323068814;963.2342287881152;20102;20851;20947.16211351529;20953.439006487206;21243.150273988867;848.9702860399856;878.6046279174269;919.8114386550741;930.4138392812484;987.6839411388287;9480.525973701288;9895.356801807859;10639.840402393971;11016.394098324668;11075.778484430428;619743;620301.0864511108;627790;629547;634606;124310;125376;125844.93240540918;126475.73524264639;126776;906.9501177435172;909.417972497602;932.0493097041116;933.1927882381826;935.1256575102301;17941;17950.640987180446;18209.089545522937;18224.635507289513;18322.17550210217;52284.95430091453;52514.737426312626;52842.47157528529;52908.17243375978;54309.72845135749;74202;76299.23700762921;76384;78534.607326963;80456.19543804487;6945.131858517685;7347.8530429392185;7645.503042302233;7934.325582325336;8248.175182481704;12058;13094.21434713882;13162.078654494477;13229.867701322864;13384.93307533456;10614.787704246026;10834.349939003685;11113.44432778374;11120.110391168526;11144.60993865211;10729.678109656723;11130.276532025393;11200.68346520824;11239.325640461271;11317.886821131684;9142;11068.723281918017;11076.889231107585;11347.602833900773;11432.199746017699;6368.172137622079;6919.550229235084;7256.492045556761;7302.963485182752;7477.775666730006;9219.44683319003;10044;10252.897471025195;11246.718832029264;11509.482073306888 22:46:33 INFO - PROCESS | 1640 | |3;mootools.html;1432.2051261549839;1537.5387383784862;1741.9738703919443;1865.5336165958502;1866.3281218761251;6880.036794848719;7194.992701021854;7242.529235599695;7918.3665306775465;8927.553622318874;7338.669759860806;8620.956895215531;8815.471071735701;8843.602037908293;8851.33614978876;1928.5467915039953;2344.202970989863;2344.847584906984;2350.1069593554425;2356.7643235676383;2280.566692328452;2312.722473303206;2332.615118505453;2347.9882600587057;2349.2850219339894;2253.571821353946;2349.3539276698957;2349.5888219561593;2358.929232123039;2369.5616310982437;2315.386422598013;2328.348062542491;2331.720193576765;2332.5684748321614;2334.4047267946567;2298.908043678251;2306.7693230676964;2310.90756369745;2312.352541288442;2317.073170731704;8787.0773568775;8837.425567338103;8848.734537963806;8892.555372231363;8929.437348463993;4529.909401811945;5132.692038477666;5214.634975551713;5294.391145018295;5305.389880163753;3433.9484907726405;3496.8426420811124;3577.069961809922;3607.2965771674535;3650.7992060436663;1042.5615562706594;1067.9466026698713;1081.9296745711583;1090.3076546393017;1093.1145771924766;11573;11596.782337854489;11625.709357266136;11666.824997625043;11666.883331166664;4512;4644.256918892961;4740.4311482621615;4760.190767569521;4760.214564596803;9855.90144098564;9920.900790991998;9935.701928942144;9955.004499549987;9962.800743985079;5181.637285389987;5210.114280572312;5219.269302297681;5250;5254.6847189168775;4018.3369743991916;4281.743095414286;4653.744044077541;4763.45220299663;4787.994521150597;3844.9810800137984;3862.1117143057254;3950.328444164499;3963.8810835674976;3978.681705463614;1272.2748033620933;1279.9312574000628;1283.813846992181;1285.9099863009687;1289.8000809874484;920.2867777472512;923.8152369526122;937.206195259527;940.6378544260509;969.7333233360882;5665.801696940587;5895.734691938873;5945.137954996501;5979.8206053817585;6168.629882207082;427.16276098845987;441.68860953028036;447.09240242308164;448.89002194462563;455.2374772256457;3991.720579559403;3998.280309544252;4071.043304823364;4078.163976384834;4172.77049762266;9868.605255789831;10610.89389106099;10685.412302323446;10726.570937162425;10740.30188037775;10018.499075046218;10621.415822129702;10634.20243481742;10649.73375665599;10654.840177397346;7775.611219439005;8191.754247372588;8193.590320483952;8200.42597018215;8203.917960820434;5584.553235741212;5875.824835032925;5965.821025369246;6108.541859360477;6173.84565385869;9908.653197138066;9919.851202232117;10015.949920250643;10041.04610062043;10055.597776089167;8354.45696029756;9970.750731231778;10213.693589192337;10232.693019209435;10254.974502549685;6873.450123990169;7278.126624805057;7413.221611730691;7470.813229669302;7663.655135519027;8413.873791893004;8420.4947703138;8460.91539084626;8483.490990540588;8494.872576911228;7363.116426028911;7492.962535187289;7525.510841795266;7598.658060387185;7614.238576142563;7338.156112047183;7371.041764570571;7395.630218488946;7492.438067144877;7521.435892308208;6925.342092501204;6931.168259808654;6993.2657071006815;7010.404115650227;7035.401990830632;4888.016266742593;4956.578690811321;4985.451600323889;5004.3994720633755;5030.37120359955;4848.733319667452;4892.633052521146;4953.876153096201;5076.593872490266;5091.905240373338 22:46:33 INFO - PROCESS | 1640 | |4;prototype.html;258.3128877186683;288.3353869331191;309.4955222986532;310.71569513894786;311.08851066375513;5378.91931621026;5529.889402211953;5561.694106824123;5617.887642247153;5660.490555849972;5526;5541.251930989315;5552.500274975251;5558.722063896799;5560.193771903072;3477.426224672926;4179.644730197937;4206.474190726151;4228.217779710763;4233.8094785734565;3478.3217272631846;3754.8498060077563;4042.878713638581;4070.14526949341;4177.749335039892;3788.3938569828833;3932.5870783567743;4127.793610319487;4172.3532852407925;4183.556672947828;3361.6974472297366;4156.958430415687;4176.14389050244;4202.936955945678;4230.428892099558;2834.4331133773326;3012.231880870386;3610.966787898152;3632.54593175853;3644.234710710754;4458.977705111486;4591.127685739699;4919.409670839486;4977.975110124463;5425.02349577076;4219.767912764797;4849.684770489906;4884.706917584921;4892.828750993734;4905.386826646669;4885.7312847793355;5906.645601263938;5918.1062060140775;5941.940580594182;6025.728842202067;3861.8455261789495;3991.3236440694686;4034.7780872052026;4043.3328500797334;4075.6535694466006;5318.97340513295;5613.894789453914;6214.9689251553455;6222.346653601352;6229.314775374705;3461.9826900865332;3614.3494171048937;3632.3824949758077;4154.4183814266025;4156.25187466259;3347.3640008398324;3351.128706536318;4036.324925156086;4196.307609244502;4211.284081706117;4037.6769858411844;4860.246661767432;4863.586595139453;4873.610111191097;4878.146324393217;4893.797790994067;5489.505944465017;5600;5933.3473317934995;5942.64344139353;1247.8253044573767;1256.2776403567984;1283.434210263477;1298.9673209798234;1362.7598885014588;946.1720994130136;955.6082006377352;975.5219942228399;978.6085565773748;979.8187335342984;5338.91991620126;5404.432894375219;5419.347099134723;5423.322084739408;5438.401775804658;4589.495155532889;5258.947410525922;5997.550183736237;6030.251227144079;6075.27096748393;5099.6685215460875;5105.438401775802;5375.381831089397;5379.220013098079;5398.865028374322;2404.6393041043634;2569.9077891895868;2570.6015567587056;2675.1305825606755;2713.782897368206;4653.139169253699;4781.402324709411;5028.7737051832755;5274.525292723597;5282;4931.408231012301;5077.492250774967;5169.0357664087405;5241.449647786927;5246.737663116905;4933.851984440401;5243.138685766498;5245.501677340647;5271.785849943033;5276.364327058624;4650.651201159994;4693.601043911306;4727.787249573847;5113.590912727047;5126.7180305083575;4655.441347038377;5076.441591424867;5557.083081291542;6052.818415447367;6104.077215677047;5336.573074153981;5832.891750567548;5839.182514448065;6423.614583125028;6427.710753016032;3248.8213148276127;3787.886363409102;3893.8778365790145;4002.4996875390575;4023.577524360017;5593.25930294161;5853.004989151939;6047.8227837979175;6084.939150608614;6114.327423983447;4666.743329116931;4971.204607262821;5333.9466605335;5787.421257874179;5973.761049557969;5430.728463576885;5442.9039475785785;5645.294338207724;5918.9704051481185;5933.169356290036;5236.329471969247;5496.900619876121;5708.744076303206;5776.429488877409;5841.474267315962;5373.677579345252;5406.78372865081;5723.914141287801;5947.1079338099635;5953.226080609493;4732.503087175797;5556.444355564411;5784.334801497882;5797.188393624811;5821.505172060422 22:46:33 INFO - PROCESS | 1640 | |5;yui.html;609.8201030695941;681.7239018197631;705.3968856627585;763.6563546404119;836.4145098431098;13449.865501344995;15523.990940588854;15702.84297157028;16239.91880040601;16300.429484968028;14124.293785310745;14423.206723630223;14474.927625361885;14514.056586321882;14561.98066135371;842.8314337132567;860.7417774667606;865.7835541114721;870.1559487297311;873.3144481581959;684.7671791590858;844.4046946902449;868.2966796894535;870.9085546017641;876.2989608313355;896.6458248991645;898.510311880027;914.07221670005;917.2524392619994;918.3846822628855;908.9045650206699;909.8180363927208;911.5168960450972;914.7575892388522;914.8490499067645;663.8937769956832;664.51158398577;667.8831204539234;680.1226417920876;680.9182898052266;15017.174055426947;15018.849811501854;15049.849501504954;15300.693986120326;15306.846931530765;14701.70596588073;14821.555353339418;14833.777493337608;15021;15058.397664093423;11991.700207494796;12088.247204155436;12109.636710898687;12129.636110916686;12358.320292383914;3940.4483372327895;3950.7827069511163;4099.159672267178;4100.220958017967;4104.343305071204;114880;116786;117671.4116429421;118983.81016189815;122241.16638250434;11232.775344493064;11311.886881131248;11395.088392928546;11396.487158077907;11482.770344593062;15580.454684086002;22933.885330573576;23669.763302366755;23706.288811335686;23780;7037.22590515043;8250.958745206235;8270.462419942685;8370.707025254087;8446.282066024334;4484.461864576272;4526.434195725535;4528.02647430804;4580.221362368406;4599.425071866017;2999.6700362960055;3119.1266445395327;3167.8279036756085;3531.2231309111953;3714.1643130295465;642.389729756733;646.6023395611664;650.5966300893382;653.9378759017885;665.5673812022128;590.6042951222691;672.4553111979312;673.3434900971514;700.1213477086225;701.9649017549102;8212.794680132925;9222.44665320083;9519.667246585484;9541.856872146924;9557.856632150524;631.4853394483481;668.4952860590223;678.1571129882889;693.414065114977;717.9784606461815;4535.569120933506;4570.177368073712;4685.495177278948;4703.95296047042;4794.424669039738;96631;149619;158755;160859;161651.38348616599;102929;135126;136829.63170368367;139183;142193;99799;105769;109292.45353773021;120311;122792;8440.324774017941;8526.957365213135;9896.554655040396;9941.25440591973;10126.240531959986;45968.770156149;63176;65682.67158664367;66249.00626490703;67544;84747;94386;94484.88241881541;98736.50631746795;99570;13076.411561479566;13216.801747973981;13348.733025339634;13460.461581536629;13527.323633818467;14719.926400368358;14831.777523337374;14963.77554336664;15162.862785290927;15277.77083343773;13861.306934653025;14141.292935352985;14267.42930282777;14378.281085945451;14555.636109097357;13691.383887724876;13756.793648095087;13887.930560347539;14381.568552943429;14564.271786410849;13625.289589717;13726.86273137256;13760.587182384545;13797;13892;11388.658340249805;11505.597304094317;11525.538978441104;11609.422226662868;11749.823752643888;7473.925260747323;9423.010583888867;10458.63394781179;11410.529260713422;11431.085513159094 22:46:33 INFO - PROCESS | 1640 | __end_tp_report 22:46:33 INFO - PROCESS | 1640 | __start_cc_report 22:46:33 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,400 22:46:33 INFO - PROCESS | 1640 | __end_cc_report 22:46:33 INFO - PROCESS | 1640 | __startTimestamp1471412793188__endTimestamp 22:46:33 INFO - PROCESS | 1640 | 22:46:33 INFO - PROCESS | 1640 | ------- Summary: start ------- 22:46:33 INFO - PROCESS | 1640 | Number of tests: 6 22:46:33 INFO - PROCESS | 1640 | 22:46:33 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5762.83 Median:5975.22 stddev:654.33 (11.0%) stddev-sans-first:630.06 22:46:33 INFO - PROCESS | 1640 | Values: 3422.8 3424.6 3461.6 3482.7 3500.2 5742.2 5786.2 5795.7 5824.1 5877.4 5742.0 5817.3 5863.9 5911.3 5964.6 5215.9 5245.1 5284.4 5326.1 5366.0 4703.2 5256.8 5334.9 5369.0 5422.1 5151.3 5183.7 5316.9 5321.2 5333.7 5195.4 5220.4 5235.6 5236.8 5307.7 5154.5 5206.1 5230.4 5329.5 5346.6 5112.3 5788.7 5870.8 5871.5 5911.9 6128.8 6150.6 6164.7 6182.4 6199.5 6241.3 6241.4 6248.0 6257.0 6261.8 4915.3 5768.6 5855.8 5912.9 5928.9 6386.8 6390.4 6391.4 6399.0 6412.8 6151.2 6171.1 6188.1 6192.1 6197.2 4651.9 6059.3 6137.2 6194.7 6229.8 5077.9 6140.8 6246.9 6250.9 6254.5 6110.7 6142.6 6188.7 6189.3 6262.7 4871.9 4911.6 4926.0 4984.0 5025.7 3662.4 4311.2 4416.1 4493.9 4520.9 5830.6 5864.8 5879.5 5896.6 5899.4 6115.6 6145.4 6153.7 6240.9 6254.7 5890.2 5910.6 5912.1 5919.8 5975.2 5480.7 5499.4 5508.3 5508.6 5526.5 6184.5 6344.3 6374.1 6416.5 6440.1 6253.0 6255.2 6267.2 6273.3 6273.3 6429.6 6476.3 6477.5 6484.0 6485.2 6074.6 6131.4 6142.2 6194.5 6207.7 5886.8 6154.2 6199.7 6247.4 6263.7 6127.1 6129.9 6167.1 6214.3 6220.1 6001.9 6061.5 6090.9 6199.0 6206.3 5443.9 5758.9 6016.1 6089.8 6138.6 6158.8 6160.4 6173.0 6186.8 6212.6 5801.3 5851.8 5914.8 6062.2 6067.5 22:46:33 INFO - PROCESS | 1640 | 22:46:33 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:62725.74 Median:39289.11 stddev:148650.29 (378.3%) stddev-sans-first:148993.87 22:46:33 INFO - PROCESS | 1640 | Values: 496.3 511.8 545.5 562.4 570.2 38468.6 41633.6 41813.6 41985.6 42092.8 42550.9 42573.1 42981.8 43080.0 43122.9 9701.9 9852.2 9889.6 9912.2 9933.8 9757.9 9759.7 9775.0 9873.3 9879.0 9739.2 9833.0 9843.7 9860.2 9863.8 9036.6 9239.4 9820.1 9839.2 9885.3 8292.5 9657.3 9774.2 9775.1 9791.3 39791.8 39955.4 40186.2 40218.4 40346.4 2537.9 3155.0 3364.9 3448.9 3856.9 30480.7 30519.7 30531.9 30682.7 30928.8 2709.6 3092.1 3127.4 3146.7 3210.2 122878.2 167473.0 167726.0 167809.0 168262.0 32995.7 33130.8 33387.0 33454.0 33474.8 30121.8 30974.4 34651.0 34859.0 35126.1 15392.0 15819.0 15828.7 15881.7 15891.2 12021.7 12023.6 12056.4 12095.8 12135.3 18823.2 18940.9 19121.3 19228.9 19295.5 6675.8 7124.0 7406.6 8109.0 8157.0 772.7 965.8 1012.3 1042.8 1095.8 28364.0 30395.9 30878.0 31186.2 31344.7 992.9 1004.7 1007.7 1049.9 1131.3 15071.8 15593.2 15669.6 15874.9 16054.3 691194.0 697367.0 697951.0 699500.0 700370.0 58091.7 58398.1 58527.4 59384.0 59396.4 1326.4 1333.1 1361.1 1363.4 1363.6 24583.8 26566.2 29848.4 30215.4 30563.7 50516.5 50877.7 51241.5 51286.2 51315.0 626337.0 626527.0 626709.0 627890.0 629341.0 26639.3 26676.5 27029.3 27079.3 27094.7 46970.8 47644.3 48181.0 48336.0 49025.0 39378.4 39628.2 39914.8 40449.4 40841.8 39173.4 39494.0 39976.8 40389.3 40750.8 38871.6 39216.0 39362.2 39779.8 40283.0 33149.0 35085.1 35731.8 35881.1 35894.3 25930.6 26179.2 26434.3 26563.2 27128.2 22:46:33 INFO - PROCESS | 1640 | 22:46:33 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:35153.89 Median:376.23 stddev:104209.25 (27698.0%) stddev-sans-first:104468.86 22:46:33 INFO - PROCESS | 1640 | Values: 371.2 374.8 377.7 383.6 400.3 15531.9 18720.1 19792.7 20778.2 20988.3 19714.7 19890.0 20057.2 20080.4 20328.7 5297.8 5762.5 5928.2 5967.3 6065.0 4981.7 5015.3 5636.6 5812.9 6032.6 5921.1 6022.7 6041.8 6042.6 6056.7 5919.5 5962.6 5998.7 6032.7 6044.2 5660.2 5838.9 5859.0 5940.9 5943.6 12903.5 13174.9 13211.3 19709.9 25511.0 2322.3 2719.4 2960.6 2965.4 2972.4 8097.8 9919.1 10098.9 10166.2 10219.8 1843.7 1877.8 1885.5 1905.6 1975.0 106971.0 112815.3 114091.0 116072.0 116275.4 11044.5 11260.9 11302.7 11344.9 11390.3 11032.2 12376.4 14188.8 14193.1 14202.4 7587.6 7861.3 8103.1 8117.8 8213.1 7935.6 7989.5 7997.8 8128.4 8141.3 4348.4 4464.4 4467.5 4511.8 4524.7 1669.0 1894.7 1971.5 2006.1 2008.7 826.6 864.0 887.9 940.2 963.2 20102.0 20851.0 20947.2 20953.4 21243.2 849.0 878.6 919.8 930.4 987.7 9480.5 9895.4 10639.8 11016.4 11075.8 619743.0 620301.1 627790.0 629547.0 634606.0 124310.0 125376.0 125844.9 126475.7 126776.0 907.0 909.4 932.0 933.2 935.1 17941.0 17950.6 18209.1 18224.6 18322.2 52285.0 52514.7 52842.5 52908.2 54309.7 74202.0 76299.2 76384.0 78534.6 80456.2 6945.1 7347.9 7645.5 7934.3 8248.2 12058.0 13094.2 13162.1 13229.9 13384.9 10614.8 10834.3 11113.4 11120.1 11144.6 10729.7 11130.3 11200.7 11239.3 11317.9 9142.0 11068.7 11076.9 11347.6 11432.2 6368.2 6919.6 7256.5 7303.0 7477.8 9219.4 10044.0 10252.9 11246.7 11509.5 22:46:33 INFO - PROCESS | 1640 | 22:46:33 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:5640.33 Median:4818.36 stddev:3177.78 (66.0%) stddev-sans-first:3170.96 22:46:33 INFO - PROCESS | 1640 | Values: 1432.2 1537.5 1742.0 1865.5 1866.3 6880.0 7195.0 7242.5 7918.4 8927.6 7338.7 8621.0 8815.5 8843.6 8851.3 1928.5 2344.2 2344.8 2350.1 2356.8 2280.6 2312.7 2332.6 2348.0 2349.3 2253.6 2349.4 2349.6 2358.9 2369.6 2315.4 2328.3 2331.7 2332.6 2334.4 2298.9 2306.8 2310.9 2312.4 2317.1 8787.1 8837.4 8848.7 8892.6 8929.4 4529.9 5132.7 5214.6 5294.4 5305.4 3433.9 3496.8 3577.1 3607.3 3650.8 1042.6 1067.9 1081.9 1090.3 1093.1 11573.0 11596.8 11625.7 11666.8 11666.9 4512.0 4644.3 4740.4 4760.2 4760.2 9855.9 9920.9 9935.7 9955.0 9962.8 5181.6 5210.1 5219.3 5250.0 5254.7 4018.3 4281.7 4653.7 4763.5 4788.0 3845.0 3862.1 3950.3 3963.9 3978.7 1272.3 1279.9 1283.8 1285.9 1289.8 920.3 923.8 937.2 940.6 969.7 5665.8 5895.7 5945.1 5979.8 6168.6 427.2 441.7 447.1 448.9 455.2 3991.7 3998.3 4071.0 4078.2 4172.8 9868.6 10610.9 10685.4 10726.6 10740.3 10018.5 10621.4 10634.2 10649.7 10654.8 7775.6 8191.8 8193.6 8200.4 8203.9 5584.6 5875.8 5965.8 6108.5 6173.8 9908.7 9919.9 10015.9 10041.0 10055.6 8354.5 9970.8 10213.7 10232.7 10255.0 6873.5 7278.1 7413.2 7470.8 7663.7 8413.9 8420.5 8460.9 8483.5 8494.9 7363.1 7493.0 7525.5 7598.7 7614.2 7338.2 7371.0 7395.6 7492.4 7521.4 6925.3 6931.2 6993.3 7010.4 7035.4 4888.0 4956.6 4985.5 5004.4 5030.4 4848.7 4892.6 4953.9 5076.6 5091.9 22:46:33 INFO - PROCESS | 1640 | 22:46:33 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4564.25 Median:5088.58 stddev:1429.17 (28.1%) stddev-sans-first:1396.16 22:46:33 INFO - PROCESS | 1640 | Values: 258.3 288.3 309.5 310.7 311.1 5378.9 5529.9 5561.7 5617.9 5660.5 5526.0 5541.3 5552.5 5558.7 5560.2 3477.4 4179.6 4206.5 4228.2 4233.8 3478.3 3754.8 4042.9 4070.1 4177.7 3788.4 3932.6 4127.8 4172.4 4183.6 3361.7 4157.0 4176.1 4202.9 4230.4 2834.4 3012.2 3611.0 3632.5 3644.2 4459.0 4591.1 4919.4 4978.0 5425.0 4219.8 4849.7 4884.7 4892.8 4905.4 4885.7 5906.6 5918.1 5941.9 6025.7 3861.8 3991.3 4034.8 4043.3 4075.7 5319.0 5613.9 6215.0 6222.3 6229.3 3462.0 3614.3 3632.4 4154.4 4156.3 3347.4 3351.1 4036.3 4196.3 4211.3 4037.7 4860.2 4863.6 4873.6 4878.1 4893.8 5489.5 5600.0 5933.3 5942.6 1247.8 1256.3 1283.4 1299.0 1362.8 946.2 955.6 975.5 978.6 979.8 5338.9 5404.4 5419.3 5423.3 5438.4 4589.5 5258.9 5997.6 6030.3 6075.3 5099.7 5105.4 5375.4 5379.2 5398.9 2404.6 2569.9 2570.6 2675.1 2713.8 4653.1 4781.4 5028.8 5274.5 5282.0 4931.4 5077.5 5169.0 5241.4 5246.7 4933.9 5243.1 5245.5 5271.8 5276.4 4650.7 4693.6 4727.8 5113.6 5126.7 4655.4 5076.4 5557.1 6052.8 6104.1 5336.6 5832.9 5839.2 6423.6 6427.7 3248.8 3787.9 3893.9 4002.5 4023.6 5593.3 5853.0 6047.8 6084.9 6114.3 4666.7 4971.2 5333.9 5787.4 5973.8 5430.7 5442.9 5645.3 5919.0 5933.2 5236.3 5496.9 5708.7 5776.4 5841.5 5373.7 5406.8 5723.9 5947.1 5953.2 4732.5 5556.4 5784.3 5797.2 5821.5 22:46:33 INFO - PROCESS | 1640 | 22:46:33 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:25277.27 Median:3622.69 stddev:40500.71 (1118.0%) stddev-sans-first:40571.98 22:46:33 INFO - PROCESS | 1640 | Values: 609.8 681.7 705.4 763.7 836.4 13449.9 15524.0 15702.8 16239.9 16300.4 14124.3 14423.2 14474.9 14514.1 14562.0 842.8 860.7 865.8 870.2 873.3 684.8 844.4 868.3 870.9 876.3 896.6 898.5 914.1 917.3 918.4 908.9 909.8 911.5 914.8 914.8 663.9 664.5 667.9 680.1 680.9 15017.2 15018.8 15049.8 15300.7 15306.8 14701.7 14821.6 14833.8 15021.0 15058.4 11991.7 12088.2 12109.6 12129.6 12358.3 3940.4 3950.8 4099.2 4100.2 4104.3 114880.0 116786.0 117671.4 118983.8 122241.2 11232.8 11311.9 11395.1 11396.5 11482.8 15580.5 22933.9 23669.8 23706.3 23780.0 7037.2 8251.0 8270.5 8370.7 8446.3 4484.5 4526.4 4528.0 4580.2 4599.4 2999.7 3119.1 3167.8 3531.2 3714.2 642.4 646.6 650.6 653.9 665.6 590.6 672.5 673.3 700.1 702.0 8212.8 9222.4 9519.7 9541.9 9557.9 631.5 668.5 678.2 693.4 718.0 4535.6 4570.2 4685.5 4704.0 4794.4 96631.0 149619.0 158755.0 160859.0 161651.4 102929.0 135126.0 136829.6 139183.0 142193.0 99799.0 105769.0 109292.5 120311.0 122792.0 8440.3 8527.0 9896.6 9941.3 10126.2 45968.8 63176.0 65682.7 66249.0 67544.0 84747.0 94386.0 94484.9 98736.5 99570.0 13076.4 13216.8 13348.7 13460.5 13527.3 14719.9 14831.8 14963.8 15162.9 15277.8 13861.3 14141.3 14267.4 14378.3 14555.6 13691.4 13756.8 13887.9 14381.6 14564.3 13625.3 13726.9 13760.6 13797.0 13892.0 11388.7 11505.6 11525.5 11609.4 11749.8 7473.9 9423.0 10458.6 11410.5 11431.1 22:46:33 INFO - PROCESS | 1640 | -------- Summary: end -------- 22:46:33 INFO - PROCESS | 1640 | 22:46:33 INFO - TEST-INFO | 1640: exit 0 22:46:33 INFO - TEST-OK | dromaeo_css | took 1113972ms 22:46:33 INFO - TEST-START | kraken 22:46:33 INFO - operating with platform_type : mac_ 22:46:33 INFO - Initialising browser for kraken test... 22:46:33 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmpeqb9aY/profile http://localhost:49266/getInfo.html) 22:46:36 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 22:46:36 INFO - PROCESS | 1653 | colorDepth:24 22:46:36 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 22:46:36 INFO - PROCESS | 1653 | __metrics 22:46:36 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 22:46:37 INFO - TEST-INFO | 1653: exit 0 22:46:37 INFO - Browser initialized. 22:46:37 INFO - Running cycle 1/1 for kraken test... 22:46:37 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmpeqb9aY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:46:49 INFO - PROCESS | 1655 | RSS: Main: 236953600 22:46:49 INFO - PROCESS | 1655 | 22:46:52 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 22:46:53 INFO - PROCESS | 1655 | RSS: Main: 249716736 22:46:53 INFO - PROCESS | 1655 | 22:46:55 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 22:46:56 INFO - PROCESS | 1655 | RSS: Main: 258494464 22:46:56 INFO - PROCESS | 1655 | 22:46:59 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 22:47:00 INFO - PROCESS | 1655 | RSS: Main: 261337088 22:47:00 INFO - PROCESS | 1655 | 22:47:02 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 22:47:03 INFO - PROCESS | 1655 | RSS: Main: 262660096 22:47:03 INFO - PROCESS | 1655 | 22:47:05 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:47:05 INFO - PROCESS | 1655 | RSS: Main: 263176192 22:47:05 INFO - PROCESS | 1655 | 22:47:08 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 22:47:09 INFO - PROCESS | 1655 | RSS: Main: 263184384 22:47:09 INFO - PROCESS | 1655 | 22:47:12 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 22:47:12 INFO - PROCESS | 1655 | RSS: Main: 264110080 22:47:12 INFO - PROCESS | 1655 | 22:47:15 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 22:47:16 INFO - PROCESS | 1655 | RSS: Main: 265080832 22:47:16 INFO - PROCESS | 1655 | 22:47:17 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:47:18 INFO - PROCESS | 1655 | RSS: Main: 265080832 22:47:18 INFO - PROCESS | 1655 | 22:47:20 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:47:21 INFO - PROCESS | 1655 | RSS: Main: 265224192 22:47:21 INFO - PROCESS | 1655 | 22:47:23 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:47:24 INFO - PROCESS | 1655 | RSS: Main: 265310208 22:47:24 INFO - PROCESS | 1655 | 22:47:27 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:47:27 INFO - PROCESS | 1655 | RSS: Main: 264679424 22:47:27 INFO - PROCESS | 1655 | 22:47:30 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:47:31 INFO - PROCESS | 1655 | RSS: Main: 265220096 22:47:31 INFO - PROCESS | 1655 | 22:47:32 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 22:47:33 INFO - PROCESS | 1655 | RSS: Main: 266416128 22:47:33 INFO - PROCESS | 1655 | 22:47:33 INFO - PROCESS | 1655 | __start_tp_report 22:47:33 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 22:47:33 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 22:47:33 INFO - PROCESS | 1655 | |i|pagename|runs| 22:47:33 INFO - PROCESS | 1655 | |0;ai-astar;108;117;110;150;103;148;170;99;110;143 22:47:33 INFO - PROCESS | 1655 | |1;audio-beat-detection;147;113;144;160;106;133;134;116;177;96 22:47:33 INFO - PROCESS | 1655 | |2;audio-dft;218;264;275;217;196;199;192;195;194;200 22:47:33 INFO - PROCESS | 1655 | |3;audio-fft;71;81;74;144;59;58;61;61;139;59 22:47:33 INFO - PROCESS | 1655 | |4;audio-oscillator;71;74;123;72;73;79;113;71;76;115 22:47:33 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;87;86;87;85;89;90;118;86;88;85 22:47:33 INFO - PROCESS | 1655 | |6;imaging-darkroom;93;96;94;95;95;95;94;115;150;116 22:47:33 INFO - PROCESS | 1655 | |7;imaging-desaturate;103;142;126;93;98;84;154;148;92;90 22:47:33 INFO - PROCESS | 1655 | |8;json-parse-financial;54;57;61;56;56;59;56;60;58;73 22:47:33 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;66;68;75;69;76;77;69;74;70;70 22:47:33 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;90;102;105;105;96;86;92;88;88;98 22:47:33 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;136;137;140;137;140;167;133;164;207;156 22:47:33 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;177;175;169;171;172;170;170;169;163;167 22:47:33 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;70;67;64;64;82;89;87;83;67;83 22:47:33 INFO - PROCESS | 1655 | __end_tp_report 22:47:33 INFO - PROCESS | 1655 | __start_cc_report 22:47:33 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1004 22:47:33 INFO - PROCESS | 1655 | __end_cc_report 22:47:33 INFO - PROCESS | 1655 | __startTimestamp1471412853200__endTimestamp 22:47:33 INFO - PROCESS | 1655 | 22:47:33 INFO - PROCESS | 1655 | ------- Summary: start ------- 22:47:33 INFO - PROCESS | 1655 | Number of tests: 14 22:47:33 INFO - PROCESS | 1655 | 22:47:33 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:125.80 Median:145.50 stddev:24.63 (16.9%) stddev-sans-first:25.27 22:47:33 INFO - PROCESS | 1655 | Values: 108.0 117.0 110.0 150.0 103.0 148.0 170.0 99.0 110.0 143.0 22:47:33 INFO - PROCESS | 1655 | 22:47:33 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:132.60 Median:145.50 stddev:25.32 (17.4%) stddev-sans-first:26.31 22:47:33 INFO - PROCESS | 1655 | Values: 147.0 113.0 144.0 160.0 106.0 133.0 134.0 116.0 177.0 96.0 22:47:33 INFO - PROCESS | 1655 | 22:47:33 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:215.00 Median:208.50 stddev:30.23 (14.5%) stddev-sans-first:32.05 22:47:33 INFO - PROCESS | 1655 | Values: 218.0 264.0 275.0 217.0 196.0 199.0 192.0 195.0 194.0 200.0 22:47:33 INFO - PROCESS | 1655 | 22:47:33 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:80.70 Median:61.00 stddev:32.96 (54.0%) stddev-sans-first:34.77 22:47:33 INFO - PROCESS | 1655 | Values: 71.0 81.0 74.0 144.0 59.0 58.0 61.0 61.0 139.0 59.0 22:47:33 INFO - PROCESS | 1655 | 22:47:33 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:86.70 Median:72.50 stddev:21.19 (29.2%) stddev-sans-first:21.70 22:47:33 INFO - PROCESS | 1655 | Values: 71.0 74.0 123.0 72.0 73.0 79.0 113.0 71.0 76.0 115.0 22:47:33 INFO - PROCESS | 1655 | 22:47:33 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:90.10 Median:87.00 stddev:9.94 (11.4%) stddev-sans-first:10.48 22:47:33 INFO - PROCESS | 1655 | Values: 87.0 86.0 87.0 85.0 89.0 90.0 118.0 86.0 88.0 85.0 22:47:33 INFO - PROCESS | 1655 | 22:47:33 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:104.30 Median:94.50 stddev:18.28 (19.3%) stddev-sans-first:18.93 22:47:33 INFO - PROCESS | 1655 | Values: 93.0 96.0 94.0 95.0 95.0 95.0 94.0 115.0 150.0 116.0 22:47:33 INFO - PROCESS | 1655 | 22:47:33 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:113.00 Median:87.00 stddev:26.77 (30.8%) stddev-sans-first:28.15 22:47:33 INFO - PROCESS | 1655 | Values: 103.0 142.0 126.0 93.0 98.0 84.0 154.0 148.0 92.0 90.0 22:47:33 INFO - PROCESS | 1655 | 22:47:33 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:58.50 stddev:5.35 (9.2%) stddev-sans-first:5.36 22:47:33 INFO - PROCESS | 1655 | Values: 54.0 57.0 61.0 56.0 56.0 59.0 56.0 60.0 58.0 73.0 22:47:33 INFO - PROCESS | 1655 | 22:47:33 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:72.00 stddev:3.78 (5.2%) stddev-sans-first:3.46 22:47:33 INFO - PROCESS | 1655 | Values: 66.0 68.0 75.0 69.0 76.0 77.0 69.0 74.0 70.0 70.0 22:47:33 INFO - PROCESS | 1655 | 22:47:33 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:95.00 Median:89.00 stddev:7.24 (8.1%) stddev-sans-first:7.45 22:47:33 INFO - PROCESS | 1655 | Values: 90.0 102.0 105.0 105.0 96.0 86.0 92.0 88.0 88.0 98.0 22:47:33 INFO - PROCESS | 1655 | 22:47:33 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:151.70 Median:148.00 stddev:23.01 (15.5%) stddev-sans-first:23.69 22:47:33 INFO - PROCESS | 1655 | Values: 136.0 137.0 140.0 137.0 140.0 167.0 133.0 164.0 207.0 156.0 22:47:33 INFO - PROCESS | 1655 | 22:47:33 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.30 Median:170.50 stddev:3.92 (2.3%) stddev-sans-first:3.32 22:47:33 INFO - PROCESS | 1655 | Values: 177.0 175.0 169.0 171.0 172.0 170.0 170.0 169.0 163.0 167.0 22:47:33 INFO - PROCESS | 1655 | 22:47:33 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.60 Median:82.50 stddev:10.05 (12.2%) stddev-sans-first:10.45 22:47:33 INFO - PROCESS | 1655 | Values: 70.0 67.0 64.0 64.0 82.0 89.0 87.0 83.0 67.0 83.0 22:47:33 INFO - PROCESS | 1655 | -------- Summary: end -------- 22:47:33 INFO - PROCESS | 1655 | 22:47:34 INFO - TEST-INFO | 1655: exit 0 22:47:34 INFO - TEST-OK | kraken | took 60252ms 22:47:34 INFO - SUITE-END | took 1174s 22:47:34 INFO - Completed test suite (00:19:34) 22:47:34 INFO - javascript benchmark 22:47:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7259.8088353816975, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3422.8459719312627, 3424.640412756659, 3461.567304086989, 3482.7387945904056, 3500.2299494111317, 5742.167385729067, 5786.218860453842, 5795.71021448928, 5824.068149096145, 5877.441643043904, 5741.995150848606, 5817.331006934204, 5863.882722345551, 5911.261092363455, 5964.582479226456, 5215.921761173586, 5245.10833158364, 5284.44513326101, 5326.067938110835, 5366.0, 4703.247480403119, 5256.816011439581, 5334.866628334304, 5369.0, 5422.05114105032, 5151.330327057496, 5183.663061900965, 5316.893662126736, 5321.1752178412025, 5333.653312534673, 5195.376554813409, 5220.425753167148, 5235.55497782689, 5236.842894713165, 5307.73461326936, 5154.4587818278915, 5206.088934436459, 5230.424653288135, 5329.467053294639, 5346.572274218053, 5112.309838171836, 5788.739506722208, 5870.794522191745, 5871.500922421599, 5911.940880591182, 6128.804883047807, 6150.600210986317, 6164.6917654117115, 6182.350853160398, 6199.535034872402, 6241.3446588108045, 6241.438270555672, 6247.969085100998, 6257.0, 6261.812145635638, 4915.336429581961, 5768.625039372428, 5855.765769369263, 5912.9113063304085, 5928.881422371528, 6386.776462823872, 6390.392912673288, 6391.360863913572, 6398.968005160037, 6412.839679008062, 6151.200343955346, 6171.105189747551, 6188.1027251048345, 6192.0711893215475, 6197.194364732646, 4651.883702907455, 6059.303180134253, 6137.232845894263, 6194.690265486708, 6229.813105606839, 5077.8730531737, 6140.785072522441, 6246.875062498724, 6250.874982500415, 6254.530910181755, 6110.694465276719, 6142.600730952474, 6188.659623720649, 6189.319174890758, 6262.718177682015, 4871.926921096187, 4911.582515486152, 4926.0, 4984.0, 5025.698458092526, 3662.359087159736, 4311.2239796836875, 4416.11677664462, 4493.88765280864, 4520.932186017212, 5830.562707796932, 5864.765409383662, 5879.52963762898, 5896.557758168069, 5899.380565040609, 6115.635867915819, 6145.385461453909, 6153.661548614869, 6240.875182496416, 6254.718537665816, 5890.204822349014, 5910.586258961831, 5912.142739302777, 5919.763209471573, 5975.223220981245, 5480.698561579072, 5499.422560631157, 5508.256385387921, 5508.641938274, 5526.50261476461, 6184.5052395809125, 6344.30212676596, 6374.139491168633, 6416.486681065504, 6440.098386225932, 6252.968735156295, 6255.249370075438, 6267.185265915402, 6273.341299163522, 6273.341299163522, 6429.58207716497, 6476.287608362982, 6477.514186435942, 6484.0, 6485.189351331083, 6074.605150665193, 6131.386861313833, 6142.222533142175, 6194.504439644727, 6207.720652570735, 5886.805230502716, 6154.230721159855, 6199.659018754011, 6247.375262473716, 6263.74945002213, 6127.111568822406, 6129.938700612936, 6167.105769663463, 6214.316425193316, 6220.098085777628, 6001.939980600138, 6061.515078793774, 6090.9390906090375, 6199.039148931923, 6206.255249370104, 5443.891122177455, 5758.856028599319, 6016.127661488972, 6089.756409743561, 6138.6009909357535, 6158.846028849314, 6160.44555989963, 6172.969135154295, 6186.752529898754, 6212.565120441525, 5801.274840644919, 5851.824445266649, 5914.822555323347, 6062.181605483203, 6067.453929146398], "value": 5722.506715343377, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.2531390257662, 511.81770111043494, 545.4926917966292, 562.3561022629087, 570.1561688700723, 38468.61531384689, 41633.58366416335, 41813.58186418139, 41985.58014419859, 42092.789536052354, 42550.93622659435, 42573.14853702924, 42981.785091074504, 43080.0, 43122.92192695184, 9701.85447218294, 9852.211823054138, 9889.554970026331, 9912.207023438108, 9933.801323973552, 9757.902420975806, 9759.707208783748, 9774.951125244364, 9873.308868379216, 9878.950605246999, 9739.220862331033, 9832.950835245814, 9843.70468885931, 9860.21118310537, 9863.753406164831, 9036.638534458647, 9239.399439036475, 9820.067093626094, 9839.163671087967, 9885.25860560461, 8292.460990035628, 9657.275704322205, 9774.218062554979, 9775.120239178437, 9791.314607977445, 39791.8010409949, 39955.40066898999, 40186.19627607431, 40218.39672404887, 40346.394804077965, 2537.8857951392233, 3154.952675709866, 3364.899053028413, 3448.9482657760154, 3856.9421458678144, 30480.695193048006, 30519.69480305191, 30531.93138240173, 30682.693173068208, 30928.845355773075, 2709.566469364912, 3092.072378286505, 3127.390158919012, 3146.716795488394, 3210.213497693057, 122878.15682764766, 167473.0, 167726.0, 167809.0, 168262.0, 32995.67004329974, 33130.834345828116, 33387.0, 33454.0, 33474.82838100655, 30121.849390752905, 30974.380512389627, 34651.0, 34859.0, 35126.12184695403, 15392.0, 15818.97176683535, 15828.683426331409, 15881.682366352608, 15891.205439727968, 12021.699457513632, 12023.579174728842, 12056.397180141134, 12095.818562721566, 12135.271883687006, 18823.152958116916, 18940.905295473436, 19121.330753423565, 19228.903855480632, 19295.51761205953, 6675.833104172338, 7124.0, 7406.556066360248, 8109.026916770025, 8157.009494615628, 772.6947855597008, 965.8458142519621, 1012.2559918460073, 1042.8122937871103, 1095.8137116690182, 28364.00725974581, 30395.936142234914, 30878.0, 31186.220344491114, 31344.715325927853, 992.93545919515, 1004.6570556124714, 1007.6926537406162, 1049.9370037797758, 1131.338167172197, 15071.773923391158, 15593.220338983005, 15669.60825979337, 15874.920625396799, 16054.27755750994, 691194.0, 697367.0, 697951.0, 699500.0, 700370.0, 58091.70954145202, 58398.12402813961, 58527.41472585305, 59384.0, 59396.40603593995, 1326.409747662281, 1333.1334632488765, 1361.101672895884, 1363.379662253692, 1363.5977386670957, 24583.754162458146, 26566.203013909613, 29848.403031938804, 30215.395692086477, 30563.694363056973, 50516.49483505265, 50877.745611271705, 51241.48758512516, 51286.23070654018, 51315.0, 626337.0, 626527.0, 626709.0, 627890.0, 629341.0, 26639.334016648965, 26676.466470670865, 27029.324266893484, 27079.323016923947, 27094.72905270922, 46970.76514617405, 47644.285335720684, 48181.0, 48336.0, 49025.0, 39378.40932385959, 39628.2074358517, 39914.80042599768, 40449.39325910055, 40841.79579102086, 39173.41239881347, 39494.0, 39976.800115999235, 40389.294403893924, 40750.79624601858, 38871.6112838868, 39216.0, 39362.2127557453, 39779.80110099431, 40283.0, 33149.0, 35085.122871928404, 35731.821340893126, 35881.1029724259, 35894.28211435809, 25930.611040834025, 26179.214623561325, 26434.339141520846, 26563.203103906915, 27128.186154415398], "value": 18892.59618521065, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.18154469395006, 374.7788804605283, 377.68840706417205, 383.55890725665466, 400.2834925483385, 15531.92234038831, 18720.149960615392, 19792.703109453334, 20778.16887324509, 20988.26541071061, 19714.704279435784, 19890.0, 20057.197712091536, 20080.39758807238, 20328.69506957397, 5297.788088476456, 5762.481376676109, 5928.170056192136, 5967.313758917737, 6065.029595264758, 4981.701097934118, 5015.297858299841, 5636.605437619368, 5812.941870581303, 6032.577719559633, 5921.082232254007, 6022.6687532185715, 6041.818745437644, 6042.637441753487, 6056.666883321415, 5919.526437884981, 5962.582619216657, 5998.670073145975, 6032.728527216286, 6044.244469441298, 5660.150977353389, 5838.9124163137585, 5859.033259512175, 5940.881182376328, 5943.554233432466, 12903.483860645563, 13174.934125329311, 13211.273379964097, 19709.901450492798, 25511.0, 2322.3149170994598, 2719.428919926818, 2960.5559166125254, 2965.4069186162637, 2972.390659914734, 8097.838043239161, 9919.107280344804, 10098.949505252427, 10166.237532185041, 10219.79560408795, 1843.7050071988551, 1877.8216069473378, 1885.4532185666278, 1905.6474552207885, 1974.9605007899904, 106971.0, 112815.30777038352, 114091.0, 116072.0, 116275.4186229072, 11044.502997365138, 11260.887391126147, 11302.717432064099, 11344.886551134383, 11390.25963312382, 11032.172587056002, 12376.381180940916, 14188.787168192486, 14193.148411095368, 14202.431902723982, 7587.620618969029, 7861.2531809478005, 8103.10865804761, 8117.79705507367, 8213.137620549876, 7935.563544005136, 7989.520628762293, 7997.7600671979935, 8128.431009829255, 8141.307988820898, 4348.369486424451, 4464.441944756905, 4467.530909254547, 4511.8195272189405, 4524.728516289033, 1669.0, 1894.7157926310888, 1971.5268335599353, 2006.1173083843355, 2008.7489063867017, 826.6114925984778, 863.9913600863911, 887.8535041718044, 940.1961323068814, 963.2342287881152, 20102.0, 20851.0, 20947.16211351529, 20953.439006487206, 21243.150273988867, 848.9702860399856, 878.6046279174269, 919.8114386550741, 930.4138392812484, 987.6839411388287, 9480.525973701288, 9895.356801807859, 10639.840402393971, 11016.394098324668, 11075.778484430428, 619743.0, 620301.0864511108, 627790.0, 629547.0, 634606.0, 124310.0, 125376.0, 125844.93240540918, 126475.73524264639, 126776.0, 906.9501177435172, 909.417972497602, 932.0493097041116, 933.1927882381826, 935.1256575102301, 17941.0, 17950.640987180446, 18209.089545522937, 18224.635507289513, 18322.17550210217, 52284.95430091453, 52514.737426312626, 52842.47157528529, 52908.17243375978, 54309.72845135749, 74202.0, 76299.23700762921, 76384.0, 78534.607326963, 80456.19543804487, 6945.131858517685, 7347.8530429392185, 7645.503042302233, 7934.325582325336, 8248.175182481704, 12058.0, 13094.21434713882, 13162.078654494477, 13229.867701322864, 13384.93307533456, 10614.787704246026, 10834.349939003685, 11113.44432778374, 11120.110391168526, 11144.60993865211, 10729.678109656723, 11130.276532025393, 11200.68346520824, 11239.325640461271, 11317.886821131684, 9142.0, 11068.723281918017, 11076.889231107585, 11347.602833900773, 11432.199746017699, 6368.172137622079, 6919.550229235084, 7256.492045556761, 7302.963485182752, 7477.775666730006, 9219.44683319003, 10044.0, 10252.897471025195, 11246.718832029264, 11509.482073306888], "value": 9298.817602686484, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1432.2051261549839, 1537.5387383784862, 1741.9738703919443, 1865.5336165958502, 1866.3281218761251, 6880.036794848719, 7194.992701021854, 7242.529235599695, 7918.3665306775465, 8927.553622318874, 7338.669759860806, 8620.956895215531, 8815.471071735701, 8843.602037908293, 8851.33614978876, 1928.5467915039953, 2344.202970989863, 2344.847584906984, 2350.1069593554425, 2356.7643235676383, 2280.566692328452, 2312.722473303206, 2332.615118505453, 2347.9882600587057, 2349.2850219339894, 2253.571821353946, 2349.3539276698957, 2349.5888219561593, 2358.929232123039, 2369.5616310982437, 2315.386422598013, 2328.348062542491, 2331.720193576765, 2332.5684748321614, 2334.4047267946567, 2298.908043678251, 2306.7693230676964, 2310.90756369745, 2312.352541288442, 2317.073170731704, 8787.0773568775, 8837.425567338103, 8848.734537963806, 8892.555372231363, 8929.437348463993, 4529.909401811945, 5132.692038477666, 5214.634975551713, 5294.391145018295, 5305.389880163753, 3433.9484907726405, 3496.8426420811124, 3577.069961809922, 3607.2965771674535, 3650.7992060436663, 1042.5615562706594, 1067.9466026698713, 1081.9296745711583, 1090.3076546393017, 1093.1145771924766, 11573.0, 11596.782337854489, 11625.709357266136, 11666.824997625043, 11666.883331166664, 4512.0, 4644.256918892961, 4740.4311482621615, 4760.190767569521, 4760.214564596803, 9855.90144098564, 9920.900790991998, 9935.701928942144, 9955.004499549987, 9962.800743985079, 5181.637285389987, 5210.114280572312, 5219.269302297681, 5250.0, 5254.6847189168775, 4018.3369743991916, 4281.743095414286, 4653.744044077541, 4763.45220299663, 4787.994521150597, 3844.9810800137984, 3862.1117143057254, 3950.328444164499, 3963.8810835674976, 3978.681705463614, 1272.2748033620933, 1279.9312574000628, 1283.813846992181, 1285.9099863009687, 1289.8000809874484, 920.2867777472512, 923.8152369526122, 937.206195259527, 940.6378544260509, 969.7333233360882, 5665.801696940587, 5895.734691938873, 5945.137954996501, 5979.8206053817585, 6168.629882207082, 427.16276098845987, 441.68860953028036, 447.09240242308164, 448.89002194462563, 455.2374772256457, 3991.720579559403, 3998.280309544252, 4071.043304823364, 4078.163976384834, 4172.77049762266, 9868.605255789831, 10610.89389106099, 10685.412302323446, 10726.570937162425, 10740.30188037775, 10018.499075046218, 10621.415822129702, 10634.20243481742, 10649.73375665599, 10654.840177397346, 7775.611219439005, 8191.754247372588, 8193.590320483952, 8200.42597018215, 8203.917960820434, 5584.553235741212, 5875.824835032925, 5965.821025369246, 6108.541859360477, 6173.84565385869, 9908.653197138066, 9919.851202232117, 10015.949920250643, 10041.04610062043, 10055.597776089167, 8354.45696029756, 9970.750731231778, 10213.693589192337, 10232.693019209435, 10254.974502549685, 6873.450123990169, 7278.126624805057, 7413.221611730691, 7470.813229669302, 7663.655135519027, 8413.873791893004, 8420.4947703138, 8460.91539084626, 8483.490990540588, 8494.872576911228, 7363.116426028911, 7492.962535187289, 7525.510841795266, 7598.658060387185, 7614.238576142563, 7338.156112047183, 7371.041764570571, 7395.630218488946, 7492.438067144877, 7521.435892308208, 6925.342092501204, 6931.168259808654, 6993.2657071006815, 7010.404115650227, 7035.401990830632, 4888.016266742593, 4956.578690811321, 4985.451600323889, 5004.3994720633755, 5030.37120359955, 4848.733319667452, 4892.633052521146, 4953.876153096201, 5076.593872490266, 5091.905240373338], "value": 4466.782746100558, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [258.3128877186683, 288.3353869331191, 309.4955222986532, 310.71569513894786, 311.08851066375513, 5378.91931621026, 5529.889402211953, 5561.694106824123, 5617.887642247153, 5660.490555849972, 5526.0, 5541.251930989315, 5552.500274975251, 5558.722063896799, 5560.193771903072, 3477.426224672926, 4179.644730197937, 4206.474190726151, 4228.217779710763, 4233.8094785734565, 3478.3217272631846, 3754.8498060077563, 4042.878713638581, 4070.14526949341, 4177.749335039892, 3788.3938569828833, 3932.5870783567743, 4127.793610319487, 4172.3532852407925, 4183.556672947828, 3361.6974472297366, 4156.958430415687, 4176.14389050244, 4202.936955945678, 4230.428892099558, 2834.4331133773326, 3012.231880870386, 3610.966787898152, 3632.54593175853, 3644.234710710754, 4458.977705111486, 4591.127685739699, 4919.409670839486, 4977.975110124463, 5425.02349577076, 4219.767912764797, 4849.684770489906, 4884.706917584921, 4892.828750993734, 4905.386826646669, 4885.7312847793355, 5906.645601263938, 5918.1062060140775, 5941.940580594182, 6025.728842202067, 3861.8455261789495, 3991.3236440694686, 4034.7780872052026, 4043.3328500797334, 4075.6535694466006, 5318.97340513295, 5613.894789453914, 6214.9689251553455, 6222.346653601352, 6229.314775374705, 3461.9826900865332, 3614.3494171048937, 3632.3824949758077, 4154.4183814266025, 4156.25187466259, 3347.3640008398324, 3351.128706536318, 4036.324925156086, 4196.307609244502, 4211.284081706117, 4037.6769858411844, 4860.246661767432, 4863.586595139453, 4873.610111191097, 4878.146324393217, 4893.797790994067, 5489.505944465017, 5600.0, 5933.3473317934995, 5942.64344139353, 1247.8253044573767, 1256.2776403567984, 1283.434210263477, 1298.9673209798234, 1362.7598885014588, 946.1720994130136, 955.6082006377352, 975.5219942228399, 978.6085565773748, 979.8187335342984, 5338.91991620126, 5404.432894375219, 5419.347099134723, 5423.322084739408, 5438.401775804658, 4589.495155532889, 5258.947410525922, 5997.550183736237, 6030.251227144079, 6075.27096748393, 5099.6685215460875, 5105.438401775802, 5375.381831089397, 5379.220013098079, 5398.865028374322, 2404.6393041043634, 2569.9077891895868, 2570.6015567587056, 2675.1305825606755, 2713.782897368206, 4653.139169253699, 4781.402324709411, 5028.7737051832755, 5274.525292723597, 5282.0, 4931.408231012301, 5077.492250774967, 5169.0357664087405, 5241.449647786927, 5246.737663116905, 4933.851984440401, 5243.138685766498, 5245.501677340647, 5271.785849943033, 5276.364327058624, 4650.651201159994, 4693.601043911306, 4727.787249573847, 5113.590912727047, 5126.7180305083575, 4655.441347038377, 5076.441591424867, 5557.083081291542, 6052.818415447367, 6104.077215677047, 5336.573074153981, 5832.891750567548, 5839.182514448065, 6423.614583125028, 6427.710753016032, 3248.8213148276127, 3787.886363409102, 3893.8778365790145, 4002.4996875390575, 4023.577524360017, 5593.25930294161, 5853.004989151939, 6047.8227837979175, 6084.939150608614, 6114.327423983447, 4666.743329116931, 4971.204607262821, 5333.9466605335, 5787.421257874179, 5973.761049557969, 5430.728463576885, 5442.9039475785785, 5645.294338207724, 5918.9704051481185, 5933.169356290036, 5236.329471969247, 5496.900619876121, 5708.744076303206, 5776.429488877409, 5841.474267315962, 5373.677579345252, 5406.78372865081, 5723.914141287801, 5947.1079338099635, 5953.226080609493, 4732.503087175797, 5556.444355564411, 5784.334801497882, 5797.188393624811, 5821.505172060422], "value": 4109.556876062082, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.8201030695941, 681.7239018197631, 705.3968856627585, 763.6563546404119, 836.4145098431098, 13449.865501344995, 15523.990940588854, 15702.84297157028, 16239.91880040601, 16300.429484968028, 14124.293785310745, 14423.206723630223, 14474.927625361885, 14514.056586321882, 14561.98066135371, 842.8314337132567, 860.7417774667606, 865.7835541114721, 870.1559487297311, 873.3144481581959, 684.7671791590858, 844.4046946902449, 868.2966796894535, 870.9085546017641, 876.2989608313355, 896.6458248991645, 898.510311880027, 914.07221670005, 917.2524392619994, 918.3846822628855, 908.9045650206699, 909.8180363927208, 911.5168960450972, 914.7575892388522, 914.8490499067645, 663.8937769956832, 664.51158398577, 667.8831204539234, 680.1226417920876, 680.9182898052266, 15017.174055426947, 15018.849811501854, 15049.849501504954, 15300.693986120326, 15306.846931530765, 14701.70596588073, 14821.555353339418, 14833.777493337608, 15021.0, 15058.397664093423, 11991.700207494796, 12088.247204155436, 12109.636710898687, 12129.636110916686, 12358.320292383914, 3940.4483372327895, 3950.7827069511163, 4099.159672267178, 4100.220958017967, 4104.343305071204, 114880.0, 116786.0, 117671.4116429421, 118983.81016189815, 122241.16638250434, 11232.775344493064, 11311.886881131248, 11395.088392928546, 11396.487158077907, 11482.770344593062, 15580.454684086002, 22933.885330573576, 23669.763302366755, 23706.288811335686, 23780.0, 7037.22590515043, 8250.958745206235, 8270.462419942685, 8370.707025254087, 8446.282066024334, 4484.461864576272, 4526.434195725535, 4528.02647430804, 4580.221362368406, 4599.425071866017, 2999.6700362960055, 3119.1266445395327, 3167.8279036756085, 3531.2231309111953, 3714.1643130295465, 642.389729756733, 646.6023395611664, 650.5966300893382, 653.9378759017885, 665.5673812022128, 590.6042951222691, 672.4553111979312, 673.3434900971514, 700.1213477086225, 701.9649017549102, 8212.794680132925, 9222.44665320083, 9519.667246585484, 9541.856872146924, 9557.856632150524, 631.4853394483481, 668.4952860590223, 678.1571129882889, 693.414065114977, 717.9784606461815, 4535.569120933506, 4570.177368073712, 4685.495177278948, 4703.95296047042, 4794.424669039738, 96631.0, 149619.0, 158755.0, 160859.0, 161651.38348616599, 102929.0, 135126.0, 136829.63170368367, 139183.0, 142193.0, 99799.0, 105769.0, 109292.45353773021, 120311.0, 122792.0, 8440.324774017941, 8526.957365213135, 9896.554655040396, 9941.25440591973, 10126.240531959986, 45968.770156149, 63176.0, 65682.67158664367, 66249.00626490703, 67544.0, 84747.0, 94386.0, 94484.88241881541, 98736.50631746795, 99570.0, 13076.411561479566, 13216.801747973981, 13348.733025339634, 13460.461581536629, 13527.323633818467, 14719.926400368358, 14831.777523337374, 14963.77554336664, 15162.862785290927, 15277.77083343773, 13861.306934653025, 14141.292935352985, 14267.42930282777, 14378.281085945451, 14555.636109097357, 13691.383887724876, 13756.793648095087, 13887.930560347539, 14381.568552943429, 14564.271786410849, 13625.289589717, 13726.86273137256, 13760.587182384545, 13797.0, 13892.0, 11388.658340249805, 11505.597304094317, 11525.538978441104, 11609.422226662868, 11749.823752643888, 7473.925260747323, 9423.010583888867, 10458.63394781179, 11410.529260713422, 11431.085513159094], "value": 7932.522382012654, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1571.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 117.0, 110.0, 150.0, 103.0, 148.0, 170.0, 99.0, 110.0, 143.0], "value": 125.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 113.0, 144.0, 160.0, 106.0, 133.0, 134.0, 116.0, 177.0, 96.0], "value": 132.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [218.0, 264.0, 275.0, 217.0, 196.0, 199.0, 192.0, 195.0, 194.0, 200.0], "value": 215.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 81.0, 74.0, 144.0, 59.0, 58.0, 61.0, 61.0, 139.0, 59.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 74.0, 123.0, 72.0, 73.0, 79.0, 113.0, 71.0, 76.0, 115.0], "value": 86.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 87.0, 85.0, 89.0, 90.0, 118.0, 86.0, 88.0, 85.0], "value": 90.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 96.0, 94.0, 95.0, 95.0, 95.0, 94.0, 115.0, 150.0, 116.0], "value": 104.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 142.0, 126.0, 93.0, 98.0, 84.0, 154.0, 148.0, 92.0, 90.0], "value": 113.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 61.0, 56.0, 56.0, 59.0, 56.0, 60.0, 58.0, 73.0], "value": 59.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 75.0, 69.0, 76.0, 77.0, 69.0, 74.0, 70.0, 70.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 102.0, 105.0, 105.0, 96.0, 86.0, 92.0, 88.0, 88.0, 98.0], "value": 95.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 137.0, 140.0, 137.0, 140.0, 167.0, 133.0, 164.0, 207.0, 156.0], "value": 151.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 175.0, 169.0, 171.0, 172.0, 170.0, 170.0, 169.0, 163.0, 167.0], "value": 170.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 64.0, 64.0, 82.0, 89.0, 87.0, 83.0, 67.0, 83.0], "value": 75.6, "unit": "score"}]}]} 22:47:34 INFO - Return code: 0 22:47:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:47:34 ERROR - # TBPL SUCCESS # 22:47:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:47:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:47:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:47:34 INFO - 2016-08-16 22:47:34.483 screenresolution[1660:10589] starting screenresolution argv=screenresolution get 22:47:34 INFO - 2016-08-16 22:47:34.486 screenresolution[1660:10589] Display 0: 1600x1200x32@60 22:47:34 INFO - 2016-08-16 22:47:34.492 screenresolution[1661:10592] starting screenresolution argv=screenresolution list 22:47:34 INFO - Available Modes on Display 0 22:47:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:47:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:47:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:47:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:47:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:47:34 INFO - Intel Iris: 22:47:34 INFO - Chipset Model: Intel Iris 22:47:34 INFO - Type: GPU 22:47:34 INFO - Bus: Built-In 22:47:34 INFO - VRAM (Dynamic, Max): 1536 MB 22:47:34 INFO - Vendor: Intel (0x8086) 22:47:34 INFO - Device ID: 0x0a2e 22:47:34 INFO - Revision ID: 0x0009 22:47:34 INFO - Displays: 22:47:34 INFO - Display: 22:47:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:47:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:47:34 INFO - Display Serial Number: 1600x1200 60 22:47:34 INFO - Main Display: Yes 22:47:34 INFO - Mirror: Off 22:47:34 INFO - Online: Yes 22:47:34 INFO - Rotation: Supported 22:47:34 INFO - Return code: 0 22:47:34 INFO - Running post-action listener: _resource_record_post_action 22:47:34 INFO - [mozharness: 2016-08-17 05:47:34.737278Z] Finished run-tests step (success) 22:47:34 INFO - Running post-run listener: _resource_record_post_run 22:47:34 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 38142976; Write bytes: 706895872; Read time: 389; Write time: 1927 22:47:34 INFO - TinderboxPrint: CPU usage
54.6% 22:47:34 INFO - TinderboxPrint: I/O read bytes / time
38,142,976 / 389 22:47:34 INFO - TinderboxPrint: I/O write bytes / time
706,895,872 / 1,927 22:47:34 INFO - TinderboxPrint: CPU idle
2,196.7 (45.4%) 22:47:34 INFO - TinderboxPrint: CPU system
982.5 (20.3%) 22:47:34 INFO - TinderboxPrint: CPU user
1,658.5 (34.3%) 22:47:34 INFO - TinderboxPrint: Swap in / out
443,023,360 / 0 22:47:34 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 398365184; Write bytes: 393005056; Read time: 29547; Write time: 708 22:47:34 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 36066304; Write bytes: 298006528; Read time: 366; Write time: 1179 22:47:35 INFO - Running post-run listener: _upload_blobber_files 22:47:35 INFO - Blob upload gear active. 22:47:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:47:35 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 22:47:35 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'] 22:47:35 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 22:47:35 INFO - (blobuploader) - INFO - Open directory for files ... 22:47:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:47:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:47:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:47:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:47:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:47:36 INFO - (blobuploader) - INFO - Done attempting. 22:47:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:47:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:47:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:47:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:47:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:47:37 INFO - (blobuploader) - INFO - Done attempting. 22:47:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:47:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:47:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:47:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:47:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:47:39 INFO - (blobuploader) - INFO - Done attempting. 22:47:39 INFO - (blobuploader) - INFO - Iteration through files over. 22:47:39 INFO - Return code: 0 22:47:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:47:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:47:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0bd611e34ad828caadb946db49b9e3c1c4f43133492b67fae257dffac9099e8324dd0276378893b5fbdb03777f178aa3eab9b091025884e9311d47751358f0f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d3aadc5d3a047feb4948370b40a5b60657d4c0e9a17878655cc7d6259accdb799a607ae9773bee31b9d011aa4b81535213ddcad776bdcd3db380c9ceb41f0cfb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c1e6936471a1a8bd5aebb05358de21b5b98e9a6ccf463f4250a77950d96ac94b9d8146d9fd60c6f09003d7d9c7752c35eff17ae34c9ba7d3cce6b07bca3efcc"} 22:47:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:47:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:47:39 INFO - Contents: 22:47:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0bd611e34ad828caadb946db49b9e3c1c4f43133492b67fae257dffac9099e8324dd0276378893b5fbdb03777f178aa3eab9b091025884e9311d47751358f0f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d3aadc5d3a047feb4948370b40a5b60657d4c0e9a17878655cc7d6259accdb799a607ae9773bee31b9d011aa4b81535213ddcad776bdcd3db380c9ceb41f0cfb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c1e6936471a1a8bd5aebb05358de21b5b98e9a6ccf463f4250a77950d96ac94b9d8146d9fd60c6f09003d7d9c7752c35eff17ae34c9ba7d3cce6b07bca3efcc"} 22:47:39 INFO - Running post-run listener: copy_logs_to_upload_dir 22:47:39 INFO - Copying logs to upload dir... 22:47:39 INFO - mkdir: /builds/slave/test/build/upload/logs 22:47:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.251374 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-16 22:47:39.469838) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 22:47:39.473054) ========= 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.TqTY2CJhIk/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.dqxKPEy9Xw/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0bd611e34ad828caadb946db49b9e3c1c4f43133492b67fae257dffac9099e8324dd0276378893b5fbdb03777f178aa3eab9b091025884e9311d47751358f0f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d3aadc5d3a047feb4948370b40a5b60657d4c0e9a17878655cc7d6259accdb799a607ae9773bee31b9d011aa4b81535213ddcad776bdcd3db380c9ceb41f0cfb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c1e6936471a1a8bd5aebb05358de21b5b98e9a6ccf463f4250a77950d96ac94b9d8146d9fd60c6f09003d7d9c7752c35eff17ae34c9ba7d3cce6b07bca3efcc"} build_url:https://queue.taskcluster.net/v1/task/U0j5oMbGRFqxKR6TpX-SXw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011012 build_url: 'https://queue.taskcluster.net/v1/task/U0j5oMbGRFqxKR6TpX-SXw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0bd611e34ad828caadb946db49b9e3c1c4f43133492b67fae257dffac9099e8324dd0276378893b5fbdb03777f178aa3eab9b091025884e9311d47751358f0f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d3aadc5d3a047feb4948370b40a5b60657d4c0e9a17878655cc7d6259accdb799a607ae9773bee31b9d011aa4b81535213ddcad776bdcd3db380c9ceb41f0cfb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c1e6936471a1a8bd5aebb05358de21b5b98e9a6ccf463f4250a77950d96ac94b9d8146d9fd60c6f09003d7d9c7752c35eff17ae34c9ba7d3cce6b07bca3efcc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 22:47:39.506556) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 22:47:39.506893) ========= 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.TqTY2CJhIk/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.dqxKPEy9Xw/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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.005131 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 22:47:39.555527) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 22:47:39.555851) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 22:47:39.556188) ========= ========= Total master_lag: 0.19 =========