abort() calls from messaging code

Andrew Bartlett abartlet at samba.org
Tue Jun 13 05:03:36 UTC 2017


(resend from samba.org address subscribed to the list)

I'm seeing odd failures in the messaging code while attempting builds
on my new locking code for ldb.  It seems as I reduce the other
flapping tests, we perturb the state and start to see different parts
of samba misbehave. 

I've saved away the tree as
git://git.catalyst.net.nz repo-messaging-pthread-abort
6fdcf40c47ccaa51e71a914e4a1f3a59ec63ba9b


In once backtrace (attached), I see this abort fire:


static int tevent_threaded_context_destructor(
	struct tevent_threaded_context *tctx)
{
	int ret;

	if (tctx->event_ctx != NULL) {
		DLIST_REMOVE(tctx->event_ctx->threaded_contexts, tctx);
	}

	ret = pthread_mutex_destroy(&tctx->event_ctx_mutex);
	if (ret != 0) {
		abort();
	}

	return 0;
}

Do you have any clues as to why this pthread mutex would fail to
destroy?

Thanks,

Andrew Bartlett

-- 
Andrew Bartlett
https://samba.org/~abartlet/
Authentication Developer, Samba Team         https://samba.org
Samba Development and Support, Catalyst IT   
https://catalyst.net.nz/services/samba



-------------- next part --------------
[1587(8967)/2120 at 2h7m16s] samba4.local.messaging
Sending pings for 1 seconds
===============================================================
INTERNAL ERROR: Signal 6 in pid 10969 (4.7.0pre1-DEVELOPERBUILD)
Please read the Trouble-Shooting section of the Samba HOWTO
===============================================================
smb_panic(): calling panic action [/home/ubuntu/autobuild/b13341/samba/selftest/gdb_backtrace 10969]
[New LWP 10976]
[New LWP 10975]
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
0x00002b4772875599 in __libc_waitpid (pid=10977, stat_loc=stat_loc at entry=0x7ffeb8373ce0, options=options at entry=0) at ../sysdeps/unix/sysv/linux/waitpid.c:40
40	../sysdeps/unix/sysv/linux/waitpid.c: No such file or directory.
#0  0x00002b4772875599 in __libc_waitpid (pid=10977, stat_loc=stat_loc at entry=0x7ffeb8373ce0, options=options at entry=0) at ../sysdeps/unix/sysv/linux/waitpid.c:40
        resultvar = 140731989048544
        oldtype = 0
#1  0x00002b47727f7232 in do_system (line=<optimized out>) at ../sysdeps/posix/system.c:148
        __result = <optimized out>
        _buffer = {__routine = 0x2b47727f74d0 <cancel_handler>, __arg = 0x7ffeb8373cb0, __canceltype = 0, __prev = 0x0}
        _avail = 1
        status = -1204339440
        save = <optimized out>
        pid = 10977
        sa = {__sigaction_handler = {sa_handler = 0x1, sa_sigaction = 0x1}, sa_mask = {__val = {65536, 0 <repeats 15 times>}}, sa_flags = 0, sa_restorer = 0x7ffeb8373e80}
        omask = {__val = {4128, 140731989054496, 47585863369544, 47585860953328, 140731989048680, 47585833283456, 433808535552, 0, 140731989048880, 47585849143655, 0, 47585833283456, 72105179991380224, 206158430224, 140731989048896, 47585830224000}}
#2  0x00002b4770ab5046 in smb_panic_default (why=0x2b4770b06f55 "internal error") at ../lib/util/fault.c:141
        result = 11079
        pidstr = "10969\000\000\000Hn\260pG+\000\000hC7\001"
        cmdstring = "/home/ubuntu/autobuild/b13341/samba/selftest/gdb_backtrace 10969\000\272\376\370\357\361{\334\000\000\000\000\000\000\000\000>o\260pG+\000\000Sp\260pG+\000\000\360\202\332wG+\000\000\f", '\000' <repeats 23 times>, " E7\270\000\000\000\000\020E7\270\376\177\000\000n\000\000\000\000\000\000\000\000B\314wG+\000\000@?7\270\376\177\000\000y2\265pG+", '\000' <repeats 11 times>, "B\314wG+\000\000p?7\270\376\177\000"
        __FUNCTION__ = "smb_panic_default"
#3  0x00002b4770ab51d7 in smb_panic (why=0x2b4770b06f55 "internal error") at ../lib/util/fault.c:169
No locals.
#4  0x00002b4770ab4e99 in fault_report (sig=6) at ../lib/util/fault.c:83
        counter = 1
        __FUNCTION__ = "fault_report"
#5  0x00002b4770ab4eae in sig_fault (sig=6) at ../lib/util/fault.c:94
No locals.
#6  <signal handler called>
No locals.
#7  0x00002b47727e7c37 in __GI_raise (sig=sig at entry=6) at ../nptl/sysdeps/unix/sysv/linux/raise.c:56
        resultvar = 0
        pid = 10969
        selftid = 10969
#8  0x00002b47727eb028 in __GI_abort () at abort.c:89
        save_stage = 2
        act = {__sigaction_handler = {sa_handler = 0x7ffeb8374730, sa_sigaction = 0x7ffeb8374730}, sa_mask = {__val = {47585826083297, 140731989050928, 8, 140731989051280, 243608798816, 47585833642104, 47585953474016, 0, 47585837351488, 140731989051008, 47585833642104, 72, 47585953474112, 47585953474112, 47585953474016, 140731989051040}}, sa_flags = 1894678693, sa_restorer = 0x7ffeb83746f8}
        sigs = {__val = {32, 0 <repeats 15 times>}}
