Can't install pbi: An error occurred!

[Child]

Hey guys,

I'm a little bit lost here. On my old machine I managed to install pbis easily - but now I'm always getting an error:
"An error occurred" and log at the bottom shows this message:

"pid 6187 (smbd), uid 0: exited on signal 6"

Anyone?

 

[ben]

FreeNAS Version (where it worked and where is isn't working), system specs, jail version, and which PBI you used (name and version and which freenas version it was associated with) would all help everyone give a better answer.

 

[Child]

Ah ... sorry. Didn't really think that through ;)

Sys: FreeNAS-8.2.0-RELEASE-p1-x64 (r11950)
Jail: FreeNAS-8.2.0-RELEASE-x64.Plugins_Jail

I took the pbis from this folder: http://sourceforge.net/projects/freenas/files/FreeNAS-8.2.0/RELEASE/x64/plugins/
It is a fresh install - jail, system and all.

Sysspecs:
AsRock E350M1/USB3 with AMD E-350 2x1,6 Ghz
8 GB DDR3-1333 (one module)
5x 2TB Harddrives

That's it I guess ... error occurs with every single pbi I tried.
Rebooting the FreeNAS-System doesn't - I already tried that one.

 

[ben]

I think smbd is CIFS/Samba - is that service running? If possible, could you turn it off and try again? I presume you're using ZFS?

 

[Child]

Yes I'm using ZFS. The five drives are set up as a RaidZ.
Turning off the CIFS-service didn't do anything. Although it stopped giving me that error "pid 6187 (smbd), uid 0: exited on signal 6" altogether.

I also checked the connection between FreeNAS and the Jail - it all seems fine to me. I can ping the Jail from my desktop and from freenas - and the other way around. Is there a way to somehow get a more comprehensive error message, then just "An error occurred" ?

 

[ben]

The footer log (in the filesystem as /var/log/messages) is a good source of error codes, someone else will have to chime in with more specific ones if there are any.

 

[ProtoSD]

This is a tip from William:

Try enabling debug in /etc/syslog.conf
restart syslogd
try to install plugin again
see if anything useful is shown in /var/log/debug.log

 

[Child]

Okay - so now I've activated the logging and thats what I got back:

Code:

Oct 10 02:07:39 MyServer manage.py: [middleware.notifier:132] Executing: /bin/rm -rf /var/tmp/firmware
Oct 10 02:07:39 MyServer manage.py: [middleware.notifier:146] Executed: /bin/rm -rf /var/tmp/firmware
Oct 10 02:07:39 MyServer manage.py: [middleware.notifier:132] Executing: /bin/mkdir -p /mnt/RaidVol/software/.freenas
Oct 10 02:07:39 MyServer manage.py: [middleware.notifier:146] Executed: /bin/mkdir -p /mnt/RaidVol/software/.freenas
Oct 10 02:07:39 MyServer manage.py: [middleware.notifier:132] Executing: /usr/sbin/chown www:www /mnt/RaidVol/software/.freenas
Oct 10 02:07:39 MyServer manage.py: [middleware.notifier:146] Executed: /usr/sbin/chown www:www /mnt/RaidVol/software/.freenas
Oct 10 02:07:39 MyServer manage.py: [middleware.notifier:132] Executing: /bin/chmod 755 /mnt/RaidVol/software/.freenas
Oct 10 02:07:39 MyServer manage.py: [middleware.notifier:146] Executed: /bin/chmod 755 /mnt/RaidVol/software/.freenas
Oct 10 02:07:39 MyServer manage.py: [middleware.notifier:132] Executing: /bin/ln -s /mnt/RaidVol/software/.freenas /var/tmp/firmware
Oct 10 02:07:39 MyServer manage.py: [middleware.notifier:146] Executed: /bin/ln -s /mnt/RaidVol/software/.freenas /var/tmp/firmware
Oct 10 02:07:46 MyServer manage.py: [middleware.notifier:149] Executing: jls -j 1
Oct 10 02:07:46 MyServer manage.py: [middleware.notifier:163] Executed: jls -j 1; returned 0
Oct 10 02:07:46 MyServer manage.py: [freeadmin.navtree:257] Model bsdGroupMembership from app account blacklisted, skipping
Oct 10 02:07:46 MyServer manage.py: [freeadmin.navtree:257] Model Advanced from app system blacklisted, skipping
Oct 10 02:07:46 MyServer manage.py: [freeadmin.navtree:257] Model Email from app system blacklisted, skipping
Oct 10 02:07:46 MyServer manage.py: [freeadmin.navtree:257] Model SSL from app system blacklisted, skipping
Oct 10 02:07:46 MyServer manage.py: [freeadmin.navtree:257] Model Settings from app system blacklisted, skipping
Oct 10 02:07:46 MyServer manage.py: [freeadmin.navtree:257] Model Alias from app network blacklisted, skipping
Oct 10 02:07:46 MyServer manage.py: [freeadmin.navtree:257] Model LAGGInterface from app network blacklisted, skipping
Oct 10 02:07:46 MyServer manage.py: [freeadmin.navtree:257] Model LAGGInterfaceMembers from app network blacklisted, skipping
Oct 10 02:07:46 MyServer manage.py: [freeadmin.navtree:257] Model Disk from app storage blacklisted, skipping
Oct 10 02:07:46 MyServer manage.py: [freeadmin.navtree:257] Model MountPoint from app storage blacklisted, skipping
Oct 10 02:07:46 MyServer manage.py: [freeadmin.navtree:257] Model ReplRemote from app storage blacklisted, skipping
Oct 10 02:07:46 MyServer manage.py: [freeadmin.navtree:257] Model Volume from app storage blacklisted, skipping
Oct 10 02:07:46 MyServer manage.py: [freeadmin.navtree:257] Model RPCToken from app services blacklisted, skipping
Oct 10 02:07:46 MyServer manage.py: [freeadmin.navtree:257] Model iSCSITargetPortalIP from app services blacklisted, skipping
Oct 10 02:07:46 MyServer manage.py: [freeadmin.navtree:257] Model services from app services blacklisted, skipping
Oct 10 02:08:02 MyServer autosnap.py: [tools.autosnap:109] Checking if process 3959 is still alive
Oct 10 02:08:02 MyServer autosnap.py: [tools.autosnap:116] Process 3959 gone

I'll attach that to my post as a txt-file ...

 

[William Grzybowski]

Looks like it is failing in the upload process.

It is really hard to debug why without access to the box.

Make sure the software dataset has enough space and check /var/log/nginx-error.log

 

[Child]

Okay - so, we're probably getting closer. That's the content that's written to the nginx-error.log when I try to upload a pbi:

Code:

2012/10/10 13:57:08 [crit] 2462#0: *396 open() "/var/tmp/firmware/0000000002" failed (13: Permission denied), client: 192.168.0.130, server: localhost, request: "POST /plugins/plugin/install/?iframe=true&X-Progress-ID=78c0baf8-1ef5-4a8f-85af-15eae0f7ea51 HTTP/1.1", host: "192.168.0.180", referrer: "http://192.168.0.180/"

It seems that something is off with the permissions. Permissions for the software & jail datasets are all Read/Write/execute for root/wheel.

 

[William Grzybowski]

Please paste # ls -l /var/tmp/firmware

I think there was a bug in 8.2 that did not set it correctly, I dont remember if it was fixed in time for release.

 

[Child]

Looks like that:

Code:

lrwxr-xr-x  1 root  wheel  30 Oct 10 14:07 /var/tmp/firmware -> /mnt/RaidVol/software/.freenas

 

[William Grzybowski]

And how are the permissions in /mnt/RaidVol/software/.freenas ?

# ls -l /mnt/RaidVol/software/.freenas

 

[Child]

Just gives me back "total 0".
But there is no dataset ".freenas" ...

... ah wait, here it is:

Code:

# ls -l /mnt/RaidVol/software                                
total 184465                                                                    
drwxr-xr-x  2 www   www           2 Oct  9 23:27 .freenas                       
drwxr-xr-x  2 root  wheel         2 Oct  5 13:27 pbi                            
-rw-------  1 root  www    94480204 Oct  5 13:26 plugins_jail-8.2.0-amd64.pbi   

 

[William Grzybowski]

Weird, looks fine.

Try this:

# killall -HUP nginx

Then try upload again...

And one more thing, how are the permissions in /mnt/RaidVol and /mnt/RaidVol/software?

# ls -la /mnt/RaidVol

 

[Child]

Code:

# ls -la /mnt/RaidVol                                        
total 25                                                                        
drwxrwx---  7 Fabian  wheel    7 Oct  5 20:26 .                                 
drwxr-xr-x  4 root    wheel  512 Oct 10 14:21 ..                                
drwxr-xr-x  2 www     www      2 Oct  5 13:27 .freenas                          
drwxrwxr-x  6 Fabian  wheel    6 Oct  6 17:06 data                              
drwxrwxrwx  3 root    wheel    3 Oct  5 13:26 jail                              
drwxrwx---  2 Fabian  wheel    9 Oct  8 11:02 scripts                           
drwxrwxrwx  4 root    wheel    5 Oct 10 14:33 software

# killall -HUP nginx: Didn't change a thing ... :(
But - am I getting this right: The pbi-install/upload fails because it is not able to write to /mnt/RaidVol/software/.freenas ?

 

[William Grzybowski]

Ok, I get it. The problem is that /mnt/RaidVol has no execute permission for others...

Do this:

# chmod o+x /mnt/RaidVol

Upload should work now.

 

[Child]

I just came to the same conclusion ;)
And it worked - thank you very much for you help.