[squid-users] Re: Sudden error (1067) when starting squid service W2K3

From: Rhys Evans <rhys.evans_at_gmail.com>
Date: Wed, 25 May 2011 14:10:49 +1200

Seeing as I don't have any neighbour caches, I set htcp_port 0 and
things seem to be OK. It still seems odd that this issue came up, I'm
wondering if maybe some Windows update altered some behaviour in
regard to allowing the binding required?

On 25 May 2011 13:58, Rhys Evans <rhys.evans_at_gmail.com> wrote:
> I've tried an absolutely fresh install of squid and still get a 1067
> error when starting the service. There is now nothing written to
> squid.exe.log but cache.log includes the text below:
>
> 2011/05/25 13:54:39| Starting Squid Cache version 2.7.STABLE8 for
> i686-pc-winnt...
> 2011/05/25 13:54:39| Running as Squid Windows System Service on
> Windows Server 2003
> 2011/05/25 13:54:39| Service command line is:
> 2011/05/25 13:54:39| Process ID 3796
> 2011/05/25 13:54:39| With 2048 file descriptors available
> 2011/05/25 13:54:39| With 2048 CRT stdio descriptors available
> 2011/05/25 13:54:39| Windows sockets initialized
> 2011/05/25 13:54:39| Using select for the IO loop
> 2011/05/25 13:54:39| Performing DNS Tests...
> 2011/05/25 13:54:39| Successful DNS name lookup tests...
> 2011/05/25 13:54:39| DNS Socket created at 0.0.0.0, port 22166, FD 5
> 2011/05/25 13:54:39| Adding nameserver 10.131.208.10 from squid.conf
> 2011/05/25 13:54:39| Adding nameserver 10.131.208.1 from squid.conf
> 2011/05/25 13:54:39| Adding nameserver 208.67.222.222 from squid.conf
> 2011/05/25 13:54:39| Adding nameserver 208.67.220.220 from squid.conf
> 2011/05/25 13:54:39| User-Agent logging is disabled.
> 2011/05/25 13:54:39| Referer logging is disabled.
> 2011/05/25 13:54:39| logfileOpen: opening log c:/squid/var/logs/access.log
> 2011/05/25 13:54:39| Unlinkd pipe opened on FD 8
> 2011/05/25 13:54:39| Swap maxSize 262144 + 8192 KB, estimated 20795 objects
> 2011/05/25 13:54:39| Target number of buckets: 1039
> 2011/05/25 13:54:39| Using 8192 Store buckets
> 2011/05/25 13:54:39| Max Mem  size: 8192 KB
> 2011/05/25 13:54:39| Max Swap size: 262144 KB
> 2011/05/25 13:54:39| Local cache digest enabled; rebuild/rewrite every
> 3600/3600 sec
> 2011/05/25 13:54:39| logfileOpen: opening log c:/squid/var/logs/store.log
> 2011/05/25 13:54:39| Rebuilding storage in d:/cache (DIRTY)
> 2011/05/25 13:54:39| Using Least Load store dir selection
> 2011/05/25 13:54:39| Set Current Directory to d:/cache
> 2011/05/25 13:54:39| Loaded Icons.
> 2011/05/25 13:54:39| Accepting proxy HTTP connections at 0.0.0.0, port
> 3128, FD 13.
> 2011/05/25 13:54:39| Accepting ICP messages at 0.0.0.0, port 3130, FD 14.
> 2011/05/25 13:54:39| commBind: Cannot bind socket FD 15 to *:4827:
> (10013) WSAEACCES, Permission denied.
> FATAL: Cannot open HTCP Socket
> Squid Cache (Version 2.7.STABLE8): Terminated abnormally.
>
> On 25 May 2011 13:22, Rhys Evans <rhys.evans_at_gmail.com> wrote:
>> I've encountered this strange error situation and would appreciate any
>> attempts to shed light on the issue.
>>
>> I've got a squid service running on Windows Server 2003 (this squid
>> service has been running since October 2008) and just the other day
>> (after a power cut) the service will no longer start.
>>
>> The error number when trying to start the service is 1067.
>>
>> The error in squid.exe.log is: 2011/05/25 13:12:28| parseConfigFile:
>> squid.conf:1 unrecognized: ''" (There is a tall rectangle character
>> in those quotes).
>>
>> The last successful and the first unsuccessful entries from cache.log are:
>>
>> 2011/05/22 22:00:02| Starting Squid Cache version 2.7.STABLE4 for
>> i686-pc-winnt...
>> 2011/05/22 22:00:02| Running as Squid Windows System Service on
>> Windows Server 2003
>> 2011/05/22 22:00:02| Service command line is:
>> 2011/05/22 22:00:02| Process ID 3004
>> 2011/05/22 22:00:02| With 2048 file descriptors available
>> 2011/05/22 22:00:02| With 2048 CRT stdio descriptors available
>> 2011/05/22 22:00:02| Windows sockets initialized
>> 2011/05/22 22:00:02| Using select for the IO loop
>> 2011/05/22 22:00:02| Performing DNS Tests...
>> 2011/05/22 22:00:02| Successful DNS name lookup tests...
>> 2011/05/22 22:00:02| DNS Socket created at 0.0.0.0, port 52505, FD 5
>> 2011/05/22 22:00:02| Adding nameserver 10.131.208.10 from squid.conf
>> 2011/05/22 22:00:02| Adding nameserver 10.131.208.1 from squid.conf
>> 2011/05/22 22:00:02| Adding nameserver 208.67.222.222 from squid.conf
>> 2011/05/22 22:00:02| Adding nameserver 208.67.220.220 from squid.conf
>> 2011/05/22 22:00:02| User-Agent logging is disabled.
>> 2011/05/22 22:00:02| Referer logging is disabled.
>> 2011/05/22 22:00:02| logfileOpen: opening log c:/squid/var/logs/access.log
>> 2011/05/22 22:00:02| Unlinkd pipe opened on FD 8
>> 2011/05/22 22:00:02| Swap maxSize 262144 + 16384 KB, estimated 0 objects
>> 2011/05/22 22:00:02| Target number of buckets: 1071
>> 2011/05/22 22:00:02| Using 8192 Store buckets
>> 2011/05/22 22:00:02| Max Mem  size: 16384 KB
>> 2011/05/22 22:00:02| Max Swap size: 262144 KB
>> 2011/05/22 22:00:02| Local cache digest enabled; rebuild/rewrite every
>> 3600/3600 sec
>> 2011/05/22 22:00:02| logfileOpen: opening log c:/squid/var/logs/store.log
>> 2011/05/22 22:00:02| Rebuilding storage in d:/cache (CLEAN)
>> 2011/05/22 22:00:02| Using Least Load store dir selection
>> 2011/05/22 22:00:02| chdir: c:/squid/var/cache: (2) No such file or directory
>> 2011/05/22 22:00:02| Current Directory is C:\squid\sbin
>> 2011/05/22 22:00:02| Loaded Icons.
>> 2011/05/22 22:00:02| Accepting proxy HTTP connections at 0.0.0.0, port
>> 3128, FD 14.
>> 2011/05/22 22:00:02| Accepting ICP messages at 0.0.0.0, port 3130, FD 15.
>> 2011/05/22 22:00:02| Accepting HTCP messages on port 4827, FD 16.
>> 2011/05/22 22:00:02| Accepting SNMP messages on port 3401, FD 17.
>> 2011/05/22 22:00:02| Ready to serve requests.
>> 2011/05/22 22:00:03| Store rebuilding is 42.8% complete
>> 2011/05/22 22:00:03| Done reading d:/cache swaplog (9566 entries)
>> 2011/05/22 22:00:03| Finished rebuilding storage from disk.
>> 2011/05/22 22:00:03|      9566 Entries scanned
>> 2011/05/22 22:00:03|         0 Invalid entries.
>> 2011/05/22 22:00:03|         0 With invalid flags.
>> 2011/05/22 22:00:03|      9566 Objects loaded.
>> 2011/05/22 22:00:03|         0 Objects expired.
>> 2011/05/22 22:00:03|         0 Objects cancelled.
>> 2011/05/22 22:00:03|         0 Duplicate URLs purged.
>> 2011/05/22 22:00:03|         0 Swapfile clashes avoided.
>> 2011/05/22 22:00:03|   Took 0.5 seconds (18015.1 objects/sec).
>> 2011/05/22 22:00:03| Beginning Validation Procedure
>> 2011/05/22 22:00:03|   Completed Validation Procedure
>> 2011/05/22 22:00:03|   Validated 9566 Entries
>> 2011/05/22 22:00:03|   store_swap_size = 235728k
>> 2011/05/22 22:00:03| storeLateRelease: released 0 objects
>> 2011/05/23 10:45:33| ipcacheParse: No Address records in response to
>> 'www.google.com'
>> 2011/05/23 10:50:52| ipcacheParse: No Address records in response to
>> 'www.update.microsoft.com'
>> 2011/05/23 11:00:03| ipcacheParse: No Address records in response to
>> 'www.update.microsoft.com'
>> 2011/05/24 08:27:15| Starting Squid Cache version 2.7.STABLE4 for
>> i686-pc-winnt...
>> 2011/05/24 08:27:15| Running as Squid Windows System Service on
>> Windows Server 2003
>> 2011/05/24 08:27:15| Service command line is:
>> 2011/05/24 08:27:15| Process ID 2364
>> 2011/05/24 08:27:15| With 2048 file descriptors available
>> 2011/05/24 08:27:15| With 2048 CRT stdio descriptors available
>> 2011/05/24 08:27:15| Windows sockets initialized
>> 2011/05/24 08:27:15| Using select for the IO loop
>> 2011/05/24 08:27:15| Performing DNS Tests...
>> 2011/05/24 08:27:15| Successful DNS name lookup tests...
>> 2011/05/24 08:27:15| DNS Socket created at 0.0.0.0, port 1096, FD 5
>> 2011/05/24 08:27:15| Adding nameserver 10.131.208.10 from squid.conf
>> 2011/05/24 08:27:15| Adding nameserver 10.131.208.1 from squid.conf
>> 2011/05/24 08:27:15| Adding nameserver 208.67.222.222 from squid.conf
>> 2011/05/24 08:27:15| Adding nameserver 208.67.220.220 from squid.conf
>> 2011/05/24 08:27:15| User-Agent logging is disabled.
>> 2011/05/24 08:27:15| Referer logging is disabled.
>> 2011/05/24 08:27:15| logfileOpen: opening log c:/squid/var/logs/access.log
>> 2011/05/24 08:27:15| Unlinkd pipe opened on FD 8
>> 2011/05/24 08:27:15| Swap maxSize 262144 + 16384 KB, estimated 0 objects
>> 2011/05/24 08:27:15| Target number of buckets: 1071
>> 2011/05/24 08:27:15| Using 8192 Store buckets
>> 2011/05/24 08:27:15| Max Mem  size: 16384 KB
>> 2011/05/24 08:27:15| Max Swap size: 262144 KB
>> 2011/05/24 08:27:15| Local cache digest enabled; rebuild/rewrite every
>> 3600/3600 sec
>> 2011/05/24 08:27:15| logfileOpen: opening log c:/squid/var/logs/store.log
>> 2011/05/24 08:27:15| Rebuilding storage in d:/cache (DIRTY)
>> 2011/05/24 08:27:15| Using Least Load store dir selection
>> 2011/05/24 08:27:15| chdir: c:/squid/var/cache: (2) No such file or directory
>> 2011/05/24 08:27:15| Current Directory is C:\squid\sbin
>> 2011/05/24 08:27:15| Loaded Icons.
>> 2011/05/24 08:27:15| Accepting proxy HTTP connections at 0.0.0.0, port
>> 3128, FD 14.
>> 2011/05/24 08:27:15| Accepting ICP messages at 0.0.0.0, port 3130, FD 15.
>> 2011/05/24 08:27:15| commBind: Cannot bind socket FD 16 to *:4827:
>> (10013) WSAEACCES, Permission denied.
>> FATAL: Cannot open HTCP Socket
>> Squid Cache (Version 2.7.STABLE4): Terminated abnormally.
>>
>> I've tried reverting to an earlier config file, building a new config
>> file, forcing encoding to ANSI, tried different line endings.
>>
>> I've tried uninstalling and reinstalling the service.
>>
>> I've tried replacing the squid directory.
>>
>> I've tried replacing and rebuilding the cache directory (it also kicks
>> up an error about that character on the first line of the conf file).
>>
>> I've tried disabling socket pooling for IIS.
>>
>> Anything else I should try?
>>
>
Received on Wed May 25 2011 - 02:10:56 MDT

This archive was generated by hypermail 2.2.0 : Wed May 25 2011 - 12:00:03 MDT