Daily Usenet report

Apr 23 04:15:01 -- Apr 24 04:15:01

Unknown entries from news log file:

First 36 / 36 lines (100.0%)

Apr 23 11:05:32 newsfeed nnrpd[95365]: SERVER perl filter not defined
Apr 23 11:05:32 newsfeed nnrpd[95365]: SERVER perl filter not defined
Apr 23 11:05:53 newsfeed nnrpd[95370]: SERVER perl filter not defined
Apr 23 11:05:53 newsfeed nnrpd[95370]: SERVER perl filter not defined
Apr 23 20:43:56 newsfeed pgpverify[164969]: pgpverify: verification failed
Apr 23 20:43:56 newsfeed pgpverify[164969]: pgpverify: verification failed
Apr 23 20:44:26 newsfeed pgpverify[164983]: pgpverify: verification failed
Apr 23 20:44:26 newsfeed pgpverify[164983]: pgpverify: verification failed
Apr 23 20:44:56 newsfeed pgpverify[165010]: pgpverify: verification failed
Apr 23 20:44:56 newsfeed pgpverify[165010]: pgpverify: verification failed
Apr 23 20:45:26 newsfeed pgpverify[165325]: pgpverify: verification failed
Apr 23 20:45:26 newsfeed pgpverify[165325]: pgpverify: verification failed
Apr 23 20:45:57 newsfeed pgpverify[165339]: pgpverify: verification failed
Apr 23 20:45:57 newsfeed pgpverify[165339]: pgpverify: verification failed
Apr 23 20:46:27 newsfeed pgpverify[165353]: pgpverify: verification failed
Apr 23 20:46:27 newsfeed pgpverify[165353]: pgpverify: verification failed
Apr 23 20:46:57 newsfeed pgpverify[165366]: pgpverify: verification failed
Apr 23 20:46:57 newsfeed pgpverify[165366]: pgpverify: verification failed
Apr 23 20:47:27 newsfeed pgpverify[165378]: pgpverify: verification failed
Apr 23 20:47:27 newsfeed pgpverify[165378]: pgpverify: verification failed
Apr 23 20:47:57 newsfeed pgpverify[165391]: pgpverify: verification failed
Apr 23 20:47:57 newsfeed pgpverify[165391]: pgpverify: verification failed
Apr 23 20:48:27 newsfeed pgpverify[165658]: pgpverify: verification failed
Apr 23 20:48:27 newsfeed pgpverify[165658]: pgpverify: verification failed
Apr 23 20:48:57 newsfeed pgpverify[165671]: pgpverify: verification failed
Apr 23 20:48:57 newsfeed pgpverify[165671]: pgpverify: verification failed
Apr 23 20:49:27 newsfeed pgpverify[165820]: pgpverify: verification failed
Apr 23 20:49:27 newsfeed pgpverify[165820]: pgpverify: verification failed
Apr 23 20:49:57 newsfeed pgpverify[165849]: pgpverify: verification failed
Apr 23 20:49:57 newsfeed pgpverify[165849]: pgpverify: verification failed
Apr 23 20:50:27 newsfeed pgpverify[165906]: pgpverify: verification failed
Apr 23 20:50:27 newsfeed pgpverify[165906]: pgpverify: verification failed
Apr 23 20:50:57 newsfeed pgpverify[165919]: pgpverify: verification failed
Apr 23 20:50:57 newsfeed pgpverify[165919]: pgpverify: verification failed
Apr 23 20:54:32 newsfeed pgpverify[166464]: pgpverify: verification failed
Apr 23 20:54:32 newsfeed pgpverify[166464]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 470067 91.1%49.5 MB 91.5%
innd 23392 4.5%2.4 MB 4.5%
nnrpd 21172 4.1%2.0 MB 3.8%
innfeed 1248 0.2%143.0 KB 0.3%
controlchan 54 0.0%9.3 KB 0.0%
pgpverify 32 0.0%3.7 KB 0.0%
overchan 2 0.0%0.3 KB 0.0%
TOTAL: 7 515967 100.0%54.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 935854 99.8%
Negative hits 1316 0.1%
Positive hits 88 0.0%
Cache misses 2 0.0%
TOTAL: 4 937260 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.014 0.0%78 0.000 0.179 1.500
article cleanup00:00:02.196 0.0%940770 0.001 0.002 0.005
article logging00:00:13.064 0.0%940858 0.008 0.014 0.025
article parse00:00:08.552 0.0%1888260 0.002 0.005 0.008
article write00:02:47.164 0.1%940768 0.019 0.178 22.716
artlog/artcncl00:00:00.000 0.0%18 0.000 0.000 0.000
data move00:00:01.248 0.0%2108584 0.000 0.001 0.003
hisgrep/artcncl00:00:00.000 0.0%96 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%18 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:02.946 0.0%942162 0.001 0.003 0.013
history sync00:00:00.020 0.0%690 0.000 0.029 0.500
history write00:00:53.382 0.0%940768 0.028 0.057 0.147
idle47:49:18.542 99.6%2460138 44.724 69.979 153.709
nntp read00:00:15.380 0.0%1653196 0.005 0.009 0.018
overview write00:00:01.294 0.0%940768 0.000 0.001 0.003
perl filter00:06:05.942 0.2%940768 0.299 0.389 0.562
python filter00:00:00.132 0.0%940772 0.000 0.000 0.001
site send00:00:12.258 0.0%1894684 0.004 0.006 0.010
TOTAL: 48:01:32.26648:00:02.134 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.030 0.0%13068 0.000 0.002 0.059
article prepare00:00:00.000 0.0%592 0.000 0.000 0.000
article read00:00:00.010 0.0%148 0.000 0.068 1.000
backlog stats00:00:00.020 0.0%76650 0.000 0.000 0.009
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.282 0.0%36120 0.000 0.008 0.059
data write00:00:00.736 0.0%22892 0.000 0.032 0.152
idle47:40:04.312100.0%76650 619.900 2238.804 7800.169
status file00:00:00.178 0.0%324 0.000 0.549 4.000
TOTAL: 47:40:06.32847:40:05.568100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:02:29.254 72.8%10508 1.000 14.204 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.240 0.1%36362 0.000 0.007 0.333
readart00:00:00.000 0.0%4 0.000 0.000 0.000
TOTAL: 00:03:25.14000:02:29.494 72.9%----

