Hi!
I use Squid for years now as loadbalancer and accelerator.
Lately our ISP decided to replace the whole IP range we use. To ease
transition we were given a two months period in which the old and new
IPs are working the same time.
As soon as we start using the second IP on our proxy server, and restart
squid to bind to the new interface too, squid serves some requests, then
decides that the originservers are gone.
cache_peers are apache2 webservers so instead of ICP requests they got
udp echo requests. They get some UDP packages (checked with tcpdump),
but when they disappear, they do not get echo requests, and they wont
come back.
If I replace the 7 (udp echo) with 0 for ICP port in the cache_peer
line, squid works, but do not notice weather the server is up&running or
not.
I use: Squid 2.6.5 (default Debian/Etch binary)
config and log is attached.
If I need to provide anything else, please let me know!
Detailed (debug) logs shows, that the first few requests have parents:
2007/06/28 13:44:23| peerGetSomeParent: GET www.aexample.com
2007/06/28 13:44:23| peerSelect: FIRST_UP_PARENT/Y.Y.Y.Y
2007/06/28 13:44:23| peerAddFwdServer: adding Y.Y.Y.Y FIRST_UP_PARENT
2007/06/28 13:44:23| peerAddFwdServer: adding Y.Y.Y.Y ANY_PARENT
2007/06/28 13:44:23| peerAddFwdServer: adding Y.Y.Y.X ANY_PARENT
[...]
2007/06/28 13:44:26| peerSelectFoo: 'GET www.example.com'
2007/06/28 13:44:26| peerSelectFoo: direct = DIRECT_NO
2007/06/28 13:44:26| peerDigestLookup: peer Y.Y.Y.Y
2007/06/28 13:44:26| peerDigestLookup: gone!
2007/06/28 13:44:26| peerDigestLookup: peer 81.2.252.112
2007/06/28 13:44:26| peerDigestLookup: gone!
2007/06/28 13:44:26| neighborsDigestSelect: choices: 0 (0)
2007/06/28 13:44:26| peerNoteDigestLookup: peer <none>, lookup: LOOKUP_NONE
Thanks in advance!
Peter Siklosi
visible_hostname www.example.com
http_port 80 vhost defaultsite=www.example.com
cache_peer Y.Y.Y.Y parent 80 7 originserver no-digest weight=3
cache_peer Y.Y.Y.X parent 80 7 originserver no-digest weight=5
acl hammerers src 193.28.86.0/255.255.255.0
acl all src 0.0.0.0/0.0.0.0
http_access deny hammerers
http_access allow all
# emulate_httpd_log on
cache_log /var/log/squid/cache.log
cache_dir ufs /home/squid 20000 128 256
cache_access_log /var/log/squid/access.log
cache_mem 1200 MB
maximum_object_size 8 MB
maximum_object_size_in_memory 2 MB
cache_replacement_policy heap LFUDA
memory_pools on
memory_pools_limit 400 MB
error_directory /usr/share/squid/errors/Hungarian
Jun 28 15:08:58 store squid[24283]: Starting Squid Cache version 2.6.STABLE5 for i386-debian-linux-gnu...
Jun 28 15:08:58 store squid[24283]: Process ID 24283
Jun 28 15:08:58 store squid[24283]: With 1024 file descriptors available
Jun 28 15:08:58 store squid[24283]: Using epoll for the IO loop
Jun 28 15:08:58 store squid[24283]: DNS Socket created at 0.0.0.0, port 49444, FD 6
Jun 28 15:08:58 store squid[24283]: Adding domain example.com from /etc/resolv.conf
Jun 28 15:08:58 store squid[24283]: Adding nameserver X.X.X.X from /etc/resolv.conf
Jun 28 15:08:58 store squid[24283]: User-Agent logging is disabled.
Jun 28 15:08:58 store squid[24283]: Referer logging is disabled.
Jun 28 15:08:58 store squid[24281]: Squid Parent: child process 24283 started
Jun 28 15:08:58 store squid[24283]: Unlinkd pipe opened on FD 11
Jun 28 15:08:58 store squid[24283]: Swap maxSize 20480000 KB, estimated 1575384 objects
Jun 28 15:08:58 store squid[24283]: Target number of buckets: 78769
Jun 28 15:08:58 store squid[24283]: Using 131072 Store buckets
Jun 28 15:08:58 store squid[24283]: Max Mem size: 1228800 KB
Jun 28 15:08:58 store squid[24283]: Max Swap size: 20480000 KB
Jun 28 15:08:58 store squid[24283]: Local cache digest enabled; rebuild/rewrite every 3600/3600 sec
Jun 28 15:08:58 store squid[24283]: Rebuilding storage in /home/squid (CLEAN)
Jun 28 15:08:58 store squid[24283]: Using Least Load store dir selection
Jun 28 15:08:58 store squid[24283]: Current Directory is /
Jun 28 15:08:58 store squid[24283]: Loaded Icons.
Jun 28 15:08:58 store squid[24283]: Accepting accelerated HTTP connections at 0.0.0.0, port 80, FD 13.
Jun 28 15:08:58 store squid[24283]: Accepting ICP messages at 0.0.0.0, port 3130, FD 14.
Jun 28 15:08:58 store squid[24283]: HTCP Disabled.
Jun 28 15:08:58 store squid[24283]: WCCP Disabled.
Jun 28 15:08:58 store squid[24283]: Configuring Parent Y.Y.Y.Y/80/7
Jun 28 15:08:58 store squid[24283]: Configuring Parent Y.Y.Y.X/80/7
Jun 28 15:08:58 store squid[24283]: Ready to serve requests.
Jun 28 15:08:58 store squid[24283]: Done reading /home/squid swaplog (37 entries)
Jun 28 15:08:58 store squid[24283]: Finished rebuilding storage from disk.
Jun 28 15:08:58 store squid[24283]: 37 Entries scanned
Jun 28 15:08:58 store squid[24283]: 0 Invalid entries.
Jun 28 15:08:58 store squid[24283]: 0 With invalid flags.
Jun 28 15:08:58 store squid[24283]: 37 Objects loaded.
Jun 28 15:08:58 store squid[24283]: 0 Objects expired.
Jun 28 15:08:58 store squid[24283]: 0 Objects cancelled.
Jun 28 15:08:58 store squid[24283]: 0 Duplicate URLs purged.
Jun 28 15:08:58 store squid[24283]: 0 Swapfile clashes avoided.
Jun 28 15:08:58 store squid[24283]: Took 0.3 seconds ( 146.6 objects/sec).
Jun 28 15:08:58 store squid[24283]: Beginning Validation Procedure
Jun 28 15:08:58 store squid[24283]: Completed Validation Procedure
Jun 28 15:08:58 store squid[24283]: Validated 37 Entries
Jun 28 15:08:58 store squid[24283]: store_swap_size = 748k
Jun 28 15:08:59 store squid[24283]: storeLateRelease: released 0 objects
Jun 28 15:09:21 store squid[24283]: Failed to select source for 'http://www.example.com/request'
Jun 28 15:09:21 store squid[24283]: always_direct = 0
Jun 28 15:09:21 store squid[24283]: never_direct = 0
Jun 28 15:09:21 store squid[24283]: timedout = 0
Jun 28 15:09:49 store squid[24283]: Preparing for shutdown after 3 requests
Jun 28 15:09:49 store squid[24283]: Waiting 30 seconds for active connections to finish
Jun 28 15:09:49 store squid[24283]: FD 13 Closing HTTP connection
Jun 28 15:09:49 store squid[24283]: Shutting down...
Jun 28 15:09:49 store squid[24283]: FD 14 Closing ICP connection
Jun 28 15:09:49 store squid[24283]: Closing unlinkd pipe on FD 11
Jun 28 15:09:49 store squid[24283]: storeDirWriteCleanLogs: Starting...
Jun 28 15:09:49 store squid[24283]: Finished. Wrote 37 entries.
Jun 28 15:09:49 store squid[24283]: Took 0.0 seconds (152892.6 entries/sec).
Jun 28 15:09:49 store squid[24283]: Squid Cache (Version 2.6.STABLE5): Exiting normally.
Jun 28 15:09:49 store squid[24281]: Squid Parent: child process 24283 exited with status 0
