-----BEGIN PGP SIGNED MESSAGE----- Hash: SHA1 On Sunday, 2017-12-10 at 13:54 +0100, Paul Neuwirth wrote:

Hello group,

I have on several machines this problem: they are continously trying to=20 access the floppy drives. Two drives already defective, due to the=20 mechanic stress.

Try reversing the cable to the drive (pin 1 at the wrong side). At least that's what happened to mine... Now it apparently works.

dmesg shows following continously: [1537682.559487] sd 0:0:3:0: [sdc] Read Capacity(10) failed: Result:=20 hostbyte=3DDID_OK driverbyte=3DDRIVER_SENSE

That's not the floppy. It should be "/dev/fd0". Telcontar:~ # mount -v /mnt/floppy mount: /dev/fd0 is write-protected, mounting read-only mount: /dev/fd0 mounted on /mnt/floppy. Telcontar:~ # ls /mnt/floppy AUTOEXE2.BAT AUTOEXEC.BAT CONFIG.SYS EGA.CPI HIMEM.SYS IO.SYS KEYBOARD.SYS MODE.COM MSCDEX.EXE MSDOS.SYS PARTINFO.EXE PTEDIT.EXE command.com Telcontar:~ # - -- Cheers, Carlos E. R. (from openSUSE 42.2 x86_64 "Malachite" at Telcontar) -----BEGIN PGP SIGNATURE----- Version: GnuPG v2 iEYEARECAAYFAlotovUACgkQtTMYHG2NR9XTBQCeJawT2eWn81R+uF050o47vVRc 1E8Anj70/q0VBxQ5+3Rmu0vwhkthse9K =HWt3 -----END PGP SIGNATURE----- -- To unsubscribe, e-mail: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org

-----BEGIN PGP SIGNED MESSAGE----- Hash: SHA1 On Monday 2017-12-11 08:34, Paul Neuwirth wrote:

On Sunday 2017-12-10 22:11, Carlos E. R. wrote:

...

...

Hello group,

I have on several machines this problem: they are continously trying to=20 access the floppy drives. Two drives already defective, due to the=20 mechanic stress.

Try reversing the cable to the drive (pin 1 at the wrong side). At least that's what happened to mine... Now it apparently works.

The mainboard does not have a floppy controller, so I use an SCSI floppy drive, it is working with a floppy disk inserted.

...

...

dmesg shows following continously: [1537682.559487] sd 0:0:3:0: [sdc] Read Capacity(10) failed: Result:=20 hostbyte=3DDID_OK driverbyte=3DDRIVER_SENSE

That's not the floppy. It should be "/dev/fd0". Would be nice, to have this enumeration.. but does not work for SCSI and USB floppy disk drives, but it works for my optical and streamer device /dev/sr? / /dev/st?.

Telcontar:~ # mount -v /mnt/floppy mount: /dev/fd0 is write-protected, mounting read-only mount: /dev/fd0 mounted on /mnt/floppy. Telcontar:~ # ls /mnt/floppy AUTOEXE2.BAT AUTOEXEC.BAT CONFIG.SYS EGA.CPI HIMEM.SYS IO.SYS KEYBOARD.SYS MODE.COM MSCDEX.EXE MSDOS.SYS PARTINFO.EXE PTEDIT.EXE command.com

it is obviously udevd trying to access: 2017-12-11T08:40:23.514423+01:00 kappa systemd-udevd[7096]: seq 26005 '/devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc' is taking a long time 2017-12-11T08:41:03.700391+01:00 kappa kernel: [1605883.536057] ...............................................................................................not responding... 2017-12-11T08:41:03.752509+01:00 kappa kernel: [1605982.903509] sd 0:0:3:0: [sdc] Read Capacity(10) failed: Result: hostbyte=DID_OK driverbyte=DRIVER_SENSE 2017-12-11T08:41:03.752546+01:00 kappa kernel: [1605982.903514] sd 0:0:3:0: [sdc] Sense Key : Not Ready [current] 2017-12-11T08:41:03.752547+01:00 kappa kernel: [1605982.903516] sd 0:0:3:0: [sdc] Add. Sense: Logical unit not ready, cause not reportable 2017-12-11T08:41:03.852387+01:00 kappa kernel: [1605982.999717] sd 0:0:3:0: [sdc] Spinning up disk... 2017-12-11T08:42:23.514220+01:00 kappa systemd-udevd[7096]: seq 26005 '/devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc' killed -----BEGIN PGP SIGNATURE----- Version: GnuPG v2 Comment: Topal (http://freshmeat.net/projects/topal) iQIcBAEBAgAGBQJaLjddAAoJEIiaa+Y8YDPuBB8P/j/QrmFbsDROhTpzDeMTxsTz fWvvIA7mmER2HgApKIyUQ1Y3YXmh5uThAxGJE2Ya1nMEjRm1mR5qJ5fDbettJsiz wodsASjNbc0+TD5BTNLRjMdMMMRC1Dq1mLuUtD+DyMeQnxwpAAWxIzyaJMkiqJbi ZEvdkoCq9Mb5/7XtAavznQscgqvUyvScEq6FROr5caKX2KjMJhoI9Vy2Sv9EniDh /X1wvF215wUyZTcMUkUoFm5tdsGzjzxOZQqySLjGmyjpiBRdRbbKAPo/YWx3WKwy fb10fLpb+5A9aH9bbzjEEwkHQqz0oAU1k5tpU/AGXwYOQuuwWUMjip5ToYrsuRZH 5A7pPb+Y2U75kqsFyrHG4iw6nm7Wsw969e6gz/Y+cJ1oZ6Q3It6Ik/Oi4lv/fF++ +KSc4/n/jy3A/yd5xHTBbzEQtIjP7cEnGYe43/M596MW3qcLBfam8N+pRoGxx7cE c/gav7SbhiZGOWe9y3hu8o95o30zZknEiMTw6zWmi3igIY5AHQprvwuzxvLBrq8C 02vu+5B2hh6b0VLkUDMGJ1nKHiST+WZaA6B7ygcCadSJBEc0G9sPinI3lUGdpjmr X+mXDCAWrVzEU+WMP/zsRZJC73+W//jj/32ontFUpzvPf3YgUIY5cn+l3yffRwP2 5In8X7qd4+WAj27nmgky =IxJ9 -----END PGP SIGNATURE----- -- To unsubscribe, e-mail: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org

-----BEGIN PGP SIGNED MESSAGE----- Hash: SHA256 Content-ID: El 2017-12-11 a las 09:12 +0100, Per Jessen escribió:

Paul Neuwirth wrote:

...

...

...

Hello group,

I have on several machines this problem: they are continously trying to=20 access the floppy drives. Two drives already defective, due to the=20 mechanic stress.

Try reversing the cable to the drive (pin 1 at the wrong side). At least that's what happened to mine... Now it apparently works.

The mainboard does not have a floppy controller, so I use an SCSI floppy drive, it is working with a floppy disk inserted.

A SCSI floppy-drive? Wow, I don't remember ever seeing one of those.

Me neither, didn't even know they existed. over USB, yes, I knew, but never handled one. I suppose it is correctly connected inside. The cable plug has a protuberance impeding inserting inverted, but nevertheless, I have seen them connected inverted: some plugs did not have the notch. And turning continuously was typical of having the cable inverted. I can't think of anything else, and with scssi... no, no idea. - -- Cheers Carlos E. R. (from openSUSE 42.2 x86_64 "Malachite" (Minas Tirith)) -----BEGIN PGP SIGNATURE----- Version: GnuPG v2 iF4EAREIAAYFAlouSg8ACgkQja8UbcUWM1wqvgD8DPc1YPVAGBDrB5T3A4TODFQx uGp21iWugj5BQo8wA6cA/1DpkZvVncTnG9E9HQVAawR9OpSkDRBcA/z0sqceGHiY =Yrqr -----END PGP SIGNATURE-----

On Monday 2017-12-11 10:25, Felix Miata wrote:

Paul Neuwirth composed on 2017-12-10 13:54:57 (UTC+0100): ... Have you tried including broken.modules=floppy on kernel cmdline? I will try on next reboot, but i just tried modprobe floppy: [1702089.760122] floppy0: no floppy controllers found

-- To unsubscribe, e-mail: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org

On Sunday, 10 December 2017 12:54:57 GMT Paul Neuwirth wrote:

I have on several machines this problem: they are continously trying to=20 access the floppy drives. Two drives already defective, due to the=20 mechanic stress.

Could it be detecting a water leak and its a spin-dry cycle? :) -- opensuse:tumbleweed:20171206 Qt: 5.9.2 KDE Frameworks: 5.40.0 - KDE Plasma: 5.11.3 - kwin 5.11.3 kmail2 5.6.3 - akonadiserver 5.6.3 - Kernel: 4.14.3-1-default - xf86-video-nouveau: 1.0.15 -- To unsubscribe, e-mail: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org

On Tuesday 2017-12-12 19:31, Mark Hounschell wrote:

...

El 2017-12-11 a las 09:12 +0100, Per Jessen escribió:

...

Paul Neuwirth wrote:

...

...

...

 Hello group,

 I have on several machines this problem: they are continously  trying to=20 access the floppy drives. Two drives already  defective, due to the=20 mechanic stress.

Try reversing the cable to the drive (pin 1 at the wrong side). At least that's what happened to mine... Now it apparently works.

The mainboard does not have a floppy controller, so I use an SCSI floppy drive, it is working with a floppy disk inserted.

A SCSI floppy-drive?  Wow, I don't remember ever seeing one of those.

Me neither, didn't even know they existed. over USB, yes, I knew, but never handled one.

I've worked with SCSI floppies back in the early 90's. Not on PCs though. I doubt seriously that the Linux kernel knows how to handle these devices properly.

You say you have several machines doing this. Have you ever, on any Linux machine, actually been able to use these SCSI floppy drives?

Yes, it does work... one second... [1734685.977032] sd 0:0:3:0: [sdc] Spinning up disk... [1734686.988075] ...............................................................................................not responding... [1734786.379534] sd 0:0:3:0: [sdc] Read Capacity(10) failed: Result: hostbyte=DID_OK driverbyte=DRIVER_SENSE [1734786.379542] sd 0:0:3:0: [sdc] Sense Key : Not Ready [current] [1734786.379545] sd 0:0:3:0: [sdc] Add. Sense: Logical unit not ready, cause not reportable [1734786.476723] sd 0:0:3:0: [sdc] Spinning up disk... [1734787.488072] .............ready [1734800.372199] sd 0:0:3:0: [sdc] 2880 512-byte logical blocks: (1.47 MB/1.41 MiB) [1734800.373939] sd 0:0:3:0: [sdc] Write Protect is off [1734800.373944] sd 0:0:3:0: [sdc] Mode Sense: 37 88 00 08 [1734800.388515] sdc: detected capacity change from 0 to 1474560 [1734800.541066] sdc: # mount -t auto -vo ro /dev/sdc mnt mount: /dev/sdc mounted on /root/mnt. # mount /dev/sdc on /root/mnt type vfat (ro,relatime,fmask=0022,dmask=0022,codepage=437,iocharset=iso8859-1,shortname=mixed,errors=remount-ro) It is complete same behaviour also on USB floppy disk drives (those were the ones, which didn't survive. The SCSI floppy disk drive does not spin up without disk inserted. By the way I am looking for a cheap 5.25" SCSI FDD.. they exist, but are traded for horrific prices.. ;) without ISA and FDC I do not know how to get my old drives working..

On Tuesday 2017-12-12 22:06, Dave Howorth wrote:

Date: Tue, 12 Dec 2017 22:06:05 From: Dave Howorth To: opensuse@opensuse.org Subject: Re: [opensuse] continous access on/spinning up of floppy drive

On Tue, 12 Dec 2017 20:33:34 +0100 (CET) Paul Neuwirth wrote:

...

It is complete same behaviour also on USB floppy disk drives (those were the ones, which didn't survive. The SCSI floppy disk drive does not spin up without disk inserted. By the way I am looking for a cheap 5.25" SCSI FDD.. they exist, but are traded for horrific prices.. ;) without ISA and FDC I do not know how to get my old drives working..

I'm confused. I thought it was SCSI drives that were failing? Now they're working but USB drives are failing? Which is it? maybe, we got a bit off the topic. Problem are not non-working drives, but that udevd continuosly tries to access (spin up) drives, without disk inserted. That should'nt be so on any removable media drives. Also are some tasks slowed down, waiting for something udevd does, extreme example is calling yast bootloader.. which takes several (tens?) minutes.

The actual drives are the same regardless of the interface they are equipped with, no? So just buy any drive and fit your interface.

-- To unsubscribe, e-mail: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org

Per Jessen composed on 2017-12-13 07:25 (UTC+0100):

Paul Neuwirth wrote:

...

By the way I am looking for a cheap 5.25" SCSI FDD.. they exist, but are traded for horrific prices.. ;) without ISA and FDC I do not know how to get my old drives working..

Buy an old PC? Not necessarily that old, depending on your definition of "old". New PCs and motherboards at least as recently as 2009 were still shipping with ISA bus floppy controllers. Examples:

Socket LGA775 Intel: http://www.biostar.com.tw/app/en/mb/introduction.php?S_ID=413 https://www.ebay.com/itm/Gigabyte-GA-G41M-ES2L-Socket-LGA775-microATX-Mother... Also LGA775 Intel: https://www.newegg.com/Product/Product.aspx?Item=9SIAAYZ69W1755 http://downloads.dell.com/manuals/all-products/esuprt_desktop/esuprt_optiple... I have the last, with 3.5" floppy, though a SFF model in which a standard 5.25" floppy drive could not physically fit. -- "Wisdom is supreme; therefore get wisdom. Whatever else you get, get wisdom." Proverbs 4:7 (New Living Translation) Team OS/2 ** Reg. Linux User #211409 ** a11y rocks! Felix Miata *** http://fm.no-ip.com/ -- To unsubscribe, e-mail: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org

Op woensdag 13 december 2017 08:25:22 CET schreef Felix Miata:

Per Jessen composed on 2017-12-13 07:25 (UTC+0100):

...

Paul Neuwirth wrote:

...

By the way I am looking for a cheap 5.25" SCSI FDD.. they exist, but are traded for horrific prices.. ;) without ISA and FDC I do not know how to get my old drives working..

Buy an old PC?

Not necessarily that old, depending on your definition of "old". New PCs and motherboards at least as recently as 2009 were still shipping with ISA bus floppy controllers. Examples:

Socket LGA775 Intel: http://www.biostar.com.tw/app/en/mb/introduction.php?S_ID=413

<https://www.ebay.com/itm/Gigabyte-GA-G41M-ES2L-Socket-LGA775-microATX-Mothe rboard-Perfect-Condition/332484364593>

Also LGA775 Intel: https://www.newegg.com/Product/Product.aspx?Item=9SIAAYZ69W1755 <http://downloads.dell.com/manuals/all-products/esuprt_desktop/esuprt_optipl ex_desktop/optiplex-760_service%20manual_en-us.pdf>

I have the last, with 3.5" floppy, though a SFF model in which a standard 5.25" floppy drive could not physically fit.

Don't know about Paul, but in my perception 2009 is old. My "old" server/ workstation is from 2008, motherboard has a floppy connector, but the case allows either a floppy drive or a CD/DVD device. ( and 6 disks ). -- Gertjan Lettink, a.k.a. Knurpht openSUSE Board Member openSUSE Forums Team -- To unsubscribe, e-mail: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org

On Wednesday 2017-12-13 09:52, Knurpht - Gertjan Lettink wrote:

Date: Wed, 13 Dec 2017 09:52:19 From: Knurpht - Gertjan Lettink To: opensuse@opensuse.org Subject: Re: [opensuse] continous access on/spinning up of floppy drive

Op woensdag 13 december 2017 08:51:28 CET schreef Per Jessen:

...

Felix Miata wrote:

...

Per Jessen composed on 2017-12-13 07:25 (UTC+0100):

...

Paul Neuwirth wrote:

...

By the way I am looking for a cheap 5.25" SCSI FDD.. they exist, but are traded for horrific prices.. ;) without ISA and FDC I do not know how to get my old drives working..

Buy an old PC?

Not necessarily that old, depending on your definition of "old". New PCs and motherboards at least as recently as 2009 were still shipping

...

with ISA bus floppy controllers. Examples: I tend to think "old" once they're less than SFr100 on ebay/ricardo.

...

<http://downloads.dell.com/manuals/all-products/esuprt_desktop/esuprt_optip lex_desktop/optiplex-760_service%20manual_en-us.pdf>> I have the last, with 3.5" floppy, though a SFF model in which a standard 5.25" floppy drive could not physically fit.

We have recently begun upgrading office PCs to Lenovo S10 - they also have an FDD interface, as well as the slots for a 3.5" or 5.25" floppy drive. Mind you, the fdd interface is blocked by the graphics card :-)

