builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0058 starttime: 1467671582.07 results: success (0) buildid: 20160704064557 builduid: 27c77172f1ec4ef2807b5c6d2a070747 revision: ebaf4086c18c2d1e3f0af12ade55840413342bc3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 15:33:02.065356) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 15:33:02.065829) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 15:33:02.066112) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 15:33:02.094462) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 15:33:02.094759) ========= 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.en1b4GqkNQ/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.MHCkN3CGSo/Listeners TMPDIR=/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-04 15:33:02-- 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% 30.2M=0s 2016-07-04 15:33:02 (30.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.613457 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 15:33:02.734332) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 15:33:02.734935) ========= 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.en1b4GqkNQ/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.MHCkN3CGSo/Listeners TMPDIR=/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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.028163 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 15:33:02.794208) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-04 15:33:02.794524) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ebaf4086c18c2d1e3f0af12ade55840413342bc3 --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 ebaf4086c18c2d1e3f0af12ade55840413342bc3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.en1b4GqkNQ/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.MHCkN3CGSo/Listeners TMPDIR=/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-04 15:33:02,868 truncating revision to first 12 chars 2016-07-04 15:33:02,868 Setting DEBUG logging. 2016-07-04 15:33:02,868 attempt 1/10 2016-07-04 15:33:02,868 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ebaf4086c18c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-04 15:33:03,980 unpacking tar archive at: mozilla-beta-ebaf4086c18c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.370353 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-04 15:33:04.186990) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 15:33:04.187375) ========= script_repo_revision: ebaf4086c18c2d1e3f0af12ade55840413342bc3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 15:33:04.187803) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 15:33:04.188076) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 15:33:04.206593) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-07-04 15:33:04.207043) ========= /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.en1b4GqkNQ/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.MHCkN3CGSo/Listeners TMPDIR=/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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 15:33:04 INFO - MultiFileLogger online at 20160704 15:33:04 in /builds/slave/test 15:33:04 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 15:33:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:33:04 INFO - {'append_to_log': False, 15:33:04 INFO - 'base_work_dir': '/builds/slave/test', 15:33:04 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:33:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:33:04 INFO - 'branch': 'Mozilla-Beta', 15:33:04 INFO - 'buildbot_json_path': 'buildprops.json', 15:33:04 INFO - 'config_files': ('talos/mac_config.py',), 15:33:04 INFO - 'default_actions': ('clobber', 15:33:04 INFO - 'read-buildbot-config', 15:33:04 INFO - 'download-and-extract', 15:33:04 INFO - 'populate-webroot', 15:33:04 INFO - 'create-virtualenv', 15:33:04 INFO - 'install', 15:33:04 INFO - 'run-tests'), 15:33:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:33:04 INFO - 'download_minidump_stackwalk': True, 15:33:04 INFO - 'download_symbols': 'ondemand', 15:33:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:33:04 INFO - 'tooltool.py': '/tools/tooltool.py', 15:33:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:33:04 INFO - '/tools/misc-python/virtualenv.py')}, 15:33:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:33:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:33:04 INFO - 'installer_path': 'installer.exe', 15:33:04 INFO - 'log_level': 'info', 15:33:04 INFO - 'log_name': 'talos', 15:33:04 INFO - 'log_to_console': True, 15:33:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:33:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:33:04 INFO - 'opt_config_files': (), 15:33:04 INFO - 'pip_index': False, 15:33:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:33:04 INFO - 'cmd': ('bash', 15:33:04 INFO - '-c', 15:33:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:33:04 INFO - 'enabled': True, 15:33:04 INFO - 'halt_on_failure': False, 15:33:04 INFO - 'name': 'check_screen_resolution'},), 15:33:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:33:04 INFO - 'cmd': ('bash', 15:33:04 INFO - '-c', 15:33:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:33:04 INFO - 'enabled': True, 15:33:04 INFO - 'halt_on_failure': False, 15:33:04 INFO - 'name': 'check_screen_resolution'},), 15:33:04 INFO - 'run_cmd_checks_enabled': True, 15:33:04 INFO - 'sps_profile': False, 15:33:04 INFO - 'sps_profile_interval': 0, 15:33:04 INFO - 'suite': 'dromaeojs', 15:33:04 INFO - 'system_bits': '32', 15:33:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:33:04 INFO - 'title': 't-yosemite-r7-0058', 15:33:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:33:04 INFO - 'use_talos_json': True, 15:33:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:33:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:33:04 INFO - 'work_dir': 'build'} 15:33:04 INFO - ##### 15:33:04 INFO - ##### Running clobber step. 15:33:04 INFO - ##### 15:33:04 INFO - Running pre-action listener: _resource_record_pre_action 15:33:04 INFO - Running main action method: clobber 15:33:04 INFO - rmtree: /builds/slave/test/build 15:33:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:33:06 INFO - Running post-action listener: _resource_record_post_action 15:33:06 INFO - ##### 15:33:06 INFO - ##### Running read-buildbot-config step. 15:33:06 INFO - ##### 15:33:06 INFO - Running pre-action listener: _resource_record_pre_action 15:33:06 INFO - Running main action method: read_buildbot_config 15:33:06 INFO - Using buildbot properties: 15:33:06 INFO - { 15:33:06 INFO - "project": "", 15:33:06 INFO - "product": "firefox", 15:33:06 INFO - "script_repo_revision": "production", 15:33:06 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 15:33:06 INFO - "repository": "", 15:33:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 15:33:06 INFO - "buildid": "20160704064557", 15:33:06 INFO - "pgo_build": "False", 15:33:06 INFO - "basedir": "/builds/slave/test", 15:33:06 INFO - "buildnumber": 36, 15:33:06 INFO - "slavename": "t-yosemite-r7-0058", 15:33:06 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 15:33:06 INFO - "platform": "yosemite_r7", 15:33:06 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 15:33:06 INFO - "branch": "mozilla-beta", 15:33:06 INFO - "repo_path": "releases/mozilla-beta", 15:33:06 INFO - "revision": "ebaf4086c18c2d1e3f0af12ade55840413342bc3", 15:33:06 INFO - "stage_platform": "macosx64", 15:33:06 INFO - "builduid": "27c77172f1ec4ef2807b5c6d2a070747", 15:33:06 INFO - "slavebuilddir": "test" 15:33:06 INFO - } 15:33:06 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.dmg. 15:33:06 INFO - Running post-action listener: _resource_record_post_action 15:33:06 INFO - ##### 15:33:06 INFO - ##### Running download-and-extract step. 15:33:06 INFO - ##### 15:33:06 INFO - Running pre-action listener: _resource_record_pre_action 15:33:06 INFO - Running main action method: download_and_extract 15:33:06 INFO - mkdir: /builds/slave/test/build/tests 15:33: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')]} 15:33:06 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.test_packages.json 15:33:06 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 15:33:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/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 15:33:07 INFO - Downloaded 1165 bytes. 15:33:07 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 15:33:07 INFO - Using the following test package requirements: 15:33:07 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 15:33:07 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:33:07 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 15:33:07 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:33:07 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 15:33:07 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 15:33:07 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:33:07 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 15:33:07 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 15:33:07 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:33:07 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 15:33:07 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:33:07 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 15:33:07 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:33:07 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 15:33:07 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:33:07 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 15:33:07 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 15:33: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')]} 15:33:07 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.common.tests.zip 15:33:07 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 15:33:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/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 15:33:08 INFO - Downloaded 18351374 bytes. 15:33:08 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'] 15:33:08 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 15:33:11 INFO - Return code: 0 15:33:11 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 15:33:11 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')]} 15:33:11 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.common.tests.zip 15:33:11 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 15:33:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/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 15:33:12 INFO - Downloaded 18351374 bytes. 15:33:12 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'] 15:33:12 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 15:33:15 INFO - Return code: 0 15:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:15 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.talos.tests.zip 15:33:15 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 15:33:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/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 15:33:21 INFO - Downloaded 10840145 bytes. 15:33:21 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'] 15:33:21 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 15:33:21 INFO - Return code: 0 15:33:21 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')]} 15:33:21 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.dmg 15:33:21 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 15:33:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 15:33:28 INFO - Downloaded 86196177 bytes. 15:33:28 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.dmg 15:33:28 INFO - mkdir: /builds/slave/test/properties 15:33:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:33:28 INFO - Writing to file /builds/slave/test/properties/build_url 15:33:28 INFO - Contents: 15:33:28 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.dmg 15:33:28 INFO - Running post-action listener: _resource_record_post_action 15:33:28 INFO - Running post-action listener: set_extra_try_arguments 15:33:28 INFO - ##### 15:33:28 INFO - ##### Running populate-webroot step. 15:33:28 INFO - ##### 15:33:28 INFO - Running pre-action listener: _resource_record_pre_action 15:33:28 INFO - Running main action method: populate_webroot 15:33:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:33:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:33:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:33:28 INFO - '--tppagecycles', 15:33:28 INFO - '7'], 15:33:28 INFO - 'tests': ['tsvgm']}}, 15:33:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:33:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:33:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:33:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:33:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:33:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:33:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:29 INFO - 'talos_options': ['--disable-e10s'], 15:33:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:33:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:33:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:29 INFO - 'talos_options': ['--disable-e10s'], 15:33:29 INFO - 'tests': ['damp', 'tps']}, 15:33:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:29 INFO - 'tests': ['damp', 'tps']}, 15:33:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:33:29 INFO - 'tests': ['dromaeo_dom']}, 15:33:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:33:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:33:29 INFO - 'tests': ['a11yr', 15:33:29 INFO - 'ts_paint', 15:33:29 INFO - 'tpaint', 15:33:29 INFO - 'sessionrestore', 15:33:29 INFO - 'sessionrestore_no_auto_restore', 15:33:29 INFO - 'tabpaint']}, 15:33:29 INFO - 'other-e10s': {'tests': ['a11yr', 15:33:29 INFO - 'ts_paint', 15:33:29 INFO - 'tpaint', 15:33:29 INFO - 'sessionrestore', 15:33:29 INFO - 'sessionrestore_no_auto_restore', 15:33:29 INFO - 'tabpaint']}, 15:33:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:33:29 INFO - 'ts_paint', 15:33:29 INFO - 'tpaint', 15:33:29 INFO - 'sessionrestore', 15:33:29 INFO - 'sessionrestore_no_auto_restore', 15:33:29 INFO - 'tabpaint']}, 15:33:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:33:29 INFO - 'ts_paint', 15:33:29 INFO - 'tpaint', 15:33:29 INFO - 'sessionrestore', 15:33:29 INFO - 'sessionrestore_no_auto_restore', 15:33:29 INFO - 'tabpaint']}, 15:33:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:33:29 INFO - 'tests': ['a11yr', 15:33:29 INFO - 'ts_paint', 15:33:29 INFO - 'tpaint', 15:33:29 INFO - 'sessionrestore', 15:33:29 INFO - 'sessionrestore_no_auto_restore', 15:33:29 INFO - 'tabpaint']}, 15:33:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:33:29 INFO - 'tests': ['a11yr', 15:33:29 INFO - 'ts_paint', 15:33:29 INFO - 'tpaint', 15:33:29 INFO - 'sessionrestore', 15:33:29 INFO - 'sessionrestore_no_auto_restore', 15:33:29 INFO - 'tabpaint']}, 15:33:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:33:29 INFO - 'tests': ['tsvgx', 15:33:29 INFO - 'tsvgr_opacity', 15:33:29 INFO - 'tart', 15:33:29 INFO - 'tscrollx', 15:33:29 INFO - 'cart']}, 15:33:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:33:29 INFO - 'tsvgr_opacity', 15:33:29 INFO - 'tart', 15:33:29 INFO - 'tscrollx', 15:33:29 INFO - 'cart']}, 15:33:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:29 INFO - 'talos_options': ['--disable-e10s'], 15:33:29 INFO - 'tests': ['tp5o']}, 15:33:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:29 INFO - 'tests': ['tp5o']}, 15:33:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:29 INFO - 'talos_options': ['--disable-e10s', 15:33:29 INFO - '--xperf_path', 15:33:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:33:29 INFO - 'tests': ['tp5n']}, 15:33:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:29 INFO - 'talos_options': ['--xperf_path', 15:33:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:33:29 INFO - 'tests': ['tp5n']}}, 15:33:29 INFO - 'talos.zip': {'path': '', 15:33:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:33:29 INFO - Running post-action listener: _resource_record_post_action 15:33:29 INFO - ##### 15:33:29 INFO - ##### Running create-virtualenv step. 15:33:29 INFO - ##### 15:33:29 INFO - Running pre-action listener: _resource_record_pre_action 15:33:29 INFO - Running main action method: create_virtualenv 15:33:29 INFO - Creating virtualenv /builds/slave/test/build/venv 15:33:29 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 15:33:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:33:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:33:29 INFO - Using real prefix '/tools/python27' 15:33:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:33:29 INFO - Installing distribute.............................................................................................................................................................................................done. 15:33:32 INFO - Installing pip.................done. 15:33:32 INFO - Return code: 0 15:33:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:33:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:32 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 0x11034ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11035c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6e14db6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101ebe00>, '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 0x110054db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101e6b20>, '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.en1b4GqkNQ/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.MHCkN3CGSo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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 15:33:32 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 15:33:32 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 15:33:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.en1b4GqkNQ/Render', 15:33:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:32 INFO - 'HOME': '/Users/cltbld', 15:33:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:32 INFO - 'LOGNAME': 'cltbld', 15:33:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:32 INFO - 'MOZ_NO_REMOTE': '1', 15:33:32 INFO - 'NO_EM_RESTART': '1', 15:33:32 INFO - 'PAGER': '/bin/cat', 15:33:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:32 INFO - 'PWD': '/builds/slave/test', 15:33:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:32 INFO - 'SHELL': '/bin/bash', 15:33:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MHCkN3CGSo/Listeners', 15:33:32 INFO - 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/', 15:33:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:32 INFO - 'USER': 'cltbld', 15:33:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:32 INFO - 'XPC_FLAGS': '0x0', 15:33:32 INFO - 'XPC_SERVICE_NAME': '0', 15:33:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:32 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 15:33:32 INFO - Cleaning up... 15:33:32 INFO - Return code: 0 15:33:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:33:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:32 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 0x11034ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11035c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6e14db6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101ebe00>, '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 0x110054db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101e6b20>, '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.en1b4GqkNQ/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.MHCkN3CGSo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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 15:33:32 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 15:33:32 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 15:33:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.en1b4GqkNQ/Render', 15:33:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:32 INFO - 'HOME': '/Users/cltbld', 15:33:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:32 INFO - 'LOGNAME': 'cltbld', 15:33:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:32 INFO - 'MOZ_NO_REMOTE': '1', 15:33:32 INFO - 'NO_EM_RESTART': '1', 15:33:32 INFO - 'PAGER': '/bin/cat', 15:33:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:32 INFO - 'PWD': '/builds/slave/test', 15:33:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:32 INFO - 'SHELL': '/bin/bash', 15:33:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MHCkN3CGSo/Listeners', 15:33:32 INFO - 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/', 15:33:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:32 INFO - 'USER': 'cltbld', 15:33:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:32 INFO - 'XPC_FLAGS': '0x0', 15:33:32 INFO - 'XPC_SERVICE_NAME': '0', 15:33:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:33 INFO - Downloading/unpacking psutil>=0.7.1 15:33:33 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 15:33:33 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 15:33:33 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 15:33:33 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 15:33:33 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 15:33:33 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 15:33:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:33:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:33:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:33:36 INFO - Installing collected packages: psutil 15:33:36 INFO - Running setup.py install for psutil 15:33:36 INFO - building 'psutil._psutil_osx' extension 15:33:36 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 15:33:37 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 15:33:37 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 15:33:37 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 15:33:37 INFO - building 'psutil._psutil_posix' extension 15:33:37 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 15:33:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:33:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:33:37 INFO - ^ 15:33:37 INFO - 1 warning generated. 15:33:37 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 15:33:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:33:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:33:37 INFO - Successfully installed psutil 15:33:37 INFO - Cleaning up... 15:33:37 INFO - Return code: 0 15:33:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:33: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')]} 15:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33: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')]} 15:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:37 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 0x11034ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11035c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6e14db6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101ebe00>, '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 0x110054db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101e6b20>, '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.en1b4GqkNQ/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.MHCkN3CGSo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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 15:33:37 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 15:33:37 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 15:33:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.en1b4GqkNQ/Render', 15:33:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:37 INFO - 'HOME': '/Users/cltbld', 15:33:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:37 INFO - 'LOGNAME': 'cltbld', 15:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:37 INFO - 'MOZ_NO_REMOTE': '1', 15:33:37 INFO - 'NO_EM_RESTART': '1', 15:33:37 INFO - 'PAGER': '/bin/cat', 15:33:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:37 INFO - 'PWD': '/builds/slave/test', 15:33:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:37 INFO - 'SHELL': '/bin/bash', 15:33:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MHCkN3CGSo/Listeners', 15:33:37 INFO - 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/', 15:33:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:37 INFO - 'USER': 'cltbld', 15:33:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:37 INFO - 'XPC_FLAGS': '0x0', 15:33:37 INFO - 'XPC_SERVICE_NAME': '0', 15:33:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:33:38 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 15:33:38 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 15:33:38 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 15:33:38 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 15:33:38 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 15:33:38 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 15:33:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:33:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:33:40 INFO - Installing collected packages: mozsystemmonitor 15:33:40 INFO - Running setup.py install for mozsystemmonitor 15:33:40 INFO - Successfully installed mozsystemmonitor 15:33:40 INFO - Cleaning up... 15:33:41 INFO - Return code: 0 15:33:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:41 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 0x11034ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11035c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6e14db6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101ebe00>, '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 0x110054db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101e6b20>, '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.en1b4GqkNQ/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.MHCkN3CGSo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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 15:33:41 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 15:33:41 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 15:33:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.en1b4GqkNQ/Render', 15:33:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:41 INFO - 'HOME': '/Users/cltbld', 15:33:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:41 INFO - 'LOGNAME': 'cltbld', 15:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:41 INFO - 'MOZ_NO_REMOTE': '1', 15:33:41 INFO - 'NO_EM_RESTART': '1', 15:33:41 INFO - 'PAGER': '/bin/cat', 15:33:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:41 INFO - 'PWD': '/builds/slave/test', 15:33:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:41 INFO - 'SHELL': '/bin/bash', 15:33:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MHCkN3CGSo/Listeners', 15:33:41 INFO - 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/', 15:33:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:41 INFO - 'USER': 'cltbld', 15:33:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:41 INFO - 'XPC_FLAGS': '0x0', 15:33:41 INFO - 'XPC_SERVICE_NAME': '0', 15:33:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:41 INFO - Downloading/unpacking blobuploader==1.2.4 15:33:41 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 15:33:41 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 15:33:41 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 15:33:41 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 15:33:41 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 15:33:41 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 15:33:43 INFO - Downloading blobuploader-1.2.4.tar.gz 15:33:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:33:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:33:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33:44 INFO - Downloading docopt-0.6.1.tar.gz 15:33:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:33:44 INFO - Installing collected packages: blobuploader, requests, docopt 15:33:44 INFO - Running setup.py install for blobuploader 15:33:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:33:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:33:45 INFO - Running setup.py install for requests 15:33:45 INFO - Running setup.py install for docopt 15:33:45 INFO - Successfully installed blobuploader requests docopt 15:33:45 INFO - Cleaning up... 15:33:45 INFO - Return code: 0 15:33:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:33:45 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')]} 15:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:45 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')]} 15:33:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:45 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 0x11034ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11035c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6e14db6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101ebe00>, '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 0x110054db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101e6b20>, '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.en1b4GqkNQ/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.MHCkN3CGSo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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 15:33:45 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 15:33:45 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 15:33:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.en1b4GqkNQ/Render', 15:33:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:45 INFO - 'HOME': '/Users/cltbld', 15:33:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:45 INFO - 'LOGNAME': 'cltbld', 15:33:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:45 INFO - 'MOZ_NO_REMOTE': '1', 15:33:45 INFO - 'NO_EM_RESTART': '1', 15:33:45 INFO - 'PAGER': '/bin/cat', 15:33:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:45 INFO - 'PWD': '/builds/slave/test', 15:33:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:45 INFO - 'SHELL': '/bin/bash', 15:33:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MHCkN3CGSo/Listeners', 15:33:45 INFO - 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/', 15:33:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:45 INFO - 'USER': 'cltbld', 15:33:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:45 INFO - 'XPC_FLAGS': '0x0', 15:33:45 INFO - 'XPC_SERVICE_NAME': '0', 15:33:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:33:46 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-Owivo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:33:46 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-TkoARS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:33:46 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-bVoCRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:33:46 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-_HMPOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:33:46 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-nIRlGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:33:46 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-yRPF4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:33:46 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-tw6GFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:33:46 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-BDMaqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:33:46 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-iyesx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:33:47 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-8joN2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:33:47 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-8UmXyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:33:47 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-Fdu9zO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:33:47 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-_YFWW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:33:47 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-oJngAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:47 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-LvC5Qr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:33:47 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-wV_rBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:33:47 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-orJPA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:33:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:33:47 INFO - Running setup.py install for manifestparser 15:33:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:33:48 INFO - Running setup.py install for mozcrash 15:33:48 INFO - Running setup.py install for mozdebug 15:33:48 INFO - Running setup.py install for mozdevice 15:33:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:33:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:33:48 INFO - Running setup.py install for mozfile 15:33:48 INFO - Running setup.py install for mozhttpd 15:33:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:33:48 INFO - Running setup.py install for mozinfo 15:33:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:33:48 INFO - Running setup.py install for mozInstall 15:33:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:33:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:33:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:33:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:33:49 INFO - Running setup.py install for mozleak 15:33:49 INFO - Running setup.py install for mozlog 15:33:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:33:49 INFO - Running setup.py install for moznetwork 15:33:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:33:49 INFO - Running setup.py install for mozprocess 15:33:49 INFO - Running setup.py install for mozprofile 15:33:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:33:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:33:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:33:49 INFO - Running setup.py install for mozrunner 15:33:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:33:49 INFO - Running setup.py install for mozscreenshot 15:33:50 INFO - Running setup.py install for moztest 15:33:50 INFO - Running setup.py install for mozversion 15:33:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:33:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:33:50 INFO - Cleaning up... 15:33:50 INFO - Return code: 0 15:33:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:50 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 0x11034ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11035c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6e14db6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101ebe00>, '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 0x110054db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101e6b20>, '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.en1b4GqkNQ/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.MHCkN3CGSo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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 15:33:50 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 15:33:50 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 15:33:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.en1b4GqkNQ/Render', 15:33:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:50 INFO - 'HOME': '/Users/cltbld', 15:33:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:50 INFO - 'LOGNAME': 'cltbld', 15:33:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:50 INFO - 'MOZ_NO_REMOTE': '1', 15:33:50 INFO - 'NO_EM_RESTART': '1', 15:33:50 INFO - 'PAGER': '/bin/cat', 15:33:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:50 INFO - 'PWD': '/builds/slave/test', 15:33:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:50 INFO - 'SHELL': '/bin/bash', 15:33:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MHCkN3CGSo/Listeners', 15:33:50 INFO - 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/', 15:33:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:50 INFO - 'USER': 'cltbld', 15:33:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:50 INFO - 'XPC_FLAGS': '0x0', 15:33:50 INFO - 'XPC_SERVICE_NAME': '0', 15:33:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:33:50 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-sbk3bB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:33:50 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)) 15:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:33:50 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-WicJOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:33:50 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)) 15:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:33:50 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-6K9Vgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:33:50 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)) 15:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:33:51 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-O2s3pC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:33:51 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)) 15:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:33:51 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-ysWePC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:33:51 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)) 15:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:33:51 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-8Y8kEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:33:51 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)) 15:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:33:51 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-B3ZquU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:33:51 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)) 15:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:33:51 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-yAMwl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:33:51 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)) 15:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:33:51 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-u941YF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:33:51 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)) 15:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:33:51 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-V6AfEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:33:51 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)) 15:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:33:51 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-Bu6Lu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:33:51 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)) 15:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:33:51 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-uPsF6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:33:51 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)) 15:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:33:51 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-ucqLVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:33:52 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)) 15:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:33:52 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-aruGhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:33:52 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)) 15:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:52 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-Cuh3zj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:52 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)) 15:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:33:52 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-nGzKpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:33:52 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)) 15:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:33:52 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-cuHIYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:33:52 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)) 15:33:52 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)) 15:33:52 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)) 15:33:52 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)) 15:33:52 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)) 15:33:52 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)) 15:33:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33:54 INFO - Downloading blessings-1.6.tar.gz 15:33:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:33:55 INFO - Installing collected packages: blessings 15:33:55 INFO - Running setup.py install for blessings 15:33:55 INFO - Successfully installed blessings 15:33:55 INFO - Cleaning up... 15:33:55 INFO - Return code: 0 15:33:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:33:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:33:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:33:55 INFO - Reading from file tmpfile_stdout 15:33:55 INFO - Current package versions: 15:33:55 INFO - blessings == 1.6 15:33:55 INFO - blobuploader == 1.2.4 15:33:55 INFO - docopt == 0.6.1 15:33:55 INFO - manifestparser == 1.1 15:33:55 INFO - mozInstall == 1.12 15:33:55 INFO - mozcrash == 0.17 15:33:55 INFO - mozdebug == 0.1 15:33:55 INFO - mozdevice == 0.48 15:33:55 INFO - mozfile == 1.2 15:33:55 INFO - mozhttpd == 0.7 15:33:55 INFO - mozinfo == 0.9 15:33:55 INFO - mozleak == 0.1 15:33:55 INFO - mozlog == 3.1 15:33:55 INFO - moznetwork == 0.27 15:33:55 INFO - mozprocess == 0.22 15:33:55 INFO - mozprofile == 0.28 15:33:55 INFO - mozrunner == 6.11 15:33:55 INFO - mozscreenshot == 0.1 15:33:55 INFO - mozsystemmonitor == 0.0 15:33:55 INFO - moztest == 0.7 15:33:55 INFO - mozversion == 1.4 15:33:55 INFO - psutil == 3.1.1 15:33:55 INFO - requests == 1.2.3 15:33:55 INFO - wsgiref == 0.1.2 15:33:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:33:55 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')]} 15:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:55 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')]} 15:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:55 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 0x11034ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11035c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6e14db6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101ebe00>, '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 0x110054db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101e6b20>, '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.en1b4GqkNQ/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.MHCkN3CGSo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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 15:33:55 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 15:33:55 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 15:33:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.en1b4GqkNQ/Render', 15:33:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:55 INFO - 'HOME': '/Users/cltbld', 15:33:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:55 INFO - 'LOGNAME': 'cltbld', 15:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:55 INFO - 'MOZ_NO_REMOTE': '1', 15:33:55 INFO - 'NO_EM_RESTART': '1', 15:33:55 INFO - 'PAGER': '/bin/cat', 15:33:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:55 INFO - 'PWD': '/builds/slave/test', 15:33:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:55 INFO - 'SHELL': '/bin/bash', 15:33:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MHCkN3CGSo/Listeners', 15:33:55 INFO - 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/', 15:33:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:55 INFO - 'USER': 'cltbld', 15:33:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:55 INFO - 'XPC_FLAGS': '0x0', 15:33:55 INFO - 'XPC_SERVICE_NAME': '0', 15:33:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:55 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)) 15:33:55 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)) 15:33:55 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)) 15:33:55 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)) 15:33:55 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)) 15:33:55 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)) 15:33:55 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)) 15:33:55 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)) 15:33:55 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)) 15:33:55 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)) 15:33:55 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)) 15:33:55 INFO - Cleaning up... 15:33:55 INFO - Return code: 0 15:33:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:33:55 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')]} 15:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:55 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')]} 15:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:55 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 0x11034ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11035c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6e14db6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101ebe00>, '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 0x110054db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101e6b20>, '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.en1b4GqkNQ/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.MHCkN3CGSo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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 15:33:55 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 15:33:55 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 15:33:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.en1b4GqkNQ/Render', 15:33:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:55 INFO - 'HOME': '/Users/cltbld', 15:33:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:55 INFO - 'LOGNAME': 'cltbld', 15:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:55 INFO - 'MOZ_NO_REMOTE': '1', 15:33:55 INFO - 'NO_EM_RESTART': '1', 15:33:55 INFO - 'PAGER': '/bin/cat', 15:33:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:55 INFO - 'PWD': '/builds/slave/test', 15:33:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:55 INFO - 'SHELL': '/bin/bash', 15:33:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MHCkN3CGSo/Listeners', 15:33:55 INFO - 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/', 15:33:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:55 INFO - 'USER': 'cltbld', 15:33:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:55 INFO - 'XPC_FLAGS': '0x0', 15:33:55 INFO - 'XPC_SERVICE_NAME': '0', 15:33:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:56 INFO - Downloading/unpacking jsonschema 15:33:56 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 15:33:56 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 15:33:56 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 15:33:56 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 15:33:56 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 15:33:56 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 15:33:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:33:58 INFO - Downloading/unpacking functools32 (from jsonschema) 15:33:58 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 15:33:58 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 15:33:58 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 15:33:58 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 15:33:58 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 15:33:58 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 15:33:58 INFO - Downloading functools32-3.2.3-2.tar.gz 15:33:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:33:59 INFO - warning: no files found matching '*.txt' 15:33:59 INFO - no previously-included directories found matching 'build' 15:33:59 INFO - no previously-included directories found matching 'dist' 15:33:59 INFO - no previously-included directories found matching '.git*' 15:33:59 INFO - Installing collected packages: jsonschema, functools32 15:33:59 INFO - Running setup.py install for functools32 15:33:59 INFO - warning: no files found matching '*.txt' 15:33:59 INFO - no previously-included directories found matching 'build' 15:33:59 INFO - no previously-included directories found matching 'dist' 15:33:59 INFO - no previously-included directories found matching '.git*' 15:33:59 INFO - Successfully installed jsonschema functools32 15:33:59 INFO - Cleaning up... 15:33:59 INFO - Return code: 0 15:33:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:33:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11034ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11035c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6e14db6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101ebe00>, '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 0x110054db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101e6b20>, '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.en1b4GqkNQ/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.MHCkN3CGSo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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 15:33:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:33:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.en1b4GqkNQ/Render', 15:33:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:59 INFO - 'HOME': '/Users/cltbld', 15:33:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:59 INFO - 'LOGNAME': 'cltbld', 15:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:59 INFO - 'MOZ_NO_REMOTE': '1', 15:33:59 INFO - 'NO_EM_RESTART': '1', 15:33:59 INFO - 'PAGER': '/bin/cat', 15:33:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:59 INFO - 'PWD': '/builds/slave/test', 15:33:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:59 INFO - 'SHELL': '/bin/bash', 15:33:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MHCkN3CGSo/Listeners', 15:33:59 INFO - 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/', 15:33:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:59 INFO - 'USER': 'cltbld', 15:33:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:59 INFO - 'XPC_FLAGS': '0x0', 15:33:59 INFO - 'XPC_SERVICE_NAME': '0', 15:33:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:59 INFO - Downloading/unpacking flake8 15:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:34:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:34:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:34:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:34:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:34:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:34:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:34:03 INFO - no previously-included directories found matching 'docs/_build' 15:34:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:34:03 INFO - Running setup.py install for pep8 15:34:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:34:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:34:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:34:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:34:03 INFO - no previously-included directories found matching 'docs/_build' 15:34:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:34:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:34:03 INFO - Cleaning up... 15:34:03 INFO - Return code: 0 15:34:03 INFO - Running post-action listener: _resource_record_post_action 15:34:03 INFO - Running post-action listener: _start_resource_monitoring 15:34:03 INFO - Starting resource monitoring. 15:34:03 INFO - ##### 15:34:03 INFO - ##### Running install step. 15:34:03 INFO - ##### 15:34:03 INFO - Running pre-action listener: _resource_record_pre_action 15:34:03 INFO - Running main action method: install 15:34:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:34:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:34:04 INFO - Reading from file tmpfile_stdout 15:34:04 INFO - Detecting whether we're running mozinstall >=1.0... 15:34:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:34:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:34:04 INFO - Reading from file tmpfile_stdout 15:34:04 INFO - Output received: 15:34:04 INFO - Usage: mozinstall [options] installer 15:34:04 INFO - Options: 15:34:04 INFO - -h, --help show this help message and exit 15:34:04 INFO - -d DEST, --destination=DEST 15:34:04 INFO - Directory to install application into. [default: 15:34:04 INFO - "/builds/slave/test"] 15:34:04 INFO - --app=APP Application being installed. [default: firefox] 15:34:04 INFO - mkdir: /builds/slave/test/build/application 15:34:04 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'] 15:34:04 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 15:34:25 INFO - Reading from file tmpfile_stdout 15:34:25 INFO - Output received: 15:34:25 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 15:34:25 INFO - Running post-action listener: _resource_record_post_action 15:34:25 INFO - ##### 15:34:25 INFO - ##### Running run-tests step. 15:34:25 INFO - ##### 15:34:25 INFO - Running pre-action listener: _resource_record_pre_action 15:34:25 INFO - Running main action method: run_tests 15:34:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:34:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:34:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:34:25 INFO - 2016-07-04 15:34:25.806 screenresolution[1647:8128] starting screenresolution argv=screenresolution get 15:34:25 INFO - 2016-07-04 15:34:25.808 screenresolution[1647:8128] Display 0: 1600x1200x32@60 15:34:25 INFO - 2016-07-04 15:34:25.814 screenresolution[1648:8130] starting screenresolution argv=screenresolution list 15:34:25 INFO - Available Modes on Display 0 15:34:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:34:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:34:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:34:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:34:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:34:26 INFO - Intel Iris: 15:34:26 INFO - Chipset Model: Intel Iris 15:34:26 INFO - Type: GPU 15:34:26 INFO - Bus: Built-In 15:34:26 INFO - VRAM (Dynamic, Max): 1536 MB 15:34:26 INFO - Vendor: Intel (0x8086) 15:34:26 INFO - Device ID: 0x0a2e 15:34:26 INFO - Revision ID: 0x0009 15:34:26 INFO - Displays: 15:34:26 INFO - Display: 15:34:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:34:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:34:26 INFO - Display Serial Number: 1600x1200 60 15:34:26 INFO - Main Display: Yes 15:34:26 INFO - Mirror: Off 15:34:26 INFO - Online: Yes 15:34:26 INFO - Rotation: Supported 15:34:26 INFO - Return code: 0 15:34:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:34:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:34:26 INFO - Python 2.7.3 15:34:26 INFO - Return code: 0 15:34:26 INFO - grabbing minidump binary from tooltool 15:34:26 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')]} 15:34:26 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 0x1101ebe00>, '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 0x110054db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101e6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:34:26 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 15:34:26 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 15:34:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:34:26 INFO - Return code: 0 15:34:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:34:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:34:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:34:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:34:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:34:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:34:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:34:27 INFO - Return code: 0 15:34:27 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/1467639957/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0058', '--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 15:34:27 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/1467639957/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0058 --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 15:34:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.en1b4GqkNQ/Render', 15:34:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:34:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:34:27 INFO - 'HOME': '/Users/cltbld', 15:34:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:34:27 INFO - 'LOGNAME': 'cltbld', 15:34:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:34:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:34:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:27 INFO - 'MOZ_NO_REMOTE': '1', 15:34:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:34:27 INFO - 'NO_EM_RESTART': '1', 15:34:27 INFO - 'PAGER': '/bin/cat', 15:34:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:34:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:27 INFO - 'PWD': '/builds/slave/test', 15:34:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:34:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:34:27 INFO - 'SHELL': '/bin/bash', 15:34:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MHCkN3CGSo/Listeners', 15:34:27 INFO - 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/', 15:34:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:34:27 INFO - 'USER': 'cltbld', 15:34:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:34:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:34:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:27 INFO - 'XPC_FLAGS': '0x0', 15:34:27 INFO - 'XPC_SERVICE_NAME': '0', 15:34:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:34:27 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/1467639957/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0058', '--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 15:34:27 INFO - mozversion application_buildid: 20160704064557 15:34:27 INFO - mozversion application_changeset: ebaf4086c18c2d1e3f0af12ade55840413342bc3 15:34:27 INFO - mozversion application_display_name: Firefox 15:34:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:34:27 INFO - mozversion application_name: Firefox 15:34:27 INFO - mozversion application_remotingname: firefox 15:34:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:34:27 INFO - mozversion application_vendor: Mozilla 15:34:27 INFO - mozversion application_version: 48.0 15:34:27 INFO - mozversion platform_buildid: 20160704064557 15:34:27 INFO - mozversion platform_changeset: ebaf4086c18c2d1e3f0af12ade55840413342bc3 15:34:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:34:27 INFO - mozversion platform_version: 48.0 15:34:27 INFO - using testdate: 1467671667 15:34:27 INFO - actual date: 1467671667 15:34:27 INFO - starting webserver on 'localhost:49264' 15:34:27 INFO - SUITE-START | Running 2 tests 15:34:27 INFO - TEST-START | dromaeo_css 15:34:27 INFO - operating with platform_type : mac_ 15:34:27 INFO - Initialising browser for dromaeo_css test... 15:34:27 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/tmpjKszcu/profile http://localhost:49264/getInfo.html) 15:34:29 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 15:34:29 INFO - PROCESS | 1666 | colorDepth:24 15:34:29 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 15:34:29 INFO - PROCESS | 1666 | __metrics 15:34:29 INFO - PROCESS | 1666 | 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" 15:34:29 ERROR - PROCESS | 1666 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:34:30 INFO - TEST-INFO | 1666: exit 0 15:34:30 INFO - Browser initialized. 15:34:30 INFO - Running cycle 1/1 for dromaeo_css test... 15:34:30 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/tmpjKszcu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:34:42 INFO - PROCESS | 1670 | RSS: Main: 161853440 15:34:42 INFO - PROCESS | 1670 | 15:35:33 INFO - PROCESS | 1670 | 1467671733347 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] 15:37:42 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49264/tests/dromaeo/cssquery-ext.html) 15:37:44 INFO - PROCESS | 1670 | RSS: Main: 311234560 15:37:44 INFO - PROCESS | 1670 | 15:40:47 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-ext.html (next: http://localhost:49264/tests/dromaeo/cssquery-jquery.html) 15:40:47 INFO - PROCESS | 1670 | RSS: Main: 299134976 15:40:47 INFO - PROCESS | 1670 | 15:43:50 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49264/tests/dromaeo/cssquery-mootools.html) 15:43:50 INFO - PROCESS | 1670 | RSS: Main: 305061888 15:43:50 INFO - PROCESS | 1670 | 15:46:52 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49264/tests/dromaeo/cssquery-prototype.html) 15:46:53 INFO - PROCESS | 1670 | RSS: Main: 297201664 15:46:53 INFO - PROCESS | 1670 | 15:49:56 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49264/tests/dromaeo/cssquery-yui.html) 15:49:57 INFO - PROCESS | 1670 | RSS: Main: 262914048 15:49:57 INFO - PROCESS | 1670 | 15:52:59 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-yui.html (next: http://localhost:49264/tests/dromaeo/cssquery-dojo.html) 15:52:59 INFO - PROCESS | 1670 | RSS: Main: 308551680 15:52:59 INFO - PROCESS | 1670 | 15:52:59 INFO - PROCESS | 1670 | __start_tp_report 15:52:59 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 15:52:59 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 15:52:59 INFO - PROCESS | 1670 | |i|pagename|runs| 15:52:59 INFO - PROCESS | 1670 | |0;dojo.html;2903.187107609869;3556.1820781220304;3561.0207193021924;3566.8751593694224;3625.655562721542;5704.857378565538;5707.543396528278;5710.172025056369;5737.684427356494;5747.798827041054;5697.344805347387;5738.053221218504;5745;5750.511206547438;5755.30936287645;5045.974770126144;5087.10975579274;5115.718635475047;5241.082810508165;5261.289725887013;5180.689158650474;5223.71269580173;5235.057689615867;5237.45006774289;5238.92141617876;4375.715578487404;5195.714235717034;5217.373915130171;5221.686698798084;5231.136862417697;5183.455737147583;5187.273781670569;5190.792368305301;5216.426193118754;5260.316158899357;5073.6955782652785;5106.157484015133;5126.820561280338;5151.484851514856;5163.741812909377;5521.889562208733;5555.083411237141;5568.276124103841;5585.273914391144;5625.634333768333;6169.5064394848305;6177.011678131477;6184.165137706397;6195;6203.596766210182;6055.182550355689;6128.601640893327;6217.098520714516;6260.530460215502;6284.811455656338;5763.481286684177;5810;5811.099279611667;5826.155207494932;5856.912146317809;6218.129461875341;6271.9686401568615;6273.8745225095245;6284.088807122942;6308.873822523524;6005.759769609254;6070.6357618543025;6121.540884433685;6130.233720784902;6165.445109940127;6230.688465576703;6245.906311405332;6251;6251;6258.718357673915;6107.969460152671;6152.661603611755;6155.907661385083;6174.475169610543;6191.071339299051;6093.9390606093375;6155.815325540241;6168.920438923171;6172.5679202456295;6209.19280493542;4940.135476291634;4940.407151141886;4950.8762280943265;4964.503549645006;4972.701637901738;4465.151621191963;4474;4481.215787237221;4497.415336006298;4503.2569626012;5642.605017648725;5692.288463942007;5760.0783874579865;5763.106718458645;5790.478856902899;6239.532035097386;6256.061590761331;6266.373362663789;6277.591956522902;6292.590981586182;5760.855978600484;5767.250257466502;5794.50746686528;5804.680742559115;5821.7380217890295;4768.807798050488;5274.393444753902;5294.57643388528;5386.272853164851;5455.8090466834265;6284.402981716729;6321.557490975588;6338.207724034496;6343.619382837044;6360.427561519486;6098.207233059674;6231.501479881689;6244.5316601256;6255.96872015637;6260.7495700171485;6257.749690012349;6295.748170073146;6354.586951848115;6364.07720880479;6390.456811171102;6176.197094377702;6195.907061394173;6208.2860471044605;6219.440250377488;6226.657533835501;6106.6336019838955;6259.843503912439;6267.811965641038;6272.7804526843165;6285.402886725754;6051.909221361595;6109.920916985209;6118.588722523033;6120.203342909657;6136.7948077883175;6071.848203794941;6095.359987201457;6130.540209484396;6132.969335153296;6137.1101190328045;5262.97368513155;5518.017457290341;5942.6731529766275;5968.731407086779;5971.820845374646;5355.892882142258;5771.07662773971;5989.940100599112;6114.814446323713;6157.9223635862645;5968.104784282393;5998.34018258;6000.489958353589;6001.7599296027665;6007.459328660441 15:52:59 INFO - PROCESS | 1670 | |1;ext.html;522.9790808367663;553.4714347797853;554.5184517624124;570.6034306157222;598.2491972574419;31395.215119622022;38305.61694383055;38930.22139557207;39012.80493597531;39151;42250.57749422505;42627;42736.14527709444;42771;42892.3566146508;8855.203031727175;9052.592633331484;9534.141927226548;9780.951095244514;9784.657536986208;11788.646340609796;12069.215500992452;12091.153619246656;12102.213356131868;12111.21277116989;11598.53605855769;11681.007114395286;11687.29876207426;11700.356480393617;11701.70745731355;11644.068474522019;11721;11726.530938762397;11735.7066073348;11756.294622322603;11478.081753459703;11555.53777848885;11570.94214528922;11595.594154204648;11601.883981160165;41253.79373103115;41691.583084169375;41777.79111104456;41786.1642767146;41792.582074179474;3147.2761264908972;3438.5186073949667;3483.5645544306963;3571.8570057581583;3809.4095415210686;28637.14088577346;29480.26299342512;29847.70152298471;29940.101796946128;30310.825294748167;2771.7366850149206;2792.902248421316;2818.943621127566;2821.083147976916;2827.971720282812;333854;333970;334352.3282383597;334380;336162;36194.457083143774;62986.37013629897;63548.04677929835;63603.36396635974;63610;35625;35760.28479430397;35837.64162358395;35899.82050089785;35927;16258;16352.182390880409;16361.77286703502;16362.018278903304;16386.344546218257;12908.612741617766;13096.279704616147;14069.085509442059;14111;14114.22371769542;8378.329733621296;8388.538630375388;8418.368622353348;8474;8488.787780305542;3486.1284678830293;3504.5268888700207;3513.1392808762016;3515.525404070469;3554.449060395643;1046.5604446132643;1100.8293714474269;1157.548556063136;1160.2980196980704;1209.1052621060353;30715.77136914543;30728;30899.382012359627;31200.68799312023;31203.84398077995;1130.9377984210948;1146.507001989136;1160.5705888821021;1170.5083864776814;1289.0976316578433;15812.36750529989;15814.051156930622;15853.445129420415;16047.358105675643;16147.434839780552;630779;638696;640935;643883;646451;62999.055014174824;63509.68245158745;63519.36480635135;63587.36412635907;63637.681811591574;1380.1650001749;1552.6273694313509;1567.6316065724773;1574.8660964105825;1614.8788840836748;26481.867590661925;29168;29653.703462965957;29667.258318542208;31331.060068197992;49669;50031.49968500269;50106.49893501018;50120.248196276356;50170;378392;381934;383035;383057;384585;21889.452763681034;22303.44241393978;22349.553008940056;27710.44579108447;27775.583366249117;41895.16209675728;42907;44284.778576108205;44577.55422445864;44699;32351.514727278638;34476.82761586176;35939.28121437504;36948.815255923546;37694.8115259422;30710.925117620776;35794.463083054296;36061.737839175505;36291.818540908185;36860.81569592135;36157.457638134925;36250.8187459061;36305.63694363023;39322.6067739319;40119.799401002805;31597.368052638358;32001;32069.198270043435;32575.348493029534;34005.97982060542;25221;25355.492890142465;25423.61864571996;25569.744302556737;25789.871050644626 15:52:59 INFO - PROCESS | 1670 | |2;jquery.html;368.78426120719377;398.08440586650704;404.83199472219013;413.7414116177389;418.7257346438083;14989.32510971416;20480.590388192228;20628.38114856555;21353.932303384827;21370.786292137072;15656.686866262668;16993.745093823603;17248.56878578036;20806.687899681478;20825.583488330223;4442.511323754385;5883.205767221413;6075.362086980869;6091.543134264925;6147.569670123094;5956.285245770514;6033.366496517869;6044.879102417949;6051.727672254737;6055.061465472859;4993.950060499385;5561.249231353776;5854.619449735775;5990.101484777275;5996.19051428056;5777.248957635523;5780.1907732917425;5810.360860305363;5826.82519524415;6154.876902461926;3976.08550033491;5799.681017544033;5807.361190269067;5813.215215945877;5819.127130930352;12933.224006559636;13408.26254555999;23197.072117115295;23768.762312377;24085.157019504408;2076.802703743142;2214.368904862107;2353.235198560458;2772.625695531098;2798.734120258572;9689.32174747768;13969.371378288002;13993.740563349245;14488.855111448856;14612.415503379852;1766.143420441085;1804.9097545122822;1822.5170329862597;1834.284628994693;1869.569998900247;102846.48576757143;103141.45287820688;127629.44741105125;130912;138435;11194.552217911356;11569.76860462786;11657.125715571367;11702.35637039971;11776.470058847372;15127.848721512644;15180;15210.239488025554;15230.695386092437;15232.238388080552;7130.358267755927;8323.417360784686;8720.825583488295;9108.407953483002;9288.609657474974;8389.790255243546;8421.326293896474;8429.620667069996;8697.695580654647;8969.641214351483;4619.214733495247;4680.882977925579;4694.718316900997;4695.5539223773685;4728.290756386501;1726.292220189716;1969.3993332033867;2011.3362590345444;2047.5393036566654;2052.671572548385;790.9598877476101;919.4529255093208;961.711486554031;977.8484334928097;1011.7521207304258;19695.615028511347;20717;20826;20915.37253882386;21066.789332106484;973.4305431322614;984.4290311619244;1025.477006726575;1030.386919782728;1034.3173505486343;10995.560177592966;11137.610183643534;11139.944300278608;11173.10615150786;11209;529076;636664;652276;652611.4738852646;675674.6216268985;122220.38889805494;125023.12465313027;125981;126651;127867;1038.2265212416798;1042.9530671119817;1053.3627155570923;1056.99471502642;1061.5753698520653;17668.91165544164;17685.292588296837;17791.822081779017;18122.09389530492;18450.26198952027;50939.981200376526;52201.95596088133;52699.47300526946;52825;54209.72895135499;73709.6314518424;74323.62838185775;74913.6254318725;74961.87557186537;75518;8010.799730006796;8106.716264930699;8142.389320800845;8228.21831925966;8306.667733290842;11076.667699969013;12260.509579616715;12586.559470418491;12590.181638193488;12671.113022088366;10463.372197668165;10741.892581074402;10959.671209863716;10991.835122473009;11004.834927475935;9259.35184537076;10393.06462418386;10451.42517161533;10819.404932728776;10965.616203433161;10957.50691218913;11145.164112691742;11314.60398886035;11343.922327378887;11381.772364552828;8004.319632831041;8039.919600803917;8062.355011598941;8128.187181281824;8431.789205269917;8280.83438331242;10525.947370263406;10893.618723344645;11137.387443690675;11160.553577856796 15:52:59 INFO - PROCESS | 1670 | |3;mootools.html;1416.6529200345917;1606.5260748079315;1644.917754112295;1904.8476121910248;2010.8793472391658;7570;7857;8792.2966162707;8859.911400885989;8882.733517994455;8565.35759818013;8801.647934082644;8805.691800786974;8812.867806982884;8813.823723525526;2504.5867431873767;2525.911593094242;2526.621006848969;2526.9747302526926;2531.962020569693;2449.1183174057323;2533.6579561759113;2539.415934335104;2545.172818833877;2559.1171045989104;2120;2314.9884250578807;2522.3441905104623;2529.3676580854785;2531.898724051045;2341.683872677184;2482.5034993001473;2524.394145405108;2532.8606926619027;2534.569123249052;2134.3703607435846;2469.172827102923;2506.4235225898146;2510.8870100845506;2511.598144296922;7348.77953661391;8628.309735221168;8847.380683352168;8972.282217422591;8997.100289971017;4656.231721765905;5427.6472029317965;5541.778328866841;5548.306461692288;5564.888702225973;3530.029241958482;3628.11111277736;3686.8525258989607;3687.1335236219466;3703.6296370362747;1006.7231511334369;1023.9351074882113;1033.457434846704;1067.5569638599973;1069.3904474449566;11455;11639.592614258545;11652.242604230783;11654.417279136009;11670.124740644485;3754.380527213034;4623.583877451046;4633.397658304466;4657.627389808875;4715.434147902273;9198;9209.033051529626;9218.170364667078;9218.492982886006;9223.631054757869;5258.132408152688;5271.789128434896;5293.470652934676;5310.4424035476495;5330.253764472977;4524.457065152203;4683.601893839062;4851.781669824866;4957.925631115536;4972.129877271463;3230.5154226866157;3887.9611203888167;3935.2916475034767;3957.3272543667645;3968.66266367362;1216.391804097951;1228.1280290993495;1228.2937311046185;1236.190295356543;1237.2267332916927;915.4095608332589;956.2636769687302;973.1387721866058;977.8679878216492;1002.5638847101534;5852.180694702745;5913.379095195029;6058.091286307089;6090.69546522681;6129.96935015331;464.27109438182407;474.5444373401504;479.601930397769;480.4426864836773;481.1291562272298;3875.670568001695;4028.274910516135;4037.1723796621623;4073.246449406869;4087.346024636044;10542.051215390498;10979.1765617579;11005.889941100646;11064.225504214628;11075.667729968114;10338.793224135476;10818.729531761768;10826.35041897473;10830.62092826763;10943.179261555415;8393.328533717287;8486.74539763808;8497.830043399097;8553.44402613828;8555.14448555152;5710.657995371002;5852.970735146297;5883.0881213411985;5962.612430192024;6104.755809767737;9592.568334424828;9673.79077615298;9878.604855805686;9878.703638890845;9882;9104.180623743894;9400.435973841591;9414.905850941677;9523.047695230422;9867.309288350034;6534.673266336569;6875.965620171867;7043.330883566258;7465.253474652492;7591.696332146652;8422.620982055945;8479.788005299917;8506.872396913928;8522.786930326543;8524.062353141273;7131.144262688511;7162.749303774552;7210.675519601526;7268.890966635399;7471.551706897603;7192.244814294633;7316.012338334257;7347.55914645123;7349;7487.401007919245;6944.236134025355;7019.3682568569075;7022.40309573692;7032.367086962198;7051;4948.653594248368;4950.331705219894;4952.4057113146655;5006.874828129326;5054.7978080876355;4959.13215187348;5013.899722005613;5020.397552293748;5149.330587023663;5247.449017853223 15:52:59 INFO - PROCESS | 1670 | |4;prototype.html;332.3416153394561;339.9987038172581;344.83103279393094;347.3487211478478;350.89297764181913;6593.241777195624;6618.470522358211;6651.866962660744;6653.367930046637;6681.198256209255;6513.67431628419;6518.315576864432;6548.541602087856;6550.5742126761725;6555.934440655592;4623.375844261023;4764.452088009889;4770.212914869043;4896.804127834882;4917.311576379309;4109.2808758467145;4744.288356746481;4880.682755620874;4899.48555401683;4906.043321552299;4812.278158276269;4815.5425234602835;4823.180059389894;4828.87927801806;4853.102176097434;3892.9416058759143;4530.909381812362;4742.976285118552;4747.95252047482;4753.3582966299455;4055.898602534931;4175.54069052404;4177.561356057631;4181.477315335583;4181.91636167278;6165.5992360496875;6229.345918678564;6247.468965137969;6250.468710159642;6289.899267628147;5768.97115514424;5775.855603609902;5782.421757824226;5792.82621521355;5795.768169273224;6705.664716764191;6933.895991560131;6951.16586009682;6955.582665040063;6958.965205173992;4667.533246675339;4717.716936983792;4720.433547974265;4726.2201736713405;4726.291056341542;5810.448007439287;7388.889166662504;7390.778276651763;7411.962940185264;7429.5542267464125;3973.4238535412205;4810.278458231223;4814.325994360793;4819.614430845594;4822.011487645024;4009.51885773709;4883.194272944996;4889.633277504201;4893.951060489349;4899.485554016848;5747.109198074305;5751.884962300815;5755.683437410982;5773.7482381871105;5800.4199580042505;6778.898316525256;7052.435805135577;7056.823579410453;7078.044463997295;7093.467989900675;1472.690734945652;1641.4419097506905;1681.478741590111;1700.7278835386526;1701.9744703829454;1096.4572536594278;1096.742265567591;1122.337820685783;1123.0790751583622;1130.5308297056795;6415.711292991827;6554.8361290968105;6636.435902948207;6642;6656.933430665728;7131.0729605151;7207.855842883113;7229.530080544748;7236.986821844946;7374.705011799468;5837.7664893404635;6361.854866124142;6673.366030227121;6699.363560461748;6708.1950165979415;3274.2469232076755;3824.2351529694174;3844.0774214188395;3878.941815872764;3898.083950271684;7457.440691948125;7735.535867847947;7757.534547927143;7774.105977812511;7776.222377762291;7473.551586904803;7494.7376841811365;7498.550086994798;7544.773656790305;7587.468877178544;7673.76978690629;7674.57789821554;7684.538927664358;7694.153643099143;7702.730404435818;6179.969100154651;6317.799618072735;7059.541129826544;7326.523775954546;7329.890051649123;6810.28492008332;6971.58170509771;7202.49582529218;7218.819529511804;7234.421246300178;7697;7702.499337543042;7717.344025757873;7730.226977302224;7734.961325193338;4814.975925120492;4821.566059054702;4824.879378015437;4833.130036593447;4843.830465933675;6422.614643121427;6442.0014897690935;7296.343329100407;7300.196978332273;7307.451941104545;6778.186617605918;7035.6833942471685;7059.364657180879;7070.540414873017;7084.681189346388;7018.298170182941;7035.753748618774;7041.507094503336;7051.576905385693;7053.682584283617;6865.828354291183;6896.137982752156;6903.965480172567;6923.446124309942;6930.826729331606;6947;6997.160340758938;7024.719011239493;7028.753993610199;7033.824154396181;5750.654960702372;6597.142371491867;6913.5506192097355;6942.895856562054;6951.131108611424 15:52:59 INFO - PROCESS | 1670 | |5;yui.html;716.6989864257012;732.6007326007325;752.6575408189275;765.152157539542;787.5550314072552;15163.014404063742;15222.77165842512;15252.161131137784;15256.923715381408;15281.2359382031;13817.101888377274;14025.158490490578;14070.437182512713;14077.648058798535;14186.929065354685;938.6057855700606;956.9043095690445;960.1742501448748;961.8749562556858;965.1795973422605;784.9960750196241;801.1467786807032;951.2104952889085;972.5866506734609;975.4050029482011;1015.4618052432186;1025.021104844875;1029.6036026129918;1030.0523518363125;1030.1501261459289;1006.6174853555639;1015.9136473399769;1017.3692310767298;1017.5777052523194;1018.2007124407342;619.5415392609482;758.12058012705;775.7905365551326;776.2625505769485;778.1246098139593;15179.848201518063;15243.237838108162;15248;15266.084034957938;15272.236388180658;12458.501659933592;12589.370531473389;12667.11330206886;12924.483020679161;13247.138935969131;9260.305477089178;10141.087302142769;10196.541155648014;10410.89589104107;10558.366498010068;3494;3509;3534.8586056557706;3571.196480791827;3642.5264715586804;80795;81733.18266817374;81797;81996;83029.92425189358;9537.904620953701;9691.563879625433;9710.75723106914;9748.805023899482;9814;19695.21219151218;21511.354659360244;21566.137354505958;22429.439264018205;22496.32511024672;7330.743423980135;7461.216572259943;7574.886376704354;7727.1886451922865;7813.68745250195;3635.7454978151804;3671.7980511071614;3688.6680198782237;3699.2601479704167;3701.7038636908983;3701.3152566775234;3768.4347347897487;3769.830357633858;3774.6225377462033;3775.528058992626;664.6112024465644;669.845935434843;680.5542369747823;684.4011489946297;684.7534887440518;557.726713910181;619.8481372063783;640.6604499615212;641.9229692436844;651.1730102769551;7989.201079891965;8402.243798058204;8536.189062039097;8603.440776349516;8814.559272036373;518.6525028231094;559.1417174636913;601.3265143039823;609.2475792396386;656.2223764838682;3787.8106094695154;3854.421836724514;3990.06233535119;4027.959720402817;4046.291898917678;83845.16154838496;84171.5791421039;84415.57792211;89136.554317228;96562.51718741361;79740.60129699315;79906;80024;81285;82051.17948820555;65999;66927;67441;67866.66066669635;68491;7357.926420735724;7571.179575794138;7595.924040759522;8045.597720114088;8094.231048050426;49123.75438122787;49255;49596;50439.74780126222;50544.747276263384;64291.67854160699;66248.33751662422;69290;69632.30367696258;70628.29371706217;10129.696109116738;10262.332948358631;10433.26967112295;10463;10475.528601213116;11037.944810275898;11120.221584489009;11316;11325.773484530428;11880.82178767302;8520.72876733988;10431.478426078818;10651.414172220602;11176.888231117584;12053.578124765942;10348.689539313833;11327;11413.85861413852;11511.76976460483;11751.47118379692;10398.376097434179;10844.132469402271;11242.437878105899;11295.887041129812;11359;9632.9036709632;9719.611215551298;9774.071463210983;9881.258905581966;9887.901120988698;9793.265505087005;9938.850917236103;9973.700788976343;9994.350367226107;10122.544485498318 15:52:59 INFO - PROCESS | 1670 | __end_tp_report 15:52:59 INFO - PROCESS | 1670 | __start_cc_report 15:52:59 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,1424 15:52:59 INFO - PROCESS | 1670 | __end_cc_report 15:52:59 INFO - PROCESS | 1670 | __startTimestamp1467672779899__endTimestamp 15:52:59 INFO - PROCESS | 1670 | 15:52:59 INFO - PROCESS | 1670 | ------- Summary: start ------- 15:52:59 INFO - PROCESS | 1670 | Number of tests: 6 15:52:59 INFO - PROCESS | 1670 | 15:52:59 INFO - PROCESS | 1670 | [#0] dojo.html Cycles:165 Average:5726.07 Median:5971.82 stddev:639.67 (10.7%) stddev-sans-first:602.08 15:52:59 INFO - PROCESS | 1670 | Values: 2903.2 3556.2 3561.0 3566.9 3625.7 5704.9 5707.5 5710.2 5737.7 5747.8 5697.3 5738.1 5745.0 5750.5 5755.3 5046.0 5087.1 5115.7 5241.1 5261.3 5180.7 5223.7 5235.1 5237.5 5238.9 4375.7 5195.7 5217.4 5221.7 5231.1 5183.5 5187.3 5190.8 5216.4 5260.3 5073.7 5106.2 5126.8 5151.5 5163.7 5521.9 5555.1 5568.3 5585.3 5625.6 6169.5 6177.0 6184.2 6195.0 6203.6 6055.2 6128.6 6217.1 6260.5 6284.8 5763.5 5810.0 5811.1 5826.2 5856.9 6218.1 6272.0 6273.9 6284.1 6308.9 6005.8 6070.6 6121.5 6130.2 6165.4 6230.7 6245.9 6251.0 6251.0 6258.7 6108.0 6152.7 6155.9 6174.5 6191.1 6093.9 6155.8 6168.9 6172.6 6209.2 4940.1 4940.4 4950.9 4964.5 4972.7 4465.2 4474.0 4481.2 4497.4 4503.3 5642.6 5692.3 5760.1 5763.1 5790.5 6239.5 6256.1 6266.4 6277.6 6292.6 5760.9 5767.3 5794.5 5804.7 5821.7 4768.8 5274.4 5294.6 5386.3 5455.8 6284.4 6321.6 6338.2 6343.6 6360.4 6098.2 6231.5 6244.5 6256.0 6260.7 6257.7 6295.7 6354.6 6364.1 6390.5 6176.2 6195.9 6208.3 6219.4 6226.7 6106.6 6259.8 6267.8 6272.8 6285.4 6051.9 6109.9 6118.6 6120.2 6136.8 6071.8 6095.4 6130.5 6133.0 6137.1 5263.0 5518.0 5942.7 5968.7 5971.8 5355.9 5771.1 5989.9 6114.8 6157.9 5968.1 5998.3 6000.5 6001.8 6007.5 15:52:59 INFO - PROCESS | 1670 | 15:52:59 INFO - PROCESS | 1670 | [#1] ext.html Cycles:180 Average:59303.45 Median:334366.16 stddev:126154.27 (37.7%) stddev-sans-first:126430.96 15:52:59 INFO - PROCESS | 1670 | Values: 523.0 553.5 554.5 570.6 598.2 31395.2 38305.6 38930.2 39012.8 39151.0 42250.6 42627.0 42736.1 42771.0 42892.4 8855.2 9052.6 9534.1 9781.0 9784.7 11788.6 12069.2 12091.2 12102.2 12111.2 11598.5 11681.0 11687.3 11700.4 11701.7 11644.1 11721.0 11726.5 11735.7 11756.3 11478.1 11555.5 11570.9 11595.6 11601.9 41253.8 41691.6 41777.8 41786.2 41792.6 3147.3 3438.5 3483.6 3571.9 3809.4 28637.1 29480.3 29847.7 29940.1 30310.8 2771.7 2792.9 2818.9 2821.1 2828.0 333854.0 333970.0 334352.3 334380.0 336162.0 36194.5 62986.4 63548.0 63603.4 63610.0 35625.0 35760.3 35837.6 35899.8 35927.0 16258.0 16352.2 16361.8 16362.0 16386.3 12908.6 13096.3 14069.1 14111.0 14114.2 8378.3 8388.5 8418.4 8474.0 8488.8 3486.1 3504.5 3513.1 3515.5 3554.4 1046.6 1100.8 1157.5 1160.3 1209.1 30715.8 30728.0 30899.4 31200.7 31203.8 1130.9 1146.5 1160.6 1170.5 1289.1 15812.4 15814.1 15853.4 16047.4 16147.4 630779.0 638696.0 640935.0 643883.0 646451.0 62999.1 63509.7 63519.4 63587.4 63637.7 1380.2 1552.6 1567.6 1574.9 1614.9 26481.9 29168.0 29653.7 29667.3 31331.1 49669.0 50031.5 50106.5 50120.2 50170.0 378392.0 381934.0 383035.0 383057.0 384585.0 21889.5 22303.4 22349.6 27710.4 27775.6 41895.2 42907.0 44284.8 44577.6 44699.0 32351.5 34476.8 35939.3 36948.8 37694.8 30710.9 35794.5 36061.7 36291.8 36860.8 36157.5 36250.8 36305.6 39322.6 40119.8 31597.4 32001.0 32069.2 32575.3 34006.0 25221.0 25355.5 25423.6 25569.7 25789.9 15:52:59 INFO - PROCESS | 1670 | 15:52:59 INFO - PROCESS | 1670 | [#2] jquery.html Cycles:180 Average:35599.19 Median:20991.08 stddev:105112.03 (500.7%) stddev-sans-first:105373.61 15:52:59 INFO - PROCESS | 1670 | Values: 368.8 398.1 404.8 413.7 418.7 14989.3 20480.6 20628.4 21353.9 21370.8 15656.7 16993.7 17248.6 20806.7 20825.6 4442.5 5883.2 6075.4 6091.5 6147.6 5956.3 6033.4 6044.9 6051.7 6055.1 4994.0 5561.2 5854.6 5990.1 5996.2 5777.2 5780.2 5810.4 5826.8 6154.9 3976.1 5799.7 5807.4 5813.2 5819.1 12933.2 13408.3 23197.1 23768.8 24085.2 2076.8 2214.4 2353.2 2772.6 2798.7 9689.3 13969.4 13993.7 14488.9 14612.4 1766.1 1804.9 1822.5 1834.3 1869.6 102846.5 103141.5 127629.4 130912.0 138435.0 11194.6 11569.8 11657.1 11702.4 11776.5 15127.8 15180.0 15210.2 15230.7 15232.2 7130.4 8323.4 8720.8 9108.4 9288.6 8389.8 8421.3 8429.6 8697.7 8969.6 4619.2 4680.9 4694.7 4695.6 4728.3 1726.3 1969.4 2011.3 2047.5 2052.7 791.0 919.5 961.7 977.8 1011.8 19695.6 20717.0 20826.0 20915.4 21066.8 973.4 984.4 1025.5 1030.4 1034.3 10995.6 11137.6 11139.9 11173.1 11209.0 529076.0 636664.0 652276.0 652611.5 675674.6 122220.4 125023.1 125981.0 126651.0 127867.0 1038.2 1043.0 1053.4 1057.0 1061.6 17668.9 17685.3 17791.8 18122.1 18450.3 50940.0 52202.0 52699.5 52825.0 54209.7 73709.6 74323.6 74913.6 74961.9 75518.0 8010.8 8106.7 8142.4 8228.2 8306.7 11076.7 12260.5 12586.6 12590.2 12671.1 10463.4 10741.9 10959.7 10991.8 11004.8 9259.4 10393.1 10451.4 10819.4 10965.6 10957.5 11145.2 11314.6 11343.9 11381.8 8004.3 8039.9 8062.4 8128.2 8431.8 8280.8 10525.9 10893.6 11137.4 11160.6 15:52:59 INFO - PROCESS | 1670 | 15:52:59 INFO - PROCESS | 1670 | [#3] mootools.html Cycles:180 Average:5674.98 Median:4989.50 stddev:3150.95 (63.2%) stddev-sans-first:3143.54 15:52:59 INFO - PROCESS | 1670 | Values: 1416.7 1606.5 1644.9 1904.8 2010.9 7570.0 7857.0 8792.3 8859.9 8882.7 8565.4 8801.6 8805.7 8812.9 8813.8 2504.6 2525.9 2526.6 2527.0 2532.0 2449.1 2533.7 2539.4 2545.2 2559.1 2120.0 2315.0 2522.3 2529.4 2531.9 2341.7 2482.5 2524.4 2532.9 2534.6 2134.4 2469.2 2506.4 2510.9 2511.6 7348.8 8628.3 8847.4 8972.3 8997.1 4656.2 5427.6 5541.8 5548.3 5564.9 3530.0 3628.1 3686.9 3687.1 3703.6 1006.7 1023.9 1033.5 1067.6 1069.4 11455.0 11639.6 11652.2 11654.4 11670.1 3754.4 4623.6 4633.4 4657.6 4715.4 9198.0 9209.0 9218.2 9218.5 9223.6 5258.1 5271.8 5293.5 5310.4 5330.3 4524.5 4683.6 4851.8 4957.9 4972.1 3230.5 3888.0 3935.3 3957.3 3968.7 1216.4 1228.1 1228.3 1236.2 1237.2 915.4 956.3 973.1 977.9 1002.6 5852.2 5913.4 6058.1 6090.7 6130.0 464.3 474.5 479.6 480.4 481.1 3875.7 4028.3 4037.2 4073.2 4087.3 10542.1 10979.2 11005.9 11064.2 11075.7 10338.8 10818.7 10826.4 10830.6 10943.2 8393.3 8486.7 8497.8 8553.4 8555.1 5710.7 5853.0 5883.1 5962.6 6104.8 9592.6 9673.8 9878.6 9878.7 9882.0 9104.2 9400.4 9414.9 9523.0 9867.3 6534.7 6876.0 7043.3 7465.3 7591.7 8422.6 8479.8 8506.9 8522.8 8524.1 7131.1 7162.7 7210.7 7268.9 7471.6 7192.2 7316.0 7347.6 7349.0 7487.4 6944.2 7019.4 7022.4 7032.4 7051.0 4948.7 4950.3 4952.4 5006.9 5054.8 4959.1 5013.9 5020.4 5149.3 5247.4 15:52:59 INFO - PROCESS | 1670 | 15:52:59 INFO - PROCESS | 1670 | [#4] prototype.html Cycles:180 Average:5752.47 Median:6533.43 stddev:1832.19 (28.0%) stddev-sans-first:1791.60 15:52:59 INFO - PROCESS | 1670 | Values: 332.3 340.0 344.8 347.3 350.9 6593.2 6618.5 6651.9 6653.4 6681.2 6513.7 6518.3 6548.5 6550.6 6555.9 4623.4 4764.5 4770.2 4896.8 4917.3 4109.3 4744.3 4880.7 4899.5 4906.0 4812.3 4815.5 4823.2 4828.9 4853.1 3892.9 4530.9 4743.0 4748.0 4753.4 4055.9 4175.5 4177.6 4181.5 4181.9 6165.6 6229.3 6247.5 6250.5 6289.9 5769.0 5775.9 5782.4 5792.8 5795.8 6705.7 6933.9 6951.2 6955.6 6959.0 4667.5 4717.7 4720.4 4726.2 4726.3 5810.4 7388.9 7390.8 7412.0 7429.6 3973.4 4810.3 4814.3 4819.6 4822.0 4009.5 4883.2 4889.6 4894.0 4899.5 5747.1 5751.9 5755.7 5773.7 5800.4 6778.9 7052.4 7056.8 7078.0 7093.5 1472.7 1641.4 1681.5 1700.7 1702.0 1096.5 1096.7 1122.3 1123.1 1130.5 6415.7 6554.8 6636.4 6642.0 6656.9 7131.1 7207.9 7229.5 7237.0 7374.7 5837.8 6361.9 6673.4 6699.4 6708.2 3274.2 3824.2 3844.1 3878.9 3898.1 7457.4 7735.5 7757.5 7774.1 7776.2 7473.6 7494.7 7498.6 7544.8 7587.5 7673.8 7674.6 7684.5 7694.2 7702.7 6180.0 6317.8 7059.5 7326.5 7329.9 6810.3 6971.6 7202.5 7218.8 7234.4 7697.0 7702.5 7717.3 7730.2 7735.0 4815.0 4821.6 4824.9 4833.1 4843.8 6422.6 6442.0 7296.3 7300.2 7307.5 6778.2 7035.7 7059.4 7070.5 7084.7 7018.3 7035.8 7041.5 7051.6 7053.7 6865.8 6896.1 6904.0 6923.4 6930.8 6947.0 6997.2 7024.7 7028.8 7033.8 5750.7 6597.1 6913.6 6942.9 6951.1 15:52:59 INFO - PROCESS | 1670 | 15:52:59 INFO - PROCESS | 1670 | [#5] yui.html Cycles:180 Average:18171.73 Median:558.43 stddev:25452.92 (4557.9%) stddev-sans-first:25490.58 15:52:59 INFO - PROCESS | 1670 | Values: 716.7 732.6 752.7 765.2 787.6 15163.0 15222.8 15252.2 15256.9 15281.2 13817.1 14025.2 14070.4 14077.6 14186.9 938.6 956.9 960.2 961.9 965.2 785.0 801.1 951.2 972.6 975.4 1015.5 1025.0 1029.6 1030.1 1030.2 1006.6 1015.9 1017.4 1017.6 1018.2 619.5 758.1 775.8 776.3 778.1 15179.8 15243.2 15248.0 15266.1 15272.2 12458.5 12589.4 12667.1 12924.5 13247.1 9260.3 10141.1 10196.5 10410.9 10558.4 3494.0 3509.0 3534.9 3571.2 3642.5 80795.0 81733.2 81797.0 81996.0 83029.9 9537.9 9691.6 9710.8 9748.8 9814.0 19695.2 21511.4 21566.1 22429.4 22496.3 7330.7 7461.2 7574.9 7727.2 7813.7 3635.7 3671.8 3688.7 3699.3 3701.7 3701.3 3768.4 3769.8 3774.6 3775.5 664.6 669.8 680.6 684.4 684.8 557.7 619.8 640.7 641.9 651.2 7989.2 8402.2 8536.2 8603.4 8814.6 518.7 559.1 601.3 609.2 656.2 3787.8 3854.4 3990.1 4028.0 4046.3 83845.2 84171.6 84415.6 89136.6 96562.5 79740.6 79906.0 80024.0 81285.0 82051.2 65999.0 66927.0 67441.0 67866.7 68491.0 7357.9 7571.2 7595.9 8045.6 8094.2 49123.8 49255.0 49596.0 50439.7 50544.7 64291.7 66248.3 69290.0 69632.3 70628.3 10129.7 10262.3 10433.3 10463.0 10475.5 11037.9 11120.2 11316.0 11325.8 11880.8 8520.7 10431.5 10651.4 11176.9 12053.6 10348.7 11327.0 11413.9 11511.8 11751.5 10398.4 10844.1 11242.4 11295.9 11359.0 9632.9 9719.6 9774.1 9881.3 9887.9 9793.3 9938.9 9973.7 9994.4 10122.5 15:52:59 INFO - PROCESS | 1670 | -------- Summary: end -------- 15:52:59 INFO - PROCESS | 1670 | 15:53:00 INFO - TEST-INFO | 1670: exit 0 15:53:00 INFO - TEST-OK | dromaeo_css | took 1112986ms 15:53:00 INFO - TEST-START | kraken 15:53:00 INFO - operating with platform_type : mac_ 15:53:00 INFO - Initialising browser for kraken test... 15:53:00 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/tmpkWibwp/profile http://localhost:49264/getInfo.html) 15:53:02 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 15:53:02 INFO - PROCESS | 1675 | colorDepth:24 15:53:02 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 15:53:02 INFO - PROCESS | 1675 | __metrics 15:53:02 INFO - PROCESS | 1675 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:53:02 ERROR - PROCESS | 1675 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:53:03 INFO - TEST-INFO | 1675: exit 0 15:53:03 INFO - Browser initialized. 15:53:03 INFO - Running cycle 1/1 for kraken test... 15:53:03 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/tmpkWibwp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:53:15 INFO - PROCESS | 1678 | RSS: Main: 161419264 15:53:15 INFO - PROCESS | 1678 | 15:53:17 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection) 15:53:18 INFO - PROCESS | 1678 | RSS: Main: 224362496 15:53:18 INFO - PROCESS | 1678 | 15:53:21 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-dft) 15:53:22 INFO - PROCESS | 1678 | RSS: Main: 239587328 15:53:22 INFO - PROCESS | 1678 | 15:53:25 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-fft) 15:53:25 INFO - PROCESS | 1678 | RSS: Main: 324767744 15:53:25 INFO - PROCESS | 1678 | 15:53:27 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator) 15:53:28 INFO - PROCESS | 1678 | RSS: Main: 231272448 15:53:28 INFO - PROCESS | 1678 | 15:53:30 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:53:31 INFO - PROCESS | 1678 | RSS: Main: 232460288 15:53:31 INFO - PROCESS | 1678 | 15:53:33 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom) 15:53:34 INFO - PROCESS | 1678 | RSS: Main: 269828096 15:53:34 INFO - PROCESS | 1678 | 15:53:37 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate) 15:53:37 INFO - PROCESS | 1678 | RSS: Main: 270233600 15:53:37 INFO - PROCESS | 1678 | 15:53:40 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial) 15:53:41 INFO - PROCESS | 1678 | RSS: Main: 269041664 15:53:41 INFO - PROCESS | 1678 | 15:53:42 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:53:43 INFO - PROCESS | 1678 | RSS: Main: 260812800 15:53:43 INFO - PROCESS | 1678 | 15:53:45 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:53:46 INFO - PROCESS | 1678 | RSS: Main: 267649024 15:53:46 INFO - PROCESS | 1678 | 15:53:48 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:53:48 INFO - PROCESS | 1678 | RSS: Main: 271224832 15:53:48 INFO - PROCESS | 1678 | 15:53:51 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:53:52 INFO - PROCESS | 1678 | RSS: Main: 278257664 15:53:52 INFO - PROCESS | 1678 | 15:53:54 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:53:55 INFO - PROCESS | 1678 | RSS: Main: 275558400 15:53:55 INFO - PROCESS | 1678 | 15:53:57 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49264/tests/kraken/driver.html?testName=ai-astar) 15:53:57 INFO - PROCESS | 1678 | RSS: Main: 336326656 15:53:57 INFO - PROCESS | 1678 | 15:53:57 INFO - PROCESS | 1678 | __start_tp_report 15:53:57 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 15:53:57 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 15:53:57 INFO - PROCESS | 1678 | |i|pagename|runs| 15:53:57 INFO - PROCESS | 1678 | |0;ai-astar;112;113;121;113;113;112;113;114;116;133 15:53:57 INFO - PROCESS | 1678 | |1;audio-beat-detection;157;121;141;161;120;139;117;182;187;148 15:53:57 INFO - PROCESS | 1678 | |2;audio-dft;186;189;186;188;185;183;186;187;183;186 15:53:57 INFO - PROCESS | 1678 | |3;audio-fft;70;80;75;155;56;56;57;61;135;55 15:53:57 INFO - PROCESS | 1678 | |4;audio-oscillator;92;91;145;79;78;86;124;79;77;154 15:53:57 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;86;84;86;85;86;84;87;85;88;85 15:53:57 INFO - PROCESS | 1678 | |6;imaging-darkroom;93;93;93;93;92;93;106;93;89;130 15:53:57 INFO - PROCESS | 1678 | |7;imaging-desaturate;86;86;87;87;87;83;87;84;86;84 15:53:57 INFO - PROCESS | 1678 | |8;json-parse-financial;61;65;65;64;64;64;65;80;60;56 15:53:57 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;63;66;63;73;78;94;99;66;67;67 15:53:57 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;81;80;79;80;79;77;80;78;79;82 15:53:57 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;127;123;128;125;127;123;126;138;173;130 15:53:57 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;161;163;163;169;154;153;162;178;180;160 15:53:57 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;66;68;69;65;66;69;71;92;85;66 15:53:57 INFO - PROCESS | 1678 | __end_tp_report 15:53:57 INFO - PROCESS | 1678 | __start_cc_report 15:53:57 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1862 15:53:57 INFO - PROCESS | 1678 | __end_cc_report 15:53:57 INFO - PROCESS | 1678 | __startTimestamp1467672837423__endTimestamp 15:53:57 INFO - PROCESS | 1678 | 15:53:57 INFO - PROCESS | 1678 | ------- Summary: start ------- 15:53:57 INFO - PROCESS | 1678 | Number of tests: 14 15:53:57 INFO - PROCESS | 1678 | 15:53:57 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:116.00 Median:113.50 stddev:6.55 (5.8%) stddev-sans-first:6.78 15:53:57 INFO - PROCESS | 1678 | Values: 112.0 113.0 121.0 113.0 113.0 112.0 113.0 114.0 116.0 133.0 15:53:57 INFO - PROCESS | 1678 | 15:53:57 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:152.50 stddev:24.78 (16.2%) stddev-sans-first:26.03 15:53:57 INFO - PROCESS | 1678 | Values: 157.0 121.0 141.0 161.0 120.0 139.0 117.0 182.0 187.0 148.0 15:53:57 INFO - PROCESS | 1678 | 15:53:57 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:185.90 Median:186.00 stddev:1.91 (1.0%) stddev-sans-first:2.03 15:53:57 INFO - PROCESS | 1678 | Values: 186.0 189.0 186.0 188.0 185.0 183.0 186.0 187.0 183.0 186.0 15:53:57 INFO - PROCESS | 1678 | 15:53:57 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:80.00 Median:59.00 stddev:35.66 (60.4%) stddev-sans-first:37.63 15:53:57 INFO - PROCESS | 1678 | Values: 70.0 80.0 75.0 155.0 56.0 56.0 57.0 61.0 135.0 55.0 15:53:57 INFO - PROCESS | 1678 | 15:53:57 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:100.50 Median:79.00 stddev:29.35 (37.1%) stddev-sans-first:30.96 15:53:57 INFO - PROCESS | 1678 | Values: 92.0 91.0 145.0 79.0 78.0 86.0 124.0 79.0 77.0 154.0 15:53:57 INFO - PROCESS | 1678 | 15:53:57 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:85.60 Median:86.00 stddev:1.26 (1.5%) stddev-sans-first:1.33 15:53:57 INFO - PROCESS | 1678 | Values: 86.0 84.0 86.0 85.0 86.0 84.0 87.0 85.0 88.0 85.0 15:53:57 INFO - PROCESS | 1678 | 15:53:57 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:97.50 Median:93.00 stddev:12.26 (13.2%) stddev-sans-first:12.89 15:53:57 INFO - PROCESS | 1678 | Values: 93.0 93.0 93.0 93.0 92.0 93.0 106.0 93.0 89.0 130.0 15:53:57 INFO - PROCESS | 1678 | 15:53:57 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:86.50 stddev:1.49 (1.7%) stddev-sans-first:1.58 15:53:57 INFO - PROCESS | 1678 | Values: 86.0 86.0 87.0 87.0 87.0 83.0 87.0 84.0 86.0 84.0 15:53:57 INFO - PROCESS | 1678 | 15:53:57 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:64.50 stddev:6.20 (9.6%) stddev-sans-first:6.46 15:53:57 INFO - PROCESS | 1678 | Values: 61.0 65.0 65.0 64.0 64.0 64.0 65.0 80.0 60.0 56.0 15:53:57 INFO - PROCESS | 1678 | 15:53:57 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:73.60 Median:70.00 stddev:12.95 (18.5%) stddev-sans-first:13.15 15:53:57 INFO - PROCESS | 1678 | Values: 63.0 66.0 63.0 73.0 78.0 94.0 99.0 66.0 67.0 67.0 15:53:57 INFO - PROCESS | 1678 | 15:53:57 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:80.00 stddev:1.43 (1.8%) stddev-sans-first:1.41 15:53:57 INFO - PROCESS | 1678 | Values: 81.0 80.0 79.0 80.0 79.0 77.0 80.0 78.0 79.0 82.0 15:53:57 INFO - PROCESS | 1678 | 15:53:57 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:132.00 Median:127.50 stddev:15.03 (11.8%) stddev-sans-first:15.84 15:53:57 INFO - PROCESS | 1678 | Values: 127.0 123.0 128.0 125.0 127.0 123.0 126.0 138.0 173.0 130.0 15:53:57 INFO - PROCESS | 1678 | 15:53:57 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.30 Median:163.00 stddev:8.99 (5.5%) stddev-sans-first:9.46 15:53:57 INFO - PROCESS | 1678 | Values: 161.0 163.0 163.0 169.0 154.0 153.0 162.0 178.0 180.0 160.0 15:53:57 INFO - PROCESS | 1678 | 15:53:57 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:69.00 stddev:9.19 (13.3%) stddev-sans-first:9.51 15:53:57 INFO - PROCESS | 1678 | Values: 66.0 68.0 69.0 65.0 66.0 69.0 71.0 92.0 85.0 66.0 15:53:57 INFO - PROCESS | 1678 | -------- Summary: end -------- 15:53:57 INFO - PROCESS | 1678 | 15:53:58 INFO - TEST-INFO | 1678: exit 0 15:53:58 INFO - TEST-OK | kraken | took 57756ms 15:53:58 INFO - SUITE-END | took 1170s 15:53:58 INFO - Completed test suite (00:19:31) 15:53:58 INFO - javascript benchmark 15:53:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2903.187107609869, 3556.1820781220304, 3561.0207193021924, 3566.8751593694224, 3625.655562721542, 5704.857378565538, 5707.543396528278, 5710.172025056369, 5737.684427356494, 5747.798827041054, 5697.344805347387, 5738.053221218504, 5745.0, 5750.511206547438, 5755.30936287645, 5045.974770126144, 5087.10975579274, 5115.718635475047, 5241.082810508165, 5261.289725887013, 5180.689158650474, 5223.71269580173, 5235.057689615867, 5237.45006774289, 5238.92141617876, 4375.715578487404, 5195.714235717034, 5217.373915130171, 5221.686698798084, 5231.136862417697, 5183.455737147583, 5187.273781670569, 5190.792368305301, 5216.426193118754, 5260.316158899357, 5073.6955782652785, 5106.157484015133, 5126.820561280338, 5151.484851514856, 5163.741812909377, 5521.889562208733, 5555.083411237141, 5568.276124103841, 5585.273914391144, 5625.634333768333, 6169.5064394848305, 6177.011678131477, 6184.165137706397, 6195.0, 6203.596766210182, 6055.182550355689, 6128.601640893327, 6217.098520714516, 6260.530460215502, 6284.811455656338, 5763.481286684177, 5810.0, 5811.099279611667, 5826.155207494932, 5856.912146317809, 6218.129461875341, 6271.9686401568615, 6273.8745225095245, 6284.088807122942, 6308.873822523524, 6005.759769609254, 6070.6357618543025, 6121.540884433685, 6130.233720784902, 6165.445109940127, 6230.688465576703, 6245.906311405332, 6251.0, 6251.0, 6258.718357673915, 6107.969460152671, 6152.661603611755, 6155.907661385083, 6174.475169610543, 6191.071339299051, 6093.9390606093375, 6155.815325540241, 6168.920438923171, 6172.5679202456295, 6209.19280493542, 4940.135476291634, 4940.407151141886, 4950.8762280943265, 4964.503549645006, 4972.701637901738, 4465.151621191963, 4474.0, 4481.215787237221, 4497.415336006298, 4503.2569626012, 5642.605017648725, 5692.288463942007, 5760.0783874579865, 5763.106718458645, 5790.478856902899, 6239.532035097386, 6256.061590761331, 6266.373362663789, 6277.591956522902, 6292.590981586182, 5760.855978600484, 5767.250257466502, 5794.50746686528, 5804.680742559115, 5821.7380217890295, 4768.807798050488, 5274.393444753902, 5294.57643388528, 5386.272853164851, 5455.8090466834265, 6284.402981716729, 6321.557490975588, 6338.207724034496, 6343.619382837044, 6360.427561519486, 6098.207233059674, 6231.501479881689, 6244.5316601256, 6255.96872015637, 6260.7495700171485, 6257.749690012349, 6295.748170073146, 6354.586951848115, 6364.07720880479, 6390.456811171102, 6176.197094377702, 6195.907061394173, 6208.2860471044605, 6219.440250377488, 6226.657533835501, 6106.6336019838955, 6259.843503912439, 6267.811965641038, 6272.7804526843165, 6285.402886725754, 6051.909221361595, 6109.920916985209, 6118.588722523033, 6120.203342909657, 6136.7948077883175, 6071.848203794941, 6095.359987201457, 6130.540209484396, 6132.969335153296, 6137.1101190328045, 5262.97368513155, 5518.017457290341, 5942.6731529766275, 5968.731407086779, 5971.820845374646, 5355.892882142258, 5771.07662773971, 5989.940100599112, 6114.814446323713, 6157.9223635862645, 5968.104784282393, 5998.34018258, 6000.489958353589, 6001.7599296027665, 6007.459328660441], "value": 5685.9183687443765, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [522.9790808367663, 553.4714347797853, 554.5184517624124, 570.6034306157222, 598.2491972574419, 31395.215119622022, 38305.61694383055, 38930.22139557207, 39012.80493597531, 39151.0, 42250.57749422505, 42627.0, 42736.14527709444, 42771.0, 42892.3566146508, 8855.203031727175, 9052.592633331484, 9534.141927226548, 9780.951095244514, 9784.657536986208, 11788.646340609796, 12069.215500992452, 12091.153619246656, 12102.213356131868, 12111.21277116989, 11598.53605855769, 11681.007114395286, 11687.29876207426, 11700.356480393617, 11701.70745731355, 11644.068474522019, 11721.0, 11726.530938762397, 11735.7066073348, 11756.294622322603, 11478.081753459703, 11555.53777848885, 11570.94214528922, 11595.594154204648, 11601.883981160165, 41253.79373103115, 41691.583084169375, 41777.79111104456, 41786.1642767146, 41792.582074179474, 3147.2761264908972, 3438.5186073949667, 3483.5645544306963, 3571.8570057581583, 3809.4095415210686, 28637.14088577346, 29480.26299342512, 29847.70152298471, 29940.101796946128, 30310.825294748167, 2771.7366850149206, 2792.902248421316, 2818.943621127566, 2821.083147976916, 2827.971720282812, 333854.0, 333970.0, 334352.3282383597, 334380.0, 336162.0, 36194.457083143774, 62986.37013629897, 63548.04677929835, 63603.36396635974, 63610.0, 35625.0, 35760.28479430397, 35837.64162358395, 35899.82050089785, 35927.0, 16258.0, 16352.182390880409, 16361.77286703502, 16362.018278903304, 16386.344546218257, 12908.612741617766, 13096.279704616147, 14069.085509442059, 14111.0, 14114.22371769542, 8378.329733621296, 8388.538630375388, 8418.368622353348, 8474.0, 8488.787780305542, 3486.1284678830293, 3504.5268888700207, 3513.1392808762016, 3515.525404070469, 3554.449060395643, 1046.5604446132643, 1100.8293714474269, 1157.548556063136, 1160.2980196980704, 1209.1052621060353, 30715.77136914543, 30728.0, 30899.382012359627, 31200.68799312023, 31203.84398077995, 1130.9377984210948, 1146.507001989136, 1160.5705888821021, 1170.5083864776814, 1289.0976316578433, 15812.36750529989, 15814.051156930622, 15853.445129420415, 16047.358105675643, 16147.434839780552, 630779.0, 638696.0, 640935.0, 643883.0, 646451.0, 62999.055014174824, 63509.68245158745, 63519.36480635135, 63587.36412635907, 63637.681811591574, 1380.1650001749, 1552.6273694313509, 1567.6316065724773, 1574.8660964105825, 1614.8788840836748, 26481.867590661925, 29168.0, 29653.703462965957, 29667.258318542208, 31331.060068197992, 49669.0, 50031.49968500269, 50106.49893501018, 50120.248196276356, 50170.0, 378392.0, 381934.0, 383035.0, 383057.0, 384585.0, 21889.452763681034, 22303.44241393978, 22349.553008940056, 27710.44579108447, 27775.583366249117, 41895.16209675728, 42907.0, 44284.778576108205, 44577.55422445864, 44699.0, 32351.514727278638, 34476.82761586176, 35939.28121437504, 36948.815255923546, 37694.8115259422, 30710.925117620776, 35794.463083054296, 36061.737839175505, 36291.818540908185, 36860.81569592135, 36157.457638134925, 36250.8187459061, 36305.63694363023, 39322.6067739319, 40119.799401002805, 31597.368052638358, 32001.0, 32069.198270043435, 32575.348493029534, 34005.97982060542, 25221.0, 25355.492890142465, 25423.61864571996, 25569.744302556737, 25789.871050644626], "value": 18871.93868739615, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.78426120719377, 398.08440586650704, 404.83199472219013, 413.7414116177389, 418.7257346438083, 14989.32510971416, 20480.590388192228, 20628.38114856555, 21353.932303384827, 21370.786292137072, 15656.686866262668, 16993.745093823603, 17248.56878578036, 20806.687899681478, 20825.583488330223, 4442.511323754385, 5883.205767221413, 6075.362086980869, 6091.543134264925, 6147.569670123094, 5956.285245770514, 6033.366496517869, 6044.879102417949, 6051.727672254737, 6055.061465472859, 4993.950060499385, 5561.249231353776, 5854.619449735775, 5990.101484777275, 5996.19051428056, 5777.248957635523, 5780.1907732917425, 5810.360860305363, 5826.82519524415, 6154.876902461926, 3976.08550033491, 5799.681017544033, 5807.361190269067, 5813.215215945877, 5819.127130930352, 12933.224006559636, 13408.26254555999, 23197.072117115295, 23768.762312377, 24085.157019504408, 2076.802703743142, 2214.368904862107, 2353.235198560458, 2772.625695531098, 2798.734120258572, 9689.32174747768, 13969.371378288002, 13993.740563349245, 14488.855111448856, 14612.415503379852, 1766.143420441085, 1804.9097545122822, 1822.5170329862597, 1834.284628994693, 1869.569998900247, 102846.48576757143, 103141.45287820688, 127629.44741105125, 130912.0, 138435.0, 11194.552217911356, 11569.76860462786, 11657.125715571367, 11702.35637039971, 11776.470058847372, 15127.848721512644, 15180.0, 15210.239488025554, 15230.695386092437, 15232.238388080552, 7130.358267755927, 8323.417360784686, 8720.825583488295, 9108.407953483002, 9288.609657474974, 8389.790255243546, 8421.326293896474, 8429.620667069996, 8697.695580654647, 8969.641214351483, 4619.214733495247, 4680.882977925579, 4694.718316900997, 4695.5539223773685, 4728.290756386501, 1726.292220189716, 1969.3993332033867, 2011.3362590345444, 2047.5393036566654, 2052.671572548385, 790.9598877476101, 919.4529255093208, 961.711486554031, 977.8484334928097, 1011.7521207304258, 19695.615028511347, 20717.0, 20826.0, 20915.37253882386, 21066.789332106484, 973.4305431322614, 984.4290311619244, 1025.477006726575, 1030.386919782728, 1034.3173505486343, 10995.560177592966, 11137.610183643534, 11139.944300278608, 11173.10615150786, 11209.0, 529076.0, 636664.0, 652276.0, 652611.4738852646, 675674.6216268985, 122220.38889805494, 125023.12465313027, 125981.0, 126651.0, 127867.0, 1038.2265212416798, 1042.9530671119817, 1053.3627155570923, 1056.99471502642, 1061.5753698520653, 17668.91165544164, 17685.292588296837, 17791.822081779017, 18122.09389530492, 18450.26198952027, 50939.981200376526, 52201.95596088133, 52699.47300526946, 52825.0, 54209.72895135499, 73709.6314518424, 74323.62838185775, 74913.6254318725, 74961.87557186537, 75518.0, 8010.799730006796, 8106.716264930699, 8142.389320800845, 8228.21831925966, 8306.667733290842, 11076.667699969013, 12260.509579616715, 12586.559470418491, 12590.181638193488, 12671.113022088366, 10463.372197668165, 10741.892581074402, 10959.671209863716, 10991.835122473009, 11004.834927475935, 9259.35184537076, 10393.06462418386, 10451.42517161533, 10819.404932728776, 10965.616203433161, 10957.50691218913, 11145.164112691742, 11314.60398886035, 11343.922327378887, 11381.772364552828, 8004.319632831041, 8039.919600803917, 8062.355011598941, 8128.187181281824, 8431.789205269917, 8280.83438331242, 10525.947370263406, 10893.618723344645, 11137.387443690675, 11160.553577856796], "value": 9566.678018481914, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1416.6529200345917, 1606.5260748079315, 1644.917754112295, 1904.8476121910248, 2010.8793472391658, 7570.0, 7857.0, 8792.2966162707, 8859.911400885989, 8882.733517994455, 8565.35759818013, 8801.647934082644, 8805.691800786974, 8812.867806982884, 8813.823723525526, 2504.5867431873767, 2525.911593094242, 2526.621006848969, 2526.9747302526926, 2531.962020569693, 2449.1183174057323, 2533.6579561759113, 2539.415934335104, 2545.172818833877, 2559.1171045989104, 2120.0, 2314.9884250578807, 2522.3441905104623, 2529.3676580854785, 2531.898724051045, 2341.683872677184, 2482.5034993001473, 2524.394145405108, 2532.8606926619027, 2534.569123249052, 2134.3703607435846, 2469.172827102923, 2506.4235225898146, 2510.8870100845506, 2511.598144296922, 7348.77953661391, 8628.309735221168, 8847.380683352168, 8972.282217422591, 8997.100289971017, 4656.231721765905, 5427.6472029317965, 5541.778328866841, 5548.306461692288, 5564.888702225973, 3530.029241958482, 3628.11111277736, 3686.8525258989607, 3687.1335236219466, 3703.6296370362747, 1006.7231511334369, 1023.9351074882113, 1033.457434846704, 1067.5569638599973, 1069.3904474449566, 11455.0, 11639.592614258545, 11652.242604230783, 11654.417279136009, 11670.124740644485, 3754.380527213034, 4623.583877451046, 4633.397658304466, 4657.627389808875, 4715.434147902273, 9198.0, 9209.033051529626, 9218.170364667078, 9218.492982886006, 9223.631054757869, 5258.132408152688, 5271.789128434896, 5293.470652934676, 5310.4424035476495, 5330.253764472977, 4524.457065152203, 4683.601893839062, 4851.781669824866, 4957.925631115536, 4972.129877271463, 3230.5154226866157, 3887.9611203888167, 3935.2916475034767, 3957.3272543667645, 3968.66266367362, 1216.391804097951, 1228.1280290993495, 1228.2937311046185, 1236.190295356543, 1237.2267332916927, 915.4095608332589, 956.2636769687302, 973.1387721866058, 977.8679878216492, 1002.5638847101534, 5852.180694702745, 5913.379095195029, 6058.091286307089, 6090.69546522681, 6129.96935015331, 464.27109438182407, 474.5444373401504, 479.601930397769, 480.4426864836773, 481.1291562272298, 3875.670568001695, 4028.274910516135, 4037.1723796621623, 4073.246449406869, 4087.346024636044, 10542.051215390498, 10979.1765617579, 11005.889941100646, 11064.225504214628, 11075.667729968114, 10338.793224135476, 10818.729531761768, 10826.35041897473, 10830.62092826763, 10943.179261555415, 8393.328533717287, 8486.74539763808, 8497.830043399097, 8553.44402613828, 8555.14448555152, 5710.657995371002, 5852.970735146297, 5883.0881213411985, 5962.612430192024, 6104.755809767737, 9592.568334424828, 9673.79077615298, 9878.604855805686, 9878.703638890845, 9882.0, 9104.180623743894, 9400.435973841591, 9414.905850941677, 9523.047695230422, 9867.309288350034, 6534.673266336569, 6875.965620171867, 7043.330883566258, 7465.253474652492, 7591.696332146652, 8422.620982055945, 8479.788005299917, 8506.872396913928, 8522.786930326543, 8524.062353141273, 7131.144262688511, 7162.749303774552, 7210.675519601526, 7268.890966635399, 7471.551706897603, 7192.244814294633, 7316.012338334257, 7347.55914645123, 7349.0, 7487.401007919245, 6944.236134025355, 7019.3682568569075, 7022.40309573692, 7032.367086962198, 7051.0, 4948.653594248368, 4950.331705219894, 4952.4057113146655, 5006.874828129326, 5054.7978080876355, 4959.13215187348, 5013.899722005613, 5020.397552293748, 5149.330587023663, 5247.449017853223], "value": 4524.072197704493, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.3416153394561, 339.9987038172581, 344.83103279393094, 347.3487211478478, 350.89297764181913, 6593.241777195624, 6618.470522358211, 6651.866962660744, 6653.367930046637, 6681.198256209255, 6513.67431628419, 6518.315576864432, 6548.541602087856, 6550.5742126761725, 6555.934440655592, 4623.375844261023, 4764.452088009889, 4770.212914869043, 4896.804127834882, 4917.311576379309, 4109.2808758467145, 4744.288356746481, 4880.682755620874, 4899.48555401683, 4906.043321552299, 4812.278158276269, 4815.5425234602835, 4823.180059389894, 4828.87927801806, 4853.102176097434, 3892.9416058759143, 4530.909381812362, 4742.976285118552, 4747.95252047482, 4753.3582966299455, 4055.898602534931, 4175.54069052404, 4177.561356057631, 4181.477315335583, 4181.91636167278, 6165.5992360496875, 6229.345918678564, 6247.468965137969, 6250.468710159642, 6289.899267628147, 5768.97115514424, 5775.855603609902, 5782.421757824226, 5792.82621521355, 5795.768169273224, 6705.664716764191, 6933.895991560131, 6951.16586009682, 6955.582665040063, 6958.965205173992, 4667.533246675339, 4717.716936983792, 4720.433547974265, 4726.2201736713405, 4726.291056341542, 5810.448007439287, 7388.889166662504, 7390.778276651763, 7411.962940185264, 7429.5542267464125, 3973.4238535412205, 4810.278458231223, 4814.325994360793, 4819.614430845594, 4822.011487645024, 4009.51885773709, 4883.194272944996, 4889.633277504201, 4893.951060489349, 4899.485554016848, 5747.109198074305, 5751.884962300815, 5755.683437410982, 5773.7482381871105, 5800.4199580042505, 6778.898316525256, 7052.435805135577, 7056.823579410453, 7078.044463997295, 7093.467989900675, 1472.690734945652, 1641.4419097506905, 1681.478741590111, 1700.7278835386526, 1701.9744703829454, 1096.4572536594278, 1096.742265567591, 1122.337820685783, 1123.0790751583622, 1130.5308297056795, 6415.711292991827, 6554.8361290968105, 6636.435902948207, 6642.0, 6656.933430665728, 7131.0729605151, 7207.855842883113, 7229.530080544748, 7236.986821844946, 7374.705011799468, 5837.7664893404635, 6361.854866124142, 6673.366030227121, 6699.363560461748, 6708.1950165979415, 3274.2469232076755, 3824.2351529694174, 3844.0774214188395, 3878.941815872764, 3898.083950271684, 7457.440691948125, 7735.535867847947, 7757.534547927143, 7774.105977812511, 7776.222377762291, 7473.551586904803, 7494.7376841811365, 7498.550086994798, 7544.773656790305, 7587.468877178544, 7673.76978690629, 7674.57789821554, 7684.538927664358, 7694.153643099143, 7702.730404435818, 6179.969100154651, 6317.799618072735, 7059.541129826544, 7326.523775954546, 7329.890051649123, 6810.28492008332, 6971.58170509771, 7202.49582529218, 7218.819529511804, 7234.421246300178, 7697.0, 7702.499337543042, 7717.344025757873, 7730.226977302224, 7734.961325193338, 4814.975925120492, 4821.566059054702, 4824.879378015437, 4833.130036593447, 4843.830465933675, 6422.614643121427, 6442.0014897690935, 7296.343329100407, 7300.196978332273, 7307.451941104545, 6778.186617605918, 7035.6833942471685, 7059.364657180879, 7070.540414873017, 7084.681189346388, 7018.298170182941, 7035.753748618774, 7041.507094503336, 7051.576905385693, 7053.682584283617, 6865.828354291183, 6896.137982752156, 6903.965480172567, 6923.446124309942, 6930.826729331606, 6947.0, 6997.160340758938, 7024.719011239493, 7028.753993610199, 7033.824154396181, 5750.654960702372, 6597.142371491867, 6913.5506192097355, 6942.895856562054, 6951.131108611424], "value": 5149.280000818573, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.6989864257012, 732.6007326007325, 752.6575408189275, 765.152157539542, 787.5550314072552, 15163.014404063742, 15222.77165842512, 15252.161131137784, 15256.923715381408, 15281.2359382031, 13817.101888377274, 14025.158490490578, 14070.437182512713, 14077.648058798535, 14186.929065354685, 938.6057855700606, 956.9043095690445, 960.1742501448748, 961.8749562556858, 965.1795973422605, 784.9960750196241, 801.1467786807032, 951.2104952889085, 972.5866506734609, 975.4050029482011, 1015.4618052432186, 1025.021104844875, 1029.6036026129918, 1030.0523518363125, 1030.1501261459289, 1006.6174853555639, 1015.9136473399769, 1017.3692310767298, 1017.5777052523194, 1018.2007124407342, 619.5415392609482, 758.12058012705, 775.7905365551326, 776.2625505769485, 778.1246098139593, 15179.848201518063, 15243.237838108162, 15248.0, 15266.084034957938, 15272.236388180658, 12458.501659933592, 12589.370531473389, 12667.11330206886, 12924.483020679161, 13247.138935969131, 9260.305477089178, 10141.087302142769, 10196.541155648014, 10410.89589104107, 10558.366498010068, 3494.0, 3509.0, 3534.8586056557706, 3571.196480791827, 3642.5264715586804, 80795.0, 81733.18266817374, 81797.0, 81996.0, 83029.92425189358, 9537.904620953701, 9691.563879625433, 9710.75723106914, 9748.805023899482, 9814.0, 19695.21219151218, 21511.354659360244, 21566.137354505958, 22429.439264018205, 22496.32511024672, 7330.743423980135, 7461.216572259943, 7574.886376704354, 7727.1886451922865, 7813.68745250195, 3635.7454978151804, 3671.7980511071614, 3688.6680198782237, 3699.2601479704167, 3701.7038636908983, 3701.3152566775234, 3768.4347347897487, 3769.830357633858, 3774.6225377462033, 3775.528058992626, 664.6112024465644, 669.845935434843, 680.5542369747823, 684.4011489946297, 684.7534887440518, 557.726713910181, 619.8481372063783, 640.6604499615212, 641.9229692436844, 651.1730102769551, 7989.201079891965, 8402.243798058204, 8536.189062039097, 8603.440776349516, 8814.559272036373, 518.6525028231094, 559.1417174636913, 601.3265143039823, 609.2475792396386, 656.2223764838682, 3787.8106094695154, 3854.421836724514, 3990.06233535119, 4027.959720402817, 4046.291898917678, 83845.16154838496, 84171.5791421039, 84415.57792211, 89136.554317228, 96562.51718741361, 79740.60129699315, 79906.0, 80024.0, 81285.0, 82051.17948820555, 65999.0, 66927.0, 67441.0, 67866.66066669635, 68491.0, 7357.926420735724, 7571.179575794138, 7595.924040759522, 8045.597720114088, 8094.231048050426, 49123.75438122787, 49255.0, 49596.0, 50439.74780126222, 50544.747276263384, 64291.67854160699, 66248.33751662422, 69290.0, 69632.30367696258, 70628.29371706217, 10129.696109116738, 10262.332948358631, 10433.26967112295, 10463.0, 10475.528601213116, 11037.944810275898, 11120.221584489009, 11316.0, 11325.773484530428, 11880.82178767302, 8520.72876733988, 10431.478426078818, 10651.414172220602, 11176.888231117584, 12053.578124765942, 10348.689539313833, 11327.0, 11413.85861413852, 11511.76976460483, 11751.47118379692, 10398.376097434179, 10844.132469402271, 11242.437878105899, 11295.887041129812, 11359.0, 9632.9036709632, 9719.611215551298, 9774.071463210983, 9881.258905581966, 9887.901120988698, 9793.265505087005, 9938.850917236103, 9973.700788976343, 9994.350367226107, 10122.544485498318], "value": 6953.527345972153, "unit": "score"}], "name": "dromaeo_css", "value": 7415.650966368196, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 121.0, 113.0, 113.0, 112.0, 113.0, 114.0, 116.0, 133.0], "value": 116.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 121.0, 141.0, 161.0, 120.0, 139.0, 117.0, 182.0, 187.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 189.0, 186.0, 188.0, 185.0, 183.0, 186.0, 187.0, 183.0, 186.0], "value": 185.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 80.0, 75.0, 155.0, 56.0, 56.0, 57.0, 61.0, 135.0, 55.0], "value": 80.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 145.0, 79.0, 78.0, 86.0, 124.0, 79.0, 77.0, 154.0], "value": 100.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 86.0, 85.0, 86.0, 84.0, 87.0, 85.0, 88.0, 85.0], "value": 85.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 93.0, 92.0, 93.0, 106.0, 93.0, 89.0, 130.0], "value": 97.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 87.0, 87.0, 87.0, 83.0, 87.0, 84.0, 86.0, 84.0], "value": 85.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 65.0, 65.0, 64.0, 64.0, 64.0, 65.0, 80.0, 60.0, 56.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 63.0, 73.0, 78.0, 94.0, 99.0, 66.0, 67.0, 67.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 79.0, 80.0, 79.0, 77.0, 80.0, 78.0, 79.0, 82.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 123.0, 128.0, 125.0, 127.0, 123.0, 126.0, 138.0, 173.0, 130.0], "value": 132.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 169.0, 154.0, 153.0, 162.0, 178.0, 180.0, 160.0], "value": 164.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 69.0, 65.0, 66.0, 69.0, 71.0, 92.0, 85.0, 66.0], "value": 71.7, "unit": "score"}], "name": "kraken", "value": 1484.0, "alertThreshold": 2.0}]} 15:53:58 INFO - Return code: 0 15:53:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:53:58 ERROR - # TBPL SUCCESS # 15:53:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:53:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:53:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:53:58 INFO - 2016-07-04 15:53:58.753 screenresolution[1682:10300] starting screenresolution argv=screenresolution get 15:53:58 INFO - 2016-07-04 15:53:58.756 screenresolution[1682:10300] Display 0: 1600x1200x32@60 15:53:58 INFO - 2016-07-04 15:53:58.762 screenresolution[1683:10303] starting screenresolution argv=screenresolution list 15:53:58 INFO - Available Modes on Display 0 15:53:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:53:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:53:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:53:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:53:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:53:58 INFO - Intel Iris: 15:53:58 INFO - Chipset Model: Intel Iris 15:53:58 INFO - Type: GPU 15:53:58 INFO - Bus: Built-In 15:53:58 INFO - VRAM (Dynamic, Max): 1536 MB 15:53:58 INFO - Vendor: Intel (0x8086) 15:53:58 INFO - Device ID: 0x0a2e 15:53:58 INFO - Revision ID: 0x0009 15:53:58 INFO - Displays: 15:53:58 INFO - Display: 15:53:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:53:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:53:58 INFO - Display Serial Number: 1600x1200 60 15:53:58 INFO - Main Display: Yes 15:53:58 INFO - Mirror: Off 15:53:58 INFO - Online: Yes 15:53:58 INFO - Rotation: Supported 15:53:58 INFO - Return code: 0 15:53:58 INFO - Running post-action listener: _resource_record_post_action 15:53:58 INFO - Running post-run listener: _resource_record_post_run 15:54:00 INFO - Total resource usage - Wall time: 1194s; CPU: 52.0%; Read bytes: 33050112; Write bytes: 496139776; Read time: 343; Write time: 1533 15:54:00 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 249856; Write bytes: 197682688; Read time: 9; Write time: 404 15:54:00 INFO - run-tests - Wall time: 1173s; CPU: 52.0%; Read bytes: 31264256; Write bytes: 297613312; Read time: 321; Write time: 1127 15:54:00 INFO - Running post-run listener: _upload_blobber_files 15:54:00 INFO - Blob upload gear active. 15:54:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:54:00 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 15:54:00 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'] 15:54:00 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 15:54:00 INFO - (blobuploader) - INFO - Open directory for files ... 15:54:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:54:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:54:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:01 INFO - (blobuploader) - INFO - Done attempting. 15:54:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:54:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:54:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:02 INFO - (blobuploader) - INFO - Done attempting. 15:54:02 INFO - (blobuploader) - INFO - Iteration through files over. 15:54:02 INFO - Return code: 0 15:54:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:54:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:54:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/39c6fa1a54000b5ae6543269c82cb36276e86e19784543d3196e8e4c5cc8fa1ddbf0a5e56ac0ea42f171327aca439ceac2bc822baea8f9e6475d70ba7b1cff4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/513d3b72e1fc1b83053ae113c7e227b0e4d9eb5e8aa9784583ea8be8cb0a40e31ab5662f9178883b392a3c8c4f6219751beaa37211dbe8842360fc3e6debcbbc"} 15:54:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:54:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:54:02 INFO - Contents: 15:54:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/39c6fa1a54000b5ae6543269c82cb36276e86e19784543d3196e8e4c5cc8fa1ddbf0a5e56ac0ea42f171327aca439ceac2bc822baea8f9e6475d70ba7b1cff4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/513d3b72e1fc1b83053ae113c7e227b0e4d9eb5e8aa9784583ea8be8cb0a40e31ab5662f9178883b392a3c8c4f6219751beaa37211dbe8842360fc3e6debcbbc"} 15:54:02 INFO - Running post-run listener: copy_logs_to_upload_dir 15:54:02 INFO - Copying logs to upload dir... 15:54:02 INFO - mkdir: /builds/slave/test/build/upload/logs 15:54:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.345667 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-07-04 15:54:02.587886) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 15:54:02.591041) ========= 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.en1b4GqkNQ/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.MHCkN3CGSo/Listeners TMPDIR=/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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/39c6fa1a54000b5ae6543269c82cb36276e86e19784543d3196e8e4c5cc8fa1ddbf0a5e56ac0ea42f171327aca439ceac2bc822baea8f9e6475d70ba7b1cff4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/513d3b72e1fc1b83053ae113c7e227b0e4d9eb5e8aa9784583ea8be8cb0a40e31ab5662f9178883b392a3c8c4f6219751beaa37211dbe8842360fc3e6debcbbc"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011117 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/39c6fa1a54000b5ae6543269c82cb36276e86e19784543d3196e8e4c5cc8fa1ddbf0a5e56ac0ea42f171327aca439ceac2bc822baea8f9e6475d70ba7b1cff4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/513d3b72e1fc1b83053ae113c7e227b0e4d9eb5e8aa9784583ea8be8cb0a40e31ab5662f9178883b392a3c8c4f6219751beaa37211dbe8842360fc3e6debcbbc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 15:54:02.623137) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 15:54:02.623436) ========= 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.en1b4GqkNQ/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.MHCkN3CGSo/Listeners TMPDIR=/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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.005182 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 15:54:02.671514) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 15:54:02.671836) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 15:54:02.672156) ========= ========= Total master_lag: 0.18 =========