#9  0x00002b4770b58c37 in tevent_threaded_context_destructor (tctx=0x2b4777da6640) at ../lib/tevent/tevent_threads.c:386
        ret = 16
#10 0x00002b4770ee8656 in _tc_free_internal (tc=0x2b4777da65e0, location=0x2b4772fef2e8 "../lib/pthreadpool/pthreadpool_tevent.c:225") at ../lib/talloc/talloc.c:1078
        d = 0x2b4770b58af8 <tevent_threaded_context_destructor>
        ptr_to_free = 0x0
        ptr = 0x2b4777da6640
#11 0x00002b4770ee89dc in _talloc_free_internal (ptr=0x2b4777da6640, location=0x2b4772fef2e8 "../lib/pthreadpool/pthreadpool_tevent.c:225") at ../lib/talloc/talloc.c:1174
        tc = 0x2b4777da65e0
#12 0x00002b4770ee9c97 in _talloc_free (ptr=0x2b4777da6640, location=0x2b4772fef2e8 "../lib/pthreadpool/pthreadpool_tevent.c:225") at ../lib/talloc/talloc.c:1716
        tc = 0x2b4777da65e0
#13 0x00002b4772feac0d in pthreadpool_tevent_job_done (ctx=0x2b4777c630d0, im=0x2b4777dad8c0, private_data=0x2b4777dad810) at ../lib/pthreadpool/pthreadpool_tevent.c:225
        state = 0x2b4777dad810
#14 0x00002b4770b54862 in tevent_common_loop_immediate (ev=0x2b4777c630d0) at ../lib/tevent/tevent_immediate.c:135
        im = 0x2b4777dad8c0
        handler = 0x2b4772feaa99 <pthreadpool_tevent_job_done>
        private_data = 0x2b4777dad810
#15 0x00002b4770b5db0d in epoll_event_loop_once (ev=0x2b4777c630d0, location=0x2b47700f39d0 "../source4/lib/messaging/tests/messaging.c:116") at ../lib/tevent/tevent_epoll.c:911
        epoll_ev = 0x2b4777c63360
        tval = {tv_sec = 59, tv_usec = 47585833643019}
        panic_triggered = false
#16 0x00002b4770b5a8ae in std_event_loop_once (ev=0x2b4777c630d0, location=0x2b47700f39d0 "../source4/lib/messaging/tests/messaging.c:116") at ../lib/tevent/tevent_standard.c:114
        glue_ptr = 0x2b4777c63210
        glue = 0x2b4777c63210
        ret = 0
#17 0x00002b4770b53700 in _tevent_loop_once (ev=0x2b4777c630d0, location=0x2b47700f39d0 "../source4/lib/messaging/tests/messaging.c:116") at ../lib/tevent/tevent.c:735
        ret = 0
        nesting_stack_ptr = 0x0
#18 0x00002b476fc3d088 in test_ping_speed (tctx=0x2b4777c63400) at ../source4/lib/messaging/tests/messaging.c:116
        data = {data = 0x2b47700f3908 "testing", length = 7}
        status1 = {v = 0}
        status2 = {v = 0}
        ev = 0x2b4777c630d0
        msg_client_ctx = 0x2b4777da0c10
        msg_server_ctx = 0x2b4777cc4c70
        ping_count = 12100
        pong_count = 12078
        tv = {tv_sec = 1497319305, tv_usec = 106316}
        timelimit = 1
        msg_ping = 61440
        msg_exit = 61441
#19 0x00002b47705f4c6f in wrap_simple_test (torture_ctx=0x2b4777c63400, tcase=0x2b4777b5e260, test=0x2b4777b5e3a0) at ../lib/torture/torture.c:633
        fn = 0x2b476fc3cc37 <test_ping_speed>
#20 0x00002b47705f4390 in internal_torture_run_test (context=0x2b4777c63400, tcase=0x2b4777b5e260, test=0x2b4777b5e3a0, already_setup=true, restricted=0x0) at ../lib/torture/torture.c:442
        success = true
        subunit_testname = 0x2b4777cc9280 "ping_speed"
#21 0x00002b47705f45f0 in torture_run_tcase_restricted (context=0x2b4777c63400, tcase=0x2b4777b5e260, restricted=0x0) at ../lib/torture/torture.c:507
        ret = true
        test = 0x2b4777b5e3a0
        setup_succeeded = true
        setup_reason = 0x2b47705f5f67 "Setup failed"
#22 0x00002b47705f3f99 in torture_run_suite_restricted (context=0x2b4777c63400, suite=0x2b4777b5dc60, restricted=0x0) at ../lib/torture/torture.c:357
        ret = true
        tcase = 0x2b4777b5e260
        tsuite = 0x2b4777a96680
#23 0x00002b47705f3ef8 in torture_run_suite (context=0x2b4777c63400, suite=0x2b4777b5dc60) at ../lib/torture/torture.c:339
No locals.
#24 0x00002b476fbfa57e in run_matching (torture=0x2b4777c63400, prefix=0x2b4777cbef00 "local", expr=0x2b4777a9ce20 "local.messaging", restricted=0x0, suite=0x2b4777b532d0, matched=0x7ffeb8374cd6) at ../source4/torture/smbtorture.c:93
        name = 0x2b4777cc4060 "local.messaging"
        ret = true
        o = 0x2b4777b5dc60
        t = 0x0
        p = 0x0
