Skip to content

feat: proactive weather IV switching#295

Merged
Fabio1988 merged 27 commits intoUnownHash:mainfrom
Mygod:proactive-weather-iv
Nov 15, 2025
Merged

feat: proactive weather IV switching#295
Fabio1988 merged 27 commits intoUnownHash:mainfrom
Mygod:proactive-weather-iv

Conversation

@Mygod
Copy link
Contributor

@Mygod Mygod commented Jul 31, 2025

This implements proactive Pokemon IV switching upon weather changes. By default, all entries will only be updated in memory unless configured to also write to DB (in that case, only new entries with valid IV will be written).

Needs testing. Anyone? :) @lenisko @M3G4THEKING

Fixes #131.

@Fabio1988
Copy link
Collaborator

Fabio1988 commented Jul 31, 2025

You still ignore our concerns about load?
Can you collect performance metrics?

RM could simply consider weather change on visualization.. and poracle already handles this successfully... What's the reason behind this?
Updating thousands of pokemon in one go, which are useless as we encounter them soonish... Or can you predict IV? 😉

It's good you added a toggle for DB... But not sure if that feature is the correct place in general... Metrics will tell :)

}
if scanParameters.ProcessPokemon {
decoder.UpdatePokemonBatch(ctx, dbDetails, scanParameters, newWildPokemon, newNearbyPokemon, newMapPokemon, decodedGmo.ClientWeather, protoData.Account)
if scanParameters.ProcessWeather && scanParameters.ProactiveIVSwitching {
Copy link
Collaborator

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

Why is this handled as scan Parameter, not just as config check?

Copy link
Contributor Author

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

So that it could be configured per area?

@Mygod
Copy link
Contributor Author

Mygod commented Jul 31, 2025

Someone send me data so I can collect performance metric. :)

@Mygod
Copy link
Contributor Author

Mygod commented Jul 31, 2025

Also yes IV prediction is available sometimes, and the data is only available in Golbat, not in ReactMap.

@Mygod
Copy link
Contributor Author

Mygod commented Aug 2, 2025

Some preliminary test data. 👀

INFO 2025-08-01 20:00:00 ProactiveIVSwitch - scan time 24.744222ms (locked time 166ns), 9968/4938/4937/1 cp scanned/locked/updated/cp updated
INFO 2025-08-01 20:00:01 ProactiveIVSwitch - scan time 3.562877ms (locked time 228ns), 2238/155/155/0 cp scanned/locked/updated/cp updated
INFO 2025-08-01 20:00:02 ProactiveIVSwitch - scan time 4.911161ms (locked time 102ns), 4043/55/55/0 cp scanned/locked/updated/cp updated
INFO 2025-08-01 20:00:02 ProactiveIVSwitch - scan time 9.140878ms (locked time 679ns), 6117/278/278/0 cp scanned/locked/updated/cp updated
INFO 2025-08-01 20:00:02 ProactiveIVSwitch - scan time 6.701312ms (locked time 90ns), 2615/783/781/1 cp scanned/locked/updated/cp updated
INFO 2025-08-01 20:00:40 ProactiveIVSwitch - scan time 2.925664ms (locked time 98ns), 2563/95/95/0 cp scanned/locked/updated/cp updated
INFO 2025-08-01 20:00:52 ProactiveIVSwitch - scan time 3.014828ms (locked time 113ns), 2762/60/60/0 cp scanned/locked/updated/cp updated
INFO 2025-08-01 21:00:00 ProactiveIVSwitch - scan time 5.950067ms (locked time 278ns), 2167/1023/1023/0 cp scanned/locked/updated/cp updated
INFO 2025-08-01 21:00:03 ProactiveIVSwitch - scan time 5.833738ms (locked time 165ns), 3823/346/346/0 cp scanned/locked/updated/cp updated
INFO 2025-08-01 21:00:23 ProactiveIVSwitch - scan time 3.759298ms (locked time 114ns), 2943/130/126/0 cp scanned/locked/updated/cp updated
INFO 2025-08-01 22:00:00 ProactiveIVSwitch - scan time 14.181379ms (locked time 195ns), 6380/2315/2311/0 cp scanned/locked/updated/cp updated
INFO 2025-08-01 22:00:00 ProactiveIVSwitch - scan time 13.944812ms (locked time 101ns), 6383/2315/1909/0 cp scanned/locked/updated/cp updated
INFO 2025-08-01 22:00:00 ProactiveIVSwitch - scan time 12.570836ms (locked time 108ns), 6384/2318/2311/4 cp scanned/locked/updated/cp updated
INFO 2025-08-01 22:00:00 ProactiveIVSwitch - scan time 4.841025ms (locked time 85ns), 3748/341/341/3 cp scanned/locked/updated/cp updated
INFO 2025-08-01 22:00:02 ProactiveIVSwitch - scan time 6.801804ms (locked time 624ns), 3824/592/591/0 cp scanned/locked/updated/cp updated
INFO 2025-08-01 22:00:02 ProactiveIVSwitch - scan time 16.199377ms (locked time 240ns), 4948/2202/2201/1 cp scanned/locked/updated/cp updated
INFO 2025-08-01 22:00:02 ProactiveIVSwitch - scan time 5.454318ms (locked time 125ns), 2510/754/751/4 cp scanned/locked/updated/cp updated
INFO 2025-08-01 22:00:03 ProactiveIVSwitch - scan time 7.495583ms (locked time 107ns), 5034/538/538/0 cp scanned/locked/updated/cp updated
INFO 2025-08-01 22:00:08 ProactiveIVSwitch - scan time 3.346822ms (locked time 93ns), 2494/111/111/0 cp scanned/locked/updated/cp updated

@jfberry
Copy link
Collaborator

jfberry commented Aug 2, 2025

Some thoughts (without full review):

  • We would want to find a way to only download one master file - we worked to get ohbemgo to be resistant to github/internet outages and this is cached locally. Can the file be shared?
  • Given the mass of updates, under no circumstances would we ever want to update the database, this option should not be available

I remain unconvinced of the value of this given that new encounters will be along in short order with any reasonable scanning strategy and most of the pokemon impacted are total junk. You state that IV can be predicted - under what circumstances and what proportion of pokemon?

We need to work out how the large number of internal locks that will be taken out reduces concurrency of processing of the pokemon which will be being delivered by the scanner (the very same ones that are being locked will be the ones we see in early GMOs and be receiving encounters for). So the timings for the change aren't enough to understand the impact - it's the overall flow through the system that we need to find some measure for. I'm not quite sure (perhaps we can measure the time for processing of GMOs and encounters to complete and see if there is a statistical impact) - I think this is already logged. Clearly this is going to be hard to see on lightly loaded systems so we'll need to consider the load volume required to gather evidence.

I also have some concern about the webhook volume generated.

@Mygod
Copy link
Contributor Author

Mygod commented Aug 2, 2025

Fixed an important bug. Now the performance is like:

INFO 2025-08-02 09:00:00 ProactiveIVSwitch - scan time 7.431183ms (locked time 226ns), 5481/2400/408/2 scanned/locked/updated/cp updated
INFO 2025-08-02 09:00:00 ProactiveIVSwitch - scan time 5.926572ms (locked time 113ns), 3571/2173/475/1 scanned/locked/updated/cp updated
INFO 2025-08-02 09:00:01 ProactiveIVSwitch - scan time 2.469165ms (locked time 173ns), 1808/166/15/4 scanned/locked/updated/cp updated
INFO 2025-08-02 09:00:02 ProactiveIVSwitch - scan time 9.893494ms (locked time 117ns), 8762/1494/494/5 scanned/locked/updated/cp updated
INFO 2025-08-02 09:00:02 ProactiveIVSwitch - scan time 4.4816ms (locked time 260ns), 5194/386/122/0 scanned/locked/updated/cp updated
INFO 2025-08-02 09:00:03 ProactiveIVSwitch - scan time 3.54144ms (locked time 119ns), 2777/593/82/2 scanned/locked/updated/cp updated
INFO 2025-08-02 09:00:45 ProactiveIVSwitch - scan time 2.771539ms (locked time 88ns), 2292/144/77/0 scanned/locked/updated/cp updated
INFO 2025-08-02 10:00:00 ProactiveIVSwitch - scan time 5.354366ms (locked time 106ns), 4033/600/124/0 scanned/locked/updated/cp updated
INFO 2025-08-02 10:00:00 ProactiveIVSwitch - scan time 3.523ms (locked time 87ns), 3109/372/74/2 scanned/locked/updated/cp updated
INFO 2025-08-02 10:00:01 ProactiveIVSwitch - scan time 2.816065ms (locked time 108ns), 1482/1017/159/3 scanned/locked/updated/cp updated
INFO 2025-08-02 10:00:05 ProactiveIVSwitch - scan time 2.320524ms (locked time 125ns), 1751/165/51/0 scanned/locked/updated/cp updated

@jfberry We can certainly look into having a single masterfile if we are to merge this. Also while ohbemgo has a local file cache, it only writes to it and never reads from it. (I copied this implementation from ohbemgo.)

As you can see, the db updates are only about 0-5 rows per cell changes on average (the last number). These are also exactly the portions that IVs are non-trivially predicted (usually due to it being Ditto or something similar). The number of locked rows probably could be optimized further.

@Mygod
Copy link
Contributor Author

Mygod commented Aug 2, 2025

Re webhooks: also fixed so that only the "cp updated" pokemon will get a webhook, so 0-5 per weather cell update.

@Mygod
Copy link
Contributor Author

Mygod commented Aug 2, 2025

Regarding "I remain unconvinced of the value of this given that new encounters will be along in short order with any reasonable scanning strategy", @lenisko please explain why you want WatWowMap/ReactMap#1120. Are you not using a reasonable scanning strategy?

@Mygod
Copy link
Contributor Author

Mygod commented Aug 2, 2025

After a bit more optimization:

INFO 2025-08-02 13:00:00 ProactiveIVSwitch - scan time 43.759442ms (locked time 119ns), 19317/1976/1976/2 scanned/locked/updated/cp updated
INFO 2025-08-02 13:00:01 ProactiveIVSwitch - scan time 31.771912ms (locked time 266ns), 10380/162/162/0 scanned/locked/updated/cp updated
INFO 2025-08-02 13:00:01 ProactiveIVSwitch - scan time 5.023593ms (locked time 148ns), 4427/77/77/0 scanned/locked/updated/cp updated
INFO 2025-08-02 13:00:01 ProactiveIVSwitch - scan time 12.135364ms (locked time 295ns), 8651/691/691/4 scanned/locked/updated/cp updated
INFO 2025-08-02 13:00:03 ProactiveIVSwitch - scan time 4.886356ms (locked time 111ns), 5184/153/153/1 scanned/locked/updated/cp updated
INFO 2025-08-02 13:00:03 ProactiveIVSwitch - scan time 3.197331ms (locked time 226ns), 2921/4/4/0 scanned/locked/updated/cp updated
INFO 2025-08-02 14:00:01 ProactiveIVSwitch - scan time 7.622185ms (locked time 96ns), 3532/394/394/2 scanned/locked/updated/cp updated
INFO 2025-08-02 14:00:03 ProactiveIVSwitch - scan time 3.398792ms (locked time 159ns), 2759/93/93/3 scanned/locked/updated/cp updated
INFO 2025-08-02 16:00:00 ProactiveIVSwitch - scan time 19.196927ms (locked time 132ns), 4492/526/526/0 scanned/locked/updated/cp updated
INFO 2025-08-02 16:00:00 ProactiveIVSwitch - scan time 3.597717ms (locked time 133ns), 2788/175/175/0 scanned/locked/updated/cp updated
INFO 2025-08-02 16:00:02 ProactiveIVSwitch - scan time 4.882574ms (locked time 150ns), 2689/34/34/1 scanned/locked/updated/cp updated
INFO 2025-08-02 16:00:03 ProactiveIVSwitch - scan time 4.692408ms (locked time 100ns), 3499/82/82/0 scanned/locked/updated/cp updated
INFO 2025-08-02 16:00:04 ProactiveIVSwitch - scan time 15.444788ms (locked time 201ns), 3557/658/658/4 scanned/locked/updated/cp updated
INFO 2025-08-02 17:00:00 ProactiveIVSwitch - scan time 3.049408ms (locked time 126ns), 2742/70/70/4 scanned/locked/updated/cp updated
INFO 2025-08-02 17:00:01 ProactiveIVSwitch - scan time 4.67523ms (locked time 112ns), 3489/403/403/1 scanned/locked/updated/cp updated
INFO 2025-08-02 19:00:01 ProactiveIVSwitch - scan time 4.312186ms (locked time 112ns), 1421/510/510/2 scanned/locked/updated/cp updated
INFO 2025-08-02 19:00:01 ProactiveIVSwitch - scan time 8.226193ms (locked time 111ns), 3484/603/603/4 scanned/locked/updated/cp updated
INFO 2025-08-02 19:00:02 ProactiveIVSwitch - scan time 5.047242ms (locked time 118ns), 2732/197/197/1 scanned/locked/updated/cp updated
INFO 2025-08-02 19:00:02 ProactiveIVSwitch - scan time 4.423982ms (locked time 127ns), 2935/117/117/0 scanned/locked/updated/cp updated
INFO 2025-08-02 19:00:02 ProactiveIVSwitch - scan time 2.57351ms (locked time 105ns), 1711/46/46/1 scanned/locked/updated/cp updated
INFO 2025-08-02 19:34:40 ProactiveIVSwitch - scan time 114.499µs (locked time 131ns), 70/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-02 19:34:40 ProactiveIVSwitch - scan time 79.687µs (locked time 88ns), 70/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-02 19:45:08 ProactiveIVSwitch - scan time 374.439µs (locked time 175ns), 237/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-02 20:00:02 ProactiveIVSwitch - scan time 2.827417ms (locked time 110ns), 2131/46/46/0 scanned/locked/updated/cp updated
INFO 2025-08-02 21:00:00 ProactiveIVSwitch - scan time 26.860431ms (locked time 238ns), 15146/1303/1303/2 scanned/locked/updated/cp updated
INFO 2025-08-02 21:00:01 ProactiveIVSwitch - scan time 1.615867ms (locked time 126ns), 1601/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-02 21:00:02 ProactiveIVSwitch - scan time 9.472621ms (locked time 216ns), 8345/132/132/0 scanned/locked/updated/cp updated
INFO 2025-08-02 21:00:04 ProactiveIVSwitch - scan time 7.699837ms (locked time 118ns), 6308/279/279/0 scanned/locked/updated/cp updated
INFO 2025-08-02 21:00:04 ProactiveIVSwitch - scan time 3.316102ms (locked time 110ns), 3232/15/15/0 scanned/locked/updated/cp updated
INFO 2025-08-02 21:03:21 ProactiveIVSwitch - scan time 2.242611ms (locked time 118ns), 2059/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-02 22:00:01 ProactiveIVSwitch - scan time 4.826435ms (locked time 152ns), 4314/54/54/0 scanned/locked/updated/cp updated
INFO 2025-08-02 22:01:32 ProactiveIVSwitch - scan time 2.884676ms (locked time 100ns), 2099/13/13/1 scanned/locked/updated/cp updated
INFO 2025-08-02 23:00:00 ProactiveIVSwitch - scan time 21.672075ms (locked time 129ns), 14749/1128/1128/0 scanned/locked/updated/cp updated
INFO 2025-08-02 23:00:00 ProactiveIVSwitch - scan time 15.667495ms (locked time 125ns), 6570/1110/1110/1 scanned/locked/updated/cp updated
INFO 2025-08-02 23:00:01 ProactiveIVSwitch - scan time 12.462727ms (locked time 125ns), 8056/102/102/1 scanned/locked/updated/cp updated
INFO 2025-08-02 23:00:03 ProactiveIVSwitch - scan time 9.222904ms (locked time 88ns), 7583/291/291/0 scanned/locked/updated/cp updated
INFO 2025-08-02 23:00:03 ProactiveIVSwitch - scan time 3.724371ms (locked time 126ns), 3828/46/46/2 scanned/locked/updated/cp updated
INFO 2025-08-02 23:00:04 ProactiveIVSwitch - scan time 4.624916ms (locked time 109ns), 4570/68/68/3 scanned/locked/updated/cp updated
INFO 2025-08-02 23:00:21 ProactiveIVSwitch - scan time 2.206407ms (locked time 134ns), 1809/9/9/0 scanned/locked/updated/cp updated
INFO 2025-08-02 23:01:01 ProactiveIVSwitch - scan time 2.55801ms (locked time 114ns), 2251/19/19/0 scanned/locked/updated/cp updated
INFO 2025-08-02 23:01:39 ProactiveIVSwitch - scan time 1.667758ms (locked time 136ns), 1531/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-02 23:02:50 ProactiveIVSwitch - scan time 2.956771ms (locked time 123ns), 2631/3/3/0 scanned/locked/updated/cp updated

@lenisko
Copy link
Contributor

lenisko commented Aug 2, 2025

Regarding "I remain unconvinced of the value of this given that new encounters will be along in short order with any reasonable scanning strategy", @lenisko please explain why you want WatWowMap/ReactMap#1120. Are you not using a reasonable scanning strategy?

Since it sounded like an easy change that would notify users about outdated data. Considering the most are using routes that would land in the same place in 10 minutes, that's in worst case 10 minutes of misleading data on the map.

Short answer for question without any knowledge around PR (I'm busy next week).

@jfberry
Copy link
Collaborator

jfberry commented Aug 3, 2025

Since it sounded like an easy change that would notify users about outdated data. Considering the most are using routes that would land in the same place in 10 minutes, that's in worst case 10 minutes of misleading data on the map.

the issue is not so much whether it is easy it’s more the total volume of pokemon that will have their IV stripped at the same time (on the hour) - question are therefore

  • what %age of records are modified both in one cell and general overall weather change frequency across a large map
  • What is the cpu/concurrency cost of doing this rather than just wait until they are accurately updated
  • How many Pokemon can be proactively updated vs just getting wiped

obviously this the has a downstream impact on other tools but the webhook issue may have been mitigated above, I haven’t had a chance to review yet

@Mygod
Copy link
Contributor Author

Mygod commented Aug 3, 2025

What is the most important metric you want to be measured? It sounds like these are just indirect measures that in the end do not amount to anything. If everything finishes instantaneously with negligible effect on the system, who cares?

"the total volume of pokemon that will have their IV stripped": depends on the weather and the current spawn pool. It could be 0% or 100% for community days. For the current spawn pool, it looks like around 10-20%.

"How many Pokemon can be proactively updated": also depends on the event. As I mentioned above, for the current event (and most events) this is looking like about 0-5 Pokemon per weather cell.

@jfberry
Copy link
Collaborator

jfberry commented Aug 3, 2025

It sounds like these are just indirect measures that in the end do not amount to anything. If everything finishes instantaneously with negligible effect on the system, who cares?

it’s a proxy to help understand the quantum of change.

If db updates are entirely disallowed that mitigates a large proportion of potential problems and if webhooks are restricted to those which have a value rather than switching to ‘no IV’ that also reduces a category of contention.

I am absolutely in favour of having an accurate representation of the pokemon in memory, but bulk changes have a history of causing problems and so I am seeking to proactively avoid this

@Mygod
Copy link
Contributor Author

Mygod commented Aug 3, 2025

Db updates even when enabled (disabled by default) are also restricted to the same pokemon as webhooks (those with a CP set). The performance I'm currently seeing is better than what I expected honestly but I haven't got a lot of data.

By the way, currently about 50% of the Pokemon scans are wasted because the data structure only supports queries by lat lon bounding box, and only ~50% of the area of the bounding box actually contains the weather cell (this percentage varies by location). If our in-memory data structure is instead using S2 cells then it would make this more efficient. :)

@jfberry
Copy link
Collaborator

jfberry commented Aug 3, 2025

Db updates even when enabled (disabled by default) are also restricted to the same pokemon as webhooks (those with a CP set). The performance I'm currently seeing is better than what I expected honestly but I haven't got a lot of data.

That’s encouraging - your provisional results are also better than I expected. Database is the largest concern for obvious reasons

By the way, currently about 50% of the Pokemon scans are wasted because the data structure only supports queries by lat lon bounding box, and only ~50% of the area of the bounding box actually contains the weather cell (this percentage varies by location). If our in-memory data structure is instead using S2 cells then it would make this more efficient. :)

