builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0071 starttime: 1467233961.21 results: success (0) buildid: 20160629104257 builduid: 97b1eb8fbe074fecbafc889ce730fec1 revision: b743fe6eabb8328430d91275462dc8e2a42eef81 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 13:59:21.206463) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 13:59:21.206987) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 13:59:21.207265) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 13:59:21.231249) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:59:21.231682) ========= 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.Lucw8HYaCF/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.SV1WKKrq7v/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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-06-29 13:59:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.27M=0.001s 2016-06-29 13:59:21 (8.27 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107193 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:59:21.360726) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:59:21.361038) ========= 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.Lucw8HYaCF/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.SV1WKKrq7v/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.020977 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:59:21.409968) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:59:21.410320) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b743fe6eabb8328430d91275462dc8e2a42eef81 --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 b743fe6eabb8328430d91275462dc8e2a42eef81 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Lucw8HYaCF/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.SV1WKKrq7v/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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-06-29 13:59:21,483 truncating revision to first 12 chars 2016-06-29 13:59:21,483 Setting DEBUG logging. 2016-06-29 13:59:21,483 attempt 1/10 2016-06-29 13:59:21,483 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b743fe6eabb8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 13:59:21,785 unpacking tar archive at: mozilla-beta-b743fe6eabb8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.564418 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:59:21.998344) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 13:59:21.998657) ========= script_repo_revision: b743fe6eabb8328430d91275462dc8e2a42eef81 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 13:59:21.999073) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 13:59:21.999345) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 13:59:22.017900) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-29 13:59:22.018439) ========= /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.Lucw8HYaCF/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.SV1WKKrq7v/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 13:59:22 INFO - MultiFileLogger online at 20160629 13:59:22 in /builds/slave/test 13:59:22 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 13:59:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:59:22 INFO - {'append_to_log': False, 13:59:22 INFO - 'base_work_dir': '/builds/slave/test', 13:59:22 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:59:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:59:22 INFO - 'branch': 'Mozilla-Beta', 13:59:22 INFO - 'buildbot_json_path': 'buildprops.json', 13:59:22 INFO - 'config_files': ('talos/mac_config.py',), 13:59:22 INFO - 'default_actions': ('clobber', 13:59:22 INFO - 'read-buildbot-config', 13:59:22 INFO - 'download-and-extract', 13:59:22 INFO - 'populate-webroot', 13:59:22 INFO - 'create-virtualenv', 13:59:22 INFO - 'install', 13:59:22 INFO - 'run-tests'), 13:59:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:59:22 INFO - 'download_minidump_stackwalk': True, 13:59:22 INFO - 'download_symbols': 'ondemand', 13:59:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:59:22 INFO - 'tooltool.py': '/tools/tooltool.py', 13:59:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:59:22 INFO - '/tools/misc-python/virtualenv.py')}, 13:59:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:59:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:59:22 INFO - 'installer_path': 'installer.exe', 13:59:22 INFO - 'log_level': 'info', 13:59:22 INFO - 'log_name': 'talos', 13:59:22 INFO - 'log_to_console': True, 13:59:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:59:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:59:22 INFO - 'opt_config_files': (), 13:59:22 INFO - 'pip_index': False, 13:59:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:59:22 INFO - 'cmd': ('bash', 13:59:22 INFO - '-c', 13:59:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:59:22 INFO - 'enabled': True, 13:59:22 INFO - 'halt_on_failure': False, 13:59:22 INFO - 'name': 'check_screen_resolution'},), 13:59:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:59:22 INFO - 'cmd': ('bash', 13:59:22 INFO - '-c', 13:59:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:59:22 INFO - 'enabled': True, 13:59:22 INFO - 'halt_on_failure': False, 13:59:22 INFO - 'name': 'check_screen_resolution'},), 13:59:22 INFO - 'run_cmd_checks_enabled': True, 13:59:22 INFO - 'sps_profile': False, 13:59:22 INFO - 'sps_profile_interval': 0, 13:59:22 INFO - 'suite': 'dromaeojs', 13:59:22 INFO - 'system_bits': '32', 13:59:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:59:22 INFO - 'title': 't-yosemite-r7-0071', 13:59:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:59:22 INFO - 'use_talos_json': True, 13:59:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:59:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:59:22 INFO - 'work_dir': 'build'} 13:59:22 INFO - ##### 13:59:22 INFO - ##### Running clobber step. 13:59:22 INFO - ##### 13:59:22 INFO - Running pre-action listener: _resource_record_pre_action 13:59:22 INFO - Running main action method: clobber 13:59:22 INFO - rmtree: /builds/slave/test/build 13:59:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:59:23 INFO - Running post-action listener: _resource_record_post_action 13:59:23 INFO - ##### 13:59:23 INFO - ##### Running read-buildbot-config step. 13:59:23 INFO - ##### 13:59:23 INFO - Running pre-action listener: _resource_record_pre_action 13:59:23 INFO - Running main action method: read_buildbot_config 13:59:23 INFO - Using buildbot properties: 13:59:23 INFO - { 13:59:23 INFO - "project": "", 13:59:23 INFO - "product": "firefox", 13:59:23 INFO - "script_repo_revision": "production", 13:59:23 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 13:59:23 INFO - "repository": "", 13:59:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 13:59:23 INFO - "buildid": "20160629104257", 13:59:23 INFO - "pgo_build": "False", 13:59:23 INFO - "basedir": "/builds/slave/test", 13:59:23 INFO - "buildnumber": 33, 13:59:23 INFO - "slavename": "t-yosemite-r7-0071", 13:59:23 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 13:59:23 INFO - "platform": "yosemite_r7", 13:59:23 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 13:59:23 INFO - "branch": "mozilla-beta", 13:59:23 INFO - "repo_path": "releases/mozilla-beta", 13:59:23 INFO - "revision": "b743fe6eabb8328430d91275462dc8e2a42eef81", 13:59:23 INFO - "stage_platform": "macosx64", 13:59:23 INFO - "builduid": "97b1eb8fbe074fecbafc889ce730fec1", 13:59:23 INFO - "slavebuilddir": "test" 13:59:23 INFO - } 13:59:23 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467222177/firefox-48.0.en-US.mac.dmg. 13:59:23 INFO - Running post-action listener: _resource_record_post_action 13:59:23 INFO - ##### 13:59:23 INFO - ##### Running download-and-extract step. 13:59:23 INFO - ##### 13:59:23 INFO - Running pre-action listener: _resource_record_pre_action 13:59:23 INFO - Running main action method: download_and_extract 13:59:23 INFO - mkdir: /builds/slave/test/build/tests 13:59:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:23 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467222177/firefox-48.0.en-US.mac.test_packages.json 13:59:23 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467222177/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 13:59:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467222177/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 13:59:23 INFO - Downloaded 1165 bytes. 13:59:23 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 13:59:23 INFO - Using the following test package requirements: 13:59:23 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 13:59:23 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:59:23 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 13:59:23 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:59:23 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 13:59:23 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 13:59:23 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:59:23 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 13:59:23 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 13:59:23 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:59:23 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 13:59:23 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:59:23 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 13:59:23 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:59:23 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 13:59:23 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:59:23 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 13:59:23 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 13:59:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:23 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467222177/firefox-48.0.en-US.mac.common.tests.zip 13:59:23 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467222177/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 13:59:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467222177/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 13:59:23 INFO - Downloaded 18350371 bytes. 13:59:23 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'] 13:59:23 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 13:59:27 INFO - Return code: 0 13:59:27 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 13:59:27 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')]} 13:59:27 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467222177/firefox-48.0.en-US.mac.common.tests.zip 13:59:27 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467222177/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 13:59:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467222177/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 13:59:27 INFO - Downloaded 18350371 bytes. 13:59:27 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'] 13:59:27 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 13:59:31 INFO - Return code: 0 13:59:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:31 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467222177/firefox-48.0.en-US.mac.talos.tests.zip 13:59:31 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467222177/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 13:59:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467222177/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 13:59:34 INFO - Downloaded 10840145 bytes. 13:59:34 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'] 13:59:34 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 13:59:34 INFO - Return code: 0 13:59: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')]} 13:59:34 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467222177/firefox-48.0.en-US.mac.dmg 13:59:34 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467222177/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 13:59:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467222177/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 13:59:40 INFO - Downloaded 86199484 bytes. 13:59:40 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467222177/firefox-48.0.en-US.mac.dmg 13:59:40 INFO - mkdir: /builds/slave/test/properties 13:59:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:59:40 INFO - Writing to file /builds/slave/test/properties/build_url 13:59:40 INFO - Contents: 13:59:40 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467222177/firefox-48.0.en-US.mac.dmg 13:59:40 INFO - Running post-action listener: _resource_record_post_action 13:59:40 INFO - Running post-action listener: set_extra_try_arguments 13:59:40 INFO - ##### 13:59:40 INFO - ##### Running populate-webroot step. 13:59:40 INFO - ##### 13:59:40 INFO - Running pre-action listener: _resource_record_pre_action 13:59:40 INFO - Running main action method: populate_webroot 13:59:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:59:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:59:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:59:40 INFO - '--tppagecycles', 13:59:40 INFO - '7'], 13:59:40 INFO - 'tests': ['tsvgm']}}, 13:59:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:59:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:59:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:59:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:59:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:59:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:59:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:40 INFO - 'talos_options': ['--disable-e10s'], 13:59:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:59:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:59:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:40 INFO - 'talos_options': ['--disable-e10s'], 13:59:40 INFO - 'tests': ['damp', 'tps']}, 13:59:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:40 INFO - 'tests': ['damp', 'tps']}, 13:59:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:59:40 INFO - 'tests': ['dromaeo_dom']}, 13:59:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:59:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:59:40 INFO - 'tests': ['a11yr', 13:59:40 INFO - 'ts_paint', 13:59:40 INFO - 'tpaint', 13:59:40 INFO - 'sessionrestore', 13:59:40 INFO - 'sessionrestore_no_auto_restore', 13:59:40 INFO - 'tabpaint']}, 13:59:40 INFO - 'other-e10s': {'tests': ['a11yr', 13:59:40 INFO - 'ts_paint', 13:59:40 INFO - 'tpaint', 13:59:40 INFO - 'sessionrestore', 13:59:40 INFO - 'sessionrestore_no_auto_restore', 13:59:40 INFO - 'tabpaint']}, 13:59:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:59:40 INFO - 'ts_paint', 13:59:40 INFO - 'tpaint', 13:59:40 INFO - 'sessionrestore', 13:59:40 INFO - 'sessionrestore_no_auto_restore', 13:59:40 INFO - 'tabpaint']}, 13:59:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:59:40 INFO - 'ts_paint', 13:59:40 INFO - 'tpaint', 13:59:40 INFO - 'sessionrestore', 13:59:40 INFO - 'sessionrestore_no_auto_restore', 13:59:40 INFO - 'tabpaint']}, 13:59:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:59:40 INFO - 'tests': ['a11yr', 13:59:40 INFO - 'ts_paint', 13:59:40 INFO - 'tpaint', 13:59:40 INFO - 'sessionrestore', 13:59:40 INFO - 'sessionrestore_no_auto_restore', 13:59:40 INFO - 'tabpaint']}, 13:59:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:59:40 INFO - 'tests': ['a11yr', 13:59:40 INFO - 'ts_paint', 13:59:40 INFO - 'tpaint', 13:59:40 INFO - 'sessionrestore', 13:59:40 INFO - 'sessionrestore_no_auto_restore', 13:59:40 INFO - 'tabpaint']}, 13:59:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:59:40 INFO - 'tests': ['tsvgx', 13:59:40 INFO - 'tsvgr_opacity', 13:59:40 INFO - 'tart', 13:59:40 INFO - 'tscrollx', 13:59:40 INFO - 'cart']}, 13:59:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:59:40 INFO - 'tsvgr_opacity', 13:59:40 INFO - 'tart', 13:59:40 INFO - 'tscrollx', 13:59:40 INFO - 'cart']}, 13:59:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:40 INFO - 'talos_options': ['--disable-e10s'], 13:59:40 INFO - 'tests': ['tp5o']}, 13:59:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:40 INFO - 'tests': ['tp5o']}, 13:59:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:40 INFO - 'talos_options': ['--disable-e10s', 13:59:40 INFO - '--xperf_path', 13:59:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:59:40 INFO - 'tests': ['tp5n']}, 13:59:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:40 INFO - 'talos_options': ['--xperf_path', 13:59:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:59:40 INFO - 'tests': ['tp5n']}}, 13:59:40 INFO - 'talos.zip': {'path': '', 13:59:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:59:40 INFO - Running post-action listener: _resource_record_post_action 13:59:40 INFO - ##### 13:59:40 INFO - ##### Running create-virtualenv step. 13:59:40 INFO - ##### 13:59:40 INFO - Running pre-action listener: _resource_record_pre_action 13:59:40 INFO - Running main action method: create_virtualenv 13:59:40 INFO - Creating virtualenv /builds/slave/test/build/venv 13:59:40 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 13:59:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:59:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:59:40 INFO - Using real prefix '/tools/python27' 13:59:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:59:41 INFO - Installing distribute.............................................................................................................................................................................................done. 13:59:44 INFO - Installing pip.................done. 13:59:44 INFO - Return code: 0 13:59:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:44 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 0x10337da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10338d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb022da5000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10321ce00>, '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 0x103085db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103217b20>, '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.Lucw8HYaCF/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.SV1WKKrq7v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 13:59:44 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 13:59:44 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 13:59:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lucw8HYaCF/Render', 13:59:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:44 INFO - 'HOME': '/Users/cltbld', 13:59:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:44 INFO - 'LOGNAME': 'cltbld', 13:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:44 INFO - 'MOZ_NO_REMOTE': '1', 13:59:44 INFO - 'NO_EM_RESTART': '1', 13:59:44 INFO - 'PAGER': '/bin/cat', 13:59:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:44 INFO - 'PWD': '/builds/slave/test', 13:59:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:44 INFO - 'SHELL': '/bin/bash', 13:59:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SV1WKKrq7v/Listeners', 13:59:44 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 13:59:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:44 INFO - 'USER': 'cltbld', 13:59:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:44 INFO - 'XPC_FLAGS': '0x0', 13:59:44 INFO - 'XPC_SERVICE_NAME': '0', 13:59:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:44 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 13:59:44 INFO - Cleaning up... 13:59:44 INFO - Return code: 0 13:59:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:44 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 0x10337da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10338d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb022da5000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10321ce00>, '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 0x103085db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103217b20>, '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.Lucw8HYaCF/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.SV1WKKrq7v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 13:59:44 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 13:59:44 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 13:59:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lucw8HYaCF/Render', 13:59:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:44 INFO - 'HOME': '/Users/cltbld', 13:59:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:44 INFO - 'LOGNAME': 'cltbld', 13:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:44 INFO - 'MOZ_NO_REMOTE': '1', 13:59:44 INFO - 'NO_EM_RESTART': '1', 13:59:44 INFO - 'PAGER': '/bin/cat', 13:59:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:44 INFO - 'PWD': '/builds/slave/test', 13:59:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:44 INFO - 'SHELL': '/bin/bash', 13:59:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SV1WKKrq7v/Listeners', 13:59:44 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 13:59:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:44 INFO - 'USER': 'cltbld', 13:59:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:44 INFO - 'XPC_FLAGS': '0x0', 13:59:44 INFO - 'XPC_SERVICE_NAME': '0', 13:59:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:44 INFO - Downloading/unpacking psutil>=0.7.1 13:59: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 13:59: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 13:59: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 13:59: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 13:59: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 13:59: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 13:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:59:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:59:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:59:48 INFO - Installing collected packages: psutil 13:59:48 INFO - Running setup.py install for psutil 13:59:48 INFO - building 'psutil._psutil_osx' extension 13:59:48 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 13:59:48 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 13:59:48 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 13:59:48 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 13:59:48 INFO - building 'psutil._psutil_posix' extension 13:59:48 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 13:59:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:59:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:59:48 INFO - ^ 13:59:48 INFO - 1 warning generated. 13:59:48 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 13:59:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:59:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:59:49 INFO - Successfully installed psutil 13:59:49 INFO - Cleaning up... 13:59:49 INFO - Return code: 0 13:59:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:49 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 0x10337da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10338d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb022da5000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10321ce00>, '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 0x103085db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103217b20>, '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.Lucw8HYaCF/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.SV1WKKrq7v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 13:59:49 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 13:59:49 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 13:59:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lucw8HYaCF/Render', 13:59:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:49 INFO - 'HOME': '/Users/cltbld', 13:59:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:49 INFO - 'LOGNAME': 'cltbld', 13:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:49 INFO - 'MOZ_NO_REMOTE': '1', 13:59:49 INFO - 'NO_EM_RESTART': '1', 13:59:49 INFO - 'PAGER': '/bin/cat', 13:59:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:49 INFO - 'PWD': '/builds/slave/test', 13:59:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:49 INFO - 'SHELL': '/bin/bash', 13:59:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SV1WKKrq7v/Listeners', 13:59:49 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 13:59:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:49 INFO - 'USER': 'cltbld', 13:59:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:49 INFO - 'XPC_FLAGS': '0x0', 13:59:49 INFO - 'XPC_SERVICE_NAME': '0', 13:59:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:59:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:59:51 INFO - Installing collected packages: mozsystemmonitor 13:59:51 INFO - Running setup.py install for mozsystemmonitor 13:59:52 INFO - Successfully installed mozsystemmonitor 13:59:52 INFO - Cleaning up... 13:59:52 INFO - Return code: 0 13:59:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:52 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 0x10337da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10338d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb022da5000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10321ce00>, '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 0x103085db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103217b20>, '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.Lucw8HYaCF/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.SV1WKKrq7v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 13:59:52 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 13:59:52 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 13:59:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lucw8HYaCF/Render', 13:59:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:52 INFO - 'HOME': '/Users/cltbld', 13:59:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:52 INFO - 'LOGNAME': 'cltbld', 13:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:52 INFO - 'MOZ_NO_REMOTE': '1', 13:59:52 INFO - 'NO_EM_RESTART': '1', 13:59:52 INFO - 'PAGER': '/bin/cat', 13:59:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:52 INFO - 'PWD': '/builds/slave/test', 13:59:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:52 INFO - 'SHELL': '/bin/bash', 13:59:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SV1WKKrq7v/Listeners', 13:59:52 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 13:59:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:52 INFO - 'USER': 'cltbld', 13:59:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:52 INFO - 'XPC_FLAGS': '0x0', 13:59:52 INFO - 'XPC_SERVICE_NAME': '0', 13:59:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:52 INFO - Downloading/unpacking blobuploader==1.2.4 13:59:52 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 13:59:52 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 13:59:52 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 13:59:52 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 13:59:52 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 13:59:52 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 13:59:54 INFO - Downloading blobuploader-1.2.4.tar.gz 13:59:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:59:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:59:54 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 13:59:54 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 13:59:54 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 13:59:54 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 13:59:54 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 13:59:54 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 13:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:59:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:59:55 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 13:59:55 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 13:59:55 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 13:59:55 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 13:59:55 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 13:59:55 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 13:59:55 INFO - Downloading docopt-0.6.1.tar.gz 13:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:59:56 INFO - Installing collected packages: blobuploader, requests, docopt 13:59:56 INFO - Running setup.py install for blobuploader 13:59:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:59:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:59:56 INFO - Running setup.py install for requests 13:59:56 INFO - Running setup.py install for docopt 13:59:56 INFO - Successfully installed blobuploader requests docopt 13:59:56 INFO - Cleaning up... 13:59:56 INFO - Return code: 0 13:59:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:56 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 0x10337da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10338d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb022da5000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10321ce00>, '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 0x103085db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103217b20>, '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.Lucw8HYaCF/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.SV1WKKrq7v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 13:59:56 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 13:59:56 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 13:59:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lucw8HYaCF/Render', 13:59:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:56 INFO - 'HOME': '/Users/cltbld', 13:59:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:56 INFO - 'LOGNAME': 'cltbld', 13:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:56 INFO - 'MOZ_NO_REMOTE': '1', 13:59:56 INFO - 'NO_EM_RESTART': '1', 13:59:56 INFO - 'PAGER': '/bin/cat', 13:59:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:56 INFO - 'PWD': '/builds/slave/test', 13:59:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:56 INFO - 'SHELL': '/bin/bash', 13:59:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SV1WKKrq7v/Listeners', 13:59:56 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 13:59:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:56 INFO - 'USER': 'cltbld', 13:59:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:56 INFO - 'XPC_FLAGS': '0x0', 13:59:56 INFO - 'XPC_SERVICE_NAME': '0', 13:59:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:59:57 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-6RPSDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:59:57 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-rQMR5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:59:57 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-7gB3dV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:59:57 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-nmZ2Yk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:59:57 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-1Ibx7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:59:57 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-EFQqi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:59:57 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-sBTY_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:59:57 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-tqIeiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:59:58 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-eNKuNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:59:58 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-OuZutg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:59:58 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-S99ZpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:59:58 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-vNDUmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:59:58 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-_adVEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:59:58 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-5eamyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:59:58 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-SCu4pE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:59:58 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-n0ZLWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:59:58 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-nu3x6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:59:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:59:59 INFO - Running setup.py install for manifestparser 13:59:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:59:59 INFO - Running setup.py install for mozcrash 13:59:59 INFO - Running setup.py install for mozdebug 13:59:59 INFO - Running setup.py install for mozdevice 13:59:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:59:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:59:59 INFO - Running setup.py install for mozfile 13:59:59 INFO - Running setup.py install for mozhttpd 13:59:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:59:59 INFO - Running setup.py install for mozinfo 14:00:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:00:00 INFO - Running setup.py install for mozInstall 14:00:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:00:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:00:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:00:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:00:00 INFO - Running setup.py install for mozleak 14:00:00 INFO - Running setup.py install for mozlog 14:00:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:00:00 INFO - Running setup.py install for moznetwork 14:00:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:00:00 INFO - Running setup.py install for mozprocess 14:00:00 INFO - Running setup.py install for mozprofile 14:00:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:00:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:00:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:00:00 INFO - Running setup.py install for mozrunner 14:00:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:00:01 INFO - Running setup.py install for mozscreenshot 14:00:01 INFO - Running setup.py install for moztest 14:00:01 INFO - Running setup.py install for mozversion 14:00:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:00:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:00:01 INFO - Cleaning up... 14:00:01 INFO - Return code: 0 14:00:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:01 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 0x10337da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10338d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb022da5000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10321ce00>, '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 0x103085db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103217b20>, '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.Lucw8HYaCF/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.SV1WKKrq7v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:00:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:00:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:00:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lucw8HYaCF/Render', 14:00:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:00:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:00:01 INFO - 'HOME': '/Users/cltbld', 14:00:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:00:01 INFO - 'LOGNAME': 'cltbld', 14:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:01 INFO - 'MOZ_NO_REMOTE': '1', 14:00:01 INFO - 'NO_EM_RESTART': '1', 14:00:01 INFO - 'PAGER': '/bin/cat', 14:00:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:01 INFO - 'PWD': '/builds/slave/test', 14:00:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:00:01 INFO - 'SHELL': '/bin/bash', 14:00:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SV1WKKrq7v/Listeners', 14:00:01 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 14:00:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:00:01 INFO - 'USER': 'cltbld', 14:00:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:00:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:01 INFO - 'XPC_FLAGS': '0x0', 14:00:01 INFO - 'XPC_SERVICE_NAME': '0', 14:00:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:00:01 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-4hWCps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:00:02 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-qqa7hW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:00:02 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-5awGQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:00:02 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-OEGmAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:00:02 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-RabZVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:00:02 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-kndCAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:00:02 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-e33sPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:00:02 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-XlvlZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:00:02 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-2CrTas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:00:02 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-dAqBpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:00:02 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-XU1UDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:00:03 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-S9JmFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:00:03 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-48Frt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:00:03 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-Vnumj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:00:03 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-TraArk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:00:03 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-jpAgJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:00:03 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-D_SvVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:00:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:06 INFO - Downloading blessings-1.6.tar.gz 14:00:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:00:06 INFO - Installing collected packages: blessings 14:00:06 INFO - Running setup.py install for blessings 14:00:06 INFO - Successfully installed blessings 14:00:06 INFO - Cleaning up... 14:00:06 INFO - Return code: 0 14:00:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:00:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:00:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:00:06 INFO - Reading from file tmpfile_stdout 14:00:06 INFO - Current package versions: 14:00:06 INFO - blessings == 1.6 14:00:06 INFO - blobuploader == 1.2.4 14:00:06 INFO - docopt == 0.6.1 14:00:06 INFO - manifestparser == 1.1 14:00:06 INFO - mozInstall == 1.12 14:00:06 INFO - mozcrash == 0.17 14:00:06 INFO - mozdebug == 0.1 14:00:06 INFO - mozdevice == 0.48 14:00:06 INFO - mozfile == 1.2 14:00:06 INFO - mozhttpd == 0.7 14:00:06 INFO - mozinfo == 0.9 14:00:06 INFO - mozleak == 0.1 14:00:06 INFO - mozlog == 3.1 14:00:06 INFO - moznetwork == 0.27 14:00:06 INFO - mozprocess == 0.22 14:00:06 INFO - mozprofile == 0.28 14:00:06 INFO - mozrunner == 6.11 14:00:06 INFO - mozscreenshot == 0.1 14:00:06 INFO - mozsystemmonitor == 0.0 14:00:06 INFO - moztest == 0.7 14:00:06 INFO - mozversion == 1.4 14:00:06 INFO - psutil == 3.1.1 14:00:06 INFO - requests == 1.2.3 14:00:06 INFO - wsgiref == 0.1.2 14:00:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:06 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 0x10337da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10338d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb022da5000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10321ce00>, '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 0x103085db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103217b20>, '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.Lucw8HYaCF/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.SV1WKKrq7v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:00:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:00:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:00:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lucw8HYaCF/Render', 14:00:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:00:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:00:06 INFO - 'HOME': '/Users/cltbld', 14:00:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:00:06 INFO - 'LOGNAME': 'cltbld', 14:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:06 INFO - 'MOZ_NO_REMOTE': '1', 14:00:06 INFO - 'NO_EM_RESTART': '1', 14:00:06 INFO - 'PAGER': '/bin/cat', 14:00:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:06 INFO - 'PWD': '/builds/slave/test', 14:00:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:00:06 INFO - 'SHELL': '/bin/bash', 14:00:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SV1WKKrq7v/Listeners', 14:00:06 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 14:00:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:00:06 INFO - 'USER': 'cltbld', 14:00:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:00:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:06 INFO - 'XPC_FLAGS': '0x0', 14:00:06 INFO - 'XPC_SERVICE_NAME': '0', 14:00:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:00:07 INFO - Cleaning up... 14:00:07 INFO - Return code: 0 14:00:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:00: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')]} 14:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00: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')]} 14:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:07 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 0x10337da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10338d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb022da5000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10321ce00>, '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 0x103085db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103217b20>, '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.Lucw8HYaCF/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.SV1WKKrq7v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:00:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:00:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lucw8HYaCF/Render', 14:00:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:00:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:00:07 INFO - 'HOME': '/Users/cltbld', 14:00:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:00:07 INFO - 'LOGNAME': 'cltbld', 14:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:07 INFO - 'MOZ_NO_REMOTE': '1', 14:00:07 INFO - 'NO_EM_RESTART': '1', 14:00:07 INFO - 'PAGER': '/bin/cat', 14:00:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:07 INFO - 'PWD': '/builds/slave/test', 14:00:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:00:07 INFO - 'SHELL': '/bin/bash', 14:00:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SV1WKKrq7v/Listeners', 14:00:07 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 14:00:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:00:07 INFO - 'USER': 'cltbld', 14:00:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:00:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:07 INFO - 'XPC_FLAGS': '0x0', 14:00:07 INFO - 'XPC_SERVICE_NAME': '0', 14:00:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:07 INFO - Downloading/unpacking jsonschema 14:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:00:09 INFO - Downloading/unpacking functools32 (from jsonschema) 14:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:10 INFO - Downloading functools32-3.2.3-2.tar.gz 14:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:00:10 INFO - warning: no files found matching '*.txt' 14:00:10 INFO - no previously-included directories found matching 'build' 14:00:10 INFO - no previously-included directories found matching 'dist' 14:00:10 INFO - no previously-included directories found matching '.git*' 14:00:10 INFO - Installing collected packages: jsonschema, functools32 14:00:10 INFO - Running setup.py install for functools32 14:00:10 INFO - warning: no files found matching '*.txt' 14:00:10 INFO - no previously-included directories found matching 'build' 14:00:10 INFO - no previously-included directories found matching 'dist' 14:00:10 INFO - no previously-included directories found matching '.git*' 14:00:10 INFO - Successfully installed jsonschema functools32 14:00:10 INFO - Cleaning up... 14:00:10 INFO - Return code: 0 14:00:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:00: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')]} 14:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00: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')]} 14:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10337da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10338d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb022da5000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10321ce00>, '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 0x103085db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103217b20>, '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.Lucw8HYaCF/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.SV1WKKrq7v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:00:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:00:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lucw8HYaCF/Render', 14:00:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:00:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:00:10 INFO - 'HOME': '/Users/cltbld', 14:00:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:00:10 INFO - 'LOGNAME': 'cltbld', 14:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:10 INFO - 'MOZ_NO_REMOTE': '1', 14:00:10 INFO - 'NO_EM_RESTART': '1', 14:00:10 INFO - 'PAGER': '/bin/cat', 14:00:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:10 INFO - 'PWD': '/builds/slave/test', 14:00:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:00:10 INFO - 'SHELL': '/bin/bash', 14:00:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SV1WKKrq7v/Listeners', 14:00:10 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 14:00:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:00:10 INFO - 'USER': 'cltbld', 14:00:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:00:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:10 INFO - 'XPC_FLAGS': '0x0', 14:00:10 INFO - 'XPC_SERVICE_NAME': '0', 14:00:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:10 INFO - Downloading/unpacking flake8 14:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:00:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:00:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:00:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:00:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:00:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:00:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:00:14 INFO - no previously-included directories found matching 'docs/_build' 14:00:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:00:14 INFO - Running setup.py install for pep8 14:00:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:00:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:00:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:00:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:00:14 INFO - no previously-included directories found matching 'docs/_build' 14:00:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:00:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:00:15 INFO - Cleaning up... 14:00:15 INFO - Return code: 0 14:00:15 INFO - Running post-action listener: _resource_record_post_action 14:00:15 INFO - Running post-action listener: _start_resource_monitoring 14:00:15 INFO - Starting resource monitoring. 14:00:15 INFO - ##### 14:00:15 INFO - ##### Running install step. 14:00:15 INFO - ##### 14:00:15 INFO - Running pre-action listener: _resource_record_pre_action 14:00:15 INFO - Running main action method: install 14:00:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:00:15 INFO - Reading from file tmpfile_stdout 14:00:15 INFO - Detecting whether we're running mozinstall >=1.0... 14:00:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:00:15 INFO - Reading from file tmpfile_stdout 14:00:15 INFO - Output received: 14:00:15 INFO - Usage: mozinstall [options] installer 14:00:15 INFO - Options: 14:00:15 INFO - -h, --help show this help message and exit 14:00:15 INFO - -d DEST, --destination=DEST 14:00:15 INFO - Directory to install application into. [default: 14:00:15 INFO - "/builds/slave/test"] 14:00:15 INFO - --app=APP Application being installed. [default: firefox] 14:00:15 INFO - mkdir: /builds/slave/test/build/application 14:00:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 14:00:37 INFO - Reading from file tmpfile_stdout 14:00:37 INFO - Output received: 14:00:37 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:00:37 INFO - Running post-action listener: _resource_record_post_action 14:00:37 INFO - ##### 14:00:37 INFO - ##### Running run-tests step. 14:00:37 INFO - ##### 14:00:37 INFO - Running pre-action listener: _resource_record_pre_action 14:00:37 INFO - Running main action method: run_tests 14:00:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:00:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:00:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:00:37 INFO - 2016-06-29 14:00:37.657 screenresolution[2232:70301] starting screenresolution argv=screenresolution get 14:00:37 INFO - 2016-06-29 14:00:37.660 screenresolution[2232:70301] Display 0: 1600x1200x32@60 14:00:37 INFO - 2016-06-29 14:00:37.665 screenresolution[2233:70305] starting screenresolution argv=screenresolution list 14:00:37 INFO - Available Modes on Display 0 14:00:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:00:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:00:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:00:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:00:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:00:37 INFO - Intel Iris: 14:00:37 INFO - Chipset Model: Intel Iris 14:00:37 INFO - Type: GPU 14:00:37 INFO - Bus: Built-In 14:00:37 INFO - VRAM (Dynamic, Max): 1536 MB 14:00:37 INFO - Vendor: Intel (0x8086) 14:00:37 INFO - Device ID: 0x0a2e 14:00:37 INFO - Revision ID: 0x0009 14:00:37 INFO - Displays: 14:00:37 INFO - Display: 14:00:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:00:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:00:37 INFO - Display Serial Number: 1600x1200 60 14:00:37 INFO - Main Display: Yes 14:00:37 INFO - Mirror: Off 14:00:37 INFO - Online: Yes 14:00:37 INFO - Rotation: Supported 14:00:37 INFO - Return code: 0 14:00:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:00:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:00:37 INFO - Python 2.7.3 14:00:37 INFO - Return code: 0 14:00:37 INFO - grabbing minidump binary from tooltool 14:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:37 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 0x10321ce00>, '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 0x103085db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103217b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:00:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:00:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:00:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:00:37 INFO - Return code: 0 14:00:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:00:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:00:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:00:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:00:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:00:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:00:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:00:39 INFO - Return code: 0 14:00:39 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/1467222177/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0071', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:00:39 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/1467222177/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0071 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:00:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lucw8HYaCF/Render', 14:00:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:00:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:00:39 INFO - 'HOME': '/Users/cltbld', 14:00:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:00:39 INFO - 'LOGNAME': 'cltbld', 14:00:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:00:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:39 INFO - 'MOZ_NO_REMOTE': '1', 14:00:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:00:39 INFO - 'NO_EM_RESTART': '1', 14:00:39 INFO - 'PAGER': '/bin/cat', 14:00:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:39 INFO - 'PWD': '/builds/slave/test', 14:00:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:00:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:00:39 INFO - 'SHELL': '/bin/bash', 14:00:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SV1WKKrq7v/Listeners', 14:00:39 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 14:00:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:00:39 INFO - 'USER': 'cltbld', 14:00:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:00:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:39 INFO - 'XPC_FLAGS': '0x0', 14:00:39 INFO - 'XPC_SERVICE_NAME': '0', 14:00:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:00:39 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/1467222177/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0071', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:00:39 INFO - mozversion application_buildid: 20160629104257 14:00:39 INFO - mozversion application_changeset: b743fe6eabb8328430d91275462dc8e2a42eef81 14:00:39 INFO - mozversion application_display_name: Firefox 14:00:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:00:39 INFO - mozversion application_name: Firefox 14:00:39 INFO - mozversion application_remotingname: firefox 14:00:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:00:39 INFO - mozversion application_vendor: Mozilla 14:00:39 INFO - mozversion application_version: 48.0 14:00:39 INFO - mozversion platform_buildid: 20160629104257 14:00:39 INFO - mozversion platform_changeset: b743fe6eabb8328430d91275462dc8e2a42eef81 14:00:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:00:39 INFO - mozversion platform_version: 48.0 14:00:39 INFO - using testdate: 1467234039 14:00:39 INFO - actual date: 1467234039 14:00:39 INFO - starting webserver on 'localhost:53918' 14:00:39 INFO - SUITE-START | Running 2 tests 14:00:39 INFO - TEST-START | dromaeo_css 14:00:39 INFO - operating with platform_type : mac_ 14:00:39 INFO - Initialising browser for dromaeo_css test... 14:00:39 INFO - TEST-INFO | started process 2251 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpLAnYIZ/profile http://localhost:53918/getInfo.html) 14:00:41 INFO - PROCESS | 2251 | __metrics Screen width/height:1600/1200 14:00:41 INFO - PROCESS | 2251 | colorDepth:24 14:00:41 INFO - PROCESS | 2251 | Browser inner width/height: 1024/689 14:00:41 INFO - PROCESS | 2251 | __metrics 14:00:41 INFO - PROCESS | 2251 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:00:41 ERROR - PROCESS | 2251 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:00:42 INFO - TEST-INFO | 2251: exit 0 14:00:42 INFO - Browser initialized. 14:00:42 INFO - Running cycle 1/1 for dromaeo_css test... 14:00:42 INFO - TEST-INFO | started process 2254 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpLAnYIZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:00:54 INFO - PROCESS | 2254 | RSS: Main: 161398784 14:00:54 INFO - PROCESS | 2254 | 14:01:45 INFO - PROCESS | 2254 | 1467234105376 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:03:55 INFO - PROCESS | 2254 | Cycle 1(1): loaded http://localhost:53918/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53918/tests/dromaeo/cssquery-ext.html) 14:03:56 INFO - PROCESS | 2254 | RSS: Main: 270790656 14:03:56 INFO - PROCESS | 2254 | 14:06:59 INFO - PROCESS | 2254 | Cycle 1(1): loaded http://localhost:53918/tests/dromaeo/cssquery-ext.html (next: http://localhost:53918/tests/dromaeo/cssquery-jquery.html) 14:06:59 INFO - PROCESS | 2254 | RSS: Main: 306614272 14:06:59 INFO - PROCESS | 2254 | 14:10:01 INFO - PROCESS | 2254 | Cycle 1(1): loaded http://localhost:53918/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53918/tests/dromaeo/cssquery-mootools.html) 14:10:02 INFO - PROCESS | 2254 | RSS: Main: 313475072 14:10:02 INFO - PROCESS | 2254 | 14:13:04 INFO - PROCESS | 2254 | Cycle 1(1): loaded http://localhost:53918/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53918/tests/dromaeo/cssquery-prototype.html) 14:13:05 INFO - PROCESS | 2254 | RSS: Main: 302866432 14:13:05 INFO - PROCESS | 2254 | 14:16:08 INFO - PROCESS | 2254 | Cycle 1(1): loaded http://localhost:53918/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53918/tests/dromaeo/cssquery-yui.html) 14:16:09 INFO - PROCESS | 2254 | RSS: Main: 271101952 14:16:09 INFO - PROCESS | 2254 | 14:19:11 INFO - PROCESS | 2254 | Cycle 1(1): loaded http://localhost:53918/tests/dromaeo/cssquery-yui.html (next: http://localhost:53918/tests/dromaeo/cssquery-dojo.html) 14:19:11 INFO - PROCESS | 2254 | RSS: Main: 315625472 14:19:11 INFO - PROCESS | 2254 | 14:19:11 INFO - PROCESS | 2254 | __start_tp_report 14:19:11 INFO - PROCESS | 2254 | _x_x_mozilla_page_load 14:19:11 INFO - PROCESS | 2254 | _x_x_mozilla_page_load_details 14:19:11 INFO - PROCESS | 2254 | |i|pagename|runs| 14:19:11 INFO - PROCESS | 2254 | |0;dojo.html;3467.479878018297;3553.644635536445;3557.09294129997;3563.305155494678;3628.147385364439;5854.092615644571;5859.1797148399255;5919.822405327842;5933.7626494940205;5971.761129554818;5903.793367232148;5958.016927207005;5970.104484327353;5970.492508136814;5971.283445986477;4456.732596044231;5250.842474725764;5318.893622127545;5361.5978801589845;5429.647072940246;5400.594955378343;5423.674579525222;5448.264484294629;5458.235846981426;5460.672359658413;5356.866078348053;5414.35027796665;5440.319960004999;5455.699936503491;5461.290032295816;5439.673619582818;5464.043792336325;5480.958617862593;5488.204210389511;5559.499645031967;5197.688138711689;5294.788208471657;5339.5461385782255;5405.945940540583;5409.188621706736;5064;5861.384554621746;5875.118732190205;5884.3527212007075;5938.435848594377;6263.31103578606;6310.747570097191;6311.968440157816;6313.084602732624;6320.6207627542035;6033.155358249848;6138.324784273726;6281.403266689657;6373.490120790326;6382.968085159591;6035.6076855004285;6043.906675851339;6060.363661815446;6070.96964515179;6073.635581865102;6420.293767685551;6421.935780642228;6426.3573642635365;6431.485481161496;6433.453156481752;6147.600405973598;6238.532110091671;6290.968545157337;6325.335839736761;6330.177076979963;6349.9682501587195;6354.618722876642;6355.968220158962;6359.872802544016;6370.872582548416;6225.097360882737;6283.465905398001;6283.528735344776;6297.307296197415;6305.842353941188;6203.503719702413;6223.408776166257;6288.748450062038;6303.149074874925;6303.842403939938;5038.244263360452;5064.645474816727;5081.8729531762;5085.821996230115;5095;4576.084783043405;4614.123316569908;4627.814887404534;4632.536746325341;4645.117427688729;6009.338972712998;6110.382061044019;6121.173641558422;6133.907991380132;6141.140240366263;6334.081558174039;6367.586106903036;6369.331220221903;6375.139356186948;6375.171227740457;5911.290645122613;6060;6074.726637301332;6098.32918378978;6098.725557349841;5483.177523371446;5516;5527.834164975057;5567.137093750394;5570.136628822539;6520.413162815369;6521.836954076186;6539.215294164731;6574.8356291093105;6583.44040756541;6237.750489980532;6316.810495685137;6338.936610633835;6351.269603995414;6353.872922541431;6467.644279564481;6558.770443034471;6570.737170513126;6594.142761440982;6602.570832895846;6282.434580887742;6300.873982520416;6309.873802524015;6314.147590075281;6315.305316415099;6218.253809542884;6281.96859015702;6291.1192433058495;6356.586821856749;6365.363463653783;6202.224721909762;6263.404976527223;6284.591501552384;6293.433590976834;6298.905516417349;5682.602217844877;5889.057750759858;6255.280642726145;6266.811995640138;6299.842503937438;6017.308009578955;6075.878482430238;6122.550631083031;6148.354422785722;6235.314115447207;5622.409646987007;6260.373962603703;6286.937130628635;6296.150019747275;6296.5592408530965;4952;6230.439260466398;6232.501399888089;6251.124842522141;6256.843578910563 14:19:11 INFO - PROCESS | 2254 | |1;ext.html;518.9766460509279;524.8714065054062;549.8130635583904;566.2751677852349;599.9860236200823;33047;33539;38769.80615096924;39503;39644.40533392001;43858.12283754323;44655.88360290994;44673.329900051525;44765;44929;9792.461414622176;10026.348287361297;10027.498625068754;10032.849507257397;10057.949710251438;9094.86357704635;9304.209142222919;9318.974912759591;11842.822357664641;12098.97158741508;11877.584284550043;11945.343006134659;11951.10366722495;11962.342071186082;11969.581064662738;11735.354555499443;11814.88185118155;11822.645320640395;11829.467673954692;11838.99368553674;11555.942220288845;11702.590409335633;11706.239094458833;11710.941445292805;11754.471048802825;41039.58960410387;41529.37705934414;41571.792141039405;41600.1679966402;41668.749937501925;3497.178163131662;3511.7015053720465;3588.946165807489;3664.120611053355;3888.9611103889165;28851.855740721163;29687.70312296871;30073.947411840698;30104;30727.846360768275;2734.9726502734916;2737.6441062661725;2796.706345833699;2805.242584502173;2825.9717402825913;379557.10221448995;383141;383571;383611;384231.07884460676;37332;38070.238595227944;65834;66136;66355.66822165858;36858.8157059213;37054.44418333727;37075.07312317214;37115.81442092772;37141;16198.676026479405;16349;16368.017918924665;16392.918035409748;16392.918035409984;12940;13810.309484525733;13866.098703584235;13875.722485550434;13900;7986.32116270112;8500.36247281444;8637.56812159402;8730.563471826383;8774.692885748967;3132.3422081362714;3461.7230621550216;3539.94690079649;3594.5327107476382;3599.6400359963795;1017.5675337981328;1021.9284650074572;1094.0645747885444;1164.2839653612966;1203.8314635950974;26804.59793103105;30595.388092238474;30806.69193308083;30988;31009.534856977163;1140.201858698914;1199.9700007499882;1261.7476504699098;1287.1826390242263;1307.522754194712;15780.842191578167;15848.207589620704;15873.603159920864;16024.75962860558;16058.43795467153;654024;661146;662821;663325;665446;63061;63459;63593;63652;63652;1395.8534353892899;1569.7096037233148;1571.4342836578594;1582.6863703126608;1617.765424013535;28788;30956.84521577468;31094.689053109178;31213.531797023516;31937.36125277435;51309.743451284;51532.484675152766;51670.74164629153;51706.48293517017;51805.37362384597;432448;434478;435122;435412;435423.6457635383;24185.274441766775;24216.87891560531;24706.382340441633;28563.571546426403;28629.856850716445;44000.33999489946;44182.55817441784;44286.55713442824;44613.553864462236;44615.77692111519;36608.633913661586;36780.080497987765;36797.81601092085;37560.43659345058;38302;37948.430773538974;38015.422057639786;38087.238255235294;38858.80570597129;39040;36977.44533832048;37581.62418375781;38427.42358864675;38486.6151338483;38947;32664.020079397655;34010;34035;34082.97751067472;34132.317353653285;24955;25065.74934250634;25180.622290665287;25244.62133068042;25577 14:19:11 INFO - PROCESS | 2254 | |2;jquery.html;348.5294851949868;374.5991788785999;409.80534246233026;412.0825339649973;413.57195302861544;16462.917685411587;20104.59790804183;21163.365099047016;21829.235976740816;21862.89068554657;16032.118233497153;18255.817441825577;22116.778832211672;22186;22205.333839984825;5939.346671866102;6225.875482490347;6266.122742816009;6275.435210831024;6277.246730392337;4520.11857687751;6099.207103076594;6206.534509911752;6231.439170474657;6453.386928241809;6721.49588780841;6727.932720672779;6728.798136055926;6729.629870357128;6750;6418.903716444257;6618.040384144296;6629.7016634251095;6630.071789949411;6697.397234248917;5773.480386765169;5800.361960184377;5803.738831752581;5811.825645230608;5812.273465816773;27267.590986135223;27591.86204068987;28022.71977280242;28191.436171276666;28194.295142621395;2197.0772275644267;2260.49138943738;2268.0247493577754;2698.2984424049887;2981.508051171554;15267.236638168159;15603.843961560353;15800.604984875356;15907.920460397623;16111.274992625244;1441.4882716635652;1546.9690606187926;1584.6751415959816;1617.4096454793917;1663.467690339092;107759;112909.99999999919;113297;117553.23670144955;117650;11346.092312614972;11639.825402618968;11739.706507337385;11772.646820595395;11863.16957812962;14631.195284259467;14802.851971480362;14844.03513771623;14858.925705371405;14880.851191488164;7744.961275193701;9486.620535178654;9499.810003799885;9509.144177024102;9521.28590355726;9788.55951482185;9803.460809655395;9832.655857044969;9859.063388978035;9877.357971731815;5857.619254748428;5918.556108291896;6959.652017399109;7067.717291308393;7080.468964827659;1679.5143188081709;1683.9494815155565;1902.2391043582402;1954.8142926421967;1958.3733205374144;903.8418276801533;934.6167671845707;977.9657711980188;1075.7579544602402;1077.4881931082673;20867.269645562334;21487.785122148893;21599.46001349979;22312;22555.548889022455;861.8448679237797;901.3435776788465;1003.3177439341172;1006.9194464442827;1069.6577095329576;11572.537098516133;11907.642770716719;11947.940260298818;11962.342071186169;11965.282083075042;601117.9496922649;684198.5790071018;694543.5272823604;709545;710382;137245;139662;146462.535374647;147426.2628686871;150694;1063.6011495689118;1107.291333546531;1125.735452168756;1130.5025788652965;1130.711668524521;18693.719594205824;19153;19504;19509.12208950629;19751.80248197557;35580.64419355773;37098.62901370952;51105.383562601295;52137.7393113032;53085.734571326895;80070;85610;86098.84752881229;87847;89336.553317233;8397.874031889405;8423.368247381593;8517.48895066298;8634.222919937236;8860.29117670572;12395.917673753718;13056.673583160496;13201.20792752438;13214.603561893158;13533.984951128508;11197.160212983896;11534.250273732181;11682.47428865686;11844.70388240301;11958.222715523463;10608.681739547827;11307.886921130683;11549.711257218301;11756.294622322688;11821;11422.428878556206;11722.58970936013;11895.345755983159;11992.460339284928;11997.520099195934;8316.41785075039;8366.665333386596;8412.327013839;8486.830263394573;8695.782605434915;11335.71660708456;11565.248258863146;11800.468978896142;11903.880961190278;11921.94039029834 14:19:11 INFO - PROCESS | 2254 | |3;mootools.html;1441.6035590212691;1445.6530432696156;1642.926068326925;1885.9811401885977;2029.168041103148;8358.707445239417;8760.299176065915;8916.108389161096;8923.553822308892;8924.687635932736;8720.651173953034;9013.549322533863;9023.864642030374;9030.277577793777;9033;2520.206135067457;2539.5555777738914;2573.5496288149593;2578.458523710023;2578.5487539680576;2530.3168144600945;2603;2604.0365064926004;2608.686957565095;2620.489004644095;2546.618007298911;2564.0513010186255;2588.48230353929;2592.0927675313583;2593.209071233273;2554.3486410965083;2568.5761849294845;2584.508943300767;2587.430765231646;2595.8961641534315;2570.2160840943507;2581.2256323103184;2611.8041146913865;2617.0055378956067;2619.2142357292737;8801.911980880173;9008.549572521413;9031.593578288992;9077.319201059881;9083.68207112748;5522.22688823565;5668.206451096849;5719.885602287931;5723.027085395493;5724.570657200727;3592.371335016388;3682.4844521766972;3706.4810926470313;3730.664240218366;3749.925001499982;1049.5329578337644;1059.2214722179192;1064.1327318235612;1072.8122578548723;1102.311055590256;11983.64049078529;12225.938870305681;12418.379081045912;12425.75148497025;12425.93787031059;4984.476629953875;5061.848144555669;5065.468125846733;5083.61872859537;5123.820666276737;10655.786884262272;10659.520321585547;10660.62687805923;10662.840057399146;10664.626738064286;5741.712914354265;5765.625234359753;5769.249997500298;5769.740361683735;5774.076147816413;4577.977110114494;4690.991436841027;4977.129002424634;5078.13671675816;5154.742262886841;4196.979015104905;4217.641500472433;4320.891977700583;4363.149185908717;4366.039471316305;1361.9319034048258;1393.4983405973842;1398.3427788939182;1406.9507567235098;1411.9505817296345;948.2745699539857;963.8843338799248;975.7414285214423;976.2482888176065;1014.0467960117613;5974.163617093611;6122.418370254819;6138.171346868205;6295.464885484694;6300.243970723543;427.16276098846606;453.94004998329274;473.41769623363456;475.8603145466588;475.9291593913694;4003.459532963071;4084.305668036441;4133.565975572582;4209.158168366339;4212.073343864345;10774.407407592658;11226.438678066064;11232.550697972152;11245.381504017194;11254.437278136224;10999.780004399867;11027.283226590245;11040.447977601088;11063.948924852126;11067.225294229487;8255.958720206481;8479.279261262862;8485.745427637181;8572.52851093196;8596.312295016383;5729.770809167587;6002.489788368038;6151.876962460815;6177.320494745484;6181.84545386369;9831.410115393099;9835.164011058854;9996.950015249877;10001.849972250277;10020;9815.950920245354;10189.694309170736;10295.794084118426;10470.214733894836;10534.262601617813;7151.713931442684;7158.319959603829;7717.344025757873;7861.056673199253;7995.240452157036;8564.700235491728;8568;8614.526201059001;8625.69810056645;8656.653733850575;7529.698812047457;7607.847843043219;7621.428392870668;7664.463487555818;7758.991331126917;7443.995060666957;7453.850922981402;7512.5492470451945;7626.8093297668;7644.12092609357;7185.389241914496;7267.0552828132;7308.976743256055;7339.339459448675;7340.11918569775;4962.404511458503;5008.148614735576;5118.616103792156;5218.321618189611;5229.40503146544;5094.923576146287;5133.263587904031;5214.5567626750635;5260.263563101245;5335.413104558418 14:19:11 INFO - PROCESS | 2254 | |4;prototype.html;332.54345964674724;333.8614474992878;339.40817565617255;346.15192777694637;347.7704714888174;6785.6267905265195;6795.456363490921;6802.999999999994;6829.897551536725;6841.897371539425;5447.319085114361;6782.898256526144;6829.146356705412;6829.351211634899;6842.863142737142;4152.252594532975;4839.4918533554;4960.727160006199;4982.153033984231;5068.06240845443;4749.90752127011;5093.185090385539;5099.7960081596875;5110.616703747215;5120.743962801864;4157.792110394484;5029.773660185282;5050.772715227824;5053.317802096725;5083.822066227683;4814.277858321245;4867.075255701406;5004.674696144775;5040.571551418134;5050.823221187259;4301.935470967938;4305.763183024932;4306.074194048295;4321.157374312011;4322.135572885404;5614.887702245932;6268.934281172212;6561.80314590563;6583.210014798255;6596.010598410229;5979.252593425822;5982.611130276518;5984.670843103628;5985.401459854023;5991.760329586811;7026.156861176692;7252.854942901113;7261.491695581311;7282.708691652328;7282.927170728331;4163.458750362433;4691.967767091234;4836.613070954315;4864.708117512961;4871.196252618313;6112.358202388774;7626.923730762733;7699;7706.113796913371;7713.5757533335645;4918.926216106761;4923.236898280772;4925.236588328815;4928.901421971612;4936.2102063669645;4995.325631039836;4999.575036121898;5002.849914502571;5003.49965003504;5008.073506401327;5919.408059194132;5927.288725352985;5945.16767652529;5950.19672344228;5967.761289548456;7034.6834392452465;7323.231060738653;7347.08161479815;7356.1172659280155;7369.77890663281;1655.96688066238;1685.3174464341962;1686.890352127108;1693.3395975569538;1697.4992377248495;998.5007496251874;1046.2571574182264;1048.2662136504478;1075.1774892207468;1076.9084627806567;5697.686627235459;6708.698108585126;6839.623820689811;7043.859122817515;7045.154581450156;6743.898841517381;7276.490645654753;7711.151773304932;7712;7750.108737495148;6892.862142757117;6961.199462061928;6968.338007889242;6971.8605627887155;6992.965035174791;3295.9452975048234;4004.6596039336982;4040.1313717550865;4043.939340909889;4071.1043570414463;7029.753958611424;7411.332980031823;7694.769156925301;7972.960135199287;8080.393970452122;7093.3970612498515;7940.325072368798;7945.364370850318;7961.960190199012;7982.600869956479;8050.59747012647;8061.838763224585;8070.1526339734655;8076.71731489395;8076.71731489395;7149.0706208192605;7337.963310183415;7627.207606212646;7657.731979380695;7665.42509311815;7530.246975302426;7551.622418879144;7553.622318883924;7555.848883022419;7582.052243469567;8056.919430805851;8058.033036035713;8059.0732065810835;8067;8080.313173380328;4748.62011039123;4790.760461976957;4791.976040119777;4796.9760151199025;4814.494478079751;6326.956052251327;7293.393552527335;7541.170471248268;7638.045244344457;7643.808904777425;7275.963620181865;7346.77959661211;7350.96324518374;7368.778936631696;7369.631518424165;5943.940560594338;7279.308465695751;7312.268773122645;7316.817079573053;7338.266173382833;7171.318724721144;7174.892376614459;7176.605286709281;7187.820304492429;7193.748218812526;5634.211210430461;6762.391384775394;7085.858282834418;7164.746169420435;7320.15818180916;6903.965480172567;7069.929300706927;7087.873637908504;7228.060352154186;7236.493445458767 14:19:11 INFO - PROCESS | 2254 | |5;yui.html;706.6819931031038;719.6221983458685;771.7877583664495;791.2483141016036;798.4371018432006;15536.611584710388;15696.058236505818;15717.292721827516;15723.449679261199;15748.842511574881;14337.498187563437;14505.637359066028;14517.983741138125;14523.273836308168;14527.055741376804;772.4785769605536;801.2708435323857;940.0552444792974;968.8934217236099;970.1995853420921;968.9922480620147;977.6724797192949;981.2738573455663;981.6269817469351;983.8130755156498;810.1250649298743;1045.5347370420166;1047.240750455921;1047.8113939490888;1052.8578641883362;1013.9797204055915;1054.346305290721;1056.815057364958;1057.04865620941;1059.2849826367171;784.8861915022347;785.8074771680974;786.6145588661572;787.7321710618418;788.8027993001749;15050.473233436887;15465.690686186213;15512.14683192424;15517.922410387988;15538.456154034668;12016.519339226508;12207.206531575419;12262.019038476901;12270.44782984759;12530.81203781944;10481.161507079416;10589.894101059044;10623.831378548353;10782.13742900574;10954.616588419447;3603.0451930238246;3642;3659.121810765397;3737.9533730555218;3874.554426240962;61944.380556194315;82420.58789706073;83040.58479707563;83553.58223208845;84381.99999999939;8108.5945702714625;9477.336586438883;9577.569009394594;9582.425054496753;10308.948455257825;21199.68200476994;21378.824164670783;21502.13991440356;21512.892435537724;21539.353819385444;7544.735934242275;7621.809454763565;7683.116441609175;7708.190639982833;7782.027246594176;3311.93376132476;4014.558398576154;4151.41880136775;4245.087306229176;4322.135572885372;3121.547375630521;3656.3784156693428;3700.3524383232825;3718.9628103719156;3726.4782930389765;561.901667208237;582.4932308891292;669.6517810738486;671.5332843673698;675.1155985658803;556.6743455078744;604.208486882177;606.9136246119485;608.3490664988508;625.252822876658;8195.95902020486;8310.127436619188;8360.874586881202;8507.829843403097;8801.779955501035;571.5541877335685;601.2694576090072;601.6781022153215;606.254307202135;631.166859745132;3863.3818589025623;3968.6372121966397;4096.549379568245;4139.648129908992;4254.914901702011;96590;97401;97677.5348369775;102993.48503257586;104978;77904.61047694726;79023;84609.30781384338;86185.70721439183;88196.23607527814;65577.03268901941;66105.66947165233;66413.33586664168;66710;66807.32981675497;8071;8473.087366235346;8487;8626.741197764077;8662.653493860427;46150.53849461462;48657.5134248653;50036.74981625069;50317;50447;69058.65470672614;69208;69489.9576506363;70221.64889175522;70769.29230707628;11172.776544468903;11428.085753139896;11428.171632467667;11643.59247426336;11751;12018.218815776947;12131.514739410324;12386.5664701735;12584.811227831407;12970.870291297344;9865.95067024689;11042.779144416905;11147.83278250843;11581.768364632828;11586;11677.649670509898;11686.18196726221;11747.530098796295;11930.701732456411;12114.21257618252;11324.37715925632;11442.027427668741;11562.421878905852;11770.656669344304;12006.21959572625;10039.548220330249;10299.400000999249;10314.226433017404;10344.53449594755;10348.646085242362;8711.520866352157;9950.701478955643;10057.849132263169;10225.897741022494;10299.948500257751 14:19:11 INFO - PROCESS | 2254 | __end_tp_report 14:19:11 INFO - PROCESS | 2254 | __start_cc_report 14:19:11 INFO - PROCESS | 2254 | _x_x_mozilla_cycle_collect,1052 14:19:11 INFO - PROCESS | 2254 | __end_cc_report 14:19:11 INFO - PROCESS | 2254 | __startTimestamp1467235151926__endTimestamp 14:19:11 INFO - PROCESS | 2254 | 14:19:11 INFO - PROCESS | 2254 | ------- Summary: start ------- 14:19:11 INFO - PROCESS | 2254 | Number of tests: 6 14:19:11 INFO - PROCESS | 2254 | 14:19:11 INFO - PROCESS | 2254 | [#0] dojo.html Cycles:165 Average:5895.80 Median:6138.32 stddev:636.79 (10.4%) stddev-sans-first:609.59 14:19:11 INFO - PROCESS | 2254 | Values: 3467.5 3553.6 3557.1 3563.3 3628.1 5854.1 5859.2 5919.8 5933.8 5971.8 5903.8 5958.0 5970.1 5970.5 5971.3 4456.7 5250.8 5318.9 5361.6 5429.6 5400.6 5423.7 5448.3 5458.2 5460.7 5356.9 5414.4 5440.3 5455.7 5461.3 5439.7 5464.0 5481.0 5488.2 5559.5 5197.7 5294.8 5339.5 5405.9 5409.2 5064.0 5861.4 5875.1 5884.4 5938.4 6263.3 6310.7 6312.0 6313.1 6320.6 6033.2 6138.3 6281.4 6373.5 6383.0 6035.6 6043.9 6060.4 6071.0 6073.6 6420.3 6421.9 6426.4 6431.5 6433.5 6147.6 6238.5 6291.0 6325.3 6330.2 6350.0 6354.6 6356.0 6359.9 6370.9 6225.1 6283.5 6283.5 6297.3 6305.8 6203.5 6223.4 6288.7 6303.1 6303.8 5038.2 5064.6 5081.9 5085.8 5095.0 4576.1 4614.1 4627.8 4632.5 4645.1 6009.3 6110.4 6121.2 6133.9 6141.1 6334.1 6367.6 6369.3 6375.1 6375.2 5911.3 6060.0 6074.7 6098.3 6098.7 5483.2 5516.0 5527.8 5567.1 5570.1 6520.4 6521.8 6539.2 6574.8 6583.4 6237.8 6316.8 6338.9 6351.3 6353.9 6467.6 6558.8 6570.7 6594.1 6602.6 6282.4 6300.9 6309.9 6314.1 6315.3 6218.3 6282.0 6291.1 6356.6 6365.4 6202.2 6263.4 6284.6 6293.4 6298.9 5682.6 5889.1 6255.3 6266.8 6299.8 6017.3 6075.9 6122.6 6148.4 6235.3 5622.4 6260.4 6286.9 6296.2 6296.6 4952.0 6230.4 6232.5 6251.1 6256.8 14:19:11 INFO - PROCESS | 2254 | 14:19:11 INFO - PROCESS | 2254 | [#1] ext.html Cycles:180 Average:62970.18 Median:3504.44 stddev:135709.73 (3872.5%) stddev-sans-first:136009.43 14:19:11 INFO - PROCESS | 2254 | Values: 519.0 524.9 549.8 566.3 600.0 33047.0 33539.0 38769.8 39503.0 39644.4 43858.1 44655.9 44673.3 44765.0 44929.0 9792.5 10026.3 10027.5 10032.8 10057.9 9094.9 9304.2 9319.0 11842.8 12099.0 11877.6 11945.3 11951.1 11962.3 11969.6 11735.4 11814.9 11822.6 11829.5 11839.0 11555.9 11702.6 11706.2 11710.9 11754.5 41039.6 41529.4 41571.8 41600.2 41668.7 3497.2 3511.7 3588.9 3664.1 3889.0 28851.9 29687.7 30073.9 30104.0 30727.8 2735.0 2737.6 2796.7 2805.2 2826.0 379557.1 383141.0 383571.0 383611.0 384231.1 37332.0 38070.2 65834.0 66136.0 66355.7 36858.8 37054.4 37075.1 37115.8 37141.0 16198.7 16349.0 16368.0 16392.9 16392.9 12940.0 13810.3 13866.1 13875.7 13900.0 7986.3 8500.4 8637.6 8730.6 8774.7 3132.3 3461.7 3539.9 3594.5 3599.6 1017.6 1021.9 1094.1 1164.3 1203.8 26804.6 30595.4 30806.7 30988.0 31009.5 1140.2 1200.0 1261.7 1287.2 1307.5 15780.8 15848.2 15873.6 16024.8 16058.4 654024.0 661146.0 662821.0 663325.0 665446.0 63061.0 63459.0 63593.0 63652.0 63652.0 1395.9 1569.7 1571.4 1582.7 1617.8 28788.0 30956.8 31094.7 31213.5 31937.4 51309.7 51532.5 51670.7 51706.5 51805.4 432448.0 434478.0 435122.0 435412.0 435423.6 24185.3 24216.9 24706.4 28563.6 28629.9 44000.3 44182.6 44286.6 44613.6 44615.8 36608.6 36780.1 36797.8 37560.4 38302.0 37948.4 38015.4 38087.2 38858.8 39040.0 36977.4 37581.6 38427.4 38486.6 38947.0 32664.0 34010.0 34035.0 34083.0 34132.3 24955.0 25065.7 25180.6 25244.6 25577.0 14:19:11 INFO - PROCESS | 2254 | 14:19:11 INFO - PROCESS | 2254 | [#2] jquery.html Cycles:180 Average:38221.21 Median:12156.93 stddev:113260.29 (931.7%) stddev-sans-first:113542.32 14:19:11 INFO - PROCESS | 2254 | Values: 348.5 374.6 409.8 412.1 413.6 16462.9 20104.6 21163.4 21829.2 21862.9 16032.1 18255.8 22116.8 22186.0 22205.3 5939.3 6225.9 6266.1 6275.4 6277.2 4520.1 6099.2 6206.5 6231.4 6453.4 6721.5 6727.9 6728.8 6729.6 6750.0 6418.9 6618.0 6629.7 6630.1 6697.4 5773.5 5800.4 5803.7 5811.8 5812.3 27267.6 27591.9 28022.7 28191.4 28194.3 2197.1 2260.5 2268.0 2698.3 2981.5 15267.2 15603.8 15800.6 15907.9 16111.3 1441.5 1547.0 1584.7 1617.4 1663.5 107759.0 112910.0 113297.0 117553.2 117650.0 11346.1 11639.8 11739.7 11772.6 11863.2 14631.2 14802.9 14844.0 14858.9 14880.9 7745.0 9486.6 9499.8 9509.1 9521.3 9788.6 9803.5 9832.7 9859.1 9877.4 5857.6 5918.6 6959.7 7067.7 7080.5 1679.5 1683.9 1902.2 1954.8 1958.4 903.8 934.6 978.0 1075.8 1077.5 20867.3 21487.8 21599.5 22312.0 22555.5 861.8 901.3 1003.3 1006.9 1069.7 11572.5 11907.6 11947.9 11962.3 11965.3 601117.9 684198.6 694543.5 709545.0 710382.0 137245.0 139662.0 146462.5 147426.3 150694.0 1063.6 1107.3 1125.7 1130.5 1130.7 18693.7 19153.0 19504.0 19509.1 19751.8 35580.6 37098.6 51105.4 52137.7 53085.7 80070.0 85610.0 86098.8 87847.0 89336.6 8397.9 8423.4 8517.5 8634.2 8860.3 12395.9 13056.7 13201.2 13214.6 13534.0 11197.2 11534.3 11682.5 11844.7 11958.2 10608.7 11307.9 11549.7 11756.3 11821.0 11422.4 11722.6 11895.3 11992.5 11997.5 8316.4 8366.7 8412.3 8486.8 8695.8 11335.7 11565.2 11800.5 11903.9 11921.9 14:19:11 INFO - PROCESS | 2254 | 14:19:11 INFO - PROCESS | 2254 | [#3] mootools.html Cycles:180 Average:5937.21 Median:4980.80 stddev:3295.77 (66.2%) stddev-sans-first:3287.70 14:19:11 INFO - PROCESS | 2254 | Values: 1441.6 1445.7 1642.9 1886.0 2029.2 8358.7 8760.3 8916.1 8923.6 8924.7 8720.7 9013.5 9023.9 9030.3 9033.0 2520.2 2539.6 2573.5 2578.5 2578.5 2530.3 2603.0 2604.0 2608.7 2620.5 2546.6 2564.1 2588.5 2592.1 2593.2 2554.3 2568.6 2584.5 2587.4 2595.9 2570.2 2581.2 2611.8 2617.0 2619.2 8801.9 9008.5 9031.6 9077.3 9083.7 5522.2 5668.2 5719.9 5723.0 5724.6 3592.4 3682.5 3706.5 3730.7 3749.9 1049.5 1059.2 1064.1 1072.8 1102.3 11983.6 12225.9 12418.4 12425.8 12425.9 4984.5 5061.8 5065.5 5083.6 5123.8 10655.8 10659.5 10660.6 10662.8 10664.6 5741.7 5765.6 5769.2 5769.7 5774.1 4578.0 4691.0 4977.1 5078.1 5154.7 4197.0 4217.6 4320.9 4363.1 4366.0 1361.9 1393.5 1398.3 1407.0 1412.0 948.3 963.9 975.7 976.2 1014.0 5974.2 6122.4 6138.2 6295.5 6300.2 427.2 453.9 473.4 475.9 475.9 4003.5 4084.3 4133.6 4209.2 4212.1 10774.4 11226.4 11232.6 11245.4 11254.4 10999.8 11027.3 11040.4 11063.9 11067.2 8256.0 8479.3 8485.7 8572.5 8596.3 5729.8 6002.5 6151.9 6177.3 6181.8 9831.4 9835.2 9997.0 10001.8 10020.0 9816.0 10189.7 10295.8 10470.2 10534.3 7151.7 7158.3 7717.3 7861.1 7995.2 8564.7 8568.0 8614.5 8625.7 8656.7 7529.7 7607.8 7621.4 7664.5 7759.0 7444.0 7453.9 7512.5 7626.8 7644.1 7185.4 7267.1 7309.0 7339.3 7340.1 4962.4 5008.1 5118.6 5218.3 5229.4 5094.9 5133.3 5214.6 5260.3 5335.4 14:19:11 INFO - PROCESS | 2254 | 14:19:11 INFO - PROCESS | 2254 | [#4] prototype.html Cycles:180 Average:5951.12 Median:6799.23 stddev:1918.36 (28.2%) stddev-sans-first:1876.82 14:19:11 INFO - PROCESS | 2254 | Values: 332.5 333.9 339.4 346.2 347.8 6785.6 6795.5 6803.0 6829.9 6841.9 5447.3 6782.9 6829.1 6829.4 6842.9 4152.3 4839.5 4960.7 4982.2 5068.1 4749.9 5093.2 5099.8 5110.6 5120.7 4157.8 5029.8 5050.8 5053.3 5083.8 4814.3 4867.1 5004.7 5040.6 5050.8 4301.9 4305.8 4306.1 4321.2 4322.1 5614.9 6268.9 6561.8 6583.2 6596.0 5979.3 5982.6 5984.7 5985.4 5991.8 7026.2 7252.9 7261.5 7282.7 7282.9 4163.5 4692.0 4836.6 4864.7 4871.2 6112.4 7626.9 7699.0 7706.1 7713.6 4918.9 4923.2 4925.2 4928.9 4936.2 4995.3 4999.6 5002.8 5003.5 5008.1 5919.4 5927.3 5945.2 5950.2 5967.8 7034.7 7323.2 7347.1 7356.1 7369.8 1656.0 1685.3 1686.9 1693.3 1697.5 998.5 1046.3 1048.3 1075.2 1076.9 5697.7 6708.7 6839.6 7043.9 7045.2 6743.9 7276.5 7711.2 7712.0 7750.1 6892.9 6961.2 6968.3 6971.9 6993.0 3295.9 4004.7 4040.1 4043.9 4071.1 7029.8 7411.3 7694.8 7973.0 8080.4 7093.4 7940.3 7945.4 7962.0 7982.6 8050.6 8061.8 8070.2 8076.7 8076.7 7149.1 7338.0 7627.2 7657.7 7665.4 7530.2 7551.6 7553.6 7555.8 7582.1 8056.9 8058.0 8059.1 8067.0 8080.3 4748.6 4790.8 4792.0 4797.0 4814.5 6327.0 7293.4 7541.2 7638.0 7643.8 7276.0 7346.8 7351.0 7368.8 7369.6 5943.9 7279.3 7312.3 7316.8 7338.3 7171.3 7174.9 7176.6 7187.8 7193.7 5634.2 6762.4 7085.9 7164.7 7320.2 6904.0 7069.9 7087.9 7228.1 7236.5 14:19:11 INFO - PROCESS | 2254 | 14:19:11 INFO - PROCESS | 2254 | [#5] yui.html Cycles:180 Average:18680.12 Median:4198.25 stddev:26444.95 (629.9%) stddev-sans-first:26484.69 14:19:11 INFO - PROCESS | 2254 | Values: 706.7 719.6 771.8 791.2 798.4 15536.6 15696.1 15717.3 15723.4 15748.8 14337.5 14505.6 14518.0 14523.3 14527.1 772.5 801.3 940.1 968.9 970.2 969.0 977.7 981.3 981.6 983.8 810.1 1045.5 1047.2 1047.8 1052.9 1014.0 1054.3 1056.8 1057.0 1059.3 784.9 785.8 786.6 787.7 788.8 15050.5 15465.7 15512.1 15517.9 15538.5 12016.5 12207.2 12262.0 12270.4 12530.8 10481.2 10589.9 10623.8 10782.1 10954.6 3603.0 3642.0 3659.1 3738.0 3874.6 61944.4 82420.6 83040.6 83553.6 84382.0 8108.6 9477.3 9577.6 9582.4 10308.9 21199.7 21378.8 21502.1 21512.9 21539.4 7544.7 7621.8 7683.1 7708.2 7782.0 3311.9 4014.6 4151.4 4245.1 4322.1 3121.5 3656.4 3700.4 3719.0 3726.5 561.9 582.5 669.7 671.5 675.1 556.7 604.2 606.9 608.3 625.3 8196.0 8310.1 8360.9 8507.8 8801.8 571.6 601.3 601.7 606.3 631.2 3863.4 3968.6 4096.5 4139.6 4254.9 96590.0 97401.0 97677.5 102993.5 104978.0 77904.6 79023.0 84609.3 86185.7 88196.2 65577.0 66105.7 66413.3 66710.0 66807.3 8071.0 8473.1 8487.0 8626.7 8662.7 46150.5 48657.5 50036.7 50317.0 50447.0 69058.7 69208.0 69490.0 70221.6 70769.3 11172.8 11428.1 11428.2 11643.6 11751.0 12018.2 12131.5 12386.6 12584.8 12970.9 9866.0 11042.8 11147.8 11581.8 11586.0 11677.6 11686.2 11747.5 11930.7 12114.2 11324.4 11442.0 11562.4 11770.7 12006.2 10039.5 10299.4 10314.2 10344.5 10348.6 8711.5 9950.7 10057.8 10225.9 10299.9 14:19:11 INFO - PROCESS | 2254 | -------- Summary: end -------- 14:19:11 INFO - PROCESS | 2254 | 14:19:12 INFO - TEST-INFO | 2254: exit 0 14:19:12 INFO - TEST-OK | dromaeo_css | took 1113181ms 14:19:12 INFO - TEST-START | kraken 14:19:12 INFO - operating with platform_type : mac_ 14:19:12 INFO - Initialising browser for kraken test... 14:19:12 INFO - TEST-INFO | started process 2256 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpDej9Ap/profile http://localhost:53918/getInfo.html) 14:19:14 INFO - PROCESS | 2256 | __metrics Screen width/height:1600/1200 14:19:14 INFO - PROCESS | 2256 | colorDepth:24 14:19:14 INFO - PROCESS | 2256 | Browser inner width/height: 1024/689 14:19:14 INFO - PROCESS | 2256 | __metrics 14:19:14 INFO - PROCESS | 2256 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:19:14 ERROR - PROCESS | 2256 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:19:15 INFO - TEST-INFO | 2256: exit 0 14:19:15 INFO - Browser initialized. 14:19:15 INFO - Running cycle 1/1 for kraken test... 14:19:15 INFO - TEST-INFO | started process 2259 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpDej9Ap/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:19:27 INFO - PROCESS | 2259 | RSS: Main: 161636352 14:19:27 INFO - PROCESS | 2259 | 14:19:29 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:53918/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53918/tests/kraken/driver.html?testName=audio-beat-detection) 14:19:30 INFO - PROCESS | 2259 | RSS: Main: 224071680 14:19:30 INFO - PROCESS | 2259 | 14:19:33 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:53918/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53918/tests/kraken/driver.html?testName=audio-dft) 14:19:34 INFO - PROCESS | 2259 | RSS: Main: 239837184 14:19:34 INFO - PROCESS | 2259 | 14:19:37 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:53918/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53918/tests/kraken/driver.html?testName=audio-fft) 14:19:37 INFO - PROCESS | 2259 | RSS: Main: 326008832 14:19:37 INFO - PROCESS | 2259 | 14:19:39 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:53918/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53918/tests/kraken/driver.html?testName=audio-oscillator) 14:19:40 INFO - PROCESS | 2259 | RSS: Main: 231346176 14:19:40 INFO - PROCESS | 2259 | 14:19:42 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:53918/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53918/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:19:43 INFO - PROCESS | 2259 | RSS: Main: 234074112 14:19:43 INFO - PROCESS | 2259 | 14:19:46 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:53918/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53918/tests/kraken/driver.html?testName=imaging-darkroom) 14:19:46 INFO - PROCESS | 2259 | RSS: Main: 271466496 14:19:46 INFO - PROCESS | 2259 | 14:19:49 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:53918/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53918/tests/kraken/driver.html?testName=imaging-desaturate) 14:19:50 INFO - PROCESS | 2259 | RSS: Main: 271798272 14:19:50 INFO - PROCESS | 2259 | 14:19:52 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:53918/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53918/tests/kraken/driver.html?testName=json-parse-financial) 14:19:53 INFO - PROCESS | 2259 | RSS: Main: 269385728 14:19:53 INFO - PROCESS | 2259 | 14:19:55 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:53918/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53918/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:19:55 INFO - PROCESS | 2259 | RSS: Main: 260833280 14:19:55 INFO - PROCESS | 2259 | 14:19:57 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:53918/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53918/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:19:58 INFO - PROCESS | 2259 | RSS: Main: 266936320 14:19:58 INFO - PROCESS | 2259 | 14:20:00 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:53918/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53918/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:20:01 INFO - PROCESS | 2259 | RSS: Main: 271319040 14:20:01 INFO - PROCESS | 2259 | 14:20:03 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:53918/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53918/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:20:04 INFO - PROCESS | 2259 | RSS: Main: 278478848 14:20:04 INFO - PROCESS | 2259 | 14:20:07 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:53918/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53918/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:20:07 INFO - PROCESS | 2259 | RSS: Main: 275447808 14:20:07 INFO - PROCESS | 2259 | 14:20:09 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:53918/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53918/tests/kraken/driver.html?testName=ai-astar) 14:20:09 INFO - PROCESS | 2259 | RSS: Main: 336674816 14:20:09 INFO - PROCESS | 2259 | 14:20:09 INFO - PROCESS | 2259 | __start_tp_report 14:20:09 INFO - PROCESS | 2259 | _x_x_mozilla_page_load 14:20:09 INFO - PROCESS | 2259 | _x_x_mozilla_page_load_details 14:20:09 INFO - PROCESS | 2259 | |i|pagename|runs| 14:20:09 INFO - PROCESS | 2259 | |0;ai-astar;114;114;120;112;111;112;114;113;114;133 14:20:09 INFO - PROCESS | 2259 | |1;audio-beat-detection;161;121;146;173;141;174;149;153;156;117 14:20:09 INFO - PROCESS | 2259 | |2;audio-dft;187;187;186;184;187;186;184;185;192;184 14:20:09 INFO - PROCESS | 2259 | |3;audio-fft;70;82;74;157;56;56;56;66;133;55 14:20:09 INFO - PROCESS | 2259 | |4;audio-oscillator;93;92;143;78;82;94;123;79;76;126 14:20:09 INFO - PROCESS | 2259 | |5;imaging-gaussian-blur;88;84;97;74;117;127;131;86;89;86 14:20:09 INFO - PROCESS | 2259 | |6;imaging-darkroom;93;95;94;95;93;96;95;94;93;94 14:20:09 INFO - PROCESS | 2259 | |7;imaging-desaturate;85;85;85;69;130;142;96;85;85;92 14:20:09 INFO - PROCESS | 2259 | |8;json-parse-financial;60;60;63;62;62;62;61;77;63;56 14:20:09 INFO - PROCESS | 2259 | |9;json-stringify-tinderbox;61;62;72;67;78;71;67;68;79;96 14:20:09 INFO - PROCESS | 2259 | |10;stanford-crypto-aes;80;76;79;81;80;79;79;79;80;84 14:20:09 INFO - PROCESS | 2259 | |11;stanford-crypto-ccm;148;147;128;126;125;124;126;125;145;140 14:20:09 INFO - PROCESS | 2259 | |12;stanford-crypto-pbkdf2;164;163;164;161;161;159;166;162;170;160 14:20:09 INFO - PROCESS | 2259 | |13;stanford-crypto-sha256-iterative;66;68;68;68;66;66;67;67;67;66 14:20:09 INFO - PROCESS | 2259 | __end_tp_report 14:20:09 INFO - PROCESS | 2259 | __start_cc_report 14:20:09 INFO - PROCESS | 2259 | _x_x_mozilla_cycle_collect,1919 14:20:09 INFO - PROCESS | 2259 | __end_cc_report 14:20:09 INFO - PROCESS | 2259 | __startTimestamp1467235209714__endTimestamp 14:20:09 INFO - PROCESS | 2259 | 14:20:09 INFO - PROCESS | 2259 | ------- Summary: start ------- 14:20:09 INFO - PROCESS | 2259 | Number of tests: 14 14:20:09 INFO - PROCESS | 2259 | 14:20:09 INFO - PROCESS | 2259 | [#0] ai-astar Cycles:10 Average:115.70 Median:114.00 stddev:6.55 (5.7%) stddev-sans-first:6.92 14:20:09 INFO - PROCESS | 2259 | Values: 114.0 114.0 120.0 112.0 111.0 112.0 114.0 113.0 114.0 133.0 14:20:09 INFO - PROCESS | 2259 | 14:20:09 INFO - PROCESS | 2259 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:154.50 stddev:19.12 (12.4%) stddev-sans-first:19.79 14:20:09 INFO - PROCESS | 2259 | Values: 161.0 121.0 146.0 173.0 141.0 174.0 149.0 153.0 156.0 117.0 14:20:09 INFO - PROCESS | 2259 | 14:20:09 INFO - PROCESS | 2259 | [#2] audio-dft Cycles:10 Average:186.20 Median:186.50 stddev:2.39 (1.3%) stddev-sans-first:2.52 14:20:09 INFO - PROCESS | 2259 | Values: 187.0 187.0 186.0 184.0 187.0 186.0 184.0 185.0 192.0 184.0 14:20:09 INFO - PROCESS | 2259 | 14:20:09 INFO - PROCESS | 2259 | [#3] audio-fft Cycles:10 Average:80.50 Median:61.00 stddev:35.63 (58.4%) stddev-sans-first:37.59 14:20:09 INFO - PROCESS | 2259 | Values: 70.0 82.0 74.0 157.0 56.0 56.0 56.0 66.0 133.0 55.0 14:20:09 INFO - PROCESS | 2259 | 14:20:09 INFO - PROCESS | 2259 | [#4] audio-oscillator Cycles:10 Average:98.60 Median:80.50 stddev:23.59 (29.3%) stddev-sans-first:24.93 14:20:09 INFO - PROCESS | 2259 | Values: 93.0 92.0 143.0 78.0 82.0 94.0 123.0 79.0 76.0 126.0 14:20:09 INFO - PROCESS | 2259 | 14:20:09 INFO - PROCESS | 2259 | [#5] imaging-gaussian-blur Cycles:10 Average:97.90 Median:86.00 stddev:19.81 (23.0%) stddev-sans-first:20.69 14:20:09 INFO - PROCESS | 2259 | Values: 88.0 84.0 97.0 74.0 117.0 127.0 131.0 86.0 89.0 86.0 14:20:09 INFO - PROCESS | 2259 | 14:20:09 INFO - PROCESS | 2259 | [#6] imaging-darkroom Cycles:10 Average:94.20 Median:94.50 stddev:1.03 (1.1%) stddev-sans-first:1.00 14:20:09 INFO - PROCESS | 2259 | Values: 93.0 95.0 94.0 95.0 93.0 96.0 95.0 94.0 93.0 94.0 14:20:09 INFO - PROCESS | 2259 | 14:20:09 INFO - PROCESS | 2259 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:85.00 stddev:22.65 (26.7%) stddev-sans-first:23.71 14:20:09 INFO - PROCESS | 2259 | Values: 85.0 85.0 85.0 69.0 130.0 142.0 96.0 85.0 85.0 92.0 14:20:09 INFO - PROCESS | 2259 | 14:20:09 INFO - PROCESS | 2259 | [#8] json-parse-financial Cycles:10 Average:62.60 Median:62.00 stddev:5.46 (8.8%) stddev-sans-first:5.71 14:20:09 INFO - PROCESS | 2259 | Values: 60.0 60.0 63.0 62.0 62.0 62.0 61.0 77.0 63.0 56.0 14:20:09 INFO - PROCESS | 2259 | 14:20:09 INFO - PROCESS | 2259 | [#9] json-stringify-tinderbox Cycles:10 Average:72.10 Median:71.50 stddev:10.27 (14.4%) stddev-sans-first:10.07 14:20:09 INFO - PROCESS | 2259 | Values: 61.0 62.0 72.0 67.0 78.0 71.0 67.0 68.0 79.0 96.0 14:20:09 INFO - PROCESS | 2259 | 14:20:09 INFO - PROCESS | 2259 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:80.00 stddev:2.00 (2.5%) stddev-sans-first:2.12 14:20:09 INFO - PROCESS | 2259 | Values: 80.0 76.0 79.0 81.0 80.0 79.0 79.0 79.0 80.0 84.0 14:20:09 INFO - PROCESS | 2259 | 14:20:09 INFO - PROCESS | 2259 | [#11] stanford-crypto-ccm Cycles:10 Average:133.40 Median:134.00 stddev:10.24 (7.6%) stddev-sans-first:9.40 14:20:09 INFO - PROCESS | 2259 | Values: 148.0 147.0 128.0 126.0 125.0 124.0 126.0 125.0 145.0 140.0 14:20:09 INFO - PROCESS | 2259 | 14:20:09 INFO - PROCESS | 2259 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.00 Median:163.50 stddev:3.23 (2.0%) stddev-sans-first:3.41 14:20:09 INFO - PROCESS | 2259 | Values: 164.0 163.0 164.0 161.0 161.0 159.0 166.0 162.0 170.0 160.0 14:20:09 INFO - PROCESS | 2259 | 14:20:09 INFO - PROCESS | 2259 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.87 14:20:09 INFO - PROCESS | 2259 | Values: 66.0 68.0 68.0 68.0 66.0 66.0 67.0 67.0 67.0 66.0 14:20:09 INFO - PROCESS | 2259 | -------- Summary: end -------- 14:20:09 INFO - PROCESS | 2259 | 14:20:10 INFO - TEST-INFO | 2259: exit 0 14:20:10 INFO - TEST-OK | kraken | took 57976ms 14:20:10 INFO - SUITE-END | took 1171s 14:20:10 INFO - Completed test suite (00:19:31) 14:20:10 INFO - javascript benchmark 14:20:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3467.479878018297, 3553.644635536445, 3557.09294129997, 3563.305155494678, 3628.147385364439, 5854.092615644571, 5859.1797148399255, 5919.822405327842, 5933.7626494940205, 5971.761129554818, 5903.793367232148, 5958.016927207005, 5970.104484327353, 5970.492508136814, 5971.283445986477, 4456.732596044231, 5250.842474725764, 5318.893622127545, 5361.5978801589845, 5429.647072940246, 5400.594955378343, 5423.674579525222, 5448.264484294629, 5458.235846981426, 5460.672359658413, 5356.866078348053, 5414.35027796665, 5440.319960004999, 5455.699936503491, 5461.290032295816, 5439.673619582818, 5464.043792336325, 5480.958617862593, 5488.204210389511, 5559.499645031967, 5197.688138711689, 5294.788208471657, 5339.5461385782255, 5405.945940540583, 5409.188621706736, 5064.0, 5861.384554621746, 5875.118732190205, 5884.3527212007075, 5938.435848594377, 6263.31103578606, 6310.747570097191, 6311.968440157816, 6313.084602732624, 6320.6207627542035, 6033.155358249848, 6138.324784273726, 6281.403266689657, 6373.490120790326, 6382.968085159591, 6035.6076855004285, 6043.906675851339, 6060.363661815446, 6070.96964515179, 6073.635581865102, 6420.293767685551, 6421.935780642228, 6426.3573642635365, 6431.485481161496, 6433.453156481752, 6147.600405973598, 6238.532110091671, 6290.968545157337, 6325.335839736761, 6330.177076979963, 6349.9682501587195, 6354.618722876642, 6355.968220158962, 6359.872802544016, 6370.872582548416, 6225.097360882737, 6283.465905398001, 6283.528735344776, 6297.307296197415, 6305.842353941188, 6203.503719702413, 6223.408776166257, 6288.748450062038, 6303.149074874925, 6303.842403939938, 5038.244263360452, 5064.645474816727, 5081.8729531762, 5085.821996230115, 5095.0, 4576.084783043405, 4614.123316569908, 4627.814887404534, 4632.536746325341, 4645.117427688729, 6009.338972712998, 6110.382061044019, 6121.173641558422, 6133.907991380132, 6141.140240366263, 6334.081558174039, 6367.586106903036, 6369.331220221903, 6375.139356186948, 6375.171227740457, 5911.290645122613, 6060.0, 6074.726637301332, 6098.32918378978, 6098.725557349841, 5483.177523371446, 5516.0, 5527.834164975057, 5567.137093750394, 5570.136628822539, 6520.413162815369, 6521.836954076186, 6539.215294164731, 6574.8356291093105, 6583.44040756541, 6237.750489980532, 6316.810495685137, 6338.936610633835, 6351.269603995414, 6353.872922541431, 6467.644279564481, 6558.770443034471, 6570.737170513126, 6594.142761440982, 6602.570832895846, 6282.434580887742, 6300.873982520416, 6309.873802524015, 6314.147590075281, 6315.305316415099, 6218.253809542884, 6281.96859015702, 6291.1192433058495, 6356.586821856749, 6365.363463653783, 6202.224721909762, 6263.404976527223, 6284.591501552384, 6293.433590976834, 6298.905516417349, 5682.602217844877, 5889.057750759858, 6255.280642726145, 6266.811995640138, 6299.842503937438, 6017.308009578955, 6075.878482430238, 6122.550631083031, 6148.354422785722, 6235.314115447207, 5622.409646987007, 6260.373962603703, 6286.937130628635, 6296.150019747275, 6296.5592408530965, 4952.0, 6230.439260466398, 6232.501399888089, 6251.124842522141, 6256.843578910563], "value": 5857.402384227477, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [518.9766460509279, 524.8714065054062, 549.8130635583904, 566.2751677852349, 599.9860236200823, 33047.0, 33539.0, 38769.80615096924, 39503.0, 39644.40533392001, 43858.12283754323, 44655.88360290994, 44673.329900051525, 44765.0, 44929.0, 9792.461414622176, 10026.348287361297, 10027.498625068754, 10032.849507257397, 10057.949710251438, 9094.86357704635, 9304.209142222919, 9318.974912759591, 11842.822357664641, 12098.97158741508, 11877.584284550043, 11945.343006134659, 11951.10366722495, 11962.342071186082, 11969.581064662738, 11735.354555499443, 11814.88185118155, 11822.645320640395, 11829.467673954692, 11838.99368553674, 11555.942220288845, 11702.590409335633, 11706.239094458833, 11710.941445292805, 11754.471048802825, 41039.58960410387, 41529.37705934414, 41571.792141039405, 41600.1679966402, 41668.749937501925, 3497.178163131662, 3511.7015053720465, 3588.946165807489, 3664.120611053355, 3888.9611103889165, 28851.855740721163, 29687.70312296871, 30073.947411840698, 30104.0, 30727.846360768275, 2734.9726502734916, 2737.6441062661725, 2796.706345833699, 2805.242584502173, 2825.9717402825913, 379557.10221448995, 383141.0, 383571.0, 383611.0, 384231.07884460676, 37332.0, 38070.238595227944, 65834.0, 66136.0, 66355.66822165858, 36858.8157059213, 37054.44418333727, 37075.07312317214, 37115.81442092772, 37141.0, 16198.676026479405, 16349.0, 16368.017918924665, 16392.918035409748, 16392.918035409984, 12940.0, 13810.309484525733, 13866.098703584235, 13875.722485550434, 13900.0, 7986.32116270112, 8500.36247281444, 8637.56812159402, 8730.563471826383, 8774.692885748967, 3132.3422081362714, 3461.7230621550216, 3539.94690079649, 3594.5327107476382, 3599.6400359963795, 1017.5675337981328, 1021.9284650074572, 1094.0645747885444, 1164.2839653612966, 1203.8314635950974, 26804.59793103105, 30595.388092238474, 30806.69193308083, 30988.0, 31009.534856977163, 1140.201858698914, 1199.9700007499882, 1261.7476504699098, 1287.1826390242263, 1307.522754194712, 15780.842191578167, 15848.207589620704, 15873.603159920864, 16024.75962860558, 16058.43795467153, 654024.0, 661146.0, 662821.0, 663325.0, 665446.0, 63061.0, 63459.0, 63593.0, 63652.0, 63652.0, 1395.8534353892899, 1569.7096037233148, 1571.4342836578594, 1582.6863703126608, 1617.765424013535, 28788.0, 30956.84521577468, 31094.689053109178, 31213.531797023516, 31937.36125277435, 51309.743451284, 51532.484675152766, 51670.74164629153, 51706.48293517017, 51805.37362384597, 432448.0, 434478.0, 435122.0, 435412.0, 435423.6457635383, 24185.274441766775, 24216.87891560531, 24706.382340441633, 28563.571546426403, 28629.856850716445, 44000.33999489946, 44182.55817441784, 44286.55713442824, 44613.553864462236, 44615.77692111519, 36608.633913661586, 36780.080497987765, 36797.81601092085, 37560.43659345058, 38302.0, 37948.430773538974, 38015.422057639786, 38087.238255235294, 38858.80570597129, 39040.0, 36977.44533832048, 37581.62418375781, 38427.42358864675, 38486.6151338483, 38947.0, 32664.020079397655, 34010.0, 34035.0, 34082.97751067472, 34132.317353653285, 24955.0, 25065.74934250634, 25180.622290665287, 25244.62133068042, 25577.0], "value": 19192.486863983897, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.5294851949868, 374.5991788785999, 409.80534246233026, 412.0825339649973, 413.57195302861544, 16462.917685411587, 20104.59790804183, 21163.365099047016, 21829.235976740816, 21862.89068554657, 16032.118233497153, 18255.817441825577, 22116.778832211672, 22186.0, 22205.333839984825, 5939.346671866102, 6225.875482490347, 6266.122742816009, 6275.435210831024, 6277.246730392337, 4520.11857687751, 6099.207103076594, 6206.534509911752, 6231.439170474657, 6453.386928241809, 6721.49588780841, 6727.932720672779, 6728.798136055926, 6729.629870357128, 6750.0, 6418.903716444257, 6618.040384144296, 6629.7016634251095, 6630.071789949411, 6697.397234248917, 5773.480386765169, 5800.361960184377, 5803.738831752581, 5811.825645230608, 5812.273465816773, 27267.590986135223, 27591.86204068987, 28022.71977280242, 28191.436171276666, 28194.295142621395, 2197.0772275644267, 2260.49138943738, 2268.0247493577754, 2698.2984424049887, 2981.508051171554, 15267.236638168159, 15603.843961560353, 15800.604984875356, 15907.920460397623, 16111.274992625244, 1441.4882716635652, 1546.9690606187926, 1584.6751415959816, 1617.4096454793917, 1663.467690339092, 107759.0, 112909.99999999919, 113297.0, 117553.23670144955, 117650.0, 11346.092312614972, 11639.825402618968, 11739.706507337385, 11772.646820595395, 11863.16957812962, 14631.195284259467, 14802.851971480362, 14844.03513771623, 14858.925705371405, 14880.851191488164, 7744.961275193701, 9486.620535178654, 9499.810003799885, 9509.144177024102, 9521.28590355726, 9788.55951482185, 9803.460809655395, 9832.655857044969, 9859.063388978035, 9877.357971731815, 5857.619254748428, 5918.556108291896, 6959.652017399109, 7067.717291308393, 7080.468964827659, 1679.5143188081709, 1683.9494815155565, 1902.2391043582402, 1954.8142926421967, 1958.3733205374144, 903.8418276801533, 934.6167671845707, 977.9657711980188, 1075.7579544602402, 1077.4881931082673, 20867.269645562334, 21487.785122148893, 21599.46001349979, 22312.0, 22555.548889022455, 861.8448679237797, 901.3435776788465, 1003.3177439341172, 1006.9194464442827, 1069.6577095329576, 11572.537098516133, 11907.642770716719, 11947.940260298818, 11962.342071186169, 11965.282083075042, 601117.9496922649, 684198.5790071018, 694543.5272823604, 709545.0, 710382.0, 137245.0, 139662.0, 146462.535374647, 147426.2628686871, 150694.0, 1063.6011495689118, 1107.291333546531, 1125.735452168756, 1130.5025788652965, 1130.711668524521, 18693.719594205824, 19153.0, 19504.0, 19509.12208950629, 19751.80248197557, 35580.64419355773, 37098.62901370952, 51105.383562601295, 52137.7393113032, 53085.734571326895, 80070.0, 85610.0, 86098.84752881229, 87847.0, 89336.553317233, 8397.874031889405, 8423.368247381593, 8517.48895066298, 8634.222919937236, 8860.29117670572, 12395.917673753718, 13056.673583160496, 13201.20792752438, 13214.603561893158, 13533.984951128508, 11197.160212983896, 11534.250273732181, 11682.47428865686, 11844.70388240301, 11958.222715523463, 10608.681739547827, 11307.886921130683, 11549.711257218301, 11756.294622322688, 11821.0, 11422.428878556206, 11722.58970936013, 11895.345755983159, 11992.460339284928, 11997.520099195934, 8316.41785075039, 8366.665333386596, 8412.327013839, 8486.830263394573, 8695.782605434915, 11335.71660708456, 11565.248258863146, 11800.468978896142, 11903.880961190278, 11921.94039029834], "value": 10192.44661563205, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1441.6035590212691, 1445.6530432696156, 1642.926068326925, 1885.9811401885977, 2029.168041103148, 8358.707445239417, 8760.299176065915, 8916.108389161096, 8923.553822308892, 8924.687635932736, 8720.651173953034, 9013.549322533863, 9023.864642030374, 9030.277577793777, 9033.0, 2520.206135067457, 2539.5555777738914, 2573.5496288149593, 2578.458523710023, 2578.5487539680576, 2530.3168144600945, 2603.0, 2604.0365064926004, 2608.686957565095, 2620.489004644095, 2546.618007298911, 2564.0513010186255, 2588.48230353929, 2592.0927675313583, 2593.209071233273, 2554.3486410965083, 2568.5761849294845, 2584.508943300767, 2587.430765231646, 2595.8961641534315, 2570.2160840943507, 2581.2256323103184, 2611.8041146913865, 2617.0055378956067, 2619.2142357292737, 8801.911980880173, 9008.549572521413, 9031.593578288992, 9077.319201059881, 9083.68207112748, 5522.22688823565, 5668.206451096849, 5719.885602287931, 5723.027085395493, 5724.570657200727, 3592.371335016388, 3682.4844521766972, 3706.4810926470313, 3730.664240218366, 3749.925001499982, 1049.5329578337644, 1059.2214722179192, 1064.1327318235612, 1072.8122578548723, 1102.311055590256, 11983.64049078529, 12225.938870305681, 12418.379081045912, 12425.75148497025, 12425.93787031059, 4984.476629953875, 5061.848144555669, 5065.468125846733, 5083.61872859537, 5123.820666276737, 10655.786884262272, 10659.520321585547, 10660.62687805923, 10662.840057399146, 10664.626738064286, 5741.712914354265, 5765.625234359753, 5769.249997500298, 5769.740361683735, 5774.076147816413, 4577.977110114494, 4690.991436841027, 4977.129002424634, 5078.13671675816, 5154.742262886841, 4196.979015104905, 4217.641500472433, 4320.891977700583, 4363.149185908717, 4366.039471316305, 1361.9319034048258, 1393.4983405973842, 1398.3427788939182, 1406.9507567235098, 1411.9505817296345, 948.2745699539857, 963.8843338799248, 975.7414285214423, 976.2482888176065, 1014.0467960117613, 5974.163617093611, 6122.418370254819, 6138.171346868205, 6295.464885484694, 6300.243970723543, 427.16276098846606, 453.94004998329274, 473.41769623363456, 475.8603145466588, 475.9291593913694, 4003.459532963071, 4084.305668036441, 4133.565975572582, 4209.158168366339, 4212.073343864345, 10774.407407592658, 11226.438678066064, 11232.550697972152, 11245.381504017194, 11254.437278136224, 10999.780004399867, 11027.283226590245, 11040.447977601088, 11063.948924852126, 11067.225294229487, 8255.958720206481, 8479.279261262862, 8485.745427637181, 8572.52851093196, 8596.312295016383, 5729.770809167587, 6002.489788368038, 6151.876962460815, 6177.320494745484, 6181.84545386369, 9831.410115393099, 9835.164011058854, 9996.950015249877, 10001.849972250277, 10020.0, 9815.950920245354, 10189.694309170736, 10295.794084118426, 10470.214733894836, 10534.262601617813, 7151.713931442684, 7158.319959603829, 7717.344025757873, 7861.056673199253, 7995.240452157036, 8564.700235491728, 8568.0, 8614.526201059001, 8625.69810056645, 8656.653733850575, 7529.698812047457, 7607.847843043219, 7621.428392870668, 7664.463487555818, 7758.991331126917, 7443.995060666957, 7453.850922981402, 7512.5492470451945, 7626.8093297668, 7644.12092609357, 7185.389241914496, 7267.0552828132, 7308.976743256055, 7339.339459448675, 7340.11918569775, 4962.404511458503, 5008.148614735576, 5118.616103792156, 5218.321618189611, 5229.40503146544, 5094.923576146287, 5133.263587904031, 5214.5567626750635, 5260.263563101245, 5335.413104558418], "value": 4721.7771816707145, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.54345964674724, 333.8614474992878, 339.40817565617255, 346.15192777694637, 347.7704714888174, 6785.6267905265195, 6795.456363490921, 6802.999999999994, 6829.897551536725, 6841.897371539425, 5447.319085114361, 6782.898256526144, 6829.146356705412, 6829.351211634899, 6842.863142737142, 4152.252594532975, 4839.4918533554, 4960.727160006199, 4982.153033984231, 5068.06240845443, 4749.90752127011, 5093.185090385539, 5099.7960081596875, 5110.616703747215, 5120.743962801864, 4157.792110394484, 5029.773660185282, 5050.772715227824, 5053.317802096725, 5083.822066227683, 4814.277858321245, 4867.075255701406, 5004.674696144775, 5040.571551418134, 5050.823221187259, 4301.935470967938, 4305.763183024932, 4306.074194048295, 4321.157374312011, 4322.135572885404, 5614.887702245932, 6268.934281172212, 6561.80314590563, 6583.210014798255, 6596.010598410229, 5979.252593425822, 5982.611130276518, 5984.670843103628, 5985.401459854023, 5991.760329586811, 7026.156861176692, 7252.854942901113, 7261.491695581311, 7282.708691652328, 7282.927170728331, 4163.458750362433, 4691.967767091234, 4836.613070954315, 4864.708117512961, 4871.196252618313, 6112.358202388774, 7626.923730762733, 7699.0, 7706.113796913371, 7713.5757533335645, 4918.926216106761, 4923.236898280772, 4925.236588328815, 4928.901421971612, 4936.2102063669645, 4995.325631039836, 4999.575036121898, 5002.849914502571, 5003.49965003504, 5008.073506401327, 5919.408059194132, 5927.288725352985, 5945.16767652529, 5950.19672344228, 5967.761289548456, 7034.6834392452465, 7323.231060738653, 7347.08161479815, 7356.1172659280155, 7369.77890663281, 1655.96688066238, 1685.3174464341962, 1686.890352127108, 1693.3395975569538, 1697.4992377248495, 998.5007496251874, 1046.2571574182264, 1048.2662136504478, 1075.1774892207468, 1076.9084627806567, 5697.686627235459, 6708.698108585126, 6839.623820689811, 7043.859122817515, 7045.154581450156, 6743.898841517381, 7276.490645654753, 7711.151773304932, 7712.0, 7750.108737495148, 6892.862142757117, 6961.199462061928, 6968.338007889242, 6971.8605627887155, 6992.965035174791, 3295.9452975048234, 4004.6596039336982, 4040.1313717550865, 4043.939340909889, 4071.1043570414463, 7029.753958611424, 7411.332980031823, 7694.769156925301, 7972.960135199287, 8080.393970452122, 7093.3970612498515, 7940.325072368798, 7945.364370850318, 7961.960190199012, 7982.600869956479, 8050.59747012647, 8061.838763224585, 8070.1526339734655, 8076.71731489395, 8076.71731489395, 7149.0706208192605, 7337.963310183415, 7627.207606212646, 7657.731979380695, 7665.42509311815, 7530.246975302426, 7551.622418879144, 7553.622318883924, 7555.848883022419, 7582.052243469567, 8056.919430805851, 8058.033036035713, 8059.0732065810835, 8067.0, 8080.313173380328, 4748.62011039123, 4790.760461976957, 4791.976040119777, 4796.9760151199025, 4814.494478079751, 6326.956052251327, 7293.393552527335, 7541.170471248268, 7638.045244344457, 7643.808904777425, 7275.963620181865, 7346.77959661211, 7350.96324518374, 7368.778936631696, 7369.631518424165, 5943.940560594338, 7279.308465695751, 7312.268773122645, 7316.817079573053, 7338.266173382833, 7171.318724721144, 7174.892376614459, 7176.605286709281, 7187.820304492429, 7193.748218812526, 5634.211210430461, 6762.391384775394, 7085.858282834418, 7164.746169420435, 7320.15818180916, 6903.965480172567, 7069.929300706927, 7087.873637908504, 7228.060352154186, 7236.493445458767], "value": 5307.880385242431, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.6819931031038, 719.6221983458685, 771.7877583664495, 791.2483141016036, 798.4371018432006, 15536.611584710388, 15696.058236505818, 15717.292721827516, 15723.449679261199, 15748.842511574881, 14337.498187563437, 14505.637359066028, 14517.983741138125, 14523.273836308168, 14527.055741376804, 772.4785769605536, 801.2708435323857, 940.0552444792974, 968.8934217236099, 970.1995853420921, 968.9922480620147, 977.6724797192949, 981.2738573455663, 981.6269817469351, 983.8130755156498, 810.1250649298743, 1045.5347370420166, 1047.240750455921, 1047.8113939490888, 1052.8578641883362, 1013.9797204055915, 1054.346305290721, 1056.815057364958, 1057.04865620941, 1059.2849826367171, 784.8861915022347, 785.8074771680974, 786.6145588661572, 787.7321710618418, 788.8027993001749, 15050.473233436887, 15465.690686186213, 15512.14683192424, 15517.922410387988, 15538.456154034668, 12016.519339226508, 12207.206531575419, 12262.019038476901, 12270.44782984759, 12530.81203781944, 10481.161507079416, 10589.894101059044, 10623.831378548353, 10782.13742900574, 10954.616588419447, 3603.0451930238246, 3642.0, 3659.121810765397, 3737.9533730555218, 3874.554426240962, 61944.380556194315, 82420.58789706073, 83040.58479707563, 83553.58223208845, 84381.99999999939, 8108.5945702714625, 9477.336586438883, 9577.569009394594, 9582.425054496753, 10308.948455257825, 21199.68200476994, 21378.824164670783, 21502.13991440356, 21512.892435537724, 21539.353819385444, 7544.735934242275, 7621.809454763565, 7683.116441609175, 7708.190639982833, 7782.027246594176, 3311.93376132476, 4014.558398576154, 4151.41880136775, 4245.087306229176, 4322.135572885372, 3121.547375630521, 3656.3784156693428, 3700.3524383232825, 3718.9628103719156, 3726.4782930389765, 561.901667208237, 582.4932308891292, 669.6517810738486, 671.5332843673698, 675.1155985658803, 556.6743455078744, 604.208486882177, 606.9136246119485, 608.3490664988508, 625.252822876658, 8195.95902020486, 8310.127436619188, 8360.874586881202, 8507.829843403097, 8801.779955501035, 571.5541877335685, 601.2694576090072, 601.6781022153215, 606.254307202135, 631.166859745132, 3863.3818589025623, 3968.6372121966397, 4096.549379568245, 4139.648129908992, 4254.914901702011, 96590.0, 97401.0, 97677.5348369775, 102993.48503257586, 104978.0, 77904.61047694726, 79023.0, 84609.30781384338, 86185.70721439183, 88196.23607527814, 65577.03268901941, 66105.66947165233, 66413.33586664168, 66710.0, 66807.32981675497, 8071.0, 8473.087366235346, 8487.0, 8626.741197764077, 8662.653493860427, 46150.53849461462, 48657.5134248653, 50036.74981625069, 50317.0, 50447.0, 69058.65470672614, 69208.0, 69489.9576506363, 70221.64889175522, 70769.29230707628, 11172.776544468903, 11428.085753139896, 11428.171632467667, 11643.59247426336, 11751.0, 12018.218815776947, 12131.514739410324, 12386.5664701735, 12584.811227831407, 12970.870291297344, 9865.95067024689, 11042.779144416905, 11147.83278250843, 11581.768364632828, 11586.0, 11677.649670509898, 11686.18196726221, 11747.530098796295, 11930.701732456411, 12114.21257618252, 11324.37715925632, 11442.027427668741, 11562.421878905852, 11770.656669344304, 12006.21959572625, 10039.548220330249, 10299.400000999249, 10314.226433017404, 10344.53449594755, 10348.646085242362, 8711.520866352157, 9950.701478955643, 10057.849132263169, 10225.897741022494, 10299.948500257751], "value": 7103.839347751353, "unit": "score"}], "name": "dromaeo_css", "value": 7672.640776984846, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 120.0, 112.0, 111.0, 112.0, 114.0, 113.0, 114.0, 133.0], "value": 115.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 121.0, 146.0, 173.0, 141.0, 174.0, 149.0, 153.0, 156.0, 117.0], "value": 149.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 187.0, 186.0, 184.0, 187.0, 186.0, 184.0, 185.0, 192.0, 184.0], "value": 186.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 82.0, 74.0, 157.0, 56.0, 56.0, 56.0, 66.0, 133.0, 55.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 143.0, 78.0, 82.0, 94.0, 123.0, 79.0, 76.0, 126.0], "value": 98.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 97.0, 74.0, 117.0, 127.0, 131.0, 86.0, 89.0, 86.0], "value": 97.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 94.0, 95.0, 93.0, 96.0, 95.0, 94.0, 93.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 69.0, 130.0, 142.0, 96.0, 85.0, 85.0, 92.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 63.0, 62.0, 62.0, 62.0, 61.0, 77.0, 63.0, 56.0], "value": 62.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 72.0, 67.0, 78.0, 71.0, 67.0, 68.0, 79.0, 96.0], "value": 72.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 79.0, 81.0, 80.0, 79.0, 79.0, 79.0, 80.0, 84.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 128.0, 126.0, 125.0, 124.0, 126.0, 125.0, 145.0, 140.0], "value": 133.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 161.0, 161.0, 159.0, 166.0, 162.0, 170.0, 160.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 68.0, 68.0, 66.0, 66.0, 67.0, 67.0, 67.0, 66.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1495.3000000000002, "alertThreshold": 2.0}]} 14:20:10 INFO - Return code: 0 14:20:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:20:11 ERROR - # TBPL SUCCESS # 14:20:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:20:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:20:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:20:11 INFO - 2016-06-29 14:20:11.051 screenresolution[2263:72279] starting screenresolution argv=screenresolution get 14:20:11 INFO - 2016-06-29 14:20:11.054 screenresolution[2263:72279] Display 0: 1600x1200x32@60 14:20:11 INFO - 2016-06-29 14:20:11.060 screenresolution[2264:72282] starting screenresolution argv=screenresolution list 14:20:11 INFO - Available Modes on Display 0 14:20:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:20:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:20:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:20:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:20:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:20:11 INFO - Intel Iris: 14:20:11 INFO - Chipset Model: Intel Iris 14:20:11 INFO - Type: GPU 14:20:11 INFO - Bus: Built-In 14:20:11 INFO - VRAM (Dynamic, Max): 1536 MB 14:20:11 INFO - Vendor: Intel (0x8086) 14:20:11 INFO - Device ID: 0x0a2e 14:20:11 INFO - Revision ID: 0x0009 14:20:11 INFO - Displays: 14:20:11 INFO - Display: 14:20:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:20:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:20:11 INFO - Display Serial Number: 1600x1200 60 14:20:11 INFO - Main Display: Yes 14:20:11 INFO - Mirror: Off 14:20:11 INFO - Online: Yes 14:20:11 INFO - Rotation: Supported 14:20:11 INFO - Return code: 0 14:20:11 INFO - Running post-action listener: _resource_record_post_action 14:20:11 INFO - Running post-run listener: _resource_record_post_run 14:20:12 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 180224; Write bytes: 494479360; Read time: 4; Write time: 1778 14:20:12 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 188985856; Write bytes: 187508736; Read time: 17657; Write time: 413 14:20:12 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 155648; Write bytes: 296181760; Read time: 3; Write time: 1334 14:20:12 INFO - Running post-run listener: _upload_blobber_files 14:20:12 INFO - Blob upload gear active. 14:20:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:20:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:20:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:20:12 INFO - (blobuploader) - INFO - Open directory for files ... 14:20:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:20:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:20:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:20:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:20:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:20:13 INFO - (blobuploader) - INFO - Done attempting. 14:20:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:20:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:20:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:20:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:20:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:20:14 INFO - (blobuploader) - INFO - Done attempting. 14:20:14 INFO - (blobuploader) - INFO - Iteration through files over. 14:20:14 INFO - Return code: 0 14:20:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:20:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:20:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8db6b11b8b03a2321781af940c753d1950a73621bc179c51b3cb98d9ba93598a570f9e3a5c903bc715b32ee3bad120cc31323a378c711144a4df0db5d82ada5e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b2cb0ba84c8d6bdb5d6955766efcd2fa9bb93a35553451c0541b186b598915082873929ad906952470cfa3464768d06a631fdd1ba492deace98b7c9da7361a89"} 14:20:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:20:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:20:14 INFO - Contents: 14:20:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8db6b11b8b03a2321781af940c753d1950a73621bc179c51b3cb98d9ba93598a570f9e3a5c903bc715b32ee3bad120cc31323a378c711144a4df0db5d82ada5e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b2cb0ba84c8d6bdb5d6955766efcd2fa9bb93a35553451c0541b186b598915082873929ad906952470cfa3464768d06a631fdd1ba492deace98b7c9da7361a89"} 14:20:14 INFO - Running post-run listener: copy_logs_to_upload_dir 14:20:14 INFO - Copying logs to upload dir... 14:20:14 INFO - mkdir: /builds/slave/test/build/upload/logs 14:20:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.322526 ========= master_lag: 2.43 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-29 14:20:16.775462) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 14:20:16.779119) ========= 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.Lucw8HYaCF/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.SV1WKKrq7v/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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/8db6b11b8b03a2321781af940c753d1950a73621bc179c51b3cb98d9ba93598a570f9e3a5c903bc715b32ee3bad120cc31323a378c711144a4df0db5d82ada5e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b2cb0ba84c8d6bdb5d6955766efcd2fa9bb93a35553451c0541b186b598915082873929ad906952470cfa3464768d06a631fdd1ba492deace98b7c9da7361a89"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467222177/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011591 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467222177/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8db6b11b8b03a2321781af940c753d1950a73621bc179c51b3cb98d9ba93598a570f9e3a5c903bc715b32ee3bad120cc31323a378c711144a4df0db5d82ada5e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b2cb0ba84c8d6bdb5d6955766efcd2fa9bb93a35553451c0541b186b598915082873929ad906952470cfa3464768d06a631fdd1ba492deace98b7c9da7361a89"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 14:20:16.817465) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 14:20:16.817813) ========= 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.Lucw8HYaCF/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.SV1WKKrq7v/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.005388 ========= master_lag: 0.26 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 14:20:17.086199) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 14:20:17.086536) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 14:20:17.086992) ========= ========= Total master_lag: 2.80 =========