#25 0x00002b476fbfa5b5 in run_matching (torture=0x2b4777c63400, prefix=0x0, expr=0x2b4777a9ce20 "local.messaging", restricted=0x0, suite=0x2b4777ab1960, matched=0x7ffeb8374cd6) at ../source4/torture/smbtorture.c:95
        name = 0x2b4777cbef00 "local"
        ret = true
        o = 0x2b4777b532d0
        t = 0x2b47700cffc8
        p = 0x2b4777a97ce0
#26 0x00002b476fbfa814 in torture_run_named_tests (torture=0x2b4777c63400, name=0x2b4777a9ce20 "local.messaging", restricted=0x0) at ../source4/torture/smbtorture.c:143
        ret = true
        matched = true
        o = 0x0
#27 0x00002b476fbfc60f in main (argc=10, argv=0x7ffeb8375428) at ../source4/torture/smbtorture.c:693
        opt = -1
        i = 2
        correct = true
        max_runtime = 1200
        argc_new = 3
        torture = 0x2b4777c63400
        results = 0x2b4777c63040
        ui_ops = 0x2b47705f8ac0 <torture_subunit_ui_ops>
        argv_new = 0x2b4777a95510
        pc = 0x2b4777a951e0
        target = 0x2b4777a9cda0 "samba4"
        status = {v = 3090633375}
        shell = 0
        ui_ops_name = 0x2b4777a9cd00 "subunit"
        basedir = 0x2b4777a9b060 "/home/ubuntu/autobuild/b13341/samba/bin/ab/tmp"
        outputdir = 0x2b4777c63540 "/home/ubuntu/autobuild/b13341/samba/bin/ab/tmp/smbtorture1KCma6"
        extra_module = 0x0
        list_tests = 0
        list_testsuites = 0
        num_extra_users = 0
        restricted = 0x0
        num_restricted = -1
        load_list = 0x0
        mem_ctx = 0x2b4777a95120
        long_options = {{longName = 0x0, shortName = 0 '\000', argInfo = 4, arg = 0x2b477235a340 <poptHelpOptions>, val = 0, descrip = 0x2b47700d064f "Help options:", argDescrip = 0x0}, {longName = 0x2b47700d065d "format", shortName = 0 '\000', argInfo = 1, arg = 0x2b47703d6320 <ui_ops_name>, val = 0, descrip = 0x2b47700d0668 "Output format (one of: simple, subunit)", argDescrip = 0x0}, {longName = 0x2b47700d0690 "smb-ports", shortName = 112 'p', argInfo = 1, arg = 0x0, val = 1006, descrip = 0x2b47700d069a "SMB ports", argDescrip = 0x0}, {longName = 0x2b47700d06a4 "basedir", shortName = 0 '\000', argInfo = 1, arg = 0x7ffeb8374d40, val = 0, descrip = 0x2b47700d06ac "base directory", argDescrip = 0x2b47700d06bb "BASEDIR"}, {longName = 0x2b47700d06c3 "seed", shortName = 0 '\000', argInfo = 2, arg = 0x2b47703dd388 <torture_seed>, val = 0, descrip = 0x2b47700d06c8 "Seed to use for randomizer", argDescrip = 0x0}, {longName = 0x2b47700d06e3 "num-progs", shortName = 0 '\000', argInfo = 2, arg = 0x0, val = 1008, descrip = 0x2b47700d06ed "num progs", argDescrip = 0x0}, {longName = 0x2b47700d06f7 "num-ops", shortName = 0 '\000', argInfo = 2, arg = 0x2b47703d6340 <torture_numops>, val = 0, descrip = 0x2b47700d06ff "num ops", argDescrip = 0x0}, {longName = 0x2b47700d0707 "entries", shortName = 0 '\000', argInfo = 2, arg = 0x2b47703d6344 <torture_entries>, val = 0, descrip = 0x2b47700d0707 "entries", argDescrip = 0x0}, {longName = 0x2b47700d070f "loadfile", shortName = 0 '\000', argInfo = 1, arg = 0x0, val = 1000, descrip = 0x2b47700d0718 "NBench load file to use", argDescrip = 0x0}, {longName = 0x2b47700d0730 "list-suites", shortName = 0 '\000', argInfo = 0, arg = 0x2b47703dd380 <list_testsuites>, val = 0, descrip = 0x2b47700d0740 "List available testsuites and exit", argDescrip = 0x0}, {longName = 0x2b47700d0763 "list", shortName = 0 '\000', argInfo = 0, arg = 0x2b47703dd384 <list_tests>, val = 0, descrip = 0x2b47700d0768 "List available tests in specified suites and exit", argDescrip = 0x0}, {longName = 0x2b47700d079a "unclist", shortName = 0 '\000', argInfo = 1, arg = 0x0, val = 1001, descrip = 0x2b47700d079a "unclist", argDescrip = 0x0}, {longName = 0x2b47700d07a2 "timelimit", shortName = 116 't', argInfo = 2, arg = 0x0, val = 1002, descrip = 0x2b47700d07ac "Set time limit (in seconds)", argDescrip = 0x0}, {longName = 0x2b47700d07c8 "failures", shortName = 102 'f', argInfo = 2, arg = 0x2b47703d6348 <torture_failures>, val = 0, descrip = 0x2b47700d07c8 "failures", argDescrip = 0x0}, {longName = 0x2b47700d07d1 "parse-dns", shortName = 68 'D', argInfo = 1, arg = 0x0, val = 1003, descrip = 0x2b47700d07d1 "parse-dns", argDescrip = 0x0}, {longName = 0x2b47700d07db "dangerous", shortName = 88 'X', argInfo = 0, arg = 0x0, val = 1005, descrip = 0x2b47700d07e8 "run dangerous tests (eg. wiping out password database)", argDescrip = 0x0}, {longName = 0x2b47700d081f "load-module", shortName = 0 '\000', argInfo = 1, arg = 0x7ffeb8374d48, val = 0, descrip = 0x2b47700d082b "load tests from DSO file", argDescrip = 0x2b47700d0844 "SOFILE"}, {longName = 0x2b47700d084b "shell", shortName = 0 '\000', argInfo = 0, arg = 0x7ffeb8374d28, val = 1, descrip = 0x2b47700d0851 "Run shell", argDescrip = 0x0}, {longName = 0x2b47700d085b "target", shortName = 84 'T', argInfo = 1, arg = 0x2b47703d6328 <target>, val = 0, descrip = 0x2b47700d0862 "samba3|samba4|other", argDescrip = 0x0}, {longName = 0x2b47700d0876 "async", shortName = 97 'a', argInfo = 0, arg = 0x0, val = 1007, descrip = 0x2b47700d087c "run async tests", argDescrip = 0x0}, {longName = 0x2b47700d088c "num-async", shortName = 0 '\000', argInfo = 2, arg = 0x2b47703d634c <torture_numasync>, val = 0, descrip = 0x2b47700d0898 "number of simultaneous async requests", argDescrip = 0x0}, {longName = 0x2b47700d08be "maximum-runtime", shortName = 0 '\000', argInfo = 2, arg = 0x7ffeb8374d24, val = 0, descrip = 0x2b47700d08d0 "set maximum time for smbtorture to live", argDescrip = 0x2b47700d08f8 "seconds"}, {longName = 0x2b47700d0900 "extra-user", shortName = 0 '\000', argInfo = 1, arg = 0x0, val = 1009, descrip = 0x2b47700d090b "extra user credentials", argDescrip = 0x0}, {longName = 0x2b47700d0922 "load-list", shortName = 0 '\000', argInfo = 1, arg = 0x7ffeb8374d50, val = 0, descrip = 0x2b47700d0930 "load a test id list from a text file", argDescrip = 0x0}, {longName = 0x0, shortName = 0 '\000', argInfo = 4, arg = 0x2b47703dcbe0 <popt_common_samba4>, val = 0, descrip = 0x2b47700d0955 "Common Samba options:", argDescrip = 0x0}, {longName = 0x0, shortName = 0 '\000', argInfo = 4, arg = 0x2b47703dca00 <popt_common_connection4>, val = 0, descrip = 0x2b47700d096b "Connection options:", argDescrip = 0x0}, {longName = 0x0, shortName = 0 '\000', argInfo = 4, arg = 0x2b47703dce40 <popt_common_credentials4>, val = 0, descrip = 0x2b47700d097f "Authentication options:", argDescrip = 0x0}, {longName = 0x0, shortName = 0 '\000', argInfo = 4, arg = 0x2b47703dcda0 <popt_common_version4>, val = 0, descrip = 0x2b47700d0997 "Version options:", argDescrip = 0x0}, {longName = 0x0, shortName = 0 '\000', argInfo = 0, arg = 0x0, val = 0, descrip = 0x0, argDescrip = 0x0}}

