LINUX.ORG.RU

Ubuntu 17.04 долгая загрузка

 , , ,


1

1

Здравствуйте! Ubuntu 17.04 Desktop. Не скажу, что прям очень долгая, но в сравнении с 16-ой в два, а то и три раза дольше. Момент, когда по центру надпись Ubuntu и меняющиеся точечки под ней. Ближе к концу лога странный скачёк на 90 секунд.

dmesg:

.......


[    1.440862] ata5: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[    1.442511] ACPI Error: [DSSP] Namespace lookup failure, AE_NOT_FOUND (20160930/psargs-359)
[    1.442515] ACPI Error: Method parse/execution failed [\_SB.PCI0.SAT0.SPT0._GTF] (Node ffff927ece0dcf28), AE_NOT_FOUND (20160930/psparse-543)
[    1.442724] ata3.00: ATA-8: WDC WD10EALX-759BA1, 17.01H17, max UDMA/133
[    1.442725] ata3.00: 1953525168 sectors, multi 16: LBA48 NCQ (depth 31/32), AA
[    1.442777] ACPI Error: [DSSP] Namespace lookup failure, AE_NOT_FOUND (20160930/psargs-359)
[    1.442781] ACPI Error: Method parse/execution failed [\_SB.PCI0.SAT0.SPT1._GTF] (Node ffff927ece0dce10), AE_NOT_FOUND (20160930/psparse-543)
[    1.443014] ata4.00: ATA-8: WDC WD10EALX-009BA0, 15.01H15, max UDMA/133
[    1.443015] ata4.00: 1953525168 sectors, multi 16: LBA48 NCQ (depth 31/32), AA
[    1.443047] ACPI Error: [DSSP] Namespace lookup failure, AE_NOT_FOUND (20160930/psargs-359)
[    1.443051] ACPI Error: Method parse/execution failed [\_SB.PCI0.SAT0.SPT3._GTF] (Node ffff927ece0dc780), AE_NOT_FOUND (20160930/psparse-543)
[    1.443056] ata6.00: ATAPI: HL-DT-ST DVDRAM GH22NS70, EX00, max UDMA/100
[    1.444684] ACPI Error: [DSSP] Namespace lookup failure, AE_NOT_FOUND (20160930/psargs-359)
[    1.444688] ACPI Error: Method parse/execution failed [\_SB.PCI0.SAT0.SPT0._GTF] (Node ffff927ece0dcf28), AE_NOT_FOUND (20160930/psparse-543)
[    1.445017] ACPI Error: [DSSP] Namespace lookup failure, AE_NOT_FOUND (20160930/psargs-359)
[    1.445021] ACPI Error: Method parse/execution failed [\_SB.PCI0.SAT0.SPT1._GTF] (Node ffff927ece0dce10), AE_NOT_FOUND (20160930/psparse-543)
[    1.445232] ata4.00: configured for UDMA/133
[    1.445562] ata3.00: configured for UDMA/133
[    1.445756] scsi 2:0:0:0: Direct-Access     ATA      WDC WD10EALX-759 1H17 PQ: 0 ANSI: 5
[    1.446909] ACPI Error: [DSSP] Namespace lookup failure, AE_NOT_FOUND (20160930/psargs-359)
[    1.446913] ACPI Error: Method parse/execution failed [\_SB.PCI0.SAT0.SPT2._GTF] (Node ffff927ece0dccd0), AE_NOT_FOUND (20160930/psparse-543)
[    1.447305] ACPI Error: [DSSP] Namespace lookup failure, AE_NOT_FOUND (20160930/psargs-359)
[    1.447309] ACPI Error: Method parse/execution failed [\_SB.PCI0.SAT0.SPT3._GTF] (Node ffff927ece0dc780), AE_NOT_FOUND (20160930/psparse-543)
[    1.447316] ata6.00: configured for UDMA/100
[    1.447391] ata5.00: ATA-8: WDC WD20EARX-00PASB0, 51.0AB51, max UDMA/133
[    1.447391] ata5.00: 3907029168 sectors, multi 16: LBA48 NCQ (depth 31/32), AA
[    1.453533] ACPI Error: [DSSP] Namespace lookup failure, AE_NOT_FOUND (20160930/psargs-359)
[    1.453537] ACPI Error: Method parse/execution failed [\_SB.PCI0.SAT0.SPT2._GTF] (Node ffff927ece0dccd0), AE_NOT_FOUND (20160930/psparse-543)
[    1.454410] ata5.00: configured for UDMA/133
[    1.462131] [drm] Initialized nouveau 1.3.1 20120801 for 0000:01:00.0 on minor 0


