builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0231 starttime: 1471610131.96 results: success (0) buildid: 20160819030226 builduid: 27059735f4094052986499b66d6b521b revision: cf06fbc831754e54c6abb71d3136597488a530e0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 05:35:31.963112) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 05:35:31.963553) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 05:35:31.963836) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 05:35:31.987255) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 05:35:31.987603) ========= 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.WaamHDsmci/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.ET5fIUcrY6/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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-19 05:35:31-- 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% 8.77M=0.001s 2016-08-19 05:35:32 (8.77 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117828 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 05:35:32.127823) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 05:35:32.128164) ========= 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.WaamHDsmci/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.ET5fIUcrY6/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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.020359 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 05:35:32.177492) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-19 05:35:32.177851) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cf06fbc831754e54c6abb71d3136597488a530e0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev cf06fbc831754e54c6abb71d3136597488a530e0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WaamHDsmci/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.ET5fIUcrY6/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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-19 05:35:32,258 truncating revision to first 12 chars 2016-08-19 05:35:32,258 Setting DEBUG logging. 2016-08-19 05:35:32,258 attempt 1/10 2016-08-19 05:35:32,259 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cf06fbc83175?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 05:35:33,966 unpacking tar archive at: mozilla-central-cf06fbc83175/testing/mozharness/ program finished with exit code 0 elapsedTime=1.972707 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-19 05:35:34.173427) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 05:35:34.173756) ========= script_repo_revision: cf06fbc831754e54c6abb71d3136597488a530e0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 05:35:34.174192) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 05:35:34.174467) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 05:35:34.198013) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-19 05:35:34.198359) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WaamHDsmci/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.ET5fIUcrY6/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 05:35:34 INFO - MultiFileLogger online at 20160819 05:35:34 in /builds/slave/test 05:35:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:35:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:35:34 INFO - {'append_to_log': False, 05:35:34 INFO - 'base_work_dir': '/builds/slave/test', 05:35:34 INFO - 'blob_upload_branch': 'Firefox', 05:35:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:35:34 INFO - 'branch': 'Firefox', 05:35:34 INFO - 'buildbot_json_path': 'buildprops.json', 05:35:34 INFO - 'config_files': ('talos/mac_config.py',), 05:35:34 INFO - 'default_actions': ('clobber', 05:35:34 INFO - 'read-buildbot-config', 05:35:34 INFO - 'download-and-extract', 05:35:34 INFO - 'populate-webroot', 05:35:34 INFO - 'create-virtualenv', 05:35:34 INFO - 'install', 05:35:34 INFO - 'run-tests'), 05:35:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:35:34 INFO - 'download_minidump_stackwalk': True, 05:35:34 INFO - 'download_symbols': 'ondemand', 05:35:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:35:34 INFO - 'tooltool.py': '/tools/tooltool.py', 05:35:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:35:34 INFO - '/tools/misc-python/virtualenv.py')}, 05:35:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:35:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:35:34 INFO - 'installer_path': 'installer.exe', 05:35:34 INFO - 'log_level': 'info', 05:35:34 INFO - 'log_name': 'talos', 05:35:34 INFO - 'log_to_console': True, 05:35:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:35:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:35:34 INFO - 'opt_config_files': (), 05:35:34 INFO - 'pip_index': False, 05:35:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:35:34 INFO - 'cmd': ('bash', 05:35:34 INFO - '-c', 05:35:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:35:34 INFO - 'enabled': True, 05:35:34 INFO - 'halt_on_failure': False, 05:35:34 INFO - 'name': 'check_screen_resolution'},), 05:35:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:35:34 INFO - 'cmd': ('bash', 05:35:34 INFO - '-c', 05:35:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:35:34 INFO - 'enabled': True, 05:35:34 INFO - 'halt_on_failure': False, 05:35:34 INFO - 'name': 'check_screen_resolution'},), 05:35:34 INFO - 'run_cmd_checks_enabled': True, 05:35:34 INFO - 'sps_profile': False, 05:35:34 INFO - 'sps_profile_interval': 0, 05:35:34 INFO - 'suite': 'dromaeojs-e10s', 05:35:34 INFO - 'system_bits': '32', 05:35:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:35:34 INFO - 'title': 't-yosemite-r7-0231', 05:35:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:35:34 INFO - 'use_talos_json': True, 05:35:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:35:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:35:34 INFO - 'work_dir': 'build'} 05:35:34 INFO - [mozharness: 2016-08-19 12:35:34.403415Z] Running clobber step. 05:35:34 INFO - Running pre-action listener: _resource_record_pre_action 05:35:34 INFO - Running main action method: clobber 05:35:34 INFO - rmtree: /builds/slave/test/build 05:35:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:35:34 INFO - Running post-action listener: _resource_record_post_action 05:35:34 INFO - [mozharness: 2016-08-19 12:35:34.607216Z] Finished clobber step (success) 05:35:34 INFO - [mozharness: 2016-08-19 12:35:34.607366Z] Running read-buildbot-config step. 05:35:34 INFO - Running pre-action listener: _resource_record_pre_action 05:35:34 INFO - Running main action method: read_buildbot_config 05:35:34 INFO - Using buildbot properties: 05:35:34 INFO - { 05:35:34 INFO - "project": "", 05:35:34 INFO - "product": "firefox", 05:35:34 INFO - "script_repo_revision": "production", 05:35:34 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:35:34 INFO - "repository": "", 05:35:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:35:34 INFO - "buildid": "20160819030226", 05:35:34 INFO - "stage_platform": "macosx64", 05:35:34 INFO - "basedir": "/builds/slave/test", 05:35:34 INFO - "nightly_build": "True", 05:35:34 INFO - "buildnumber": 4, 05:35:34 INFO - "slavename": "t-yosemite-r7-0231", 05:35:34 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:35:34 INFO - "platform": "yosemite_r7", 05:35:34 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:35:34 INFO - "branch": "mozilla-central", 05:35:34 INFO - "repo_path": "mozilla-central", 05:35:34 INFO - "revision": "cf06fbc831754e54c6abb71d3136597488a530e0", 05:35:34 INFO - "pgo_build": "False", 05:35:34 INFO - "builduid": "27059735f4094052986499b66d6b521b", 05:35:34 INFO - "slavebuilddir": "test" 05:35:34 INFO - } 05:35:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/a8HGQK-4SPmvztM8K_myOg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 05:35:34 INFO - Running post-action listener: _resource_record_post_action 05:35:34 INFO - [mozharness: 2016-08-19 12:35:34.611348Z] Finished read-buildbot-config step (success) 05:35:34 INFO - [mozharness: 2016-08-19 12:35:34.611475Z] Running download-and-extract step. 05:35:34 INFO - Running pre-action listener: _resource_record_pre_action 05:35:34 INFO - Running main action method: download_and_extract 05:35:34 INFO - mkdir: /builds/slave/test/build/tests 05:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:34 INFO - trying https://queue.taskcluster.net/v1/task/a8HGQK-4SPmvztM8K_myOg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 05:35:34 INFO - Downloading https://queue.taskcluster.net/v1/task/a8HGQK-4SPmvztM8K_myOg/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 05:35:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a8HGQK-4SPmvztM8K_myOg/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 05:35:35 INFO - Downloaded 1199 bytes. 05:35:35 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:35:35 INFO - Using the following test package requirements: 05:35:35 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:35:35 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:35:35 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 05:35:35 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:35:35 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 05:35:35 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:35:35 INFO - u'jsshell-mac.zip'], 05:35:35 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:35:35 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 05:35:35 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:35:35 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:35:35 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 05:35:35 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:35:35 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 05:35:35 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:35:35 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 05:35:35 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:35:35 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 05:35:35 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:35 INFO - trying https://queue.taskcluster.net/v1/task/a8HGQK-4SPmvztM8K_myOg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:35:35 INFO - Downloading https://queue.taskcluster.net/v1/task/a8HGQK-4SPmvztM8K_myOg/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 05:35:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a8HGQK-4SPmvztM8K_myOg/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 05:35:36 INFO - Downloaded 16339607 bytes. 05:35:36 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 05:35:43 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 05:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:43 INFO - trying https://queue.taskcluster.net/v1/task/a8HGQK-4SPmvztM8K_myOg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:35:43 INFO - Downloading https://queue.taskcluster.net/v1/task/a8HGQK-4SPmvztM8K_myOg/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 05:35:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a8HGQK-4SPmvztM8K_myOg/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 05:35:44 INFO - Downloaded 16339607 bytes. 05:35:44 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 05:35:50 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')]} 05:35:50 INFO - trying https://queue.taskcluster.net/v1/task/a8HGQK-4SPmvztM8K_myOg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:35:50 INFO - Downloading https://queue.taskcluster.net/v1/task/a8HGQK-4SPmvztM8K_myOg/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 05:35:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a8HGQK-4SPmvztM8K_myOg/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 05:35:51 INFO - Downloaded 14413981 bytes. 05:35:51 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 05:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:51 INFO - trying https://queue.taskcluster.net/v1/task/a8HGQK-4SPmvztM8K_myOg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:35:51 INFO - Downloading https://queue.taskcluster.net/v1/task/a8HGQK-4SPmvztM8K_myOg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 05:35:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a8HGQK-4SPmvztM8K_myOg/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 05:35:54 INFO - Downloaded 111382805 bytes. 05:35:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a8HGQK-4SPmvztM8K_myOg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:35:54 INFO - mkdir: /builds/slave/test/properties 05:35:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:35:54 INFO - Writing to file /builds/slave/test/properties/build_url 05:35:54 INFO - Contents: 05:35:54 INFO - build_url:https://queue.taskcluster.net/v1/task/a8HGQK-4SPmvztM8K_myOg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:35:55 INFO - Running post-action listener: _resource_record_post_action 05:35:55 INFO - Running post-action listener: set_extra_try_arguments 05:35:55 INFO - [mozharness: 2016-08-19 12:35:55.232762Z] Finished download-and-extract step (success) 05:35:55 INFO - [mozharness: 2016-08-19 12:35:55.232942Z] Running populate-webroot step. 05:35:55 INFO - Running pre-action listener: _resource_record_pre_action 05:35:55 INFO - Running main action method: populate_webroot 05:35:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:35:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:35:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:35:55 INFO - '--tppagecycles', 05:35:55 INFO - '7'], 05:35:55 INFO - 'tests': ['tsvgm']}}, 05:35:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:35:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:35:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:35:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:35:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:35:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:35:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:55 INFO - 'talos_options': ['--disable-e10s'], 05:35:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:55 INFO - 'talos_options': ['--disable-e10s'], 05:35:55 INFO - 'tests': ['damp', 'tps']}, 05:35:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:55 INFO - 'tests': ['damp', 'tps']}, 05:35:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:35:55 INFO - 'tests': ['dromaeo_dom']}, 05:35:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:35:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:35:55 INFO - 'tests': ['basic_compositor_video']}, 05:35:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:35:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:35:55 INFO - 'tests': ['a11yr', 05:35:55 INFO - 'ts_paint', 05:35:55 INFO - 'tpaint', 05:35:55 INFO - 'sessionrestore', 05:35:55 INFO - 'sessionrestore_no_auto_restore', 05:35:55 INFO - 'tabpaint']}, 05:35:55 INFO - 'other-e10s': {'tests': ['a11yr', 05:35:55 INFO - 'ts_paint', 05:35:55 INFO - 'tpaint', 05:35:55 INFO - 'sessionrestore', 05:35:55 INFO - 'sessionrestore_no_auto_restore', 05:35:55 INFO - 'tabpaint']}, 05:35:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:35:55 INFO - 'ts_paint', 05:35:55 INFO - 'tpaint', 05:35:55 INFO - 'sessionrestore', 05:35:55 INFO - 'sessionrestore_no_auto_restore', 05:35:55 INFO - 'tabpaint']}, 05:35:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:35:55 INFO - 'ts_paint', 05:35:55 INFO - 'tpaint', 05:35:55 INFO - 'sessionrestore', 05:35:55 INFO - 'sessionrestore_no_auto_restore', 05:35:55 INFO - 'tabpaint']}, 05:35:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:35:55 INFO - 'tests': ['a11yr', 05:35:55 INFO - 'ts_paint', 05:35:55 INFO - 'tpaint', 05:35:55 INFO - 'sessionrestore', 05:35:55 INFO - 'sessionrestore_no_auto_restore', 05:35:55 INFO - 'tabpaint']}, 05:35:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:35:55 INFO - 'tests': ['a11yr', 05:35:55 INFO - 'ts_paint', 05:35:55 INFO - 'tpaint', 05:35:55 INFO - 'sessionrestore', 05:35:55 INFO - 'sessionrestore_no_auto_restore', 05:35:55 INFO - 'tabpaint']}, 05:35:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:35:55 INFO - 'tests': ['tsvgx', 05:35:55 INFO - 'tsvgr_opacity', 05:35:55 INFO - 'tart', 05:35:55 INFO - 'tscrollx', 05:35:55 INFO - 'cart']}, 05:35:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:35:55 INFO - 'tsvgr_opacity', 05:35:55 INFO - 'tart', 05:35:55 INFO - 'tscrollx', 05:35:55 INFO - 'cart']}, 05:35:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:55 INFO - 'talos_options': ['--disable-e10s'], 05:35:55 INFO - 'tests': ['tp5o']}, 05:35:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:55 INFO - 'tests': ['tp5o']}, 05:35:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:55 INFO - 'talos_options': ['--disable-e10s', 05:35:55 INFO - '--xperf_path', 05:35:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:55 INFO - 'tests': ['tp5n']}, 05:35:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:55 INFO - 'talos_options': ['--xperf_path', 05:35:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:55 INFO - 'tests': ['tp5n']}}, 05:35:55 INFO - 'talos.zip': {'path': '', 05:35:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:35:55 INFO - Running post-action listener: _resource_record_post_action 05:35:55 INFO - [mozharness: 2016-08-19 12:35:55.252097Z] Finished populate-webroot step (success) 05:35:55 INFO - [mozharness: 2016-08-19 12:35:55.252229Z] Running create-virtualenv step. 05:35:55 INFO - Running pre-action listener: _resource_record_pre_action 05:35:55 INFO - Running main action method: create_virtualenv 05:35:55 INFO - Creating virtualenv /builds/slave/test/build/venv 05:35:55 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 05:35:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:35:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:35:55 INFO - Using real prefix '/tools/python27' 05:35:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:35:56 INFO - Installing distribute.............................................................................................................................................................................................done. 05:35:58 INFO - Installing pip.................done. 05:35:58 INFO - Return code: 0 05:35:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:58 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 0x102ec0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f55618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5b259e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e24d30>, '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 0x102b89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e1cb20>, '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.WaamHDsmci/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.ET5fIUcrY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 05:35:58 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 05:35:58 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 05:35:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WaamHDsmci/Render', 05:35:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:58 INFO - 'HOME': '/Users/cltbld', 05:35:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:58 INFO - 'LOGNAME': 'cltbld', 05:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:58 INFO - 'MOZ_NO_REMOTE': '1', 05:35:58 INFO - 'NO_EM_RESTART': '1', 05:35:58 INFO - 'PAGER': '/bin/cat', 05:35:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:58 INFO - 'PWD': '/builds/slave/test', 05:35:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:58 INFO - 'SHELL': '/bin/bash', 05:35:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ET5fIUcrY6/Listeners', 05:35:58 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 05:35:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:58 INFO - 'USER': 'cltbld', 05:35:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:58 INFO - 'XPC_FLAGS': '0x0', 05:35:58 INFO - 'XPC_SERVICE_NAME': '0', 05:35:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:59 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 05:35:59 INFO - Cleaning up... 05:35:59 INFO - Return code: 0 05:35:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:35: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')]} 05:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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')]} 05:35:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102ec0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f55618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5b259e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e24d30>, '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 0x102b89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e1cb20>, '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.WaamHDsmci/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.ET5fIUcrY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 05:35:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:35:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:35:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WaamHDsmci/Render', 05:35:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:59 INFO - 'HOME': '/Users/cltbld', 05:35:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:59 INFO - 'LOGNAME': 'cltbld', 05:35:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:59 INFO - 'MOZ_NO_REMOTE': '1', 05:35:59 INFO - 'NO_EM_RESTART': '1', 05:35:59 INFO - 'PAGER': '/bin/cat', 05:35:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:59 INFO - 'PWD': '/builds/slave/test', 05:35:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:59 INFO - 'SHELL': '/bin/bash', 05:35:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ET5fIUcrY6/Listeners', 05:35:59 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 05:35:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:59 INFO - 'USER': 'cltbld', 05:35:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:59 INFO - 'XPC_FLAGS': '0x0', 05:35:59 INFO - 'XPC_SERVICE_NAME': '0', 05:35:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:59 INFO - Downloading/unpacking psutil>=3.1.1 05:35:59 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 05:35:59 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 05:35:59 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 05:35:59 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 05:35:59 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 05:35:59 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 05:36:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:36:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:36:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:36:02 INFO - Installing collected packages: psutil 05:36:02 INFO - Running setup.py install for psutil 05:36:02 INFO - building 'psutil._psutil_osx' extension 05:36:02 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 05:36:02 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 05:36:02 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 05:36:02 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 05:36:02 INFO - building 'psutil._psutil_posix' extension 05:36:02 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 05:36:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:36:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:36:02 INFO - ^ 05:36:03 INFO - 1 warning generated. 05:36:03 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 05:36:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:36:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:36:03 INFO - Successfully installed psutil 05:36:03 INFO - Cleaning up... 05:36:03 INFO - Return code: 0 05:36:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:36:03 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')]} 05:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:03 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')]} 05:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:03 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 0x102ec0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f55618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5b259e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e24d30>, '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 0x102b89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e1cb20>, '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.WaamHDsmci/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.ET5fIUcrY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 05:36:03 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 05:36:03 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 05:36:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WaamHDsmci/Render', 05:36:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:03 INFO - 'HOME': '/Users/cltbld', 05:36:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:03 INFO - 'LOGNAME': 'cltbld', 05:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:03 INFO - 'MOZ_NO_REMOTE': '1', 05:36:03 INFO - 'NO_EM_RESTART': '1', 05:36:03 INFO - 'PAGER': '/bin/cat', 05:36:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:03 INFO - 'PWD': '/builds/slave/test', 05:36:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:03 INFO - 'SHELL': '/bin/bash', 05:36:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ET5fIUcrY6/Listeners', 05:36:03 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 05:36:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:03 INFO - 'USER': 'cltbld', 05:36:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:03 INFO - 'XPC_FLAGS': '0x0', 05:36:03 INFO - 'XPC_SERVICE_NAME': '0', 05:36:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:36:03 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 05:36:03 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 05:36:03 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 05:36:03 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 05:36:03 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 05:36:03 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 05:36:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:36:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:36:06 INFO - Installing collected packages: mozsystemmonitor 05:36:06 INFO - Running setup.py install for mozsystemmonitor 05:36:06 INFO - Successfully installed mozsystemmonitor 05:36:06 INFO - Cleaning up... 05:36:06 INFO - Return code: 0 05:36:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102ec0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f55618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5b259e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e24d30>, '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 0x102b89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e1cb20>, '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.WaamHDsmci/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.ET5fIUcrY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 05:36:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:36:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:36:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WaamHDsmci/Render', 05:36:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:06 INFO - 'HOME': '/Users/cltbld', 05:36:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:06 INFO - 'LOGNAME': 'cltbld', 05:36:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:06 INFO - 'MOZ_NO_REMOTE': '1', 05:36:06 INFO - 'NO_EM_RESTART': '1', 05:36:06 INFO - 'PAGER': '/bin/cat', 05:36:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:06 INFO - 'PWD': '/builds/slave/test', 05:36:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:06 INFO - 'SHELL': '/bin/bash', 05:36:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ET5fIUcrY6/Listeners', 05:36:06 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 05:36:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:06 INFO - 'USER': 'cltbld', 05:36:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:06 INFO - 'XPC_FLAGS': '0x0', 05:36:06 INFO - 'XPC_SERVICE_NAME': '0', 05:36:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:06 INFO - Downloading/unpacking jsonschema==2.5.1 05:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:36:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:36:08 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 05:36:08 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 05:36:08 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 05:36:08 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 05:36:08 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 05:36:08 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 05:36:09 INFO - Downloading functools32-3.2.3-2.tar.gz 05:36:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:36:09 INFO - warning: no files found matching '*.txt' 05:36:09 INFO - no previously-included directories found matching 'build' 05:36:09 INFO - no previously-included directories found matching 'dist' 05:36:09 INFO - no previously-included directories found matching '.git*' 05:36:09 INFO - Installing collected packages: jsonschema, functools32 05:36:09 INFO - Running setup.py install for functools32 05:36:09 INFO - warning: no files found matching '*.txt' 05:36:09 INFO - no previously-included directories found matching 'build' 05:36:09 INFO - no previously-included directories found matching 'dist' 05:36:09 INFO - no previously-included directories found matching '.git*' 05:36:09 INFO - Successfully installed jsonschema functools32 05:36:09 INFO - Cleaning up... 05:36:09 INFO - Return code: 0 05:36:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:36:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102ec0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f55618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5b259e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e24d30>, '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 0x102b89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e1cb20>, '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.WaamHDsmci/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.ET5fIUcrY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 05:36:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:36:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:36:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WaamHDsmci/Render', 05:36:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:09 INFO - 'HOME': '/Users/cltbld', 05:36:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:09 INFO - 'LOGNAME': 'cltbld', 05:36:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:09 INFO - 'MOZ_NO_REMOTE': '1', 05:36:09 INFO - 'NO_EM_RESTART': '1', 05:36:09 INFO - 'PAGER': '/bin/cat', 05:36:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:09 INFO - 'PWD': '/builds/slave/test', 05:36:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:09 INFO - 'SHELL': '/bin/bash', 05:36:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ET5fIUcrY6/Listeners', 05:36:09 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 05:36:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:09 INFO - 'USER': 'cltbld', 05:36:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:09 INFO - 'XPC_FLAGS': '0x0', 05:36:09 INFO - 'XPC_SERVICE_NAME': '0', 05:36:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:36:10 INFO - Cleaning up... 05:36:10 INFO - Return code: 0 05:36:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:10 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 0x102ec0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f55618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5b259e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e24d30>, '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 0x102b89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e1cb20>, '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.WaamHDsmci/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.ET5fIUcrY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 05:36:10 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 05:36:10 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 05:36:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WaamHDsmci/Render', 05:36:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:10 INFO - 'HOME': '/Users/cltbld', 05:36:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:10 INFO - 'LOGNAME': 'cltbld', 05:36:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:10 INFO - 'MOZ_NO_REMOTE': '1', 05:36:10 INFO - 'NO_EM_RESTART': '1', 05:36:10 INFO - 'PAGER': '/bin/cat', 05:36:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:10 INFO - 'PWD': '/builds/slave/test', 05:36:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:10 INFO - 'SHELL': '/bin/bash', 05:36:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ET5fIUcrY6/Listeners', 05:36:10 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 05:36:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:10 INFO - 'USER': 'cltbld', 05:36:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:10 INFO - 'XPC_FLAGS': '0x0', 05:36:10 INFO - 'XPC_SERVICE_NAME': '0', 05:36:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:10 INFO - Downloading/unpacking blobuploader==1.2.4 05:36:10 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 05:36:10 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 05:36:10 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 05:36:10 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 05:36:10 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 05:36:10 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 05:36:12 INFO - Downloading blobuploader-1.2.4.tar.gz 05:36:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:36:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:36: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 05:36: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 05:36: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 05:36: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 05:36: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 05:36: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 05:36:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:36:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:14 INFO - Downloading docopt-0.6.1.tar.gz 05:36:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:36:14 INFO - Installing collected packages: blobuploader, requests, docopt 05:36:14 INFO - Running setup.py install for blobuploader 05:36:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:36:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:36:14 INFO - Running setup.py install for requests 05:36:14 INFO - Running setup.py install for docopt 05:36:14 INFO - Successfully installed blobuploader requests docopt 05:36:14 INFO - Cleaning up... 05:36:15 INFO - Return code: 0 05:36:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:15 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 0x102ec0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f55618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5b259e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e24d30>, '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 0x102b89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e1cb20>, '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.WaamHDsmci/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.ET5fIUcrY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 05:36:15 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 05:36:15 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 05:36:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WaamHDsmci/Render', 05:36:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:15 INFO - 'HOME': '/Users/cltbld', 05:36:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:15 INFO - 'LOGNAME': 'cltbld', 05:36:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:15 INFO - 'MOZ_NO_REMOTE': '1', 05:36:15 INFO - 'NO_EM_RESTART': '1', 05:36:15 INFO - 'PAGER': '/bin/cat', 05:36:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:15 INFO - 'PWD': '/builds/slave/test', 05:36:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:15 INFO - 'SHELL': '/bin/bash', 05:36:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ET5fIUcrY6/Listeners', 05:36:15 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 05:36:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:15 INFO - 'USER': 'cltbld', 05:36:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:15 INFO - 'XPC_FLAGS': '0x0', 05:36:15 INFO - 'XPC_SERVICE_NAME': '0', 05:36:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:36:15 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-JIzhsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:36:15 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-fnWBw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:36:15 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-uWFPRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:36:15 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-2fEOTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:36:15 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-qgkJmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:36:15 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-kmTTR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:36:15 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-DtGGjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:36:16 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-J8c86C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:36:16 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-0pfLIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:36:16 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-9VG9cK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:36:16 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-tUfqXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:36:16 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-uG2LjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:36:16 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-Py7FVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:36:16 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-SsAZDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:16 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-zub6sa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:36:16 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-LqPQH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:36:16 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-EmXefg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:36:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:36:17 INFO - Running setup.py install for manifestparser 05:36:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:36:17 INFO - Running setup.py install for mozcrash 05:36:17 INFO - Running setup.py install for mozdebug 05:36:17 INFO - Running setup.py install for mozdevice 05:36:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:36:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:36:17 INFO - Running setup.py install for mozfile 05:36:17 INFO - Running setup.py install for mozhttpd 05:36:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:36:17 INFO - Running setup.py install for mozinfo 05:36:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:36:18 INFO - Running setup.py install for mozInstall 05:36:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:36:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:36:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:36:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:36:18 INFO - Running setup.py install for mozleak 05:36:18 INFO - Running setup.py install for mozlog 05:36:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:36:18 INFO - Running setup.py install for moznetwork 05:36:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:36:18 INFO - Running setup.py install for mozprocess 05:36:18 INFO - Running setup.py install for mozprofile 05:36:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:36:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:36:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:36:19 INFO - Running setup.py install for mozrunner 05:36:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:36:19 INFO - Running setup.py install for mozscreenshot 05:36:19 INFO - Running setup.py install for moztest 05:36:19 INFO - Running setup.py install for mozversion 05:36:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:36:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:36:19 INFO - Cleaning up... 05:36:19 INFO - Return code: 0 05:36:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:19 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')]} 05:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:19 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')]} 05:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:19 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 0x102ec0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f55618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5b259e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e24d30>, '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 0x102b89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e1cb20>, '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.WaamHDsmci/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.ET5fIUcrY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 05:36:19 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 05:36:19 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 05:36:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WaamHDsmci/Render', 05:36:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:19 INFO - 'HOME': '/Users/cltbld', 05:36:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:19 INFO - 'LOGNAME': 'cltbld', 05:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:19 INFO - 'MOZ_NO_REMOTE': '1', 05:36:19 INFO - 'NO_EM_RESTART': '1', 05:36:19 INFO - 'PAGER': '/bin/cat', 05:36:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:19 INFO - 'PWD': '/builds/slave/test', 05:36:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:19 INFO - 'SHELL': '/bin/bash', 05:36:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ET5fIUcrY6/Listeners', 05:36:19 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 05:36:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:19 INFO - 'USER': 'cltbld', 05:36:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:19 INFO - 'XPC_FLAGS': '0x0', 05:36:19 INFO - 'XPC_SERVICE_NAME': '0', 05:36:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:36:19 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-ZLLk7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:36:20 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)) 05:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:36:20 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-4Ni5qM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:36:20 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)) 05:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:36:20 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-myy0PU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:36:20 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)) 05:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:36:20 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-MYYMGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:36:20 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)) 05:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:36:20 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-vUoXT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:36:20 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)) 05:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:36:20 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-LELKsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:36:20 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)) 05:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:36:20 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-JKKcEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:36:20 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)) 05:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:36:20 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-NlDxhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:36:20 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)) 05:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:36:20 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-cFl7VB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:36:20 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)) 05:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:36:20 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-FJJBBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:36: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)) 05:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:36:20 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-2giJ1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:36:21 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)) 05:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:36:21 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-MNDYlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:36:21 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)) 05:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:36:21 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-q37esl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:36:21 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)) 05:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:36:21 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-qUS_CO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:36:21 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)) 05:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:21 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-rUPNOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:21 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)) 05:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:36:21 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-_sMuAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:36:21 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)) 05:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:36:21 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-1a8wbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:36:21 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)) 05:36:21 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)) 05:36:21 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)) 05:36:21 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)) 05:36:21 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)) 05:36:21 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)) 05:36:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:36:21 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 05:36:21 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 05:36:21 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 05:36:21 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 05:36:21 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 05:36:21 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 05:36:24 INFO - Downloading blessings-1.6.tar.gz 05:36:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:36:24 INFO - Installing collected packages: blessings 05:36:24 INFO - Running setup.py install for blessings 05:36:24 INFO - Successfully installed blessings 05:36:24 INFO - Cleaning up... 05:36:24 INFO - Return code: 0 05:36:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:36:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:36:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:36:24 INFO - Reading from file tmpfile_stdout 05:36:24 INFO - Current package versions: 05:36:24 INFO - blessings == 1.6 05:36:24 INFO - blobuploader == 1.2.4 05:36:24 INFO - docopt == 0.6.1 05:36:24 INFO - functools32 == 3.2.3-2 05:36:24 INFO - jsonschema == 2.5.1 05:36:24 INFO - manifestparser == 1.1 05:36:24 INFO - mozInstall == 1.12 05:36:24 INFO - mozcrash == 0.17 05:36:24 INFO - mozdebug == 0.1 05:36:24 INFO - mozdevice == 0.48 05:36:24 INFO - mozfile == 1.2 05:36:24 INFO - mozhttpd == 0.7 05:36:24 INFO - mozinfo == 0.9 05:36:24 INFO - mozleak == 0.1 05:36:24 INFO - mozlog == 3.3 05:36:24 INFO - moznetwork == 0.27 05:36:24 INFO - mozprocess == 0.23 05:36:24 INFO - mozprofile == 0.28 05:36:24 INFO - mozrunner == 6.12 05:36:24 INFO - mozscreenshot == 0.1 05:36:24 INFO - mozsystemmonitor == 0.3 05:36:24 INFO - moztest == 0.7 05:36:24 INFO - mozversion == 1.4 05:36:24 INFO - psutil == 3.1.1 05:36:24 INFO - requests == 1.2.3 05:36:24 INFO - wsgiref == 0.1.2 05:36:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36: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')]} 05:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36: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')]} 05:36:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36: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 0x102ec0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f55618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5b259e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e24d30>, '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 0x102b89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e1cb20>, '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.WaamHDsmci/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.ET5fIUcrY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 05:36: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 05:36: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 05:36:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WaamHDsmci/Render', 05:36:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:24 INFO - 'HOME': '/Users/cltbld', 05:36:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:24 INFO - 'LOGNAME': 'cltbld', 05:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:24 INFO - 'MOZ_NO_REMOTE': '1', 05:36:24 INFO - 'NO_EM_RESTART': '1', 05:36:24 INFO - 'PAGER': '/bin/cat', 05:36:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:24 INFO - 'PWD': '/builds/slave/test', 05:36:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:24 INFO - 'SHELL': '/bin/bash', 05:36:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ET5fIUcrY6/Listeners', 05:36:24 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 05:36:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:24 INFO - 'USER': 'cltbld', 05:36:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:24 INFO - 'XPC_FLAGS': '0x0', 05:36:24 INFO - 'XPC_SERVICE_NAME': '0', 05:36:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:25 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)) 05:36:25 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)) 05:36:25 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)) 05:36:25 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)) 05:36:25 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)) 05:36:25 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)) 05:36:25 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)) 05:36:25 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)) 05:36:25 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)) 05:36:25 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)) 05:36:25 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)) 05:36:25 INFO - Cleaning up... 05:36:25 INFO - Return code: 0 05:36:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:25 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 0x102ec0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f55618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5b259e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e24d30>, '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 0x102b89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e1cb20>, '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.WaamHDsmci/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.ET5fIUcrY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 05:36:25 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 05:36:25 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 05:36:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WaamHDsmci/Render', 05:36:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:25 INFO - 'HOME': '/Users/cltbld', 05:36:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:25 INFO - 'LOGNAME': 'cltbld', 05:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:25 INFO - 'MOZ_NO_REMOTE': '1', 05:36:25 INFO - 'NO_EM_RESTART': '1', 05:36:25 INFO - 'PAGER': '/bin/cat', 05:36:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:25 INFO - 'PWD': '/builds/slave/test', 05:36:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:25 INFO - 'SHELL': '/bin/bash', 05:36:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ET5fIUcrY6/Listeners', 05:36:25 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 05:36:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:25 INFO - 'USER': 'cltbld', 05:36:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:25 INFO - 'XPC_FLAGS': '0x0', 05:36:25 INFO - 'XPC_SERVICE_NAME': '0', 05:36:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:36:25 INFO - Cleaning up... 05:36:25 INFO - Return code: 0 05:36:25 INFO - Running post-action listener: _resource_record_post_action 05:36:25 INFO - Running post-action listener: _start_resource_monitoring 05:36:25 INFO - Starting resource monitoring. 05:36:25 INFO - [mozharness: 2016-08-19 12:36:25.373383Z] Finished create-virtualenv step (success) 05:36:25 INFO - [mozharness: 2016-08-19 12:36:25.374362Z] Running install step. 05:36:25 INFO - Running pre-action listener: _resource_record_pre_action 05:36:25 INFO - Running main action method: install 05:36:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:36:25 INFO - Reading from file tmpfile_stdout 05:36:25 INFO - Detecting whether we're running mozinstall >=1.0... 05:36:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:36:25 INFO - Reading from file tmpfile_stdout 05:36:25 INFO - Output received: 05:36:25 INFO - Usage: mozinstall [options] installer 05:36:25 INFO - Options: 05:36:25 INFO - -h, --help show this help message and exit 05:36:25 INFO - -d DEST, --destination=DEST 05:36:25 INFO - Directory to install application into. [default: 05:36:25 INFO - "/builds/slave/test"] 05:36:25 INFO - --app=APP Application being installed. [default: firefox] 05:36:25 INFO - mkdir: /builds/slave/test/build/application 05:36: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'] 05:36: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 05:37:00 INFO - Reading from file tmpfile_stdout 05:37:00 INFO - Output received: 05:37:00 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:37:00 INFO - Running post-action listener: _resource_record_post_action 05:37:00 INFO - [mozharness: 2016-08-19 12:37:00.254115Z] Finished install step (success) 05:37:00 INFO - [mozharness: 2016-08-19 12:37:00.254282Z] Running run-tests step. 05:37:00 INFO - Running pre-action listener: _resource_record_pre_action 05:37:00 INFO - Running main action method: run_tests 05:37:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:37:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:37:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:37:00 INFO - 2016-08-19 05:37:00.268 screenresolution[2269:280462] starting screenresolution argv=screenresolution get 05:37:00 INFO - 2016-08-19 05:37:00.271 screenresolution[2269:280462] Display 0: 1600x1200x32@60 05:37:00 INFO - 2016-08-19 05:37:00.277 screenresolution[2270:280464] starting screenresolution argv=screenresolution list 05:37:00 INFO - Available Modes on Display 0 05:37:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:37:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:37:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:37:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:37:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:37:00 INFO - Intel Iris: 05:37:00 INFO - Chipset Model: Intel Iris 05:37:00 INFO - Type: GPU 05:37:00 INFO - Bus: Built-In 05:37:00 INFO - VRAM (Dynamic, Max): 1536 MB 05:37:00 INFO - Vendor: Intel (0x8086) 05:37:00 INFO - Device ID: 0x0a2e 05:37:00 INFO - Revision ID: 0x0009 05:37:00 INFO - Displays: 05:37:00 INFO - Display: 05:37:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:37:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:37:00 INFO - Display Serial Number: 1600x1200 60 05:37:00 INFO - Main Display: Yes 05:37:00 INFO - Mirror: Off 05:37:00 INFO - Online: Yes 05:37:00 INFO - Rotation: Supported 05:37:00 INFO - Return code: 0 05:37:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:37:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:37:00 INFO - Python 2.7.3 05:37:00 INFO - Return code: 0 05:37:00 INFO - grabbing minidump binary from tooltool 05:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:00 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 0x102e24d30>, '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 0x102b89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e1cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:37:00 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 05:37:00 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 05:37:00 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 05:37:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:37:00 INFO - Return code: 0 05:37:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:37:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:37:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:37:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:37:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:37:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a8HGQK-4SPmvztM8K_myOg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0231', '--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 05:37:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a8HGQK-4SPmvztM8K_myOg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0231 --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 05:37:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WaamHDsmci/Render', 05:37:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:00 INFO - 'HOME': '/Users/cltbld', 05:37:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:00 INFO - 'LOGNAME': 'cltbld', 05:37:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:37:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:37:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:00 INFO - 'MOZ_NO_REMOTE': '1', 05:37:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:37:00 INFO - 'NO_EM_RESTART': '1', 05:37:00 INFO - 'PAGER': '/bin/cat', 05:37:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:00 INFO - 'PWD': '/builds/slave/test', 05:37:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:37:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:00 INFO - 'SHELL': '/bin/bash', 05:37:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ET5fIUcrY6/Listeners', 05:37:00 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 05:37:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:00 INFO - 'USER': 'cltbld', 05:37:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:00 INFO - 'XPC_FLAGS': '0x0', 05:37:00 INFO - 'XPC_SERVICE_NAME': '0', 05:37:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a8HGQK-4SPmvztM8K_myOg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0231', '--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 05:37:00 INFO - mozversion application_buildid: 20160819030226 05:37:00 INFO - mozversion application_changeset: cf06fbc831754e54c6abb71d3136597488a530e0 05:37:00 INFO - mozversion application_display_name: Nightly 05:37:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:37:00 INFO - mozversion application_name: Firefox 05:37:00 INFO - mozversion application_remotingname: firefox 05:37:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:37:00 INFO - mozversion application_vendor: Mozilla 05:37:00 INFO - mozversion application_version: 51.0a1 05:37:00 INFO - mozversion platform_buildid: 20160819030226 05:37:00 INFO - mozversion platform_changeset: cf06fbc831754e54c6abb71d3136597488a530e0 05:37:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:37:00 INFO - mozversion platform_version: 51.0a1 05:37:00 INFO - using testdate: 1471610220 05:37:00 INFO - actual date: 1471610220 05:37:00 INFO - starting webserver on 'localhost:50615' 05:37:00 INFO - SUITE-START | Running 2 tests 05:37:00 INFO - TEST-START | dromaeo_css 05:37:00 INFO - operating with platform_type : mac_ 05:37:00 INFO - Initialising browser for dromaeo_css test... 05:37:00 INFO - TEST-INFO | started process 2280 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmpNrmKid/profile http://localhost:50615/getInfo.html) 05:37:04 INFO - PROCESS | 2280 | __metrics Screen width/height:1600/1200 05:37:04 INFO - PROCESS | 2280 | colorDepth:24 05:37:04 INFO - PROCESS | 2280 | Browser inner width/height: 1024/689 05:37:04 INFO - PROCESS | 2280 | __metrics 05:37:04 ERROR - PROCESS | 2280 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 05:37:04 INFO - TEST-INFO | 2280: exit 0 05:37:04 INFO - Browser initialized. 05:37:04 INFO - Running cycle 1/1 for dromaeo_css test... 05:37:04 INFO - TEST-INFO | started process 2285 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmpNrmKid/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:37:16 INFO - PROCESS | 2285 | RSS: Main: 239394816 05:37:16 INFO - PROCESS | 2285 | 05:38:06 INFO - PROCESS | 2285 | 1471610286618 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] 05:40:18 INFO - PROCESS | 2285 | Cycle 1(1): loaded http://localhost:50615/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50615/tests/dromaeo/cssquery-ext.html) 05:40:20 INFO - PROCESS | 2285 | RSS: Main: 254693376 05:40:20 INFO - PROCESS | 2285 | 05:43:22 INFO - PROCESS | 2285 | Cycle 1(1): loaded http://localhost:50615/tests/dromaeo/cssquery-ext.html (next: http://localhost:50615/tests/dromaeo/cssquery-jquery.html) 05:43:23 INFO - PROCESS | 2285 | RSS: Main: 266514432 05:43:23 INFO - PROCESS | 2285 | 05:46:25 INFO - PROCESS | 2285 | Cycle 1(1): loaded http://localhost:50615/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50615/tests/dromaeo/cssquery-mootools.html) 05:46:25 INFO - PROCESS | 2285 | RSS: Main: 271204352 05:46:25 INFO - PROCESS | 2285 | 05:49:27 INFO - PROCESS | 2285 | Cycle 1(1): loaded http://localhost:50615/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50615/tests/dromaeo/cssquery-prototype.html) 05:49:28 INFO - PROCESS | 2285 | RSS: Main: 270512128 05:49:28 INFO - PROCESS | 2285 | 05:52:31 INFO - PROCESS | 2285 | Cycle 1(1): loaded http://localhost:50615/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50615/tests/dromaeo/cssquery-yui.html) 05:52:31 INFO - PROCESS | 2285 | RSS: Main: 275865600 05:52:31 INFO - PROCESS | 2285 | 05:55:34 INFO - PROCESS | 2285 | Cycle 1(1): loaded http://localhost:50615/tests/dromaeo/cssquery-yui.html (next: http://localhost:50615/tests/dromaeo/cssquery-dojo.html) 05:55:34 INFO - PROCESS | 2285 | RSS: Main: 278540288 05:55:34 INFO - PROCESS | 2285 | 05:55:34 INFO - PROCESS | 2285 | __start_tp_report 05:55:34 INFO - PROCESS | 2285 | _x_x_mozilla_page_load 05:55:34 INFO - PROCESS | 2285 | _x_x_mozilla_page_load_details 05:55:34 INFO - PROCESS | 2285 | |i|pagename|runs| 05:55:34 INFO - PROCESS | 2285 | |0;dojo.html;3372.5615669962904;3411.6417776133503;3417.1798768295585;3444.018454740401;3448.689617934386;5765.769369225236;5818.738156782944;5830.387809280028;5958.940410595893;5962.701864906759;4878.560929516343;5847.766089356432;5852.385499522553;5953.613015154012;5994.760209591611;4450.955490445102;5156.793728250885;5230.843074707765;5298.36419629643;5314.176302673072;4883.6337274704365;4956.934259134286;5382.6770393776305;5422.8373148805595;5437.265969094181;5150.716710580917;5178.922316165261;5271.051210782058;5291.761870715827;5298.470152984709;5251.002309561171;5274.892272622754;5296.470352964673;5303.284056652341;5307.761150748187;5297.549708274802;5305.973470132624;5323.361196656426;5339.3058902342445;5362.329708786402;5700.3159620845345;5798.739056742456;5886.293644762656;5945.8810823783715;5960.850978725523;5572.192032155314;6095.177151084636;6209.3790620938;6273.466755325803;6275.497960163176;6168.599041062316;6276.3409841966395;6283.214598175228;6290.087937249074;6290.685465726695;5788.942110578924;5839.591228614041;5887;5897.882042359129;5961.463468287875;6250.248341081528;6271.090691849657;6293.559450838397;6295.527835412362;6296.590721603081;6093.695315234309;6229.1590635264565;6235.127082208494;6245.156903817927;6255.6872156392;6164.229471316085;6181.856356574048;6184.196054512974;6219.47134493564;6231.75072997075;6194.4115309045565;6204.441600255998;6247.531435142382;6255.24937007562;6260.123582698426;6164.260288765377;6257.812265632038;6273.435390814758;6284.717187726564;6286.748530058838;4867.245576935581;4934.062528119646;4959.950400495949;4968.801247950041;5032.370953630796;4480.641548676098;4486.6186374157905;4487.080148569536;4496.505384407713;4529.977350113294;5874.265716785402;6010.579259451796;6026.156338112668;6027.78902738402;6031.8793624127275;6157.630542167484;6173.259208894871;6205.131281620576;6210.5652604317265;6257.624542527463;5970.462658360769;5973.462388385066;5986.161937328778;5999.100134979701;6002.8594567033;5515.25544051556;5527;5534.05920993424;5550.0564903965615;5559.805406810823;6197.101420294122;6217.875642487034;6234.906476402948;6267.96866015667;6362.9045564316575;6242.968785156045;6266.624002559861;6267.749290028531;6267.903116954423;6286.968565157328;6309.211348581427;6337.493000560036;6339.90490142639;6366.586171898997;6369.617822930639;6205.627662340094;6215.129881816459;6217.813465596039;6222.968885155727;6266.467350275278;6199.876002480015;6240.313565507881;6258.092576576462;6262.968685156545;6271.059341098871;6227.128202051807;6264.279607844974;6295.527835412271;6297.370262973666;6299.6535190564955;6095.8780824382375;6118.893302669218;6140.017597184607;6156.692165391623;6255.624662520263;5950.9404905952115;6048.153258543895;6097.146399504161;6128.417800308964;6152.169457123231;5205.713685747321;6168;6223.813285601439;6245.250569931637;6269.185005949197;5985.491233245223;6067.211262536019;6100.847478812888;6102.9694851525455;6103.542234332354 05:55:34 INFO - PROCESS | 2285 | |1;ext.html;465.34386515013836;489.7037292438076;503.3004124267268;526.0137242669994;545.152288191862;36659.81670091649;38962.80518597403;39050.41424378636;39107;39140;35092.82453587735;40933.38599920996;41333.246676632196;41399.965000874996;41403.79298103513;7760.961195194016;8615.741527754177;8653.783655408633;9011.414258073204;9558.713238602853;8514.829703405929;9727.027297270251;9823.705288841345;9835.803283934318;9844.163246124088;9816.312858099936;9831.803363932717;9832.557534910946;9845.212383009342;9869.90130098697;9782.853257201148;9812.754681133028;9857.211423086135;9869.950650246774;9987.051230133162;8248.958755206246;9737.756556086155;9742.1719153872;9756.707298781048;9770.26722995778;30011;38811;39146.21707565861;39361.21277574432;39489.60510394888;2680.32991752062;3281.442154833684;3570.839312230956;3662.3957047087197;4148.274052040911;24984.875680594418;26676.59985100225;30244.69755302441;31059.22351941197;31063.029915213458;3102.7828052036366;3126.816400137132;3139.309351942569;3162.430762462756;3246.96753032469;459512;468531;469503;470731;472103;32945;32971.83514082462;32983;33059.504107438406;33078.50382244268;33159.834200829326;33971.32057358839;34483.82758086194;34899.825500872335;35906.640933590854;16534.421295254848;16630.251638676287;16728.996260224427;16732.41436549715;16743;12782.360881955865;12825;12939.805902911465;12958.611241662766;12987.870121298854;18352.541186470444;18353.90823045876;18372.265109395743;18383.72424413635;18416.90791546034;7865.252800983897;7941.285284324323;7941.761747147595;8038.8794168087525;8049.6377663005305;843.8270154618289;897.1432282170512;944.990550094504;961.7162936933621;967.8209531236744;26087;29616;30464.69535304663;30756;31583.84208078991;939.9154076133044;947.2895328503622;1072.447689439939;1138.6527109231763;1140.4468832616174;13068.54260100892;14434.350454229374;15278;15781.28984195714;16023.519294421187;695140;700839;702199;703324;703871;58088;58231.70884145637;58592.12111818326;58804.70597646984;58969.705151473965;1339.450825161679;1374.3677908162158;1393.1223329302677;1401.054288355356;1402.978955315671;22515.88742056345;28071.57892631653;29841;29972.550411743407;30287.848560757055;49240.50759492359;49530.504694954034;49635.751821242106;49639;49670.75164624154;580903;581587;582357;582720;584150;26409.60385594179;26425.60361594539;26973.730262697907;27034.864825675744;27120.864395677894;47295.29057064078;48241;48761.780955476395;48830.511694884015;48883.77790555122;35306.293874122886;37115;38796.6120338793;39516.60483395129;39636.00909977158;36045.81977090098;39604;39901.80049099852;40429.39355909605;41350.37974430446;34344.313113738084;38690.0327491815;39772;39796;41046.58953410428;31181;34522;35261.94214173579;35335.29329413346;35655.46516802198;25171.87414062918;26016.219513414628;26281.868590656923;26412;26450.603240951787 05:55:34 INFO - PROCESS | 2285 | |2;jquery.html;360.67719391144925;374.98125093745324;381.52690663577164;387.80609695152424;405.31906397252607;19485.318013869517;21450.249241276557;21569.784302156975;21660.350189494322;21819.01814418351;20489.79510204901;20608.38174854753;21102.366928992156;21374.358769236907;21479.892600537016;6022.759089636409;6063.575549711522;6224.284207316171;6291.559590828644;6322.683865806691;4239.427677263561;6142.201513803199;6276.623402595836;6689.096971908803;6969.059177011115;7002.579845209304;7012.403945664599;7025.82435439113;7028.718851245944;7040.260772618878;6549.148610680629;6893.724251029953;6965.616891070964;7021.89467157993;7033.261507541737;5965.075413310944;6054.122152287893;6059.45464908156;6074.696265186767;6133.1106989486725;13455.259960702157;13595.388207530685;13630.659233519242;13779.724405511834;13806.792898106536;1904.114586717183;2155.80597746202;2169.566086782634;2285.1544928376607;2357.552065107624;8155.388345874083;8539.57302134897;10053.547590358452;10163.339382940085;10446.68659940203;1839.8988055656935;1913.885166889991;1985.656924828716;1993.1329871505795;2022.8078332558384;106749;131177.99999999904;131691;132019;133575.33212333877;9695.078967498217;11343.376114313627;11420.31478111316;11583.189176757545;11641.941790291165;13821;14172.574822755334;14240.928795355956;14336.283185840666;14399.928000360142;8443.029051659138;8581.528015959057;8607.61265743043;8610;8635.611397487128;8431.578421079044;8505.65977360911;8510.659573616986;8607.01019382779;8708.52103134321;4523.95476045242;4526.140033393644;4538.069695712371;4541.2733962565835;4591.357209990604;1336.5722968650134;1650.0759574638241;1683.1163639089332;1908;1960.5882764619305;379.1261143065261;879.859222524393;905.9547022648973;1013.5641674080069;1023.2734758321526;11247.943760281147;11832.88167118335;12120.393980300949;12176.75646487083;12182.756344873053;430.5178200415492;879.8298263309782;951.471933077135;972.4408465132577;1054.0408228512017;11270.605528806616;11401.714957125972;11457.885421145682;11490.42547872603;11547.018503427134;548110;578334.1083294641;621479;635336;636689;126107;127292.36353818171;132209;132241.33879330542;141762.2911885434;973.4013581647378;997.7455748784158;1027.0807627173638;1039.7296702857311;1045.7908418316367;17047.573810654834;19220;20092.296769612993;20109.994500274635;20214.292499763025;39852.20295594014;39912.867466043885;56218.43781562296;57130;58160.70919645375;74776.62611687124;81219.59390203012;81684;81732;82132;7725.304722574995;7850.214978502104;7927.801804954922;8188.672453101809;8336.416450848625;12723.745525089631;13014.609561713163;13056.34718264102;13114.540991065267;13115.213087214797;10952.335762413322;11264.211505194886;11356.829647555129;11511.42442877836;11541.249818761753;10961.271439559594;11057.502412391623;11060.668179954615;11392.601258955896;11449.255798373079;11214.495347709535;11468.197226194086;11548.364839933884;11588.420578970849;11662.533498660297;6833.658317084027;7927.960360198162;8068.193180681885;8170.877436838571;8172.468789528662;10701.304415212986;10958.068564171816;11121.274373084783;11193.720156995814;11299.644042714926 05:55:34 INFO - PROCESS | 2285 | |3;mootools.html;1519.1037288000082;1549.7675348697696;1729.948101556953;1826.6985947318692;1852.7313539536776;7938;8364.205400486951;8495.532745698983;8937.955310223448;8942.374033817643;8530.23227909488;8733.51965641891;8740.606672699729;8756.387052906299;8768.956155219232;2375.8336916415815;2391.80865530758;2396.9760302396926;2399.0883464283547;2401.8318717689767;1989.8408127349778;2340.707411573553;2391.198948352304;2393.56915755164;2401.6637670726113;2358.6226203807396;2378.6907701998716;2381.559411508868;2394.580948334043;2408.397900524869;2343.8828058597173;2362.995726816096;2371.2174982255815;2379.7144342678816;2383.547126046063;2346.366481050124;2351.9412014699597;2364.7398786133513;2366.4557151854997;2370.8696021718797;8727.563621818947;8768.035516093225;8828.24959878411;8849.778755531099;8860.158284962918;5149.665271757323;5269.552088072518;5291.920621190685;5296.232046353296;5296.311479507678;3555.3244883472057;3577.177249232691;3591.2458383739445;3629.1108678373967;3631.618680038611;1077.9137668986461;1078.4553800330782;1085.8588383510173;1091.5415525479318;1103.6413165721092;11347.659570212823;11421.714457138554;11506.482208300731;11531.308121512653;11555.306681599046;4466.977665111654;4574.08518296342;4712.104700107037;4742.454617719007;4763.76181190939;9602.615895364246;9693.854592181124;9714.562844672007;9733.805323893625;9735.02649735035;5211.7915283389;5248.425472358277;5249.763760630781;5250.947490525045;5260.552853007537;3681.245344704329;3903.4535165076913;4161.854335098257;4445.888527868033;4860.829870954571;3501.844391350848;3856.8650097247023;3883.3204189266767;3979.721419500665;4000.8999775005277;1131.4908291268798;1300.291341219019;1307.3724612186204;1320.1089264746258;1324.569514907659;890.5369208011798;922.3313098003894;923.7413524213097;931.1247427418206;947.4883562876107;5785.859232084156;5858.677772722456;5905.114232865105;5996.2504686914135;6021.5182785377065;954.6706386296717;978.9525208027343;986.4623780039896;1005.0652892809757;1028.2545154762738;3631.800250986168;3750.6811920986474;3969.801509924492;3971.2057588481844;4056.7363121397607;10296.588136474607;10631.043206111488;10639.255252132276;10646.14830813533;10666.626668066736;10496.370217786956;10547.576077229629;10820.729481763019;10837.187210959051;10894.891051089387;8135.999999999882;8155.469894456842;8318.12659670738;8322.417430779908;8359.080501144868;5737.942620573908;5820.738066787089;5884.7940322088525;5923.733431995484;5928;9397.906020939976;10008.699739007841;10093.243006774375;10101.545430455793;10126.24053196028;10030.448325342177;10180.287379883337;10192.796144077225;10250.128739056965;10250.436226007641;6863.347981941708;7183.425325974014;7401.33387995083;7405.96297018533;7593.5823529706395;8358.874616880874;8396.160383961555;8407.654775235933;8412.327013838756;8432;6394.392532709385;7378.372838308804;7406.333429991327;7589;7657.617119143909;7338.596377199306;7351.081114860643;7385;7398.704051837866;7518.135414427411;6970.23327433992;6972.965135174291;7051.083359163276;7060.152781666233;7082.433405327664;4944.604431645532;5036.521530454601;5050.823221187241;5054.772535235849;5114.590832733446;4910.729909854992;4962.801487940442;4966.404031516241;5065.974670126626;5196.246544251138 05:55:34 INFO - PROCESS | 2285 | |4;prototype.html;276.7301880666349;285.6529316879991;291.6786955093426;309.36116918563175;314.94960806271;5421.864453388667;5449.3188351456065;5481.5340696040885;5484.643498172621;5505.3393592768825;4704;4983.3272508211385;5093.363329583802;5427.3215848019;5432.185172224168;3082.244850011745;3406.693397594216;3632.654897784706;3824.6557809797114;4036.777977211252;4024.907048334864;4063.891123290685;4122;4122.248044581056;4129.731567448106;3709.7588656737225;4110.177964407116;4117;4120.91758164838;4172.624463798257;3390.7787601778164;3429.2455659754937;3974.225026119908;4086.7752273624938;4168.458100446937;3272.7054565089256;3578.159132603836;3580.4092324766384;3597.442396428558;3607.5670919489567;5214.582833373321;5288;5306.204069389584;5332.2801421808335;5335.985168379853;4612.746298953556;4739.559127049572;4769.399103676702;4772.594329481998;4934.925976110361;5098.694078355311;5672.68800215988;5700.515456186229;5724.996251312007;5773.682447465388;3912.767478244344;3961.2473630010204;3979.781112038837;3981.3231750602467;3989.142334398089;5659.320881494247;5956.791512297092;5983.282006159288;6007.858506883678;6032.185654936571;3368.612609549884;4014.4781178446615;4039.616626190562;4040.1919616076902;4048.514178298623;3473.913152171165;4045.887380970257;4069.674426045909;4086.652634526039;4098.73358231714;3753.774773513598;4749.553979700457;4760.7619619018915;4771.976140119277;4796.37647105874;5291.603129765283;5362;5717.714114294268;5769.913451298234;5779.595428320062;1194.8685644579089;1209.4557449147742;1353.1407556201882;1369.3427154965473;1383.7716776731927;707.9610621415871;721.527399553283;730.583567366596;803.7709252863023;823.4071468542639;5115.948840511622;5303.189309665883;5425.891482170335;5429.425466614716;5441.632889692996;5065.594752419797;5952.82141535746;5990.232881300027;6013.428724271187;6030.517558595302;4761.928571071437;4857.732824694675;4931.630127740434;5418.945810541923;5437.483439073281;2987.4771914914804;3080.6303243610464;3134.8871150741616;3145.6697046809754;3178.284885900654;5206.245094461282;5670.136581026638;5693.459121383545;6043.576949613484;6142.447179753844;5745.798897038583;5921.733521991435;6052.818415447544;6186.051159072724;6200.883840908679;5756.906187824384;6020.066889632114;6228.096925945712;6297.788128054725;6350.237971443456;5608.46719561641;6002.609830361012;6021.578489505692;6075.696215189135;6112.358202388685;5513.649155956817;5616.943830561806;5964.940350596438;5977.850553736192;6058.363871793575;5814.075499038217;5945.732442040032;6001.669908154919;6333.683315834282;6346.2067241594805;3451.913702157466;3544.946825797667;3773.981130094332;4095.385692146202;4096.242195193899;5056.890012642272;5159.484051594811;5594;5950.6132101415005;6002.189704389852;4357.912841743084;5788.016037273758;5808.215890854681;5814.389489103583;5877.353491115889;5687.203791469115;5762.740676669644;5764.971175144097;5767.307923049261;5782;5673.177389278614;5676.20533125371;5687.5734319927;5700.714964251853;5709.800156994485;5526.392096869422;5692.3169219692245;5804.709764511842;5814.883702326015;5828.03693488432;4998.3002379667605;5238.711870846988;5725.713714314351;5743.368229494836;5779.2775903012125 05:55:34 INFO - PROCESS | 2285 | |5;yui.html;699.6566592143084;713.6289129652585;721.3327671903488;792.1247022040645;823.1809349697048;12859.614211573644;16252.593685157877;16286.592835179112;16289.429869954554;16310.266038028287;14681.119132852036;14762.778558321634;14783.408663653468;14789.556313310592;14824.258787060659;680.2585182151454;835.7283882738104;836.5649862071734;853.9188777066169;856.7087190355278;858.171864151094;860.6643409070467;862.1637012098255;863.6156910174975;865.9826803463927;892.97754071588;902.9548522573878;905.1853332001185;905.2576886952702;906.0803284666036;897.7261935109822;899.2356496977582;901.4185850126697;903.7379160043612;905.6196397513061;643.157463722525;667.1493845347172;676.1480534526482;676.6278546799241;677.1062197898775;14626.488072917396;14750.336234869457;14854.554363369009;14868.330925108396;14892.180930048842;11271.605493807678;14563.563093107225;14565.271736413242;14572.271386430635;14655.120692758468;10072.294939354248;11722.824157637642;11816.05534265663;11914.689384167734;12005.399730013465;3838.213166300902;3883.708721845873;3931.9213615727526;3942.448057271984;4065.613766692189;103730;104130.91738165195;106512;106846.46576767221;107449;11182.049525790237;11183.496742646601;11208.439578021067;11314.208005439541;11722.94138529319;22271.665925011137;22444.316676249346;22461;22509.88745056264;22543.436414089778;8129.634166462523;8178.427510074357;8324.125966773523;8422.410431269753;8442.831143377098;4446.6220371268155;4514.796834142471;4544.386507821468;4551.45382554089;4681.95318046822;3585.1395665040723;3604.891853244407;3644.3075815594952;3670.302642497917;3686.557613086447;574.4112284908002;587.7737071227523;658.7891874600082;662.8806814773291;665.3014334948382;508;562.5274769193896;583.982480525585;648.9448396886318;675.0920012583068;8262.504249745034;8691.846296167372;9238.815223695488;9376.437413755197;9397.436153830791;581.3895409819672;629.7449532939168;644.1690219616642;647.4561368450525;677.1298880937971;4002.818463937161;4248.760819524605;4471.128130014681;4518.932216016762;4530.61489773373;132148;161446.54213831315;163818;166039;168433.1578342125;76413.6179319111;78959;94071;141765;142847.4294941979;69485;80752.59623701962;81408;104577.90844183073;104829.95170048355;9285.303602229726;9581.568829402555;9736.610535578497;9843.261755368232;9979.251556133175;51306;56423.43576564182;57989;59102.70448647729;59119;55204.44795552154;61384;74236.62881685558;82599.76100358379;82677.58661206656;11273.985341319321;11450.141239407245;11518.712032198926;11585.189036767682;11599.594014209462;12760.617181484571;14630.634234144232;14784.408623654934;15107.32017059257;15129.39482420735;11379.829302560634;13874.583762487142;13930.79103813464;14130.364133613806;14730.484433044792;13693.863061369259;13730.45078196901;14217.502387416804;14222.857771422154;14573.708525829636;11426.714332141762;13420.194788312732;13423.798643020167;13707.246101464116;14135.64660883486;10611.575536978435;10908.072813810915;11244.55021799119;11375;11429.771404571695;10948.616798412017;11205.422752766746;11359.886401136213;11369.4883730234;11478.540858365572 05:55:34 INFO - PROCESS | 2285 | __end_tp_report 05:55:34 INFO - PROCESS | 2285 | __start_cc_report 05:55:34 INFO - PROCESS | 2285 | _x_x_mozilla_cycle_collect,411 05:55:34 INFO - PROCESS | 2285 | __end_cc_report 05:55:34 INFO - PROCESS | 2285 | __startTimestamp1471611334874__endTimestamp 05:55:34 INFO - PROCESS | 2285 | 05:55:34 INFO - PROCESS | 2285 | ------- Summary: start ------- 05:55:34 INFO - PROCESS | 2285 | Number of tests: 6 05:55:34 INFO - PROCESS | 2285 | 05:55:34 INFO - PROCESS | 2285 | [#0] dojo.html Cycles:165 Average:5803.36 Median:6095.18 stddev:643.82 (10.6%) stddev-sans-first:616.91 05:55:34 INFO - PROCESS | 2285 | Values: 3372.6 3411.6 3417.2 3444.0 3448.7 5765.8 5818.7 5830.4 5958.9 5962.7 4878.6 5847.8 5852.4 5953.6 5994.8 4451.0 5156.8 5230.8 5298.4 5314.2 4883.6 4956.9 5382.7 5422.8 5437.3 5150.7 5178.9 5271.1 5291.8 5298.5 5251.0 5274.9 5296.5 5303.3 5307.8 5297.5 5306.0 5323.4 5339.3 5362.3 5700.3 5798.7 5886.3 5945.9 5960.9 5572.2 6095.2 6209.4 6273.5 6275.5 6168.6 6276.3 6283.2 6290.1 6290.7 5788.9 5839.6 5887.0 5897.9 5961.5 6250.2 6271.1 6293.6 6295.5 6296.6 6093.7 6229.2 6235.1 6245.2 6255.7 6164.2 6181.9 6184.2 6219.5 6231.8 6194.4 6204.4 6247.5 6255.2 6260.1 6164.3 6257.8 6273.4 6284.7 6286.7 4867.2 4934.1 4960.0 4968.8 5032.4 4480.6 4486.6 4487.1 4496.5 4530.0 5874.3 6010.6 6026.2 6027.8 6031.9 6157.6 6173.3 6205.1 6210.6 6257.6 5970.5 5973.5 5986.2 5999.1 6002.9 5515.3 5527.0 5534.1 5550.1 5559.8 6197.1 6217.9 6234.9 6268.0 6362.9 6243.0 6266.6 6267.7 6267.9 6287.0 6309.2 6337.5 6339.9 6366.6 6369.6 6205.6 6215.1 6217.8 6223.0 6266.5 6199.9 6240.3 6258.1 6263.0 6271.1 6227.1 6264.3 6295.5 6297.4 6299.7 6095.9 6118.9 6140.0 6156.7 6255.6 5950.9 6048.2 6097.1 6128.4 6152.2 5205.7 6168.0 6223.8 6245.3 6269.2 5985.5 6067.2 6100.8 6103.0 6103.5 05:55:34 INFO - PROCESS | 2285 | 05:55:34 INFO - PROCESS | 2285 | [#1] ext.html Cycles:180 Average:69732.02 Median:39143.11 stddev:158632.99 (405.3%) stddev-sans-first:158992.75 05:55:34 INFO - PROCESS | 2285 | Values: 465.3 489.7 503.3 526.0 545.2 36659.8 38962.8 39050.4 39107.0 39140.0 35092.8 40933.4 41333.2 41400.0 41403.8 7761.0 8615.7 8653.8 9011.4 9558.7 8514.8 9727.0 9823.7 9835.8 9844.2 9816.3 9831.8 9832.6 9845.2 9869.9 9782.9 9812.8 9857.2 9870.0 9987.1 8249.0 9737.8 9742.2 9756.7 9770.3 30011.0 38811.0 39146.2 39361.2 39489.6 2680.3 3281.4 3570.8 3662.4 4148.3 24984.9 26676.6 30244.7 31059.2 31063.0 3102.8 3126.8 3139.3 3162.4 3247.0 459512.0 468531.0 469503.0 470731.0 472103.0 32945.0 32971.8 32983.0 33059.5 33078.5 33159.8 33971.3 34483.8 34899.8 35906.6 16534.4 16630.3 16729.0 16732.4 16743.0 12782.4 12825.0 12939.8 12958.6 12987.9 18352.5 18353.9 18372.3 18383.7 18416.9 7865.3 7941.3 7941.8 8038.9 8049.6 843.8 897.1 945.0 961.7 967.8 26087.0 29616.0 30464.7 30756.0 31583.8 939.9 947.3 1072.4 1138.7 1140.4 13068.5 14434.4 15278.0 15781.3 16023.5 695140.0 700839.0 702199.0 703324.0 703871.0 58088.0 58231.7 58592.1 58804.7 58969.7 1339.5 1374.4 1393.1 1401.1 1403.0 22515.9 28071.6 29841.0 29972.6 30287.8 49240.5 49530.5 49635.8 49639.0 49670.8 580903.0 581587.0 582357.0 582720.0 584150.0 26409.6 26425.6 26973.7 27034.9 27120.9 47295.3 48241.0 48761.8 48830.5 48883.8 35306.3 37115.0 38796.6 39516.6 39636.0 36045.8 39604.0 39901.8 40429.4 41350.4 34344.3 38690.0 39772.0 39796.0 41046.6 31181.0 34522.0 35261.9 35335.3 35655.5 25171.9 26016.2 26281.9 26412.0 26450.6 05:55:34 INFO - PROCESS | 2285 | 05:55:34 INFO - PROCESS | 2285 | [#2] jquery.html Cycles:180 Average:35099.81 Median:11817.85 stddev:101352.35 (857.6%) stddev-sans-first:101603.11 05:55:34 INFO - PROCESS | 2285 | Values: 360.7 375.0 381.5 387.8 405.3 19485.3 21450.2 21569.8 21660.4 21819.0 20489.8 20608.4 21102.4 21374.4 21479.9 6022.8 6063.6 6224.3 6291.6 6322.7 4239.4 6142.2 6276.6 6689.1 6969.1 7002.6 7012.4 7025.8 7028.7 7040.3 6549.1 6893.7 6965.6 7021.9 7033.3 5965.1 6054.1 6059.5 6074.7 6133.1 13455.3 13595.4 13630.7 13779.7 13806.8 1904.1 2155.8 2169.6 2285.2 2357.6 8155.4 8539.6 10053.5 10163.3 10446.7 1839.9 1913.9 1985.7 1993.1 2022.8 106749.0 131178.0 131691.0 132019.0 133575.3 9695.1 11343.4 11420.3 11583.2 11641.9 13821.0 14172.6 14240.9 14336.3 14399.9 8443.0 8581.5 8607.6 8610.0 8635.6 8431.6 8505.7 8510.7 8607.0 8708.5 4524.0 4526.1 4538.1 4541.3 4591.4 1336.6 1650.1 1683.1 1908.0 1960.6 379.1 879.9 906.0 1013.6 1023.3 11247.9 11832.9 12120.4 12176.8 12182.8 430.5 879.8 951.5 972.4 1054.0 11270.6 11401.7 11457.9 11490.4 11547.0 548110.0 578334.1 621479.0 635336.0 636689.0 126107.0 127292.4 132209.0 132241.3 141762.3 973.4 997.7 1027.1 1039.7 1045.8 17047.6 19220.0 20092.3 20110.0 20214.3 39852.2 39912.9 56218.4 57130.0 58160.7 74776.6 81219.6 81684.0 81732.0 82132.0 7725.3 7850.2 7927.8 8188.7 8336.4 12723.7 13014.6 13056.3 13114.5 13115.2 10952.3 11264.2 11356.8 11511.4 11541.2 10961.3 11057.5 11060.7 11392.6 11449.3 11214.5 11468.2 11548.4 11588.4 11662.5 6833.7 7928.0 8068.2 8170.9 8172.5 10701.3 10958.1 11121.3 11193.7 11299.6 05:55:34 INFO - PROCESS | 2285 | 05:55:34 INFO - PROCESS | 2285 | [#3] mootools.html Cycles:180 Average:5683.32 Median:4885.78 stddev:3175.41 (65.0%) stddev-sans-first:3168.90 05:55:34 INFO - PROCESS | 2285 | Values: 1519.1 1549.8 1729.9 1826.7 1852.7 7938.0 8364.2 8495.5 8938.0 8942.4 8530.2 8733.5 8740.6 8756.4 8769.0 2375.8 2391.8 2397.0 2399.1 2401.8 1989.8 2340.7 2391.2 2393.6 2401.7 2358.6 2378.7 2381.6 2394.6 2408.4 2343.9 2363.0 2371.2 2379.7 2383.5 2346.4 2351.9 2364.7 2366.5 2370.9 8727.6 8768.0 8828.2 8849.8 8860.2 5149.7 5269.6 5291.9 5296.2 5296.3 3555.3 3577.2 3591.2 3629.1 3631.6 1077.9 1078.5 1085.9 1091.5 1103.6 11347.7 11421.7 11506.5 11531.3 11555.3 4467.0 4574.1 4712.1 4742.5 4763.8 9602.6 9693.9 9714.6 9733.8 9735.0 5211.8 5248.4 5249.8 5250.9 5260.6 3681.2 3903.5 4161.9 4445.9 4860.8 3501.8 3856.9 3883.3 3979.7 4000.9 1131.5 1300.3 1307.4 1320.1 1324.6 890.5 922.3 923.7 931.1 947.5 5785.9 5858.7 5905.1 5996.3 6021.5 954.7 979.0 986.5 1005.1 1028.3 3631.8 3750.7 3969.8 3971.2 4056.7 10296.6 10631.0 10639.3 10646.1 10666.6 10496.4 10547.6 10820.7 10837.2 10894.9 8136.0 8155.5 8318.1 8322.4 8359.1 5737.9 5820.7 5884.8 5923.7 5928.0 9397.9 10008.7 10093.2 10101.5 10126.2 10030.4 10180.3 10192.8 10250.1 10250.4 6863.3 7183.4 7401.3 7406.0 7593.6 8358.9 8396.2 8407.7 8412.3 8432.0 6394.4 7378.4 7406.3 7589.0 7657.6 7338.6 7351.1 7385.0 7398.7 7518.1 6970.2 6973.0 7051.1 7060.2 7082.4 4944.6 5036.5 5050.8 5054.8 5114.6 4910.7 4962.8 4966.4 5066.0 5196.2 05:55:34 INFO - PROCESS | 2285 | 05:55:34 INFO - PROCESS | 2285 | [#4] prototype.html Cycles:180 Average:4673.61 Median:5334.13 stddev:1482.66 (27.8%) stddev-sans-first:1449.63 05:55:34 INFO - PROCESS | 2285 | Values: 276.7 285.7 291.7 309.4 314.9 5421.9 5449.3 5481.5 5484.6 5505.3 4704.0 4983.3 5093.4 5427.3 5432.2 3082.2 3406.7 3632.7 3824.7 4036.8 4024.9 4063.9 4122.0 4122.2 4129.7 3709.8 4110.2 4117.0 4120.9 4172.6 3390.8 3429.2 3974.2 4086.8 4168.5 3272.7 3578.2 3580.4 3597.4 3607.6 5214.6 5288.0 5306.2 5332.3 5336.0 4612.7 4739.6 4769.4 4772.6 4934.9 5098.7 5672.7 5700.5 5725.0 5773.7 3912.8 3961.2 3979.8 3981.3 3989.1 5659.3 5956.8 5983.3 6007.9 6032.2 3368.6 4014.5 4039.6 4040.2 4048.5 3473.9 4045.9 4069.7 4086.7 4098.7 3753.8 4749.6 4760.8 4772.0 4796.4 5291.6 5362.0 5717.7 5769.9 5779.6 1194.9 1209.5 1353.1 1369.3 1383.8 708.0 721.5 730.6 803.8 823.4 5115.9 5303.2 5425.9 5429.4 5441.6 5065.6 5952.8 5990.2 6013.4 6030.5 4761.9 4857.7 4931.6 5418.9 5437.5 2987.5 3080.6 3134.9 3145.7 3178.3 5206.2 5670.1 5693.5 6043.6 6142.4 5745.8 5921.7 6052.8 6186.1 6200.9 5756.9 6020.1 6228.1 6297.8 6350.2 5608.5 6002.6 6021.6 6075.7 6112.4 5513.6 5616.9 5964.9 5977.9 6058.4 5814.1 5945.7 6001.7 6333.7 6346.2 3451.9 3544.9 3774.0 4095.4 4096.2 5056.9 5159.5 5594.0 5950.6 6002.2 4357.9 5788.0 5808.2 5814.4 5877.4 5687.2 5762.7 5765.0 5767.3 5782.0 5673.2 5676.2 5687.6 5700.7 5709.8 5526.4 5692.3 5804.7 5814.9 5828.0 4998.3 5238.7 5725.7 5743.4 5779.3 05:55:34 INFO - PROCESS | 2285 | 05:55:34 INFO - PROCESS | 2285 | [#5] yui.html Cycles:180 Average:23083.07 Median:3907.82 stddev:37022.96 (947.4%) stddev-sans-first:37088.68 05:55:34 INFO - PROCESS | 2285 | Values: 699.7 713.6 721.3 792.1 823.2 12859.6 16252.6 16286.6 16289.4 16310.3 14681.1 14762.8 14783.4 14789.6 14824.3 680.3 835.7 836.6 853.9 856.7 858.2 860.7 862.2 863.6 866.0 893.0 903.0 905.2 905.3 906.1 897.7 899.2 901.4 903.7 905.6 643.2 667.1 676.1 676.6 677.1 14626.5 14750.3 14854.6 14868.3 14892.2 11271.6 14563.6 14565.3 14572.3 14655.1 10072.3 11722.8 11816.1 11914.7 12005.4 3838.2 3883.7 3931.9 3942.4 4065.6 103730.0 104130.9 106512.0 106846.5 107449.0 11182.0 11183.5 11208.4 11314.2 11722.9 22271.7 22444.3 22461.0 22509.9 22543.4 8129.6 8178.4 8324.1 8422.4 8442.8 4446.6 4514.8 4544.4 4551.5 4682.0 3585.1 3604.9 3644.3 3670.3 3686.6 574.4 587.8 658.8 662.9 665.3 508.0 562.5 584.0 648.9 675.1 8262.5 8691.8 9238.8 9376.4 9397.4 581.4 629.7 644.2 647.5 677.1 4002.8 4248.8 4471.1 4518.9 4530.6 132148.0 161446.5 163818.0 166039.0 168433.2 76413.6 78959.0 94071.0 141765.0 142847.4 69485.0 80752.6 81408.0 104577.9 104830.0 9285.3 9581.6 9736.6 9843.3 9979.3 51306.0 56423.4 57989.0 59102.7 59119.0 55204.4 61384.0 74236.6 82599.8 82677.6 11274.0 11450.1 11518.7 11585.2 11599.6 12760.6 14630.6 14784.4 15107.3 15129.4 11379.8 13874.6 13930.8 14130.4 14730.5 13693.9 13730.5 14217.5 14222.9 14573.7 11426.7 13420.2 13423.8 13707.2 14135.6 10611.6 10908.1 11244.6 11375.0 11429.8 10948.6 11205.4 11359.9 11369.5 11478.5 05:55:34 INFO - PROCESS | 2285 | -------- Summary: end -------- 05:55:34 INFO - PROCESS | 2285 | 05:55:35 INFO - TEST-INFO | 2285: exit 0 05:55:35 INFO - TEST-OK | dromaeo_css | took 1114661ms 05:55:35 INFO - TEST-START | kraken 05:55:35 INFO - operating with platform_type : mac_ 05:55:35 INFO - Initialising browser for kraken test... 05:55:35 INFO - TEST-INFO | started process 2291 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmpEzl2D1/profile http://localhost:50615/getInfo.html) 05:55:38 INFO - PROCESS | 2291 | __metrics Screen width/height:1600/1200 05:55:38 INFO - PROCESS | 2291 | colorDepth:24 05:55:38 INFO - PROCESS | 2291 | Browser inner width/height: 1024/689 05:55:38 INFO - PROCESS | 2291 | __metrics 05:55:38 ERROR - PROCESS | 2291 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 05:55:39 INFO - TEST-INFO | 2291: exit 0 05:55:39 INFO - Browser initialized. 05:55:39 INFO - Running cycle 1/1 for kraken test... 05:55:39 INFO - TEST-INFO | started process 2294 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmpEzl2D1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:51 INFO - PROCESS | 2294 | RSS: Main: 239558656 05:55:51 INFO - PROCESS | 2294 | 05:55:53 INFO - PROCESS | 2294 | Cycle 1(1): loaded http://localhost:50615/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50615/tests/kraken/driver.html?testName=audio-beat-detection) 05:55:54 INFO - PROCESS | 2294 | RSS: Main: 252399616 05:55:54 INFO - PROCESS | 2294 | 05:55:57 INFO - PROCESS | 2294 | Cycle 1(1): loaded http://localhost:50615/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50615/tests/kraken/driver.html?testName=audio-dft) 05:55:57 INFO - PROCESS | 2294 | RSS: Main: 261070848 05:55:57 INFO - PROCESS | 2294 | 05:56:01 INFO - PROCESS | 2294 | Cycle 1(1): loaded http://localhost:50615/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50615/tests/kraken/driver.html?testName=audio-fft) 05:56:01 INFO - PROCESS | 2294 | RSS: Main: 263811072 05:56:01 INFO - PROCESS | 2294 | 05:56:03 INFO - PROCESS | 2294 | Cycle 1(1): loaded http://localhost:50615/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50615/tests/kraken/driver.html?testName=audio-oscillator) 05:56:04 INFO - PROCESS | 2294 | RSS: Main: 265187328 05:56:04 INFO - PROCESS | 2294 | 05:56:06 INFO - PROCESS | 2294 | Cycle 1(1): loaded http://localhost:50615/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50615/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:56:07 INFO - PROCESS | 2294 | RSS: Main: 265715712 05:56:07 INFO - PROCESS | 2294 | 05:56:10 INFO - PROCESS | 2294 | Cycle 1(1): loaded http://localhost:50615/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50615/tests/kraken/driver.html?testName=imaging-darkroom) 05:56:10 INFO - PROCESS | 2294 | RSS: Main: 267137024 05:56:10 INFO - PROCESS | 2294 | 05:56:13 INFO - PROCESS | 2294 | Cycle 1(1): loaded http://localhost:50615/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50615/tests/kraken/driver.html?testName=imaging-desaturate) 05:56:14 INFO - PROCESS | 2294 | RSS: Main: 266420224 05:56:14 INFO - PROCESS | 2294 | 05:56:17 INFO - PROCESS | 2294 | Cycle 1(1): loaded http://localhost:50615/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50615/tests/kraken/driver.html?testName=json-parse-financial) 05:56:18 INFO - PROCESS | 2294 | RSS: Main: 267575296 05:56:18 INFO - PROCESS | 2294 | 05:56:19 INFO - PROCESS | 2294 | Cycle 1(1): loaded http://localhost:50615/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50615/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:56:20 INFO - PROCESS | 2294 | RSS: Main: 267177984 05:56:20 INFO - PROCESS | 2294 | 05:56:22 INFO - PROCESS | 2294 | Cycle 1(1): loaded http://localhost:50615/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50615/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:56:23 INFO - PROCESS | 2294 | RSS: Main: 267321344 05:56:23 INFO - PROCESS | 2294 | 05:56:25 INFO - PROCESS | 2294 | Cycle 1(1): loaded http://localhost:50615/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50615/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:56:25 INFO - PROCESS | 2294 | RSS: Main: 267526144 05:56:25 INFO - PROCESS | 2294 | 05:56:28 INFO - PROCESS | 2294 | Cycle 1(1): loaded http://localhost:50615/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50615/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:56:29 INFO - PROCESS | 2294 | RSS: Main: 267550720 05:56:29 INFO - PROCESS | 2294 | 05:56:32 INFO - PROCESS | 2294 | Cycle 1(1): loaded http://localhost:50615/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50615/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:56:33 INFO - PROCESS | 2294 | RSS: Main: 267726848 05:56:33 INFO - PROCESS | 2294 | 05:56:34 INFO - PROCESS | 2294 | Cycle 1(1): loaded http://localhost:50615/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50615/tests/kraken/driver.html?testName=ai-astar) 05:56:35 INFO - PROCESS | 2294 | RSS: Main: 268615680 05:56:35 INFO - PROCESS | 2294 | 05:56:35 INFO - PROCESS | 2294 | __start_tp_report 05:56:35 INFO - PROCESS | 2294 | _x_x_mozilla_page_load 05:56:35 INFO - PROCESS | 2294 | _x_x_mozilla_page_load_details 05:56:35 INFO - PROCESS | 2294 | |i|pagename|runs| 05:56:35 INFO - PROCESS | 2294 | |0;ai-astar;106;114;109;117;115;122;117;117;118;115 05:56:35 INFO - PROCESS | 2294 | |1;audio-beat-detection;144;112;137;160;108;130;166;111;160;109 05:56:35 INFO - PROCESS | 2294 | |2;audio-dft;202;198;191;261;251;200;197;199;202;195 05:56:35 INFO - PROCESS | 2294 | |3;audio-fft;71;81;75;147;58;58;59;60;139;59 05:56:35 INFO - PROCESS | 2294 | |4;audio-oscillator;70;70;115;71;70;76;113;69;74;114 05:56:35 INFO - PROCESS | 2294 | |5;imaging-gaussian-blur;90;88;90;101;113;131;112;88;105;110 05:56:35 INFO - PROCESS | 2294 | |6;imaging-darkroom;121;98;149;93;153;150;95;96;99;153 05:56:35 INFO - PROCESS | 2294 | |7;imaging-desaturate;92;94;75;144;143;99;149;128;91;112 05:56:35 INFO - PROCESS | 2294 | |8;json-parse-financial;53;57;56;56;54;60;56;54;56;57 05:56:35 INFO - PROCESS | 2294 | |9;json-stringify-tinderbox;65;70;91;68;73;72;67;70;69;69 05:56:35 INFO - PROCESS | 2294 | |10;stanford-crypto-aes;89;89;93;97;88;89;87;86;94;82 05:56:35 INFO - PROCESS | 2294 | |11;stanford-crypto-ccm;135;138;139;136;152;147;152;139;153;143 05:56:35 INFO - PROCESS | 2294 | |12;stanford-crypto-pbkdf2;171;173;171;172;150;233;230;191;220;234 05:56:35 INFO - PROCESS | 2294 | |13;stanford-crypto-sha256-iterative;69;69;67;71;70;68;69;67;65;68 05:56:35 INFO - PROCESS | 2294 | __end_tp_report 05:56:35 INFO - PROCESS | 2294 | __start_cc_report 05:56:35 INFO - PROCESS | 2294 | _x_x_mozilla_cycle_collect,1052 05:56:35 INFO - PROCESS | 2294 | __end_cc_report 05:56:35 INFO - PROCESS | 2294 | __startTimestamp1471611395041__endTimestamp 05:56:35 INFO - PROCESS | 2294 | 05:56:35 INFO - PROCESS | 2294 | ------- Summary: start ------- 05:56:35 INFO - PROCESS | 2294 | Number of tests: 14 05:56:35 INFO - PROCESS | 2294 | 05:56:35 INFO - PROCESS | 2294 | [#0] ai-astar Cycles:10 Average:115.00 Median:117.00 stddev:4.57 (3.9%) stddev-sans-first:3.50 05:56:35 INFO - PROCESS | 2294 | Values: 106.0 114.0 109.0 117.0 115.0 122.0 117.0 117.0 118.0 115.0 05:56:35 INFO - PROCESS | 2294 | 05:56:35 INFO - PROCESS | 2294 | [#1] audio-beat-detection Cycles:10 Average:133.70 Median:140.50 stddev:23.13 (16.5%) stddev-sans-first:24.23 05:56:35 INFO - PROCESS | 2294 | Values: 144.0 112.0 137.0 160.0 108.0 130.0 166.0 111.0 160.0 109.0 05:56:35 INFO - PROCESS | 2294 | 05:56:35 INFO - PROCESS | 2294 | [#2] audio-dft Cycles:10 Average:209.60 Median:201.00 stddev:24.78 (12.3%) stddev-sans-first:26.13 05:56:35 INFO - PROCESS | 2294 | Values: 202.0 198.0 191.0 261.0 251.0 200.0 197.0 199.0 202.0 195.0 05:56:35 INFO - PROCESS | 2294 | 05:56:35 INFO - PROCESS | 2294 | [#3] audio-fft Cycles:10 Average:80.70 Median:59.50 stddev:33.87 (56.9%) stddev-sans-first:35.74 05:56:35 INFO - PROCESS | 2294 | Values: 71.0 81.0 75.0 147.0 58.0 58.0 59.0 60.0 139.0 59.0 05:56:35 INFO - PROCESS | 2294 | 05:56:35 INFO - PROCESS | 2294 | [#4] audio-oscillator Cycles:10 Average:84.20 Median:70.00 stddev:20.68 (29.5%) stddev-sans-first:21.28 05:56:35 INFO - PROCESS | 2294 | Values: 70.0 70.0 115.0 71.0 70.0 76.0 113.0 69.0 74.0 114.0 05:56:35 INFO - PROCESS | 2294 | 05:56:35 INFO - PROCESS | 2294 | [#5] imaging-gaussian-blur Cycles:10 Average:102.80 Median:109.50 stddev:14.18 (12.9%) stddev-sans-first:14.26 05:56:35 INFO - PROCESS | 2294 | Values: 90.0 88.0 90.0 101.0 113.0 131.0 112.0 88.0 105.0 110.0 05:56:35 INFO - PROCESS | 2294 | 05:56:35 INFO - PROCESS | 2294 | [#6] imaging-darkroom Cycles:10 Average:120.70 Median:94.00 stddev:27.43 (29.2%) stddev-sans-first:29.09 05:56:35 INFO - PROCESS | 2294 | Values: 121.0 98.0 149.0 93.0 153.0 150.0 95.0 96.0 99.0 153.0 05:56:35 INFO - PROCESS | 2294 | 05:56:35 INFO - PROCESS | 2294 | [#7] imaging-desaturate Cycles:10 Average:112.70 Median:83.00 stddev:26.47 (31.9%) stddev-sans-first:27.00 05:56:35 INFO - PROCESS | 2294 | Values: 92.0 94.0 75.0 144.0 143.0 99.0 149.0 128.0 91.0 112.0 05:56:35 INFO - PROCESS | 2294 | 05:56:35 INFO - PROCESS | 2294 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:1.97 (3.5%) stddev-sans-first:1.79 05:56:35 INFO - PROCESS | 2294 | Values: 53.0 57.0 56.0 56.0 54.0 60.0 56.0 54.0 56.0 57.0 05:56:35 INFO - PROCESS | 2294 | 05:56:35 INFO - PROCESS | 2294 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:70.00 stddev:7.26 (10.4%) stddev-sans-first:7.32 05:56:35 INFO - PROCESS | 2294 | Values: 65.0 70.0 91.0 68.0 73.0 72.0 67.0 70.0 69.0 69.0 05:56:35 INFO - PROCESS | 2294 | 05:56:35 INFO - PROCESS | 2294 | [#10] stanford-crypto-aes Cycles:10 Average:89.40 Median:89.00 stddev:4.30 (4.8%) stddev-sans-first:4.56 05:56:35 INFO - PROCESS | 2294 | Values: 89.0 89.0 93.0 97.0 88.0 89.0 87.0 86.0 94.0 82.0 05:56:35 INFO - PROCESS | 2294 | 05:56:35 INFO - PROCESS | 2294 | [#11] stanford-crypto-ccm Cycles:10 Average:143.40 Median:145.00 stddev:7.04 (4.9%) stddev-sans-first:6.78 05:56:35 INFO - PROCESS | 2294 | Values: 135.0 138.0 139.0 136.0 152.0 147.0 152.0 139.0 153.0 143.0 05:56:35 INFO - PROCESS | 2294 | 05:56:35 INFO - PROCESS | 2294 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.50 Median:205.50 stddev:31.66 (15.4%) stddev-sans-first:32.41 05:56:35 INFO - PROCESS | 2294 | Values: 171.0 173.0 171.0 172.0 150.0 233.0 230.0 191.0 220.0 234.0 05:56:35 INFO - PROCESS | 2294 | 05:56:35 INFO - PROCESS | 2294 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:69.00 stddev:1.70 (2.5%) stddev-sans-first:1.79 05:56:35 INFO - PROCESS | 2294 | Values: 69.0 69.0 67.0 71.0 70.0 68.0 69.0 67.0 65.0 68.0 05:56:35 INFO - PROCESS | 2294 | -------- Summary: end -------- 05:56:35 INFO - PROCESS | 2294 | 05:56:35 INFO - TEST-INFO | 2294: exit 0 05:56:35 INFO - TEST-OK | kraken | took 60317ms 05:56:35 INFO - SUITE-END | took 1174s 05:56:36 INFO - Completed test suite (00:19:35) 05:56:36 INFO - javascript benchmark 05:56:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7305.701857765481, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3372.5615669962904, 3411.6417776133503, 3417.1798768295585, 3444.018454740401, 3448.689617934386, 5765.769369225236, 5818.738156782944, 5830.387809280028, 5958.940410595893, 5962.701864906759, 4878.560929516343, 5847.766089356432, 5852.385499522553, 5953.613015154012, 5994.760209591611, 4450.955490445102, 5156.793728250885, 5230.843074707765, 5298.36419629643, 5314.176302673072, 4883.6337274704365, 4956.934259134286, 5382.6770393776305, 5422.8373148805595, 5437.265969094181, 5150.716710580917, 5178.922316165261, 5271.051210782058, 5291.761870715827, 5298.470152984709, 5251.002309561171, 5274.892272622754, 5296.470352964673, 5303.284056652341, 5307.761150748187, 5297.549708274802, 5305.973470132624, 5323.361196656426, 5339.3058902342445, 5362.329708786402, 5700.3159620845345, 5798.739056742456, 5886.293644762656, 5945.8810823783715, 5960.850978725523, 5572.192032155314, 6095.177151084636, 6209.3790620938, 6273.466755325803, 6275.497960163176, 6168.599041062316, 6276.3409841966395, 6283.214598175228, 6290.087937249074, 6290.685465726695, 5788.942110578924, 5839.591228614041, 5887.0, 5897.882042359129, 5961.463468287875, 6250.248341081528, 6271.090691849657, 6293.559450838397, 6295.527835412362, 6296.590721603081, 6093.695315234309, 6229.1590635264565, 6235.127082208494, 6245.156903817927, 6255.6872156392, 6164.229471316085, 6181.856356574048, 6184.196054512974, 6219.47134493564, 6231.75072997075, 6194.4115309045565, 6204.441600255998, 6247.531435142382, 6255.24937007562, 6260.123582698426, 6164.260288765377, 6257.812265632038, 6273.435390814758, 6284.717187726564, 6286.748530058838, 4867.245576935581, 4934.062528119646, 4959.950400495949, 4968.801247950041, 5032.370953630796, 4480.641548676098, 4486.6186374157905, 4487.080148569536, 4496.505384407713, 4529.977350113294, 5874.265716785402, 6010.579259451796, 6026.156338112668, 6027.78902738402, 6031.8793624127275, 6157.630542167484, 6173.259208894871, 6205.131281620576, 6210.5652604317265, 6257.624542527463, 5970.462658360769, 5973.462388385066, 5986.161937328778, 5999.100134979701, 6002.8594567033, 5515.25544051556, 5527.0, 5534.05920993424, 5550.0564903965615, 5559.805406810823, 6197.101420294122, 6217.875642487034, 6234.906476402948, 6267.96866015667, 6362.9045564316575, 6242.968785156045, 6266.624002559861, 6267.749290028531, 6267.903116954423, 6286.968565157328, 6309.211348581427, 6337.493000560036, 6339.90490142639, 6366.586171898997, 6369.617822930639, 6205.627662340094, 6215.129881816459, 6217.813465596039, 6222.968885155727, 6266.467350275278, 6199.876002480015, 6240.313565507881, 6258.092576576462, 6262.968685156545, 6271.059341098871, 6227.128202051807, 6264.279607844974, 6295.527835412271, 6297.370262973666, 6299.6535190564955, 6095.8780824382375, 6118.893302669218, 6140.017597184607, 6156.692165391623, 6255.624662520263, 5950.9404905952115, 6048.153258543895, 6097.146399504161, 6128.417800308964, 6152.169457123231, 5205.713685747321, 6168.0, 6223.813285601439, 6245.250569931637, 6269.185005949197, 5985.491233245223, 6067.211262536019, 6100.847478812888, 6102.9694851525455, 6103.542234332354], "value": 5762.756303368835, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [465.34386515013836, 489.7037292438076, 503.3004124267268, 526.0137242669994, 545.152288191862, 36659.81670091649, 38962.80518597403, 39050.41424378636, 39107.0, 39140.0, 35092.82453587735, 40933.38599920996, 41333.246676632196, 41399.965000874996, 41403.79298103513, 7760.961195194016, 8615.741527754177, 8653.783655408633, 9011.414258073204, 9558.713238602853, 8514.829703405929, 9727.027297270251, 9823.705288841345, 9835.803283934318, 9844.163246124088, 9816.312858099936, 9831.803363932717, 9832.557534910946, 9845.212383009342, 9869.90130098697, 9782.853257201148, 9812.754681133028, 9857.211423086135, 9869.950650246774, 9987.051230133162, 8248.958755206246, 9737.756556086155, 9742.1719153872, 9756.707298781048, 9770.26722995778, 30011.0, 38811.0, 39146.21707565861, 39361.21277574432, 39489.60510394888, 2680.32991752062, 3281.442154833684, 3570.839312230956, 3662.3957047087197, 4148.274052040911, 24984.875680594418, 26676.59985100225, 30244.69755302441, 31059.22351941197, 31063.029915213458, 3102.7828052036366, 3126.816400137132, 3139.309351942569, 3162.430762462756, 3246.96753032469, 459512.0, 468531.0, 469503.0, 470731.0, 472103.0, 32945.0, 32971.83514082462, 32983.0, 33059.504107438406, 33078.50382244268, 33159.834200829326, 33971.32057358839, 34483.82758086194, 34899.825500872335, 35906.640933590854, 16534.421295254848, 16630.251638676287, 16728.996260224427, 16732.41436549715, 16743.0, 12782.360881955865, 12825.0, 12939.805902911465, 12958.611241662766, 12987.870121298854, 18352.541186470444, 18353.90823045876, 18372.265109395743, 18383.72424413635, 18416.90791546034, 7865.252800983897, 7941.285284324323, 7941.761747147595, 8038.8794168087525, 8049.6377663005305, 843.8270154618289, 897.1432282170512, 944.990550094504, 961.7162936933621, 967.8209531236744, 26087.0, 29616.0, 30464.69535304663, 30756.0, 31583.84208078991, 939.9154076133044, 947.2895328503622, 1072.447689439939, 1138.6527109231763, 1140.4468832616174, 13068.54260100892, 14434.350454229374, 15278.0, 15781.28984195714, 16023.519294421187, 695140.0, 700839.0, 702199.0, 703324.0, 703871.0, 58088.0, 58231.70884145637, 58592.12111818326, 58804.70597646984, 58969.705151473965, 1339.450825161679, 1374.3677908162158, 1393.1223329302677, 1401.054288355356, 1402.978955315671, 22515.88742056345, 28071.57892631653, 29841.0, 29972.550411743407, 30287.848560757055, 49240.50759492359, 49530.504694954034, 49635.751821242106, 49639.0, 49670.75164624154, 580903.0, 581587.0, 582357.0, 582720.0, 584150.0, 26409.60385594179, 26425.60361594539, 26973.730262697907, 27034.864825675744, 27120.864395677894, 47295.29057064078, 48241.0, 48761.780955476395, 48830.511694884015, 48883.77790555122, 35306.293874122886, 37115.0, 38796.6120338793, 39516.60483395129, 39636.00909977158, 36045.81977090098, 39604.0, 39901.80049099852, 40429.39355909605, 41350.37974430446, 34344.313113738084, 38690.0327491815, 39772.0, 39796.0, 41046.58953410428, 31181.0, 34522.0, 35261.94214173579, 35335.29329413346, 35655.46516802198, 25171.87414062918, 26016.219513414628, 26281.868590656923, 26412.0, 26450.603240951787], "value": 19200.53318689327, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.67719391144925, 374.98125093745324, 381.52690663577164, 387.80609695152424, 405.31906397252607, 19485.318013869517, 21450.249241276557, 21569.784302156975, 21660.350189494322, 21819.01814418351, 20489.79510204901, 20608.38174854753, 21102.366928992156, 21374.358769236907, 21479.892600537016, 6022.759089636409, 6063.575549711522, 6224.284207316171, 6291.559590828644, 6322.683865806691, 4239.427677263561, 6142.201513803199, 6276.623402595836, 6689.096971908803, 6969.059177011115, 7002.579845209304, 7012.403945664599, 7025.82435439113, 7028.718851245944, 7040.260772618878, 6549.148610680629, 6893.724251029953, 6965.616891070964, 7021.89467157993, 7033.261507541737, 5965.075413310944, 6054.122152287893, 6059.45464908156, 6074.696265186767, 6133.1106989486725, 13455.259960702157, 13595.388207530685, 13630.659233519242, 13779.724405511834, 13806.792898106536, 1904.114586717183, 2155.80597746202, 2169.566086782634, 2285.1544928376607, 2357.552065107624, 8155.388345874083, 8539.57302134897, 10053.547590358452, 10163.339382940085, 10446.68659940203, 1839.8988055656935, 1913.885166889991, 1985.656924828716, 1993.1329871505795, 2022.8078332558384, 106749.0, 131177.99999999904, 131691.0, 132019.0, 133575.33212333877, 9695.078967498217, 11343.376114313627, 11420.31478111316, 11583.189176757545, 11641.941790291165, 13821.0, 14172.574822755334, 14240.928795355956, 14336.283185840666, 14399.928000360142, 8443.029051659138, 8581.528015959057, 8607.61265743043, 8610.0, 8635.611397487128, 8431.578421079044, 8505.65977360911, 8510.659573616986, 8607.01019382779, 8708.52103134321, 4523.95476045242, 4526.140033393644, 4538.069695712371, 4541.2733962565835, 4591.357209990604, 1336.5722968650134, 1650.0759574638241, 1683.1163639089332, 1908.0, 1960.5882764619305, 379.1261143065261, 879.859222524393, 905.9547022648973, 1013.5641674080069, 1023.2734758321526, 11247.943760281147, 11832.88167118335, 12120.393980300949, 12176.75646487083, 12182.756344873053, 430.5178200415492, 879.8298263309782, 951.471933077135, 972.4408465132577, 1054.0408228512017, 11270.605528806616, 11401.714957125972, 11457.885421145682, 11490.42547872603, 11547.018503427134, 548110.0, 578334.1083294641, 621479.0, 635336.0, 636689.0, 126107.0, 127292.36353818171, 132209.0, 132241.33879330542, 141762.2911885434, 973.4013581647378, 997.7455748784158, 1027.0807627173638, 1039.7296702857311, 1045.7908418316367, 17047.573810654834, 19220.0, 20092.296769612993, 20109.994500274635, 20214.292499763025, 39852.20295594014, 39912.867466043885, 56218.43781562296, 57130.0, 58160.70919645375, 74776.62611687124, 81219.59390203012, 81684.0, 81732.0, 82132.0, 7725.304722574995, 7850.214978502104, 7927.801804954922, 8188.672453101809, 8336.416450848625, 12723.745525089631, 13014.609561713163, 13056.34718264102, 13114.540991065267, 13115.213087214797, 10952.335762413322, 11264.211505194886, 11356.829647555129, 11511.42442877836, 11541.249818761753, 10961.271439559594, 11057.502412391623, 11060.668179954615, 11392.601258955896, 11449.255798373079, 11214.495347709535, 11468.197226194086, 11548.364839933884, 11588.420578970849, 11662.533498660297, 6833.658317084027, 7927.960360198162, 8068.193180681885, 8170.877436838571, 8172.468789528662, 10701.304415212986, 10958.068564171816, 11121.274373084783, 11193.720156995814, 11299.644042714926], "value": 9370.357681900214, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1519.1037288000082, 1549.7675348697696, 1729.948101556953, 1826.6985947318692, 1852.7313539536776, 7938.0, 8364.205400486951, 8495.532745698983, 8937.955310223448, 8942.374033817643, 8530.23227909488, 8733.51965641891, 8740.606672699729, 8756.387052906299, 8768.956155219232, 2375.8336916415815, 2391.80865530758, 2396.9760302396926, 2399.0883464283547, 2401.8318717689767, 1989.8408127349778, 2340.707411573553, 2391.198948352304, 2393.56915755164, 2401.6637670726113, 2358.6226203807396, 2378.6907701998716, 2381.559411508868, 2394.580948334043, 2408.397900524869, 2343.8828058597173, 2362.995726816096, 2371.2174982255815, 2379.7144342678816, 2383.547126046063, 2346.366481050124, 2351.9412014699597, 2364.7398786133513, 2366.4557151854997, 2370.8696021718797, 8727.563621818947, 8768.035516093225, 8828.24959878411, 8849.778755531099, 8860.158284962918, 5149.665271757323, 5269.552088072518, 5291.920621190685, 5296.232046353296, 5296.311479507678, 3555.3244883472057, 3577.177249232691, 3591.2458383739445, 3629.1108678373967, 3631.618680038611, 1077.9137668986461, 1078.4553800330782, 1085.8588383510173, 1091.5415525479318, 1103.6413165721092, 11347.659570212823, 11421.714457138554, 11506.482208300731, 11531.308121512653, 11555.306681599046, 4466.977665111654, 4574.08518296342, 4712.104700107037, 4742.454617719007, 4763.76181190939, 9602.615895364246, 9693.854592181124, 9714.562844672007, 9733.805323893625, 9735.02649735035, 5211.7915283389, 5248.425472358277, 5249.763760630781, 5250.947490525045, 5260.552853007537, 3681.245344704329, 3903.4535165076913, 4161.854335098257, 4445.888527868033, 4860.829870954571, 3501.844391350848, 3856.8650097247023, 3883.3204189266767, 3979.721419500665, 4000.8999775005277, 1131.4908291268798, 1300.291341219019, 1307.3724612186204, 1320.1089264746258, 1324.569514907659, 890.5369208011798, 922.3313098003894, 923.7413524213097, 931.1247427418206, 947.4883562876107, 5785.859232084156, 5858.677772722456, 5905.114232865105, 5996.2504686914135, 6021.5182785377065, 954.6706386296717, 978.9525208027343, 986.4623780039896, 1005.0652892809757, 1028.2545154762738, 3631.800250986168, 3750.6811920986474, 3969.801509924492, 3971.2057588481844, 4056.7363121397607, 10296.588136474607, 10631.043206111488, 10639.255252132276, 10646.14830813533, 10666.626668066736, 10496.370217786956, 10547.576077229629, 10820.729481763019, 10837.187210959051, 10894.891051089387, 8135.999999999882, 8155.469894456842, 8318.12659670738, 8322.417430779908, 8359.080501144868, 5737.942620573908, 5820.738066787089, 5884.7940322088525, 5923.733431995484, 5928.0, 9397.906020939976, 10008.699739007841, 10093.243006774375, 10101.545430455793, 10126.24053196028, 10030.448325342177, 10180.287379883337, 10192.796144077225, 10250.128739056965, 10250.436226007641, 6863.347981941708, 7183.425325974014, 7401.33387995083, 7405.96297018533, 7593.5823529706395, 8358.874616880874, 8396.160383961555, 8407.654775235933, 8412.327013838756, 8432.0, 6394.392532709385, 7378.372838308804, 7406.333429991327, 7589.0, 7657.617119143909, 7338.596377199306, 7351.081114860643, 7385.0, 7398.704051837866, 7518.135414427411, 6970.23327433992, 6972.965135174291, 7051.083359163276, 7060.152781666233, 7082.433405327664, 4944.604431645532, 5036.521530454601, 5050.823221187241, 5054.772535235849, 5114.590832733446, 4910.729909854992, 4962.801487940442, 4966.404031516241, 5065.974670126626, 5196.246544251138], "value": 4585.324932826337, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.7301880666349, 285.6529316879991, 291.6786955093426, 309.36116918563175, 314.94960806271, 5421.864453388667, 5449.3188351456065, 5481.5340696040885, 5484.643498172621, 5505.3393592768825, 4704.0, 4983.3272508211385, 5093.363329583802, 5427.3215848019, 5432.185172224168, 3082.244850011745, 3406.693397594216, 3632.654897784706, 3824.6557809797114, 4036.777977211252, 4024.907048334864, 4063.891123290685, 4122.0, 4122.248044581056, 4129.731567448106, 3709.7588656737225, 4110.177964407116, 4117.0, 4120.91758164838, 4172.624463798257, 3390.7787601778164, 3429.2455659754937, 3974.225026119908, 4086.7752273624938, 4168.458100446937, 3272.7054565089256, 3578.159132603836, 3580.4092324766384, 3597.442396428558, 3607.5670919489567, 5214.582833373321, 5288.0, 5306.204069389584, 5332.2801421808335, 5335.985168379853, 4612.746298953556, 4739.559127049572, 4769.399103676702, 4772.594329481998, 4934.925976110361, 5098.694078355311, 5672.68800215988, 5700.515456186229, 5724.996251312007, 5773.682447465388, 3912.767478244344, 3961.2473630010204, 3979.781112038837, 3981.3231750602467, 3989.142334398089, 5659.320881494247, 5956.791512297092, 5983.282006159288, 6007.858506883678, 6032.185654936571, 3368.612609549884, 4014.4781178446615, 4039.616626190562, 4040.1919616076902, 4048.514178298623, 3473.913152171165, 4045.887380970257, 4069.674426045909, 4086.652634526039, 4098.73358231714, 3753.774773513598, 4749.553979700457, 4760.7619619018915, 4771.976140119277, 4796.37647105874, 5291.603129765283, 5362.0, 5717.714114294268, 5769.913451298234, 5779.595428320062, 1194.8685644579089, 1209.4557449147742, 1353.1407556201882, 1369.3427154965473, 1383.7716776731927, 707.9610621415871, 721.527399553283, 730.583567366596, 803.7709252863023, 823.4071468542639, 5115.948840511622, 5303.189309665883, 5425.891482170335, 5429.425466614716, 5441.632889692996, 5065.594752419797, 5952.82141535746, 5990.232881300027, 6013.428724271187, 6030.517558595302, 4761.928571071437, 4857.732824694675, 4931.630127740434, 5418.945810541923, 5437.483439073281, 2987.4771914914804, 3080.6303243610464, 3134.8871150741616, 3145.6697046809754, 3178.284885900654, 5206.245094461282, 5670.136581026638, 5693.459121383545, 6043.576949613484, 6142.447179753844, 5745.798897038583, 5921.733521991435, 6052.818415447544, 6186.051159072724, 6200.883840908679, 5756.906187824384, 6020.066889632114, 6228.096925945712, 6297.788128054725, 6350.237971443456, 5608.46719561641, 6002.609830361012, 6021.578489505692, 6075.696215189135, 6112.358202388685, 5513.649155956817, 5616.943830561806, 5964.940350596438, 5977.850553736192, 6058.363871793575, 5814.075499038217, 5945.732442040032, 6001.669908154919, 6333.683315834282, 6346.2067241594805, 3451.913702157466, 3544.946825797667, 3773.981130094332, 4095.385692146202, 4096.242195193899, 5056.890012642272, 5159.484051594811, 5594.0, 5950.6132101415005, 6002.189704389852, 4357.912841743084, 5788.016037273758, 5808.215890854681, 5814.389489103583, 5877.353491115889, 5687.203791469115, 5762.740676669644, 5764.971175144097, 5767.307923049261, 5782.0, 5673.177389278614, 5676.20533125371, 5687.5734319927, 5700.714964251853, 5709.800156994485, 5526.392096869422, 5692.3169219692245, 5804.709764511842, 5814.883702326015, 5828.03693488432, 4998.3002379667605, 5238.711870846988, 5725.713714314351, 5743.368229494836, 5779.2775903012125], "value": 4178.172834848764, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.6566592143084, 713.6289129652585, 721.3327671903488, 792.1247022040645, 823.1809349697048, 12859.614211573644, 16252.593685157877, 16286.592835179112, 16289.429869954554, 16310.266038028287, 14681.119132852036, 14762.778558321634, 14783.408663653468, 14789.556313310592, 14824.258787060659, 680.2585182151454, 835.7283882738104, 836.5649862071734, 853.9188777066169, 856.7087190355278, 858.171864151094, 860.6643409070467, 862.1637012098255, 863.6156910174975, 865.9826803463927, 892.97754071588, 902.9548522573878, 905.1853332001185, 905.2576886952702, 906.0803284666036, 897.7261935109822, 899.2356496977582, 901.4185850126697, 903.7379160043612, 905.6196397513061, 643.157463722525, 667.1493845347172, 676.1480534526482, 676.6278546799241, 677.1062197898775, 14626.488072917396, 14750.336234869457, 14854.554363369009, 14868.330925108396, 14892.180930048842, 11271.605493807678, 14563.563093107225, 14565.271736413242, 14572.271386430635, 14655.120692758468, 10072.294939354248, 11722.824157637642, 11816.05534265663, 11914.689384167734, 12005.399730013465, 3838.213166300902, 3883.708721845873, 3931.9213615727526, 3942.448057271984, 4065.613766692189, 103730.0, 104130.91738165195, 106512.0, 106846.46576767221, 107449.0, 11182.049525790237, 11183.496742646601, 11208.439578021067, 11314.208005439541, 11722.94138529319, 22271.665925011137, 22444.316676249346, 22461.0, 22509.88745056264, 22543.436414089778, 8129.634166462523, 8178.427510074357, 8324.125966773523, 8422.410431269753, 8442.831143377098, 4446.6220371268155, 4514.796834142471, 4544.386507821468, 4551.45382554089, 4681.95318046822, 3585.1395665040723, 3604.891853244407, 3644.3075815594952, 3670.302642497917, 3686.557613086447, 574.4112284908002, 587.7737071227523, 658.7891874600082, 662.8806814773291, 665.3014334948382, 508.0, 562.5274769193896, 583.982480525585, 648.9448396886318, 675.0920012583068, 8262.504249745034, 8691.846296167372, 9238.815223695488, 9376.437413755197, 9397.436153830791, 581.3895409819672, 629.7449532939168, 644.1690219616642, 647.4561368450525, 677.1298880937971, 4002.818463937161, 4248.760819524605, 4471.128130014681, 4518.932216016762, 4530.61489773373, 132148.0, 161446.54213831315, 163818.0, 166039.0, 168433.1578342125, 76413.6179319111, 78959.0, 94071.0, 141765.0, 142847.4294941979, 69485.0, 80752.59623701962, 81408.0, 104577.90844183073, 104829.95170048355, 9285.303602229726, 9581.568829402555, 9736.610535578497, 9843.261755368232, 9979.251556133175, 51306.0, 56423.43576564182, 57989.0, 59102.70448647729, 59119.0, 55204.44795552154, 61384.0, 74236.62881685558, 82599.76100358379, 82677.58661206656, 11273.985341319321, 11450.141239407245, 11518.712032198926, 11585.189036767682, 11599.594014209462, 12760.617181484571, 14630.634234144232, 14784.408623654934, 15107.32017059257, 15129.39482420735, 11379.829302560634, 13874.583762487142, 13930.79103813464, 14130.364133613806, 14730.484433044792, 13693.863061369259, 13730.45078196901, 14217.502387416804, 14222.857771422154, 14573.708525829636, 11426.714332141762, 13420.194788312732, 13423.798643020167, 13707.246101464116, 14135.64660883486, 10611.575536978435, 10908.072813810915, 11244.55021799119, 11375.0, 11429.771404571695, 10948.616798412017, 11205.422752766746, 11359.886401136213, 11369.4883730234, 11478.540858365572], "value": 7653.716949926791, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1582.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 109.0, 117.0, 115.0, 122.0, 117.0, 117.0, 118.0, 115.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 112.0, 137.0, 160.0, 108.0, 130.0, 166.0, 111.0, 160.0, 109.0], "value": 133.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 198.0, 191.0, 261.0, 251.0, 200.0, 197.0, 199.0, 202.0, 195.0], "value": 209.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 81.0, 75.0, 147.0, 58.0, 58.0, 59.0, 60.0, 139.0, 59.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 115.0, 71.0, 70.0, 76.0, 113.0, 69.0, 74.0, 114.0], "value": 84.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 90.0, 101.0, 113.0, 131.0, 112.0, 88.0, 105.0, 110.0], "value": 102.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 98.0, 149.0, 93.0, 153.0, 150.0, 95.0, 96.0, 99.0, 153.0], "value": 120.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 75.0, 144.0, 143.0, 99.0, 149.0, 128.0, 91.0, 112.0], "value": 112.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 57.0, 56.0, 56.0, 54.0, 60.0, 56.0, 54.0, 56.0, 57.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 70.0, 91.0, 68.0, 73.0, 72.0, 67.0, 70.0, 69.0, 69.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 93.0, 97.0, 88.0, 89.0, 87.0, 86.0, 94.0, 82.0], "value": 89.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 138.0, 139.0, 136.0, 152.0, 147.0, 152.0, 139.0, 153.0, 143.0], "value": 143.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 171.0, 172.0, 150.0, 233.0, 230.0, 191.0, 220.0, 234.0], "value": 194.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 67.0, 71.0, 70.0, 68.0, 69.0, 67.0, 65.0, 68.0], "value": 68.3, "unit": "score"}]}]} 05:56:36 INFO - Return code: 0 05:56:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:56:36 ERROR - # TBPL SUCCESS # 05:56:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:56:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:56:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:56:36 INFO - 2016-08-19 05:56:36.374 screenresolution[2299:283189] starting screenresolution argv=screenresolution get 05:56:36 INFO - 2016-08-19 05:56:36.376 screenresolution[2299:283189] Display 0: 1600x1200x32@60 05:56:36 INFO - 2016-08-19 05:56:36.382 screenresolution[2300:283192] starting screenresolution argv=screenresolution list 05:56:36 INFO - Available Modes on Display 0 05:56:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:56:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:56:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:56:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:56:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:56:36 INFO - Intel Iris: 05:56:36 INFO - Chipset Model: Intel Iris 05:56:36 INFO - Type: GPU 05:56:36 INFO - Bus: Built-In 05:56:36 INFO - VRAM (Dynamic, Max): 1536 MB 05:56:36 INFO - Vendor: Intel (0x8086) 05:56:36 INFO - Device ID: 0x0a2e 05:56:36 INFO - Revision ID: 0x0009 05:56:36 INFO - Displays: 05:56:36 INFO - Display: 05:56:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:56:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:56:36 INFO - Display Serial Number: 1600x1200 60 05:56:36 INFO - Main Display: Yes 05:56:36 INFO - Mirror: Off 05:56:36 INFO - Online: Yes 05:56:36 INFO - Rotation: Supported 05:56:36 INFO - Return code: 0 05:56:36 INFO - Running post-action listener: _resource_record_post_action 05:56:36 INFO - [mozharness: 2016-08-19 12:56:36.623331Z] Finished run-tests step (success) 05:56:36 INFO - Running post-run listener: _resource_record_post_run 05:56:36 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 7983616; Write bytes: 709208576; Read time: 48; Write time: 2075 05:56:36 INFO - TinderboxPrint: CPU usage
54.6% 05:56:36 INFO - TinderboxPrint: I/O read bytes / time
7,983,616 / 48 05:56:36 INFO - TinderboxPrint: I/O write bytes / time
709,208,576 / 2,075 05:56:36 INFO - TinderboxPrint: CPU idle
2,199.9 (45.4%) 05:56:36 INFO - TinderboxPrint: CPU system
980.2 (20.2%) 05:56:36 INFO - TinderboxPrint: CPU user
1,661.6 (34.3%) 05:56:36 INFO - TinderboxPrint: Swap in / out
421,453,824 / 0 05:56:36 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 388160000; Write bytes: 383342592; Read time: 29337; Write time: 836 05:56:36 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 7983616; Write bytes: 300347904; Read time: 48; Write time: 1170 05:56:37 INFO - Running post-run listener: _upload_blobber_files 05:56:37 INFO - Blob upload gear active. 05:56:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:56:37 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:56:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:56:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:56:37 INFO - (blobuploader) - INFO - Open directory for files ... 05:56:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:56:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:56:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:38 INFO - (blobuploader) - INFO - Done attempting. 05:56:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:56:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:56:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:39 INFO - (blobuploader) - INFO - Done attempting. 05:56:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:56:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:56:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:45 INFO - (blobuploader) - INFO - Done attempting. 05:56:45 INFO - (blobuploader) - INFO - Iteration through files over. 05:56:45 INFO - Return code: 0 05:56:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:56:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:56:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c971d31c8e0e0b33177b4398a7c2f46b9b7fc08ce1912f6a309d8c8b4162b81bb10231621bb3127dcccbd469d8812ce77090d0f42358866fd2a70bde81969c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42be197e115e1fb609c5ea162f333007902192424b2e4a05b36856f40850b644a171cf6aab0a5a39f16a82843b99209c53eddf5f3811a9ad030660852faccf36", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9aeb24bece40c769b74c900e71d09a20114c7049978150d430ffb665e1d7923fc5b8d29e161190494b3e044a3bb06141243b207be2dd2f34f610a88a3fad479d"} 05:56:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:56:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:56:45 INFO - Contents: 05:56:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c971d31c8e0e0b33177b4398a7c2f46b9b7fc08ce1912f6a309d8c8b4162b81bb10231621bb3127dcccbd469d8812ce77090d0f42358866fd2a70bde81969c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42be197e115e1fb609c5ea162f333007902192424b2e4a05b36856f40850b644a171cf6aab0a5a39f16a82843b99209c53eddf5f3811a9ad030660852faccf36", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9aeb24bece40c769b74c900e71d09a20114c7049978150d430ffb665e1d7923fc5b8d29e161190494b3e044a3bb06141243b207be2dd2f34f610a88a3fad479d"} 05:56:45 INFO - Running post-run listener: copy_logs_to_upload_dir 05:56:45 INFO - Copying logs to upload dir... 05:56:45 INFO - mkdir: /builds/slave/test/build/upload/logs 05:56:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.908335 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-19 05:56:45.145221) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 05:56:45.148395) ========= 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.WaamHDsmci/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.ET5fIUcrY6/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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/Firefox/sha512/9c971d31c8e0e0b33177b4398a7c2f46b9b7fc08ce1912f6a309d8c8b4162b81bb10231621bb3127dcccbd469d8812ce77090d0f42358866fd2a70bde81969c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42be197e115e1fb609c5ea162f333007902192424b2e4a05b36856f40850b644a171cf6aab0a5a39f16a82843b99209c53eddf5f3811a9ad030660852faccf36", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9aeb24bece40c769b74c900e71d09a20114c7049978150d430ffb665e1d7923fc5b8d29e161190494b3e044a3bb06141243b207be2dd2f34f610a88a3fad479d"} build_url:https://queue.taskcluster.net/v1/task/a8HGQK-4SPmvztM8K_myOg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011062 build_url: 'https://queue.taskcluster.net/v1/task/a8HGQK-4SPmvztM8K_myOg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c971d31c8e0e0b33177b4398a7c2f46b9b7fc08ce1912f6a309d8c8b4162b81bb10231621bb3127dcccbd469d8812ce77090d0f42358866fd2a70bde81969c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42be197e115e1fb609c5ea162f333007902192424b2e4a05b36856f40850b644a171cf6aab0a5a39f16a82843b99209c53eddf5f3811a9ad030660852faccf36", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9aeb24bece40c769b74c900e71d09a20114c7049978150d430ffb665e1d7923fc5b8d29e161190494b3e044a3bb06141243b207be2dd2f34f610a88a3fad479d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 05:56:45.181274) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 05:56:45.181603) ========= 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.WaamHDsmci/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.ET5fIUcrY6/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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.005159 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 05:56:45.230009) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 05:56:45.230321) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 05:56:45.230696) ========= ========= Total master_lag: 0.18 =========