Thread 3 (Thread 0x2b477809f700 (LWP 10975)):
#0  pthread_cond_timedwait@@GLIBC_2.3.2 () at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_timedwait.S:238
No locals.
#1  0x00002b4772fe9ad1 in pthreadpool_server (arg=0x2b4777cc4dc0) at ../lib/pthreadpool/pthreadpool.c:405
        ts = {tv_sec = 1497319307, tv_nsec = 149286}
        job = {id = 0, fn = 0x2b4772fea9a5 <pthreadpool_tevent_job_fn>, private_data = 0x2b4777dad810}
        pool = 0x2b4777cc4dc0
        res = 0
        __PRETTY_FUNCTION__ = "pthreadpool_server"
#2  0x00002b477043213f in uwrap_pthread_create_start (_a=0x2b4777c643a0) at ../lib/uid_wrapper/uid_wrapper.c:714
        a = 0x0
        start_routine = 0x2b4772fe9a42 <pthreadpool_server>
        arg = 0x2b4777cc4dc0
        id = 0x2b4777daa1d0
#3  0x00002b477060b184 in start_thread (arg=0x2b477809f700) at pthread_create.c:312
        __res = <optimized out>
        pd = 0x2b477809f700
        now = <optimized out>
        unwind_buf = {cancel_jmp_buf = {{jmp_buf = {47585956591360, 1270052620894455723, 0, 0, 47585956592064, 47585956591360, 5129268141833570219, 5129251294307796907}, mask_was_saved = 0}}, priv = {pad = {0x0, 0x0, 0x0, 0x0}, data = {prev = 0x0, cleanup = 0x0, canceltype = 0}}}
        not_first_call = <optimized out>
        pagesize_m1 = <optimized out>
        sp = <optimized out>
        freesize = <optimized out>
        __PRETTY_FUNCTION__ = "start_thread"