.........


[   10.470310] audit: type=1400 audit(1505040410.924:2): apparmor="STATUS" operation="profile_load" profile="unconfined" name="content-hub-clipboard" pid=796 comm="apparmor_parser"
[   10.470316] audit: type=1400 audit(1505040410.924:3): apparmor="STATUS" operation="profile_load" profile="unconfined" name="content-hub-peer-picker" pid=797 comm="apparmor_parser"
[   10.551614] audit: type=1400 audit(1505040411.012:4): apparmor="STATUS" operation="profile_load" profile="unconfined" name="url-dispatcher-bad-url-helper" pid=835 comm="apparmor_parser"
[   10.673931] audit: type=1400 audit(1505040411.128:5): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/sbin/dhclient" pid=799 comm="apparmor_parser"
[   10.673933] audit: type=1400 audit(1505040411.128:6): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/NetworkManager/nm-dhcp-client.action" pid=799 comm="apparmor_parser"
[   10.673934] audit: type=1400 audit(1505040411.128:7): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/NetworkManager/nm-dhcp-helper" pid=799 comm="apparmor_parser"
[   10.673934] audit: type=1400 audit(1505040411.128:8): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/connman/scripts/dhclient-script" pid=799 comm="apparmor_parser"
[   10.673995] audit: type=1400 audit(1505040411.128:9): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/lightdm/lightdm-guest-session" pid=798 comm="apparmor_parser"
[   10.673996] audit: type=1400 audit(1505040411.128:10): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/lightdm/lightdm-guest-session//chromium" pid=798 comm="apparmor_parser"
[   10.704904] audit: type=1400 audit(1505040411.160:11): apparmor="STATUS" operation="profile_load" profile="unconfined" name="unity8-dash" pid=845 comm="apparmor_parser"
[  100.003869] IPv6: ADDRCONF(NETDEV_UP): enp4s0: link is not ready
[  100.004408] IPv6: ADDRCONF(NETDEV_UP): enp4s0: link is not ready


..........

Ответ на: комментарий от iljuase

systemd-analyze blame

20.927s apt-daily.service
          7.222s mysql.service
          7.179s NetworkManager-wait-online.service
          5.660s dev-sda2.device
          4.280s apparmor.service
          4.108s ModemManager.service
          3.670s accounts-daemon.service
          3.250s apache2.service
          2.659s grub-common.service
          2.610s fwupd.service
          2.578s NetworkManager.service
          2.497s redis-server.service
          2.141s snapd.service
          1.921s irqbalance.service
          1.919s speech-dispatcher.service
          1.745s polkit.service
          1.738s keyboard-setup.service
          1.338s gpu-manager.service
          1.338s thermald.service
          1.330s alsa-restore.service
          1.326s pppd-dns.service
          1.323s rsyslog.service
          1.273s lightdm.service
          1.272s plymouth-quit-wait.service
          1.240s avahi-daemon.service
          1.178s systemd-modules-load.service
          1.135s repowerd.service
           859ms systemd-tmpfiles-setup-dev.service
           841ms plymouth-start.service
           829ms dns-clean.service
           778ms upower.service
           709ms systemd-tmpfiles-setup.service
           683ms systemd-logind.service
           675ms console-setup.service
           663ms colord.service
           638ms apport.service
           576ms systemd-timesyncd.service
           575ms systemd-journald.service
           462ms systemd-resolved.service
           384ms udisks2.service
           369ms resolvconf.service
           355ms systemd-udevd.service
           316ms swapfile.swap
           276ms systemd-user-sessions.service
           275ms openvpn.service
           275ms plymouth-read-write.service
           269ms rtkit-daemon.service
           237ms systemd-update-utmp.service
           215ms systemd-sysctl.service
           188ms dev-hugepages.mount
           186ms sys-kernel-debug.mount
           185ms setvtrgb.service
           169ms packagekit.service
           150ms networking.service
           131ms phpsessionclean.service
           130ms systemd-journal-flush.service
           124ms systemd-remount-fs.service

