Re: [squid-users] RE: FATAL: Ipc::Mem::Segment::create failed to shm_open(/squid-squid-page-pool.shm): (13) Permission denied

From: Amos Jeffries <squid3_at_treenet.co.nz>
Date: Thu, 20 Sep 2012 16:03:36 +1200

On 19/09/2012 4:40 a.m., Holmes, Michael A (Mike) wrote:
> More solutions to problems seen with adding the "worker" setting.
>
> To fix this
> "2012/09/18 10:05:20 kid5| commBind: Cannot bind socket FD 12 to [::]: (13) Permission denied"
>
> Do this
> #chown squid -R .../var/run/squid/

There is something very strange going on with your system permissions.
Firstly a kernel SHM device (used by the kernel itself) is not operating
properly, then your Squid is installed without ownership and read/write
of its own directories.

>
> -------
> Unfortunately there is now another problem a rolling failure of the children process by the looks of it.
>
> FATAL: kid3 registration timed out

... now the UNIX sockets are not relaying packets or the worker
processes are not responding fast enough. These sockets are another
kernel internal messaging system, so they shodul be working, but with
the SHM problem you had I'm not going to assume that.

One possible cause is that you have very large cache_dir configured and
the workers are busy loading those into memory with all the slow disk
I/O and RAM allocations that entails.

Another is that the SHM device is still not working properly, even with
tmpfs space allocated for its socket handles.

Amos