#4  0x00002b47728aebed in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:111
No locals.

Thread 2 (Thread 0x2b47782a0700 (LWP 10976)):
#0  pthread_cond_timedwait@@GLIBC_2.3.2 () at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_timedwait.S:238
No locals.
#1  0x00002b4772fe9ad1 in pthreadpool_server (arg=0x2b4777cc4dc0) at ../lib/pthreadpool/pthreadpool.c:405
        ts = {tv_sec = 1497319307, tv_nsec = 71485}
        job = {id = 0, fn = 0x2b4772fea9a5 <pthreadpool_tevent_job_fn>, private_data = 0x2b4777dad810}
        pool = 0x2b4777cc4dc0
        res = 0
        __PRETTY_FUNCTION__ = "pthreadpool_server"
#2  0x00002b477043213f in uwrap_pthread_create_start (_a=0x2b4777c643a0) at ../lib/uid_wrapper/uid_wrapper.c:714
        a = 0x0
        start_routine = 0x2b4772fe9a42 <pthreadpool_server>
        arg = 0x2b4777cc4dc0
        id = 0x2b4777da9b50
#3  0x00002b477060b184 in start_thread (arg=0x2b47782a0700) at pthread_create.c:312
        __res = <optimized out>
        pd = 0x2b47782a0700
        now = <optimized out>
        unwind_buf = {cancel_jmp_buf = {{jmp_buf = {47585958692608, 1270052620894455723, 0, 0, 47585958693312, 47585958692608, 5129268416174606251, 5129251294307796907}, mask_was_saved = 0}}, priv = {pad = {0x0, 0x0, 0x0, 0x0}, data = {prev = 0x0, cleanup = 0x0, canceltype = 0}}}
        not_first_call = <optimized out>
        pagesize_m1 = <optimized out>
        sp = <optimized out>
        freesize = <optimized out>
        __PRETTY_FUNCTION__ = "start_thread"
#4  0x00002b47728aebed in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:111
No locals.

Thread 1 (Thread 0x2b4777a92d40 (LWP 10969)):
#0  0x00002b4772875599 in __libc_waitpid (pid=10977, stat_loc=stat_loc at entry=0x7ffeb8373ce0, options=options at entry=0) at ../sysdeps/unix/sysv/linux/waitpid.c:40
        resultvar = 140731989048544
        oldtype = 0
#1  0x00002b47727f7232 in do_system (line=<optimized out>) at ../sysdeps/posix/system.c:148
        __result = <optimized out>
        _buffer = {__routine = 0x2b47727f74d0 <cancel_handler>, __arg = 0x7ffeb8373cb0, __canceltype = 0, __prev = 0x0}
        _avail = 1
        status = -1204339440
        save = <optimized out>
        pid = 10977
        sa = {__sigaction_handler = {sa_handler = 0x1, sa_sigaction = 0x1}, sa_mask = {__val = {65536, 0 <repeats 15 times>}}, sa_flags = 0, sa_restorer = 0x7ffeb8373e80}
        omask = {__val = {4128, 140731989054496, 47585863369544, 47585860953328, 140731989048680, 47585833283456, 433808535552, 0, 140731989048880, 47585849143655, 0, 47585833283456, 72105179991380224, 206158430224, 140731989048896, 47585830224000}}
#2  0x00002b4770ab5046 in smb_panic_default (why=0x2b4770b06f55 "internal error") at ../lib/util/fault.c:141
        result = 11079
        pidstr = "10969\000\000\000Hn\260pG+\000\000hC7\001"
        cmdstring = "/home/ubuntu/autobuild/b13341/samba/selftest/gdb_backtrace 10969\000\272\376\370\357\361{\334\000\000\000\000\000\000\000\000>o\260pG+\000\000Sp\260pG+\000\000\360\202\332wG+\000\000\f", '\000' <repeats 23 times>, " E7\270\000\000\000\000\020E7\270\376\177\000\000n\000\000\000\000\000\000\000\000B\314wG+\000\000@?7\270\376\177\000\000y2\265pG+", '\000' <repeats 11 times>, "B\314wG+\000\000p?7\270\376\177\000"
        __FUNCTION__ = "smb_panic_default"
#3  0x00002b4770ab51d7 in smb_panic (why=0x2b4770b06f55 "internal error") at ../lib/util/fault.c:169
No locals.
#4  0x00002b4770ab4e99 in fault_report (sig=6) at ../lib/util/fault.c:83
        counter = 1
        __FUNCTION__ = "fault_report"
#5  0x00002b4770ab4eae in sig_fault (sig=6) at ../lib/util/fault.c:94
No locals.
#6  <signal handler called>
No locals.
#7  0x00002b47727e7c37 in __GI_raise (sig=sig at entry=6) at ../nptl/sysdeps/unix/sysv/linux/raise.c:56
        resultvar = 0
        pid = 10969
        selftid = 10969