yes when I made my original comments about memory size it was with the assumption a cell to Pokemon mapping would be needed. Your solution sidesteps this using current data structures so then it becomes a pure perf/concurrency impact

@Mygod
Copy link
Contributor Author

Mygod commented Aug 4, 2025

Yes, I was actually suggesting to use S2 cell data structure for the entire Pokemon tree.

Now under a much higher load:

INFO 2025-08-03 17:00:00 ProactiveIVSwitch - scan time 17.210957ms (locked time 112ns), 6594/365/365/2 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:00 ProactiveIVSwitch - scan time 38.071757ms (locked time 111ns), 4166/319/319/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:00 ProactiveIVSwitch - scan time 18.87786ms (locked time 191ns), 2300/1/1/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:00 ProactiveIVSwitch - scan time 49.393622ms (locked time 92ns), 4063/202/202/1 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:00 ProactiveIVSwitch - scan time 71.693761ms (locked time 125ns), 4494/243/243/4 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:00 ProactiveIVSwitch - scan time 32.321356ms (locked time 187ns), 2284/19/19/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:00 ProactiveIVSwitch - scan time 182.734195ms (locked time 112ns), 11487/482/481/1 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:00 ProactiveIVSwitch - scan time 136.196326ms (locked time 121ns), 4964/199/198/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:00 ProactiveIVSwitch - scan time 124.016513ms (locked time 122ns), 4954/474/474/1 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:00 ProactiveIVSwitch - scan time 237.904716ms (locked time 158ns), 7344/545/545/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:00 ProactiveIVSwitch - scan time 418.651748ms (locked time 91ns), 14311/1374/1372/4 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 207.150177ms (locked time 13.799µs), 5537/492/492/4 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 455.933144ms (locked time 104ns), 13298/703/703/3 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 308.421349ms (locked time 116ns), 8374/536/536/3 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 468.479141ms (locked time 41.4µs), 12975/1047/1047/3 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 303.068376ms (locked time 131ns), 9914/473/473/1 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 159.182678ms (locked time 93ns), 6070/199/199/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 215.845554ms (locked time 106ns), 7798/328/328/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 302.115078ms (locked time 119ns), 10243/675/674/2 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 335.058187ms (locked time 180ns), 9585/832/831/7 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 899.183868ms (locked time 122ns), 36665/1724/1724/2 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 210.310393ms (locked time 94ns), 6222/492/492/4 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 905.975876ms (locked time 114ns), 37934/1771/1770/3 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 130.86895ms (locked time 165ns), 5887/159/159/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 53.579304ms (locked time 98ns), 3880/97/97/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 380.125078ms (locked time 124ns), 9952/700/699/2 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 580.604885ms (locked time 108ns), 21999/971/971/4 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 829.835682ms (locked time 111ns), 27396/1173/1172/4 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 204.893623ms (locked time 153ns), 11196/364/363/1 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 286.411509ms (locked time 94ns), 8569/986/984/3 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 107.835254ms (locked time 107ns), 5320/343/343/2 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 367.619761ms (locked time 175ns), 19145/619/619/4 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 993.116524ms (locked time 124ns), 47210/2691/2690/15 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 1.112304178s (locked time 118ns), 51301/2630/2627/14 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 37.510057ms (locked time 102ns), 3702/67/67/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 91.185604ms (locked time 111ns), 11299/589/589/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 98.255081ms (locked time 120ns), 14776/543/542/1 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 31.810414ms (locked time 132ns), 9666/734/733/4 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 83.508732ms (locked time 267ns), 8212/311/311/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 89.316199ms (locked time 119ns), 5384/505/505/3 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 106.152409ms (locked time 95ns), 6901/405/405/2 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 53.790245ms (locked time 97ns), 4662/183/183/2 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 104.686547ms (locked time 90ns), 10934/291/290/3 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 44.43459ms (locked time 121ns), 6525/646/646/1 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 9.80482ms (locked time 132ns), 3649/18/18/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 31.654209ms (locked time 152ns), 8267/669/669/6 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 35.906503ms (locked time 89ns), 10822/782/782/3 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 22.051625ms (locked time 91ns), 6204/361/361/1 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 22.901705ms (locked time 155ns), 5326/156/156/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 12.749905ms (locked time 102ns), 5058/121/121/1 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 11.063106ms (locked time 77ns), 4119/366/366/1 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 11.241941ms (locked time 83ns), 5445/239/239/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 14.207524ms (locked time 131ns), 4314/309/309/1 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 21.086293ms (locked time 155ns), 6190/683/683/3 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 12.716616ms (locked time 141ns), 5710/296/296/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 16.880656ms (locked time 132ns), 6271/439/437/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 27.543644ms (locked time 119ns), 7277/634/634/2 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 12.538884ms (locked time 184ns), 5558/29/29/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 10.843724ms (locked time 151ns), 4017/199/199/1 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:03 ProactiveIVSwitch - scan time 9.745354ms (locked time 118ns), 3938/192/192/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:03 ProactiveIVSwitch - scan time 10.374635ms (locked time 36.069µs), 3673/89/89/1 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:03 ProactiveIVSwitch - scan time 30.50035ms (locked time 128ns), 8535/517/516/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:03 ProactiveIVSwitch - scan time 13.853502ms (locked time 99ns), 6082/69/69/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:03 ProactiveIVSwitch - scan time 23.057303ms (locked time 150ns), 8201/109/109/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:03 ProactiveIVSwitch - scan time 6.072614ms (locked time 157ns), 2352/25/25/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:03 ProactiveIVSwitch - scan time 15.591003ms (locked time 105ns), 5867/487/487/2 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:03 ProactiveIVSwitch - scan time 184.153µs (locked time 128ns), 84/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:03 ProactiveIVSwitch - scan time 72.361µs (locked time 73ns), 50/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:04 ProactiveIVSwitch - scan time 7.634223ms (locked time 97ns), 2564/312/312/2 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:04 ProactiveIVSwitch - scan time 4.448363ms (locked time 122ns), 2055/28/28/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:05 ProactiveIVSwitch - scan time 14.073336ms (locked time 118ns), 4113/274/274/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:05 ProactiveIVSwitch - scan time 11.6455ms (locked time 106ns), 3603/185/185/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:06 ProactiveIVSwitch - scan time 12.888378ms (locked time 126ns), 5434/29/29/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:06 ProactiveIVSwitch - scan time 10.777289ms (locked time 98ns), 5140/23/23/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:06 ProactiveIVSwitch - scan time 6.509662ms (locked time 103ns), 2857/57/57/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:07 ProactiveIVSwitch - scan time 14.948383ms (locked time 100ns), 6151/148/148/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:07 ProactiveIVSwitch - scan time 11.436718ms (locked time 99ns), 5063/12/12/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:09 ProactiveIVSwitch - scan time 8.536369ms (locked time 101ns), 4003/49/49/3 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:10 ProactiveIVSwitch - scan time 3.211823ms (locked time 124ns), 1546/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:11 ProactiveIVSwitch - scan time 10.233337ms (locked time 149ns), 3494/37/37/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:11 ProactiveIVSwitch - scan time 8.460503ms (locked time 116ns), 4651/2/2/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:15 ProactiveIVSwitch - scan time 4.298525ms (locked time 101ns), 2473/6/6/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:17 ProactiveIVSwitch - scan time 8.722355ms (locked time 98ns), 4314/1/1/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:18 ProactiveIVSwitch - scan time 6.753391ms (locked time 121ns), 3022/11/11/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:27 ProactiveIVSwitch - scan time 3.028656ms (locked time 123ns), 1225/7/7/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:28 ProactiveIVSwitch - scan time 701.719µs (locked time 679ns), 154/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:28 ProactiveIVSwitch - scan time 2.80267ms (locked time 176ns), 569/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:31 ProactiveIVSwitch - scan time 9.393629ms (locked time 114ns), 4859/3/3/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:40 ProactiveIVSwitch - scan time 228.826µs (locked time 88ns), 145/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:45 ProactiveIVSwitch - scan time 4.600797ms (locked time 107ns), 2306/0/0/0 scanned/locked/updated/cp updated