Control commands to INND:

CommandNumber
flush 54
flushlogs 4
go 4
logmode 4
lowmark 2
mode 298
name 4
pause 4
paused 4
reload 4
reserve 4
TOTAL: 11 386

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
control@usenet-fr.news.eu.org0023202
TOTAL0023202

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 176 940202 940198 2 2 99%66:49:48
2news.icm.edu.pl 56 72 4 68 0 5%10:07:16
3localhost 6 4 4 0 0 100%00:00:00
TOTAL: 3 238 940278 940206 70 2 99%76:57:04
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl3.6 GB22.3 KB0.0 KB3.6 GB 99%4.0 KB
2news.icm.edu.pl408.1 KB0.0 KB0.0 KB408.1 KB100%102.0 KB
3localhost7.8 KB0.0 KB0.0 KB7.8 KB100%1.9 KB
TOTAL: 33.6 GB22.3 KB0.0 KB3.6 GB 99%4.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 23 04:15:01 - 04:59:59 13938 3.0% 5.1643.2 MB 2.4% 16.39
Apr 23 05:00:00 - 05:59:59 19461 4.1% 5.4160.7 MB 3.3% 17.27
Apr 23 06:00:00 - 06:59:59 18606 4.0% 5.1756.6 MB 3.1% 16.09
Apr 23 07:00:00 - 07:59:59 18989 4.0% 5.2759.5 MB 3.3% 16.92
Apr 23 08:00:00 - 08:59:59 19433 4.1% 5.4068.7 MB 3.8% 19.53
Apr 23 09:00:00 - 09:59:59 21073 4.5% 5.85103.7 MB 5.7% 29.49
Apr 23 10:00:00 - 10:59:59 22366 4.8% 6.21116.1 MB 6.4% 33.03
Apr 23 11:00:00 - 11:59:59 21011 4.5% 5.8478.5 MB 4.3% 22.33
Apr 23 12:00:00 - 12:59:59 20357 4.3% 5.6574.9 MB 4.1% 21.32
Apr 23 13:00:00 - 13:59:59 21680 4.6% 6.0282.2 MB 4.5% 23.38
Apr 23 14:00:00 - 14:59:59 26484 5.6% 7.36110.6 MB 6.1% 31.46
Apr 23 15:00:00 - 15:59:59 20878 4.4% 5.8085.6 MB 4.7% 24.34
Apr 23 16:00:00 - 16:59:59 21751 4.6% 6.04100.3 MB 5.5% 28.52
Apr 23 17:00:00 - 17:59:59 17820 3.8% 4.9576.0 MB 4.2% 21.60
Apr 23 18:00:00 - 18:59:59 20796 4.4% 5.7889.8 MB 4.9% 25.55
Apr 23 19:00:00 - 19:59:59 20314 4.3% 5.6477.6 MB 4.2% 22.06
Apr 23 20:00:00 - 20:59:59 19247 4.1% 5.3571.2 MB 3.9% 20.24
Apr 23 21:00:00 - 21:59:59 17948 3.8% 4.9967.5 MB 3.7% 19.20
Apr 23 22:00:00 - 22:59:59 17661 3.8% 4.9171.2 MB 3.9% 20.27
Apr 23 23:00:00 - 23:59:59 18981 4.0% 5.2775.9 MB 4.2% 21.58
Apr 24 00:00:00 - 00:59:59 17893 3.8% 4.9766.6 MB 3.6% 18.95
Apr 24 01:00:00 - 01:59:59 17349 3.7% 4.8252.5 MB 2.9% 14.94
Apr 24 02:00:00 - 02:59:59 17330 3.7% 4.8151.6 MB 2.8% 14.66
Apr 24 03:00:00 - 03:59:59 14117 3.0% 3.9268.8 MB 3.8% 19.56
Apr 24 04:00:00 - 04:15:01 4530 1.0% 5.0315.8 MB 0.9% 17.95
TOTAL: 24:00:00 470013 100.0% 5.441.8 GB 100.0% 21.63
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 45 0 0 1 0 0 0 0 44
TOTAL: 1 45 0 0 1 0 0 0 0 44

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 44
TOTAL: 1 44
TOTAL: 1 44

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 23532 144 12950 4 0 0 0%47:59:32
2poznan 6 0 4 0 0 0 0%01:00:10
TOTAL: 2 23538 144 12954 4 0 0 0%48:59:42
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm444.5 KB21.8 KB466.3 KB0.0 KB/s3.2 KB47:59:32
2poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:00:10
TOTAL: 2444.5 KB21.8 KB466.3 KB0.0 KB/s3.2 KB48:59:42
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1172.16.2.4 576 46.3 KB 2 0 000:01:02
2isvcs01.man.lodz.pl 4 00.0 KB 0 4 000:00:00
TOTAL: 2 580 46.3 KB 2 4 000:03:26

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved1470 46.3 KB 2 0 000:02:22
2*.man.lodz.pl2884 00.0 KB 0 4 000:00:24
3*.internet-census.org 10 00.0 KB 0 0 000:00:38
4*.195.132.66.censys-scanner.com 2 00.0 KB 0 0 000:00:01
TOTAL: 44366 46.3 KB 2 4 000:03:26

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
172.16.2.4 1.460 2.974 0.00000:01:02
93.123.109.166 1.620 3.722 0.00000:00:24
nms1.man.lodz.pl 6.674 14.230 0.00000:00:24
152.32.164.139 0.010 0.032 0.00000:00:23
zl-dala-us-gp1-wk123a.internet-census.org 0.004 0.012 0.00000:00:21
95.163.5.83 0.018 0.008 0.00000:00:20
80.111.142.213 0.026 0.038 0.00000:00:05
zl-laxc-us-cpp-wk109.internet-census.org 0.004 0.010 0.00000:00:04
sh-chi-us-cpp-wk106.internet-census.org 0.002 0.012 0.00000:00:04
sh-chi-us-cpp-wk107.internet-census.org 0.004 0.010 0.00000:00:04
sh-ams-nl-cpp-wk103.internet-census.org 0.006 0.008 0.00000:00:04
147.185.133.33 0.002 0.012 0.00000:00:03
110.195.132.66.censys-scanner.com 0.052 0.020 0.00000:00:01
195.140.214.30 0.006 0.008 0.00000:00:00
205.210.31.248 0.002 0.012 0.00000:00:00
193.176.31.152 0.002 0.014 0.00000:00:00
isvcs01.man.lodz.pl 0.020 0.018 0.00000:00:00
TOTAL: 17 9.912 21.140 0.00000:03:26

