Bug 24961

Summary: После обновления не запускается alteratord
Product: Branch p5 Reporter: Vladimir Karpinsky <vvkarpinsky>
Component: cross-componentAssignee: Nobody's working on this, feel free to take it <nobody>
Status: NEW --- QA Contact: QA p5 <qa-p5>
Severity: normal    
Priority: P3 CC: mike, shakirov
Version: unspecified   
Hardware: all   
OS: Linux   

Description Vladimir Karpinsky 2011-01-23 23:04:08 MSK
После обновления до alterator-4.19-alt0.M50P.3 

# service alteratord start
Starting alteratord service:             [ DONE ]

Но:
# service alteratord status
alteratord is dead, but stale PID file exists

и в /var/log/messages:
guile18: _bind_unix: address /var/run/alteratord/.socket in use
alteratord: alteratord startup succeeded 

# netstat -pan | grep /var/run/alteratord/.socket 
unix  2      [ ACC ]     STREAM     LISTENING     17056960 31776/guile18     /var/run/alteratord/.socket
unix  2      [ ]         STREAM     CONNECTING    0      -   /var/run/alteratord/.socket
unix  2      [ ]         STREAM     CONNECTING    0      -   /var/run/alteratord/.socket
unix  2      [ ]         STREAM     CONNECTING    0      -   /var/run/alteratord/.socket
unix  2      [ ]         STREAM     CONNECTING    0      -   /var/run/alteratord/.socket
unix  2      [ ]         STREAM     CONNECTING    0      -   /var/run/alteratord/.socket
unix  3      [ ]         STREAM     CONNECTING    0      -   /var/run/alteratord/.socket
unix  2      [ ]         STREAM     CONNECTING    0      -   /var/run/alteratord/.socket
unix  2      [ ]         STREAM     CONNECTED     17057677 31776/guile18     /var/run/alteratord/.socket
Comment 1 Lenar Shakirov 2011-01-24 10:08:52 MSK
Рассказывайте что откуда обновляли, потому что в 5.1, если я ничего не путаю,  alterator-4.14-alt1.M51.1
Comment 2 Lenar Shakirov 2011-01-24 18:40:52 MSK
И все же, вы обновляли из p5 или 5.1?

Покажите выводы команд:
$ rpm -qa | egrep '(alterator|vhttp)'
$ grep '^[[:blank:]]*rpm' /etc/apt/sources.list* -R
$ apt-get check
Comment 3 Lenar Shakirov 2011-01-25 13:52:48 MSK
Покажите:

# rpm -V alterator alterator-fbi libvhttpd

# netstat -anlp | grep guile

Еще раз на всякий случай покажите:
# service ahttpd status
Comment 4 Lenar Shakirov 2011-01-25 14:44:06 MSK
# cat /etc/ahttpd/acl.conf /etc/alterator/menu/module-expert-list
# cat /etc/alterator/menu/module-order-list /etc/alterator/menu/module-skip-list 
# telnet 127.0.0.1 8080
# ip a
Comment 5 Lenar Shakirov 2011-01-25 21:17:39 MSK
# netstat -anlp | grep 8080
# service ahttpd stop
# telnet 127.0.0.1 8080

P.S. почему вы не отвечаете в багзиле? :)
Comment 6 Vladimir Karpinsky 2011-01-25 21:28:07 MSK
(В ответ на комментарий №5)
> # netstat -anlp | grep 8080
tcp        0      0 0.0.0.0:8080                0.0.0.0:*                   LISTEN      12062/guile18
tcp       47      0 195.19.205.74:8080          114.207.113.55:4517         CLOSE_WAIT  - 
tcp      170      0 195.19.205.74:8080          194.149.90.24:4092          CLOSE_WAIT  - 
tcp       20      0 195.19.205.74:8080          61.160.201.10:39472         CLOSE_WAIT  - 
tcp       13      0 127.0.0.1:8080              127.0.0.1:39757             CLOSE_WAIT  - 
tcp       38      0 195.19.205.74:8080          192.168.5.220:3136          CLOSE_WAIT  12062/guile18

> # service ahttpd stop
Stopping ahttpd service:                                            [ DONE ]

> # telnet 127.0.0.1 8080
Trying 127.0.0.1...
telnet: connect to address 127.0.0.1: Connection refused

> P.S. почему вы не отвечаете в багзиле? :)