ROTFL, same for my server/workstation. So, NVIDIA card out, CD/DVD device out and I could have a floppy drive. Sorry to say so, but I see absolutely no reason to return to such media.

thinner, lighter than optical disks.. and data theft prevention ;) -- To unsubscribe, e-mail: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org

On 12/11/2017 08:44 AM, Paul Neuwirth wrote:

it is obviously udevd trying to access:

A bit OT: I'm using another harddrive for backups, and that is a bit loud. To avoid that udevd is spinning it up every 5 minutes, I just remove /dev/sdc after boot, and have created a device file for it in some other place which I can use (mount,rsync,umount,hdparm -y) in my backup scripts. ;-) Have a nice day, Berny -- To unsubscribe, e-mail: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org

On Wednesday 2017-12-13 12:10, Werner Flamme wrote:

Knurpht - Gertjan Lettink [13.12.2017 10:34]:

...

And, data theft ? Please elaborate ...

Who can use those floppy disks? About no one. So why should one steal them? Only to bring them into a museum? :)

an almost secret way to transport (unencrypted) secret keys.. -- To unsubscribe, e-mail: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org

-----BEGIN PGP SIGNED MESSAGE----- Hash: SHA1 On Wednesday, 2017-12-13 at 02:25 -0500, Felix Miata wrote:

Per Jessen composed on 2017-12-13 07:25 (UTC+0100):

...

Paul Neuwirth wrote:

...

...

By the way I am looking for a cheap 5.25" SCSI FDD.. they exist, but are traded for horrific prices.. ;) without ISA and FDC I do not know how to get my old drives working..

...

Buy an old PC? Not necessarily that old, depending on your definition of "old". New PCs and motherboards at least as recently as 2009 were still shipping with ISA bus floppy controllers. Examples:

My desktop machine has a floppy drive, I installed it just in case I want to inspect and retrieve some data from old floppies I have. I still have some old backups made in floppies which I wish to retrieve one day. The bay would accept a 5¼" drive (same size as cdrom drive, but of course, I have a 3½ only. - -- Cheers, Carlos E. R. (from openSUSE 42.2 x86_64 "Malachite" at Telcontar) -----BEGIN PGP SIGNATURE----- Version: GnuPG v2 iEYEARECAAYFAloxIKYACgkQtTMYHG2NR9VfZQCfWb6pNd3/GpK9qHFzDOLm/9ch +gsAniqSQX49hyXbRgwf+4b6BXV1Ylks =MHke -----END PGP SIGNATURE-----

Carlos E. R. wrote:

On Wednesday, 2017-12-13 at 02:25 -0500, Felix Miata wrote:

...

Per Jessen composed on 2017-12-13 07:25 (UTC+0100):

...

Paul Neuwirth wrote:

...

...

By the way I am looking for a cheap 5.25" SCSI FDD.. they exist, but are traded for horrific prices.. ;) without ISA and FDC I do not know how to get my old drives working..

...

Buy an old PC? Not necessarily that old, depending on your definition of "old". New PCs and motherboards at least as recently as 2009 were still shipping with ISA bus floppy controllers. Examples:

My desktop machine has a floppy drive, I installed it just in case I want to inspect and retrieve some data from old floppies I have.

I still have some old backups made in floppies which I wish to retrieve one day.

I would make dd copies of those whilst you can - floppy disks don't last. -- Per Jessen, Zürich (2.6°C) http://www.dns24.ch/ - your free DNS host, made in Switzerland. -- To unsubscribe, e-mail: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org

On 12/13/2017 09:07 AM, Carlos E. R. wrote:

dd is no good with them, they have to be restored with proprietary software (PC tools backup) in a suitable machine. Which is why it is such a nuisance that I balkout at the idea.

I thought dd copied sectors, regardless of the format. You should still be able to back up the disks and restore to another floppy. -- To unsubscribe, e-mail: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org

Carlos E. R. wrote:

On Wednesday, 2017-12-13 at 14:47 +0100, Per Jessen wrote:

...

Carlos E. R. wrote:

...

...

My desktop machine has a floppy drive, I installed it just in case I want to inspect and retrieve some data from old floppies I have.

I still have some old backups made in floppies which I wish to retrieve one day.

I would make dd copies of those whilst you can - floppy disks don't last.

That's my intention.

These are good quality disks, not the filth they sold on later days. I tried a decade ago and they were good.

dd is no good with them, they have to be restored with proprietary software (PC tools backup) in a suitable machine. Which is why it is such a nuisance that I balkout at the idea.

dd would be fine for creating the binary sector-by-sector copy that will outlive the floppy itself. What you need to actually read your backup is a different matter. -- Per Jessen, Zürich (2.7°C) http://www.cloudsuisse.com/ - your owncloud, hosted in Switzerland. -- To unsubscribe, e-mail: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org

On Fri, 15 Dec 2017 02:38:32 +0000 Paul Groves wrote:

Experiencing the same problem on openSUSE and Ubuntu

On 10/12/17 13:42, James Knott wrote:

...

On 12/10/2017 07:54 AM, Paul Neuwirth wrote:

...

I have on several machines this problem: they are continously trying to=20 access the floppy drives. Two drives already defective, due to the=20 mechanic stress.

May or may not be available / practical to you but: I have one old machine still with a floppy and had that spin-up issue. The machine is an old HP and there is an option in the BIOS to 'hide (device) from OS'. The floppy was one of those 'device' options. 'Hiding' the floppy from the OS solved the problem. Of course, if I need the floppy I need to reboot and re-enable in the BIOS but that is not a frequent problem, to say the least. Ralph -- To unsubscribe, e-mail: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org

On Thu, 14 Dec 2017 23:12:11 -0500 Felix Miata wrote:

listreader composed on 2017-12-14 21:51 (UTC-0600):

...

May or may not be available / practical to you but: I have one old machine still with a floppy and had that spin-up issue. The machine is an old HP and there is an option in the BIOS to 'hide (device) from OS'. The floppy was one of those 'device' options. 'Hiding' the floppy from the OS solved the problem. Of course, if I need the floppy I need to reboot and re-enable in the BIOS but that is not a frequent problem, to say the least.

I started doing that on several machines when in TW@13.2 I discovered this: https://bugzilla.opensuse.org/show_bug.cgi?id=916773 "unexpected fd0/floppy messages on tty[1-6]"

Two+ years ago and ticket still open. Bugs involving old hardware are doomed. Ralph -- To unsubscribe, e-mail: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org

-----BEGIN PGP SIGNED MESSAGE----- Hash: SHA1 Hi carlos, for non standart disks you could use this hardware/software solution here (at least in my opinion for private use not to expensive): https://www.kryoflux.com/?page=home and by the way, i own disks from 1986 they work still pretty fine :-))) simoN Am 13.12.2017 um 15:07 schrieb Carlos E. R.:

On Wednesday, 2017-12-13 at 14:47 +0100, Per Jessen wrote:

...

Carlos E. R. wrote:

...

...

My desktop machine has a floppy drive, I installed it just in case I want to inspect and retrieve some data from old floppies I have.

I still have some old backups made in floppies which I wish to retrieve one day.

...

I would make dd copies of those whilst you can - floppy disks don't last.

That's my intention.

These are good quality disks, not the filth they sold on later days. I tried a decade ago and they were good.

dd is no good with them, they have to be restored with proprietary software (PC tools backup) in a suitable machine. Which is why it is such a nuisance that I balkout at the idea.

-- Cheers, Carlos E. R. (from openSUSE 42.2 x86_64 "Malachite" at Telcontar)

- -- B e c h e r e r GmbH Sondermaschinenbau Mauermatten Strasse 22 79183 Waldkirch Germany Tel.: (+49) (0)7681 3134 Fax: (+49) (0)7681 4378 Mail: info@becherer.de Web: www.becherer.de USt-ID-Nr.: DE 814912198 Registergericht: Freiburg HRB 701860 Geschäftsführer: Dipl.-Ing. (FH), EWE Simon H. Becherer Gerichtsstand / Sitz: Waldkirch Es gelten ausschließlich unsere allgemeinen Liefer- und Zahlungsbedingungen / Einkaufsbedingungen: www.becherer.de/AGB -----BEGIN PGP SIGNATURE----- Version: GnuPG v2.0.19 (GNU/Linux) iQIcBAEBAgAGBQJaNAnZAAoJEOuDxDCJWQG+PGUP/2SlS3gYt2ZcFgz+0A+C/pC9 NkoPuPZsslFdg/sK+6pQnmFGkIJHx5P89VB4T9VLvAWLEvii0AI0Po9yWK1zaYhm kv4oMjK3MIerl0B8Hv/CWBLEBjjCxlS9xQCvmb5OcyS6646rrUSLGiMi4IGQSTp4 6fIstRDEXD+QrdeMnom5uxHnchMZ2RnLXZeZJ/GcrjuSKwCy4YsvCEocC4DX/ymx QXGfkURZiZX3Uq2H5RGRgN1vxdOqbrZO9BGgzhKkvRXS1mMPOszUoRBmUn0xhEwq C4CDmMDfDhM3m+NH2ND4N8pGS8f/S6IQnaPeHeTHg9z9ML+Mo6ZnyhJgwRxz3bdI 6AGdKfDkpqf48GqiBnODh64RARnqi9C5Xqjd11nMmH5hRLUcziCtk9vFsAoulGvd EHpZ/jLxNvbGr8lOpl9fLJ6vatqDgRVKzlbjLN9BnSYtwNS6wEcXuzmmRHFnwicB 89FN270h3loJ+ozW8GhulGpEw3FPvCZ/QiDKimDrvORQfg/gENWPerGK3XJaKvR+ XScVsXzSdkE2/VSnWXSHjsf+E6NFb4mttfbFFZ/GKKZ8sGLubnF1DwCD6QXbwbbq GwVxghZse+JODCBSz7u0Vv3UURt9hKTnWsAj8zicZRW/z3tvXy3E15XBnZfSS/ph ENuytdCgOeivVjhXobUf =2f6X -----END PGP SIGNATURE----- -- To unsubscribe, e-mail: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org

-----BEGIN PGP SIGNED MESSAGE----- Hash: SHA1 On Friday, 2017-12-15 at 18:43 +0100, Simon Becherer wrote:

Hi carlos,

for non standart disks you could use this hardware/software solution here (at least in my opinion for private use not to expensive):

https://www.kryoflux.com/?page=home

A bit overkill :-) I simply hope to set a table with my old computer, retrieve each backup/archive, transfer to main computer somehow, delete archive on old computer, retrieve another archive. Just time consuming, but no big deal, I hope. My archives need the same proprietary software as used to create, to restore them.

and by the way, i own disks from 1986 they work still pretty fine :-)))

Me too :-) - -- Cheers, Carlos E. R. (from openSUSE 42.2 x86_64 "Malachite" at Telcontar) -----BEGIN PGP SIGNATURE----- Version: GnuPG v2 iEYEARECAAYFAlo0E24ACgkQtTMYHG2NR9WAkQCcDdRCFWM7XXcwQ/yDqZdBrHJd 5BwAn3RCF9gRTU7uxToh3ToMBhJxKN3H =80g3 -----END PGP SIGNATURE----- -- To unsubscribe, e-mail: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org

On 12/10/2017 06:54 AM, Paul Neuwirth wrote:

I have on several machines this problem: they are continously trying to=20 access the floppy drives. Two drives already defective, due to the=20 mechanic stress.

dmesg shows following continously: [1537682.559487] sd 0:0:3:0: [sdc] Read Capacity(10) failed: Result:=20 hostbyte=3DDID_OK driverbyte=3DDRIVER_SENSE [1537682.559496] sd 0:0:3:0: [sdc] Sense Key : Not Ready [current] [1537682.559498] sd 0:0:3:0: [sdc] Add. Sense: Logical unit not ready,=20 cause not reportable [1537682.656688] sd 0:0:3:0: [sdc] Spinning up disk... [1537683.668046]=20

I have noticed this as well in recent kernels. I posted to Arch about it (along with other issues) and didn't get a specific answer. With the 4.13.3 kernel I begin seeing: Oct 04 14:28:43 phoinix kernel: print_req_error: I/O error, dev fd0, sector 0 Oct 04 14:28:43 phoinix kernel: floppy: error 10 while reading block 0 Oct 04 14:28:43 phoinix kernel: print_req_error: I/O error, dev fd0, sector 0 Oct 04 14:28:43 phoinix kernel: floppy: error 10 while reading block 0 It continues to this day: $ jcnl -b | grep fd0 Dec 13 20:39:09 phoinix kernel: Floppy drive(s): fd0 is 1.44M Dec 13 20:39:09 phoinix kernel: print_req_error: I/O error, dev fd0, sector 0 Dec 13 20:39:09 phoinix kernel: print_req_error: I/O error, dev fd0, sector 0 Just dunno... I like my floppy, it secure :) -- David C. Rankin, J.D.,P.E. -- To unsubscribe, e-mail: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org

On 15/12/17 17:45, Knurpht - Gertjan Lettink wrote:

Op vrijdag 15 december 2017 18:39:55 CET schreef Paul Groves:

...

I have one of these; https://youtu.be/M8qk1WCbvag

It works great and I can read and write my 1.44MB 1MB and 720k floppies.

But on linux, the floppy drive is continuously trying to read all the time making annoying tick, tick, tick sounds. So I have to leave a disk in all the time.

On windows however it works flawlessly. So there is a big in linux of course.

Now the floppy drive is detected as /dev/sdc could this be an indication of the problem?

Although when I use an el-cheapo external USB drive the drive works fine. (And is also /dev/sdc).

I notice that when booting up, the drive is fine in the BIOS and also in grub. As soon as the kernel is loaded the problem starts. Perhaps it is the floppy module not loaded or missing?

Can anyone explain?

Check with lsmod | grep floppy whether the driver is loaded.

lsmod | grep floppy Returns nothing modprobe -v floppy insmod /lib/modules/4.13.0-19-generic/kernel/drivers/block/floppy.ko modprobe: ERROR: could not insert 'floppy': No such device Erm..? There is a floppy drive though. What have I done wrong? -- To unsubscribe, e-mail: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org

-----BEGIN PGP SIGNED MESSAGE----- Hash: SHA1 On Wednesday, 2017-12-20 at 16:23 +0100, Per Jessen wrote:

Paul Groves wrote:

...

lsmod | grep floppy

Returns nothing

modprobe -v floppy insmod /lib/modules/4.13.0-19-generic/kernel/drivers/block/floppy.ko modprobe: ERROR: could not insert 'floppy': No such device

Erm..? There is a floppy drive though.

