root@crcns:~/debug-share# strace -tt -f apache2 -X ... initialization output discarded ... Following generated when request to file made: 21:31:41.805895 epoll_wait(15, {{EPOLLIN, {u32=138144992, u64=593327707488251104}}}, 2, -1) = 1 21:31:59.455156 accept(3, {sa_family=AF_INET, sin_port=htons(61834), sin_addr=inet_addr("192.168.56.1")}, [16]) = 16 21:31:59.457212 semop(458753, 0xb773dd66, 1) = 0 21:31:59.457794 getsockname(16, {sa_family=AF_INET, sin_port=htons(80), sin_addr=inet_addr("192.168.56.103")}, [16]) = 0 21:31:59.457794 fcntl64(16, F_GETFL) = 0x2 (flags O_RDWR) 21:31:59.458081 fcntl64(16, F_SETFL, O_RDWR|O_NONBLOCK) = 0 21:31:59.459216 read(16, "GET /files/news/crcns-neuroinfor"..., 8000) = 629 21:31:59.462268 gettimeofday({1322602319, 462711}, NULL) = 0 21:31:59.464064 stat64("/mnt/crcns-data/downloads/site-files/news/crcns-neuroinformatics-article.pdf", {st_mode=S_IFREG|0644, st_size=134452, ...}) = 0 21:31:59.466810 open("/.htaccess", O_RDONLY|O_LARGEFILE) = -1 ENOENT (No such file or directory) 21:31:59.467751 open("/mnt/.htaccess", O_RDONLY|O_LARGEFILE) = -1 ENOENT (No such file or directory) 21:31:59.468246 open("/mnt/crcns-data/.htaccess", O_RDONLY|O_LARGEFILE) = -1 ENOENT (No such file or directory) 21:31:59.469276 open("/mnt/crcns-data/downloads/.htaccess", O_RDONLY|O_LARGEFILE) = -1 ENOENT (No such file or directory) 21:31:59.471085 open("/mnt/crcns-data/downloads/site-files/.htaccess", O_RDONLY|O_LARGEFILE) = -1 ENOENT (No such file or directory) 21:31:59.472579 open("/mnt/crcns-data/downloads/site-files/news/.htaccess", O_RDONLY|O_LARGEFILE) = -1 ENOENT (No such file or directory) 21:31:59.474664 open("/mnt/crcns-data/downloads/site-files/news/crcns-neuroinformatics-article.pdf/.htaccess", O_RDONLY|O_LARGEFILE) = -1 ENOTDIR (Not a directory) 21:31:59.477315 open("/etc/hosts", O_RDONLY|0x80000 /* O_??? */) = 17 21:31:59.478085 fstat64(17, {st_mode=S_IFREG|0644, st_size=295, ...}) = 0 21:31:59.479584 mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb6882000 21:31:59.480296 read(17, "# File:\n# /etc/hosts\n# \n# For cr"..., 4096) = 295 21:31:59.481294 read(17, "", 4096) = 0 21:31:59.481886 close(17) = 0 21:31:59.482787 munmap(0xb6882000, 4096) = 0 21:31:59.483489 open("/etc/ld.so.cache", O_RDONLY) = 17 21:31:59.484193 fstat64(17, {st_mode=S_IFREG|0644, st_size=19175, ...}) = 0 21:31:59.484952 mmap2(NULL, 19175, PROT_READ, MAP_PRIVATE, 17, 0) = 0xb687e000 21:31:59.485383 close(17) = 0 21:31:59.486039 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) 21:31:59.486984 open("/lib/libnss_dns.so.2", O_RDONLY) = 17 21:31:59.487954 read(17, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\220\v\0"..., 512) = 512 21:31:59.488634 fstat64(17, {st_mode=S_IFREG|0644, st_size=17884, ...}) = 0 21:31:59.489589 mmap2(NULL, 20616, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 17, 0) = 0xb6878000 21:31:59.490130 mmap2(0xb687c000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 17, 0x3) = 0xb687c000 21:31:59.490871 close(17) = 0 21:31:59.491801 munmap(0xb687e000, 19175) = 0 21:31:59.493672 stat64("/etc/resolv.conf", {st_mode=S_IFREG|0644, st_size=175, ...}) = 0 21:31:59.494791 gettimeofday({1322602319, 494951}, NULL) = 0 21:31:59.495385 socket(PF_INET, SOCK_DGRAM, IPPROTO_IP) = 17 21:31:59.495861 connect(17, {sa_family=AF_INET, sin_port=htons(53), sin_addr=inet_addr("192.168.53.1")}, 28) = 0 21:31:59.496432 fcntl64(17, F_GETFL) = 0x2 (flags O_RDWR) 21:31:59.496910 fcntl64(17, F_SETFL, O_RDWR|O_NONBLOCK) = 0 21:31:59.498230 gettimeofday({1322602319, 498491}, NULL) = 0 21:31:59.498988 poll([{fd=17, events=POLLOUT, revents=POLLOUT}], 1, 0) = 1 21:31:59.499860 send(17, "\366\324\1\0\0\1\0\0\0\0\0\0\0011\00256\003168\003192\7"..., 43, MSG_NOSIGNAL) = 43 21:31:59.500626 poll([{fd=17, events=POLLIN, revents=POLLIN}], 1, 5000) = 1 21:31:59.501949 ioctl(17, FIONREAD, [43]) = 0 21:31:59.502990 recvfrom(17, "\366\324\205\203\0\1\0\0\0\0\0\0\0011\00256\003168\003"..., 1024, 0, {sa_family=AF_INET, sin_port=htons(53), sin_addr=inet_addr("192.168.53.1")}, [16]) = 43 21:31:59.504414 close(17) = 0 21:31:59.505170 open("/mnt/crcns-data/downloads/site-files/news/crcns-neuroinformatics-article.pdf", O_RDONLY|O_LARGEFILE) = 17 21:31:59.507457 brk(0x83f6000) = 0x83f6000 21:31:59.508898 setsockopt(16, SOL_TCP, TCP_CORK, [1], 4) = 0 21:31:59.509647 writev(16, [{"HTTP/1.1 200 OK\r\nDate: Tue, 29 N"..., 368}], 1) = 368 21:31:59.511051 sendfile(16, 17, [0], 134452) = -1 EPROTO (Protocol error) 21:31:59.596778 setsockopt(16, SOL_TCP, TCP_CORK, [0], 4) = 0 21:31:59.598471 read(16, 0x83ccd40, 8000) = -1 EAGAIN (Resource temporarily unavailable) 21:31:59.598471 write(8, "192.168.56.1 - - [29/Nov/2011:21"..., 266) = 266 21:31:59.598471 close(16) = 0 21:31:59.598471 read(5, 0xbfcfe897, 1) = -1 EAGAIN (Resource temporarily unavailable) 21:31:59.599321 close(17) = 0 21:31:59.600568 semop(458753, 0xb773dd60, 1) = 0 21:31:59.603758 epoll_wait(15, root@crcns:~/debug-share# tail /var/log/messages Nov 29 21:09:42 crcns kernel: [ 1511.414993] VbglR0HGCMInternalCall: vbglR0HGCMInternalPreprocessCall failed. rc=-2 Nov 29 21:09:42 crcns kernel: [ 1511.415870] VBoxGuestCommonIOCtl: HGCM_CALL: 64 Failed. rc=-2. Nov 29 21:10:24 crcns kernel: [ 1553.954113] VbglR0HGCMInternalCall: vbglR0HGCMInternalPreprocessCall failed. rc=-2 Nov 29 21:10:24 crcns kernel: [ 1553.954293] VBoxGuestCommonIOCtl: HGCM_CALL: 64 Failed. rc=-2. Nov 29 21:11:27 crcns kernel: [ 1616.385882] VbglR0HGCMInternalCall: vbglR0HGCMInternalPreprocessCall failed. rc=-2 Nov 29 21:11:27 crcns kernel: [ 1616.386043] VBoxGuestCommonIOCtl: HGCM_CALL: 64 Failed. rc=-2. Nov 29 21:15:00 crcns udhcpc[2662]: Lease of 192.168.56.103 obtained, lease time 3600 Nov 29 21:25:12 crcns -- MARK -- Nov 29 21:31:59 crcns kernel: [ 2847.582035] VbglR0HGCMInternalCall: vbglR0HGCMInternalPreprocessCall failed. rc=-2 Nov 29 21:31:59 crcns kernel: [ 2847.582834] VBoxGuestCommonIOCtl: HGCM_CALL: 64 Failed. rc=-2.