I'm observing what feels like a bug in the calculation of "accepted size" in innd's checkpoint log lines with long-running connections. This may also be happening with status log lines, but I haven't focused on those.[...]
In the process of feeding >1 billion articles to a new server. Both servers are running INN and I'm using innxmit on the source machine. After starting innxmit, initially the calculation of the accepted size in the checkpoint log lines seems correct, but over time it seems to miscalculate.
% grep checkpoint log/news.notice | awk '{ print $23 }'
254853120
244031488
240500736
222146560
245587968
221945856
107102208 <--- begins to fall off dramatically
113074176
113967104
98664448
99794944
Best I can tell through watching the CNFS buffer, filesystem, and network metrics, I'm always receiving about the same rate/amount of data throughout the connection lifetime.
I do not personally know how to prove this out
further, so I'm throwing it out to the masses.
Hi Jesse,
I'm observing what feels like a bug in the calculation of "accepted size" in >> innd's checkpoint log lines with long-running connections. This may also be >> happening with status log lines, but I haven't focused on those.[...]
In the process of feeding >1 billion articles to a new server. Both servers >> are running INN and I'm using innxmit on the source machine. After starting >> innxmit, initially the calculation of the accepted size in the checkpoint log
lines seems correct, but over time it seems to miscalculate.
% grep checkpoint log/news.notice | awk '{ print $23 }'
254853120
244031488
240500736
222146560
245587968
221945856
107102208 <--- begins to fall off dramatically> 113074176
113967104
98664448
99794944
Best I can tell through watching the CNFS buffer, filesystem, and network
metrics, I'm always receiving about the same rate/amount of data throughout >> the connection lifetime.
After a quick glance at how innd computes the accepted size, I did not
find anything suspicious :(
I do not personally know how to prove this out
further, so I'm throwing it out to the masses.
Could you please add the -v flag to innxmit?
This way, it will write the accepted size of the articles it has sent,
from its point of view. It will be interesting to compare the values
between innd on your new server and innxmit on your source server.
It writes something like that when you stop it:
Dec 13 07:50:34 news innxmit[4066916]: news.hazardzone.fr stats offered
57805 accepted 57668 refused 6 rejected 99 missing 0 accsize 383582687 rejsize 1183910
Dec 13 07:50:34 news innxmit[4066916]: news.hazardzone.fr times user
2.449 system 11.016 elapsed 32855.176
Could you please add the -v flag to innxmit?
This way, it will write the accepted size of the articles it has sent,
from its point of view. It will be interesting to compare the values
between innd on your new server and innxmit on your source server.
It writes something like that when you stop it:
Dec 13 07:50:34 news innxmit[4066916]: news.hazardzone.fr stats offered
57805 accepted 57668 refused 6 rejected 99 missing 0 accsize 383582687 rejsize 1183910
Dec 13 07:50:34 news innxmit[4066916]: news.hazardzone.fr times user
2.449 system 11.016 elapsed 32855.176
There are discrepancies between innxmit and innd:
Jul 18 05:39:12 omnios-inn innxmit[14548]: [ID 738504 news.warning] 192.168.1.75 stats offered 27521180 accepted 27520730 refused 0 rejected 418 missing 0 accsize 87812383303 rejsize 696317
Jul 18 05:39:12 omnios-inn innxmit[14548]: [ID 452021 news.warning] 192.168.1.75 times user 476.884 system 3070.203 elapsed 39294.478
Jul 18 05:39:12 archive innd: [ID 702911 news.notice] 192.168.1.110:29 closed seconds 39295 accepted 27520762 refused 0 rejected 418 duplicate 32 accepted size 79449063424 duplicate size 99298 rejected size 696317
| Sysop: | Amessyroom |
|---|---|
| Location: | Fayetteville, NC |
| Users: | 74 |
| Nodes: | 6 (0 / 6) |
| Uptime: | 52:26:55 |
| Calls: | 1,101 |
| Calls today: | 1 |
| Files: | 1,339 |
| Messages: | 276,091 |