Могу и в багзиле, просто письмо приходит в ящик, я там же на него и отвечаю. ;-)
Comment 7 Lenar Shakirov 2011-01-26 12:27:36 MSK
# alterator-cmdline /menu/avail_sections action list
# service ahttpd start
# mypid=`ps eax|grep ahttp|grep -v grep|awk '{print $1}'`
# strace -o /tmp/mylog.txt -f -p $mypid

в новом терминале опять выполните:
# telnet 127.0.0.1 8080
и нажмите Enter

покажите вывод:
# cat /tmp/mylog.txt

P.S. мой жаббер snejok@altlinux.org, там будет удобнее дебажить проблему :)
Comment 8 Vladimir Karpinsky 2011-01-26 15:06:41 MSK
(В ответ на комментарий №7)
> # alterator-cmdline /menu/avail_sections action list
Ожидание, ничего не происходит 
^C
> # service ahttpd start
[ DONE ]
> # mypid=`ps eax|grep ahttp|grep -v grep|awk '{print $1}'`

> # strace -o /tmp/mylog.txt -f -p $mypid
> в новом терминале опять выполните:
> # telnet 127.0.0.1 8080
> и нажмите Enter
> покажите вывод:
> # cat /tmp/mylog.txt

27490 select(13, [12], NULL, NULL, {2, 180713}) = 0 (Timeout)
27490 select(13, [12], NULL, NULL, {10, 0}) = 0 (Timeout)
27490 select(13, [12], NULL, NULL, {10, 0}) = 1 (in [12], left {9, 430404})
27490 accept(12, {sa_family=AF_INET, sin_port=htons(57222), sin_addr=inet_addr("127.0.0.1")}, [16]) = 15
27490 fcntl64(12, F_GETFD)              = 0x1 (flags FD_CLOEXEC)
27490 fcntl64(12, F_SETFD, FD_CLOEXEC)  = 0
27490 ioctl(15, FIONBIO, [1])           = 0
27490 gettimeofday({1296043415, 275153}, NULL) = 0
27490 select(16, [12 15], NULL, NULL, {10, 0}) = 1 (in [15], left {7, 826507})
27490 recv(15, "\r", 1, MSG_PEEK)       = 1
27490 time(NULL)                        = 1296043417
27490 read(15, "\r\n", 11)              = 2
27490 read(15, 0x80cce72, 9)            = -1 EAGAIN (Resource temporarily unavailable)
27490 brk(0x80f7000)                    = 0x80f7000
27490 select(16, [12 15], NULL, NULL, {10, 0}) = 0 (Timeout)
27490 select(16, [12 15], NULL, NULL, {10, 0}) = 0 (Timeout)
27490 select(16, [12 15], NULL, NULL, {10, 0}) = 0 (Timeout)
27490 select(16, [12 15], NULL, NULL, {10, 0}) = 0 (Timeout)
27490 select(16, [12 15], NULL, NULL, {10, 0}) = 0 (Timeout)
27490 select(16, [12 15], NULL, NULL, {10, 0}
Comment 9 Vladimir Karpinsky 2011-01-26 15:09:53 MSK
(В ответ на комментарий №8)
...
> 27490 select(16, [12 15], NULL, NULL, {10, 0}) = 0 (Timeout)
> 27490 select(16, [12 15], NULL, NULL, {10, 0}) = 0 (Timeout)
> 27490 select(16, [12 15], NULL, NULL, {10, 0}

После выхода из telneta дописалась последняя строка, добавилось штук 15 аналогичных и далее:

27490 select(16, [12 15], NULL, NULL, {10, 0}) = 1 (in [15], left {3, 908288})
27490 time(NULL)                        = 1296043663
27490 read(15, "", 9)                   = 0
27490 close(15)                         = 0
Comment 10 Lenar Shakirov 2011-01-27 11:54:30 MSK
(В ответ на комментарий №8)
> (В ответ на комментарий №7)
> > # alterator-cmdline /menu/avail_sections action list
> Ожидание, ничего не происходит 
> ^C

О! А вот это уже знакомо (для p5)!

Даже вот это не работает, просто висит?

# alterator-cmdline /help action read

Если да, то делаем так:

# service ahttpd stop
# service alteratord stop
# ps eax | grep guile
# strace -f alterator-cmdline /help action read 2>/dev/null
Comment 11 Vladimir Karpinsky 2011-01-27 12:50:42 MSK
(В ответ на комментарий №10)
> (В ответ на комментарий №8)
> > (В ответ на комментарий №7)
> > > # alterator-cmdline /menu/avail_sections action list
> > Ожидание, ничего не происходит 
> > ^C
> 
> О! А вот это уже знакомо (для p5)!
> 
> Даже вот это не работает, просто висит?
> 
> # alterator-cmdline /help action read

Да

> Если да, то делаем так:
> 
> # service ahttpd stop
> # service alteratord stop
> # ps eax | grep guile

23047 pts/0 S+ 0:00 grep guile LESSKEY=/etc/.less HOSTNAME=plkv.gsras.ru GDK_PIXBUF_MODULEDIR=/usr/lib/gtk-2.0/2.10.0/

> # strace -f alterator-cmdline /help action read 2>/dev/null

Тоже висит, а что должно происходить?
Comment 12 Lenar Shakirov 2011-01-27 13:17:42 MSK
(В ответ на комментарий №11)
> > # strace -f alterator-cmdline /help action read 2>/dev/null
> 
> Тоже висит, а что должно происходить?

Смотрите https://bugzilla.altlinux.org/show_bug.cgi?id=24796#c5

баги очень похожие (в плане проблемы с alterator)

Может у вас есть аська? Напишите мне свой номер в почту
Comment 13 Vladimir Karpinsky 2011-01-27 13:25:02 MSK
(В ответ на комментарий №12)
> (В ответ на комментарий №11)
> > > # strace -f alterator-cmdline /help action read 2>/dev/null
> > 
> > Тоже висит, а что должно происходить?
> 
> Смотрите https://bugzilla.altlinux.org/show_bug.cgi?id=24796#c5
> 
> баги очень похожие (в плане проблемы с alterator)
> 
> Может у вас есть аська? Напишите мне свой номер в почту

Нет нету. Чаос до 15 Мск могу непрерывно сидеть за компьютером и ловить сообщения...
Comment 14 Lenar Shakirov 2011-01-27 17:36:06 MSK
(В ответ на комментарий №11)
<skip>
> Да
> 
> > Если да, то делаем так:
> > 
> > # service ahttpd stop
> > # service alteratord stop
> > # ps eax | grep guile
> > # strace -f alterator-cmdline /help action read 2>/dev/null
> 
> Тоже висит, а что должно происходить?

А вы сколько подождали? Следует немного подождать, т.к. процесс запускается под strace. Ждать стоит не более 2 мин :)
Comment 15 Vladimir Karpinsky 2011-01-27 17:43:43 MSK
(В ответ на комментарий №14)
> > > # strace -f alterator-cmdline /help action read 2>/dev/null
> > 
> > Тоже висит, а что должно происходить?
> 
> А вы сколько подождали? Следует немного подождать, т.к. процесс запускается под
> strace. Ждать стоит не более 2 мин :)

