builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0226 starttime: 1469206133.04 results: success (0) buildid: 20160722032758 builduid: 6fa0c13327a748b9b0bb88e0184ecac4 revision: 68ca20cf8042a14e44e826e6e7985677c138bfd6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 09:48:53.044550) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 09:48:53.044921) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 09:48:53.045183) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 09:48:53.112088) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 09:48:53.112430) ========= 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.DtwMuHCDhj/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.ykR5CRVU17/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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-22 09:48:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.6M=0.001s 2016-07-22 09:48:53 (18.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.585510 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 09:48:53.719948) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 09:48:53.720253) ========= 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.DtwMuHCDhj/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.ykR5CRVU17/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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.026092 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 09:48:53.770152) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 09:48:53.770553) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 68ca20cf8042a14e44e826e6e7985677c138bfd6 --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 68ca20cf8042a14e44e826e6e7985677c138bfd6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DtwMuHCDhj/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.ykR5CRVU17/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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-22 09:48:53,854 truncating revision to first 12 chars 2016-07-22 09:48:53,854 Setting DEBUG logging. 2016-07-22 09:48:53,854 attempt 1/10 2016-07-22 09:48:53,854 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/68ca20cf8042?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-22 09:48:54,519 unpacking tar archive at: mozilla-beta-68ca20cf8042/testing/mozharness/ program finished with exit code 0 elapsedTime=0.944437 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 09:48:54.737095) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 09:48:54.737406) ========= script_repo_revision: 68ca20cf8042a14e44e826e6e7985677c138bfd6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 09:48:54.737777) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 09:48:54.738036) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 09:48:54.758902) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-22 09:48:54.759288) ========= /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.DtwMuHCDhj/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.ykR5CRVU17/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 09:48:54 INFO - MultiFileLogger online at 20160722 09:48:54 in /builds/slave/test 09:48:54 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 09:48:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:48:54 INFO - {'append_to_log': False, 09:48:54 INFO - 'base_work_dir': '/builds/slave/test', 09:48:54 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:48:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:48:54 INFO - 'branch': 'Mozilla-Beta', 09:48:54 INFO - 'buildbot_json_path': 'buildprops.json', 09:48:54 INFO - 'config_files': ('talos/mac_config.py',), 09:48:54 INFO - 'default_actions': ('clobber', 09:48:54 INFO - 'read-buildbot-config', 09:48:54 INFO - 'download-and-extract', 09:48:54 INFO - 'populate-webroot', 09:48:54 INFO - 'create-virtualenv', 09:48:54 INFO - 'install', 09:48:54 INFO - 'run-tests'), 09:48:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:48:54 INFO - 'download_minidump_stackwalk': True, 09:48:54 INFO - 'download_symbols': 'ondemand', 09:48:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:48:54 INFO - 'tooltool.py': '/tools/tooltool.py', 09:48:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:48:54 INFO - '/tools/misc-python/virtualenv.py')}, 09:48:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:48:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:48:54 INFO - 'installer_path': 'installer.exe', 09:48:54 INFO - 'log_level': 'info', 09:48:54 INFO - 'log_name': 'talos', 09:48:54 INFO - 'log_to_console': True, 09:48:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:48:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:48:54 INFO - 'opt_config_files': (), 09:48:54 INFO - 'pip_index': False, 09:48:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:48:54 INFO - 'cmd': ('bash', 09:48:54 INFO - '-c', 09:48:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:48:54 INFO - 'enabled': True, 09:48:54 INFO - 'halt_on_failure': False, 09:48:54 INFO - 'name': 'check_screen_resolution'},), 09:48:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:48:54 INFO - 'cmd': ('bash', 09:48:54 INFO - '-c', 09:48:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:48:54 INFO - 'enabled': True, 09:48:54 INFO - 'halt_on_failure': False, 09:48:54 INFO - 'name': 'check_screen_resolution'},), 09:48:54 INFO - 'run_cmd_checks_enabled': True, 09:48:54 INFO - 'sps_profile': False, 09:48:54 INFO - 'sps_profile_interval': 0, 09:48:54 INFO - 'suite': 'dromaeojs', 09:48:54 INFO - 'system_bits': '32', 09:48:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:48:54 INFO - 'title': 't-yosemite-r7-0226', 09:48:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:48:54 INFO - 'use_talos_json': True, 09:48:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:48:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:48:54 INFO - 'work_dir': 'build'} 09:48:54 INFO - ##### 09:48:54 INFO - ##### Running clobber step. 09:48:54 INFO - ##### 09:48:54 INFO - Running pre-action listener: _resource_record_pre_action 09:48:54 INFO - Running main action method: clobber 09:48:54 INFO - rmtree: /builds/slave/test/build 09:48:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:48:57 INFO - Running post-action listener: _resource_record_post_action 09:48:57 INFO - ##### 09:48:57 INFO - ##### Running read-buildbot-config step. 09:48:57 INFO - ##### 09:48:57 INFO - Running pre-action listener: _resource_record_pre_action 09:48:57 INFO - Running main action method: read_buildbot_config 09:48:57 INFO - Using buildbot properties: 09:48:57 INFO - { 09:48:57 INFO - "project": "", 09:48:57 INFO - "product": "firefox", 09:48:57 INFO - "script_repo_revision": "production", 09:48:57 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:48:57 INFO - "repository": "", 09:48:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:48:57 INFO - "buildid": "20160722032758", 09:48:57 INFO - "pgo_build": "False", 09:48:57 INFO - "basedir": "/builds/slave/test", 09:48:57 INFO - "buildnumber": 51, 09:48:57 INFO - "slavename": "t-yosemite-r7-0226", 09:48:57 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:48:57 INFO - "platform": "yosemite_r7", 09:48:57 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:48:57 INFO - "branch": "mozilla-beta", 09:48:57 INFO - "repo_path": "releases/mozilla-beta", 09:48:57 INFO - "revision": "68ca20cf8042a14e44e826e6e7985677c138bfd6", 09:48:57 INFO - "stage_platform": "macosx64", 09:48:57 INFO - "builduid": "6fa0c13327a748b9b0bb88e0184ecac4", 09:48:57 INFO - "slavebuilddir": "test" 09:48:57 INFO - } 09:48:57 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.dmg. 09:48:57 INFO - Running post-action listener: _resource_record_post_action 09:48:57 INFO - ##### 09:48:57 INFO - ##### Running download-and-extract step. 09:48:57 INFO - ##### 09:48:57 INFO - Running pre-action listener: _resource_record_pre_action 09:48:57 INFO - Running main action method: download_and_extract 09:48:57 INFO - mkdir: /builds/slave/test/build/tests 09:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:48:57 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.test_packages.json 09:48:57 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 09:48:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/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 09:48:57 INFO - Downloaded 1165 bytes. 09:48:57 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 09:48:57 INFO - Using the following test package requirements: 09:48:57 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 09:48:57 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:48:57 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 09:48:57 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:48:57 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 09:48:57 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:48:57 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:48:57 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 09:48:57 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 09:48:57 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:48:57 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 09:48:57 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:48:57 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 09:48:57 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:48:57 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 09:48:57 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:48:57 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 09:48:57 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 09:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:48:57 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.common.tests.zip 09:48:57 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 09:48:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/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 09:49:00 INFO - Downloaded 18314888 bytes. 09:49:00 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'] 09:49:00 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 09:49:03 INFO - Return code: 0 09:49:03 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 09:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:49:03 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.common.tests.zip 09:49:03 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 09:49:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/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 09:49:03 INFO - Downloaded 18314888 bytes. 09:49:03 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'] 09:49:03 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 09:49:07 INFO - Return code: 0 09:49:07 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')]} 09:49:07 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.talos.tests.zip 09:49:07 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 09:49:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/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 09:49:09 INFO - Downloaded 10840145 bytes. 09:49:09 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'] 09:49:09 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 09:49:09 INFO - Return code: 0 09:49:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:49:09 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.dmg 09:49:09 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 09:49:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 09:49:13 INFO - Downloaded 86192613 bytes. 09:49:13 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.dmg 09:49:13 INFO - mkdir: /builds/slave/test/properties 09:49:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:49:13 INFO - Writing to file /builds/slave/test/properties/build_url 09:49:13 INFO - Contents: 09:49:13 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.dmg 09:49:13 INFO - Running post-action listener: _resource_record_post_action 09:49:13 INFO - Running post-action listener: set_extra_try_arguments 09:49:13 INFO - ##### 09:49:13 INFO - ##### Running populate-webroot step. 09:49:13 INFO - ##### 09:49:13 INFO - Running pre-action listener: _resource_record_pre_action 09:49:13 INFO - Running main action method: populate_webroot 09:49:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:49:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:49:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:49:13 INFO - '--tppagecycles', 09:49:13 INFO - '7'], 09:49:13 INFO - 'tests': ['tsvgm']}}, 09:49:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:49:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:49:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:49:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:49:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:49:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:49:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:13 INFO - 'talos_options': ['--disable-e10s'], 09:49:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:49:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:49:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:13 INFO - 'talos_options': ['--disable-e10s'], 09:49:13 INFO - 'tests': ['damp', 'tps']}, 09:49:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:13 INFO - 'tests': ['damp', 'tps']}, 09:49:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:49:13 INFO - 'tests': ['dromaeo_dom']}, 09:49:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:49:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:49:13 INFO - 'tests': ['a11yr', 09:49:13 INFO - 'ts_paint', 09:49:13 INFO - 'tpaint', 09:49:13 INFO - 'sessionrestore', 09:49:13 INFO - 'sessionrestore_no_auto_restore', 09:49:13 INFO - 'tabpaint']}, 09:49:13 INFO - 'other-e10s': {'tests': ['a11yr', 09:49:13 INFO - 'ts_paint', 09:49:13 INFO - 'tpaint', 09:49:13 INFO - 'sessionrestore', 09:49:13 INFO - 'sessionrestore_no_auto_restore', 09:49:13 INFO - 'tabpaint']}, 09:49:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:49:13 INFO - 'ts_paint', 09:49:13 INFO - 'tpaint', 09:49:13 INFO - 'sessionrestore', 09:49:13 INFO - 'sessionrestore_no_auto_restore', 09:49:13 INFO - 'tabpaint']}, 09:49:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:49:13 INFO - 'ts_paint', 09:49:13 INFO - 'tpaint', 09:49:13 INFO - 'sessionrestore', 09:49:13 INFO - 'sessionrestore_no_auto_restore', 09:49:13 INFO - 'tabpaint']}, 09:49:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:49:13 INFO - 'tests': ['a11yr', 09:49:13 INFO - 'ts_paint', 09:49:13 INFO - 'tpaint', 09:49:13 INFO - 'sessionrestore', 09:49:13 INFO - 'sessionrestore_no_auto_restore', 09:49:13 INFO - 'tabpaint']}, 09:49:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:49:13 INFO - 'tests': ['a11yr', 09:49:13 INFO - 'ts_paint', 09:49:13 INFO - 'tpaint', 09:49:13 INFO - 'sessionrestore', 09:49:13 INFO - 'sessionrestore_no_auto_restore', 09:49:13 INFO - 'tabpaint']}, 09:49:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:49:13 INFO - 'tests': ['tsvgx', 09:49:13 INFO - 'tsvgr_opacity', 09:49:13 INFO - 'tart', 09:49:13 INFO - 'tscrollx', 09:49:13 INFO - 'cart']}, 09:49:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:49:13 INFO - 'tsvgr_opacity', 09:49:13 INFO - 'tart', 09:49:13 INFO - 'tscrollx', 09:49:13 INFO - 'cart']}, 09:49:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:13 INFO - 'talos_options': ['--disable-e10s'], 09:49:13 INFO - 'tests': ['tp5o']}, 09:49:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:13 INFO - 'tests': ['tp5o']}, 09:49:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:13 INFO - 'talos_options': ['--disable-e10s', 09:49:13 INFO - '--xperf_path', 09:49:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:49:13 INFO - 'tests': ['tp5n']}, 09:49:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:13 INFO - 'talos_options': ['--xperf_path', 09:49:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:49:13 INFO - 'tests': ['tp5n']}}, 09:49:13 INFO - 'talos.zip': {'path': '', 09:49:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:49:13 INFO - Running post-action listener: _resource_record_post_action 09:49:13 INFO - ##### 09:49:13 INFO - ##### Running create-virtualenv step. 09:49:13 INFO - ##### 09:49:13 INFO - Running pre-action listener: _resource_record_pre_action 09:49:13 INFO - Running main action method: create_virtualenv 09:49:13 INFO - Creating virtualenv /builds/slave/test/build/venv 09:49:13 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 09:49:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:49:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:49:13 INFO - Using real prefix '/tools/python27' 09:49:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:49:14 INFO - Installing distribute.............................................................................................................................................................................................done. 09:49:17 INFO - Installing pip.................done. 09:49:17 INFO - Return code: 0 09:49:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:49:17 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')]} 09:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:17 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')]} 09:49:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:17 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 0x103414a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103424420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f965bea1540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032b3e00>, '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 0x10311cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032aeb20>, '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.DtwMuHCDhj/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.ykR5CRVU17/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 09:49:17 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 09:49:17 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 09:49:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DtwMuHCDhj/Render', 09:49:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:17 INFO - 'HOME': '/Users/cltbld', 09:49:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:17 INFO - 'LOGNAME': 'cltbld', 09:49:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:17 INFO - 'MOZ_NO_REMOTE': '1', 09:49:17 INFO - 'NO_EM_RESTART': '1', 09:49:17 INFO - 'PAGER': '/bin/cat', 09:49:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:17 INFO - 'PWD': '/builds/slave/test', 09:49:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:17 INFO - 'SHELL': '/bin/bash', 09:49:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ykR5CRVU17/Listeners', 09:49:17 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 09:49:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:17 INFO - 'USER': 'cltbld', 09:49:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:17 INFO - 'XPC_FLAGS': '0x0', 09:49:17 INFO - 'XPC_SERVICE_NAME': '0', 09:49:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:17 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 09:49:17 INFO - Cleaning up... 09:49:17 INFO - Return code: 0 09:49:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:49:17 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')]} 09:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:17 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')]} 09:49:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:17 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 0x103414a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103424420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f965bea1540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032b3e00>, '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 0x10311cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032aeb20>, '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.DtwMuHCDhj/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.ykR5CRVU17/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 09:49:17 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 09:49:17 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 09:49:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DtwMuHCDhj/Render', 09:49:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:17 INFO - 'HOME': '/Users/cltbld', 09:49:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:17 INFO - 'LOGNAME': 'cltbld', 09:49:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:17 INFO - 'MOZ_NO_REMOTE': '1', 09:49:17 INFO - 'NO_EM_RESTART': '1', 09:49:17 INFO - 'PAGER': '/bin/cat', 09:49:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:17 INFO - 'PWD': '/builds/slave/test', 09:49:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:17 INFO - 'SHELL': '/bin/bash', 09:49:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ykR5CRVU17/Listeners', 09:49:17 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 09:49:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:17 INFO - 'USER': 'cltbld', 09:49:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:17 INFO - 'XPC_FLAGS': '0x0', 09:49:17 INFO - 'XPC_SERVICE_NAME': '0', 09:49:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:17 INFO - Downloading/unpacking psutil>=0.7.1 09:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:49:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:49:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:49:21 INFO - Installing collected packages: psutil 09:49:21 INFO - Running setup.py install for psutil 09:49:21 INFO - building 'psutil._psutil_osx' extension 09:49:21 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 09:49:21 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 09:49:21 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 09:49:21 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 09:49:22 INFO - building 'psutil._psutil_posix' extension 09:49:22 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 09:49:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:49:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:49:22 INFO - ^ 09:49:22 INFO - 1 warning generated. 09:49:22 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 09:49:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:49:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:49:22 INFO - Successfully installed psutil 09:49:22 INFO - Cleaning up... 09:49:22 INFO - Return code: 0 09:49:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:49: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')]} 09:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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')]} 09:49:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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', '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 0x103414a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103424420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f965bea1540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032b3e00>, '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 0x10311cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032aeb20>, '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.DtwMuHCDhj/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.ykR5CRVU17/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 09:49: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:49: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 mozsystemmonitor==0.0.0 09:49:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DtwMuHCDhj/Render', 09:49:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:22 INFO - 'HOME': '/Users/cltbld', 09:49:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:22 INFO - 'LOGNAME': 'cltbld', 09:49:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:22 INFO - 'MOZ_NO_REMOTE': '1', 09:49:22 INFO - 'NO_EM_RESTART': '1', 09:49:22 INFO - 'PAGER': '/bin/cat', 09:49:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:22 INFO - 'PWD': '/builds/slave/test', 09:49:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:22 INFO - 'SHELL': '/bin/bash', 09:49:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ykR5CRVU17/Listeners', 09:49:22 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 09:49:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:22 INFO - 'USER': 'cltbld', 09:49:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:22 INFO - 'XPC_FLAGS': '0x0', 09:49:22 INFO - 'XPC_SERVICE_NAME': '0', 09:49:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:49:22 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 09:49:22 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 09:49:22 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 09:49:22 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 09:49:22 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 09:49:22 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 09:49:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:49:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:49:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:49:25 INFO - Installing collected packages: mozsystemmonitor 09:49:25 INFO - Running setup.py install for mozsystemmonitor 09:49:25 INFO - Successfully installed mozsystemmonitor 09:49:25 INFO - Cleaning up... 09:49:25 INFO - Return code: 0 09:49:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:49:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103414a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103424420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f965bea1540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032b3e00>, '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 0x10311cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032aeb20>, '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.DtwMuHCDhj/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.ykR5CRVU17/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 09:49:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:49:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:49:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DtwMuHCDhj/Render', 09:49:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:25 INFO - 'HOME': '/Users/cltbld', 09:49:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:25 INFO - 'LOGNAME': 'cltbld', 09:49:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:25 INFO - 'MOZ_NO_REMOTE': '1', 09:49:25 INFO - 'NO_EM_RESTART': '1', 09:49:25 INFO - 'PAGER': '/bin/cat', 09:49:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:25 INFO - 'PWD': '/builds/slave/test', 09:49:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:25 INFO - 'SHELL': '/bin/bash', 09:49:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ykR5CRVU17/Listeners', 09:49:25 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 09:49:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:25 INFO - 'USER': 'cltbld', 09:49:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:25 INFO - 'XPC_FLAGS': '0x0', 09:49:25 INFO - 'XPC_SERVICE_NAME': '0', 09:49:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:25 INFO - Downloading/unpacking blobuploader==1.2.4 09:49:25 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 09:49:25 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 09:49:25 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 09:49:25 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 09:49:25 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 09:49:25 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 09:49:28 INFO - Downloading blobuploader-1.2.4.tar.gz 09:49:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:49:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:49:28 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 09:49:28 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 09:49:28 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 09:49:28 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 09:49:28 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 09:49:28 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 09:49:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:49:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:49:28 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 09:49:28 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 09:49:28 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 09:49:28 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 09:49:28 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 09:49:28 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 09:49:29 INFO - Downloading docopt-0.6.1.tar.gz 09:49:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:49:29 INFO - Installing collected packages: blobuploader, requests, docopt 09:49:29 INFO - Running setup.py install for blobuploader 09:49:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:49:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:49:29 INFO - Running setup.py install for requests 09:49:30 INFO - Running setup.py install for docopt 09:49:30 INFO - Successfully installed blobuploader requests docopt 09:49:30 INFO - Cleaning up... 09:49:30 INFO - Return code: 0 09:49:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49:30 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')]} 09:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:30 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')]} 09:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:30 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 0x103414a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103424420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f965bea1540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032b3e00>, '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 0x10311cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032aeb20>, '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.DtwMuHCDhj/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.ykR5CRVU17/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 09:49:30 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 09:49:30 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 09:49:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DtwMuHCDhj/Render', 09:49:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:30 INFO - 'HOME': '/Users/cltbld', 09:49:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:30 INFO - 'LOGNAME': 'cltbld', 09:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:30 INFO - 'MOZ_NO_REMOTE': '1', 09:49:30 INFO - 'NO_EM_RESTART': '1', 09:49:30 INFO - 'PAGER': '/bin/cat', 09:49:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:30 INFO - 'PWD': '/builds/slave/test', 09:49:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:30 INFO - 'SHELL': '/bin/bash', 09:49:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ykR5CRVU17/Listeners', 09:49:30 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 09:49:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:30 INFO - 'USER': 'cltbld', 09:49:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:30 INFO - 'XPC_FLAGS': '0x0', 09:49:30 INFO - 'XPC_SERVICE_NAME': '0', 09:49:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:49:30 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-Nsbb76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:49:30 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-7YzFRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:49:30 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-LHLuGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:49:30 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-ZXhCEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:49:30 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-hhFvhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:49:31 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-dl23vz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:49:31 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-k1_YfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:49:31 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-_er9vS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:49:31 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-lUNre3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:49:31 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-A5Fl2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:49:31 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-vICHyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:49:31 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-y1w0F4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:49:31 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-Kyrjz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:49:31 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-GKFYnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:31 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-GzZQM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:49:32 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-rfIl5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:49:32 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-HntgSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:49:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:49:32 INFO - Running setup.py install for manifestparser 09:49:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:49:32 INFO - Running setup.py install for mozcrash 09:49:32 INFO - Running setup.py install for mozdebug 09:49:32 INFO - Running setup.py install for mozdevice 09:49:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:49:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:49:32 INFO - Running setup.py install for mozfile 09:49:33 INFO - Running setup.py install for mozhttpd 09:49:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:49:33 INFO - Running setup.py install for mozinfo 09:49:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:49:33 INFO - Running setup.py install for mozInstall 09:49:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:49:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:49:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:49:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:49:33 INFO - Running setup.py install for mozleak 09:49:33 INFO - Running setup.py install for mozlog 09:49:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:49:33 INFO - Running setup.py install for moznetwork 09:49:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:49:33 INFO - Running setup.py install for mozprocess 09:49:34 INFO - Running setup.py install for mozprofile 09:49:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:49:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:49:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:49:34 INFO - Running setup.py install for mozrunner 09:49:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:49:34 INFO - Running setup.py install for mozscreenshot 09:49:34 INFO - Running setup.py install for moztest 09:49:34 INFO - Running setup.py install for mozversion 09:49:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:49:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:49:34 INFO - Cleaning up... 09:49:34 INFO - Return code: 0 09:49:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:34 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 0x103414a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103424420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f965bea1540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032b3e00>, '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 0x10311cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032aeb20>, '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.DtwMuHCDhj/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.ykR5CRVU17/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 09:49:34 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 09:49:34 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 09:49:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DtwMuHCDhj/Render', 09:49:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:34 INFO - 'HOME': '/Users/cltbld', 09:49:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:34 INFO - 'LOGNAME': 'cltbld', 09:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:34 INFO - 'MOZ_NO_REMOTE': '1', 09:49:34 INFO - 'NO_EM_RESTART': '1', 09:49:34 INFO - 'PAGER': '/bin/cat', 09:49:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:34 INFO - 'PWD': '/builds/slave/test', 09:49:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:34 INFO - 'SHELL': '/bin/bash', 09:49:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ykR5CRVU17/Listeners', 09:49:34 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 09:49:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:34 INFO - 'USER': 'cltbld', 09:49:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:34 INFO - 'XPC_FLAGS': '0x0', 09:49:34 INFO - 'XPC_SERVICE_NAME': '0', 09:49:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:49:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-_ZxECR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:49:35 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)) 09:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:49:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-lOyeWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:49:35 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)) 09:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:49:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-hSCw52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:49:35 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)) 09:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:49:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-fZUyXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:49:35 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)) 09:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:49:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-1zvAA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:49:35 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)) 09:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:49:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-mOBAoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:49:35 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)) 09:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:49:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-XlvcwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:49:35 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)) 09:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:49:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-Cncy5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:49:35 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)) 09:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:49:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-Fy_RYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:49:36 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)) 09:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:49:36 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-tDQ0Vk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:49:36 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)) 09:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:49:36 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-7fCoZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:49:36 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)) 09:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:49:36 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-mSFYbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:49:36 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)) 09:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:49:36 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-wH5qmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:49:36 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)) 09:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:49:36 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-MjinFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:49:36 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)) 09:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:36 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-PzheYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:36 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)) 09:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:49:36 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-6h8AE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:49:36 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)) 09:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:49:36 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-nvxZbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:49:36 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)) 09:49:36 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)) 09:49:36 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)) 09:49:36 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)) 09:49:36 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)) 09:49:36 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)) 09:49:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:49:36 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 09:49:36 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 09:49:36 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 09:49:36 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 09:49:36 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 09:49:36 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 09:49:39 INFO - Downloading blessings-1.6.tar.gz 09:49:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:49:39 INFO - Installing collected packages: blessings 09:49:39 INFO - Running setup.py install for blessings 09:49:39 INFO - Successfully installed blessings 09:49:39 INFO - Cleaning up... 09:49:39 INFO - Return code: 0 09:49:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:49:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:49:40 INFO - Reading from file tmpfile_stdout 09:49:40 INFO - Current package versions: 09:49:40 INFO - blessings == 1.6 09:49:40 INFO - blobuploader == 1.2.4 09:49:40 INFO - docopt == 0.6.1 09:49:40 INFO - manifestparser == 1.1 09:49:40 INFO - mozInstall == 1.12 09:49:40 INFO - mozcrash == 0.17 09:49:40 INFO - mozdebug == 0.1 09:49:40 INFO - mozdevice == 0.48 09:49:40 INFO - mozfile == 1.2 09:49:40 INFO - mozhttpd == 0.7 09:49:40 INFO - mozinfo == 0.9 09:49:40 INFO - mozleak == 0.1 09:49:40 INFO - mozlog == 3.1 09:49:40 INFO - moznetwork == 0.27 09:49:40 INFO - mozprocess == 0.22 09:49:40 INFO - mozprofile == 0.28 09:49:40 INFO - mozrunner == 6.11 09:49:40 INFO - mozscreenshot == 0.1 09:49:40 INFO - mozsystemmonitor == 0.0 09:49:40 INFO - moztest == 0.7 09:49:40 INFO - mozversion == 1.4 09:49:40 INFO - psutil == 3.1.1 09:49:40 INFO - requests == 1.2.3 09:49:40 INFO - wsgiref == 0.1.2 09:49:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:40 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 0x103414a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103424420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f965bea1540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032b3e00>, '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 0x10311cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032aeb20>, '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.DtwMuHCDhj/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.ykR5CRVU17/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 09:49:40 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 09:49:40 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 09:49:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DtwMuHCDhj/Render', 09:49:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:40 INFO - 'HOME': '/Users/cltbld', 09:49:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:40 INFO - 'LOGNAME': 'cltbld', 09:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:40 INFO - 'MOZ_NO_REMOTE': '1', 09:49:40 INFO - 'NO_EM_RESTART': '1', 09:49:40 INFO - 'PAGER': '/bin/cat', 09:49:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:40 INFO - 'PWD': '/builds/slave/test', 09:49:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:40 INFO - 'SHELL': '/bin/bash', 09:49:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ykR5CRVU17/Listeners', 09:49:40 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 09:49:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:40 INFO - 'USER': 'cltbld', 09:49:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:40 INFO - 'XPC_FLAGS': '0x0', 09:49:40 INFO - 'XPC_SERVICE_NAME': '0', 09:49:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:40 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)) 09:49:40 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)) 09:49:40 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)) 09:49:40 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)) 09:49:40 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)) 09:49:40 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)) 09:49:40 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)) 09:49:40 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)) 09:49:40 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)) 09:49:40 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)) 09:49:40 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)) 09:49:40 INFO - Cleaning up... 09:49:40 INFO - Return code: 0 09:49:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:40 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 0x103414a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103424420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f965bea1540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032b3e00>, '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 0x10311cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032aeb20>, '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.DtwMuHCDhj/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.ykR5CRVU17/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 09:49:40 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 09:49:40 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 09:49:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DtwMuHCDhj/Render', 09:49:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:40 INFO - 'HOME': '/Users/cltbld', 09:49:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:40 INFO - 'LOGNAME': 'cltbld', 09:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:40 INFO - 'MOZ_NO_REMOTE': '1', 09:49:40 INFO - 'NO_EM_RESTART': '1', 09:49:40 INFO - 'PAGER': '/bin/cat', 09:49:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:40 INFO - 'PWD': '/builds/slave/test', 09:49:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:40 INFO - 'SHELL': '/bin/bash', 09:49:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ykR5CRVU17/Listeners', 09:49:40 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 09:49:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:40 INFO - 'USER': 'cltbld', 09:49:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:40 INFO - 'XPC_FLAGS': '0x0', 09:49:40 INFO - 'XPC_SERVICE_NAME': '0', 09:49:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:40 INFO - Downloading/unpacking jsonschema 09:49:40 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 09:49:40 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 09:49:40 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 09:49:40 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 09:49:40 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 09:49:40 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 09:49:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:49:43 INFO - Downloading/unpacking functools32 (from jsonschema) 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49:43 INFO - Downloading functools32-3.2.3-2.tar.gz 09:49:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:49:43 INFO - warning: no files found matching '*.txt' 09:49:43 INFO - no previously-included directories found matching 'build' 09:49:43 INFO - no previously-included directories found matching 'dist' 09:49:43 INFO - no previously-included directories found matching '.git*' 09:49:43 INFO - Installing collected packages: jsonschema, functools32 09:49:43 INFO - Running setup.py install for functools32 09:49:43 INFO - warning: no files found matching '*.txt' 09:49:43 INFO - no previously-included directories found matching 'build' 09:49:43 INFO - no previously-included directories found matching 'dist' 09:49:43 INFO - no previously-included directories found matching '.git*' 09:49:43 INFO - Successfully installed jsonschema functools32 09:49:43 INFO - Cleaning up... 09:49:43 INFO - Return code: 0 09:49:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:43 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 0x103414a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103424420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f965bea1540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032b3e00>, '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 0x10311cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032aeb20>, '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.DtwMuHCDhj/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.ykR5CRVU17/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 09:49:43 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 09:49:43 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 09:49:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DtwMuHCDhj/Render', 09:49:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:43 INFO - 'HOME': '/Users/cltbld', 09:49:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:43 INFO - 'LOGNAME': 'cltbld', 09:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:43 INFO - 'MOZ_NO_REMOTE': '1', 09:49:43 INFO - 'NO_EM_RESTART': '1', 09:49:43 INFO - 'PAGER': '/bin/cat', 09:49:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:43 INFO - 'PWD': '/builds/slave/test', 09:49:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:43 INFO - 'SHELL': '/bin/bash', 09:49:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ykR5CRVU17/Listeners', 09:49:43 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 09:49:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:43 INFO - 'USER': 'cltbld', 09:49:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:43 INFO - 'XPC_FLAGS': '0x0', 09:49:43 INFO - 'XPC_SERVICE_NAME': '0', 09:49:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:44 INFO - Downloading/unpacking flake8 09:49:44 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 09:49:44 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 09:49:44 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 09:49:44 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 09:49:44 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 09:49:44 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 09:49:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:49:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:49:46 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 09:49:46 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 09:49:46 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 09:49:46 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 09:49:46 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 09:49:46 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 09:49:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:49:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:49:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:49:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:49:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:49:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:49:48 INFO - no previously-included directories found matching 'docs/_build' 09:49:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:49:48 INFO - Running setup.py install for pep8 09:49:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:49:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:49:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:49:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:49:48 INFO - no previously-included directories found matching 'docs/_build' 09:49:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:49:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:49:48 INFO - Cleaning up... 09:49:48 INFO - Return code: 0 09:49:48 INFO - Running post-action listener: _resource_record_post_action 09:49:48 INFO - Running post-action listener: _start_resource_monitoring 09:49:48 INFO - Starting resource monitoring. 09:49:48 INFO - ##### 09:49:48 INFO - ##### Running install step. 09:49:48 INFO - ##### 09:49:48 INFO - Running pre-action listener: _resource_record_pre_action 09:49:48 INFO - Running main action method: install 09:49:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:49:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:49:48 INFO - Reading from file tmpfile_stdout 09:49:48 INFO - Detecting whether we're running mozinstall >=1.0... 09:49:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:49:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:49:48 INFO - Reading from file tmpfile_stdout 09:49:48 INFO - Output received: 09:49:48 INFO - Usage: mozinstall [options] installer 09:49:48 INFO - Options: 09:49:48 INFO - -h, --help show this help message and exit 09:49:48 INFO - -d DEST, --destination=DEST 09:49:48 INFO - Directory to install application into. [default: 09:49:48 INFO - "/builds/slave/test"] 09:49:48 INFO - --app=APP Application being installed. [default: firefox] 09:49:48 INFO - mkdir: /builds/slave/test/build/application 09:49:48 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'] 09:49:48 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 09:50:10 INFO - Reading from file tmpfile_stdout 09:50:10 INFO - Output received: 09:50:10 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:50:10 INFO - Running post-action listener: _resource_record_post_action 09:50:10 INFO - ##### 09:50:10 INFO - ##### Running run-tests step. 09:50:10 INFO - ##### 09:50:10 INFO - Running pre-action listener: _resource_record_pre_action 09:50:10 INFO - Running main action method: run_tests 09:50:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:50:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:50:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:50:10 INFO - 2016-07-22 09:50:10.730 screenresolution[1644:8480] starting screenresolution argv=screenresolution get 09:50:10 INFO - 2016-07-22 09:50:10.732 screenresolution[1644:8480] Display 0: 1600x1200x32@60 09:50:10 INFO - 2016-07-22 09:50:10.738 screenresolution[1645:8483] starting screenresolution argv=screenresolution list 09:50:10 INFO - Available Modes on Display 0 09:50:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:50:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:50:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:50:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:50:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:50:10 INFO - Intel Iris: 09:50:10 INFO - Chipset Model: Intel Iris 09:50:10 INFO - Type: GPU 09:50:10 INFO - Bus: Built-In 09:50:10 INFO - VRAM (Dynamic, Max): 1536 MB 09:50:10 INFO - Vendor: Intel (0x8086) 09:50:10 INFO - Device ID: 0x0a2e 09:50:10 INFO - Revision ID: 0x0009 09:50:10 INFO - Displays: 09:50:10 INFO - Display: 09:50:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:50:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:50:10 INFO - Display Serial Number: 1600x1200 60 09:50:10 INFO - Main Display: Yes 09:50:10 INFO - Mirror: Off 09:50:10 INFO - Online: Yes 09:50:10 INFO - Rotation: Supported 09:50:10 INFO - Return code: 0 09:50:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:50:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:50:10 INFO - Python 2.7.3 09:50:10 INFO - Return code: 0 09:50:10 INFO - grabbing minidump binary from tooltool 09:50:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:50:10 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032b3e00>, '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 0x10311cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032aeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:50:10 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:50:10 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:50:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:50:11 INFO - Return code: 0 09:50:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:50:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:50:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:50:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:50:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:50:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:50:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:50:12 INFO - Return code: 0 09:50:12 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/1469183278/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0226', '--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 09:50:12 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/1469183278/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0226 --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 09:50:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DtwMuHCDhj/Render', 09:50:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:50:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:50:12 INFO - 'HOME': '/Users/cltbld', 09:50:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:50:12 INFO - 'LOGNAME': 'cltbld', 09:50:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:50:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:12 INFO - 'MOZ_NO_REMOTE': '1', 09:50:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:50:12 INFO - 'NO_EM_RESTART': '1', 09:50:12 INFO - 'PAGER': '/bin/cat', 09:50:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:12 INFO - 'PWD': '/builds/slave/test', 09:50:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:50:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:50:12 INFO - 'SHELL': '/bin/bash', 09:50:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ykR5CRVU17/Listeners', 09:50:12 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 09:50:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:50:12 INFO - 'USER': 'cltbld', 09:50:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:50:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:12 INFO - 'XPC_FLAGS': '0x0', 09:50:12 INFO - 'XPC_SERVICE_NAME': '0', 09:50:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:50:12 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/1469183278/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0226', '--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 09:50:12 INFO - mozversion application_buildid: 20160722032758 09:50:12 INFO - mozversion application_changeset: 68ca20cf8042a14e44e826e6e7985677c138bfd6 09:50:12 INFO - mozversion application_display_name: Firefox 09:50:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:50:12 INFO - mozversion application_name: Firefox 09:50:12 INFO - mozversion application_remotingname: firefox 09:50:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:50:12 INFO - mozversion application_vendor: Mozilla 09:50:12 INFO - mozversion application_version: 48.0 09:50:12 INFO - mozversion platform_buildid: 20160722032758 09:50:12 INFO - mozversion platform_changeset: 68ca20cf8042a14e44e826e6e7985677c138bfd6 09:50:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:50:12 INFO - mozversion platform_version: 48.0 09:50:12 INFO - using testdate: 1469206212 09:50:12 INFO - actual date: 1469206212 09:50:12 INFO - starting webserver on 'localhost:49271' 09:50:12 INFO - SUITE-START | Running 2 tests 09:50:12 INFO - TEST-START | dromaeo_css 09:50:12 INFO - operating with platform_type : mac_ 09:50:12 INFO - Initialising browser for dromaeo_css test... 09:50:12 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmpXJE3Vq/profile http://localhost:49271/getInfo.html) 09:50:14 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 09:50:14 INFO - PROCESS | 1663 | colorDepth:24 09:50:14 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 09:50:14 INFO - PROCESS | 1663 | __metrics 09:50:14 INFO - PROCESS | 1663 | 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" 09:50:14 ERROR - PROCESS | 1663 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:50:15 INFO - TEST-INFO | 1663: exit 0 09:50:15 INFO - Browser initialized. 09:50:15 INFO - Running cycle 1/1 for dromaeo_css test... 09:50:15 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmpXJE3Vq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:50:27 INFO - PROCESS | 1667 | RSS: Main: 160329728 09:50:27 INFO - PROCESS | 1667 | 09:51:18 INFO - PROCESS | 1667 | 1469206278635 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] 09:53:28 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 09:53:29 INFO - PROCESS | 1667 | RSS: Main: 308658176 09:53:29 INFO - PROCESS | 1667 | 09:56:32 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 09:56:33 INFO - PROCESS | 1667 | RSS: Main: 302014464 09:56:33 INFO - PROCESS | 1667 | 09:59:35 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 09:59:36 INFO - PROCESS | 1667 | RSS: Main: 307200000 09:59:36 INFO - PROCESS | 1667 | 10:02:38 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 10:02:38 INFO - PROCESS | 1667 | RSS: Main: 297234432 10:02:38 INFO - PROCESS | 1667 | 10:05:41 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 10:05:42 INFO - PROCESS | 1667 | RSS: Main: 264642560 10:05:42 INFO - PROCESS | 1667 | 10:08:45 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 10:08:45 INFO - PROCESS | 1667 | RSS: Main: 309415936 10:08:45 INFO - PROCESS | 1667 | 10:08:45 INFO - PROCESS | 1667 | __start_tp_report 10:08:45 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 10:08:45 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 10:08:45 INFO - PROCESS | 1667 | |i|pagename|runs| 10:08:45 INFO - PROCESS | 1667 | |0;dojo.html;3418;3499.2065347706907;3524.1189702574366;3548.609652938178;3611.9819400902993;5745.052066409037;5765.913511297329;5770.422957704228;5816.272965879265;5821.767129314828;5764.711764411783;5770.134479828017;5772.624779389337;5781.364049954502;5784.074548072309;5191.221316802482;5272.947270527303;5282.23407605897;5294.7617357219015;5356.1697936819855;5326.547243484309;5358.892822143554;5371.973140134294;5374.516293533581;5375.139977603584;5285.6300058995885;5331.120365139747;5367.1680889462195;5371.81198658047;5381.865453363658;4562.338460923164;5324.707141107277;5379.784808607651;5398.460153984609;5403.405625381205;5141.460146684619;5186.896262074775;5218.452062533417;5293.788248470057;5299.205119232108;5645.689487078209;5686.5735069869925;5700.828975130753;5712.371639119693;5725.914111288334;6282.591631543935;6323.051542268697;6332;6349.301576826545;6358.586691865014;6142.846428839315;6204;6291.276503202144;6292.1820163378925;6303.747850085991;5974.312954010257;5988.461038506468;5991.58058935879;6013.639181649115;6036.6076205046975;6372;6372.522060845455;6374.298827129012;6383.616982981036;6383.904241436382;6065.2901257037465;6129.297663865929;6247.500199983991;6259.092431597484;6259.405356491126;6289;6300.59046161998;6305;6305.464035556937;6326.4622507087415;6257;6292.937070629327;6299.496040316763;6299.811005669837;6339.207599050119;6169.5064394848305;6281.937180628135;6287.9056814147825;6301.117843501914;6306.810795676137;4974.228994505857;5044.798208071709;5045.041442125985;5050.6464547482055;5057.595392368602;4515.729056256635;4540.568645978627;4544.045750392388;4575.176468235683;4579.22153233951;4819.7108173509705;5880.206172166788;5888.146218798251;5909.793157239562;5926.7925622603;6252.624842509464;6294.276158241861;6299.338569450233;6302.401271879165;6322.778702745381;5931.347551769302;5948;5968;5972.402759723993;6008.849778755566;5409.2967914171695;5443.945560544423;5477.917831232535;5527.723613819373;5537.889242215133;6408.58344207625;6474.546781725234;6485.5460117792245;6496.512761542808;6502.089707440962;6276.717547710273;6296.779612713533;6301.243850737941;6302.65335406557;6314.400131987454;6356.745730170742;6375.139356187041;6404.391582799627;6437.581557198767;6469.676516174267;5515.283013208257;5811.331696854916;6272.686365681607;6290.748370065329;6318.652474113968;6255.906161407492;6265.4361107500545;6293.465055470153;6301.747930082929;6304.873902522016;6102.0541816018585;6139.140520327069;6141.170941922784;6199.535034872312;6245.500359971283;6221.3156552780065;6227.439530442282;6232.563720539519;6239.719212635533;6242.188515492957;6114.38856114385;6119.388061194023;6127.20346354971;6129.877402452015;6140.416660417253;6054.576179667381;6073.99779036454;6112.685862051747;6147.66187859672;6169.96915015422;6064.363241859718;6105.239096190078;6145.600535965148;6146.6004709693725;6149.508039356931 10:08:45 INFO - PROCESS | 1667 | |1;ext.html;502.65819242914813;518.2537146509025;551.3346332279971;618.5299172628801;644.3041515163624;31858.681413185863;32414.513782293256;32432.351352972986;32458.837705811467;32581;39643;40269.59730402695;40322.79838600803;40429.79785101078;40489.98775030626;9673.032696730306;9848.901510984906;9849.212063034976;9876.802463950717;9904.50477476127;7929.682812687485;9596.712098637052;9721.416714997087;9725.51372431379;11818.822717659243;11698;11763.35301558414;11777.057835373149;11790.997765189926;11808.527658893634;10404.11565016967;11673.949344558989;11828.23116497425;11859.822102668468;11862.406879655982;11299.604513842058;11456.083513318914;11571.53713851445;11715.472803723853;11732.882671173349;39147;39583;39615;41859.79070104661;42054.52809151665;3354.5639066921144;3392.1289147563093;3408.7102596279346;3410.897673069812;3474.2877710069374;28161.859190703915;28497.86008559676;29462.26344341387;30134;30514.931977380907;2796.6923638399758;2801.9159425217276;2826.660800703908;2892.8264304141817;2906.302487403008;354838;355131;355237;355475;355586;36646.450303245474;37144.628553714654;37154.25691486155;61192.77614447686;62211;35539.75610853608;35702.92891213268;35743.4638480423;35808.64191358105;35851.4622280666;16345.591360216089;16521.586960325847;16526.421575244807;16533.83466165323;16538.25577849;13545.864541354658;13557.983151263694;13598.86401135976;13607.115537490032;13613.047086703835;7963.323117534958;8011.118776934532;8250.257476827115;8338.62476188573;8415.579221039046;3489.2498112905846;3529.7176225901867;3537.734669899716;3543.078799512094;3580.9820950895078;1014.5333146752577;1088.4992903264588;1091.014353875954;1164.941752912368;1198.7842188405996;30650.846745766128;30663.38673226523;30803.69196308053;30823.029848882226;31076.22309442282;1031.7523794289316;1162.7790719763218;1203.1337437045488;1206.2641788509002;1217.762536305412;14123.152610843383;15929.681406371808;16077.919610402107;16453;16554.503364899072;653883;654732;656595;657308.1403778947;659354;63131.368686313464;63845;63902.680486597266;63985;63999;1337.3714354253486;1476.350405821435;1526.4428483603406;1570.387548855947;1637.9426720064741;23987.040518379068;27111.59332609973;28425.857870710515;28750.712492875642;28916.566251505825;49666.751666241435;49818.75090624524;50421.24368134554;50477;50703;432715;433962;434781.8260908675;435158;436205.8189709031;23505.529889401772;26152.73847261503;26568.202953911412;26920;26923.326916827235;39312;42328.57671423246;44408.77795611001;47062.76468617635;48752;35464.46803298004;36615.816920915226;36688.26623467462;36877;37494.812525937195;35589.64410355863;35745.64254357527;36236.63763362333;36511.634883650826;36581.08547286339;35285.47071793977;35742.821285893406;36244.637553624125;36812;36822.631773682995;31628.734850605717;32206.67793322037;32688;32728;33435.83282083574;25101.623475648244;25146.868390922085;25148.49703005966;25198.17103608002;25343.746562534878 10:08:45 INFO - PROCESS | 1667 | |2;jquery.html;415.9064210552624;416.14066951744644;419.1240307756789;421.22074162798845;429.7550396274123;15290.46483373082;20106;20763.44274179437;20788.480287992807;20956.952152392358;20516.384508464733;20781.688274675893;21955.341339759794;21955.67066494004;21992.34022979313;5012.373453318335;5876.08920617305;6060.2121724175795;6063.575549711522;6071.878562428748;5975.133605627181;6044.123602077696;6075.939240607581;6080.753445543675;6088.512918966472;4398.164348773738;4440.533743956887;6320.810375688737;6628.701708423133;6630.867382652368;6382.968085159591;6642.800715978528;6665.5334126610915;6665.866682666319;6701.932980670204;5827.737751801179;5855;5861.794837180678;5865.472107510344;5867.11993201019;25298.608576528284;26488.337791555172;26864.865675671495;27689.169324920284;27691.584626230622;2206.7131272934575;2240.5182885679656;2377.4413012941945;2462.679851619278;2759.6412466379443;9755;10020.849687254697;10344.586216551328;10381.584736610526;10658.520366583522;1645.8025036995518;1763.8059813420514;1776.2184638758904;1794.0850166415091;1824.9178786954485;97142;116276.25585616223;118218.40890795492;119066;123020;11701.590444334408;11957.222780519412;11996.520139194508;12023.63929082129;12076.335801531;13249.403776830066;14170.64573385653;14562.563123106323;14956.775648365283;15815.762763558556;9188.081191880892;9211.769705757275;9282.118198771106;9286.489243091559;9360.812783744286;9437.716868493957;9443.244540436748;9463.668771592962;9481.90518094824;9500.95249523748;4736.976315118402;4790.257510085942;4793;4807.278908163734;4869.586085182728;2037.327681864981;2041.47942274719;2051.548659294953;2066.8036536529007;2094.6124966881175;901.6618767962015;970.5341436110706;994.8259054665405;998.5706146357136;1018.6791160784329;20712;21070.841103739134;21125.68311475329;21270.893645531673;21272.78727212708;963.9518024098767;966.1497881863914;997.1574019953129;999.8501723018442;1002.9197664186847;9213.81572368549;11147.498362573542;11160.441977901073;11171.888281117248;11196.38419886914;629820;642426;650887;656548;657907;132738.33630831784;133776;135034.32482837522;135320.1743860489;140564;1048.2400259811575;1053.210092430677;1057.1595581512715;1069.4332004037872;1070.9143268538498;16231.918840405722;17017;18119.45641630753;18776.624467510846;18910;51669;53367;53790.46209537855;53939.190912135564;56157.71921140368;77840;78937;79555;79868.2013179884;80942.59528702318;6618.503612229199;8241.95879020601;8432.25623723605;8436.198561136682;8525.872111918203;9270.490123043297;12004.339761313211;12589.93705031469;12899.806502902651;12974.416151273404;10953.56185752561;10958.12335013213;11237.60668376603;11356.432178391213;11540.653780386601;10973.177011724312;11027.393493357942;11101.500432480396;11301.434928253719;11303.265287756269;10943.179261555257;11332.206745527734;11347.886521135013;11592;11718.824217636571;8260.554402979575;8342.916570834213;8370.246677799027;8532.530710810717;8725.21473067427;9786.31495795316;11218.66344009681;11269.985701286923;11551.306921584395;11563.42182890869 10:08:45 INFO - PROCESS | 1667 | |3;mootools.html;1513.833478317384;1633.7222672145733;1661.260738971158;1939.9903000484996;2016.6676635364956;8386.203310685483;9025;9177.63289468422;9182.449053056822;9204.171624553788;8881.378303518757;9164.679236226733;9169.862452063207;9171.495567743772;9190.724278271662;2554.910578129766;2574.3049376668287;2580;2582.3415029167536;2590.7538783815507;2501;2562.500312439075;2575.4591535777417;2575.8068144889116;2586.4439145583697;2531.7847982921476;2556.6037264223983;2583.1346498922885;2585.3278147681644;2587.2884956636885;2540.9110681126162;2549.1715192562397;2572.421205228818;2585.379508917846;2592.896284148632;2526.280010197085;2559.104313490282;2573.6654234949337;2573.974260257411;2574.3178057814694;8942.195202431813;9270.675526356545;9313.394629349139;9333.813323733555;9340.71977840666;5657.4908258256955;5733.856653583652;5806.2451881255165;5823;5826.1552074948895;3661.139632186434;3771.0949372150762;3788.3749181385037;3823.254465379252;3840.3663395539984;1010.3836659637615;1032.4270030133273;1056.2447849787438;1079.8596182496303;1107.0866535108487;12309.753804923941;12395.132340736061;12402.56591019319;12403.379831008504;12413.813792793115;4757.738324392122;4831.637627177905;4844.539768721966;4895.31465594817;4906.705597664151;9684.273679474067;9686.32195746291;9692.46691431978;9728.173105285989;9760.658376956773;5532.28080349552;5603.691796951207;5637.295338082739;5640.153976903497;5678.886422271531;4075.5313138988804;4691.976540117277;5090.898182036339;5177.145770947826;5209.348831396075;4042.919141617151;4130.979345103256;4178.603032711888;4187.790610469464;4198.895027624334;1260.2627462934286;1274.1017582604243;1278.2522224498773;1290.9741805163844;1292.3344477594046;915.8214148241029;939.3612343606277;950.5674917912334;974.1232890398556;1009.0464511037;5974.731137098841;5997.580169388189;6101.176341193882;6133.202683651097;6220.968895155585;470.5929371094048;485.5144855144855;487.8609596265047;495.68276303166004;499.8325560937054;3968.8015599219925;4033.69747268956;4075.1645912587846;4111.835526578963;4134.276501612266;8761.430507017023;11093.5562577496;11311.981921627093;11443.771124577628;11460.426978651034;10678.786424271471;10753.946230268799;10890.673279801618;10926.125909927187;10942.45287735626;8594.183552562621;8602.483850968962;8740.470417676881;8767.868481972775;8787.956060219785;5978.222831031938;6031.815296731154;6058.90911636317;6064.727087280995;6126.754929802758;9965.850512242467;10180.389176649425;10201.081902628799;10214.744631384276;10221.488925553842;9673.516324183622;10105.696829095139;10130.696079117639;10291.485425728833;10374;7173.282671732994;7357.742479013209;7363.595002274927;7844.882326764989;8030;8004.119546849958;8381.916180838358;8557.44376615518;8558.614862331086;8561.272291855263;7404.666789994355;7594;7654.15804261542;7654.655540500802;7661.655225514976;7486.401087912845;7493.812654683677;7520.548767073993;7613.352865006536;7686.116096648957;7096.645167741695;7143.785686429415;7151.570905745672;7186.209516953027;7188.101487314086;4913.410390753133;4956.900861982812;5007.899842003067;5077.8730531737;5110.105731497048;5063.620228482952;5145.125328694056;5167.741612919263;5306.628536002443;5320.494553017457 10:08:45 INFO - PROCESS | 1667 | |4;prototype.html;318.60652094663095;333.7580254315623;339.14535370865434;340.77679120176293;347.90084825824647;6747.257801641822;6760.932390676098;6771.255161932189;6847.897281540781;6897.862042759142;6650.401463868251;6661.034150048252;6669.399754022137;6702.162229721285;6724;4769.809207631691;4872.488388719186;4912.975435122819;4955.776990035457;4973.129702302101;4918.434380046287;4973.229149481836;4980.651354405193;4998.5501304882555;4999.675021123633;4009.779462129596;4899;4903.779329930144;4911.386076740408;4986.227134794112;4727.621790256771;4855.247436647308;4857.975710121462;4914.189158788796;4917.139500587383;3454.5681789776277;4100.384942258655;4205.411242426063;4207.978960105211;4216.3464662976985;6403.423691867708;6433.420992110732;6452.709628066748;6457.999010153434;6461.160049193575;5868.794592189253;5885.234919460443;5889.411058894119;5898.351181370046;5907.852303692399;6881;7119.252478489788;7131.500794944356;7134.17956934954;7154.713811447536;4666.766661666903;4680.204365257914;4690.413698287714;4694.929576056362;4723.881902952419;7528.058992625922;7615.16233214346;7627.389808815282;7628.160902300742;7630.198829122974;4770.689905156154;4777.283407488835;4782.282657601318;4784.138855006132;4793.32893394925;4836.46798852126;4836.830710925101;4840.394950631171;4852.296417019583;4860.902781944412;5576.386597474275;5822.82531524055;5839.0949402842625;5852.531797456193;5865.20819689345;7200.351968322771;7205.495615306983;7244.782656520313;7258.491905566665;7284.854302913912;1658.797371905359;1688;1689.1300979995312;1689.5015970288794;1692.2638652186338;1054.5623566219933;1059.5391004912888;1077.245927850492;1079.4494807648;1083.496174278964;6610.338966103447;6650.667466626649;6778.084958530535;6782.626955517494;6797.5581587196675;7478.85042299151;7486;7498.6625601848045;7499.8500029999095;7594.81012974669;6821.420179284816;6837.076994605664;6844.178698556205;6854;6859.759908403182;2969.3170570768843;3633.2733453309443;4006.759594424344;4010.057636455431;4013.337799263089;7566.167721550625;7889.842203156019;7928.008998875141;7954.125046244909;7986.4825683120025;7758.379329653614;7803.648835802403;7804.609769511501;7829.843403131906;7830.6084695764985;7914.485558438683;7916.564588947548;7920.168382320004;7925.247101525346;7939.603019848984;7530.849383012419;7560.773176804704;7576.545407275581;7580.886286705593;7593.278638529331;7076.681549330189;7346.37555807741;7371.8157046074275;7404.444666649915;7436.814079647836;7852.921470785219;7871.212878712083;7872.291493765589;7917.327027202522;7918.326942209977;4719.693219940693;4783.832565860178;4785.59322457581;4795.20879054952;4801.351817504592;6855.313476115788;7507.399408047234;7530.924690753022;7537.434692397982;7543.698252069856;5436.266104076058;7094.964525177341;7218.097737782778;7240.493165478366;7269.890951635624;7161.57030578167;7236.710531578889;7238.710451581877;7248.782536523912;7252.129744430702;7074.151101867808;7089.645517724196;7091.893621595577;7094.53885497441;7111.964440177766;6965.373116419547;7246.376811594203;7247.528910620793;7252.963735181502;7274.054372931485;6826.658667066527;7044.119485064367;7095.113110861143;7095.46783991213;7129.144502659714 10:08:45 INFO - PROCESS | 1667 | |5;yui.html;721.1994685898652;766.7316439246262;781.5076501803866;783.2872086401376;817.989782618466;14761.704765904675;14831.332590033448;14976.700465990687;14977.775333370008;15018.39926402944;14209.928950355234;14382.856171438283;14421.927890360534;14426.855731442682;14442.133471991689;776.2509178642608;791.1613689489132;940.6472572785206;956.650822449806;988.6836212412031;985.5515740338165;987.1017374189489;987.1806400687412;988.6391467114487;993.0813997052734;1043.0925095167177;1043.7025447747394;1044.9007344302318;1045.0124632222514;1049.1921220660088;832.4838600067936;849.362977766675;852.8251708399763;854.6325080215505;1035.3891204189526;753.2806170107534;773.8916551682769;774.3572834547313;775.0892701076212;775.317720406039;15294.158821264826;15378.3079761411;15384.461543845911;15393.999390039611;15456.459023934109;11853.348065856375;11991.700207494796;12010.69973250667;12066.638000859988;12101.152919295653;10159.187265018782;10199.133073688745;10391.584336626525;10588.576456941713;10685.41230232337;3552.378333791576;3576.2311103112697;3622.2936527377174;3663.19409729859;3832.540095188567;78023.60988195079;79225.60387198027;83725.58137209337;85223.72164417538;85375;10098.747531311628;10166.745831354276;10289.742756431;10306.948465257627;10454.581816727397;19651.803481965282;23538.411539711644;23545.764542354358;23565;23657.408564785674;7532.887006694904;7688;7746.18665040174;7783.143854176036;7922.445428820042;4184.163167366539;4217.852375166915;4241.724287921275;4291.356296555542;4377.8248870044845;3751.437284407361;3791.9951212928595;3809.3904975203836;3812.752171108869;3821.2357528494413;698.2110215456603;698.9615571143636;706.720845266117;714.9347472266389;721.7365661533503;590.9245173783672;607.9483243924227;610.2250142319318;634.8412896775806;650.3528988656317;7793.883091753628;8125.918740812516;8288.21261980111;8390.83218335642;8622.051574326819;531.2774626507946;589.286962775047;593.87231745175;597.8580910460998;630.6594439002979;3002.549617557384;3254.316593515341;3797.4873392091713;3839.4816699745734;3940.5271367435516;95097;96281;98330;98601;98717.01282987221;75549;76189;76642.6167869157;77277;78797.60601197073;67779.66110169418;68622.28444288833;68787.65606171938;69655.30344696589;71237.28762712306;7633.70227061412;8410.87383689233;8526.78683032929;8593.484390936565;8691.782705432415;38101.809490952364;47429;47616.57150285497;48003;48038.75980620214;60023.39976600353;61602.69198654158;62941;67586;68494.31505684879;11091.223614346918;11459.828102578635;11476.885231147915;11559.190856639954;11969.281843089442;11977.341246231541;12139.817902731289;12274.877251227374;12344.321062341298;12441.688957775767;11294.265872718248;11680.123990700902;11768.823467648162;11926.582569610022;11980.64058078259;11649.359285239394;11680.415979201176;11894;11946.283223006647;11954.880451195377;9164.770880728036;11419.60031398897;11588.768224635629;11600.245984011011;11720.355380454157;10062.647807326708;10093.949530252301;10218.489075546044;10315.845262320921;10397;9796.804063918538;10047.250687826434;10065.949670251603;10103.472291314238;10143.543540540546 10:08:45 INFO - PROCESS | 1667 | __end_tp_report 10:08:45 INFO - PROCESS | 1667 | __start_cc_report 10:08:45 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1371 10:08:45 INFO - PROCESS | 1667 | __end_cc_report 10:08:45 INFO - PROCESS | 1667 | __startTimestamp1469207325355__endTimestamp 10:08:45 INFO - PROCESS | 1667 | 10:08:45 INFO - PROCESS | 1667 | ------- Summary: start ------- 10:08:45 INFO - PROCESS | 1667 | Number of tests: 6 10:08:45 INFO - PROCESS | 1667 | 10:08:45 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5833.23 Median:6105.24 stddev:634.65 (10.4%) stddev-sans-first:607.65 10:08:45 INFO - PROCESS | 1667 | Values: 3418.0 3499.2 3524.1 3548.6 3612.0 5745.1 5765.9 5770.4 5816.3 5821.8 5764.7 5770.1 5772.6 5781.4 5784.1 5191.2 5272.9 5282.2 5294.8 5356.2 5326.5 5358.9 5372.0 5374.5 5375.1 5285.6 5331.1 5367.2 5371.8 5381.9 4562.3 5324.7 5379.8 5398.5 5403.4 5141.5 5186.9 5218.5 5293.8 5299.2 5645.7 5686.6 5700.8 5712.4 5725.9 6282.6 6323.1 6332.0 6349.3 6358.6 6142.8 6204.0 6291.3 6292.2 6303.7 5974.3 5988.5 5991.6 6013.6 6036.6 6372.0 6372.5 6374.3 6383.6 6383.9 6065.3 6129.3 6247.5 6259.1 6259.4 6289.0 6300.6 6305.0 6305.5 6326.5 6257.0 6292.9 6299.5 6299.8 6339.2 6169.5 6281.9 6287.9 6301.1 6306.8 4974.2 5044.8 5045.0 5050.6 5057.6 4515.7 4540.6 4544.0 4575.2 4579.2 4819.7 5880.2 5888.1 5909.8 5926.8 6252.6 6294.3 6299.3 6302.4 6322.8 5931.3 5948.0 5968.0 5972.4 6008.8 5409.3 5443.9 5477.9 5527.7 5537.9 6408.6 6474.5 6485.5 6496.5 6502.1 6276.7 6296.8 6301.2 6302.7 6314.4 6356.7 6375.1 6404.4 6437.6 6469.7 5515.3 5811.3 6272.7 6290.7 6318.7 6255.9 6265.4 6293.5 6301.7 6304.9 6102.1 6139.1 6141.2 6199.5 6245.5 6221.3 6227.4 6232.6 6239.7 6242.2 6114.4 6119.4 6127.2 6129.9 6140.4 6054.6 6074.0 6112.7 6147.7 6170.0 6064.4 6105.2 6145.6 6146.6 6149.5 10:08:45 INFO - PROCESS | 1667 | 10:08:45 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:61198.45 Median:3481.77 stddev:133481.02 (3833.7%) stddev-sans-first:133777.67 10:08:45 INFO - PROCESS | 1667 | Values: 502.7 518.3 551.3 618.5 644.3 31858.7 32414.5 32432.4 32458.8 32581.0 39643.0 40269.6 40322.8 40429.8 40490.0 9673.0 9848.9 9849.2 9876.8 9904.5 7929.7 9596.7 9721.4 9725.5 11818.8 11698.0 11763.4 11777.1 11791.0 11808.5 10404.1 11673.9 11828.2 11859.8 11862.4 11299.6 11456.1 11571.5 11715.5 11732.9 39147.0 39583.0 39615.0 41859.8 42054.5 3354.6 3392.1 3408.7 3410.9 3474.3 28161.9 28497.9 29462.3 30134.0 30514.9 2796.7 2801.9 2826.7 2892.8 2906.3 354838.0 355131.0 355237.0 355475.0 355586.0 36646.5 37144.6 37154.3 61192.8 62211.0 35539.8 35702.9 35743.5 35808.6 35851.5 16345.6 16521.6 16526.4 16533.8 16538.3 13545.9 13558.0 13598.9 13607.1 13613.0 7963.3 8011.1 8250.3 8338.6 8415.6 3489.2 3529.7 3537.7 3543.1 3581.0 1014.5 1088.5 1091.0 1164.9 1198.8 30650.8 30663.4 30803.7 30823.0 31076.2 1031.8 1162.8 1203.1 1206.3 1217.8 14123.2 15929.7 16077.9 16453.0 16554.5 653883.0 654732.0 656595.0 657308.1 659354.0 63131.4 63845.0 63902.7 63985.0 63999.0 1337.4 1476.4 1526.4 1570.4 1637.9 23987.0 27111.6 28425.9 28750.7 28916.6 49666.8 49818.8 50421.2 50477.0 50703.0 432715.0 433962.0 434781.8 435158.0 436205.8 23505.5 26152.7 26568.2 26920.0 26923.3 39312.0 42328.6 44408.8 47062.8 48752.0 35464.5 36615.8 36688.3 36877.0 37494.8 35589.6 35745.6 36236.6 36511.6 36581.1 35285.5 35742.8 36244.6 36812.0 36822.6 31628.7 32206.7 32688.0 32728.0 33435.8 25101.6 25146.9 25148.5 25198.2 25343.7 10:08:45 INFO - PROCESS | 1667 | 10:08:45 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:36713.53 Median:13880.64 stddev:107766.71 (776.4%) stddev-sans-first:108034.56 10:08:45 INFO - PROCESS | 1667 | Values: 415.9 416.1 419.1 421.2 429.8 15290.5 20106.0 20763.4 20788.5 20957.0 20516.4 20781.7 21955.3 21955.7 21992.3 5012.4 5876.1 6060.2 6063.6 6071.9 5975.1 6044.1 6075.9 6080.8 6088.5 4398.2 4440.5 6320.8 6628.7 6630.9 6383.0 6642.8 6665.5 6665.9 6701.9 5827.7 5855.0 5861.8 5865.5 5867.1 25298.6 26488.3 26864.9 27689.2 27691.6 2206.7 2240.5 2377.4 2462.7 2759.6 9755.0 10020.8 10344.6 10381.6 10658.5 1645.8 1763.8 1776.2 1794.1 1824.9 97142.0 116276.3 118218.4 119066.0 123020.0 11701.6 11957.2 11996.5 12023.6 12076.3 13249.4 14170.6 14562.6 14956.8 15815.8 9188.1 9211.8 9282.1 9286.5 9360.8 9437.7 9443.2 9463.7 9481.9 9501.0 4737.0 4790.3 4793.0 4807.3 4869.6 2037.3 2041.5 2051.5 2066.8 2094.6 901.7 970.5 994.8 998.6 1018.7 20712.0 21070.8 21125.7 21270.9 21272.8 964.0 966.1 997.2 999.9 1002.9 9213.8 11147.5 11160.4 11171.9 11196.4 629820.0 642426.0 650887.0 656548.0 657907.0 132738.3 133776.0 135034.3 135320.2 140564.0 1048.2 1053.2 1057.2 1069.4 1070.9 16231.9 17017.0 18119.5 18776.6 18910.0 51669.0 53367.0 53790.5 53939.2 56157.7 77840.0 78937.0 79555.0 79868.2 80942.6 6618.5 8242.0 8432.3 8436.2 8525.9 9270.5 12004.3 12589.9 12899.8 12974.4 10953.6 10958.1 11237.6 11356.4 11540.7 10973.2 11027.4 11101.5 11301.4 11303.3 10943.2 11332.2 11347.9 11592.0 11718.8 8260.6 8342.9 8370.2 8532.5 8725.2 9786.3 11218.7 11270.0 11551.3 11563.4 10:08:45 INFO - PROCESS | 1667 | 10:08:45 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:5892.73 Median:2728.37 stddev:3273.95 (120.0%) stddev-sans-first:3266.59 10:08:45 INFO - PROCESS | 1667 | Values: 1513.8 1633.7 1661.3 1940.0 2016.7 8386.2 9025.0 9177.6 9182.4 9204.2 8881.4 9164.7 9169.9 9171.5 9190.7 2554.9 2574.3 2580.0 2582.3 2590.8 2501.0 2562.5 2575.5 2575.8 2586.4 2531.8 2556.6 2583.1 2585.3 2587.3 2540.9 2549.2 2572.4 2585.4 2592.9 2526.3 2559.1 2573.7 2574.0 2574.3 8942.2 9270.7 9313.4 9333.8 9340.7 5657.5 5733.9 5806.2 5823.0 5826.2 3661.1 3771.1 3788.4 3823.3 3840.4 1010.4 1032.4 1056.2 1079.9 1107.1 12309.8 12395.1 12402.6 12403.4 12413.8 4757.7 4831.6 4844.5 4895.3 4906.7 9684.3 9686.3 9692.5 9728.2 9760.7 5532.3 5603.7 5637.3 5640.2 5678.9 4075.5 4692.0 5090.9 5177.1 5209.3 4042.9 4131.0 4178.6 4187.8 4198.9 1260.3 1274.1 1278.3 1291.0 1292.3 915.8 939.4 950.6 974.1 1009.0 5974.7 5997.6 6101.2 6133.2 6221.0 470.6 485.5 487.9 495.7 499.8 3968.8 4033.7 4075.2 4111.8 4134.3 8761.4 11093.6 11312.0 11443.8 11460.4 10678.8 10753.9 10890.7 10926.1 10942.5 8594.2 8602.5 8740.5 8767.9 8788.0 5978.2 6031.8 6058.9 6064.7 6126.8 9965.9 10180.4 10201.1 10214.7 10221.5 9673.5 10105.7 10130.7 10291.5 10374.0 7173.3 7357.7 7363.6 7844.9 8030.0 8004.1 8381.9 8557.4 8558.6 8561.3 7404.7 7594.0 7654.2 7654.7 7661.7 7486.4 7493.8 7520.5 7613.4 7686.1 7096.6 7143.8 7151.6 7186.2 7188.1 4913.4 4956.9 5007.9 5077.9 5110.1 5063.6 5145.1 5167.7 5306.6 5320.5 10:08:45 INFO - PROCESS | 1667 | 10:08:45 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:5922.54 Median:6774.67 stddev:1922.81 (28.4%) stddev-sans-first:1881.63 10:08:45 INFO - PROCESS | 1667 | Values: 318.6 333.8 339.1 340.8 347.9 6747.3 6760.9 6771.3 6847.9 6897.9 6650.4 6661.0 6669.4 6702.2 6724.0 4769.8 4872.5 4913.0 4955.8 4973.1 4918.4 4973.2 4980.7 4998.6 4999.7 4009.8 4899.0 4903.8 4911.4 4986.2 4727.6 4855.2 4858.0 4914.2 4917.1 3454.6 4100.4 4205.4 4208.0 4216.3 6403.4 6433.4 6452.7 6458.0 6461.2 5868.8 5885.2 5889.4 5898.4 5907.9 6881.0 7119.3 7131.5 7134.2 7154.7 4666.8 4680.2 4690.4 4694.9 4723.9 7528.1 7615.2 7627.4 7628.2 7630.2 4770.7 4777.3 4782.3 4784.1 4793.3 4836.5 4836.8 4840.4 4852.3 4860.9 5576.4 5822.8 5839.1 5852.5 5865.2 7200.4 7205.5 7244.8 7258.5 7284.9 1658.8 1688.0 1689.1 1689.5 1692.3 1054.6 1059.5 1077.2 1079.4 1083.5 6610.3 6650.7 6778.1 6782.6 6797.6 7478.9 7486.0 7498.7 7499.9 7594.8 6821.4 6837.1 6844.2 6854.0 6859.8 2969.3 3633.3 4006.8 4010.1 4013.3 7566.2 7889.8 7928.0 7954.1 7986.5 7758.4 7803.6 7804.6 7829.8 7830.6 7914.5 7916.6 7920.2 7925.2 7939.6 7530.8 7560.8 7576.5 7580.9 7593.3 7076.7 7346.4 7371.8 7404.4 7436.8 7852.9 7871.2 7872.3 7917.3 7918.3 4719.7 4783.8 4785.6 4795.2 4801.4 6855.3 7507.4 7530.9 7537.4 7543.7 5436.3 7095.0 7218.1 7240.5 7269.9 7161.6 7236.7 7238.7 7248.8 7252.1 7074.2 7089.6 7091.9 7094.5 7112.0 6965.4 7246.4 7247.5 7253.0 7274.1 6826.7 7044.1 7095.1 7095.5 7129.1 10:08:45 INFO - PROCESS | 1667 | 10:08:45 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:18374.33 Median:4201.01 stddev:25764.28 (613.3%) stddev-sans-first:25802.46 10:08:45 INFO - PROCESS | 1667 | Values: 721.2 766.7 781.5 783.3 818.0 14761.7 14831.3 14976.7 14977.8 15018.4 14209.9 14382.9 14421.9 14426.9 14442.1 776.3 791.2 940.6 956.7 988.7 985.6 987.1 987.2 988.6 993.1 1043.1 1043.7 1044.9 1045.0 1049.2 832.5 849.4 852.8 854.6 1035.4 753.3 773.9 774.4 775.1 775.3 15294.2 15378.3 15384.5 15394.0 15456.5 11853.3 11991.7 12010.7 12066.6 12101.2 10159.2 10199.1 10391.6 10588.6 10685.4 3552.4 3576.2 3622.3 3663.2 3832.5 78023.6 79225.6 83725.6 85223.7 85375.0 10098.7 10166.7 10289.7 10306.9 10454.6 19651.8 23538.4 23545.8 23565.0 23657.4 7532.9 7688.0 7746.2 7783.1 7922.4 4184.2 4217.9 4241.7 4291.4 4377.8 3751.4 3792.0 3809.4 3812.8 3821.2 698.2 699.0 706.7 714.9 721.7 590.9 607.9 610.2 634.8 650.4 7793.9 8125.9 8288.2 8390.8 8622.1 531.3 589.3 593.9 597.9 630.7 3002.5 3254.3 3797.5 3839.5 3940.5 95097.0 96281.0 98330.0 98601.0 98717.0 75549.0 76189.0 76642.6 77277.0 78797.6 67779.7 68622.3 68787.7 69655.3 71237.3 7633.7 8410.9 8526.8 8593.5 8691.8 38101.8 47429.0 47616.6 48003.0 48038.8 60023.4 61602.7 62941.0 67586.0 68494.3 11091.2 11459.8 11476.9 11559.2 11969.3 11977.3 12139.8 12274.9 12344.3 12441.7 11294.3 11680.1 11768.8 11926.6 11980.6 11649.4 11680.4 11894.0 11946.3 11954.9 9164.8 11419.6 11588.8 11600.2 11720.4 10062.6 10093.9 10218.5 10315.8 10397.0 9796.8 10047.3 10065.9 10103.5 10143.5 10:08:45 INFO - PROCESS | 1667 | -------- Summary: end -------- 10:08:45 INFO - PROCESS | 1667 | 10:08:45 INFO - TEST-INFO | 1667: exit 0 10:08:45 INFO - TEST-OK | dromaeo_css | took 1113527ms 10:08:45 INFO - TEST-START | kraken 10:08:45 INFO - operating with platform_type : mac_ 10:08:45 INFO - Initialising browser for kraken test... 10:08:45 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmp_ywaLY/profile http://localhost:49271/getInfo.html) 10:08:48 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 10:08:48 INFO - PROCESS | 1673 | colorDepth:24 10:08:48 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 10:08:48 INFO - PROCESS | 1673 | __metrics 10:08:48 INFO - PROCESS | 1673 | 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" 10:08:48 ERROR - PROCESS | 1673 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:08:48 INFO - TEST-INFO | 1673: exit 0 10:08:48 INFO - Browser initialized. 10:08:48 INFO - Running cycle 1/1 for kraken test... 10:08:48 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmp_ywaLY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:09:00 INFO - PROCESS | 1676 | RSS: Main: 160284672 10:09:00 INFO - PROCESS | 1676 | 10:09:03 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 10:09:04 INFO - PROCESS | 1676 | RSS: Main: 223805440 10:09:04 INFO - PROCESS | 1676 | 10:09:06 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 10:09:07 INFO - PROCESS | 1676 | RSS: Main: 239607808 10:09:07 INFO - PROCESS | 1676 | 10:09:10 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 10:09:11 INFO - PROCESS | 1676 | RSS: Main: 324980736 10:09:11 INFO - PROCESS | 1676 | 10:09:13 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 10:09:13 INFO - PROCESS | 1676 | RSS: Main: 231092224 10:09:13 INFO - PROCESS | 1676 | 10:09:15 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:09:16 INFO - PROCESS | 1676 | RSS: Main: 232071168 10:09:16 INFO - PROCESS | 1676 | 10:09:19 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 10:09:19 INFO - PROCESS | 1676 | RSS: Main: 270823424 10:09:19 INFO - PROCESS | 1676 | 10:09:22 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 10:09:23 INFO - PROCESS | 1676 | RSS: Main: 271134720 10:09:23 INFO - PROCESS | 1676 | 10:09:26 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 10:09:26 INFO - PROCESS | 1676 | RSS: Main: 269049856 10:09:26 INFO - PROCESS | 1676 | 10:09:28 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:09:28 INFO - PROCESS | 1676 | RSS: Main: 261373952 10:09:28 INFO - PROCESS | 1676 | 10:09:30 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:09:31 INFO - PROCESS | 1676 | RSS: Main: 267747328 10:09:31 INFO - PROCESS | 1676 | 10:09:33 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:09:34 INFO - PROCESS | 1676 | RSS: Main: 271630336 10:09:34 INFO - PROCESS | 1676 | 10:09:36 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:09:37 INFO - PROCESS | 1676 | RSS: Main: 278528000 10:09:37 INFO - PROCESS | 1676 | 10:09:40 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:09:40 INFO - PROCESS | 1676 | RSS: Main: 275775488 10:09:40 INFO - PROCESS | 1676 | 10:09:42 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 10:09:42 INFO - PROCESS | 1676 | RSS: Main: 336699392 10:09:42 INFO - PROCESS | 1676 | 10:09:42 INFO - PROCESS | 1676 | __start_tp_report 10:09:42 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 10:09:42 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 10:09:42 INFO - PROCESS | 1676 | |i|pagename|runs| 10:09:42 INFO - PROCESS | 1676 | |0;ai-astar;113;112;118;112;111;112;113;113;112;133 10:09:42 INFO - PROCESS | 1676 | |1;audio-beat-detection;157;124;138;164;117;140;140;116;168;117 10:09:42 INFO - PROCESS | 1676 | |2;audio-dft;187;186;185;196;263;208;184;185;187;184 10:09:42 INFO - PROCESS | 1676 | |3;audio-fft;72;87;76;154;75;57;82;87;137;56 10:09:42 INFO - PROCESS | 1676 | |4;audio-oscillator;92;91;138;79;78;82;126;79;77;127 10:09:42 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;88;85;88;88;90;83;89;86;88;84 10:09:42 INFO - PROCESS | 1676 | |6;imaging-darkroom;93;93;93;94;93;93;93;93;92;93 10:09:42 INFO - PROCESS | 1676 | |7;imaging-desaturate;84;85;84;84;92;140;137;83;94;123 10:09:42 INFO - PROCESS | 1676 | |8;json-parse-financial;60;63;63;64;63;62;63;78;59;56 10:09:42 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;62;61;68;75;71;71;64;65;65;65 10:09:42 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;80;77;79;78;79;78;78;78;72;83 10:09:42 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;128;125;126;124;124;126;125;123;146;138 10:09:42 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;169;164;166;168;157;165;158;164;197;160 10:09:42 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;67;66;67;67;65;66;67;66;68;66 10:09:42 INFO - PROCESS | 1676 | __end_tp_report 10:09:42 INFO - PROCESS | 1676 | __start_cc_report 10:09:42 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1993 10:09:42 INFO - PROCESS | 1676 | __end_cc_report 10:09:42 INFO - PROCESS | 1676 | __startTimestamp1469207382747__endTimestamp 10:09:42 INFO - PROCESS | 1676 | 10:09:42 INFO - PROCESS | 1676 | ------- Summary: start ------- 10:09:42 INFO - PROCESS | 1676 | Number of tests: 14 10:09:42 INFO - PROCESS | 1676 | 10:09:42 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:114.90 Median:113.00 stddev:6.64 (5.9%) stddev-sans-first:7.01 10:09:42 INFO - PROCESS | 1676 | Values: 113.0 112.0 118.0 112.0 111.0 112.0 113.0 113.0 112.0 133.0 10:09:42 INFO - PROCESS | 1676 | 10:09:42 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:138.10 Median:140.00 stddev:19.74 (14.1%) stddev-sans-first:19.72 10:09:42 INFO - PROCESS | 1676 | Values: 157.0 124.0 138.0 164.0 117.0 140.0 140.0 116.0 168.0 117.0 10:09:42 INFO - PROCESS | 1676 | 10:09:42 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:196.50 Median:187.00 stddev:24.55 (13.1%) stddev-sans-first:25.79 10:09:42 INFO - PROCESS | 1676 | Values: 187.0 186.0 185.0 196.0 263.0 208.0 184.0 185.0 187.0 184.0 10:09:42 INFO - PROCESS | 1676 | 10:09:42 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:88.30 Median:75.50 stddev:32.23 (42.7%) stddev-sans-first:33.64 10:09:42 INFO - PROCESS | 1676 | Values: 72.0 87.0 76.0 154.0 75.0 57.0 82.0 87.0 137.0 56.0 10:09:42 INFO - PROCESS | 1676 | 10:09:42 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:79.00 stddev:23.84 (30.2%) stddev-sans-first:25.22 10:09:42 INFO - PROCESS | 1676 | Values: 92.0 91.0 138.0 79.0 78.0 82.0 126.0 79.0 77.0 127.0 10:09:42 INFO - PROCESS | 1676 | 10:09:42 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:86.90 Median:88.00 stddev:2.28 (2.6%) stddev-sans-first:2.39 10:09:42 INFO - PROCESS | 1676 | Values: 88.0 85.0 88.0 88.0 90.0 83.0 89.0 86.0 88.0 84.0 10:09:42 INFO - PROCESS | 1676 | 10:09:42 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:93.00 Median:93.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 10:09:42 INFO - PROCESS | 1676 | Values: 93.0 93.0 93.0 94.0 93.0 93.0 93.0 93.0 92.0 93.0 10:09:42 INFO - PROCESS | 1676 | 10:09:42 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:100.60 Median:84.00 stddev:23.28 (27.7%) stddev-sans-first:23.90 10:09:42 INFO - PROCESS | 1676 | Values: 84.0 85.0 84.0 84.0 92.0 140.0 137.0 83.0 94.0 123.0 10:09:42 INFO - PROCESS | 1676 | 10:09:42 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:63.00 stddev:5.78 (9.2%) stddev-sans-first:6.02 10:09:42 INFO - PROCESS | 1676 | Values: 60.0 63.0 63.0 64.0 63.0 62.0 63.0 78.0 59.0 56.0 10:09:42 INFO - PROCESS | 1676 | 10:09:42 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:66.50 stddev:4.45 (6.7%) stddev-sans-first:4.38 10:09:42 INFO - PROCESS | 1676 | Values: 62.0 61.0 68.0 75.0 71.0 71.0 64.0 65.0 65.0 65.0 10:09:42 INFO - PROCESS | 1676 | 10:09:42 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:78.50 stddev:2.74 (3.5%) stddev-sans-first:2.83 10:09:42 INFO - PROCESS | 1676 | Values: 80.0 77.0 79.0 78.0 79.0 78.0 78.0 78.0 72.0 83.0 10:09:42 INFO - PROCESS | 1676 | 10:09:42 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:126.00 stddev:7.49 (5.9%) stddev-sans-first:7.94 10:09:42 INFO - PROCESS | 1676 | Values: 128.0 125.0 126.0 124.0 124.0 126.0 125.0 123.0 146.0 138.0 10:09:42 INFO - PROCESS | 1676 | 10:09:42 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:165.50 stddev:11.34 (6.9%) stddev-sans-first:12.00 10:09:42 INFO - PROCESS | 1676 | Values: 169.0 164.0 166.0 168.0 157.0 165.0 158.0 164.0 197.0 160.0 10:09:42 INFO - PROCESS | 1676 | 10:09:42 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 10:09:42 INFO - PROCESS | 1676 | Values: 67.0 66.0 67.0 67.0 65.0 66.0 67.0 66.0 68.0 66.0 10:09:42 INFO - PROCESS | 1676 | -------- Summary: end -------- 10:09:42 INFO - PROCESS | 1676 | 10:09:43 INFO - TEST-INFO | 1676: exit 0 10:09:43 INFO - TEST-OK | kraken | took 57694ms 10:09:43 INFO - SUITE-END | took 1171s 10:09:43 INFO - Completed test suite (00:19:31) 10:09:43 INFO - javascript benchmark 10:09:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3418.0, 3499.2065347706907, 3524.1189702574366, 3548.609652938178, 3611.9819400902993, 5745.052066409037, 5765.913511297329, 5770.422957704228, 5816.272965879265, 5821.767129314828, 5764.711764411783, 5770.134479828017, 5772.624779389337, 5781.364049954502, 5784.074548072309, 5191.221316802482, 5272.947270527303, 5282.23407605897, 5294.7617357219015, 5356.1697936819855, 5326.547243484309, 5358.892822143554, 5371.973140134294, 5374.516293533581, 5375.139977603584, 5285.6300058995885, 5331.120365139747, 5367.1680889462195, 5371.81198658047, 5381.865453363658, 4562.338460923164, 5324.707141107277, 5379.784808607651, 5398.460153984609, 5403.405625381205, 5141.460146684619, 5186.896262074775, 5218.452062533417, 5293.788248470057, 5299.205119232108, 5645.689487078209, 5686.5735069869925, 5700.828975130753, 5712.371639119693, 5725.914111288334, 6282.591631543935, 6323.051542268697, 6332.0, 6349.301576826545, 6358.586691865014, 6142.846428839315, 6204.0, 6291.276503202144, 6292.1820163378925, 6303.747850085991, 5974.312954010257, 5988.461038506468, 5991.58058935879, 6013.639181649115, 6036.6076205046975, 6372.0, 6372.522060845455, 6374.298827129012, 6383.616982981036, 6383.904241436382, 6065.2901257037465, 6129.297663865929, 6247.500199983991, 6259.092431597484, 6259.405356491126, 6289.0, 6300.59046161998, 6305.0, 6305.464035556937, 6326.4622507087415, 6257.0, 6292.937070629327, 6299.496040316763, 6299.811005669837, 6339.207599050119, 6169.5064394848305, 6281.937180628135, 6287.9056814147825, 6301.117843501914, 6306.810795676137, 4974.228994505857, 5044.798208071709, 5045.041442125985, 5050.6464547482055, 5057.595392368602, 4515.729056256635, 4540.568645978627, 4544.045750392388, 4575.176468235683, 4579.22153233951, 4819.7108173509705, 5880.206172166788, 5888.146218798251, 5909.793157239562, 5926.7925622603, 6252.624842509464, 6294.276158241861, 6299.338569450233, 6302.401271879165, 6322.778702745381, 5931.347551769302, 5948.0, 5968.0, 5972.402759723993, 6008.849778755566, 5409.2967914171695, 5443.945560544423, 5477.917831232535, 5527.723613819373, 5537.889242215133, 6408.58344207625, 6474.546781725234, 6485.5460117792245, 6496.512761542808, 6502.089707440962, 6276.717547710273, 6296.779612713533, 6301.243850737941, 6302.65335406557, 6314.400131987454, 6356.745730170742, 6375.139356187041, 6404.391582799627, 6437.581557198767, 6469.676516174267, 5515.283013208257, 5811.331696854916, 6272.686365681607, 6290.748370065329, 6318.652474113968, 6255.906161407492, 6265.4361107500545, 6293.465055470153, 6301.747930082929, 6304.873902522016, 6102.0541816018585, 6139.140520327069, 6141.170941922784, 6199.535034872312, 6245.500359971283, 6221.3156552780065, 6227.439530442282, 6232.563720539519, 6239.719212635533, 6242.188515492957, 6114.38856114385, 6119.388061194023, 6127.20346354971, 6129.877402452015, 6140.416660417253, 6054.576179667381, 6073.99779036454, 6112.685862051747, 6147.66187859672, 6169.96915015422, 6064.363241859718, 6105.239096190078, 6145.600535965148, 6146.6004709693725, 6149.508039356931], "value": 5794.160127552393, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.65819242914813, 518.2537146509025, 551.3346332279971, 618.5299172628801, 644.3041515163624, 31858.681413185863, 32414.513782293256, 32432.351352972986, 32458.837705811467, 32581.0, 39643.0, 40269.59730402695, 40322.79838600803, 40429.79785101078, 40489.98775030626, 9673.032696730306, 9848.901510984906, 9849.212063034976, 9876.802463950717, 9904.50477476127, 7929.682812687485, 9596.712098637052, 9721.416714997087, 9725.51372431379, 11818.822717659243, 11698.0, 11763.35301558414, 11777.057835373149, 11790.997765189926, 11808.527658893634, 10404.11565016967, 11673.949344558989, 11828.23116497425, 11859.822102668468, 11862.406879655982, 11299.604513842058, 11456.083513318914, 11571.53713851445, 11715.472803723853, 11732.882671173349, 39147.0, 39583.0, 39615.0, 41859.79070104661, 42054.52809151665, 3354.5639066921144, 3392.1289147563093, 3408.7102596279346, 3410.897673069812, 3474.2877710069374, 28161.859190703915, 28497.86008559676, 29462.26344341387, 30134.0, 30514.931977380907, 2796.6923638399758, 2801.9159425217276, 2826.660800703908, 2892.8264304141817, 2906.302487403008, 354838.0, 355131.0, 355237.0, 355475.0, 355586.0, 36646.450303245474, 37144.628553714654, 37154.25691486155, 61192.77614447686, 62211.0, 35539.75610853608, 35702.92891213268, 35743.4638480423, 35808.64191358105, 35851.4622280666, 16345.591360216089, 16521.586960325847, 16526.421575244807, 16533.83466165323, 16538.25577849, 13545.864541354658, 13557.983151263694, 13598.86401135976, 13607.115537490032, 13613.047086703835, 7963.323117534958, 8011.118776934532, 8250.257476827115, 8338.62476188573, 8415.579221039046, 3489.2498112905846, 3529.7176225901867, 3537.734669899716, 3543.078799512094, 3580.9820950895078, 1014.5333146752577, 1088.4992903264588, 1091.014353875954, 1164.941752912368, 1198.7842188405996, 30650.846745766128, 30663.38673226523, 30803.69196308053, 30823.029848882226, 31076.22309442282, 1031.7523794289316, 1162.7790719763218, 1203.1337437045488, 1206.2641788509002, 1217.762536305412, 14123.152610843383, 15929.681406371808, 16077.919610402107, 16453.0, 16554.503364899072, 653883.0, 654732.0, 656595.0, 657308.1403778947, 659354.0, 63131.368686313464, 63845.0, 63902.680486597266, 63985.0, 63999.0, 1337.3714354253486, 1476.350405821435, 1526.4428483603406, 1570.387548855947, 1637.9426720064741, 23987.040518379068, 27111.59332609973, 28425.857870710515, 28750.712492875642, 28916.566251505825, 49666.751666241435, 49818.75090624524, 50421.24368134554, 50477.0, 50703.0, 432715.0, 433962.0, 434781.8260908675, 435158.0, 436205.8189709031, 23505.529889401772, 26152.73847261503, 26568.202953911412, 26920.0, 26923.326916827235, 39312.0, 42328.57671423246, 44408.77795611001, 47062.76468617635, 48752.0, 35464.46803298004, 36615.816920915226, 36688.26623467462, 36877.0, 37494.812525937195, 35589.64410355863, 35745.64254357527, 36236.63763362333, 36511.634883650826, 36581.08547286339, 35285.47071793977, 35742.821285893406, 36244.637553624125, 36812.0, 36822.631773682995, 31628.734850605717, 32206.67793322037, 32688.0, 32728.0, 33435.83282083574, 25101.623475648244, 25146.868390922085, 25148.49703005966, 25198.17103608002, 25343.746562534878], "value": 18631.851823138524, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.9064210552624, 416.14066951744644, 419.1240307756789, 421.22074162798845, 429.7550396274123, 15290.46483373082, 20106.0, 20763.44274179437, 20788.480287992807, 20956.952152392358, 20516.384508464733, 20781.688274675893, 21955.341339759794, 21955.67066494004, 21992.34022979313, 5012.373453318335, 5876.08920617305, 6060.2121724175795, 6063.575549711522, 6071.878562428748, 5975.133605627181, 6044.123602077696, 6075.939240607581, 6080.753445543675, 6088.512918966472, 4398.164348773738, 4440.533743956887, 6320.810375688737, 6628.701708423133, 6630.867382652368, 6382.968085159591, 6642.800715978528, 6665.5334126610915, 6665.866682666319, 6701.932980670204, 5827.737751801179, 5855.0, 5861.794837180678, 5865.472107510344, 5867.11993201019, 25298.608576528284, 26488.337791555172, 26864.865675671495, 27689.169324920284, 27691.584626230622, 2206.7131272934575, 2240.5182885679656, 2377.4413012941945, 2462.679851619278, 2759.6412466379443, 9755.0, 10020.849687254697, 10344.586216551328, 10381.584736610526, 10658.520366583522, 1645.8025036995518, 1763.8059813420514, 1776.2184638758904, 1794.0850166415091, 1824.9178786954485, 97142.0, 116276.25585616223, 118218.40890795492, 119066.0, 123020.0, 11701.590444334408, 11957.222780519412, 11996.520139194508, 12023.63929082129, 12076.335801531, 13249.403776830066, 14170.64573385653, 14562.563123106323, 14956.775648365283, 15815.762763558556, 9188.081191880892, 9211.769705757275, 9282.118198771106, 9286.489243091559, 9360.812783744286, 9437.716868493957, 9443.244540436748, 9463.668771592962, 9481.90518094824, 9500.95249523748, 4736.976315118402, 4790.257510085942, 4793.0, 4807.278908163734, 4869.586085182728, 2037.327681864981, 2041.47942274719, 2051.548659294953, 2066.8036536529007, 2094.6124966881175, 901.6618767962015, 970.5341436110706, 994.8259054665405, 998.5706146357136, 1018.6791160784329, 20712.0, 21070.841103739134, 21125.68311475329, 21270.893645531673, 21272.78727212708, 963.9518024098767, 966.1497881863914, 997.1574019953129, 999.8501723018442, 1002.9197664186847, 9213.81572368549, 11147.498362573542, 11160.441977901073, 11171.888281117248, 11196.38419886914, 629820.0, 642426.0, 650887.0, 656548.0, 657907.0, 132738.33630831784, 133776.0, 135034.32482837522, 135320.1743860489, 140564.0, 1048.2400259811575, 1053.210092430677, 1057.1595581512715, 1069.4332004037872, 1070.9143268538498, 16231.918840405722, 17017.0, 18119.45641630753, 18776.624467510846, 18910.0, 51669.0, 53367.0, 53790.46209537855, 53939.190912135564, 56157.71921140368, 77840.0, 78937.0, 79555.0, 79868.2013179884, 80942.59528702318, 6618.503612229199, 8241.95879020601, 8432.25623723605, 8436.198561136682, 8525.872111918203, 9270.490123043297, 12004.339761313211, 12589.93705031469, 12899.806502902651, 12974.416151273404, 10953.56185752561, 10958.12335013213, 11237.60668376603, 11356.432178391213, 11540.653780386601, 10973.177011724312, 11027.393493357942, 11101.500432480396, 11301.434928253719, 11303.265287756269, 10943.179261555257, 11332.206745527734, 11347.886521135013, 11592.0, 11718.824217636571, 8260.554402979575, 8342.916570834213, 8370.246677799027, 8532.530710810717, 8725.21473067427, 9786.31495795316, 11218.66344009681, 11269.985701286923, 11551.306921584395, 11563.42182890869], "value": 9834.610219342216, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1513.833478317384, 1633.7222672145733, 1661.260738971158, 1939.9903000484996, 2016.6676635364956, 8386.203310685483, 9025.0, 9177.63289468422, 9182.449053056822, 9204.171624553788, 8881.378303518757, 9164.679236226733, 9169.862452063207, 9171.495567743772, 9190.724278271662, 2554.910578129766, 2574.3049376668287, 2580.0, 2582.3415029167536, 2590.7538783815507, 2501.0, 2562.500312439075, 2575.4591535777417, 2575.8068144889116, 2586.4439145583697, 2531.7847982921476, 2556.6037264223983, 2583.1346498922885, 2585.3278147681644, 2587.2884956636885, 2540.9110681126162, 2549.1715192562397, 2572.421205228818, 2585.379508917846, 2592.896284148632, 2526.280010197085, 2559.104313490282, 2573.6654234949337, 2573.974260257411, 2574.3178057814694, 8942.195202431813, 9270.675526356545, 9313.394629349139, 9333.813323733555, 9340.71977840666, 5657.4908258256955, 5733.856653583652, 5806.2451881255165, 5823.0, 5826.1552074948895, 3661.139632186434, 3771.0949372150762, 3788.3749181385037, 3823.254465379252, 3840.3663395539984, 1010.3836659637615, 1032.4270030133273, 1056.2447849787438, 1079.8596182496303, 1107.0866535108487, 12309.753804923941, 12395.132340736061, 12402.56591019319, 12403.379831008504, 12413.813792793115, 4757.738324392122, 4831.637627177905, 4844.539768721966, 4895.31465594817, 4906.705597664151, 9684.273679474067, 9686.32195746291, 9692.46691431978, 9728.173105285989, 9760.658376956773, 5532.28080349552, 5603.691796951207, 5637.295338082739, 5640.153976903497, 5678.886422271531, 4075.5313138988804, 4691.976540117277, 5090.898182036339, 5177.145770947826, 5209.348831396075, 4042.919141617151, 4130.979345103256, 4178.603032711888, 4187.790610469464, 4198.895027624334, 1260.2627462934286, 1274.1017582604243, 1278.2522224498773, 1290.9741805163844, 1292.3344477594046, 915.8214148241029, 939.3612343606277, 950.5674917912334, 974.1232890398556, 1009.0464511037, 5974.731137098841, 5997.580169388189, 6101.176341193882, 6133.202683651097, 6220.968895155585, 470.5929371094048, 485.5144855144855, 487.8609596265047, 495.68276303166004, 499.8325560937054, 3968.8015599219925, 4033.69747268956, 4075.1645912587846, 4111.835526578963, 4134.276501612266, 8761.430507017023, 11093.5562577496, 11311.981921627093, 11443.771124577628, 11460.426978651034, 10678.786424271471, 10753.946230268799, 10890.673279801618, 10926.125909927187, 10942.45287735626, 8594.183552562621, 8602.483850968962, 8740.470417676881, 8767.868481972775, 8787.956060219785, 5978.222831031938, 6031.815296731154, 6058.90911636317, 6064.727087280995, 6126.754929802758, 9965.850512242467, 10180.389176649425, 10201.081902628799, 10214.744631384276, 10221.488925553842, 9673.516324183622, 10105.696829095139, 10130.696079117639, 10291.485425728833, 10374.0, 7173.282671732994, 7357.742479013209, 7363.595002274927, 7844.882326764989, 8030.0, 8004.119546849958, 8381.916180838358, 8557.44376615518, 8558.614862331086, 8561.272291855263, 7404.666789994355, 7594.0, 7654.15804261542, 7654.655540500802, 7661.655225514976, 7486.401087912845, 7493.812654683677, 7520.548767073993, 7613.352865006536, 7686.116096648957, 7096.645167741695, 7143.785686429415, 7151.570905745672, 7186.209516953027, 7188.101487314086, 4913.410390753133, 4956.900861982812, 5007.899842003067, 5077.8730531737, 5110.105731497048, 5063.620228482952, 5145.125328694056, 5167.741612919263, 5306.628536002443, 5320.494553017457], "value": 4688.66500837152, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.60652094663095, 333.7580254315623, 339.14535370865434, 340.77679120176293, 347.90084825824647, 6747.257801641822, 6760.932390676098, 6771.255161932189, 6847.897281540781, 6897.862042759142, 6650.401463868251, 6661.034150048252, 6669.399754022137, 6702.162229721285, 6724.0, 4769.809207631691, 4872.488388719186, 4912.975435122819, 4955.776990035457, 4973.129702302101, 4918.434380046287, 4973.229149481836, 4980.651354405193, 4998.5501304882555, 4999.675021123633, 4009.779462129596, 4899.0, 4903.779329930144, 4911.386076740408, 4986.227134794112, 4727.621790256771, 4855.247436647308, 4857.975710121462, 4914.189158788796, 4917.139500587383, 3454.5681789776277, 4100.384942258655, 4205.411242426063, 4207.978960105211, 4216.3464662976985, 6403.423691867708, 6433.420992110732, 6452.709628066748, 6457.999010153434, 6461.160049193575, 5868.794592189253, 5885.234919460443, 5889.411058894119, 5898.351181370046, 5907.852303692399, 6881.0, 7119.252478489788, 7131.500794944356, 7134.17956934954, 7154.713811447536, 4666.766661666903, 4680.204365257914, 4690.413698287714, 4694.929576056362, 4723.881902952419, 7528.058992625922, 7615.16233214346, 7627.389808815282, 7628.160902300742, 7630.198829122974, 4770.689905156154, 4777.283407488835, 4782.282657601318, 4784.138855006132, 4793.32893394925, 4836.46798852126, 4836.830710925101, 4840.394950631171, 4852.296417019583, 4860.902781944412, 5576.386597474275, 5822.82531524055, 5839.0949402842625, 5852.531797456193, 5865.20819689345, 7200.351968322771, 7205.495615306983, 7244.782656520313, 7258.491905566665, 7284.854302913912, 1658.797371905359, 1688.0, 1689.1300979995312, 1689.5015970288794, 1692.2638652186338, 1054.5623566219933, 1059.5391004912888, 1077.245927850492, 1079.4494807648, 1083.496174278964, 6610.338966103447, 6650.667466626649, 6778.084958530535, 6782.626955517494, 6797.5581587196675, 7478.85042299151, 7486.0, 7498.6625601848045, 7499.8500029999095, 7594.81012974669, 6821.420179284816, 6837.076994605664, 6844.178698556205, 6854.0, 6859.759908403182, 2969.3170570768843, 3633.2733453309443, 4006.759594424344, 4010.057636455431, 4013.337799263089, 7566.167721550625, 7889.842203156019, 7928.008998875141, 7954.125046244909, 7986.4825683120025, 7758.379329653614, 7803.648835802403, 7804.609769511501, 7829.843403131906, 7830.6084695764985, 7914.485558438683, 7916.564588947548, 7920.168382320004, 7925.247101525346, 7939.603019848984, 7530.849383012419, 7560.773176804704, 7576.545407275581, 7580.886286705593, 7593.278638529331, 7076.681549330189, 7346.37555807741, 7371.8157046074275, 7404.444666649915, 7436.814079647836, 7852.921470785219, 7871.212878712083, 7872.291493765589, 7917.327027202522, 7918.326942209977, 4719.693219940693, 4783.832565860178, 4785.59322457581, 4795.20879054952, 4801.351817504592, 6855.313476115788, 7507.399408047234, 7530.924690753022, 7537.434692397982, 7543.698252069856, 5436.266104076058, 7094.964525177341, 7218.097737782778, 7240.493165478366, 7269.890951635624, 7161.57030578167, 7236.710531578889, 7238.710451581877, 7248.782536523912, 7252.129744430702, 7074.151101867808, 7089.645517724196, 7091.893621595577, 7094.53885497441, 7111.964440177766, 6965.373116419547, 7246.376811594203, 7247.528910620793, 7252.963735181502, 7274.054372931485, 6826.658667066527, 7044.119485064367, 7095.113110861143, 7095.46783991213, 7129.144502659714], "value": 5275.4728112327175, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.1994685898652, 766.7316439246262, 781.5076501803866, 783.2872086401376, 817.989782618466, 14761.704765904675, 14831.332590033448, 14976.700465990687, 14977.775333370008, 15018.39926402944, 14209.928950355234, 14382.856171438283, 14421.927890360534, 14426.855731442682, 14442.133471991689, 776.2509178642608, 791.1613689489132, 940.6472572785206, 956.650822449806, 988.6836212412031, 985.5515740338165, 987.1017374189489, 987.1806400687412, 988.6391467114487, 993.0813997052734, 1043.0925095167177, 1043.7025447747394, 1044.9007344302318, 1045.0124632222514, 1049.1921220660088, 832.4838600067936, 849.362977766675, 852.8251708399763, 854.6325080215505, 1035.3891204189526, 753.2806170107534, 773.8916551682769, 774.3572834547313, 775.0892701076212, 775.317720406039, 15294.158821264826, 15378.3079761411, 15384.461543845911, 15393.999390039611, 15456.459023934109, 11853.348065856375, 11991.700207494796, 12010.69973250667, 12066.638000859988, 12101.152919295653, 10159.187265018782, 10199.133073688745, 10391.584336626525, 10588.576456941713, 10685.41230232337, 3552.378333791576, 3576.2311103112697, 3622.2936527377174, 3663.19409729859, 3832.540095188567, 78023.60988195079, 79225.60387198027, 83725.58137209337, 85223.72164417538, 85375.0, 10098.747531311628, 10166.745831354276, 10289.742756431, 10306.948465257627, 10454.581816727397, 19651.803481965282, 23538.411539711644, 23545.764542354358, 23565.0, 23657.408564785674, 7532.887006694904, 7688.0, 7746.18665040174, 7783.143854176036, 7922.445428820042, 4184.163167366539, 4217.852375166915, 4241.724287921275, 4291.356296555542, 4377.8248870044845, 3751.437284407361, 3791.9951212928595, 3809.3904975203836, 3812.752171108869, 3821.2357528494413, 698.2110215456603, 698.9615571143636, 706.720845266117, 714.9347472266389, 721.7365661533503, 590.9245173783672, 607.9483243924227, 610.2250142319318, 634.8412896775806, 650.3528988656317, 7793.883091753628, 8125.918740812516, 8288.21261980111, 8390.83218335642, 8622.051574326819, 531.2774626507946, 589.286962775047, 593.87231745175, 597.8580910460998, 630.6594439002979, 3002.549617557384, 3254.316593515341, 3797.4873392091713, 3839.4816699745734, 3940.5271367435516, 95097.0, 96281.0, 98330.0, 98601.0, 98717.01282987221, 75549.0, 76189.0, 76642.6167869157, 77277.0, 78797.60601197073, 67779.66110169418, 68622.28444288833, 68787.65606171938, 69655.30344696589, 71237.28762712306, 7633.70227061412, 8410.87383689233, 8526.78683032929, 8593.484390936565, 8691.782705432415, 38101.809490952364, 47429.0, 47616.57150285497, 48003.0, 48038.75980620214, 60023.39976600353, 61602.69198654158, 62941.0, 67586.0, 68494.31505684879, 11091.223614346918, 11459.828102578635, 11476.885231147915, 11559.190856639954, 11969.281843089442, 11977.341246231541, 12139.817902731289, 12274.877251227374, 12344.321062341298, 12441.688957775767, 11294.265872718248, 11680.123990700902, 11768.823467648162, 11926.582569610022, 11980.64058078259, 11649.359285239394, 11680.415979201176, 11894.0, 11946.283223006647, 11954.880451195377, 9164.770880728036, 11419.60031398897, 11588.768224635629, 11600.245984011011, 11720.355380454157, 10062.647807326708, 10093.949530252301, 10218.489075546044, 10315.845262320921, 10397.0, 9796.804063918538, 10047.250687826434, 10065.949670251603, 10103.472291314238, 10143.543540540546], "value": 7071.257497887011, "unit": "score"}], "name": "dromaeo_css", "value": 7553.370461175252, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 118.0, 112.0, 111.0, 112.0, 113.0, 113.0, 112.0, 133.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 124.0, 138.0, 164.0, 117.0, 140.0, 140.0, 116.0, 168.0, 117.0], "value": 138.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 186.0, 185.0, 196.0, 263.0, 208.0, 184.0, 185.0, 187.0, 184.0], "value": 196.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 87.0, 76.0, 154.0, 75.0, 57.0, 82.0, 87.0, 137.0, 56.0], "value": 88.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 138.0, 79.0, 78.0, 82.0, 126.0, 79.0, 77.0, 127.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 88.0, 90.0, 83.0, 89.0, 86.0, 88.0, 84.0], "value": 86.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 94.0, 93.0, 93.0, 93.0, 93.0, 92.0, 93.0], "value": 93.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 84.0, 92.0, 140.0, 137.0, 83.0, 94.0, 123.0], "value": 100.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 63.0, 64.0, 63.0, 62.0, 63.0, 78.0, 59.0, 56.0], "value": 63.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 68.0, 75.0, 71.0, 71.0, 64.0, 65.0, 65.0, 65.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 77.0, 79.0, 78.0, 79.0, 78.0, 78.0, 78.0, 72.0, 83.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 125.0, 126.0, 124.0, 124.0, 126.0, 125.0, 123.0, 146.0, 138.0], "value": 128.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 164.0, 166.0, 168.0, 157.0, 165.0, 158.0, 164.0, 197.0, 160.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 67.0, 65.0, 66.0, 67.0, 66.0, 68.0, 66.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1485.0, "alertThreshold": 2.0}]} 10:09:43 INFO - Return code: 0 10:09:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:09:44 ERROR - # TBPL SUCCESS # 10:09:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:09:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:09:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:09:44 INFO - 2016-07-22 10:09:44.064 screenresolution[1680:10860] starting screenresolution argv=screenresolution get 10:09:44 INFO - 2016-07-22 10:09:44.066 screenresolution[1680:10860] Display 0: 1600x1200x32@60 10:09:44 INFO - 2016-07-22 10:09:44.072 screenresolution[1681:10863] starting screenresolution argv=screenresolution list 10:09:44 INFO - Available Modes on Display 0 10:09:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:09:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:09:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:09:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:09:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:09:44 INFO - Intel Iris: 10:09:44 INFO - Chipset Model: Intel Iris 10:09:44 INFO - Type: GPU 10:09:44 INFO - Bus: Built-In 10:09:44 INFO - VRAM (Dynamic, Max): 1536 MB 10:09:44 INFO - Vendor: Intel (0x8086) 10:09:44 INFO - Device ID: 0x0a2e 10:09:44 INFO - Revision ID: 0x0009 10:09:44 INFO - Displays: 10:09:44 INFO - Display: 10:09:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:09:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:09:44 INFO - Display Serial Number: 1600x1200 60 10:09:44 INFO - Main Display: Yes 10:09:44 INFO - Mirror: Off 10:09:44 INFO - Online: Yes 10:09:44 INFO - Rotation: Supported 10:09:44 INFO - Return code: 0 10:09:44 INFO - Running post-action listener: _resource_record_post_action 10:09:44 INFO - Running post-run listener: _resource_record_post_run 10:09:45 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 31817216; Write bytes: 495639040; Read time: 198; Write time: 1539 10:09:45 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 191345152; Write bytes: 186377728; Read time: 17382; Write time: 400 10:09:45 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 30035456; Write bytes: 298468352; Read time: 183; Write time: 1108 10:09:45 INFO - Running post-run listener: _upload_blobber_files 10:09:45 INFO - Blob upload gear active. 10:09:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:09:45 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 10:09:45 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'] 10:09:45 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 10:09:45 INFO - (blobuploader) - INFO - Open directory for files ... 10:09:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:09:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:09:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:46 INFO - (blobuploader) - INFO - Done attempting. 10:09:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:09:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:09:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:48 INFO - (blobuploader) - INFO - Done attempting. 10:09:48 INFO - (blobuploader) - INFO - Iteration through files over. 10:09:48 INFO - Return code: 0 10:09:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:09:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:09:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ff87cc85377b7cc296bd5b271b9d6efcb95419813dc71939148aa6e1356996e6abdbcac54cb6b81eeec39709dafe49c42943ef8769d757047d53459e8c50decf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/67dd204cdd99a737570fb0e74be713a4cf05280f41b3d99e5822c8188cbf513be62dca05c7c1b6cbcae8ab87593f22645507f07f2eec2cf3486522f8aeb513c9"} 10:09:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:09:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:09:48 INFO - Contents: 10:09:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ff87cc85377b7cc296bd5b271b9d6efcb95419813dc71939148aa6e1356996e6abdbcac54cb6b81eeec39709dafe49c42943ef8769d757047d53459e8c50decf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/67dd204cdd99a737570fb0e74be713a4cf05280f41b3d99e5822c8188cbf513be62dca05c7c1b6cbcae8ab87593f22645507f07f2eec2cf3486522f8aeb513c9"} 10:09:48 INFO - Running post-run listener: copy_logs_to_upload_dir 10:09:48 INFO - Copying logs to upload dir... 10:09:48 INFO - mkdir: /builds/slave/test/build/upload/logs 10:09:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.491456 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-22 10:09:48.285254) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 10:09:48.288792) ========= 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.DtwMuHCDhj/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.ykR5CRVU17/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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/ff87cc85377b7cc296bd5b271b9d6efcb95419813dc71939148aa6e1356996e6abdbcac54cb6b81eeec39709dafe49c42943ef8769d757047d53459e8c50decf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/67dd204cdd99a737570fb0e74be713a4cf05280f41b3d99e5822c8188cbf513be62dca05c7c1b6cbcae8ab87593f22645507f07f2eec2cf3486522f8aeb513c9"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009648 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ff87cc85377b7cc296bd5b271b9d6efcb95419813dc71939148aa6e1356996e6abdbcac54cb6b81eeec39709dafe49c42943ef8769d757047d53459e8c50decf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/67dd204cdd99a737570fb0e74be713a4cf05280f41b3d99e5822c8188cbf513be62dca05c7c1b6cbcae8ab87593f22645507f07f2eec2cf3486522f8aeb513c9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 10:09:48.320031) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 10:09:48.320689) ========= 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.DtwMuHCDhj/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.ykR5CRVU17/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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.004754 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 10:09:48.372685) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 10:09:48.373329) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 10:09:48.374001) ========= ========= Total master_lag: 0.17 =========