Por que demora tanto para detectar um pendrive?

Question

Estou escrevendo um script initramfs e quero detectar usb-sticks o mais rápido possível.

Quando insiro um stick usb 2.0, a detecção de idVendor, idProduct e classe USB acontece dentro de 100 ms. Mas o subsistema scsi não "anexa" até que cerca de 1 s tenha passado e leva 500 ms antes que a partição seja totalmente reconhecida.

Eu suponho que o driver precisa ler a tabela de partições para detectar partições. Por que demora tanto tempo? Eu não espero que o tempo de envio / recepção urbano seja tão longo ou o tempo de acesso do flash demore tanto tempo.

Eu tentei 5 paus de diferentes fornecedores e o resultado é o mesmo.

[ 5731.097540] usb 2-1.2: new high-speed USB device number 7 using ehci-pci
[ 5731.195360] usb 2-1.2: New USB device found, idVendor=0951, idProduct=1643
[ 5731.195368] usb 2-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[ 5731.195372] usb 2-1.2: Product: DataTraveler G3
[ 5731.195376] usb 2-1.2: Manufacturer: Kingston
[ 5731.195379] usb 2-1.2: SerialNumber: 001CC0EC32BCBBB04712022C
[ 5731.196942] usb-storage 2-1.2:1.0: USB Mass Storage device detected
[ 5731.197193] scsi host9: usb-storage 2-1.2:1.0
[ 5732.268389] scsi 9:0:0:0: Direct-Access     Kingston DataTraveler G3  PMAP PQ: 0 ANSI: 0 CCS
[ 5732.268995] sd 9:0:0:0: Attached scsi generic sg2 type 0
[ 5732.883939] sd 9:0:0:0: [sdb] 7595520 512-byte logical blocks: (3.88 GB/3.62 GiB)
[ 5732.884565] sd 9:0:0:0: [sdb] Write Protect is off
[ 5732.884568] sd 9:0:0:0: [sdb] Mode Sense: 23 00 00 00
[ 5732.885178] sd 9:0:0:0: [sdb] No Caching mode page found
[ 5732.885181] sd 9:0:0:0: [sdb] Assuming drive cache: write through
[ 5732.903834]  sdb: sdb1
[ 5732.906812] sd 9:0:0:0: [sdb] Attached SCSI removable disk

Editar Então, encontrei o parâmetro de módulo delay_use que por padrão é definido como 1 segundo, o que explica o atraso que estou vendo. Mas eu estou querendo saber se alguém pode fornecer contexto por que esse parâmetro é necessário? Um comentário sugeriu que para sticks usb mais antigos, delay_use pode precisar ser configurado para até 5 segundos. O que é dentro do pendrive que leva tanto tempo; inicialização de firmware; lê a partir do flash? Acho difícil acreditar que precisamos de atrasos de 1 segundo ou mais quando a latência para acessar o flash é da ordem de dezenas de microssegundos.

Sei que isso pode ser um pouco fora do tópico para este canal, se for o caso, vou para electronics.stackexchange.com

    

Answer 1

Você pode alterar o tempo limite escrevendo para /sys/module/usb_storage/parameters/delay_use .

Para discos usb mais antigos, um atraso de 5 segundos ou até mais pode ser necessário (e 5 foi o padrão até ser reduzido para 1 segundo em 2010), presumivelmente porque o controlador está com falta de energia enquanto os motores de disco estão inicializando. Ou possivelmente porque o firmware interno do SCSI leva tempo para inicializar antes de responder (você pode dizer que estou apenas especulando aqui?).

Para armazenamento em estado sólido moderno, provavelmente não é necessário, e muitas pessoas definem como 0. Infelizmente, é um parâmetro global que se aplica a todos os dispositivos, portanto, se você tiver dispositivos lentos, precisará suportar o atraso para cada dispositivo USB de armazenamento em massa que você usa. Seria bom se pudesse ser definido por dispositivo pelo udev, mas esse não é o caso.

    

Answer 2