>
> Squid Cache (Version 3.2.1): Terminated abnormally.
> CPU Usage: 0.210 seconds = 0.140 user + 0.070 sys
> Maximum Resident Size: 36176 KB
> Page faults with physical i/o: 0
> Memory usage for squid via mallinfo():
> total space in arena: 4124 KB
> Ordinary blocks: 4043 KB 6 blks
> Small blocks: 0 KB 1 blks
> Holding blocks: 568 KB 2 blks
> Free Small blocks: 0 KB
> Free Ordinary blocks: 80 KB
> Total in use: 4611 KB 112%
> Total free: 80 KB 2%
>
>
> -----Original Message-----
> From: Holmes, Michael A (Mike) [mailto:Mike.Holmes_at_lsi.com]
> Sent: Tuesday, September 18, 2012 10:18 AM
> To: squid-users_at_squid-cache.org
> Subject: [squid-users] RE: FATAL: Ipc::Mem::Segment::create failed to shm_open(/squid-squid-page-pool.shm): (13) Permission denied
>
> After adding the shm fix, I now get the flowing as seen in the log below, it appears to not specify a port number.
> Still struggling to configure with multiple workers.
>
> "2012/09/18 10:05:20 kid5| commBind: Cannot bind socket FD 12 to [::]: (13) Permission denied"
>
>
> SHM FIX::
> Just add the following line to your /etc/fstab file:
> shm /dev/shm tmpfs nodev,nosuid,noexec 0 0
> After that use (as root):
> # mount shm
>
>
> LATEST LOG::
> 2012/09/18 10:05:17 kid2| Starting Squid Cache version 3.2.1 for powerpc-unknown-linux-gnu...
> 2012/09/18 10:05:17 kid2| Process ID 1760
> 2012/09/18 10:05:17 kid2| Process Roles: worker
> 2012/09/18 10:05:17 kid2| With 1024 file descriptors available
> 2012/09/18 10:05:17 kid2| Initializing IP Cache...
> 2012/09/18 10:05:17 kid2| DNS Socket created at [::], FD 8
> 2012/09/18 10:05:17 kid2| DNS Socket created at 0.0.0.0, FD 9
> 2012/09/18 10:05:17 kid2| Adding domain agere.com from /etc/resolv.conf
> 2012/09/18 10:05:17 kid2| Adding domain agere.com from /etc/resolv.conf
> 2012/09/18 10:05:17 kid2| Adding nameserver 135.149.17.30 from /etc/resolv.conf
> 2012/09/18 10:05:17 kid2| Adding nameserver 192.19.3.85 from /etc/resolv.conf
> 2012/09/18 10:05:17 kid3| Starting Squid Cache version 3.2.1 for powerpc-unknown-linux-gnu...
> 2012/09/18 10:05:17 kid3| Process ID 1759
> 2012/09/18 10:05:17 kid3| Process Roles: worker
> 2012/09/18 10:05:17 kid3| With 1024 file descriptors available
> 2012/09/18 10:05:17 kid3| Initializing IP Cache...
> 2012/09/18 10:05:17 kid3| DNS Socket created at [::], FD 8
> 2012/09/18 10:05:17 kid3| DNS Socket created at 0.0.0.0, FD 9
> 2012/09/18 10:05:17 kid3| Adding domain agere.com from /etc/resolv.conf
> 2012/09/18 10:05:17 kid3| Adding domain agere.com from /etc/resolv.conf
> 2012/09/18 10:05:17 kid3| Adding nameserver 135.149.17.30 from /etc/resolv.conf
> 2012/09/18 10:05:17 kid3| Adding nameserver 192.19.3.85 from /etc/resolv.conf
> 2012/09/18 10:05:18 kid4| Starting Squid Cache version 3.2.1 for powerpc-unknown-linux-gnu...
> 2012/09/18 10:05:18 kid4| Process ID 1758
> 2012/09/18 10:05:18 kid4| Process Roles: worker
> 2012/09/18 10:05:18 kid4| With 1024 file descriptors available
> 2012/09/18 10:05:18 kid4| Initializing IP Cache...
> 2012/09/18 10:05:18 kid4| DNS Socket created at [::], FD 8
> 2012/09/18 10:05:18 kid4| DNS Socket created at 0.0.0.0, FD 9
> 2012/09/18 10:05:18 kid4| Adding domain agere.com from /etc/resolv.conf
> 2012/09/18 10:05:18 kid4| Adding domain agere.com from /etc/resolv.conf
> 2012/09/18 10:05:18 kid4| Adding nameserver 135.149.17.30 from /etc/resolv.conf
> 2012/09/18 10:05:18 kid4| Adding nameserver 192.19.3.85 from /etc/resolv.conf
> 2012/09/18 10:05:18 kid1| Starting Squid Cache version 3.2.1 for powerpc-unknown-linux-gnu...
> 2012/09/18 10:05:18 kid1| Process ID 1761
> 2012/09/18 10:05:18 kid1| Process Roles: worker
> 2012/09/18 10:05:18 kid1| With 1024 file descriptors available
> 2012/09/18 10:05:18 kid1| Initializing IP Cache...
> 2012/09/18 10:05:18 kid1| DNS Socket created at [::], FD 8
> 2012/09/18 10:05:18 kid1| DNS Socket created at 0.0.0.0, FD 9
> 2012/09/18 10:05:18 kid1| Adding domain agere.com from /etc/resolv.conf
> 2012/09/18 10:05:18 kid1| Adding domain agere.com from /etc/resolv.conf
> 2012/09/18 10:05:18 kid1| Adding nameserver 135.149.17.30 from /etc/resolv.conf
> 2012/09/18 10:05:18 kid1| Adding nameserver 192.19.3.85 from /etc/resolv.conf
> 2012/09/18 10:05:19 kid1| Logfile: opening log stdio:/root/access.log
> 2012/09/18 10:05:19 kid2| Logfile: opening log stdio:/root/access.log
> 2012/09/18 10:05:19 kid4| Logfile: opening log stdio:/root/access.log
> 2012/09/18 10:05:19 kid3| Logfile: opening log stdio:/root/access.log
> 2012/09/18 10:05:19 kid2| Logfile: opening log stdio:/root/store.log
> 2012/09/18 10:05:19 kid4| Logfile: opening log stdio:/root/store.log
> 2012/09/18 10:05:19 kid3| Logfile: opening log stdio:/root/store.log
> 2012/09/18 10:05:19 kid2| WARNING: disk-cache maximum object size is unlimited but mem-cache maximum object size is 32.00 KB
> 2012/09/18 10:05:19 kid4| WARNING: disk-cache maximum object size is unlimited but mem-cache maximum object size is 32.00 KB
> 2012/09/18 10:05:19 kid1| Logfile: opening log stdio:/root/store.log
> 2012/09/18 10:05:19 kid3| WARNING: disk-cache maximum object size is unlimited but mem-cache maximum object size is 32.00 KB
> 2012/09/18 10:05:19 kid2| Swap maxSize 0 + 32768 KB, estimated 2520 objects
> 2012/09/18 10:05:19 kid4| Swap maxSize 0 + 32768 KB, estimated 2520 objects
> 2012/09/18 10:05:19 kid4| Target number of buckets: 126
> 2012/09/18 10:05:19 kid4| Using 8192 Store buckets
> 2012/09/18 10:05:19 kid4| Max Mem size: 32768 KB [shared]
> 2012/09/18 10:05:19 kid4| Max Swap size: 0 KB
> 2012/09/18 10:05:19 kid4| Using Least Load store dir selection
> 2012/09/18 10:05:19 kid1| WARNING: disk-cache maximum object size is unlimited but mem-cache maximum object size is 32.00 KB
> 2012/09/18 10:05:19 kid3| Swap maxSize 0 + 32768 KB, estimated 2520 objects
> 2012/09/18 10:05:19 kid2| Target number of buckets: 126
> 2012/09/18 10:05:19 kid1| Swap maxSize 0 + 32768 KB, estimated 2520 objects
> 2012/09/18 10:05:19 kid3| Target number of buckets: 126
> 2012/09/18 10:05:19 kid2| Using 8192 Store buckets
> 2012/09/18 10:05:19 kid4| Set Current Directory to /usr/local/squid-3.2.1/var/cache/squid
> 2012/09/18 10:05:19 kid1| Target number of buckets: 126
> 2012/09/18 10:05:19 kid3| Using 8192 Store buckets
> 2012/09/18 10:05:19 kid3| Max Mem size: 32768 KB [shared]
> 2012/09/18 10:05:19 kid3| Max Swap size: 0 KB
> 2012/09/18 10:05:19 kid3| Using Least Load store dir selection
> 2012/09/18 10:05:19 kid3| Set Current Directory to /usr/local/squid-3.2.1/var/cache/squid
> 2012/09/18 10:05:19 kid2| Max Mem size: 32768 KB [shared]
> 2012/09/18 10:05:19 kid1| Using 8192 Store buckets
> 2012/09/18 10:05:19 kid2| Max Swap size: 0 KB
> 2012/09/18 10:05:19 kid1| Max Mem size: 32768 KB [shared]
> 2012/09/18 10:05:19 kid2| Using Least Load store dir selection
> 2012/09/18 10:05:19 kid1| Max Swap size: 0 KB
> 2012/09/18 10:05:19 kid2| Set Current Directory to /usr/local/squid-3.2.1/var/cache/squid
> 2012/09/18 10:05:19 kid1| Using Least Load store dir selection
> 2012/09/18 10:05:19 kid1| Set Current Directory to /usr/local/squid-3.2.1/var/cache/squid
> 2012/09/18 10:05:19 kid3| Loaded Icons.
> 2012/09/18 10:05:19 kid2| Loaded Icons.
> 2012/09/18 10:05:19 kid4| Loaded Icons.
> 2012/09/18 10:05:19 kid1| Loaded Icons.
> 2012/09/18 10:05:19 kid3| HTCP Disabled.
> 2012/09/18 10:05:19 kid2| HTCP Disabled.
> 2012/09/18 10:05:19 kid4| HTCP Disabled.
> 2012/09/18 10:05:19 kid1| HTCP Disabled.
> 2012/09/18 10:05:19 kid3| Configuring Parent 135.156.195.210/9480/0
> 2012/09/18 10:05:19 kid2| Configuring Parent 135.156.195.210/9480/0
> 2012/09/18 10:05:19 kid4| Configuring Parent 135.156.195.210/9480/0
> 2012/09/18 10:05:19 kid1| Configuring Parent 135.156.195.210/9480/0
> 2012/09/18 10:05:19 kid3| Squid plugin modules loaded: 0
> 2012/09/18 10:05:19 kid2| Squid plugin modules loaded: 0
> 2012/09/18 10:05:19 kid4| Squid plugin modules loaded: 0
> 2012/09/18 10:05:19 kid1| Squid plugin modules loaded: 0
> 2012/09/18 10:05:19 kid3| commBind: Cannot bind socket FD 14 to [::]: (13) Permission denied
> 2012/09/18 10:05:19 kid2| commBind: Cannot bind socket FD 14 to [::]: (13) Permission denied
> 2012/09/18 10:05:19 kid4| commBind: Cannot bind socket FD 14 to [::]: (13) Permission denied
> 2012/09/18 10:05:19 kid1| commBind: Cannot bind socket FD 14 to [::]: (13) Permission denied
> 2012/09/18 10:05:20 kid5| Starting Squid Cache version 3.2.1 for powerpc-unknown-linux-gnu...
> 2012/09/18 10:05:20 kid5| Process ID 1757
> 2012/09/18 10:05:20 kid5| Process Roles: coordinator
> 2012/09/18 10:05:20 kid5| With 1024 file descriptors available
> 2012/09/18 10:05:20 kid5| Initializing IP Cache...
> 2012/09/18 10:05:20 kid5| DNS Socket created at [::], FD 8
> 2012/09/18 10:05:20 kid5| DNS Socket created at 0.0.0.0, FD 9
> 2012/09/18 10:05:20 kid5| Adding domain agere.com from /etc/resolv.conf
> 2012/09/18 10:05:20 kid5| Adding domain agere.com from /etc/resolv.conf
> 2012/09/18 10:05:20 kid5| Adding nameserver 135.149.17.30 from /etc/resolv.conf
> 2012/09/18 10:05:20 kid5| Adding nameserver 192.19.3.85 from /etc/resolv.conf
> 2012/09/18 10:05:20 kid5| Logfile: opening log stdio:/root/access.log
> 2012/09/18 10:05:20 kid5| Logfile: opening log stdio:/root/store.log
> 2012/09/18 10:05:20 kid5| Swap maxSize 0 + 32768 KB, estimated 2520 objects
> 2012/09/18 10:05:20 kid5| Target number of buckets: 126
> 2012/09/18 10:05:20 kid5| Using 8192 Store buckets
> 2012/09/18 10:05:20 kid5| Max Mem size: 32768 KB [shared]
> 2012/09/18 10:05:20 kid5| Max Swap size: 0 KB
> 2012/09/18 10:05:20 kid5| Using Least Load store dir selection
> 2012/09/18 10:05:20 kid5| Set Current Directory to /usr/local/squid-3.2.1/var/cache/squid
> 2012/09/18 10:05:20 kid5| Loaded Icons.
> 2012/09/18 10:05:20 kid5| Configuring Parent 135.156.195.210/9480/0
> 2012/09/18 10:05:20 kid5| Squid plugin modules loaded: 0
> 2012/09/18 10:05:20 kid5| commBind: Cannot bind socket FD 12 to [::]: (13) Permission denied
> 2012/09/18 10:05:21 kid3| storeLateRelease: released 0 objects
> 2012/09/18 10:05:21 kid2| storeLateRelease: released 0 objects
> 2012/09/18 10:05:21 kid4| storeLateRelease: released 0 objects
> 2012/09/18 10:05:21 kid1| storeLateRelease: released 0 objects
> 2012/09/18 10:05:21 kid5| storeLateRelease: released 0 objects
>
> -----Original Message-----
> From: Holmes, Michael A (Mike) [mailto:Mike.Holmes_at_lsi.com]
> Sent: Tuesday, September 18, 2012 8:29 AM
> To: squid-users_at_squid-cache.org
> Subject: [squid-users] RE: FATAL: Ipc::Mem::Segment::create failed to shm_open(/squid-squid-page-pool.shm): (13) Permission denied
>
> The OS is Linux 2.6.35
>
> -----Original Message-----
> From: Holmes, Michael A (Mike)
> Sent: Monday, September 17, 2012 3:45 PM
> To: squid-users_at_squid-cache.org
> Subject: FATAL: Ipc::Mem::Segment::create failed to shm_open(/squid-squid-page-pool.shm): (13) Permission denied
>
> I just added "workers 4" to my working configuration and I get an shm_open error. I assume it is trying to write to the root directory "/squid-squid-page-pool.shm" as the user squid which will fail.
>
> How do I redirect this?
>
> Thanks Mike
>
>
> Squid Cache (Version 3.2.1): Terminated abnormally.
> CPU Usage: 0.060 seconds = 0.040 user + 0.020 sys
> Maximum Resident Size: 18560 KB
> Page faults with physical i/o: 0
> 2012/09/17 15:34:33 kid1| Creating Swap Directories
> 2012/09/17 15:38:02| storeDirWriteCleanLogs: Starting...
> 2012/09/17 15:38:02| Finished. Wrote 0 entries.
> 2012/09/17 15:38:02| Took 0.00 seconds ( 0.00 entries/sec).
> FATAL: Ipc::Mem::Segment::create failed to shm_open(/squid-squid-page-pool.shm): (13) Permission denied
Received on Thu Sep 20 2012 - 04:03:47 MDT

This archive was generated by hypermail 2.2.0 : Thu Sep 20 2012 - 12:00:04 MDT