#8  0x00002b47727eb028 in __GI_abort () at abort.c:89
        save_stage = 2
        act = {__sigaction_handler = {sa_handler = 0x7ffeb8374730, sa_sigaction = 0x7ffeb8374730}, sa_mask = {__val = {47585826083297, 140731989050928, 8, 140731989051280, 243608798816, 47585833642104, 47585953474016, 0, 47585837351488, 140731989051008, 47585833642104, 72, 47585953474112, 47585953474112, 47585953474016, 140731989051040}}, sa_flags = 1894678693, sa_restorer = 0x7ffeb83746f8}
        sigs = {__val = {32, 0 <repeats 15 times>}}
#9  0x00002b4770b58c37 in tevent_threaded_context_destructor (tctx=0x2b4777da6640) at ../lib/tevent/tevent_threads.c:386
        ret = 16
#10 0x00002b4770ee8656 in _tc_free_internal (tc=0x2b4777da65e0, location=0x2b4772fef2e8 "../lib/pthreadpool/pthreadpool_tevent.c:225") at ../lib/talloc/talloc.c:1078
        d = 0x2b4770b58af8 <tevent_threaded_context_destructor>
        ptr_to_free = 0x0
        ptr = 0x2b4777da6640
#11 0x00002b4770ee89dc in _talloc_free_internal (ptr=0x2b4777da6640, location=0x2b4772fef2e8 "../lib/pthreadpool/pthreadpool_tevent.c:225") at ../lib/talloc/talloc.c:1174
        tc = 0x2b4777da65e0
#12 0x00002b4770ee9c97 in _talloc_free (ptr=0x2b4777da6640, location=0x2b4772fef2e8 "../lib/pthreadpool/pthreadpool_tevent.c:225") at ../lib/talloc/talloc.c:1716
        tc = 0x2b4777da65e0
#13 0x00002b4772feac0d in pthreadpool_tevent_job_done (ctx=0x2b4777c630d0, im=0x2b4777dad8c0, private_data=0x2b4777dad810) at ../lib/pthreadpool/pthreadpool_tevent.c:225
        state = 0x2b4777dad810
#14 0x00002b4770b54862 in tevent_common_loop_immediate (ev=0x2b4777c630d0) at ../lib/tevent/tevent_immediate.c:135
        im = 0x2b4777dad8c0
        handler = 0x2b4772feaa99 <pthreadpool_tevent_job_done>
        private_data = 0x2b4777dad810
#15 0x00002b4770b5db0d in epoll_event_loop_once (ev=0x2b4777c630d0, location=0x2b47700f39d0 "../source4/lib/messaging/tests/messaging.c:116") at ../lib/tevent/tevent_epoll.c:911
        epoll_ev = 0x2b4777c63360
        tval = {tv_sec = 59, tv_usec = 47585833643019}
        panic_triggered = false
#16 0x00002b4770b5a8ae in std_event_loop_once (ev=0x2b4777c630d0, location=0x2b47700f39d0 "../source4/lib/messaging/tests/messaging.c:116") at ../lib/tevent/tevent_standard.c:114
        glue_ptr = 0x2b4777c63210
        glue = 0x2b4777c63210
        ret = 0
#17 0x00002b4770b53700 in _tevent_loop_once (ev=0x2b4777c630d0, location=0x2b47700f39d0 "../source4/lib/messaging/tests/messaging.c:116") at ../lib/tevent/tevent.c:735
        ret = 0
        nesting_stack_ptr = 0x0
#18 0x00002b476fc3d088 in test_ping_speed (tctx=0x2b4777c63400) at ../source4/lib/messaging/tests/messaging.c:116
        data = {data = 0x2b47700f3908 "testing", length = 7}
        status1 = {v = 0}
        status2 = {v = 0}
        ev = 0x2b4777c630d0
        msg_client_ctx = 0x2b4777da0c10
        msg_server_ctx = 0x2b4777cc4c70
        ping_count = 12100
        pong_count = 12078
        tv = {tv_sec = 1497319305, tv_usec = 106316}
        timelimit = 1
        msg_ping = 61440
        msg_exit = 61441
#19 0x00002b47705f4c6f in wrap_simple_test (torture_ctx=0x2b4777c63400, tcase=0x2b4777b5e260, test=0x2b4777b5e3a0) at ../lib/torture/torture.c:633
        fn = 0x2b476fc3cc37 <test_ping_speed>
#20 0x00002b47705f4390 in internal_torture_run_test (context=0x2b4777c63400, tcase=0x2b4777b5e260, test=0x2b4777b5e3a0, already_setup=true, restricted=0x0) at ../lib/torture/torture.c:442
        success = true
        subunit_testname = 0x2b4777cc9280 "ping_speed"
#21 0x00002b47705f45f0 in torture_run_tcase_restricted (context=0x2b4777c63400, tcase=0x2b4777b5e260, restricted=0x0) at ../lib/torture/torture.c:507
        ret = true
        test = 0x2b4777b5e3a0
        setup_succeeded = true
        setup_reason = 0x2b47705f5f67 "Setup failed"
#22 0x00002b47705f3f99 in torture_run_suite_restricted (context=0x2b4777c63400, suite=0x2b4777b5dc60, restricted=0x0) at ../lib/torture/torture.c:357
        ret = true
        tcase = 0x2b4777b5e260
        tsuite = 0x2b4777a96680