Thoughts?

@jfberry
Copy link
Collaborator

jfberry commented Aug 4, 2025

Yes, I was actually suggesting to use S2 cell data structure for the entire Pokemon tree.

When I did my (desktop) research on data structures, I considered an S2-index (and quadkey) before settling on the rtree structure. The general consensus seemed to be that the S2 structures did not react well to rapid change and suited a more static set of objects being searched. This would map to spawnpoints quite well potentially (if you accepted that you could have inactive spawnpoints present), but didn't map well to active pokemon. The other consideration was read/write concurrency - the tidwell rtree library had a copy-on-write model, which allowed scanning without blocking concurrent change.

I'd be very happy for an alternative implementation to be proposed if it either gained us substantially on performance (less likely), memory, or facilitated something new (like instance sharding, simplification of interface to the extent that it became straightforward to roll out to other object types)

I'd encourage this to be a separate PR unless this ultimately becomes blocked due to performance issues

Now under a much higher load:

What constitutes "higher"? It's hard to total this without writing a script (which I don't have time for right now), but going down this list it looks like approximately 50 cells were modified (out of how many?), resulting in perhaps 25,000 pokemon being updated although this would only issue a few hundred webhooks/database updates.
It's this kind of aggregated impact which is interesting to think about the overall cost. There are several seconds worth of scan time cumulatively - the longer durations (500+ms, I see even a 1s scan) may be the concurrency of these running together or just related to the volume of pokemon in particular cells - it is hard to draw any full conclusions here.

My original question was around the cpu impact and whether gmo processing or encounter time that would also run concurrently saw a change in performance.

INFO 2025-08-03 17:00:00 ProactiveIVSwitch - scan time 17.210957ms (locked time 112ns), 6594/365/365/2 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:00 ProactiveIVSwitch - scan time 38.071757ms (locked time 111ns), 4166/319/319/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:00 ProactiveIVSwitch - scan time 18.87786ms (locked time 191ns), 2300/1/1/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:00 ProactiveIVSwitch - scan time 49.393622ms (locked time 92ns), 4063/202/202/1 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:00 ProactiveIVSwitch - scan time 71.693761ms (locked time 125ns), 4494/243/243/4 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:00 ProactiveIVSwitch - scan time 32.321356ms (locked time 187ns), 2284/19/19/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:00 ProactiveIVSwitch - scan time 182.734195ms (locked time 112ns), 11487/482/481/1 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:00 ProactiveIVSwitch - scan time 136.196326ms (locked time 121ns), 4964/199/198/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:00 ProactiveIVSwitch - scan time 124.016513ms (locked time 122ns), 4954/474/474/1 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:00 ProactiveIVSwitch - scan time 237.904716ms (locked time 158ns), 7344/545/545/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:00 ProactiveIVSwitch - scan time 418.651748ms (locked time 91ns), 14311/1374/1372/4 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 207.150177ms (locked time 13.799µs), 5537/492/492/4 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 455.933144ms (locked time 104ns), 13298/703/703/3 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 308.421349ms (locked time 116ns), 8374/536/536/3 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 468.479141ms (locked time 41.4µs), 12975/1047/1047/3 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 303.068376ms (locked time 131ns), 9914/473/473/1 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 159.182678ms (locked time 93ns), 6070/199/199/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 215.845554ms (locked time 106ns), 7798/328/328/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 302.115078ms (locked time 119ns), 10243/675/674/2 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 335.058187ms (locked time 180ns), 9585/832/831/7 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 899.183868ms (locked time 122ns), 36665/1724/1724/2 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 210.310393ms (locked time 94ns), 6222/492/492/4 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 905.975876ms (locked time 114ns), 37934/1771/1770/3 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 130.86895ms (locked time 165ns), 5887/159/159/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 53.579304ms (locked time 98ns), 3880/97/97/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 380.125078ms (locked time 124ns), 9952/700/699/2 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 580.604885ms (locked time 108ns), 21999/971/971/4 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 829.835682ms (locked time 111ns), 27396/1173/1172/4 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 204.893623ms (locked time 153ns), 11196/364/363/1 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 286.411509ms (locked time 94ns), 8569/986/984/3 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 107.835254ms (locked time 107ns), 5320/343/343/2 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 367.619761ms (locked time 175ns), 19145/619/619/4 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 993.116524ms (locked time 124ns), 47210/2691/2690/15 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 1.112304178s (locked time 118ns), 51301/2630/2627/14 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 37.510057ms (locked time 102ns), 3702/67/67/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 91.185604ms (locked time 111ns), 11299/589/589/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 98.255081ms (locked time 120ns), 14776/543/542/1 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 31.810414ms (locked time 132ns), 9666/734/733/4 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:01 ProactiveIVSwitch - scan time 83.508732ms (locked time 267ns), 8212/311/311/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 89.316199ms (locked time 119ns), 5384/505/505/3 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 106.152409ms (locked time 95ns), 6901/405/405/2 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 53.790245ms (locked time 97ns), 4662/183/183/2 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 104.686547ms (locked time 90ns), 10934/291/290/3 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 44.43459ms (locked time 121ns), 6525/646/646/1 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 9.80482ms (locked time 132ns), 3649/18/18/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 31.654209ms (locked time 152ns), 8267/669/669/6 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 35.906503ms (locked time 89ns), 10822/782/782/3 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 22.051625ms (locked time 91ns), 6204/361/361/1 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 22.901705ms (locked time 155ns), 5326/156/156/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 12.749905ms (locked time 102ns), 5058/121/121/1 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 11.063106ms (locked time 77ns), 4119/366/366/1 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 11.241941ms (locked time 83ns), 5445/239/239/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 14.207524ms (locked time 131ns), 4314/309/309/1 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 21.086293ms (locked time 155ns), 6190/683/683/3 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 12.716616ms (locked time 141ns), 5710/296/296/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 16.880656ms (locked time 132ns), 6271/439/437/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 27.543644ms (locked time 119ns), 7277/634/634/2 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 12.538884ms (locked time 184ns), 5558/29/29/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:02 ProactiveIVSwitch - scan time 10.843724ms (locked time 151ns), 4017/199/199/1 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:03 ProactiveIVSwitch - scan time 9.745354ms (locked time 118ns), 3938/192/192/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:03 ProactiveIVSwitch - scan time 10.374635ms (locked time 36.069µs), 3673/89/89/1 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:03 ProactiveIVSwitch - scan time 30.50035ms (locked time 128ns), 8535/517/516/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:03 ProactiveIVSwitch - scan time 13.853502ms (locked time 99ns), 6082/69/69/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:03 ProactiveIVSwitch - scan time 23.057303ms (locked time 150ns), 8201/109/109/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:03 ProactiveIVSwitch - scan time 6.072614ms (locked time 157ns), 2352/25/25/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:03 ProactiveIVSwitch - scan time 15.591003ms (locked time 105ns), 5867/487/487/2 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:03 ProactiveIVSwitch - scan time 184.153µs (locked time 128ns), 84/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:03 ProactiveIVSwitch - scan time 72.361µs (locked time 73ns), 50/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:04 ProactiveIVSwitch - scan time 7.634223ms (locked time 97ns), 2564/312/312/2 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:04 ProactiveIVSwitch - scan time 4.448363ms (locked time 122ns), 2055/28/28/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:05 ProactiveIVSwitch - scan time 14.073336ms (locked time 118ns), 4113/274/274/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:05 ProactiveIVSwitch - scan time 11.6455ms (locked time 106ns), 3603/185/185/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:06 ProactiveIVSwitch - scan time 12.888378ms (locked time 126ns), 5434/29/29/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:06 ProactiveIVSwitch - scan time 10.777289ms (locked time 98ns), 5140/23/23/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:06 ProactiveIVSwitch - scan time 6.509662ms (locked time 103ns), 2857/57/57/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:07 ProactiveIVSwitch - scan time 14.948383ms (locked time 100ns), 6151/148/148/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:07 ProactiveIVSwitch - scan time 11.436718ms (locked time 99ns), 5063/12/12/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:09 ProactiveIVSwitch - scan time 8.536369ms (locked time 101ns), 4003/49/49/3 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:10 ProactiveIVSwitch - scan time 3.211823ms (locked time 124ns), 1546/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:11 ProactiveIVSwitch - scan time 10.233337ms (locked time 149ns), 3494/37/37/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:11 ProactiveIVSwitch - scan time 8.460503ms (locked time 116ns), 4651/2/2/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:15 ProactiveIVSwitch - scan time 4.298525ms (locked time 101ns), 2473/6/6/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:17 ProactiveIVSwitch - scan time 8.722355ms (locked time 98ns), 4314/1/1/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:18 ProactiveIVSwitch - scan time 6.753391ms (locked time 121ns), 3022/11/11/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:27 ProactiveIVSwitch - scan time 3.028656ms (locked time 123ns), 1225/7/7/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:28 ProactiveIVSwitch - scan time 701.719µs (locked time 679ns), 154/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:28 ProactiveIVSwitch - scan time 2.80267ms (locked time 176ns), 569/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:31 ProactiveIVSwitch - scan time 9.393629ms (locked time 114ns), 4859/3/3/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:40 ProactiveIVSwitch - scan time 228.826µs (locked time 88ns), 145/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 17:00:45 ProactiveIVSwitch - scan time 4.600797ms (locked time 107ns), 2306/0/0/0 scanned/locked/updated/cp updated

Thoughts?

@Mygod
Copy link
Contributor Author

Mygod commented Aug 4, 2025

vmware_uKmx5Yf798

Here's a CPU graph during start of an hour. The peaks are presumably GC. The hour start is I think around "40 secs" in the graph. It looks like there are plenty of headroom still. Related logs below. There was some timeout but that was probably because I was gaming on the same PC a few minutes earlier. :)

This is a pretty nightmare scenario.

