builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0180 starttime: 1468721355.43 results: success (0) buildid: 20160714035157 builduid: 428dea4a520a404f91ed970baf353636 revision: fc7cc284b0c73491db3f45c165cf7ddb78fdde01 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 19:09:15.428202) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 19:09:15.429098) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 19:09:15.429470) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 19:09:15.795539) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 19:09:15.795829) ========= 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.YN7BNETlzH/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.PQtRtVBCEc/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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-16 19:09:15-- 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% 154M=0s 2016-07-16 19:09:16 (154 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.482404 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 19:09:16.321714) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 19:09:16.322028) ========= 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.YN7BNETlzH/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.PQtRtVBCEc/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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.028042 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 19:09:16.397740) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-16 19:09:16.398078) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fc7cc284b0c73491db3f45c165cf7ddb78fdde01 --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 fc7cc284b0c73491db3f45c165cf7ddb78fdde01 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YN7BNETlzH/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.PQtRtVBCEc/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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-16 19:09:16,481 truncating revision to first 12 chars 2016-07-16 19:09:16,481 Setting DEBUG logging. 2016-07-16 19:09:16,481 attempt 1/10 2016-07-16 19:09:16,481 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/fc7cc284b0c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-16 19:09:18,402 unpacking tar archive at: mozilla-beta-fc7cc284b0c7/testing/mozharness/ program finished with exit code 0 elapsedTime=2.168154 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-16 19:09:18.599473) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 19:09:18.599982) ========= script_repo_revision: fc7cc284b0c73491db3f45c165cf7ddb78fdde01 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 19:09:18.600667) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 19:09:18.601133) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 19:09:18.622232) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-07-16 19:09:18.622759) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.YN7BNETlzH/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.PQtRtVBCEc/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 19:09:18 INFO - MultiFileLogger online at 20160716 19:09:18 in /builds/slave/test 19:09:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 19:09:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:09:18 INFO - {'append_to_log': False, 19:09:18 INFO - 'base_work_dir': '/builds/slave/test', 19:09:18 INFO - 'blob_upload_branch': 'Mozilla-Beta', 19:09:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:09:18 INFO - 'branch': 'Mozilla-Beta', 19:09:18 INFO - 'buildbot_json_path': 'buildprops.json', 19:09:18 INFO - 'config_files': ('talos/mac_config.py',), 19:09:18 INFO - 'default_actions': ('clobber', 19:09:18 INFO - 'read-buildbot-config', 19:09:18 INFO - 'download-and-extract', 19:09:18 INFO - 'populate-webroot', 19:09:18 INFO - 'create-virtualenv', 19:09:18 INFO - 'install', 19:09:18 INFO - 'run-tests'), 19:09:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:09:18 INFO - 'download_minidump_stackwalk': True, 19:09:18 INFO - 'download_symbols': 'ondemand', 19:09:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:09:18 INFO - 'tooltool.py': '/tools/tooltool.py', 19:09:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:09:18 INFO - '/tools/misc-python/virtualenv.py')}, 19:09:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:09:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:09:18 INFO - 'installer_path': 'installer.exe', 19:09:18 INFO - 'log_level': 'info', 19:09:18 INFO - 'log_name': 'talos', 19:09:18 INFO - 'log_to_console': True, 19:09:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:09:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:09:18 INFO - 'opt_config_files': (), 19:09:18 INFO - 'pip_index': False, 19:09:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:09:18 INFO - 'cmd': ('bash', 19:09:18 INFO - '-c', 19:09:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:09:18 INFO - 'enabled': True, 19:09:18 INFO - 'halt_on_failure': False, 19:09:18 INFO - 'name': 'check_screen_resolution'},), 19:09:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:09:18 INFO - 'cmd': ('bash', 19:09:18 INFO - '-c', 19:09:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:09:18 INFO - 'enabled': True, 19:09:18 INFO - 'halt_on_failure': False, 19:09:18 INFO - 'name': 'check_screen_resolution'},), 19:09:18 INFO - 'run_cmd_checks_enabled': True, 19:09:18 INFO - 'sps_profile': False, 19:09:18 INFO - 'sps_profile_interval': 0, 19:09:18 INFO - 'suite': 'dromaeojs-e10s', 19:09:18 INFO - 'system_bits': '32', 19:09:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:09:18 INFO - 'title': 't-yosemite-r7-0180', 19:09:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:09:18 INFO - 'use_talos_json': True, 19:09:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:09:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:09:18 INFO - 'work_dir': 'build'} 19:09:18 INFO - ##### 19:09:18 INFO - ##### Running clobber step. 19:09:18 INFO - ##### 19:09:18 INFO - Running pre-action listener: _resource_record_pre_action 19:09:18 INFO - Running main action method: clobber 19:09:18 INFO - rmtree: /builds/slave/test/build 19:09:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:09:20 INFO - Running post-action listener: _resource_record_post_action 19:09:20 INFO - ##### 19:09:20 INFO - ##### Running read-buildbot-config step. 19:09:20 INFO - ##### 19:09:20 INFO - Running pre-action listener: _resource_record_pre_action 19:09:20 INFO - Running main action method: read_buildbot_config 19:09:20 INFO - Using buildbot properties: 19:09:20 INFO - { 19:09:20 INFO - "project": "", 19:09:20 INFO - "product": "firefox", 19:09:20 INFO - "script_repo_revision": "production", 19:09:20 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 19:09:20 INFO - "repository": "", 19:09:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 19:09:20 INFO - "buildid": "20160714035157", 19:09:20 INFO - "pgo_build": "False", 19:09:20 INFO - "basedir": "/builds/slave/test", 19:09:20 INFO - "buildnumber": 46, 19:09:20 INFO - "slavename": "t-yosemite-r7-0180", 19:09:20 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 19:09:20 INFO - "platform": "yosemite_r7", 19:09:20 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 19:09:20 INFO - "branch": "mozilla-beta", 19:09:20 INFO - "repo_path": "releases/mozilla-beta", 19:09:20 INFO - "revision": "fc7cc284b0c73491db3f45c165cf7ddb78fdde01", 19:09:20 INFO - "stage_platform": "macosx64", 19:09:20 INFO - "builduid": "428dea4a520a404f91ed970baf353636", 19:09:20 INFO - "slavebuilddir": "test" 19:09:20 INFO - } 19:09:20 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493517/firefox-48.0.en-US.mac.dmg. 19:09:20 INFO - Running post-action listener: _resource_record_post_action 19:09:20 INFO - ##### 19:09:20 INFO - ##### Running download-and-extract step. 19:09:20 INFO - ##### 19:09:20 INFO - Running pre-action listener: _resource_record_pre_action 19:09:20 INFO - Running main action method: download_and_extract 19:09:20 INFO - mkdir: /builds/slave/test/build/tests 19:09:20 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')]} 19:09:20 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493517/firefox-48.0.en-US.mac.test_packages.json 19:09:20 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493517/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 19:09:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493517/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 19:09:21 INFO - Downloaded 1165 bytes. 19:09:21 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 19:09:21 INFO - Using the following test package requirements: 19:09:21 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 19:09:21 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 19:09:21 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 19:09:21 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 19:09:21 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 19:09:21 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 19:09:21 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 19:09:21 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 19:09:21 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 19:09:21 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 19:09:21 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 19:09:21 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 19:09:21 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 19:09:21 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 19:09:21 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 19:09:21 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 19:09:21 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 19:09:21 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 19:09: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')]} 19:09:21 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493517/firefox-48.0.en-US.mac.common.tests.zip 19:09:21 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493517/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 19:09:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493517/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 19:09:22 INFO - Downloaded 18314867 bytes. 19:09:22 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'] 19:09:22 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 19:09:25 INFO - Return code: 0 19:09:25 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 19:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:25 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493517/firefox-48.0.en-US.mac.common.tests.zip 19:09:25 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493517/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 19:09:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493517/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 19:09:27 INFO - Downloaded 18314867 bytes. 19:09:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:09:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:09:31 INFO - Return code: 0 19:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:31 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493517/firefox-48.0.en-US.mac.talos.tests.zip 19:09:31 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493517/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 19:09:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493517/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 19:09:39 INFO - Downloaded 10840145 bytes. 19:09:39 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'] 19:09:39 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 19:09:39 INFO - Return code: 0 19:09:39 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')]} 19:09:39 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493517/firefox-48.0.en-US.mac.dmg 19:09:39 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493517/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 19:09:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493517/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 19:09:41 INFO - Downloaded 86189359 bytes. 19:09:41 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493517/firefox-48.0.en-US.mac.dmg 19:09:41 INFO - mkdir: /builds/slave/test/properties 19:09:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:09:41 INFO - Writing to file /builds/slave/test/properties/build_url 19:09:41 INFO - Contents: 19:09:41 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493517/firefox-48.0.en-US.mac.dmg 19:09:41 INFO - Running post-action listener: _resource_record_post_action 19:09:41 INFO - Running post-action listener: set_extra_try_arguments 19:09:41 INFO - ##### 19:09:41 INFO - ##### Running populate-webroot step. 19:09:41 INFO - ##### 19:09:41 INFO - Running pre-action listener: _resource_record_pre_action 19:09:41 INFO - Running main action method: populate_webroot 19:09:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:09:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:09:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:09:41 INFO - '--tppagecycles', 19:09:41 INFO - '7'], 19:09:41 INFO - 'tests': ['tsvgm']}}, 19:09:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:09:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:09:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:09:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:09:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:09:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:09:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:41 INFO - 'talos_options': ['--disable-e10s'], 19:09:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:09:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:09:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:41 INFO - 'talos_options': ['--disable-e10s'], 19:09:41 INFO - 'tests': ['damp', 'tps']}, 19:09:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:41 INFO - 'tests': ['damp', 'tps']}, 19:09:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:09:41 INFO - 'tests': ['dromaeo_dom']}, 19:09:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:09:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:09:41 INFO - 'tests': ['a11yr', 19:09:41 INFO - 'ts_paint', 19:09:41 INFO - 'tpaint', 19:09:41 INFO - 'sessionrestore', 19:09:41 INFO - 'sessionrestore_no_auto_restore', 19:09:41 INFO - 'tabpaint']}, 19:09:41 INFO - 'other-e10s': {'tests': ['a11yr', 19:09:41 INFO - 'ts_paint', 19:09:41 INFO - 'tpaint', 19:09:41 INFO - 'sessionrestore', 19:09:41 INFO - 'sessionrestore_no_auto_restore', 19:09:41 INFO - 'tabpaint']}, 19:09:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:09:41 INFO - 'ts_paint', 19:09:41 INFO - 'tpaint', 19:09:41 INFO - 'sessionrestore', 19:09:41 INFO - 'sessionrestore_no_auto_restore', 19:09:41 INFO - 'tabpaint']}, 19:09:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:09:41 INFO - 'ts_paint', 19:09:41 INFO - 'tpaint', 19:09:41 INFO - 'sessionrestore', 19:09:41 INFO - 'sessionrestore_no_auto_restore', 19:09:41 INFO - 'tabpaint']}, 19:09:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:09:41 INFO - 'tests': ['a11yr', 19:09:41 INFO - 'ts_paint', 19:09:41 INFO - 'tpaint', 19:09:41 INFO - 'sessionrestore', 19:09:41 INFO - 'sessionrestore_no_auto_restore', 19:09:41 INFO - 'tabpaint']}, 19:09:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:09:41 INFO - 'tests': ['a11yr', 19:09:41 INFO - 'ts_paint', 19:09:41 INFO - 'tpaint', 19:09:41 INFO - 'sessionrestore', 19:09:41 INFO - 'sessionrestore_no_auto_restore', 19:09:41 INFO - 'tabpaint']}, 19:09:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:09:41 INFO - 'tests': ['tsvgx', 19:09:41 INFO - 'tsvgr_opacity', 19:09:41 INFO - 'tart', 19:09:41 INFO - 'tscrollx', 19:09:41 INFO - 'cart']}, 19:09:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:09:41 INFO - 'tsvgr_opacity', 19:09:41 INFO - 'tart', 19:09:41 INFO - 'tscrollx', 19:09:41 INFO - 'cart']}, 19:09:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:41 INFO - 'talos_options': ['--disable-e10s'], 19:09:41 INFO - 'tests': ['tp5o']}, 19:09:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:41 INFO - 'tests': ['tp5o']}, 19:09:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:41 INFO - 'talos_options': ['--disable-e10s', 19:09:41 INFO - '--xperf_path', 19:09:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:09:41 INFO - 'tests': ['tp5n']}, 19:09:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:41 INFO - 'talos_options': ['--xperf_path', 19:09:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:09:41 INFO - 'tests': ['tp5n']}}, 19:09:41 INFO - 'talos.zip': {'path': '', 19:09:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:09:41 INFO - Running post-action listener: _resource_record_post_action 19:09:41 INFO - ##### 19:09:41 INFO - ##### Running create-virtualenv step. 19:09:41 INFO - ##### 19:09:41 INFO - Running pre-action listener: _resource_record_pre_action 19:09:41 INFO - Running main action method: create_virtualenv 19:09:41 INFO - Creating virtualenv /builds/slave/test/build/venv 19:09:41 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 19:09:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:09:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:09:41 INFO - Using real prefix '/tools/python27' 19:09:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:09:42 INFO - Installing distribute.............................................................................................................................................................................................done. 19:09:45 INFO - Installing pip.................done. 19:09:45 INFO - Return code: 0 19:09:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:09: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')]} 19:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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')]} 19:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:45 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 0x100fd0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fe0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd15bc81b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e6fe00>, '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 0x100cd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6ab20>, '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.YN7BNETlzH/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.PQtRtVBCEc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 19:09:45 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 19:09:45 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 19:09:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YN7BNETlzH/Render', 19:09:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:09:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:09:45 INFO - 'HOME': '/Users/cltbld', 19:09:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:09:45 INFO - 'LOGNAME': 'cltbld', 19:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:45 INFO - 'MOZ_NO_REMOTE': '1', 19:09:45 INFO - 'NO_EM_RESTART': '1', 19:09:45 INFO - 'PAGER': '/bin/cat', 19:09:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:45 INFO - 'PWD': '/builds/slave/test', 19:09:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:09:45 INFO - 'SHELL': '/bin/bash', 19:09:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQtRtVBCEc/Listeners', 19:09:45 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 19:09:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:09:45 INFO - 'USER': 'cltbld', 19:09:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:09:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:45 INFO - 'XPC_FLAGS': '0x0', 19:09:45 INFO - 'XPC_SERVICE_NAME': '0', 19:09:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:45 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 19:09:45 INFO - Cleaning up... 19:09:45 INFO - Return code: 0 19:09:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:09: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')]} 19:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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')]} 19:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:45 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 0x100fd0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fe0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd15bc81b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e6fe00>, '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 0x100cd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6ab20>, '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.YN7BNETlzH/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.PQtRtVBCEc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 19:09:45 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 19:09:45 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 19:09:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YN7BNETlzH/Render', 19:09:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:09:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:09:45 INFO - 'HOME': '/Users/cltbld', 19:09:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:09:45 INFO - 'LOGNAME': 'cltbld', 19:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:45 INFO - 'MOZ_NO_REMOTE': '1', 19:09:45 INFO - 'NO_EM_RESTART': '1', 19:09:45 INFO - 'PAGER': '/bin/cat', 19:09:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:45 INFO - 'PWD': '/builds/slave/test', 19:09:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:09:45 INFO - 'SHELL': '/bin/bash', 19:09:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQtRtVBCEc/Listeners', 19:09:45 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 19:09:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:09:45 INFO - 'USER': 'cltbld', 19:09:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:09:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:45 INFO - 'XPC_FLAGS': '0x0', 19:09:45 INFO - 'XPC_SERVICE_NAME': '0', 19:09:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:45 INFO - Downloading/unpacking psutil>=0.7.1 19:09:45 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 19:09:45 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 19:09:45 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 19:09:45 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 19:09:45 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 19:09:45 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 19:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:09:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:09:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:09:49 INFO - Installing collected packages: psutil 19:09:49 INFO - Running setup.py install for psutil 19:09:49 INFO - building 'psutil._psutil_osx' extension 19:09:49 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 19:09:50 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 19:09:50 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 19:09:50 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 19:09:50 INFO - building 'psutil._psutil_posix' extension 19:09:50 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 19:09:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:09:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:09:50 INFO - ^ 19:09:50 INFO - 1 warning generated. 19:09:50 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 19:09:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:09:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:09:50 INFO - Successfully installed psutil 19:09:50 INFO - Cleaning up... 19:09:50 INFO - Return code: 0 19:09:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100fd0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fe0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd15bc81b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e6fe00>, '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 0x100cd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6ab20>, '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.YN7BNETlzH/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.PQtRtVBCEc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 19:09:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 19:09:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:09:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YN7BNETlzH/Render', 19:09:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:09:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:09:50 INFO - 'HOME': '/Users/cltbld', 19:09:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:09:50 INFO - 'LOGNAME': 'cltbld', 19:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:50 INFO - 'MOZ_NO_REMOTE': '1', 19:09:50 INFO - 'NO_EM_RESTART': '1', 19:09:50 INFO - 'PAGER': '/bin/cat', 19:09:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:50 INFO - 'PWD': '/builds/slave/test', 19:09:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:09:50 INFO - 'SHELL': '/bin/bash', 19:09:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQtRtVBCEc/Listeners', 19:09:50 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 19:09:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:09:50 INFO - 'USER': 'cltbld', 19:09:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:09:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:50 INFO - 'XPC_FLAGS': '0x0', 19:09:50 INFO - 'XPC_SERVICE_NAME': '0', 19:09:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:09:51 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 19:09:51 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 19:09:51 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 19:09:51 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 19:09:51 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 19:09:51 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 19:09:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:09:53 INFO - Installing collected packages: mozsystemmonitor 19:09:53 INFO - Running setup.py install for mozsystemmonitor 19:09:53 INFO - Successfully installed mozsystemmonitor 19:09:53 INFO - Cleaning up... 19:09:53 INFO - Return code: 0 19:09:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:09:53 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')]} 19:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:53 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')]} 19:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:53 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 0x100fd0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fe0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd15bc81b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e6fe00>, '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 0x100cd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6ab20>, '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.YN7BNETlzH/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.PQtRtVBCEc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 19:09:53 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 19:09:53 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 19:09:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YN7BNETlzH/Render', 19:09:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:09:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:09:53 INFO - 'HOME': '/Users/cltbld', 19:09:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:09:53 INFO - 'LOGNAME': 'cltbld', 19:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:53 INFO - 'MOZ_NO_REMOTE': '1', 19:09:53 INFO - 'NO_EM_RESTART': '1', 19:09:53 INFO - 'PAGER': '/bin/cat', 19:09:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:53 INFO - 'PWD': '/builds/slave/test', 19:09:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:09:53 INFO - 'SHELL': '/bin/bash', 19:09:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQtRtVBCEc/Listeners', 19:09:53 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 19:09:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:09:53 INFO - 'USER': 'cltbld', 19:09:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:09:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:53 INFO - 'XPC_FLAGS': '0x0', 19:09:53 INFO - 'XPC_SERVICE_NAME': '0', 19:09:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:54 INFO - Downloading/unpacking blobuploader==1.2.4 19:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:56 INFO - Downloading blobuploader-1.2.4.tar.gz 19:09:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:09:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:09:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:09:57 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 19:09:57 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 19:09:57 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 19:09:57 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 19:09:57 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 19:09:57 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 19:09:57 INFO - Downloading docopt-0.6.1.tar.gz 19:09:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:09:57 INFO - Installing collected packages: blobuploader, requests, docopt 19:09:57 INFO - Running setup.py install for blobuploader 19:09:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:09:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:09:57 INFO - Running setup.py install for requests 19:09:58 INFO - Running setup.py install for docopt 19:09:58 INFO - Successfully installed blobuploader requests docopt 19:09:58 INFO - Cleaning up... 19:09:58 INFO - Return code: 0 19:09:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:09:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:58 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 0x100fd0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fe0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd15bc81b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e6fe00>, '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 0x100cd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6ab20>, '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.YN7BNETlzH/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.PQtRtVBCEc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 19:09:58 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 19:09:58 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 19:09:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YN7BNETlzH/Render', 19:09:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:09:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:09:58 INFO - 'HOME': '/Users/cltbld', 19:09:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:09:58 INFO - 'LOGNAME': 'cltbld', 19:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:58 INFO - 'MOZ_NO_REMOTE': '1', 19:09:58 INFO - 'NO_EM_RESTART': '1', 19:09:58 INFO - 'PAGER': '/bin/cat', 19:09:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:58 INFO - 'PWD': '/builds/slave/test', 19:09:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:09:58 INFO - 'SHELL': '/bin/bash', 19:09:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQtRtVBCEc/Listeners', 19:09:58 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 19:09:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:09:58 INFO - 'USER': 'cltbld', 19:09:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:09:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:58 INFO - 'XPC_FLAGS': '0x0', 19:09:58 INFO - 'XPC_SERVICE_NAME': '0', 19:09:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:09:58 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-QLKEr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:09:59 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-nYyNG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:09:59 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-1c2II0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:09:59 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Wgcs24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:09:59 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-kTK5ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:09:59 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-GiSHQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:09:59 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-zL676B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:09:59 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-zkvtkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:09:59 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-SLZutY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:09:59 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-sC8jdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:09:59 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-HVBVyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:10:00 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-JeDZqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:10:00 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-ql4gvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:10:00 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-O_g_eZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:00 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-KPfIZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:10:00 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Mll6IO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:10:00 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-jDyqrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:10:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:10:00 INFO - Running setup.py install for manifestparser 19:10:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:10:00 INFO - Running setup.py install for mozcrash 19:10:00 INFO - Running setup.py install for mozdebug 19:10:01 INFO - Running setup.py install for mozdevice 19:10:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:10:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:10:01 INFO - Running setup.py install for mozfile 19:10:01 INFO - Running setup.py install for mozhttpd 19:10:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:10:01 INFO - Running setup.py install for mozinfo 19:10:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:10:01 INFO - Running setup.py install for mozInstall 19:10:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:10:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:10:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:10:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:10:01 INFO - Running setup.py install for mozleak 19:10:02 INFO - Running setup.py install for mozlog 19:10:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:10:02 INFO - Running setup.py install for moznetwork 19:10:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:10:02 INFO - Running setup.py install for mozprocess 19:10:02 INFO - Running setup.py install for mozprofile 19:10:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:10:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:10:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:10:02 INFO - Running setup.py install for mozrunner 19:10:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:10:02 INFO - Running setup.py install for mozscreenshot 19:10:03 INFO - Running setup.py install for moztest 19:10:03 INFO - Running setup.py install for mozversion 19:10:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:10:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:10:03 INFO - Cleaning up... 19:10:03 INFO - Return code: 0 19:10:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:03 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 0x100fd0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fe0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd15bc81b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e6fe00>, '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 0x100cd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6ab20>, '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.YN7BNETlzH/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.PQtRtVBCEc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 19:10:03 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 19:10:03 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 19:10:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YN7BNETlzH/Render', 19:10:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:03 INFO - 'HOME': '/Users/cltbld', 19:10:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:03 INFO - 'LOGNAME': 'cltbld', 19:10:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:03 INFO - 'MOZ_NO_REMOTE': '1', 19:10:03 INFO - 'NO_EM_RESTART': '1', 19:10:03 INFO - 'PAGER': '/bin/cat', 19:10:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:03 INFO - 'PWD': '/builds/slave/test', 19:10:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:03 INFO - 'SHELL': '/bin/bash', 19:10:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQtRtVBCEc/Listeners', 19:10:03 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 19:10:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:03 INFO - 'USER': 'cltbld', 19:10:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:03 INFO - 'XPC_FLAGS': '0x0', 19:10:03 INFO - 'XPC_SERVICE_NAME': '0', 19:10:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:10:03 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-eL8XcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:10:03 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)) 19:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:10:03 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-lXhTY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:10:03 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)) 19:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:10:03 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-4fv_Au-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:10:03 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)) 19:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:10:03 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-gyARx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:10:04 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)) 19:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:10:04 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-jxLSw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:10:04 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)) 19:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:10:04 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-r2LzIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:10:04 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)) 19:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:10:04 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-ppOzov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:10:04 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)) 19:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:10:04 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-RprG3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:10:04 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)) 19:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:10:04 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-gUGCZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:10:04 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)) 19:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:10:04 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-WmQ5DH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:10:04 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)) 19:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:10:04 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Jeb2r7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:10:04 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)) 19:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:10:04 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-r0ccpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:10:04 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)) 19:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:10:04 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-FdIZIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:10:04 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)) 19:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:10:05 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-dvR_IS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:10:05 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)) 19:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:05 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-gFi6Zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:05 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)) 19:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:10:05 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-zjCWVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:10:05 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)) 19:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:10:05 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-VaJ56L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:10:05 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)) 19:10:05 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)) 19:10:05 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)) 19:10:05 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)) 19:10:05 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)) 19:10:05 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)) 19:10:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:10:05 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 19:10:05 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 19:10:05 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 19:10:05 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 19:10:05 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 19:10:05 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 19:10:07 INFO - Downloading blessings-1.6.tar.gz 19:10:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:10:08 INFO - Installing collected packages: blessings 19:10:08 INFO - Running setup.py install for blessings 19:10:08 INFO - Successfully installed blessings 19:10:08 INFO - Cleaning up... 19:10:08 INFO - Return code: 0 19:10:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:10:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:10:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:10:08 INFO - Reading from file tmpfile_stdout 19:10:08 INFO - Current package versions: 19:10:08 INFO - blessings == 1.6 19:10:08 INFO - blobuploader == 1.2.4 19:10:08 INFO - docopt == 0.6.1 19:10:08 INFO - manifestparser == 1.1 19:10:08 INFO - mozInstall == 1.12 19:10:08 INFO - mozcrash == 0.17 19:10:08 INFO - mozdebug == 0.1 19:10:08 INFO - mozdevice == 0.48 19:10:08 INFO - mozfile == 1.2 19:10:08 INFO - mozhttpd == 0.7 19:10:08 INFO - mozinfo == 0.9 19:10:08 INFO - mozleak == 0.1 19:10:08 INFO - mozlog == 3.1 19:10:08 INFO - moznetwork == 0.27 19:10:08 INFO - mozprocess == 0.22 19:10:08 INFO - mozprofile == 0.28 19:10:08 INFO - mozrunner == 6.11 19:10:08 INFO - mozscreenshot == 0.1 19:10:08 INFO - mozsystemmonitor == 0.0 19:10:08 INFO - moztest == 0.7 19:10:08 INFO - mozversion == 1.4 19:10:08 INFO - psutil == 3.1.1 19:10:08 INFO - requests == 1.2.3 19:10:08 INFO - wsgiref == 0.1.2 19:10:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:08 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 0x100fd0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fe0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd15bc81b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e6fe00>, '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 0x100cd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6ab20>, '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.YN7BNETlzH/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.PQtRtVBCEc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 19:10:08 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 19:10:08 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 19:10:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YN7BNETlzH/Render', 19:10:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:08 INFO - 'HOME': '/Users/cltbld', 19:10:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:08 INFO - 'LOGNAME': 'cltbld', 19:10:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:08 INFO - 'MOZ_NO_REMOTE': '1', 19:10:08 INFO - 'NO_EM_RESTART': '1', 19:10:08 INFO - 'PAGER': '/bin/cat', 19:10:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:08 INFO - 'PWD': '/builds/slave/test', 19:10:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:08 INFO - 'SHELL': '/bin/bash', 19:10:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQtRtVBCEc/Listeners', 19:10:08 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 19:10:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:08 INFO - 'USER': 'cltbld', 19:10:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:08 INFO - 'XPC_FLAGS': '0x0', 19:10:08 INFO - 'XPC_SERVICE_NAME': '0', 19:10:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:08 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)) 19:10:08 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)) 19:10:08 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)) 19:10:08 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)) 19:10:08 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)) 19:10:08 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)) 19:10:08 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)) 19:10:08 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)) 19:10:08 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)) 19:10:08 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)) 19:10:08 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)) 19:10:08 INFO - Cleaning up... 19:10:08 INFO - Return code: 0 19:10:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:08 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 0x100fd0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fe0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd15bc81b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e6fe00>, '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 0x100cd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6ab20>, '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.YN7BNETlzH/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.PQtRtVBCEc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 19:10:08 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 19:10:08 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 19:10:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YN7BNETlzH/Render', 19:10:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:08 INFO - 'HOME': '/Users/cltbld', 19:10:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:08 INFO - 'LOGNAME': 'cltbld', 19:10:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:08 INFO - 'MOZ_NO_REMOTE': '1', 19:10:08 INFO - 'NO_EM_RESTART': '1', 19:10:08 INFO - 'PAGER': '/bin/cat', 19:10:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:08 INFO - 'PWD': '/builds/slave/test', 19:10:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:08 INFO - 'SHELL': '/bin/bash', 19:10:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQtRtVBCEc/Listeners', 19:10:08 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 19:10:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:08 INFO - 'USER': 'cltbld', 19:10:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:08 INFO - 'XPC_FLAGS': '0x0', 19:10:08 INFO - 'XPC_SERVICE_NAME': '0', 19:10:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:09 INFO - Downloading/unpacking jsonschema 19:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:10:11 INFO - Downloading/unpacking functools32 (from jsonschema) 19:10:11 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 19:10:11 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 19:10:11 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 19:10:11 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 19:10:11 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 19:10:11 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 19:10:11 INFO - Downloading functools32-3.2.3-2.tar.gz 19:10:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:10:12 INFO - warning: no files found matching '*.txt' 19:10:12 INFO - no previously-included directories found matching 'build' 19:10:12 INFO - no previously-included directories found matching 'dist' 19:10:12 INFO - no previously-included directories found matching '.git*' 19:10:12 INFO - Installing collected packages: jsonschema, functools32 19:10:12 INFO - Running setup.py install for functools32 19:10:12 INFO - warning: no files found matching '*.txt' 19:10:12 INFO - no previously-included directories found matching 'build' 19:10:12 INFO - no previously-included directories found matching 'dist' 19:10:12 INFO - no previously-included directories found matching '.git*' 19:10:12 INFO - Successfully installed jsonschema functools32 19:10:12 INFO - Cleaning up... 19:10:12 INFO - Return code: 0 19:10:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:10:12 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')]} 19:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:12 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')]} 19:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:12 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 0x100fd0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fe0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd15bc81b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e6fe00>, '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 0x100cd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6ab20>, '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.YN7BNETlzH/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.PQtRtVBCEc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 19:10:12 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 19:10:12 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 19:10:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YN7BNETlzH/Render', 19:10:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:12 INFO - 'HOME': '/Users/cltbld', 19:10:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:12 INFO - 'LOGNAME': 'cltbld', 19:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:12 INFO - 'MOZ_NO_REMOTE': '1', 19:10:12 INFO - 'NO_EM_RESTART': '1', 19:10:12 INFO - 'PAGER': '/bin/cat', 19:10:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:12 INFO - 'PWD': '/builds/slave/test', 19:10:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:12 INFO - 'SHELL': '/bin/bash', 19:10:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQtRtVBCEc/Listeners', 19:10:12 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 19:10:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:12 INFO - 'USER': 'cltbld', 19:10:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:12 INFO - 'XPC_FLAGS': '0x0', 19:10:12 INFO - 'XPC_SERVICE_NAME': '0', 19:10:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:12 INFO - Downloading/unpacking flake8 19:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:10:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:10:15 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 19:10:15 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 19:10:15 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 19:10:15 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 19:10:15 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 19:10:15 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 19:10:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:10:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:10:15 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 19:10:15 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 19:10:15 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 19:10:15 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 19:10:15 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 19:10:15 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 19:10:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:10:15 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 19:10:15 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 19:10:15 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 19:10:15 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 19:10:15 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 19:10:15 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 19:10:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:10:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:10:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:10:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:10:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:10:16 INFO - no previously-included directories found matching 'docs/_build' 19:10:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:10:16 INFO - Running setup.py install for pep8 19:10:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:10:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:10:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:10:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:10:16 INFO - no previously-included directories found matching 'docs/_build' 19:10:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:10:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:10:16 INFO - Cleaning up... 19:10:16 INFO - Return code: 0 19:10:16 INFO - Running post-action listener: _resource_record_post_action 19:10:16 INFO - Running post-action listener: _start_resource_monitoring 19:10:16 INFO - Starting resource monitoring. 19:10:16 INFO - ##### 19:10:16 INFO - ##### Running install step. 19:10:16 INFO - ##### 19:10:16 INFO - Running pre-action listener: _resource_record_pre_action 19:10:16 INFO - Running main action method: install 19:10:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:10:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:10:17 INFO - Reading from file tmpfile_stdout 19:10:17 INFO - Detecting whether we're running mozinstall >=1.0... 19:10:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:10:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:10:17 INFO - Reading from file tmpfile_stdout 19:10:17 INFO - Output received: 19:10:17 INFO - Usage: mozinstall [options] installer 19:10:17 INFO - Options: 19:10:17 INFO - -h, --help show this help message and exit 19:10:17 INFO - -d DEST, --destination=DEST 19:10:17 INFO - Directory to install application into. [default: 19:10:17 INFO - "/builds/slave/test"] 19:10:17 INFO - --app=APP Application being installed. [default: firefox] 19:10:17 INFO - mkdir: /builds/slave/test/build/application 19:10:17 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'] 19:10:17 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 19:10:39 INFO - Reading from file tmpfile_stdout 19:10:39 INFO - Output received: 19:10:39 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 19:10:39 INFO - Running post-action listener: _resource_record_post_action 19:10:39 INFO - ##### 19:10:39 INFO - ##### Running run-tests step. 19:10:39 INFO - ##### 19:10:39 INFO - Running pre-action listener: _resource_record_pre_action 19:10:39 INFO - Running main action method: run_tests 19:10:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:10:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:10:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:10:39 INFO - 2016-07-16 19:10:39.127 screenresolution[1664:10883] starting screenresolution argv=screenresolution get 19:10:39 INFO - 2016-07-16 19:10:39.130 screenresolution[1664:10883] Display 0: 1600x1200x32@60 19:10:39 INFO - 2016-07-16 19:10:39.136 screenresolution[1665:10885] starting screenresolution argv=screenresolution list 19:10:39 INFO - Available Modes on Display 0 19:10:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:10:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:10:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:10:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:10:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:10:39 INFO - Intel Iris: 19:10:39 INFO - Chipset Model: Intel Iris 19:10:39 INFO - Type: GPU 19:10:39 INFO - Bus: Built-In 19:10:39 INFO - VRAM (Dynamic, Max): 1536 MB 19:10:39 INFO - Vendor: Intel (0x8086) 19:10:39 INFO - Device ID: 0x0a2e 19:10:39 INFO - Revision ID: 0x0009 19:10:39 INFO - Displays: 19:10:39 INFO - Display: 19:10:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:10:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:10:39 INFO - Display Serial Number: 1600x1200 60 19:10:39 INFO - Main Display: Yes 19:10:39 INFO - Mirror: Off 19:10:39 INFO - Online: Yes 19:10:39 INFO - Rotation: Supported 19:10:39 INFO - Return code: 0 19:10:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:10:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:10:39 INFO - Python 2.7.3 19:10:39 INFO - Return code: 0 19:10:39 INFO - grabbing minidump binary from tooltool 19:10:39 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')]} 19:10:39 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 0x100e6fe00>, '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 0x100cd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:10:39 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 19:10:39 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 19:10:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:10:39 INFO - Return code: 0 19:10:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:10:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:10:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:10:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:10:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:10:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:10:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:10:40 INFO - Return code: 0 19:10:40 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-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493517/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0180', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:10:40 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-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493517/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0180 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:10:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YN7BNETlzH/Render', 19:10:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:40 INFO - 'HOME': '/Users/cltbld', 19:10:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:40 INFO - 'LOGNAME': 'cltbld', 19:10:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:10:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:40 INFO - 'MOZ_NO_REMOTE': '1', 19:10:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:10:40 INFO - 'NO_EM_RESTART': '1', 19:10:40 INFO - 'PAGER': '/bin/cat', 19:10:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:40 INFO - 'PWD': '/builds/slave/test', 19:10:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:10:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:40 INFO - 'SHELL': '/bin/bash', 19:10:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PQtRtVBCEc/Listeners', 19:10:40 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 19:10:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:40 INFO - 'USER': 'cltbld', 19:10:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:40 INFO - 'XPC_FLAGS': '0x0', 19:10:40 INFO - 'XPC_SERVICE_NAME': '0', 19:10:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493517/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0180', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:10:40 INFO - mozversion application_buildid: 20160714035157 19:10:40 INFO - mozversion application_changeset: fc7cc284b0c73491db3f45c165cf7ddb78fdde01 19:10:40 INFO - mozversion application_display_name: Firefox 19:10:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:10:40 INFO - mozversion application_name: Firefox 19:10:40 INFO - mozversion application_remotingname: firefox 19:10:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 19:10:40 INFO - mozversion application_vendor: Mozilla 19:10:40 INFO - mozversion application_version: 48.0 19:10:40 INFO - mozversion platform_buildid: 20160714035157 19:10:40 INFO - mozversion platform_changeset: fc7cc284b0c73491db3f45c165cf7ddb78fdde01 19:10:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 19:10:40 INFO - mozversion platform_version: 48.0 19:10:40 INFO - using testdate: 1468721440 19:10:40 INFO - actual date: 1468721440 19:10:40 INFO - starting webserver on 'localhost:49267' 19:10:40 INFO - SUITE-START | Running 2 tests 19:10:40 INFO - TEST-START | dromaeo_css 19:10:40 INFO - operating with platform_type : mac_ 19:10:40 INFO - Initialising browser for dromaeo_css test... 19:10:40 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpp38lGC/profile http://localhost:49267/getInfo.html) 19:10:43 INFO - PROCESS | 1683 | __metrics Screen width/height:1600/1200 19:10:43 INFO - PROCESS | 1683 | colorDepth:24 19:10:43 INFO - PROCESS | 1683 | Browser inner width/height: 1024/689 19:10:43 INFO - PROCESS | 1683 | __metrics 19:10:43 ERROR - PROCESS | 1683 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 19:10:44 INFO - TEST-INFO | 1683: exit 0 19:10:44 INFO - Browser initialized. 19:10:44 INFO - Running cycle 1/1 for dromaeo_css test... 19:10:44 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpp38lGC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:10:56 INFO - PROCESS | 1688 | RSS: Main: 171134976 19:10:56 INFO - PROCESS | 1688 | 19:11:45 INFO - PROCESS | 1688 | 1468721505841 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] 19:13:55 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 19:13:57 INFO - PROCESS | 1688 | RSS: Main: 182161408 19:13:57 INFO - PROCESS | 1688 | 19:16:59 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 19:16:59 INFO - PROCESS | 1688 | RSS: Main: 192684032 19:16:59 INFO - PROCESS | 1688 | 19:20:01 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 19:20:02 INFO - PROCESS | 1688 | RSS: Main: 195182592 19:20:02 INFO - PROCESS | 1688 | 19:23:03 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 19:23:04 INFO - PROCESS | 1688 | RSS: Main: 198729728 19:23:04 INFO - PROCESS | 1688 | 19:26:06 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 19:26:07 INFO - PROCESS | 1688 | RSS: Main: 197636096 19:26:07 INFO - PROCESS | 1688 | 19:29:09 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 19:29:09 INFO - PROCESS | 1688 | RSS: Main: 202620928 19:29:09 INFO - PROCESS | 1688 | 19:29:09 INFO - PROCESS | 1688 | __start_tp_report 19:29:09 INFO - PROCESS | 1688 | _x_x_mozilla_page_load 19:29:09 INFO - PROCESS | 1688 | _x_x_mozilla_page_load_details 19:29:09 INFO - PROCESS | 1688 | |i|pagename|runs| 19:29:09 INFO - PROCESS | 1688 | |0;dojo.html;3615.1323682316242;3645.2162785001237;3674.7243956703255;3703.166787472818;3714.814259287035;5948.88102237955;5978.133170690253;5987.4910632596175;5996.790112346058;6003.879922401555;5977.013792724195;6002.219711437507;6006.399360064002;6019.849503762408;6031.72857221425;5341.359036915565;5371.677699338033;5411.215373770801;5446.891062178754;5494.752736126884;5338.67967921924;5435.483629055233;5439.075357189267;5459.890802183954;5487.670739755627;5411.567074634039;5418;5440.347158341005;5493.093639549469;5530.557555395559;5425.186222066702;5426.321709786277;5434.538064264542;5455.509004189642;5457.890842183174;5330.813421530266;5375.865603359947;5386.13821788512;5425.782968681248;5487.75305111271;5400.189971504266;5669.489745922846;5746.798862039808;5819.039858423355;5877.9118313225335;6216.298151709865;6226.782062627832;6240;6264.185655864709;6272.6236425814595;6269.717862696144;6300.527460440485;6313.905291420632;6316.1788967434395;6344.841378965517;5938.435848594377;6050.21347224858;6069.15031895535;6104.877902441926;6124.081387791867;6368.554201205964;6390.45681117101;6437.710303036374;6457.903131453032;6463.7091330890225;6154.138420621117;6232.937670623236;6252.437280644764;6257.655828929453;6276.843078923063;6257.5932564383165;6326.2724786649205;6334.429901308812;6335.588186767845;6336.429721325103;6221.688915554204;6233.844153896189;6264.436200741864;6264.843378915563;6266.968665156736;4583.633309335245;6141.700809433325;6142.8057410146475;6258.812235632939;6268.341824108494;4221.345691417835;4448.621867141329;5061.696298222045;5064.442911279756;5109.875827317984;4594.747288899076;4614.100250451197;4617.769111544477;4621.630269578425;4672.439307283148;4739.312799644033;5887.646741195542;5980.940190598125;6061.363556826558;6124.265088189446;5532.197831314437;5956.13636022783;6120.112583675342;6329.544204832914;6346.143270658495;5471.699056551928;6083.878322433527;6099.268087829489;6108.5723999319625;6145.231846019247;5428.4842939920645;5527.364353099365;5576.9163462548095;5610.186522954149;5651.773929042874;6495.837604059936;6549.24683661385;6561.507886908405;6573.901391479131;6579.539432239697;6301.558890877778;6307.526935479766;6331.493480521455;6336.968315158395;6338.429541341301;6328.651924144032;6376.93623063782;6447.838804029937;6502.512311576746;6505.60966342021;6241.21984751906;6250.156228909039;6251.343608920998;6256.124142619946;6265.462487692492;6253.530985176039;6326.177596912372;6327.651979141191;6333.556651034383;6338.841528961629;6133;6133.610107582569;6143.389059649542;6148.569600127948;6192.59748116371;6177;6212.316645169119;6214.1921550199995;6225.439710426083;6236.469900058546;5876.236089308362;6085.908711369245;6151.200343955257;6199.504039676905;6248.968755156195;6122.916604401471;6167.506599471942;6198.0702894566175;6215.192025036717;6236.75052997875;6122.204113465221;6196.783112591218;6197.628142311476;6218.5647004709235;6219.533534984804 19:29:09 INFO - PROCESS | 1688 | |1;ext.html;542.192133720756;545.1658961788463;571.3515160293072;610.0544156557335;653.1411194279522;39097.21805563891;39856.40215396764;39983.800080999594;40100.59899401005;40173.59826401735;42072.36891446623;42156;42339.3649095263;42362.152756944844;42420.363694544605;9773.70678879633;9970;9976.451295178762;9977;9978.550965206583;9788;9933.850992235122;10044.799104017915;10057.647982320621;10076.647317343895;10035;10088.495575221246;10106.393616383004;10123.64567240143;10175.236857235699;10001.59993600255;10039.24705647072;10041;10069.798604027916;10094.74763130924;9965;10060.748481287954;10068.647597334058;10097.646582369582;10143.036411540892;40906.59093409058;41151.58848411508;41425.585744142474;41495;41598.376024359655;2626.645402870607;3069.7083777041144;3277.4100661880852;3349.246419555605;3383.7293016558615;22291.77395243261;25971.740282597122;28247;28500.287492812844;28527.714722852714;2688.1129227354927;2743.876525556355;2762.8342299462097;2804.298925268683;2843.957340639892;346366;380888;418196;419291.9035404834;432290.3854807247;36225.818870905474;38315.23369532594;57375;65645;66218;28436.289092772848;36726.26547469036;36840.81579592085;37053.258934821155;37118.62881371206;16087.115208663636;16104.19479026044;16166.515004549883;16217.59456013609;16249.675006499803;11132.833007504894;13262.801057984138;13316.800247996287;13370.331483425789;13389.062765606508;8480.74557763268;8507.276881465144;8510.659573616986;8610.268127209132;8669.739907802776;3538.858445662196;3564.6435356464663;3602.351576716164;3607.6572725591027;3663.6153203913204;1010.3382284603449;1017.5166795772097;1043.186314674555;1057.582255009267;1080.4819228983133;29044;29122;29541.26146846346;29590.96431624883;29832.701672982992;1014.9188064954786;1150.6950658075616;1203.2239205712267;1228.8893999540085;1250.66020907451;13382.866171338163;15128.848711512745;15294.311755971008;15299.235038248044;17014.48956531306;613306;636381;652402;652423;653488;65125;65200.67399663066;65522;65640.67179664072;65642.01536976949;1501;1553.1147246069859;1554.2617256802928;1556.7275726747773;1556.8365321641065;30009;30762;30996.535051973788;31093.689063109985;31302;52038.95922081613;55693.44306557045;56120.438795613154;56331.155032675364;56510.717446412506;579426;595482;595716;600618;602656;28652.713472865005;28767.424651506433;28922.855385722938;29188;29283;46564.603061908194;47252;48371.5162848367;48372.75813620909;48581.514184859116;38951;39158.80420597879;39298.6070139295;39335.803320984356;40132.1973560533;26669.19992400231;31420;31795.41022948797;36113.63886361103;38886.4167037489;33435;38558.80720596379;38658.80670596629;38853.611463885;39093.80453097716;31581.526277105404;32345;32354.191145221557;32530.67469325371;32903;20814.37556873296;24497.387565311008;24697.753022469544;24805.875970620033;24997.750022499542 19:29:09 INFO - PROCESS | 1688 | |2;jquery.html;410.3659845538642;413.46249875162283;414.71384744526296;417.6616940278375;423.78175239751533;20582;21264.681029784526;21333.35999920003;21542.246021389215;22553.210637627686;12009.879901200986;12320.691982700415;13905.374258158381;21050;21303.57392852142;5331.946680533193;5563.749631266603;5610.635308704921;5629.3526244482;5657.801976930808;6057.363976782441;6131.632102073868;6178.907316390235;6179.814605561818;6190.907136392958;5451.890962180754;6037.973544497424;6154.753809847601;6184.536159788011;6209.9068513972325;5511.724413779295;5540.279763630742;5569.693666848301;5575.526080283161;5613.943860561383;5490.890182196334;5495.505404513613;5497.285352904097;5497.615166938316;5497.642653227527;13931.930340348234;14065.156090634595;14166.787498187536;14340.856591434162;16757.748633770505;2152.78367722238;2159.8596091254017;2251.324602619208;2303.861768293891;2312.2138472919287;8566.543687573128;9914.157296629795;9992.550335234931;10125.645602403954;10201.846972295421;1801.3427646565192;1809.6471188118321;1816.3370369814922;1825.5709908171568;1849.4729002234299;111640;121126.3943680276;121209.78790212073;125018.37490812578;126102;11811.52753889852;11945.343006134746;12008.339541325311;12093.637190884288;12294.508219671292;15500.457483988006;15506.147161905978;15507.379704811681;15508.147051912254;15563.766543501857;8059.919400805917;8922.152395522415;9366.157045865904;9376.968533461313;9427.528623568795;9384.390014649027;9427.528623568795;9452.57463414148;9467.384619999679;9548.236141108695;4733;4770.737609431515;4823.879403014883;4836.782344794422;4880.097182021337;1780.5459607799928;1990.9303174388826;2071.658176400907;2097.748270207585;2111.4932416219995;901.1439132823843;1019.23557332001;1058.3755584205355;1058.5183741397645;1081;15495.831864514523;18184;19768.604627907647;20174.89038102889;21726.565468690853;986.8470387090013;990.980180396388;993.6224234790733;994.2940512236394;1058.5342449322275;9380.5309734513;11533.365664888512;11576.536938522533;11590.652280431601;11652.766944661229;623624.7637523657;653622.7318863375;663058;675396;680687;100906;117870;128533.35733321274;130322;132298;966.1111777165025;991.4101109839634;991.4249735153594;1000.9149222316039;1025.1542477456128;18902.43292701221;19290.4212873614;19633.70549441731;19700.01499924969;19926.30257940965;45449.95475203558;54239.45760542344;54701;55549.7222513901;56889.14666280092;72430;72877.6356118216;73457.26542734719;74111;74987.62506187652;8198.42611017247;8279.420440569102;8289.991025787169;8389;8447.324214062983;9220.815583688154;11986.880131198577;12734.490620375082;12988.805167922677;13029.218246905217;5423.3491980962535;5764.711764411679;11062.778744424906;11286.943565282121;11529.769404612029;11072.833907491233;11123.72190695239;11224.438778060901;11353.659390218307;11373.829392559284;11326.433678315887;11344.319340839576;11392.25950313227;11464.885351146382;11525.481353338952;8044.758657240292;8098.3116435103675;8300.826495688096;8317.126701696236;8642.265407440438;11275.379854108103;11395.544178232778;11446.198766086294;11790.23363481371;11820.0543956485 19:29:09 INFO - PROCESS | 1688 | |3;mootools.html;1641.7619445180449;1656.4368114840956;1928.2576208159853;2000.359884836852;2057.4444899877044;8283.5029898206;8980.550972451383;9079.727608171757;9285.350025498217;9336.81326373472;9002.32482563807;9031.503267320295;9036.457812531253;9054.728358149267;9143.771405714844;2527.582948813448;2549.7067837198683;2551.2473820223076;2562.4875024995076;2574.3692795265188;2526;2570.678665166854;2575.88408521616;2576.0339872547793;2582.4447743735095;2537.8984840606354;2551.170869467421;2586.7154612992554;2587.7153513113544;2594.675665541807;2550.349660836484;2571.112966026727;2576.4203054312816;2579.148880869318;2585.8836352364187;2510.3849556858504;2566.512362651109;2574.4336246025846;2577.6262441945814;2588.2364702412647;9315.021922698155;9345.252379809599;9346.299027572892;9364.625414983393;9393.62425502979;5653.406392328829;5713.200151978726;5760.8271751847515;5770.711464426804;5890.764369425217;3676.613955534684;3771.9057023574355;3822.503074600284;3827.9808600957094;3837.520309961255;1067.0503252105632;1075.6611667324767;1079.098952374768;1124.269225003746;1126.1610100475198;12370.195937264049;12471.999999999909;12534.81197782034;12574.559890403883;12581.496740130384;5035;5047.293378926953;5110.540051395392;5121.206213036985;5166.535011848877;10599.576016959236;10624.575016999233;10653;10687.465626718633;10698.679039628823;5651.717414129277;5668.0647693130995;5729.8567535811935;5733.455321744427;5792.681402522818;4592.03567250881;5005.574526165244;5081.669691470117;5123.462036486189;5194.792208311701;3642.21692336149;4261.190373828963;4289.378040184219;4304.677149213821;4340.392345071693;1214.4959841665786;1401.5374926274305;1430.8497607751244;1435.8492358302437;1438.8561143885738;908.2643059122132;954.1222075690242;982.8083523712808;990.5195979949718;1002.6791426743372;6033.215681961317;6095.847603809941;6130.969345153246;6239.126522286883;6256.655883926337;465.33457156266866;472.6549618778311;482.56328023139116;485.9295402166666;496.5580633236423;4114.794260286973;4123.402106694512;4133.483314585676;4165.625093741517;4246.7027308088755;10817.080548153337;11235.15736319763;11277.492512836941;11307.547698091985;11379.487923043484;10794.784104318027;11000.669979900616;11023.06303964156;11057.22599418033;11074.446277686084;8464.280536154372;8736.344774141964;8737.082606326372;8759.2992560595;8766.736997890073;5839.182514448065;5854.677992710442;5969.701514924323;6002.219711437485;6063.181470501426;9772.560234789593;9859.802803943738;9913.65302214419;9975.401475911469;10045.49772511386;9796.461194634363;10083.394996300245;10322.019408156213;10389.06498415116;10428.113610342902;5727.369989301257;6803;7601.695932162652;7687.5387476751575;7754.495957762728;8602.39783215169;8607.053224145464;8649.135086491553;8659.48043117415;8699.826003480022;7547.73582924595;7567.356774674215;7717.151113377637;7797.805054873674;7841.568713720572;7519.436042296959;7549.811254718676;7552.244775522404;7650.273224043707;7759.961200193963;7169.139703235436;7190.029346038427;7256.092988376453;7264.600446975467;7284.344409003215;4952.752362381939;4960.156773348612;5093.541581257705;5131.8717032073;5142.254373115802;5046.243063540498;5127.256547800623;5136.30659860914;5216.321878155815;5361.27622770921 19:29:09 INFO - PROCESS | 1688 | |4;prototype.html;341.7641827139274;343.155836641861;343.8074678180221;348.8116417134747;354.0458464438336;6933.653317334132;6959.721611135561;6986.406155476784;6997.1253593300835;7033.50765446419;6863.656817159134;6868.175818901726;6877.587344759318;6884.896726549093;6905.205901321349;4837.879053023685;4905.877353066184;5030.647854650176;5039.244113382985;5042.697438153704;4080.5919408059103;4992.77532511036;5034.899302013958;5040.873978150539;5088.26220198071;5008.198688209887;5019.096562618727;5021.648484606079;5041.672291301072;5045.520675535837;5017.37282839645;5019.874503137415;5122.948770512285;5123.7438128093445;5140.408852981917;4009.278329900617;4313.09425020746;4322.351647252937;4329.19909816685;4337.674674399401;5539.639923404966;6342.572921092763;6455.451286640641;6514.185726784152;6555.213374395055;5909.911351329733;5923.289205295349;5935.614185077956;5947.4052594740615;5970.761169553212;7326.377257933082;7363.116426028857;7389.556626602421;7395.889061664079;7476.065491813523;4865.635077369211;4870.951290487121;4872.244802055687;4880.877978050542;4890.217565189588;7438.256174382573;7727.150013498511;7752.147263800977;7758.844823103506;7780.455368124233;4943.555080042814;4957.281194226817;4957.380327459067;4970.353853998957;4973.701577905337;5000.199968005102;5046.1926091825135;5048;5069.771860266297;5073.16292811682;5907.3797251288;5932.436418540232;5937.732802023919;5941.197938278364;5959.463648271676;7399.556026638311;7407;7408.7036518539735;7410.036695229694;7412.925870741224;1457.4388860288866;1721.468574984443;1769.1066011664027;1770.460009697029;1774.272548255235;1128.7629597784558;1139.0944199361527;1141.6175581180232;1141.7659379827116;1142.9771404571861;6880.8967865482055;6907.861842763217;6937.583744975318;6971.651417429108;6990;7465.328120469184;7594.620268986529;7670.309672129535;7693.49992250502;7693.999780028673;6894;6942.409895158968;7250.274972502813;7253.963730181315;7261.237570055068;4085.55058943516;4128.4632997710105;4131.97934010328;4135.152293779768;4137.40007698882;8118.553479558563;8129;8132;8133.5526546039355;8137.471064380797;7628.237176282439;7684.3084122429245;7983.161768014391;8003.4797738146835;8060.355171586259;6496.870062598721;8020.43856930021;8091.98850143732;8110.918890811016;8128.512289262663;7708.653110609924;7725.49784264021;7732.574708391093;7748;7752;7596.506227095442;7616.200298968529;7622.466427350254;7626.54240745557;7634.961825190839;7319.63401829917;7439.442041846992;7819.374450044096;8030;8126.796830079295;4121.567235440236;4454.08691218293;4673;4956.10790057793;4964.205727083794;7739;7742.806429839299;7750.689972401041;7763.68945242184;7812.765617031499;7258.600776957318;7427.183009868802;7502.174760776201;7508.648443280262;7509.136449308399;5420.620556561161;6227.283862355705;7465.440091993014;7489.625518723933;7496.362809161283;7278.09023872016;7278.854422911618;7291.781246562611;7317.487775855852;7339.155997060407;7448.73929412468;7464.888026679496;7471.925280747123;7494.925050749423;7505.587192704454;6210.472109870711;6676.664667066509;7293.161286452126;7294.343509084208;7359.227281135403 19:29:09 INFO - PROCESS | 1688 | |5;yui.html;712.9607871567064;763.5838468034921;767.7926959720876;774.9651265693043;775.8138046868752;14951.252437378142;15207.543773686793;15260.771088433683;15266.54967778062;15268.16025118618;14184.21986790726;14217;14227.430902763903;14251.71496570068;14253.643658908506;780.9023872015998;801.767487428645;908.6410867707252;931.7996630724393;964.6286179820785;931.5994122527311;951.8952915179359;960.0639376607821;963.1187463470916;963.1235575626182;990.2325697584357;1009.6314845081566;1016.0195411428008;1016.5120742043823;1017.2878984710695;968.7239136846;1006.7583779892809;1006.9899301006969;1009.1119814563211;1010.6816352848866;733.2777214443769;735.477810754365;754.5435011817881;755.5806527377304;755.7581573896356;14863.108213507116;14865.256737163207;14892.255387230594;14906.552803415914;15039.473618423302;12923.612291631267;12957.48170073196;13100.47598096075;13109.475620975245;13227;10181.490925453698;10201;10319.58721651133;10394.79210415795;10455.21585881062;3555.0579096539436;3574.696150827183;3584.8386822593047;3632.164602141496;3786.2048969716393;70411.94382084222;80733.59633201855;85374.57312713396;85505;86193;9481.857772133424;9619;9743.805123897624;9744.75638109053;9955.900440995641;22421.32736017922;22427.102915883508;22490;22490.66264006041;22509.88745056264;7526.059242594676;7528.736494222676;7619.580923049175;7677.193894641094;7797.298243158143;4126.711130220856;4183.937240941388;4189.308764053897;4204.159168166379;4211.873643790691;3381.1547113221695;3561.9821900890847;3572.7499075064497;3607.206414588786;3621.3300539400293;680.323078536859;692.3318997167758;700.3066963705894;704.7603814703026;707.5613119865716;579.7622974580402;588.2676068295;596.8537708261417;604.2477115990532;609.8505866062754;7177.7487787927175;7667.118281397599;8121.918780812234;8146.2261085196815;8229.670813167406;507.7283653245496;544.3196004993757;545.6753231827057;558.4778232352681;613.4938675592654;3808.638179372955;3928.7642741435607;3963.583823698528;4031.4154447604933;4032.3145065338963;86075;87221;88501.55749221213;88543.55728221318;88808.55595722109;57382.42617573771;70563.64718176478;74700.62649686717;74886;77884.61057694675;63703.6814815923;68144.65927670429;68574;68840.62318753597;69353.3064669357;7952.761417157494;8070.314023308085;8217.54803485814;8269.710560130367;8335.569002692711;47680.04639907113;47768.761156194;48361;48857.755711221216;50413.747931261576;61664.45838853885;65028.34971650223;65822;65854.67072664606;66123;10566.735831604272;10751.462426878781;10876.293040952312;11014.44927753625;11132;11587.536498540301;11717.179797414099;11842.407879606157;11991.520339186334;12425.689357766129;10778.730531736455;10825.621103261348;11126.276792008493;11409.54361825551;11626.53493860236;10959.287646302964;11053.944730276296;11268.887311126784;11446.084313254752;11659.300441973508;9678.17735492491;10825.350478971286;10858.185636077484;10872.782544349227;11072;9124.863127052966;9170.495622740547;9216.410655259491;9258.629654814002;9311;7402.481826272325;8052.677892884219;9361.953190234006;9542.570584323583;9567.712968610953 19:29:09 INFO - PROCESS | 1688 | __end_tp_report 19:29:09 INFO - PROCESS | 1688 | __start_cc_report 19:29:09 INFO - PROCESS | 1688 | _x_x_mozilla_cycle_collect,395 19:29:09 INFO - PROCESS | 1688 | __end_cc_report 19:29:09 INFO - PROCESS | 1688 | __startTimestamp1468722549717__endTimestamp 19:29:09 INFO - PROCESS | 1688 | 19:29:09 INFO - PROCESS | 1688 | ------- Summary: start ------- 19:29:09 INFO - PROCESS | 1688 | Number of tests: 6 19:29:09 INFO - PROCESS | 1688 | 19:29:09 INFO - PROCESS | 1688 | [#0] dojo.html Cycles:165 Average:5870.24 Median:6133.00 stddev:624.10 (10.2%) stddev-sans-first:600.42 19:29:09 INFO - PROCESS | 1688 | Values: 3615.1 3645.2 3674.7 3703.2 3714.8 5948.9 5978.1 5987.5 5996.8 6003.9 5977.0 6002.2 6006.4 6019.8 6031.7 5341.4 5371.7 5411.2 5446.9 5494.8 5338.7 5435.5 5439.1 5459.9 5487.7 5411.6 5418.0 5440.3 5493.1 5530.6 5425.2 5426.3 5434.5 5455.5 5457.9 5330.8 5375.9 5386.1 5425.8 5487.8 5400.2 5669.5 5746.8 5819.0 5877.9 6216.3 6226.8 6240.0 6264.2 6272.6 6269.7 6300.5 6313.9 6316.2 6344.8 5938.4 6050.2 6069.2 6104.9 6124.1 6368.6 6390.5 6437.7 6457.9 6463.7 6154.1 6232.9 6252.4 6257.7 6276.8 6257.6 6326.3 6334.4 6335.6 6336.4 6221.7 6233.8 6264.4 6264.8 6267.0 4583.6 6141.7 6142.8 6258.8 6268.3 4221.3 4448.6 5061.7 5064.4 5109.9 4594.7 4614.1 4617.8 4621.6 4672.4 4739.3 5887.6 5980.9 6061.4 6124.3 5532.2 5956.1 6120.1 6329.5 6346.1 5471.7 6083.9 6099.3 6108.6 6145.2 5428.5 5527.4 5576.9 5610.2 5651.8 6495.8 6549.2 6561.5 6573.9 6579.5 6301.6 6307.5 6331.5 6337.0 6338.4 6328.7 6376.9 6447.8 6502.5 6505.6 6241.2 6250.2 6251.3 6256.1 6265.5 6253.5 6326.2 6327.7 6333.6 6338.8 6133.0 6133.6 6143.4 6148.6 6192.6 6177.0 6212.3 6214.2 6225.4 6236.5 5876.2 6085.9 6151.2 6199.5 6249.0 6122.9 6167.5 6198.1 6215.2 6236.8 6122.2 6196.8 6197.6 6218.6 6219.5 19:29:09 INFO - PROCESS | 1688 | 19:29:09 INFO - PROCESS | 1688 | [#1] ext.html Cycles:180 Average:67081.32 Median:3366.49 stddev:148880.61 (4422.4%) stddev-sans-first:149214.44 19:29:09 INFO - PROCESS | 1688 | Values: 542.2 545.2 571.4 610.1 653.1 39097.2 39856.4 39983.8 40100.6 40173.6 42072.4 42156.0 42339.4 42362.2 42420.4 9773.7 9970.0 9976.5 9977.0 9978.6 9788.0 9933.9 10044.8 10057.6 10076.6 10035.0 10088.5 10106.4 10123.6 10175.2 10001.6 10039.2 10041.0 10069.8 10094.7 9965.0 10060.7 10068.6 10097.6 10143.0 40906.6 41151.6 41425.6 41495.0 41598.4 2626.6 3069.7 3277.4 3349.2 3383.7 22291.8 25971.7 28247.0 28500.3 28527.7 2688.1 2743.9 2762.8 2804.3 2844.0 346366.0 380888.0 418196.0 419291.9 432290.4 36225.8 38315.2 57375.0 65645.0 66218.0 28436.3 36726.3 36840.8 37053.3 37118.6 16087.1 16104.2 16166.5 16217.6 16249.7 11132.8 13262.8 13316.8 13370.3 13389.1 8480.7 8507.3 8510.7 8610.3 8669.7 3538.9 3564.6 3602.4 3607.7 3663.6 1010.3 1017.5 1043.2 1057.6 1080.5 29044.0 29122.0 29541.3 29591.0 29832.7 1014.9 1150.7 1203.2 1228.9 1250.7 13382.9 15128.8 15294.3 15299.2 17014.5 613306.0 636381.0 652402.0 652423.0 653488.0 65125.0 65200.7 65522.0 65640.7 65642.0 1501.0 1553.1 1554.3 1556.7 1556.8 30009.0 30762.0 30996.5 31093.7 31302.0 52039.0 55693.4 56120.4 56331.2 56510.7 579426.0 595482.0 595716.0 600618.0 602656.0 28652.7 28767.4 28922.9 29188.0 29283.0 46564.6 47252.0 48371.5 48372.8 48581.5 38951.0 39158.8 39298.6 39335.8 40132.2 26669.2 31420.0 31795.4 36113.6 38886.4 33435.0 38558.8 38658.8 38853.6 39093.8 31581.5 32345.0 32354.2 32530.7 32903.0 20814.4 24497.4 24697.8 24805.9 24997.8 19:29:09 INFO - PROCESS | 1688 | 19:29:09 INFO - PROCESS | 1688 | [#2] jquery.html Cycles:180 Average:36161.93 Median:11988.95 stddev:109517.80 (913.5%) stddev-sans-first:109792.12 19:29:09 INFO - PROCESS | 1688 | Values: 410.4 413.5 414.7 417.7 423.8 20582.0 21264.7 21333.4 21542.2 22553.2 12009.9 12320.7 13905.4 21050.0 21303.6 5331.9 5563.7 5610.6 5629.4 5657.8 6057.4 6131.6 6178.9 6179.8 6190.9 5451.9 6038.0 6154.8 6184.5 6209.9 5511.7 5540.3 5569.7 5575.5 5613.9 5490.9 5495.5 5497.3 5497.6 5497.6 13931.9 14065.2 14166.8 14340.9 16757.7 2152.8 2159.9 2251.3 2303.9 2312.2 8566.5 9914.2 9992.6 10125.6 10201.8 1801.3 1809.6 1816.3 1825.6 1849.5 111640.0 121126.4 121209.8 125018.4 126102.0 11811.5 11945.3 12008.3 12093.6 12294.5 15500.5 15506.1 15507.4 15508.1 15563.8 8059.9 8922.2 9366.2 9377.0 9427.5 9384.4 9427.5 9452.6 9467.4 9548.2 4733.0 4770.7 4823.9 4836.8 4880.1 1780.5 1990.9 2071.7 2097.7 2111.5 901.1 1019.2 1058.4 1058.5 1081.0 15495.8 18184.0 19768.6 20174.9 21726.6 986.8 991.0 993.6 994.3 1058.5 9380.5 11533.4 11576.5 11590.7 11652.8 623624.8 653622.7 663058.0 675396.0 680687.0 100906.0 117870.0 128533.4 130322.0 132298.0 966.1 991.4 991.4 1000.9 1025.2 18902.4 19290.4 19633.7 19700.0 19926.3 45450.0 54239.5 54701.0 55549.7 56889.1 72430.0 72877.6 73457.3 74111.0 74987.6 8198.4 8279.4 8290.0 8389.0 8447.3 9220.8 11986.9 12734.5 12988.8 13029.2 5423.3 5764.7 11062.8 11286.9 11529.8 11072.8 11123.7 11224.4 11353.7 11373.8 11326.4 11344.3 11392.3 11464.9 11525.5 8044.8 8098.3 8300.8 8317.1 8642.3 11275.4 11395.5 11446.2 11790.2 11820.1 19:29:09 INFO - PROCESS | 1688 | 19:29:09 INFO - PROCESS | 1688 | [#3] mootools.html Cycles:180 Average:5957.67 Median:5040.62 stddev:3319.49 (65.9%) stddev-sans-first:3312.96 19:29:09 INFO - PROCESS | 1688 | Values: 1641.8 1656.4 1928.3 2000.4 2057.4 8283.5 8980.6 9079.7 9285.4 9336.8 9002.3 9031.5 9036.5 9054.7 9143.8 2527.6 2549.7 2551.2 2562.5 2574.4 2526.0 2570.7 2575.9 2576.0 2582.4 2537.9 2551.2 2586.7 2587.7 2594.7 2550.3 2571.1 2576.4 2579.1 2585.9 2510.4 2566.5 2574.4 2577.6 2588.2 9315.0 9345.3 9346.3 9364.6 9393.6 5653.4 5713.2 5760.8 5770.7 5890.8 3676.6 3771.9 3822.5 3828.0 3837.5 1067.1 1075.7 1079.1 1124.3 1126.2 12370.2 12472.0 12534.8 12574.6 12581.5 5035.0 5047.3 5110.5 5121.2 5166.5 10599.6 10624.6 10653.0 10687.5 10698.7 5651.7 5668.1 5729.9 5733.5 5792.7 4592.0 5005.6 5081.7 5123.5 5194.8 3642.2 4261.2 4289.4 4304.7 4340.4 1214.5 1401.5 1430.8 1435.8 1438.9 908.3 954.1 982.8 990.5 1002.7 6033.2 6095.8 6131.0 6239.1 6256.7 465.3 472.7 482.6 485.9 496.6 4114.8 4123.4 4133.5 4165.6 4246.7 10817.1 11235.2 11277.5 11307.5 11379.5 10794.8 11000.7 11023.1 11057.2 11074.4 8464.3 8736.3 8737.1 8759.3 8766.7 5839.2 5854.7 5969.7 6002.2 6063.2 9772.6 9859.8 9913.7 9975.4 10045.5 9796.5 10083.4 10322.0 10389.1 10428.1 5727.4 6803.0 7601.7 7687.5 7754.5 8602.4 8607.1 8649.1 8659.5 8699.8 7547.7 7567.4 7717.2 7797.8 7841.6 7519.4 7549.8 7552.2 7650.3 7760.0 7169.1 7190.0 7256.1 7264.6 7284.3 4952.8 4960.2 5093.5 5131.9 5142.3 5046.2 5127.3 5136.3 5216.3 5361.3 19:29:09 INFO - PROCESS | 1688 | 19:29:09 INFO - PROCESS | 1688 | [#4] prototype.html Cycles:180 Average:6051.25 Median:6899.60 stddev:1946.86 (28.2%) stddev-sans-first:1904.58 19:29:09 INFO - PROCESS | 1688 | Values: 341.8 343.2 343.8 348.8 354.0 6933.7 6959.7 6986.4 6997.1 7033.5 6863.7 6868.2 6877.6 6884.9 6905.2 4837.9 4905.9 5030.6 5039.2 5042.7 4080.6 4992.8 5034.9 5040.9 5088.3 5008.2 5019.1 5021.6 5041.7 5045.5 5017.4 5019.9 5122.9 5123.7 5140.4 4009.3 4313.1 4322.4 4329.2 4337.7 5539.6 6342.6 6455.5 6514.2 6555.2 5909.9 5923.3 5935.6 5947.4 5970.8 7326.4 7363.1 7389.6 7395.9 7476.1 4865.6 4871.0 4872.2 4880.9 4890.2 7438.3 7727.2 7752.1 7758.8 7780.5 4943.6 4957.3 4957.4 4970.4 4973.7 5000.2 5046.2 5048.0 5069.8 5073.2 5907.4 5932.4 5937.7 5941.2 5959.5 7399.6 7407.0 7408.7 7410.0 7412.9 1457.4 1721.5 1769.1 1770.5 1774.3 1128.8 1139.1 1141.6 1141.8 1143.0 6880.9 6907.9 6937.6 6971.7 6990.0 7465.3 7594.6 7670.3 7693.5 7694.0 6894.0 6942.4 7250.3 7254.0 7261.2 4085.6 4128.5 4132.0 4135.2 4137.4 8118.6 8129.0 8132.0 8133.6 8137.5 7628.2 7684.3 7983.2 8003.5 8060.4 6496.9 8020.4 8092.0 8110.9 8128.5 7708.7 7725.5 7732.6 7748.0 7752.0 7596.5 7616.2 7622.5 7626.5 7635.0 7319.6 7439.4 7819.4 8030.0 8126.8 4121.6 4454.1 4673.0 4956.1 4964.2 7739.0 7742.8 7750.7 7763.7 7812.8 7258.6 7427.2 7502.2 7508.6 7509.1 5420.6 6227.3 7465.4 7489.6 7496.4 7278.1 7278.9 7291.8 7317.5 7339.2 7448.7 7464.9 7471.9 7494.9 7505.6 6210.5 6676.7 7293.2 7294.3 7359.2 19:29:09 INFO - PROCESS | 1688 | 19:29:09 INFO - PROCESS | 1688 | [#5] yui.html Cycles:180 Average:17825.71 Median:28970.45 stddev:24690.39 (85.2%) stddev-sans-first:24726.22 19:29:09 INFO - PROCESS | 1688 | Values: 713.0 763.6 767.8 775.0 775.8 14951.3 15207.5 15260.8 15266.5 15268.2 14184.2 14217.0 14227.4 14251.7 14253.6 780.9 801.8 908.6 931.8 964.6 931.6 951.9 960.1 963.1 963.1 990.2 1009.6 1016.0 1016.5 1017.3 968.7 1006.8 1007.0 1009.1 1010.7 733.3 735.5 754.5 755.6 755.8 14863.1 14865.3 14892.3 14906.6 15039.5 12923.6 12957.5 13100.5 13109.5 13227.0 10181.5 10201.0 10319.6 10394.8 10455.2 3555.1 3574.7 3584.8 3632.2 3786.2 70411.9 80733.6 85374.6 85505.0 86193.0 9481.9 9619.0 9743.8 9744.8 9955.9 22421.3 22427.1 22490.0 22490.7 22509.9 7526.1 7528.7 7619.6 7677.2 7797.3 4126.7 4183.9 4189.3 4204.2 4211.9 3381.2 3562.0 3572.7 3607.2 3621.3 680.3 692.3 700.3 704.8 707.6 579.8 588.3 596.9 604.2 609.9 7177.7 7667.1 8121.9 8146.2 8229.7 507.7 544.3 545.7 558.5 613.5 3808.6 3928.8 3963.6 4031.4 4032.3 86075.0 87221.0 88501.6 88543.6 88808.6 57382.4 70563.6 74700.6 74886.0 77884.6 63703.7 68144.7 68574.0 68840.6 69353.3 7952.8 8070.3 8217.5 8269.7 8335.6 47680.0 47768.8 48361.0 48857.8 50413.7 61664.5 65028.3 65822.0 65854.7 66123.0 10566.7 10751.5 10876.3 11014.4 11132.0 11587.5 11717.2 11842.4 11991.5 12425.7 10778.7 10825.6 11126.3 11409.5 11626.5 10959.3 11053.9 11268.9 11446.1 11659.3 9678.2 10825.4 10858.2 10872.8 11072.0 9124.9 9170.5 9216.4 9258.6 9311.0 7402.5 8052.7 9362.0 9542.6 9567.7 19:29:09 INFO - PROCESS | 1688 | -------- Summary: end -------- 19:29:09 INFO - PROCESS | 1688 | 19:29:10 INFO - TEST-INFO | 1688: exit 0 19:29:10 INFO - TEST-OK | dromaeo_css | took 1109545ms 19:29:10 INFO - TEST-START | kraken 19:29:10 INFO - operating with platform_type : mac_ 19:29:10 INFO - Initialising browser for kraken test... 19:29:10 INFO - TEST-INFO | started process 1695 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpcHgEUx/profile http://localhost:49267/getInfo.html) 19:29:12 INFO - PROCESS | 1695 | __metrics Screen width/height:1600/1200 19:29:12 INFO - PROCESS | 1695 | colorDepth:24 19:29:12 INFO - PROCESS | 1695 | Browser inner width/height: 1024/689 19:29:12 INFO - PROCESS | 1695 | __metrics 19:29:12 ERROR - PROCESS | 1695 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 19:29:13 INFO - TEST-INFO | 1695: exit 0 19:29:13 INFO - Browser initialized. 19:29:13 INFO - Running cycle 1/1 for kraken test... 19:29:13 INFO - TEST-INFO | started process 1699 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpcHgEUx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:29:25 INFO - PROCESS | 1699 | RSS: Main: 171028480 19:29:25 INFO - PROCESS | 1699 | 19:29:27 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 19:29:28 INFO - PROCESS | 1699 | RSS: Main: 183795712 19:29:28 INFO - PROCESS | 1699 | 19:29:31 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 19:29:32 INFO - PROCESS | 1699 | RSS: Main: 192524288 19:29:32 INFO - PROCESS | 1699 | 19:29:35 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 19:29:36 INFO - PROCESS | 1699 | RSS: Main: 196145152 19:29:36 INFO - PROCESS | 1699 | 19:29:38 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 19:29:38 INFO - PROCESS | 1699 | RSS: Main: 196759552 19:29:38 INFO - PROCESS | 1699 | 19:29:40 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:29:41 INFO - PROCESS | 1699 | RSS: Main: 197922816 19:29:41 INFO - PROCESS | 1699 | 19:29:44 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 19:29:44 INFO - PROCESS | 1699 | RSS: Main: 198361088 19:29:44 INFO - PROCESS | 1699 | 19:29:47 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 19:29:48 INFO - PROCESS | 1699 | RSS: Main: 198209536 19:29:48 INFO - PROCESS | 1699 | 19:29:51 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 19:29:51 INFO - PROCESS | 1699 | RSS: Main: 198459392 19:29:51 INFO - PROCESS | 1699 | 19:29:53 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:29:54 INFO - PROCESS | 1699 | RSS: Main: 197816320 19:29:54 INFO - PROCESS | 1699 | 19:29:55 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:29:56 INFO - PROCESS | 1699 | RSS: Main: 198012928 19:29:56 INFO - PROCESS | 1699 | 19:29:58 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:29:59 INFO - PROCESS | 1699 | RSS: Main: 198184960 19:29:59 INFO - PROCESS | 1699 | 19:30:01 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:30:02 INFO - PROCESS | 1699 | RSS: Main: 198369280 19:30:02 INFO - PROCESS | 1699 | 19:30:05 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:30:06 INFO - PROCESS | 1699 | RSS: Main: 198393856 19:30:06 INFO - PROCESS | 1699 | 19:30:07 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 19:30:08 INFO - PROCESS | 1699 | RSS: Main: 200396800 19:30:08 INFO - PROCESS | 1699 | 19:30:08 INFO - PROCESS | 1699 | __start_tp_report 19:30:08 INFO - PROCESS | 1699 | _x_x_mozilla_page_load 19:30:08 INFO - PROCESS | 1699 | _x_x_mozilla_page_load_details 19:30:08 INFO - PROCESS | 1699 | |i|pagename|runs| 19:30:08 INFO - PROCESS | 1699 | |0;ai-astar;116;112;117;117;116;133;116;116;115;116 19:30:08 INFO - PROCESS | 1699 | |1;audio-beat-detection;140;130;182;196;133;138;122;153;155;120 19:30:08 INFO - PROCESS | 1699 | |2;audio-dft;255;242;195;196;193;198;189;205;176;261 19:30:08 INFO - PROCESS | 1699 | |3;audio-fft;65;71;77;147;57;56;56;62;125;59 19:30:08 INFO - PROCESS | 1699 | |4;audio-oscillator;80;81;121;73;80;91;119;80;83;120 19:30:08 INFO - PROCESS | 1699 | |5;imaging-gaussian-blur;118;132;99;87;89;85;87;85;87;84 19:30:08 INFO - PROCESS | 1699 | |6;imaging-darkroom;93;95;94;95;112;126;95;126;101;149 19:30:08 INFO - PROCESS | 1699 | |7;imaging-desaturate;90;92;88;112;133;125;90;113;124;95 19:30:08 INFO - PROCESS | 1699 | |8;json-parse-financial;59;63;65;64;64;65;63;78;64;59 19:30:08 INFO - PROCESS | 1699 | |9;json-stringify-tinderbox;61;67;63;64;75;72;72;64;65;67 19:30:08 INFO - PROCESS | 1699 | |10;stanford-crypto-aes;82;78;79;82;80;79;79;80;83;83 19:30:08 INFO - PROCESS | 1699 | |11;stanford-crypto-ccm;144;145;148;138;141;145;136;126;144;137 19:30:08 INFO - PROCESS | 1699 | |12;stanford-crypto-pbkdf2;162;169;168;160;198;159;192;219;200;168 19:30:08 INFO - PROCESS | 1699 | |13;stanford-crypto-sha256-iterative;65;70;66;60;82;65;58;74;98;93 19:30:08 INFO - PROCESS | 1699 | __end_tp_report 19:30:08 INFO - PROCESS | 1699 | __start_cc_report 19:30:08 INFO - PROCESS | 1699 | _x_x_mozilla_cycle_collect,1032 19:30:08 INFO - PROCESS | 1699 | __end_cc_report 19:30:08 INFO - PROCESS | 1699 | __startTimestamp1468722608119__endTimestamp 19:30:08 INFO - PROCESS | 1699 | 19:30:08 INFO - PROCESS | 1699 | ------- Summary: start ------- 19:30:08 INFO - PROCESS | 1699 | Number of tests: 14 19:30:08 INFO - PROCESS | 1699 | 19:30:08 INFO - PROCESS | 1699 | [#0] ai-astar Cycles:10 Average:117.40 Median:116.00 stddev:5.66 (4.9%) stddev-sans-first:5.98 19:30:08 INFO - PROCESS | 1699 | Values: 116.0 112.0 117.0 117.0 116.0 133.0 116.0 116.0 115.0 116.0 19:30:08 INFO - PROCESS | 1699 | 19:30:08 INFO - PROCESS | 1699 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:146.50 stddev:25.15 (17.2%) stddev-sans-first:26.56 19:30:08 INFO - PROCESS | 1699 | Values: 140.0 130.0 182.0 196.0 133.0 138.0 122.0 153.0 155.0 120.0 19:30:08 INFO - PROCESS | 1699 | 19:30:08 INFO - PROCESS | 1699 | [#2] audio-dft Cycles:10 Average:211.00 Median:201.50 stddev:30.03 (14.9%) stddev-sans-first:27.31 19:30:08 INFO - PROCESS | 1699 | Values: 255.0 242.0 195.0 196.0 193.0 198.0 189.0 205.0 176.0 261.0 19:30:08 INFO - PROCESS | 1699 | 19:30:08 INFO - PROCESS | 1699 | [#3] audio-fft Cycles:10 Average:77.50 Median:60.50 stddev:31.99 (52.9%) stddev-sans-first:33.61 19:30:08 INFO - PROCESS | 1699 | Values: 65.0 71.0 77.0 147.0 57.0 56.0 56.0 62.0 125.0 59.0 19:30:08 INFO - PROCESS | 1699 | 19:30:08 INFO - PROCESS | 1699 | [#4] audio-oscillator Cycles:10 Average:92.80 Median:80.00 stddev:19.27 (24.1%) stddev-sans-first:19.88 19:30:08 INFO - PROCESS | 1699 | Values: 80.0 81.0 121.0 73.0 80.0 91.0 119.0 80.0 83.0 120.0 19:30:08 INFO - PROCESS | 1699 | 19:30:08 INFO - PROCESS | 1699 | [#5] imaging-gaussian-blur Cycles:10 Average:95.30 Median:87.00 stddev:16.54 (19.0%) stddev-sans-first:15.37 19:30:08 INFO - PROCESS | 1699 | Values: 118.0 132.0 99.0 87.0 89.0 85.0 87.0 85.0 87.0 84.0 19:30:08 INFO - PROCESS | 1699 | 19:30:08 INFO - PROCESS | 1699 | [#6] imaging-darkroom Cycles:10 Average:108.60 Median:93.50 stddev:19.20 (20.5%) stddev-sans-first:19.52 19:30:08 INFO - PROCESS | 1699 | Values: 93.0 95.0 94.0 95.0 112.0 126.0 95.0 126.0 101.0 149.0 19:30:08 INFO - PROCESS | 1699 | 19:30:08 INFO - PROCESS | 1699 | [#7] imaging-desaturate Cycles:10 Average:106.20 Median:89.00 stddev:17.16 (19.3%) stddev-sans-first:17.18 19:30:08 INFO - PROCESS | 1699 | Values: 90.0 92.0 88.0 112.0 133.0 125.0 90.0 113.0 124.0 95.0 19:30:08 INFO - PROCESS | 1699 | 19:30:08 INFO - PROCESS | 1699 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:64.00 stddev:5.25 (8.2%) stddev-sans-first:5.20 19:30:08 INFO - PROCESS | 1699 | Values: 59.0 63.0 65.0 64.0 64.0 65.0 63.0 78.0 64.0 59.0 19:30:08 INFO - PROCESS | 1699 | 19:30:08 INFO - PROCESS | 1699 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:4.57 (6.8%) stddev-sans-first:4.30 19:30:08 INFO - PROCESS | 1699 | Values: 61.0 67.0 63.0 64.0 75.0 72.0 72.0 64.0 65.0 67.0 19:30:08 INFO - PROCESS | 1699 | 19:30:08 INFO - PROCESS | 1699 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:81.00 stddev:1.84 (2.3%) stddev-sans-first:1.87 19:30:08 INFO - PROCESS | 1699 | Values: 82.0 78.0 79.0 82.0 80.0 79.0 79.0 80.0 83.0 83.0 19:30:08 INFO - PROCESS | 1699 | 19:30:08 INFO - PROCESS | 1699 | [#11] stanford-crypto-ccm Cycles:10 Average:140.40 Median:144.00 stddev:6.42 (4.5%) stddev-sans-first:6.67 19:30:08 INFO - PROCESS | 1699 | Values: 144.0 145.0 148.0 138.0 141.0 145.0 136.0 126.0 144.0 137.0 19:30:08 INFO - PROCESS | 1699 | 19:30:08 INFO - PROCESS | 1699 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.50 Median:180.50 stddev:20.98 (11.6%) stddev-sans-first:21.27 19:30:08 INFO - PROCESS | 1699 | Values: 162.0 169.0 168.0 160.0 198.0 159.0 192.0 219.0 200.0 168.0 19:30:08 INFO - PROCESS | 1699 | 19:30:08 INFO - PROCESS | 1699 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:72.00 stddev:13.69 (19.0%) stddev-sans-first:14.20 19:30:08 INFO - PROCESS | 1699 | Values: 65.0 70.0 66.0 60.0 82.0 65.0 58.0 74.0 98.0 93.0 19:30:08 INFO - PROCESS | 1699 | -------- Summary: end -------- 19:30:08 INFO - PROCESS | 1699 | 19:30:08 INFO - TEST-INFO | 1699: exit 0 19:30:09 INFO - TEST-OK | kraken | took 58703ms 19:30:09 INFO - SUITE-END | took 1168s 19:30:09 INFO - Completed test suite (00:19:28) 19:30:09 INFO - javascript benchmark 19:30:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3615.1323682316242, 3645.2162785001237, 3674.7243956703255, 3703.166787472818, 3714.814259287035, 5948.88102237955, 5978.133170690253, 5987.4910632596175, 5996.790112346058, 6003.879922401555, 5977.013792724195, 6002.219711437507, 6006.399360064002, 6019.849503762408, 6031.72857221425, 5341.359036915565, 5371.677699338033, 5411.215373770801, 5446.891062178754, 5494.752736126884, 5338.67967921924, 5435.483629055233, 5439.075357189267, 5459.890802183954, 5487.670739755627, 5411.567074634039, 5418.0, 5440.347158341005, 5493.093639549469, 5530.557555395559, 5425.186222066702, 5426.321709786277, 5434.538064264542, 5455.509004189642, 5457.890842183174, 5330.813421530266, 5375.865603359947, 5386.13821788512, 5425.782968681248, 5487.75305111271, 5400.189971504266, 5669.489745922846, 5746.798862039808, 5819.039858423355, 5877.9118313225335, 6216.298151709865, 6226.782062627832, 6240.0, 6264.185655864709, 6272.6236425814595, 6269.717862696144, 6300.527460440485, 6313.905291420632, 6316.1788967434395, 6344.841378965517, 5938.435848594377, 6050.21347224858, 6069.15031895535, 6104.877902441926, 6124.081387791867, 6368.554201205964, 6390.45681117101, 6437.710303036374, 6457.903131453032, 6463.7091330890225, 6154.138420621117, 6232.937670623236, 6252.437280644764, 6257.655828929453, 6276.843078923063, 6257.5932564383165, 6326.2724786649205, 6334.429901308812, 6335.588186767845, 6336.429721325103, 6221.688915554204, 6233.844153896189, 6264.436200741864, 6264.843378915563, 6266.968665156736, 4583.633309335245, 6141.700809433325, 6142.8057410146475, 6258.812235632939, 6268.341824108494, 4221.345691417835, 4448.621867141329, 5061.696298222045, 5064.442911279756, 5109.875827317984, 4594.747288899076, 4614.100250451197, 4617.769111544477, 4621.630269578425, 4672.439307283148, 4739.312799644033, 5887.646741195542, 5980.940190598125, 6061.363556826558, 6124.265088189446, 5532.197831314437, 5956.13636022783, 6120.112583675342, 6329.544204832914, 6346.143270658495, 5471.699056551928, 6083.878322433527, 6099.268087829489, 6108.5723999319625, 6145.231846019247, 5428.4842939920645, 5527.364353099365, 5576.9163462548095, 5610.186522954149, 5651.773929042874, 6495.837604059936, 6549.24683661385, 6561.507886908405, 6573.901391479131, 6579.539432239697, 6301.558890877778, 6307.526935479766, 6331.493480521455, 6336.968315158395, 6338.429541341301, 6328.651924144032, 6376.93623063782, 6447.838804029937, 6502.512311576746, 6505.60966342021, 6241.21984751906, 6250.156228909039, 6251.343608920998, 6256.124142619946, 6265.462487692492, 6253.530985176039, 6326.177596912372, 6327.651979141191, 6333.556651034383, 6338.841528961629, 6133.0, 6133.610107582569, 6143.389059649542, 6148.569600127948, 6192.59748116371, 6177.0, 6212.316645169119, 6214.1921550199995, 6225.439710426083, 6236.469900058546, 5876.236089308362, 6085.908711369245, 6151.200343955257, 6199.504039676905, 6248.968755156195, 6122.916604401471, 6167.506599471942, 6198.0702894566175, 6215.192025036717, 6236.75052997875, 6122.204113465221, 6196.783112591218, 6197.628142311476, 6218.5647004709235, 6219.533534984804], "value": 5834.870519050747, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.192133720756, 545.1658961788463, 571.3515160293072, 610.0544156557335, 653.1411194279522, 39097.21805563891, 39856.40215396764, 39983.800080999594, 40100.59899401005, 40173.59826401735, 42072.36891446623, 42156.0, 42339.3649095263, 42362.152756944844, 42420.363694544605, 9773.70678879633, 9970.0, 9976.451295178762, 9977.0, 9978.550965206583, 9788.0, 9933.850992235122, 10044.799104017915, 10057.647982320621, 10076.647317343895, 10035.0, 10088.495575221246, 10106.393616383004, 10123.64567240143, 10175.236857235699, 10001.59993600255, 10039.24705647072, 10041.0, 10069.798604027916, 10094.74763130924, 9965.0, 10060.748481287954, 10068.647597334058, 10097.646582369582, 10143.036411540892, 40906.59093409058, 41151.58848411508, 41425.585744142474, 41495.0, 41598.376024359655, 2626.645402870607, 3069.7083777041144, 3277.4100661880852, 3349.246419555605, 3383.7293016558615, 22291.77395243261, 25971.740282597122, 28247.0, 28500.287492812844, 28527.714722852714, 2688.1129227354927, 2743.876525556355, 2762.8342299462097, 2804.298925268683, 2843.957340639892, 346366.0, 380888.0, 418196.0, 419291.9035404834, 432290.3854807247, 36225.818870905474, 38315.23369532594, 57375.0, 65645.0, 66218.0, 28436.289092772848, 36726.26547469036, 36840.81579592085, 37053.258934821155, 37118.62881371206, 16087.115208663636, 16104.19479026044, 16166.515004549883, 16217.59456013609, 16249.675006499803, 11132.833007504894, 13262.801057984138, 13316.800247996287, 13370.331483425789, 13389.062765606508, 8480.74557763268, 8507.276881465144, 8510.659573616986, 8610.268127209132, 8669.739907802776, 3538.858445662196, 3564.6435356464663, 3602.351576716164, 3607.6572725591027, 3663.6153203913204, 1010.3382284603449, 1017.5166795772097, 1043.186314674555, 1057.582255009267, 1080.4819228983133, 29044.0, 29122.0, 29541.26146846346, 29590.96431624883, 29832.701672982992, 1014.9188064954786, 1150.6950658075616, 1203.2239205712267, 1228.8893999540085, 1250.66020907451, 13382.866171338163, 15128.848711512745, 15294.311755971008, 15299.235038248044, 17014.48956531306, 613306.0, 636381.0, 652402.0, 652423.0, 653488.0, 65125.0, 65200.67399663066, 65522.0, 65640.67179664072, 65642.01536976949, 1501.0, 1553.1147246069859, 1554.2617256802928, 1556.7275726747773, 1556.8365321641065, 30009.0, 30762.0, 30996.535051973788, 31093.689063109985, 31302.0, 52038.95922081613, 55693.44306557045, 56120.438795613154, 56331.155032675364, 56510.717446412506, 579426.0, 595482.0, 595716.0, 600618.0, 602656.0, 28652.713472865005, 28767.424651506433, 28922.855385722938, 29188.0, 29283.0, 46564.603061908194, 47252.0, 48371.5162848367, 48372.75813620909, 48581.514184859116, 38951.0, 39158.80420597879, 39298.6070139295, 39335.803320984356, 40132.1973560533, 26669.19992400231, 31420.0, 31795.41022948797, 36113.63886361103, 38886.4167037489, 33435.0, 38558.80720596379, 38658.80670596629, 38853.611463885, 39093.80453097716, 31581.526277105404, 32345.0, 32354.191145221557, 32530.67469325371, 32903.0, 20814.37556873296, 24497.387565311008, 24697.753022469544, 24805.875970620033, 24997.750022499542], "value": 18880.95164772949, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.3659845538642, 413.46249875162283, 414.71384744526296, 417.6616940278375, 423.78175239751533, 20582.0, 21264.681029784526, 21333.35999920003, 21542.246021389215, 22553.210637627686, 12009.879901200986, 12320.691982700415, 13905.374258158381, 21050.0, 21303.57392852142, 5331.946680533193, 5563.749631266603, 5610.635308704921, 5629.3526244482, 5657.801976930808, 6057.363976782441, 6131.632102073868, 6178.907316390235, 6179.814605561818, 6190.907136392958, 5451.890962180754, 6037.973544497424, 6154.753809847601, 6184.536159788011, 6209.9068513972325, 5511.724413779295, 5540.279763630742, 5569.693666848301, 5575.526080283161, 5613.943860561383, 5490.890182196334, 5495.505404513613, 5497.285352904097, 5497.615166938316, 5497.642653227527, 13931.930340348234, 14065.156090634595, 14166.787498187536, 14340.856591434162, 16757.748633770505, 2152.78367722238, 2159.8596091254017, 2251.324602619208, 2303.861768293891, 2312.2138472919287, 8566.543687573128, 9914.157296629795, 9992.550335234931, 10125.645602403954, 10201.846972295421, 1801.3427646565192, 1809.6471188118321, 1816.3370369814922, 1825.5709908171568, 1849.4729002234299, 111640.0, 121126.3943680276, 121209.78790212073, 125018.37490812578, 126102.0, 11811.52753889852, 11945.343006134746, 12008.339541325311, 12093.637190884288, 12294.508219671292, 15500.457483988006, 15506.147161905978, 15507.379704811681, 15508.147051912254, 15563.766543501857, 8059.919400805917, 8922.152395522415, 9366.157045865904, 9376.968533461313, 9427.528623568795, 9384.390014649027, 9427.528623568795, 9452.57463414148, 9467.384619999679, 9548.236141108695, 4733.0, 4770.737609431515, 4823.879403014883, 4836.782344794422, 4880.097182021337, 1780.5459607799928, 1990.9303174388826, 2071.658176400907, 2097.748270207585, 2111.4932416219995, 901.1439132823843, 1019.23557332001, 1058.3755584205355, 1058.5183741397645, 1081.0, 15495.831864514523, 18184.0, 19768.604627907647, 20174.89038102889, 21726.565468690853, 986.8470387090013, 990.980180396388, 993.6224234790733, 994.2940512236394, 1058.5342449322275, 9380.5309734513, 11533.365664888512, 11576.536938522533, 11590.652280431601, 11652.766944661229, 623624.7637523657, 653622.7318863375, 663058.0, 675396.0, 680687.0, 100906.0, 117870.0, 128533.35733321274, 130322.0, 132298.0, 966.1111777165025, 991.4101109839634, 991.4249735153594, 1000.9149222316039, 1025.1542477456128, 18902.43292701221, 19290.4212873614, 19633.70549441731, 19700.01499924969, 19926.30257940965, 45449.95475203558, 54239.45760542344, 54701.0, 55549.7222513901, 56889.14666280092, 72430.0, 72877.6356118216, 73457.26542734719, 74111.0, 74987.62506187652, 8198.42611017247, 8279.420440569102, 8289.991025787169, 8389.0, 8447.324214062983, 9220.815583688154, 11986.880131198577, 12734.490620375082, 12988.805167922677, 13029.218246905217, 5423.3491980962535, 5764.711764411679, 11062.778744424906, 11286.943565282121, 11529.769404612029, 11072.833907491233, 11123.72190695239, 11224.438778060901, 11353.659390218307, 11373.829392559284, 11326.433678315887, 11344.319340839576, 11392.25950313227, 11464.885351146382, 11525.481353338952, 8044.758657240292, 8098.3116435103675, 8300.826495688096, 8317.126701696236, 8642.265407440438, 11275.379854108103, 11395.544178232778, 11446.198766086294, 11790.23363481371, 11820.0543956485], "value": 9478.561678912649, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1641.7619445180449, 1656.4368114840956, 1928.2576208159853, 2000.359884836852, 2057.4444899877044, 8283.5029898206, 8980.550972451383, 9079.727608171757, 9285.350025498217, 9336.81326373472, 9002.32482563807, 9031.503267320295, 9036.457812531253, 9054.728358149267, 9143.771405714844, 2527.582948813448, 2549.7067837198683, 2551.2473820223076, 2562.4875024995076, 2574.3692795265188, 2526.0, 2570.678665166854, 2575.88408521616, 2576.0339872547793, 2582.4447743735095, 2537.8984840606354, 2551.170869467421, 2586.7154612992554, 2587.7153513113544, 2594.675665541807, 2550.349660836484, 2571.112966026727, 2576.4203054312816, 2579.148880869318, 2585.8836352364187, 2510.3849556858504, 2566.512362651109, 2574.4336246025846, 2577.6262441945814, 2588.2364702412647, 9315.021922698155, 9345.252379809599, 9346.299027572892, 9364.625414983393, 9393.62425502979, 5653.406392328829, 5713.200151978726, 5760.8271751847515, 5770.711464426804, 5890.764369425217, 3676.613955534684, 3771.9057023574355, 3822.503074600284, 3827.9808600957094, 3837.520309961255, 1067.0503252105632, 1075.6611667324767, 1079.098952374768, 1124.269225003746, 1126.1610100475198, 12370.195937264049, 12471.999999999909, 12534.81197782034, 12574.559890403883, 12581.496740130384, 5035.0, 5047.293378926953, 5110.540051395392, 5121.206213036985, 5166.535011848877, 10599.576016959236, 10624.575016999233, 10653.0, 10687.465626718633, 10698.679039628823, 5651.717414129277, 5668.0647693130995, 5729.8567535811935, 5733.455321744427, 5792.681402522818, 4592.03567250881, 5005.574526165244, 5081.669691470117, 5123.462036486189, 5194.792208311701, 3642.21692336149, 4261.190373828963, 4289.378040184219, 4304.677149213821, 4340.392345071693, 1214.4959841665786, 1401.5374926274305, 1430.8497607751244, 1435.8492358302437, 1438.8561143885738, 908.2643059122132, 954.1222075690242, 982.8083523712808, 990.5195979949718, 1002.6791426743372, 6033.215681961317, 6095.847603809941, 6130.969345153246, 6239.126522286883, 6256.655883926337, 465.33457156266866, 472.6549618778311, 482.56328023139116, 485.9295402166666, 496.5580633236423, 4114.794260286973, 4123.402106694512, 4133.483314585676, 4165.625093741517, 4246.7027308088755, 10817.080548153337, 11235.15736319763, 11277.492512836941, 11307.547698091985, 11379.487923043484, 10794.784104318027, 11000.669979900616, 11023.06303964156, 11057.22599418033, 11074.446277686084, 8464.280536154372, 8736.344774141964, 8737.082606326372, 8759.2992560595, 8766.736997890073, 5839.182514448065, 5854.677992710442, 5969.701514924323, 6002.219711437485, 6063.181470501426, 9772.560234789593, 9859.802803943738, 9913.65302214419, 9975.401475911469, 10045.49772511386, 9796.461194634363, 10083.394996300245, 10322.019408156213, 10389.06498415116, 10428.113610342902, 5727.369989301257, 6803.0, 7601.695932162652, 7687.5387476751575, 7754.495957762728, 8602.39783215169, 8607.053224145464, 8649.135086491553, 8659.48043117415, 8699.826003480022, 7547.73582924595, 7567.356774674215, 7717.151113377637, 7797.805054873674, 7841.568713720572, 7519.436042296959, 7549.811254718676, 7552.244775522404, 7650.273224043707, 7759.961200193963, 7169.139703235436, 7190.029346038427, 7256.092988376453, 7264.600446975467, 7284.344409003215, 4952.752362381939, 4960.156773348612, 5093.541581257705, 5131.8717032073, 5142.254373115802, 5046.243063540498, 5127.256547800623, 5136.30659860914, 5216.321878155815, 5361.27622770921], "value": 4744.188109792149, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.7641827139274, 343.155836641861, 343.8074678180221, 348.8116417134747, 354.0458464438336, 6933.653317334132, 6959.721611135561, 6986.406155476784, 6997.1253593300835, 7033.50765446419, 6863.656817159134, 6868.175818901726, 6877.587344759318, 6884.896726549093, 6905.205901321349, 4837.879053023685, 4905.877353066184, 5030.647854650176, 5039.244113382985, 5042.697438153704, 4080.5919408059103, 4992.77532511036, 5034.899302013958, 5040.873978150539, 5088.26220198071, 5008.198688209887, 5019.096562618727, 5021.648484606079, 5041.672291301072, 5045.520675535837, 5017.37282839645, 5019.874503137415, 5122.948770512285, 5123.7438128093445, 5140.408852981917, 4009.278329900617, 4313.09425020746, 4322.351647252937, 4329.19909816685, 4337.674674399401, 5539.639923404966, 6342.572921092763, 6455.451286640641, 6514.185726784152, 6555.213374395055, 5909.911351329733, 5923.289205295349, 5935.614185077956, 5947.4052594740615, 5970.761169553212, 7326.377257933082, 7363.116426028857, 7389.556626602421, 7395.889061664079, 7476.065491813523, 4865.635077369211, 4870.951290487121, 4872.244802055687, 4880.877978050542, 4890.217565189588, 7438.256174382573, 7727.150013498511, 7752.147263800977, 7758.844823103506, 7780.455368124233, 4943.555080042814, 4957.281194226817, 4957.380327459067, 4970.353853998957, 4973.701577905337, 5000.199968005102, 5046.1926091825135, 5048.0, 5069.771860266297, 5073.16292811682, 5907.3797251288, 5932.436418540232, 5937.732802023919, 5941.197938278364, 5959.463648271676, 7399.556026638311, 7407.0, 7408.7036518539735, 7410.036695229694, 7412.925870741224, 1457.4388860288866, 1721.468574984443, 1769.1066011664027, 1770.460009697029, 1774.272548255235, 1128.7629597784558, 1139.0944199361527, 1141.6175581180232, 1141.7659379827116, 1142.9771404571861, 6880.8967865482055, 6907.861842763217, 6937.583744975318, 6971.651417429108, 6990.0, 7465.328120469184, 7594.620268986529, 7670.309672129535, 7693.49992250502, 7693.999780028673, 6894.0, 6942.409895158968, 7250.274972502813, 7253.963730181315, 7261.237570055068, 4085.55058943516, 4128.4632997710105, 4131.97934010328, 4135.152293779768, 4137.40007698882, 8118.553479558563, 8129.0, 8132.0, 8133.5526546039355, 8137.471064380797, 7628.237176282439, 7684.3084122429245, 7983.161768014391, 8003.4797738146835, 8060.355171586259, 6496.870062598721, 8020.43856930021, 8091.98850143732, 8110.918890811016, 8128.512289262663, 7708.653110609924, 7725.49784264021, 7732.574708391093, 7748.0, 7752.0, 7596.506227095442, 7616.200298968529, 7622.466427350254, 7626.54240745557, 7634.961825190839, 7319.63401829917, 7439.442041846992, 7819.374450044096, 8030.0, 8126.796830079295, 4121.567235440236, 4454.08691218293, 4673.0, 4956.10790057793, 4964.205727083794, 7739.0, 7742.806429839299, 7750.689972401041, 7763.68945242184, 7812.765617031499, 7258.600776957318, 7427.183009868802, 7502.174760776201, 7508.648443280262, 7509.136449308399, 5420.620556561161, 6227.283862355705, 7465.440091993014, 7489.625518723933, 7496.362809161283, 7278.09023872016, 7278.854422911618, 7291.781246562611, 7317.487775855852, 7339.155997060407, 7448.73929412468, 7464.888026679496, 7471.925280747123, 7494.925050749423, 7505.587192704454, 6210.472109870711, 6676.664667066509, 7293.161286452126, 7294.343509084208, 7359.227281135403], "value": 5402.312165946806, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.9607871567064, 763.5838468034921, 767.7926959720876, 774.9651265693043, 775.8138046868752, 14951.252437378142, 15207.543773686793, 15260.771088433683, 15266.54967778062, 15268.16025118618, 14184.21986790726, 14217.0, 14227.430902763903, 14251.71496570068, 14253.643658908506, 780.9023872015998, 801.767487428645, 908.6410867707252, 931.7996630724393, 964.6286179820785, 931.5994122527311, 951.8952915179359, 960.0639376607821, 963.1187463470916, 963.1235575626182, 990.2325697584357, 1009.6314845081566, 1016.0195411428008, 1016.5120742043823, 1017.2878984710695, 968.7239136846, 1006.7583779892809, 1006.9899301006969, 1009.1119814563211, 1010.6816352848866, 733.2777214443769, 735.477810754365, 754.5435011817881, 755.5806527377304, 755.7581573896356, 14863.108213507116, 14865.256737163207, 14892.255387230594, 14906.552803415914, 15039.473618423302, 12923.612291631267, 12957.48170073196, 13100.47598096075, 13109.475620975245, 13227.0, 10181.490925453698, 10201.0, 10319.58721651133, 10394.79210415795, 10455.21585881062, 3555.0579096539436, 3574.696150827183, 3584.8386822593047, 3632.164602141496, 3786.2048969716393, 70411.94382084222, 80733.59633201855, 85374.57312713396, 85505.0, 86193.0, 9481.857772133424, 9619.0, 9743.805123897624, 9744.75638109053, 9955.900440995641, 22421.32736017922, 22427.102915883508, 22490.0, 22490.66264006041, 22509.88745056264, 7526.059242594676, 7528.736494222676, 7619.580923049175, 7677.193894641094, 7797.298243158143, 4126.711130220856, 4183.937240941388, 4189.308764053897, 4204.159168166379, 4211.873643790691, 3381.1547113221695, 3561.9821900890847, 3572.7499075064497, 3607.206414588786, 3621.3300539400293, 680.323078536859, 692.3318997167758, 700.3066963705894, 704.7603814703026, 707.5613119865716, 579.7622974580402, 588.2676068295, 596.8537708261417, 604.2477115990532, 609.8505866062754, 7177.7487787927175, 7667.118281397599, 8121.918780812234, 8146.2261085196815, 8229.670813167406, 507.7283653245496, 544.3196004993757, 545.6753231827057, 558.4778232352681, 613.4938675592654, 3808.638179372955, 3928.7642741435607, 3963.583823698528, 4031.4154447604933, 4032.3145065338963, 86075.0, 87221.0, 88501.55749221213, 88543.55728221318, 88808.55595722109, 57382.42617573771, 70563.64718176478, 74700.62649686717, 74886.0, 77884.61057694675, 63703.6814815923, 68144.65927670429, 68574.0, 68840.62318753597, 69353.3064669357, 7952.761417157494, 8070.314023308085, 8217.54803485814, 8269.710560130367, 8335.569002692711, 47680.04639907113, 47768.761156194, 48361.0, 48857.755711221216, 50413.747931261576, 61664.45838853885, 65028.34971650223, 65822.0, 65854.67072664606, 66123.0, 10566.735831604272, 10751.462426878781, 10876.293040952312, 11014.44927753625, 11132.0, 11587.536498540301, 11717.179797414099, 11842.407879606157, 11991.520339186334, 12425.689357766129, 10778.730531736455, 10825.621103261348, 11126.276792008493, 11409.54361825551, 11626.53493860236, 10959.287646302964, 11053.944730276296, 11268.887311126784, 11446.084313254752, 11659.300441973508, 9678.17735492491, 10825.350478971286, 10858.185636077484, 10872.782544349227, 11072.0, 9124.863127052966, 9170.495622740547, 9216.410655259491, 9258.629654814002, 9311.0, 7402.481826272325, 8052.677892884219, 9361.953190234006, 9542.570584323583, 9567.712968610953], "value": 6912.3940228314095, "unit": "score"}], "name": "dromaeo_css", "value": 7548.605607087949, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 112.0, 117.0, 117.0, 116.0, 133.0, 116.0, 116.0, 115.0, 116.0], "value": 117.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 130.0, 182.0, 196.0, 133.0, 138.0, 122.0, 153.0, 155.0, 120.0], "value": 146.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [255.0, 242.0, 195.0, 196.0, 193.0, 198.0, 189.0, 205.0, 176.0, 261.0], "value": 211.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 77.0, 147.0, 57.0, 56.0, 56.0, 62.0, 125.0, 59.0], "value": 77.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 121.0, 73.0, 80.0, 91.0, 119.0, 80.0, 83.0, 120.0], "value": 92.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 132.0, 99.0, 87.0, 89.0, 85.0, 87.0, 85.0, 87.0, 84.0], "value": 95.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 94.0, 95.0, 112.0, 126.0, 95.0, 126.0, 101.0, 149.0], "value": 108.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 92.0, 88.0, 112.0, 133.0, 125.0, 90.0, 113.0, 124.0, 95.0], "value": 106.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 63.0, 65.0, 64.0, 64.0, 65.0, 63.0, 78.0, 64.0, 59.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 67.0, 63.0, 64.0, 75.0, 72.0, 72.0, 64.0, 65.0, 67.0], "value": 67.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 78.0, 79.0, 82.0, 80.0, 79.0, 79.0, 80.0, 83.0, 83.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 145.0, 148.0, 138.0, 141.0, 145.0, 136.0, 126.0, 144.0, 137.0], "value": 140.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 169.0, 168.0, 160.0, 198.0, 159.0, 192.0, 219.0, 200.0, 168.0], "value": 179.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 70.0, 66.0, 60.0, 82.0, 65.0, 58.0, 74.0, 98.0, 93.0], "value": 73.1, "unit": "score"}], "name": "kraken", "value": 1560.6, "alertThreshold": 2.0}]} 19:30:09 INFO - Return code: 0 19:30:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:30:09 ERROR - # TBPL SUCCESS # 19:30:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:30:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:30:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:30:09 INFO - 2016-07-16 19:30:09.401 screenresolution[1705:13613] starting screenresolution argv=screenresolution get 19:30:09 INFO - 2016-07-16 19:30:09.404 screenresolution[1705:13613] Display 0: 1600x1200x32@60 19:30:09 INFO - 2016-07-16 19:30:09.410 screenresolution[1706:13616] starting screenresolution argv=screenresolution list 19:30:09 INFO - Available Modes on Display 0 19:30:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:30:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:30:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:30:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:30:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:30:09 INFO - Intel Iris: 19:30:09 INFO - Chipset Model: Intel Iris 19:30:09 INFO - Type: GPU 19:30:09 INFO - Bus: Built-In 19:30:09 INFO - VRAM (Dynamic, Max): 1536 MB 19:30:09 INFO - Vendor: Intel (0x8086) 19:30:09 INFO - Device ID: 0x0a2e 19:30:09 INFO - Revision ID: 0x0009 19:30:09 INFO - Displays: 19:30:09 INFO - Display: 19:30:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:30:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:30:09 INFO - Display Serial Number: 1600x1200 60 19:30:09 INFO - Main Display: Yes 19:30:09 INFO - Mirror: Off 19:30:09 INFO - Online: Yes 19:30:09 INFO - Rotation: Supported 19:30:09 INFO - Return code: 0 19:30:09 INFO - Running post-action listener: _resource_record_post_action 19:30:09 INFO - Running post-run listener: _resource_record_post_run 19:30:10 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 32464384; Write bytes: 497883648; Read time: 321; Write time: 1739 19:30:10 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 191332864; Write bytes: 187127808; Read time: 17705; Write time: 402 19:30:10 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 30682624; Write bytes: 299962880; Read time: 302; Write time: 1302 19:30:10 INFO - Running post-run listener: _upload_blobber_files 19:30:10 INFO - Blob upload gear active. 19:30:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:30:10 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 19:30:10 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'] 19:30:10 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 19:30:11 INFO - (blobuploader) - INFO - Open directory for files ... 19:30:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:30:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:30:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:30:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:30:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:30:12 INFO - (blobuploader) - INFO - Done attempting. 19:30:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:30:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:30:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:30:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:30:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:30:13 INFO - (blobuploader) - INFO - Done attempting. 19:30:13 INFO - (blobuploader) - INFO - Iteration through files over. 19:30:13 INFO - Return code: 0 19:30:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:30:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:30:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5c17fc7575c51cf524a06bfa6254e713d912d6900f9fa844192c12422e3d73f0308dc7e099914a7763fd6073b3113517edeb1dab0778959dd4e7fcb4b3f0611f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c2a02100877390e7cc3c23374ac8fa410a70426aea9064b12e3b0060705fb21109d454eef0932373a84271912204b18487f34cb59cfa3bfd155d0c61fee86d4c"} 19:30:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:30:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:30:13 INFO - Contents: 19:30:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5c17fc7575c51cf524a06bfa6254e713d912d6900f9fa844192c12422e3d73f0308dc7e099914a7763fd6073b3113517edeb1dab0778959dd4e7fcb4b3f0611f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c2a02100877390e7cc3c23374ac8fa410a70426aea9064b12e3b0060705fb21109d454eef0932373a84271912204b18487f34cb59cfa3bfd155d0c61fee86d4c"} 19:30:13 INFO - Running post-run listener: copy_logs_to_upload_dir 19:30:13 INFO - Copying logs to upload dir... 19:30:13 INFO - mkdir: /builds/slave/test/build/upload/logs 19:30:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.160264 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-07-16 19:30:13.824988) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 19:30:13.828805) ========= 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.YN7BNETlzH/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.PQtRtVBCEc/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5c17fc7575c51cf524a06bfa6254e713d912d6900f9fa844192c12422e3d73f0308dc7e099914a7763fd6073b3113517edeb1dab0778959dd4e7fcb4b3f0611f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c2a02100877390e7cc3c23374ac8fa410a70426aea9064b12e3b0060705fb21109d454eef0932373a84271912204b18487f34cb59cfa3bfd155d0c61fee86d4c"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493517/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011121 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493517/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5c17fc7575c51cf524a06bfa6254e713d912d6900f9fa844192c12422e3d73f0308dc7e099914a7763fd6073b3113517edeb1dab0778959dd4e7fcb4b3f0611f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c2a02100877390e7cc3c23374ac8fa410a70426aea9064b12e3b0060705fb21109d454eef0932373a84271912204b18487f34cb59cfa3bfd155d0c61fee86d4c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 19:30:13.863805) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 19:30:13.864181) ========= 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.YN7BNETlzH/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.PQtRtVBCEc/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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.005153 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 19:30:13.914214) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 19:30:13.914549) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 19:30:13.915222) ========= ========= Total master_lag: 0.24 =========