#23 0x00002b47705f3ef8 in torture_run_suite (context=0x2b4777c63400, suite=0x2b4777b5dc60) at ../lib/torture/torture.c:339
No locals.
#24 0x00002b476fbfa57e in run_matching (torture=0x2b4777c63400, prefix=0x2b4777cbef00 "local", expr=0x2b4777a9ce20 "local.messaging", restricted=0x0, suite=0x2b4777b532d0, matched=0x7ffeb8374cd6) at ../source4/torture/smbtorture.c:93
        name = 0x2b4777cc4060 "local.messaging"
        ret = true
        o = 0x2b4777b5dc60
        t = 0x0
        p = 0x0
#25 0x00002b476fbfa5b5 in run_matching (torture=0x2b4777c63400, prefix=0x0, expr=0x2b4777a9ce20 "local.messaging", restricted=0x0, suite=0x2b4777ab1960, matched=0x7ffeb8374cd6) at ../source4/torture/smbtorture.c:95
        name = 0x2b4777cbef00 "local"
        ret = true
        o = 0x2b4777b532d0
        t = 0x2b47700cffc8
        p = 0x2b4777a97ce0
#26 0x00002b476fbfa814 in torture_run_named_tests (torture=0x2b4777c63400, name=0x2b4777a9ce20 "local.messaging", restricted=0x0) at ../source4/torture/smbtorture.c:143
        ret = true
        matched = true
        o = 0x0
#27 0x00002b476fbfc60f in main (argc=10, argv=0x7ffeb8375428) at ../source4/torture/smbtorture.c:693
        opt = -1
        i = 2
        correct = true
        max_runtime = 1200
        argc_new = 3
        torture = 0x2b4777c63400
        results = 0x2b4777c63040
        ui_ops = 0x2b47705f8ac0 <torture_subunit_ui_ops>
        argv_new = 0x2b4777a95510
        pc = 0x2b4777a951e0
        target = 0x2b4777a9cda0 "samba4"
        status = {v = 3090633375}
        shell = 0
        ui_ops_name = 0x2b4777a9cd00 "subunit"
        basedir = 0x2b4777a9b060 "/home/ubuntu/autobuild/b13341/samba/bin/ab/tmp"
        outputdir = 0x2b4777c63540 "/home/ubuntu/autobuild/b13341/samba/bin/ab/tmp/smbtorture1KCma6"
        extra_module = 0x0
        list_tests = 0
        list_testsuites = 0
        num_extra_users = 0
        restricted = 0x0
        num_restricted = -1
        load_list = 0x0
        mem_ctx = 0x2b4777a95120
        long_options = {{longName = 0x0, shortName = 0 '\000', argInfo = 4, arg = 0x2b477235a340 <poptHelpOptions>, val = 0, descrip = 0x2b47700d064f "Help options:", argDescrip = 0x0}, {longName = 0x2b47700d065d "format", shortName = 0 '\000', argInfo = 1, arg = 0x2b47703d6320 <ui_ops_name>, val = 0, descrip = 0x2b47700d0668 "Output format (one of: simple, subunit)", argDescrip = 0x0}, {longName = 0x2b47700d0690 "smb-ports", shortName = 112 'p', argInfo = 1, arg = 0x0, val = 1006, descrip = 0x2b47700d069a "SMB ports", argDescrip = 0x0}, {longName = 0x2b47700d06a4 "basedir", shortName = 0 '\000', argInfo = 1, arg = 0x7ffeb8374d40, val = 0, descrip = 0x2b47700d06ac "base directory", argDescrip = 0x2b47700d06bb "BASEDIR"}, {longName = 0x2b47700d06c3 "seed", shortName = 0 '\000', argInfo = 2, arg = 0x2b47703dd388 <torture_seed>, val = 0, descrip = 0x2b47700d06c8 "Seed to use for randomizer", argDescrip = 0x0}, {longName = 0x2b47700d06e3 "num-progs", shortName = 0 '\000', argInfo = 2, arg = 0x0, val = 1008, descrip = 0x2b47700d06ed "num progs", argDescrip = 0x0}, {longName = 0x2b47700d06f7 "num-ops", shortName = 0 '\000', argInfo = 2, arg = 0x2b47703d6340 <torture_numops>, val = 0, descrip = 0x2b47700d06ff "num ops", argDescrip = 0x0}, {longName = 0x2b47700d0707 "entries", shortName = 0 '\000', argInfo = 2, arg = 0x2b47703d6344 <torture_entries>, val = 0, descrip = 0x2b47700d0707 "entries", argDescrip = 0x0}, {longName = 0x2b47700d070f "loadfile", shortName = 0 '\000', argInfo = 1, arg = 0x0, val = 1000, descrip = 0x2b47700d0718 "NBench load file to use", argDescrip = 0x0}, {longName = 0x2b47700d0730 "list-suites", shortName = 0 '\000', argInfo = 0, arg = 0x2b47703dd380 <list_testsuites>, val = 0, descrip = 0x2b47700d0740 "List available testsuites and exit", argDescrip = 0x0}, {longName = 0x2b47700d0763 "list", shortName = 0 '\000', argInfo = 0, arg = 0x2b47703dd384 <list_tests>, val = 0, descrip = 0x2b47700d0768 "List available tests in specified suites and exit", argDescrip = 0x0}, {longName = 0x2b47700d079a "unclist", shortName = 0 '\000', argInfo = 1, arg = 0x0, val = 1001, descrip = 0x2b47700d079a "unclist", argDescrip = 0x0}, {longName = 0x2b47700d07a2 "timelimit", shortName = 116 't', argInfo = 2, arg = 0x0, val = 1002, descrip = 0x2b47700d07ac "Set time limit (in seconds)", argDescrip = 0x0}, {longName = 0x2b47700d07c8 "failures", shortName = 102 'f', argInfo = 2, arg = 0x2b47703d6348 <torture_failures>, val = 0, descrip = 0x2b47700d07c8 "failures", argDescrip = 0x0}, {longName = 0x2b47700d07d1 "parse-dns", shortName = 68 'D', argInfo = 1, arg = 0x0, val = 1003, descrip = 0x2b47700d07d1 "parse-dns", argDescrip = 0x0}, {longName = 0x2b47700d07db "dangerous", shortName = 88 'X', argInfo = 0, arg = 0x0, val = 1005, descrip = 0x2b47700d07e8 "run dangerous tests (eg. wiping out password database)", argDescrip = 0x0}, {longName = 0x2b47700d081f "load-module", shortName = 0 '\000', argInfo = 1, arg = 0x7ffeb8374d48, val = 0, descrip = 0x2b47700d082b "load tests from DSO file", argDescrip = 0x2b47700d0844 "SOFILE"}, {longName = 0x2b47700d084b "shell", shortName = 0 '\000', argInfo = 0, arg = 0x7ffeb8374d28, val = 1, descrip = 0x2b47700d0851 "Run shell", argDescrip = 0x0}, {longName = 0x2b47700d085b "target", shortName = 84 'T', argInfo = 1, arg = 0x2b47703d6328 <target>, val = 0, descrip = 0x2b47700d0862 "samba3|samba4|other", argDescrip = 0x0}, {longName = 0x2b47700d0876 "async", shortName = 97 'a', argInfo = 0, arg = 0x0, val = 1007, descrip = 0x2b47700d087c "run async tests", argDescrip = 0x0}, {longName = 0x2b47700d088c "num-async", shortName = 0 '\000', argInfo = 2, arg = 0x2b47703d634c <torture_numasync>, val = 0, descrip = 0x2b47700d0898 "number of simultaneous async requests", argDescrip = 0x0}, {longName = 0x2b47700d08be "maximum-runtime", shortName = 0 '\000', argInfo = 2, arg = 0x7ffeb8374d24, val = 0, descrip = 0x2b47700d08d0 "set maximum time for smbtorture to live", argDescrip = 0x2b47700d08f8 "seconds"}, {longName = 0x2b47700d0900 "extra-user", shortName = 0 '\000', argInfo = 1, arg = 0x0, val = 1009, descrip = 0x2b47700d090b "extra user credentials", argDescrip = 0x0}, {longName = 0x2b47700d0922 "load-list", shortName = 0 '\000', argInfo = 1, arg = 0x7ffeb8374d50, val = 0, descrip = 0x2b47700d0930 "load a test id list from a text file", argDescrip = 0x0}, {longName = 0x0, shortName = 0 '\000', argInfo = 4, arg = 0x2b47703dcbe0 <popt_common_samba4>, val = 0, descrip = 0x2b47700d0955 "Common Samba options:", argDescrip = 0x0}, {longName = 0x0, shortName = 0 '\000', argInfo = 4, arg = 0x2b47703dca00 <popt_common_connection4>, val = 0, descrip = 0x2b47700d096b "Connection options:", argDescrip = 0x0}, {longName = 0x0, shortName = 0 '\000', argInfo = 4, arg = 0x2b47703dce40 <popt_common_credentials4>, val = 0, descrip = 0x2b47700d097f "Authentication options:", argDescrip = 0x0}, {longName = 0x0, shortName = 0 '\000', argInfo = 4, arg = 0x2b47703dcda0 <popt_common_version4>, val = 0, descrip = 0x2b47700d0997 "Version options:", argDescrip = 0x0}, {longName = 0x0, shortName = 0 '\000', argInfo = 0, arg = 0x0, val = 0, descrip = 0x0, argDescrip = 0x0}}