INFO 2025-08-03 23:00:00 ProactiveIVSwitch - scan time 33.258µs (locked time 149ns), 13/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:00 ProactiveIVSwitch - scan time 114.32µs (locked time 107ns), 13/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:00 ProactiveIVSwitch - scan time 83.322µs (locked time 41.691µs), 13/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:00 ProactiveIVSwitch - scan time 28.315µs (locked time 256ns), 13/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:00 ProactiveIVSwitch - scan time 285.760808ms (locked time 165ns), 4568/520/520/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:00 ProactiveIVSwitch - scan time 227.072659ms (locked time 471ns), 4842/216/216/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:00 ProactiveIVSwitch - scan time 466.776827ms (locked time 974ns), 7502/390/390/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:00 ProactiveIVSwitch - scan time 100.777486ms (locked time 107ns), 1213/69/69/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:00 ProactiveIVSwitch - scan time 358.803678ms (locked time 78ns), 5294/195/195/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:01 ProactiveIVSwitch - scan time 152.777607ms (locked time 493ns), 2214/204/204/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:01 ProactiveIVSwitch - scan time 445.427518ms (locked time 121ns), 4820/526/526/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:01 ProactiveIVSwitch - scan time 109.436161ms (locked time 187ns), 2569/36/36/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:01 ProactiveIVSwitch - scan time 640.435078ms (locked time 175ns), 5496/627/624/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:01 ProactiveIVSwitch - scan time 620.555168ms (locked time 244ns), 4375/428/428/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:01 ProactiveIVSwitch - scan time 826.868659ms (locked time 309.322µs), 8394/943/943/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:01 ProactiveIVSwitch - scan time 354.657996ms (locked time 277ns), 3394/53/53/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:01 ProactiveIVSwitch - scan time 690.214308ms (locked time 204ns), 7500/6/6/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:01 ProactiveIVSwitch - scan time 965.878642ms (locked time 94ns), 10512/314/314/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:01 ProactiveIVSwitch - scan time 307.577067ms (locked time 131ns), 1803/154/154/3 scanned/locked/updated/cp updated
ERRO 2025-08-03 23:00:01 Raw: Error (1) during HTTP receive read tcp 192.168.1.105:9001->162.55.14.71:44657: read: connection timed out
INFO 2025-08-03 23:00:01 ProactiveIVSwitch - scan time 1.388822762s (locked time 50.512µs), 6763/1156/1156/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:02 ProactiveIVSwitch - scan time 864.396162ms (locked time 98ns), 4684/36/36/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:02 ProactiveIVSwitch - scan time 885.06809ms (locked time 168ns), 4686/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:02 ProactiveIVSwitch - scan time 967.581196ms (locked time 95ns), 4686/36/36/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:02 ProactiveIVSwitch - scan time 431.938853ms (locked time 100ns), 1407/143/143/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:02 ProactiveIVSwitch - scan time 1.298088436s (locked time 102ns), 4521/304/304/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:02 ProactiveIVSwitch - scan time 559.240704ms (locked time 112ns), 1803/3/3/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:02 ProactiveIVSwitch - scan time 1.082364057s (locked time 165ns), 2382/421/421/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:02 ProactiveIVSwitch - scan time 600.530565ms (locked time 118ns), 1529/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:02 ProactiveIVSwitch - scan time 1.123702011s (locked time 19.548µs), 4522/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:02 ProactiveIVSwitch - scan time 1.519450482s (locked time 91ns), 5080/340/339/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:02 ProactiveIVSwitch - scan time 639.214187ms (locked time 87ns), 1803/2/2/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:02 ProactiveIVSwitch - scan time 1.385959538s (locked time 148ns), 3274/233/233/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:03 ProactiveIVSwitch - scan time 454.75626ms (locked time 248ns), 1803/3/3/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:03 ProactiveIVSwitch - scan time 1.822805707s (locked time 197ns), 5114/194/194/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:03 ProactiveIVSwitch - scan time 2.217303206s (locked time 120ns), 10980/165/163/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:03 ProactiveIVSwitch - scan time 2.059381367s (locked time 114ns), 4648/526/526/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:03 ProactiveIVSwitch - scan time 1.343784738s (locked time 121ns), 4150/59/59/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:03 ProactiveIVSwitch - scan time 2.501587317s (locked time 138ns), 9810/821/821/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:03 ProactiveIVSwitch - scan time 2.779860304s (locked time 172ns), 8853/682/682/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:03 ProactiveIVSwitch - scan time 2.951245725s (locked time 116ns), 10980/457/455/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:03 ProactiveIVSwitch - scan time 1.525451078s (locked time 54ns), 3265/171/170/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:03 ProactiveIVSwitch - scan time 2.288032469s (locked time 329ns), 4225/12/12/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:04 ProactiveIVSwitch - scan time 1.659640229s (locked time 183ns), 1459/96/93/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:04 ProactiveIVSwitch - scan time 1.703842063s (locked time 117ns), 1459/129/125/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:04 ProactiveIVSwitch - scan time 1.901443496s (locked time 355ns), 3264/116/116/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:04 ProactiveIVSwitch - scan time 1.215810432s (locked time 110ns), 3086/8/8/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:04 ProactiveIVSwitch - scan time 2.904899198s (locked time 92ns), 10045/354/351/14 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:04 ProactiveIVSwitch - scan time 1.280190166s (locked time 265ns), 2024/97/97/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:04 ProactiveIVSwitch - scan time 2.397507955s (locked time 130ns), 7072/304/304/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:04 ProactiveIVSwitch - scan time 2.194922088s (locked time 362ns), 3470/27/25/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:04 ProactiveIVSwitch - scan time 3.024786989s (locked time 132ns), 3469/406/401/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:04 ProactiveIVSwitch - scan time 3.059916363s (locked time 101ns), 6147/185/185/13 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:04 ProactiveIVSwitch - scan time 1.527332759s (locked time 122ns), 3473/3/3/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:04 ProactiveIVSwitch - scan time 3.035862211s (locked time 14.604µs), 4762/324/324/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:04 ProactiveIVSwitch - scan time 3.237569977s (locked time 188ns), 4907/236/236/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:04 ProactiveIVSwitch - scan time 2.352218803s (locked time 151ns), 3528/157/157/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:04 ProactiveIVSwitch - scan time 631.360785ms (locked time 161ns), 1372/31/31/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:05 ProactiveIVSwitch - scan time 1.540974264s (locked time 196ns), 2720/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:05 ProactiveIVSwitch - scan time 3.484919486s (locked time 102ns), 7500/9/9/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:05 ProactiveIVSwitch - scan time 2.951533831s (locked time 81ns), 5999/121/121/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:05 ProactiveIVSwitch - scan time 2.47725674s (locked time 141ns), 6322/7/7/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:05 ProactiveIVSwitch - scan time 961.584345ms (locked time 128ns), 2123/16/16/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:05 ProactiveIVSwitch - scan time 3.254369986s (locked time 145ns), 5049/147/147/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:05 ProactiveIVSwitch - scan time 4.137451572s (locked time 176ns), 8592/292/292/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:05 ProactiveIVSwitch - scan time 1.051524515s (locked time 147ns), 4516/5/5/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:05 ProactiveIVSwitch - scan time 2.273619254s (locked time 145ns), 2032/91/91/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:05 ProactiveIVSwitch - scan time 3.803830069s (locked time 128ns), 10982/11/11/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:05 ProactiveIVSwitch - scan time 2.071473504s (locked time 116ns), 2123/64/64/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:05 ProactiveIVSwitch - scan time 2.315070025s (locked time 119ns), 3736/155/155/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:05 ProactiveIVSwitch - scan time 3.11291988s (locked time 346ns), 5209/157/153/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:05 ProactiveIVSwitch - scan time 4.221210614s (locked time 107ns), 5208/143/138/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:06 ProactiveIVSwitch - scan time 2.777164783s (locked time 171ns), 3059/169/169/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:06 ProactiveIVSwitch - scan time 3.651879128s (locked time 117ns), 8040/162/161/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:06 ProactiveIVSwitch - scan time 1.598178975s (locked time 133ns), 3729/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:06 ProactiveIVSwitch - scan time 5.559889483s (locked time 145ns), 11249/1811/1811/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:06 ProactiveIVSwitch - scan time 1.104429782s (locked time 90ns), 1942/52/52/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:06 ProactiveIVSwitch - scan time 903.476565ms (locked time 374ns), 1410/5/5/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:06 ProactiveIVSwitch - scan time 5.268915288s (locked time 93ns), 10050/179/178/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:06 ProactiveIVSwitch - scan time 4.657346336s (locked time 21.687µs), 4292/327/327/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:06 ProactiveIVSwitch - scan time 911.641306ms (locked time 152ns), 1899/15/15/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:06 ProactiveIVSwitch - scan time 2.710076117s (locked time 197ns), 4432/9/6/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:06 ProactiveIVSwitch - scan time 746.891681ms (locked time 155ns), 1527/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:06 ProactiveIVSwitch - scan time 1.696982747s (locked time 136ns), 2369/71/71/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:06 ProactiveIVSwitch - scan time 398.912241ms (locked time 180ns), 1442/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:06 ProactiveIVSwitch - scan time 2.221878028s (locked time 142ns), 4788/2/2/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:06 ProactiveIVSwitch - scan time 5.837033744s (locked time 155ns), 9732/723/723/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:06 ProactiveIVSwitch - scan time 1.347722845s (locked time 82ns), 2018/2/2/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:06 ProactiveIVSwitch - scan time 1.496007137s (locked time 133ns), 3267/11/11/9 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:06 ProactiveIVSwitch - scan time 4.717633347s (locked time 148ns), 4431/343/340/12 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:06 ProactiveIVSwitch - scan time 2.526995969s (locked time 143ns), 2501/124/124/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:07 ProactiveIVSwitch - scan time 2.286392756s (locked time 89ns), 4433/11/10/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:07 ProactiveIVSwitch - scan time 4.092756036s (locked time 107ns), 4798/141/130/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:07 ProactiveIVSwitch - scan time 5.152640767s (locked time 147ns), 6813/168/167/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:07 ProactiveIVSwitch - scan time 4.767841537s (locked time 6.965µs), 5120/205/205/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:07 ProactiveIVSwitch - scan time 2.969064853s (locked time 158ns), 2297/182/181/13 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:07 ProactiveIVSwitch - scan time 4.587449249s (locked time 98ns), 4797/123/113/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:07 ProactiveIVSwitch - scan time 5.297197623s (locked time 108ns), 7682/262/262/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:07 ProactiveIVSwitch - scan time 3.652502045s (locked time 82ns), 5133/106/106/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:07 ProactiveIVSwitch - scan time 3.594504994s (locked time 166ns), 3520/154/154/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:07 ProactiveIVSwitch - scan time 421.141474ms (locked time 131ns), 929/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:07 ProactiveIVSwitch - scan time 6.38572876s (locked time 103ns), 8232/795/794/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:07 ProactiveIVSwitch - scan time 1.068553131s (locked time 136ns), 1551/54/54/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:07 ProactiveIVSwitch - scan time 2.304015239s (locked time 125ns), 1105/108/108/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:07 ProactiveIVSwitch - scan time 880.274844ms (locked time 142ns), 2401/5/5/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:07 ProactiveIVSwitch - scan time 5.543992516s (locked time 97ns), 10029/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:07 ProactiveIVSwitch - scan time 2.435719362s (locked time 129ns), 5423/1/1/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:07 ProactiveIVSwitch - scan time 3.516223145s (locked time 194ns), 3126/134/128/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:07 ProactiveIVSwitch - scan time 5.614602597s (locked time 241ns), 7157/73/73/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:07 ProactiveIVSwitch - scan time 4.715757943s (locked time 191ns), 5617/243/241/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:07 ProactiveIVSwitch - scan time 2.800403639s (locked time 118ns), 2431/104/104/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:07 ProactiveIVSwitch - scan time 2.181236478s (locked time 167ns), 2085/36/36/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:07 ProactiveIVSwitch - scan time 3.545522543s (locked time 165ns), 7498/20/20/17 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:07 ProactiveIVSwitch - scan time 1.602264118s (locked time 89ns), 2264/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:08 ProactiveIVSwitch - scan time 5.804743303s (locked time 83ns), 6267/441/441/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:08 ProactiveIVSwitch - scan time 5.49258241s (locked time 187ns), 4265/317/317/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:08 ProactiveIVSwitch - scan time 5.671110228s (locked time 130ns), 5898/262/255/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:08 ProactiveIVSwitch - scan time 1.768603875s (locked time 236ns), 1410/5/5/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:08 ProactiveIVSwitch - scan time 3.963769596s (locked time 109ns), 4625/68/68/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:08 ProactiveIVSwitch - scan time 5.74722289s (locked time 203ns), 10988/4/4/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:08 ProactiveIVSwitch - scan time 4.762802897s (locked time 473ns), 7048/109/105/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:08 ProactiveIVSwitch - scan time 3.586665754s (locked time 188ns), 3129/104/96/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:08 ProactiveIVSwitch - scan time 6.458670122s (locked time 125ns), 11341/96/95/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:08 ProactiveIVSwitch - scan time 2.519345596s (locked time 113ns), 1173/111/111/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:08 ProactiveIVSwitch - scan time 4.736271836s (locked time 181ns), 4477/152/152/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:08 ProactiveIVSwitch - scan time 1.959198512s (locked time 194ns), 2036/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:08 ProactiveIVSwitch - scan time 5.547013171s (locked time 100ns), 8044/39/33/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:08 ProactiveIVSwitch - scan time 5.739737531s (locked time 158ns), 10514/10/10/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:08 ProactiveIVSwitch - scan time 1.051682948s (locked time 99ns), 2546/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:08 ProactiveIVSwitch - scan time 170.121933ms (locked time 106ns), 549/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:08 ProactiveIVSwitch - scan time 6.516837163s (locked time 183ns), 11459/173/157/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:08 ProactiveIVSwitch - scan time 3.429749565s (locked time 273ns), 5893/14/14/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:08 ProactiveIVSwitch - scan time 2.30017096s (locked time 204ns), 2018/5/5/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:08 ProactiveIVSwitch - scan time 6.286435125s (locked time 256ns), 5670/459/459/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:08 ProactiveIVSwitch - scan time 5.236358226s (locked time 176ns), 9769/101/101/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:08 ProactiveIVSwitch - scan time 7.806677628s (locked time 116ns), 8873/859/859/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:08 ProactiveIVSwitch - scan time 6.349149733s (locked time 30.902µs), 11460/71/58/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:08 ProactiveIVSwitch - scan time 7.782203975s (locked time 160ns), 9765/840/839/12 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:08 ProactiveIVSwitch - scan time 6.650499192s (locked time 335ns), 10987/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:08 ProactiveIVSwitch - scan time 1.463053269s (locked time 179ns), 1802/2/2/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:08 ProactiveIVSwitch - scan time 2.585072309s (locked time 118ns), 2314/67/67/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:09 ProactiveIVSwitch - scan time 7.063214566s (locked time 111ns), 5898/249/241/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:09 ProactiveIVSwitch - scan time 6.867982405s (locked time 110ns), 9772/90/83/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:09 ProactiveIVSwitch - scan time 3.827621056s (locked time 151ns), 4048/93/93/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:09 ProactiveIVSwitch - scan time 463.617679ms (locked time 127ns), 771/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:09 ProactiveIVSwitch - scan time 1.303333123s (locked time 222ns), 1457/6/6/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:09 ProactiveIVSwitch - scan time 5.468066659s (locked time 110ns), 4118/237/225/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:09 ProactiveIVSwitch - scan time 7.509472727s (locked time 5.743µs), 11341/266/264/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:09 ProactiveIVSwitch - scan time 3.228863017s (locked time 61.379µs), 1908/68/68/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:09 ProactiveIVSwitch - scan time 7.0383915s (locked time 190ns), 7055/364/355/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:09 ProactiveIVSwitch - scan time 8.00457983s (locked time 114ns), 12093/432/432/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:09 ProactiveIVSwitch - scan time 4.173007369s (locked time 76ns), 4791/3/3/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:09 ProactiveIVSwitch - scan time 1.630718475s (locked time 220ns), 2428/10/10/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:09 ProactiveIVSwitch - scan time 700.990718ms (locked time 144ns), 1907/1/1/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:09 ProactiveIVSwitch - scan time 4.979965563s (locked time 112ns), 6550/239/238/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:09 ProactiveIVSwitch - scan time 2.221581236s (locked time 118ns), 2743/44/44/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:09 ProactiveIVSwitch - scan time 4.707274016s (locked time 112ns), 3824/227/227/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:09 ProactiveIVSwitch - scan time 3.003896919s (locked time 148ns), 2009/56/51/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:09 ProactiveIVSwitch - scan time 1.946324133s (locked time 148ns), 2250/3/3/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:09 ProactiveIVSwitch - scan time 5.602034423s (locked time 31.984µs), 9728/17/17/15 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:09 ProactiveIVSwitch - scan time 8.190308262s (locked time 184ns), 10077/493/493/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:09 ProactiveIVSwitch - scan time 5.325992705s (locked time 150ns), 2011/165/164/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:09 ProactiveIVSwitch - scan time 6.340581193s (locked time 159ns), 9769/10/10/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:10 ProactiveIVSwitch - scan time 4.019078774s (locked time 109ns), 5291/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:10 ProactiveIVSwitch - scan time 5.856667521s (locked time 193ns), 4348/217/217/9 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:10 ProactiveIVSwitch - scan time 1.2910112s (locked time 159ns), 2120/2/2/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:10 ProactiveIVSwitch - scan time 6.460084904s (locked time 145ns), 13339/2/2/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:11 ProactiveIVSwitch - scan time 4.420171314s (locked time 246ns), 4121/11/8/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:11 ProactiveIVSwitch - scan time 8.896793776s (locked time 114ns), 7904/282/282/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:11 ProactiveIVSwitch - scan time 2.875099561s (locked time 186ns), 2050/42/42/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:11 ProactiveIVSwitch - scan time 6.838815268s (locked time 102ns), 10049/6/6/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:11 ProactiveIVSwitch - scan time 9.294347602s (locked time 141ns), 11464/156/150/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:12 ProactiveIVSwitch - scan time 4.670757599s (locked time 222ns), 4444/12/11/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:12 ProactiveIVSwitch - scan time 7.280632216s (locked time 231ns), 4121/167/158/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:12 ProactiveIVSwitch - scan time 4.602176913s (locked time 171ns), 4298/22/22/17 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:12 ProactiveIVSwitch - scan time 5.351834201s (locked time 96ns), 2797/127/127/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:12 DB - InUse: 0 Idle 5 WaitDuration 404h42m52.764245019s
INFO 2025-08-03 23:00:12 ProactiveIVSwitch - scan time 3.936524244s (locked time 300ns), 1502/53/53/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:12 ProactiveIVSwitch - scan time 8.381093107s (locked time 83ns), 3055/168/168/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:12 ProactiveIVSwitch - scan time 3.299033809s (locked time 145ns), 2432/1/1/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:12 ProactiveIVSwitch - scan time 11.007902814s (locked time 165ns), 13072/96/89/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:12 ProactiveIVSwitch - scan time 2.937403463s (locked time 134ns), 2124/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:12 ProactiveIVSwitch - scan time 4.398455917s (locked time 116ns), 3268/16/16/9 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:12 ProactiveIVSwitch - scan time 5.011586083s (locked time 123ns), 3121/10/10/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:12 ProactiveIVSwitch - scan time 8.381477206s (locked time 123ns), 8033/4/3/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:12 ProactiveIVSwitch - scan time 5.259045093s (locked time 87ns), 4789/1/1/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:12 ProactiveIVSwitch - scan time 9.697037542s (locked time 116ns), 7566/325/325/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:12 ProactiveIVSwitch - scan time 5.147235937s (locked time 150ns), 3265/8/4/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:13 ProactiveIVSwitch - scan time 10.151049219s (locked time 213ns), 11338/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:13 ProactiveIVSwitch - scan time 9.54424006s (locked time 230ns), 10987/10/10/9 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:13 ProactiveIVSwitch - scan time 6.379230404s (locked time 175ns), 4793/1/1/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:13 ProactiveIVSwitch - scan time 3.61145185s (locked time 208ns), 2008/11/11/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:13 ProactiveIVSwitch - scan time 11.105448838s (locked time 114ns), 11461/109/100/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:13 ProactiveIVSwitch - scan time 11.49408196s (locked time 189ns), 18029/2/2/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:13 ProactiveIVSwitch - scan time 12.041579394s (locked time 159ns), 13086/583/568/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:13 ProactiveIVSwitch - scan time 12.221186307s (locked time 94ns), 9057/386/386/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:13 ProactiveIVSwitch - scan time 12.888945936s (locked time 183ns), 28125/1280/1280/13 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:13 ProactiveIVSwitch - scan time 12.065883112s (locked time 11.64µs), 18026/180/176/14 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:13 ProactiveIVSwitch - scan time 7.392610296s (locked time 137ns), 5896/8/8/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:13 ProactiveIVSwitch - scan time 11.983217549s (locked time 136ns), 11604/443/435/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:14 ProactiveIVSwitch - scan time 5.537989023s (locked time 247ns), 3900/19/19/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:14 ProactiveIVSwitch - scan time 12.069327804s (locked time 111ns), 13072/79/73/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:14 ProactiveIVSwitch - scan time 10.705202569s (locked time 164ns), 11521/73/68/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:14 ProactiveIVSwitch - scan time 11.722490574s (locked time 101ns), 13072/139/134/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:14 ProactiveIVSwitch - scan time 9.989700246s (locked time 115ns), 5846/137/137/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:14 ProactiveIVSwitch - scan time 12.217329796s (locked time 229ns), 8888/197/190/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:14 ProactiveIVSwitch - scan time 8.191364577s (locked time 152ns), 10503/7/7/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:14 ProactiveIVSwitch - scan time 12.399645911s (locked time 140ns), 8887/161/148/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:14 ProactiveIVSwitch - scan time 9.999358647s (locked time 225ns), 4102/202/202/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:15 ProactiveIVSwitch - scan time 5.089120442s (locked time 227ns), 2125/2/2/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:15 ProactiveIVSwitch - scan time 12.720021118s (locked time 103ns), 10513/5/5/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:15 ProactiveIVSwitch - scan time 12.560145654s (locked time 108ns), 13342/195/191/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:15 ProactiveIVSwitch - scan time 6.093645818s (locked time 124ns), 4535/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:15 ProactiveIVSwitch - scan time 13.163341182s (locked time 124ns), 13342/274/272/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:15 ProactiveIVSwitch - scan time 6.172670488s (locked time 248ns), 2378/10/10/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:15 ProactiveIVSwitch - scan time 10.738050359s (locked time 366ns), 2968/271/271/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:15 ProactiveIVSwitch - scan time 13.201794225s (locked time 243ns), 5638/362/362/9 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:16 ProactiveIVSwitch - scan time 13.401103462s (locked time 205ns), 18032/8/7/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:16 ProactiveIVSwitch - scan time 14.033159522s (locked time 228ns), 8886/124/114/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:16 ProactiveIVSwitch - scan time 14.755242125s (locked time 126ns), 10841/630/630/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:16 ProactiveIVSwitch - scan time 9.754069509s (locked time 154ns), 7041/12/12/9 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:16 ProactiveIVSwitch - scan time 6.941197762s (locked time 201ns), 1907/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:16 ProactiveIVSwitch - scan time 5.200654995s (locked time 220ns), 3266/13/13/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:16 ProactiveIVSwitch - scan time 4.633216863s (locked time 297ns), 2012/6/6/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:16 ProactiveIVSwitch - scan time 10.377061988s (locked time 202ns), 2199/215/215/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:16 ProactiveIVSwitch - scan time 10.084940894s (locked time 173ns), 8370/74/74/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:16 ProactiveIVSwitch - scan time 7.793670663s (locked time 148ns), 3471/3/3/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:16 ProactiveIVSwitch - scan time 9.422210275s (locked time 185ns), 1584/116/116/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:16 ProactiveIVSwitch - scan time 8.300640906s (locked time 697ns), 5426/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:17 ProactiveIVSwitch - scan time 15.983242292s (locked time 95ns), 14144/344/324/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:17 ProactiveIVSwitch - scan time 15.905092216s (locked time 128ns), 16530/354/354/12 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:17 ProactiveIVSwitch - scan time 15.153292216s (locked time 137ns), 10096/619/618/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:17 ProactiveIVSwitch - scan time 15.016675702s (locked time 140ns), 14140/104/82/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:17 ProactiveIVSwitch - scan time 16.193817222s (locked time 112ns), 14143/311/294/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:17 ProactiveIVSwitch - scan time 10.68208777s (locked time 111ns), 9732/13/13/11 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:17 ProactiveIVSwitch - scan time 10.340729592s (locked time 176ns), 6261/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:17 ProactiveIVSwitch - scan time 9.489289963s (locked time 102ns), 5198/16/16/14 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:17 ProactiveIVSwitch - scan time 11.024166897s (locked time 115ns), 11992/14/14/11 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:17 ProactiveIVSwitch - scan time 4.683277173s (locked time 14.378µs), 2081/4/4/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:17 ProactiveIVSwitch - scan time 7.558085713s (locked time 143ns), 4350/4/4/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:17 ProactiveIVSwitch - scan time 8.768007705s (locked time 110ns), 5897/3/3/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:17 ProactiveIVSwitch - scan time 14.894509976s (locked time 87ns), 14145/172/162/9 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:17 ProactiveIVSwitch - scan time 8.201369292s (locked time 163ns), 5200/4/4/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:17 ProactiveIVSwitch - scan time 11.694679412s (locked time 175ns), 12714/21/17/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:17 ProactiveIVSwitch - scan time 14.609320211s (locked time 233ns), 14146/15/7/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:17 ProactiveIVSwitch - scan time 13.113002797s (locked time 158ns), 14140/14/14/10 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:17 ProactiveIVSwitch - scan time 13.287851639s (locked time 95ns), 9727/9/9/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:17 ProactiveIVSwitch - scan time 15.897345858s (locked time 156ns), 9920/425/421/10 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:17 ProactiveIVSwitch - scan time 10.310081224s (locked time 189ns), 2533/119/119/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:17 ProactiveIVSwitch - scan time 9.362284333s (locked time 180ns), 3467/14/14/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:18 ProactiveIVSwitch - scan time 14.885320065s (locked time 151ns), 14146/105/97/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:18 ProactiveIVSwitch - scan time 5.415093394s (locked time 227ns), 5192/6/6/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:18 ProactiveIVSwitch - scan time 14.026934117s (locked time 149ns), 9906/105/98/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:18 ProactiveIVSwitch - scan time 6.518957719s (locked time 290ns), 6159/13/13/11 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:18 ProactiveIVSwitch - scan time 10.764536742s (locked time 155ns), 4678/2/2/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:18 ProactiveIVSwitch - scan time 7.101182877s (locked time 99.378µs), 4105/11/11/9 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:18 ProactiveIVSwitch - scan time 12.031459635s (locked time 10.9µs), 10504/5/5/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:18 ProactiveIVSwitch - scan time 17.59199271s (locked time 116ns), 15432/206/188/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:18 ProactiveIVSwitch - scan time 12.737761749s (locked time 225ns), 8209/24/22/12 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:18 ProactiveIVSwitch - scan time 13.613690962s (locked time 164ns), 13341/7/7/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:18 ProactiveIVSwitch - scan time 12.031885419s (locked time 107ns), 16414/5/5/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:18 ProactiveIVSwitch - scan time 8.071535985s (locked time 335ns), 6153/8/6/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:18 ProactiveIVSwitch - scan time 16.365433463s (locked time 106ns), 11576/107/96/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:18 ProactiveIVSwitch - scan time 1.834881281s (locked time 97ns), 2123/1/1/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 16.660949454s (locked time 112ns), 12823/145/132/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 1.21532656s (locked time 210ns), 1796/1/1/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 10.812222233s (locked time 200ns), 9764/45/45/35 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 13.695088473s (locked time 108ns), 13066/16/15/13 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 16.02308832s (locked time 120ns), 8246/483/478/9 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 7.028435161s (locked time 144ns), 4296/7/7/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 17.602955113s (locked time 150ns), 15414/346/333/9 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 7.985040944s (locked time 172ns), 2379/3/3/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 9.742010751s (locked time 237ns), 3350/118/118/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 10.231460609s (locked time 129ns), 4787/12/12/11 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 1.843995879s (locked time 160ns), 806/8/8/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 13.043351952s (locked time 110ns), 11473/5/4/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 12.760400216s (locked time 231ns), 9980/37/37/20 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 4.156443479s (locked time 169ns), 5429/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 7.487944191s (locked time 120ns), 3127/14/14/10 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 13.527599628s (locked time 175ns), 2901/307/307/16 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 17.095992285s (locked time 103ns), 15409/149/132/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 15.168085081s (locked time 122ns), 16440/2/2/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 1.926870072s (locked time 150ns), 2526/4/4/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 15.007505999s (locked time 144ns), 8201/96/88/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 15.82195391s (locked time 92ns), 4203/407/407/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 14.62841211s (locked time 87ns), 13067/28/28/20 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 2.945582567s (locked time 485ns), 1819/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 5.687814853s (locked time 379ns), 2553/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 17.906978766s (locked time 106ns), 9621/662/655/15 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 15.360276621s (locked time 174ns), 7674/261/248/14 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 13.800017954s (locked time 141ns), 4995/192/192/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 18.341054137s (locked time 141ns), 12832/365/353/17 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 10.650180862s (locked time 151ns), 8222/5/5/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 11.067950625s (locked time 147ns), 4347/13/13/11 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 12.64759872s (locked time 142ns), 7673/15/12/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 4.790530944s (locked time 165ns), 4996/3/3/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 8.99997588s (locked time 264ns), 4684/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 16.195047149s (locked time 100ns), 12805/172/158/10 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 10.786486033s (locked time 87ns), 4444/19/18/14 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 11.958959936s (locked time 101ns), 7671/29/22/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 6.567274085s (locked time 122ns), 4446/10/9/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 17.506907762s (locked time 1µs), 7682/481/463/9 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:19 ProactiveIVSwitch - scan time 17.625472872s (locked time 171ns), 12721/118/111/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 13.845100742s (locked time 184ns), 9553/114/104/19 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 13.39797671s (locked time 128ns), 10980/5/5/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 15.623308521s (locked time 150ns), 16426/1/1/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 7.241411307s (locked time 91ns), 6525/38/38/13 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 19.102094178s (locked time 159ns), 18021/852/846/9 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 14.88761122s (locked time 137ns), 5014/308/308/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 9.526133178s (locked time 210ns), 5006/5/5/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 18.116035366s (locked time 199ns), 12724/510/499/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 13.96514896s (locked time 194ns), 10982/14/14/13 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 1.110168767s (locked time 205ns), 4048/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 14.502622891s (locked time 208ns), 9234/82/72/11 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 11.765516346s (locked time 112ns), 7672/18/17/14 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 1.758563631s (locked time 157ns), 3120/4/4/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 7.764039935s (locked time 196ns), 4600/35/35/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 15.607931456s (locked time 152ns), 11475/23/21/20 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 13.217580294s (locked time 106ns), 9979/4/4/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 11.999884201s (locked time 183ns), 9550/27/27/16 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 8.099740346s (locked time 249ns), 4349/1/1/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 17.592755587s (locked time 191ns), 9229/276/244/10 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 16.600745337s (locked time 229ns), 3318/373/373/10 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 11.572441381s (locked time 208ns), 4299/4/4/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 12.645126631s (locked time 267ns), 9223/49/42/16 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 4.370867338s (locked time 63.294µs), 4101/15/15/15 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 3.252845196s (locked time 234ns), 2898/17/17/15 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 15.818653843s (locked time 149ns), 9231/78/64/13 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 14.722762649s (locked time 104ns), 8209/3/3/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 4.296680108s (locked time 161ns), 3052/70/70/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 15.959583955s (locked time 172ns), 6516/244/243/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 9.84962111s (locked time 357ns), 7490/35/35/33 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 11.532829879s (locked time 117ns), 11979/14/14/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 5.030771845s (locked time 157ns), 2899/11/11/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 19.246664953s (locked time 122ns), 28067/14/14/12 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 14.912887573s (locked time 159ns), 11995/13/13/10 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 3.742551805s (locked time 153ns), 2522/3/3/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 8.792780695s (locked time 183ns), 6803/8/7/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 7.606329534s (locked time 478ns), 5893/21/21/15 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:20 ProactiveIVSwitch - scan time 1.160827669s (locked time 6.075µs), 2901/4/4/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:21 ProactiveIVSwitch - scan time 14.944500132s (locked time 89ns), 14133/29/29/25 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:21 ProactiveIVSwitch - scan time 16.862773301s (locked time 106ns), 3222/466/465/15 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:21 ProactiveIVSwitch - scan time 5.352497363s (locked time 1.895976ms), 4349/5/5/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:21 ProactiveIVSwitch - scan time 13.119349809s (locked time 273ns), 9764/6/6/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:21 ProactiveIVSwitch - scan time 12.884332647s (locked time 237ns), 9764/1/1/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:21 ProactiveIVSwitch - scan time 7.78943507s (locked time 357ns), 6257/53/53/40 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:21 ProactiveIVSwitch - scan time 17.743480852s (locked time 185ns), 16491/5/5/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:21 ProactiveIVSwitch - scan time 20.17647531s (locked time 120ns), 28074/8/7/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:21 ProactiveIVSwitch - scan time 10.060337933s (locked time 128ns), 9561/8/8/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:21 ProactiveIVSwitch - scan time 4.310011027s (locked time 104ns), 3271/11/11/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:21 ProactiveIVSwitch - scan time 11.976430872s (locked time 158ns), 6803/6/4/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:21 ProactiveIVSwitch - scan time 20.118155694s (locked time 108ns), 28072/17/17/13 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:21 ProactiveIVSwitch - scan time 13.767899058s (locked time 134ns), 10976/6/6/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:21 ProactiveIVSwitch - scan time 5.489233205s (locked time 187ns), 6521/3/3/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:21 ProactiveIVSwitch - scan time 2.372730072s (locked time 93ns), 2305/10/10/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:21 ProactiveIVSwitch - scan time 13.871338582s (locked time 138ns), 9976/6/6/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:21 ProactiveIVSwitch - scan time 14.821324426s (locked time 170ns), 9978/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:21 ProactiveIVSwitch - scan time 3.928978348s (locked time 168ns), 3887/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:21 ProactiveIVSwitch - scan time 16.178101293s (locked time 289ns), 10985/19/19/17 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:21 ProactiveIVSwitch - scan time 15.026572042s (locked time 82ns), 12712/35/33/28 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:21 ProactiveIVSwitch - scan time 20.002356639s (locked time 122ns), 13597/328/321/17 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:21 ProactiveIVSwitch - scan time 5.905365993s (locked time 58.244µs), 4443/12/11/9 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:21 ProactiveIVSwitch - scan time 17.122227261s (locked time 167ns), 15427/24/20/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:21 ProactiveIVSwitch - scan time 7.795805539s (locked time 153ns), 5892/5/5/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:21 ProactiveIVSwitch - scan time 7.45415941s (locked time 136ns), 2011/3/3/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:21 ProactiveIVSwitch - scan time 6.685954067s (locked time 195ns), 4676/1/1/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:22 ProactiveIVSwitch - scan time 10.746825874s (locked time 62.976µs), 9773/9/9/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:22 ProactiveIVSwitch - scan time 15.669258955s (locked time 178ns), 13348/11/11/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:22 ProactiveIVSwitch - scan time 18.327586146s (locked time 759ns), 14248/73/60/12 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:22 ProactiveIVSwitch - scan time 11.347297378s (locked time 4.943ms), 16414/10/10/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:22 ProactiveIVSwitch - scan time 2.030069343s (locked time 157ns), 2253/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:22 ProactiveIVSwitch - scan time 10.8424089s (locked time 45.579µs), 9773/15/15/10 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:22 ProactiveIVSwitch - scan time 11.702403411s (locked time 247ns), 7490/9/9/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:22 ProactiveIVSwitch - scan time 21.502104648s (locked time 135ns), 12816/1317/1317/15 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:22 ProactiveIVSwitch - scan time 4.740433886s (locked time 177ns), 5106/82/82/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:22 ProactiveIVSwitch - scan time 20.149018388s (locked time 197ns), 9225/357/338/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:22 ProactiveIVSwitch - scan time 13.134573123s (locked time 185ns), 12712/15/13/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:22 ProactiveIVSwitch - scan time 20.910493089s (locked time 130ns), 10580/574/574/20 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:22 ProactiveIVSwitch - scan time 3.631919725s (locked time 141ns), 4851/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:22 ProactiveIVSwitch - scan time 7.531451579s (locked time 997ns), 7487/5/5/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:22 ProactiveIVSwitch - scan time 9.558443894s (locked time 158ns), 6547/16/15/13 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:22 ProactiveIVSwitch - scan time 20.694032507s (locked time 365ns), 13596/646/625/21 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:22 ProactiveIVSwitch - scan time 8.758129726s (locked time 219.702µs), 6257/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:22 ProactiveIVSwitch - scan time 3.158762448s (locked time 133ns), 2123/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:22 ProactiveIVSwitch - scan time 22.060149707s (locked time 112ns), 19130/1607/1607/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:22 ProactiveIVSwitch - scan time 13.801040997s (locked time 123ns), 9553/6/6/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:22 ProactiveIVSwitch - scan time 2.904774113s (locked time 200ns), 2842/76/76/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:22 ProactiveIVSwitch - scan time 9.533843438s (locked time 133ns), 9231/30/30/25 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:22 ProactiveIVSwitch - scan time 3.278096796s (locked time 221ns), 4346/5/5/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:22 ProactiveIVSwitch - scan time 5.276137132s (locked time 164ns), 4047/6/6/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:22 ProactiveIVSwitch - scan time 12.131437183s (locked time 254ns), 11978/4/4/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:22 ProactiveIVSwitch - scan time 19.58536707s (locked time 115ns), 15425/7/7/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:23 ProactiveIVSwitch - scan time 14.024048489s (locked time 139ns), 9968/11/11/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:23 ProactiveIVSwitch - scan time 17.122758692s (locked time 105ns), 15427/26/26/23 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:23 ProactiveIVSwitch - scan time 21.476575886s (locked time 120ns), 28067/3/3/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:23 ProactiveIVSwitch - scan time 14.117909768s (locked time 137ns), 11977/15/15/10 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:23 ProactiveIVSwitch - scan time 9.108057377s (locked time 137ns), 7486/2/2/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:23 ProactiveIVSwitch - scan time 20.98546274s (locked time 104ns), 14256/280/262/9 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:23 ProactiveIVSwitch - scan time 20.380646735s (locked time 306ns), 14253/181/163/12 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:23 ProactiveIVSwitch - scan time 22.110405221s (locked time 169ns), 14789/845/828/49 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:23 ProactiveIVSwitch - scan time 3.715156378s (locked time 295ns), 4785/7/7/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:23 ProactiveIVSwitch - scan time 11.347895569s (locked time 185ns), 9725/16/15/13 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:23 ProactiveIVSwitch - scan time 15.301637136s (locked time 280ns), 11467/26/25/22 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:23 ProactiveIVSwitch - scan time 15.274596924s (locked time 114ns), 9547/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:23 ProactiveIVSwitch - scan time 18.447516171s (locked time 908ns), 8313/325/325/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:23 ProactiveIVSwitch - scan time 15.511752401s (locked time 128ns), 12806/37/36/28 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:23 ProactiveIVSwitch - scan time 5.590830892s (locked time 152ns), 4678/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:23 ProactiveIVSwitch - scan time 20.425446638s (locked time 120ns), 4662/934/934/14 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:23 ProactiveIVSwitch - scan time 12.190752746s (locked time 281ns), 8059/100/100/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:23 ProactiveIVSwitch - scan time 14.492556751s (locked time 250ns), 9728/29/28/26 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:23 ProactiveIVSwitch - scan time 1.885600652s (locked time 98ns), 3056/9/9/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:23 ProactiveIVSwitch - scan time 14.802376353s (locked time 181ns), 12711/4/2/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:23 ProactiveIVSwitch - scan time 18.686706437s (locked time 158ns), 18028/8/8/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:23 ProactiveIVSwitch - scan time 17.140309734s (locked time 147ns), 14802/51/51/43 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:23 ProactiveIVSwitch - scan time 15.541270172s (locked time 485ns), 15419/8/8/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:23 ProactiveIVSwitch - scan time 4.75313207s (locked time 143ns), 4781/6/6/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 13.304348846s (locked time 340.387µs), 9560/1/1/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 9.999756926s (locked time 437ns), 14247/27/24/18 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 14.695170856s (locked time 120ns), 13605/22/21/11 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 22.202984296s (locked time 148ns), 28061/9/9/9 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 7.0865765s (locked time 226ns), 4801/225/225/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 19.768285235s (locked time 126ns), 11078/236/217/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 2.069783136s (locked time 144ns), 2159/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 9.976592879s (locked time 68.946µs), 11064/2/2/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 18.573357438s (locked time 93ns), 18026/12/12/10 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 7.233362279s (locked time 231ns), 10042/4/4/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 3.883710534s (locked time 261ns), 4347/6/6/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 18.898300952s (locked time 133ns), 15425/11/11/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 12.685716526s (locked time 438ns), 9774/3/3/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 22.403657175s (locked time 92ns), 11088/363/336/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 3.498175964s (locked time 170ns), 3514/16/16/12 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 13.42274247s (locked time 273ns), 12718/14/12/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 14.402334936s (locked time 589ns), 9776/8/8/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 22.396481486s (locked time 126ns), 20379/168/152/15 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 16.888857078s (locked time 214ns), 13592/48/44/31 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 19.569070541s (locked time 497ns), 16426/6/6/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 11.758025005s (locked time 146ns), 12788/7/6/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 21.65962278s (locked time 184ns), 11080/327/306/9 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 22.922072066s (locked time 114ns), 14794/295/274/19 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 3.226430588s (locked time 126ns), 4789/1/1/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 12.913444939s (locked time 163ns), 10061/30/30/28 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 11.465199984s (locked time 489ns), 11064/81/80/21 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 5.36074565s (locked time 152ns), 4780/349/349/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 16.891223721s (locked time 301ns), 13595/13/13/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 9.751717357s (locked time 272ns), 12796/7/7/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:24 ProactiveIVSwitch - scan time 7.938798796s (locked time 268ns), 10043/8/8/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 9.736655499s (locked time 298ns), 13328/20/20/11 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 18.096398994s (locked time 105ns), 12712/8/6/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 6.853038717s (locked time 181ns), 7663/16/16/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 12.585087942s (locked time 11.963µs), 9971/19/19/13 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 6.648842144s (locked time 133ns), 9903/29/29/19 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 22.050636262s (locked time 509ns), 8675/702/702/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 16.620251581s (locked time 201ns), 12805/8/6/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 12.396865904s (locked time 128ns), 13327/3/3/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 17.429548393s (locked time 196ns), 9549/5/5/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 17.308211203s (locked time 254ns), 5822/733/733/14 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 16.289232646s (locked time 198ns), 10977/25/25/21 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 12.892859766s (locked time 139ns), 8866/24/24/18 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 13.467684936s (locked time 129ns), 14127/30/29/16 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 15.182783002s (locked time 149ns), 13613/7/7/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 8.326124849s (locked time 88ns), 7663/32/32/22 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 8.504310498s (locked time 162ns), 14787/45/45/33 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 8.691334708s (locked time 78ns), 10485/18/18/13 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 12.746607861s (locked time 126ns), 12718/18/16/15 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 22.735171456s (locked time 156ns), 8788/742/742/22 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 10.883879678s (locked time 201ns), 12794/3/3/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 8.023713927s (locked time 102ns), 11455/12/11/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 24.7947251s (locked time 232ns), 20395/608/584/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 2.727053586s (locked time 267ns), 9937/7/7/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 1.657351433s (locked time 134ns), 3265/20/20/15 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 6.324133386s (locked time 229ns), 8203/52/52/43 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 20.577445037s (locked time 135ns), 10429/248/248/17 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 8.159683279s (locked time 185ns), 11454/7/5/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 12.217554343s (locked time 258ns), 15406/2/2/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:25 ProactiveIVSwitch - scan time 6.234467535s (locked time 367ns), 9775/34/34/20 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 2.738534495s (locked time 129ns), 4347/4/4/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 17.691777358s (locked time 153ns), 13598/9/9/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 8.409395722s (locked time 138ns), 11729/44/30/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 17.525045946s (locked time 114ns), 11742/24/13/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 14.059874634s (locked time 314ns), 14252/13/10/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 21.127427107s (locked time 135ns), 11747/251/209/16 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 14.26297706s (locked time 163ns), 11741/12/4/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 8.272588587s (locked time 186ns), 11731/79/75/16 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 4.913325427s (locked time 119ns), 6247/10/10/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 8.058256132s (locked time 178ns), 11731/8/4/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 16.345461368s (locked time 872ns), 11747/162/146/17 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 22.581118939s (locked time 335ns), 18036/5/5/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 1.560989697s (locked time 158ns), 2900/5/5/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 19.350549796s (locked time 124ns), 11746/76/55/16 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 22.767022924s (locked time 106ns), 11745/223/180/12 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 19.366886663s (locked time 103ns), 16414/4/4/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 14.192012298s (locked time 217ns), 8867/35/34/30 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 5.72135452s (locked time 127ns), 9778/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 9.683289403s (locked time 35.363µs), 10041/3/3/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 17.963611211s (locked time 160ns), 13598/9/9/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 4.921169535s (locked time 126ns), 9950/5/5/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 12.451225402s (locked time 168ns), 13607/13/13/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 8.054739397s (locked time 64.02µs), 12719/11/9/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 23.154639472s (locked time 131ns), 11747/396/356/23 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 12.789593452s (locked time 203ns), 14248/8/5/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 3.000421261s (locked time 92ns), 3055/4/4/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 24.613016709s (locked time 152ns), 20377/258/228/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 13.734067001s (locked time 207ns), 11741/14/7/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 18.595048025s (locked time 213ns), 11739/3/1/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 5.548762683s (locked time 131ns), 9952/12/12/9 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 2.857129414s (locked time 117ns), 5001/8/8/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 24.984114627s (locked time 112ns), 28062/13/13/12 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 9.358206789s (locked time 175ns), 10484/11/11/9 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 17.349175332s (locked time 141ns), 16414/3/3/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:26 ProactiveIVSwitch - scan time 15.428334407s (locked time 325ns), 14127/14/14/12 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:27 ProactiveIVSwitch - scan time 2.466772803s (locked time 101ns), 3266/2/2/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:27 ProactiveIVSwitch - scan time 20.861195627s (locked time 225ns), 6194/699/699/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:27 ProactiveIVSwitch - scan time 14.453620084s (locked time 1.466µs), 13610/13/13/12 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:27 ProactiveIVSwitch - scan time 6.442364936s (locked time 255ns), 9556/34/34/26 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:27 ProactiveIVSwitch - scan time 18.263µs (locked time 92ns), 8/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:27 ProactiveIVSwitch - scan time 12.568457637s (locked time 277ns), 14120/5/5/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:27 ProactiveIVSwitch - scan time 13.500226218s (locked time 134ns), 14786/20/20/17 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:27 ProactiveIVSwitch - scan time 3.946866433s (locked time 139ns), 6166/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:27 ProactiveIVSwitch - scan time 8.579838472s (locked time 105ns), 10046/7/7/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:27 ProactiveIVSwitch - scan time 18.653088427s (locked time 129ns), 18028/31/31/20 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:27 ProactiveIVSwitch - scan time 24.79789878s (locked time 175ns), 20371/56/39/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:28 ProactiveIVSwitch - scan time 8.733790723s (locked time 312ns), 13335/5/5/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:28 ProactiveIVSwitch - scan time 21.069393735s (locked time 166ns), 7730/667/667/29 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:28 ProactiveIVSwitch - scan time 17.48827449s (locked time 265ns), 12801/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:28 ProactiveIVSwitch - scan time 1.977287325s (locked time 220ns), 5438/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:28 ProactiveIVSwitch - scan time 9.243061775s (locked time 441ns), 10880/84/71/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:28 ProactiveIVSwitch - scan time 4.170744439s (locked time 87ns), 4437/15/14/10 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:28 ProactiveIVSwitch - scan time 5.505073167s (locked time 83ns), 6165/9/9/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:28 ProactiveIVSwitch - scan time 7.150261741s (locked time 272ns), 10043/4/4/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:28 ProactiveIVSwitch - scan time 2.977709083s (locked time 174ns), 3120/10/10/9 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:28 ProactiveIVSwitch - scan time 1.856500056s (locked time 140ns), 2114/3/3/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:28 ProactiveIVSwitch - scan time 10.651915812s (locked time 143ns), 9902/7/7/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:28 ProactiveIVSwitch - scan time 11.932078834s (locked time 376ns), 16405/2/2/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:28 ProactiveIVSwitch - scan time 14.650810462s (locked time 135ns), 15408/7/7/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:28 ProactiveIVSwitch - scan time 14.493340994s (locked time 122ns), 16411/2/2/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:28 ProactiveIVSwitch - scan time 10.077681215s (locked time 151ns), 14795/9/9/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:29 ProactiveIVSwitch - scan time 9.617340514s (locked time 142ns), 11497/1/1/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:29 ProactiveIVSwitch - scan time 8.545434989s (locked time 185ns), 7472/18/18/16 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:29 ProactiveIVSwitch - scan time 10.764950281s (locked time 125ns), 14248/4/1/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:29 ProactiveIVSwitch - scan time 27.209810274s (locked time 41.086µs), 27345/374/336/34 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:29 ProactiveIVSwitch - scan time 4.062312423s (locked time 166ns), 2300/4/4/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:29 ProactiveIVSwitch - scan time 16.679458715s (locked time 16.476µs), 18021/8/6/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:29 ProactiveIVSwitch - scan time 20.689752033s (locked time 201ns), 13602/14/13/11 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:29 ProactiveIVSwitch - scan time 5.215938221s (locked time 250ns), 10030/2/2/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:29 ProactiveIVSwitch - scan time 11.393813785s (locked time 134ns), 14124/10/10/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:29 ProactiveIVSwitch - scan time 24.406333811s (locked time 194ns), 10885/274/229/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:29 ProactiveIVSwitch - scan time 10.646268242s (locked time 122ns), 11495/30/30/19 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:29 ProactiveIVSwitch - scan time 10.88882911s (locked time 145ns), 13619/8/8/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:29 ProactiveIVSwitch - scan time 12.328705717s (locked time 196ns), 13058/32/30/22 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:30 ProactiveIVSwitch - scan time 16.654886677s (locked time 256ns), 14792/5/5/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:30 ProactiveIVSwitch - scan time 12.532235115s (locked time 145ns), 18033/5/5/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:30 ProactiveIVSwitch - scan time 25.962723652s (locked time 153ns), 27347/149/132/14 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:30 ProactiveIVSwitch - scan time 24.425874542s (locked time 83ns), 10885/311/259/12 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:30 ProactiveIVSwitch - scan time 19.077339392s (locked time 211ns), 18023/16/16/11 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:30 ProactiveIVSwitch - scan time 24.655493641s (locked time 142ns), 10883/225/161/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:30 ProactiveIVSwitch - scan time 11.259524408s (locked time 89ns), 13058/36/35/23 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:30 ProactiveIVSwitch - scan time 4.897121989s (locked time 127ns), 4452/11/10/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:30 ProactiveIVSwitch - scan time 6.041078265s (locked time 246ns), 6548/9/8/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:30 ProactiveIVSwitch - scan time 21.395567939s (locked time 136ns), 15424/7/7/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:30 ProactiveIVSwitch - scan time 6.863212842s (locked time 345ns), 5002/1/1/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:30 ProactiveIVSwitch - scan time 12.954707286s (locked time 174ns), 13333/5/5/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:30 ProactiveIVSwitch - scan time 11.015223714s (locked time 254ns), 13062/1/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:30 ProactiveIVSwitch - scan time 15.301970247s (locked time 191ns), 15411/9/9/9 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:30 ProactiveIVSwitch - scan time 9.102989652s (locked time 271ns), 9896/4/4/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:30 ProactiveIVSwitch - scan time 9.971360528s (locked time 140ns), 9224/48/48/33 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:30 ProactiveIVSwitch - scan time 12.906686542s (locked time 88ns), 13055/22/18/12 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:30 ProactiveIVSwitch - scan time 11.731117662s (locked time 153ns), 9902/3/3/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:30 ProactiveIVSwitch - scan time 7.9266063s (locked time 439ns), 9939/5/5/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:30 ProactiveIVSwitch - scan time 13.211744098s (locked time 225ns), 18032/13/13/10 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:30 ProactiveIVSwitch - scan time 15.471236825s (locked time 183ns), 16410/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:30 ProactiveIVSwitch - scan time 26.668376213s (locked time 152ns), 10884/363/289/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:30 ProactiveIVSwitch - scan time 7.835663717s (locked time 186ns), 12771/19/19/16 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:30 ProactiveIVSwitch - scan time 18.434700629s (locked time 153ns), 18022/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:30 ProactiveIVSwitch - scan time 24.152125003s (locked time 161ns), 13525/375/367/10 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:30 ProactiveIVSwitch - scan time 14.970008273s (locked time 351ns), 20340/1/1/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:30 ProactiveIVSwitch - scan time 14.123448847s (locked time 172ns), 14244/8/5/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:31 ProactiveIVSwitch - scan time 3.303463755s (locked time 176ns), 4317/28/28/19 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:31 ProactiveIVSwitch - scan time 12.721861649s (locked time 128ns), 13619/19/19/10 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:31 ProactiveIVSwitch - scan time 678.200366ms (locked time 173ns), 3096/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:31 ProactiveIVSwitch - scan time 21.042211602s (locked time 212ns), 16413/1/1/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:31 ProactiveIVSwitch - scan time 13.464790642s (locked time 105ns), 10879/57/38/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:31 ProactiveIVSwitch - scan time 4.794652641s (locked time 188ns), 3894/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:31 ProactiveIVSwitch - scan time 13.897434613s (locked time 821ns), 13333/3/3/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:31 ProactiveIVSwitch - scan time 25.014301235s (locked time 114ns), 10891/164/116/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:31 ProactiveIVSwitch - scan time 29.593738613s (locked time 191ns), 27343/207/168/22 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:31 ProactiveIVSwitch - scan time 28.364909987s (locked time 211ns), 10886/369/301/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:31 ProactiveIVSwitch - scan time 10.227365235s (locked time 210ns), 11959/36/36/25 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:31 ProactiveIVSwitch - scan time 6.247146931s (locked time 165ns), 8193/22/22/17 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:31 ProactiveIVSwitch - scan time 8.400080225s (locked time 129ns), 13057/35/35/24 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:31 ProactiveIVSwitch - scan time 13.25089492s (locked time 208ns), 9720/44/44/37 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:31 ProactiveIVSwitch - scan time 19.559359527s (locked time 268ns), 20359/37/37/27 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:31 ProactiveIVSwitch - scan time 22.737121536s (locked time 94ns), 13507/121/112/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:32 ProactiveIVSwitch - scan time 12.149665416s (locked time 186ns), 13331/3/3/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:32 ProactiveIVSwitch - scan time 5.405273029s (locked time 140ns), 4994/12/12/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:32 ProactiveIVSwitch - scan time 21.058741026s (locked time 164ns), 16413/3/3/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:32 ProactiveIVSwitch - scan time 28.747713801s (locked time 121ns), 13436/927/927/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:32 ProactiveIVSwitch - scan time 29.750909866s (locked time 162ns), 27342/105/83/10 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:32 ProactiveIVSwitch - scan time 27.000523556s (locked time 135ns), 9007/772/771/35 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:32 ProactiveIVSwitch - scan time 3.896509598s (locked time 771ns), 2079/8/8/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:32 ProactiveIVSwitch - scan time 5.345874311s (locked time 141ns), 5437/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:32 ProactiveIVSwitch - scan time 1.995344227s (locked time 171ns), 4991/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:32 ProactiveIVSwitch - scan time 3.980101342s (locked time 235ns), 2304/41/40/30 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:32 ProactiveIVSwitch - scan time 23.226262949s (locked time 178ns), 20355/2/2/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:32 ProactiveIVSwitch - scan time 18.252797749s (locked time 84ns), 20348/2/2/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:32 ProactiveIVSwitch - scan time 1.917364499s (locked time 91ns), 2490/5/5/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:32 ProactiveIVSwitch - scan time 9.54955813s (locked time 117ns), 13620/17/17/13 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:33 ProactiveIVSwitch - scan time 5.922509945s (locked time 104ns), 4254/5/5/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:33 ProactiveIVSwitch - scan time 4.29552775s (locked time 134ns), 4921/2/2/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:33 ProactiveIVSwitch - scan time 28.359190409s (locked time 134ns), 27345/15/14/10 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:33 ProactiveIVSwitch - scan time 16.602523349s (locked time 157ns), 20346/7/7/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:33 ProactiveIVSwitch - scan time 30.134397368s (locked time 98ns), 27352/45/39/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:33 ProactiveIVSwitch - scan time 21.195562017s (locked time 295ns), 20357/15/14/11 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:33 ProactiveIVSwitch - scan time 12.67657305s (locked time 256ns), 16407/1/1/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:33 ProactiveIVSwitch - scan time 30.648565049s (locked time 175ns), 27353/65/49/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:34 ProactiveIVSwitch - scan time 5.806443627s (locked time 136ns), 7651/32/32/22 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:34 ProactiveIVSwitch - scan time 10.286408819s (locked time 158ns), 9888/8/8/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:34 ProactiveIVSwitch - scan time 16.061153288s (locked time 177ns), 14124/17/17/15 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:34 ProactiveIVSwitch - scan time 9.235144279s (locked time 142ns), 11956/10/10/9 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:34 ProactiveIVSwitch - scan time 33.811269825s (locked time 563ns), 32654/207/201/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:34 ProactiveIVSwitch - scan time 10.215271465s (locked time 303ns), 10873/20/20/15 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:34 ProactiveIVSwitch - scan time 32.919887101s (locked time 170ns), 27343/67/55/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:34 ProactiveIVSwitch - scan time 33.042302361s (locked time 100ns), 27342/399/376/15 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:34 ProactiveIVSwitch - scan time 12.099937913s (locked time 19.977µs), 13618/9/9/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:34 ProactiveIVSwitch - scan time 2.152211701s (locked time 301ns), 2371/3/3/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:34 ProactiveIVSwitch - scan time 9.033124942s (locked time 152ns), 11716/66/64/53 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:34 ProactiveIVSwitch - scan time 7.50575926s (locked time 137.584µs), 7655/13/13/10 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:34 ProactiveIVSwitch - scan time 34.452952204s (locked time 311ns), 32663/440/418/10 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:34 ProactiveIVSwitch - scan time 33.381649469s (locked time 113ns), 27342/114/85/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:34 ProactiveIVSwitch - scan time 1.674449159s (locked time 250ns), 2304/9/8/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:34 ProactiveIVSwitch - scan time 2.897860742s (locked time 195ns), 4776/23/23/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 33.800716873s (locked time 106ns), 27337/653/607/25 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 10.273478577s (locked time 118ns), 12772/9/9/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 32.293013839s (locked time 185ns), 32514/133/120/19 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 21.726561609s (locked time 553ns), 20349/18/18/15 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 32.80265539s (locked time 95ns), 32504/109/98/16 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 27.688523809s (locked time 202ns), 25840/199/179/33 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 11.420243154s (locked time 269ns), 14802/49/49/43 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 585.560374ms (locked time 245ns), 2244/2/2/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 33.233377088s (locked time 159ns), 32500/205/166/15 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 19.544802733s (locked time 3.202154ms), 27333/41/41/30 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 22.46411541s (locked time 152ns), 25804/13/8/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 2.008607865s (locked time 205ns), 2376/1/1/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 27.056599294s (locked time 161ns), 32390/50/48/16 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 33.525653781s (locked time 160ns), 32204/357/323/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 29.553145997s (locked time 127ns), 25840/233/225/29 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 34.774564306s (locked time 161ns), 32276/1860/1832/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 15.307093692s (locked time 106ns), 20338/10/10/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 28.369049147s (locked time 169ns), 27353/43/43/35 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 18.323004585s (locked time 133ns), 25802/115/109/10 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 35.052590232s (locked time 141ns), 32658/2290/2259/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 29.939606089s (locked time 200ns), 25839/212/188/19 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 31.160434769s (locked time 81ns), 32386/177/155/31 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 33.811627475s (locked time 235ns), 32211/669/647/11 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 4.245805433s (locked time 394ns), 10029/5/5/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 210.183977ms (locked time 98ns), 1434/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 18.543875378s (locked time 139ns), 27927/11/11/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 20.614354351s (locked time 172ns), 25795/54/47/13 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 31.880208227s (locked time 191ns), 32458/84/66/9 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 6.406413625s (locked time 99ns), 13331/13/13/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 31.529410268s (locked time 119.003µs), 25895/157/136/18 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 311.826559ms (locked time 156ns), 2242/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 11.27359233s (locked time 187ns), 14245/33/30/25 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 16.446348786s (locked time 174ns), 27350/7/7/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 386.969278ms (locked time 147ns), 3515/13/13/9 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 34.806800944s (locked time 121ns), 32515/448/416/26 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 29.104150733s (locked time 163ns), 25848/117/97/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 16.723372844s (locked time 156ns), 20341/13/13/9 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 28.668028849s (locked time 225ns), 25845/77/69/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 13.165706616s (locked time 833ns), 9420/818/817/48 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 16.315192733s (locked time 197ns), 27349/10/10/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 27.680107318s (locked time 145ns), 25836/65/61/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 33.736666273s (locked time 104ns), 26175/501/465/25 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 24.835460595s (locked time 177ns), 27938/112/112/89 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 27.148139602s (locked time 175ns), 32377/5/4/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 32.683407823s (locked time 92ns), 26016/450/427/23 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 16.673032295s (locked time 117ns), 27349/8/8/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:35 ProactiveIVSwitch - scan time 10.615977145s (locked time 9.019µs), 15419/65/65/52 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 11.86449093s (locked time 407ns), 16399/21/21/16 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 26.732539869s (locked time 118ns), 27932/12/12/11 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 12.788985811s (locked time 182ns), 14798/39/39/33 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 23.48175924s (locked time 293ns), 32372/10/8/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 5.221665436s (locked time 165ns), 10027/25/25/22 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 16.215460974s (locked time 103ns), 32342/15/14/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 17.643607516s (locked time 134ns), 27346/23/23/17 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 6.171055346s (locked time 189ns), 13330/11/11/8 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 14.672038594s (locked time 131ns), 20342/13/13/9 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 32.766583133s (locked time 94ns), 32480/151/135/15 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 33.78967106s (locked time 111ns), 32503/129/93/11 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 20.830465658s (locked time 750ns), 27932/13/13/12 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 9.807484792s (locked time 517ns), 11951/14/14/12 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 33.988677161s (locked time 155ns), 32502/318/283/18 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 14.072178701s (locked time 170ns), 25792/22/22/17 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 8.059477092s (locked time 186ns), 14797/16/16/11 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 18.126629398s (locked time 386ns), 32366/9/7/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 2.97563292s (locked time 71.228µs), 10024/1/1/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 28.501207617s (locked time 414ns), 32391/25/24/16 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 17.428517261s (locked time 243ns), 25800/17/17/13 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 18.58038551s (locked time 172ns), 27351/5/5/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 20.195715915s (locked time 208ns), 27333/5/5/5 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 18.406512275s (locked time 225ns), 27352/15/15/9 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 4.678351817s (locked time 348ns), 14788/10/10/7 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 18.050188538s (locked time 19.901µs), 27347/12/12/12 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 17.711865024s (locked time 165ns), 32353/13/12/9 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 5.440785705s (locked time 234ns), 12702/79/77/58 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 8.965538873s (locked time 184ns), 20318/22/22/16 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 27.294645659s (locked time 152ns), 32377/20/19/16 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 205.170552ms (locked time 165ns), 2248/3/3/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 34.660056343s (locked time 138ns), 20839/2062/2061/56 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 26.010564544s (locked time 164ns), 32373/6/5/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 10.546684673s (locked time 208ns), 25797/21/21/15 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 511.41533ms (locked time 12.826µs), 4790/28/28/23 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 14.550544468s (locked time 90ns), 25793/21/21/15 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 749.441244ms (locked time 127ns), 10018/7/7/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 1.41368999s (locked time 155ns), 20330/7/6/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 10.891338684s (locked time 139ns), 27916/58/58/47 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:36 ProactiveIVSwitch - scan time 17.001720311s (locked time 279ns), 32342/6/5/4 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:37 ProactiveIVSwitch - scan time 10.089950485s (locked time 136ns), 20319/10/10/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:37 ProactiveIVSwitch - scan time 1.383685799s (locked time 193ns), 13453/31/31/22 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:37 ProactiveIVSwitch - scan time 11.004059433s (locked time 162ns), 27916/7/7/6 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:37 ProactiveIVSwitch - scan time 12.674160939s (locked time 197ns), 32320/13/12/9 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:37 ProactiveIVSwitch - scan time 3.488546143s (locked time 445ns), 27919/7/7/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:37 ProactiveIVSwitch - scan time 12.835725657s (locked time 166ns), 32320/3/2/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:37 ProactiveIVSwitch - scan time 10.38372773s (locked time 319ns), 25795/13/13/12 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:37 ProactiveIVSwitch - scan time 875.893443ms (locked time 162ns), 16386/4/4/3 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:37 ProactiveIVSwitch - scan time 1.094180034s (locked time 308ns), 20327/2/2/2 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:37 ProactiveIVSwitch - scan time 326.021395ms (locked time 214ns), 20328/2/2/1 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:37 ProactiveIVSwitch - scan time 146.428949ms (locked time 231ns), 27912/12/12/12 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:40 ProactiveIVSwitch - scan time 3.573644ms (locked time 710ns), 1285/6/6/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:40 ProactiveIVSwitch - scan time 5.973545ms (locked time 124ns), 2042/20/20/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:42 STATS: Write area stats
INFO 2025-08-03 23:00:42 DB - InUse: 1 Idle 4 WaitDuration 404h42m52.764245019s
INFO 2025-08-03 23:00:46 ProactiveIVSwitch - scan time 62.118µs (locked time 214ns), 21/0/0/0 scanned/locked/updated/cp updated
INFO 2025-08-03 23:00:49 ProactiveIVSwitch - scan time 5.136468ms (locked time 182ns), 2011/0/0/0 scanned/locked/updated/cp updated

