builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0293 starttime: 1468876135.76 results: success (0) buildid: 20160718022258 builduid: 2dbe88499edb4912bb362b1d041e53ee revision: 2b7160a603f1f8f1fb5cef64dc73fb87c115bed7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 14:08:55.758309) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 14:08:55.758747) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 14:08:55.759016) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 14:08:55.783778) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 14:08:55.784110) ========= 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.X0Jo6XI4no/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.Gr3yge9ZhA/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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-07-18 14:08:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 33.8M=0s 2016-07-18 14:08:55 (33.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085673 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 14:08:55.892139) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 14:08:55.892446) ========= 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.X0Jo6XI4no/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.Gr3yge9ZhA/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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.025268 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 14:08:55.940601) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-18 14:08:55.940950) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2b7160a603f1f8f1fb5cef64dc73fb87c115bed7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2b7160a603f1f8f1fb5cef64dc73fb87c115bed7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.X0Jo6XI4no/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.Gr3yge9ZhA/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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-07-18 14:08:56,022 truncating revision to first 12 chars 2016-07-18 14:08:56,022 Setting DEBUG logging. 2016-07-18 14:08:56,022 attempt 1/10 2016-07-18 14:08:56,022 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2b7160a603f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 14:08:58,169 unpacking tar archive at: mozilla-beta-2b7160a603f1/testing/mozharness/ program finished with exit code 0 elapsedTime=2.424830 ========= master_lag: 0.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-18 14:08:58.595663) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 14:08:58.596039) ========= script_repo_revision: 2b7160a603f1f8f1fb5cef64dc73fb87c115bed7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 14:08:58.596420) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 14:08:58.596757) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 14:08:58.668211) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-18 14:08:58.668645) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.X0Jo6XI4no/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.Gr3yge9ZhA/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 14:08:58 INFO - MultiFileLogger online at 20160718 14:08:58 in /builds/slave/test 14:08:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:08:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:08:58 INFO - {'append_to_log': False, 14:08:58 INFO - 'base_work_dir': '/builds/slave/test', 14:08:58 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:08:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:08:58 INFO - 'branch': 'Mozilla-Beta', 14:08:58 INFO - 'buildbot_json_path': 'buildprops.json', 14:08:58 INFO - 'config_files': ('talos/mac_config.py',), 14:08:58 INFO - 'default_actions': ('clobber', 14:08:58 INFO - 'read-buildbot-config', 14:08:58 INFO - 'download-and-extract', 14:08:58 INFO - 'populate-webroot', 14:08:58 INFO - 'create-virtualenv', 14:08:58 INFO - 'install', 14:08:58 INFO - 'run-tests'), 14:08:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:08:58 INFO - 'download_minidump_stackwalk': True, 14:08:58 INFO - 'download_symbols': 'ondemand', 14:08:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:08:58 INFO - 'tooltool.py': '/tools/tooltool.py', 14:08:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:08:58 INFO - '/tools/misc-python/virtualenv.py')}, 14:08:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:08:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:08:58 INFO - 'installer_path': 'installer.exe', 14:08:58 INFO - 'log_level': 'info', 14:08:58 INFO - 'log_name': 'talos', 14:08:58 INFO - 'log_to_console': True, 14:08:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:08:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:08:58 INFO - 'opt_config_files': (), 14:08:58 INFO - 'pip_index': False, 14:08:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:08:58 INFO - 'cmd': ('bash', 14:08:58 INFO - '-c', 14:08:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:08:58 INFO - 'enabled': True, 14:08:58 INFO - 'halt_on_failure': False, 14:08:58 INFO - 'name': 'check_screen_resolution'},), 14:08:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:08:58 INFO - 'cmd': ('bash', 14:08:58 INFO - '-c', 14:08:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:08:58 INFO - 'enabled': True, 14:08:58 INFO - 'halt_on_failure': False, 14:08:58 INFO - 'name': 'check_screen_resolution'},), 14:08:58 INFO - 'run_cmd_checks_enabled': True, 14:08:58 INFO - 'sps_profile': False, 14:08:58 INFO - 'sps_profile_interval': 0, 14:08:58 INFO - 'suite': 'dromaeojs', 14:08:58 INFO - 'system_bits': '32', 14:08:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:08:58 INFO - 'title': 't-yosemite-r7-0293', 14:08:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:08:58 INFO - 'use_talos_json': True, 14:08:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:08:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:08:58 INFO - 'work_dir': 'build'} 14:08:58 INFO - ##### 14:08:58 INFO - ##### Running clobber step. 14:08:58 INFO - ##### 14:08:58 INFO - Running pre-action listener: _resource_record_pre_action 14:08:58 INFO - Running main action method: clobber 14:08:58 INFO - rmtree: /builds/slave/test/build 14:08:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:09:00 INFO - Running post-action listener: _resource_record_post_action 14:09:00 INFO - ##### 14:09:00 INFO - ##### Running read-buildbot-config step. 14:09:00 INFO - ##### 14:09:00 INFO - Running pre-action listener: _resource_record_pre_action 14:09:00 INFO - Running main action method: read_buildbot_config 14:09:00 INFO - Using buildbot properties: 14:09:00 INFO - { 14:09:00 INFO - "project": "", 14:09:00 INFO - "product": "firefox", 14:09:00 INFO - "script_repo_revision": "production", 14:09:00 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 14:09:00 INFO - "repository": "", 14:09:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 14:09:00 INFO - "buildid": "20160718022258", 14:09:00 INFO - "pgo_build": "False", 14:09:00 INFO - "basedir": "/builds/slave/test", 14:09:00 INFO - "buildnumber": 44, 14:09:00 INFO - "slavename": "t-yosemite-r7-0293", 14:09:00 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 14:09:00 INFO - "platform": "yosemite_r7", 14:09:00 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:09:00 INFO - "branch": "mozilla-beta", 14:09:00 INFO - "repo_path": "releases/mozilla-beta", 14:09:00 INFO - "revision": "2b7160a603f1f8f1fb5cef64dc73fb87c115bed7", 14:09:00 INFO - "stage_platform": "macosx64", 14:09:00 INFO - "builduid": "2dbe88499edb4912bb362b1d041e53ee", 14:09:00 INFO - "slavebuilddir": "test" 14:09:00 INFO - } 14:09:00 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833778/firefox-48.0.en-US.mac.dmg. 14:09:00 INFO - Running post-action listener: _resource_record_post_action 14:09:00 INFO - ##### 14:09:00 INFO - ##### Running download-and-extract step. 14:09:00 INFO - ##### 14:09:00 INFO - Running pre-action listener: _resource_record_pre_action 14:09:00 INFO - Running main action method: download_and_extract 14:09:00 INFO - mkdir: /builds/slave/test/build/tests 14:09: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:00 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833778/firefox-48.0.en-US.mac.test_packages.json 14:09:00 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833778/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 14:09:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833778/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 14:09:00 INFO - Downloaded 1165 bytes. 14:09:00 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 14:09:00 INFO - Using the following test package requirements: 14:09:00 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 14:09:00 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:09:00 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 14:09:00 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:09:00 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 14:09:00 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:09:00 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:09:00 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 14:09:00 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 14:09:00 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:09:00 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 14:09:00 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:09:00 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 14:09:00 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:09:00 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 14:09:00 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:09:00 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 14:09:00 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 14:09: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:00 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833778/firefox-48.0.en-US.mac.common.tests.zip 14:09:00 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833778/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 14:09:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833778/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 14:09:01 INFO - Downloaded 18314742 bytes. 14:09:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:09:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:09:04 INFO - Return code: 0 14:09:04 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 14:09:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:04 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833778/firefox-48.0.en-US.mac.common.tests.zip 14:09:04 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833778/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 14:09:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833778/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 14:09:04 INFO - Downloaded 18314742 bytes. 14:09:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:09:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:09:08 INFO - Return code: 0 14:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:08 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833778/firefox-48.0.en-US.mac.talos.tests.zip 14:09:08 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833778/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 14:09:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833778/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 14:09:14 INFO - Downloaded 10840145 bytes. 14:09:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:09:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 14:09:15 INFO - Return code: 0 14:09: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:15 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833778/firefox-48.0.en-US.mac.dmg 14:09:15 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833778/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 14:09:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833778/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 14:09:18 INFO - Downloaded 86191565 bytes. 14:09:18 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833778/firefox-48.0.en-US.mac.dmg 14:09:18 INFO - mkdir: /builds/slave/test/properties 14:09:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:09:18 INFO - Writing to file /builds/slave/test/properties/build_url 14:09:18 INFO - Contents: 14:09:18 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833778/firefox-48.0.en-US.mac.dmg 14:09:18 INFO - Running post-action listener: _resource_record_post_action 14:09:18 INFO - Running post-action listener: set_extra_try_arguments 14:09:18 INFO - ##### 14:09:18 INFO - ##### Running populate-webroot step. 14:09:18 INFO - ##### 14:09:18 INFO - Running pre-action listener: _resource_record_pre_action 14:09:18 INFO - Running main action method: populate_webroot 14:09:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:09:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:09:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:09:18 INFO - '--tppagecycles', 14:09:18 INFO - '7'], 14:09:18 INFO - 'tests': ['tsvgm']}}, 14:09:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:09:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:09:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:09:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:09:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:09:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:09:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:18 INFO - 'talos_options': ['--disable-e10s'], 14:09:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:09:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:09:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:18 INFO - 'talos_options': ['--disable-e10s'], 14:09:18 INFO - 'tests': ['damp', 'tps']}, 14:09:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:18 INFO - 'tests': ['damp', 'tps']}, 14:09:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:09:18 INFO - 'tests': ['dromaeo_dom']}, 14:09:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:09:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:09:18 INFO - 'tests': ['a11yr', 14:09:18 INFO - 'ts_paint', 14:09:18 INFO - 'tpaint', 14:09:18 INFO - 'sessionrestore', 14:09:18 INFO - 'sessionrestore_no_auto_restore', 14:09:18 INFO - 'tabpaint']}, 14:09:18 INFO - 'other-e10s': {'tests': ['a11yr', 14:09:18 INFO - 'ts_paint', 14:09:18 INFO - 'tpaint', 14:09:18 INFO - 'sessionrestore', 14:09:18 INFO - 'sessionrestore_no_auto_restore', 14:09:18 INFO - 'tabpaint']}, 14:09:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:09:18 INFO - 'ts_paint', 14:09:18 INFO - 'tpaint', 14:09:18 INFO - 'sessionrestore', 14:09:18 INFO - 'sessionrestore_no_auto_restore', 14:09:18 INFO - 'tabpaint']}, 14:09:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:09:18 INFO - 'ts_paint', 14:09:18 INFO - 'tpaint', 14:09:18 INFO - 'sessionrestore', 14:09:18 INFO - 'sessionrestore_no_auto_restore', 14:09:18 INFO - 'tabpaint']}, 14:09:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:09:18 INFO - 'tests': ['a11yr', 14:09:18 INFO - 'ts_paint', 14:09:18 INFO - 'tpaint', 14:09:18 INFO - 'sessionrestore', 14:09:18 INFO - 'sessionrestore_no_auto_restore', 14:09:18 INFO - 'tabpaint']}, 14:09:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:09:18 INFO - 'tests': ['a11yr', 14:09:18 INFO - 'ts_paint', 14:09:18 INFO - 'tpaint', 14:09:18 INFO - 'sessionrestore', 14:09:18 INFO - 'sessionrestore_no_auto_restore', 14:09:18 INFO - 'tabpaint']}, 14:09:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:09:18 INFO - 'tests': ['tsvgx', 14:09:18 INFO - 'tsvgr_opacity', 14:09:18 INFO - 'tart', 14:09:18 INFO - 'tscrollx', 14:09:18 INFO - 'cart']}, 14:09:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:09:18 INFO - 'tsvgr_opacity', 14:09:18 INFO - 'tart', 14:09:18 INFO - 'tscrollx', 14:09:18 INFO - 'cart']}, 14:09:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:18 INFO - 'talos_options': ['--disable-e10s'], 14:09:18 INFO - 'tests': ['tp5o']}, 14:09:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:18 INFO - 'tests': ['tp5o']}, 14:09:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:18 INFO - 'talos_options': ['--disable-e10s', 14:09:18 INFO - '--xperf_path', 14:09:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:09:18 INFO - 'tests': ['tp5n']}, 14:09:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:18 INFO - 'talos_options': ['--xperf_path', 14:09:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:09:18 INFO - 'tests': ['tp5n']}}, 14:09:18 INFO - 'talos.zip': {'path': '', 14:09:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:09:18 INFO - Running post-action listener: _resource_record_post_action 14:09:18 INFO - ##### 14:09:18 INFO - ##### Running create-virtualenv step. 14:09:18 INFO - ##### 14:09:18 INFO - Running pre-action listener: _resource_record_pre_action 14:09:18 INFO - Running main action method: create_virtualenv 14:09:18 INFO - Creating virtualenv /builds/slave/test/build/venv 14:09:18 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 14:09:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:09:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:09:19 INFO - Using real prefix '/tools/python27' 14:09:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:09:19 INFO - Installing distribute.............................................................................................................................................................................................done. 14:09:22 INFO - Installing pip.................done. 14:09:22 INFO - Return code: 0 14:09:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:22 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 0x10d6ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d70f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d38498960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d59ee00>, '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 0x10d407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d599b20>, '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.X0Jo6XI4no/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.Gr3yge9ZhA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 14:09:22 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 14:09:22 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 14:09:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X0Jo6XI4no/Render', 14:09:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:22 INFO - 'HOME': '/Users/cltbld', 14:09:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:22 INFO - 'LOGNAME': 'cltbld', 14:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:22 INFO - 'MOZ_NO_REMOTE': '1', 14:09:22 INFO - 'NO_EM_RESTART': '1', 14:09:22 INFO - 'PAGER': '/bin/cat', 14:09:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:22 INFO - 'PWD': '/builds/slave/test', 14:09:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:22 INFO - 'SHELL': '/bin/bash', 14:09:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gr3yge9ZhA/Listeners', 14:09:22 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 14:09:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:22 INFO - 'USER': 'cltbld', 14:09:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:22 INFO - 'XPC_FLAGS': '0x0', 14:09:22 INFO - 'XPC_SERVICE_NAME': '0', 14:09:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:23 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 14:09:23 INFO - Cleaning up... 14:09:23 INFO - Return code: 0 14:09:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:23 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d6ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d70f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d38498960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d59ee00>, '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 0x10d407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d599b20>, '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.X0Jo6XI4no/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.Gr3yge9ZhA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 14:09:23 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>=0.7.1'] in /builds/slave/test/build 14:09:23 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>=0.7.1 14:09:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X0Jo6XI4no/Render', 14:09:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:23 INFO - 'HOME': '/Users/cltbld', 14:09:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:23 INFO - 'LOGNAME': 'cltbld', 14:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:23 INFO - 'MOZ_NO_REMOTE': '1', 14:09:23 INFO - 'NO_EM_RESTART': '1', 14:09:23 INFO - 'PAGER': '/bin/cat', 14:09:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:23 INFO - 'PWD': '/builds/slave/test', 14:09:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:23 INFO - 'SHELL': '/bin/bash', 14:09:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gr3yge9ZhA/Listeners', 14:09:23 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 14:09:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:23 INFO - 'USER': 'cltbld', 14:09:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:23 INFO - 'XPC_FLAGS': '0x0', 14:09:23 INFO - 'XPC_SERVICE_NAME': '0', 14:09:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:23 INFO - Downloading/unpacking psutil>=0.7.1 14:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:09:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:09:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:09:27 INFO - Installing collected packages: psutil 14:09:27 INFO - Running setup.py install for psutil 14:09:27 INFO - building 'psutil._psutil_osx' extension 14:09:27 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 14:09:28 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 14:09:28 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 14:09:28 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 14:09:28 INFO - building 'psutil._psutil_posix' extension 14:09:28 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 14:09:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:09:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:09:28 INFO - ^ 14:09:28 INFO - 1 warning generated. 14:09:28 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 14:09:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:09:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:09:28 INFO - Successfully installed psutil 14:09:28 INFO - Cleaning up... 14:09:28 INFO - Return code: 0 14:09:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d6ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d70f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d38498960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d59ee00>, '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 0x10d407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d599b20>, '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.X0Jo6XI4no/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.Gr3yge9ZhA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 14:09:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:09:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X0Jo6XI4no/Render', 14:09:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:28 INFO - 'HOME': '/Users/cltbld', 14:09:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:28 INFO - 'LOGNAME': 'cltbld', 14:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:28 INFO - 'MOZ_NO_REMOTE': '1', 14:09:28 INFO - 'NO_EM_RESTART': '1', 14:09:28 INFO - 'PAGER': '/bin/cat', 14:09:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:28 INFO - 'PWD': '/builds/slave/test', 14:09:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:28 INFO - 'SHELL': '/bin/bash', 14:09:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gr3yge9ZhA/Listeners', 14:09:28 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 14:09:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:28 INFO - 'USER': 'cltbld', 14:09:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:28 INFO - 'XPC_FLAGS': '0x0', 14:09:28 INFO - 'XPC_SERVICE_NAME': '0', 14:09:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:09:29 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 14:09:29 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 14:09:29 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 14:09:29 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 14:09:29 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 14:09:29 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 14:09:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:09:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:09:31 INFO - Installing collected packages: mozsystemmonitor 14:09:31 INFO - Running setup.py install for mozsystemmonitor 14:09:31 INFO - Successfully installed mozsystemmonitor 14:09:31 INFO - Cleaning up... 14:09:31 INFO - Return code: 0 14:09:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:31 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 0x10d6ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d70f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d38498960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d59ee00>, '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 0x10d407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d599b20>, '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.X0Jo6XI4no/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.Gr3yge9ZhA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 14:09:31 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 14:09:31 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 14:09:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X0Jo6XI4no/Render', 14:09:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:31 INFO - 'HOME': '/Users/cltbld', 14:09:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:31 INFO - 'LOGNAME': 'cltbld', 14:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:31 INFO - 'MOZ_NO_REMOTE': '1', 14:09:31 INFO - 'NO_EM_RESTART': '1', 14:09:31 INFO - 'PAGER': '/bin/cat', 14:09:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:31 INFO - 'PWD': '/builds/slave/test', 14:09:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:31 INFO - 'SHELL': '/bin/bash', 14:09:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gr3yge9ZhA/Listeners', 14:09:31 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 14:09:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:31 INFO - 'USER': 'cltbld', 14:09:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:31 INFO - 'XPC_FLAGS': '0x0', 14:09:31 INFO - 'XPC_SERVICE_NAME': '0', 14:09:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:32 INFO - Downloading/unpacking blobuploader==1.2.4 14:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:34 INFO - Downloading blobuploader-1.2.4.tar.gz 14:09:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:09:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:09:34 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 14:09:34 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 14:09:34 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 14:09:34 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 14:09:34 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 14:09:34 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 14:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:09:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:09:35 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 14:09:35 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 14:09:35 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 14:09:35 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 14:09:35 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 14:09:35 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 14:09:35 INFO - Downloading docopt-0.6.1.tar.gz 14:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:09:35 INFO - Installing collected packages: blobuploader, requests, docopt 14:09:35 INFO - Running setup.py install for blobuploader 14:09:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:09:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:09:36 INFO - Running setup.py install for requests 14:09:36 INFO - Running setup.py install for docopt 14:09:36 INFO - Successfully installed blobuploader requests docopt 14:09:36 INFO - Cleaning up... 14:09:36 INFO - Return code: 0 14:09:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:36 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 0x10d6ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d70f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d38498960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d59ee00>, '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 0x10d407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d599b20>, '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.X0Jo6XI4no/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.Gr3yge9ZhA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 14:09:36 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 14:09:36 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 14:09:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X0Jo6XI4no/Render', 14:09:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:36 INFO - 'HOME': '/Users/cltbld', 14:09:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:36 INFO - 'LOGNAME': 'cltbld', 14:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:36 INFO - 'MOZ_NO_REMOTE': '1', 14:09:36 INFO - 'NO_EM_RESTART': '1', 14:09:36 INFO - 'PAGER': '/bin/cat', 14:09:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:36 INFO - 'PWD': '/builds/slave/test', 14:09:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:36 INFO - 'SHELL': '/bin/bash', 14:09:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gr3yge9ZhA/Listeners', 14:09:36 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 14:09:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:36 INFO - 'USER': 'cltbld', 14:09:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:36 INFO - 'XPC_FLAGS': '0x0', 14:09:36 INFO - 'XPC_SERVICE_NAME': '0', 14:09:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:09:37 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-r1Scv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:09:37 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-9vUJ2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:09:37 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-4hCmso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:09:37 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-JAjahT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:09:37 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-sb560L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:09:37 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-0DsgbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:09:37 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-FPTPMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:09:37 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-TNVQQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:09:37 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-kHMa2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:09:37 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-YCVsII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:09:38 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-m4qaOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:09:38 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-P4lcaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:09:38 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-UeYFn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:09:38 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-GTtgin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:38 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-Z5HRrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:09:38 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-Y2gqPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:09:38 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-lVj2SR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:09:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:09:38 INFO - Running setup.py install for manifestparser 14:09:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:09:38 INFO - Running setup.py install for mozcrash 14:09:39 INFO - Running setup.py install for mozdebug 14:09:39 INFO - Running setup.py install for mozdevice 14:09:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:09:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:09:39 INFO - Running setup.py install for mozfile 14:09:39 INFO - Running setup.py install for mozhttpd 14:09:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:09:39 INFO - Running setup.py install for mozinfo 14:09:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:09:39 INFO - Running setup.py install for mozInstall 14:09:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:09:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:09:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:09:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:09:40 INFO - Running setup.py install for mozleak 14:09:40 INFO - Running setup.py install for mozlog 14:09:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:09:40 INFO - Running setup.py install for moznetwork 14:09:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:09:40 INFO - Running setup.py install for mozprocess 14:09:40 INFO - Running setup.py install for mozprofile 14:09:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:09:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:09:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:09:40 INFO - Running setup.py install for mozrunner 14:09:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:09:40 INFO - Running setup.py install for mozscreenshot 14:09:41 INFO - Running setup.py install for moztest 14:09:41 INFO - Running setup.py install for mozversion 14:09:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:09:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:09:41 INFO - Cleaning up... 14:09:41 INFO - Return code: 0 14:09:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09:41 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:41 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:41 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 0x10d6ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d70f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d38498960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d59ee00>, '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 0x10d407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d599b20>, '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.X0Jo6XI4no/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.Gr3yge9ZhA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 14:09:41 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 14:09:41 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 14:09:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X0Jo6XI4no/Render', 14:09:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:41 INFO - 'HOME': '/Users/cltbld', 14:09:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:41 INFO - 'LOGNAME': 'cltbld', 14:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:41 INFO - 'MOZ_NO_REMOTE': '1', 14:09:41 INFO - 'NO_EM_RESTART': '1', 14:09:41 INFO - 'PAGER': '/bin/cat', 14:09:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:41 INFO - 'PWD': '/builds/slave/test', 14:09:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:41 INFO - 'SHELL': '/bin/bash', 14:09:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gr3yge9ZhA/Listeners', 14:09:41 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 14:09:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:41 INFO - 'USER': 'cltbld', 14:09:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:41 INFO - 'XPC_FLAGS': '0x0', 14:09:41 INFO - 'XPC_SERVICE_NAME': '0', 14:09:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:09:41 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-kNu2Bw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:09:41 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)) 14:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:09:41 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-y4J_nA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:09:41 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)) 14:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:09:41 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-OpUxeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:09:42 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)) 14:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:09:42 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-_my9dH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:09:42 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)) 14:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:09:42 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-HabemE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:09:42 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)) 14:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:09:42 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-Aha6r7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:09:42 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)) 14:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:09:42 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-_jLmaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:09:42 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)) 14:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:09:42 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-SsikcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:09:42 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)) 14:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:09:42 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-lr6Pns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:09:42 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)) 14:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:09:42 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-CLqNn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:09:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 14:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:09:42 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-dOpDkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:09:42 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)) 14:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:09:42 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-daQfvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:09:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 14:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:09:42 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-b5AEif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:09:43 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)) 14:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:09:43 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-XFvYXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 14:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:43 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-5swpqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:43 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)) 14:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:09:43 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-Sa5nBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:09:43 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)) 14:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:09:43 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-CIXmU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:09:43 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)) 14:09:43 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)) 14:09:43 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)) 14:09:43 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)) 14:09:43 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)) 14:09:43 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)) 14:09:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:45 INFO - Downloading blessings-1.6.tar.gz 14:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:09:46 INFO - Installing collected packages: blessings 14:09:46 INFO - Running setup.py install for blessings 14:09:46 INFO - Successfully installed blessings 14:09:46 INFO - Cleaning up... 14:09:46 INFO - Return code: 0 14:09:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:09:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:09:46 INFO - Reading from file tmpfile_stdout 14:09:46 INFO - Current package versions: 14:09:46 INFO - blessings == 1.6 14:09:46 INFO - blobuploader == 1.2.4 14:09:46 INFO - docopt == 0.6.1 14:09:46 INFO - manifestparser == 1.1 14:09:46 INFO - mozInstall == 1.12 14:09:46 INFO - mozcrash == 0.17 14:09:46 INFO - mozdebug == 0.1 14:09:46 INFO - mozdevice == 0.48 14:09:46 INFO - mozfile == 1.2 14:09:46 INFO - mozhttpd == 0.7 14:09:46 INFO - mozinfo == 0.9 14:09:46 INFO - mozleak == 0.1 14:09:46 INFO - mozlog == 3.1 14:09:46 INFO - moznetwork == 0.27 14:09:46 INFO - mozprocess == 0.22 14:09:46 INFO - mozprofile == 0.28 14:09:46 INFO - mozrunner == 6.11 14:09:46 INFO - mozscreenshot == 0.1 14:09:46 INFO - mozsystemmonitor == 0.0 14:09:46 INFO - moztest == 0.7 14:09:46 INFO - mozversion == 1.4 14:09:46 INFO - psutil == 3.1.1 14:09:46 INFO - requests == 1.2.3 14:09:46 INFO - wsgiref == 0.1.2 14:09:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09:46 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:46 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:46 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 0x10d6ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d70f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d38498960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d59ee00>, '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 0x10d407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d599b20>, '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.X0Jo6XI4no/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.Gr3yge9ZhA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 14:09:46 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 14:09:46 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 14:09:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X0Jo6XI4no/Render', 14:09:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:46 INFO - 'HOME': '/Users/cltbld', 14:09:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:46 INFO - 'LOGNAME': 'cltbld', 14:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:46 INFO - 'MOZ_NO_REMOTE': '1', 14:09:46 INFO - 'NO_EM_RESTART': '1', 14:09:46 INFO - 'PAGER': '/bin/cat', 14:09:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:46 INFO - 'PWD': '/builds/slave/test', 14:09:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:46 INFO - 'SHELL': '/bin/bash', 14:09:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gr3yge9ZhA/Listeners', 14:09:46 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 14:09:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:46 INFO - 'USER': 'cltbld', 14:09:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:46 INFO - 'XPC_FLAGS': '0x0', 14:09:46 INFO - 'XPC_SERVICE_NAME': '0', 14:09:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:46 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)) 14:09:46 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)) 14:09:46 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)) 14:09:46 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)) 14:09:46 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)) 14:09:46 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)) 14:09:46 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)) 14:09:46 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)) 14:09:46 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)) 14:09:46 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)) 14:09:46 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)) 14:09:46 INFO - Cleaning up... 14:09:46 INFO - Return code: 0 14:09:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:09:46 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:46 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:46 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 0x10d6ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d70f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d38498960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d59ee00>, '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 0x10d407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d599b20>, '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.X0Jo6XI4no/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.Gr3yge9ZhA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 14:09:46 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 14:09:46 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 14:09:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X0Jo6XI4no/Render', 14:09:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:46 INFO - 'HOME': '/Users/cltbld', 14:09:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:46 INFO - 'LOGNAME': 'cltbld', 14:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:46 INFO - 'MOZ_NO_REMOTE': '1', 14:09:46 INFO - 'NO_EM_RESTART': '1', 14:09:46 INFO - 'PAGER': '/bin/cat', 14:09:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:46 INFO - 'PWD': '/builds/slave/test', 14:09:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:46 INFO - 'SHELL': '/bin/bash', 14:09:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gr3yge9ZhA/Listeners', 14:09:46 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 14:09:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:46 INFO - 'USER': 'cltbld', 14:09:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:46 INFO - 'XPC_FLAGS': '0x0', 14:09:46 INFO - 'XPC_SERVICE_NAME': '0', 14:09:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:47 INFO - Downloading/unpacking jsonschema 14:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:09:49 INFO - Downloading/unpacking functools32 (from jsonschema) 14:09:49 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 14:09:49 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 14:09:49 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 14:09:49 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 14:09:49 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 14:09:49 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 14:09:49 INFO - Downloading functools32-3.2.3-2.tar.gz 14:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:09:50 INFO - warning: no files found matching '*.txt' 14:09:50 INFO - no previously-included directories found matching 'build' 14:09:50 INFO - no previously-included directories found matching 'dist' 14:09:50 INFO - no previously-included directories found matching '.git*' 14:09:50 INFO - Installing collected packages: jsonschema, functools32 14:09:50 INFO - Running setup.py install for functools32 14:09:50 INFO - warning: no files found matching '*.txt' 14:09:50 INFO - no previously-included directories found matching 'build' 14:09:50 INFO - no previously-included directories found matching 'dist' 14:09:50 INFO - no previously-included directories found matching '.git*' 14:09:50 INFO - Successfully installed jsonschema functools32 14:09:50 INFO - Cleaning up... 14:09:50 INFO - Return code: 0 14:09:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:09: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:50 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d6ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d70f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d38498960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d59ee00>, '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 0x10d407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d599b20>, '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.X0Jo6XI4no/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.Gr3yge9ZhA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 14:09:50 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', 'flake8'] in /builds/slave/test/build 14:09:50 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 flake8 14:09:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X0Jo6XI4no/Render', 14:09:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:50 INFO - 'HOME': '/Users/cltbld', 14:09:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:50 INFO - 'LOGNAME': 'cltbld', 14:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:50 INFO - 'MOZ_NO_REMOTE': '1', 14:09:50 INFO - 'NO_EM_RESTART': '1', 14:09:50 INFO - 'PAGER': '/bin/cat', 14:09:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:50 INFO - 'PWD': '/builds/slave/test', 14:09:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:50 INFO - 'SHELL': '/bin/bash', 14:09:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gr3yge9ZhA/Listeners', 14:09:50 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 14:09:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:50 INFO - 'USER': 'cltbld', 14:09:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:50 INFO - 'XPC_FLAGS': '0x0', 14:09:50 INFO - 'XPC_SERVICE_NAME': '0', 14:09:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:50 INFO - Downloading/unpacking flake8 14:09:50 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 14:09:50 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 14:09:50 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 14:09:50 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 14:09:50 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 14:09:50 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 14:09:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:09:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:09:53 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 14:09:53 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 14:09:53 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 14:09:53 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 14:09:53 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 14:09:53 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 14:09:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:09:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:09:53 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 14:09:53 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 14:09:53 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 14:09:53 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 14:09:53 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 14:09:53 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 14:09:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:09:53 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 14:09:53 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 14:09:53 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 14:09:53 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 14:09:53 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 14:09:53 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 14:09:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:09:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:09:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:09:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:09:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:09:54 INFO - no previously-included directories found matching 'docs/_build' 14:09:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:09:54 INFO - Running setup.py install for pep8 14:09:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:09:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:09:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:09:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:09:54 INFO - no previously-included directories found matching 'docs/_build' 14:09:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:09:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:09:54 INFO - Cleaning up... 14:09:54 INFO - Return code: 0 14:09:54 INFO - Running post-action listener: _resource_record_post_action 14:09:54 INFO - Running post-action listener: _start_resource_monitoring 14:09:54 INFO - Starting resource monitoring. 14:09:54 INFO - ##### 14:09:54 INFO - ##### Running install step. 14:09:54 INFO - ##### 14:09:54 INFO - Running pre-action listener: _resource_record_pre_action 14:09:54 INFO - Running main action method: install 14:09:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:09:54 INFO - Reading from file tmpfile_stdout 14:09:54 INFO - Detecting whether we're running mozinstall >=1.0... 14:09:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:09:55 INFO - Reading from file tmpfile_stdout 14:09:55 INFO - Output received: 14:09:55 INFO - Usage: mozinstall [options] installer 14:09:55 INFO - Options: 14:09:55 INFO - -h, --help show this help message and exit 14:09:55 INFO - -d DEST, --destination=DEST 14:09:55 INFO - Directory to install application into. [default: 14:09:55 INFO - "/builds/slave/test"] 14:09:55 INFO - --app=APP Application being installed. [default: firefox] 14:09:55 INFO - mkdir: /builds/slave/test/build/application 14:09:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 14:10:16 INFO - Reading from file tmpfile_stdout 14:10:16 INFO - Output received: 14:10:16 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:10:16 INFO - Running post-action listener: _resource_record_post_action 14:10:16 INFO - ##### 14:10:16 INFO - ##### Running run-tests step. 14:10:16 INFO - ##### 14:10:16 INFO - Running pre-action listener: _resource_record_pre_action 14:10:16 INFO - Running main action method: run_tests 14:10:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:10:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:10:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:10:16 INFO - 2016-07-18 14:10:16.689 screenresolution[1645:7594] starting screenresolution argv=screenresolution get 14:10:16 INFO - 2016-07-18 14:10:16.692 screenresolution[1645:7594] Display 0: 1600x1200x32@60 14:10:16 INFO - 2016-07-18 14:10:16.698 screenresolution[1646:7596] starting screenresolution argv=screenresolution list 14:10:16 INFO - Available Modes on Display 0 14:10:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:10:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:10:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:10:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:10:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:10:16 INFO - Intel Iris: 14:10:16 INFO - Chipset Model: Intel Iris 14:10:16 INFO - Type: GPU 14:10:16 INFO - Bus: Built-In 14:10:16 INFO - VRAM (Dynamic, Max): 1536 MB 14:10:16 INFO - Vendor: Intel (0x8086) 14:10:16 INFO - Device ID: 0x0a2e 14:10:16 INFO - Revision ID: 0x0009 14:10:16 INFO - Displays: 14:10:16 INFO - Display: 14:10:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:10:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:10:16 INFO - Display Serial Number: 1600x1200 60 14:10:16 INFO - Main Display: Yes 14:10:16 INFO - Mirror: Off 14:10:16 INFO - Online: Yes 14:10:16 INFO - Rotation: Supported 14:10:16 INFO - Return code: 0 14:10:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:10:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:10:16 INFO - Python 2.7.3 14:10:16 INFO - Return code: 0 14:10:16 INFO - grabbing minidump binary from tooltool 14:10:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:16 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d59ee00>, '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 0x10d407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d599b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:10:16 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 14:10:16 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 14:10:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:10:17 INFO - Return code: 0 14:10:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:10:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:10:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:10:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:10:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:10:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:10:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:10:18 INFO - Return code: 0 14:10:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833778/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0293', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833778/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0293 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:10:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X0Jo6XI4no/Render', 14:10:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:10:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:10:18 INFO - 'HOME': '/Users/cltbld', 14:10:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:10:18 INFO - 'LOGNAME': 'cltbld', 14:10:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:10:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:18 INFO - 'MOZ_NO_REMOTE': '1', 14:10:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:10:18 INFO - 'NO_EM_RESTART': '1', 14:10:18 INFO - 'PAGER': '/bin/cat', 14:10:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:18 INFO - 'PWD': '/builds/slave/test', 14:10:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:10:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:10:18 INFO - 'SHELL': '/bin/bash', 14:10:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gr3yge9ZhA/Listeners', 14:10:18 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 14:10:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:10:18 INFO - 'USER': 'cltbld', 14:10:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:10:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:18 INFO - 'XPC_FLAGS': '0x0', 14:10:18 INFO - 'XPC_SERVICE_NAME': '0', 14:10:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:10:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833778/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0293', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:10:18 INFO - mozversion application_buildid: 20160718022258 14:10:18 INFO - mozversion application_changeset: 2b7160a603f1f8f1fb5cef64dc73fb87c115bed7 14:10:18 INFO - mozversion application_display_name: Firefox 14:10:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:10:18 INFO - mozversion application_name: Firefox 14:10:18 INFO - mozversion application_remotingname: firefox 14:10:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:10:18 INFO - mozversion application_vendor: Mozilla 14:10:18 INFO - mozversion application_version: 48.0 14:10:18 INFO - mozversion platform_buildid: 20160718022258 14:10:18 INFO - mozversion platform_changeset: 2b7160a603f1f8f1fb5cef64dc73fb87c115bed7 14:10:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:10:18 INFO - mozversion platform_version: 48.0 14:10:18 INFO - using testdate: 1468876218 14:10:18 INFO - actual date: 1468876218 14:10:18 INFO - starting webserver on 'localhost:49269' 14:10:18 INFO - SUITE-START | Running 2 tests 14:10:18 INFO - TEST-START | dromaeo_css 14:10:18 INFO - operating with platform_type : mac_ 14:10:18 INFO - Initialising browser for dromaeo_css test... 14:10:18 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/tmpmQ6MHw/profile http://localhost:49269/getInfo.html) 14:10:20 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 14:10:20 INFO - PROCESS | 1664 | colorDepth:24 14:10:20 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 14:10:20 INFO - PROCESS | 1664 | __metrics 14:10:20 INFO - PROCESS | 1664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:10:20 ERROR - PROCESS | 1664 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:10:21 INFO - TEST-INFO | 1664: exit 0 14:10:21 INFO - Browser initialized. 14:10:21 INFO - Running cycle 1/1 for dromaeo_css test... 14:10:21 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/tmpmQ6MHw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:10:33 INFO - PROCESS | 1667 | RSS: Main: 160423936 14:10:33 INFO - PROCESS | 1667 | 14:11:24 INFO - PROCESS | 1667 | 1468876284628 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] 14:13:34 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 14:13:35 INFO - PROCESS | 1667 | RSS: Main: 262647808 14:13:35 INFO - PROCESS | 1667 | 14:16:38 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 14:16:39 INFO - PROCESS | 1667 | RSS: Main: 310919168 14:16:39 INFO - PROCESS | 1667 | 14:19:40 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 14:19:41 INFO - PROCESS | 1667 | RSS: Main: 310513664 14:19:41 INFO - PROCESS | 1667 | 14:22:43 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 14:22:44 INFO - PROCESS | 1667 | RSS: Main: 307593216 14:22:44 INFO - PROCESS | 1667 | 14:25:47 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 14:25:48 INFO - PROCESS | 1667 | RSS: Main: 274714624 14:25:48 INFO - PROCESS | 1667 | 14:28:50 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 14:28:50 INFO - PROCESS | 1667 | RSS: Main: 316715008 14:28:50 INFO - PROCESS | 1667 | 14:28:50 INFO - PROCESS | 1667 | __start_tp_report 14:28:50 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 14:28:50 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 14:28:50 INFO - PROCESS | 1667 | |i|pagename|runs| 14:28:50 INFO - PROCESS | 1667 | |0;dojo.html;3484.982575087125;3582.1760994971164;3582.892513224604;3590.1742599202166;3678.2643471305746;5859.414058594139;5882.529397648189;5927.525797936166;5984.401559844014;5988.880222395549;5913.438223368784;5935.673537955411;5937.139114828358;5954.225950626413;5966.910496342547;5270.367555893288;5286.180642000496;5384.273123128367;5387.4612538746005;5428.9185662215095;4524.389207456984;5399.595030372718;5428.022955867942;5463.726813659301;5477.0415177344;5333.653312534673;5378.166384210434;5382;5388.43421440749;5463.863403414906;5423.701696406716;5455.672659640434;5462.8361149165585;5464.23500709901;5501.422350653163;4912.70523768575;5259.76331065103;5344.759485823147;5359.785608575652;5365.382980957162;5758.510526605243;5767.279090113736;5803.47768700819;5829.795957141522;5839.503642190419;5770.480656740913;6111.388861113853;6233.345498722614;6260.40526150015;6270.31026587075;6193.473554747852;6225.5330850185965;6266.091416744592;6302.653354065525;6304.779332723333;6037.88221604499;6042.516598672096;6063.605865618721;6071.908921366183;6074.3259751981095;6380.042993551005;6387.233531976192;6393.552451328455;6404.1674582304;6405.295417504164;6206.131141640174;6210.161628180228;6298.275698294663;6311.873762524724;6314.242290925118;6250.6874656267;6304;6314.747410103636;6319.146915166394;6333.334999825044;6172.5679202456295;6249.531285153541;6269.435750782452;6271.843203919847;6276.309605943343;6186.1648677428875;6199;6257.43683068526;6269.874602508015;6315.052742088632;4327.831485498898;5022.547970682583;5069.873253168626;5072.6195535335;5076.568491678175;4513.842015529441;4583.793729282191;4600.401947746772;4602.148602508547;4615.376924115201;6009.669468179205;6059.363766804422;6079.483243924316;6087.573869829158;6115.296740874856;6289.528285378615;6339.2709838368255;6351.110844481776;6359.046143078575;6366.490680745529;5975.551833612496;6025.548083893726;6033.939660603425;6048.727807248684;6057.061155520813;5555.722213889289;5560.388357280696;5562.082256427644;5572.86067848307;5628.240187574707;6490.383413575702;6508.479321654161;6514.1531600891585;6527.738890444424;6544.607323560602;6212.347703491068;6270.2475702915945;6289.150964619717;6290.24517057956;6341.8097457076365;6485.54601177913;6499.837504062436;6552.24649165333;6558;6566.737330506726;6290.748370065146;6294.874102518015;6298.433141017331;6310.7475700971445;6319.399657032574;6193.783217587543;6249.468795152463;6254.186955695731;6305.653189074645;6315.810525684236;6094.329623741473;6228.22147231596;6237.844053898689;6243.250809902841;6253.749850005949;6183.0107182850525;6256.530760192913;6276.121343012073;6279.780207692709;6286.622802631857;6081.39186081406;6130.386961304012;6145.016797312409;6210.441060304594;6267.655278959701;6201.534884883562;6231.127642130196;6249.531285153723;6265.154204182377;6267.185265915402;6225.968870155621;6258.249010118815;6282.528810339334;6291.496680265659;6304.842378940563 14:28:50 INFO - PROCESS | 1667 | |1;ext.html;535.617033820818;536.1154095742027;541.5802752866529;551.1347184919678;587.538782056086;29578.704212957862;33163.50254746181;40314.58898938534;40666.59333406665;40809.387859182134;43839.78080109603;44231.336529951994;44330.77834610822;44344.891377715576;44382.55617443832;8975.506347150904;9513.38163019405;9744.22046236303;9765.12113909748;9789.95105024474;9061.50161741104;9181.908180918206;9192.862107068398;10236.897631023707;12244.938775306111;11761.176717629769;11806.7638647227;11816.645500634952;11817.586384476544;11859.881401186007;11739.413029348541;11840.407979600985;11848.407579620984;11858.169928105037;11859.52561897523;11611.767764644745;11755.94122029393;11762.70593235176;11773.882261177365;11779.823302650468;39680.801595992125;40316.79841600773;42106.57893421057;42143.57856421427;42327;3393.3043726036103;3425.2806910548816;3513.350030244413;3622.474741162543;3988.6809055275507;28408.715912840813;29478.557821632694;29702.405951880843;29916.55125173124;30347.696523034927;2757.7242275772464;2792.7486526212533;2819.8167119137397;2896.189067061226;2896.4062367214883;358345.20827395696;359196;360677.1966140179;361587;362332;38122;38759;38785.2242955145;38861.80569097136;62034;30495.69504304973;37218;37285.88142355734;37306.626933730855;37332.066698332215;15825.366985320688;16010.839891601168;16011.439599613957;16022.359105635876;16163.515094547183;12716.872831271754;13407.463701452029;13526.526571569948;13535.59393218205;13552.254625995665;8101.635426405708;8178.977627796526;8181.018277806701;8482;8690.261327787082;3488.8255587220538;3549.6982756465472;3554.7689400188906;3557.8221088945447;3584.175639602906;945.4705364995486;1000.2947921715173;1017.1811691588194;1036.233187441288;1241.7951038078616;30232.244193895327;30531.69468305333;30597.23506912345;30835.69164308373;31008.68991310058;1066.933066933067;1107.4462768615692;1217.65601217657;1218.634409677111;1329.2622594459974;13081.803772943413;14662.486812961708;14762.846736059604;14887.255637218312;14932.40270389194;653941;659559;667698;668002;668903;63239.6838015807;63910.36089639137;63948.68025659935;63977.72044559083;64001.39996500032;1548.9302981365865;1551.100361790159;1555.8020324350414;1563.8983466074897;1566.772817941392;23849.926753295797;28935.85532072326;29477;29836.104916852528;30178.849105754332;53978;54619.180712290145;54621;54767.45232547623;54799.63000925009;518792;519920;521641;521897;523154;25970.35074123162;25971.74028259769;28009.43981120407;28449.573256400756;28510;37574.87275381743;39368.212635747695;45680.543194568956;48599.5140048595;49510.50489495059;36488.27023459569;37489.81255093707;37783.05542361353;37907.241855163295;38730.6126938727;37035.444468332455;37230.44154337633;37660.43509347307;37811.81094094512;38016.619833801306;36930.26139477142;37605.68380106793;37657.2468550622;38778.4183237246;38817.805910970266;32041.51937720983;32814;32957.67042329642;33026.66973330236;33040;22193.77806221982;23355.29418773797;24772.876135619208;25566.360840979123;25639.743602563736 14:28:50 INFO - PROCESS | 1667 | |2;jquery.html;408.4955080475612;409.1040621039923;414.49017708218906;416.75619762438953;423.8813132322949;20513.179472821088;21161.047752851122;21283.787162128374;21319.893400532994;22327.888360558216;22530.43673908149;22597.661035084486;22692;22710.545789084208;22722.88638556809;5210.9478905210935;5583.6928968906695;5585.245991791117;5588.524975377078;5596.992541342557;5285.814996475124;5483.122700367922;5572.665640061609;5642.971785141089;5653.830385088454;5607.158926161088;5632.239647647577;5639.295088113986;5646.971765141168;5649.322081350223;5450.373207081197;5613.242212301348;5643.746031428575;6132.969335153296;6237.563370564062;5519.9448005520235;5546.112621980504;5555.444455554452;5559.610827242094;5569.275994120779;13998.160110393408;14098.224597647126;14391.992560520768;14401.495947641783;14413.639659008504;2274.55646149001;2357.0336162173426;2374.3589230907733;2496;2617.044778655796;9993;10087.747806304827;10111.241656875764;10618.309809862412;10716.624918127905;1867.3090956346239;1873.4847916822982;1885.4060970794155;1910.0489743346564;1926.0754837677853;107845;122774;124193;125370;127427.99999999907;9818.656347027963;11663.825042624367;11913.70215744596;11913.821292680617;12099.939500302442;15625.218739063;15710.057396556014;15716.68566628684;15736.60658483547;15746.976446530938;8797.340199485065;9180.8622870657;9260;9267;9515.333926625208;9425.62297508092;9442.622295108256;9450.480223587769;9450.810983780286;9508.952455237817;4900.191468407673;4938.2839488274;4939.506049395103;4942.505749425029;4983.476734942851;1930.8221984589388;1975.4172519106899;2012.0945574491245;2086.2072412483462;2091.665333546656;863.7781076584375;950.5199874063553;958.3195930889008;968.2254196642658;1000.979980400388;20367.898160509103;20747.792522074586;20767.169313227303;20983.84588847628;20988.47528811792;1041.193075366597;1043.7234132954773;1050.0916707048348;1054.7943151085617;1055.488088277185;9916.4545949972;11113.444327783578;11141.554337826396;11166.994970452699;11253.493592788343;554658.2267088719;634972;636228.8188559028;650457;656608;72525.63737181386;73495;102010.48994754978;123987;125852.74147258593;975.9219262458986;986.2405947420447;1003.3478239144614;1005.9144972677404;1034.6533911139852;18255.726164107815;18637.347692831227;18800.435986920413;18943;18982.240710371432;45249;53300;53630.195547067604;54379.64050898759;54520.90958180893;71539;76391.61804190943;81036.18963810286;81107;81875.59062204651;8205.548694821842;8453.816465694685;8545.700900468702;8710.520921349387;8818.955905220433;12911.354432278536;13113.475460981454;13225.669358265735;13376.398062087424;13490.32548372597;10614.923527270481;10731.624393146203;11190;11202.551897924317;11276.605318813803;10821.350718956888;11233.49449274801;11312.377819219693;11646.592369267035;11898.286102833858;11393.035817503991;11563.479643415898;11711.590094346997;11790.410479476164;12029.75940481203;8421.452605580862;8536.44513106646;8536.44513106671;8561.61472733716;8669.783255418664;8515.531645759294;11257.605983790529;11426.02878755282;11546.249493782878;11669.824952625548 14:28:50 INFO - PROCESS | 1667 | |3;mootools.html;1387.285547942809;1552.4333618229346;1573.6065983504125;1809.4209852847086;1815.2013114229737;6878.690458929348;8848;8971.685990990316;9000.954995225014;9011.14394132558;8858.95570522148;9095.272378209744;9107.998120206772;9120.680776172836;9127.497987610679;2552.1833013435707;2571.4985577812336;2574.6009368547907;2576.510463012022;2580.8322459040196;2498.4503409249937;2567.7047139579;2567.845929244242;2571.832830865997;2579.548578998668;2531.1141100614823;2563.1541591274836;2573.8327008744373;2575.6909170899517;2576.8711564421797;2535.4802265535614;2556.4759224358963;2564.6922369315707;2579.045753071357;2580.9612855807177;2121.5756848630335;2515.9245222643167;2567.0245306783304;2567.242663414297;2571.2029270926073;8899.866502002475;9119.49842758648;9199.218066464358;9244;9252.537373131383;5303.939212157584;5729.28383952006;5836.416358364172;5946.167536544887;6020;3645;3716.739828212026;3765.35988881888;3775.6035616260447;3806.6764325032404;1027.922905782062;1056.033729137838;1056.598492572825;1061.930974486656;1062.6811956413123;12573.685657858536;12577.371131443391;12606.81089783654;12636.49454021838;12685.746285074247;4839.104765618372;4849.7011996944375;4936.432310284364;4940.110780059552;4964.304997300381;9793.363431376938;9810.754731131636;9817.754556136153;9836.262280329003;9838;5677.205191273225;5683.090705487102;5683.5737319700365;5686.14707793826;5695.117256825199;4675.95324046762;4784.378030856036;5112.412072611697;5223.399309079428;5295.073362161606;4005.559388467266;4019.5578486366476;4077.796110194538;4127;4133.318002529609;1075.1452595186845;1094.5129417409335;1282.9166104203198;1285.6528737240892;1302.7134030513273;904.4482865452069;921.8018126102786;934.5047125023748;950.2635457520477;982.3369225772575;6008.699565021731;6023.367546407651;6077.908831367533;6148.754049838046;6206.348333424925;479.5635971266131;483.5672073494203;486.8782804298925;487.8780304923769;495.10880415252404;3545.6986156177013;3957;4039;4130.132672138824;4139.3583994480905;10439.060484556427;10849.728756781144;10877;10908.400037997828;10985.285956412808;10626.149908007495;10697.62558310471;10698.14414846826;10701.09040731531;10886.67339979802;8570.78573035679;8757.168069033432;8805.251553617885;8809.11908809114;8840.33697472705;5656.123300888369;5886.764529418775;5951.7024148791525;5962.07587823888;6122.846928826637;9706.5146742664;9883.406995580288;10034.949825250827;10053.69838904834;10061.849072263776;9800.31397802147;9913.405195688281;9921.603135874484;10135.341202821794;10199.796004079728;7050.894236586353;7253.202147763636;7546.358559522502;7760.650770715219;7898.763037108896;8499.022612399653;8521.403501754818;8568.957155214184;8572.05707372176;8578.742637720878;7527.1720110788865;7595.696172153052;7655.0813902332075;7725.575093369694;7764.961175194087;7351.742689005859;7370.96314518424;7393.630318483947;7416.555006699399;7576.772696819105;7156.642167891689;7271.963640181977;7297.16082650502;7300.890486642811;7312.451566132455;4221.430106935524;5019.648624596243;5036.093503169464;5109.540141387293;5130.820421285237;5048.924266135938;5094.1849304111165;5145.305383773143;5167.483251674803;5386.218998245155 14:28:50 INFO - PROCESS | 1667 | |4;prototype.html;333.4964204051882;338.2010830254334;344.43168771526985;350.66161154485917;352.0529774905506;5122.61580381472;6863.622500762463;6883.414909732673;6891.552049116816;6901.275366086564;5240.895182096356;6628.370304821046;6691.732330706766;6716.227633822112;6952.791416257521;5173.30160428343;5183.989122121188;5186.766595503193;5196.662216955905;5217.321748172732;5135.050015747099;5196.090684130281;5201.739913004353;5211.609129315298;5213.452587478317;4871.050145221666;4944.752762361867;5057.190849464087;5118.411382691001;5130.71781052042;5043.9747801260755;5054.469280725544;5058.544730974193;5062.164742817431;5081.6696914700615;4342.131573685244;4349.760763158025;4358.4987726411555;4359.193549193409;4359.825606975717;6532.967335163341;6574.868502629968;6601.801945941629;6605.537612367136;6614.470842332602;5905.940940590582;5912.881742365172;5914.2311499504785;5914.4381283777975;5925.259342582177;5815.534757219412;7045.964770176116;7308.817279568;7329.780106596757;7340.522866013745;4849.418069831643;4872.4640289568115;4878.24387219978;4894.730789806559;4899.093667671492;7674.155842857282;7685.154632990367;7710.344620707247;7727.768166955;7735.265149810759;4955.72743499111;4955.776990035457;4968.701877887338;4980.77586508608;4981.302617633534;5039.118154323052;5048.798048078036;5053.823116190915;5065.138926382524;5069.997351046316;5684.744186511617;5950.8809823803285;5975.462208401264;5979.1629171915965;6005.429484198994;5978.85052873673;7355.7057717690695;7397.37122344596;7397.593132377771;7410.518316309531;1676.5389517882436;1707.3512065415064;1707.9316827327016;1708.2739835569832;1711.5549957011017;990.2276224544867;1020.9693709188737;1061.1510791366875;1081.118888106191;1086.918481113904;6280.9685951569945;6464.38588334117;6961;7009.12385951756;7039.190493093258;6138.570300079041;7654.655540500691;7682.962800021925;7693.1922148173635;7693.807654808563;5851.356350801409;6797.796066118024;6986.196587392414;6995.4053905417595;7012.333828286304;3964.0684439156776;4019.437278780973;4044.8179831907637;4079;4124.91750164995;6414.679266036679;6513.283538810727;8131.674733010614;8135.715249966341;8145.389095817837;7979.640916158787;7981.281684648409;7983.401244906655;7989.320907722792;7990.240927111915;8101.513909165469;8107.1082180958865;8108;8108.472949258279;8116.837663246702;7397.593132377771;7673.808154796175;7697;7720.922790772021;7777.805554860947;7524.914784938149;7563;7588.089429268523;7594;7594.620268986418;8054.959725201336;8082;8089.3528517719615;8094.10964793884;8097.676092956216;4808.110499557593;4864.635152363516;4879.097366987119;4884.169691152583;4898.706077635354;7414.962925185339;7667.233276672511;7690.615469226628;7709.498882572615;7711.460197786326;7374.1151061872915;7422.406207503494;7439.851202976019;7446.25537446251;7453.813654658677;7437.739679111205;7437.925620743723;7438.814029649302;7439.2188820173105;7439.51643143194;6946.756863509753;7264.963675181591;7270.272972702899;7278.017467641801;7278.745243916437;7146.321099495747;7408.925910740823;7429.665665044978;7436.144843342869;7470.589117598584;7214.422846172399;7218.675159617725;7225.132984041738;7232.602206878672;7238.746643867439 14:28:50 INFO - PROCESS | 1667 | |5;yui.html;704.7674267491728;717.3436305780211;728.7886512911256;774.907011158661;819.0908092017859;15671.981321214127;15909.44316948907;15956.920215398906;15982.360705571778;15988.76016859748;14570.927145364285;14644.707105857902;14658.26708664568;14674.339654715537;14709;956.4213650741306;993.7714325705092;997.8503224516344;999.8700168978023;1003.3528374198637;976.0824824664793;992.4095163377779;993.6075250276136;993.6075250276173;996.1333639733442;1057.3391630231106;1060.708305216064;1061.5382308695703;1062.9946850265737;1066.109798318401;1046.4767616191905;1050.758325585116;1051.9421431821247;1053.389034360077;1057.978840423195;782.6243403166512;783.1737516919648;784.9293563579305;785.5679376343046;786.9016372953381;15718.685626287524;15759.606009849731;15873.285702143432;15960.201989900575;15969.600759980976;12111;12173.634790956285;12176.147669663127;12520.311382873939;12662.936685316607;9496.907855596557;10262.486875656188;10494;10525.31585446951;10559.947200263949;3246.155999440139;3564.821758912044;3579.8210089495683;3596.766210196355;3799.9620003799882;70036.29963700348;71077.64461177713;78903.6054819728;79579.60210198912;83234;8046.275835174863;9601.039896010483;9644.373115747454;9889.159421449114;9909.108180263811;21639.56720865574;21643.242486512896;21733.34799956004;21755.564888702138;21849.67225491619;7731.845363092819;7823.178566250575;7905.802354941173;7911.683532658744;7914.0503139623615;4256.9574304257185;4322.481302243751;4344.543822898613;4373.103513779667;4377.343398490252;3750.6811920986474;3821.6751576115785;3822;3823.2926908522013;3824.598417166213;571.2773341722724;656.1076935367896;673.9292374300726;676.5061505101304;685.5817951049855;554.9916751248735;608.537511491261;617.4319625944142;620.432304441431;623.4575918950542;8299.419040667095;8375.246227839401;8441.704540341181;8500.234978851933;8522.147785221552;576.5906206593282;582.5223316880117;598.2671227746064;607.7417097733446;650.5576208178484;3847.076701591654;3872.43849641806;4031.7177797554477;4066.79666016698;4151.6886233532605;85231.72152417719;85264.14735852687;87611.12388876158;88377;89429;64478;72539.27460725325;72771.63614181895;74471;74854.87717684239;64367;67059.66470167619;67377;67695;69009;8562.74311770648;8602;8713.041565427671;8839.867401988846;8872.645094196418;42235.94410139771;43115.13769724651;43620.90947726205;43855;44265.89335266644;63006.73986520336;63233.735325294154;63906;64221.67889160525;64578.67710661417;11033.724156896142;11213;11295.71760705956;11412.372319522507;11832.935035846815;11843.881561184278;12077.57728479499;12081.577144800242;12295.508179672714;12795.232286062866;11621.24461909973;11695;11790.587329443772;11840.644780656594;12265.877341226473;10099.94950025245;11466.94266528662;11679.883201168219;11823.881761182278;12124.515019399125;11471.942640286745;11624.767504650028;11642.76714465689;11732.237404568676;11776.293422394683;8188.713395031384;10082.747931301776;10090.243231757795;10434.269601128151;10451.477426128815;9987.450690211817;10020.94989525077;10024.498775061364;10026.197904167504;10052.497375131361 14:28:50 INFO - PROCESS | 1667 | __end_tp_report 14:28:50 INFO - PROCESS | 1667 | __start_cc_report 14:28:50 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,963 14:28:50 INFO - PROCESS | 1667 | __end_cc_report 14:28:50 INFO - PROCESS | 1667 | __startTimestamp1468877330628__endTimestamp 14:28:50 INFO - PROCESS | 1667 | 14:28:50 INFO - PROCESS | 1667 | ------- Summary: start ------- 14:28:50 INFO - PROCESS | 1667 | Number of tests: 6 14:28:50 INFO - PROCESS | 1667 | 14:28:50 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5891.76 Median:6183.01 stddev:632.21 (10.2%) stddev-sans-first:605.29 14:28:50 INFO - PROCESS | 1667 | Values: 3485.0 3582.2 3582.9 3590.2 3678.3 5859.4 5882.5 5927.5 5984.4 5988.9 5913.4 5935.7 5937.1 5954.2 5966.9 5270.4 5286.2 5384.3 5387.5 5428.9 4524.4 5399.6 5428.0 5463.7 5477.0 5333.7 5378.2 5382.0 5388.4 5463.9 5423.7 5455.7 5462.8 5464.2 5501.4 4912.7 5259.8 5344.8 5359.8 5365.4 5758.5 5767.3 5803.5 5829.8 5839.5 5770.5 6111.4 6233.3 6260.4 6270.3 6193.5 6225.5 6266.1 6302.7 6304.8 6037.9 6042.5 6063.6 6071.9 6074.3 6380.0 6387.2 6393.6 6404.2 6405.3 6206.1 6210.2 6298.3 6311.9 6314.2 6250.7 6304.0 6314.7 6319.1 6333.3 6172.6 6249.5 6269.4 6271.8 6276.3 6186.2 6199.0 6257.4 6269.9 6315.1 4327.8 5022.5 5069.9 5072.6 5076.6 4513.8 4583.8 4600.4 4602.1 4615.4 6009.7 6059.4 6079.5 6087.6 6115.3 6289.5 6339.3 6351.1 6359.0 6366.5 5975.6 6025.5 6033.9 6048.7 6057.1 5555.7 5560.4 5562.1 5572.9 5628.2 6490.4 6508.5 6514.2 6527.7 6544.6 6212.3 6270.2 6289.2 6290.2 6341.8 6485.5 6499.8 6552.2 6558.0 6566.7 6290.7 6294.9 6298.4 6310.7 6319.4 6193.8 6249.5 6254.2 6305.7 6315.8 6094.3 6228.2 6237.8 6243.3 6253.7 6183.0 6256.5 6276.1 6279.8 6286.6 6081.4 6130.4 6145.0 6210.4 6267.7 6201.5 6231.1 6249.5 6265.2 6267.2 6226.0 6258.2 6282.5 6291.5 6304.8 14:28:50 INFO - PROCESS | 1667 | 14:28:50 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:64362.05 Median:180951.52 stddev:141889.49 (78.4%) stddev-sans-first:142206.60 14:28:50 INFO - PROCESS | 1667 | Values: 535.6 536.1 541.6 551.1 587.5 29578.7 33163.5 40314.6 40666.6 40809.4 43839.8 44231.3 44330.8 44344.9 44382.6 8975.5 9513.4 9744.2 9765.1 9790.0 9061.5 9181.9 9192.9 10236.9 12244.9 11761.2 11806.8 11816.6 11817.6 11859.9 11739.4 11840.4 11848.4 11858.2 11859.5 11611.8 11755.9 11762.7 11773.9 11779.8 39680.8 40316.8 42106.6 42143.6 42327.0 3393.3 3425.3 3513.4 3622.5 3988.7 28408.7 29478.6 29702.4 29916.6 30347.7 2757.7 2792.7 2819.8 2896.2 2896.4 358345.2 359196.0 360677.2 361587.0 362332.0 38122.0 38759.0 38785.2 38861.8 62034.0 30495.7 37218.0 37285.9 37306.6 37332.1 15825.4 16010.8 16011.4 16022.4 16163.5 12716.9 13407.5 13526.5 13535.6 13552.3 8101.6 8179.0 8181.0 8482.0 8690.3 3488.8 3549.7 3554.8 3557.8 3584.2 945.5 1000.3 1017.2 1036.2 1241.8 30232.2 30531.7 30597.2 30835.7 31008.7 1066.9 1107.4 1217.7 1218.6 1329.3 13081.8 14662.5 14762.8 14887.3 14932.4 653941.0 659559.0 667698.0 668002.0 668903.0 63239.7 63910.4 63948.7 63977.7 64001.4 1548.9 1551.1 1555.8 1563.9 1566.8 23849.9 28935.9 29477.0 29836.1 30178.8 53978.0 54619.2 54621.0 54767.5 54799.6 518792.0 519920.0 521641.0 521897.0 523154.0 25970.4 25971.7 28009.4 28449.6 28510.0 37574.9 39368.2 45680.5 48599.5 49510.5 36488.3 37489.8 37783.1 37907.2 38730.6 37035.4 37230.4 37660.4 37811.8 38016.6 36930.3 37605.7 37657.2 38778.4 38817.8 32041.5 32814.0 32957.7 33026.7 33040.0 22193.8 23355.3 24772.9 25566.4 25639.7 14:28:50 INFO - PROCESS | 1667 | 14:28:50 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:35030.54 Median:22701.27 stddev:104068.75 (458.4%) stddev-sans-first:104328.22 14:28:50 INFO - PROCESS | 1667 | Values: 408.5 409.1 414.5 416.8 423.9 20513.2 21161.0 21283.8 21319.9 22327.9 22530.4 22597.7 22692.0 22710.5 22722.9 5210.9 5583.7 5585.2 5588.5 5597.0 5285.8 5483.1 5572.7 5643.0 5653.8 5607.2 5632.2 5639.3 5647.0 5649.3 5450.4 5613.2 5643.7 6133.0 6237.6 5519.9 5546.1 5555.4 5559.6 5569.3 13998.2 14098.2 14392.0 14401.5 14413.6 2274.6 2357.0 2374.4 2496.0 2617.0 9993.0 10087.7 10111.2 10618.3 10716.6 1867.3 1873.5 1885.4 1910.0 1926.1 107845.0 122774.0 124193.0 125370.0 127428.0 9818.7 11663.8 11913.7 11913.8 12099.9 15625.2 15710.1 15716.7 15736.6 15747.0 8797.3 9180.9 9260.0 9267.0 9515.3 9425.6 9442.6 9450.5 9450.8 9509.0 4900.2 4938.3 4939.5 4942.5 4983.5 1930.8 1975.4 2012.1 2086.2 2091.7 863.8 950.5 958.3 968.2 1001.0 20367.9 20747.8 20767.2 20983.8 20988.5 1041.2 1043.7 1050.1 1054.8 1055.5 9916.5 11113.4 11141.6 11167.0 11253.5 554658.2 634972.0 636228.8 650457.0 656608.0 72525.6 73495.0 102010.5 123987.0 125852.7 975.9 986.2 1003.3 1005.9 1034.7 18255.7 18637.3 18800.4 18943.0 18982.2 45249.0 53300.0 53630.2 54379.6 54520.9 71539.0 76391.6 81036.2 81107.0 81875.6 8205.5 8453.8 8545.7 8710.5 8819.0 12911.4 13113.5 13225.7 13376.4 13490.3 10614.9 10731.6 11190.0 11202.6 11276.6 10821.4 11233.5 11312.4 11646.6 11898.3 11393.0 11563.5 11711.6 11790.4 12029.8 8421.5 8536.4 8536.4 8561.6 8669.8 8515.5 11257.6 11426.0 11546.2 11669.8 14:28:50 INFO - PROCESS | 1667 | 14:28:50 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:5863.35 Median:5071.55 stddev:3274.69 (64.6%) stddev-sans-first:3266.60 14:28:50 INFO - PROCESS | 1667 | Values: 1387.3 1552.4 1573.6 1809.4 1815.2 6878.7 8848.0 8971.7 9001.0 9011.1 8859.0 9095.3 9108.0 9120.7 9127.5 2552.2 2571.5 2574.6 2576.5 2580.8 2498.5 2567.7 2567.8 2571.8 2579.5 2531.1 2563.2 2573.8 2575.7 2576.9 2535.5 2556.5 2564.7 2579.0 2581.0 2121.6 2515.9 2567.0 2567.2 2571.2 8899.9 9119.5 9199.2 9244.0 9252.5 5303.9 5729.3 5836.4 5946.2 6020.0 3645.0 3716.7 3765.4 3775.6 3806.7 1027.9 1056.0 1056.6 1061.9 1062.7 12573.7 12577.4 12606.8 12636.5 12685.7 4839.1 4849.7 4936.4 4940.1 4964.3 9793.4 9810.8 9817.8 9836.3 9838.0 5677.2 5683.1 5683.6 5686.1 5695.1 4676.0 4784.4 5112.4 5223.4 5295.1 4005.6 4019.6 4077.8 4127.0 4133.3 1075.1 1094.5 1282.9 1285.7 1302.7 904.4 921.8 934.5 950.3 982.3 6008.7 6023.4 6077.9 6148.8 6206.3 479.6 483.6 486.9 487.9 495.1 3545.7 3957.0 4039.0 4130.1 4139.4 10439.1 10849.7 10877.0 10908.4 10985.3 10626.1 10697.6 10698.1 10701.1 10886.7 8570.8 8757.2 8805.3 8809.1 8840.3 5656.1 5886.8 5951.7 5962.1 6122.8 9706.5 9883.4 10034.9 10053.7 10061.8 9800.3 9913.4 9921.6 10135.3 10199.8 7050.9 7253.2 7546.4 7760.7 7898.8 8499.0 8521.4 8569.0 8572.1 8578.7 7527.2 7595.7 7655.1 7725.6 7765.0 7351.7 7371.0 7393.6 7416.6 7576.8 7156.6 7272.0 7297.2 7300.9 7312.5 4221.4 5019.6 5036.1 5109.5 5130.8 5048.9 5094.2 5145.3 5167.5 5386.2 14:28:50 INFO - PROCESS | 1667 | 14:28:50 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:6026.47 Median:6703.98 stddev:1925.62 (28.7%) stddev-sans-first:1883.02 14:28:50 INFO - PROCESS | 1667 | Values: 333.5 338.2 344.4 350.7 352.1 5122.6 6863.6 6883.4 6891.6 6901.3 5240.9 6628.4 6691.7 6716.2 6952.8 5173.3 5184.0 5186.8 5196.7 5217.3 5135.1 5196.1 5201.7 5211.6 5213.5 4871.1 4944.8 5057.2 5118.4 5130.7 5044.0 5054.5 5058.5 5062.2 5081.7 4342.1 4349.8 4358.5 4359.2 4359.8 6533.0 6574.9 6601.8 6605.5 6614.5 5905.9 5912.9 5914.2 5914.4 5925.3 5815.5 7046.0 7308.8 7329.8 7340.5 4849.4 4872.5 4878.2 4894.7 4899.1 7674.2 7685.2 7710.3 7727.8 7735.3 4955.7 4955.8 4968.7 4980.8 4981.3 5039.1 5048.8 5053.8 5065.1 5070.0 5684.7 5950.9 5975.5 5979.2 6005.4 5978.9 7355.7 7397.4 7397.6 7410.5 1676.5 1707.4 1707.9 1708.3 1711.6 990.2 1021.0 1061.2 1081.1 1086.9 6281.0 6464.4 6961.0 7009.1 7039.2 6138.6 7654.7 7683.0 7693.2 7693.8 5851.4 6797.8 6986.2 6995.4 7012.3 3964.1 4019.4 4044.8 4079.0 4124.9 6414.7 6513.3 8131.7 8135.7 8145.4 7979.6 7981.3 7983.4 7989.3 7990.2 8101.5 8107.1 8108.0 8108.5 8116.8 7397.6 7673.8 7697.0 7720.9 7777.8 7524.9 7563.0 7588.1 7594.0 7594.6 8055.0 8082.0 8089.4 8094.1 8097.7 4808.1 4864.6 4879.1 4884.2 4898.7 7415.0 7667.2 7690.6 7709.5 7711.5 7374.1 7422.4 7439.9 7446.3 7453.8 7437.7 7437.9 7438.8 7439.2 7439.5 6946.8 7265.0 7270.3 7278.0 7278.7 7146.3 7408.9 7429.7 7436.1 7470.6 7214.4 7218.7 7225.1 7232.6 7238.7 14:28:50 INFO - PROCESS | 1667 | 14:28:50 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:17683.22 Median:23718.81 stddev:23968.80 (101.1%) stddev-sans-first:24002.13 14:28:50 INFO - PROCESS | 1667 | Values: 704.8 717.3 728.8 774.9 819.1 15672.0 15909.4 15956.9 15982.4 15988.8 14570.9 14644.7 14658.3 14674.3 14709.0 956.4 993.8 997.9 999.9 1003.4 976.1 992.4 993.6 993.6 996.1 1057.3 1060.7 1061.5 1063.0 1066.1 1046.5 1050.8 1051.9 1053.4 1058.0 782.6 783.2 784.9 785.6 786.9 15718.7 15759.6 15873.3 15960.2 15969.6 12111.0 12173.6 12176.1 12520.3 12662.9 9496.9 10262.5 10494.0 10525.3 10559.9 3246.2 3564.8 3579.8 3596.8 3800.0 70036.3 71077.6 78903.6 79579.6 83234.0 8046.3 9601.0 9644.4 9889.2 9909.1 21639.6 21643.2 21733.3 21755.6 21849.7 7731.8 7823.2 7905.8 7911.7 7914.1 4257.0 4322.5 4344.5 4373.1 4377.3 3750.7 3821.7 3822.0 3823.3 3824.6 571.3 656.1 673.9 676.5 685.6 555.0 608.5 617.4 620.4 623.5 8299.4 8375.2 8441.7 8500.2 8522.1 576.6 582.5 598.3 607.7 650.6 3847.1 3872.4 4031.7 4066.8 4151.7 85231.7 85264.1 87611.1 88377.0 89429.0 64478.0 72539.3 72771.6 74471.0 74854.9 64367.0 67059.7 67377.0 67695.0 69009.0 8562.7 8602.0 8713.0 8839.9 8872.6 42235.9 43115.1 43620.9 43855.0 44265.9 63006.7 63233.7 63906.0 64221.7 64578.7 11033.7 11213.0 11295.7 11412.4 11832.9 11843.9 12077.6 12081.6 12295.5 12795.2 11621.2 11695.0 11790.6 11840.6 12265.9 10099.9 11466.9 11679.9 11823.9 12124.5 11471.9 11624.8 11642.8 11732.2 11776.3 8188.7 10082.7 10090.2 10434.3 10451.5 9987.5 10020.9 10024.5 10026.2 10052.5 14:28:50 INFO - PROCESS | 1667 | -------- Summary: end -------- 14:28:50 INFO - PROCESS | 1667 | 14:28:51 INFO - TEST-INFO | 1667: exit 0 14:28:51 INFO - TEST-OK | dromaeo_css | took 1112865ms 14:28:51 INFO - TEST-START | kraken 14:28:51 INFO - operating with platform_type : mac_ 14:28:51 INFO - Initialising browser for kraken test... 14:28:51 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/tmpQx63hu/profile http://localhost:49269/getInfo.html) 14:28:53 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 14:28:53 INFO - PROCESS | 1675 | colorDepth:24 14:28:53 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 14:28:53 INFO - PROCESS | 1675 | __metrics 14:28:53 INFO - PROCESS | 1675 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:28:53 ERROR - PROCESS | 1675 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:28:54 INFO - TEST-INFO | 1675: exit 0 14:28:54 INFO - Browser initialized. 14:28:54 INFO - Running cycle 1/1 for kraken test... 14:28:54 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/tmpQx63hu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:29:05 INFO - PROCESS | 1678 | RSS: Main: 160751616 14:29:05 INFO - PROCESS | 1678 | 14:29:08 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 14:29:09 INFO - PROCESS | 1678 | RSS: Main: 224641024 14:29:09 INFO - PROCESS | 1678 | 14:29:12 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 14:29:12 INFO - PROCESS | 1678 | RSS: Main: 241569792 14:29:12 INFO - PROCESS | 1678 | 14:29:16 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 14:29:16 INFO - PROCESS | 1678 | RSS: Main: 325541888 14:29:16 INFO - PROCESS | 1678 | 14:29:18 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 14:29:19 INFO - PROCESS | 1678 | RSS: Main: 231612416 14:29:19 INFO - PROCESS | 1678 | 14:29:21 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:29:22 INFO - PROCESS | 1678 | RSS: Main: 232640512 14:29:22 INFO - PROCESS | 1678 | 14:29:24 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 14:29:25 INFO - PROCESS | 1678 | RSS: Main: 270241792 14:29:25 INFO - PROCESS | 1678 | 14:29:28 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 14:29:28 INFO - PROCESS | 1678 | RSS: Main: 270176256 14:29:28 INFO - PROCESS | 1678 | 14:29:31 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 14:29:32 INFO - PROCESS | 1678 | RSS: Main: 269647872 14:29:32 INFO - PROCESS | 1678 | 14:29:33 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:29:34 INFO - PROCESS | 1678 | RSS: Main: 259428352 14:29:34 INFO - PROCESS | 1678 | 14:29:36 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:29:36 INFO - PROCESS | 1678 | RSS: Main: 266203136 14:29:36 INFO - PROCESS | 1678 | 14:29:38 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:29:39 INFO - PROCESS | 1678 | RSS: Main: 271011840 14:29:39 INFO - PROCESS | 1678 | 14:29:42 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:29:43 INFO - PROCESS | 1678 | RSS: Main: 278069248 14:29:43 INFO - PROCESS | 1678 | 14:29:45 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:29:46 INFO - PROCESS | 1678 | RSS: Main: 275234816 14:29:46 INFO - PROCESS | 1678 | 14:29:48 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 14:29:48 INFO - PROCESS | 1678 | RSS: Main: 336363520 14:29:48 INFO - PROCESS | 1678 | 14:29:48 INFO - PROCESS | 1678 | __start_tp_report 14:29:48 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 14:29:48 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 14:29:48 INFO - PROCESS | 1678 | |i|pagename|runs| 14:29:48 INFO - PROCESS | 1678 | |0;ai-astar;113;113;117;112;111;112;112;110;116;191 14:29:48 INFO - PROCESS | 1678 | |1;audio-beat-detection;162;151;130;192;154;175;120;167;188;113 14:29:48 INFO - PROCESS | 1678 | |2;audio-dft;184;187;184;182;181;182;184;184;182;185 14:29:48 INFO - PROCESS | 1678 | |3;audio-fft;70;78;72;152;56;74;85;53;122;74 14:29:48 INFO - PROCESS | 1678 | |4;audio-oscillator;92;91;141;80;78;80;124;79;79;127 14:29:48 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;87;85;87;85;88;85;88;86;88;84 14:29:48 INFO - PROCESS | 1678 | |6;imaging-darkroom;93;92;92;92;92;104;149;93;91;95 14:29:48 INFO - PROCESS | 1678 | |7;imaging-desaturate;125;136;86;83;85;82;81;83;84;84 14:29:48 INFO - PROCESS | 1678 | |8;json-parse-financial;57;62;62;62;62;64;65;79;60;57 14:29:48 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;61;64;71;73;70;68;67;65;66;66 14:29:48 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;80;79;78;79;79;80;79;78;82;83 14:29:48 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;126;126;125;137;132;136;122;126;153;165 14:29:48 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;162;161;163;162;163;163;163;162;160;160 14:29:48 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;65;66;68;67;67;65;66;68;66;66 14:29:48 INFO - PROCESS | 1678 | __end_tp_report 14:29:48 INFO - PROCESS | 1678 | __start_cc_report 14:29:48 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1923 14:29:48 INFO - PROCESS | 1678 | __end_cc_report 14:29:48 INFO - PROCESS | 1678 | __startTimestamp1468877388329__endTimestamp 14:29:48 INFO - PROCESS | 1678 | 14:29:48 INFO - PROCESS | 1678 | ------- Summary: start ------- 14:29:48 INFO - PROCESS | 1678 | Number of tests: 14 14:29:48 INFO - PROCESS | 1678 | 14:29:48 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:120.70 Median:113.00 stddev:24.79 (21.9%) stddev-sans-first:26.14 14:29:48 INFO - PROCESS | 1678 | Values: 113.0 113.0 117.0 112.0 111.0 112.0 112.0 110.0 116.0 191.0 14:29:48 INFO - PROCESS | 1678 | 14:29:48 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:155.20 Median:164.50 stddev:27.25 (16.6%) stddev-sans-first:28.79 14:29:48 INFO - PROCESS | 1678 | Values: 162.0 151.0 130.0 192.0 154.0 175.0 120.0 167.0 188.0 113.0 14:29:48 INFO - PROCESS | 1678 | 14:29:48 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:183.50 Median:184.00 stddev:1.78 (1.0%) stddev-sans-first:1.88 14:29:48 INFO - PROCESS | 1678 | Values: 184.0 187.0 184.0 182.0 181.0 182.0 184.0 184.0 182.0 185.0 14:29:48 INFO - PROCESS | 1678 | 14:29:48 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:83.60 Median:73.00 stddev:30.53 (41.8%) stddev-sans-first:31.98 14:29:48 INFO - PROCESS | 1678 | Values: 70.0 78.0 72.0 152.0 56.0 74.0 85.0 53.0 122.0 74.0 14:29:48 INFO - PROCESS | 1678 | 14:29:48 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:97.10 Median:79.50 stddev:24.07 (30.3%) stddev-sans-first:25.46 14:29:48 INFO - PROCESS | 1678 | Values: 92.0 91.0 141.0 80.0 78.0 80.0 124.0 79.0 79.0 127.0 14:29:48 INFO - PROCESS | 1678 | 14:29:48 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:87.00 stddev:1.49 (1.7%) stddev-sans-first:1.56 14:29:48 INFO - PROCESS | 1678 | Values: 87.0 85.0 87.0 85.0 88.0 85.0 88.0 86.0 88.0 84.0 14:29:48 INFO - PROCESS | 1678 | 14:29:48 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:99.30 Median:92.00 stddev:17.86 (19.4%) stddev-sans-first:18.80 14:29:48 INFO - PROCESS | 1678 | Values: 93.0 92.0 92.0 92.0 92.0 104.0 149.0 93.0 91.0 95.0 14:29:48 INFO - PROCESS | 1678 | 14:29:48 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:92.90 Median:83.50 stddev:20.04 (24.0%) stddev-sans-first:17.56 14:29:48 INFO - PROCESS | 1678 | Values: 125.0 136.0 86.0 83.0 85.0 82.0 81.0 83.0 84.0 84.0 14:29:48 INFO - PROCESS | 1678 | 14:29:48 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:62.00 stddev:6.20 (10.0%) stddev-sans-first:6.18 14:29:48 INFO - PROCESS | 1678 | Values: 57.0 62.0 62.0 62.0 62.0 64.0 65.0 79.0 60.0 57.0 14:29:48 INFO - PROCESS | 1678 | 14:29:48 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.50 stddev:3.54 (5.2%) stddev-sans-first:2.99 14:29:48 INFO - PROCESS | 1678 | Values: 61.0 64.0 71.0 73.0 70.0 68.0 67.0 65.0 66.0 66.0 14:29:48 INFO - PROCESS | 1678 | 14:29:48 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:79.50 stddev:1.64 (2.1%) stddev-sans-first:1.73 14:29:48 INFO - PROCESS | 1678 | Values: 80.0 79.0 78.0 79.0 79.0 80.0 79.0 78.0 82.0 83.0 14:29:48 INFO - PROCESS | 1678 | 14:29:48 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:134.00 stddev:13.94 (10.4%) stddev-sans-first:14.42 14:29:48 INFO - PROCESS | 1678 | Values: 126.0 126.0 125.0 137.0 132.0 136.0 122.0 126.0 153.0 165.0 14:29:48 INFO - PROCESS | 1678 | 14:29:48 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:162.50 stddev:1.20 (0.7%) stddev-sans-first:1.27 14:29:48 INFO - PROCESS | 1678 | Values: 162.0 161.0 163.0 162.0 163.0 163.0 163.0 162.0 160.0 160.0 14:29:48 INFO - PROCESS | 1678 | 14:29:48 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:1.07 (1.6%) stddev-sans-first:1.01 14:29:48 INFO - PROCESS | 1678 | Values: 65.0 66.0 68.0 67.0 67.0 65.0 66.0 68.0 66.0 66.0 14:29:48 INFO - PROCESS | 1678 | -------- Summary: end -------- 14:29:48 INFO - PROCESS | 1678 | 14:29:49 INFO - TEST-INFO | 1678: exit 0 14:29:49 INFO - TEST-OK | kraken | took 58015ms 14:29:49 INFO - SUITE-END | took 1170s 14:29:49 INFO - Completed test suite (00:19:31) 14:29:49 INFO - javascript benchmark 14:29:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3484.982575087125, 3582.1760994971164, 3582.892513224604, 3590.1742599202166, 3678.2643471305746, 5859.414058594139, 5882.529397648189, 5927.525797936166, 5984.401559844014, 5988.880222395549, 5913.438223368784, 5935.673537955411, 5937.139114828358, 5954.225950626413, 5966.910496342547, 5270.367555893288, 5286.180642000496, 5384.273123128367, 5387.4612538746005, 5428.9185662215095, 4524.389207456984, 5399.595030372718, 5428.022955867942, 5463.726813659301, 5477.0415177344, 5333.653312534673, 5378.166384210434, 5382.0, 5388.43421440749, 5463.863403414906, 5423.701696406716, 5455.672659640434, 5462.8361149165585, 5464.23500709901, 5501.422350653163, 4912.70523768575, 5259.76331065103, 5344.759485823147, 5359.785608575652, 5365.382980957162, 5758.510526605243, 5767.279090113736, 5803.47768700819, 5829.795957141522, 5839.503642190419, 5770.480656740913, 6111.388861113853, 6233.345498722614, 6260.40526150015, 6270.31026587075, 6193.473554747852, 6225.5330850185965, 6266.091416744592, 6302.653354065525, 6304.779332723333, 6037.88221604499, 6042.516598672096, 6063.605865618721, 6071.908921366183, 6074.3259751981095, 6380.042993551005, 6387.233531976192, 6393.552451328455, 6404.1674582304, 6405.295417504164, 6206.131141640174, 6210.161628180228, 6298.275698294663, 6311.873762524724, 6314.242290925118, 6250.6874656267, 6304.0, 6314.747410103636, 6319.146915166394, 6333.334999825044, 6172.5679202456295, 6249.531285153541, 6269.435750782452, 6271.843203919847, 6276.309605943343, 6186.1648677428875, 6199.0, 6257.43683068526, 6269.874602508015, 6315.052742088632, 4327.831485498898, 5022.547970682583, 5069.873253168626, 5072.6195535335, 5076.568491678175, 4513.842015529441, 4583.793729282191, 4600.401947746772, 4602.148602508547, 4615.376924115201, 6009.669468179205, 6059.363766804422, 6079.483243924316, 6087.573869829158, 6115.296740874856, 6289.528285378615, 6339.2709838368255, 6351.110844481776, 6359.046143078575, 6366.490680745529, 5975.551833612496, 6025.548083893726, 6033.939660603425, 6048.727807248684, 6057.061155520813, 5555.722213889289, 5560.388357280696, 5562.082256427644, 5572.86067848307, 5628.240187574707, 6490.383413575702, 6508.479321654161, 6514.1531600891585, 6527.738890444424, 6544.607323560602, 6212.347703491068, 6270.2475702915945, 6289.150964619717, 6290.24517057956, 6341.8097457076365, 6485.54601177913, 6499.837504062436, 6552.24649165333, 6558.0, 6566.737330506726, 6290.748370065146, 6294.874102518015, 6298.433141017331, 6310.7475700971445, 6319.399657032574, 6193.783217587543, 6249.468795152463, 6254.186955695731, 6305.653189074645, 6315.810525684236, 6094.329623741473, 6228.22147231596, 6237.844053898689, 6243.250809902841, 6253.749850005949, 6183.0107182850525, 6256.530760192913, 6276.121343012073, 6279.780207692709, 6286.622802631857, 6081.39186081406, 6130.386961304012, 6145.016797312409, 6210.441060304594, 6267.655278959701, 6201.534884883562, 6231.127642130196, 6249.531285153723, 6265.154204182377, 6267.185265915402, 6225.968870155621, 6258.249010118815, 6282.528810339334, 6291.496680265659, 6304.842378940563], "value": 5852.914601423684, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.617033820818, 536.1154095742027, 541.5802752866529, 551.1347184919678, 587.538782056086, 29578.704212957862, 33163.50254746181, 40314.58898938534, 40666.59333406665, 40809.387859182134, 43839.78080109603, 44231.336529951994, 44330.77834610822, 44344.891377715576, 44382.55617443832, 8975.506347150904, 9513.38163019405, 9744.22046236303, 9765.12113909748, 9789.95105024474, 9061.50161741104, 9181.908180918206, 9192.862107068398, 10236.897631023707, 12244.938775306111, 11761.176717629769, 11806.7638647227, 11816.645500634952, 11817.586384476544, 11859.881401186007, 11739.413029348541, 11840.407979600985, 11848.407579620984, 11858.169928105037, 11859.52561897523, 11611.767764644745, 11755.94122029393, 11762.70593235176, 11773.882261177365, 11779.823302650468, 39680.801595992125, 40316.79841600773, 42106.57893421057, 42143.57856421427, 42327.0, 3393.3043726036103, 3425.2806910548816, 3513.350030244413, 3622.474741162543, 3988.6809055275507, 28408.715912840813, 29478.557821632694, 29702.405951880843, 29916.55125173124, 30347.696523034927, 2757.7242275772464, 2792.7486526212533, 2819.8167119137397, 2896.189067061226, 2896.4062367214883, 358345.20827395696, 359196.0, 360677.1966140179, 361587.0, 362332.0, 38122.0, 38759.0, 38785.2242955145, 38861.80569097136, 62034.0, 30495.69504304973, 37218.0, 37285.88142355734, 37306.626933730855, 37332.066698332215, 15825.366985320688, 16010.839891601168, 16011.439599613957, 16022.359105635876, 16163.515094547183, 12716.872831271754, 13407.463701452029, 13526.526571569948, 13535.59393218205, 13552.254625995665, 8101.635426405708, 8178.977627796526, 8181.018277806701, 8482.0, 8690.261327787082, 3488.8255587220538, 3549.6982756465472, 3554.7689400188906, 3557.8221088945447, 3584.175639602906, 945.4705364995486, 1000.2947921715173, 1017.1811691588194, 1036.233187441288, 1241.7951038078616, 30232.244193895327, 30531.69468305333, 30597.23506912345, 30835.69164308373, 31008.68991310058, 1066.933066933067, 1107.4462768615692, 1217.65601217657, 1218.634409677111, 1329.2622594459974, 13081.803772943413, 14662.486812961708, 14762.846736059604, 14887.255637218312, 14932.40270389194, 653941.0, 659559.0, 667698.0, 668002.0, 668903.0, 63239.6838015807, 63910.36089639137, 63948.68025659935, 63977.72044559083, 64001.39996500032, 1548.9302981365865, 1551.100361790159, 1555.8020324350414, 1563.8983466074897, 1566.772817941392, 23849.926753295797, 28935.85532072326, 29477.0, 29836.104916852528, 30178.849105754332, 53978.0, 54619.180712290145, 54621.0, 54767.45232547623, 54799.63000925009, 518792.0, 519920.0, 521641.0, 521897.0, 523154.0, 25970.35074123162, 25971.74028259769, 28009.43981120407, 28449.573256400756, 28510.0, 37574.87275381743, 39368.212635747695, 45680.543194568956, 48599.5140048595, 49510.50489495059, 36488.27023459569, 37489.81255093707, 37783.05542361353, 37907.241855163295, 38730.6126938727, 37035.444468332455, 37230.44154337633, 37660.43509347307, 37811.81094094512, 38016.619833801306, 36930.26139477142, 37605.68380106793, 37657.2468550622, 38778.4183237246, 38817.805910970266, 32041.51937720983, 32814.0, 32957.67042329642, 33026.66973330236, 33040.0, 22193.77806221982, 23355.29418773797, 24772.876135619208, 25566.360840979123, 25639.743602563736], "value": 18927.779054800434, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.4955080475612, 409.1040621039923, 414.49017708218906, 416.75619762438953, 423.8813132322949, 20513.179472821088, 21161.047752851122, 21283.787162128374, 21319.893400532994, 22327.888360558216, 22530.43673908149, 22597.661035084486, 22692.0, 22710.545789084208, 22722.88638556809, 5210.9478905210935, 5583.6928968906695, 5585.245991791117, 5588.524975377078, 5596.992541342557, 5285.814996475124, 5483.122700367922, 5572.665640061609, 5642.971785141089, 5653.830385088454, 5607.158926161088, 5632.239647647577, 5639.295088113986, 5646.971765141168, 5649.322081350223, 5450.373207081197, 5613.242212301348, 5643.746031428575, 6132.969335153296, 6237.563370564062, 5519.9448005520235, 5546.112621980504, 5555.444455554452, 5559.610827242094, 5569.275994120779, 13998.160110393408, 14098.224597647126, 14391.992560520768, 14401.495947641783, 14413.639659008504, 2274.55646149001, 2357.0336162173426, 2374.3589230907733, 2496.0, 2617.044778655796, 9993.0, 10087.747806304827, 10111.241656875764, 10618.309809862412, 10716.624918127905, 1867.3090956346239, 1873.4847916822982, 1885.4060970794155, 1910.0489743346564, 1926.0754837677853, 107845.0, 122774.0, 124193.0, 125370.0, 127427.99999999907, 9818.656347027963, 11663.825042624367, 11913.70215744596, 11913.821292680617, 12099.939500302442, 15625.218739063, 15710.057396556014, 15716.68566628684, 15736.60658483547, 15746.976446530938, 8797.340199485065, 9180.8622870657, 9260.0, 9267.0, 9515.333926625208, 9425.62297508092, 9442.622295108256, 9450.480223587769, 9450.810983780286, 9508.952455237817, 4900.191468407673, 4938.2839488274, 4939.506049395103, 4942.505749425029, 4983.476734942851, 1930.8221984589388, 1975.4172519106899, 2012.0945574491245, 2086.2072412483462, 2091.665333546656, 863.7781076584375, 950.5199874063553, 958.3195930889008, 968.2254196642658, 1000.979980400388, 20367.898160509103, 20747.792522074586, 20767.169313227303, 20983.84588847628, 20988.47528811792, 1041.193075366597, 1043.7234132954773, 1050.0916707048348, 1054.7943151085617, 1055.488088277185, 9916.4545949972, 11113.444327783578, 11141.554337826396, 11166.994970452699, 11253.493592788343, 554658.2267088719, 634972.0, 636228.8188559028, 650457.0, 656608.0, 72525.63737181386, 73495.0, 102010.48994754978, 123987.0, 125852.74147258593, 975.9219262458986, 986.2405947420447, 1003.3478239144614, 1005.9144972677404, 1034.6533911139852, 18255.726164107815, 18637.347692831227, 18800.435986920413, 18943.0, 18982.240710371432, 45249.0, 53300.0, 53630.195547067604, 54379.64050898759, 54520.90958180893, 71539.0, 76391.61804190943, 81036.18963810286, 81107.0, 81875.59062204651, 8205.548694821842, 8453.816465694685, 8545.700900468702, 8710.520921349387, 8818.955905220433, 12911.354432278536, 13113.475460981454, 13225.669358265735, 13376.398062087424, 13490.32548372597, 10614.923527270481, 10731.624393146203, 11190.0, 11202.551897924317, 11276.605318813803, 10821.350718956888, 11233.49449274801, 11312.377819219693, 11646.592369267035, 11898.286102833858, 11393.035817503991, 11563.479643415898, 11711.590094346997, 11790.410479476164, 12029.75940481203, 8421.452605580862, 8536.44513106646, 8536.44513106671, 8561.61472733716, 8669.783255418664, 8515.531645759294, 11257.605983790529, 11426.02878755282, 11546.249493782878, 11669.824952625548], "value": 9609.243345211231, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1387.285547942809, 1552.4333618229346, 1573.6065983504125, 1809.4209852847086, 1815.2013114229737, 6878.690458929348, 8848.0, 8971.685990990316, 9000.954995225014, 9011.14394132558, 8858.95570522148, 9095.272378209744, 9107.998120206772, 9120.680776172836, 9127.497987610679, 2552.1833013435707, 2571.4985577812336, 2574.6009368547907, 2576.510463012022, 2580.8322459040196, 2498.4503409249937, 2567.7047139579, 2567.845929244242, 2571.832830865997, 2579.548578998668, 2531.1141100614823, 2563.1541591274836, 2573.8327008744373, 2575.6909170899517, 2576.8711564421797, 2535.4802265535614, 2556.4759224358963, 2564.6922369315707, 2579.045753071357, 2580.9612855807177, 2121.5756848630335, 2515.9245222643167, 2567.0245306783304, 2567.242663414297, 2571.2029270926073, 8899.866502002475, 9119.49842758648, 9199.218066464358, 9244.0, 9252.537373131383, 5303.939212157584, 5729.28383952006, 5836.416358364172, 5946.167536544887, 6020.0, 3645.0, 3716.739828212026, 3765.35988881888, 3775.6035616260447, 3806.6764325032404, 1027.922905782062, 1056.033729137838, 1056.598492572825, 1061.930974486656, 1062.6811956413123, 12573.685657858536, 12577.371131443391, 12606.81089783654, 12636.49454021838, 12685.746285074247, 4839.104765618372, 4849.7011996944375, 4936.432310284364, 4940.110780059552, 4964.304997300381, 9793.363431376938, 9810.754731131636, 9817.754556136153, 9836.262280329003, 9838.0, 5677.205191273225, 5683.090705487102, 5683.5737319700365, 5686.14707793826, 5695.117256825199, 4675.95324046762, 4784.378030856036, 5112.412072611697, 5223.399309079428, 5295.073362161606, 4005.559388467266, 4019.5578486366476, 4077.796110194538, 4127.0, 4133.318002529609, 1075.1452595186845, 1094.5129417409335, 1282.9166104203198, 1285.6528737240892, 1302.7134030513273, 904.4482865452069, 921.8018126102786, 934.5047125023748, 950.2635457520477, 982.3369225772575, 6008.699565021731, 6023.367546407651, 6077.908831367533, 6148.754049838046, 6206.348333424925, 479.5635971266131, 483.5672073494203, 486.8782804298925, 487.8780304923769, 495.10880415252404, 3545.6986156177013, 3957.0, 4039.0, 4130.132672138824, 4139.3583994480905, 10439.060484556427, 10849.728756781144, 10877.0, 10908.400037997828, 10985.285956412808, 10626.149908007495, 10697.62558310471, 10698.14414846826, 10701.09040731531, 10886.67339979802, 8570.78573035679, 8757.168069033432, 8805.251553617885, 8809.11908809114, 8840.33697472705, 5656.123300888369, 5886.764529418775, 5951.7024148791525, 5962.07587823888, 6122.846928826637, 9706.5146742664, 9883.406995580288, 10034.949825250827, 10053.69838904834, 10061.849072263776, 9800.31397802147, 9913.405195688281, 9921.603135874484, 10135.341202821794, 10199.796004079728, 7050.894236586353, 7253.202147763636, 7546.358559522502, 7760.650770715219, 7898.763037108896, 8499.022612399653, 8521.403501754818, 8568.957155214184, 8572.05707372176, 8578.742637720878, 7527.1720110788865, 7595.696172153052, 7655.0813902332075, 7725.575093369694, 7764.961175194087, 7351.742689005859, 7370.96314518424, 7393.630318483947, 7416.555006699399, 7576.772696819105, 7156.642167891689, 7271.963640181977, 7297.16082650502, 7300.890486642811, 7312.451566132455, 4221.430106935524, 5019.648624596243, 5036.093503169464, 5109.540141387293, 5130.820421285237, 5048.924266135938, 5094.1849304111165, 5145.305383773143, 5167.483251674803, 5386.218998245155], "value": 4648.645703164532, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.4964204051882, 338.2010830254334, 344.43168771526985, 350.66161154485917, 352.0529774905506, 5122.61580381472, 6863.622500762463, 6883.414909732673, 6891.552049116816, 6901.275366086564, 5240.895182096356, 6628.370304821046, 6691.732330706766, 6716.227633822112, 6952.791416257521, 5173.30160428343, 5183.989122121188, 5186.766595503193, 5196.662216955905, 5217.321748172732, 5135.050015747099, 5196.090684130281, 5201.739913004353, 5211.609129315298, 5213.452587478317, 4871.050145221666, 4944.752762361867, 5057.190849464087, 5118.411382691001, 5130.71781052042, 5043.9747801260755, 5054.469280725544, 5058.544730974193, 5062.164742817431, 5081.6696914700615, 4342.131573685244, 4349.760763158025, 4358.4987726411555, 4359.193549193409, 4359.825606975717, 6532.967335163341, 6574.868502629968, 6601.801945941629, 6605.537612367136, 6614.470842332602, 5905.940940590582, 5912.881742365172, 5914.2311499504785, 5914.4381283777975, 5925.259342582177, 5815.534757219412, 7045.964770176116, 7308.817279568, 7329.780106596757, 7340.522866013745, 4849.418069831643, 4872.4640289568115, 4878.24387219978, 4894.730789806559, 4899.093667671492, 7674.155842857282, 7685.154632990367, 7710.344620707247, 7727.768166955, 7735.265149810759, 4955.72743499111, 4955.776990035457, 4968.701877887338, 4980.77586508608, 4981.302617633534, 5039.118154323052, 5048.798048078036, 5053.823116190915, 5065.138926382524, 5069.997351046316, 5684.744186511617, 5950.8809823803285, 5975.462208401264, 5979.1629171915965, 6005.429484198994, 5978.85052873673, 7355.7057717690695, 7397.37122344596, 7397.593132377771, 7410.518316309531, 1676.5389517882436, 1707.3512065415064, 1707.9316827327016, 1708.2739835569832, 1711.5549957011017, 990.2276224544867, 1020.9693709188737, 1061.1510791366875, 1081.118888106191, 1086.918481113904, 6280.9685951569945, 6464.38588334117, 6961.0, 7009.12385951756, 7039.190493093258, 6138.570300079041, 7654.655540500691, 7682.962800021925, 7693.1922148173635, 7693.807654808563, 5851.356350801409, 6797.796066118024, 6986.196587392414, 6995.4053905417595, 7012.333828286304, 3964.0684439156776, 4019.437278780973, 4044.8179831907637, 4079.0, 4124.91750164995, 6414.679266036679, 6513.283538810727, 8131.674733010614, 8135.715249966341, 8145.389095817837, 7979.640916158787, 7981.281684648409, 7983.401244906655, 7989.320907722792, 7990.240927111915, 8101.513909165469, 8107.1082180958865, 8108.0, 8108.472949258279, 8116.837663246702, 7397.593132377771, 7673.808154796175, 7697.0, 7720.922790772021, 7777.805554860947, 7524.914784938149, 7563.0, 7588.089429268523, 7594.0, 7594.620268986418, 8054.959725201336, 8082.0, 8089.3528517719615, 8094.10964793884, 8097.676092956216, 4808.110499557593, 4864.635152363516, 4879.097366987119, 4884.169691152583, 4898.706077635354, 7414.962925185339, 7667.233276672511, 7690.615469226628, 7709.498882572615, 7711.460197786326, 7374.1151061872915, 7422.406207503494, 7439.851202976019, 7446.25537446251, 7453.813654658677, 7437.739679111205, 7437.925620743723, 7438.814029649302, 7439.2188820173105, 7439.51643143194, 6946.756863509753, 7264.963675181591, 7270.272972702899, 7278.017467641801, 7278.745243916437, 7146.321099495747, 7408.925910740823, 7429.665665044978, 7436.144843342869, 7470.589117598584, 7214.422846172399, 7218.675159617725, 7225.132984041738, 7232.602206878672, 7238.746643867439], "value": 5379.018488231783, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.7674267491728, 717.3436305780211, 728.7886512911256, 774.907011158661, 819.0908092017859, 15671.981321214127, 15909.44316948907, 15956.920215398906, 15982.360705571778, 15988.76016859748, 14570.927145364285, 14644.707105857902, 14658.26708664568, 14674.339654715537, 14709.0, 956.4213650741306, 993.7714325705092, 997.8503224516344, 999.8700168978023, 1003.3528374198637, 976.0824824664793, 992.4095163377779, 993.6075250276136, 993.6075250276173, 996.1333639733442, 1057.3391630231106, 1060.708305216064, 1061.5382308695703, 1062.9946850265737, 1066.109798318401, 1046.4767616191905, 1050.758325585116, 1051.9421431821247, 1053.389034360077, 1057.978840423195, 782.6243403166512, 783.1737516919648, 784.9293563579305, 785.5679376343046, 786.9016372953381, 15718.685626287524, 15759.606009849731, 15873.285702143432, 15960.201989900575, 15969.600759980976, 12111.0, 12173.634790956285, 12176.147669663127, 12520.311382873939, 12662.936685316607, 9496.907855596557, 10262.486875656188, 10494.0, 10525.31585446951, 10559.947200263949, 3246.155999440139, 3564.821758912044, 3579.8210089495683, 3596.766210196355, 3799.9620003799882, 70036.29963700348, 71077.64461177713, 78903.6054819728, 79579.60210198912, 83234.0, 8046.275835174863, 9601.039896010483, 9644.373115747454, 9889.159421449114, 9909.108180263811, 21639.56720865574, 21643.242486512896, 21733.34799956004, 21755.564888702138, 21849.67225491619, 7731.845363092819, 7823.178566250575, 7905.802354941173, 7911.683532658744, 7914.0503139623615, 4256.9574304257185, 4322.481302243751, 4344.543822898613, 4373.103513779667, 4377.343398490252, 3750.6811920986474, 3821.6751576115785, 3822.0, 3823.2926908522013, 3824.598417166213, 571.2773341722724, 656.1076935367896, 673.9292374300726, 676.5061505101304, 685.5817951049855, 554.9916751248735, 608.537511491261, 617.4319625944142, 620.432304441431, 623.4575918950542, 8299.419040667095, 8375.246227839401, 8441.704540341181, 8500.234978851933, 8522.147785221552, 576.5906206593282, 582.5223316880117, 598.2671227746064, 607.7417097733446, 650.5576208178484, 3847.076701591654, 3872.43849641806, 4031.7177797554477, 4066.79666016698, 4151.6886233532605, 85231.72152417719, 85264.14735852687, 87611.12388876158, 88377.0, 89429.0, 64478.0, 72539.27460725325, 72771.63614181895, 74471.0, 74854.87717684239, 64367.0, 67059.66470167619, 67377.0, 67695.0, 69009.0, 8562.74311770648, 8602.0, 8713.041565427671, 8839.867401988846, 8872.645094196418, 42235.94410139771, 43115.13769724651, 43620.90947726205, 43855.0, 44265.89335266644, 63006.73986520336, 63233.735325294154, 63906.0, 64221.67889160525, 64578.67710661417, 11033.724156896142, 11213.0, 11295.71760705956, 11412.372319522507, 11832.935035846815, 11843.881561184278, 12077.57728479499, 12081.577144800242, 12295.508179672714, 12795.232286062866, 11621.24461909973, 11695.0, 11790.587329443772, 11840.644780656594, 12265.877341226473, 10099.94950025245, 11466.94266528662, 11679.883201168219, 11823.881761182278, 12124.515019399125, 11471.942640286745, 11624.767504650028, 11642.76714465689, 11732.237404568676, 11776.293422394683, 8188.713395031384, 10082.747931301776, 10090.243231757795, 10434.269601128151, 10451.477426128815, 9987.450690211817, 10020.94989525077, 10024.498775061364, 10026.197904167504, 10052.497375131361], "value": 7073.444684281506, "unit": "score"}], "name": "dromaeo_css", "value": 7570.813220070993, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 117.0, 112.0, 111.0, 112.0, 112.0, 110.0, 116.0, 191.0], "value": 120.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 151.0, 130.0, 192.0, 154.0, 175.0, 120.0, 167.0, 188.0, 113.0], "value": 155.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 187.0, 184.0, 182.0, 181.0, 182.0, 184.0, 184.0, 182.0, 185.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 78.0, 72.0, 152.0, 56.0, 74.0, 85.0, 53.0, 122.0, 74.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 141.0, 80.0, 78.0, 80.0, 124.0, 79.0, 79.0, 127.0], "value": 97.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 85.0, 88.0, 85.0, 88.0, 86.0, 88.0, 84.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 92.0, 92.0, 92.0, 104.0, 149.0, 93.0, 91.0, 95.0], "value": 99.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 136.0, 86.0, 83.0, 85.0, 82.0, 81.0, 83.0, 84.0, 84.0], "value": 92.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 62.0, 62.0, 62.0, 62.0, 64.0, 65.0, 79.0, 60.0, 57.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 64.0, 71.0, 73.0, 70.0, 68.0, 67.0, 65.0, 66.0, 66.0], "value": 67.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 78.0, 79.0, 79.0, 80.0, 79.0, 78.0, 82.0, 83.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 126.0, 125.0, 137.0, 132.0, 136.0, 122.0, 126.0, 153.0, 165.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 162.0, 163.0, 163.0, 163.0, 162.0, 160.0, 160.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 68.0, 67.0, 67.0, 65.0, 66.0, 68.0, 66.0, 66.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1491.5, "alertThreshold": 2.0}]} 14:29:49 INFO - Return code: 0 14:29:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:29:49 ERROR - # TBPL SUCCESS # 14:29:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:29:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:29:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:29:49 INFO - 2016-07-18 14:29:49.664 screenresolution[1682:9853] starting screenresolution argv=screenresolution get 14:29:49 INFO - 2016-07-18 14:29:49.667 screenresolution[1682:9853] Display 0: 1600x1200x32@60 14:29:49 INFO - 2016-07-18 14:29:49.673 screenresolution[1683:9856] starting screenresolution argv=screenresolution list 14:29:49 INFO - Available Modes on Display 0 14:29:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:29:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:29:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:29:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:29:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:29:49 INFO - Intel Iris: 14:29:49 INFO - Chipset Model: Intel Iris 14:29:49 INFO - Type: GPU 14:29:49 INFO - Bus: Built-In 14:29:49 INFO - VRAM (Dynamic, Max): 1536 MB 14:29:49 INFO - Vendor: Intel (0x8086) 14:29:49 INFO - Device ID: 0x0a2e 14:29:49 INFO - Revision ID: 0x0009 14:29:49 INFO - Displays: 14:29:49 INFO - Display: 14:29:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:29:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:29:49 INFO - Display Serial Number: 1600x1200 60 14:29:49 INFO - Main Display: Yes 14:29:49 INFO - Mirror: Off 14:29:49 INFO - Online: Yes 14:29:49 INFO - Rotation: Supported 14:29:49 INFO - Return code: 0 14:29:49 INFO - Running post-action listener: _resource_record_post_action 14:29:49 INFO - Running post-run listener: _resource_record_post_run 14:29:50 INFO - Total resource usage - Wall time: 1194s; CPU: 53.0%; Read bytes: 37094912; Write bytes: 491773440; Read time: 245; Write time: 1535 14:29:50 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 186137088; Write bytes: 174288896; Read time: 16493; Write time: 379 14:29:50 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 30952960; Write bytes: 297098752; Read time: 189; Write time: 1097 14:29:50 INFO - Running post-run listener: _upload_blobber_files 14:29:50 INFO - Blob upload gear active. 14:29:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:29:50 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:29:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:29:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:29:51 INFO - (blobuploader) - INFO - Open directory for files ... 14:29:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:29:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:29:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:52 INFO - (blobuploader) - INFO - Done attempting. 14:29:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:29:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:29:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:53 INFO - (blobuploader) - INFO - Done attempting. 14:29:53 INFO - (blobuploader) - INFO - Iteration through files over. 14:29:53 INFO - Return code: 0 14:29:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:29:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:29:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c2ff433a8b22382fd665c185e6e5ece278893baf4298ccd3d98109cf0975e9f7cecdba2554835910480bf760bed6e1f1a1097411c48f0d848b2c5007444642d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/68a03b470e2e00e4c995ae0f2e189417864caec7c2a555d82840d1a962b8f22b61a84f8cb80bd16bf4005a340396df0cae51274a5f2b486632de2b163556d3e2"} 14:29:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:29:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:29:53 INFO - Contents: 14:29:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c2ff433a8b22382fd665c185e6e5ece278893baf4298ccd3d98109cf0975e9f7cecdba2554835910480bf760bed6e1f1a1097411c48f0d848b2c5007444642d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/68a03b470e2e00e4c995ae0f2e189417864caec7c2a555d82840d1a962b8f22b61a84f8cb80bd16bf4005a340396df0cae51274a5f2b486632de2b163556d3e2"} 14:29:53 INFO - Running post-run listener: copy_logs_to_upload_dir 14:29:53 INFO - Copying logs to upload dir... 14:29:53 INFO - mkdir: /builds/slave/test/build/upload/logs 14:29:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.807369 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-18 14:29:53.513697) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 14:29:53.517087) ========= 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.X0Jo6XI4no/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.Gr3yge9ZhA/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c2ff433a8b22382fd665c185e6e5ece278893baf4298ccd3d98109cf0975e9f7cecdba2554835910480bf760bed6e1f1a1097411c48f0d848b2c5007444642d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/68a03b470e2e00e4c995ae0f2e189417864caec7c2a555d82840d1a962b8f22b61a84f8cb80bd16bf4005a340396df0cae51274a5f2b486632de2b163556d3e2"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833778/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011184 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833778/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c2ff433a8b22382fd665c185e6e5ece278893baf4298ccd3d98109cf0975e9f7cecdba2554835910480bf760bed6e1f1a1097411c48f0d848b2c5007444642d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/68a03b470e2e00e4c995ae0f2e189417864caec7c2a555d82840d1a962b8f22b61a84f8cb80bd16bf4005a340396df0cae51274a5f2b486632de2b163556d3e2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 14:29:53.552673) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 14:29:53.552989) ========= 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.X0Jo6XI4no/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.Gr3yge9ZhA/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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.005326 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 14:29:53.601418) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 14:29:53.601760) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 14:29:53.602068) ========= ========= Total master_lag: 0.38 =========