Acontece que há um tempo limite de 1 segundo int drivers / usb / storage / usb.c . Eu habilitei mais depuração de log, digitando os dois comandos a seguir:

echo 8 > /proc/sys/kernel/printk
echo "module usb_storage +p" > /sys/kernel/debug/dynamic_debug/control
echo 0xFFFFFF > /proc/sys/dev/scsi/logging_level

O subsistema scsi tem uma maneira estranha (em comparação com o resto das facilidades de log de linux) de especificar os níveis de log; eles são bits deslocados um passo para cada nível, consulte drivers / scsi / scsi_logging.h

Veja a linha starting scan abaixo. O kernel aguarda 1 segundo antes de fazer a varredura.

[21960.837879 <   23.040778>] usb 2-1.2: USB disconnect, device number 18
[21960.838263 <    0.000384>] sd 20:0:0:0: [sg2] sg_remove_device
[21960.838888 <    0.000625>] sd 20:0:0:0: [sg2] sg_device_destroy
[21966.157918 <    5.319030>] usb 2-1.2: new high-speed USB device number 19 using ehci-pci
[21966.251625 <    0.093707>] usb 2-1.2: New USB device found, idVendor=0781, idProduct=5530
[21966.251634 <    0.000009>] usb 2-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[21966.251638 <    0.000004>] usb 2-1.2: Product: Firebird USB Flash Drive
[21966.251641 <    0.000003>] usb 2-1.2: Manufacturer: SanDisk
[21966.251644 <    0.000003>] usb 2-1.2: SerialNumber: 4C532000001215110130
[21966.252184 <    0.000540>] usb-storage 2-1.2:1.0: USB Mass Storage device detected
[21966.252307 <    0.000123>] scsi host21: usb-storage 2-1.2:1.0
[21966.252439 <    0.000132>] usb-storage 2-1.2:1.0: waiting for device to settle before scanning
[21967.250018 <    0.997579>] usb-storage 2-1.2:1.0: starting scan
[21967.250242 <    0.000224>] usb-storage 2-1.2:1.0: scan complete
[21967.250295 <    0.000053>] scsi host21: scsi_scan_host_selected: <4294967295:4294967295:18446744073709551615>
[21967.250354 <    0.000059>] scsi 21:0:0:0: scsi scan: INQUIRY pass 1 length 36
[21967.251717 <    0.001363>] scsi 21:0:0:0: scsi scan: INQUIRY successful with code 0x0
[21967.251738 <    0.000021>] scsi 21:0:0:0: Direct-Access     SanDisk  Cruzer           1.26 PQ: 0 ANSI: 5
[21967.251745 <    0.000007>] scsi target21:0:0: scsi scan: Sequential scan
[21967.251776 <    0.000031>] scsi 21:0:0:1: scsi scan: INQUIRY pass 1 length 36
[21967.251907 <    0.000131>] scsi 21:0:0:1: scsi scan: INQUIRY failed with code 0x40000
[21967.252282 <    0.000375>] sd 21:0:0:0: sg_alloc: dev=2 
[21967.252366 <    0.000084>] sd 21:0:0:0: Attached scsi generic sg2 type 0
[21967.253703 <    0.001337>] sd 21:0:0:0: [sdb] 7821312 512-byte logical blocks: (4.00 GB/3.72 GiB)
[21967.255324 <    0.001621>] sd 21:0:0:0: [sdb] Write Protect is off
[21967.255334 <    0.000010>] sd 21:0:0:0: [sdb] Mode Sense: 43 00 00 00
[21967.258145 <    0.002811>] sd 21:0:0:0: [sdb] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
[21967.272208 <    0.014063>]  sdb: sdb1
[21967.276433 <    0.004225>] sd 21:0:0:0: [sdb] Attached SCSI removable disk

Linus Torvalds alterou o atraso padrão de 5 para 1 segundo em Diminuir o atraso de armazenamento de armazenamento USB para algo mais razoável . Ele não fornece nenhum contexto sobre as razões técnicas de porque o atraso foi definido tão alto, mas sugere que ele pode ter mascarado alguns bugs do kernel.