Aggregated stats via an LLM:

Total updated cells: 729
Total Scanned: 7812777
Total Locked: 86654
Total Updated: 84191
Total CP Updated: 5566
Average Scan Time: 10.7087 seconds
Average Wait Time (Locked Time): 0.0000169082 seconds

@jfberry
Copy link
Collaborator

jfberry commented Aug 4, 2025

Total updated cells: 729 Total Scanned: 7812777 Total Locked: 86654 Total Updated: 84191 Total CP Updated: 5566 Average Scan Time: 10.7087 seconds Average Wait Time (Locked Time): 0.0000169082 seconds

How many workers are sending you data?
Those are some pretty horrible cpu graphs, do you still see the peaks with this turned off? I wouldn't expect to see them at all - and those logs make for some very uncomfortable reading :-(.

It may be that we need to understand any other constraints before trusting your readings.
Perhaps sentry would help?

go 1.25 has experimental change to GC which can be activated and may give instant feedback whether they are GC peaks (as they'd be different in shape at least!)

From the logs you can clearly see the impact of the concurrent changes on the hour, as they start to build up everything slows right down - I would expect users to notice if they are in reactmap, and I also suspect that the times of processing other work would be impacted.
It may be that using a buffered channel to restrict the paralisation of the weather change would show an improvement

@Mygod
Copy link
Contributor Author

Mygod commented Aug 4, 2025

Yes they are GC peaks. They were there before weather switches; they were there when I was testing the previous PR (#244) as well.

There are lots of workers sending me data apparently, not sure how many. I have at least 729 active weather cells. Probably even the biggest mapper wouldn't have as many. :)

@jfberry
Copy link
Collaborator

jfberry commented Aug 4, 2025

There are lots of workers sending me data apparently, not sure how many. I have at least 729 active weather cells. Probably even the biggest mapper wouldn't have as many. :)

I'm not sure that's true, large mappers have many thousands of workers and each one could be across multiple weather cells

@Mygod
Copy link
Contributor Author

Mygod commented Aug 5, 2025

Apparently some people have much more weather cells. 😠 y u guys map so much

@lenisko
Copy link
Contributor

lenisko commented Aug 8, 2025

Got it, since I poked about it.. count me in :)

@Mygod
Copy link
Contributor Author

Mygod commented Aug 13, 2025

Okay I added concurrency limit. From my testing for the past few days, I can no longer see any weather cell switching back and forth: the fastest update interval was 3 second and this only happened once for one cell. I think it's fine to not add a mutex since we have mutex on the pokemon row, and furthermore the updates are now also gated by timestamp.

@jfberry What do you think? Would you like to review the code, or should testers start testing in production, or both simultaneously? :)

