builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0232 starttime: 1468465685.19 results: success (0) buildid: 20160708005359 builduid: 4495d366d0f74df0ab8635fef256276d revision: 60d09be974d615ae5c7fa1129516dbd0a6884dc5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 20:08:05.187398) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 20:08:05.187859) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 20:08:05.188152) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 20:08:05.214027) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 20:08:05.214401) ========= 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.ZbcPeq1NoB/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.Ol5hwJmiMI/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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-13 20:08:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.9M=0.001s 2016-07-13 20:08:05 (18.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109399 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 20:08:05.346234) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 20:08:05.346553) ========= 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.ZbcPeq1NoB/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.Ol5hwJmiMI/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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.025568 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 20:08:05.395272) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 20:08:05.395640) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 60d09be974d615ae5c7fa1129516dbd0a6884dc5 --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 60d09be974d615ae5c7fa1129516dbd0a6884dc5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZbcPeq1NoB/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.Ol5hwJmiMI/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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-13 20:08:05,476 truncating revision to first 12 chars 2016-07-13 20:08:05,476 Setting DEBUG logging. 2016-07-13 20:08:05,476 attempt 1/10 2016-07-13 20:08:05,477 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/60d09be974d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 20:08:06,506 unpacking tar archive at: mozilla-beta-60d09be974d6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.296599 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 20:08:06.714339) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 20:08:06.714670) ========= script_repo_revision: 60d09be974d615ae5c7fa1129516dbd0a6884dc5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 20:08:06.715101) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 20:08:06.715374) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 20:08:06.733809) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-07-13 20:08:06.734486) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZbcPeq1NoB/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.Ol5hwJmiMI/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 20:08:06 INFO - MultiFileLogger online at 20160713 20:08:06 in /builds/slave/test 20:08:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 20:08:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:08:06 INFO - {'append_to_log': False, 20:08:06 INFO - 'base_work_dir': '/builds/slave/test', 20:08:06 INFO - 'blob_upload_branch': 'Mozilla-Beta', 20:08:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:08:06 INFO - 'branch': 'Mozilla-Beta', 20:08:06 INFO - 'buildbot_json_path': 'buildprops.json', 20:08:06 INFO - 'config_files': ('talos/mac_config.py',), 20:08:06 INFO - 'default_actions': ('clobber', 20:08:06 INFO - 'read-buildbot-config', 20:08:06 INFO - 'download-and-extract', 20:08:06 INFO - 'populate-webroot', 20:08:06 INFO - 'create-virtualenv', 20:08:06 INFO - 'install', 20:08:06 INFO - 'run-tests'), 20:08:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:08:06 INFO - 'download_minidump_stackwalk': True, 20:08:06 INFO - 'download_symbols': 'ondemand', 20:08:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:08:06 INFO - 'tooltool.py': '/tools/tooltool.py', 20:08:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:08:06 INFO - '/tools/misc-python/virtualenv.py')}, 20:08:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:08:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:08:06 INFO - 'installer_path': 'installer.exe', 20:08:06 INFO - 'log_level': 'info', 20:08:06 INFO - 'log_name': 'talos', 20:08:06 INFO - 'log_to_console': True, 20:08:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:08:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:08:06 INFO - 'opt_config_files': (), 20:08:06 INFO - 'pip_index': False, 20:08:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:08:06 INFO - 'cmd': ('bash', 20:08:06 INFO - '-c', 20:08:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:08:06 INFO - 'enabled': True, 20:08:06 INFO - 'halt_on_failure': False, 20:08:06 INFO - 'name': 'check_screen_resolution'},), 20:08:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:08:06 INFO - 'cmd': ('bash', 20:08:06 INFO - '-c', 20:08:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:08:06 INFO - 'enabled': True, 20:08:06 INFO - 'halt_on_failure': False, 20:08:06 INFO - 'name': 'check_screen_resolution'},), 20:08:06 INFO - 'run_cmd_checks_enabled': True, 20:08:06 INFO - 'sps_profile': False, 20:08:06 INFO - 'sps_profile_interval': 0, 20:08:06 INFO - 'suite': 'dromaeojs-e10s', 20:08:06 INFO - 'system_bits': '32', 20:08:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:08:06 INFO - 'title': 't-yosemite-r7-0232', 20:08:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:08:06 INFO - 'use_talos_json': True, 20:08:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:08:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:08:06 INFO - 'work_dir': 'build'} 20:08:06 INFO - ##### 20:08:06 INFO - ##### Running clobber step. 20:08:06 INFO - ##### 20:08:06 INFO - Running pre-action listener: _resource_record_pre_action 20:08:06 INFO - Running main action method: clobber 20:08:06 INFO - rmtree: /builds/slave/test/build 20:08:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:08:08 INFO - Running post-action listener: _resource_record_post_action 20:08:08 INFO - ##### 20:08:08 INFO - ##### Running read-buildbot-config step. 20:08:08 INFO - ##### 20:08:08 INFO - Running pre-action listener: _resource_record_pre_action 20:08:08 INFO - Running main action method: read_buildbot_config 20:08:08 INFO - Using buildbot properties: 20:08:08 INFO - { 20:08:08 INFO - "project": "", 20:08:08 INFO - "product": "firefox", 20:08:08 INFO - "script_repo_revision": "production", 20:08:08 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 20:08:08 INFO - "repository": "", 20:08:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 20:08:08 INFO - "buildid": "20160708005359", 20:08:08 INFO - "pgo_build": "False", 20:08:08 INFO - "basedir": "/builds/slave/test", 20:08:08 INFO - "buildnumber": 39, 20:08:08 INFO - "slavename": "t-yosemite-r7-0232", 20:08:08 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 20:08:08 INFO - "platform": "yosemite_r7", 20:08:08 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 20:08:08 INFO - "branch": "mozilla-beta", 20:08:08 INFO - "repo_path": "releases/mozilla-beta", 20:08:08 INFO - "revision": "60d09be974d615ae5c7fa1129516dbd0a6884dc5", 20:08:08 INFO - "stage_platform": "macosx64", 20:08:08 INFO - "builduid": "4495d366d0f74df0ab8635fef256276d", 20:08:08 INFO - "slavebuilddir": "test" 20:08:08 INFO - } 20:08:08 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.dmg. 20:08:08 INFO - Running post-action listener: _resource_record_post_action 20:08:08 INFO - ##### 20:08:08 INFO - ##### Running download-and-extract step. 20:08:08 INFO - ##### 20:08:08 INFO - Running pre-action listener: _resource_record_pre_action 20:08:08 INFO - Running main action method: download_and_extract 20:08:08 INFO - mkdir: /builds/slave/test/build/tests 20:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:08 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.test_packages.json 20:08:08 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 20:08:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/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 20:08:09 INFO - Downloaded 1165 bytes. 20:08:09 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 20:08:09 INFO - Using the following test package requirements: 20:08:09 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 20:08:09 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:08:09 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 20:08:09 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:08:09 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 20:08:09 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 20:08:09 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:08:09 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 20:08:09 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 20:08:09 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:08:09 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 20:08:09 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:08:09 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 20:08:09 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:08:09 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 20:08:09 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:08:09 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 20:08:09 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 20:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:09 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.common.tests.zip 20:08:09 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 20:08:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/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 20:08:11 INFO - Downloaded 18351484 bytes. 20:08:11 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'] 20:08:11 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 20:08:14 INFO - Return code: 0 20:08:14 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 20:08:14 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')]} 20:08:14 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.common.tests.zip 20:08:14 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 20:08:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/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 20:08:14 INFO - Downloaded 18351484 bytes. 20:08:14 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'] 20:08:14 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 20:08:18 INFO - Return code: 0 20:08:18 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')]} 20:08:18 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.talos.tests.zip 20:08:18 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 20:08:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/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 20:08:21 INFO - Downloaded 10840145 bytes. 20:08:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:08:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 20:08:21 INFO - Return code: 0 20:08: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')]} 20:08:21 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.dmg 20:08:21 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 20:08:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 20:08:36 INFO - Downloaded 86183525 bytes. 20:08:36 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.dmg 20:08:36 INFO - mkdir: /builds/slave/test/properties 20:08:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:08:36 INFO - Writing to file /builds/slave/test/properties/build_url 20:08:36 INFO - Contents: 20:08:36 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.dmg 20:08:36 INFO - Running post-action listener: _resource_record_post_action 20:08:36 INFO - Running post-action listener: set_extra_try_arguments 20:08:36 INFO - ##### 20:08:36 INFO - ##### Running populate-webroot step. 20:08:36 INFO - ##### 20:08:36 INFO - Running pre-action listener: _resource_record_pre_action 20:08:36 INFO - Running main action method: populate_webroot 20:08:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:08:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:08:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:08:36 INFO - '--tppagecycles', 20:08:36 INFO - '7'], 20:08:36 INFO - 'tests': ['tsvgm']}}, 20:08:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:08:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:08:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:08:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:08:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:08:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:08:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:36 INFO - 'talos_options': ['--disable-e10s'], 20:08:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:08:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:08:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:36 INFO - 'talos_options': ['--disable-e10s'], 20:08:36 INFO - 'tests': ['damp', 'tps']}, 20:08:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:36 INFO - 'tests': ['damp', 'tps']}, 20:08:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:08:36 INFO - 'tests': ['dromaeo_dom']}, 20:08:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:08:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:08:36 INFO - 'tests': ['a11yr', 20:08:36 INFO - 'ts_paint', 20:08:36 INFO - 'tpaint', 20:08:36 INFO - 'sessionrestore', 20:08:36 INFO - 'sessionrestore_no_auto_restore', 20:08:36 INFO - 'tabpaint']}, 20:08:36 INFO - 'other-e10s': {'tests': ['a11yr', 20:08:36 INFO - 'ts_paint', 20:08:36 INFO - 'tpaint', 20:08:36 INFO - 'sessionrestore', 20:08:36 INFO - 'sessionrestore_no_auto_restore', 20:08:36 INFO - 'tabpaint']}, 20:08:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:08:36 INFO - 'ts_paint', 20:08:36 INFO - 'tpaint', 20:08:36 INFO - 'sessionrestore', 20:08:36 INFO - 'sessionrestore_no_auto_restore', 20:08:36 INFO - 'tabpaint']}, 20:08:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:08:36 INFO - 'ts_paint', 20:08:36 INFO - 'tpaint', 20:08:36 INFO - 'sessionrestore', 20:08:36 INFO - 'sessionrestore_no_auto_restore', 20:08:36 INFO - 'tabpaint']}, 20:08:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:08:36 INFO - 'tests': ['a11yr', 20:08:36 INFO - 'ts_paint', 20:08:36 INFO - 'tpaint', 20:08:36 INFO - 'sessionrestore', 20:08:36 INFO - 'sessionrestore_no_auto_restore', 20:08:36 INFO - 'tabpaint']}, 20:08:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:08:36 INFO - 'tests': ['a11yr', 20:08:36 INFO - 'ts_paint', 20:08:36 INFO - 'tpaint', 20:08:36 INFO - 'sessionrestore', 20:08:36 INFO - 'sessionrestore_no_auto_restore', 20:08:36 INFO - 'tabpaint']}, 20:08:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:08:36 INFO - 'tests': ['tsvgx', 20:08:36 INFO - 'tsvgr_opacity', 20:08:36 INFO - 'tart', 20:08:36 INFO - 'tscrollx', 20:08:36 INFO - 'cart']}, 20:08:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:08:36 INFO - 'tsvgr_opacity', 20:08:36 INFO - 'tart', 20:08:36 INFO - 'tscrollx', 20:08:36 INFO - 'cart']}, 20:08:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:36 INFO - 'talos_options': ['--disable-e10s'], 20:08:36 INFO - 'tests': ['tp5o']}, 20:08:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:36 INFO - 'tests': ['tp5o']}, 20:08:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:36 INFO - 'talos_options': ['--disable-e10s', 20:08:36 INFO - '--xperf_path', 20:08:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:08:36 INFO - 'tests': ['tp5n']}, 20:08:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:36 INFO - 'talos_options': ['--xperf_path', 20:08:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:08:36 INFO - 'tests': ['tp5n']}}, 20:08:36 INFO - 'talos.zip': {'path': '', 20:08:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:08:36 INFO - Running post-action listener: _resource_record_post_action 20:08:36 INFO - ##### 20:08:36 INFO - ##### Running create-virtualenv step. 20:08:36 INFO - ##### 20:08:36 INFO - Running pre-action listener: _resource_record_pre_action 20:08:36 INFO - Running main action method: create_virtualenv 20:08:36 INFO - Creating virtualenv /builds/slave/test/build/venv 20:08:36 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 20:08:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:08:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:08:37 INFO - Using real prefix '/tools/python27' 20:08:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:08:37 INFO - Installing distribute.............................................................................................................................................................................................done. 20:08:40 INFO - Installing pip.................done. 20:08:40 INFO - Return code: 0 20:08:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd03420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93825cc6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db92e00>, '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 0x10d9fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db8db20>, '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.ZbcPeq1NoB/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.Ol5hwJmiMI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 20:08:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:08:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:08:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZbcPeq1NoB/Render', 20:08:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:40 INFO - 'HOME': '/Users/cltbld', 20:08:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:40 INFO - 'LOGNAME': 'cltbld', 20:08:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:40 INFO - 'MOZ_NO_REMOTE': '1', 20:08:40 INFO - 'NO_EM_RESTART': '1', 20:08:40 INFO - 'PAGER': '/bin/cat', 20:08:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:40 INFO - 'PWD': '/builds/slave/test', 20:08:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:40 INFO - 'SHELL': '/bin/bash', 20:08:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ol5hwJmiMI/Listeners', 20:08:40 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 20:08:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:40 INFO - 'USER': 'cltbld', 20:08:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:40 INFO - 'XPC_FLAGS': '0x0', 20:08:40 INFO - 'XPC_SERVICE_NAME': '0', 20:08:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:40 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 20:08:40 INFO - Cleaning up... 20:08:40 INFO - Return code: 0 20:08:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10dcf3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd03420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93825cc6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db92e00>, '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 0x10d9fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db8db20>, '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.ZbcPeq1NoB/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.Ol5hwJmiMI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 20:08:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 20:08:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:08:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZbcPeq1NoB/Render', 20:08:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:40 INFO - 'HOME': '/Users/cltbld', 20:08:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:40 INFO - 'LOGNAME': 'cltbld', 20:08:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:40 INFO - 'MOZ_NO_REMOTE': '1', 20:08:40 INFO - 'NO_EM_RESTART': '1', 20:08:40 INFO - 'PAGER': '/bin/cat', 20:08:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:40 INFO - 'PWD': '/builds/slave/test', 20:08:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:40 INFO - 'SHELL': '/bin/bash', 20:08:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ol5hwJmiMI/Listeners', 20:08:40 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 20:08:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:40 INFO - 'USER': 'cltbld', 20:08:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:40 INFO - 'XPC_FLAGS': '0x0', 20:08:40 INFO - 'XPC_SERVICE_NAME': '0', 20:08:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:41 INFO - Downloading/unpacking psutil>=0.7.1 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:08:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:08:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:08:44 INFO - Installing collected packages: psutil 20:08:44 INFO - Running setup.py install for psutil 20:08:44 INFO - building 'psutil._psutil_osx' extension 20:08:44 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 20:08:45 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 20:08:45 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 20:08:45 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 20:08:45 INFO - building 'psutil._psutil_posix' extension 20:08:45 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 20:08:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:08:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:08:45 INFO - ^ 20:08:45 INFO - 1 warning generated. 20:08:45 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 20:08:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:08:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:08:45 INFO - Successfully installed psutil 20:08:45 INFO - Cleaning up... 20:08:46 INFO - Return code: 0 20:08:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:08:46 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')]} 20:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:46 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')]} 20:08:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:46 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 0x10dcf3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd03420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93825cc6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db92e00>, '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 0x10d9fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db8db20>, '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.ZbcPeq1NoB/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.Ol5hwJmiMI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 20:08:46 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 20:08:46 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 20:08:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZbcPeq1NoB/Render', 20:08:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:46 INFO - 'HOME': '/Users/cltbld', 20:08:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:46 INFO - 'LOGNAME': 'cltbld', 20:08:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:46 INFO - 'MOZ_NO_REMOTE': '1', 20:08:46 INFO - 'NO_EM_RESTART': '1', 20:08:46 INFO - 'PAGER': '/bin/cat', 20:08:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:46 INFO - 'PWD': '/builds/slave/test', 20:08:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:46 INFO - 'SHELL': '/bin/bash', 20:08:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ol5hwJmiMI/Listeners', 20:08:46 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 20:08:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:46 INFO - 'USER': 'cltbld', 20:08:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:46 INFO - 'XPC_FLAGS': '0x0', 20:08:46 INFO - 'XPC_SERVICE_NAME': '0', 20:08:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:08:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:08:48 INFO - Installing collected packages: mozsystemmonitor 20:08:48 INFO - Running setup.py install for mozsystemmonitor 20:08:48 INFO - Successfully installed mozsystemmonitor 20:08:48 INFO - Cleaning up... 20:08:49 INFO - Return code: 0 20:08:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10dcf3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd03420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93825cc6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db92e00>, '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 0x10d9fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db8db20>, '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.ZbcPeq1NoB/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.Ol5hwJmiMI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 20:08:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:08:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:08:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZbcPeq1NoB/Render', 20:08:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:49 INFO - 'HOME': '/Users/cltbld', 20:08:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:49 INFO - 'LOGNAME': 'cltbld', 20:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:49 INFO - 'MOZ_NO_REMOTE': '1', 20:08:49 INFO - 'NO_EM_RESTART': '1', 20:08:49 INFO - 'PAGER': '/bin/cat', 20:08:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:49 INFO - 'PWD': '/builds/slave/test', 20:08:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:49 INFO - 'SHELL': '/bin/bash', 20:08:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ol5hwJmiMI/Listeners', 20:08:49 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 20:08:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:49 INFO - 'USER': 'cltbld', 20:08:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:49 INFO - 'XPC_FLAGS': '0x0', 20:08:49 INFO - 'XPC_SERVICE_NAME': '0', 20:08:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:49 INFO - Downloading/unpacking blobuploader==1.2.4 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08:51 INFO - Downloading blobuploader-1.2.4.tar.gz 20:08:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:08:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:08:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:53 INFO - Downloading docopt-0.6.1.tar.gz 20:08:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:08:53 INFO - Installing collected packages: blobuploader, requests, docopt 20:08:53 INFO - Running setup.py install for blobuploader 20:08:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:08:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:08:53 INFO - Running setup.py install for requests 20:08:53 INFO - Running setup.py install for docopt 20:08:53 INFO - Successfully installed blobuploader requests docopt 20:08:53 INFO - Cleaning up... 20:08:54 INFO - Return code: 0 20:08:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:08:54 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')]} 20:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:54 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')]} 20:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:54 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 0x10dcf3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd03420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93825cc6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db92e00>, '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 0x10d9fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db8db20>, '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.ZbcPeq1NoB/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.Ol5hwJmiMI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 20:08:54 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 20:08:54 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 20:08:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZbcPeq1NoB/Render', 20:08:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:54 INFO - 'HOME': '/Users/cltbld', 20:08:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:54 INFO - 'LOGNAME': 'cltbld', 20:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:54 INFO - 'MOZ_NO_REMOTE': '1', 20:08:54 INFO - 'NO_EM_RESTART': '1', 20:08:54 INFO - 'PAGER': '/bin/cat', 20:08:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:54 INFO - 'PWD': '/builds/slave/test', 20:08:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:54 INFO - 'SHELL': '/bin/bash', 20:08:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ol5hwJmiMI/Listeners', 20:08:54 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 20:08:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:54 INFO - 'USER': 'cltbld', 20:08:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:54 INFO - 'XPC_FLAGS': '0x0', 20:08:54 INFO - 'XPC_SERVICE_NAME': '0', 20:08:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:08:54 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-2WKQVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:08:54 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-wySW0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:08:54 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-PJ7fFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:08:54 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-VQZyHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:08:54 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-gmo9VW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:08:54 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-mVgXWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:08:54 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-SXoR6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:08:55 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-72QjvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:08:55 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-3rts0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:08:55 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-UBQXsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:08:55 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-HTB0_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:08:55 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-QdZG8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:08:55 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-_J77uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:08:55 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-OnPm1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:55 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-mdoywY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:08:55 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-6QT4Nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:08:55 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-0gGuxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:08:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:08:56 INFO - Running setup.py install for manifestparser 20:08:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:08:56 INFO - Running setup.py install for mozcrash 20:08:56 INFO - Running setup.py install for mozdebug 20:08:56 INFO - Running setup.py install for mozdevice 20:08:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:08:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:08:56 INFO - Running setup.py install for mozfile 20:08:56 INFO - Running setup.py install for mozhttpd 20:08:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:08:56 INFO - Running setup.py install for mozinfo 20:08:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:08:57 INFO - Running setup.py install for mozInstall 20:08:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:08:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:08:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:08:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:08:57 INFO - Running setup.py install for mozleak 20:08:57 INFO - Running setup.py install for mozlog 20:08:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:08:57 INFO - Running setup.py install for moznetwork 20:08:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:08:57 INFO - Running setup.py install for mozprocess 20:08:57 INFO - Running setup.py install for mozprofile 20:08:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:08:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:08:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:08:58 INFO - Running setup.py install for mozrunner 20:08:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:08:58 INFO - Running setup.py install for mozscreenshot 20:08:58 INFO - Running setup.py install for moztest 20:08:58 INFO - Running setup.py install for mozversion 20:08:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:08:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:08:58 INFO - Cleaning up... 20:08:58 INFO - Return code: 0 20:08:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:58 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 0x10dcf3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd03420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93825cc6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db92e00>, '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 0x10d9fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db8db20>, '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.ZbcPeq1NoB/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.Ol5hwJmiMI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 20:08:58 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 20:08:58 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 20:08:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZbcPeq1NoB/Render', 20:08:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:58 INFO - 'HOME': '/Users/cltbld', 20:08:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:58 INFO - 'LOGNAME': 'cltbld', 20:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:58 INFO - 'MOZ_NO_REMOTE': '1', 20:08:58 INFO - 'NO_EM_RESTART': '1', 20:08:58 INFO - 'PAGER': '/bin/cat', 20:08:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:58 INFO - 'PWD': '/builds/slave/test', 20:08:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:58 INFO - 'SHELL': '/bin/bash', 20:08:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ol5hwJmiMI/Listeners', 20:08:58 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 20:08:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:58 INFO - 'USER': 'cltbld', 20:08:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:58 INFO - 'XPC_FLAGS': '0x0', 20:08:58 INFO - 'XPC_SERVICE_NAME': '0', 20:08:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:08:58 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-dEv6_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:08:59 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)) 20:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:08:59 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-ojYhM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:08:59 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)) 20:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:08:59 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-Mmh2sN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:08:59 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)) 20:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:08:59 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-QZf_W_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:08:59 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)) 20:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:08:59 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-EqaR22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:08:59 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)) 20:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:08:59 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-a6cC2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:08:59 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)) 20:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:08:59 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-_erVzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:08:59 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)) 20:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:08:59 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-aweCH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:08:59 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)) 20:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:08:59 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-HjWlw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:08:59 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)) 20:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:08:59 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-FZo9FB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:08:59 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)) 20:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:08:59 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-EpINeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:09:00 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)) 20:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:09:00 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-pnrZtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:09:00 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)) 20:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:09:00 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-J2sr02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:09:00 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)) 20:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:09:00 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-D2Uz_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:09:00 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)) 20:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:00 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-Oyvxz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:00 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)) 20:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:09:00 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-2FgIU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:09:00 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)) 20:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:09:00 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-4Q6HJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:09:00 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)) 20:09:00 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)) 20:09:00 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)) 20:09:00 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)) 20:09:00 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)) 20:09:00 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)) 20:09:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:09:00 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 20:09:00 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 20:09:00 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 20:09:00 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 20:09:00 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 20:09:00 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 20:09:03 INFO - Downloading blessings-1.6.tar.gz 20:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:09:03 INFO - Installing collected packages: blessings 20:09:03 INFO - Running setup.py install for blessings 20:09:03 INFO - Successfully installed blessings 20:09:03 INFO - Cleaning up... 20:09:03 INFO - Return code: 0 20:09:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:09:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:09:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:09:03 INFO - Reading from file tmpfile_stdout 20:09:03 INFO - Current package versions: 20:09:03 INFO - blessings == 1.6 20:09:03 INFO - blobuploader == 1.2.4 20:09:03 INFO - docopt == 0.6.1 20:09:03 INFO - manifestparser == 1.1 20:09:03 INFO - mozInstall == 1.12 20:09:03 INFO - mozcrash == 0.17 20:09:03 INFO - mozdebug == 0.1 20:09:03 INFO - mozdevice == 0.48 20:09:03 INFO - mozfile == 1.2 20:09:03 INFO - mozhttpd == 0.7 20:09:03 INFO - mozinfo == 0.9 20:09:03 INFO - mozleak == 0.1 20:09:03 INFO - mozlog == 3.1 20:09:03 INFO - moznetwork == 0.27 20:09:03 INFO - mozprocess == 0.22 20:09:03 INFO - mozprofile == 0.28 20:09:03 INFO - mozrunner == 6.11 20:09:03 INFO - mozscreenshot == 0.1 20:09:03 INFO - mozsystemmonitor == 0.0 20:09:03 INFO - moztest == 0.7 20:09:03 INFO - mozversion == 1.4 20:09:03 INFO - psutil == 3.1.1 20:09:03 INFO - requests == 1.2.3 20:09:03 INFO - wsgiref == 0.1.2 20:09:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:03 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 0x10dcf3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd03420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93825cc6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db92e00>, '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 0x10d9fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db8db20>, '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.ZbcPeq1NoB/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.Ol5hwJmiMI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 20:09:03 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 20:09:03 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 20:09:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZbcPeq1NoB/Render', 20:09:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:03 INFO - 'HOME': '/Users/cltbld', 20:09:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:03 INFO - 'LOGNAME': 'cltbld', 20:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:03 INFO - 'MOZ_NO_REMOTE': '1', 20:09:03 INFO - 'NO_EM_RESTART': '1', 20:09:03 INFO - 'PAGER': '/bin/cat', 20:09:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:03 INFO - 'PWD': '/builds/slave/test', 20:09:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:03 INFO - 'SHELL': '/bin/bash', 20:09:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ol5hwJmiMI/Listeners', 20:09:03 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 20:09:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:03 INFO - 'USER': 'cltbld', 20:09:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:03 INFO - 'XPC_FLAGS': '0x0', 20:09:03 INFO - 'XPC_SERVICE_NAME': '0', 20:09:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:04 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)) 20:09:04 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)) 20:09:04 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)) 20:09:04 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)) 20:09:04 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)) 20:09:04 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)) 20:09:04 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)) 20:09:04 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)) 20:09:04 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)) 20:09:04 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)) 20:09:04 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)) 20:09:04 INFO - Cleaning up... 20:09:04 INFO - Return code: 0 20:09:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:09:04 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')]} 20:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:04 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')]} 20:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:04 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 0x10dcf3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd03420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93825cc6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db92e00>, '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 0x10d9fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db8db20>, '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.ZbcPeq1NoB/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.Ol5hwJmiMI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 20:09:04 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 20:09:04 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 20:09:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZbcPeq1NoB/Render', 20:09:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:04 INFO - 'HOME': '/Users/cltbld', 20:09:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:04 INFO - 'LOGNAME': 'cltbld', 20:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:04 INFO - 'MOZ_NO_REMOTE': '1', 20:09:04 INFO - 'NO_EM_RESTART': '1', 20:09:04 INFO - 'PAGER': '/bin/cat', 20:09:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:04 INFO - 'PWD': '/builds/slave/test', 20:09:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:04 INFO - 'SHELL': '/bin/bash', 20:09:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ol5hwJmiMI/Listeners', 20:09:04 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 20:09:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:04 INFO - 'USER': 'cltbld', 20:09:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:04 INFO - 'XPC_FLAGS': '0x0', 20:09:04 INFO - 'XPC_SERVICE_NAME': '0', 20:09:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:04 INFO - Downloading/unpacking jsonschema 20:09:04 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 20:09:04 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 20:09:04 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 20:09:04 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 20:09:04 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 20:09:04 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 20:09:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:09:06 INFO - Downloading/unpacking functools32 (from jsonschema) 20:09:06 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 20:09:06 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 20:09:06 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 20:09:06 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 20:09:06 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 20:09:06 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 20:09:07 INFO - Downloading functools32-3.2.3-2.tar.gz 20:09:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:09:07 INFO - warning: no files found matching '*.txt' 20:09:07 INFO - no previously-included directories found matching 'build' 20:09:07 INFO - no previously-included directories found matching 'dist' 20:09:07 INFO - no previously-included directories found matching '.git*' 20:09:07 INFO - Installing collected packages: jsonschema, functools32 20:09:07 INFO - Running setup.py install for functools32 20:09:07 INFO - warning: no files found matching '*.txt' 20:09:07 INFO - no previously-included directories found matching 'build' 20:09:07 INFO - no previously-included directories found matching 'dist' 20:09:07 INFO - no previously-included directories found matching '.git*' 20:09:07 INFO - Successfully installed jsonschema functools32 20:09:07 INFO - Cleaning up... 20:09:07 INFO - Return code: 0 20:09:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd03420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93825cc6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db92e00>, '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 0x10d9fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db8db20>, '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.ZbcPeq1NoB/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.Ol5hwJmiMI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 20:09:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 20:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:09:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZbcPeq1NoB/Render', 20:09:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:07 INFO - 'HOME': '/Users/cltbld', 20:09:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:07 INFO - 'LOGNAME': 'cltbld', 20:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:07 INFO - 'MOZ_NO_REMOTE': '1', 20:09:07 INFO - 'NO_EM_RESTART': '1', 20:09:07 INFO - 'PAGER': '/bin/cat', 20:09:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:07 INFO - 'PWD': '/builds/slave/test', 20:09:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:07 INFO - 'SHELL': '/bin/bash', 20:09:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ol5hwJmiMI/Listeners', 20:09:07 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 20:09:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:07 INFO - 'USER': 'cltbld', 20:09:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:07 INFO - 'XPC_FLAGS': '0x0', 20:09:07 INFO - 'XPC_SERVICE_NAME': '0', 20:09:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:07 INFO - Downloading/unpacking flake8 20:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:09:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:09:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:09:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:09:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:09:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:09:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:09:11 INFO - no previously-included directories found matching 'docs/_build' 20:09:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:09:11 INFO - Running setup.py install for pep8 20:09:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:09:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:09:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:09:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:09:11 INFO - no previously-included directories found matching 'docs/_build' 20:09:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:09:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:09:11 INFO - Cleaning up... 20:09:11 INFO - Return code: 0 20:09:11 INFO - Running post-action listener: _resource_record_post_action 20:09:11 INFO - Running post-action listener: _start_resource_monitoring 20:09:11 INFO - Starting resource monitoring. 20:09:11 INFO - ##### 20:09:11 INFO - ##### Running install step. 20:09:11 INFO - ##### 20:09:11 INFO - Running pre-action listener: _resource_record_pre_action 20:09:11 INFO - Running main action method: install 20:09:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:09:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:09:12 INFO - Reading from file tmpfile_stdout 20:09:12 INFO - Detecting whether we're running mozinstall >=1.0... 20:09:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:09:12 INFO - Reading from file tmpfile_stdout 20:09:12 INFO - Output received: 20:09:12 INFO - Usage: mozinstall [options] installer 20:09:12 INFO - Options: 20:09:12 INFO - -h, --help show this help message and exit 20:09:12 INFO - -d DEST, --destination=DEST 20:09:12 INFO - Directory to install application into. [default: 20:09:12 INFO - "/builds/slave/test"] 20:09:12 INFO - --app=APP Application being installed. [default: firefox] 20:09:12 INFO - mkdir: /builds/slave/test/build/application 20:09:12 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'] 20:09:12 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 20:09:34 INFO - Reading from file tmpfile_stdout 20:09:34 INFO - Output received: 20:09:34 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 20:09:34 INFO - Running post-action listener: _resource_record_post_action 20:09:34 INFO - ##### 20:09:34 INFO - ##### Running run-tests step. 20:09:34 INFO - ##### 20:09:34 INFO - Running pre-action listener: _resource_record_pre_action 20:09:34 INFO - Running main action method: run_tests 20:09:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:09:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:09:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:09:34 INFO - 2016-07-13 20:09:34.083 screenresolution[1648:7909] starting screenresolution argv=screenresolution get 20:09:34 INFO - 2016-07-13 20:09:34.086 screenresolution[1648:7909] Display 0: 1600x1200x32@60 20:09:34 INFO - 2016-07-13 20:09:34.091 screenresolution[1649:7911] starting screenresolution argv=screenresolution list 20:09:34 INFO - Available Modes on Display 0 20:09:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:09:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:09:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:09:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:09:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:09:34 INFO - Intel Iris: 20:09:34 INFO - Chipset Model: Intel Iris 20:09:34 INFO - Type: GPU 20:09:34 INFO - Bus: Built-In 20:09:34 INFO - VRAM (Dynamic, Max): 1536 MB 20:09:34 INFO - Vendor: Intel (0x8086) 20:09:34 INFO - Device ID: 0x0a2e 20:09:34 INFO - Revision ID: 0x0009 20:09:34 INFO - Displays: 20:09:34 INFO - Display: 20:09:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:09:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:09:34 INFO - Display Serial Number: 1600x1200 60 20:09:34 INFO - Main Display: Yes 20:09:34 INFO - Mirror: Off 20:09:34 INFO - Online: Yes 20:09:34 INFO - Rotation: Supported 20:09:34 INFO - Return code: 0 20:09:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:09:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:09:34 INFO - Python 2.7.3 20:09:34 INFO - Return code: 0 20:09:34 INFO - grabbing minidump binary from tooltool 20:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:34 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 0x10db92e00>, '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 0x10d9fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db8db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:09:34 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 20:09:34 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 20:09:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:09:34 INFO - Return code: 0 20:09:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:09:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:09:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:09:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:09:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:09:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:09:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:09:35 INFO - Return code: 0 20:09:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0232', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0232 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:09:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZbcPeq1NoB/Render', 20:09:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:35 INFO - 'HOME': '/Users/cltbld', 20:09:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:35 INFO - 'LOGNAME': 'cltbld', 20:09:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:09:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:09:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:35 INFO - 'MOZ_NO_REMOTE': '1', 20:09:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:09:35 INFO - 'NO_EM_RESTART': '1', 20:09:35 INFO - 'PAGER': '/bin/cat', 20:09:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:35 INFO - 'PWD': '/builds/slave/test', 20:09:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:09:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:35 INFO - 'SHELL': '/bin/bash', 20:09:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ol5hwJmiMI/Listeners', 20:09:35 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 20:09:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:35 INFO - 'USER': 'cltbld', 20:09:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:35 INFO - 'XPC_FLAGS': '0x0', 20:09:35 INFO - 'XPC_SERVICE_NAME': '0', 20:09:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0232', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:09:35 INFO - mozversion application_buildid: 20160708005359 20:09:35 INFO - mozversion application_changeset: 60d09be974d615ae5c7fa1129516dbd0a6884dc5 20:09:35 INFO - mozversion application_display_name: Firefox 20:09:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:09:35 INFO - mozversion application_name: Firefox 20:09:35 INFO - mozversion application_remotingname: firefox 20:09:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 20:09:35 INFO - mozversion application_vendor: Mozilla 20:09:35 INFO - mozversion application_version: 48.0 20:09:35 INFO - mozversion platform_buildid: 20160708005359 20:09:35 INFO - mozversion platform_changeset: 60d09be974d615ae5c7fa1129516dbd0a6884dc5 20:09:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 20:09:35 INFO - mozversion platform_version: 48.0 20:09:35 INFO - using testdate: 1468465775 20:09:35 INFO - actual date: 1468465775 20:09:35 INFO - starting webserver on 'localhost:49264' 20:09:35 INFO - SUITE-START | Running 2 tests 20:09:35 INFO - TEST-START | dromaeo_css 20:09:35 INFO - operating with platform_type : mac_ 20:09:35 INFO - Initialising browser for dromaeo_css test... 20:09:35 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/tmpHPGHId/profile http://localhost:49264/getInfo.html) 20:09:38 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 20:09:38 INFO - PROCESS | 1667 | colorDepth:24 20:09:38 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 20:09:38 INFO - PROCESS | 1667 | __metrics 20:09:38 ERROR - PROCESS | 1667 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 20:09:39 INFO - TEST-INFO | 1667: exit 0 20:09:39 INFO - Browser initialized. 20:09:39 INFO - Running cycle 1/1 for dromaeo_css test... 20:09:39 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/tmpHPGHId/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:09:51 INFO - PROCESS | 1672 | RSS: Main: 170786816 20:09:51 INFO - PROCESS | 1672 | 20:10:40 INFO - PROCESS | 1672 | 1468465840754 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] 20:12:51 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49264/tests/dromaeo/cssquery-ext.html) 20:12:52 INFO - PROCESS | 1672 | RSS: Main: 182075392 20:12:52 INFO - PROCESS | 1672 | 20:15:54 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-ext.html (next: http://localhost:49264/tests/dromaeo/cssquery-jquery.html) 20:15:55 INFO - PROCESS | 1672 | RSS: Main: 192819200 20:15:55 INFO - PROCESS | 1672 | 20:18:56 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49264/tests/dromaeo/cssquery-mootools.html) 20:18:57 INFO - PROCESS | 1672 | RSS: Main: 194789376 20:18:57 INFO - PROCESS | 1672 | 20:21:59 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49264/tests/dromaeo/cssquery-prototype.html) 20:21:59 INFO - PROCESS | 1672 | RSS: Main: 198602752 20:21:59 INFO - PROCESS | 1672 | 20:25:02 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49264/tests/dromaeo/cssquery-yui.html) 20:25:02 INFO - PROCESS | 1672 | RSS: Main: 197750784 20:25:02 INFO - PROCESS | 1672 | 20:28:04 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-yui.html (next: http://localhost:49264/tests/dromaeo/cssquery-dojo.html) 20:28:05 INFO - PROCESS | 1672 | RSS: Main: 202506240 20:28:05 INFO - PROCESS | 1672 | 20:28:05 INFO - PROCESS | 1672 | __start_tp_report 20:28:05 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 20:28:05 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 20:28:05 INFO - PROCESS | 1672 | |i|pagename|runs| 20:28:05 INFO - PROCESS | 1672 | |0;dojo.html;3652.3608368535506;3717.9070523236933;3736.570294416141;3777.150141218226;3781.3760729479636;6113.083556793957;6128.483736330591;6145.692715364231;6149.508039356852;6150;4521.892136426572;5982.820515384535;6096.828477679209;6154.692265386735;6160.860240855445;4892.339534162896;5092;5434.994526012681;5482.259894914176;5591.4688104630195;4620.907581848361;5428.972855135738;5449.7275136243225;5512.173174023908;5569.415211402805;5533.197686335479;5538.307711536058;5544.112941929292;5557.5831812614015;5561.110222364423;4904.828331008415;5483.698396588186;5568.1091025435935;5577.888442231173;5587;4502.684812063157;5446.155845843861;5462.726863656841;5499.917501237484;5540.778368865281;5395.892082158374;5789;6056.6063205891915;6145.201123853915;6200.62796232223;6289.245290565115;6355;6389.936100638981;6408.391202835724;6427.100205971168;6323.968380158116;6387.425131738166;6441.613503189824;6502.512311576651;6542.771003014872;6143.96928015366;6166.630002199838;6174.197354343952;6174.536909731788;6200.720967556471;6682.298358672367;6685.431738302202;6693.497987650946;6707.5304728668525;6713.160854893138;5239.633225674243;6172.69136543171;6222.471089957405;6239.656818874914;6293.433590976742;6455.838604034937;6462.998235273541;6479.319671434526;6491.058796474485;6556.082148499214;6347.143135676624;6362;6375.458086062737;6388.009858471944;6392.520560957947;6223.96888015566;6303.905441418382;6352.936470635327;6377.64922929234;6398.584092034003;5134.666246693953;5182.4299327073995;5184.300119483897;5192.948070519246;5200.635955483155;3904.2581909437117;4516.345129956204;4647.16351056813;4676.69601475903;4702.388689470347;6172.722227499773;6183.165272688129;6199.752009919643;6240.157578726814;6269.279032911274;6447.967760161169;6454.806355809334;6466.935330646727;6467.611943283418;6474.352564743582;6159.5072394209255;6173.629582225081;6204.689765511706;6260.968695156495;6273.090401891792;5722.62802917809;5748.741306641211;5763.308402991668;5797.188393624896;5804.04233301509;6810.523263371517;6846.965765171242;6874.828129296608;6876.106106206261;6885.311468853175;6343.397377249154;6378.968105159444;6432.710528026157;6473.967630161819;6486.189226346707;6766.357196066366;6787.864242715217;6802.829929251809;6811.182658081062;6833.077534532775;5341.599380046589;6353.888069587896;6354.809355719336;6359.17330747;6364.840878978062;6309.33751956038;6341.778037768656;6390;6428.871422571428;6499.090127382265;6235.937640623536;6289.213848268966;6294.779682711083;6312.400321969406;6312.589681670676;6232.439080482778;6293.937060629335;6299.622022678654;6299.811005669837;6313.779017734358;5187.688738675692;6137.8979746733885;6143.1706719592285;6159.876802463836;6233.688315584293;6268.498520118471;6297.338779428277;6306.46395056407;6317.368263173646;6366.108744775643;6160.383961603804;6181.938180618136;6224.190855188796;6238.095476156022;6259.624422534663 20:28:05 INFO - PROCESS | 1672 | |1;ext.html;564.31999440674;567.7360027587173;579.6666916523001;581.0952881582722;599.1103211730582;35092.82453587732;41125.97185070375;41152.17695646089;41313.58686413139;41364.58635413645;42226.31094756214;42262.78868605661;42658;42915.35626965598;42924;9830.410175389481;9991;10005.949970250174;10039.447830369327;10089.344192627492;8790.51652159131;9839.754006149831;9951.502424878763;10093.343932644355;10119.241056920724;8790.6923257686;9953.104220620142;9954.104130628242;10021.799564008716;10105.949470252675;8747.343949203836;9974.850377244347;9984.301098923079;10081.042300981431;10087.293889427743;8716.869246961302;9940.602375904955;9943.105120539114;9986.750331241705;10082.3364144916;40289.19421611581;40654.593454065376;40689.593104068874;40841;40993;3397.2186397128553;3472.9131771705656;3478.8867562380046;3587.820608969541;3855.5951625079524;29004.854975724986;29096;29836.701632983608;30178.698213017808;30535.541966870514;2806.859657017161;2826.6042754014456;2836.5177919753487;2844.687084420712;2856.128880691388;432523;433532;435443.82278088725;436753;437360;38193.61806381956;38645.80677096653;68118.31881681219;68363.97454038194;68420.6578967102;38621.42067868984;38664.61335386666;38988.025299367175;39029.41455878164;39143.41284880729;16915.23881425339;17085.658286834194;17106.230219640147;17124.914375428292;17160.91419542919;13904.791428128587;13914.582562523141;13957.092788968685;14319.427222911176;14466.132032078109;8615.483071015758;8616.224539791448;8678.86981695275;8760.386772925962;8836.955815220883;3564.9483402396354;3567;3638.7634803737674;3640.0535860675886;3648.3068217038676;977.2279898879948;1031.9989610078212;1038.4889985071702;1079.2660990526517;1131.9943400282946;31364.05907822769;31379;31408.05775826729;31942.840285798422;32096.518552221736;1113.4425510494057;1137.4881303413497;1153.7058050197313;1204.3677069538562;1274.751423472414;15738.606534836492;16185;16279.51161465158;16428.342866285213;16475.91762041206;1017776;1036059;1037275;1041160;1041194;63796.68101659462;65193.34806651968;65775.01337479941;65807;65822.67088664525;1561.9219039048003;1573.8268790433044;1577.8106627204809;1581.6994770993474;1592.283472437408;25702.742972570784;32047.35905281928;32200.516992245604;32439.513407299382;32723.509147362332;56679.43320566742;57631.71184144053;58297.4170258292;58367.70816145892;58515.12227316679;573926;574953;578922.1053894704;581631;583882;29339.973100941366;44567.33149002703;44902.77548612236;46649.53350466588;46702;46098.53901460942;46237.768811157075;46565.3015204779;47141.764291178326;49285.26072108993;38929.6107038926;38946.6105338943;40235.79882100571;40251.39622905717;40252.59747402606;38928.83213503599;39595;39726.60273397345;39888.80055599703;40215.597844022355;37915.43126853044;38861.80569097136;39604.60395396009;39712.80143599379;40410.9897252571;27254.863725681244;27735.722642773315;31221.8438907804;32912.835435822664;35002.12494687653;23830.64254036156;26465;26684.066057687887;27737.21173482078;28135.43729125365 20:28:05 INFO - PROCESS | 1672 | |2;jquery.html;371.2667481723596;376.69487714950907;414.8112608763012;417.4760675352432;421.0379283337574;13406.798898016514;21327.466813329655;21369.145234190633;21739.13043478263;22121;19804.60390792183;19828;21539.46151346217;21742.782572174314;22528;5863.384344643815;5894.705264736756;6132.110843927628;6167.444929956303;6205.255369355684;5423.918641220384;5755.740991655385;6096.085587161939;6189.071639254103;6218.098375735515;5819.6508209507565;6000.279966404016;6062.878742425149;6092.31937947304;6098.115773212881;5821.359650438449;6044.69776511177;6143.9385606143815;6144.0783882417545;6155.969220153893;5872.794452194195;5908.734106965154;5987.2815262168815;5995.910061349084;6004.129401236796;13964.022518423715;14178.503752368617;14318.212498312589;14338.928305358511;14394.928025359806;2129.350548082834;2392.629142482918;2412.883286211884;2463.408781892351;2753.2428582139873;10153.492325383775;10325;10427.270091093627;10459.68620941373;10532;1695.85585225256;1846.658368201887;1877.4836919847014;1877.4836919847014;1924.6054558815408;117792.23311650332;125718;126652;127541.36229318887;127973;12036.45835937385;12168.939155304166;12237.755244895052;12242.816357754462;12269.38653067361;15648.530544083696;15991.760123598155;16011.439599613957;16013.679726405406;16049;8236.217559331853;9413.57638906251;9533.523323833919;9635.325527213168;9635.951820240854;9200.033996430278;9484.810303794024;9571.712848614414;9592;9618.855717164248;4837.419509658793;4888.535589119028;4899.191633380524;4928.408590969107;4960.082384758831;1895.2797936783934;1973.2501649373432;2020.8383329333617;2095.088636443152;2119.4595378178465;920.9179214423026;943.4056544376998;988.7775250568708;1021.9386836789816;1062.6068354708652;21323.893380533307;21329.893350533457;22142.003609837597;22840.086396544284;23362;911.2709832134399;992.503748125937;1023.3041531758475;1041.1306559023149;1050.8896565860475;8680;11391.97472227487;11415.543378264776;11499.425028748696;11503;620340;670592;685991;690640;691777;138942.30528847492;141924;143752.84370734447;144559.2772036154;146140;1111.6609434122508;1116.3357802107732;1126.645106791358;1129.4239937631867;1134.5688638317552;18605.81394186095;18918;19395.709064364328;19425.708614371077;19643.410697679094;42323.365149522164;54747.45252547423;55518;56918.43081569131;57100.14349784674;84278;85102.57448712717;85869.14130858611;87032.69450958114;88900.55549722469;8545.487270763773;8598.312135029308;8629.43908645936;8796.208341249318;8837.646494140163;7979.5611241382285;12613.684657883627;13079.280639564915;13206.735865282833;13423.597292081253;11445.828312575151;11555.826662600235;11567.595134170264;11720.824187637363;11923.701907452383;10211.183105351703;11284.887151128383;11400.429978501208;11419.31484110956;11785.705357366134;11786.941065294619;11800.350980696145;11832.70418239551;11839;12039.819402708792;8083.878741818995;8388.664453421794;8787.428817127122;8821.911780882367;8862;10540.947295263475;11882;11956.222845515014;11979.221350612183;12154.574589889311 20:28:05 INFO - PROCESS | 1672 | |3;mootools.html;1629.7636842657814;1644.210778826163;1921.1450904347562;2008.8292495137912;2067.2351230044887;7840.803979900498;8466.788330291745;9023.684171054014;9255.398399104053;9342.906570934298;9112.589933452993;9187.265018798496;9276.675316363928;9290.628374864997;9303.39527930684;2560.4751026039617;2565.474077814053;2577.6777902762155;2595.2344058502695;2598.8180827342094;2453.4847681986716;2579.9226023219335;2597.4805038992276;2618.4681961052806;2620.0960668569314;2216.74507431645;2585.340738111788;2593.4294455219915;2597.8441293522355;2600.1939398786435;2583.677040369954;2587.0427941661706;2587.637730717701;2601.6747906511687;2635.3543381871373;2571.6913970323494;2580.213035024317;2583.677040369954;2612.3207965928805;2617.424166683327;9159.633614655406;9399.436033837992;9446.00816914221;9450.85823712645;9477.620895164186;5732.369439361709;5763.106718458645;5779.913301300484;5872.911906321408;5916.556258280603;3702.851885924587;3787.9621203787883;3800.4869342638667;3834.9808250958567;3851.4607954886337;923.445932440537;1021.5454122915305;1049.7638031442864;1090.8363745438169;1093.4587379247323;12250.877491225152;12396.938015309956;12629.305388203646;12684.30236337001;12727.74544509114;5108.003939231814;5134.897302053938;5192.143296356135;5192.766325515361;5232.633715639945;10598.364098154136;10607.416592087355;10672.62645807393;10817.350958942332;10875.945620271848;5662.8301150965535;5736.913946290725;5799.2750906136735;5955.255593050869;5963.761449542057;3792.943105853359;5053.974730126326;5152.768125434364;5229.032628963654;5353.946460535345;3727.552693676776;4284.721493102938;4306;4312.331588603772;4385.232584297735;1380.5858242527202;1392.9761625205465;1407.4370251899118;1414.1232435889815;1427.6787722762294;848.8005318750089;868.379108937113;959.6065613098596;973.634886917406;987.7530617345664;6170.475509581735;6180.598261113013;6186.628802271878;6250.781222657185;6282.717277722513;482.9348038014823;486.9975650121727;489.2709862305211;498.925161225819;500.0324372339535;4062.268791617478;4069.348904175318;4156.397322388298;4193.035601811539;4232.322828347511;9635.710928672152;10990.285631433931;11390.715232119263;11490;11541.961223489927;9872.950635246778;10126;10478.685639430829;11313.490892909838;11336.979671829575;8439.409241353047;8733.825323493495;8754.518501482353;8833.779155521164;8837.690680826141;5980.970095149496;6043.3050199227655;6064.545159112996;6132.693365331626;6160.815175544741;9845.507724613884;9892.752681183028;9942.751431214278;9966.50167491608;10066.496675166067;9802.75493112678;10126.443045632266;10219.642312519027;10271.897281027093;10296.742581435525;7171.784846454615;7695.115061767969;7815.92184078152;7941.404394670307;7958.64186111638;8664.696735614223;8733.257673097858;8738.650453981769;8800.515971621622;8809.911900880908;7613.5431874087735;7675.385969122569;7787.5716835574585;7844.4116691247245;7873.5275883447175;7564.697412103455;7594.392448603988;7630.198829123085;7636.732714354971;7733.92266077332;7303.342699157101;7377.5204611700065;7407;7420.183779784112;7434.293742094493;5086.262491938722;5126.589872810241;5206.140986737298;5324.440933701905;5329.73351332424;5178.844634660966;5219.269302297757;5245.737713114406;5407.756650950795;5429.647072940246 20:28:05 INFO - PROCESS | 1672 | |4;prototype.html;298.5491907220097;341.1131059245961;343.5465185954541;348.27211128740936;351.917299434633;7073.08049953506;7090.3618674319305;7098.432125429959;7148.285171482849;7156.212816590178;7077.433805295577;7089.7873063808165;7095.254998225189;7106.751263705772;7119.038929744483;4222.754287485199;4854.417469903617;5157.355330583677;5184.1186998210205;5190.169572868342;4491.663125265602;5106.744662766847;5173.974130129344;5201.271821944931;5205.427402985669;5145.6398052136365;5151.278820965068;5157.690538567679;5170.327857378536;5189.584833213334;5146.330976973007;5147.227915812639;5152.969406118773;5158.896822063538;5160.303359046518;4412.426384570017;4425.380446737459;4428.867133985986;4429.512753597101;4445.377437235418;6516.3157868423605;6753.8649227015185;6780.016897549827;6784.626845523544;6787.185537735454;5940.108983652487;5979.910301345483;5987.101934709828;5990.430909063632;5993.250843644544;7541.660625271821;7551.811204719871;7553.546787192786;7570.16728159902;7585.81035474112;4816.927746083811;4821.638377121695;4824.614030877557;4839.709617422931;4846.80612775492;7711.305982461549;7954.761357159295;8036.4776289541;8050.677972881136;8057.556834374107;3961.544422391404;4652.953470465252;4831.202851529529;4870.391201099863;4925.630577706686;5019.67372120811;5027.99440111979;5032.823851165192;5035.77339019745;5041.949580504222;5984.431479009487;6002.879942401128;6007.969960150259;6018.428249316308;6023.759049638053;7576.204498527575;7590.354819840265;7596.468247222641;7597.012388389474;7619.276168763959;1453.6801903581195;1689.403513679561;1718.1752758675905;1735.9045252511232;1750.1511766793096;926.6015613286216;1082.2965072702807;1091.061686949223;1101.7025403141106;1101.9889801102047;7291.08861392326;7370.447216458787;7374.889376659355;7375.704971801175;7417.109946806418;6660.733570657217;7617.847643047108;7691.961585185928;7766.417518686121;7921.247481489249;7353.595552244571;7384.926150738531;7395.445341599401;7410.592417416986;7435.8141046474275;4169.207850508455;4199.727017743837;4208.915821683549;4211.7888108743155;4217.156568686275;8340.833183336299;8363.247307742333;8416.621252043673;8448.11294814048;8472.618732157067;7864.646090925922;8142.51144931306;8150.184981501921;8234.752957411287;8246.3815213858;8380.329573634095;8450;8451.45065570736;8451.619677114544;8465.915340846635;6741.494387921024;7884.1327453978865;7938.603069846369;7958.761237162895;7983.8802417964935;7553.7356192533;7780.805479863048;7783.805404864697;7797.415193860596;7833;8374.07885132647;8406.495610263404;8418.494890306602;8425.073241943504;8440.240378365976;4895.094407534618;4962.776675049704;4971.627127965345;4978.800847966186;4982.825601103944;7886.921130788619;7926.643301051351;7933.523988560474;7943.126256111938;7970.601469926596;7331.963340183478;7656.119546252252;7675.309222170032;7690.461667683208;7691.384689224737;7563.432742544442;7619.69521219145;7626.771196864103;7631.1605723369275;7676;7449.553026818408;7461.701531938662;7470.663820128216;7478;7489.8876516851205;7127.358537731629;7372.262773722585;7622.2758837910305;7634.656440460081;7653.387728981556;7370.299821516947;7451.515651482637;7481.812954676177;7485.176630570524;7505.774826755206 20:28:05 INFO - PROCESS | 1672 | |5;yui.html;710.8365076032512;771.340503869192;771.4021633234239;781.1641543548405;783.0994356490039;15467.92266038671;15620.140892250922;15959;15962.600934976603;15974.440894568677;12736.299503527302;14291.285435728198;14597.854021459782;14647.780283295733;14708.338124784384;792.8136887831355;924.8751418558476;939.0750111140521;939.6570251858057;950.8621249918775;933.2021121940745;934.0379409208492;949;950.800331930292;975.9268054895875;864.394923553512;1004.2317627015302;1019.7195771162916;1021.1728499915056;1051.1118105201092;992.9602815887356;1012.1295685710284;1012.2711647613706;1012.5443550402348;1042.2704107125005;750.7109762741329;782.3858271257036;782.9569373684445;784.5332027443662;784.6822037074994;15509.844901550952;15622.453214137564;15851;15923.964942278715;16073.839261607469;13519.121257118255;13579.59261222165;13589.980751443582;13667.316634168352;13694.52069177584;10285;10303.124234440007;10353.9482302588;10411.167106631527;10649.893501064967;3598.838052287653;3614.819259037064;3661.286049220403;3737.103095257146;3877.8448862045484;83624;85577.57211213966;87679.12320876773;87791.56104219439;88416;9743.65897193609;9993.350432221881;10051;10067.76861148982;10240.283180177465;22659.773402266095;22925.312240632808;22980.770192298198;24146;24148.154814581405;7779.572123533147;7845.176256492986;7931.920680793233;7974.681012759424;8064.919350806417;4061.4923134608175;4180.916381672349;4264.381664658607;4333.609975102193;4387.122575484916;3727.422249551324;3737.869174578931;3755.549334079928;3799.677027452642;3807.124361396839;660.075893748746;674;678.1963373402534;681.9556728812711;688.3529482286634;549.8405462415855;586.5571493522449;607.8541150123939;610.3987572241339;610.484140900938;7609.885851712229;8450;8461.23848853606;8491.830163396697;8599.828003439896;536.9597280204;580.8054301808857;607.908813677943;625.6246252248615;639.9552031357761;3224.467962786161;3442.294329662413;3963.365861462152;4000.9199816003515;4018.9196216075516;92394;93036;95409;96780.0321996785;97211;51849;64623.67688161529;72396;73204.63397682978;83352;69536.304636954;71064.93402598966;71688;72548.54902901912;73441;8667.133286671282;8766.60550275252;8769;8825.779355516164;8960.462372257685;47083;51389;52168.478315216365;52922.47077529175;53007.469925300255;70836;70966;72364.63817680877;73368;73393.0642774283;11059.778804424028;11143.609973651208;11253.268537545033;11257.71855703614;11616;12123.515059397525;12167.574134905235;12344.197627154206;12345.074119441257;12468.127231093737;11849.526018959144;11886.465109069939;11894.34581098048;11921.52313907434;11945.641630751092;11837.585684501;11855.762884742084;11856.051515878882;12003.279803211835;12158.148929575198;11169.38568378747;11659.941700291443;11810.527578896748;11836.70408239801;12327;9903.801923961624;9956.352837065568;10172.898271017195;10221.33561318512;10287.382757034602;8553.144685531397;9735.269854761063;9826.803463930824;10090.34412763168;10099 20:28:05 INFO - PROCESS | 1672 | __end_tp_report 20:28:05 INFO - PROCESS | 1672 | __start_cc_report 20:28:05 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,395 20:28:05 INFO - PROCESS | 1672 | __end_cc_report 20:28:05 INFO - PROCESS | 1672 | __startTimestamp1468466885122__endTimestamp 20:28:05 INFO - PROCESS | 1672 | 20:28:05 INFO - PROCESS | 1672 | ------- Summary: start ------- 20:28:05 INFO - PROCESS | 1672 | Number of tests: 6 20:28:05 INFO - PROCESS | 1672 | 20:28:05 INFO - PROCESS | 1672 | [#0] dojo.html Cycles:165 Average:5981.40 Median:6224.19 stddev:685.40 (11.0%) stddev-sans-first:662.70 20:28:05 INFO - PROCESS | 1672 | Values: 3652.4 3717.9 3736.6 3777.2 3781.4 6113.1 6128.5 6145.7 6149.5 6150.0 4521.9 5982.8 6096.8 6154.7 6160.9 4892.3 5092.0 5435.0 5482.3 5591.5 4620.9 5429.0 5449.7 5512.2 5569.4 5533.2 5538.3 5544.1 5557.6 5561.1 4904.8 5483.7 5568.1 5577.9 5587.0 4502.7 5446.2 5462.7 5499.9 5540.8 5395.9 5789.0 6056.6 6145.2 6200.6 6289.2 6355.0 6389.9 6408.4 6427.1 6324.0 6387.4 6441.6 6502.5 6542.8 6144.0 6166.6 6174.2 6174.5 6200.7 6682.3 6685.4 6693.5 6707.5 6713.2 5239.6 6172.7 6222.5 6239.7 6293.4 6455.8 6463.0 6479.3 6491.1 6556.1 6347.1 6362.0 6375.5 6388.0 6392.5 6224.0 6303.9 6352.9 6377.6 6398.6 5134.7 5182.4 5184.3 5192.9 5200.6 3904.3 4516.3 4647.2 4676.7 4702.4 6172.7 6183.2 6199.8 6240.2 6269.3 6448.0 6454.8 6466.9 6467.6 6474.4 6159.5 6173.6 6204.7 6261.0 6273.1 5722.6 5748.7 5763.3 5797.2 5804.0 6810.5 6847.0 6874.8 6876.1 6885.3 6343.4 6379.0 6432.7 6474.0 6486.2 6766.4 6787.9 6802.8 6811.2 6833.1 5341.6 6353.9 6354.8 6359.2 6364.8 6309.3 6341.8 6390.0 6428.9 6499.1 6235.9 6289.2 6294.8 6312.4 6312.6 6232.4 6293.9 6299.6 6299.8 6313.8 5187.7 6137.9 6143.2 6159.9 6233.7 6268.5 6297.3 6306.5 6317.4 6366.1 6160.4 6181.9 6224.2 6238.1 6259.6 20:28:05 INFO - PROCESS | 1672 | 20:28:05 INFO - PROCESS | 1672 | [#1] ext.html Cycles:180 Average:79658.37 Median:38763.21 stddev:197657.63 (509.9%) stddev-sans-first:198122.90 20:28:05 INFO - PROCESS | 1672 | Values: 564.3 567.7 579.7 581.1 599.1 35092.8 41126.0 41152.2 41313.6 41364.6 42226.3 42262.8 42658.0 42915.4 42924.0 9830.4 9991.0 10005.9 10039.4 10089.3 8790.5 9839.8 9951.5 10093.3 10119.2 8790.7 9953.1 9954.1 10021.8 10105.9 8747.3 9974.9 9984.3 10081.0 10087.3 8716.9 9940.6 9943.1 9986.8 10082.3 40289.2 40654.6 40689.6 40841.0 40993.0 3397.2 3472.9 3478.9 3587.8 3855.6 29004.9 29096.0 29836.7 30178.7 30535.5 2806.9 2826.6 2836.5 2844.7 2856.1 432523.0 433532.0 435443.8 436753.0 437360.0 38193.6 38645.8 68118.3 68364.0 68420.7 38621.4 38664.6 38988.0 39029.4 39143.4 16915.2 17085.7 17106.2 17124.9 17160.9 13904.8 13914.6 13957.1 14319.4 14466.1 8615.5 8616.2 8678.9 8760.4 8837.0 3564.9 3567.0 3638.8 3640.1 3648.3 977.2 1032.0 1038.5 1079.3 1132.0 31364.1 31379.0 31408.1 31942.8 32096.5 1113.4 1137.5 1153.7 1204.4 1274.8 15738.6 16185.0 16279.5 16428.3 16475.9 1017776.0 1036059.0 1037275.0 1041160.0 1041194.0 63796.7 65193.3 65775.0 65807.0 65822.7 1561.9 1573.8 1577.8 1581.7 1592.3 25702.7 32047.4 32200.5 32439.5 32723.5 56679.4 57631.7 58297.4 58367.7 58515.1 573926.0 574953.0 578922.1 581631.0 583882.0 29340.0 44567.3 44902.8 46649.5 46702.0 46098.5 46237.8 46565.3 47141.8 49285.3 38929.6 38946.6 40235.8 40251.4 40252.6 38928.8 39595.0 39726.6 39888.8 40215.6 37915.4 38861.8 39604.6 39712.8 40411.0 27254.9 27735.7 31221.8 32912.8 35002.1 23830.6 26465.0 26684.1 27737.2 28135.4 20:28:05 INFO - PROCESS | 1672 | 20:28:05 INFO - PROCESS | 1672 | [#2] jquery.html Cycles:180 Average:37917.44 Median:21454.30 stddev:112192.20 (522.9%) stddev-sans-first:112471.50 20:28:05 INFO - PROCESS | 1672 | Values: 371.3 376.7 414.8 417.5 421.0 13406.8 21327.5 21369.1 21739.1 22121.0 19804.6 19828.0 21539.5 21742.8 22528.0 5863.4 5894.7 6132.1 6167.4 6205.3 5423.9 5755.7 6096.1 6189.1 6218.1 5819.7 6000.3 6062.9 6092.3 6098.1 5821.4 6044.7 6143.9 6144.1 6156.0 5872.8 5908.7 5987.3 5995.9 6004.1 13964.0 14178.5 14318.2 14338.9 14394.9 2129.4 2392.6 2412.9 2463.4 2753.2 10153.5 10325.0 10427.3 10459.7 10532.0 1695.9 1846.7 1877.5 1877.5 1924.6 117792.2 125718.0 126652.0 127541.4 127973.0 12036.5 12168.9 12237.8 12242.8 12269.4 15648.5 15991.8 16011.4 16013.7 16049.0 8236.2 9413.6 9533.5 9635.3 9636.0 9200.0 9484.8 9571.7 9592.0 9618.9 4837.4 4888.5 4899.2 4928.4 4960.1 1895.3 1973.3 2020.8 2095.1 2119.5 920.9 943.4 988.8 1021.9 1062.6 21323.9 21329.9 22142.0 22840.1 23362.0 911.3 992.5 1023.3 1041.1 1050.9 8680.0 11392.0 11415.5 11499.4 11503.0 620340.0 670592.0 685991.0 690640.0 691777.0 138942.3 141924.0 143752.8 144559.3 146140.0 1111.7 1116.3 1126.6 1129.4 1134.6 18605.8 18918.0 19395.7 19425.7 19643.4 42323.4 54747.5 55518.0 56918.4 57100.1 84278.0 85102.6 85869.1 87032.7 88900.6 8545.5 8598.3 8629.4 8796.2 8837.6 7979.6 12613.7 13079.3 13206.7 13423.6 11445.8 11555.8 11567.6 11720.8 11923.7 10211.2 11284.9 11400.4 11419.3 11785.7 11786.9 11800.4 11832.7 11839.0 12039.8 8083.9 8388.7 8787.4 8821.9 8862.0 10540.9 11882.0 11956.2 11979.2 12154.6 20:28:05 INFO - PROCESS | 1672 | 20:28:05 INFO - PROCESS | 1672 | [#3] mootools.html Cycles:180 Average:5988.67 Median:5192.45 stddev:3316.41 (63.9%) stddev-sans-first:3309.54 20:28:05 INFO - PROCESS | 1672 | Values: 1629.8 1644.2 1921.1 2008.8 2067.2 7840.8 8466.8 9023.7 9255.4 9342.9 9112.6 9187.3 9276.7 9290.6 9303.4 2560.5 2565.5 2577.7 2595.2 2598.8 2453.5 2579.9 2597.5 2618.5 2620.1 2216.7 2585.3 2593.4 2597.8 2600.2 2583.7 2587.0 2587.6 2601.7 2635.4 2571.7 2580.2 2583.7 2612.3 2617.4 9159.6 9399.4 9446.0 9450.9 9477.6 5732.4 5763.1 5779.9 5872.9 5916.6 3702.9 3788.0 3800.5 3835.0 3851.5 923.4 1021.5 1049.8 1090.8 1093.5 12250.9 12396.9 12629.3 12684.3 12727.7 5108.0 5134.9 5192.1 5192.8 5232.6 10598.4 10607.4 10672.6 10817.4 10875.9 5662.8 5736.9 5799.3 5955.3 5963.8 3792.9 5054.0 5152.8 5229.0 5353.9 3727.6 4284.7 4306.0 4312.3 4385.2 1380.6 1393.0 1407.4 1414.1 1427.7 848.8 868.4 959.6 973.6 987.8 6170.5 6180.6 6186.6 6250.8 6282.7 482.9 487.0 489.3 498.9 500.0 4062.3 4069.3 4156.4 4193.0 4232.3 9635.7 10990.3 11390.7 11490.0 11542.0 9873.0 10126.0 10478.7 11313.5 11337.0 8439.4 8733.8 8754.5 8833.8 8837.7 5981.0 6043.3 6064.5 6132.7 6160.8 9845.5 9892.8 9942.8 9966.5 10066.5 9802.8 10126.4 10219.6 10271.9 10296.7 7171.8 7695.1 7815.9 7941.4 7958.6 8664.7 8733.3 8738.7 8800.5 8809.9 7613.5 7675.4 7787.6 7844.4 7873.5 7564.7 7594.4 7630.2 7636.7 7733.9 7303.3 7377.5 7407.0 7420.2 7434.3 5086.3 5126.6 5206.1 5324.4 5329.7 5178.8 5219.3 5245.7 5407.8 5429.6 20:28:05 INFO - PROCESS | 1672 | 20:28:05 INFO - PROCESS | 1672 | [#4] prototype.html Cycles:180 Average:6227.41 Median:7152.25 stddev:2048.17 (28.6%) stddev-sans-first:2004.99 20:28:05 INFO - PROCESS | 1672 | Values: 298.5 341.1 343.5 348.3 351.9 7073.1 7090.4 7098.4 7148.3 7156.2 7077.4 7089.8 7095.3 7106.8 7119.0 4222.8 4854.4 5157.4 5184.1 5190.2 4491.7 5106.7 5174.0 5201.3 5205.4 5145.6 5151.3 5157.7 5170.3 5189.6 5146.3 5147.2 5153.0 5158.9 5160.3 4412.4 4425.4 4428.9 4429.5 4445.4 6516.3 6753.9 6780.0 6784.6 6787.2 5940.1 5979.9 5987.1 5990.4 5993.3 7541.7 7551.8 7553.5 7570.2 7585.8 4816.9 4821.6 4824.6 4839.7 4846.8 7711.3 7954.8 8036.5 8050.7 8057.6 3961.5 4653.0 4831.2 4870.4 4925.6 5019.7 5028.0 5032.8 5035.8 5041.9 5984.4 6002.9 6008.0 6018.4 6023.8 7576.2 7590.4 7596.5 7597.0 7619.3 1453.7 1689.4 1718.2 1735.9 1750.2 926.6 1082.3 1091.1 1101.7 1102.0 7291.1 7370.4 7374.9 7375.7 7417.1 6660.7 7617.8 7692.0 7766.4 7921.2 7353.6 7384.9 7395.4 7410.6 7435.8 4169.2 4199.7 4208.9 4211.8 4217.2 8340.8 8363.2 8416.6 8448.1 8472.6 7864.6 8142.5 8150.2 8234.8 8246.4 8380.3 8450.0 8451.5 8451.6 8465.9 6741.5 7884.1 7938.6 7958.8 7983.9 7553.7 7780.8 7783.8 7797.4 7833.0 8374.1 8406.5 8418.5 8425.1 8440.2 4895.1 4962.8 4971.6 4978.8 4982.8 7886.9 7926.6 7933.5 7943.1 7970.6 7332.0 7656.1 7675.3 7690.5 7691.4 7563.4 7619.7 7626.8 7631.2 7676.0 7449.6 7461.7 7470.7 7478.0 7489.9 7127.4 7372.3 7622.3 7634.7 7653.4 7370.3 7451.5 7481.8 7485.2 7505.8 20:28:05 INFO - PROCESS | 1672 | 20:28:05 INFO - PROCESS | 1672 | [#5] yui.html Cycles:180 Average:18769.29 Median:25735.06 stddev:26175.35 (101.7%) stddev-sans-first:26213.66 20:28:05 INFO - PROCESS | 1672 | Values: 710.8 771.3 771.4 781.2 783.1 15467.9 15620.1 15959.0 15962.6 15974.4 12736.3 14291.3 14597.9 14647.8 14708.3 792.8 924.9 939.1 939.7 950.9 933.2 934.0 949.0 950.8 975.9 864.4 1004.2 1019.7 1021.2 1051.1 993.0 1012.1 1012.3 1012.5 1042.3 750.7 782.4 783.0 784.5 784.7 15509.8 15622.5 15851.0 15924.0 16073.8 13519.1 13579.6 13590.0 13667.3 13694.5 10285.0 10303.1 10353.9 10411.2 10649.9 3598.8 3614.8 3661.3 3737.1 3877.8 83624.0 85577.6 87679.1 87791.6 88416.0 9743.7 9993.4 10051.0 10067.8 10240.3 22659.8 22925.3 22980.8 24146.0 24148.2 7779.6 7845.2 7931.9 7974.7 8064.9 4061.5 4180.9 4264.4 4333.6 4387.1 3727.4 3737.9 3755.5 3799.7 3807.1 660.1 674.0 678.2 682.0 688.4 549.8 586.6 607.9 610.4 610.5 7609.9 8450.0 8461.2 8491.8 8599.8 537.0 580.8 607.9 625.6 640.0 3224.5 3442.3 3963.4 4000.9 4018.9 92394.0 93036.0 95409.0 96780.0 97211.0 51849.0 64623.7 72396.0 73204.6 83352.0 69536.3 71064.9 71688.0 72548.5 73441.0 8667.1 8766.6 8769.0 8825.8 8960.5 47083.0 51389.0 52168.5 52922.5 53007.5 70836.0 70966.0 72364.6 73368.0 73393.1 11059.8 11143.6 11253.3 11257.7 11616.0 12123.5 12167.6 12344.2 12345.1 12468.1 11849.5 11886.5 11894.3 11921.5 11945.6 11837.6 11855.8 11856.1 12003.3 12158.1 11169.4 11659.9 11810.5 11836.7 12327.0 9903.8 9956.4 10172.9 10221.3 10287.4 8553.1 9735.3 9826.8 10090.3 10099.0 20:28:05 INFO - PROCESS | 1672 | -------- Summary: end -------- 20:28:05 INFO - PROCESS | 1672 | 20:28:05 INFO - TEST-INFO | 1672: exit 0 20:28:05 INFO - TEST-OK | dromaeo_css | took 1109864ms 20:28:05 INFO - TEST-START | kraken 20:28:05 INFO - operating with platform_type : mac_ 20:28:05 INFO - Initialising browser for kraken test... 20:28:05 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/tmpSRbOZZ/profile http://localhost:49264/getInfo.html) 20:28:08 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 20:28:08 INFO - PROCESS | 1680 | colorDepth:24 20:28:08 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 20:28:08 INFO - PROCESS | 1680 | __metrics 20:28:08 ERROR - PROCESS | 1680 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 20:28:09 INFO - TEST-INFO | 1680: exit 0 20:28:09 INFO - Browser initialized. 20:28:09 INFO - Running cycle 1/1 for kraken test... 20:28:09 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/tmpSRbOZZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:28:20 INFO - PROCESS | 1684 | RSS: Main: 170995712 20:28:20 INFO - PROCESS | 1684 | 20:28:23 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection) 20:28:24 INFO - PROCESS | 1684 | RSS: Main: 183603200 20:28:24 INFO - PROCESS | 1684 | 20:28:27 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-dft) 20:28:28 INFO - PROCESS | 1684 | RSS: Main: 192278528 20:28:28 INFO - PROCESS | 1684 | 20:28:31 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-fft) 20:28:32 INFO - PROCESS | 1684 | RSS: Main: 196448256 20:28:32 INFO - PROCESS | 1684 | 20:28:33 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator) 20:28:34 INFO - PROCESS | 1684 | RSS: Main: 196648960 20:28:34 INFO - PROCESS | 1684 | 20:28:36 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:28:37 INFO - PROCESS | 1684 | RSS: Main: 197849088 20:28:37 INFO - PROCESS | 1684 | 20:28:40 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom) 20:28:40 INFO - PROCESS | 1684 | RSS: Main: 198193152 20:28:40 INFO - PROCESS | 1684 | 20:28:43 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate) 20:28:44 INFO - PROCESS | 1684 | RSS: Main: 198483968 20:28:44 INFO - PROCESS | 1684 | 20:28:47 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial) 20:28:47 INFO - PROCESS | 1684 | RSS: Main: 198909952 20:28:47 INFO - PROCESS | 1684 | 20:28:49 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:28:50 INFO - PROCESS | 1684 | RSS: Main: 197701632 20:28:50 INFO - PROCESS | 1684 | 20:28:51 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:28:52 INFO - PROCESS | 1684 | RSS: Main: 197808128 20:28:52 INFO - PROCESS | 1684 | 20:28:54 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:28:55 INFO - PROCESS | 1684 | RSS: Main: 198643712 20:28:55 INFO - PROCESS | 1684 | 20:28:57 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:28:58 INFO - PROCESS | 1684 | RSS: Main: 198209536 20:28:58 INFO - PROCESS | 1684 | 20:29:01 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:29:02 INFO - PROCESS | 1684 | RSS: Main: 198184960 20:29:02 INFO - PROCESS | 1684 | 20:29:03 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49264/tests/kraken/driver.html?testName=ai-astar) 20:29:04 INFO - PROCESS | 1684 | RSS: Main: 199892992 20:29:04 INFO - PROCESS | 1684 | 20:29:04 INFO - PROCESS | 1684 | __start_tp_report 20:29:04 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 20:29:04 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 20:29:04 INFO - PROCESS | 1684 | |i|pagename|runs| 20:29:04 INFO - PROCESS | 1684 | |0;ai-astar;116;112;140;170;120;151;115;101;165;167 20:29:04 INFO - PROCESS | 1684 | |1;audio-beat-detection;161;136;174;159;153;165;139;123;170;120 20:29:04 INFO - PROCESS | 1684 | |2;audio-dft;190;228;191;282;196;189;176;166;271;182 20:29:04 INFO - PROCESS | 1684 | |3;audio-fft;63;80;74;142;57;56;58;71;127;57 20:29:04 INFO - PROCESS | 1684 | |4;audio-oscillator;78;81;139;110;110;132;119;78;83;120 20:29:04 INFO - PROCESS | 1684 | |5;imaging-gaussian-blur;94;85;89;84;89;85;89;86;102;128 20:29:04 INFO - PROCESS | 1684 | |6;imaging-darkroom;146;133;93;103;94;94;94;126;102;94 20:29:04 INFO - PROCESS | 1684 | |7;imaging-desaturate;89;91;98;91;90;89;81;149;145;92 20:29:04 INFO - PROCESS | 1684 | |8;json-parse-financial;58;62;64;64;64;65;64;77;63;60 20:29:04 INFO - PROCESS | 1684 | |9;json-stringify-tinderbox;61;67;70;65;75;72;69;66;65;66 20:29:04 INFO - PROCESS | 1684 | |10;stanford-crypto-aes;81;81;79;79;82;80;79;82;81;84 20:29:04 INFO - PROCESS | 1684 | |11;stanford-crypto-ccm;124;117;145;150;137;141;141;126;182;164 20:29:04 INFO - PROCESS | 1684 | |12;stanford-crypto-pbkdf2;160;200;200;173;215;188;162;162;166;168 20:29:04 INFO - PROCESS | 1684 | |13;stanford-crypto-sha256-iterative;64;69;69;61;68;101;87;61;90;64 20:29:04 INFO - PROCESS | 1684 | __end_tp_report 20:29:04 INFO - PROCESS | 1684 | __start_cc_report 20:29:04 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,1041 20:29:04 INFO - PROCESS | 1684 | __end_cc_report 20:29:04 INFO - PROCESS | 1684 | __startTimestamp1468466944152__endTimestamp 20:29:04 INFO - PROCESS | 1684 | 20:29:04 INFO - PROCESS | 1684 | ------- Summary: start ------- 20:29:04 INFO - PROCESS | 1684 | Number of tests: 14 20:29:04 INFO - PROCESS | 1684 | 20:29:04 INFO - PROCESS | 1684 | [#0] ai-astar Cycles:10 Average:135.70 Median:145.50 stddev:26.03 (17.9%) stddev-sans-first:26.61 20:29:04 INFO - PROCESS | 1684 | Values: 116.0 112.0 140.0 170.0 120.0 151.0 115.0 101.0 165.0 167.0 20:29:04 INFO - PROCESS | 1684 | 20:29:04 INFO - PROCESS | 1684 | [#1] audio-beat-detection Cycles:10 Average:150.00 Median:160.00 stddev:19.32 (12.1%) stddev-sans-first:20.07 20:29:04 INFO - PROCESS | 1684 | Values: 161.0 136.0 174.0 159.0 153.0 165.0 139.0 123.0 170.0 120.0 20:29:04 INFO - PROCESS | 1684 | 20:29:04 INFO - PROCESS | 1684 | [#2] audio-dft Cycles:10 Average:207.10 Median:193.50 stddev:40.03 (20.7%) stddev-sans-first:41.97 20:29:04 INFO - PROCESS | 1684 | Values: 190.0 228.0 191.0 282.0 196.0 189.0 176.0 166.0 271.0 182.0 20:29:04 INFO - PROCESS | 1684 | 20:29:04 INFO - PROCESS | 1684 | [#3] audio-fft Cycles:10 Average:78.50 Median:60.50 stddev:30.83 (51.0%) stddev-sans-first:32.19 20:29:04 INFO - PROCESS | 1684 | Values: 63.0 80.0 74.0 142.0 57.0 56.0 58.0 71.0 127.0 57.0 20:29:04 INFO - PROCESS | 1684 | 20:29:04 INFO - PROCESS | 1684 | [#4] audio-oscillator Cycles:10 Average:105.00 Median:108.50 stddev:23.27 (21.4%) stddev-sans-first:22.54 20:29:04 INFO - PROCESS | 1684 | Values: 78.0 81.0 139.0 110.0 110.0 132.0 119.0 78.0 83.0 120.0 20:29:04 INFO - PROCESS | 1684 | 20:29:04 INFO - PROCESS | 1684 | [#5] imaging-gaussian-blur Cycles:10 Average:93.10 Median:87.50 stddev:13.39 (15.3%) stddev-sans-first:14.20 20:29:04 INFO - PROCESS | 1684 | Values: 94.0 85.0 89.0 84.0 89.0 85.0 89.0 86.0 102.0 128.0 20:29:04 INFO - PROCESS | 1684 | 20:29:04 INFO - PROCESS | 1684 | [#6] imaging-darkroom Cycles:10 Average:107.90 Median:93.50 stddev:19.62 (21.0%) stddev-sans-first:15.21 20:29:04 INFO - PROCESS | 1684 | Values: 146.0 133.0 93.0 103.0 94.0 94.0 94.0 126.0 102.0 94.0 20:29:04 INFO - PROCESS | 1684 | 20:29:04 INFO - PROCESS | 1684 | [#7] imaging-desaturate Cycles:10 Average:101.50 Median:90.50 stddev:24.35 (26.9%) stddev-sans-first:25.40 20:29:04 INFO - PROCESS | 1684 | Values: 89.0 91.0 98.0 91.0 90.0 89.0 81.0 149.0 145.0 92.0 20:29:04 INFO - PROCESS | 1684 | 20:29:04 INFO - PROCESS | 1684 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.00 stddev:5.02 (7.8%) stddev-sans-first:4.82 20:29:04 INFO - PROCESS | 1684 | Values: 58.0 62.0 64.0 64.0 64.0 65.0 64.0 77.0 63.0 60.0 20:29:04 INFO - PROCESS | 1684 | 20:29:04 INFO - PROCESS | 1684 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:4.01 (5.9%) stddev-sans-first:3.46 20:29:04 INFO - PROCESS | 1684 | Values: 61.0 67.0 70.0 65.0 75.0 72.0 69.0 66.0 65.0 66.0 20:29:04 INFO - PROCESS | 1684 | 20:29:04 INFO - PROCESS | 1684 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:81.00 stddev:1.62 (2.0%) stddev-sans-first:1.72 20:29:04 INFO - PROCESS | 1684 | Values: 81.0 81.0 79.0 79.0 82.0 80.0 79.0 82.0 81.0 84.0 20:29:04 INFO - PROCESS | 1684 | 20:29:04 INFO - PROCESS | 1684 | [#11] stanford-crypto-ccm Cycles:10 Average:142.70 Median:143.00 stddev:19.39 (13.6%) stddev-sans-first:19.35 20:29:04 INFO - PROCESS | 1684 | Values: 124.0 117.0 145.0 150.0 137.0 141.0 141.0 126.0 182.0 164.0 20:29:04 INFO - PROCESS | 1684 | 20:29:04 INFO - PROCESS | 1684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.40 Median:180.50 stddev:19.78 (11.0%) stddev-sans-first:19.70 20:29:04 INFO - PROCESS | 1684 | Values: 160.0 200.0 200.0 173.0 215.0 188.0 162.0 162.0 166.0 168.0 20:29:04 INFO - PROCESS | 1684 | 20:29:04 INFO - PROCESS | 1684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:68.50 stddev:14.04 (20.5%) stddev-sans-first:14.48 20:29:04 INFO - PROCESS | 1684 | Values: 64.0 69.0 69.0 61.0 68.0 101.0 87.0 61.0 90.0 64.0 20:29:04 INFO - PROCESS | 1684 | -------- Summary: end -------- 20:29:04 INFO - PROCESS | 1684 | 20:29:04 INFO - TEST-INFO | 1684: exit 0 20:29:04 INFO - TEST-OK | kraken | took 59252ms 20:29:04 INFO - SUITE-END | took 1169s 20:29:05 INFO - Completed test suite (00:19:29) 20:29:05 INFO - javascript benchmark 20:29:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3652.3608368535506, 3717.9070523236933, 3736.570294416141, 3777.150141218226, 3781.3760729479636, 6113.083556793957, 6128.483736330591, 6145.692715364231, 6149.508039356852, 6150.0, 4521.892136426572, 5982.820515384535, 6096.828477679209, 6154.692265386735, 6160.860240855445, 4892.339534162896, 5092.0, 5434.994526012681, 5482.259894914176, 5591.4688104630195, 4620.907581848361, 5428.972855135738, 5449.7275136243225, 5512.173174023908, 5569.415211402805, 5533.197686335479, 5538.307711536058, 5544.112941929292, 5557.5831812614015, 5561.110222364423, 4904.828331008415, 5483.698396588186, 5568.1091025435935, 5577.888442231173, 5587.0, 4502.684812063157, 5446.155845843861, 5462.726863656841, 5499.917501237484, 5540.778368865281, 5395.892082158374, 5789.0, 6056.6063205891915, 6145.201123853915, 6200.62796232223, 6289.245290565115, 6355.0, 6389.936100638981, 6408.391202835724, 6427.100205971168, 6323.968380158116, 6387.425131738166, 6441.613503189824, 6502.512311576651, 6542.771003014872, 6143.96928015366, 6166.630002199838, 6174.197354343952, 6174.536909731788, 6200.720967556471, 6682.298358672367, 6685.431738302202, 6693.497987650946, 6707.5304728668525, 6713.160854893138, 5239.633225674243, 6172.69136543171, 6222.471089957405, 6239.656818874914, 6293.433590976742, 6455.838604034937, 6462.998235273541, 6479.319671434526, 6491.058796474485, 6556.082148499214, 6347.143135676624, 6362.0, 6375.458086062737, 6388.009858471944, 6392.520560957947, 6223.96888015566, 6303.905441418382, 6352.936470635327, 6377.64922929234, 6398.584092034003, 5134.666246693953, 5182.4299327073995, 5184.300119483897, 5192.948070519246, 5200.635955483155, 3904.2581909437117, 4516.345129956204, 4647.16351056813, 4676.69601475903, 4702.388689470347, 6172.722227499773, 6183.165272688129, 6199.752009919643, 6240.157578726814, 6269.279032911274, 6447.967760161169, 6454.806355809334, 6466.935330646727, 6467.611943283418, 6474.352564743582, 6159.5072394209255, 6173.629582225081, 6204.689765511706, 6260.968695156495, 6273.090401891792, 5722.62802917809, 5748.741306641211, 5763.308402991668, 5797.188393624896, 5804.04233301509, 6810.523263371517, 6846.965765171242, 6874.828129296608, 6876.106106206261, 6885.311468853175, 6343.397377249154, 6378.968105159444, 6432.710528026157, 6473.967630161819, 6486.189226346707, 6766.357196066366, 6787.864242715217, 6802.829929251809, 6811.182658081062, 6833.077534532775, 5341.599380046589, 6353.888069587896, 6354.809355719336, 6359.17330747, 6364.840878978062, 6309.33751956038, 6341.778037768656, 6390.0, 6428.871422571428, 6499.090127382265, 6235.937640623536, 6289.213848268966, 6294.779682711083, 6312.400321969406, 6312.589681670676, 6232.439080482778, 6293.937060629335, 6299.622022678654, 6299.811005669837, 6313.779017734358, 5187.688738675692, 6137.8979746733885, 6143.1706719592285, 6159.876802463836, 6233.688315584293, 6268.498520118471, 6297.338779428277, 6306.46395056407, 6317.368263173646, 6366.108744775643, 6160.383961603804, 6181.938180618136, 6224.190855188796, 6238.095476156022, 6259.624422534663], "value": 5940.762818017183, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.31999440674, 567.7360027587173, 579.6666916523001, 581.0952881582722, 599.1103211730582, 35092.82453587732, 41125.97185070375, 41152.17695646089, 41313.58686413139, 41364.58635413645, 42226.31094756214, 42262.78868605661, 42658.0, 42915.35626965598, 42924.0, 9830.410175389481, 9991.0, 10005.949970250174, 10039.447830369327, 10089.344192627492, 8790.51652159131, 9839.754006149831, 9951.502424878763, 10093.343932644355, 10119.241056920724, 8790.6923257686, 9953.104220620142, 9954.104130628242, 10021.799564008716, 10105.949470252675, 8747.343949203836, 9974.850377244347, 9984.301098923079, 10081.042300981431, 10087.293889427743, 8716.869246961302, 9940.602375904955, 9943.105120539114, 9986.750331241705, 10082.3364144916, 40289.19421611581, 40654.593454065376, 40689.593104068874, 40841.0, 40993.0, 3397.2186397128553, 3472.9131771705656, 3478.8867562380046, 3587.820608969541, 3855.5951625079524, 29004.854975724986, 29096.0, 29836.701632983608, 30178.698213017808, 30535.541966870514, 2806.859657017161, 2826.6042754014456, 2836.5177919753487, 2844.687084420712, 2856.128880691388, 432523.0, 433532.0, 435443.82278088725, 436753.0, 437360.0, 38193.61806381956, 38645.80677096653, 68118.31881681219, 68363.97454038194, 68420.6578967102, 38621.42067868984, 38664.61335386666, 38988.025299367175, 39029.41455878164, 39143.41284880729, 16915.23881425339, 17085.658286834194, 17106.230219640147, 17124.914375428292, 17160.91419542919, 13904.791428128587, 13914.582562523141, 13957.092788968685, 14319.427222911176, 14466.132032078109, 8615.483071015758, 8616.224539791448, 8678.86981695275, 8760.386772925962, 8836.955815220883, 3564.9483402396354, 3567.0, 3638.7634803737674, 3640.0535860675886, 3648.3068217038676, 977.2279898879948, 1031.9989610078212, 1038.4889985071702, 1079.2660990526517, 1131.9943400282946, 31364.05907822769, 31379.0, 31408.05775826729, 31942.840285798422, 32096.518552221736, 1113.4425510494057, 1137.4881303413497, 1153.7058050197313, 1204.3677069538562, 1274.751423472414, 15738.606534836492, 16185.0, 16279.51161465158, 16428.342866285213, 16475.91762041206, 1017776.0, 1036059.0, 1037275.0, 1041160.0, 1041194.0, 63796.68101659462, 65193.34806651968, 65775.01337479941, 65807.0, 65822.67088664525, 1561.9219039048003, 1573.8268790433044, 1577.8106627204809, 1581.6994770993474, 1592.283472437408, 25702.742972570784, 32047.35905281928, 32200.516992245604, 32439.513407299382, 32723.509147362332, 56679.43320566742, 57631.71184144053, 58297.4170258292, 58367.70816145892, 58515.12227316679, 573926.0, 574953.0, 578922.1053894704, 581631.0, 583882.0, 29339.973100941366, 44567.33149002703, 44902.77548612236, 46649.53350466588, 46702.0, 46098.53901460942, 46237.768811157075, 46565.3015204779, 47141.764291178326, 49285.26072108993, 38929.6107038926, 38946.6105338943, 40235.79882100571, 40251.39622905717, 40252.59747402606, 38928.83213503599, 39595.0, 39726.60273397345, 39888.80055599703, 40215.597844022355, 37915.43126853044, 38861.80569097136, 39604.60395396009, 39712.80143599379, 40410.9897252571, 27254.863725681244, 27735.722642773315, 31221.8438907804, 32912.835435822664, 35002.12494687653, 23830.64254036156, 26465.0, 26684.066057687887, 27737.21173482078, 28135.43729125365], "value": 19889.961618427522, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.2667481723596, 376.69487714950907, 414.8112608763012, 417.4760675352432, 421.0379283337574, 13406.798898016514, 21327.466813329655, 21369.145234190633, 21739.13043478263, 22121.0, 19804.60390792183, 19828.0, 21539.46151346217, 21742.782572174314, 22528.0, 5863.384344643815, 5894.705264736756, 6132.110843927628, 6167.444929956303, 6205.255369355684, 5423.918641220384, 5755.740991655385, 6096.085587161939, 6189.071639254103, 6218.098375735515, 5819.6508209507565, 6000.279966404016, 6062.878742425149, 6092.31937947304, 6098.115773212881, 5821.359650438449, 6044.69776511177, 6143.9385606143815, 6144.0783882417545, 6155.969220153893, 5872.794452194195, 5908.734106965154, 5987.2815262168815, 5995.910061349084, 6004.129401236796, 13964.022518423715, 14178.503752368617, 14318.212498312589, 14338.928305358511, 14394.928025359806, 2129.350548082834, 2392.629142482918, 2412.883286211884, 2463.408781892351, 2753.2428582139873, 10153.492325383775, 10325.0, 10427.270091093627, 10459.68620941373, 10532.0, 1695.85585225256, 1846.658368201887, 1877.4836919847014, 1877.4836919847014, 1924.6054558815408, 117792.23311650332, 125718.0, 126652.0, 127541.36229318887, 127973.0, 12036.45835937385, 12168.939155304166, 12237.755244895052, 12242.816357754462, 12269.38653067361, 15648.530544083696, 15991.760123598155, 16011.439599613957, 16013.679726405406, 16049.0, 8236.217559331853, 9413.57638906251, 9533.523323833919, 9635.325527213168, 9635.951820240854, 9200.033996430278, 9484.810303794024, 9571.712848614414, 9592.0, 9618.855717164248, 4837.419509658793, 4888.535589119028, 4899.191633380524, 4928.408590969107, 4960.082384758831, 1895.2797936783934, 1973.2501649373432, 2020.8383329333617, 2095.088636443152, 2119.4595378178465, 920.9179214423026, 943.4056544376998, 988.7775250568708, 1021.9386836789816, 1062.6068354708652, 21323.893380533307, 21329.893350533457, 22142.003609837597, 22840.086396544284, 23362.0, 911.2709832134399, 992.503748125937, 1023.3041531758475, 1041.1306559023149, 1050.8896565860475, 8680.0, 11391.97472227487, 11415.543378264776, 11499.425028748696, 11503.0, 620340.0, 670592.0, 685991.0, 690640.0, 691777.0, 138942.30528847492, 141924.0, 143752.84370734447, 144559.2772036154, 146140.0, 1111.6609434122508, 1116.3357802107732, 1126.645106791358, 1129.4239937631867, 1134.5688638317552, 18605.81394186095, 18918.0, 19395.709064364328, 19425.708614371077, 19643.410697679094, 42323.365149522164, 54747.45252547423, 55518.0, 56918.43081569131, 57100.14349784674, 84278.0, 85102.57448712717, 85869.14130858611, 87032.69450958114, 88900.55549722469, 8545.487270763773, 8598.312135029308, 8629.43908645936, 8796.208341249318, 8837.646494140163, 7979.5611241382285, 12613.684657883627, 13079.280639564915, 13206.735865282833, 13423.597292081253, 11445.828312575151, 11555.826662600235, 11567.595134170264, 11720.824187637363, 11923.701907452383, 10211.183105351703, 11284.887151128383, 11400.429978501208, 11419.31484110956, 11785.705357366134, 11786.941065294619, 11800.350980696145, 11832.70418239551, 11839.0, 12039.819402708792, 8083.878741818995, 8388.664453421794, 8787.428817127122, 8821.911780882367, 8862.0, 10540.947295263475, 11882.0, 11956.222845515014, 11979.221350612183, 12154.574589889311], "value": 9899.438756837018, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1629.7636842657814, 1644.210778826163, 1921.1450904347562, 2008.8292495137912, 2067.2351230044887, 7840.803979900498, 8466.788330291745, 9023.684171054014, 9255.398399104053, 9342.906570934298, 9112.589933452993, 9187.265018798496, 9276.675316363928, 9290.628374864997, 9303.39527930684, 2560.4751026039617, 2565.474077814053, 2577.6777902762155, 2595.2344058502695, 2598.8180827342094, 2453.4847681986716, 2579.9226023219335, 2597.4805038992276, 2618.4681961052806, 2620.0960668569314, 2216.74507431645, 2585.340738111788, 2593.4294455219915, 2597.8441293522355, 2600.1939398786435, 2583.677040369954, 2587.0427941661706, 2587.637730717701, 2601.6747906511687, 2635.3543381871373, 2571.6913970323494, 2580.213035024317, 2583.677040369954, 2612.3207965928805, 2617.424166683327, 9159.633614655406, 9399.436033837992, 9446.00816914221, 9450.85823712645, 9477.620895164186, 5732.369439361709, 5763.106718458645, 5779.913301300484, 5872.911906321408, 5916.556258280603, 3702.851885924587, 3787.9621203787883, 3800.4869342638667, 3834.9808250958567, 3851.4607954886337, 923.445932440537, 1021.5454122915305, 1049.7638031442864, 1090.8363745438169, 1093.4587379247323, 12250.877491225152, 12396.938015309956, 12629.305388203646, 12684.30236337001, 12727.74544509114, 5108.003939231814, 5134.897302053938, 5192.143296356135, 5192.766325515361, 5232.633715639945, 10598.364098154136, 10607.416592087355, 10672.62645807393, 10817.350958942332, 10875.945620271848, 5662.8301150965535, 5736.913946290725, 5799.2750906136735, 5955.255593050869, 5963.761449542057, 3792.943105853359, 5053.974730126326, 5152.768125434364, 5229.032628963654, 5353.946460535345, 3727.552693676776, 4284.721493102938, 4306.0, 4312.331588603772, 4385.232584297735, 1380.5858242527202, 1392.9761625205465, 1407.4370251899118, 1414.1232435889815, 1427.6787722762294, 848.8005318750089, 868.379108937113, 959.6065613098596, 973.634886917406, 987.7530617345664, 6170.475509581735, 6180.598261113013, 6186.628802271878, 6250.781222657185, 6282.717277722513, 482.9348038014823, 486.9975650121727, 489.2709862305211, 498.925161225819, 500.0324372339535, 4062.268791617478, 4069.348904175318, 4156.397322388298, 4193.035601811539, 4232.322828347511, 9635.710928672152, 10990.285631433931, 11390.715232119263, 11490.0, 11541.961223489927, 9872.950635246778, 10126.0, 10478.685639430829, 11313.490892909838, 11336.979671829575, 8439.409241353047, 8733.825323493495, 8754.518501482353, 8833.779155521164, 8837.690680826141, 5980.970095149496, 6043.3050199227655, 6064.545159112996, 6132.693365331626, 6160.815175544741, 9845.507724613884, 9892.752681183028, 9942.751431214278, 9966.50167491608, 10066.496675166067, 9802.75493112678, 10126.443045632266, 10219.642312519027, 10271.897281027093, 10296.742581435525, 7171.784846454615, 7695.115061767969, 7815.92184078152, 7941.404394670307, 7958.64186111638, 8664.696735614223, 8733.257673097858, 8738.650453981769, 8800.515971621622, 8809.911900880908, 7613.5431874087735, 7675.385969122569, 7787.5716835574585, 7844.4116691247245, 7873.5275883447175, 7564.697412103455, 7594.392448603988, 7630.198829123085, 7636.732714354971, 7733.92266077332, 7303.342699157101, 7377.5204611700065, 7407.0, 7420.183779784112, 7434.293742094493, 5086.262491938722, 5126.589872810241, 5206.140986737298, 5324.440933701905, 5329.73351332424, 5178.844634660966, 5219.269302297757, 5245.737713114406, 5407.756650950795, 5429.647072940246], "value": 4764.729643637803, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.5491907220097, 341.1131059245961, 343.5465185954541, 348.27211128740936, 351.917299434633, 7073.08049953506, 7090.3618674319305, 7098.432125429959, 7148.285171482849, 7156.212816590178, 7077.433805295577, 7089.7873063808165, 7095.254998225189, 7106.751263705772, 7119.038929744483, 4222.754287485199, 4854.417469903617, 5157.355330583677, 5184.1186998210205, 5190.169572868342, 4491.663125265602, 5106.744662766847, 5173.974130129344, 5201.271821944931, 5205.427402985669, 5145.6398052136365, 5151.278820965068, 5157.690538567679, 5170.327857378536, 5189.584833213334, 5146.330976973007, 5147.227915812639, 5152.969406118773, 5158.896822063538, 5160.303359046518, 4412.426384570017, 4425.380446737459, 4428.867133985986, 4429.512753597101, 4445.377437235418, 6516.3157868423605, 6753.8649227015185, 6780.016897549827, 6784.626845523544, 6787.185537735454, 5940.108983652487, 5979.910301345483, 5987.101934709828, 5990.430909063632, 5993.250843644544, 7541.660625271821, 7551.811204719871, 7553.546787192786, 7570.16728159902, 7585.81035474112, 4816.927746083811, 4821.638377121695, 4824.614030877557, 4839.709617422931, 4846.80612775492, 7711.305982461549, 7954.761357159295, 8036.4776289541, 8050.677972881136, 8057.556834374107, 3961.544422391404, 4652.953470465252, 4831.202851529529, 4870.391201099863, 4925.630577706686, 5019.67372120811, 5027.99440111979, 5032.823851165192, 5035.77339019745, 5041.949580504222, 5984.431479009487, 6002.879942401128, 6007.969960150259, 6018.428249316308, 6023.759049638053, 7576.204498527575, 7590.354819840265, 7596.468247222641, 7597.012388389474, 7619.276168763959, 1453.6801903581195, 1689.403513679561, 1718.1752758675905, 1735.9045252511232, 1750.1511766793096, 926.6015613286216, 1082.2965072702807, 1091.061686949223, 1101.7025403141106, 1101.9889801102047, 7291.08861392326, 7370.447216458787, 7374.889376659355, 7375.704971801175, 7417.109946806418, 6660.733570657217, 7617.847643047108, 7691.961585185928, 7766.417518686121, 7921.247481489249, 7353.595552244571, 7384.926150738531, 7395.445341599401, 7410.592417416986, 7435.8141046474275, 4169.207850508455, 4199.727017743837, 4208.915821683549, 4211.7888108743155, 4217.156568686275, 8340.833183336299, 8363.247307742333, 8416.621252043673, 8448.11294814048, 8472.618732157067, 7864.646090925922, 8142.51144931306, 8150.184981501921, 8234.752957411287, 8246.3815213858, 8380.329573634095, 8450.0, 8451.45065570736, 8451.619677114544, 8465.915340846635, 6741.494387921024, 7884.1327453978865, 7938.603069846369, 7958.761237162895, 7983.8802417964935, 7553.7356192533, 7780.805479863048, 7783.805404864697, 7797.415193860596, 7833.0, 8374.07885132647, 8406.495610263404, 8418.494890306602, 8425.073241943504, 8440.240378365976, 4895.094407534618, 4962.776675049704, 4971.627127965345, 4978.800847966186, 4982.825601103944, 7886.921130788619, 7926.643301051351, 7933.523988560474, 7943.126256111938, 7970.601469926596, 7331.963340183478, 7656.119546252252, 7675.309222170032, 7690.461667683208, 7691.384689224737, 7563.432742544442, 7619.69521219145, 7626.771196864103, 7631.1605723369275, 7676.0, 7449.553026818408, 7461.701531938662, 7470.663820128216, 7478.0, 7489.8876516851205, 7127.358537731629, 7372.262773722585, 7622.2758837910305, 7634.656440460081, 7653.387728981556, 7370.299821516947, 7451.515651482637, 7481.812954676177, 7485.176630570524, 7505.774826755206], "value": 5522.857412805266, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.8365076032512, 771.340503869192, 771.4021633234239, 781.1641543548405, 783.0994356490039, 15467.92266038671, 15620.140892250922, 15959.0, 15962.600934976603, 15974.440894568677, 12736.299503527302, 14291.285435728198, 14597.854021459782, 14647.780283295733, 14708.338124784384, 792.8136887831355, 924.8751418558476, 939.0750111140521, 939.6570251858057, 950.8621249918775, 933.2021121940745, 934.0379409208492, 949.0, 950.800331930292, 975.9268054895875, 864.394923553512, 1004.2317627015302, 1019.7195771162916, 1021.1728499915056, 1051.1118105201092, 992.9602815887356, 1012.1295685710284, 1012.2711647613706, 1012.5443550402348, 1042.2704107125005, 750.7109762741329, 782.3858271257036, 782.9569373684445, 784.5332027443662, 784.6822037074994, 15509.844901550952, 15622.453214137564, 15851.0, 15923.964942278715, 16073.839261607469, 13519.121257118255, 13579.59261222165, 13589.980751443582, 13667.316634168352, 13694.52069177584, 10285.0, 10303.124234440007, 10353.9482302588, 10411.167106631527, 10649.893501064967, 3598.838052287653, 3614.819259037064, 3661.286049220403, 3737.103095257146, 3877.8448862045484, 83624.0, 85577.57211213966, 87679.12320876773, 87791.56104219439, 88416.0, 9743.65897193609, 9993.350432221881, 10051.0, 10067.76861148982, 10240.283180177465, 22659.773402266095, 22925.312240632808, 22980.770192298198, 24146.0, 24148.154814581405, 7779.572123533147, 7845.176256492986, 7931.920680793233, 7974.681012759424, 8064.919350806417, 4061.4923134608175, 4180.916381672349, 4264.381664658607, 4333.609975102193, 4387.122575484916, 3727.422249551324, 3737.869174578931, 3755.549334079928, 3799.677027452642, 3807.124361396839, 660.075893748746, 674.0, 678.1963373402534, 681.9556728812711, 688.3529482286634, 549.8405462415855, 586.5571493522449, 607.8541150123939, 610.3987572241339, 610.484140900938, 7609.885851712229, 8450.0, 8461.23848853606, 8491.830163396697, 8599.828003439896, 536.9597280204, 580.8054301808857, 607.908813677943, 625.6246252248615, 639.9552031357761, 3224.467962786161, 3442.294329662413, 3963.365861462152, 4000.9199816003515, 4018.9196216075516, 92394.0, 93036.0, 95409.0, 96780.0321996785, 97211.0, 51849.0, 64623.67688161529, 72396.0, 73204.63397682978, 83352.0, 69536.304636954, 71064.93402598966, 71688.0, 72548.54902901912, 73441.0, 8667.133286671282, 8766.60550275252, 8769.0, 8825.779355516164, 8960.462372257685, 47083.0, 51389.0, 52168.478315216365, 52922.47077529175, 53007.469925300255, 70836.0, 70966.0, 72364.63817680877, 73368.0, 73393.0642774283, 11059.778804424028, 11143.609973651208, 11253.268537545033, 11257.71855703614, 11616.0, 12123.515059397525, 12167.574134905235, 12344.197627154206, 12345.074119441257, 12468.127231093737, 11849.526018959144, 11886.465109069939, 11894.34581098048, 11921.52313907434, 11945.641630751092, 11837.585684501, 11855.762884742084, 11856.051515878882, 12003.279803211835, 12158.148929575198, 11169.38568378747, 11659.941700291443, 11810.527578896748, 11836.70408239801, 12327.0, 9903.801923961624, 9956.352837065568, 10172.898271017195, 10221.33561318512, 10287.382757034602, 8553.144685531397, 9735.269854761063, 9826.803463930824, 10090.34412763168, 10099.0], "value": 7172.994328134267, "unit": "score"}], "name": "dromaeo_css", "value": 7774.465590838259, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 112.0, 140.0, 170.0, 120.0, 151.0, 115.0, 101.0, 165.0, 167.0], "value": 135.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 136.0, 174.0, 159.0, 153.0, 165.0, 139.0, 123.0, 170.0, 120.0], "value": 150.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 228.0, 191.0, 282.0, 196.0, 189.0, 176.0, 166.0, 271.0, 182.0], "value": 207.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 80.0, 74.0, 142.0, 57.0, 56.0, 58.0, 71.0, 127.0, 57.0], "value": 78.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 81.0, 139.0, 110.0, 110.0, 132.0, 119.0, 78.0, 83.0, 120.0], "value": 105.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 85.0, 89.0, 84.0, 89.0, 85.0, 89.0, 86.0, 102.0, 128.0], "value": 93.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 133.0, 93.0, 103.0, 94.0, 94.0, 94.0, 126.0, 102.0, 94.0], "value": 107.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 91.0, 98.0, 91.0, 90.0, 89.0, 81.0, 149.0, 145.0, 92.0], "value": 101.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 62.0, 64.0, 64.0, 64.0, 65.0, 64.0, 77.0, 63.0, 60.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 67.0, 70.0, 65.0, 75.0, 72.0, 69.0, 66.0, 65.0, 66.0], "value": 67.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 79.0, 79.0, 82.0, 80.0, 79.0, 82.0, 81.0, 84.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 117.0, 145.0, 150.0, 137.0, 141.0, 141.0, 126.0, 182.0, 164.0], "value": 142.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 200.0, 200.0, 173.0, 215.0, 188.0, 162.0, 162.0, 166.0, 168.0], "value": 179.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 69.0, 61.0, 68.0, 101.0, 87.0, 61.0, 90.0, 64.0], "value": 73.4, "unit": "score"}], "name": "kraken", "value": 1586.8, "alertThreshold": 2.0}]} 20:29:05 INFO - Return code: 0 20:29:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:29:05 ERROR - # TBPL SUCCESS # 20:29:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:29:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:29:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:29:05 INFO - 2016-07-13 20:29:05.486 screenresolution[1689:10894] starting screenresolution argv=screenresolution get 20:29:05 INFO - 2016-07-13 20:29:05.488 screenresolution[1689:10894] Display 0: 1600x1200x32@60 20:29:05 INFO - 2016-07-13 20:29:05.494 screenresolution[1690:10897] starting screenresolution argv=screenresolution list 20:29:05 INFO - Available Modes on Display 0 20:29:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:29:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:29:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:29:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:29:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:29:05 INFO - Intel Iris: 20:29:05 INFO - Chipset Model: Intel Iris 20:29:05 INFO - Type: GPU 20:29:05 INFO - Bus: Built-In 20:29:05 INFO - VRAM (Dynamic, Max): 1536 MB 20:29:05 INFO - Vendor: Intel (0x8086) 20:29:05 INFO - Device ID: 0x0a2e 20:29:05 INFO - Revision ID: 0x0009 20:29:05 INFO - Displays: 20:29:05 INFO - Display: 20:29:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:29:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:29:05 INFO - Display Serial Number: 1600x1200 60 20:29:05 INFO - Main Display: Yes 20:29:05 INFO - Mirror: Off 20:29:05 INFO - Online: Yes 20:29:05 INFO - Rotation: Supported 20:29:05 INFO - Return code: 0 20:29:05 INFO - Running post-action listener: _resource_record_post_action 20:29:05 INFO - Running post-run listener: _resource_record_post_run 20:29:06 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 31661568; Write bytes: 498784768; Read time: 198; Write time: 1568 20:29:06 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194820608; Write bytes: 196584960; Read time: 17555; Write time: 425 20:29:06 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 29875712; Write bytes: 301192192; Read time: 181; Write time: 1139 20:29:06 INFO - Running post-run listener: _upload_blobber_files 20:29:06 INFO - Blob upload gear active. 20:29:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:29:06 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 20:29:06 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'] 20:29:06 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 20:29:07 INFO - (blobuploader) - INFO - Open directory for files ... 20:29:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:29:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:29:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:07 INFO - (blobuploader) - INFO - Done attempting. 20:29:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:29:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:29:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:08 INFO - (blobuploader) - INFO - Done attempting. 20:29:08 INFO - (blobuploader) - INFO - Iteration through files over. 20:29:08 INFO - Return code: 0 20:29:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:29:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:29:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d49ab636aa7a5d316f3c4efbe0cd391e266392212f9f8c20c42a6e5f63e8f1c880089520ad4c7d534e680eb16511f3742483ec4c4ca748a3bc7bd8c2ca70fe81", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/727e711ac27b35c003f1511270cee2e02b0980a616a65e7577bd9009271e4eda43650ec0654e909494cb3b9646477f68457f585a7efced89788cb1bd7910646d"} 20:29:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:29:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:29:08 INFO - Contents: 20:29:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d49ab636aa7a5d316f3c4efbe0cd391e266392212f9f8c20c42a6e5f63e8f1c880089520ad4c7d534e680eb16511f3742483ec4c4ca748a3bc7bd8c2ca70fe81", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/727e711ac27b35c003f1511270cee2e02b0980a616a65e7577bd9009271e4eda43650ec0654e909494cb3b9646477f68457f585a7efced89788cb1bd7910646d"} 20:29:08 INFO - Running post-run listener: copy_logs_to_upload_dir 20:29:08 INFO - Copying logs to upload dir... 20:29:08 INFO - mkdir: /builds/slave/test/build/upload/logs 20:29:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.131930 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-07-13 20:29:08.915084) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 20:29:08.918807) ========= 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.ZbcPeq1NoB/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.Ol5hwJmiMI/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d49ab636aa7a5d316f3c4efbe0cd391e266392212f9f8c20c42a6e5f63e8f1c880089520ad4c7d534e680eb16511f3742483ec4c4ca748a3bc7bd8c2ca70fe81", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/727e711ac27b35c003f1511270cee2e02b0980a616a65e7577bd9009271e4eda43650ec0654e909494cb3b9646477f68457f585a7efced89788cb1bd7910646d"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010760 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d49ab636aa7a5d316f3c4efbe0cd391e266392212f9f8c20c42a6e5f63e8f1c880089520ad4c7d534e680eb16511f3742483ec4c4ca748a3bc7bd8c2ca70fe81", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/727e711ac27b35c003f1511270cee2e02b0980a616a65e7577bd9009271e4eda43650ec0654e909494cb3b9646477f68457f585a7efced89788cb1bd7910646d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 20:29:08.957190) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 20:29:08.957759) ========= 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.ZbcPeq1NoB/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.Ol5hwJmiMI/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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.005007 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 20:29:09.007094) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 20:29:09.007416) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 20:29:09.007756) ========= ========= Total master_lag: 0.19 =========