I might be mistaken, but I think 'floppy' is for a real floppy, not a USB floppy. (didn't you say yours is hooked up via USB?)

Yes, you are correct. - -- Cheers, Carlos E. R. (from openSUSE 42.2 x86_64 "Malachite" at Telcontar) -----BEGIN PGP SIGNATURE----- Version: GnuPG v2 iEYEARECAAYFAlo6ncIACgkQtTMYHG2NR9UFngCeOd4jKDniUWInkyqbWXuv8ud+ emoAoIUFSkAd+XaTToEsChA5D+XYPO4u =NtaD -----END PGP SIGNATURE----- -- To unsubscribe, e-mail: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org

Bernhard Voelker wrote:

On 12/11/2017 08:44 AM, Paul Neuwirth wrote:

...

it is obviously udevd trying to access:

A bit OT: I'm using another harddrive for backups, and that is a bit loud. To avoid that udevd is spinning it up every 5 minutes, I just remove /dev/sdc after boot, and have created a device file for it in some other place which I can use (mount,rsync,umount,hdparm -y) in my backup scripts. ;-)

Have a nice day, Berny

Wouldn't a line like hdparm -S 60 /dev/sdc in hdparm.conf be simpler? Switches the drive off after 5 min. So long! -- To unsubscribe, e-mail: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org

-----BEGIN PGP SIGNED MESSAGE----- Hash: SHA1 On Saturday, 2017-12-23 at 14:51 -0000, Paul Groves wrote: ...

The drive is ticking all the time with the LED flashing. I am worried this is going to wear the drive out. It is old after all.

It is a Linux problem because when I boot to windows 7 the drive operated normally. In ubuntu or opensuse the drive is continuously being read all the time. The only way to stop it is to put in a floppy disk but this is not a solution to the problem.

Well, you should report this in Bugzilla. - -- Cheers, Carlos E. R. (from openSUSE 42.2 x86_64 "Malachite" at Telcontar) -----BEGIN PGP SIGNATURE----- Version: GnuPG v2 iEYEARECAAYFAlo+1moACgkQtTMYHG2NR9XUegCeP3g/zpvI57AmOrrgQdKfGe83 /3cAniysL/wOeOD9dBJQsYtDc8+b8DvD =tg/a -----END PGP SIGNATURE----- -- To unsubscribe, e-mail: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org

-----BEGIN PGP SIGNED MESSAGE----- Hash: SHA1 On Wed, 13 Dec 2017 13:53:33 +0100 (CET) "Carlos E. R." wrote:

I see udev trying, then kernel failing. :-?

Did you try login in a different desktop? Perhaps close the graphical session, and try in text mode?

Enter a line in fstab for the floppy, no-auto?

unfortunately that did not work. is there a possibility to create an udev rule, making udev not to try accessing? lsscsi -lvi [0:0:3:0] disk TEAC FC-5 HGF 00 RV D /dev/sdc - state=running queue_depth=2 scsi_level=2 type=0 device_blocked=0 timeout=30 dir: /sys/bus/scsi/devices/0:0:3:0 [/sys/devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0] -----BEGIN PGP SIGNATURE----- Version: GnuPG v2 iQIcBAEBAgAGBQJaTLUWAAoJEIiaa+Y8YDPu5CUQALLXfaQL5X73szFXpTJzFQQk u6odr61juzJtTieGzBt32reXUZJFUw4Kik6LhPOYfJVb3gow8nGV3VNidNI9l2xW c9OsbnJFB53ZRO3ggGAjmXfg6ifqY2SMWgQsHPmHYNw6JzSXw2B4f0DV79MljwP9 5iJ5ir3Jr9sVzg1eMqbCk6Yxo7qsbXIxysxw7b11UmIeHz/aTCXk4BUe4gDVU7Iv Bz35YYIJfwydjG+n1UbaCGPMxSCN5ziPxz+pj3hrHcnZ6I3uQUeBEQzPzSCT8Fos GCw8DXhNH4XD6CIFjQkR3Q5GwLIRdNQt7LEACnUnUsB514/f33Dz0IP2Q6dzz+0+ cunUD9MS3pTRHqhc/Hderx+R0plsIubwmFRV7jMKiVjgZBGZxFeQqm2YwjuoFrbY 6VTtOcdiQBQuXe23BVKdEOoamnkCyfTUzReoezre37R3kVhubYzAOSGbX6gVow0k U7uk3C6nb3AAljkmPRIHPSSfiPfBVGD7LoN4N50wv0eYd96Fb3ofHIqOP/yQAbv9 +pfWYFYsxWLNQwshRyc3ay+no1eA+NvUvDIA876tKuX9PfZ5RmV4gHq5Kykx1nCu Vfm8EbiLByZL+V0AzRSXMkLGjSKvlHFISz/RvzwqSjiqmmyhLuy2rqIGSMM8sqHG vnSK8dYozQYwVCMPBl+y =1LhW -----END PGP SIGNATURE-----

03.01.2018 13:48, Paul Neuwirth пишет:

On Wed, 13 Dec 2017 13:53:33 +0100 (CET) "Carlos E. R." wrote:

...

I see udev trying, then kernel failing. :-?

...

Did you try login in a different desktop? Perhaps close the graphical session, and try in text mode?

...

Enter a line in fstab for the floppy, no-auto?

unfortunately that did not work.

is there a possibility to create an udev rule, making udev not to try accessing?

I looked through this thread and I miss any prove that it is udev that continuously tries to access disk. There is log of single access attempt that could be interpreted as if access was caused by udev which is more or less normal - udev attempts to query SCSI device initially. Please upload full log after boot (journalctl -b) that shows *multiple* attempts to access drive, so that at least timing between them is known. I have my theory but I'd rather wait for facts.

On Wed, 3 Jan 2018 14:03:51 +0300 Andrei Borzenkov wrote:

03.01.2018 13:48, Paul Neuwirth пишет:

...

On Wed, 13 Dec 2017 13:53:33 +0100 (CET) "Carlos E. R." wrote:

...

I see udev trying, then kernel failing. :-?

...

Did you try login in a different desktop? Perhaps close the graphical session, and try in text mode?

...

Enter a line in fstab for the floppy, no-auto?

unfortunately that did not work.

is there a possibility to create an udev rule, making udev not to try accessing?

I looked through this thread and I miss any prove that it is udev that continuously tries to access disk. There is log of single access attempt that could be interpreted as if access was caused by udev which is more or less normal - udev attempts to query SCSI device initially.

Please upload full log after boot (journalctl -b) that shows *multiple* attempts to access drive, so that at least timing between them is known. I have my theory but I'd rather wait for facts.

Thank you for the help. I found out, that from time of creation of devices or loading the kernel module of the scsi controller, the drive gets accessed until a floppy gets inserted. to speed up boot process, on current boot I inserted a (blank) floppy. after boot process continued I removed the floppy. I had other issues (network) at this boot. On next "clean" boot I could provide a full log. The most relevant part of journalctl -b: Dez 29 18:27:28 linux-7qz0 kernel: scsi host0: Adaptec AIC7XXX EISA/VLB/PCI SCSI HBA DRIVER, Rev 7.0 aic7860: Ultra Single Channel A, SCSI Id=7, 3/253 SCBs Dez 29 18:27:28 linux-7qz0 kernel: scsi 0:0:0:0: Processor HP C7670A 3945 PQ: 0 ANSI: 2 Dez 29 18:27:28 linux-7qz0 kernel: scsi target0:0:0: Beginning Domain Validation Dez 29 18:27:28 linux-7qz0 kernel: scsi target0:0:0: Ending Domain Validation Dez 29 18:27:28 linux-7qz0 kernel: scsi 0:0:0:0: Attached scsi generic sg3 type 3 Dez 29 18:27:28 linux-7qz0 kernel: scsi 0:0:3:0: Direct-Access TEAC FC-5 HGF 00 RV D PQ: 0 ANSI: 1 CCS Dez 29 18:27:28 linux-7qz0 kernel: scsi target0:0:3: Beginning Domain Validation Dez 29 18:27:28 linux-7qz0 kernel: scsi target0:0:3: Ending Domain Validation Dez 29 18:27:28 linux-7qz0 kernel: sd 0:0:3:0: Attached scsi generic sg4 type 0 Dez 29 18:27:28 linux-7qz0 kernel: sd 0:0:3:0: Power-on or device reset occurred Dez 29 18:27:28 linux-7qz0 kernel: sd 0:0:3:0: [sdc] Spinning up disk... Dez 29 18:27:29 linux-7qz0 kernel: scsi 0:0:5:0: Sequential-Access Seagate STT20000N 7.30 PQ: 0 ANSI: 2 Dez 29 18:27:29 linux-7qz0 kernel: scsi target0:0:5: Beginning Domain Validation Dez 29 18:27:29 linux-7qz0 kernel: scsi target0:0:5: FAST-10 SCSI 10.0 MB/s ST (100 ns, offset 15) Dez 29 18:27:29 linux-7qz0 kernel: scsi target0:0:5: Domain Validation skipping write tests Dez 29 18:27:29 linux-7qz0 kernel: scsi target0:0:5: Ending Domain Validation Dez 29 18:27:29 linux-7qz0 kernel: scsi 0:0:5:0: Attached scsi generic sg5 type 1 Dez 29 18:27:29 linux-7qz0 kernel: ACPI: PCI Interrupt Link [APC4] enabled at IRQ 19 Dez 29 18:27:29 linux-7qz0 kernel: firewire_ohci 0000:01:08.0: added OHCI v1.10 device as card 0, 4 IR + 8 IT contexts, quirks 0x11 Dez 29 18:27:30 linux-7qz0 kernel: . Dez 29 18:27:30 linux-7qz0 kernel: firewire_core 0000:01:08.0: created device fw0: GUID 00016c20008dc5ce, S400 Dez 29 18:27:41 linux-7qz0 kernel: ........... Dez 29 18:27:41 linux-7qz0 kernel: usb 1-4: new high-speed USB device number 4 using ehci-pci Dez 29 18:27:41 linux-7qz0 kernel: usb 1-4: New USB device found, idVendor=1f75, idProduct=0611 Dez 29 18:27:41 linux-7qz0 kernel: usb 1-4: New USB device strings: Mfr=4, Product=5, SerialNumber=6 Dez 29 18:27:41 linux-7qz0 kernel: usb 1-4: SerialNumber: 20160327 Dez 29 18:27:46 linux-7qz0 systemd-udevd[209]: giving up waiting for workers to finish Dez 29 18:27:46 linux-7qz0 systemd-udevd[209]: event loop failed: Connection timed out Dez 29 18:27:46 linux-7qz0 systemd[1]: systemd-udevd.service: Main process exited, code=exited, status=1/FAILURE Dez 29 18:28:44 linux-7qz0 kernel: ............................................................ready "ready" means disk inserted.. then it kept quiet until I reloaded kernel module aic7xxx: Jan 03 11:25:27 kappa kernel: scsi host0: Adaptec AIC7XXX EISA/VLB/PCI SCSI HBA DRIVER, Rev 7.0 aic7860: Ultra Single Channel A, SCSI Id=7, 3/253 SCBs Jan 03 11:25:27 kappa kernel: scsi 0:0:0:0: Processor HP C7670A 3945 PQ: 0 ANSI: 2 Jan 03 11:25:27 kappa kernel: scsi target0:0:0: Beginning Domain Validation Jan 03 11:25:27 kappa kernel: scsi target0:0:0: Ending Domain Validation Jan 03 11:25:27 kappa kernel: scsi 0:0:0:0: Attached scsi generic sg3 type 3 Jan 03 11:25:27 kappa kernel: scsi 0:0:3:0: Direct-Access TEAC FC-5 HGF 00 RV D PQ: 0 ANSI: 1 CCS Jan 03 11:25:27 kappa kernel: scsi target0:0:3: Beginning Domain Validation Jan 03 11:25:27 kappa kernel: scsi target0:0:3: Ending Domain Validation Jan 03 11:25:27 kappa kernel: sd 0:0:3:0: Attached scsi generic sg4 type 0 Jan 03 11:25:27 kappa kernel: sd 0:0:3:0: Power-on or device reset occurred Jan 03 11:25:27 kappa kernel: sd 0:0:3:0: [sdc] Spinning up disk... Jan 03 11:25:27 kappa kernel: scsi 0:0:4:0: Scanner Nikon LS-2000 1.31 PQ: 0 ANSI: 2 Jan 03 11:25:27 kappa kernel: scsi target0:0:4: Beginning Domain Validation Jan 03 11:25:27 kappa kernel: scsi target0:0:4: Ending Domain Validation Jan 03 11:25:27 kappa kernel: scsi 0:0:4:0: Attached scsi generic sg5 type 6 Jan 03 11:25:27 kappa kernel: scsi 0:0:5:0: Sequential-Access Seagate STT20000N 7.30 PQ: 0 ANSI: 2 Jan 03 11:25:27 kappa kernel: scsi target0:0:5: Beginning Domain Validation Jan 03 11:25:27 kappa kernel: scsi target0:0:5: FAST-10 SCSI 10.0 MB/s ST (100 ns, offset 15) Jan 03 11:25:27 kappa kernel: scsi target0:0:5: Domain Validation skipping write tests Jan 03 11:25:27 kappa kernel: scsi target0:0:5: Ending Domain Validation Jan 03 11:25:27 kappa kernel: st 0:0:5:0: Attached scsi tape st0 Jan 03 11:25:27 kappa kernel: st 0:0:5:0: st0: try direct i/o: yes (alignment 4 B) Jan 03 11:25:27 kappa kernel: st 0:0:5:0: Attached scsi generic sg7 type 1 Jan 03 11:27:08 kappa kernel: ...............................................................................................not responding... Jan 03 11:27:08 kappa kernel: sd 0:0:3:0: [sdc] Read Capacity(10) failed: Result: hostbyte=DID_OK driverbyte=DRIVER_SENSE Jan 03 11:27:08 kappa kernel: sd 0:0:3:0: [sdc] Sense Key : Not Ready [current] Jan 03 11:27:08 kappa kernel: sd 0:0:3:0: [sdc] Add. Sense: Logical unit not ready, cause not reportable Jan 03 11:27:08 kappa kernel: sd 0:0:3:0: [sdc] Write Protect is on Jan 03 11:27:08 kappa kernel: sd 0:0:3:0: [sdc] Mode Sense: 37 88 80 08 Jan 03 11:27:08 kappa kernel: sd 0:0:3:0: [sdc] Asking for cache data failed Jan 03 11:27:08 kappa kernel: sd 0:0:3:0: [sdc] Assuming drive cache: write through Jan 03 11:27:08 kappa kernel: sd 0:0:3:0: [sdc] Spinning up disk... Jan 03 11:27:08 kappa kernel: sd 0:0:3:0: [sdc] Spinning up disk... Jan 03 11:27:09 kappa kernel: . Jan 03 11:27:09 kappa kernel: . Jan 03 11:27:10 kappa kernel: . Jan 03 11:27:10 kappa kernel: . Jan 03 11:27:11 kappa kernel: . Jan 03 11:27:11 kappa kernel: . Jan 03 11:27:12 kappa kernel: . Jan 03 11:27:12 kappa kernel: . Jan 03 11:27:13 kappa kernel: . Jan 03 11:27:13 kappa kernel: . Jan 03 11:27:14 kappa kernel: . Jan 03 11:27:14 kappa kernel: . Jan 03 11:27:15 kappa kernel: . Jan 03 11:27:15 kappa kernel: . Jan 03 11:27:16 kappa kernel: . Jan 03 11:27:16 kappa kernel: . Jan 03 11:27:17 kappa kernel: . Jan 03 11:27:17 kappa kernel: . Jan 03 11:27:19 kappa kernel: . Jan 03 11:27:19 kappa kernel: . Jan 03 11:27:20 kappa kernel: . Jan 03 11:27:20 kappa kernel: . Jan 03 11:27:21 kappa kernel: . Jan 03 11:27:21 kappa kernel: . Jan 03 11:27:22 kappa kernel: . Jan 03 11:27:22 kappa kernel: . Jan 03 11:27:23 kappa kernel: . Jan 03 11:27:23 kappa kernel: . Jan 03 11:27:24 kappa kernel: . Jan 03 11:27:24 kappa kernel: . Jan 03 11:27:25 kappa kernel: . Jan 03 11:27:25 kappa kernel: . Jan 03 11:27:26 kappa kernel: . Jan 03 11:27:26 kappa kernel: . Jan 03 11:27:27 kappa kernel: . Jan 03 11:27:27 kappa kernel: . Jan 03 11:27:28 kappa kernel: . Jan 03 11:27:28 kappa kernel: . Jan 03 11:27:29 kappa kernel: . Jan 03 11:27:29 kappa kernel: . Jan 03 11:27:30 kappa kernel: . Jan 03 11:27:30 kappa kernel: . Jan 03 11:27:31 kappa kernel: . Jan 03 11:27:31 kappa kernel: . Jan 03 11:27:32 kappa kernel: . Jan 03 11:27:32 kappa kernel: . Jan 03 11:27:33 kappa kernel: . Jan 03 11:27:33 kappa kernel: . Jan 03 11:27:34 kappa kernel: . Jan 03 11:27:34 kappa kernel: . Jan 03 11:27:35 kappa kernel: . Jan 03 11:27:35 kappa kernel: . Jan 03 11:27:36 kappa kernel: . Jan 03 11:27:36 kappa kernel: . Jan 03 11:27:38 kappa kernel: . Jan 03 11:27:38 kappa kernel: . Jan 03 11:27:39 kappa kernel: . Jan 03 11:27:39 kappa kernel: . Jan 03 11:27:40 kappa kernel: . Jan 03 11:27:40 kappa kernel: . Jan 03 11:27:41 kappa kernel: . Jan 03 11:27:41 kappa kernel: . Jan 03 11:27:42 kappa kernel: . Jan 03 11:27:42 kappa kernel: . Jan 03 11:27:43 kappa kernel: . Jan 03 11:27:43 kappa kernel: . Jan 03 11:27:44 kappa kernel: . Jan 03 11:27:44 kappa kernel: . Jan 03 11:27:45 kappa kernel: . Jan 03 11:27:45 kappa kernel: . Jan 03 11:27:46 kappa kernel: . Jan 03 11:27:46 kappa kernel: . Jan 03 11:27:47 kappa kernel: . Jan 03 11:27:47 kappa kernel: . Jan 03 11:27:48 kappa kernel: . Jan 03 11:27:48 kappa kernel: . Jan 03 11:27:49 kappa kernel: . Jan 03 11:27:49 kappa kernel: . Jan 03 11:27:50 kappa kernel: . Jan 03 11:27:50 kappa kernel: . Jan 03 11:27:51 kappa kernel: . Jan 03 11:27:51 kappa kernel: . Jan 03 11:27:52 kappa kernel: . Jan 03 11:27:52 kappa kernel: . Jan 03 11:27:53 kappa kernel: . Jan 03 11:27:53 kappa kernel: . Jan 03 11:27:54 kappa kernel: . Jan 03 11:27:54 kappa kernel: . Jan 03 11:27:56 kappa kernel: . Jan 03 11:27:56 kappa kernel: . Jan 03 11:27:57 kappa kernel: . Jan 03 11:27:57 kappa kernel: . Jan 03 11:27:58 kappa kernel: . Jan 03 11:27:58 kappa kernel: . Jan 03 11:27:59 kappa kernel: . Jan 03 11:27:59 kappa kernel: . Jan 03 11:28:00 kappa kernel: . Jan 03 11:28:00 kappa kernel: . Jan 03 11:28:01 kappa kernel: . Jan 03 11:28:01 kappa kernel: . Jan 03 11:28:02 kappa kernel: . Jan 03 11:28:02 kappa kernel: . Jan 03 11:28:03 kappa kernel: . Jan 03 11:28:03 kappa kernel: . Jan 03 11:28:04 kappa kernel: . Jan 03 11:28:04 kappa kernel: . Jan 03 11:28:05 kappa kernel: . Jan 03 11:28:05 kappa kernel: . Jan 03 11:28:06 kappa kernel: . Jan 03 11:28:06 kappa kernel: . Jan 03 11:28:07 kappa kernel: . Jan 03 11:28:07 kappa kernel: . Jan 03 11:28:08 kappa kernel: . Jan 03 11:28:08 kappa kernel: . Jan 03 11:28:09 kappa systemd-udevd[613]: seq 2990 '/devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc' is taking a long time Jan 03 11:28:09 kappa kernel: . Jan 03 11:28:09 kappa kernel: . Jan 03 11:28:10 kappa kernel: . Jan 03 11:28:10 kappa kernel: . Jan 03 11:28:11 kappa kernel: . Jan 03 11:28:11 kappa kernel: . Jan 03 11:28:12 kappa kernel: . Jan 03 11:28:12 kappa kernel: . Jan 03 11:28:14 kappa kernel: . Jan 03 11:28:14 kappa kernel: . Jan 03 11:28:15 kappa kernel: . Jan 03 11:28:15 kappa kernel: . Jan 03 11:28:16 kappa kernel: . Jan 03 11:28:16 kappa kernel: . Jan 03 11:28:17 kappa kernel: . Jan 03 11:28:17 kappa kernel: . Jan 03 11:28:18 kappa kernel: . Jan 03 11:28:18 kappa kernel: . Jan 03 11:28:19 kappa kernel: . Jan 03 11:28:19 kappa kernel: . Jan 03 11:28:20 kappa kernel: . Jan 03 11:28:20 kappa kernel: . Jan 03 11:28:21 kappa kernel: . Jan 03 11:28:21 kappa kernel: . Jan 03 11:28:22 kappa kernel: . Jan 03 11:28:22 kappa kernel: . Jan 03 11:28:23 kappa kernel: . Jan 03 11:28:23 kappa kernel: . Jan 03 11:28:24 kappa kernel: . Jan 03 11:28:24 kappa kernel: . Jan 03 11:28:25 kappa kernel: . Jan 03 11:28:25 kappa kernel: . Jan 03 11:28:26 kappa kernel: . Jan 03 11:28:26 kappa kernel: . Jan 03 11:28:27 kappa kernel: . Jan 03 11:28:27 kappa kernel: . Jan 03 11:28:28 kappa kernel: . Jan 03 11:28:28 kappa kernel: . Jan 03 11:28:29 kappa kernel: . Jan 03 11:28:29 kappa kernel: . Jan 03 11:28:30 kappa kernel: . Jan 03 11:28:30 kappa kernel: . Jan 03 11:28:31 kappa kernel: . Jan 03 11:28:31 kappa kernel: . Jan 03 11:28:33 kappa kernel: . Jan 03 11:28:33 kappa kernel: . Jan 03 11:28:34 kappa kernel: . Jan 03 11:28:34 kappa kernel: . Jan 03 11:28:35 kappa kernel: . Jan 03 11:28:35 kappa kernel: . Jan 03 11:28:36 kappa kernel: . Jan 03 11:28:36 kappa kernel: . Jan 03 11:28:37 kappa kernel: . Jan 03 11:28:37 kappa kernel: . Jan 03 11:28:38 kappa kernel: . Jan 03 11:28:38 kappa kernel: . Jan 03 11:28:39 kappa kernel: . Jan 03 11:28:39 kappa kernel: . Jan 03 11:28:40 kappa kernel: . Jan 03 11:28:40 kappa kernel: . Jan 03 11:28:41 kappa kernel: . Jan 03 11:28:41 kappa kernel: . Jan 03 11:28:42 kappa kernel: . Jan 03 11:28:42 kappa kernel: . Jan 03 11:28:43 kappa kernel: . Jan 03 11:28:43 kappa kernel: . Jan 03 11:28:44 kappa kernel: . Jan 03 11:28:44 kappa kernel: . Jan 03 11:28:45 kappa kernel: . Jan 03 11:28:45 kappa kernel: . Jan 03 11:28:46 kappa kernel: . Jan 03 11:28:46 kappa kernel: . Jan 03 11:28:47 kappa kernel: . Jan 03 11:28:47 kappa kernel: . Jan 03 11:28:48 kappa kernel: .not responding... Jan 03 11:28:48 kappa kernel: sd 0:0:3:0: [sdc] Read Capacity(10) failed: Result: hostbyte=DID_OK driverbyte=DRIVER_SENSE Jan 03 11:28:48 kappa kernel: sd 0:0:3:0: [sdc] Sense Key : Not Ready [current] Jan 03 11:28:48 kappa kernel: sd 0:0:3:0: [sdc] Add. Sense: Logical unit not ready, cause not reportable Jan 03 11:28:48 kappa kernel: .not responding... Jan 03 11:28:48 kappa kernel: sd 0:0:3:0: [sdc] Attached SCSI removable disk Jan 03 11:28:48 kappa kernel: sd 0:0:3:0: [sdc] Spinning up disk... Jan 03 11:30:09 kappa systemd-udevd[613]: seq 2990 '/devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc' killed Jan 03 11:30:29 kappa kernel: ...............................................................................................not responding... Jan 03 11:30:29 kappa systemd-udevd[613]: worker [15183] terminated by signal 9 (Killed) Jan 03 11:30:29 kappa systemd-udevd[613]: worker [15183] failed while handling '/devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc' Jan 03 11:30:29 kappa kernel: sd 0:0:3:0: [sdc] Spinning up disk... Jan 03 11:31:30 kappa systemd-udevd[613]: seq 2991 '/devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc' is taking a long time Jan 03 11:32:09 kappa kernel: ...............................................................................................not responding... Jan 03 11:32:09 kappa kernel: sd 0:0:3:0: [sdc] Read Capacity(10) failed: Result: hostbyte=DID_OK driverbyte=DRIVER_SENSE Jan 03 11:32:09 kappa kernel: sd 0:0:3:0: [sdc] Sense Key : Not Ready [current] Jan 03 11:32:09 kappa kernel: sd 0:0:3:0: [sdc] Add. Sense: Logical unit not ready, cause not reportable Jan 03 11:32:09 kappa kernel: sd 0:0:3:0: [sdc] Spinning up disk... Jan 03 11:33:30 kappa systemd-udevd[613]: seq 2991 '/devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc' killed Jan 03 11:33:50 kappa kernel: ...............................................................................................not responding... Jan 03 11:33:50 kappa kernel: sd 0:0:3:0: [sdc] Spinning up disk... Jan 03 11:35:30 kappa kernel: ...............................................................................................not responding... Jan 03 11:35:30 kappa kernel: sd 0:0:3:0: [sdc] Read Capacity(10) failed: Result: hostbyte=DID_OK driverbyte=DRIVER_SENSE Jan 03 11:35:30 kappa kernel: sd 0:0:3:0: [sdc] Sense Key : Not Ready [current] Jan 03 11:35:30 kappa kernel: sd 0:0:3:0: [sdc] Add. Sense: Logical unit not ready, cause not reportable Jan 03 11:35:30 kappa systemd-udevd[613]: worker [15182] terminated by signal 9 (Killed) Jan 03 11:35:30 kappa systemd-udevd[613]: worker [15182] failed while handling '/devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc' Jan 03 11:35:30 kappa kernel: sd 0:0:3:0: [sdc] Spinning up disk... Jan 03 11:36:31 kappa systemd-udevd[613]: seq 2992 '/devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc' is taking a long time Jan 03 11:37:11 kappa kernel: ...............................................................................................not responding... Jan 03 11:37:11 kappa kernel: sd 0:0:3:0: [sdc] Read Capacity(10) failed: Result: hostbyte=DID_OK driverbyte=DRIVER_SENSE Jan 03 11:37:11 kappa kernel: sd 0:0:3:0: [sdc] Sense Key : Not Ready [current] Jan 03 11:37:11 kappa kernel: sd 0:0:3:0: [sdc] Add. Sense: Logical unit not ready, cause not reportable Jan 03 11:37:11 kappa kernel: sd 0:0:3:0: [sdc] Spinning up disk... Jan 03 11:38:31 kappa systemd-udevd[613]: seq 2992 '/devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc' killed Jan 03 11:38:51 kappa kernel: ...............................................................................................not responding... Jan 03 11:38:51 kappa kernel: sd 0:0:3:0: [sdc] Read Capacity(10) failed: Result: hostbyte=DID_OK driverbyte=DRIVER_SENSE Jan 03 11:38:51 kappa kernel: sd 0:0:3:0: [sdc] Sense Key : Not Ready [current] Jan 03 11:38:51 kappa kernel: sd 0:0:3:0: [sdc] Add. Sense: Logical unit not ready, cause not reportable Jan 03 11:38:51 kappa kernel: sd 0:0:3:0: [sdc] Spinning up disk... Jan 03 11:40:32 kappa systemd-udevd[613]: worker [15297] terminated by signal 9 (Killed) Jan 03 11:40:32 kappa kernel: ...............................................................................................not responding... Jan 03 11:40:32 kappa systemd-udevd[613]: worker [15297] failed while handling '/devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc' Jan 03 11:40:32 kappa kernel: sd 0:0:3:0: [sdc] Spinning up disk... Jan 03 11:41:32 kappa systemd-udevd[613]: seq 2993 '/devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc' is taking a long time Jan 03 11:42:12 kappa kernel: ...............................................................................................not responding... Jan 03 11:42:12 kappa kernel: sd 0:0:3:0: [sdc] Read Capacity(10) failed: Result: hostbyte=DID_OK driverbyte=DRIVER_SENSE Jan 03 11:42:12 kappa kernel: sd 0:0:3:0: [sdc] Sense Key : Not Ready [current] Jan 03 11:42:12 kappa kernel: sd 0:0:3:0: [sdc] Add. Sense: Logical unit not ready, cause not reportable Jan 03 11:42:12 kappa kernel: sd 0:0:3:0: [sdc] Spinning up disk... Jan 03 11:43:32 kappa systemd-udevd[613]: seq 2993 '/devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc' killed Jan 03 11:43:53 kappa kernel: ...............................................................................................not responding... Jan 03 11:43:53 kappa kernel: sd 0:0:3:0: [sdc] Read Capacity(10) failed: Result: hostbyte=DID_OK driverbyte=DRIVER_SENSE Jan 03 11:43:53 kappa kernel: sd 0:0:3:0: [sdc] Sense Key : Not Ready [current] Jan 03 11:43:53 kappa kernel: sd 0:0:3:0: [sdc] Add. Sense: Logical unit not ready, cause not reportable and so on until now.. journalctl shows best, that it is in fact udevd..

On Wed, 3 Jan 2018 19:40:27 +0100 "Carlos E. R." wrote:

On 2018-01-03 16:57, Paul Neuwirth wrote:

...

...

Dez 29 18:27:46 linux-7qz0 systemd[1]: systemd-udevd.service: Main process exited, code=exited, status=1/FAILURE Dez 29 18:28:44 linux-7qz0 kernel: ............................................................ready

"ready" means disk inserted..

then it kept quiet until I reloaded kernel module aic7xxx:

Hum! Why do you reload that module?

lsscsi did not list a scanner attached (was maybe powered off at boot time), rescan-scsi-bus.sh did not find it. after reloading the module the scanner got found.

On Thu, 4 Jan 2018 10:50:06 +0300 Andrei Borzenkov wrote:

03.01.2018 18:57, Paul Neuwirth пишет:

...

journalctl shows best, that it is in fact udevd..

Actually udevd is probably just the messenger here. Annotated log

...

Jan 03 11:25:27 kappa kernel: scsi 0:0:3:0: Direct-Access TEAC FC-5 HGF 00 RV D PQ: 0 ANSI: 1 CCS Jan 03 11:25:27 kappa kernel: sd 0:0:3:0: Attached scsi generic sg4 type 0 Jan 03 11:25:27 kappa kernel: sd 0:0:3:0: Power-on or device reset occurred Jan 03 11:25:27 kappa kernel: sd 0:0:3:0: [sdc] Spinning up disk...

This comes from kernel directly. It does it as the first step when probing for new SCSI disk. Note that if device explicitly says that medium is not present, "Spinning up" is skipped.

...

Jan 03 11:27:08 kappa kernel: sd 0:0:3:0: [sdc] Read Capacity(10) failed: Result: hostbyte=DID_OK driverbyte=DRIVER_SENSE Jan 03 11:27:08 kappa kernel: sd 0:0:3:0: [sdc] Sense Key : Not Ready [current] Jan 03 11:27:08 kappa kernel: sd 0:0:3:0: [sdc] Add. Sense: Logical unit not ready, cause not reportable Jan 03 11:27:08 kappa kernel: sd 0:0:3:0: [sdc] Write Protect is on Jan 03 11:27:08 kappa kernel: sd 0:0:3:0: [sdc] Mode Sense: 37 88 80 08 Jan 03 11:27:08 kappa kernel: sd 0:0:3:0: [sdc] Asking for cache data failed Jan 03 11:27:08 kappa kernel: sd 0:0:3:0: [sdc] Assuming drive cache: write through

The above is executed only if driver thinks that medium is present (otherwise there is no point to even attempt to read capacity). Driver starts with assumption it is. Again - if device returns proper sense code indicating no medium is present, this step should have been skipped. Still, as READ CAPACITY fails we should have reset "medium present" indication ...

... and we announce block device sdc to user space (i.e. udevd) now. So udevd spawns handler thread.

...

Jan 03 11:27:08 kappa kernel: sd 0:0:3:0: [sdc] Spinning up disk...

Still kernel directly.

...

Jan 03 11:27:08 kappa kernel: sd 0:0:3:0: [sdc] Spinning up disk...

And *this* comes from udevd handler trying to open device node. Which triggers device revalidation. And apparently it also resets "medium not present" flag back because driver has never received proper response from device. And because driver flips this flag from TRUE to FALSE it apparently generates change event. Which spawns yet another udevd handler which tries to open device node ... notice incrementing event numbers:

...

Jan 03 11:28:09 kappa systemd-udevd[613]: seq 2990 '/devices/pci0000:00/0000:00:0a.0/0000:01: 06.0/host0/target0:0:3/0:0:3:0/block/sdc' is taking a long time Jan 03 11:31:30 kappa systemd-udevd[613]: seq 2991 '/devices/pci0000:00/0000:00:0a.0/0000:01: 06.0/host0/target0:0:3/0:0:3:0/block/sdc' is taking a long time Jan 03 11:36:31 kappa systemd-udevd[613]: seq 2992 '/devices/pci0000:00/0000:00:0a.0/0000:01: 06.0/host0/target0:0:3/0:0:3:0/block/sdc' is taking a long time Jan 03 11:41:32 kappa systemd-udevd[613]: seq 2993 '/devices/pci0000:00/0000:00:0a.0/0000:01: 06.0/host0/target0:0:3/0:0:3:0/block/sdc' is taking a long time

Could you please reproduce it once more and provide output of "udevadm monitor -k" to confirm this.

thank you for your help. just reloaded kernel modue, and output of command: # udevadm monitor -k monitor will print the received events for: KERNEL - the kernel uevent ^Z [1]+ Stopped udevadm monitor -k # rmmod aic7xxx # fg udevadm monitor -k KERNEL[487599.298381] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:0/0:0:0:0/bsg/0:0:0:0 (bsg) KERNEL[487599.298422] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:0/0:0:0:0/scsi_generic/sg3 (scsi_generic) KERNEL[487599.298440] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:0/0:0:0:0/scsi_device/0:0:0:0 (scsi_device) KERNEL[487599.298465] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:0/0:0:0:0 (scsi) KERNEL[487599.298481] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:0/spi_transport/target0:0:0 (spi_transport) KERNEL[487599.298506] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:0 (scsi) KERNEL[487599.298531] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/bsg/0:0:3:0 (bsg) KERNEL[487599.298556] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/scsi_generic/sg4 (scsi_generic) KERNEL[487599.298571] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/scsi_device/0:0:3:0 (scsi_device) KERNEL[487599.298587] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/scsi_disk/0:0:3:0 (scsi_disk) KERNEL[487599.298600] remove /devices/virtual/bdi/8:32 (bdi) KERNEL[487599.298624] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[487599.298646] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0 (scsi) KERNEL[487599.298663] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/spi_transport/target0:0:3 (spi_transport) KERNEL[487599.298685] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3 (scsi) KERNEL[487599.298709] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:4/0:0:4:0/bsg/0:0:4:0 (bsg) KERNEL[487599.298733] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:4/0:0:4:0/scsi_generic/sg5 (scsi_generic) KERNEL[487599.298749] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:4/0:0:4:0/scsi_device/0:0:4:0 (scsi_device) KERNEL[487599.298770] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:4/0:0:4:0 (scsi) KERNEL[487599.298785] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:4/spi_transport/target0:0:4 (spi_transport) KERNEL[487599.298806] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:4 (scsi) KERNEL[487599.298830] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:5/0:0:5:0/bsg/0:0:5:0 (bsg) KERNEL[487599.298856] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:5/0:0:5:0/scsi_generic/sg7 (scsi_generic) KERNEL[487599.298871] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:5/0:0:5:0/scsi_device/0:0:5:0 (scsi_device) KERNEL[487599.298894] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:5/0:0:5:0/scsi_tape/st0 (scsi_tape) KERNEL[487599.298918] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:5/0:0:5:0/scsi_tape/nst0 (scsi_tape) KERNEL[487599.298941] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:5/0:0:5:0/scsi_tape/st0l (scsi_tape) KERNEL[487599.298965] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:5/0:0:5:0/scsi_tape/nst0l (scsi_tape) KERNEL[487599.298990] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:5/0:0:5:0/scsi_tape/st0m (scsi_tape) KERNEL[487599.299014] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:5/0:0:5:0/scsi_tape/nst0m (scsi_tape) KERNEL[487599.299038] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:5/0:0:5:0/scsi_tape/st0a (scsi_tape) KERNEL[487599.299061] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:5/0:0:5:0/scsi_tape/nst0a (scsi_tape) KERNEL[487599.299083] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:5/0:0:5:0 (scsi) KERNEL[487599.299098] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:5/spi_transport/target0:0:5 (spi_transport) KERNEL[487599.299119] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:5 (scsi) KERNEL[487599.299134] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/spi_host/host0 (spi_host) KERNEL[487599.299148] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/scsi_host/host0 (scsi_host) KERNEL[487599.299168] remove /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0 (scsi) KERNEL[487599.299183] remove /bus/pci/drivers/aic7xxx (drivers) KERNEL[487599.299196] remove /module/aic7xxx (module) ^Z [1]+ Stopped udevadm monitor -k # modprobe aic7xxx; fg udevadm monitor -k KERNEL[487838.926097] add /module/aic7xxx (module) KERNEL[487838.926140] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0 (scsi) KERNEL[487838.926157] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/scsi_host/host0 (scsi_host) KERNEL[487838.926172] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/spi_host/host0 (spi_host) KERNEL[487838.926199] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:0 (scsi) KERNEL[487838.926215] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:0/spi_transport/target0:0:0 (spi_transport) KERNEL[487838.926238] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:0/0:0:0:0 (scsi) KERNEL[487838.926253] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:0/0:0:0:0/scsi_device/0:0:0:0 (scsi_device) KERNEL[487838.926278] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:0/0:0:0:0/scsi_generic/sg3 (scsi_generic) KERNEL[487838.926304] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:0/0:0:0:0/bsg/0:0:0:0 (bsg) KERNEL[487838.926326] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3 (scsi) KERNEL[487838.926340] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/spi_transport/target0:0:3 (spi_transport) KERNEL[487838.926363] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0 (scsi) KERNEL[487838.926378] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/scsi_disk/0:0:3:0 (scsi_disk) KERNEL[487838.926392] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/scsi_device/0:0:3:0 (scsi_device) KERNEL[487838.926415] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/scsi_generic/sg4 (scsi_generic) KERNEL[487838.926440] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/bsg/0:0:3:0 (bsg) KERNEL[487838.926465] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0 (scsi) KERNEL[487838.926488] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:4 (scsi) KERNEL[487838.926503] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:4/spi_transport/target0:0:4 (spi_transport) KERNEL[487838.926525] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:4/0:0:4:0 (scsi) KERNEL[487838.926540] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:4/0:0:4:0/scsi_device/0:0:4:0 (scsi_device) KERNEL[487838.926563] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:4/0:0:4:0/scsi_generic/sg5 (scsi_generic) KERNEL[487838.926587] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:4/0:0:4:0/bsg/0:0:4:0 (bsg) KERNEL[487838.926609] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:5 (scsi) KERNEL[487838.926623] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:5/spi_transport/target0:0:5 (spi_transport) KERNEL[487838.926645] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:5/0:0:5:0 (scsi) KERNEL[487838.926669] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:5/0:0:5:0/scsi_tape/st0 (scsi_tape) KERNEL[487838.926694] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:5/0:0:5:0/scsi_tape/nst0 (scsi_tape) KERNEL[487838.926717] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:5/0:0:5:0/scsi_tape/st0l (scsi_tape) KERNEL[487838.926741] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:5/0:0:5:0/scsi_tape/nst0l (scsi_tape) KERNEL[487838.926766] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:5/0:0:5:0/scsi_tape/st0m (scsi_tape) KERNEL[487838.926790] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:5/0:0:5:0/scsi_tape/nst0m (scsi_tape) KERNEL[487838.926813] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:5/0:0:5:0/scsi_tape/st0a (scsi_tape) KERNEL[487838.926838] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:5/0:0:5:0/scsi_tape/nst0a (scsi_tape) KERNEL[487838.926853] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:5/0:0:5:0/scsi_device/0:0:5:0 (scsi_device) KERNEL[487838.926877] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:5/0:0:5:0/scsi_generic/sg7 (scsi_generic) KERNEL[487838.926902] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:5/0:0:5:0/bsg/0:0:5:0 (bsg) KERNEL[487838.926917] add /bus/pci/drivers/aic7xxx (drivers) KERNEL[487838.926930] add /devices/virtual/bdi/8:32 (bdi) KERNEL[487838.926954] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[487838.926986] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[487838.927021] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[487838.927054] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[487939.384425] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[488039.884765] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[488039.895676] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block)

On Thu, 4 Jan 2018 13:22:39 +0300 Andrei Borzenkov wrote:

04.01.2018 12:06, Paul Neuwirth пишет:

...

KERNEL[487838.926954] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[487838.926986] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[487838.927021] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[487838.927054] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[487939.384425] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[488039.884765] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[488039.895676] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block)