@jfberry
Copy link
Collaborator

jfberry commented Aug 13, 2025

Seems sensible for you to test with some real users alongside other reviews.

First read through:

  1. For the concurrency limit, I don't think numcpu's is the right number as the whole point is to stop everything getting mashed up with database writes or other processing challenges - so if it is based on numcpus it should be lower than that, or pick some reasonable value (eg 6). Assuming it's very quick in memory then this will likely not hold things up at all.
  2. Need to address the issue of multiple master files; ... currently ohbem has a watcher which loads and stores to cache which is used on startup if there is a failure. If first run we supply a default. If this can't be hooked into then having golbat download / store in cache/ etc is a reasonable alternative and have ohbem use this - but two different master files with different logic doesn't make any sense whatsoever.

@Mygod
Copy link
Contributor Author

Mygod commented Aug 13, 2025

  1. Will fix.
  2. As I already said, Gohbem doesn't load cache ever. It only stores. The masterfile in Gohbem doesn't have typing so a separate one is downloaded.

@jfberry
Copy link
Collaborator

jfberry commented Aug 13, 2025

It is golbat which loads the cached copy into ohbem when the initial retrieval fails giving the cached functionality.
Whatever the solution we should only download a single master file, cache it in case of startup on not availability and have a default for first use. This capability was added because of repeated issues