Curious NNRP server explorers [Top 20]:

SystemConn
nms1.man.lodz.pl 2880
93.123.109.166 870
80.111.142.213 8
152.32.164.139 6
zl-dala-us-gp1-wk123a.internet-census.org 2
95.163.5.83 2
sh-ams-nl-cpp-wk103.internet-census.org 2
sh-chi-us-cpp-wk107.internet-census.org 2
110.195.132.66.censys-scanner.com 2
sh-chi-us-cpp-wk106.internet-census.org 2
193.176.31.152 2
zl-laxc-us-cpp-wk109.internet-census.org 2
205.210.31.248 2
195.140.214.30 2
147.185.133.33 2
TOTAL: 15 3786

NNRP unrecognized commands (by host) [Top 20]:

SystemConn
93.123.109.166 1948
147.185.133.33 8
152.32.164.139 4
110.195.132.66.censys-scanner.com 2
TOTAL: 4 1962

NNRP unrecognized commands (by command) [Top 20]:

CommandCount
À#024À#022#023#001#023#002#023#003#001 870
#026#003#001#001#006#001 870
¢#033é 2
ý†—¸zêÔ#006D„€eŠ 2
ßøü­ÁÜŸ¢­*Í 2
Åx#004#022 2
HÐ#025xO=ã£#025‹ª&eMæÛ7¦ ¯dd%¥D@Géz 2
#017#001àj#036Œ”Ã`Rãò ‹Ð©"€÷‰l^Ì\¿#014íÏÁµ¼#005×W#014¤À-#S... 2
ó¯G›a#004{#=€½#023#001a €Åʶ‘l5r/ 2
¡éÛDIšT‡ÚÉ¥&b)Ðd#011Ë»#011#003²[KZ Í 2
3jh¹÷b6ä÷.¨çÚ‡#021 Ó=žÔ?¸Õ#014‰]#010zõ‰AƒÒY]åL... 2
ðTë¸#017 2
`ávdd±nݧ $Îr$#015#034H‚ðLFmHi7™ä;Vk#030§;>¨jSò§... 2
!øE#027¥#015S©á…ï­ Zhò’‰¨#010¼ö\„cLýÃÀaÏx™{#024¢DU... 2
#030\¼HN<Ç–x#011*õ*ë9Ïàvsv& q#007ü#0165(­%#005¼e»¥ÓU#031þ... 2
çpvwÜWì#020:wc'#015Il 2
—#017͉3À– n#034Í”–o†3ÎêB~#021w 2
ý&)#037°kˆQ 2
vZ]T#027£þ\x7fÊlzS#014§Òg¼!øŸCΤ©38'e #021ôQí-f"ÜŠÖ... 2
H¢´ò#023#037Ï ¢Ê+#021Ñu\‘Õ+ÿYtƒ89‹‹4E€YûÑaìžõ9c 2
TOTAL: 113 1962

NNRP client timeouts [Top 20]:

SystemConnPeer
195.140.214.30 2 2
TOTAL: 1 2 6

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1pl 4100.0%
TOTAL: 1 4100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

NewsgroupCount
1pl.comp.pecet 4
TOTAL: 1 4