OK, this confirms that at the end it is kernel issue. You should really report it to kernel folks as true solution must be implemented in kernel driver.

So there are two issues - (initial) spin up and permanent stream of "change" events. To workaround the latter - try disabling periodic device polling in kernel:

echo 0 > /sys/block/sdc/events_poll_msecs

and check with "udevadm monitor" whether events stop.

For the former you can pass quirk parameter to scsi_mod; create /etc/modprobe.d/teac.conf (name is arbitrary) with:

options scsi_mod dev_flags=TEAC:FC-5:4096

Check /sys/block/sdc/device/{vendor,model} for correct values. This flag suppresses initial spin up of device. You will need to reboot (and do not forget you also need to recreate initrd as scsi_mod is most likely loaded there).

Hello, one little question: what is the concerned part of kernel? I did a bug general bug report on the kernel mailing list. But no response until now. Maybe I should mention the kernel module/part/whatever in the topic, and write a copy to the maintainer. But I do not have a clue which part it is. Thank you again Paul

On Fri, 19 Jan 2018 14:17:48 +0300 Andrei Borzenkov wrote:

So did any of my suggestion help?

On Fri, Jan 19, 2018 at 1:57 PM, Paul Neuwirth wrote:

...

On Thu, 4 Jan 2018 13:22:39 +0300 Andrei Borzenkov wrote:

