[Installation, Configuration & DEPLOYMENT] - Re: JBoss AS 4.2.3 start as service question
by wslyhbb
munmap(0x2b517fe6e000, 2106696) = 0
munmap(0x2b5180071000, 2189120) = 0
munmap(0x2b51808fa000, 2145888) = 0
munmap(0x2b5181991000, 2099408) = 0
munmap(0x2b5181b92000, 2124288) = 0
munmap(0x2b518029f000, 2148896) = 0
munmap(0x2b51806c3000, 2318784) = 0
munmap(0x2b5181d99000, 2110440) = 0
munmap(0x2b5181f9e000, 2112744) = 0
munmap(0x2b51821a2000, 2108656) = 0
close(1) = 0
close(2) = 0
exit_group(1) = ?
View the original post : http://www.jboss.com/index.html?module=bb&op=viewtopic&p=4172446#4172446
Reply to the post : http://www.jboss.com/index.html?module=bb&op=posting&mode=reply&p=4172446
17 years, 8 months
[Installation, Configuration & DEPLOYMENT] - Re: JBoss AS 4.2.3 start as service question
by wslyhbb
Hmm, actually it seems the page was cached and the service is not starting :-(.
# strace su -l jboss -c '$JBOSS_HOME/bin/run.sh 2>&1 $JBOSS_LOG_FILE &'
execve("/bin/su", ["su", "-l", "jboss", "-c", "$JBOSS_HOME/bin/run.sh 2>&1 $JBO"...], [/* 75 vars */]) = 0
brk(0) = 0x609000
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ece2000
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ece3000
access("/etc/ld.so.preload", R_OK) = -1 ENOENT (No such file or directory)
open("/etc/ld.so.cache", O_RDONLY) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=93699, ...}) = 0
mmap(NULL, 93699, PROT_READ, MAP_PRIVATE, 3, 0) = 0x2b517ece4000
close(3) = 0
open("/lib64/libpam.so.0", O_RDONLY) = 3
read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\300!\0\0\0\0\0\0"..., 832) = 832
fstat(3, {st_mode=S_IFREG|0755, st_size=44944, ...}) = 0
mmap(NULL, 2140456, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x2b517eee3000
mprotect(0x2b517eeee000, 2093056, PROT_NONE) = 0
mmap(0x2b517f0ed000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0xa000) = 0x2b517f0ed000
close(3) = 0
open("/lib64/libpam_misc.so.0", O_RDONLY) = 3
read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0000\17\0\0\0\0\0\0"..., 832) = 832
fstat(3, {st_mode=S_IFREG|0755, st_size=10968, ...}) = 0
mmap(NULL, 2106248, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x2b517f0ee000
mprotect(0x2b517f0f0000, 2097152, PROT_NONE) = 0
mmap(0x2b517f2f0000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x2000) = 0x2b517f2f0000
close(3) = 0
open("/lib64/libc.so.6", O_RDONLY) = 3
read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\220\341\1\0\0\0\0\0"..., 832) = 832
fstat(3, {st_mode=S_IFREG|0755, st_size=1379584, ...}) = 0
mmap(NULL, 3486136, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x2b517f2f1000
mprotect(0x2b517f43c000, 2093056, PROT_NONE) = 0
mmap(0x2b517f63b000, 20480, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x14a000) = 0x2b517f63b000
mmap(0x2b517f640000, 16824, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x2b517f640000
close(3) = 0
open("/lib64/libaudit.so.0", O_RDONLY) = 3
read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\340%\0\0\0\0\0\0"..., 832) = 832
fstat(3, {st_mode=S_IFREG|0755, st_size=84408, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517f645000
mmap(NULL, 2179680, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x2b517f646000
mprotect(0x2b517f659000, 2097152, PROT_NONE) = 0
mmap(0x2b517f859000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x13000) = 0x2b517f859000
close(3) = 0
open("/lib64/libdl.so.2", O_RDONLY) = 3
read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0 \16\0\0\0\0\0\0"..., 832) = 832
fstat(3, {st_mode=S_IFREG|0755, st_size=14632, ...}) = 0
mmap(NULL, 2109728, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x2b517f85b000
mprotect(0x2b517f85d000, 2097152, PROT_NONE) = 0
mmap(0x2b517fa5d000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x2000) = 0x2b517fa5d000
close(3) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517fa5f000
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517fa60000
arch_prctl(ARCH_SET_FS, 0x2b517fa5fc70) = 0
mprotect(0x2b517fa5d000, 4096, PROT_READ) = 0
mprotect(0x2b517f859000, 4096, PROT_READ) = 0
mprotect(0x2b517f63b000, 16384, PROT_READ) = 0
mprotect(0x2b517eee1000, 4096, PROT_READ) = 0
munmap(0x2b517ece4000, 93699) = 0
brk(0) = 0x609000
brk(0x62a000) = 0x62a000
open("/usr/share/locale/locale-archive", O_RDONLY) = -1 ENOENT (No such file or directory)
open("/usr/share/locale/locale.alias", O_RDONLY) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=2586, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ece4000
read(3, "# Locale name alias data base.\n#"..., 4096) = 2586
read(3, "", 4096) = 0
close(3) = 0
munmap(0x2b517ece4000, 4096) = 0
open("/usr/share/locale/en_US.UTF-8/LC_IDENTIFICATION", O_RDONLY) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=373, ...}) = 0
mmap(NULL, 373, PROT_READ, MAP_PRIVATE, 3, 0) = 0x2b517ece4000
close(3) = 0
open("/usr/lib64/gconv/gconv-modules.cache", O_RDONLY) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=25702, ...}) = 0
mmap(NULL, 25702, PROT_READ, MAP_SHARED, 3, 0) = 0x2b517ece5000
close(3) = 0
open("/usr/share/locale/en_US.UTF-8/LC_MEASUREMENT", O_RDONLY) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=23, ...}) = 0
mmap(NULL, 23, PROT_READ, MAP_PRIVATE, 3, 0) = 0x2b517ecec000
close(3) = 0
open("/usr/share/locale/en_US.UTF-8/LC_TELEPHONE", O_RDONLY) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=59, ...}) = 0
mmap(NULL, 59, PROT_READ, MAP_PRIVATE, 3, 0) = 0x2b517eced000
close(3) = 0
open("/usr/share/locale/en_US.UTF-8/LC_ADDRESS", O_RDONLY) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=155, ...}) = 0
mmap(NULL, 155, PROT_READ, MAP_PRIVATE, 3, 0) = 0x2b517ecee000
close(3) = 0
open("/usr/share/locale/en_US.UTF-8/LC_NAME", O_RDONLY) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=77, ...}) = 0
mmap(NULL, 77, PROT_READ, MAP_PRIVATE, 3, 0) = 0x2b517ecef000
close(3) = 0
open("/usr/share/locale/en_US.UTF-8/LC_PAPER", O_RDONLY) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=34, ...}) = 0
mmap(NULL, 34, PROT_READ, MAP_PRIVATE, 3, 0) = 0x2b517ecf0000
close(3) = 0
open("/usr/share/locale/en_US.UTF-8/LC_MESSAGES", O_RDONLY) = 3
fstat(3, {st_mode=S_IFDIR|0755, st_size=4096, ...}) = 0
close(3) = 0
open("/usr/share/locale/en_US.UTF-8/LC_MESSAGES/SYS_LC_MESSAGES", O_RDONLY) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=52, ...}) = 0
mmap(NULL, 52, PROT_READ, MAP_PRIVATE, 3, 0) = 0x2b517ecf1000
close(3) = 0
open("/usr/share/locale/en_US.UTF-8/LC_MONETARY", O_RDONLY) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=286, ...}) = 0
mmap(NULL, 286, PROT_READ, MAP_PRIVATE, 3, 0) = 0x2b517ecf2000
close(3) = 0
open("/usr/share/locale/en_US.UTF-8/LC_COLLATE", O_RDONLY) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=932338, ...}) = 0
mmap(NULL, 932338, PROT_READ, MAP_PRIVATE, 3, 0) = 0x2b517ecf3000
close(3) = 0
open("/usr/share/locale/en_US.UTF-8/LC_TIME", O_RDONLY) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=2454, ...}) = 0
mmap(NULL, 2454, PROT_READ, MAP_PRIVATE, 3, 0) = 0x2b517edd7000
close(3) = 0
open("/usr/share/locale/en_US.UTF-8/LC_NUMERIC", O_RDONLY) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=54, ...}) = 0
mmap(NULL, 54, PROT_READ, MAP_PRIVATE, 3, 0) = 0x2b517edd8000
close(3) = 0
open("/usr/share/locale/en_US.UTF-8/LC_CTYPE", O_RDONLY) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=254076, ...}) = 0
mmap(NULL, 254076, PROT_READ, MAP_PRIVATE, 3, 0) = 0x2b517edd9000
close(3) = 0
socket(PF_FILE, SOCK_STREAM, 0) = 3
fcntl(3, F_SETFL, O_RDWR|O_NONBLOCK) = 0
connect(3, {sa_family=AF_FILE, path="/var/run/nscd/socket"}, 110) = -1 ENOENT (No such file or directory)
close(3) = 0
socket(PF_FILE, SOCK_STREAM, 0) = 3
fcntl(3, F_SETFL, O_RDWR|O_NONBLOCK) = 0
connect(3, {sa_family=AF_FILE, path="/var/run/nscd/socket"}, 110) = -1 ENOENT (No such file or directory)
close(3) = 0
open("/etc/nsswitch.conf", O_RDONLY) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=1313, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee18000
read(3, "#\n# /etc/nsswitch.conf\n#\n# An ex"..., 4096) = 1313
read(3, "", 4096) = 0
close(3) = 0
munmap(0x2b517ee18000, 4096) = 0
open("/etc/ld.so.cache", O_RDONLY) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=93699, ...}) = 0
mmap(NULL, 93699, PROT_READ, MAP_PRIVATE, 3, 0) = 0x2b517ee18000
close(3) = 0
open("/lib64/libnss_files.so.2", O_RDONLY) = 3
read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\240\37\0\0\0\0\0\0"..., 832) = 832
fstat(3, {st_mode=S_IFREG|0755, st_size=43432, ...}) = 0
mmap(NULL, 2139432, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x2b517fa61000
mprotect(0x2b517fa6b000, 2093056, PROT_NONE) = 0
mmap(0x2b517fc6a000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x9000) = 0x2b517fc6a000
close(3) = 0
mprotect(0x2b517fc6a000, 4096, PROT_READ) = 0
munmap(0x2b517ee18000, 93699) = 0
open("/etc/passwd", O_RDONLY|0x80000 /* O_??? */) = 3
fcntl(3, F_GETFD) = 0x1 (flags FD_CLOEXEC)
fstat(3, {st_mode=S_IFREG|0644, st_size=1661, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee18000
read(3, "root:x:0:0:root:/root:/bin/bash\n"..., 4096) = 1661
close(3) = 0
munmap(0x2b517ee18000, 4096) = 0
stat("/etc/pam.d", {st_mode=S_IFDIR|0755, st_size=4096, ...}) = 0
open("/etc/pam.d/su", O_RDONLY) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=483, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee18000
read(3, "#%PAM-1.0\nauth sufficient "..., 4096) = 483
open("/lib64/security/pam_rootok.so", O_RDONLY) = 4
read(4, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0p\4\0\0\0\0\0\0"..., 832) = 832
fstat(4, {st_mode=S_IFREG|0755, st_size=4168, ...}) = 0
mmap(NULL, 2099496, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 4, 0) = 0x2b517fc6c000
mprotect(0x2b517fc6d000, 2093056, PROT_NONE) = 0
mmap(0x2b517fe6c000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 4, 0) = 0x2b517fe6c000
close(4) = 0
open("/etc/pam.d/system-auth", O_RDONLY) = 4
fstat(4, {st_mode=S_IFREG|0644, st_size=729, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517fe6d000
read(4, "#%PAM-1.0\n\nauth required "..., 4096) = 729
open("/lib64/security/pam_env.so", O_RDONLY) = 5
read(5, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0P\n\0\0\0\0\0\0"..., 832) = 832
fstat(5, {st_mode=S_IFREG|0755, st_size=11368, ...}) = 0
mmap(NULL, 2106696, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 5, 0) = 0x2b517fe6e000
mprotect(0x2b517fe71000, 2093056, PROT_NONE) = 0
mmap(0x2b5180070000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 5, 0x2000) = 0x2b5180070000
close(5) = 0
open("/lib64/security/pam_unix.so", O_RDONLY) = 5
read(5, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\260\"\0\0\0\0\0\0"..., 832) = 832
fstat(5, {st_mode=S_IFREG|0755, st_size=44632, ...}) = 0
mmap(NULL, 2189120, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 5, 0) = 0x2b5180071000
mprotect(0x2b518007b000, 2097152, PROT_NONE) = 0
mmap(0x2b518027b000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 5, 0xa000) = 0x2b518027b000
mmap(0x2b518027c000, 46912, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x2b518027c000
close(5) = 0
open("/etc/ld.so.cache", O_RDONLY) = 5
fstat(5, {st_mode=S_IFREG|0644, st_size=93699, ...}) = 0
mmap(NULL, 93699, PROT_READ, MAP_PRIVATE, 5, 0) = 0x2b5180288000
close(5) = 0
open("/usr/lib64/libcrack.so.2", O_RDONLY) = 5
read(5, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0@8\0\0\0\0\0\0"..., 832) = 832
fstat(5, {st_mode=S_IFREG|0755, st_size=38640, ...}) = 0
mmap(NULL, 2148896, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 5, 0) = 0x2b518029f000
mprotect(0x2b51802a7000, 2097152, PROT_NONE) = 0
mmap(0x2b51804a7000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 5, 0x8000) = 0x2b51804a7000
mmap(0x2b51804a8000, 14880, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x2b51804a8000
close(5) = 0
open("/lib64/libnsl.so.1", O_RDONLY) = 5
read(5, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0P@\0\0\0\0\0\0"..., 832) = 832
fstat(5, {st_mode=S_IFREG|0755, st_size=84880, ...}) = 0
mmap(NULL, 2190032, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 5, 0) = 0x2b51804ac000
mprotect(0x2b51804c0000, 2093056, PROT_NONE) = 0
mmap(0x2b51806bf000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 5, 0x13000) = 0x2b51806bf000
mmap(0x2b51806c1000, 6864, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x2b51806c1000
close(5) = 0
open("/lib64/libcrypt.so.1", O_RDONLY) = 5
read(5, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\360\t\0\0\0\0\0\0"..., 832) = 832
fstat(5, {st_mode=S_IFREG|0755, st_size=35024, ...}) = 0
mmap(NULL, 2318784, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 5, 0) = 0x2b51806c3000
mprotect(0x2b51806cb000, 2093056, PROT_NONE) = 0
mmap(0x2b51808ca000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 5, 0x7000) = 0x2b51808ca000
mmap(0x2b51808cc000, 184768, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x2b51808cc000
close(5) = 0
mprotect(0x2b51808ca000, 4096, PROT_READ) = 0
mprotect(0x2b51806bf000, 4096, PROT_READ) = 0
munmap(0x2b5180288000, 93699) = 0
open("/lib64/security/pam_ldap.so", O_RDONLY) = 5
read(5, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0p\36\0\0\0\0\0\0"..., 832) = 832
fstat(5, {st_mode=S_IFREG|0755, st_size=50624, ...}) = 0
mmap(NULL, 2145888, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 5, 0) = 0x2b51808fa000
mprotect(0x2b5180906000, 2093056, PROT_NONE) = 0
mmap(0x2b5180b05000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 5, 0xb000) = 0x2b5180b05000
close(5) = 0
open("/etc/ld.so.cache", O_RDONLY) = 5
fstat(5, {st_mode=S_IFREG|0644, st_size=93699, ...}) = 0
mmap(NULL, 93699, PROT_READ, MAP_PRIVATE, 5, 0) = 0x2b5180b06000
close(5) = 0
open("/usr/lib64/libldap-2.4.so.2", O_RDONLY) = 5
read(5, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\0\317\0\0\0\0\0\0"..., 832) = 832
fstat(5, {st_mode=S_IFREG|0755, st_size=279944, ...}) = 0
mmap(NULL, 2375240, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 5, 0) = 0x2b5180b1d000
mprotect(0x2b5180b5f000, 2093056, PROT_NONE) = 0
mmap(0x2b5180d5e000, 12288, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 5, 0x41000) = 0x2b5180d5e000
close(5) = 0
open("/usr/lib64/liblber-2.4.so.2", O_RDONLY) = 5
read(5, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0`3\0\0\0\0\0\0"..., 832) = 832
fstat(5, {st_mode=S_IFREG|0755, st_size=64928, ...}) = 0
mmap(NULL, 2160392, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 5, 0) = 0x2b5180d61000
mprotect(0x2b5180d70000, 2097152, PROT_NONE) = 0
mmap(0x2b5180f70000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 5, 0xf000) = 0x2b5180f70000
close(5) = 0
open("/lib64/libresolv.so.2", O_RDONLY) = 5
read(5, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\0003\0\0\0\0\0\0"..., 832) = 832
fstat(5, {st_mode=S_IFREG|0755, st_size=76672, ...}) = 0
mmap(NULL, 2181896, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 5, 0) = 0x2b5180f71000
mprotect(0x2b5180f82000, 2097152, PROT_NONE) = 0
mmap(0x2b5181182000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 5, 0x11000) = 0x2b5181182000
mmap(0x2b5181184000, 6920, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x2b5181184000
close(5) = 0
open("/usr/lib64/tls/x86_64/libsasl2.so.2", O_RDONLY) = -1 ENOENT (No such file or directory)
stat("/usr/lib64/tls/x86_64", 0x7fff2bddef10) = -1 ENOENT (No such file or directory)
open("/usr/lib64/tls/libsasl2.so.2", O_RDONLY) = -1 ENOENT (No such file or directory)
stat("/usr/lib64/tls", 0x7fff2bddef10) = -1 ENOENT (No such file or directory)
open("/usr/lib64/x86_64/libsasl2.so.2", O_RDONLY) = -1 ENOENT (No such file or directory)
stat("/usr/lib64/x86_64", 0x7fff2bddef10) = -1 ENOENT (No such file or directory)
open("/usr/lib64/libsasl2.so.2", O_RDONLY) = 5
read(5, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\340F\0\0\0\0\0\0"..., 832) = 832
fstat(5, {st_mode=S_IFREG|0755, st_size=107704, ...}) = 0
mmap(NULL, 2203152, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 5, 0) = 0x2b5181186000
mprotect(0x2b51811a0000, 2093056, PROT_NONE) = 0
mmap(0x2b518139f000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 5, 0x19000) = 0x2b518139f000
close(5) = 0
open("/usr/lib64/libssl.so.0.9.8", O_RDONLY) = 5
read(5, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0 #\1\0\0\0\0\0"..., 832) = 832
fstat(5, {st_mode=S_IFREG|0755, st_size=327352, ...}) = 0
mmap(NULL, 2422768, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 5, 0) = 0x2b51813a0000
mprotect(0x2b51813ea000, 2093056, PROT_NONE) = 0
mmap(0x2b51815e9000, 28672, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 5, 0x49000) = 0x2b51815e9000
close(5) = 0
open("/usr/lib64/libcrypto.so.0.9.8", O_RDONLY) = 5
read(5, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\0\27\6\0\0\0\0\0"..., 832) = 832
fstat(5, {st_mode=S_IFREG|0755, st_size=1694528, ...}) = 0
mmap(NULL, 3804728, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 5, 0) = 0x2b51815f0000
mprotect(0x2b518176b000, 2093056, PROT_NONE) = 0
mmap(0x2b518196a000, 147456, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 5, 0x17a000) = 0x2b518196a000
mmap(0x2b518198e000, 11832, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x2b518198e000
close(5) = 0
mprotect(0x2b5181182000, 4096, PROT_READ) = 0
munmap(0x2b5180b06000, 93699) = 0
open("/lib64/security/pam_deny.so", O_RDONLY) = 5
read(5, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\200\4\0\0\0\0\0\0"..., 832) = 832
fstat(5, {st_mode=S_IFREG|0755, st_size=4008, ...}) = 0
mmap(NULL, 2099408, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 5, 0) = 0x2b5181991000
mprotect(0x2b5181992000, 2093056, PROT_NONE) = 0
mmap(0x2b5181b91000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 5, 0) = 0x2b5181b91000
close(5) = 0
read(4, "", 4096) = 0
close(4) = 0
munmap(0x2b517fe6d000, 4096) = 0
open("/etc/pam.d/system-auth", O_RDONLY) = 4
fstat(4, {st_mode=S_IFREG|0644, st_size=729, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517fe6d000
read(4, "#%PAM-1.0\n\nauth required "..., 4096) = 729
read(4, "", 4096) = 0
close(4) = 0
munmap(0x2b517fe6d000, 4096) = 0
open("/etc/pam.d/system-auth", O_RDONLY) = 4
fstat(4, {st_mode=S_IFREG|0644, st_size=729, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517fe6d000
read(4, "#%PAM-1.0\n\nauth required "..., 4096) = 729
open("/lib64/security/pam_cracklib.so", O_RDONLY) = 5
read(5, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0000\f\0\0\0\0\0\0"..., 832) = 832
fstat(5, {st_mode=S_IFREG|0755, st_size=12544, ...}) = 0
mmap(NULL, 2124288, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 5, 0) = 0x2b5181b92000
mprotect(0x2b5181b95000, 2093056, PROT_NONE) = 0
mmap(0x2b5181d94000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 5, 0x2000) = 0x2b5181d94000
mmap(0x2b5181d95000, 14848, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x2b5181d95000
close(5) = 0
read(4, "", 4096) = 0
close(4) = 0
munmap(0x2b517fe6d000, 4096) = 0
open("/lib64/security/pam_xauth.so", O_RDONLY) = 4
read(4, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0p\24\0\0\0\0\0\0"..., 832) = 832
fstat(4, {st_mode=S_IFREG|0755, st_size=15184, ...}) = 0
mmap(NULL, 2110440, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 4, 0) = 0x2b5181d99000
mprotect(0x2b5181d9c000, 2097152, PROT_NONE) = 0
mmap(0x2b5181f9c000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 4, 0x3000) = 0x2b5181f9c000
close(4) = 0
open("/etc/pam.d/system-auth", O_RDONLY) = 4
fstat(4, {st_mode=S_IFREG|0644, st_size=729, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b5181f9d000
read(4, "#%PAM-1.0\n\nauth required "..., 4096) = 729
open("/lib64/security/pam_mkhomedir.so", O_RDONLY) = 5
read(5, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\320\r\0\0\0\0\0\0"..., 832) = 832
fstat(5, {st_mode=S_IFREG|0755, st_size=17424, ...}) = 0
mmap(NULL, 2112744, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 5, 0) = 0x2b5181f9e000
mprotect(0x2b5181fa0000, 2093056, PROT_NONE) = 0
mmap(0x2b518219f000, 12288, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 5, 0x1000) = 0x2b518219f000
close(5) = 0
open("/lib64/security/pam_limits.so", O_RDONLY) = 5
read(5, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\320\16\0\0\0\0\0\0"..., 832) = 832
fstat(5, {st_mode=S_IFREG|0755, st_size=13400, ...}) = 0
mmap(NULL, 2108656, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 5, 0) = 0x2b51821a2000
mprotect(0x2b51821a5000, 2093056, PROT_NONE) = 0
mmap(0x2b51823a4000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 5, 0x2000) = 0x2b51823a4000
close(5) = 0
read(4, "", 4096) = 0
close(4) = 0
munmap(0x2b5181f9d000, 4096) = 0
read(3, "", 4096) = 0
close(3) = 0
munmap(0x2b517ee18000, 4096) = 0
open("/etc/pam.d/other", O_RDONLY) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=154, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee18000
read(3, "#%PAM-1.0\nauth required "..., 4096) = 154
read(3, "", 4096) = 0
close(3) = 0
munmap(0x2b517ee18000, 4096) = 0
getuid() = 0
getuid() = 0
open("/etc/passwd", O_RDONLY|0x80000 /* O_??? */) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=1661, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee18000
read(3, "root:x:0:0:root:/root:/bin/bash\n"..., 4096) = 1661
close(3) = 0
munmap(0x2b517ee18000, 4096) = 0
ioctl(0, SNDCTL_TMR_TIMEBASE or TCGETS, {B38400 opost isig icanon echo ...}) = 0
readlink("/proc/self/fd/0", "/dev/pts/1", 4095) = 10
gettimeofday({1219712881, 593263}, NULL) = 0
getuid() = 0
socket(PF_NETLINK, SOCK_RAW, 9) = 3
fcntl(3, F_SETFD, FD_CLOEXEC) = 0
readlink("/proc/self/exe", "/bin/su", 4095) = 7
sendto(3, "p\0\0\0L\4\5\0\1\0\0\0\0\0\0\0op=PAM:authentic"..., 112, 0, {sa_family=AF_NETLINK, pid=0, groups=00000000}, 12) = 112
poll([{fd=3, events=POLLIN, revents=POLLIN}], 1, 100) = 1
recvfrom(3, "$\0\0\0\2\0\0\0\1\0\0\0\246+\0\0\0\0\0\0p\0\0\0L\4\5\0\1\0\0\0"..., 8988, MSG_PEEK|MSG_DONTWAIT, {sa_family=AF_NETLINK, pid=0, groups=00000000}, [12]) = 36
recvfrom(3, "$\0\0\0\2\0\0\0\1\0\0\0\246+\0\0\0\0\0\0p\0\0\0L\4\5\0\1\0\0\0"..., 8988, MSG_DONTWAIT, {sa_family=AF_NETLINK, pid=0, groups=00000000}, [12]) = 36
close(3) = 0
getuid() = 0
open("/etc/passwd", O_RDONLY|0x80000 /* O_??? */) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=1661, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee18000
read(3, "root:x:0:0:root:/root:/bin/bash\n"..., 4096) = 1661
close(3) = 0
munmap(0x2b517ee18000, 4096) = 0
geteuid() = 0
open("/etc/shadow", O_RDONLY|0x80000 /* O_??? */) = 3
fstat(3, {st_mode=S_IFREG|0400, st_size=816, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee18000
read(3, "root:$1$s1zhRhlz$Eqxpsd/Cq7g5ojI"..., 4096) = 816
close(3) = 0
munmap(0x2b517ee18000, 4096) = 0
gettimeofday({1219712881, 595097}, NULL) = 0
socket(PF_NETLINK, SOCK_RAW, 9) = 3
fcntl(3, F_SETFD, FD_CLOEXEC) = 0
readlink("/proc/self/exe", "/bin/su", 4095) = 7
sendto(3, "l\0\0\0M\4\5\0\2\0\0\0\0\0\0\0op=PAM:accountin"..., 108, 0, {sa_family=AF_NETLINK, pid=0, groups=00000000}, 12) = 108
poll([{fd=3, events=POLLIN, revents=POLLIN}], 1, 100) = 1
recvfrom(3, "$\0\0\0\2\0\0\0\2\0\0\0\246+\0\0\0\0\0\0l\0\0\0M\4\5\0\2\0\0\0"..., 8988, MSG_PEEK|MSG_DONTWAIT, {sa_family=AF_NETLINK, pid=0, groups=00000000}, [12]) = 36
recvfrom(3, "$\0\0\0\2\0\0\0\2\0\0\0\246+\0\0\0\0\0\0l\0\0\0M\4\5\0\2\0\0\0"..., 8988, MSG_DONTWAIT, {sa_family=AF_NETLINK, pid=0, groups=00000000}, [12]) = 36
close(3) = 0
access("/usr/X11R6/bin/xauth", X_OK) = -1 ENOENT (No such file or directory)
access("/usr/bin/xauth", X_OK) = 0
getuid() = 0
open("/etc/passwd", O_RDONLY|0x80000 /* O_??? */) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=1661, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee18000
read(3, "root:x:0:0:root:/root:/bin/bash\n"..., 4096) = 1661
close(3) = 0
munmap(0x2b517ee18000, 4096) = 0
open("/etc/passwd", O_RDONLY|0x80000 /* O_??? */) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=1661, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee18000
read(3, "root:x:0:0:root:/root:/bin/bash\n"..., 4096) = 1661
close(3) = 0
munmap(0x2b517ee18000, 4096) = 0
open("/etc/passwd", O_RDONLY|0x80000 /* O_??? */) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=1661, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee18000
read(3, "root:x:0:0:root:/root:/bin/bash\n"..., 4096) = 1661
close(3) = 0
munmap(0x2b517ee18000, 4096) = 0
stat("/usr/local/jboss-4.2.3.GA/", {st_mode=S_IFDIR|0755, st_size=4096, ...}) = 0
open("/etc/passwd", O_RDONLY|0x80000 /* O_??? */) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=1661, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee18000
read(3, "root:x:0:0:root:/root:/bin/bash\n"..., 4096) = 1661
close(3) = 0
munmap(0x2b517ee18000, 4096) = 0
getrlimit(RLIMIT_CPU, {rlim_cur=RLIM_INFINITY, rlim_max=RLIM_INFINITY}) = 0
getrlimit(RLIMIT_FSIZE, {rlim_cur=RLIM_INFINITY, rlim_max=RLIM_INFINITY}) = 0
getrlimit(RLIMIT_DATA, {rlim_cur=RLIM_INFINITY, rlim_max=RLIM_INFINITY}) = 0
getrlimit(RLIMIT_STACK, {rlim_cur=8192*1024, rlim_max=RLIM_INFINITY}) = 0
getrlimit(RLIMIT_CORE, {rlim_cur=RLIM_INFINITY, rlim_max=RLIM_INFINITY}) = 0
getrlimit(RLIMIT_RSS, {rlim_cur=RLIM_INFINITY, rlim_max=RLIM_INFINITY}) = 0
getrlimit(RLIMIT_NPROC, {rlim_cur=8191, rlim_max=8191}) = 0
getrlimit(RLIMIT_NOFILE, {rlim_cur=1024, rlim_max=1024}) = 0
getrlimit(RLIMIT_MEMLOCK, {rlim_cur=32*1024, rlim_max=32*1024}) = 0
getrlimit(RLIMIT_AS, {rlim_cur=RLIM_INFINITY, rlim_max=RLIM_INFINITY}) = 0
getrlimit(RLIMIT_LOCKS, {rlim_cur=RLIM_INFINITY, rlim_max=RLIM_INFINITY}) = 0
getrlimit(RLIMIT_SIGPENDING, {rlim_cur=8191, rlim_max=8191}) = 0
getrlimit(RLIMIT_MSGQUEUE, {rlim_cur=800*1024, rlim_max=800*1024}) = 0
getrlimit(RLIMIT_NICE, {rlim_cur=20, rlim_max=20}) = 0
getrlimit(RLIMIT_RTPRIO, {rlim_cur=0, rlim_max=0}) = 0
getpriority(PRIO_PROCESS, 0) = 20
open("/etc/security/limits.conf", O_RDONLY) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=1983, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee18000
read(3, "# /etc/security/limits.conf\n#\n#E"..., 4096) = 1983
open("/etc/passwd", O_RDONLY|0x80000 /* O_??? */) = 4
fstat(4, {st_mode=S_IFREG|0644, st_size=1661, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee19000
read(4, "root:x:0:0:root:/root:/bin/bash\n"..., 4096) = 1661
close(4) = 0
munmap(0x2b517ee19000, 4096) = 0
socket(PF_FILE, SOCK_STREAM, 0) = 4
fcntl(4, F_SETFL, O_RDWR|O_NONBLOCK) = 0
connect(4, {sa_family=AF_FILE, path="/var/run/nscd/socket"}, 110) = -1 ENOENT (No such file or directory)
close(4) = 0
socket(PF_FILE, SOCK_STREAM, 0) = 4
fcntl(4, F_SETFL, O_RDWR|O_NONBLOCK) = 0
connect(4, {sa_family=AF_FILE, path="/var/run/nscd/socket"}, 110) = -1 ENOENT (No such file or directory)
close(4) = 0
open("/etc/group", O_RDONLY|0x80000 /* O_??? */) = 4
fstat(4, {st_mode=S_IFREG|0644, st_size=669, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee19000
read(4, "root:x:0:\nbin:x:1:\ndaemon:x:2:me"..., 4096) = 669
close(4) = 0
munmap(0x2b517ee19000, 4096) = 0
open("/etc/group", O_RDONLY|0x80000 /* O_??? */) = 4
fstat(4, {st_mode=S_IFREG|0644, st_size=669, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee19000
lseek(4, 0, SEEK_CUR) = 0
read(4, "root:x:0:\nbin:x:1:\ndaemon:x:2:me"..., 4096) = 669
read(4, "", 4096) = 0
close(4) = 0
munmap(0x2b517ee19000, 4096) = 0
open("/etc/ld.so.cache", O_RDONLY) = 4
fstat(4, {st_mode=S_IFREG|0644, st_size=93699, ...}) = 0
mmap(NULL, 93699, PROT_READ, MAP_PRIVATE, 4, 0) = 0x2b517ee19000
close(4) = 0
open("/lib64/libnss_ldap.so.2", O_RDONLY) = 4
read(4, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\0204\0\0\0\0\0\0"..., 832) = 832
fstat(4, {st_mode=S_IFREG|0755, st_size=85552, ...}) = 0
mmap(NULL, 2228000, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 4, 0) = 0x2b51823a5000
mprotect(0x2b51823b9000, 2093056, PROT_NONE) = 0
mmap(0x2b51825b8000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 4, 0x13000) = 0x2b51825b8000
mmap(0x2b51825ba000, 44832, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x2b51825ba000
close(4) = 0
munmap(0x2b517ee19000, 93699) = 0
rt_sigaction(SIGPIPE, {SIG_IGN}, {SIG_IGN}, 8) = 0
geteuid() = 0
open("/etc/ldap.conf", O_RDONLY) = 4
fstat(4, {st_mode=S_IFREG|0644, st_size=9693, ...}) = 0
fstat(4, {st_mode=S_IFREG|0644, st_size=9693, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee19000
read(4, "#@(#)$Id: ldap.conf,v 2.47 2006/"..., 4096) = 4096
read(4, "g the UNIX-Crypt\n# hash mechanis"..., 4096) = 4096
read(4, "oupName\n#nss_map_attribute uniqu"..., 4096) = 1501
read(4, "", 4096) = 0
close(4) = 0
munmap(0x2b517ee19000, 4096) = 0
open("/etc/ldap.secret", O_RDONLY) = 4
fstat(4, {st_mode=S_IFREG|0600, st_size=11, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee19000
read(4, "Camry92381\n", 4096) = 11
close(4) = 0
munmap(0x2b517ee19000, 4096) = 0
uname({sys="Linux", node="server01.bluemapletech.com", ...}) = 0
getpid() = 11174
open("/etc/resolv.conf", O_RDONLY) = 4
fstat(4, {st_mode=S_IFREG|0644, st_size=174, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee19000
read(4, "# Dynamic resolv.conf(5) file fo"..., 4096) = 174
read(4, "", 4096) = 0
close(4) = 0
munmap(0x2b517ee19000, 4096) = 0
uname({sys="Linux", node="server01.bluemapletech.com", ...}) = 0
socket(PF_FILE, SOCK_STREAM, 0) = 4
fcntl(4, F_SETFL, O_RDWR|O_NONBLOCK) = 0
connect(4, {sa_family=AF_FILE, path="/var/run/nscd/socket"}, 110) = -1 ENOENT (No such file or directory)
close(4) = 0
socket(PF_FILE, SOCK_STREAM, 0) = 4
fcntl(4, F_SETFL, O_RDWR|O_NONBLOCK) = 0
connect(4, {sa_family=AF_FILE, path="/var/run/nscd/socket"}, 110) = -1 ENOENT (No such file or directory)
close(4) = 0
open("/etc/ld.so.cache", O_RDONLY) = 4
fstat(4, {st_mode=S_IFREG|0644, st_size=93699, ...}) = 0
mmap(NULL, 93699, PROT_READ, MAP_PRIVATE, 4, 0) = 0x2b517ee19000
close(4) = 0
open("/lib64/libnss_mdns4_minimal.so.2", O_RDONLY) = 4
read(4, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\360\n\0\0\0\0\0\0"..., 832) = 832
fstat(4, {st_mode=S_IFREG|0755, st_size=9400, ...}) = 0
mmap(NULL, 2104640, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 4, 0) = 0x2b51825c5000
mprotect(0x2b51825c7000, 2093056, PROT_NONE) = 0
mmap(0x2b51827c6000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 4, 0x1000) = 0x2b51827c6000
close(4) = 0
munmap(0x2b517ee19000, 93699) = 0
open("/etc/host.conf", O_RDONLY) = 4
fstat(4, {st_mode=S_IFREG|0644, st_size=51, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee19000
read(4, "order hosts,bind\nmulti on\nnospoo"..., 4096) = 51
read(4, "", 4096) = 0
close(4) = 0
munmap(0x2b517ee19000, 4096) = 0
open("/etc/hosts", O_RDONLY|0x80000 /* O_??? */) = 4
fstat(4, {st_mode=S_IFREG|0644, st_size=98, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee19000
read(4, "192.168.1.12\t\tkerberos.bluemaple"..., 4096) = 98
read(4, "", 4096) = 0
close(4) = 0
munmap(0x2b517ee19000, 4096) = 0
open("/etc/openldap/ldap.conf", O_RDONLY) = 4
fstat(4, {st_mode=S_IFREG|0644, st_size=692, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee19000
read(4, "# $OpenLDAP: pkg/ldap/libraries/"..., 4096) = 692
read(4, "", 4096) = 0
close(4) = 0
munmap(0x2b517ee19000, 4096) = 0
open("/usr/local/jboss-4.2.3.GA//ldaprc", O_RDONLY) = -1 ENOENT (No such file or directory)
open("/usr/local/jboss-4.2.3.GA//.ldaprc", O_RDONLY) = -1 ENOENT (No such file or directory)
open("ldaprc", O_RDONLY) = -1 ENOENT (No such file or directory)
stat("/etc/ldap.conf", {st_mode=S_IFREG|0644, st_size=9693, ...}) = 0
geteuid() = 0
brk(0x64f000) = 0x64f000
stat("/etc/ldap.conf", {st_mode=S_IFREG|0644, st_size=9693, ...}) = 0
geteuid() = 0
socket(PF_NETLINK, SOCK_RAW, 0) = 4
bind(4, {sa_family=AF_NETLINK, pid=0, groups=00000000}, 12) = 0
getsockname(4, {sa_family=AF_NETLINK, pid=11174, groups=00000000}, [3160928554980474892]) = 0
gettimeofday({1219712881, 608098}, NULL) = 0
sendto(4, "\24\0\0\0\26\0\1\3qW\263H\0\0\0\0\0\0\0\0", 20, 0, {sa_family=AF_NETLINK, pid=0, groups=00000000}, 12) = 20
recvmsg(4, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, msg_iov(1)=[{"0\0\0\0\24\0\2\0qW\263H\246+\0\0\2\10\200\376\1\0\0\0\10\0\1\0\177\0\0\1"..., 4096}], msg_controllen=0, msg_flags=0}, 0) = 228
recvmsg(4, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, msg_iov(1)=[{"@\0\0\0\24\0\2\0qW\263H\246+\0\0\n\200\200\376\1\0\0\0\24\0\1\0\0\0\0\0"..., 4096}], msg_controllen=0, msg_flags=0}, 0) = 256
recvmsg(4, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, msg_iov(1)=[{"\24\0\0\0\3\0\2\0qW\263H\246+\0\0\0\0\0\0\1\0\0\0\24\0\1\0\0\0\0\0"..., 4096}], msg_controllen=0, msg_flags=0}, 0) = 20
close(4) = 0
open("/etc/hosts", O_RDONLY|0x80000 /* O_??? */) = 4
fstat(4, {st_mode=S_IFREG|0644, st_size=98, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee19000
read(4, "192.168.1.12\t\tkerberos.bluemaple"..., 4096) = 98
read(4, "", 4096) = 0
close(4) = 0
munmap(0x2b517ee19000, 4096) = 0
open("/etc/hosts", O_RDONLY|0x80000 /* O_??? */) = 4
fstat(4, {st_mode=S_IFREG|0644, st_size=98, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee19000
read(4, "192.168.1.12\t\tkerberos.bluemaple"..., 4096) = 98
read(4, "", 4096) = 0
close(4) = 0
munmap(0x2b517ee19000, 4096) = 0
socket(PF_INET, SOCK_STREAM, IPPROTO_IP) = 4
fcntl(4, F_SETFD, FD_CLOEXEC) = 0
setsockopt(4, SOL_SOCKET, SO_KEEPALIVE, [1], 4) = 0
setsockopt(4, SOL_TCP, TCP_NODELAY, [1], 4) = 0
fcntl(4, F_GETFL) = 0x2 (flags O_RDWR)
fcntl(4, F_SETFL, O_RDWR|O_NONBLOCK) = 0
connect(4, {sa_family=AF_INET, sin_port=htons(389), sin_addr=inet_addr("127.0.0.1")}, 16) = -1 EINPROGRESS (Operation now in progress)
poll([{fd=4, events=POLLOUT|POLLERR|POLLHUP, revents=POLLOUT}], 1, 30000) = 1
getpeername(4, {sa_family=AF_INET, sin_port=htons(389), sin_addr=inet_addr("127.0.0.1")}, [18377501229438730256]) = 0
fcntl(4, F_GETFL) = 0x802 (flags O_RDWR|O_NONBLOCK)
fcntl(4, F_SETFL, O_RDWR) = 0
gettimeofday({1219712881, 610534}, NULL) = 0
gettimeofday({1219712881, 610655}, NULL) = 0
write(4, "0\35\2\1\1w\30\200\0261.3.6.1.4.1.1466.20037", 31) = 31
gettimeofday({1219712881, 610771}, NULL) = 0
poll([{fd=4, events=POLLIN|POLLPRI|POLLERR|POLLHUP, revents=POLLIN}], 1, 30000) = 1
read(4, "0\f\2\1\1x\7\n", 8) = 8
read(4, "\1\0\4\0\4\0", 6) = 6
gettimeofday({1219712881, 611117}, NULL) = 0
open("/usr/share/locale/en_US.UTF-8/LC_MESSAGES/libc.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
open("/usr/share/locale/en_US.utf8/LC_MESSAGES/libc.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
open("/usr/share/locale/en_US/LC_MESSAGES/libc.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
open("/usr/share/locale/en.UTF-8/LC_MESSAGES/libc.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
open("/usr/share/locale/en.utf8/LC_MESSAGES/libc.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
open("/usr/share/locale/en/LC_MESSAGES/libc.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
open("/dev/urandom", O_RDONLY|O_NOCTTY|O_NONBLOCK) = 5
fstat(5, {st_mode=S_IFCHR|0666, st_rdev=makedev(1, 9), ...}) = 0
poll([{fd=5, events=POLLIN, revents=POLLIN}], 1, 10) = 1
read(5, "\207\376\201\226RTM\275\311\177o\251I2X\23\ro\341\331y\356\274\'\232kb\27\210\311\360=", 32) = 32
close(5) = 0
getuid() = 0
gettimeofday({1219712881, 614565}, NULL) = 0
open("/etc/ssl/cacert.crt", O_RDONLY) = 5
fstat(5, {st_mode=S_IFREG|0644, st_size=1269, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee19000
read(5, "-----BEGIN CERTIFICATE-----\nMIID"..., 4096) = 1269
read(5, "", 4096) = 0
close(5) = 0
munmap(0x2b517ee19000, 4096) = 0
open("/etc/pki/tls/cert.pem", O_RDONLY) = 5
fstat(5, {st_mode=S_IFREG|0644, st_size=562120, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee19000
read(5, "Certificate:\n Data:\n V"..., 4096) = 4096
read(5, "dBgNVHQ4EFgQU\noBEKIz6W8Qfs4q8p74"..., 4096) = 4096
read(5, "nVzdC5jb20wggEiMA0GCSqGSIb3DQEBA"..., 4096) = 4096
read(5, ":d6:71:d9\n-----BEGIN CERTIFICATE"..., 4096) = 4096
brk(0x670000) = 0x670000
read(5, ":79:89:21:9a:e2:4c:07:0a:86:35:b"..., 4096) = 4096
read(5, "B4:AB:73:AA:E7:F6:34:60:2F:FA\n "..., 4096) = 4096
read(5, " 68:2f:f0:4b:"..., 4096) = 4096
read(5, " bit):\n 00:a8"..., 4096) = 4096
read(5, "erica Online Root Certification "..., 4096) = 4096
read(5, "7:f2:\n ed:a5:0b:4d:dd:e8:"..., 4096) = 4096
read(5, ":44:2f:a2:\n 6"..., 4096) = 4096
read(5, " Modulus (4096 bit):\n "..., 4096) = 4096
read(5, "\n e4:11:e4:96:46:bd:6c:02"..., 4096) = 4096
read(5, "d:38:6e:cb:5a:bb:86:bc:94:67:33:"..., 4096) = 4096
read(5, " Public Key Algorithm: rsaEnc"..., 4096) = 4096
read(5, "PAQH/BAQDAgEGMA0GCSqGSIb3DQEBBQU"..., 4096) = 4096
read(5, "5ehD5f/xXtabz5OTZy\ndc93Uk3zyZAsu"..., 4096) = 4096
read(5, "68:60:46:fb:28:14:47:55:e1:a7:80"..., 4096) = 4096
read(5, "0.0.2.9.40.51377\n "..., 4096) = 4096
read(5, "A6NC4wAwIE\nkDANBgkqhkiG9w0BAQUFA"..., 4096) = 4096
read(5, "a:d4:48:9f:b9:40:84:0b:98:68:fb:"..., 4096) = 4096
read(5, "plicable standard terms and cond"..., 4096) = 4096
read(5, " RSA Public Key: (4096 b"..., 4096) = 4096
read(5, "b:8b:08:b0:a2:f3:95:4e:1a:cb:9b:"..., 4096) = 4096
read(5, " Modulus (2048 bit):\n "..., 4096) = 4096
read(5, " c8:c7:52:f8:2f:50:d9:ef:b1:"..., 4096) = 4096
read(5, "WAYDVR0gBFEwTzBN\nBgsrBgEEAYGHLgo"..., 4096) = 4096
read(5, "zCkTsA18cgCSR5aiR\nVhKC9+Ar9NuuYS"..., 4096) = 4096
read(5, "5:\n 2f:a2:f0:f2\n-----BEGI"..., 4096) = 4096
read(5, ":c0:40:23:ed:2d:28:82:45:3e:\n "..., 4096) = 4096
read(5, "2:EF:63:64:2B:C3\n\n Signature "..., 4096) = 4096
read(5, "ey Identifier: \n "..., 4096) = 4096
read(5, " a7:e2:ba:9f:f5:f7:4d:a5:3"..., 4096) = 4096
read(5, "2:ac:84:ca:df:a9:f0:5f:04:\n "..., 4096) = 4096
read(5, " X509v3 Subject Key Identi"..., 4096) = 4096
read(5, "a4:43:ce:26:c4:44:12:6c:b8:\n "..., 4096) = 4096
brk(0x691000) = 0x691000
read(5, "7:cf:\n cb:81:"..., 4096) = 4096
read(5, "2:\n cf:29:03:"..., 4096) = 4096
read(5, "blic Key Algorithm: rsaEncryptio"..., 4096) = 4096
read(5, "ature Algorithm: md5WithRSAEncry"..., 4096) = 4096
read(5, "wIEkDANBgkqhkiG9w0BAQQFAAOBgQBOb"..., 4096) = 4096
read(5, "cnVzdC5uZXQxOzA5\nBgNVBAsTMnd3dy5"..., 4096) = 4096
read(5, "jAwMCBFbnRydXN0Lm5ldCBMaW1pdGVk\n"..., 4096) = 4096
read(5, "A1UdHwRpMGcwZaBjoGGkXzBdMQswCQYD"..., 4096) = 4096
read(5, "yption\n RSA Public Ke"..., 4096) = 4096
read(5, " cd:33:9d:3f:a3:96:eb"..., 4096) = 4096
read(5, " X509v3 Issuer Alternative Name"..., 4096) = 4096
read(5, " fa:a0:c7:7d:3a:13:e3:e"..., 4096) = 4096
read(5, " 80:7a:57:ad:f2:ee:5f:"..., 4096) = 4096
read(5, " 1e:5c:4e:2b:8"..., 4096) = 4096
read(5, "6:4c:17:40:c0:09:28:\n e4:"..., 4096) = 4096
read(5, "10:\n dc:28:1a"..., 4096) = 4096
read(5, "Bi9Fi1jUIxaS5BZuKGNZMN9QAZxjiRqf"..., 4096) = 4096
read(5, "5:55:8b:be:92:\n be:9c:a4:"..., 4096) = 4096
read(5, "ical\n Certificate"..., 4096) = 4096
read(5, " c9:4a:fa:3f:a4:ea:07:"..., 4096) = 4096
read(5, ":53:dd:81:aa:d8:63:78:f6:d8:53:6"..., 4096) = 4096
read(5, "DTAyMTIwNTEzMjMzM1oXDTMyMTIwNTEz"..., 4096) = 4096
read(5, "3d:ce:29:2f:d8:6f:9f:89:1c:64:93"..., 4096) = 4096
read(5, "eWJlclRydXN0IEds\nb2JhbCBSb290MIG"..., 4096) = 4096
read(5, " e2:56:05:0f:18:4d:fc:20:82:d"..., 4096) = 4096
read(5, "yaXR5MSEwHwYDVQQDExhodHRw\nOi8vd3"..., 4096) = 4096
read(5, "s (2048 bit):\n "..., 4096) = 4096
read(5, "mBWWg==\n-----END CERTIFICATE----"..., 4096) = 4096
brk(0x6b2000) = 0x6b2000
read(5, "0:\n ef:d3:96:7e:26:90:89:"..., 4096) = 4096
read(5, ":75:a6:71:28:\n "..., 4096) = 4096
read(5, "ZRCb92CRTzo3wno7wpVqVZHYUxJZHMQ\n"..., 4096) = 4096
read(5, "Key Usage: \n TLS "..., 4096) = 4096
read(5, "VzL2lw\nczIwMDIvcmVuZXdhbENMQVNFM"..., 4096) = 4096
read(5, "/ips2002CLASEA1.crl\n "..., 4096) = 4096
read(5, ".es C.I.F. B-60929452, OU=IPS C"..., 4096) = 4096
read(5, "MDEwNzUwWjCCARQxCzAJBgNVBAYTAkVT"..., 4096) = 4096
read(5, ":9D:09:D5:0E:60:78:03:22:A2:3F:C"..., 4096) = 4096
read(5, "R4w\nHAYJKoZIhvcNAQkBFg9pcHNAbWFp"..., 4096) = 4096
read(5, "-END CERTIFICATE-----\nCertificat"..., 4096) = 4096
read(5, "Lm5ldC9kb2NzIGNpbWVuIHZhZ3kg\na2V"..., 4096) = 4096
read(5, " 7a:e9:e2:80:c3:e9:e9:f6:fd:6c:1"..., 4096) = 4096
read(5, ":86:51:1c:e4:fe:64:08:28:04:79:0"..., 4096) = 4096
read(5, "NlcnRpZmljYXRlIGFyZSBzdWJqZWN0IH"..., 4096) = 4096
read(5, "QH/BAgwBgEB/wIBBDAOBgNVHQ8BAf8E\n"..., 4096) = 4096
read(5, " \n Certificate Si"..., 4096) = 4096
read(5, "oPkg3Goi3XZZenMfvJ2II4pEZXNLxId2"..., 4096) = 4096
read(5, "2:2a:e7:bf:a0:72:e5:9c:24:6a:31:"..., 4096) = 4096
read(5, " Signature Algorithm: sha1With"..., 4096) = 4096
read(5, "DVQQKExBRdW9WYWRpcyBMaW1pdGVkMSU"..., 4096) = 4096
read(5, "hvcNAQECBQADfgBl3X7hsuyw4jrg7HFG"..., 4096) = 4096
read(5, "94:ce:01:ea:3e:b5:63:\n "..., 4096) = 4096
read(5, "c:57:a5:0c:6d:\n "..., 4096) = 4096
read(5, "o:\n Public Key Algori"..., 4096) = 4096
read(5, "LDXE97IMzbtFuMhbsmMcWi1mmNKsFVy2"..., 4096) = 4096
read(5, "2Uv\nkVrCqIexVmiUefkl98HVrhq4uz2P"..., 4096) = 4096
read(5, "dj4ro1tgQIkejanZz2\nZrUYrAqmVCY0M"..., 4096) = 4096
brk(0x6d3000) = 0x6d3000
read(5, "tpb3ZlcmhlaWQubmwvcG9saWNpZXMv\nc"..., 4096) = 4096
read(5, "GlvbiBBdXRob3JpdHkwggEgMA0GCSqGS"..., 4096) = 4096
read(5, "\n CA:TRUE\n "..., 4096) = 4096
read(5, "kqcwEKDwOzEmDyei+B\n26Nu/yYwl/WL3"..., 4096) = 4096
read(5, "e:da:a5:ef:1e:60:85:69:42:d3:\n "..., 4096) = 4096
read(5, "QBUwABBgdghXQBUwABMBIGA1UdEwEB/w"..., 4096) = 4096
read(5, "er: \n keyid:5B:25"..., 4096) = 4096
read(5, "----END CERTIFICATE-----\nCertifi"..., 4096) = 4096
read(5, " b7:2f:c8:98:ab:fe:8a:50:59"..., 4096) = 4096
read(5, ":79:83:f6:e8:\n "..., 4096) = 4096
read(5, "0:a4:65:6c:4c:09:0c:89:ba:b8:d3:"..., 4096) = 4096
read(5, "ce:fb:7c:82:e8:11:\n "..., 4096) = 4096
read(5, ":82:3f:04:8e:b4:d5:f0:49:a7:64:b"..., 4096) = 4096
read(5, "T\n Subject: C=DE, ST=Hamb"..., 4096) = 4096
read(5, ":9a:2a:59:aa:c4:\n "..., 4096) = 4096
read(5, " Exponent: 65537 (0x"..., 4096) = 4096
read(5, " 90:8e:49:4c:c4:56:"..., 4096) = 4096
read(5, "Eu\nMS4xLiBDZXJ0aWZpY2F0ZXMgZnJvb"..., 4096) = 4096
read(5, " Signature Algorithm: md5WithRS"..., 4096) = 4096
read(5, " f2:44:d9:d5:88:12:dd:76"..., 4096) = 4096
read(5, "--\nMIIDJzCCApCgAwIBAgIBATANBgkqh"..., 4096) = 4096
read(5, "uW8NxuOzRAvZim+aKZuZGCg70eNAKJpa"..., 4096) = 4096
read(5, "d:15:e1:eb:cb:3a:d5:e2:\n "..., 4096) = 4096
read(5, " 00:df:71:6f:3"..., 4096) = 4096
read(5, "u2l+nZrghtWjlA3QVHdWpaIbOjGM9O9y"..., 4096) = 4096
read(5, "8uRgnn4AgPLit6\nE5Qbvfa2gI5lBZMAH"..., 4096) = 4096
read(5, "0:68:52:\n 9e:df:a2:85:c5:"..., 4096) = 4096
read(5, " CA:TRUE\n "..., 4096) = 4096
brk(0x6f4000) = 0x6f4000
read(5, "3:82:69:24:76:28:59:35:a1:1d:c0:"..., 4096) = 4096
read(5, "t Before: Jul 9 18:31:20 1999 G"..., 4096) = 4096
read(5, "8ydgwQgYDVR0fBDswOTA3oDWgM4YxaHR"..., 4096) = 4096
read(5, "XNlIG9ubHkxRTBDBgNVBAMTPFZlcmlTa"..., 4096) = 4096
read(5, "uYy4gLSBGb3IgYXV0aG9yaXplZCB1c2U"..., 4096) = 4096
read(5, ":d8:f4:35:56:80:da:b7:6d:17:8f:9"..., 4096) = 4096
read(5, " X509v3 Subject Key Iden"..., 4096) = 4096
read(5, "66:a6:9b:ea:\n "..., 4096) = 4096
read(5, " Signature Algorithm: md2WithRS"..., 4096) = 4096
read(5, "ryption\n Issuer: C=US, O="..., 4096) = 4096
read(5, ":dd:4f:c3:9b:13:75:b8:01:c0:e6:c"..., 4096) = 4096
read(5, "MeJ5t60aG+rmGyVTyssSv1EYcWskVMP8"..., 4096) = 4096
read(5, "dulus (1024 bit):\n "..., 4096) = 4096
read(5, "n Access: \n OCSP "..., 4096) = 4096
read(5, " Signature Algorithm: sha1WithRS"..., 4096) = 4096
read(5, " 65537 (0x10001)\n X509v3 "..., 4096) = 4096
read(5, ":3e:86:2c:e7:73:\n "..., 4096) = 4096
read(5, "1K7hql+LvqySHyN2y1fAXWijQY7i7RhB"..., 4096) = 968
read(5, "", 4096) = 0
close(5) = 0
munmap(0x2b517ee19000, 4096) = 0
gettimeofday({1219712881, 637151}, NULL) = 0
brk(0x715000) = 0x715000
gettimeofday({1219712881, 637366}, NULL) = 0
write(4, "\200\206\1\3\1\0]\0\0\0 \0\0009\0\0008\0\0005\0\0\210\0\0\207\0\0\204\0\0\26"..., 136) = 136
read(4, "\26\3\1\0J\2\0", 7) = 7
gettimeofday({1219712881, 637873}, NULL) = 0
gettimeofday({1219712881, 637967}, NULL) = 0
read(4, "\0F\3\1H\263Wq\204\346\245\234TT\265\274<\257\1&\23;\253\3407\301\0064\7\267\274\342"..., 72) = 72
read(4, "\26\3\1\6E", 5) = 5
read(4, "\v\0\6A\0\6>\0\2\2710\202\2\2650\202\2\36\2\t\0\254\36798\373\244\20/0\r\6"..., 1605) = 1605
gettimeofday({1219712881, 638818}, NULL) = 0
open("/etc/localtime", O_RDONLY) = 5
fstat(5, {st_mode=S_IFREG|0644, st_size=3543, ...}) = 0
fstat(5, {st_mode=S_IFREG|0644, st_size=3543, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee19000
read(5, "TZif2\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\5\0\0\0\5\0\0\0\0"..., 4096) = 3543
lseek(5, -2264, SEEK_CUR) = 1279
read(5, "TZif2\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\6\0\0\0\6\0\0\0\0"..., 4096) = 2264
close(5) = 0
munmap(0x2b517ee19000, 4096) = 0
gettimeofday({1219712881, 639623}, NULL) = 0
gettimeofday({1219712881, 639732}, NULL) = 0
gettimeofday({1219712881, 639765}, NULL) = 0
read(4, "\26\3\1\0\4", 5) = 5
read(4, "\16\0\0\0", 4) = 4
write(4, "\26\3\1\0\206\20\0\0\202\0\200]\232\272\34\234\250\262i\304\262\21\210`\311\fg\251\241!\200\366"..., 198) = 198
read(4, "\24\3\1\0\1", 5) = 5
read(4, "\1", 1) = 1
read(4, "\26\3\1\0000", 5) = 5
read(4, "\367\302Ef\337\301v\254\321\355\r\210\20{?\21\323\371\233M\212\267T\336\0308\210\347\"/b\273"..., 48) = 48
gettimeofday({1219712881, 641563}, NULL) = 0
write(4, "\27\3\1\0 :\365\272|k0\355\v\230\215\n\3731k\275B\352\247\232[\371\271t1(c<"..., 122) = 122
gettimeofday({1219712881, 641683}, NULL) = 0
poll([{fd=4, events=POLLIN|POLLPRI|POLLERR|POLLHUP, revents=POLLIN}], 1, 30000) = 1
read(4, "\27\3\1\0 ", 5) = 5
read(4, "\352\364\2629T\24\222]\252$xE\241\277\25]\25j:\261\2\tE\322\200\267\r\335\246\340\372\301", 32) = 32
read(4, "\27\3\1\0000", 5) = 5
read(4, "e\254u\33\247l\5\237>/\235\177\361\202\343\345\364R\374T\226\365\352\n\33\r\323vQ@M\245"..., 48) = 48
gettimeofday({1219712881, 642114}, NULL) = 0
setsockopt(4, SOL_SOCKET, SO_KEEPALIVE, [0], 4) = 0
fcntl(4, F_SETFD, FD_CLOEXEC) = 0
getsockname(4, {sa_family=AF_INET, sin_port=htons(34578), sin_addr=inet_addr("127.0.0.1")}, [16]) = 0
getpeername(4, {sa_family=AF_INET, sin_port=htons(389), sin_addr=inet_addr("127.0.0.1")}, [68719476752]) = 0
gettimeofday({1219712881, 642319}, NULL) = 0
gettimeofday({1219712881, 642371}, NULL) = 0
write(4, "\27\3\1\0 \230\272\371\30\25z]\333\336\3\320\246\207zt\2\216}\340D/\327w\234\240v-"..., 170) = 170
poll([{fd=4, events=POLLIN|POLLPRI|POLLERR|POLLHUP, revents=POLLIN}], 1, -1) = 1
read(4, "\27\3\1\0 ", 5) = 5
read(4, "[\234\324\352OD1S\271\242p[z=B\335i\254\322\323b$<\302\"\364}-\270H!C", 32) = 32
read(4, "\27\3\1\0000", 5) = 5
read(4, "\27\361>\233\211\305_\36\311s\347Z\325|T\377\17(vc\262\374D\224\376\22\365N\35p\331\33"..., 48) = 48
gettimeofday({1219712881, 643042}, NULL) = 0
gettimeofday({1219712881, 643074}, NULL) = 0
stat("/etc/ldap.conf", {st_mode=S_IFREG|0644, st_size=9693, ...}) = 0
geteuid() = 0
getsockname(4, {sa_family=AF_INET, sin_port=htons(34578), sin_addr=inet_addr("127.0.0.1")}, [3160904958430150672]) = 0
getpeername(4, {sa_family=AF_INET, sin_port=htons(389), sin_addr=inet_addr("127.0.0.1")}, [68719476752]) = 0
stat("/etc/ldap.conf", {st_mode=S_IFREG|0644, st_size=9693, ...}) = 0
geteuid() = 0
getsockname(4, {sa_family=AF_INET, sin_port=htons(34578), sin_addr=inet_addr("127.0.0.1")}, [16]) = 0
getpeername(4, {sa_family=AF_INET, sin_port=htons(389), sin_addr=inet_addr("127.0.0.1")}, [68719476752]) = 0
gettimeofday({1219712881, 643470}, NULL) = 0
write(4, "\27\3\1\0 \333:\366T\344l\246\274\325$C/\26\10\362\177\27\222\252\243&q\342\0235a\23"..., 186) = 186
gettimeofday({1219712881, 643571}, NULL) = 0
poll([{fd=4, events=POLLIN|POLLPRI|POLLERR|POLLHUP, revents=POLLIN}], 1, -1) = 1
read(4, "\27\3\1\0 ", 5) = 5
read(4, "\23\356\355\370mq5\322i \260\20_&\365\210\255\16fp\206\365&\336\234<\321~\202\243&=", 32) = 32
read(4, "\27\3\1\0000", 5) = 5
read(4, "\352\223{$\217\37#\212\330\300\4\244\205T{\314\204X`|\225\243\374\0329\327\'\240\331\rp0"..., 48) = 48
gettimeofday({1219712881, 644069}, NULL) = 0
stat("/etc/ldap.conf", {st_mode=S_IFREG|0644, st_size=9693, ...}) = 0
geteuid() = 0
getsockname(4, {sa_family=AF_INET, sin_port=htons(34578), sin_addr=inet_addr("127.0.0.1")}, [16]) = 0
getpeername(4, {sa_family=AF_INET, sin_port=htons(389), sin_addr=inet_addr("127.0.0.1")}, [68719476752]) = 0
rt_sigaction(SIGPIPE, {SIG_IGN}, NULL, 8) = 0
open("/etc/passwd", O_RDONLY|0x80000 /* O_??? */) = 5
fstat(5, {st_mode=S_IFREG|0644, st_size=1661, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee19000
read(5, "root:x:0:0:root:/root:/bin/bash\n"..., 4096) = 1661
close(5) = 0
munmap(0x2b517ee19000, 4096) = 0
open("/etc/group", O_RDONLY|0x80000 /* O_??? */) = 5
fstat(5, {st_mode=S_IFREG|0644, st_size=669, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee19000
read(5, "root:x:0:\nbin:x:1:\ndaemon:x:2:me"..., 4096) = 669
close(5) = 0
munmap(0x2b517ee19000, 4096) = 0
open("/etc/group", O_RDONLY|0x80000 /* O_??? */) = 5
fstat(5, {st_mode=S_IFREG|0644, st_size=669, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b517ee19000
lseek(5, 0, SEEK_CUR) = 0
read(5, "root:x:0:\nbin:x:1:\ndaemon:x:2:me"..., 4096) = 669
read(5, "", 4096) = 0
close(5) = 0
munmap(0x2b517ee19000, 4096) = 0
rt_sigaction(SIGPIPE, {SIG_IGN}, {SIG_IGN}, 8) = 0
stat("/etc/ldap.conf", {st_mode=S_IFREG|0644, st_size=9693, ...}) = 0
geteuid() = 0
getsockname(4, {sa_family=AF_INET, sin_port=htons(34578), sin_addr=inet_addr("127.0.0.1")}, [16]) = 0
getpeername(4, {sa_family=AF_INET, sin_port=htons(389), sin_addr=inet_addr("127.0.0.1")}, [68719476752]) = 0
stat("/etc/ldap.conf", {st_mode=S_IFREG|0644, st_size=9693, ...}) = 0
geteuid() = 0
getsockname(4, {sa_family=AF_INET, sin_port=htons(34578), sin_addr=inet_addr("127.0.0.1")}, [9393265137604886544]) = 0
getpeername(4, {sa_family=AF_INET, sin_port=htons(389), sin_addr=inet_addr("127.0.0.1")}, [68719476752]) = 0
stat("/etc/ldap.conf", {st_mode=S_IFREG|0644, st_size=9693, ...}) = 0
geteuid() = 0
getsockname(4, {sa_family=AF_INET, sin_port=htons(34578), sin_addr=inet_addr("127.0.0.1")}, [16]) = 0
getpeername(4, {sa_family=AF_INET, sin_port=htons(389), sin_addr=inet_addr("127.0.0.1")}, [68719476752]) = 0
gettimeofday({1219712881, 645589}, NULL) = 0
write(4, "\27\3\1\0 \253@\210\354\224\330\24\327\27E\370$\315\276O\274\177\356\0\255\37\250\21\327<\304z"..., 170) = 170
poll([{fd=4, events=POLLIN|POLLPRI|POLLERR|POLLHUP, revents=POLLIN}], 1, -1) = 1
read(4, "\27\3\1\0 ", 5) = 5
read(4, "o\346P\364t\346KEA\223\344\276\317lE\334r\211d\277\0273\266\275\331\261`Cy\4\221A", 32) = 32
read(4, "\27\3\1\0000", 5) = 5
read(4, "\25\370f\3655\342\20\351\27Y\243\217\t[\325\204\316\374>y&\334m\237\333\231w\337\264.Y\365"..., 48) = 48
gettimeofday({1219712881, 646113}, NULL) = 0
gettimeofday({1219712881, 646144}, NULL) = 0
stat("/etc/ldap.conf", {st_mode=S_IFREG|0644, st_size=9693, ...}) = 0
geteuid() = 0
getsockname(4, {sa_family=AF_INET, sin_port=htons(34578), sin_addr=inet_addr("127.0.0.1")}, [9583941490611060752]) = 0
getpeername(4, {sa_family=AF_INET, sin_port=htons(389), sin_addr=inet_addr("127.0.0.1")}, [68719476752]) = 0
stat("/etc/ldap.conf", {st_mode=S_IFREG|0644, st_size=9693, ...}) = 0
geteuid() = 0
getsockname(4, {sa_family=AF_INET, sin_port=htons(34578), sin_addr=inet_addr("127.0.0.1")}, [9583941482021126160]) = 0
getpeername(4, {sa_family=AF_INET, sin_port=htons(389), sin_addr=inet_addr("127.0.0.1")}, [68719476752]) = 0
gettimeofday({1219712881, 646529}, NULL) = 0
write(4, "\27\3\1\0 \321\204b\347\240T\r\6v=\345K\302\263\"]af8$\266\203ju3\246\177"..., 186) = 186
gettimeofday({1219712881, 646630}, NULL) = 0
poll([{fd=4, events=POLLIN|POLLPRI|POLLERR|POLLHUP, revents=POLLIN}], 1, -1) = 1
read(4, "\27\3\1\0 ", 5) = 5
read(4, "6\320P\t\270\245J\257\366\1}\313\204\3>\361\316C_G\30\335\33\361\334\227\26\316X4\226G", 32) = 32
read(4, "\27\3\1\0000", 5) = 5
read(4, "P\237\216\21B\227\214+\213\fy\310p\270\3~\221\244Q\3765_\214A\207\372\226\350\340F25"..., 48) = 48
gettimeofday({1219712881, 647021}, NULL) = 0
stat("/etc/ldap.conf", {st_mode=S_IFREG|0644, st_size=9693, ...}) = 0
geteuid() = 0
getsockname(4, {sa_family=AF_INET, sin_port=htons(34578), sin_addr=inet_addr("127.0.0.1")}, [16]) = 0
getpeername(4, {sa_family=AF_INET, sin_port=htons(389), sin_addr=inet_addr("127.0.0.1")}, [68719476752]) = 0
rt_sigaction(SIGPIPE, {SIG_IGN}, NULL, 8) = 0
read(3, "", 4096) = 0
close(3) = 0
munmap(0x2b517ee18000, 4096) = 0
open("/etc/security/limits.d", O_RDONLY|O_NONBLOCK|O_DIRECTORY|0x80000) = -1 ENOENT (No such file or directory)
setrlimit(RLIMIT_NICE, {rlim_cur=20, rlim_max=20}) = 0
setrlimit(RLIMIT_RTPRIO, {rlim_cur=0, rlim_max=0}) = 0
getuid() = 0
access("/var/run/utmpx", F_OK) = -1 ENOENT (No such file or directory)
open("/var/run/utmp", O_RDWR|0x80000 /* O_??? */) = 3
fcntl(3, F_GETFD) = 0x1 (flags FD_CLOEXEC)
fcntl(3, F_SETFD, FD_CLOEXEC) = 0
lseek(3, 0, SEEK_SET) = 0
alarm(0) = 0
rt_sigaction(SIGALRM, {0x2b517f3f6d30, [], SA_RESTORER, 0x2b517f321ae0}, {SIG_DFL}, 8) = 0
alarm(1) = 0
fcntl(3, F_SETLKW, {type=F_RDLCK, whence=SEEK_SET, start=0, len=0}) = 0
read(3, "\10\0\0\0\327\3\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 384) = 384
read(3, "\2\0\0\0\0\0\0\0~\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 384) = 384
read(3, "\1\0\0\0005N\0\0~\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 384) = 384
read(3, "\10\0\0\0q\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 384) = 384
read(3, "\6\0\0\0\5\36\0\0tty1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 384) = 384
read(3, "\6\0\0\0\6\36\0\0tty2\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 384) = 384
read(3, "\6\0\0\0\7\36\0\0tty3\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 384) = 384
read(3, "\6\0\0\0\10\36\0\0tty4\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 384) = 384
read(3, "\6\0\0\0\t\36\0\0tty5\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 384) = 384
read(3, "\6\0\0\0\n\36\0\0tty6\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 384) = 384
read(3, "", 384) = 0
fcntl(3, F_SETLKW, {type=F_UNLCK, whence=SEEK_SET, start=0, len=0}) = 0
alarm(0) = 1
rt_sigaction(SIGALRM, {SIG_DFL}, NULL, 8) = 0
close(3) = 0
getuid() = 0
gettimeofday({1219712881, 648302}, NULL) = 0
stat("/etc/localtime", {st_mode=S_IFREG|0644, st_size=3543, ...}) = 0
socket(PF_FILE, SOCK_DGRAM, 0) = 3
fcntl(3, F_SETFD, FD_CLOEXEC) = 0
connect(3, {sa_family=AF_FILE, path="/dev/log"}, 110) = 0
sendto(3, "<86>Aug 25 20:08:01 su: pam_unix"..., 86, MSG_NOSIGNAL, NULL, 0) = 86
socket(PF_NETLINK, SOCK_RAW, 9) = 5
fcntl(5, F_SETFD, FD_CLOEXEC) = 0
readlink("/proc/self/exe", "/bin/su", 4095) = 7
sendto(5, "p\0\0\0Q\4\5\0\3\0\0\0\0\0\0\0op=PAM:session_o"..., 112, 0, {sa_family=AF_NETLINK, pid=0, groups=00000000}, 12) = 112
poll([{fd=5, events=POLLIN, revents=POLLIN}], 1, 100) = 1
recvfrom(5, "$\0\0\0\2\0\0\0\3\0\0\0\246+\0\0\0\0\0\0p\0\0\0Q\4\5\0\3\0\0\0"..., 8988, MSG_PEEK|MSG_DONTWAIT, {sa_family=AF_NETLINK, pid=0, groups=00000000}, [12]) = 36
recvfrom(5, "$\0\0\0\2\0\0\0\3\0\0\0\246+\0\0\0\0\0\0p\0\0\0Q\4\5\0\3\0\0\0"..., 8988, MSG_DONTWAIT, {sa_family=AF_NETLINK, pid=0, groups=00000000}, [12]) = 36
close(5) = 0
socket(PF_NETLINK, SOCK_RAW, 9) = 5
fcntl(5, F_SETFD, FD_CLOEXEC) = 0
readlink("/proc/self/exe", "/bin/su", 4095) = 7
sendto(5, "l\0\0\0O\4\5\0\4\0\0\0\0\0\0\0op=PAM:setcred a"..., 108, 0, {sa_family=AF_NETLINK, pid=0, groups=00000000}, 12) = 108
poll([{fd=5, events=POLLIN, revents=POLLIN}], 1, 100) = 1
recvfrom(5, "$\0\0\0\2\0\0\0\4\0\0\0\246+\0\0\0\0\0\0l\0\0\0O\4\5\0\4\0\0\0"..., 8988, MSG_PEEK|MSG_DONTWAIT, {sa_family=AF_NETLINK, pid=0, groups=00000000}, [12]) = 36
recvfrom(5, "$\0\0\0\2\0\0\0\4\0\0\0\246+\0\0\0\0\0\0l\0\0\0O\4\5\0\4\0\0\0"..., 8988, MSG_DONTWAIT, {sa_family=AF_NETLINK, pid=0, groups=00000000}, [12]) = 36
close(5) = 0
rt_sigaction(SIGPIPE, {SIG_IGN}, {SIG_IGN}, 8) = 0
clone(child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x2b517fa5fd00) = 11179
rt_sigaction(SIGPIPE, {SIG_IGN}, NULL, 8) = 0
rt_sigprocmask(SIG_BLOCK, ~[RTMIN RT_1], NULL, 8) = 0
rt_sigaction(SIGTERM, {0x401cf0, [], SA_RESTORER, 0x2b517f321ae0}, NULL, 8) = 0
rt_sigprocmask(SIG_UNBLOCK, [ALRM TERM], NULL, 8) = 0
wait4(-1, [{WIFEXITED(s) && WEXITSTATUS(s) == 1}], WSTOPPED, NULL) = 11179
socket(PF_NETLINK, SOCK_RAW, 9) = 5
fcntl(5, F_SETFD, FD_CLOEXEC) = 0
readlink("/proc/self/exe", "/bin/su", 4095) = 7
sendto(5, "l\0\0\0P\4\5\0\5\0\0\0\0\0\0\0op=PAM:setcred a"..., 108, 0, {sa_family=AF_NETLINK, pid=0, groups=00000000}, 12) = 108
poll([{fd=5, events=POLLIN, revents=POLLIN}], 1, 100) = 1
recvfrom(5, "$\0\0\0\2\0\0\0\5\0\0\0\246+\0\0\0\0\0\0l\0\0\0P\4\5\0\5\0\0\0"..., 8988, MSG_PEEK|MSG_DONTWAIT, {sa_family=AF_NETLINK, pid=0, groups=00000000}, [12]) = 36
recvfrom(5, "$\0\0\0\2\0\0\0\5\0\0\0\246+\0\0\0\0\0\0l\0\0\0P\4\5\0\5\0\0\0"..., 8988, MSG_DONTWAIT, {sa_family=AF_NETLINK, pid=0, groups=00000000}, [12]) = 36
close(5) = 0
getuid() = 0
gettimeofday({1219712881, 659526}, NULL) = 0
stat("/etc/localtime", {st_mode=S_IFREG|0644, st_size=3543, ...}) = 0
sendto(3, "<86>Aug 25 20:08:01 su: pam_unix"..., 75, MSG_NOSIGNAL, NULL, 0) = 75
socket(PF_NETLINK, SOCK_RAW, 9) = 5
fcntl(5, F_SETFD, FD_CLOEXEC) = 0
readlink("/proc/self/exe", "/bin/su", 4095) = 7
sendto(5, "p\0\0\0R\4\5\0\6\0\0\0\0\0\0\0op=PAM:session_c"..., 112, 0, {sa_family=AF_NETLINK, pid=0, groups=00000000}, 12) = 112
poll([{fd=5, events=POLLIN, revents=POLLIN}], 1, 100) = 1
recvfrom(5, "$\0\0\0\2\0\0\0\6\0\0\0\246+\0\0\0\0\0\0p\0\0\0R\4\5\0\6\0\0\0"..., 8988, MSG_PEEK|MSG_DONTWAIT, {sa_family=AF_NETLINK, pid=0, groups=00000000}, [12]) = 36
recvfrom(5, "$\0\0\0\2\0\0\0\6\0\0\0\246+\0\0\0\0\0\0p\0\0\0R\4\5\0\6\0\0\0"..., 8988, MSG_DONTWAIT, {sa_family=AF_NETLINK, pid=0, groups=00000000}, [12]) = 36
close(5) = 0
munmap(0x2b517fc6c000, 2099496) = 0
munm
View the original post : http://www.jboss.com/index.html?module=bb&op=viewtopic&p=4172445#4172445
Reply to the post : http://www.jboss.com/index.html?module=bb&op=posting&mode=reply&p=4172445
17 years, 8 months
[JBoss Cache: Core Edition] - Re: Endless loop trying to obtain lock in 1.4.1.SP9
by BradleyDouglas
Thanks for replying - but I've got two things to clear up.
Firstly, is there a way to tell which version of the cache is being used? The reason I ask is that I've upgraded out app & jboss app server to use the core cahce version 2.2.1 and still appear to have the same problem with it endlessly looping trying to lock a node that is already locked by the user.
I've attached the new logs below, and would really appreciate some help, as I've had to disable 2nd level cacheing in hibernate as this is taking our production environment off the air when it goes awry. The first logs are a grep for "ReconciliationBatch#2" showing the life of the node that is being locked when things go bad. The second is a snippet of all the jboss.cache logs around where the endless loop starts.
Please - any help or hints about how resolve this would be really appreciated, and if more details are needed I'm happy to provide them.
Thanks,
anonymous wrote :
| 2008-08-25 16:12:34,953 TRACE [org.hibernate.event.def.DefaultFlushEntityEventListener] Updating entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:35,015 TRACE [org.hibernate.persister.entity.AbstractEntityPersister] Updating entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:35,015 TRACE [org.hibernate.persister.entity.AbstractEntityPersister] Dehydrating entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:35,015 DEBUG [org.hibernate.cache.TransactionalCache] updating: com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2
| 2008-08-25 16:12:35,015 TRACE [org.jboss.cache.interceptors.TxInterceptor] (null) call on method [_put; id:3(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, item, CacheEntry(com.synyati.spurwing.reconciliation.entity.ReconciliationBatch)[1,true,Mon Aug 25 16:12:33 EST 2008,3,Mon Aug 25 16:12:33 EST 2008,3,CONTRIBUTED,2,3,2,null,0,null,BGD100_payer.csv], true)]
| 2008-08-25 16:12:35,015 TRACE [org.jboss.cache.interceptors.PessimisticLockInterceptor] PessimisticLockInterceptor invoked for method _put; id:3(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, item, CacheEntry(com.synyati.spurwing.reconciliation.entity.ReconciliationBatch)[1,true,Mon Aug 25 16:12:33 EST 2008,3,Mon Aug 25 16:12:33 EST 2008,3,CONTRIBUTED,2,3,2,null,0,null,BGD100_payer.csv], true)
| 2008-08-25 16:12:35,015 TRACE [org.jboss.cache.interceptors.PessimisticLockInterceptor] Attempting to lock node /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 for owner GlobalTransaction::10
| 2008-08-25 16:12:35,015 TRACE [org.jboss.cache.Node] created child: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2
| 2008-08-25 16:12:35,015 TRACE [org.jboss.cache.Node] acquiring WL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, caller=GlobalTransaction::10, lock=
| 2008-08-25 16:12:35,015 TRACE [org.jboss.cache.Node] acquired WL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, caller=GlobalTransaction::10, lock=write owner=GlobalTransaction::10
| 2008-08-25 16:12:35,015 TRACE [org.jboss.cache.interceptors.CallInterceptor] Invoking method _put; id:3(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, item, CacheEntry(com.synyati.spurwing.reconciliation.entity.ReconciliationBatch)[1,true,Mon Aug 25 16:12:33 EST 2008,3,Mon Aug 25 16:12:33 EST 2008,3,CONTRIBUTED,2,3,2,null,0,null,BGD100_payer.csv], true) on cache.
| 2008-08-25 16:12:35,015 TRACE [org.jboss.cache.TreeCache] _put(GlobalTransaction::10, "/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2", item, CacheEntry(com.synyati.spurwing.reconciliation.entity.ReconciliationBatch)[1,true,Mon Aug 25 16:12:33 EST 2008,3,Mon Aug 25 16:12:33 EST 2008,3,CONTRIBUTED,2,3,2,null,0,null,BGD100_payer.csv])
| 2008-08-25 16:12:35,015 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Adding event EvictedEN[fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 event=3 diff=1] to region at /_default_/
| 2008-08-25 16:12:35,125 TRACE [org.hibernate.engine.QueryParameters] named parameters: {batch=com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2}
| 2008-08-25 16:12:35,171 TRACE [org.jboss.cache.Node] acquiring WL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, caller=GlobalTransaction::10, lock=write owner=GlobalTransaction::10
| 2008-08-25 16:12:35,171 TRACE [org.jboss.cache.lock.IdentityLock] acquireWriteLock(): caller already owns lock for /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 (caller=GlobalTransaction::10)
| 2008-08-25 16:12:35,171 TRACE [org.jboss.cache.Node] acquired WL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, caller=GlobalTransaction::10, lock=write owner=GlobalTransaction::10
| 2008-08-25 16:12:35,531 DEBUG [org.jboss.cache.eviction.BaseEvictionAlgorithm] Adding element /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 for a node that doesn't exist yet. Process as an add.
| 2008-08-25 16:12:35,531 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] Adding node /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 with 1 elements to eviction queue
| 2008-08-25 16:12:35,531 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 added successfully to eviction queue
| 2008-08-25 16:12:35,531 TRACE [org.jboss.cache.Node] acquiring WL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, caller=GlobalTransaction::10, lock=write owner=GlobalTransaction::10
| 2008-08-25 16:12:35,531 TRACE [org.jboss.cache.lock.IdentityLock] acquireWriteLock(): caller already owns lock for /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 (caller=GlobalTransaction::10)
| 2008-08-25 16:12:35,531 TRACE [org.jboss.cache.Node] acquired WL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, caller=GlobalTransaction::10, lock=write owner=GlobalTransaction::10
| 2008-08-25 16:12:35,718 TRACE [org.hibernate.event.def.DefaultLoadEventListener] loading entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:35,718 TRACE [org.hibernate.event.def.DefaultLoadEventListener] attempting to resolve: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:35,718 TRACE [org.hibernate.event.def.DefaultLoadEventListener] object not resolved in any cache: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:35,718 TRACE [org.hibernate.persister.entity.AbstractEntityPersister] Fetching entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:35,718 DEBUG [org.hibernate.loader.Loader] loading entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:35,734 DEBUG [org.hibernate.loader.Loader] result row: EntityKey[com.synyati.spurwing.security.entity.Organisation#3], EntityKey[com.synyati.spurwing.i18n.entity.Message#8765], null, null, EntityKey[com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:35,734 TRACE [org.hibernate.loader.Loader] Initializing object from ResultSet: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:35,734 TRACE [org.hibernate.persister.entity.AbstractEntityPersister] Hydrating entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:35,734 DEBUG [org.hibernate.loader.Loader] result row: EntityKey[com.synyati.spurwing.security.entity.Organisation#3], EntityKey[com.synyati.spurwing.i18n.entity.Message#8766], null, null, EntityKey[com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:35,734 DEBUG [org.hibernate.loader.Loader] result row: EntityKey[com.synyati.spurwing.security.entity.Organisation#3], EntityKey[com.synyati.spurwing.i18n.entity.Message#8767], null, null, EntityKey[com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:35,734 DEBUG [org.hibernate.engine.TwoPhaseLoad] resolving associations for [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:35,734 DEBUG [org.hibernate.engine.TwoPhaseLoad] done materializing entity [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:35,734 TRACE [org.hibernate.engine.QueryParameters] named parameters: {batch=com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2}
| 2008-08-25 16:12:35,828 TRACE [org.hibernate.engine.QueryParameters] named parameters: {batch=com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2}
| 2008-08-25 16:12:35,828 TRACE [org.hibernate.engine.QueryParameters] named parameters: {batch=com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2}
| 2008-08-25 16:12:35,828 TRACE [org.hibernate.engine.QueryParameters] named parameters: {batch=com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2}
| 2008-08-25 16:12:35,828 TRACE [org.hibernate.event.def.DefaultLoadEventListener] loading entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:35,828 TRACE [org.hibernate.event.def.DefaultLoadEventListener] attempting to resolve: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:35,828 TRACE [org.hibernate.event.def.DefaultLoadEventListener] object not resolved in any cache: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:35,828 TRACE [org.hibernate.persister.entity.AbstractEntityPersister] Fetching entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:35,828 DEBUG [org.hibernate.loader.Loader] loading entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:35,843 DEBUG [org.hibernate.loader.Loader] result row: EntityKey[com.synyati.spurwing.security.entity.Organisation#3], EntityKey[com.synyati.spurwing.i18n.entity.Message#8765], null, null, EntityKey[com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:35,843 TRACE [org.hibernate.loader.Loader] Initializing object from ResultSet: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:35,843 TRACE [org.hibernate.persister.entity.AbstractEntityPersister] Hydrating entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:35,843 DEBUG [org.hibernate.loader.Loader] result row: EntityKey[com.synyati.spurwing.security.entity.Organisation#3], EntityKey[com.synyati.spurwing.i18n.entity.Message#8766], null, null, EntityKey[com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:35,843 DEBUG [org.hibernate.loader.Loader] result row: EntityKey[com.synyati.spurwing.security.entity.Organisation#3], EntityKey[com.synyati.spurwing.i18n.entity.Message#8767], null, null, EntityKey[com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:35,843 DEBUG [org.hibernate.engine.TwoPhaseLoad] resolving associations for [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:35,843 DEBUG [org.hibernate.engine.TwoPhaseLoad] done materializing entity [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:40,406 TRACE [org.jboss.cache.interceptors.PessimisticLockInterceptor] PessimisticLockInterceptor invoked for method prepare; id:10(GlobalTransaction::10, [_put; id:3(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, item, CacheEntry(com.synyati.spurwing.reconciliation.entity.ReconciliationBatch)[1,true,Mon Aug 25 16:12:33 EST 2008,3,Mon Aug 25 16:12:33 EST 2008,3,CONTRIBUTED,2,3,2,null,0,null,BGD100_payer.csv], true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/TransactionMapping, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatchDataMatch, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationSummary, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/Transaction, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/User, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/SecurityGroupTransaction, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/PeerOrgCode, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/Menu, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reservation/segment/entity/SegmentStatus, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/UserRole, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationErrorData, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/UserSecurityGroup, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/money/entity/CardType, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/Module, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/SecurityGroup, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/Organisation, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/DomainRestriction, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reservation/segment/entity/SegmentType, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/Domain, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/OrganisationSynonym, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/money/entity/CurrencyDescription, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/i18n/entity/Message, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/ModuleTransaction, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatchData, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/TransactionMapping, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatchDataMatch, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationSummary, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/Transaction, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/User, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/SecurityGroupTransaction, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/PeerOrgCode, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/Menu, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reservation/segment/entity/SegmentStatus, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/UserRole, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationErrorData, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/UserSecurityGroup, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/money/entity/CardType, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/Module, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/SecurityGroup, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/Organisation, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/DomainRestriction, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reservation/segment/entity/SegmentType, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/Domain, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/OrganisationSynonym, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/money/entity/CurrencyDescription, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/i18n/entity/Message, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/ModuleTransaction, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatchData, true)], null, false)
| 2008-08-25 16:12:40,406 TRACE [org.jboss.cache.interceptors.CallInterceptor] Suppressing invocation of method prepare; id:10(GlobalTransaction::10, [_put; id:3(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, item, CacheEntry(com.synyati.spurwing.reconciliation.entity.ReconciliationBatch)[1,true,Mon Aug 25 16:12:33 EST 2008,3,Mon Aug 25 16:12:33 EST 2008,3,CONTRIBUTED,2,3,2,null,0,null,BGD100_payer.csv], true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/TransactionMapping, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatchDataMatch, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationSummary, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/Transaction, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/User, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/SecurityGroupTransaction, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/PeerOrgCode, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/Menu, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reservation/segment/entity/SegmentStatus, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/UserRole, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationErrorData, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/UserSecurityGroup, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/money/entity/CardType, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/Module, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/SecurityGroup, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/Organisation, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/DomainRestriction, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reservation/segment/entity/SegmentType, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/Domain, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/OrganisationSynonym, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/money/entity/CurrencyDescription, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/i18n/entity/Message, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/ModuleTransaction, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatchData, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/TransactionMapping, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatchDataMatch, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationSummary, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/Transaction, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/User, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/SecurityGroupTransaction, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/PeerOrgCode, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/Menu, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reservation/segment/entity/SegmentStatus, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/UserRole, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationErrorData, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/UserSecurityGroup, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/money/entity/CardType, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/Module, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/SecurityGroup, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/Organisation, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/DomainRestriction, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reservation/segment/entity/SegmentType, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/Domain, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/OrganisationSynonym, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/money/entity/CurrencyDescription, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/i18n/entity/Message, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/security/entity/ModuleTransaction, true), _remove; id:5(GlobalTransaction::10, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatchData, true)], null, false) on cache.
| 2008-08-25 16:12:40,468 TRACE [org.jboss.cache.TransactionEntry] releasing lock for /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 (write owner=GlobalTransaction::10)
| 2008-08-25 16:12:41,312 TRACE [org.hibernate.event.def.DefaultLoadEventListener] loading entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,312 TRACE [org.hibernate.event.def.DefaultLoadEventListener] attempting to resolve: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,312 TRACE [org.hibernate.event.def.DefaultLoadEventListener] object not resolved in any cache: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,312 TRACE [org.hibernate.persister.entity.AbstractEntityPersister] Fetching entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,312 DEBUG [org.hibernate.loader.Loader] loading entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,312 DEBUG [org.hibernate.loader.Loader] result row: EntityKey[com.synyati.spurwing.security.entity.Organisation#3], EntityKey[com.synyati.spurwing.i18n.entity.Message#8765], null, null, EntityKey[com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,312 TRACE [org.hibernate.loader.Loader] Initializing object from ResultSet: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,312 TRACE [org.hibernate.persister.entity.AbstractEntityPersister] Hydrating entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,328 DEBUG [org.hibernate.loader.Loader] result row: EntityKey[com.synyati.spurwing.security.entity.Organisation#3], EntityKey[com.synyati.spurwing.i18n.entity.Message#8766], null, null, EntityKey[com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,328 DEBUG [org.hibernate.loader.Loader] result row: EntityKey[com.synyati.spurwing.security.entity.Organisation#3], EntityKey[com.synyati.spurwing.i18n.entity.Message#8767], null, null, EntityKey[com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,328 DEBUG [org.hibernate.engine.TwoPhaseLoad] resolving associations for [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,328 DEBUG [org.hibernate.engine.TwoPhaseLoad] done materializing entity [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,328 TRACE [org.hibernate.engine.QueryParameters] named parameters: {batch=com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2}
| 2008-08-25 16:12:41,359 TRACE [org.hibernate.event.def.DefaultLoadEventListener] loading entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,359 TRACE [org.hibernate.event.def.DefaultLoadEventListener] attempting to resolve: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,359 TRACE [org.hibernate.event.def.DefaultLoadEventListener] object not resolved in any cache: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,359 TRACE [org.hibernate.persister.entity.AbstractEntityPersister] Fetching entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,359 DEBUG [org.hibernate.loader.Loader] loading entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,359 DEBUG [org.hibernate.loader.Loader] result row: EntityKey[com.synyati.spurwing.security.entity.Organisation#3], EntityKey[com.synyati.spurwing.i18n.entity.Message#8765], null, null, EntityKey[com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,359 TRACE [org.hibernate.loader.Loader] Initializing object from ResultSet: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,359 TRACE [org.hibernate.persister.entity.AbstractEntityPersister] Hydrating entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,359 DEBUG [org.hibernate.loader.Loader] result row: EntityKey[com.synyati.spurwing.security.entity.Organisation#3], EntityKey[com.synyati.spurwing.i18n.entity.Message#8766], null, null, EntityKey[com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,359 DEBUG [org.hibernate.loader.Loader] result row: EntityKey[com.synyati.spurwing.security.entity.Organisation#3], EntityKey[com.synyati.spurwing.i18n.entity.Message#8767], null, null, EntityKey[com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,375 DEBUG [org.hibernate.engine.TwoPhaseLoad] resolving associations for [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,375 DEBUG [org.hibernate.engine.TwoPhaseLoad] done materializing entity [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,484 TRACE [org.hibernate.engine.QueryParameters] named parameters: {batch=com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2}
| 2008-08-25 16:12:41,500 TRACE [org.hibernate.event.def.DefaultLoadEventListener] loading entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,500 TRACE [org.hibernate.event.def.DefaultLoadEventListener] attempting to resolve: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,500 TRACE [org.hibernate.event.def.DefaultLoadEventListener] object not resolved in any cache: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,500 TRACE [org.hibernate.persister.entity.AbstractEntityPersister] Fetching entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,500 DEBUG [org.hibernate.loader.Loader] loading entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,500 DEBUG [org.hibernate.loader.Loader] result row: EntityKey[com.synyati.spurwing.security.entity.Organisation#3], EntityKey[com.synyati.spurwing.i18n.entity.Message#8765], null, null, EntityKey[com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,500 TRACE [org.hibernate.loader.Loader] Initializing object from ResultSet: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,500 TRACE [org.hibernate.persister.entity.AbstractEntityPersister] Hydrating entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,500 DEBUG [org.hibernate.loader.Loader] result row: EntityKey[com.synyati.spurwing.security.entity.Organisation#3], EntityKey[com.synyati.spurwing.i18n.entity.Message#8766], null, null, EntityKey[com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,500 DEBUG [org.hibernate.loader.Loader] result row: EntityKey[com.synyati.spurwing.security.entity.Organisation#3], EntityKey[com.synyati.spurwing.i18n.entity.Message#8767], null, null, EntityKey[com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,500 DEBUG [org.hibernate.engine.TwoPhaseLoad] resolving associations for [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,500 DEBUG [org.hibernate.engine.TwoPhaseLoad] done materializing entity [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,625 TRACE [org.hibernate.engine.QueryParameters] named parameters: {batch=com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2}
| 2008-08-25 16:12:41,640 TRACE [org.hibernate.event.def.DefaultLoadEventListener] loading entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,640 TRACE [org.hibernate.event.def.DefaultLoadEventListener] attempting to resolve: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,640 TRACE [org.hibernate.event.def.DefaultLoadEventListener] object not resolved in any cache: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,640 TRACE [org.hibernate.persister.entity.AbstractEntityPersister] Fetching entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,640 DEBUG [org.hibernate.loader.Loader] loading entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,656 DEBUG [org.hibernate.loader.Loader] result row: EntityKey[com.synyati.spurwing.security.entity.Organisation#3], EntityKey[com.synyati.spurwing.i18n.entity.Message#8765], null, null, EntityKey[com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,656 TRACE [org.hibernate.loader.Loader] Initializing object from ResultSet: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,656 TRACE [org.hibernate.persister.entity.AbstractEntityPersister] Hydrating entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,656 DEBUG [org.hibernate.loader.Loader] result row: EntityKey[com.synyati.spurwing.security.entity.Organisation#3], EntityKey[com.synyati.spurwing.i18n.entity.Message#8766], null, null, EntityKey[com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,656 DEBUG [org.hibernate.loader.Loader] result row: EntityKey[com.synyati.spurwing.security.entity.Organisation#3], EntityKey[com.synyati.spurwing.i18n.entity.Message#8767], null, null, EntityKey[com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,656 DEBUG [org.hibernate.engine.TwoPhaseLoad] resolving associations for [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:41,656 DEBUG [org.hibernate.engine.TwoPhaseLoad] done materializing entity [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:55,906 DEBUG [org.hibernate.loader.Loader] result row: EntityKey[com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:55,906 TRACE [org.hibernate.loader.Loader] Initializing object from ResultSet: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:55,906 TRACE [org.hibernate.persister.entity.AbstractEntityPersister] Hydrating entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:55,906 DEBUG [org.hibernate.engine.TwoPhaseLoad] resolving associations for [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:55,937 DEBUG [org.hibernate.engine.TwoPhaseLoad] adding entity to second-level cache: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:12:55,937 TRACE [org.jboss.cache.interceptors.TxInterceptor] (null) call on method [_get; id:26(/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, item, true)]
| 2008-08-25 16:12:55,937 TRACE [org.jboss.cache.interceptors.PessimisticLockInterceptor] PessimisticLockInterceptor invoked for method _get; id:26(/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, item, true)
| 2008-08-25 16:12:55,937 TRACE [org.jboss.cache.interceptors.PessimisticLockInterceptor] Attempting to lock node /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 for owner GlobalTransaction::11
| 2008-08-25 16:12:55,937 TRACE [org.jboss.cache.interceptors.CallInterceptor] Invoking method _get; id:26(/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, item, true) on cache.
| 2008-08-25 16:12:55,937 TRACE [org.jboss.cache.TreeCache] _get("/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2", item, "true")
| 2008-08-25 16:12:55,937 DEBUG [org.hibernate.cache.TransactionalCache] caching: com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2
| 2008-08-25 16:12:55,937 TRACE [org.jboss.cache.interceptors.TxInterceptor] (null) call on method [_put; id:4(null, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, item, CacheEntry(com.synyati.spurwing.reconciliation.entity.ReconciliationBatch)[1,true,2008-08-25 16:12:33.0,3,2008-08-25 16:12:33.0,3,CONTRIBUTED,2,3,2,null,0,null,BGD100_payer.csv], true, 0)]
| 2008-08-25 16:12:55,937 TRACE [org.jboss.cache.interceptors.PessimisticLockInterceptor] PessimisticLockInterceptor invoked for method _put; id:4(null, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, item, CacheEntry(com.synyati.spurwing.reconciliation.entity.ReconciliationBatch)[1,true,2008-08-25 16:12:33.0,3,2008-08-25 16:12:33.0,3,CONTRIBUTED,2,3,2,null,0,null,BGD100_payer.csv], true, 0)
| 2008-08-25 16:12:55,937 TRACE [org.jboss.cache.interceptors.PessimisticLockInterceptor] Attempting to lock node /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 for owner Thread[http-127.0.0.1-8080-1,5,jboss]
| 2008-08-25 16:12:55,937 TRACE [org.jboss.cache.Node] created child: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2
| 2008-08-25 16:12:55,937 TRACE [org.jboss.cache.Node] acquiring WL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, caller=Thread[http-127.0.0.1-8080-1,5,jboss], lock=
| 2008-08-25 16:12:55,937 TRACE [org.jboss.cache.Node] acquired WL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, caller=Thread[http-127.0.0.1-8080-1,5,jboss], lock=write owner=Thread[http-127.0.0.1-8080-1,5,jboss]
| 2008-08-25 16:12:55,937 TRACE [org.jboss.cache.interceptors.CallInterceptor] Invoking method _put; id:4(null, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, item, CacheEntry(com.synyati.spurwing.reconciliation.entity.ReconciliationBatch)[1,true,2008-08-25 16:12:33.0,3,2008-08-25 16:12:33.0,3,CONTRIBUTED,2,3,2,null,0,null,BGD100_payer.csv], true, 0) on cache.
| 2008-08-25 16:12:55,937 TRACE [org.jboss.cache.TreeCache] _put(null, "/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2", item, CacheEntry(com.synyati.spurwing.reconciliation.entity.ReconciliationBatch)[1,true,2008-08-25 16:12:33.0,3,2008-08-25 16:12:33.0,3,CONTRIBUTED,2,3,2,null,0,null,BGD100_payer.csv])
| 2008-08-25 16:12:55,937 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Adding event EvictedEN[fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 event=3 diff=1] to region at /_default_/
| 2008-08-25 16:12:55,937 TRACE [org.jboss.cache.interceptors.UnlockInterceptor] releasing lock for /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2: write owner=Thread[http-127.0.0.1-8080-1,5,jboss]
| 2008-08-25 16:12:55,937 DEBUG [org.hibernate.engine.TwoPhaseLoad] done materializing entity [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:13:15,093 TRACE [org.jboss.cache.Node] acquiring WL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, caller=GlobalTransaction::12, lock=
| 2008-08-25 16:13:15,093 TRACE [org.jboss.cache.Node] acquired WL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, caller=GlobalTransaction::12, lock=write owner=GlobalTransaction::12
| 2008-08-25 16:13:15,140 TRACE [org.jboss.cache.Node] acquiring WL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, caller=GlobalTransaction::12, lock=write owner=GlobalTransaction::12
| 2008-08-25 16:13:15,140 TRACE [org.jboss.cache.lock.IdentityLock] acquireWriteLock(): caller already owns lock for /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 (caller=GlobalTransaction::12)
| 2008-08-25 16:13:15,140 TRACE [org.jboss.cache.Node] acquired WL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, caller=GlobalTransaction::12, lock=write owner=GlobalTransaction::12
| 2008-08-25 16:13:17,281 TRACE [org.jboss.cache.TransactionEntry] releasing lock for /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 (write owner=GlobalTransaction::12)
| 2008-08-25 16:13:43,453 TRACE [org.jboss.cache.Node] acquiring WL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, caller=GlobalTransaction::13, lock=
| 2008-08-25 16:13:43,453 TRACE [org.jboss.cache.Node] acquired WL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, caller=GlobalTransaction::13, lock=write owner=GlobalTransaction::13
| 2008-08-25 16:13:43,953 TRACE [org.jboss.cache.TransactionEntry] releasing lock for /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 (write owner=GlobalTransaction::13)
| 2008-08-25 16:14:15,828 TRACE [org.jboss.cache.eviction.LRUAlgorithm] Node /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 has been idle for 75344ms
| 2008-08-25 16:14:15,828 TRACE [org.jboss.cache.eviction.LRUAlgorithm] Node /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 has been alive for 100297ms
| 2008-08-25 16:14:15,828 TRACE [org.jboss.cache.eviction.LRUAlgorithm] Node /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 should not be evicted
| 2008-08-25 16:14:20,812 TRACE [org.jboss.cache.eviction.LRUAlgorithm] Node /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 has been idle for 80328ms
| 2008-08-25 16:14:20,812 TRACE [org.jboss.cache.eviction.LRUAlgorithm] Node /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 has been alive for 105281ms
| 2008-08-25 16:14:20,812 TRACE [org.jboss.cache.eviction.LRUAlgorithm] Node /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 should not be evicted
| 2008-08-25 16:14:23,921 DEBUG [org.hibernate.loader.Loader] result row: EntityKey[com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:14:23,921 TRACE [org.hibernate.loader.Loader] Initializing object from ResultSet: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:14:23,921 TRACE [org.hibernate.persister.entity.AbstractEntityPersister] Hydrating entity: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:14:23,953 DEBUG [org.hibernate.engine.TwoPhaseLoad] resolving associations for [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:14:23,953 DEBUG [org.hibernate.engine.TwoPhaseLoad] adding entity to second-level cache: [com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2]
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.interceptors.TxInterceptor] (null) call on method [_get; id:26(/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, item, true)]
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.interceptors.PessimisticLockInterceptor] PessimisticLockInterceptor invoked for method _get; id:26(/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, item, true)
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.interceptors.PessimisticLockInterceptor] Attempting to lock node /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 for owner GlobalTransaction::14
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.Node] acquiring RL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, caller=GlobalTransaction::14, lock=
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.Node] acquired RL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, caller=GlobalTransaction::14, lock=read owners=[GlobalTransaction::14]
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.interceptors.CallInterceptor] Invoking method _get; id:26(/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, item, true) on cache.
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.TreeCache] _get("/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2", item, "true")
| 2008-08-25 16:14:23,953 DEBUG [org.hibernate.cache.TransactionalCache] caching: com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.interceptors.TxInterceptor] (null) call on method [_put; id:4(null, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, item, CacheEntry(com.synyati.spurwing.reconciliation.entity.ReconciliationBatch)[1,true,2008-08-25 16:12:33.0,3,2008-08-25 16:12:33.0,3,CONTRIBUTED,2,3,2,null,0,null,BGD100_payer.csv], true, 0)]
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.interceptors.PessimisticLockInterceptor] PessimisticLockInterceptor invoked for method _put; id:4(null, /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, item, CacheEntry(com.synyati.spurwing.reconciliation.entity.ReconciliationBatch)[1,true,2008-08-25 16:12:33.0,3,2008-08-25 16:12:33.0,3,CONTRIBUTED,2,3,2,null,0,null,BGD100_payer.csv], true, 0)
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.interceptors.PessimisticLockInterceptor] Attempting to lock node /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 for owner Thread[http-127.0.0.1-8080-1,5,jboss]
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.Node] acquiring WL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, caller=Thread[http-127.0.0.1-8080-1,5,jboss], lock=read owners=[GlobalTransaction::14]
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.Node] acquired WL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, caller=Thread[http-127.0.0.1-8080-1,5,jboss], lock=read owners=[GlobalTransaction::14], write owner=Thread[http-127.0.0.1-8080-1,5,jboss]
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.interceptors.PessimisticLockInterceptor] Attempting to lock node /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 for owner Thread[http-127.0.0.1-8080-1,5,jboss]
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.Node] acquiring WL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, caller=Thread[http-127.0.0.1-8080-1,5,jboss], lock=read owners=[GlobalTransaction::14], write owner=Thread[http-127.0.0.1-8080-1,5,jboss]
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.lock.IdentityLock] acquireWriteLock(): caller already owns lock for /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 (caller=Thread[http-127.0.0.1-8080-1,5,jboss])
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.Node] acquired WL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, caller=Thread[http-127.0.0.1-8080-1,5,jboss], lock=read owners=[GlobalTransaction::14], write owner=Thread[http-127.0.0.1-8080-1,5,jboss]
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.interceptors.PessimisticLockInterceptor] Attempting to lock node /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 for owner Thread[http-127.0.0.1-8080-1,5,jboss]
|
|
anonymous wrote :
| 2008-08-25 16:14:20,812 TRACE [org.jboss.cache.eviction.LRUAlgorithm] Node /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 has been idle for 80328ms
| 2008-08-25 16:14:20,812 TRACE [org.jboss.cache.eviction.LRUAlgorithm] Node /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 has been alive for 105281ms
| 2008-08-25 16:14:20,812 TRACE [org.jboss.cache.eviction.LRUAlgorithm] Node /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 should not be evicted
| ...
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Invoking EvictionInterceptor
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Updating node/element events with no tx
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.eviction.RegionManager] getRegion(): user-specified region not found: / will use the global default region
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.eviction.RegionManager] getRegion(): user-specified region not found: / will use the global default region
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Adding event EvictedEN[fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#3 event=2 diff=0] to region at /_default_/
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Finished updating node
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Finished invoking EvictionInterceptor
| 2008-08-25 16:14:23,953 DEBUG [org.hibernate.cache.TransactionalCache] item already cached: com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#3
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.interceptors.TxInterceptor] (null) call on method [_get; id:26(/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, item, true)]
| 2008-08-25 16:14:23,953 DEBUG [org.jboss.cache.interceptors.TxInterceptor] local transaction exists - registering global tx if not present for Thread[http-127.0.0.1-8080-1,5,jboss]
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.interceptors.TxInterceptor] Associated gtx in txTable is GlobalTransaction::14
| 2008-08-25 16:14:23,953 DEBUG [org.jboss.cache.interceptors.TxInterceptor] Transaction TransactionImple < ac, BasicAction: -3f57fe3d:1215:48b24c98:263 status: ActionStatus.RUNNING > is already registered.
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.interceptors.PessimisticLockInterceptor] PessimisticLockInterceptor invoked for method _get; id:26(/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, item, true)
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.interceptors.PessimisticLockInterceptor] Attempting to lock node /spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2 for owner GlobalTransaction::14
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.Node] acquiring RL: fqn=/, caller=GlobalTransaction::14, lock=read owners=[GlobalTransaction::14]
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.Node] acquired RL: fqn=/, caller=GlobalTransaction::14, lock=read owners=[GlobalTransaction::14]
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.Node] acquiring RL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM, caller=GlobalTransaction::14, lock=read owners=[GlobalTransaction::14]
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.Node] acquired RL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM, caller=GlobalTransaction::14, lock=read owners=[GlobalTransaction::14]
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.Node] acquiring RL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com, caller=GlobalTransaction::14, lock=read owners=[GlobalTransaction::14]
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.Node] acquired RL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com, caller=GlobalTransaction::14, lock=read owners=[GlobalTransaction::14]
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.Node] acquiring RL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati, caller=GlobalTransaction::14, lock=read owners=[GlobalTransaction::14]
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.Node] acquired RL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati, caller=GlobalTransaction::14, lock=read owners=[GlobalTransaction::14]
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.Node] acquiring RL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing, caller=GlobalTransaction::14, lock=read owners=[GlobalTransaction::14]
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.Node] acquired RL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing, caller=GlobalTransaction::14, lock=read owners=[GlobalTransaction::14]
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.Node] acquiring RL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation, caller=GlobalTransaction::14, lock=read owners=[GlobalTransaction::14]
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.Node] acquired RL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation, caller=GlobalTransaction::14, lock=read owners=[GlobalTransaction::14]
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.Node] acquiring RL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity, caller=GlobalTransaction::14, lock=read owners=[GlobalTransaction::14]
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.Node] acquired RL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity, caller=GlobalTransaction::14, lock=read owners=[GlobalTransaction::14]
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.Node] acquiring RL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch, caller=GlobalTransaction::14, lock=read owners=[GlobalTransaction::14]
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.Node] acquired RL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch, caller=GlobalTransaction::14, lock=read owners=[GlobalTransaction::14]
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.Node] acquiring RL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, caller=GlobalTransaction::14, lock=
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.Node] acquired RL: fqn=/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, caller=GlobalTransaction::14, lock=read owners=[GlobalTransaction::14]
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.interceptors.CallInterceptor] Invoking method _get; id:26(/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2, item, true) on cache.
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.TreeCache] _get("/spurwing_ear,spurwing-ejb_jar,SpurwingEM/com/synyati/spurwing/reconciliation/entity/ReconciliationBatch/com.synyati.spurwing.reconciliation.entity.ReconciliationBatch#2", item, "true")
| 2008-08-25 16:14:23,953 TRACE [org.jboss.cache.interceptors.EvictionInterceptor
View the original post : http://www.jboss.com/index.html?module=bb&op=viewtopic&p=4172442#4172442
Reply to the post : http://www.jboss.com/index.html?module=bb&op=posting&mode=reply&p=4172442
17 years, 8 months