Gentoo Websites Logo
Go to: Gentoo Home Documentation Forums Lists Bugs Planet Store Wiki Get Gentoo!
Bug 588244 - net-im/ejabberd-16.04: prevents new users from logging in after some time
Summary: net-im/ejabberd-16.04: prevents new users from logging in after some time
Status: RESOLVED FIXED
Alias: None
Product: Gentoo Linux
Classification: Unclassified
Component: Current packages (show other bugs)
Hardware: All Linux
: Normal normal (vote)
Assignee: Amadeusz Żołnowski (RETIRED)
URL: https://github.com/processone/ejabber...
Whiteboard:
Keywords:
Depends on:
Blocks: 576398
  Show dependency tree
 
Reported: 2016-07-07 14:41 UTC by Sergey Popov
Modified: 2016-07-13 20:35 UTC (History)
1 user (show)

See Also:
Package list:
Runtime testing required: ---


Attachments

Note You need to log in before you can comment on or make changes to this bug.
Description Sergey Popov gentoo-dev 2016-07-07 14:41:57 UTC
Not sure how to reproduce it properly, but after some time this thing happens in log during new clients login:

Accepted connection 10.0.0.213:44578 -> 10.1.0.61:5222
2016-07-07 17:30:24.825 [info] <0.31849.1>@ejabberd_c2s:wait_for_sasl_response:875 ({socket_state,fast_tls,{tlssock,#Port<0.59011>,#Port<0.59012>},<0.31848.1>}) Accepted authentication for pi
nkbyte by ejabberd_auth_mnesia from 10.0.0.213
2016-07-07 17:30:25.085 [info] <0.31849.1>@ejabberd_c2s:open_session:1101 ({socket_state,fast_tls,{tlssock,#Port<0.59011>,#Port<0.59012>},<0.31848.1>}) Opened session for pinkbyte@jabber.dstu
.local/oas1
2016-07-07 17:30:25.087 [info] <0.31849.1>@ejabberd_c2s:handle_enable:2671 Stream management with resumption enabled for pinkbyte@jabber.dstu.local/oas1
2016-07-07 17:30:25.151 [info] <0.31849.1>@ejabberd_c2s:terminate:1762 ({socket_state,fast_tls,{tlssock,#Port<0.59011>,#Port<0.59012>},<0.31848.1>}) Close session for pinkbyte@jabber.dstu.loc
al/oas1
2016-07-07 17:30:25.152 [info] <0.31849.1>@ejabberd_c2s:handle_unacked_stanzas:2841 4 stanzas were not acknowledged by pinkbyte@jabber.dstu.local/oas1
2016-07-07 17:30:25.153 [error] <0.31849.1> gen_fsm <0.31849.1> in state session_established terminated with reason: bad argument in call to fxml:element_to_binary({xmlel,<<"message">>,[{<<"f
rom">>,<<"bard@jabber.dstu.local">>},{<<"to">>,<<"pinkbyte@jabber.dstu....">>},...],...}) in ejabberd_c2s:send_element/2 line 1831
2016-07-07 17:30:25.154 [error] <0.31849.1> CRASH REPORT Process <0.31849.1> with 0 neighbours exited with reason: bad argument in call to fxml:element_to_binary({xmlel,<<"message">>,[{<<"fro
m">>,<<"bard@jabber.dstu.local">>},{<<"to">>,<<"pinkbyte@jabber.dstu....">>},...],...}) in ejabberd_c2s:send_element/2 line 1831

If currently connected user will try to relogin - same thing will happen for him.

After restarting ejabberd - everything works fine, but after some time this problem pops up again.

Contents of ejabberd.yml(which was autogenerated during migration from 2.1.13-r2):

hosts: 
  - "jabber.dstu.local"
access: 
  announce: 
    admin: allow
  c2s: 
    blocked: deny
    all: allow
  c2s_shaper: 
    admin: none
    all: normal
  configure: 
    admin: allow
  local: 
    local: allow
  max_user_offline_messages: 
    admin: 5000
    all: 100
  max_user_sessions: 
    all: 10
  mod_register_networks: 
    ip_10.0.0.0/8: allow
    ip_0.0.0.0/0: deny
  muc: 
    all: allow
  muc_admin: 
    admin: allow
  muc_create: 
    local: allow
  pubsub_createnode: 
    local: allow
  register: 
    blocked: deny
    all: allow
  s2s_shaper: 
    all: fast
acl: 
  admin: 
    user: 
      - "pinkbyte": "jabber.dstu.local"
      - "bard": "jabber.dstu.local"
      - "admin": "jabber.dstu.local"
  blocked: 
    user: 
      - "user": "jabber.dstu.local"
  ip_0.0.0.0/0: 
    ip: 
      - "0.0.0.0/0"
  ip_10.0.0.0/8: 
    ip: 
      - "10.0.0.0/8"
  local: 
    user_regexp: 
      - ""
auth_method: 
  - mnesia
language: "ru"
listen: 
  - 
    port: 5222
    module: ejabberd_c2s
#    max_stanza_size: 65536
    shaper: c2s_shaper
    access: c2s
    starttls: true
    starttls_required: true
    certfile: "/etc/ssl/dstu/JABBER_server.pem"
  - 
    port: 5280
    module: ejabberd_http
    web_admin: true
    http_poll: true
    http_bind: true
loglevel: 4
max_fsm_queue: 1000
modules: 
  mod_register: 
    ip_access: mod_register_networks
    welcome_message: 
      subject: "Welcome!"
      body: "Welcome to DSTU Jabber server."
    registration_watchers: 
      - "bard@jabber.dstu.local"
    access: register
  mod_adhoc: []
  mod_announce: 
    access: announce
  mod_blocking: []
  mod_caps: []
  mod_configure: []
  mod_disco: []
  mod_http_bind: []
  mod_last: []
  mod_muc: 
    access: muc
    access_create: muc_create
    access_persistent: muc_create
    access_admin: muc_admin
  mod_offline: 
    access_max_user_messages: max_user_offline_messages
  mod_ping: []
  mod_privacy: []
  mod_private: []
  mod_pubsub: 
    access_createnode: pubsub_createnode
    ignore_pep_from_offline: true
    last_item_cache: true
    max_items_node: 100
    plugins: 
      - "flat"
      - "hometree"
      - "pep"
  mod_roster: []
  mod_shared_roster: []
  mod_time: []
  mod_vcard: 
    search: true
    matches: infinity
    allow_return_all: true
  mod_version: []
shaper: 
  normal: 1000
  fast: 50000
Comment 1 Amadeusz Żołnowski (RETIRED) gentoo-dev 2016-07-07 19:30:50 UTC
Please attach a bit more information: your arch, flags used to build ejabberd, etc.
Comment 2 Sergey Popov gentoo-dev 2016-07-07 19:50:08 UTC
emerge --info ejabberd

Portage 2.2.26 (python 2.7.10-final-0, default/linux/amd64/13.0, gcc-4.9.3, glibc-2.22-r4, 4.5.0-gentoo-r1 x86_64)
=================================================================
                         System Settings
=================================================================
System uname: Linux-4.5.0-gentoo-r1-x86_64-QEMU_Virtual_CPU_version_2.5+-with-gentoo-2.2
KiB Mem:     4051660 total,    865980 free
KiB Swap:          0 total,         0 free
Timestamp of repository gentoo: Wed, 06 Jul 2016 21:15:01 +0000
sh bash 4.3_p42-r1
ld GNU ld (Gentoo 2.24 p1.4) 2.24
distcc 3.2rc1 x86_64-pc-linux-gnu [enabled]
app-shells/bash:          4.3_p42-r1::gentoo
dev-java/java-config:     2.2.0-r3::gentoo
dev-lang/perl:            5.20.2::gentoo
dev-lang/python:          2.7.10-r1::gentoo
dev-util/cmake:           3.3.1-r1::gentoo
dev-util/pkgconfig:       0.28-r2::gentoo
sys-apps/baselayout:      2.2::gentoo
sys-apps/openrc:          0.19.1::gentoo
sys-apps/sandbox:         2.10-r1::gentoo
sys-devel/autoconf:       2.69::gentoo
sys-devel/automake:       1.13.4::gentoo, 1.14.1::gentoo, 1.15::gentoo
sys-devel/binutils:       2.24-r3::gentoo
sys-devel/gcc:            4.8.5::gentoo, 4.9.3::gentoo
sys-devel/gcc-config:     1.7.3::gentoo
sys-devel/libtool:        2.4.6::gentoo
sys-devel/make:           4.1-r1::gentoo
sys-kernel/linux-headers: 4.3::gentoo (virtual/os-headers)
sys-libs/glibc:           2.22-r4::gentoo
Repositories:

gentoo
    location: /usr/portage
    sync-type: rsync
    sync-uri: rsync://rsync.dstu.local/gentoo-portage
    priority: -1000

ACCEPT_KEYWORDS="amd64"
ACCEPT_LICENSE="* -@EULA"
CBUILD="x86_64-pc-linux-gnu"
CFLAGS="-O2 -pipe"
CHOST="x86_64-pc-linux-gnu"
CONFIG_PROTECT="/etc /usr/share/gnupg/qualified.txt"
CONFIG_PROTECT_MASK="/etc/ca-certificates.conf /etc/env.d /etc/fonts/fonts.conf /etc/gconf /etc/gentoo-release /etc/php/apache2-php5.6/ext-active/ /etc/php/cgi-php5.6/ext-active/ /etc/php/cli-php5.6/ext-active/ /etc/revdep-rebuild /etc/sandbox.d /etc/terminfo"
CXXFLAGS="-O2 -pipe"
DISTDIR="/usr/portage/distfiles"
EMERGE_DEFAULT_OPTS="--keep-going --jobs=3"
FCFLAGS="-O2 -pipe"
FEATURES="assume-digests binpkg-logs config-protect-if-modified distcc distlocks ebuild-locks fixlafiles merge-sync news parallel-fetch preserve-libs protect-owned sandbox sfperms strict unknown-features-warn unmerge-logs unmerge-orphans userfetch userpriv usersandbox usersync xattr"
FFLAGS="-O2 -pipe"
GENTOO_MIRRORS="http://distfiles.gentoo.org"
LANG="ru_RU.UTF-8"
LDFLAGS="-Wl,-O1 -Wl,--as-needed"
MAKEOPTS="-j8"
PKGDIR="/usr/portage/packages"
PORTAGE_CONFIGROOT="/"
PORTAGE_RSYNC_OPTS="--recursive --links --safe-links --perms --times --omit-dir-times --compress --force --whole-file --delete --stats --human-readable --timeout=180 --exclude=/distfiles --exclude=/local --exclude=/packages"
PORTAGE_TMPDIR="/var/tmp"
USE="acl amd64 bzip2 cli cracklib crypt cxx dri fortran iconv ipv6 logrotate mmx mmxext modules multilib ncurses nls nptl openmp pam pcre readline seccomp session sse sse2 ssl syslog threads unicode vhosts xattr zlib" ABI_X86="64" ALSA_CARDS="ali5451 als4000 atiixp atiixp-modem bt87x ca0106 cmipci emu10k1x ens1370 ens1371 es1938 es1968 fm801 hda-intel intel8x0 intel8x0m maestro3 trident usb-audio via82xx via82xx-modem ymfpci" APACHE2_MODULES="authn_core authz_core socache_shmcb unixd actions alias auth_basic authn_alias authn_anon authn_dbm authn_default authn_file authz_dbm authz_default authz_groupfile authz_host authz_owner authz_user autoindex cache cgi cgid dav dav_fs dav_lock deflate dir disk_cache env expires ext_filter file_cache filter headers include info log_config logio mem_cache mime mime_magic negotiation rewrite setenvif speling status unique_id userdir usertrack vhost_alias" CALLIGRA_FEATURES="kexi words flow plan sheets stage tables krita karbon braindump author" CAMERAS="ptp2" COLLECTD_PLUGINS="df interface irq load memory rrdtool swap syslog" CPU_FLAGS_X86="mmx mmxext sse sse2" ELIBC="glibc" GPSD_PROTOCOLS="ashtech aivdm earthmate evermore fv18 garmin garmintxt gpsclock itrax mtk3301 nmea ntrip navcom oceanserver oldstyle oncore rtcm104v2 rtcm104v3 sirf superstar2 timing tsip tripmate tnt ublox ubx" INPUT_DEVICES="keyboard mouse evdev" KERNEL="linux" LCD_DEVICES="bayrad cfontz cfontz633 glk hd44780 lb216 lcdm001 mtxorb ncurses text" LIBREOFFICE_EXTENSIONS="presenter-console presenter-minimizer" LINGUAS="ru" OFFICE_IMPLEMENTATION="libreoffice" PHP_TARGETS="php5-5" PYTHON_SINGLE_TARGET="python2_7" PYTHON_TARGETS="python2_7" RUBY_TARGETS="ruby20 ruby21" USERLAND="GNU" VIDEO_CARDS="amdgpu fbdev intel nouveau radeon radeonsi vesa dummy v4l" XTABLES_ADDONS="quota2 psd pknock lscan length2 ipv4options ipset ipp2p iface geoip fuzzy condition tee tarpit sysrq steal rawnat logmark ipmark dhcpmac delude chaos account"
Unset:  CC, CPPFLAGS, CTARGET, CXX, INSTALL_MASK, LC_ALL, PORTAGE_BUNZIP2_COMMAND, PORTAGE_COMPRESS, PORTAGE_COMPRESS_FLAGS, PORTAGE_RSYNC_EXTRA_OPTS, USE_PYTHON

=================================================================
                        Package Settings
=================================================================

net-im/ejabberd-16.04::gentoo was built with the following:
USE="nls pam zlib -captcha -debug -full-xml -hipe -ldap -mssql -mysql -odbc -postgres -redis -riak -roster-gw -sqlite" ABI_X86="64"
Comment 3 Sergey Popov gentoo-dev 2016-07-12 13:02:24 UTC
It seems that some problems arised during conversion from older versions. Deleting one of the mnesia databases, related to pubsub entries "fixes" the issue.

So, i am closing this as WORKSFORME
Comment 4 Amadeusz Żołnowski (RETIRED) gentoo-dev 2016-07-12 17:55:03 UTC
We cannot leave it like that. Could you provide more information on how exactly have you fixed that and what are the consequences? Is pubsub database valuable or if user loses it there's no harm? We should include this information in postinst message when user upgrades ejabberd from 2.x.
Comment 5 Sergey Popov gentoo-dev 2016-07-13 07:01:33 UTC
Sure. The database, which causes troubles is located in /var/spool/jabber. Simply removing all files that matches wildcard 'pubsub*' helped.

User's visible changes - all stored moods, activities, geoinfo and so on will be lost(and definitely - some other data, that can be stored in pubsub).

Here[1] some dev noted, that some function can be called manually to force migration of very old data, but i did not try that(honestly - stored moods is not a mission-critical data for our company, that can not be lost :-))

[1] - https://github.com/processone/ejabberd/issues/479#issuecomment-124497456
Comment 6 Amadeusz Żołnowski (RETIRED) gentoo-dev 2016-07-13 20:35:56 UTC
Thanks, I have add the warning based on your comment.