...

04.01.2018 12:06, Paul Neuwirth пишет:

...

KERNEL[487838.926954] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[487838.926986] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[487838.927021] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[487838.927054] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[487939.384425] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[488039.884765] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[488039.895676] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block)

OK, this confirms that at the end it is kernel issue. You should really report it to kernel folks as true solution must be implemented in kernel driver.

So there are two issues - (initial) spin up and permanent stream of "change" events. To workaround the latter - try disabling periodic device polling in kernel:

echo 0 > /sys/block/sdc/events_poll_msecs

and check with "udevadm monitor" whether events stop.

For the former you can pass quirk parameter to scsi_mod; create /etc/modprobe.d/teac.conf (name is arbitrary) with:

options scsi_mod dev_flags=TEAC:FC-5:4096

Check /sys/block/sdc/device/{vendor,model} for correct values. This flag suppresses initial spin up of device. You will need to reboot (and do not forget you also need to recreate initrd as scsi_mod is most likely loaded there).

Hello,

one little question: what is the concerned part of kernel? I did a bug general bug report on the kernel mailing list. But no response until now. Maybe I should mention the kernel module/part/whatever in the topic, and write a copy to the maintainer. But I do not have a clue which part it is.

Thank you again

Paul

both methods did not work, yet.. but I did not reboot yet.. I don't know yet when the next reboot can take place.. I wrote the config file exactly as above. I did reload the driver module aic7xxx. But of course was unable to reload scsi_mod. [508787.941786] scsi 1:0:3:0: Direct-Access TEAC FC-5 HGF 00 RV D PQ: 0 ANSI: 1 CCS # cat /sys/block/sdc/device/vendor /sys/block/sdc/device/model TEAC FC-5 HGF 00 -- To unsubscribe, e-mail: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org

On Fri, 19 Jan 2018 17:36:22 +0300 Andrei Borzenkov wrote:

On Fri, Jan 19, 2018 at 3:14 PM, Paul Neuwirth wrote:

...

On Fri, 19 Jan 2018 14:17:48 +0300 Andrei Borzenkov wrote:

...

So did any of my suggestion help?

On Fri, Jan 19, 2018 at 1:57 PM, Paul Neuwirth wrote:

...

On Thu, 4 Jan 2018 13:22:39 +0300 Andrei Borzenkov wrote:

...

04.01.2018 12:06, Paul Neuwirth пишет:

...

KERNEL[487838.926954] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[487838.926986] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[487838.927021] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[487838.927054] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[487939.384425] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[488039.884765] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[488039.895676] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block)

OK, this confirms that at the end it is kernel issue. You should really report it to kernel folks as true solution must be implemented in kernel driver.

So there are two issues - (initial) spin up and permanent stream of "change" events. To workaround the latter - try disabling periodic device polling in kernel:

echo 0 > /sys/block/sdc/events_poll_msecs

...

both methods did not work, yet.. but I did not reboot yet.. I don't

Well, I expect this does not require reboot. Can you confirm that the value is still 0?

# echo 0 > /sys/block/sdc/events_poll_msecs # cat /sys/block/sdc/events_poll_msecs 0 # udevadm monitor monitor will print the received events for: UDEV - the event which udev sends out after rule processing KERNEL - the kernel uevent KERNEL[523053.824420] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host1/target1:0:3/1:0:3:0/block/sdc (block) KERNEL[523053.834769] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host1/target1:0:3/1:0:3:0/block/sdc (block) UDEV [523154.250415] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host1/target1:0:3/1:0:3:0/block/sdc (block) KERNEL[523154.268823] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host1/target1:0:3/1:0:3:0/block/sdc (block) KERNEL[523254.727839] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host1/target1:0:3/1:0:3:0/block/sdc (block) KERNEL[523254.738130] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host1/target1:0:3/1:0:3:0/block/sdc (block) UDEV [523355.196902] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host1/target1:0:3/1:0:3:0/block/sdc (block) KERNEL[523355.213367] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host1/target1:0:3/1:0:3:0/block/sdc (block) KERNEL[523455.684259] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host1/target1:0:3/1:0:3:0/block/sdc (block) KERNEL[523455.694681] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host1/target1:0:3/1:0:3:0/block/sdc (block) UDEV [523556.149346] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host1/target1:0:3/1:0:3:0/block/sdc (block) [...] # cat /sys/block/sdc/events_poll_msecs 0 -- To unsubscribe, e-mail: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org

20.01.2018 10:56, Andrei Borzenkov пишет:

20.01.2018 10:41, Paul Neuwirth пишет:

...

...

Well, I expect this does not require reboot. Can you confirm that the value is still 0?

# echo 0 > /sys/block/sdc/events_poll_msecs # cat /sys/block/sdc/events_poll_msecs 0 # udevadm monitor monitor will print the received events for: UDEV - the event which udev sends out after rule processing KERNEL - the kernel uevent

KERNEL[523053.824420] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host1/target1:0:3/1:0:3:0/block/sdc (block) KERNEL[523053.834769] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host1/target1:0:3/1:0:3:0/block/sdc (block) UDEV [523154.250415]

Could you run "udevadm monitor -kp" to show event properties, this may give hint?

But I start to suspect that it is indeed triggered by udev opening device.

Try stracing udevd systemctl show -p MainPID systemd-udevd.service strace -f -o /tmp/udevd.trace -p <Value of MainPID> for couple of events. -- To unsubscribe, e-mail: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org

On Sat, 20 Jan 2018 11:18:59 +0300 Andrei Borzenkov wrote:

20.01.2018 10:56, Andrei Borzenkov пишет:

...

20.01.2018 10:41, Paul Neuwirth пишет:

...

...

Well, I expect this does not require reboot. Can you confirm that the value is still 0?

# echo 0 > /sys/block/sdc/events_poll_msecs # cat /sys/block/sdc/events_poll_msecs 0 # udevadm monitor monitor will print the received events for: UDEV - the event which udev sends out after rule processing KERNEL - the kernel uevent

KERNEL[523053.824420] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host1/target1:0:3/1:0:3:0/block/sdc (block) KERNEL[523053.834769] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host1/target1:0:3/1:0:3:0/block/sdc (block) UDEV [523154.250415]

Could you run "udevadm monitor -kp" to show event properties, this may give hint?

But I start to suspect that it is indeed triggered by udev opening device.

Try stracing udevd

systemctl show -p MainPID systemd-udevd.service strace -f -o /tmp/udevd.trace -p <Value of MainPID>

for couple of events.