resultvar = 140731989048544
oldtype = 0
A debugging session is active.

	Inferior 1 [process 10969] will be detached.

Quit anyway? (y or n) [answered Y; input not from terminal]
smb_panic(): action returned status 0
PANIC: internal error
UNEXPECTED(error): samba4.local.messaging.ping_speed (samba.subunit.RemotedTestCase)(none)
REASON: Exception: Exception: was started but never finished!
UNEXPECTED(error): samba4.local.messaging.ping_speed(none) (samba.subunit.RemotedTestCase)
REASON: was started but never finished!

FAILED (0 failures, 2 errors and 0 unexpected successes in 0 testsuites)

A summary with detailed information can be found in:
  ./bin/ab/summary
TOP 10 slowest tests
samba3.local.nss(ad_dc:local) -> 705
samba.tests.docs -> 625
samba4.rpc.samr.passwords.lockout on ncacn_np with (ad_dc_ntvfs) -> 226
samba4.rpc.samr.passwords.pwdlastset on ncacn_np with (ad_dc_ntvfs) -> 202
samba4.blackbox.upgradeprovision.release-4-0-0 -> 178
samba4.blackbox.upgradeprovision.alpha13 -> 155
samba4.raw.notify(ad_dc_ntvfs) -> 111
samba3.base.delaywrite(ad_dc) -> 108
samba3.raw.notify(ad_dc) -> 103
samba3.raw.notify(nt4_dc) -> 99
ERROR: test failed with exit code 1


More information about the samba-technical mailing list