Obelix ()
Ответ на: комментарий от ozz_is_here

ХЗ, роутер всегда раздаёт IPv4 Думаю, можно спокойно отключить их. Странно, что система не бете, а из-за такой мелочи может на полторы минуты оттормаживать загрузку..

Obelix ()
Ответ на: комментарий от ozz_is_here

Сделал как ты сказал. Бутнулся.

dmesg:

[   13.404165] asus_wmi: SFUN value: 0x0
[   13.404361] input: Eee PC WMI hotkeys as /devices/platform/eeepc-wmi/input/input20
[   13.404411] asus_wmi: Number of fans: 1
[   14.163847] input: HDA NVidia HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:01.0/0000:01:00.1/sound/card1/input21
[   14.164518] input: HDA NVidia HDMI/DP,pcm=7 as /devices/pci0000:00/0000:00:01.0/0000:01:00.1/sound/card1/input22
[   14.164558] input: HDA NVidia HDMI/DP,pcm=8 as /devices/pci0000:00/0000:00:01.0/0000:01:00.1/sound/card1/input23
[   14.164590] input: HDA NVidia HDMI/DP,pcm=9 as /devices/pci0000:00/0000:00:01.0/0000:01:00.1/sound/card1/input24
[   96.056838] kauditd_printk_skb: 26 callbacks suppressed
[   96.056839] audit: type=1400 audit(1505052337.508:38): apparmor="DENIED" operation="open" profile="/usr/sbin/mysqld" name="/proc/1176/status" pid=1176 comm="mysqld" requested_mask="r" denied_mask="r" fsuid=123 ouid=123
[   96.056849] audit: type=1400 audit(1505052337.508:39): apparmor="DENIED" operation="open" profile="/usr/sbin/mysqld" name="/sys/devices/system/node/" pid=1176 comm="mysqld" requested_mask="r" denied_mask="r" fsuid=123 ouid=0
[   96.056886] audit: type=1400 audit(1505052337.508:40): apparmor="DENIED" operation="open" profile="/usr/sbin/mysqld" name="/proc/1176/status" pid=1176 comm="mysqld" requested_mask="r" denied_mask="r" fsuid=123 ouid=123
[   96.431540] IPv6: ADDRCONF(NETDEV_UP): enp4s0: link is not ready
[   96.432090] IPv6: ADDRCONF(NETDEV_UP): enp4s0: link is not ready
[   96.453830] e1000: enp4s0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX/TX
[   96.454013] IPv6: ADDRCONF(NETDEV_CHANGE): enp4s0: link becomes ready
Obelix ()
Ответ на: комментарий от ozz_is_here

прошлые изменения не убирал.
Изменил строку в GRUB на GRUB_CMDLINE_LINUX_DEFAULT=«quiet splash ipv6.disable=1». Перегенерил GRUB - прошло без ошибок.
Но время загрузки не изменилось.
Концовка dsmsg:

[   13.165850] asus_wmi: Number of fans: 1
[   14.081798] input: HDA NVidia HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:01.0/0000:01:00.1/sound/card1/input21
[   14.081836] input: HDA NVidia HDMI/DP,pcm=7 as /devices/pci0000:00/0000:00:01.0/0000:01:00.1/sound/card1/input22
[   14.081868] input: HDA NVidia HDMI/DP,pcm=8 as /devices/pci0000:00/0000:00:01.0/0000:01:00.1/sound/card1/input23
[   14.081901] input: HDA NVidia HDMI/DP,pcm=9 as /devices/pci0000:00/0000:00:01.0/0000:01:00.1/sound/card1/input24
[   96.136071] kauditd_printk_skb: 26 callbacks suppressed
[   96.136072] audit: type=1400 audit(1505053977.601:38): apparmor="DENIED" operation="open" profile="/usr/sbin/mysqld" name="/proc/1167/status" pid=1167 comm="mysqld" requested_mask="r" denied_mask="r" fsuid=123 ouid=123
[   96.136073] audit: type=1400 audit(1505053977.601:39): apparmor="DENIED" operation="open" profile="/usr/sbin/mysqld" name="/sys/devices/system/node/" pid=1167 comm="mysqld" requested_mask="r" denied_mask="r" fsuid=123 ouid=0
[   96.136083] audit: type=1400 audit(1505053977.601:40): apparmor="DENIED" operation="open" profile="/usr/sbin/mysqld" name="/proc/1167/status" pid=1167 comm="mysqld" requested_mask="r" denied_mask="r" fsuid=123 ouid=123
[   96.333153] e1000: enp4s0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX/TX

Obelix ()
Ответ на: комментарий от Obelix

Возможно правильнее было бы сделать запуск LAMP по необходимости (накидать в баш скрипт старты сервисов и остановить их в автозагрузе), но для меня это пока неизведанный вопрос!

Obelix ()

7.179s NetworkManager-wait-online.service

Избавь себя и свой комп, от этого «универсального» настройщека интернетов.
Тебе нужны: systemd-networkd
systemd-resolved

Для начала, to begin with - IPv6 + systemd-networked + systemd-resolved + dnscrypt-proxy services

Затем, удали SE Linux модули из кернела.
Тем более, что Ubuntu не умеет их использовать ни разу.

Ясно же видно:

10.470310] audit: type=1400 audit(1505040410.924:2): apparmor=«STATUS» operation=«profile_load» profile=«unconfined»

blitz ()
Ответ на: комментарий от ozz_is_here

помогло ли тебе отключение IPv6 хоть немного ускорить загрузку

С точностью - `до наоборот'. IPv6 - сегодня используют весь инет, и если провайдер/DNS не обеспечивает работу по этому протоколу - возникнут ошибки и задержки загрузки сайтов.

blitz ()
Ответ на: комментарий от blitz

С точностью - `до наоборот'. IPv6 - сегодня используют весь инет, и если провайдер/DNS не обеспечивает работу по этому протоколу - возникнут ошибки и задержки загрузки сайтов.

спасибо, посмеялся

vaddd ★★ ()
Ответ на: комментарий от blitz

Это Apparmor

Тебе нужны: systemd-networkd
systemd-resolved

По сабжу:

Избавь себя

От советов фанатиков networkd

WDC WD10EALX-009BA0
5.660s dev-sda2.device

Давай полный syslog, с момента загрузки. Возможно все грузится нормально и так и должно на HDD, или у тебя что-то с питанием и ты переключаешь UDMA режимы. Но в целом если это какой-нибудь ноутбук с убитым/медленным HDD, то это скорей всего нормально. Также можешь отредактировать /lib/systemd/system/NetworkManager-wait-online.service timeout например секунд до 12 и посмотреть, что изменится (только не забудь сделать daemon-reload после).

anonymous_sama ★★★★★ ()
Ответ на: комментарий от anonymous_sama

Принцесса - на кроватке с горошинкой въехала в тему?
Сколько секунд занимает запуск dhcpd и NetworkManager?

systemd-networkd + systemd-resolved - устанавливают сетевые соединения - мгновенно, в отличие от.

blitz ()
Ответ на: комментарий от Obelix

Вроде нашел проблему, но пока не знаю как решить! Отключил сплеш скрин при загрузке и увидел процессы которы отдают ошибки и берут на себя примерно 1мин 20секунд на попытку решения.