596 epoll_wait(10, {{EPOLLIN, {u32=2122288400, u64=94912309595408}}}, 11, -1) = 1 596 clock_gettime(CLOCK_BOOTTIME, {582823, 518241478}) = 0 596 read(11, "\21\0\0\0\0\0\0\0\2\0\0\0)D\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 128) = 128 596 wait4(-1, [{WIFSIGNALED(s) && WTERMSIG(s) == SIGKILL}], WNOHANG, NULL) = 17449 596 sendmsg(5, {msg_name(0)=NULL, msg_iov(4)=[{"PRIORITY=4\nSYSLOG_FACILITY=3\nCOD"..., 128}, {"MESSAGE=", 8}, {"worker [17449] terminated by sig"..., 46}, {"\n", 1}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 183 596 sendmsg(5, {msg_name(0)=NULL, msg_iov(4)=[{"PRIORITY=3\nSYSLOG_FACILITY=3\nCOD"..., 128}, {"MESSAGE=", 8}, {"worker [17449] failed while hand"..., 120}, {"\n", 1}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 257 596 unlink("/run/udev/data/b8:32") = -1 ENOENT (No such file or directory) 596 open("/sys/devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host1/target1:0:3/1:0:3:0/block/sdc/uevent", O_RDONLY|O_CLOEXEC) = 14 596 fstat(14, {st_mode=S_IFREG|0644, st_size=4096, ...}) = 0 596 fstat(14, {st_mode=S_IFREG|0644, st_size=4096, ...}) = 0 596 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7ff6ab172000 596 read(14, "MAJOR=8\nMINOR=32\nDEVNAME=sdc\nDEV"..., 4096) = 42 596 read(14, "", 4096) = 0 596 read(14, "", 4096) = 0 596 close(14) = 0 596 munmap(0x7ff6ab172000, 4096) = 0 596 open("/run/udev/data/b8:32", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory) 596 sendmsg(3, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000002}, msg_iov(2)=[{"libudev\0\376\355\312\376(\0\0\0(\0\0\0\334\0\0\0\360\3\35\267{\313\305\356"..., 40}, {"DEVPATH=/devices/pci0000:00/0000"..., 220}], msg_controllen=0, msg_flags=0}, 0) = -1 ECONNREFUSED (Connection refused) 596 wait4(-1, 0x7ffe83f9d61c, WNOHANG, NULL) = -1 ECHILD (No child processes) 596 stat("/etc/udev/rules.d", {st_mode=S_IFDIR|0755, st_size=176, ...}) = 0 596 stat("/run/udev/rules.d", {st_mode=S_IFDIR|0755, st_size=40, ...}) = 0 596 stat("/usr/lib/udev/rules.d", {st_mode=S_IFDIR|0755, st_size=4098, ...}) = 0 596 stat("/etc/systemd/hwdb/hwdb.bin", 0x7ffe83f9d460) = -1 ENOENT (No such file or directory) 596 stat("/etc/udev/hwdb.bin", {st_mode=S_IFREG|0444, st_size=7007575, ...}) = 0 596 stat("/etc/modprobe.d", {st_mode=S_IFDIR|0755, st_size=392, ...}) = 0 596 stat("/lib/modules/4.4.104-18.44-default/modules.dep.bin", {st_mode=S_IFREG|0644, st_size=581226, ...}) = 0 596 stat("/lib/modules/4.4.104-18.44-default/modules.alias.bin", {st_mode=S_IFREG|0644, st_size=977379, ...}) = 0 596 stat("/lib/modules/4.4.104-18.44-default/modules.symbols.bin", {st_mode=S_IFREG|0644, st_size=620895, ...}) = 0 596 stat("/lib/modules/4.4.104-18.44-default/modules.builtin.bin", {st_mode=S_IFREG|0644, st_size=5168, ...}) = 0 596 stat("/etc/systemd/network", 0x7ffe83f9d440) = -1 ENOENT (No such file or directory) 596 stat("/run/systemd/network", 0x7ffe83f9d440) = -1 ENOENT (No such file or directory) 596 stat("/usr/lib/systemd/network", {st_mode=S_IFDIR|0755, st_size=128, ...}) = 0 596 stat("/lib/systemd/network", 0x7ffe83f9d440) = -1 ENOENT (No such file or directory) 596 socket(PF_NETLINK, SOCK_RAW|SOCK_CLOEXEC|SOCK_NONBLOCK, NETLINK_KOBJECT_UEVENT) = 14 596 bind(14, {sa_family=AF_NETLINK, pid=0, groups=00000000}, 12) = 0 596 getsockname(14, {sa_family=AF_NETLINK, pid=596, groups=00000000}, [12]) = 0 596 setsockopt(14, SOL_SOCKET, SO_PASSCRED, [1], 4) = 0 596 clone(child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x7ff6ab15cb90) = 17492 596 close(14) = 0 596 timerfd_settime(13, TFD_TIMER_ABSTIME, {it_interval={0, 0}, it_value={582884, 283214000}}, NULL) = 0 596 epoll_wait(10, {}, 11, 0) = 0 596 clock_gettime(CLOCK_BOOTTIME, {582823, 523913782}) = 0 596 epoll_wait(10, 17492 set_robust_list(0x7ff6ab15cba0, 24) = 0 596 <... epoll_wait resumed> {{EPOLLIN, {u32=2122290224, u64=94912309597232}}}, 11, -1) = 1 596 clock_gettime(CLOCK_BOOTTIME, {582823, 537527483}) = 0 596 recvmsg(3, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000001}, msg_iov(1)=[{"change@/devices/pci0000:00/0000:"..., 8192}], msg_controllen=32, [{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SCM_CREDENTIALS, {pid=0, uid=0, gid=0}}], msg_flags=0}, 0) = 284 596 getrandom("I\272\312>\343V\1\302\323ms\f\347n\372\257", 16, GRND_NONBLOCK) = 16 596 getrandom("\27\303UH\335\253nvI\237\203\226\303.\357\v", 16, GRND_NONBLOCK) = 16 596 getrandom("m\200\320>{j1\353\205\0>\373\n\0233x", 16, GRND_NONBLOCK) = 16 596 getrandom("\343\325\300\3\323\272\26\302\253\256gf\327np\256", 16, GRND_NONBLOCK) = 16 596 getrandom("\304\354\35F\4h\362\333 H\304OPOIO", 16, GRND_NONBLOCK) = 16 596 getrandom("\300w!b\226.n\t-\340\246m\16\10\226\332", 16, GRND_NONBLOCK) = 16 596 epoll_wait(10, {}, 11, 0) = 0 596 clock_gettime(CLOCK_BOOTTIME, {582823, 538751923}) = 0 596 epoll_wait(10, 17492 close(3) = 0 17492 close(4) = 0 17492 close(7) = 0 17492 signalfd4(-1, ~[RTMIN RT_1], 8, O_NONBLOCK|O_CLOEXEC) = 3 17492 epoll_create1(EPOLL_CLOEXEC) = 4 17492 epoll_ctl(4, EPOLL_CTL_ADD, 3, {EPOLLIN, {u32=3, u64=3}}) = 0 17492 epoll_ctl(4, EPOLL_CTL_ADD, 14, {EPOLLIN, {u32=14, u64=14}}) = 0 17492 prctl(PR_SET_PDEATHSIG, SIGTERM) = 0 17492 open("/proc/self/oom_score_adj", O_WRONLY|O_NOCTTY|O_CLOEXEC) = 7 17492 fcntl(7, F_GETFL) = 0x8001 (flags O_WRONLY|O_LARGEFILE) 17492 fstat(7, {st_mode=S_IFREG|0644, st_size=0, ...}) = 0 17492 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7ff6ab172000 17492 write(7, "0\n", 2) = 2 17492 close(7) = 0 17492 munmap(0x7ff6ab172000, 4096) = 0 17492 open("/dev/sdc", O_RDONLY|O_NONBLOCK|O_NOFOLLOW|O_CLOEXEC 596 <... epoll_wait resumed> {{EPOLLIN, {u32=2122192824, u64=94912309499832}}}, 11, -1) = 1 596 clock_gettime(CLOCK_BOOTTIME, {582884, 283369623}) = 0 596 read(13, "\1\0\0\0\0\0\0\0", 8) = 8 596 socket(PF_LOCAL, SOCK_DGRAM|SOCK_CLOEXEC, 0) = 14 596 getsockopt(14, SOL_SOCKET, SO_SNDBUF, [212992], [4]) = 0 596 setsockopt(14, SOL_SOCKET, SO_SNDBUFFORCE, [8388608], 4) = 0 596 sendmsg(14, {msg_name(21)={sa_family=AF_LOCAL, sun_path="/run/systemd/notify"}, msg_iov(1)=[{"WATCHDOG=1", 10}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 10 596 close(14) = 0 596 timerfd_settime(12, TFD_TIMER_ABSTIME, {it_interval={0, 0}, it_value={583013, 283214000}}, NULL) = 0 596 sendmsg(5, {msg_name(0)=NULL, msg_iov(4)=[{"PRIORITY=4\nSYSLOG_FACILITY=3\nCOD"..., 141}, {"MESSAGE=", 8}, {"seq 10556 '/devices/pci0000:00/0"..., 115}, {"\n", 1}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 265 596 timerfd_settime(13, TFD_TIMER_ABSTIME, {it_interval={0, 0}, it_value={583004, 283214000}}, NULL) = 0 596 epoll_wait(10, {}, 11, 0) = 0 596 clock_gettime(CLOCK_BOOTTIME, {582884, 285290559}) = 0 596 epoll_wait(10, {{EPOLLIN, {u32=2122290224, u64=94912309597232}}}, 11, -1) = 1 596 clock_gettime(CLOCK_BOOTTIME, {582924, 23635872}) = 0 596 recvmsg(3, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000001}, msg_iov(1)=[{"change@/devices/pci0000:00/0000:"..., 8192}], msg_controllen=32, [{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SCM_CREDENTIALS, {pid=0, uid=0, gid=0}}], msg_flags=0}, 0) = 274 596 getrandom("\336XpR\330\31\177\336\33\331\203XQ\341\262\262", 16, GRND_NONBLOCK) = 16 596 getrandom("\227v-Z\200sA\4\376}\\\2010\314\34\346", 16, GRND_NONBLOCK) = 16 596 getrandom("\1779\247$\2570z\301yK\324g\340Jo\300", 16, GRND_NONBLOCK) = 16 596 getrandom("\235U\263\254ATf\277\245\213\224<\255knj", 16, GRND_NONBLOCK) = 16 596 getrandom("\326\330\f\2\377\336\337\213\207\223\364\347Z\337\37\231", 16, GRND_NONBLOCK) = 16 596 getrandom("L\346i\224w\0\27n\247\n\222\346h\347\353n", 16, GRND_NONBLOCK) = 16 596 stat("/etc/udev/rules.d", {st_mode=S_IFDIR|0755, st_size=176, ...}) = 0 596 stat("/run/udev/rules.d", {st_mode=S_IFDIR|0755, st_size=40, ...}) = 0 596 stat("/usr/lib/udev/rules.d", {st_mode=S_IFDIR|0755, st_size=4098, ...}) = 0 596 stat("/etc/systemd/hwdb/hwdb.bin", 0x7ffe83f9d470) = -1 ENOENT (No such file or directory) 596 stat("/etc/udev/hwdb.bin", {st_mode=S_IFREG|0444, st_size=7007575, ...}) = 0 596 stat("/etc/modprobe.d", {st_mode=S_IFDIR|0755, st_size=392, ...}) = 0 596 stat("/lib/modules/4.4.104-18.44-default/modules.dep.bin", {st_mode=S_IFREG|0644, st_size=581226, ...}) = 0 596 stat("/lib/modules/4.4.104-18.44-default/modules.alias.bin", {st_mode=S_IFREG|0644, st_size=977379, ...}) = 0 596 stat("/lib/modules/4.4.104-18.44-default/modules.symbols.bin", {st_mode=S_IFREG|0644, st_size=620895, ...}) = 0 596 stat("/lib/modules/4.4.104-18.44-default/modules.builtin.bin", {st_mode=S_IFREG|0644, st_size=5168, ...}) = 0 596 stat("/etc/systemd/network", 0x7ffe83f9d450) = -1 ENOENT (No such file or directory) 596 stat("/run/systemd/network", 0x7ffe83f9d450) = -1 ENOENT (No such file or directory) 596 stat("/usr/lib/systemd/network", {st_mode=S_IFDIR|0755, st_size=128, ...}) = 0 596 stat("/lib/systemd/network", 0x7ffe83f9d450) = -1 ENOENT (No such file or directory) 596 epoll_wait(10, {}, 11, 0) = 0 596 clock_gettime(CLOCK_BOOTTIME, {582924, 26276979}) = 0 596 epoll_wait(10, {{EPOLLIN, {u32=2122290224, u64=94912309597232}}}, 11, -1) = 1 596 clock_gettime(CLOCK_BOOTTIME, {582924, 34046473}) = 0 596 recvmsg(3, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000001}, msg_iov(1)=[{"change@/devices/pci0000:00/0000:"..., 8192}], msg_controllen=32, [{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SCM_CREDENTIALS, {pid=0, uid=0, gid=0}}], msg_flags=0}, 0) = 274 596 getrandom("\325\276_^\337<\24\366\216\237\17/<\347\360P", 16, GRND_NONBLOCK) = 16 596 getrandom("\20\253\220u\222\374\234\2216\316j1_\346\374\243", 16, GRND_NONBLOCK) = 16 596 getrandom("w@\21\245\317\234\16\300\210Ac\236\315_\324m", 16, GRND_NONBLOCK) = 16 596 getrandom("\217\237$`[<\201p!\357\355D\33+#f", 16, GRND_NONBLOCK) = 16 596 getrandom("\30\216\223H\230\32\246\26\212\7\200\376\332\16^\302", 16, GRND_NONBLOCK) = 16 596 getrandom("\247\217F\322D\31\tK\221\266ivd\222\nZ", 16, GRND_NONBLOCK) = 16 596 epoll_wait(10, {}, 11, 0) = 0 596 clock_gettime(CLOCK_BOOTTIME, {582924, 34760207}) = 0 596 epoll_wait(10, {{EPOLLIN, {u32=2122192824, u64=94912309499832}}}, 11, -1) = 1 596 clock_gettime(CLOCK_BOOTTIME, {583004, 283393653}) = 0 596 read(13, "\1\0\0\0\0\0\0\0", 8) = 8 596 socket(PF_LOCAL, SOCK_DGRAM|SOCK_CLOEXEC, 0) = 14 596 getsockopt(14, SOL_SOCKET, SO_SNDBUF, [212992], [4]) = 0 596 setsockopt(14, SOL_SOCKET, SO_SNDBUFFORCE, [8388608], 4) = 0 596 sendmsg(14, {msg_name(21)={sa_family=AF_LOCAL, sun_path="/run/systemd/notify"}, msg_iov(1)=[{"WATCHDOG=1", 10}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 10 596 close(14) = 0 596 timerfd_settime(12, TFD_TIMER_ABSTIME, {it_interval={0, 0}, it_value={583133, 283214000}}, NULL) = 0 596 kill(17492, SIGKILL) = 0 596 kill(17492, SIGCONT) = 0 596 sendmsg(5, {msg_name(0)=NULL, msg_iov(4)=[{"PRIORITY=3\nSYSLOG_FACILITY=3\nCOD"..., 133}, {"MESSAGE=", 8}, {"seq 10556 '/devices/pci0000:00/0"..., 100}, {"\n", 1}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 242 596 epoll_wait(10, {}, 11, 0) = 0 596 clock_gettime(CLOCK_BOOTTIME, {583004, 285443432}) = 0 596 epoll_wait(10, 17492 +++ killed by SIGKILL +++ 596 <... epoll_wait resumed> {{EPOLLIN, {u32=2122288400, u64=94912309595408}}}, 11, -1) = 1 596 clock_gettime(CLOCK_BOOTTIME, {583024, 514908703}) = 0 596 read(11, "\21\0\0\0\0\0\0\0\2\0\0\0TD\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 128) = 128 596 wait4(-1, [{WIFSIGNALED(s) && WTERMSIG(s) == SIGKILL}], WNOHANG, NULL) = 17492 596 sendmsg(5, {msg_name(0)=NULL, msg_iov(4)=[{"PRIORITY=4\nSYSLOG_FACILITY=3\nCOD"..., 128}, {"MESSAGE=", 8}, {"worker [17492] terminated by sig"..., 46}, {"\n", 1}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 183 596 sendmsg(5, {msg_name(0)=NULL, msg_iov(4)=[{"PRIORITY=3\nSYSLOG_FACILITY=3\nCOD"..., 128}, {"MESSAGE=", 8}, {"worker [17492] failed while hand"..., 120}, {"\n", 1}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 257 596 unlink("/run/udev/data/b8:32") = -1 ENOENT (No such file or directory) 596 open("/sys/devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host1/target1:0:3/1:0:3:0/block/sdc/uevent", O_RDONLY|O_CLOEXEC) = 14 596 fstat(14, {st_mode=S_IFREG|0644, st_size=4096, ...}) = 0 596 fstat(14, {st_mode=S_IFREG|0644, st_size=4096, ...}) = 0 596 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7ff6ab172000 596 read(14, "MAJOR=8\nMINOR=32\nDEVNAME=sdc\nDEV"..., 4096) = 42 596 read(14, "", 4096) = 0 596 read(14, "", 4096) = 0 596 close(14) = 0 596 munmap(0x7ff6ab172000, 4096) = 0 596 open("/run/udev/data/b8:32", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory) 596 sendmsg(3, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000002}, msg_iov(2)=[{"libudev\0\376\355\312\376(\0\0\0(\0\0\0\334\0\0\0\360\3\35\267{\313\305\356"..., 40}, {"DEVPATH=/devices/pci0000:00/0000"..., 220}], msg_controllen=0, msg_flags=0}, 0) = -1 ECONNREFUSED (Connection refused) 596 wait4(-1, 0x7ffe83f9d61c, WNOHANG, NULL) = -1 ECHILD (No child processes) 596 stat("/etc/udev/rules.d", {st_mode=S_IFDIR|0755, st_size=176, ...}) = 0 596 stat("/run/udev/rules.d", {st_mode=S_IFDIR|0755, st_size=40, ...}) = 0 596 stat("/usr/lib/udev/rules.d", {st_mode=S_IFDIR|0755, st_size=4098, ...}) = 0 596 stat("/etc/systemd/hwdb/hwdb.bin", 0x7ffe83f9d460) = -1 ENOENT (No such file or directory) 596 stat("/etc/udev/hwdb.bin", {st_mode=S_IFREG|0444, st_size=7007575, ...}) = 0 596 stat("/etc/modprobe.d", {st_mode=S_IFDIR|0755, st_size=392, ...}) = 0 596 stat("/lib/modules/4.4.104-18.44-default/modules.dep.bin", {st_mode=S_IFREG|0644, st_size=581226, ...}) = 0 596 stat("/lib/modules/4.4.104-18.44-default/modules.alias.bin", {st_mode=S_IFREG|0644, st_size=977379, ...}) = 0 596 stat("/lib/modules/4.4.104-18.44-default/modules.symbols.bin", {st_mode=S_IFREG|0644, st_size=620895, ...}) = 0 596 stat("/lib/modules/4.4.104-18.44-default/modules.builtin.bin", {st_mode=S_IFREG|0644, st_size=5168, ...}) = 0 596 stat("/etc/systemd/network", 0x7ffe83f9d440) = -1 ENOENT (No such file or directory) 596 stat("/run/systemd/network", 0x7ffe83f9d440) = -1 ENOENT (No such file or directory) 596 stat("/usr/lib/systemd/network", {st_mode=S_IFDIR|0755, st_size=128, ...}) = 0 596 stat("/lib/systemd/network", 0x7ffe83f9d440) = -1 ENOENT (No such file or directory) 596 socket(PF_NETLINK, SOCK_RAW|SOCK_CLOEXEC|SOCK_NONBLOCK, NETLINK_KOBJECT_UEVENT) = 14 596 bind(14, {sa_family=AF_NETLINK, pid=0, groups=00000000}, 12) = 0 596 getsockname(14, {sa_family=AF_NETLINK, pid=596, groups=00000000}, [12]) = 0 596 setsockopt(14, SOL_SOCKET, SO_PASSCRED, [1], 4) = 0 596 clone(child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x7ff6ab15cb90) = 17513 596 close(14) = 0 596 timerfd_settime(13, TFD_TIMER_ABSTIME, {it_interval={0, 0}, it_value={583085, 283214000}}, NULL) = 0 596 epoll_wait(10, {}, 11, 0) = 0 596 clock_gettime(CLOCK_BOOTTIME, {583024, 521367667}) = 0 596 epoll_wait(10, 17513 set_robust_list(0x7ff6ab15cba0, 24) = 0 596 <... epoll_wait resumed> {{EPOLLIN, {u32=2122290224, u64=94912309597232}}}, 11, -1) = 1 596 clock_gettime(CLOCK_BOOTTIME, {583024, 533831748}) = 0 596 recvmsg(3, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000001}, msg_iov(1)=[{"change@/devices/pci0000:00/0000:"..., 8192}], msg_controllen=32, [{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SCM_CREDENTIALS, {pid=0, uid=0, gid=0}}], msg_flags=0}, 0) = 284 596 getrandom("\33\2737~f\336\21\332\\\10\267\224|\31\3623", 16, GRND_NONBLOCK) = 16 596 getrandom( 17513 close(3 596 <... getrandom resumed> "h\352\375O\217\27\302T1\305\23+\276).\227", 16, GRND_NONBLOCK) = 16 596 getrandom("\254\223\366\216c\352\325(\244J)W\272\4K\24", 16, GRND_NONBLOCK) = 16 596 getrandom("\323\312'\203\265\365\244\26\232\203(\323\7\355\21\3", 16, GRND_NONBLOCK) = 16 596 getrandom("P \363\374V\363>(\255\342\23v)i\342\236", 16, GRND_NONBLOCK) = 16 596 getrandom( 17513 <... close resumed> ) = 0 596 <... getrandom resumed> "(Wmwz]c \375\264\212\321F#\2\245", 16, GRND_NONBLOCK) = 16 17513 close(4 596 epoll_wait(10, 17513 <... close resumed> ) = 0 17513 close(7 596 <... epoll_wait resumed> {}, 11, 0) = 0 17513 <... close resumed> ) = 0 17513 signalfd4(-1, ~[RTMIN RT_1], 8, O_NONBLOCK|O_CLOEXEC) = 3 17513 epoll_create1(EPOLL_CLOEXEC) = 4 17513 epoll_ctl(4, EPOLL_CTL_ADD, 3, {EPOLLIN, {u32=3, u64=3}}) = 0 17513 epoll_ctl(4, EPOLL_CTL_ADD, 14, {EPOLLIN, {u32=14, u64=14}}) = 0 17513 prctl(PR_SET_PDEATHSIG, SIGTERM) = 0 17513 open("/proc/self/oom_score_adj", O_WRONLY|O_NOCTTY|O_CLOEXEC) = 7 17513 fcntl(7, F_GETFL) = 0x8001 (flags O_WRONLY|O_LARGEFILE) 17513 fstat(7, {st_mode=S_IFREG|0644, st_size=0, ...}) = 0 17513 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7ff6ab172000 17513 write(7, "0\n", 2) = 2 17513 close(7) = 0 17513 munmap(0x7ff6ab172000, 4096) = 0 17513 open("/dev/sdc", O_RDONLY|O_NONBLOCK|O_NOFOLLOW|O_CLOEXEC 596 clock_gettime(CLOCK_BOOTTIME, {583024, 538011185}) = 0 596 epoll_wait(10, {{EPOLLIN, {u32=2122192824, u64=94912309499832}}}, 11, -1) = 1 596 clock_gettime(CLOCK_BOOTTIME, {583085, 283414558}) = 0 596 read(13, "\1\0\0\0\0\0\0\0", 8) = 8 596 socket(PF_LOCAL, SOCK_DGRAM|SOCK_CLOEXEC, 0) = 14 596 getsockopt(14, SOL_SOCKET, SO_SNDBUF, [212992], [4]) = 0 596 setsockopt(14, SOL_SOCKET, SO_SNDBUFFORCE, [8388608], 4) = 0 596 sendmsg(14, {msg_name(21)={sa_family=AF_LOCAL, sun_path="/run/systemd/notify"}, msg_iov(1)=[{"WATCHDOG=1", 10}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 10 596 close(14) = 0 596 timerfd_settime(12, TFD_TIMER_ABSTIME, {it_interval={0, 0}, it_value={583213, 283214000}}, NULL) = 0 596 sendmsg(5, {msg_name(0)=NULL, msg_iov(4)=[{"PRIORITY=4\nSYSLOG_FACILITY=3\nCOD"..., 141}, {"MESSAGE=", 8}, {"seq 10557 '/devices/pci0000:00/0"..., 115}, {"\n", 1}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 265 596 timerfd_settime(13, TFD_TIMER_ABSTIME, {it_interval={0, 0}, it_value={583205, 283214000}}, NULL) = 0 596 epoll_wait(10, {}, 11, 0) = 0 596 clock_gettime(CLOCK_BOOTTIME, {583085, 285743861}) = 0 596 epoll_wait(10, {{EPOLLIN, {u32=2122290224, u64=94912309597232}}}, 11, -1) = 1 596 clock_gettime(CLOCK_BOOTTIME, {583125, 12301198}) = 0 596 recvmsg(3, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000001}, msg_iov(1)=[{"change@/devices/pci0000:00/0000:"..., 8192}], msg_controllen=32, [{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SCM_CREDENTIALS, {pid=0, uid=0, gid=0}}], msg_flags=0}, 0) = 274 596 getrandom("\203\326\257al0Y\357XZ\345B,11\17", 16, GRND_NONBLOCK) = 16 596 getrandom("Pbm\341\346\3\301r\372\202\377\341\2137 \230", 16, GRND_NONBLOCK) = 16 596 getrandom("#\230\3762w\275\350D#\355\275\266f\r\370'", 16, GRND_NONBLOCK) = 16 596 getrandom("_u\247\17fb\332)\335\230\334\254\365pr8", 16, GRND_NONBLOCK) = 16 596 getrandom("\203\214c\360m\212\351(\10\303\227\251\5\336g\362", 16, GRND_NONBLOCK) = 16 596 getrandom("\t\251]\363L\240!\210'\361\252\30\334\231b\36", 16, GRND_NONBLOCK) = 16 596 stat("/etc/udev/rules.d", {st_mode=S_IFDIR|0755, st_size=176, ...}) = 0 596 stat("/run/udev/rules.d", {st_mode=S_IFDIR|0755, st_size=40, ...}) = 0 596 stat("/usr/lib/udev/rules.d", {st_mode=S_IFDIR|0755, st_size=4098, ...}) = 0 596 stat("/etc/systemd/hwdb/hwdb.bin", 0x7ffe83f9d470) = -1 ENOENT (No such file or directory) 596 stat("/etc/udev/hwdb.bin", {st_mode=S_IFREG|0444, st_size=7007575, ...}) = 0 596 stat("/etc/modprobe.d", {st_mode=S_IFDIR|0755, st_size=392, ...}) = 0 596 stat("/lib/modules/4.4.104-18.44-default/modules.dep.bin", {st_mode=S_IFREG|0644, st_size=581226, ...}) = 0 596 stat("/lib/modules/4.4.104-18.44-default/modules.alias.bin", {st_mode=S_IFREG|0644, st_size=977379, ...}) = 0 596 stat("/lib/modules/4.4.104-18.44-default/modules.symbols.bin", {st_mode=S_IFREG|0644, st_size=620895, ...}) = 0 596 stat("/lib/modules/4.4.104-18.44-default/modules.builtin.bin", {st_mode=S_IFREG|0644, st_size=5168, ...}) = 0 596 stat("/etc/systemd/network", 0x7ffe83f9d450) = -1 ENOENT (No such file or directory) 596 stat("/run/systemd/network", 0x7ffe83f9d450) = -1 ENOENT (No such file or directory) 596 stat("/usr/lib/systemd/network", {st_mode=S_IFDIR|0755, st_size=128, ...}) = 0 596 stat("/lib/systemd/network", 0x7ffe83f9d450) = -1 ENOENT (No such file or directory) 596 epoll_wait(10, {}, 11, 0) = 0 596 clock_gettime(CLOCK_BOOTTIME, {583125, 15391816}) = 0 596 epoll_wait(10, {{EPOLLIN, {u32=2122290224, u64=94912309597232}}}, 11, -1) = 1 596 clock_gettime(CLOCK_BOOTTIME, {583125, 23809899}) = 0 596 recvmsg(3, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000001}, msg_iov(1)=[{"change@/devices/pci0000:00/0000:"..., 8192}], msg_controllen=32, [{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SCM_CREDENTIALS, {pid=0, uid=0, gid=0}}], msg_flags=0}, 0) = 274 596 getrandom("\31-\347!\215p\324\265P\312\252\330\214]\220\37", 16, GRND_NONBLOCK) = 16 596 getrandom("8Y\255\341`\220\17\265\322e\233\267\332\352\226\202", 16, GRND_NONBLOCK) = 16 596 getrandom("\305\23\31\355z\326\32\345>c\251\324\202\346\262\4", 16, GRND_NONBLOCK) = 16 596 getrandom("\200\377McW\363\355T\213*N\210|\35q\333", 16, GRND_NONBLOCK) = 16 596 getrandom("{\276\321f7F^\375\305\306=O?\2133,", 16, GRND_NONBLOCK) = 16 596 getrandom("\37\302\260w\341\365\270\213\300\335\313\342\354\377j\233", 16, GRND_NONBLOCK) = 16 596 epoll_wait(10, {}, 11, 0) = 0 596 clock_gettime(CLOCK_BOOTTIME, {583125, 25550378}) = 0 596 epoll_wait(10, {{EPOLLIN, {u32=2122192824, u64=94912309499832}}}, 11, -1) = 1 596 clock_gettime(CLOCK_BOOTTIME, {583205, 283412078}) = 0 596 read(13, "\1\0\0\0\0\0\0\0", 8) = 8 596 socket(PF_LOCAL, SOCK_DGRAM|SOCK_CLOEXEC, 0) = 14 596 getsockopt(14, SOL_SOCKET, SO_SNDBUF, [212992], [4]) = 0 596 setsockopt(14, SOL_SOCKET, SO_SNDBUFFORCE, [8388608], 4) = 0 596 sendmsg(14, {msg_name(21)={sa_family=AF_LOCAL, sun_path="/run/systemd/notify"}, msg_iov(1)=[{"WATCHDOG=1", 10}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 10 596 close(14) = 0 596 timerfd_settime(12, TFD_TIMER_ABSTIME, {it_interval={0, 0}, it_value={583333, 283214000}}, NULL) = 0 596 kill(17513, SIGKILL) = 0 596 kill(17513, SIGCONT) = 0 596 sendmsg(5, {msg_name(0)=NULL, msg_iov(4)=[{"PRIORITY=3\nSYSLOG_FACILITY=3\nCOD"..., 133}, {"MESSAGE=", 8}, {"seq 10557 '/devices/pci0000:00/0"..., 100}, {"\n", 1}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 242 596 epoll_wait(10, {}, 11, 0) = 0 596 clock_gettime(CLOCK_BOOTTIME, {583205, 285612283}) = 0 596 epoll_wait(10, 17513 +++ killed by SIGKILL +++ 596 <... epoll_wait resumed> {{EPOLLIN, {u32=2122288400, u64=94912309595408}}}, 11, -1) = 1 596 clock_gettime(CLOCK_BOOTTIME, {583225, 458211927}) = 0 596 read(11, "\21\0\0\0\0\0\0\0\2\0\0\0iD\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 128) = 128 596 wait4(-1, [{WIFSIGNALED(s) && WTERMSIG(s) == SIGKILL}], WNOHANG, NULL) = 17513 596 sendmsg(5, {msg_name(0)=NULL, msg_iov(4)=[{"PRIORITY=4\nSYSLOG_FACILITY=3\nCOD"..., 128}, {"MESSAGE=", 8}, {"worker [17513] terminated by sig"..., 46}, {"\n", 1}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 183 596 sendmsg(5, {msg_name(0)=NULL, msg_iov(4)=[{"PRIORITY=3\nSYSLOG_FACILITY=3\nCOD"..., 128}, {"MESSAGE=", 8}, {"worker [17513] failed while hand"..., 120}, {"\n", 1}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 257 596 unlink("/run/udev/data/b8:32") = -1 ENOENT (No such file or directory) 596 open("/sys/devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host1/target1:0:3/1:0:3:0/block/sdc/uevent", O_RDONLY|O_CLOEXEC) = 14 596 fstat(14, {st_mode=S_IFREG|0644, st_size=4096, ...}) = 0 596 fstat(14, {st_mode=S_IFREG|0644, st_size=4096, ...}) = 0 596 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7ff6ab172000 596 read(14, "MAJOR=8\nMINOR=32\nDEVNAME=sdc\nDEV"..., 4096) = 42 596 read(14, "", 4096) = 0 596 read(14, "", 4096) = 0 596 close(14) = 0 596 munmap(0x7ff6ab172000, 4096) = 0 596 open("/run/udev/data/b8:32", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory) 596 sendmsg(3, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000002}, msg_iov(2)=[{"libudev\0\376\355\312\376(\0\0\0(\0\0\0\346\0\0\0\360\3\35\267{\313\305\356"..., 40}, {"DEVPATH=/devices/pci0000:00/0000"..., 230}], msg_controllen=0, msg_flags=0}, 0) = -1 ECONNREFUSED (Connection refused) 596 wait4(-1, 0x7ffe83f9d61c, WNOHANG, NULL) = -1 ECHILD (No child processes) 596 stat("/etc/udev/rules.d", {st_mode=S_IFDIR|0755, st_size=176, ...}) = 0 596 stat("/run/udev/rules.d", {st_mode=S_IFDIR|0755, st_size=40, ...}) = 0 596 stat("/usr/lib/udev/rules.d", {st_mode=S_IFDIR|0755, st_size=4098, ...}) = 0 596 stat("/etc/systemd/hwdb/hwdb.bin", 0x7ffe83f9d460) = -1 ENOENT (No such file or directory) 596 stat("/etc/udev/hwdb.bin", {st_mode=S_IFREG|0444, st_size=7007575, ...}) = 0 596 stat("/etc/modprobe.d", {st_mode=S_IFDIR|0755, st_size=392, ...}) = 0 596 stat("/lib/modules/4.4.104-18.44-default/modules.dep.bin", {st_mode=S_IFREG|0644, st_size=581226, ...}) = 0 596 stat("/lib/modules/4.4.104-18.44-default/modules.alias.bin", {st_mode=S_IFREG|0644, st_size=977379, ...}) = 0 596 stat("/lib/modules/4.4.104-18.44-default/modules.symbols.bin", {st_mode=S_IFREG|0644, st_size=620895, ...}) = 0 596 stat("/lib/modules/4.4.104-18.44-default/modules.builtin.bin", {st_mode=S_IFREG|0644, st_size=5168, ...}) = 0 596 stat("/etc/systemd/network", 0x7ffe83f9d440) = -1 ENOENT (No such file or directory) 596 stat("/run/systemd/network", 0x7ffe83f9d440) = -1 ENOENT (No such file or directory) 596 stat("/usr/lib/systemd/network", {st_mode=S_IFDIR|0755, st_size=128, ...}) = 0 596 stat("/lib/systemd/network", 0x7ffe83f9d440) = -1 ENOENT (No such file or directory) 596 socket(PF_NETLINK, SOCK_RAW|SOCK_CLOEXEC|SOCK_NONBLOCK, NETLINK_KOBJECT_UEVENT) = 14 596 bind(14, {sa_family=AF_NETLINK, pid=0, groups=00000000}, 12) = 0 596 getsockname(14, {sa_family=AF_NETLINK, pid=596, groups=00000000}, [12]) = 0 596 setsockopt(14, SOL_SOCKET, SO_PASSCRED, [1], 4) = 0 596 clone(child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x7ff6ab15cb90) = 17562 596 close(14) = 0 596 timerfd_settime(13, TFD_TIMER_ABSTIME, {it_interval={0, 0}, it_value={583286, 283214000}}, NULL) = 0 596 epoll_wait(10, {}, 11, 0) = 0 596 clock_gettime(CLOCK_BOOTTIME, {583225, 462566489}) = 0 596 epoll_wait(10, 17562 set_robust_list(0x7ff6ab15cba0, 24) = 0 17562 close(3) = 0 17562 close(4) = 0 17562 close(7) = 0 17562 signalfd4(-1, ~[RTMIN RT_1], 8, O_NONBLOCK|O_CLOEXEC) = 3 17562 epoll_create1(EPOLL_CLOEXEC) = 4 17562 epoll_ctl(4, EPOLL_CTL_ADD, 3, {EPOLLIN, {u32=3, u64=3}}) = 0 17562 epoll_ctl(4, EPOLL_CTL_ADD, 14, {EPOLLIN, {u32=14, u64=14}}) = 0 17562 prctl(PR_SET_PDEATHSIG, SIGTERM) = 0 17562 open("/proc/self/oom_score_adj", O_WRONLY|O_NOCTTY|O_CLOEXEC) = 7 17562 fcntl(7, F_GETFL) = 0x8001 (flags O_WRONLY|O_LARGEFILE) 17562 fstat(7, 596 <... epoll_wait resumed> {{EPOLLIN, {u32=2122290224, u64=94912309597232}}}, 11, -1) = 1 17562 <... fstat resumed> {st_mode=S_IFREG|0644, st_size=0, ...}) = 0 17562 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 596 clock_gettime(CLOCK_BOOTTIME, 17562 <... mmap resumed> ) = 0x7ff6ab172000 596 <... clock_gettime resumed> {583225, 476952391}) = 0 17562 write(7, "0\n", 2) = 2 596 recvmsg(3, 17562 close(7 596 <... recvmsg resumed> {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000001}, msg_iov(1)=[{"change@/devices/pci0000:00/0000:"..., 8192}], msg_controllen=32, [{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SCM_CREDENTIALS, {pid=0, uid=0, gid=0}}], msg_flags=0}, 0) = 284 17562 <... close resumed> ) = 0 17562 munmap(0x7ff6ab172000, 4096 596 getrandom( 17562 <... munmap resumed> ) = 0 596 <... getrandom resumed> "\372\373:\260\t\21)\352\374;\21\220JY\332V", 16, GRND_NONBLOCK) = 16 596 getrandom( 17562 open("/dev/sdc", O_RDONLY|O_NONBLOCK|O_NOFOLLOW|O_CLOEXEC 596 <... getrandom resumed> "o\267\250\315\341w\237tb\215\32\201I3\17\177", 16, GRND_NONBLOCK) = 16 596 getrandom("\t\373\203d\236-\26\315[u\300\217\236o\0U", 16, GRND_NONBLOCK) = 16 596 getrandom("\320$6\370\236\223\355\333\225\205\216\344\306\306\264\n", 16, GRND_NONBLOCK) = 16 596 getrandom("\2018\23W\357{ 17562 +++ killed by SIGKILL +++ 596 <... epoll_wait resumed> {{EPOLLIN, {u32=2122288400, u64=94912309595408}}}, 11, -1) = 1 596 clock_gettime(CLOCK_BOOTTIME, {583426, 402357750}) = 0 596 read(11, "\21\0\0\0\0\0\0\0\2\0\0\0\232D\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 128) = 128 596 wait4(-1, [{WIFSIGNALED(s) && WTERMSIG(s) == SIGKILL}], WNOHANG, NULL) = 17562 596 sendmsg(5, {msg_name(0)=NULL, msg_iov(4)=[{"PRIORITY=4\nSYSLOG_FACILITY=3\nCOD"..., 128}, {"MESSAGE=", 8}, {"worker [17562] terminated by sig"..., 46}, {"\n", 1}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 183 596 sendmsg(5, {msg_name(0)=NULL, msg_iov(4)=[{"PRIORITY=3\nSYSLOG_FACILITY=3\nCOD"..., 128}, {"MESSAGE=", 8}, {"worker [17562] failed while hand"..., 120}, {"\n", 1}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 257 596 unlink("/run/udev/data/b8:32") = -1 ENOENT (No such file or directory) 596 open("/sys/devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host1/target1:0:3/1:0:3:0/block/sdc/uevent", O_RDONLY|O_CLOEXEC) = 14 596 fstat(14, {st_mode=S_IFREG|0644, st_size=4096, ...}) = 0 596 fstat(14, {st_mode=S_IFREG|0644, st_size=4096, ...}) = 0 596 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7ff6ab172000 596 read(14, "MAJOR=8\nMINOR=32\nDEVNAME=sdc\nDEV"..., 4096) = 42 596 read(14, "", 4096) = 0 596 read(14, "", 4096) = 0 596 close(14) = 0 596 munmap(0x7ff6ab172000, 4096) = 0 596 open("/run/udev/data/b8:32", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory) 596 sendmsg(3, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000002}, msg_iov(2)=[{"libudev\0\376\355\312\376(\0\0\0(\0\0\0\334\0\0\0\360\3\35\267{\313\305\356"..., 40}, {"DEVPATH=/devices/pci0000:00/0000"..., 220}], msg_controllen=0, msg_flags=0}, 0) = -1 ECONNREFUSED (Connection refused) 596 wait4(-1, 0x7ffe83f9d61c, WNOHANG, NULL) = -1 ECHILD (No child processes) 596 stat("/etc/udev/rules.d", {st_mode=S_IFDIR|0755, st_size=176, ...}) = 0 596 stat("/run/udev/rules.d", {st_mode=S_IFDIR|0755, st_size=40, ...}) = 0 596 stat("/usr/lib/udev/rules.d", {st_mode=S_IFDIR|0755, st_size=4098, ...}) = 0 596 stat("/etc/systemd/hwdb/hwdb.bin", 0x7ffe83f9d460) = -1 ENOENT (No such file or directory) 596 stat("/etc/udev/hwdb.bin", {st_mode=S_IFREG|0444, st_size=7007575, ...}) = 0 596 stat("/etc/modprobe.d", {st_mode=S_IFDIR|0755, st_size=392, ...}) = 0 596 stat("/lib/modules/4.4.104-18.44-default/modules.dep.bin", {st_mode=S_IFREG|0644, st_size=581226, ...}) = 0 596 stat("/lib/modules/4.4.104-18.44-default/modules.alias.bin", {st_mode=S_IFREG|0644, st_size=977379, ...}) = 0 596 stat("/lib/modules/4.4.104-18.44-default/modules.symbols.bin", {st_mode=S_IFREG|0644, st_size=620895, ...}) = 0 596 stat("/lib/modules/4.4.104-18.44-default/modules.builtin.bin", {st_mode=S_IFREG|0644, st_size=5168, ...}) = 0 596 stat("/etc/systemd/network", 0x7ffe83f9d440) = -1 ENOENT (No such file or directory) 596 stat("/run/systemd/network", 0x7ffe83f9d440) = -1 ENOENT (No such file or directory) 596 stat("/usr/lib/systemd/network", {st_mode=S_IFDIR|0755, st_size=128, ...}) = 0 596 stat("/lib/systemd/network", 0x7ffe83f9d440) = -1 ENOENT (No such file or directory) 596 socket(PF_NETLINK, SOCK_RAW|SOCK_CLOEXEC|SOCK_NONBLOCK, NETLINK_KOBJECT_UEVENT) = 14 596 bind(14, {sa_family=AF_NETLINK, pid=0, groups=00000000}, 12) = 0 596 getsockname(14, {sa_family=AF_NETLINK, pid=596, groups=00000000}, [12]) = 0 596 setsockopt(14, SOL_SOCKET, SO_PASSCRED, [1], 4) = 0 596 clone(child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x7ff6ab15cb90) = 17792 596 close(14) = 0 596 timerfd_settime(13, TFD_TIMER_ABSTIME, {it_interval={0, 0}, it_value={583487, 283214000}}, NULL) = 0 596 epoll_wait(10, {}, 11, 0) = 0 596 clock_gettime(CLOCK_BOOTTIME, {583426, 407987625}) = 0 596 epoll_wait(10, 17792 set_robust_list(0x7ff6ab15cba0, 24) = 0 17792 close(3) = 0 17792 close(4) = 0 17792 close(7) = 0 17792 signalfd4(-1, ~[RTMIN RT_1], 8, O_NONBLOCK|O_CLOEXEC) = 3 17792 epoll_create1(EPOLL_CLOEXEC) = 4 17792 epoll_ctl(4, EPOLL_CTL_ADD, 3, {EPOLLIN, {u32=3, u64=3}}) = 0 17792 epoll_ctl(4, EPOLL_CTL_ADD, 14, {EPOLLIN, {u32=14, u64=14}}) = 0 17792 prctl(PR_SET_PDEATHSIG, SIGTERM) = 0 17792 open("/proc/self/oom_score_adj", O_WRONLY|O_NOCTTY|O_CLOEXEC) = 7 17792 fcntl(7, F_GETFL) = 0x8001 (flags O_WRONLY|O_LARGEFILE) 17792 fstat(7, {st_mode=S_IFREG|0644, st_size=0, ...}) = 0 17792 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7ff6ab172000 17792 write(7, "0\n", 2) = 2 17792 close(7 596 <... epoll_wait resumed> {{EPOLLIN, {u32=2122290224, u64=94912309597232}}}, 11, -1) = 1 17792 <... close resumed> ) = 0 17792 munmap(0x7ff6ab172000, 4096 596 clock_gettime(CLOCK_BOOTTIME, 17792 <... munmap resumed> ) = 0 596 <... clock_gettime resumed> {583426, 421239448}) = 0 17792 open("/dev/sdc", O_RDONLY|O_NONBLOCK|O_NOFOLLOW|O_CLOEXEC 596 recvmsg(3, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000001}, msg_iov(1)=[{"change@/devices/pci0000:00/0000:"..., 8192}], msg_controllen=32, [{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SCM_CREDENTIALS, {pid=0, uid=0, gid=0}}], msg_flags=0}, 0) = 284 596 getrandom("W[\350Q!\340\30\270\307\244\20\311x\326\32\222", 16, GRND_NONBLOCK) = 16 596 getrandom("\177\343\3608\376'\253\242\320\353\321A\"\313\32\317", 16, GRND_NONBLOCK) = 16 596 getrandom("\355\356\10\201y7\3262\7i\323\232(\nb\356", 16, GRND_NONBLOCK) = 16 596 getrandom("\364\"e\332\233\373\275\262O{!\201\322\343\335\274", 16, GRND_NONBLOCK) = 16 596 getrandom("0\37\23-\332\200\354\5#\267\347\326\307B\277)", 16, GRND_NONBLOCK) = 16 596 getrandom("\373\26@\r!\225[\200\7pgV\375\375R\7", 16, GRND_NONBLOCK) = 16 596 epoll_wait(10, {}, 11, 0) = 0 596 clock_gettime(CLOCK_BOOTTIME, {583426, 421996081}) = 0 596 epoll_wait(10, -- To unsubscribe, e-mail: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org

On 04/01/2018 10:22, Andrei Borzenkov wrote:

04.01.2018 12:06, Paul Neuwirth пишет:

...

KERNEL[487838.926954] add /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[487838.926986] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[487838.927021] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[487838.927054] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[487939.384425] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[488039.884765] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[488039.895676] change /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block)

OK, this confirms that at the end it is kernel issue. You should really report it to kernel folks as true solution must be implemented in kernel driver.

So there are two issues - (initial) spin up and permanent stream of "change" events. To workaround the latter - try disabling periodic device polling in kernel:

echo 0 > /sys/block/sdc/events_poll_msecs

and check with "udevadm monitor" whether events stop.

For the former you can pass quirk parameter to scsi_mod; create /etc/modprobe.d/teac.conf (name is arbitrary) with:

options scsi_mod dev_flags=TEAC:FC-5:4096

Check /sys/block/sdc/device/{vendor,model} for correct values. This flag suppresses initial spin up of device. You will need to reboot (and do not forget you also need to recreate initrd as scsi_mod is most likely loaded there).

I know this is old but I had to use my floppy drive today to update a device firmware. I actually forgot about this issue. My workaround until now was to insert a broken floppy disk and it stopped the drive being polled. I just tried: echo 0 > /sys/block/sdd/events_poll_msecs as root and this workaround sorts out the problem until reboot. udevadm monitor shows nothing before or after this command. by default /sys/block/sdd/events_poll_msecs is set to -1 This problem also exists on my dual boot of Ubuntu 18.04.1, on which the same workaround is working. How can I make this workaround permanent? Or has this been resolved and not released yet? Running on latest LEAP -- To unsubscribe, e-mail: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org

22.10.2018 22:49, Paul Groves пишет:

On 04/01/2018 10:22, Andrei Borzenkov wrote:

...

04.01.2018 12:06, Paul Neuwirth пишет:

...

KERNEL[487838.926954] add      /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[487838.926986] change   /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[487838.927021] change   /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[487838.927054] change   /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[487939.384425] change   /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[488039.884765] change   /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block) KERNEL[488039.895676] change   /devices/pci0000:00/0000:00:0a.0/0000:01:06.0/host0/target0:0:3/0:0:3:0/block/sdc (block)

OK, this confirms that at the end it is kernel issue. You should really report it to kernel folks as true solution must be implemented in kernel driver.

So there are two issues - (initial) spin up and permanent stream of "change" events. To workaround the latter - try disabling periodic device polling in kernel:

echo 0 > /sys/block/sdc/events_poll_msecs

and check with "udevadm monitor" whether events stop.

For the former you can pass quirk parameter to scsi_mod; create /etc/modprobe.d/teac.conf (name is arbitrary) with:

options scsi_mod dev_flags=TEAC:FC-5:4096

Check /sys/block/sdc/device/{vendor,model} for correct values. This flag suppresses initial spin up of device. You will need to reboot (and do not forget you also need to recreate initrd as scsi_mod is most likely loaded there).

I know this is old but I had to use my floppy drive today to update a device firmware. I actually forgot about this issue. My workaround until now was to insert a broken floppy disk and it stopped the drive being polled.

I just tried: echo 0 > /sys/block/sdd/events_poll_msecs

as root and this workaround sorts out the problem until reboot.

udevadm monitor shows nothing before or after this command. by default /sys/block/sdd/events_poll_msecs is set to -1

This problem also exists on my dual boot of Ubuntu 18.04.1, on which the same workaround is working.

How can I make this workaround permanent?

You can create udev rule, you can create start-up script that runs on boot ...

Or has this been resolved and not released yet?

You mean you did not bother to report it in almost 2 years?

Running on latest LEAP

-- To unsubscribe, e-mail: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org