builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0080 starttime: 1468909448.75 results: success (0) buildid: 20160718142157 builduid: 7d23d67028f94a32ab61f3abaa859185 revision: d2ab9c39bd1059d74acb3d9ac87dbfbba913427b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 23:24:08.752208) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 23:24:08.752634) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 23:24:08.752917) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 23:24:08.777663) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 23:24:08.777959) ========= 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.P9StSqlRz9/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.dNcfBoPn1I/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-18 23:24:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 165M=0s 2016-07-18 23:24:09 (165 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.413149 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 23:24:09.311929) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 23:24:09.312228) ========= 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.P9StSqlRz9/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.dNcfBoPn1I/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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.029384 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 23:24:09.364798) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 23:24:09.365123) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d2ab9c39bd1059d74acb3d9ac87dbfbba913427b --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 d2ab9c39bd1059d74acb3d9ac87dbfbba913427b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.P9StSqlRz9/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.dNcfBoPn1I/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-18 23:24:09,440 truncating revision to first 12 chars 2016-07-18 23:24:09,440 Setting DEBUG logging. 2016-07-18 23:24:09,440 attempt 1/10 2016-07-18 23:24:09,440 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d2ab9c39bd10?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 23:24:10,132 unpacking tar archive at: mozilla-beta-d2ab9c39bd10/testing/mozharness/ program finished with exit code 0 elapsedTime=0.959286 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 23:24:10.346118) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 23:24:10.346414) ========= script_repo_revision: d2ab9c39bd1059d74acb3d9ac87dbfbba913427b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 23:24:10.346805) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 23:24:10.347080) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 23:24:10.364646) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-18 23:24:10.364923) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.P9StSqlRz9/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.dNcfBoPn1I/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 23:24:10 INFO - MultiFileLogger online at 20160718 23:24:10 in /builds/slave/test 23:24:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 23:24:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:24:10 INFO - {'append_to_log': False, 23:24:10 INFO - 'base_work_dir': '/builds/slave/test', 23:24:10 INFO - 'blob_upload_branch': 'Mozilla-Beta', 23:24:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:24:10 INFO - 'branch': 'Mozilla-Beta', 23:24:10 INFO - 'buildbot_json_path': 'buildprops.json', 23:24:10 INFO - 'config_files': ('talos/mac_config.py',), 23:24:10 INFO - 'default_actions': ('clobber', 23:24:10 INFO - 'read-buildbot-config', 23:24:10 INFO - 'download-and-extract', 23:24:10 INFO - 'populate-webroot', 23:24:10 INFO - 'create-virtualenv', 23:24:10 INFO - 'install', 23:24:10 INFO - 'run-tests'), 23:24:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:24:10 INFO - 'download_minidump_stackwalk': True, 23:24:10 INFO - 'download_symbols': 'ondemand', 23:24:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:24:10 INFO - 'tooltool.py': '/tools/tooltool.py', 23:24:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:24:10 INFO - '/tools/misc-python/virtualenv.py')}, 23:24:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:24:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:24:10 INFO - 'installer_path': 'installer.exe', 23:24:10 INFO - 'log_level': 'info', 23:24:10 INFO - 'log_name': 'talos', 23:24:10 INFO - 'log_to_console': True, 23:24:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:24:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:24:10 INFO - 'opt_config_files': (), 23:24:10 INFO - 'pip_index': False, 23:24:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:24:10 INFO - 'cmd': ('bash', 23:24:10 INFO - '-c', 23:24:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:24:10 INFO - 'enabled': True, 23:24:10 INFO - 'halt_on_failure': False, 23:24:10 INFO - 'name': 'check_screen_resolution'},), 23:24:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:24:10 INFO - 'cmd': ('bash', 23:24:10 INFO - '-c', 23:24:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:24:10 INFO - 'enabled': True, 23:24:10 INFO - 'halt_on_failure': False, 23:24:10 INFO - 'name': 'check_screen_resolution'},), 23:24:10 INFO - 'run_cmd_checks_enabled': True, 23:24:10 INFO - 'sps_profile': False, 23:24:10 INFO - 'sps_profile_interval': 0, 23:24:10 INFO - 'suite': 'dromaeojs', 23:24:10 INFO - 'system_bits': '32', 23:24:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:24:10 INFO - 'title': 't-yosemite-r7-0080', 23:24:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:24:10 INFO - 'use_talos_json': True, 23:24:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:24:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:24:10 INFO - 'work_dir': 'build'} 23:24:10 INFO - ##### 23:24:10 INFO - ##### Running clobber step. 23:24:10 INFO - ##### 23:24:10 INFO - Running pre-action listener: _resource_record_pre_action 23:24:10 INFO - Running main action method: clobber 23:24:10 INFO - rmtree: /builds/slave/test/build 23:24:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:24:12 INFO - Running post-action listener: _resource_record_post_action 23:24:12 INFO - ##### 23:24:12 INFO - ##### Running read-buildbot-config step. 23:24:12 INFO - ##### 23:24:12 INFO - Running pre-action listener: _resource_record_pre_action 23:24:12 INFO - Running main action method: read_buildbot_config 23:24:12 INFO - Using buildbot properties: 23:24:12 INFO - { 23:24:12 INFO - "project": "", 23:24:12 INFO - "product": "firefox", 23:24:12 INFO - "script_repo_revision": "production", 23:24:12 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 23:24:12 INFO - "repository": "", 23:24:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 23:24:12 INFO - "buildid": "20160718142157", 23:24:12 INFO - "pgo_build": "False", 23:24:12 INFO - "basedir": "/builds/slave/test", 23:24:12 INFO - "buildnumber": 3, 23:24:12 INFO - "slavename": "t-yosemite-r7-0080", 23:24:12 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 23:24:12 INFO - "platform": "yosemite_r7", 23:24:12 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 23:24:12 INFO - "branch": "mozilla-beta", 23:24:12 INFO - "repo_path": "releases/mozilla-beta", 23:24:12 INFO - "revision": "d2ab9c39bd1059d74acb3d9ac87dbfbba913427b", 23:24:12 INFO - "stage_platform": "macosx64", 23:24:12 INFO - "builduid": "7d23d67028f94a32ab61f3abaa859185", 23:24:12 INFO - "slavebuilddir": "test" 23:24:12 INFO - } 23:24:12 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468876917/firefox-48.0.en-US.mac.dmg. 23:24:12 INFO - Running post-action listener: _resource_record_post_action 23:24:12 INFO - ##### 23:24:12 INFO - ##### Running download-and-extract step. 23:24:12 INFO - ##### 23:24:12 INFO - Running pre-action listener: _resource_record_pre_action 23:24:12 INFO - Running main action method: download_and_extract 23:24:12 INFO - mkdir: /builds/slave/test/build/tests 23:24: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')]} 23:24:12 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468876917/firefox-48.0.en-US.mac.test_packages.json 23:24:12 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468876917/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 23:24:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468876917/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 23:24:13 INFO - Downloaded 1165 bytes. 23:24:13 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 23:24:13 INFO - Using the following test package requirements: 23:24:13 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 23:24:13 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 23:24:13 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 23:24:13 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 23:24:13 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 23:24:13 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 23:24:13 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 23:24:13 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 23:24:13 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 23:24:13 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 23:24:13 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 23:24:13 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 23:24:13 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 23:24:13 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 23:24:13 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 23:24:13 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 23:24:13 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 23:24:13 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 23:24:13 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')]} 23:24:13 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468876917/firefox-48.0.en-US.mac.common.tests.zip 23:24:13 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468876917/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 23:24:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468876917/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 23:24:13 INFO - Downloaded 18314748 bytes. 23:24:13 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'] 23:24:13 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 23:24:16 INFO - Return code: 0 23:24:16 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 23:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:16 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468876917/firefox-48.0.en-US.mac.common.tests.zip 23:24:16 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468876917/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 23:24:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468876917/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 23:24:16 INFO - Downloaded 18314748 bytes. 23:24:16 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'] 23:24:16 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 23:24:20 INFO - Return code: 0 23:24: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')]} 23:24:20 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468876917/firefox-48.0.en-US.mac.talos.tests.zip 23:24:20 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468876917/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 23:24:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468876917/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 23:24:20 INFO - Downloaded 10840145 bytes. 23:24:20 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'] 23:24:20 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 23:24:21 INFO - Return code: 0 23:24: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')]} 23:24:21 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468876917/firefox-48.0.en-US.mac.dmg 23:24:21 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468876917/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 23:24:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468876917/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 23:24:25 INFO - Downloaded 86190543 bytes. 23:24:25 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468876917/firefox-48.0.en-US.mac.dmg 23:24:25 INFO - mkdir: /builds/slave/test/properties 23:24:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:24:25 INFO - Writing to file /builds/slave/test/properties/build_url 23:24:25 INFO - Contents: 23:24:25 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468876917/firefox-48.0.en-US.mac.dmg 23:24:26 INFO - Running post-action listener: _resource_record_post_action 23:24:26 INFO - Running post-action listener: set_extra_try_arguments 23:24:26 INFO - ##### 23:24:26 INFO - ##### Running populate-webroot step. 23:24:26 INFO - ##### 23:24:26 INFO - Running pre-action listener: _resource_record_pre_action 23:24:26 INFO - Running main action method: populate_webroot 23:24:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:24:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:24:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:24:26 INFO - '--tppagecycles', 23:24:26 INFO - '7'], 23:24:26 INFO - 'tests': ['tsvgm']}}, 23:24:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:24:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:24:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:24:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:24:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:24:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:24:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:26 INFO - 'talos_options': ['--disable-e10s'], 23:24:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:24:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:24:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:26 INFO - 'talos_options': ['--disable-e10s'], 23:24:26 INFO - 'tests': ['damp', 'tps']}, 23:24:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:26 INFO - 'tests': ['damp', 'tps']}, 23:24:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:24:26 INFO - 'tests': ['dromaeo_dom']}, 23:24:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:24:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:24:26 INFO - 'tests': ['a11yr', 23:24:26 INFO - 'ts_paint', 23:24:26 INFO - 'tpaint', 23:24:26 INFO - 'sessionrestore', 23:24:26 INFO - 'sessionrestore_no_auto_restore', 23:24:26 INFO - 'tabpaint']}, 23:24:26 INFO - 'other-e10s': {'tests': ['a11yr', 23:24:26 INFO - 'ts_paint', 23:24:26 INFO - 'tpaint', 23:24:26 INFO - 'sessionrestore', 23:24:26 INFO - 'sessionrestore_no_auto_restore', 23:24:26 INFO - 'tabpaint']}, 23:24:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:24:26 INFO - 'ts_paint', 23:24:26 INFO - 'tpaint', 23:24:26 INFO - 'sessionrestore', 23:24:26 INFO - 'sessionrestore_no_auto_restore', 23:24:26 INFO - 'tabpaint']}, 23:24:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:24:26 INFO - 'ts_paint', 23:24:26 INFO - 'tpaint', 23:24:26 INFO - 'sessionrestore', 23:24:26 INFO - 'sessionrestore_no_auto_restore', 23:24:26 INFO - 'tabpaint']}, 23:24:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:24:26 INFO - 'tests': ['a11yr', 23:24:26 INFO - 'ts_paint', 23:24:26 INFO - 'tpaint', 23:24:26 INFO - 'sessionrestore', 23:24:26 INFO - 'sessionrestore_no_auto_restore', 23:24:26 INFO - 'tabpaint']}, 23:24:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:24:26 INFO - 'tests': ['a11yr', 23:24:26 INFO - 'ts_paint', 23:24:26 INFO - 'tpaint', 23:24:26 INFO - 'sessionrestore', 23:24:26 INFO - 'sessionrestore_no_auto_restore', 23:24:26 INFO - 'tabpaint']}, 23:24:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:24:26 INFO - 'tests': ['tsvgx', 23:24:26 INFO - 'tsvgr_opacity', 23:24:26 INFO - 'tart', 23:24:26 INFO - 'tscrollx', 23:24:26 INFO - 'cart']}, 23:24:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:24:26 INFO - 'tsvgr_opacity', 23:24:26 INFO - 'tart', 23:24:26 INFO - 'tscrollx', 23:24:26 INFO - 'cart']}, 23:24:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:26 INFO - 'talos_options': ['--disable-e10s'], 23:24:26 INFO - 'tests': ['tp5o']}, 23:24:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:26 INFO - 'tests': ['tp5o']}, 23:24:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:26 INFO - 'talos_options': ['--disable-e10s', 23:24:26 INFO - '--xperf_path', 23:24:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:24:26 INFO - 'tests': ['tp5n']}, 23:24:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:26 INFO - 'talos_options': ['--xperf_path', 23:24:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:24:26 INFO - 'tests': ['tp5n']}}, 23:24:26 INFO - 'talos.zip': {'path': '', 23:24:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:24:26 INFO - Running post-action listener: _resource_record_post_action 23:24:26 INFO - ##### 23:24:26 INFO - ##### Running create-virtualenv step. 23:24:26 INFO - ##### 23:24:26 INFO - Running pre-action listener: _resource_record_pre_action 23:24:26 INFO - Running main action method: create_virtualenv 23:24:26 INFO - Creating virtualenv /builds/slave/test/build/venv 23:24:26 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 23:24:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:24:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:24:26 INFO - Using real prefix '/tools/python27' 23:24:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:24:27 INFO - Installing distribute.............................................................................................................................................................................................done. 23:24:29 INFO - Installing pip.................done. 23:24:29 INFO - Return code: 0 23:24:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:24:29 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')]} 23:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:29 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')]} 23:24:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:29 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 0x102992a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029a2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8415c50e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102831e00>, '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 0x10269adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10282cb20>, '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.P9StSqlRz9/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.dNcfBoPn1I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 23:24:29 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 23:24:29 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 23:24:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P9StSqlRz9/Render', 23:24:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:24:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:24:29 INFO - 'HOME': '/Users/cltbld', 23:24:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:24:29 INFO - 'LOGNAME': 'cltbld', 23:24:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:29 INFO - 'MOZ_NO_REMOTE': '1', 23:24:29 INFO - 'NO_EM_RESTART': '1', 23:24:29 INFO - 'PAGER': '/bin/cat', 23:24:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:24:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:29 INFO - 'PWD': '/builds/slave/test', 23:24:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:24:29 INFO - 'SHELL': '/bin/bash', 23:24:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNcfBoPn1I/Listeners', 23:24:29 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 23:24:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:24:29 INFO - 'USER': 'cltbld', 23:24:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:24:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:24:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:29 INFO - 'XPC_FLAGS': '0x0', 23:24:29 INFO - 'XPC_SERVICE_NAME': '0', 23:24:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:30 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 23:24:30 INFO - Cleaning up... 23:24:30 INFO - Return code: 0 23:24:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:30 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 0x102992a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029a2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8415c50e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102831e00>, '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 0x10269adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10282cb20>, '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.P9StSqlRz9/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.dNcfBoPn1I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 23:24:30 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 23:24:30 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 23:24:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P9StSqlRz9/Render', 23:24:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:24:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:24:30 INFO - 'HOME': '/Users/cltbld', 23:24:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:24:30 INFO - 'LOGNAME': 'cltbld', 23:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:30 INFO - 'MOZ_NO_REMOTE': '1', 23:24:30 INFO - 'NO_EM_RESTART': '1', 23:24:30 INFO - 'PAGER': '/bin/cat', 23:24:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:30 INFO - 'PWD': '/builds/slave/test', 23:24:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:24:30 INFO - 'SHELL': '/bin/bash', 23:24:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNcfBoPn1I/Listeners', 23:24:30 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 23:24:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:24:30 INFO - 'USER': 'cltbld', 23:24:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:24:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:30 INFO - 'XPC_FLAGS': '0x0', 23:24:30 INFO - 'XPC_SERVICE_NAME': '0', 23:24:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:30 INFO - Downloading/unpacking psutil>=0.7.1 23:24:30 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 23:24:30 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 23:24:30 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 23:24:30 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 23:24:30 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 23:24:30 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 23:24:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:24:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:24:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:24:33 INFO - Installing collected packages: psutil 23:24:33 INFO - Running setup.py install for psutil 23:24:33 INFO - building 'psutil._psutil_osx' extension 23:24:33 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 23:24:34 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 23:24:34 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 23:24:34 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 23:24:34 INFO - building 'psutil._psutil_posix' extension 23:24:34 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 23:24:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:24:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:24:34 INFO - ^ 23:24:34 INFO - 1 warning generated. 23:24:34 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 23:24:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:24:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:24:35 INFO - Successfully installed psutil 23:24:35 INFO - Cleaning up... 23:24:35 INFO - Return code: 0 23:24:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:24:35 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')]} 23:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:35 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')]} 23:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:35 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 0x102992a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029a2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8415c50e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102831e00>, '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 0x10269adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10282cb20>, '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.P9StSqlRz9/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.dNcfBoPn1I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 23:24:35 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 23:24:35 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 23:24:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P9StSqlRz9/Render', 23:24:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:24:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:24:35 INFO - 'HOME': '/Users/cltbld', 23:24:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:24:35 INFO - 'LOGNAME': 'cltbld', 23:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:35 INFO - 'MOZ_NO_REMOTE': '1', 23:24:35 INFO - 'NO_EM_RESTART': '1', 23:24:35 INFO - 'PAGER': '/bin/cat', 23:24:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:35 INFO - 'PWD': '/builds/slave/test', 23:24:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:24:35 INFO - 'SHELL': '/bin/bash', 23:24:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNcfBoPn1I/Listeners', 23:24:35 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 23:24:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:24:35 INFO - 'USER': 'cltbld', 23:24:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:24:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:35 INFO - 'XPC_FLAGS': '0x0', 23:24:35 INFO - 'XPC_SERVICE_NAME': '0', 23:24:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:24:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:24:37 INFO - Installing collected packages: mozsystemmonitor 23:24:37 INFO - Running setup.py install for mozsystemmonitor 23:24:37 INFO - Successfully installed mozsystemmonitor 23:24:37 INFO - Cleaning up... 23:24:38 INFO - Return code: 0 23:24:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:24:38 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')]} 23:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:38 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')]} 23:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:38 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 0x102992a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029a2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8415c50e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102831e00>, '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 0x10269adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10282cb20>, '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.P9StSqlRz9/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.dNcfBoPn1I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 23:24:38 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 23:24:38 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 23:24:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P9StSqlRz9/Render', 23:24:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:24:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:24:38 INFO - 'HOME': '/Users/cltbld', 23:24:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:24:38 INFO - 'LOGNAME': 'cltbld', 23:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:38 INFO - 'MOZ_NO_REMOTE': '1', 23:24:38 INFO - 'NO_EM_RESTART': '1', 23:24:38 INFO - 'PAGER': '/bin/cat', 23:24:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:38 INFO - 'PWD': '/builds/slave/test', 23:24:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:24:38 INFO - 'SHELL': '/bin/bash', 23:24:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNcfBoPn1I/Listeners', 23:24:38 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 23:24:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:24:38 INFO - 'USER': 'cltbld', 23:24:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:24:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:38 INFO - 'XPC_FLAGS': '0x0', 23:24:38 INFO - 'XPC_SERVICE_NAME': '0', 23:24:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:38 INFO - Downloading/unpacking blobuploader==1.2.4 23:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:40 INFO - Downloading blobuploader-1.2.4.tar.gz 23:24:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:24:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:24:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:41 INFO - Downloading docopt-0.6.1.tar.gz 23:24:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:24:42 INFO - Installing collected packages: blobuploader, requests, docopt 23:24:42 INFO - Running setup.py install for blobuploader 23:24:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:24:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:24:42 INFO - Running setup.py install for requests 23:24:42 INFO - Running setup.py install for docopt 23:24:42 INFO - Successfully installed blobuploader requests docopt 23:24:42 INFO - Cleaning up... 23:24:42 INFO - Return code: 0 23:24:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:24:42 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')]} 23:24:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:42 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')]} 23:24:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:42 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 0x102992a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029a2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8415c50e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102831e00>, '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 0x10269adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10282cb20>, '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.P9StSqlRz9/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.dNcfBoPn1I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 23:24:42 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 23:24:42 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 23:24:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P9StSqlRz9/Render', 23:24:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:24:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:24:42 INFO - 'HOME': '/Users/cltbld', 23:24:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:24:42 INFO - 'LOGNAME': 'cltbld', 23:24:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:42 INFO - 'MOZ_NO_REMOTE': '1', 23:24:42 INFO - 'NO_EM_RESTART': '1', 23:24:42 INFO - 'PAGER': '/bin/cat', 23:24:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:24:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:42 INFO - 'PWD': '/builds/slave/test', 23:24:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:24:42 INFO - 'SHELL': '/bin/bash', 23:24:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNcfBoPn1I/Listeners', 23:24:42 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 23:24:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:24:42 INFO - 'USER': 'cltbld', 23:24:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:24:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:24:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:42 INFO - 'XPC_FLAGS': '0x0', 23:24:42 INFO - 'XPC_SERVICE_NAME': '0', 23:24:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:24:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:24:43 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-mOTPAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:24:43 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-rjQ9r7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:24:43 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-hhV0XT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:24:43 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-tInntS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:24:43 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-CSOqcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:24:43 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-L2WDF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:24:43 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-JK7rV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:24:43 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-dKdv9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:24:43 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-_0f9dZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:24:44 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-vHFssN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:24:44 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-gHKFSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:24:44 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-yJo1UQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:24:44 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-hBAeKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:24:44 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-iqzkim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:24:44 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-8EWTW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:24:44 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-XtjnYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:24:44 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-tL3bMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:24:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:24:44 INFO - Running setup.py install for manifestparser 23:24:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:24:45 INFO - Running setup.py install for mozcrash 23:24:45 INFO - Running setup.py install for mozdebug 23:24:45 INFO - Running setup.py install for mozdevice 23:24:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:24:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:24:45 INFO - Running setup.py install for mozfile 23:24:45 INFO - Running setup.py install for mozhttpd 23:24:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:24:45 INFO - Running setup.py install for mozinfo 23:24:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:24:45 INFO - Running setup.py install for mozInstall 23:24:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:24:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:24:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:24:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:24:46 INFO - Running setup.py install for mozleak 23:24:46 INFO - Running setup.py install for mozlog 23:24:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:24:46 INFO - Running setup.py install for moznetwork 23:24:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:24:46 INFO - Running setup.py install for mozprocess 23:24:46 INFO - Running setup.py install for mozprofile 23:24:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:24:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:24:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:24:46 INFO - Running setup.py install for mozrunner 23:24:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:24:47 INFO - Running setup.py install for mozscreenshot 23:24:47 INFO - Running setup.py install for moztest 23:24:47 INFO - Running setup.py install for mozversion 23:24:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:24:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:24:47 INFO - Cleaning up... 23:24:47 INFO - Return code: 0 23:24:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:24:47 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')]} 23:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:47 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')]} 23:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:47 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 0x102992a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029a2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8415c50e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102831e00>, '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 0x10269adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10282cb20>, '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.P9StSqlRz9/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.dNcfBoPn1I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 23:24:47 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 23:24:47 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 23:24:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P9StSqlRz9/Render', 23:24:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:24:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:24:47 INFO - 'HOME': '/Users/cltbld', 23:24:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:24:47 INFO - 'LOGNAME': 'cltbld', 23:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:47 INFO - 'MOZ_NO_REMOTE': '1', 23:24:47 INFO - 'NO_EM_RESTART': '1', 23:24:47 INFO - 'PAGER': '/bin/cat', 23:24:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:47 INFO - 'PWD': '/builds/slave/test', 23:24:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:24:47 INFO - 'SHELL': '/bin/bash', 23:24:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNcfBoPn1I/Listeners', 23:24:47 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 23:24:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:24:47 INFO - 'USER': 'cltbld', 23:24:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:24:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:47 INFO - 'XPC_FLAGS': '0x0', 23:24:47 INFO - 'XPC_SERVICE_NAME': '0', 23:24:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:24:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:24:47 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-pnht0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:24:47 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)) 23:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:24:47 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-3ugi9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:24:47 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)) 23:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:24:47 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-rNaTW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:24:48 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)) 23:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:24:48 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-PYiHZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:24:48 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)) 23:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:24:48 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-xAw7_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:24:48 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)) 23:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:24:48 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-BdzoIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:24:48 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)) 23:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:24:48 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-tY2YTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:24:48 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)) 23:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:24:48 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-qaRf5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:24:48 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)) 23:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:24:48 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-TMT0QW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:24:48 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)) 23:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:24:48 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-8qzCoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:24:48 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)) 23:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:24:48 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-dKbvTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:24:48 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)) 23:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:24:48 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-fL05c4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:24:49 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)) 23:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:24:49 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-mL3QDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:24:49 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)) 23:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:24:49 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-JLcVIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:24:49 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)) 23:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:24:49 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-ZZSD30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:24:49 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)) 23:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:24:49 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-BHPNz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:24:49 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)) 23:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:24:49 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-Za5J5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:24:49 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)) 23:24:49 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)) 23:24:49 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)) 23:24:49 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)) 23:24:49 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)) 23:24:49 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)) 23:24:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:52 INFO - Downloading blessings-1.6.tar.gz 23:24:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:24:52 INFO - Installing collected packages: blessings 23:24:52 INFO - Running setup.py install for blessings 23:24:52 INFO - Successfully installed blessings 23:24:52 INFO - Cleaning up... 23:24:52 INFO - Return code: 0 23:24:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:24:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:24:52 INFO - Reading from file tmpfile_stdout 23:24:52 INFO - Current package versions: 23:24:52 INFO - blessings == 1.6 23:24:52 INFO - blobuploader == 1.2.4 23:24:52 INFO - docopt == 0.6.1 23:24:52 INFO - manifestparser == 1.1 23:24:52 INFO - mozInstall == 1.12 23:24:52 INFO - mozcrash == 0.17 23:24:52 INFO - mozdebug == 0.1 23:24:52 INFO - mozdevice == 0.48 23:24:52 INFO - mozfile == 1.2 23:24:52 INFO - mozhttpd == 0.7 23:24:52 INFO - mozinfo == 0.9 23:24:52 INFO - mozleak == 0.1 23:24:52 INFO - mozlog == 3.1 23:24:52 INFO - moznetwork == 0.27 23:24:52 INFO - mozprocess == 0.22 23:24:52 INFO - mozprofile == 0.28 23:24:52 INFO - mozrunner == 6.11 23:24:52 INFO - mozscreenshot == 0.1 23:24:52 INFO - mozsystemmonitor == 0.0 23:24:52 INFO - moztest == 0.7 23:24:52 INFO - mozversion == 1.4 23:24:52 INFO - psutil == 3.1.1 23:24:52 INFO - requests == 1.2.3 23:24:52 INFO - wsgiref == 0.1.2 23:24:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:52 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 0x102992a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029a2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8415c50e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102831e00>, '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 0x10269adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10282cb20>, '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.P9StSqlRz9/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.dNcfBoPn1I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 23:24:52 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 23:24:52 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 23:24:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P9StSqlRz9/Render', 23:24:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:24:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:24:52 INFO - 'HOME': '/Users/cltbld', 23:24:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:24:52 INFO - 'LOGNAME': 'cltbld', 23:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:52 INFO - 'MOZ_NO_REMOTE': '1', 23:24:52 INFO - 'NO_EM_RESTART': '1', 23:24:52 INFO - 'PAGER': '/bin/cat', 23:24:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:52 INFO - 'PWD': '/builds/slave/test', 23:24:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:24:52 INFO - 'SHELL': '/bin/bash', 23:24:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNcfBoPn1I/Listeners', 23:24:52 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 23:24:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:24:52 INFO - 'USER': 'cltbld', 23:24:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:24:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:52 INFO - 'XPC_FLAGS': '0x0', 23:24:52 INFO - 'XPC_SERVICE_NAME': '0', 23:24:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:52 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)) 23:24:52 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)) 23:24:52 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)) 23:24:52 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)) 23:24:52 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)) 23:24:52 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)) 23:24:52 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)) 23:24:52 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)) 23:24:52 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)) 23:24:52 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)) 23:24:52 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)) 23:24:52 INFO - Cleaning up... 23:24:52 INFO - Return code: 0 23:24:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102992a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029a2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8415c50e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102831e00>, '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 0x10269adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10282cb20>, '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.P9StSqlRz9/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.dNcfBoPn1I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 23:24:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:24:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P9StSqlRz9/Render', 23:24:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:24:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:24:52 INFO - 'HOME': '/Users/cltbld', 23:24:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:24:52 INFO - 'LOGNAME': 'cltbld', 23:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:52 INFO - 'MOZ_NO_REMOTE': '1', 23:24:52 INFO - 'NO_EM_RESTART': '1', 23:24:52 INFO - 'PAGER': '/bin/cat', 23:24:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:52 INFO - 'PWD': '/builds/slave/test', 23:24:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:24:52 INFO - 'SHELL': '/bin/bash', 23:24:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNcfBoPn1I/Listeners', 23:24:52 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 23:24:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:24:52 INFO - 'USER': 'cltbld', 23:24:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:24:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:52 INFO - 'XPC_FLAGS': '0x0', 23:24:52 INFO - 'XPC_SERVICE_NAME': '0', 23:24:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:53 INFO - Downloading/unpacking jsonschema 23:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:24:55 INFO - Downloading/unpacking functools32 (from jsonschema) 23:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:56 INFO - Downloading functools32-3.2.3-2.tar.gz 23:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:24:56 INFO - warning: no files found matching '*.txt' 23:24:56 INFO - no previously-included directories found matching 'build' 23:24:56 INFO - no previously-included directories found matching 'dist' 23:24:56 INFO - no previously-included directories found matching '.git*' 23:24:56 INFO - Installing collected packages: jsonschema, functools32 23:24:56 INFO - Running setup.py install for functools32 23:24:56 INFO - warning: no files found matching '*.txt' 23:24:56 INFO - no previously-included directories found matching 'build' 23:24:56 INFO - no previously-included directories found matching 'dist' 23:24:56 INFO - no previously-included directories found matching '.git*' 23:24:56 INFO - Successfully installed jsonschema functools32 23:24:56 INFO - Cleaning up... 23:24:56 INFO - Return code: 0 23:24:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:56 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 0x102992a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029a2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8415c50e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102831e00>, '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 0x10269adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10282cb20>, '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.P9StSqlRz9/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.dNcfBoPn1I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 23:24:56 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 23:24:56 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 23:24:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P9StSqlRz9/Render', 23:24:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:24:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:24:56 INFO - 'HOME': '/Users/cltbld', 23:24:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:24:56 INFO - 'LOGNAME': 'cltbld', 23:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:56 INFO - 'MOZ_NO_REMOTE': '1', 23:24:56 INFO - 'NO_EM_RESTART': '1', 23:24:56 INFO - 'PAGER': '/bin/cat', 23:24:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:56 INFO - 'PWD': '/builds/slave/test', 23:24:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:24:56 INFO - 'SHELL': '/bin/bash', 23:24:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNcfBoPn1I/Listeners', 23:24:56 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 23:24:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:24:56 INFO - 'USER': 'cltbld', 23:24:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:24:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:56 INFO - 'XPC_FLAGS': '0x0', 23:24:56 INFO - 'XPC_SERVICE_NAME': '0', 23:24:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:56 INFO - Downloading/unpacking flake8 23:24: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 23:24: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 23:24: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 23:24: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 23:24: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 23:24: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 23:24:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:24:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:24:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:25:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:25:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:25:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:25:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:25:00 INFO - no previously-included directories found matching 'docs/_build' 23:25:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:25:00 INFO - Running setup.py install for pep8 23:25:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:25:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:25:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:25:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:25:00 INFO - no previously-included directories found matching 'docs/_build' 23:25:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:25:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:25:00 INFO - Cleaning up... 23:25:00 INFO - Return code: 0 23:25:00 INFO - Running post-action listener: _resource_record_post_action 23:25:00 INFO - Running post-action listener: _start_resource_monitoring 23:25:00 INFO - Starting resource monitoring. 23:25:00 INFO - ##### 23:25:00 INFO - ##### Running install step. 23:25:00 INFO - ##### 23:25:00 INFO - Running pre-action listener: _resource_record_pre_action 23:25:00 INFO - Running main action method: install 23:25:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:25:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:25:01 INFO - Reading from file tmpfile_stdout 23:25:01 INFO - Detecting whether we're running mozinstall >=1.0... 23:25:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:25:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:25:01 INFO - Reading from file tmpfile_stdout 23:25:01 INFO - Output received: 23:25:01 INFO - Usage: mozinstall [options] installer 23:25:01 INFO - Options: 23:25:01 INFO - -h, --help show this help message and exit 23:25:01 INFO - -d DEST, --destination=DEST 23:25:01 INFO - Directory to install application into. [default: 23:25:01 INFO - "/builds/slave/test"] 23:25:01 INFO - --app=APP Application being installed. [default: firefox] 23:25:01 INFO - mkdir: /builds/slave/test/build/application 23:25:01 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'] 23:25:01 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 23:25:23 INFO - Reading from file tmpfile_stdout 23:25:23 INFO - Output received: 23:25:23 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 23:25:23 INFO - Running post-action listener: _resource_record_post_action 23:25:23 INFO - ##### 23:25:23 INFO - ##### Running run-tests step. 23:25:23 INFO - ##### 23:25:23 INFO - Running pre-action listener: _resource_record_pre_action 23:25:23 INFO - Running main action method: run_tests 23:25:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:25:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:25:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:25:23 INFO - 2016-07-18 23:25:23.030 screenresolution[1638:7543] starting screenresolution argv=screenresolution get 23:25:23 INFO - 2016-07-18 23:25:23.032 screenresolution[1638:7543] Display 0: 1600x1200x32@60 23:25:23 INFO - 2016-07-18 23:25:23.038 screenresolution[1639:7545] starting screenresolution argv=screenresolution list 23:25:23 INFO - Available Modes on Display 0 23:25:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:25:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:25:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:25:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:25:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:25:23 INFO - Intel Iris: 23:25:23 INFO - Chipset Model: Intel Iris 23:25:23 INFO - Type: GPU 23:25:23 INFO - Bus: Built-In 23:25:23 INFO - VRAM (Dynamic, Max): 1536 MB 23:25:23 INFO - Vendor: Intel (0x8086) 23:25:23 INFO - Device ID: 0x0a2e 23:25:23 INFO - Revision ID: 0x0009 23:25:23 INFO - Displays: 23:25:23 INFO - Display: 23:25:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:25:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:25:23 INFO - Display Serial Number: 1600x1200 60 23:25:23 INFO - Main Display: Yes 23:25:23 INFO - Mirror: Off 23:25:23 INFO - Online: Yes 23:25:23 INFO - Rotation: Supported 23:25:23 INFO - Return code: 0 23:25:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:25:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:25:23 INFO - Python 2.7.3 23:25:23 INFO - Return code: 0 23:25:23 INFO - grabbing minidump binary from tooltool 23:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:23 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 0x102831e00>, '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 0x10269adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10282cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:25:23 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 23:25:23 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 23:25:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:25:23 INFO - Return code: 0 23:25:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:25:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:25:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:25:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:25:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:25:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:25:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:25:24 INFO - Return code: 0 23:25:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468876917/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0080', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 23:25:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468876917/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0080 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 23:25:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P9StSqlRz9/Render', 23:25:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:25:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:25:24 INFO - 'HOME': '/Users/cltbld', 23:25:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:25:24 INFO - 'LOGNAME': 'cltbld', 23:25:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:25:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:25:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:24 INFO - 'MOZ_NO_REMOTE': '1', 23:25:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:25:24 INFO - 'NO_EM_RESTART': '1', 23:25:24 INFO - 'PAGER': '/bin/cat', 23:25:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:25:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:24 INFO - 'PWD': '/builds/slave/test', 23:25:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:25:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:25:24 INFO - 'SHELL': '/bin/bash', 23:25:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNcfBoPn1I/Listeners', 23:25:24 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 23:25:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:25:24 INFO - 'USER': 'cltbld', 23:25:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:25:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:25:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:24 INFO - 'XPC_FLAGS': '0x0', 23:25:24 INFO - 'XPC_SERVICE_NAME': '0', 23:25:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:25:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468876917/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0080', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 23:25:24 INFO - mozversion application_buildid: 20160718142157 23:25:24 INFO - mozversion application_changeset: d2ab9c39bd1059d74acb3d9ac87dbfbba913427b 23:25:24 INFO - mozversion application_display_name: Firefox 23:25:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:25:24 INFO - mozversion application_name: Firefox 23:25:24 INFO - mozversion application_remotingname: firefox 23:25:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 23:25:24 INFO - mozversion application_vendor: Mozilla 23:25:24 INFO - mozversion application_version: 48.0 23:25:24 INFO - mozversion platform_buildid: 20160718142157 23:25:24 INFO - mozversion platform_changeset: d2ab9c39bd1059d74acb3d9ac87dbfbba913427b 23:25:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 23:25:24 INFO - mozversion platform_version: 48.0 23:25:24 INFO - using testdate: 1468909524 23:25:24 INFO - actual date: 1468909524 23:25:24 INFO - starting webserver on 'localhost:49277' 23:25:24 INFO - SUITE-START | Running 2 tests 23:25:24 INFO - TEST-START | dromaeo_css 23:25:24 INFO - operating with platform_type : mac_ 23:25:24 INFO - Initialising browser for dromaeo_css test... 23:25:24 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/tmpYEp9JR/profile http://localhost:49277/getInfo.html) 23:25:26 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 23:25:26 INFO - PROCESS | 1657 | colorDepth:24 23:25:26 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 23:25:26 INFO - PROCESS | 1657 | __metrics 23:25:26 INFO - PROCESS | 1657 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:25:26 ERROR - PROCESS | 1657 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:25:27 INFO - TEST-INFO | 1657: exit 0 23:25:27 INFO - Browser initialized. 23:25:27 INFO - Running cycle 1/1 for dromaeo_css test... 23:25:27 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/tmpYEp9JR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:25:39 INFO - PROCESS | 1660 | RSS: Main: 160575488 23:25:39 INFO - PROCESS | 1660 | 23:26:30 INFO - PROCESS | 1660 | 1468909590793 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] 23:28:40 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 23:28:42 INFO - PROCESS | 1660 | RSS: Main: 339894272 23:28:42 INFO - PROCESS | 1660 | 23:31:45 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 23:31:46 INFO - PROCESS | 1660 | RSS: Main: 307466240 23:31:46 INFO - PROCESS | 1660 | 23:34:48 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 23:34:48 INFO - PROCESS | 1660 | RSS: Main: 310083584 23:34:48 INFO - PROCESS | 1660 | 23:37:50 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 23:37:51 INFO - PROCESS | 1660 | RSS: Main: 309534720 23:37:51 INFO - PROCESS | 1660 | 23:40:54 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 23:40:55 INFO - PROCESS | 1660 | RSS: Main: 271851520 23:40:55 INFO - PROCESS | 1660 | 23:43:57 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 23:43:58 INFO - PROCESS | 1660 | RSS: Main: 315396096 23:43:58 INFO - PROCESS | 1660 | 23:43:58 INFO - PROCESS | 1660 | __start_tp_report 23:43:58 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 23:43:58 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 23:43:58 INFO - PROCESS | 1660 | |i|pagename|runs| 23:43:58 INFO - PROCESS | 1660 | |0;dojo.html;3483.460063690128;3580.6061333253347;3587.1570181007473;3604.8377822997945;3674.9448758268613;5940.821775346736;5949.6727679977585;5962.165296858443;5970.761169553218;6030.577859549839;5944.0192368259295;5974.13375060617;5991.101334799782;6009.369016253296;6016.608920420181;5250.422453530108;5317.8936421271555;5376.731163441832;5381.81163659272;5421.674699518042;5362;5414.43148469411;5424.213489044087;5432.592555558329;5455.236266922614;5293.68237905725;5345.33183352081;5355.410904800468;5360.678359298435;5474.562035037207;5400.594955378362;5413.593980451482;5427.83716488506;5428.511433970922;5499.752511137009;5220.738963051832;5275.525202731734;5351.491608297206;5361.222622719683;5372.785088596452;5782.045962416196;5785.2768403949085;5865.941340586625;5869.413058694096;5881.67650779207;6244.188255526798;6245.156903818017;6271.6864156792435;6289.0252010938375;6300.4329610334835;6213.689315534205;6272.435480806749;6287.559870809046;6339.936600633981;6358.841028974266;6054.182685337467;6063.617796285892;6075.3111392328965;6076.453119219247;6106.877862442815;6388.648624325614;6405.615663060231;6423.293437721847;6423.775167869102;6438.130852334969;6188.226471691039;6218.284897236876;6316.147320111726;6341.397567231105;6347.460465860361;6309.842253943596;6317.020861766434;6321.020241862519;6326.177596912464;6341.682915854189;6182.783602573888;6244.625322480666;6251.718672659741;6263.248410190807;6267;6237.532185086136;6256.937430625636;6305.085762564402;6310.5267104967315;6340.873182536324;5010;5023.748812559357;5052.69683818972;5052.72210028452;5057.797688092435;3937.7243592948794;4030.4760381150263;4524.09518096382;4572.382728331632;4642.001969576557;6058.697065146813;6082.787102451482;6087.66517841523;6096.512279017668;6103.176071230416;6218.160548326008;6313.305536390993;6342.112104305401;6381.521385896076;6403.775867844603;6036.366181550961;6068.241469816273;6092.116643086728;6107.4197951194565;6108.694565271719;5602.887942241132;5608.242887210256;5618.831435056954;5619.072852979212;5620.269364982526;6376.458001069868;6453.645049522322;6459.321771214143;6469.320721324193;6479.8056058318325;6289.308176100717;6357.618542887441;6370;6374.713137908712;6379.170707807955;6505.2518960318275;6522.478201743944;6530.706118224786;6557.147570815763;6561.048647945926;6188.44304012641;6220.0047992321015;6279.246490421178;6293.937060629335;6296.212973378328;6209.565330427007;6239.188905442264;6266.843328916631;6271.529635277464;6272.686365681607;5179.689218646893;6215.906761398673;6217.689115544295;6234.251889773256;6237.563370564017;6186.536009799193;6239.844003899757;6246.063090536274;6246.3441338660605;6248.156498872776;5255.395629502656;6077.787277445268;6208.9689551551955;6211.813645590459;6222.439980401786;6095.177151084724;6127.693615319127;6135.171751813448;6139.461473530676;6168.383161683796;6104.32852386246;6175.228096487939;6181.320054794059;6236.407541283571;6275.152854364603 23:43:58 INFO - PROCESS | 1660 | |1;ext.html;539.0808671215577;552.9852720258326;594.165197896955;600.684640563704;605.8576234584874;27020.18939431818;30383.240418989535;33047.83476082619;39059.80470097649;40181.19637607246;43311.78344108283;43743;43759;43943.340849887194;43979;9560.856587151198;9782.168515676176;9786.755331116708;9797.363171393872;9799.069088436587;9158.450492970444;10786.838197427045;11987.460564274628;11991.460384282685;12011.339376334297;11682.649520514356;11766.235194712359;11768.235064720766;11780.116491263147;11790.469428875722;11574.942125289363;11739.413029348583;11749.706257343549;11750.648675402354;11779.411029448493;11614.419279036014;11738.295702257892;11744.941275293655;11748.941255293754;11749.471273792615;41554;42091;42160.78919605413;42174.73475795731;42280;3296.8516416761063;3357.9664203357897;3399.3711163434846;3493.2838768052743;3558.7864728116137;28099;28592.857035714896;30224.395512089854;30486.695133048608;30637.693623063707;2484.6391891285875;2634.4360551873147;2763.709810469912;2770.8476033818133;2896.4496745618267;527266.3636681831;528597;528765;529312;530103;36974;63478.778242761284;63740;64124;64315.03527447092;36220;36350.09124771849;36414.27171456556;36417.27165456676;36428.45357319642;14512.346944387527;16094.436694715863;16437.67124657524;16449.58876028085;16451.095189764437;13111.803322950163;13245.602631920865;13283.20300781937;13395.464181432633;13843.030987830956;8393.790155246168;8417.200365965224;8418.116097809765;8496.575171241413;8508.404411691246;3069.0971597609177;3472.9754722356965;3510.087377281925;3510.613832478425;3545.025118092545;984.1339621133357;1030.701096681954;1082.680609220282;1110.7947876553867;1148.024179447463;26109.738902611112;30311;30470.84764576207;30901.963893693148;31961.84019079936;1156.1675593572613;1173.284296579086;1236.5610208376077;1256.3153081570565;1267.454994352419;15420.614484637974;15573.610659733371;15671.68656626884;15788.368465261261;15981.760273595906;631937;640501;647971;648999;650238;62766;63292.68353658295;63382.049269261;63417.048744268875;63475.047874281925;1448.6957738874744;1539.776732373822;1582.1535478519168;1598;1604.254021879785;25044.123455678964;28736.137915862557;28876.844926203557;29585.26036849096;30204.5469317956;46914.76542617265;47536.7623161882;47537.52462475331;47623.761881190374;48603.5139648599;362761;365753;366751;366900.82045486686;367571;23521.529569408172;24002.639960400957;27304.54259116689;27850.025249116185;28232;43703.78148109239;44199.558004419545;44232;44443.555564443945;44889.551104488535;34614.653853461146;35545.466817997236;36423.81788091043;37073.814630926674;37173.442398363506;37867.431988520744;38846.80576597099;38948.41577376285;39018;42419.363709544996;37098.07254818651;37567;37754.8112259437;38720.41919371268;38883.80558097304;27957;33434.49848252229;33528;34471.82764086164;34503.309933801684;20958;24095.879520602284;24358.756412436356;24396.51206975886;24860.875695621406 23:43:58 INFO - PROCESS | 1660 | |2;jquery.html;413.1983951134798;417.12612077697213;417.32393522493567;418.4998926283091;430.79321925475773;20282.492937676565;20899.059542320592;20939.68590471144;21195.364139075813;22297.66553501699;20682.48293792656;20897.955102244865;21604.910791573322;21787.23744668937;21887;5441.59188060895;5767;5768.3654797972185;5768.82693519193;5776.306843178803;4231.915361692764;4457.732536047832;5572.108462645978;5781.450762177607;5945.732442040097;6223.471004964561;6226.906596401035;6228.844278893019;6243.594166379194;6244.875102497947;6242.18851549298;6353.587016843913;6637.800865974028;6842.863142737117;6843.486738494608;4084.326086195774;5787;6077.118817771398;6084.209052823149;6094.299155597118;13989.3704783285;14086.084404513675;14109.365078571489;14143.575692729235;24910.626340604904;2353.7410884802657;2469.506098780233;2588.8835002424935;2597.6493173421723;2796.8601569921625;10288.228382871315;10513.106385957202;10582.634368583782;13232.603021909357;14705.70588588233;1765.4527096600095;1769.938052168168;1796.4161647464625;1865.2445759467437;1890.461218552706;104323.99999999924;112316.92076980755;114749.81943164537;132346.33826830806;134573;9468.5323774815;11709.88290117105;11799.646010619696;11835.526578936919;12093.45579448927;12598.307093109966;15814.60463488422;15874.841251587337;15910.363585456684;15927.044377337164;9066.592003359865;9170.403923744936;9190;9209.95395023034;9275.443473391619;9466.952665236768;9488.525573721425;9510.524473776284;9519.809603807886;9542.61829526825;3968.900777480528;4838.177509823338;4859.781309841065;4862.343583616237;4898.216285394391;1662.9002259864446;1779.9251117284696;1951;2032.7459067616549;2039;859.832332695131;963.6723514005272;1004.8542961270575;1023.1967905194387;1045.8065257927308;19617.21531138767;20571.868547229747;20974.0561674725;21128.683069753966;21241.893790531256;996.875390576178;1007.6372505897871;1032.70051685012;1033.3593172233263;1057.5241141486208;8938.4190027648;10836.891631083588;11053.226274160732;11069.114470842313;11087.50106245221;641453;651669.7416512887;661580;664996;667398;118224;124014.75985240033;128793;130943;137493;1041.6250149946013;1055.4353420919772;1058.9788204235872;1062.3678911047914;1080.1143062688677;17895.910520447316;18099.457016289532;18182.09089545491;18344.449666510027;18658.906705466386;53964;54305;55653.72173139108;57128.28615141552;57136.857262855345;54470.72764636151;82195;82994;83580.16419835723;83814.58092709497;8031.357491400557;8154.75535733929;8341.16588341161;8712.041675415572;8820.2061814437;12722.109452338247;12894.419751111034;13072.607821765363;13150.408231629408;13424.194548327132;5719.971400142973;8686.739397818075;8949.686760963335;11484.253523520945;11635.301881887113;11010.119190464904;11173.776524469302;11354;11401.657950261506;11512.94243528777;8821.64713411482;11649;11682;11696.642685851455;11977.700557486132;8449.366297527587;8518.403711740119;8560.186782255676;8561.315094792526;8822.33832462555;11263.324200547993;11488.94255528717;11696.35670038122;11743.823842642196;11878.168528202943 23:43:58 INFO - PROCESS | 1660 | |3;mootools.html;1358.4973559782882;1556.0741358891455;1619.7489389144682;1797.2990533691861;2053.804888535589;8216.753497395073;8802.07578204289;8956.32827537934;8978.371513994023;8982.326325525595;8692.391532592721;8991.325650576217;9011.41425807322;9012.279017678586;9021.142991415822;2526.861022643754;2553.310606136342;2554.2081954594137;2558.1941688368197;2567.242663414288;2478.4175718706088;2545.847249165047;2552.081250749738;2557.3223095879607;2567.306827156676;2521.180616299701;2553.1957433408415;2560.334313078604;2566.935826604331;2571.0744132112422;2163.4050636075126;2486.490269494758;2543.5167318209574;2564.666593342872;2565.743425657438;2500.6499090127395;2538.961915571268;2539.21284401836;2553.553128202557;2558.9360265993314;8775.210231079234;8997.685081022199;9085.000649928503;9122.270218382513;9123.863142052875;5627.915581266284;5788.942110578924;5789.247397838296;5848.385919478478;5881.382454842223;3660.5790334111384;3742.6631603155574;3765.962340376616;3796.2787070456525;3800.714946379005;1045.4406892312577;1056.514003558364;1057.8466122412208;1091.1979694924225;1097.040089921319;10867.565297388095;11982.101342399355;12590.81113783294;12603.747925041447;12618.68453288666;4819.132556139858;4863.9513604864205;4884.633652476078;4895.951040489621;4940.580050695731;9739.318247722591;9750.756231094138;9763.316567840184;9779.022097790306;9800;4783.808647654055;5620.437956204429;5654.802081927113;5657.179708942181;5660.971695141498;4650.697704649187;4805.7597120143855;5074.2642316864585;5190.221466779938;5264.131418315935;4004.1190937993597;4013.9397909031386;4090.1206240658403;4108.589141085868;4124.360724087771;1271.1419791640606;1280.2318608834626;1280.257450678604;1288.4008935844877;1296.125115547002;761.1665226576889;832.5046597274612;920.1350730313484;925.9397989302346;986.3194395866828;5693.715314234271;5846.619969701956;6021.5182785377065;6076.392360763888;6169.198004259418;889.9199072083544;957.6408846682494;1002.7643503776607;1017.9287449878585;1019.6838979916249;3292.423825830518;4056.371262454324;4074.409210664437;4113.197926404322;4138.979305103455;10736.355818650905;11365.602203922823;11371.43142842871;11491.655250342503;11520;11186.832197517044;11201.831972520418;11360.829587556193;11370.431478426046;11372.886271137348;8665.306775457948;8705.782355441164;8768.824623507495;8773.561321933877;8853.601587928559;5667.4332566743;5944.613600115978;5999.460048595647;6011.128386384037;6052.576319657582;9934.155596774355;9995.400275983464;10021.949890250502;10170.694879153638;10230.437325946847;9211.940626828;9219.631214751334;10468.528916198637;10637.202209834139;10663.946680266548;6486;6959.826004349932;7169.641517924188;7325.816854578678;7332.450066244946;8421.284190843848;8479.660813567634;8483.194096560817;8498.70254541088;8524.872126917977;7482.551046937201;7520.473566850268;7543.886841697269;7589.582572958319;7720.922790772245;7405.370543503863;7454.068241469817;7454.850902982019;7576.886346704914;7583;7148.213696493278;7168.211496735459;7184.173820010766;7202.423806095395;7220.89168662481;4946.480619534897;4966.419494170167;5071.527296133472;5151.613628977767;5169.224616307433;5051.141305978066;5131.179011358314;5166.870828229325;5211.5049070338255;5313.229581710708 23:43:58 INFO - PROCESS | 1660 | |4;prototype.html;327.7590970636583;332.4531146264395;341.41447417678677;343.7370411635098;344.6691176470588;6287.7799277025315;6455.483561315095;6518.608883466995;6539.705713242904;6609.900851487231;4542.477615074267;6358.109864618946;6475.417212450879;6494.642794646293;6502.5773324733855;4873.465797785149;4923.876903077434;4926.655134140611;4930.087933732253;4962.851114466554;4679.953200468003;4764.285357196413;4924.630652701062;4937.382827146606;4956.5043495650325;4862.586680132193;4875.00062487191;4879.804807807701;4916.754162291889;4939.876503087416;4865.44047434546;4882.975585122052;4884.5848102911295;4886.902261954777;4891.730954797485;4203.453551038346;4224.852130175429;4234.407182994383;4240.109576988836;4240.194363071007;6296.244450665904;6346.9055211780005;6351.491880649537;6376;6376.585521941059;4716.434027916637;4971.975140124277;5013.7966887947;5822.010258256107;5825.126231065332;6536.117624120778;7033.788986330367;7072.292770722886;7073.752418665322;7080.256573059806;4601.3558101865765;4610.054938737584;4610.101030299093;4612.515685852971;4630.351750754897;7334.229905859861;7450.850982980364;7455.627218639101;7485.550866947946;7487.513311634781;4638.698484598491;4647.512011238839;4658.557437043475;4661.440627124767;4676.134915040729;4566.907273736823;4569.29175977724;4716.127516409475;4722.409698787652;4727.763611819395;4707.552782485658;4809.182438985381;5406.729663516887;5597.524210442077;5609.5792815539;7068.858622827514;7093.787186384417;7096.680649370791;7099.148102227766;7105.964470177616;1300.811382349573;1554.8367421420814;1592;1599.176424141568;1627.7395616701508;1029.5933106423072;1037.0666400239845;1046.8743750749807;1050.3540322701483;1051.332403923514;6410.102585638015;6519.380658837403;6525.869482610321;6547.443467305237;6556.475481961432;7291.489595728248;7291.489595728354;7294.525855819461;7300;7302.014228079248;6490.707918143695;6509.707063182168;6514.1531600891585;6526.412622863965;6537.5750576212395;3806.42903564462;3816.1795214029116;3819.598942111094;3823.1780167264174;3824.2351529694174;7263.709451621876;7546.169921308651;7606;7606.163322034572;7631.198724133997;7379.262073792578;7387.150477695134;7388.408927285805;7401.407887368998;7429.2570742926355;7579.1662917079075;7579.924200758032;7580.982079497875;7588.924110758932;7605.961970190225;6845.178578570603;7198.856022879409;7230.49386542958;7241.891371629325;7257.346838784535;7058.11773528309;7106.289371062852;7131.714731410893;7149.963255327844;7176.031235783103;7490.02629658141;7502.774916752506;7505.812354691177;7570.205128461653;7603.125640551408;4671.649626277975;4675;4679.368285281444;4682.882927926829;4688.460827004802;6967.268436814062;7034.753783617549;7183.03029091066;7215.350618444365;7228.277172282729;6240.219972503437;6815.625140617313;6971.755988540377;6976.5814051157095;6979.755708550177;6956.79129626112;6981.441484681111;7065;7072.9646351767915;7099.538529995534;6916.723331066701;6916.792496225121;6919.342662447059;6930.27232140618;6940.236573976959;6861.862762744618;7070.717171313296;7097.183823860116;7099.396551293198;7109.502334836512;6891.724331026903;6935.237123916264;6938.132733408324;6941.097657304518;6943.826404339932 23:43:58 INFO - PROCESS | 1660 | |5;yui.html;662.2218892800958;702.5293053654051;717.634006656605;751.7030772844727;779.1585088104847;15599.220038998048;15800;15809.841901580981;15812.367505299775;15828.129452880086;14480.855191448083;14551.199684017374;14608.780868286984;14630.41478340865;14635.780463293033;777.3897490469982;789.8064974081358;950.6387572722356;954.3367359685021;965.8696076029717;949.9002604726508;952.176367442161;958.6261358070358;958.7315551645551;959.0457494792691;1019.1031891935124;1024.7591815923251;1025.2874252394552;1027.3271007490107;1029.2743615750915;819.5533434278303;1008.2236677758121;1012.2003617142449;1032.4940779018302;1035.8498017787454;707.4022451028873;721.9819504512377;771.4561234329784;772.6754762999553;774.1407038187607;15230;15329.080255184725;15336.079835209923;15347.309371078329;15357.539273821803;12931.676708082374;13188.406521706545;13279.004074694436;13343.532976345781;13356.465741370333;10246.231532635082;10323.380597164194;10326.483675816255;10699;11062.22564420491;3542.982285088558;3569.268299998494;3594.6045934947133;3650.7261955353188;3813.7521061130938;83704;83836.58081709614;83880;86055.13944860596;86605;9179.908200918038;9248.583813728399;9360.953195234117;9586.281028922858;10003.249756268164;21651.56696866054;21684;21844;21892.45268868291;22063.66904496434;7796.649150788228;7870.685172593032;8064.032316121986;8131.878021829677;8267.421280510427;4290.592393722592;4324.805383757738;4326;4375.343698445195;4452.260101514743;3832.5017747692623;3904.8047597620007;3906.9609303907164;3910.2179564087296;3911.530616326059;694.6006046523169;705.3087973785616;722.3282347416848;722.8120688620996;728.388153950684;539.8083680293518;553.5184389581091;573.8708790522182;608.2913405882186;618.1253526260291;6895.655217239118;7201.3158749918675;7746.302832744967;8223.835523289501;8812.955935220283;507.24167369781674;600.942910423509;612.4579746924004;623.6133597169784;626.5614070150913;3834.175652234783;3947.703922205846;3961.7821019844187;4025.4163146343617;4054.5945405459806;86137.56931215303;89340.5532972344;89846.65230021554;89929.55035224782;90059.54970225107;72820;77513.61243193748;77750;78927.60536197282;79970;59938.70030649819;61559;69816.99999999898;70285.64857175783;71484;8614.526201059001;8679.696210632597;8693.956530217309;8759.693410730848;8986.640534378552;47861.76069119771;49045.50954490552;50272.497275026784;51075.74462127666;51685;64242;65062;66350.66824665846;66468.6676566614;66470;11080.05819505351;11130.499127539118;11415.486303116213;11542.480588373712;11806.527738890349;11807.291562506278;11811.409429528661;12060.939695301819;12065.819012714992;12415.130940834055;11602.361870097226;11651.88348116508;11655.358955257543;11861.822072669089;11886.28682279066;11280.774384512428;11742.941285293518;11801.704957376134;11804.58683946092;11869.643910682693;11500.712482187677;11796.292222466336;11860.288382697066;11907.821382679094;12086.879131208576;8571.228589426732;9855.704328870146;10022.849657255001;10091.293609447563;10315.742106447398;9752.512374381395;9872.851907221253;9986.230670932939;10102.141317988053;10125.392476451436 23:43:58 INFO - PROCESS | 1660 | __end_tp_report 23:43:58 INFO - PROCESS | 1660 | __start_cc_report 23:43:58 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,1663 23:43:58 INFO - PROCESS | 1660 | __end_cc_report 23:43:58 INFO - PROCESS | 1660 | __startTimestamp1468910638107__endTimestamp 23:43:58 INFO - PROCESS | 1660 | 23:43:58 INFO - PROCESS | 1660 | ------- Summary: start ------- 23:43:58 INFO - PROCESS | 1660 | Number of tests: 6 23:43:58 INFO - PROCESS | 1660 | 23:43:58 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5890.02 Median:6139.46 stddev:637.24 (10.4%) stddev-sans-first:610.58 23:43:58 INFO - PROCESS | 1660 | Values: 3483.5 3580.6 3587.2 3604.8 3674.9 5940.8 5949.7 5962.2 5970.8 6030.6 5944.0 5974.1 5991.1 6009.4 6016.6 5250.4 5317.9 5376.7 5381.8 5421.7 5362.0 5414.4 5424.2 5432.6 5455.2 5293.7 5345.3 5355.4 5360.7 5474.6 5400.6 5413.6 5427.8 5428.5 5499.8 5220.7 5275.5 5351.5 5361.2 5372.8 5782.0 5785.3 5865.9 5869.4 5881.7 6244.2 6245.2 6271.7 6289.0 6300.4 6213.7 6272.4 6287.6 6339.9 6358.8 6054.2 6063.6 6075.3 6076.5 6106.9 6388.6 6405.6 6423.3 6423.8 6438.1 6188.2 6218.3 6316.1 6341.4 6347.5 6309.8 6317.0 6321.0 6326.2 6341.7 6182.8 6244.6 6251.7 6263.2 6267.0 6237.5 6256.9 6305.1 6310.5 6340.9 5010.0 5023.7 5052.7 5052.7 5057.8 3937.7 4030.5 4524.1 4572.4 4642.0 6058.7 6082.8 6087.7 6096.5 6103.2 6218.2 6313.3 6342.1 6381.5 6403.8 6036.4 6068.2 6092.1 6107.4 6108.7 5602.9 5608.2 5618.8 5619.1 5620.3 6376.5 6453.6 6459.3 6469.3 6479.8 6289.3 6357.6 6370.0 6374.7 6379.2 6505.3 6522.5 6530.7 6557.1 6561.0 6188.4 6220.0 6279.2 6293.9 6296.2 6209.6 6239.2 6266.8 6271.5 6272.7 5179.7 6215.9 6217.7 6234.3 6237.6 6186.5 6239.8 6246.1 6246.3 6248.2 5255.4 6077.8 6209.0 6211.8 6222.4 6095.2 6127.7 6135.2 6139.5 6168.4 6104.3 6175.2 6181.3 6236.4 6275.2 23:43:58 INFO - PROCESS | 1660 | 23:43:58 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:64345.99 Median:19043.81 stddev:140611.02 (738.4%) stddev-sans-first:140923.86 23:43:58 INFO - PROCESS | 1660 | Values: 539.1 553.0 594.2 600.7 605.9 27020.2 30383.2 33047.8 39059.8 40181.2 43311.8 43743.0 43759.0 43943.3 43979.0 9560.9 9782.2 9786.8 9797.4 9799.1 9158.5 10786.8 11987.5 11991.5 12011.3 11682.6 11766.2 11768.2 11780.1 11790.5 11574.9 11739.4 11749.7 11750.6 11779.4 11614.4 11738.3 11744.9 11748.9 11749.5 41554.0 42091.0 42160.8 42174.7 42280.0 3296.9 3358.0 3399.4 3493.3 3558.8 28099.0 28592.9 30224.4 30486.7 30637.7 2484.6 2634.4 2763.7 2770.8 2896.4 527266.4 528597.0 528765.0 529312.0 530103.0 36974.0 63478.8 63740.0 64124.0 64315.0 36220.0 36350.1 36414.3 36417.3 36428.5 14512.3 16094.4 16437.7 16449.6 16451.1 13111.8 13245.6 13283.2 13395.5 13843.0 8393.8 8417.2 8418.1 8496.6 8508.4 3069.1 3473.0 3510.1 3510.6 3545.0 984.1 1030.7 1082.7 1110.8 1148.0 26109.7 30311.0 30470.8 30902.0 31961.8 1156.2 1173.3 1236.6 1256.3 1267.5 15420.6 15573.6 15671.7 15788.4 15981.8 631937.0 640501.0 647971.0 648999.0 650238.0 62766.0 63292.7 63382.0 63417.0 63475.0 1448.7 1539.8 1582.2 1598.0 1604.3 25044.1 28736.1 28876.8 29585.3 30204.5 46914.8 47536.8 47537.5 47623.8 48603.5 362761.0 365753.0 366751.0 366900.8 367571.0 23521.5 24002.6 27304.5 27850.0 28232.0 43703.8 44199.6 44232.0 44443.6 44889.6 34614.7 35545.5 36423.8 37073.8 37173.4 37867.4 38846.8 38948.4 39018.0 42419.4 37098.1 37567.0 37754.8 38720.4 38883.8 27957.0 33434.5 33528.0 34471.8 34503.3 20958.0 24095.9 24358.8 24396.5 24860.9 23:43:58 INFO - PROCESS | 1660 | 23:43:58 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:36685.11 Median:21423.40 stddev:109298.76 (510.2%) stddev-sans-first:109571.44 23:43:58 INFO - PROCESS | 1660 | Values: 413.2 417.1 417.3 418.5 430.8 20282.5 20899.1 20939.7 21195.4 22297.7 20682.5 20898.0 21604.9 21787.2 21887.0 5441.6 5767.0 5768.4 5768.8 5776.3 4231.9 4457.7 5572.1 5781.5 5945.7 6223.5 6226.9 6228.8 6243.6 6244.9 6242.2 6353.6 6637.8 6842.9 6843.5 4084.3 5787.0 6077.1 6084.2 6094.3 13989.4 14086.1 14109.4 14143.6 24910.6 2353.7 2469.5 2588.9 2597.6 2796.9 10288.2 10513.1 10582.6 13232.6 14705.7 1765.5 1769.9 1796.4 1865.2 1890.5 104324.0 112316.9 114749.8 132346.3 134573.0 9468.5 11709.9 11799.6 11835.5 12093.5 12598.3 15814.6 15874.8 15910.4 15927.0 9066.6 9170.4 9190.0 9210.0 9275.4 9467.0 9488.5 9510.5 9519.8 9542.6 3968.9 4838.2 4859.8 4862.3 4898.2 1662.9 1779.9 1951.0 2032.7 2039.0 859.8 963.7 1004.9 1023.2 1045.8 19617.2 20571.9 20974.1 21128.7 21241.9 996.9 1007.6 1032.7 1033.4 1057.5 8938.4 10836.9 11053.2 11069.1 11087.5 641453.0 651669.7 661580.0 664996.0 667398.0 118224.0 124014.8 128793.0 130943.0 137493.0 1041.6 1055.4 1059.0 1062.4 1080.1 17895.9 18099.5 18182.1 18344.4 18658.9 53964.0 54305.0 55653.7 57128.3 57136.9 54470.7 82195.0 82994.0 83580.2 83814.6 8031.4 8154.8 8341.2 8712.0 8820.2 12722.1 12894.4 13072.6 13150.4 13424.2 5720.0 8686.7 8949.7 11484.3 11635.3 11010.1 11173.8 11354.0 11401.7 11512.9 8821.6 11649.0 11682.0 11696.6 11977.7 8449.4 8518.4 8560.2 8561.3 8822.3 11263.3 11488.9 11696.4 11743.8 11878.2 23:43:58 INFO - PROCESS | 1660 | 23:43:58 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:5874.22 Median:5072.90 stddev:3268.76 (64.4%) stddev-sans-first:3260.31 23:43:58 INFO - PROCESS | 1660 | Values: 1358.5 1556.1 1619.7 1797.3 2053.8 8216.8 8802.1 8956.3 8978.4 8982.3 8692.4 8991.3 9011.4 9012.3 9021.1 2526.9 2553.3 2554.2 2558.2 2567.2 2478.4 2545.8 2552.1 2557.3 2567.3 2521.2 2553.2 2560.3 2566.9 2571.1 2163.4 2486.5 2543.5 2564.7 2565.7 2500.6 2539.0 2539.2 2553.6 2558.9 8775.2 8997.7 9085.0 9122.3 9123.9 5627.9 5788.9 5789.2 5848.4 5881.4 3660.6 3742.7 3766.0 3796.3 3800.7 1045.4 1056.5 1057.8 1091.2 1097.0 10867.6 11982.1 12590.8 12603.7 12618.7 4819.1 4864.0 4884.6 4896.0 4940.6 9739.3 9750.8 9763.3 9779.0 9800.0 4783.8 5620.4 5654.8 5657.2 5661.0 4650.7 4805.8 5074.3 5190.2 5264.1 4004.1 4013.9 4090.1 4108.6 4124.4 1271.1 1280.2 1280.3 1288.4 1296.1 761.2 832.5 920.1 925.9 986.3 5693.7 5846.6 6021.5 6076.4 6169.2 889.9 957.6 1002.8 1017.9 1019.7 3292.4 4056.4 4074.4 4113.2 4139.0 10736.4 11365.6 11371.4 11491.7 11520.0 11186.8 11201.8 11360.8 11370.4 11372.9 8665.3 8705.8 8768.8 8773.6 8853.6 5667.4 5944.6 5999.5 6011.1 6052.6 9934.2 9995.4 10021.9 10170.7 10230.4 9211.9 9219.6 10468.5 10637.2 10663.9 6486.0 6959.8 7169.6 7325.8 7332.5 8421.3 8479.7 8483.2 8498.7 8524.9 7482.6 7520.5 7543.9 7589.6 7720.9 7405.4 7454.1 7454.9 7576.9 7583.0 7148.2 7168.2 7184.2 7202.4 7220.9 4946.5 4966.4 5071.5 5151.6 5169.2 5051.1 5131.2 5166.9 5211.5 5313.2 23:43:58 INFO - PROCESS | 1660 | 23:43:58 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:5737.06 Median:6511.93 stddev:1837.30 (28.2%) stddev-sans-first:1797.04 23:43:58 INFO - PROCESS | 1660 | Values: 327.8 332.5 341.4 343.7 344.7 6287.8 6455.5 6518.6 6539.7 6609.9 4542.5 6358.1 6475.4 6494.6 6502.6 4873.5 4923.9 4926.7 4930.1 4962.9 4680.0 4764.3 4924.6 4937.4 4956.5 4862.6 4875.0 4879.8 4916.8 4939.9 4865.4 4883.0 4884.6 4886.9 4891.7 4203.5 4224.9 4234.4 4240.1 4240.2 6296.2 6346.9 6351.5 6376.0 6376.6 4716.4 4972.0 5013.8 5822.0 5825.1 6536.1 7033.8 7072.3 7073.8 7080.3 4601.4 4610.1 4610.1 4612.5 4630.4 7334.2 7450.9 7455.6 7485.6 7487.5 4638.7 4647.5 4658.6 4661.4 4676.1 4566.9 4569.3 4716.1 4722.4 4727.8 4707.6 4809.2 5406.7 5597.5 5609.6 7068.9 7093.8 7096.7 7099.1 7106.0 1300.8 1554.8 1592.0 1599.2 1627.7 1029.6 1037.1 1046.9 1050.4 1051.3 6410.1 6519.4 6525.9 6547.4 6556.5 7291.5 7291.5 7294.5 7300.0 7302.0 6490.7 6509.7 6514.2 6526.4 6537.6 3806.4 3816.2 3819.6 3823.2 3824.2 7263.7 7546.2 7606.0 7606.2 7631.2 7379.3 7387.2 7388.4 7401.4 7429.3 7579.2 7579.9 7581.0 7588.9 7606.0 6845.2 7198.9 7230.5 7241.9 7257.3 7058.1 7106.3 7131.7 7150.0 7176.0 7490.0 7502.8 7505.8 7570.2 7603.1 4671.6 4675.0 4679.4 4682.9 4688.5 6967.3 7034.8 7183.0 7215.4 7228.3 6240.2 6815.6 6971.8 6976.6 6979.8 6956.8 6981.4 7065.0 7073.0 7099.5 6916.7 6916.8 6919.3 6930.3 6940.2 6861.9 7070.7 7097.2 7099.4 7109.5 6891.7 6935.2 6938.1 6941.1 6943.8 23:43:58 INFO - PROCESS | 1660 | 23:43:58 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:18343.26 Median:48453.64 stddev:25345.82 (52.3%) stddev-sans-first:25382.15 23:43:58 INFO - PROCESS | 1660 | Values: 662.2 702.5 717.6 751.7 779.2 15599.2 15800.0 15809.8 15812.4 15828.1 14480.9 14551.2 14608.8 14630.4 14635.8 777.4 789.8 950.6 954.3 965.9 949.9 952.2 958.6 958.7 959.0 1019.1 1024.8 1025.3 1027.3 1029.3 819.6 1008.2 1012.2 1032.5 1035.8 707.4 722.0 771.5 772.7 774.1 15230.0 15329.1 15336.1 15347.3 15357.5 12931.7 13188.4 13279.0 13343.5 13356.5 10246.2 10323.4 10326.5 10699.0 11062.2 3543.0 3569.3 3594.6 3650.7 3813.8 83704.0 83836.6 83880.0 86055.1 86605.0 9179.9 9248.6 9361.0 9586.3 10003.2 21651.6 21684.0 21844.0 21892.5 22063.7 7796.6 7870.7 8064.0 8131.9 8267.4 4290.6 4324.8 4326.0 4375.3 4452.3 3832.5 3904.8 3907.0 3910.2 3911.5 694.6 705.3 722.3 722.8 728.4 539.8 553.5 573.9 608.3 618.1 6895.7 7201.3 7746.3 8223.8 8813.0 507.2 600.9 612.5 623.6 626.6 3834.2 3947.7 3961.8 4025.4 4054.6 86137.6 89340.6 89846.7 89929.6 90059.5 72820.0 77513.6 77750.0 78927.6 79970.0 59938.7 61559.0 69817.0 70285.6 71484.0 8614.5 8679.7 8694.0 8759.7 8986.6 47861.8 49045.5 50272.5 51075.7 51685.0 64242.0 65062.0 66350.7 66468.7 66470.0 11080.1 11130.5 11415.5 11542.5 11806.5 11807.3 11811.4 12060.9 12065.8 12415.1 11602.4 11651.9 11655.4 11861.8 11886.3 11280.8 11742.9 11801.7 11804.6 11869.6 11500.7 11796.3 11860.3 11907.8 12086.9 8571.2 9855.7 10022.8 10091.3 10315.7 9752.5 9872.9 9986.2 10102.1 10125.4 23:43:58 INFO - PROCESS | 1660 | -------- Summary: end -------- 23:43:58 INFO - PROCESS | 1660 | 23:43:58 INFO - TEST-INFO | 1660: exit 0 23:43:58 INFO - TEST-OK | dromaeo_css | took 1114000ms 23:43:58 INFO - TEST-START | kraken 23:43:58 INFO - operating with platform_type : mac_ 23:43:58 INFO - Initialising browser for kraken test... 23:43:58 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/tmpE5zCeh/profile http://localhost:49277/getInfo.html) 23:44:00 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 23:44:00 INFO - PROCESS | 1671 | colorDepth:24 23:44:00 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 23:44:00 INFO - PROCESS | 1671 | __metrics 23:44:00 INFO - PROCESS | 1671 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:44:00 ERROR - PROCESS | 1671 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:44:01 INFO - TEST-INFO | 1671: exit 0 23:44:01 INFO - Browser initialized. 23:44:01 INFO - Running cycle 1/1 for kraken test... 23:44:01 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/tmpE5zCeh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:44:13 INFO - PROCESS | 1674 | RSS: Main: 160722944 23:44:13 INFO - PROCESS | 1674 | 23:44:16 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 23:44:16 INFO - PROCESS | 1674 | RSS: Main: 224309248 23:44:16 INFO - PROCESS | 1674 | 23:44:19 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 23:44:20 INFO - PROCESS | 1674 | RSS: Main: 239419392 23:44:20 INFO - PROCESS | 1674 | 23:44:23 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 23:44:23 INFO - PROCESS | 1674 | RSS: Main: 324091904 23:44:23 INFO - PROCESS | 1674 | 23:44:25 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 23:44:26 INFO - PROCESS | 1674 | RSS: Main: 230400000 23:44:26 INFO - PROCESS | 1674 | 23:44:28 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:44:29 INFO - PROCESS | 1674 | RSS: Main: 232935424 23:44:29 INFO - PROCESS | 1674 | 23:44:31 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 23:44:32 INFO - PROCESS | 1674 | RSS: Main: 269959168 23:44:32 INFO - PROCESS | 1674 | 23:44:35 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 23:44:35 INFO - PROCESS | 1674 | RSS: Main: 271044608 23:44:35 INFO - PROCESS | 1674 | 23:44:38 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 23:44:39 INFO - PROCESS | 1674 | RSS: Main: 269959168 23:44:39 INFO - PROCESS | 1674 | 23:44:40 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:44:41 INFO - PROCESS | 1674 | RSS: Main: 259665920 23:44:41 INFO - PROCESS | 1674 | 23:44:43 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:44:43 INFO - PROCESS | 1674 | RSS: Main: 266522624 23:44:43 INFO - PROCESS | 1674 | 23:44:45 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:44:46 INFO - PROCESS | 1674 | RSS: Main: 271089664 23:44:46 INFO - PROCESS | 1674 | 23:44:49 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:44:49 INFO - PROCESS | 1674 | RSS: Main: 278224896 23:44:49 INFO - PROCESS | 1674 | 23:44:52 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:44:53 INFO - PROCESS | 1674 | RSS: Main: 275542016 23:44:53 INFO - PROCESS | 1674 | 23:44:55 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 23:44:55 INFO - PROCESS | 1674 | RSS: Main: 336576512 23:44:55 INFO - PROCESS | 1674 | 23:44:55 INFO - PROCESS | 1674 | __start_tp_report 23:44:55 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 23:44:55 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 23:44:55 INFO - PROCESS | 1674 | |i|pagename|runs| 23:44:55 INFO - PROCESS | 1674 | |0;ai-astar;114;114;120;113;113;112;114;114;114;135 23:44:55 INFO - PROCESS | 1674 | |1;audio-beat-detection;155;119;141;163;119;139;136;117;167;117 23:44:55 INFO - PROCESS | 1674 | |2;audio-dft;187;186;184;188;184;186;184;183;181;184 23:44:55 INFO - PROCESS | 1674 | |3;audio-fft;69;79;73;153;56;56;56;62;131;54 23:44:55 INFO - PROCESS | 1674 | |4;audio-oscillator;91;91;144;79;77;80;123;79;77;124 23:44:55 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;89;86;89;87;88;85;89;87;88;86 23:44:55 INFO - PROCESS | 1674 | |6;imaging-darkroom;93;93;94;92;92;93;93;93;92;93 23:44:55 INFO - PROCESS | 1674 | |7;imaging-desaturate;85;84;83;86;83;84;83;82;84;83 23:44:55 INFO - PROCESS | 1674 | |8;json-parse-financial;60;63;62;61;61;63;62;78;58;55 23:44:55 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;62;62;82;105;104;95;66;66;66;65 23:44:55 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;80;78;78;79;79;78;78;76;82;82 23:44:55 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;126;126;128;126;126;127;139;122;144;131 23:44:55 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;164;159;162;167;162;162;162;172;161;161 23:44:55 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;56;80;97;96;70;66;68;68;67;81 23:44:55 INFO - PROCESS | 1674 | __end_tp_report 23:44:55 INFO - PROCESS | 1674 | __start_cc_report 23:44:55 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1941 23:44:55 INFO - PROCESS | 1674 | __end_cc_report 23:44:55 INFO - PROCESS | 1674 | __startTimestamp1468910695437__endTimestamp 23:44:55 INFO - PROCESS | 1674 | 23:44:55 INFO - PROCESS | 1674 | ------- Summary: start ------- 23:44:55 INFO - PROCESS | 1674 | Number of tests: 14 23:44:55 INFO - PROCESS | 1674 | 23:44:55 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:116.30 Median:114.00 stddev:6.91 (6.1%) stddev-sans-first:7.28 23:44:55 INFO - PROCESS | 1674 | Values: 114.0 114.0 120.0 113.0 113.0 112.0 114.0 114.0 114.0 135.0 23:44:55 INFO - PROCESS | 1674 | 23:44:55 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:140.00 stddev:19.35 (13.8%) stddev-sans-first:19.43 23:44:55 INFO - PROCESS | 1674 | Values: 155.0 119.0 141.0 163.0 119.0 139.0 136.0 117.0 167.0 117.0 23:44:55 INFO - PROCESS | 1674 | 23:44:55 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:184.70 Median:185.00 stddev:2.06 (1.1%) stddev-sans-first:2.01 23:44:55 INFO - PROCESS | 1674 | Values: 187.0 186.0 184.0 188.0 184.0 186.0 184.0 183.0 181.0 184.0 23:44:55 INFO - PROCESS | 1674 | 23:44:55 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:78.90 Median:59.00 stddev:34.67 (58.8%) stddev-sans-first:36.59 23:44:55 INFO - PROCESS | 1674 | Values: 69.0 79.0 73.0 153.0 56.0 56.0 56.0 62.0 131.0 54.0 23:44:55 INFO - PROCESS | 1674 | 23:44:55 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:79.00 stddev:24.54 (31.1%) stddev-sans-first:25.95 23:44:55 INFO - PROCESS | 1674 | Values: 91.0 91.0 144.0 79.0 77.0 80.0 123.0 79.0 77.0 124.0 23:44:55 INFO - PROCESS | 1674 | 23:44:55 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:88.00 stddev:1.43 (1.6%) stddev-sans-first:1.39 23:44:55 INFO - PROCESS | 1674 | Values: 89.0 86.0 89.0 87.0 88.0 85.0 89.0 87.0 88.0 86.0 23:44:55 INFO - PROCESS | 1674 | 23:44:55 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:92.80 Median:93.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 23:44:55 INFO - PROCESS | 1674 | Values: 93.0 93.0 94.0 92.0 92.0 93.0 93.0 93.0 92.0 93.0 23:44:55 INFO - PROCESS | 1674 | 23:44:55 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:83.70 Median:84.00 stddev:1.16 (1.4%) stddev-sans-first:1.13 23:44:55 INFO - PROCESS | 1674 | Values: 85.0 84.0 83.0 86.0 83.0 84.0 83.0 82.0 84.0 83.0 23:44:55 INFO - PROCESS | 1674 | 23:44:55 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:62.30 Median:62.00 stddev:6.04 (9.7%) stddev-sans-first:6.35 23:44:55 INFO - PROCESS | 1674 | Values: 60.0 63.0 62.0 61.0 61.0 63.0 62.0 78.0 58.0 55.0 23:44:55 INFO - PROCESS | 1674 | 23:44:55 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:77.30 Median:66.00 stddev:17.70 (26.8%) stddev-sans-first:17.88 23:44:55 INFO - PROCESS | 1674 | Values: 62.0 62.0 82.0 105.0 104.0 95.0 66.0 66.0 66.0 65.0 23:44:55 INFO - PROCESS | 1674 | 23:44:55 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.00 stddev:1.89 (2.4%) stddev-sans-first:1.96 23:44:55 INFO - PROCESS | 1674 | Values: 80.0 78.0 78.0 79.0 79.0 78.0 78.0 76.0 82.0 82.0 23:44:55 INFO - PROCESS | 1674 | 23:44:55 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:129.50 Median:127.50 stddev:6.80 (5.3%) stddev-sans-first:7.10 23:44:55 INFO - PROCESS | 1674 | Values: 126.0 126.0 128.0 126.0 126.0 127.0 139.0 122.0 144.0 131.0 23:44:55 INFO - PROCESS | 1674 | 23:44:55 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.20 Median:162.00 stddev:3.74 (2.3%) stddev-sans-first:3.95 23:44:55 INFO - PROCESS | 1674 | Values: 164.0 159.0 162.0 167.0 162.0 162.0 162.0 172.0 161.0 161.0 23:44:55 INFO - PROCESS | 1674 | 23:44:55 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.90 Median:75.00 stddev:13.40 (17.9%) stddev-sans-first:12.34 23:44:55 INFO - PROCESS | 1674 | Values: 56.0 80.0 97.0 96.0 70.0 66.0 68.0 68.0 67.0 81.0 23:44:55 INFO - PROCESS | 1674 | -------- Summary: end -------- 23:44:55 INFO - PROCESS | 1674 | 23:44:56 INFO - TEST-INFO | 1674: exit 0 23:44:56 INFO - TEST-OK | kraken | took 57535ms 23:44:56 INFO - SUITE-END | took 1171s 23:44:56 INFO - Completed test suite (00:19:31) 23:44:56 INFO - javascript benchmark 23:44:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3483.460063690128, 3580.6061333253347, 3587.1570181007473, 3604.8377822997945, 3674.9448758268613, 5940.821775346736, 5949.6727679977585, 5962.165296858443, 5970.761169553218, 6030.577859549839, 5944.0192368259295, 5974.13375060617, 5991.101334799782, 6009.369016253296, 6016.608920420181, 5250.422453530108, 5317.8936421271555, 5376.731163441832, 5381.81163659272, 5421.674699518042, 5362.0, 5414.43148469411, 5424.213489044087, 5432.592555558329, 5455.236266922614, 5293.68237905725, 5345.33183352081, 5355.410904800468, 5360.678359298435, 5474.562035037207, 5400.594955378362, 5413.593980451482, 5427.83716488506, 5428.511433970922, 5499.752511137009, 5220.738963051832, 5275.525202731734, 5351.491608297206, 5361.222622719683, 5372.785088596452, 5782.045962416196, 5785.2768403949085, 5865.941340586625, 5869.413058694096, 5881.67650779207, 6244.188255526798, 6245.156903818017, 6271.6864156792435, 6289.0252010938375, 6300.4329610334835, 6213.689315534205, 6272.435480806749, 6287.559870809046, 6339.936600633981, 6358.841028974266, 6054.182685337467, 6063.617796285892, 6075.3111392328965, 6076.453119219247, 6106.877862442815, 6388.648624325614, 6405.615663060231, 6423.293437721847, 6423.775167869102, 6438.130852334969, 6188.226471691039, 6218.284897236876, 6316.147320111726, 6341.397567231105, 6347.460465860361, 6309.842253943596, 6317.020861766434, 6321.020241862519, 6326.177596912464, 6341.682915854189, 6182.783602573888, 6244.625322480666, 6251.718672659741, 6263.248410190807, 6267.0, 6237.532185086136, 6256.937430625636, 6305.085762564402, 6310.5267104967315, 6340.873182536324, 5010.0, 5023.748812559357, 5052.69683818972, 5052.72210028452, 5057.797688092435, 3937.7243592948794, 4030.4760381150263, 4524.09518096382, 4572.382728331632, 4642.001969576557, 6058.697065146813, 6082.787102451482, 6087.66517841523, 6096.512279017668, 6103.176071230416, 6218.160548326008, 6313.305536390993, 6342.112104305401, 6381.521385896076, 6403.775867844603, 6036.366181550961, 6068.241469816273, 6092.116643086728, 6107.4197951194565, 6108.694565271719, 5602.887942241132, 5608.242887210256, 5618.831435056954, 5619.072852979212, 5620.269364982526, 6376.458001069868, 6453.645049522322, 6459.321771214143, 6469.320721324193, 6479.8056058318325, 6289.308176100717, 6357.618542887441, 6370.0, 6374.713137908712, 6379.170707807955, 6505.2518960318275, 6522.478201743944, 6530.706118224786, 6557.147570815763, 6561.048647945926, 6188.44304012641, 6220.0047992321015, 6279.246490421178, 6293.937060629335, 6296.212973378328, 6209.565330427007, 6239.188905442264, 6266.843328916631, 6271.529635277464, 6272.686365681607, 5179.689218646893, 6215.906761398673, 6217.689115544295, 6234.251889773256, 6237.563370564017, 6186.536009799193, 6239.844003899757, 6246.063090536274, 6246.3441338660605, 6248.156498872776, 5255.395629502656, 6077.787277445268, 6208.9689551551955, 6211.813645590459, 6222.439980401786, 6095.177151084724, 6127.693615319127, 6135.171751813448, 6139.461473530676, 6168.383161683796, 6104.32852386246, 6175.228096487939, 6181.320054794059, 6236.407541283571, 6275.152854364603], "value": 5850.557583352918, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.0808671215577, 552.9852720258326, 594.165197896955, 600.684640563704, 605.8576234584874, 27020.18939431818, 30383.240418989535, 33047.83476082619, 39059.80470097649, 40181.19637607246, 43311.78344108283, 43743.0, 43759.0, 43943.340849887194, 43979.0, 9560.856587151198, 9782.168515676176, 9786.755331116708, 9797.363171393872, 9799.069088436587, 9158.450492970444, 10786.838197427045, 11987.460564274628, 11991.460384282685, 12011.339376334297, 11682.649520514356, 11766.235194712359, 11768.235064720766, 11780.116491263147, 11790.469428875722, 11574.942125289363, 11739.413029348583, 11749.706257343549, 11750.648675402354, 11779.411029448493, 11614.419279036014, 11738.295702257892, 11744.941275293655, 11748.941255293754, 11749.471273792615, 41554.0, 42091.0, 42160.78919605413, 42174.73475795731, 42280.0, 3296.8516416761063, 3357.9664203357897, 3399.3711163434846, 3493.2838768052743, 3558.7864728116137, 28099.0, 28592.857035714896, 30224.395512089854, 30486.695133048608, 30637.693623063707, 2484.6391891285875, 2634.4360551873147, 2763.709810469912, 2770.8476033818133, 2896.4496745618267, 527266.3636681831, 528597.0, 528765.0, 529312.0, 530103.0, 36974.0, 63478.778242761284, 63740.0, 64124.0, 64315.03527447092, 36220.0, 36350.09124771849, 36414.27171456556, 36417.27165456676, 36428.45357319642, 14512.346944387527, 16094.436694715863, 16437.67124657524, 16449.58876028085, 16451.095189764437, 13111.803322950163, 13245.602631920865, 13283.20300781937, 13395.464181432633, 13843.030987830956, 8393.790155246168, 8417.200365965224, 8418.116097809765, 8496.575171241413, 8508.404411691246, 3069.0971597609177, 3472.9754722356965, 3510.087377281925, 3510.613832478425, 3545.025118092545, 984.1339621133357, 1030.701096681954, 1082.680609220282, 1110.7947876553867, 1148.024179447463, 26109.738902611112, 30311.0, 30470.84764576207, 30901.963893693148, 31961.84019079936, 1156.1675593572613, 1173.284296579086, 1236.5610208376077, 1256.3153081570565, 1267.454994352419, 15420.614484637974, 15573.610659733371, 15671.68656626884, 15788.368465261261, 15981.760273595906, 631937.0, 640501.0, 647971.0, 648999.0, 650238.0, 62766.0, 63292.68353658295, 63382.049269261, 63417.048744268875, 63475.047874281925, 1448.6957738874744, 1539.776732373822, 1582.1535478519168, 1598.0, 1604.254021879785, 25044.123455678964, 28736.137915862557, 28876.844926203557, 29585.26036849096, 30204.5469317956, 46914.76542617265, 47536.7623161882, 47537.52462475331, 47623.761881190374, 48603.5139648599, 362761.0, 365753.0, 366751.0, 366900.82045486686, 367571.0, 23521.529569408172, 24002.639960400957, 27304.54259116689, 27850.025249116185, 28232.0, 43703.78148109239, 44199.558004419545, 44232.0, 44443.555564443945, 44889.551104488535, 34614.653853461146, 35545.466817997236, 36423.81788091043, 37073.814630926674, 37173.442398363506, 37867.431988520744, 38846.80576597099, 38948.41577376285, 39018.0, 42419.363709544996, 37098.07254818651, 37567.0, 37754.8112259437, 38720.41919371268, 38883.80558097304, 27957.0, 33434.49848252229, 33528.0, 34471.82764086164, 34503.309933801684, 20958.0, 24095.879520602284, 24358.756412436356, 24396.51206975886, 24860.875695621406], "value": 19031.06226635396, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.1983951134798, 417.12612077697213, 417.32393522493567, 418.4998926283091, 430.79321925475773, 20282.492937676565, 20899.059542320592, 20939.68590471144, 21195.364139075813, 22297.66553501699, 20682.48293792656, 20897.955102244865, 21604.910791573322, 21787.23744668937, 21887.0, 5441.59188060895, 5767.0, 5768.3654797972185, 5768.82693519193, 5776.306843178803, 4231.915361692764, 4457.732536047832, 5572.108462645978, 5781.450762177607, 5945.732442040097, 6223.471004964561, 6226.906596401035, 6228.844278893019, 6243.594166379194, 6244.875102497947, 6242.18851549298, 6353.587016843913, 6637.800865974028, 6842.863142737117, 6843.486738494608, 4084.326086195774, 5787.0, 6077.118817771398, 6084.209052823149, 6094.299155597118, 13989.3704783285, 14086.084404513675, 14109.365078571489, 14143.575692729235, 24910.626340604904, 2353.7410884802657, 2469.506098780233, 2588.8835002424935, 2597.6493173421723, 2796.8601569921625, 10288.228382871315, 10513.106385957202, 10582.634368583782, 13232.603021909357, 14705.70588588233, 1765.4527096600095, 1769.938052168168, 1796.4161647464625, 1865.2445759467437, 1890.461218552706, 104323.99999999924, 112316.92076980755, 114749.81943164537, 132346.33826830806, 134573.0, 9468.5323774815, 11709.88290117105, 11799.646010619696, 11835.526578936919, 12093.45579448927, 12598.307093109966, 15814.60463488422, 15874.841251587337, 15910.363585456684, 15927.044377337164, 9066.592003359865, 9170.403923744936, 9190.0, 9209.95395023034, 9275.443473391619, 9466.952665236768, 9488.525573721425, 9510.524473776284, 9519.809603807886, 9542.61829526825, 3968.900777480528, 4838.177509823338, 4859.781309841065, 4862.343583616237, 4898.216285394391, 1662.9002259864446, 1779.9251117284696, 1951.0, 2032.7459067616549, 2039.0, 859.832332695131, 963.6723514005272, 1004.8542961270575, 1023.1967905194387, 1045.8065257927308, 19617.21531138767, 20571.868547229747, 20974.0561674725, 21128.683069753966, 21241.893790531256, 996.875390576178, 1007.6372505897871, 1032.70051685012, 1033.3593172233263, 1057.5241141486208, 8938.4190027648, 10836.891631083588, 11053.226274160732, 11069.114470842313, 11087.50106245221, 641453.0, 651669.7416512887, 661580.0, 664996.0, 667398.0, 118224.0, 124014.75985240033, 128793.0, 130943.0, 137493.0, 1041.6250149946013, 1055.4353420919772, 1058.9788204235872, 1062.3678911047914, 1080.1143062688677, 17895.910520447316, 18099.457016289532, 18182.09089545491, 18344.449666510027, 18658.906705466386, 53964.0, 54305.0, 55653.72173139108, 57128.28615141552, 57136.857262855345, 54470.72764636151, 82195.0, 82994.0, 83580.16419835723, 83814.58092709497, 8031.357491400557, 8154.75535733929, 8341.16588341161, 8712.041675415572, 8820.2061814437, 12722.109452338247, 12894.419751111034, 13072.607821765363, 13150.408231629408, 13424.194548327132, 5719.971400142973, 8686.739397818075, 8949.686760963335, 11484.253523520945, 11635.301881887113, 11010.119190464904, 11173.776524469302, 11354.0, 11401.657950261506, 11512.94243528777, 8821.64713411482, 11649.0, 11682.0, 11696.642685851455, 11977.700557486132, 8449.366297527587, 8518.403711740119, 8560.186782255676, 8561.315094792526, 8822.33832462555, 11263.324200547993, 11488.94255528717, 11696.35670038122, 11743.823842642196, 11878.168528202943], "value": 9728.684065529564, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.4973559782882, 1556.0741358891455, 1619.7489389144682, 1797.2990533691861, 2053.804888535589, 8216.753497395073, 8802.07578204289, 8956.32827537934, 8978.371513994023, 8982.326325525595, 8692.391532592721, 8991.325650576217, 9011.41425807322, 9012.279017678586, 9021.142991415822, 2526.861022643754, 2553.310606136342, 2554.2081954594137, 2558.1941688368197, 2567.242663414288, 2478.4175718706088, 2545.847249165047, 2552.081250749738, 2557.3223095879607, 2567.306827156676, 2521.180616299701, 2553.1957433408415, 2560.334313078604, 2566.935826604331, 2571.0744132112422, 2163.4050636075126, 2486.490269494758, 2543.5167318209574, 2564.666593342872, 2565.743425657438, 2500.6499090127395, 2538.961915571268, 2539.21284401836, 2553.553128202557, 2558.9360265993314, 8775.210231079234, 8997.685081022199, 9085.000649928503, 9122.270218382513, 9123.863142052875, 5627.915581266284, 5788.942110578924, 5789.247397838296, 5848.385919478478, 5881.382454842223, 3660.5790334111384, 3742.6631603155574, 3765.962340376616, 3796.2787070456525, 3800.714946379005, 1045.4406892312577, 1056.514003558364, 1057.8466122412208, 1091.1979694924225, 1097.040089921319, 10867.565297388095, 11982.101342399355, 12590.81113783294, 12603.747925041447, 12618.68453288666, 4819.132556139858, 4863.9513604864205, 4884.633652476078, 4895.951040489621, 4940.580050695731, 9739.318247722591, 9750.756231094138, 9763.316567840184, 9779.022097790306, 9800.0, 4783.808647654055, 5620.437956204429, 5654.802081927113, 5657.179708942181, 5660.971695141498, 4650.697704649187, 4805.7597120143855, 5074.2642316864585, 5190.221466779938, 5264.131418315935, 4004.1190937993597, 4013.9397909031386, 4090.1206240658403, 4108.589141085868, 4124.360724087771, 1271.1419791640606, 1280.2318608834626, 1280.257450678604, 1288.4008935844877, 1296.125115547002, 761.1665226576889, 832.5046597274612, 920.1350730313484, 925.9397989302346, 986.3194395866828, 5693.715314234271, 5846.619969701956, 6021.5182785377065, 6076.392360763888, 6169.198004259418, 889.9199072083544, 957.6408846682494, 1002.7643503776607, 1017.9287449878585, 1019.6838979916249, 3292.423825830518, 4056.371262454324, 4074.409210664437, 4113.197926404322, 4138.979305103455, 10736.355818650905, 11365.602203922823, 11371.43142842871, 11491.655250342503, 11520.0, 11186.832197517044, 11201.831972520418, 11360.829587556193, 11370.431478426046, 11372.886271137348, 8665.306775457948, 8705.782355441164, 8768.824623507495, 8773.561321933877, 8853.601587928559, 5667.4332566743, 5944.613600115978, 5999.460048595647, 6011.128386384037, 6052.576319657582, 9934.155596774355, 9995.400275983464, 10021.949890250502, 10170.694879153638, 10230.437325946847, 9211.940626828, 9219.631214751334, 10468.528916198637, 10637.202209834139, 10663.946680266548, 6486.0, 6959.826004349932, 7169.641517924188, 7325.816854578678, 7332.450066244946, 8421.284190843848, 8479.660813567634, 8483.194096560817, 8498.70254541088, 8524.872126917977, 7482.551046937201, 7520.473566850268, 7543.886841697269, 7589.582572958319, 7720.922790772245, 7405.370543503863, 7454.068241469817, 7454.850902982019, 7576.886346704914, 7583.0, 7148.213696493278, 7168.211496735459, 7184.173820010766, 7202.423806095395, 7220.89168662481, 4946.480619534897, 4966.419494170167, 5071.527296133472, 5151.613628977767, 5169.224616307433, 5051.141305978066, 5131.179011358314, 5166.870828229325, 5211.5049070338255, 5313.229581710708], "value": 4735.841827021567, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.7590970636583, 332.4531146264395, 341.41447417678677, 343.7370411635098, 344.6691176470588, 6287.7799277025315, 6455.483561315095, 6518.608883466995, 6539.705713242904, 6609.900851487231, 4542.477615074267, 6358.109864618946, 6475.417212450879, 6494.642794646293, 6502.5773324733855, 4873.465797785149, 4923.876903077434, 4926.655134140611, 4930.087933732253, 4962.851114466554, 4679.953200468003, 4764.285357196413, 4924.630652701062, 4937.382827146606, 4956.5043495650325, 4862.586680132193, 4875.00062487191, 4879.804807807701, 4916.754162291889, 4939.876503087416, 4865.44047434546, 4882.975585122052, 4884.5848102911295, 4886.902261954777, 4891.730954797485, 4203.453551038346, 4224.852130175429, 4234.407182994383, 4240.109576988836, 4240.194363071007, 6296.244450665904, 6346.9055211780005, 6351.491880649537, 6376.0, 6376.585521941059, 4716.434027916637, 4971.975140124277, 5013.7966887947, 5822.010258256107, 5825.126231065332, 6536.117624120778, 7033.788986330367, 7072.292770722886, 7073.752418665322, 7080.256573059806, 4601.3558101865765, 4610.054938737584, 4610.101030299093, 4612.515685852971, 4630.351750754897, 7334.229905859861, 7450.850982980364, 7455.627218639101, 7485.550866947946, 7487.513311634781, 4638.698484598491, 4647.512011238839, 4658.557437043475, 4661.440627124767, 4676.134915040729, 4566.907273736823, 4569.29175977724, 4716.127516409475, 4722.409698787652, 4727.763611819395, 4707.552782485658, 4809.182438985381, 5406.729663516887, 5597.524210442077, 5609.5792815539, 7068.858622827514, 7093.787186384417, 7096.680649370791, 7099.148102227766, 7105.964470177616, 1300.811382349573, 1554.8367421420814, 1592.0, 1599.176424141568, 1627.7395616701508, 1029.5933106423072, 1037.0666400239845, 1046.8743750749807, 1050.3540322701483, 1051.332403923514, 6410.102585638015, 6519.380658837403, 6525.869482610321, 6547.443467305237, 6556.475481961432, 7291.489595728248, 7291.489595728354, 7294.525855819461, 7300.0, 7302.014228079248, 6490.707918143695, 6509.707063182168, 6514.1531600891585, 6526.412622863965, 6537.5750576212395, 3806.42903564462, 3816.1795214029116, 3819.598942111094, 3823.1780167264174, 3824.2351529694174, 7263.709451621876, 7546.169921308651, 7606.0, 7606.163322034572, 7631.198724133997, 7379.262073792578, 7387.150477695134, 7388.408927285805, 7401.407887368998, 7429.2570742926355, 7579.1662917079075, 7579.924200758032, 7580.982079497875, 7588.924110758932, 7605.961970190225, 6845.178578570603, 7198.856022879409, 7230.49386542958, 7241.891371629325, 7257.346838784535, 7058.11773528309, 7106.289371062852, 7131.714731410893, 7149.963255327844, 7176.031235783103, 7490.02629658141, 7502.774916752506, 7505.812354691177, 7570.205128461653, 7603.125640551408, 4671.649626277975, 4675.0, 4679.368285281444, 4682.882927926829, 4688.460827004802, 6967.268436814062, 7034.753783617549, 7183.03029091066, 7215.350618444365, 7228.277172282729, 6240.219972503437, 6815.625140617313, 6971.755988540377, 6976.5814051157095, 6979.755708550177, 6956.79129626112, 6981.441484681111, 7065.0, 7072.9646351767915, 7099.538529995534, 6916.723331066701, 6916.792496225121, 6919.342662447059, 6930.27232140618, 6940.236573976959, 6861.862762744618, 7070.717171313296, 7097.183823860116, 7099.396551293198, 7109.502334836512, 6891.724331026903, 6935.237123916264, 6938.132733408324, 6941.097657304518, 6943.826404339932], "value": 5120.65245575875, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.2218892800958, 702.5293053654051, 717.634006656605, 751.7030772844727, 779.1585088104847, 15599.220038998048, 15800.0, 15809.841901580981, 15812.367505299775, 15828.129452880086, 14480.855191448083, 14551.199684017374, 14608.780868286984, 14630.41478340865, 14635.780463293033, 777.3897490469982, 789.8064974081358, 950.6387572722356, 954.3367359685021, 965.8696076029717, 949.9002604726508, 952.176367442161, 958.6261358070358, 958.7315551645551, 959.0457494792691, 1019.1031891935124, 1024.7591815923251, 1025.2874252394552, 1027.3271007490107, 1029.2743615750915, 819.5533434278303, 1008.2236677758121, 1012.2003617142449, 1032.4940779018302, 1035.8498017787454, 707.4022451028873, 721.9819504512377, 771.4561234329784, 772.6754762999553, 774.1407038187607, 15230.0, 15329.080255184725, 15336.079835209923, 15347.309371078329, 15357.539273821803, 12931.676708082374, 13188.406521706545, 13279.004074694436, 13343.532976345781, 13356.465741370333, 10246.231532635082, 10323.380597164194, 10326.483675816255, 10699.0, 11062.22564420491, 3542.982285088558, 3569.268299998494, 3594.6045934947133, 3650.7261955353188, 3813.7521061130938, 83704.0, 83836.58081709614, 83880.0, 86055.13944860596, 86605.0, 9179.908200918038, 9248.583813728399, 9360.953195234117, 9586.281028922858, 10003.249756268164, 21651.56696866054, 21684.0, 21844.0, 21892.45268868291, 22063.66904496434, 7796.649150788228, 7870.685172593032, 8064.032316121986, 8131.878021829677, 8267.421280510427, 4290.592393722592, 4324.805383757738, 4326.0, 4375.343698445195, 4452.260101514743, 3832.5017747692623, 3904.8047597620007, 3906.9609303907164, 3910.2179564087296, 3911.530616326059, 694.6006046523169, 705.3087973785616, 722.3282347416848, 722.8120688620996, 728.388153950684, 539.8083680293518, 553.5184389581091, 573.8708790522182, 608.2913405882186, 618.1253526260291, 6895.655217239118, 7201.3158749918675, 7746.302832744967, 8223.835523289501, 8812.955935220283, 507.24167369781674, 600.942910423509, 612.4579746924004, 623.6133597169784, 626.5614070150913, 3834.175652234783, 3947.703922205846, 3961.7821019844187, 4025.4163146343617, 4054.5945405459806, 86137.56931215303, 89340.5532972344, 89846.65230021554, 89929.55035224782, 90059.54970225107, 72820.0, 77513.61243193748, 77750.0, 78927.60536197282, 79970.0, 59938.70030649819, 61559.0, 69816.99999999898, 70285.64857175783, 71484.0, 8614.526201059001, 8679.696210632597, 8693.956530217309, 8759.693410730848, 8986.640534378552, 47861.76069119771, 49045.50954490552, 50272.497275026784, 51075.74462127666, 51685.0, 64242.0, 65062.0, 66350.66824665846, 66468.6676566614, 66470.0, 11080.05819505351, 11130.499127539118, 11415.486303116213, 11542.480588373712, 11806.527738890349, 11807.291562506278, 11811.409429528661, 12060.939695301819, 12065.819012714992, 12415.130940834055, 11602.361870097226, 11651.88348116508, 11655.358955257543, 11861.822072669089, 11886.28682279066, 11280.774384512428, 11742.941285293518, 11801.704957376134, 11804.58683946092, 11869.643910682693, 11500.712482187677, 11796.292222466336, 11860.288382697066, 11907.821382679094, 12086.879131208576, 8571.228589426732, 9855.704328870146, 10022.849657255001, 10091.293609447563, 10315.742106447398, 9752.512374381395, 9872.851907221253, 9986.230670932939, 10102.141317988053, 10125.392476451436], "value": 7094.794095645492, "unit": "score"}], "name": "dromaeo_css", "value": 7557.912951051644, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 120.0, 113.0, 113.0, 112.0, 114.0, 114.0, 114.0, 135.0], "value": 116.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 119.0, 141.0, 163.0, 119.0, 139.0, 136.0, 117.0, 167.0, 117.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 186.0, 184.0, 188.0, 184.0, 186.0, 184.0, 183.0, 181.0, 184.0], "value": 184.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 79.0, 73.0, 153.0, 56.0, 56.0, 56.0, 62.0, 131.0, 54.0], "value": 78.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 144.0, 79.0, 77.0, 80.0, 123.0, 79.0, 77.0, 124.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 87.0, 88.0, 85.0, 89.0, 87.0, 88.0, 86.0], "value": 87.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 92.0, 92.0, 93.0, 93.0, 93.0, 92.0, 93.0], "value": 92.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 83.0, 86.0, 83.0, 84.0, 83.0, 82.0, 84.0, 83.0], "value": 83.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 62.0, 61.0, 61.0, 63.0, 62.0, 78.0, 58.0, 55.0], "value": 62.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 82.0, 105.0, 104.0, 95.0, 66.0, 66.0, 66.0, 65.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 78.0, 79.0, 79.0, 78.0, 78.0, 76.0, 82.0, 82.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 126.0, 128.0, 126.0, 126.0, 127.0, 139.0, 122.0, 144.0, 131.0], "value": 129.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 159.0, 162.0, 167.0, 162.0, 162.0, 162.0, 172.0, 161.0, 161.0], "value": 163.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 80.0, 97.0, 96.0, 70.0, 66.0, 68.0, 68.0, 67.0, 81.0], "value": 74.9, "unit": "score"}], "name": "kraken", "value": 1463.8, "alertThreshold": 2.0}]} 23:44:56 INFO - Return code: 0 23:44:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:44:56 ERROR - # TBPL SUCCESS # 23:44:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:44:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:44:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:44:56 INFO - 2016-07-18 23:44:56.748 screenresolution[1678:10032] starting screenresolution argv=screenresolution get 23:44:56 INFO - 2016-07-18 23:44:56.751 screenresolution[1678:10032] Display 0: 1600x1200x32@60 23:44:56 INFO - 2016-07-18 23:44:56.757 screenresolution[1679:10035] starting screenresolution argv=screenresolution list 23:44:56 INFO - Available Modes on Display 0 23:44:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:44:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:44:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:44:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:44:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:44:56 INFO - Intel Iris: 23:44:56 INFO - Chipset Model: Intel Iris 23:44:56 INFO - Type: GPU 23:44:56 INFO - Bus: Built-In 23:44:56 INFO - VRAM (Dynamic, Max): 1536 MB 23:44:56 INFO - Vendor: Intel (0x8086) 23:44:56 INFO - Device ID: 0x0a2e 23:44:56 INFO - Revision ID: 0x0009 23:44:56 INFO - Displays: 23:44:56 INFO - Display: 23:44:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:44:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:44:56 INFO - Display Serial Number: 1600x1200 60 23:44:56 INFO - Main Display: Yes 23:44:56 INFO - Mirror: Off 23:44:56 INFO - Online: Yes 23:44:56 INFO - Rotation: Supported 23:44:56 INFO - Return code: 0 23:44:56 INFO - Running post-action listener: _resource_record_post_action 23:44:56 INFO - Running post-run listener: _resource_record_post_run 23:44:58 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 38155776; Write bytes: 493785600; Read time: 381; Write time: 2366 23:44:58 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194816512; Write bytes: 194568192; Read time: 17562; Write time: 352 23:44:58 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 36374016; Write bytes: 298205696; Read time: 362; Write time: 2010 23:44:58 INFO - Running post-run listener: _upload_blobber_files 23:44:58 INFO - Blob upload gear active. 23:44:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:44:58 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 23:44:58 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'] 23:44:58 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 23:44:58 INFO - (blobuploader) - INFO - Open directory for files ... 23:44:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:44:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:44:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:44:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:44:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:44:59 INFO - (blobuploader) - INFO - Done attempting. 23:44:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:44:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:44:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:45:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:45:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:45:00 INFO - (blobuploader) - INFO - Done attempting. 23:45:00 INFO - (blobuploader) - INFO - Iteration through files over. 23:45:00 INFO - Return code: 0 23:45:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:45:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:45:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e84fa7c9c49dfb71978a9c70b6a3ddf82ddb166b1050c3ed00a880404ac095662ac5732624552c76c96a36d0a4b07e298cf0a1a5010f4a337136387d8eb0b75d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c9eff70e52bafc332fb535773058f07d877c7c9aab2a02bf21631c89eb1a498ffb5af9af3ab41da6d32269ebcb789839017bd594fac96759f81de9f34a8befa8"} 23:45:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:45:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:45:00 INFO - Contents: 23:45:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e84fa7c9c49dfb71978a9c70b6a3ddf82ddb166b1050c3ed00a880404ac095662ac5732624552c76c96a36d0a4b07e298cf0a1a5010f4a337136387d8eb0b75d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c9eff70e52bafc332fb535773058f07d877c7c9aab2a02bf21631c89eb1a498ffb5af9af3ab41da6d32269ebcb789839017bd594fac96759f81de9f34a8befa8"} 23:45:00 INFO - Running post-run listener: copy_logs_to_upload_dir 23:45:00 INFO - Copying logs to upload dir... 23:45:00 INFO - mkdir: /builds/slave/test/build/upload/logs 23:45:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.526947 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-18 23:45:00.937618) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 23:45:00.941325) ========= 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.P9StSqlRz9/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.dNcfBoPn1I/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e84fa7c9c49dfb71978a9c70b6a3ddf82ddb166b1050c3ed00a880404ac095662ac5732624552c76c96a36d0a4b07e298cf0a1a5010f4a337136387d8eb0b75d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c9eff70e52bafc332fb535773058f07d877c7c9aab2a02bf21631c89eb1a498ffb5af9af3ab41da6d32269ebcb789839017bd594fac96759f81de9f34a8befa8"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468876917/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011218 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468876917/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e84fa7c9c49dfb71978a9c70b6a3ddf82ddb166b1050c3ed00a880404ac095662ac5732624552c76c96a36d0a4b07e298cf0a1a5010f4a337136387d8eb0b75d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c9eff70e52bafc332fb535773058f07d877c7c9aab2a02bf21631c89eb1a498ffb5af9af3ab41da6d32269ebcb789839017bd594fac96759f81de9f34a8befa8"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 23:45:00.978483) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 23:45:00.979292) ========= 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.P9StSqlRz9/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.dNcfBoPn1I/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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.005021 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 23:45:01.029596) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 23:45:01.029911) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 23:45:01.030245) ========= ========= Total master_lag: 0.28 =========