stats.txt revision 3096
1 2---------- Begin Simulation Statistics ---------- 3host_inst_rate 1433278 # Simulator instruction rate (inst/s) 4host_mem_usage 194568 # Number of bytes of host memory used 5host_seconds 44.14 # Real time elapsed on the host 6host_tick_rate 80562367 # Simulator tick rate (ticks/s) 7sim_freq 2000000000 # Frequency of simulated ticks 8sim_insts 63264995 # Number of instructions simulated 9sim_seconds 1.778030 # Number of seconds simulated 10sim_ticks 3556060806 # Number of ticks simulated 11system.cpu0.dtb.accesses 1831687 # DTB accesses 12system.cpu0.dtb.acv 360 # DTB access violations 13system.cpu0.dtb.hits 12876975 # DTB hits 14system.cpu0.dtb.misses 11050 # DTB misses 15system.cpu0.dtb.read_accesses 495437 # DTB read accesses 16system.cpu0.dtb.read_acv 219 # DTB read access violations 17system.cpu0.dtb.read_hits 7121424 # DTB read hits 18system.cpu0.dtb.read_misses 9036 # DTB read misses 19system.cpu0.dtb.write_accesses 1336250 # DTB write accesses 20system.cpu0.dtb.write_acv 141 # DTB write access violations 21system.cpu0.dtb.write_hits 5755551 # DTB write hits 22system.cpu0.dtb.write_misses 2014 # DTB write misses 23system.cpu0.idle_fraction 0.984569 # Percentage of idle cycles 24system.cpu0.itb.accesses 2328068 # ITB accesses 25system.cpu0.itb.acv 216 # ITB acv 26system.cpu0.itb.hits 2323500 # ITB hits 27system.cpu0.itb.misses 4568 # ITB misses 28system.cpu0.kern.callpal 179206 # number of callpals executed 29system.cpu0.kern.callpal_cserve 1 0.00% 0.00% # number of callpals executed 30system.cpu0.kern.callpal_wripir 91 0.05% 0.05% # number of callpals executed 31system.cpu0.kern.callpal_wrmces 1 0.00% 0.05% # number of callpals executed 32system.cpu0.kern.callpal_wrfen 1 0.00% 0.05% # number of callpals executed 33system.cpu0.kern.callpal_wrvptptr 1 0.00% 0.05% # number of callpals executed 34system.cpu0.kern.callpal_swpctx 1375 0.77% 0.82% # number of callpals executed 35system.cpu0.kern.callpal_tbi 20 0.01% 0.83% # number of callpals executed 36system.cpu0.kern.callpal_wrent 7 0.00% 0.84% # number of callpals executed 37system.cpu0.kern.callpal_swpipl 168681 94.13% 94.96% # number of callpals executed 38system.cpu0.kern.callpal_rdps 4713 2.63% 97.59% # number of callpals executed 39system.cpu0.kern.callpal_wrkgp 1 0.00% 97.59% # number of callpals executed 40system.cpu0.kern.callpal_wrusp 4 0.00% 97.59% # number of callpals executed 41system.cpu0.kern.callpal_rdusp 11 0.01% 97.60% # number of callpals executed 42system.cpu0.kern.callpal_whami 2 0.00% 97.60% # number of callpals executed 43system.cpu0.kern.callpal_rti 3639 2.03% 99.63% # number of callpals executed 44system.cpu0.kern.callpal_callsys 461 0.26% 99.89% # number of callpals executed 45system.cpu0.kern.callpal_imb 197 0.11% 100.00% # number of callpals executed 46system.cpu0.kern.inst.arm 0 # number of arm instructions executed 47system.cpu0.kern.inst.hwrei 197512 # number of hwrei instructions executed 48system.cpu0.kern.inst.ivlb 0 # number of ivlb instructions executed 49system.cpu0.kern.inst.ivle 0 # number of ivle instructions executed 50system.cpu0.kern.inst.quiesce 1917 # number of quiesce instructions executed 51system.cpu0.kern.ipl_count 174431 # number of times we switched to this ipl 52system.cpu0.kern.ipl_count_0 73383 42.07% 42.07% # number of times we switched to this ipl 53system.cpu0.kern.ipl_count_21 286 0.16% 42.23% # number of times we switched to this ipl 54system.cpu0.kern.ipl_count_22 5540 3.18% 45.41% # number of times we switched to this ipl 55system.cpu0.kern.ipl_count_30 8 0.00% 45.41% # number of times we switched to this ipl 56system.cpu0.kern.ipl_count_31 95214 54.59% 100.00% # number of times we switched to this ipl 57system.cpu0.kern.ipl_good 156222 # number of times we switched to this ipl from a different ipl 58system.cpu0.kern.ipl_good_0 73336 46.94% 46.94% # number of times we switched to this ipl from a different ipl 59system.cpu0.kern.ipl_good_21 286 0.18% 47.13% # number of times we switched to this ipl from a different ipl 60system.cpu0.kern.ipl_good_22 5540 3.55% 50.67% # number of times we switched to this ipl from a different ipl 61system.cpu0.kern.ipl_good_30 8 0.01% 50.68% # number of times we switched to this ipl from a different ipl 62system.cpu0.kern.ipl_good_31 77052 49.32% 100.00% # number of times we switched to this ipl from a different ipl 63system.cpu0.kern.ipl_ticks 3555570558 # number of cycles we spent at this ipl 64system.cpu0.kern.ipl_ticks_0 3533670973 99.38% 99.38% # number of cycles we spent at this ipl 65system.cpu0.kern.ipl_ticks_21 45785 0.00% 99.39% # number of cycles we spent at this ipl 66system.cpu0.kern.ipl_ticks_22 1008642 0.03% 99.41% # number of cycles we spent at this ipl 67system.cpu0.kern.ipl_ticks_30 1988 0.00% 99.41% # number of cycles we spent at this ipl 68system.cpu0.kern.ipl_ticks_31 20843170 0.59% 100.00% # number of cycles we spent at this ipl 69system.cpu0.kern.ipl_used 0.895609 # fraction of swpipl calls that actually changed the ipl 70system.cpu0.kern.ipl_used_0 0.999360 # fraction of swpipl calls that actually changed the ipl 71system.cpu0.kern.ipl_used_21 1 # fraction of swpipl calls that actually changed the ipl 72system.cpu0.kern.ipl_used_22 1 # fraction of swpipl calls that actually changed the ipl 73system.cpu0.kern.ipl_used_30 1 # fraction of swpipl calls that actually changed the ipl 74system.cpu0.kern.ipl_used_31 0.809251 # fraction of swpipl calls that actually changed the ipl 75system.cpu0.kern.mode_good_kernel 1633 76system.cpu0.kern.mode_good_user 1486 77system.cpu0.kern.mode_good_idle 147 78system.cpu0.kern.mode_switch_kernel 2898 # number of protection mode switches 79system.cpu0.kern.mode_switch_user 1486 # number of protection mode switches 80system.cpu0.kern.mode_switch_idle 2090 # number of protection mode switches 81system.cpu0.kern.mode_switch_good 0.504479 # fraction of useful protection mode switches 82system.cpu0.kern.mode_switch_good_kernel 0.563492 # fraction of useful protection mode switches 83system.cpu0.kern.mode_switch_good_user 1 # fraction of useful protection mode switches 84system.cpu0.kern.mode_switch_good_idle 0.070335 # fraction of useful protection mode switches 85system.cpu0.kern.mode_ticks_kernel 29671488 0.83% 0.83% # number of ticks spent at the given mode 86system.cpu0.kern.mode_ticks_user 2605758 0.07% 0.91% # number of ticks spent at the given mode 87system.cpu0.kern.mode_ticks_idle 3523245106 99.09% 100.00% # number of ticks spent at the given mode 88system.cpu0.kern.swap_context 1376 # number of times the context was actually changed 89system.cpu0.kern.syscall 312 # number of syscalls executed 90system.cpu0.kern.syscall_fork 9 2.88% 2.88% # number of syscalls executed 91system.cpu0.kern.syscall_read 20 6.41% 9.29% # number of syscalls executed 92system.cpu0.kern.syscall_write 6 1.92% 11.22% # number of syscalls executed 93system.cpu0.kern.syscall_close 36 11.54% 22.76% # number of syscalls executed 94system.cpu0.kern.syscall_chdir 1 0.32% 23.08% # number of syscalls executed 95system.cpu0.kern.syscall_chmod 1 0.32% 23.40% # number of syscalls executed 96system.cpu0.kern.syscall_obreak 26 8.33% 31.73% # number of syscalls executed 97system.cpu0.kern.syscall_lseek 9 2.88% 34.62% # number of syscalls executed 98system.cpu0.kern.syscall_getpid 8 2.56% 37.18% # number of syscalls executed 99system.cpu0.kern.syscall_setuid 2 0.64% 37.82% # number of syscalls executed 100system.cpu0.kern.syscall_getuid 4 1.28% 39.10% # number of syscalls executed 101system.cpu0.kern.syscall_access 4 1.28% 40.38% # number of syscalls executed 102system.cpu0.kern.syscall_dup 4 1.28% 41.67% # number of syscalls executed 103system.cpu0.kern.syscall_open 40 12.82% 54.49% # number of syscalls executed 104system.cpu0.kern.syscall_getgid 4 1.28% 55.77% # number of syscalls executed 105system.cpu0.kern.syscall_sigprocmask 12 3.85% 59.62% # number of syscalls executed 106system.cpu0.kern.syscall_ioctl 13 4.17% 63.78% # number of syscalls executed 107system.cpu0.kern.syscall_readlink 1 0.32% 64.10% # number of syscalls executed 108system.cpu0.kern.syscall_execve 7 2.24% 66.35% # number of syscalls executed 109system.cpu0.kern.syscall_pre_F64_stat 22 7.05% 73.40% # number of syscalls executed 110system.cpu0.kern.syscall_pre_F64_lstat 1 0.32% 73.72% # number of syscalls executed 111system.cpu0.kern.syscall_mmap 28 8.97% 82.69% # number of syscalls executed 112system.cpu0.kern.syscall_munmap 4 1.28% 83.97% # number of syscalls executed 113system.cpu0.kern.syscall_mprotect 7 2.24% 86.22% # number of syscalls executed 114system.cpu0.kern.syscall_gethostname 1 0.32% 86.54% # number of syscalls executed 115system.cpu0.kern.syscall_dup2 3 0.96% 87.50% # number of syscalls executed 116system.cpu0.kern.syscall_pre_F64_fstat 15 4.81% 92.31% # number of syscalls executed 117system.cpu0.kern.syscall_fcntl 11 3.53% 95.83% # number of syscalls executed 118system.cpu0.kern.syscall_socket 3 0.96% 96.79% # number of syscalls executed 119system.cpu0.kern.syscall_connect 3 0.96% 97.76% # number of syscalls executed 120system.cpu0.kern.syscall_setgid 2 0.64% 98.40% # number of syscalls executed 121system.cpu0.kern.syscall_getrlimit 2 0.64% 99.04% # number of syscalls executed 122system.cpu0.kern.syscall_setsid 3 0.96% 100.00% # number of syscalls executed 123system.cpu0.not_idle_fraction 0.015431 # Percentage of non-idle cycles 124system.cpu0.numCycles 54873632 # number of cpu cycles simulated 125system.cpu0.num_insts 54868848 # Number of instructions executed 126system.cpu0.num_refs 12918621 # Number of memory references 127system.cpu1.dtb.accesses 524398 # DTB accesses 128system.cpu1.dtb.acv 60 # DTB access violations 129system.cpu1.dtb.hits 2058922 # DTB hits 130system.cpu1.dtb.misses 5263 # DTB misses 131system.cpu1.dtb.read_accesses 337746 # DTB read accesses 132system.cpu1.dtb.read_acv 23 # DTB read access violations 133system.cpu1.dtb.read_hits 1301369 # DTB read hits 134system.cpu1.dtb.read_misses 4766 # DTB read misses 135system.cpu1.dtb.write_accesses 186652 # DTB write accesses 136system.cpu1.dtb.write_acv 37 # DTB write access violations 137system.cpu1.dtb.write_hits 757553 # DTB write hits 138system.cpu1.dtb.write_misses 497 # DTB write misses 139system.cpu1.idle_fraction 0.997638 # Percentage of idle cycles 140system.cpu1.itb.accesses 1711917 # ITB accesses 141system.cpu1.itb.acv 23 # ITB acv 142system.cpu1.itb.hits 1709682 # ITB hits 143system.cpu1.itb.misses 2235 # ITB misses 144system.cpu1.kern.callpal 25990 # number of callpals executed 145system.cpu1.kern.callpal_cserve 1 0.00% 0.00% # number of callpals executed 146system.cpu1.kern.callpal_wripir 8 0.03% 0.03% # number of callpals executed 147system.cpu1.kern.callpal_wrmces 1 0.00% 0.04% # number of callpals executed 148system.cpu1.kern.callpal_wrfen 1 0.00% 0.04% # number of callpals executed 149system.cpu1.kern.callpal_swpctx 554 2.13% 2.17% # number of callpals executed 150system.cpu1.kern.callpal_tbi 7 0.03% 2.20% # number of callpals executed 151system.cpu1.kern.callpal_wrent 7 0.03% 2.23% # number of callpals executed 152system.cpu1.kern.callpal_swpipl 22366 86.06% 88.28% # number of callpals executed 153system.cpu1.kern.callpal_rdps 98 0.38% 88.66% # number of callpals executed 154system.cpu1.kern.callpal_wrkgp 1 0.00% 88.66% # number of callpals executed 155system.cpu1.kern.callpal_wrusp 4 0.02% 88.68% # number of callpals executed 156system.cpu1.kern.callpal_rdusp 1 0.00% 88.68% # number of callpals executed 157system.cpu1.kern.callpal_whami 3 0.01% 88.70% # number of callpals executed 158system.cpu1.kern.callpal_rti 2613 10.05% 98.75% # number of callpals executed 159system.cpu1.kern.callpal_callsys 208 0.80% 99.55% # number of callpals executed 160system.cpu1.kern.callpal_imb 116 0.45% 100.00% # number of callpals executed 161system.cpu1.kern.callpal_rdunique 1 0.00% 100.00% # number of callpals executed 162system.cpu1.kern.inst.arm 0 # number of arm instructions executed 163system.cpu1.kern.inst.hwrei 35475 # number of hwrei instructions executed 164system.cpu1.kern.inst.ivlb 0 # number of ivlb instructions executed 165system.cpu1.kern.inst.ivle 0 # number of ivle instructions executed 166system.cpu1.kern.inst.quiesce 1946 # number of quiesce instructions executed 167system.cpu1.kern.ipl_count 26882 # number of times we switched to this ipl 168system.cpu1.kern.ipl_count_0 9636 35.85% 35.85% # number of times we switched to this ipl 169system.cpu1.kern.ipl_count_22 5504 20.47% 56.32% # number of times we switched to this ipl 170system.cpu1.kern.ipl_count_30 91 0.34% 56.66% # number of times we switched to this ipl 171system.cpu1.kern.ipl_count_31 11651 43.34% 100.00% # number of times we switched to this ipl 172system.cpu1.kern.ipl_good 26602 # number of times we switched to this ipl from a different ipl 173system.cpu1.kern.ipl_good_0 9607 36.11% 36.11% # number of times we switched to this ipl from a different ipl 174system.cpu1.kern.ipl_good_22 5504 20.69% 56.80% # number of times we switched to this ipl from a different ipl 175system.cpu1.kern.ipl_good_30 91 0.34% 57.15% # number of times we switched to this ipl from a different ipl 176system.cpu1.kern.ipl_good_31 11400 42.85% 100.00% # number of times we switched to this ipl from a different ipl 177system.cpu1.kern.ipl_ticks 3556060349 # number of cycles we spent at this ipl 178system.cpu1.kern.ipl_ticks_0 3533823708 99.37% 99.37% # number of cycles we spent at this ipl 179system.cpu1.kern.ipl_ticks_22 1040434 0.03% 99.40% # number of cycles we spent at this ipl 180system.cpu1.kern.ipl_ticks_30 23860 0.00% 99.40% # number of cycles we spent at this ipl 181system.cpu1.kern.ipl_ticks_31 21172347 0.60% 100.00% # number of cycles we spent at this ipl 182system.cpu1.kern.ipl_used 0.989584 # fraction of swpipl calls that actually changed the ipl 183system.cpu1.kern.ipl_used_0 0.996990 # fraction of swpipl calls that actually changed the ipl 184system.cpu1.kern.ipl_used_22 1 # fraction of swpipl calls that actually changed the ipl 185system.cpu1.kern.ipl_used_30 1 # fraction of swpipl calls that actually changed the ipl 186system.cpu1.kern.ipl_used_31 0.978457 # fraction of swpipl calls that actually changed the ipl 187system.cpu1.kern.mode_good_kernel 691 188system.cpu1.kern.mode_good_user 692 189system.cpu1.kern.mode_good_idle 0 190system.cpu1.kern.mode_switch_kernel 3163 # number of protection mode switches 191system.cpu1.kern.mode_switch_user 692 # number of protection mode switches 192system.cpu1.kern.mode_switch_idle 0 # number of protection mode switches 193system.cpu1.kern.mode_switch_good 0.358755 # fraction of useful protection mode switches 194system.cpu1.kern.mode_switch_good_kernel 0.218463 # fraction of useful protection mode switches 195system.cpu1.kern.mode_switch_good_user 1 # fraction of useful protection mode switches 196system.cpu1.kern.mode_switch_good_idle <err: div-0> # fraction of useful protection mode switches 197system.cpu1.kern.mode_ticks_kernel 3554209770 99.95% 99.95% # number of ticks spent at the given mode 198system.cpu1.kern.mode_ticks_user 1850577 0.05% 100.00% # number of ticks spent at the given mode 199system.cpu1.kern.mode_ticks_idle 0 0.00% 100.00% # number of ticks spent at the given mode 200system.cpu1.kern.swap_context 555 # number of times the context was actually changed 201system.cpu1.kern.syscall 163 # number of syscalls executed 202system.cpu1.kern.syscall_fork 1 0.61% 0.61% # number of syscalls executed 203system.cpu1.kern.syscall_read 13 7.98% 8.59% # number of syscalls executed 204system.cpu1.kern.syscall_write 1 0.61% 9.20% # number of syscalls executed 205system.cpu1.kern.syscall_close 13 7.98% 17.18% # number of syscalls executed 206system.cpu1.kern.syscall_obreak 18 11.04% 28.22% # number of syscalls executed 207system.cpu1.kern.syscall_lseek 4 2.45% 30.67% # number of syscalls executed 208system.cpu1.kern.syscall_getpid 2 1.23% 31.90% # number of syscalls executed 209system.cpu1.kern.syscall_setuid 2 1.23% 33.13% # number of syscalls executed 210system.cpu1.kern.syscall_getuid 4 2.45% 35.58% # number of syscalls executed 211system.cpu1.kern.syscall_open 28 17.18% 52.76% # number of syscalls executed 212system.cpu1.kern.syscall_getgid 4 2.45% 55.21% # number of syscalls executed 213system.cpu1.kern.syscall_sigprocmask 2 1.23% 56.44% # number of syscalls executed 214system.cpu1.kern.syscall_ioctl 3 1.84% 58.28% # number of syscalls executed 215system.cpu1.kern.syscall_readlink 1 0.61% 58.90% # number of syscalls executed 216system.cpu1.kern.syscall_execve 1 0.61% 59.51% # number of syscalls executed 217system.cpu1.kern.syscall_pre_F64_stat 9 5.52% 65.03% # number of syscalls executed 218system.cpu1.kern.syscall_mmap 27 16.56% 81.60% # number of syscalls executed 219system.cpu1.kern.syscall_munmap 2 1.23% 82.82% # number of syscalls executed 220system.cpu1.kern.syscall_mprotect 7 4.29% 87.12% # number of syscalls executed 221system.cpu1.kern.syscall_gethostname 1 0.61% 87.73% # number of syscalls executed 222system.cpu1.kern.syscall_dup2 1 0.61% 88.34% # number of syscalls executed 223system.cpu1.kern.syscall_pre_F64_fstat 13 7.98% 96.32% # number of syscalls executed 224system.cpu1.kern.syscall_fcntl 3 1.84% 98.16% # number of syscalls executed 225system.cpu1.kern.syscall_setgid 2 1.23% 99.39% # number of syscalls executed 226system.cpu1.kern.syscall_getrlimit 1 0.61% 100.00% # number of syscalls executed 227system.cpu1.not_idle_fraction 0.002362 # Percentage of non-idle cycles 228system.cpu1.numCycles 8398405 # number of cpu cycles simulated 229system.cpu1.num_insts 8396147 # Number of instructions executed 230system.cpu1.num_refs 2073144 # Number of memory references 231system.disk0.dma_read_bytes 1024 # Number of bytes transfered via DMA reads (not PRD). 232system.disk0.dma_read_full_pages 0 # Number of full page size DMA reads (not PRD). 233system.disk0.dma_read_txs 1 # Number of DMA read transactions (not PRD). 234system.disk0.dma_write_bytes 2521088 # Number of bytes transfered via DMA writes. 235system.disk0.dma_write_full_pages 285 # Number of full page size DMA writes. 236system.disk0.dma_write_txs 375 # Number of DMA write transactions. 237system.disk2.dma_read_bytes 0 # Number of bytes transfered via DMA reads (not PRD). 238system.disk2.dma_read_full_pages 0 # Number of full page size DMA reads (not PRD). 239system.disk2.dma_read_txs 0 # Number of DMA read transactions (not PRD). 240system.disk2.dma_write_bytes 8192 # Number of bytes transfered via DMA writes. 241system.disk2.dma_write_full_pages 1 # Number of full page size DMA writes. 242system.disk2.dma_write_txs 1 # Number of DMA write transactions. 243system.tsunami.ethernet.coalescedRxDesc <err: div-0> # average number of RxDesc's coalesced into each post 244system.tsunami.ethernet.coalescedRxIdle <err: div-0> # average number of RxIdle's coalesced into each post 245system.tsunami.ethernet.coalescedRxOk <err: div-0> # average number of RxOk's coalesced into each post 246system.tsunami.ethernet.coalescedRxOrn <err: div-0> # average number of RxOrn's coalesced into each post 247system.tsunami.ethernet.coalescedSwi <err: div-0> # average number of Swi's coalesced into each post 248system.tsunami.ethernet.coalescedTotal <err: div-0> # average number of interrupts coalesced into each post 249system.tsunami.ethernet.coalescedTxDesc <err: div-0> # average number of TxDesc's coalesced into each post 250system.tsunami.ethernet.coalescedTxIdle <err: div-0> # average number of TxIdle's coalesced into each post 251system.tsunami.ethernet.coalescedTxOk <err: div-0> # average number of TxOk's coalesced into each post 252system.tsunami.ethernet.descDMAReads 0 # Number of descriptors the device read w/ DMA 253system.tsunami.ethernet.descDMAWrites 0 # Number of descriptors the device wrote w/ DMA 254system.tsunami.ethernet.descDmaReadBytes 0 # number of descriptor bytes read w/ DMA 255system.tsunami.ethernet.descDmaWriteBytes 0 # number of descriptor bytes write w/ DMA 256system.tsunami.ethernet.droppedPackets 0 # number of packets dropped 257system.tsunami.ethernet.postedInterrupts 0 # number of posts to CPU 258system.tsunami.ethernet.postedRxDesc 0 # number of RxDesc interrupts posted to CPU 259system.tsunami.ethernet.postedRxIdle 0 # number of rxIdle interrupts posted to CPU 260system.tsunami.ethernet.postedRxOk 0 # number of RxOk interrupts posted to CPU 261system.tsunami.ethernet.postedRxOrn 0 # number of RxOrn posted to CPU 262system.tsunami.ethernet.postedSwi 0 # number of software interrupts posted to CPU 263system.tsunami.ethernet.postedTxDesc 0 # number of TxDesc interrupts posted to CPU 264system.tsunami.ethernet.postedTxIdle 0 # number of TxIdle interrupts posted to CPU 265system.tsunami.ethernet.postedTxOk 0 # number of TxOk interrupts posted to CPU 266system.tsunami.ethernet.totalRxDesc 0 # total number of RxDesc written to ISR 267system.tsunami.ethernet.totalRxIdle 0 # total number of RxIdle written to ISR 268system.tsunami.ethernet.totalRxOk 0 # total number of RxOk written to ISR 269system.tsunami.ethernet.totalRxOrn 0 # total number of RxOrn written to ISR 270system.tsunami.ethernet.totalSwi 0 # total number of Swi written to ISR 271system.tsunami.ethernet.totalTxDesc 0 # total number of TxDesc written to ISR 272system.tsunami.ethernet.totalTxIdle 0 # total number of TxIdle written to ISR 273system.tsunami.ethernet.totalTxOk 0 # total number of TxOk written to ISR 274 275---------- End Simulation Statistics ---------- 276