Да, я  честно признаться, в какой-то момент совсем о нём забыл и этот процесс у меня часа 2 висел, если не больше :-)
Comment 16 Lenar Shakirov 2011-01-27 17:54:59 MSK
(В ответ на комментарий №15)
> Да, я  честно признаться, в какой-то момент совсем о нём забыл и этот процесс у
> меня часа 2 висел, если не больше :-)

Ок, тогда так:

# service ahttpd stop
# service alteratord stop
# ps eax | grep guile
# alterator-cmdline -l /help action read

появилась опция "-l"
Comment 17 Vladimir Karpinsky 2011-01-27 18:00:55 MSK
(В ответ на комментарий №16)
> (В ответ на комментарий №15)
> > Да, я  честно признаться, в какой-то момент совсем о нём забыл и этот процесс у
> > меня часа 2 висел, если не больше :-)
> 
> Ок, тогда так:
> 
> # service ahttpd stop
> # service alteratord stop
> # ps eax | grep guile
23947 pts/0    S+     0:00 grep guile  LESSKEY=/etc/.less HOSTNAME=plkv.gsras.ru GDK_PIXBUF_MODULEDIR=/usr/lib/gtk-2.0/2.10.0/

> # alterator-cmdline -l /help action read
<пустая строка>
url:/usr/share/alterator/help/en_US/notfound.html
Comment 18 Lenar Shakirov 2011-01-27 18:14:30 MSK
(В ответ на комментарий №17)
> > # alterator-cmdline -l /help action read
> <пустая строка>
> url:/usr/share/alterator/help/en_US/notfound.html

Да, вы тоже напоролись на #24796 :)
До этого проблема воспроизводилась только в livecd.
Comment 19 Vladimir Karpinsky 2011-01-27 18:56:27 MSK
(В ответ на комментарий №18)
> Да, вы тоже напоролись на #24796 :)

Спасибо, доктор, за диагноз :-)

И что с этим делать? Там написано, что пофикшено, но как и где непонятно.