@Mygod
Copy link
Contributor Author

Mygod commented Aug 13, 2025

That doesn't seem like a good design but okay. Fixed both.

@jfberry
Copy link
Collaborator

jfberry commented Aug 13, 2025

I argued golbat should take care of it all and just give the masterfile to ohbem in all cases (which makes sense now) but this was the way Len/Fabio agreed to divide the work.

@Mygod
Copy link
Contributor Author

Mygod commented Aug 13, 2025

I was referring to that if the cache path is going to be passed to Gohbem then Gohbem should handle the logic of reading cache file as well instead of just writing. :)

@Mygod
Copy link
Contributor Author

Mygod commented Aug 14, 2025

Summoning testers @lenisko @M3G4THEKING

@lenisko
Copy link
Contributor

lenisko commented Aug 31, 2025

Swapped on prod. I will provide update in a day or two.

@Mygod Mygod mentioned this pull request Oct 29, 2025
@Fabio1988
Copy link
Collaborator

Swapped on prod. I will provide update in a day or two.

You are still on this branch? Any negative on this change? @lenisko

@lenisko
Copy link
Contributor

lenisko commented Oct 30, 2025

@Fabio1988 Been on it for a week or so, saw no issues. Switched back when bans hit.

@Mygod
Copy link
Contributor Author

Mygod commented Nov 10, 2025

So as far as I can see, there is nothing blocking merging. It would be very useful to have this. Hit that merge button when?

@Fabio1988 Fabio1988 merged commit c17dc86 into UnownHash:main Nov 15, 2025
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment

Labels

None yet

Projects

None yet

Development

Successfully merging this pull request may close these issues.

Proactive IV switching on weather change

4 participants