Real time: Jun/24/2013 23:54:11 Profiler Stats -------------- Elapsed_time_in_seconds: 0 Elapsed_time_in_minutes: 0 Elapsed_time_in_hours: 0 Elapsed_time_in_days: 0 Virtual_time_in_seconds: 0.51 Virtual_time_in_minutes: 0.0085 Virtual_time_in_hours: 0.000141667 Virtual_time_in_days: 5.90278e-06 Ruby_current_time: 221941 Ruby_start_time: 0 Ruby_cycles: 221941 mbytes_resident: 51.1953 mbytes_total: 146.023 resident_ratio: 0.35065 Busy Controller Counts: L1Cache-0:0 Directory-0:0 Busy Bank Count:0 sequencer_requests_outstanding: [binsize: 1 max: 16 count: 969 average: 15.7379 | standard deviation: 1.20089 | 0 1 1 1 1 1 1 2 1 1 1 1 1 1 9 110 836 ] All Non-Zero Cycle Demand Cache Accesses ---------------------------------------- latency: [binsize: 512 max: 5298 count: 954 average: 3683.39 | standard deviation: 578.018 | 2 4 3 2 7 90 286 327 210 22 1 ] latency: LD: [binsize: 256 max: 4587 count: 42 average: 3722.1 | standard deviation: 463.961 | 0 0 0 0 0 0 0 0 0 0 0 5 6 5 9 9 4 4 ] latency: ST: [binsize: 512 max: 5298 count: 854 average: 3677.29 | standard deviation: 585.222 | 2 4 3 2 7 78 258 291 188 20 1 ] latency: IFETCH: [binsize: 256 max: 5106 count: 58 average: 3745.14 | standard deviation: 548.056 | 0 0 0 0 0 0 0 0 0 0 1 6 7 10 7 11 8 6 1 1 ] hit latency: [binsize: 256 max: 4375 count: 38 average: 3245.53 | standard deviation: 508.825 | 0 0 0 0 0 0 0 1 0 2 3 10 5 9 3 2 2 1 ] hit latency: ST: [binsize: 256 max: 4375 count: 36 average: 3241 | standard deviation: 520.843 | 0 0 0 0 0 0 0 1 0 2 3 10 4 8 3 2 2 1 ] hit latency: IFETCH: [binsize: 256 max: 3515 count: 2 average: 3327 | standard deviation: 265.872 | 0 0 0 0 0 0 0 0 0 0 0 0 1 1 ] miss latency: [binsize: 512 max: 5298 count: 916 average: 3701.55 | standard deviation: 573.776 | 2 4 3 1 5 77 272 322 207 22 1 ] miss latency: LD: [binsize: 256 max: 4587 count: 42 average: 3722.1 | standard deviation: 463.961 | 0 0 0 0 0 0 0 0 0 0 0 5 6 5 9 9 4 4 ] miss latency: ST: [binsize: 512 max: 5298 count: 818 average: 3696.49 | standard deviation: 580.688 | 2 4 3 1 5 65 246 286 185 20 1 ] miss latency: IFETCH: [binsize: 256 max: 5106 count: 56 average: 3760.07 | standard deviation: 550.834 | 0 0 0 0 0 0 0 0 0 0 1 6 6 9 7 11 8 6 1 1 ] miss latency: Directory: [binsize: 512 max: 5298 count: 916 average: 3701.55 | standard deviation: 573.776 | 2 4 3 1 5 77 272 322 207 22 1 ] miss latency: Directory::issue_to_initial_request: [binsize: 1 max: 0 count: 0 average: NaN |standard deviation: NaN | 0 ] miss latency: Directory::initial_to_forward_request: [binsize: 1 max: 0 count: 0 average: NaN |standard deviation: NaN | 0 ] miss latency: Directory::forward_to_first_response: [binsize: 1 max: 0 count: 0 average: NaN |standard deviation: NaN | 0 ] miss latency: Directory::first_response_to_completion: [binsize: 1 max: 0 count: 0 average: NaN |standard deviation: NaN | 0 ] incomplete times: 916 miss latency: LD: Directory: [binsize: 256 max: 4587 count: 42 average: 3722.1 | standard deviation: 463.961 | 0 0 0 0 0 0 0 0 0 0 0 5 6 5 9 9 4 4 ] miss latency: ST: Directory: [binsize: 512 max: 5298 count: 818 average: 3696.49 | standard deviation: 580.688 | 2 4 3 1 5 65 246 286 185 20 1 ] miss latency: IFETCH: Directory: [binsize: 256 max: 5106 count: 56 average: 3760.07 | standard deviation: 550.834 | 0 0 0 0 0 0 0 0 0 0 1 6 6 9 7 11 8 6 1 1 ] Request vs. RubySystem State Profile -------------------------------- Message Delayed Cycles ---------------------- Total_delay_cycles: [binsize: 1 max: 12 count: 1828 average: 0.280088 | standard deviation: 1.03285 | 1658 32 43 46 23 10 9 2 2 2 0 0 1 ] virtual_network_0_delay_cycles: [binsize: 1 max: 0 count: 0 average: NaN |standard deviation: NaN | 0 ] virtual_network_1_delay_cycles: [binsize: 1 max: 7 count: 916 average: 0.265284 | standard deviation: 0.915561 | 824 19 30 28 3 6 4 2 ] virtual_network_2_delay_cycles: [binsize: 1 max: 12 count: 912 average: 0.294956 | standard deviation: 1.13907 | 834 13 13 18 20 4 5 0 2 2 0 0 1 ] virtual_network_3_delay_cycles: [binsize: 1 max: 0 count: 0 average: NaN |standard deviation: NaN | 0 ] virtual_network_4_delay_cycles: [binsize: 1 max: 0 count: 0 average: NaN |standard deviation: NaN | 0 ] virtual_network_5_delay_cycles: [binsize: 1 max: 0 count: 0 average: NaN |standard deviation: NaN | 0 ] virtual_network_6_delay_cycles: [binsize: 1 max: 0 count: 0 average: NaN |standard deviation: NaN | 0 ] virtual_network_7_delay_cycles: [binsize: 1 max: 0 count: 0 average: NaN |standard deviation: NaN | 0 ] virtual_network_8_delay_cycles: [binsize: 1 max: 0 count: 0 average: NaN |standard deviation: NaN | 0 ] virtual_network_9_delay_cycles: [binsize: 1 max: 0 count: 0 average: NaN |standard deviation: NaN | 0 ] Resource Usage -------------- page_size: 4096 user_time: 0 system_time: 0 page_reclaims: 9501 page_faults: 0 swaps: 0 block_inputs: 0 block_outputs: 88 Network Stats ------------- total_msg_count_Control: 2748 21984 total_msg_count_Data: 2742 197424 total_msg_count_Response_Data: 2748 197856 total_msg_count_Writeback_Control: 2739 21912 total_msgs: 10977 total_bytes: 439176 switch_0_inlinks: 2 switch_0_outlinks: 2 links_utilized_percent_switch_0: 2.06125 links_utilized_percent_switch_0_link_0: 2.06294 bw: 16000 base_latency: 1 links_utilized_percent_switch_0_link_1: 2.05956 bw: 16000 base_latency: 1 outgoing_messages_switch_0_link_0_Response_Data: 916 65952 [ 0 0 0 0 916 0 0 0 0 0 ] base_latency: 1 outgoing_messages_switch_0_link_0_Writeback_Control: 913 7304 [ 0 0 0 913 0 0 0 0 0 0 ] base_latency: 1 outgoing_messages_switch_0_link_1_Control: 916 7328 [ 0 0 916 0 0 0 0 0 0 0 ] base_latency: 1 outgoing_messages_switch_0_link_1_Data: 914 65808 [ 0 0 914 0 0 0 0 0 0 0 ] base_latency: 1 switch_1_inlinks: 2 switch_1_outlinks: 2 links_utilized_percent_switch_1: 2.06125 links_utilized_percent_switch_1_link_0: 2.05956 bw: 16000 base_latency: 1 links_utilized_percent_switch_1_link_1: 2.06294 bw: 16000 base_latency: 1 outgoing_messages_switch_1_link_0_Control: 916 7328 [ 0 0 916 0 0 0 0 0 0 0 ] base_latency: 1 outgoing_messages_switch_1_link_0_Data: 914 65808 [ 0 0 914 0 0 0 0 0 0 0 ] base_latency: 1 outgoing_messages_switch_1_link_1_Response_Data: 916 65952 [ 0 0 0 0 916 0 0 0 0 0 ] base_latency: 1 outgoing_messages_switch_1_link_1_Writeback_Control: 913 7304 [ 0 0 0 913 0 0 0 0 0 0 ] base_latency: 1 switch_2_inlinks: 2 switch_2_outlinks: 2 links_utilized_percent_switch_2: 2.06125 links_utilized_percent_switch_2_link_0: 2.06294 bw: 16000 base_latency: 1 links_utilized_percent_switch_2_link_1: 2.05956 bw: 16000 base_latency: 1 outgoing_messages_switch_2_link_0_Response_Data: 916 65952 [ 0 0 0 0 916 0 0 0 0 0 ] base_latency: 1 outgoing_messages_switch_2_link_0_Writeback_Control: 913 7304 [ 0 0 0 913 0 0 0 0 0 0 ] base_latency: 1 outgoing_messages_switch_2_link_1_Control: 916 7328 [ 0 0 916 0 0 0 0 0 0 0 ] base_latency: 1 outgoing_messages_switch_2_link_1_Data: 914 65808 [ 0 0 914 0 0 0 0 0 0 0 ] base_latency: 1