[FAILED] Failed to activate swap /swapfile
Seee 'systemctl status swapfile.swap' for details.
[DEPEND] Dependency failed for Swap.

[OK] ...
[OK] ...

[  *** ] (1 of 2) A start job is running for dev-mapper-cryptswap1.device (51s / no limit)
[ ***  ] (2 of 2) A start job is running for dev-disk-by\x2duuid-1788b8e0\x2d3e66\...\xu.device (54s /no limit)


systemctl status swapfile.swap:

swapfile.swap - /swapfile
   Loaded: loaded (/etc/fstab; generated; vendor preset: enabled)
   Active: failed (Result: exit-code) since Tue 2017-09-12 23:00:23 MSK; 3min 20s ago
     What: /swapfile
     Docs: man:fstab(5)
           man:systemd-fstab-generator(8)

сен 12 23:00:23 Userok systemd[1]: Activating swap /swapfile...
сен 12 23:00:23 Userok swapon[387]: swapon: /swapfile: read swap header failed
сен 12 23:00:23 Userok systemd[1]: swapfile.swap: Swap process exited, code=exited status=255
сен 12 23:00:23 Userok systemd[1]: Failed to activate swap /swapfile.
сен 12 23:00:23 Userok systemd[1]: swapfile.swap: Unit entered failed state.


Свап у меня был в разделе на 16.Х версии Ubuntu, после апа на 17.04 раздел остался не задействованым (8 Gb). Оперативы 16 Gb, своп создавался до апа оперативы, отсюда он и меньше в два раза.

Obelix ()
Ответ на: комментарий от Obelix

Всё правильно у тебя.
Не создаёшь партицию под swap и записываешь его отдельным файлом.

blitz@inode ~ % systemctl status swapfile.swap
● swapfile.swap - /swapfile
   Loaded: loaded (/etc/fstab; generated; vendor preset: disabled)
   Active: active since Tue 2017-09-12 23:31:03 CEST; 13min ago
     What: /swapfile
     Docs: man:fstab(5)
           man:systemd-fstab-generator(8)
  Process: 217 ExecActivate=/sbin/swapon /swapfile (code=exited, status=0/SUCCESS)
    Tasks: 0 (limit: 4915)
   CGroup: /system.slice/swapfile.swap

Sep 12 23:31:01 inode systemd[1]: Activating swap /swapfile...
Sep 12 23:31:03 inode systemd[1]: Activated swap /swapfile.
blitz@inode ~ % ls -al / | grep swapfile 
-rw-------   1 root root 17179869184 Mar 22 01:27 swapfile

В твоём случае - удалить под рутом /swapfile и создать его по-новой.

blitz ()
Ответ на: комментарий от blitz

Пока система стала загружаться вместо 1:50 всего 30 секунд и это со стартом LAMP. Пока вовсе отключил своп, до того, как разберусь, как его включить корректно (в файл или пустой раздел, что остался по начледству от свопа предыдущей версии)
Сначала закоментил строки (сто не помогло ускорить загрузку, так как истинная проблема была ниже)

#/swapfile   none   swap    sw   0   0
#/dev/mapper/cryptswap1 none swap sw 0 0
ПС Странный порядок монтирования. Может в этом проблема? Ибо в нете я видел везде сначала идёт строка начинающаяся с /dev/mapper/cryptswap1 ?

Затем закоментил

cryptswap1 UUID=1727b9f0-7e86-4d51-9323-363d29d18d7f /dev/urandom swap,offset=1024,cipher=aes-xts-plain64
И только тогда система стала загружаться без ошибок за 30 сек!!!

Файл /swapfile Пытаюсь разобраться какой своп выбрать (файл или раздел) и как восстановить своп обратно.

Obelix ()
Ответ на: комментарий от Obelix

cryptswap - это вовсе излишне, если RAM >= 8GB.
Почему? Потому что, программам вполне достаточно RAM.

И криптовать своп - не знаю, есть смысл в этом, если скажем KeePassx его не использует.

У себя, файл /swapfile на SSD.

blitz ()