June 10, 201313 yr Hi, i updated to the latest rc-13 and filled up my array with data from an old backup drive (1.5 TB: videos, music, lot of pictures, time machine). Now the array needs nearly 15-20min to start (mount) and on first time boot-up (the array will auto start) the webinterface does not respond. I think the syslog looks fine... Is there anything i can do? Kind regards Demokan Hardware: Mainboard: ASUS P8H77-I Prozessor: Intel Core i3-3220T RAM: 8GB Corsair Parity: 3 TB Hitachi Data1: 3 TB Hitachi syslog.txt
June 10, 201313 yr Do you have a monitor attached to your UnRAID box? If not, connect one. Then watch the initial boot and see if (a) the bizroot/bizimage files are loading quickly and the time involved is in actual Linux initializations; or (b) the bizroom/bizimage files are loading S.L.O.W.L.Y ==> this can happen if for some reason your USB flash drive is read at USB v1 rates. Shouldn't happen on any modern board; but can ... and the "solution" is often to simply use another USB port (which will likely require "fiddling" in the BIOS to get the boot device set correctly).
June 11, 201313 yr Author Thanks I tried that. The image loads in seconds (4s) and the complete boot (incl. plex) needs 30s. I even tried to change the USB port and the 4GB RAM limit. Starting to the maintain mode works fine. But no change of the mounting speed... But I recognized the drives making a reading/writing noise while the array is not started. Should I check some SMART status or Hitachi firmware updates?
June 11, 201313 yr So the long time interval you're referring to is from the time you click Start on the Web GUI until the array is actually ready ??
June 11, 201313 yr Author Yes. Spinning up all drives... Start array... Mounting disks... <- this needs 30-60min to proceed and the webinterface does not respond Restart SMB... Start AFP... After the array is mounted and ready everything works fine. EDIT: I installed a HDD LED and noticed periodically reads & writes on both disks (every 6s). The webinterface read/writer counter is also counting. And if i spindown the discs they will immediately spinup. Is there any correlation to my imported data? I used the Wiki Transferring Files guide...
June 11, 201313 yr ... and this is with only ONE data disk plus parity !! I can't think of ANYTHING that would cause this to run this slowly with the possible exception of both drives being accessed in PIO mode [VERY unlikely] or a hung network protocol. (and even then I wouldn't think it would take 30-60 minutes !!) Disable any add-ons you're running and all of the protocols except SMB and see if that makes a difference.
June 11, 201313 yr Author All plugins (its just plex) are already disabled. Both drives Parity and Data are 3 TB Hitachi (Hitachi_HDS5C3030BLE630). They are new and just used for unRAID. Before first use i precleard both drives (1 times) with no errors.
June 11, 201313 yr Yes. Spinning up all drives... Start array... Mounting disks... <- this needs 30-60min to proceed and the webinterface does not respond Restart SMB... Start AFP... After the array is mounted and ready everything works fine. EDIT: I installed a HDD LED and noticed periodically reads & writes on both disks (every 6s). The webinterface read/writer counter is also counting. And if i spindown the discs they will immediately spinup. Is there any correlation to my imported data? I used the Wiki Transferring Files guide... Are you cleanly stopping the array before shutting the server down? I can see it taking a long time replaying the file-system-journals if you do not shut down cleanly. (as long as 30 minutes or more) This would be noted in the system log though. As far as disk accesses, it sounds like something is using your disks. Install the inotifywatch package to learn what is using them. Joe L.
June 11, 201313 yr Author AFP deactivated - no improvement In webinterface: Stopping the array and then power down or using the console via telnet: powerdown I am setting up the inotify watches for my data drive (/mnt/disk1). This will take a while. The webinterface says the array is not mounted jet. But i can already access to the array data via console... (/mnt/disk1 and /mnt/user)
June 11, 201313 yr The webinterface says the array is not mounted jet. But i can already access to the array data via console... (/mnt/disk1 and /mnt/user) The unRAID web interface does not refresh itself. If you can access the data, the disks are mounted.
June 11, 201313 yr Author Okay good to know! So if i try to refresh the interface, it still says "Mounting disks..." I can access via terminal , but not over AFP oder SMB. (only the flash drive works)
June 11, 201313 yr This line in the syslog seems VERY WRONG. I think your "plex" is improperly configured. changing owner of /mnt/disk1 from nobody to unraid-plex all disks should be owned by "nobody" (you can probably do as you please with sub-directories) The delays in starting were all in the set up and configuration of "afp" Jun 10 17:06:36 demoserver afpd[1947]: dsi_stream_read: len:0, unexpected EOF" I'd find a better implementation. It seems to be stopping the array and delaying everything. Jun 10 16:49:11 demoserver emhttp: shcmd (23): :>/etc/samba/smb-shares.conf Jun 10 16:49:11 demoserver emhttp: shcmd (24): cp /etc/netatalk/AppleVolumes.default- /etc/netatalk/AppleVolumes.default Jun 10 16:49:11 demoserver emhttp: Restart SMB... Jun 10 16:49:11 demoserver emhttp: shcmd (25): killall -HUP smbd Jun 10 16:49:11 demoserver emhttp: shcmd (26): ps axc | grep -q rpc.mountd Jun 10 16:49:11 demoserver emhttp: _shcmd: shcmd (26): exit status: 1 Jun 10 16:49:11 demoserver emhttp: Start AFP... Jun 10 16:49:11 demoserver emhttp: shcmd (27): /etc/rc.d/rc.atalk start |& logger Jun 10 16:49:11 demoserver logger: starting appletalk daemons: cnid_metad afpd Jun 10 16:49:11 demoserver emhttp: shcmd (28): cp /etc/avahi/services/afp.service- /etc/avahi/services/afp.service Jun 10 16:49:11 demoserver avahi-daemon[1411]: Files changed, reloading. Jun 10 16:49:11 demoserver avahi-daemon[1411]: Loading service file /services/afp.service. Jun 10 16:49:11 demoserver emhttp: shcmd (29): cp /etc/avahi/services/smb.service- /etc/avahi/services/smb.service Jun 10 16:49:11 demoserver avahi-daemon[1411]: Files changed, reloading. Jun 10 16:49:11 demoserver avahi-daemon[1411]: Service group file /services/smb.service changed, reloading. Jun 10 16:49:11 demoserver emhttp: shcmd (30): /usr/local/sbin/emhttp_event svcs_restarted Jun 10 16:49:11 demoserver emhttp_event: svcs_restarted Jun 10 16:49:12 demoserver avahi-daemon[1411]: Service "demoserver" (/services/afp.service) successfully established. Jun 10 16:49:12 demoserver avahi-daemon[1411]: Service "demoserver-SMB" (/services/smb.service) successfully established. Jun 10 17:02:10 demoserver emhttp: shcmd (31): /usr/local/sbin/set_ncq sdb 1 &> /dev/null Jun 10 17:02:10 demoserver emhttp: shcmd (32): /usr/local/sbin/set_ncq sdc 1 &> /dev/null Jun 10 17:02:10 demoserver kernel: mdcmd (12): set md_num_stripes 1280 Jun 10 17:02:10 demoserver kernel: mdcmd (13): set md_write_limit 768 Jun 10 17:02:10 demoserver kernel: mdcmd (14): set md_sync_window 384 Jun 10 17:02:10 demoserver kernel: mdcmd (15): set spinup_group 0 0 Jun 10 17:02:10 demoserver kernel: mdcmd (16): set spinup_group 1 0 Jun 10 17:02:33 demoserver emhttp: shcmd (33): /usr/local/sbin/set_ncq sdb 1 &> /dev/null Jun 10 17:02:33 demoserver emhttp: shcmd (34): /usr/local/sbin/set_ncq sdc 1 &> /dev/null Jun 10 17:02:33 demoserver kernel: mdcmd (17): set md_num_stripes 1280 Jun 10 17:02:33 demoserver kernel: mdcmd (18): set md_write_limit 768 Jun 10 17:02:33 demoserver kernel: mdcmd (19): set md_sync_window 384 Jun 10 17:02:33 demoserver kernel: mdcmd (20): set spinup_group 0 0 Jun 10 17:02:33 demoserver kernel: mdcmd (21): set spinup_group 1 0 Jun 10 17:06:36 demoserver afpd[1947]: dsi_stream_read: len:0, unexpected EOF Jun 10 17:08:22 demoserver emhttp: shcmd (35): /usr/local/sbin/emhttp_event stopping_svcs Jun 10 17:08:22 demoserver emhttp_event: stopping_svcs Jun 10 17:08:22 demoserver emhttp: Stop AVAHI... Jun 10 17:08:22 demoserver emhttp: shcmd (36): /etc/rc.d/rc.avahidaemon stop |& logger Jun 10 17:08:22 demoserver logger: Stopping Avahi mDNS/DNS-SD Daemon: stopped Jun 10 17:08:22 demoserver avahi-daemon[1411]: Got SIGTERM, quitting. Jun 10 17:08:22 demoserver avahi-dnsconfd[1421]: read(): EOF Jun 10 17:08:22 demoserver avahi-daemon[1411]: Leaving mDNS multicast group on interface eth0.IPv4 with address 10.0.1.10. Jun 10 17:08:22 demoserver avahi-daemon[1411]: avahi-daemon 0.6.31 exiting. Jun 10 17:08:23 demoserver emhttp: shcmd (37): /etc/rc.d/rc.avahidnsconfd stop |& logger Jun 10 17:08:23 demoserver logger: Stopping Avahi mDNS/DNS-SD DNS Server Configuration Daemon: stopped Jun 10 17:08:23 demoserver emhttp: shcmd (38): rm /etc/avahi/services/afp.service &> /dev/null Jun 10 17:08:23 demoserver emhttp: shcmd (39): rm /etc/avahi/services/smb.service &> /dev/null Jun 10 17:08:23 demoserver emhttp: Stop AFP... Jun 10 17:08:23 demoserver emhttp: shcmd (40): /etc/rc.d/rc.atalk stop |& logger Jun 10 17:08:23 demoserver emhttp: shcmd (41): ps axc | grep -q rpc.mountd Jun 10 17:08:23 demoserver emhttp: _shcmd: shcmd (41): exit status: 1 Jun 10 17:08:23 demoserver emhttp: Stop SMB... Jun 10 17:08:23 demoserver emhttp: shcmd (42): /etc/rc.d/rc.samba stop |& logger Jun 10 17:08:23 demoserver emhttp: Spinning up all drives... Jun 10 17:08:23 demoserver emhttp: Sync filesystems... Jun 10 17:08:23 demoserver emhttp: shcmd (43): sync Jun 10 17:08:23 demoserver kernel: mdcmd (22): spinup 0 Jun 10 17:08:23 demoserver kernel: mdcmd (23): spinup 1 Jun 10 17:08:26 demoserver emhttp: shcmd (44): /usr/local/sbin/emhttp_event unmounting_disks Jun 10 17:08:26 demoserver emhttp_event: unmounting_disks Jun 10 17:08:26 demoserver pms: Stopping Plex... Jun 10 17:08:29 demoserver emhttp: shcmd (45): set -o pipefail ; umount /mnt/user |& logger Jun 10 17:08:29 demoserver emhttp: shcmd (46): rmdir /mnt/user |& logger Jun 10 17:08:29 demoserver emhttp: shcmd (47): crontab -c /etc/cron.d -d &> /dev/null Jun 10 17:08:29 demoserver emhttp: Unmounting disks... Jun 10 17:08:29 demoserver emhttp: shcmd (48): umount /mnt/disk1 |& logger Jun 10 17:08:30 demoserver emhttp: shcmd (49): rmdir /mnt/disk1 |& logger Jun 10 17:08:30 demoserver emhttp: shcmd (50): /usr/local/sbin/emhttp_event stopping_array Jun 10 17:08:30 demoserver emhttp_event: stopping_array Jun 10 17:08:30 demoserver emhttp: shcmd (51): rmmod md-mod |& logger Jun 10 17:08:30 demoserver emhttp: shcmd (52): modprobe md-mod super=/boot/config/super.dat slots=3 |& logger Jun 10 17:08:30 demoserver kernel: mdcmd (24): stop Jun 10 17:08:30 demoserver kernel: md1: stopping Jun 10 17:08:30 demoserver kernel: md: unRAID driver removed Jun 10 17:08:30 demoserver emhttp: shcmd (53): udevadm settle Jun 10 17:08:30 demoserver emhttp: Device inventory: Jun 10 17:08:30 demoserver emhttp: Hitachi_HDS5C3030BLE630_MCE9215Q07UDGW (sdb) 2930266584 Jun 10 17:08:30 demoserver emhttp: Hitachi_HDS5C3030BLE630_MCM9215Q08S10X (sdc) 2930266584 Jun 10 17:08:30 demoserver kernel: md: unRAID driver 2.1.6 installed Jun 10 17:08:30 demoserver kernel: mdcmd (1): import 0 8,16 2930266532 Hitachi_HDS5C3030BLE630_MCE9215Q07UDGW Jun 10 17:08:30 demoserver kernel: md: import disk0: [8,16] (sdb) Hitachi_HDS5C3030BLE630_MCE9215Q07UDGW size: 2930266532 Jun 10 17:08:30 demoserver emhttp: shcmd (54): /usr/local/sbin/emhttp_event driver_loaded Jun 10 17:08:30 demoserver kernel: mdcmd (2): import 1 8,32 2930266532 Hitachi_HDS5C3030BLE630_MCM9215Q08S10X Jun 10 17:08:30 demoserver kernel: md: import disk1: [8,32] (sdc) Hitachi_HDS5C3030BLE630_MCM9215Q08S10X size: 2930266532 Jun 10 17:08:30 demoserver kernel: mdcmd (3): import 2 0,0 Jun 10 17:08:30 demoserver emhttp_event: driver_loaded Jun 10 17:08:30 demoserver emhttp: shcmd (55): /usr/local/sbin/emhttp_event stopped Jun 10 17:08:30 demoserver emhttp_event: stopped Jun 10 17:08:30 demoserver emhttp: shcmd (56): :>/etc/samba/smb-shares.conf Jun 10 17:08:30 demoserver emhttp: shcmd (57): cp /etc/netatalk/AppleVolumes.default- /etc/netatalk/AppleVolumes.default Jun 10 17:08:30 demoserver emhttp: Start SMB... Jun 10 17:08:30 demoserver emhttp: shcmd (58): /etc/rc.d/rc.samba start |& logger Jun 10 17:08:30 demoserver logger: Starting Samba: /usr/sbin/nmbd -D Jun 10 17:08:30 demoserver logger: /usr/sbin/smbd -D Jun 10 17:08:30 demoserver emhttp: shcmd (59): ps axc | grep -q rpc.mountd Jun 10 17:08:30 demoserver emhttp: _shcmd: shcmd (59): exit status: 1 Jun 10 17:08:30 demoserver emhttp: Start AVAHI... Jun 10 17:08:30 demoserver emhttp: shcmd (60): /etc/rc.d/rc.avahidaemon start |& logger Jun 10 17:08:30 demoserver logger: Starting Avahi mDNS/DNS-SD Daemon: /usr/sbin/avahi-daemon -D Jun 10 17:08:30 demoserver avahi-daemon[2190]: Found user 'avahi' (UID 61) and group 'avahi' (GID 214). Jun 10 17:08:30 demoserver avahi-daemon[2190]: Successfully dropped root privileges. Jun 10 17:08:30 demoserver avahi-daemon[2190]: avahi-daemon 0.6.31 starting up. Jun 10 17:08:30 demoserver avahi-daemon[2190]: WARNING: No NSS support for mDNS detected, consider installing nss-mdns! Jun 10 17:08:30 demoserver avahi-daemon[2190]: Successfully called chroot(). Jun 10 17:08:30 demoserver avahi-daemon[2190]: Successfully dropped remaining capabilities. Jun 10 17:08:30 demoserver avahi-daemon[2190]: No service file found in /etc/avahi/services. Jun 10 17:08:30 demoserver avahi-daemon[2190]: Joining mDNS multicast group on interface eth0.IPv4 with address 10.0.1.10. Jun 10 17:08:30 demoserver avahi-daemon[2190]: New relevant interface eth0.IPv4 for mDNS. Jun 10 17:08:30 demoserver avahi-daemon[2190]: Network interface enumeration completed. Jun 10 17:08:30 demoserver avahi-daemon[2190]: Registering new address record for 10.0.1.10 on eth0.IPv4. Jun 10 17:08:30 demoserver avahi-daemon[2190]: Registering HINFO record with values 'I686'/'LINUX'. Jun 10 17:08:30 demoserver emhttp: shcmd (61): /etc/rc.d/rc.avahidnsconfd start |& logger Jun 10 17:08:30 demoserver logger: Starting Avahi mDNS/DNS-SD DNS Server Configuration Daemon: /usr/sbin/avahi-dnsconfd -D Jun 10 17:08:30 demoserver avahi-dnsconfd[2199]: Successfully connected to Avahi daemon. In any case, the disks were mounted here Jun 10 17:08:38 demoserver emhttp_event: disks_mounted
June 12, 201313 yr Author I did the following things: - cleared all "Apple" files (.DS_Store, .AppleD*, .apdisk, Temporary Items, Network Trash Folder) - checked the array with reiserfsck (no errors found) - new permissions via utils page - deactivated all shares / plugins - restored the "go" file (thanks dgaschk) - finally did a parity check (no errors found) The array now mounts in regular speed. But i have still unknown reading/writing on the array. lsof looks normal and notifywait (-mr /mnt) shows nothing.
June 12, 201313 yr But i have still unknown reading/writing on the array. lsof looks normal and notifywait (-mr /mnt) shows nothing.Upgrade to RC14
June 13, 201313 yr Author Thank you all! I updated to rc14 and the read/write issues are gone. The array works fine! But the Plex plugin will still not work with its old configuration. If i reset the Plex config file, it starts with a new library and works. The old Path was: /mnt/disk1 Should i change the Plex Path? I read something in the Plex forums about that ( http://forums.plexapp.com/index.php/topic/65860-transport-endpoint-is-not-connected/ ).
Archived
This topic is now archived and is closed to further replies.