search

GwenNelson / distcc

Automatically exported from code.google.com/p/distcc
GNU General Public License v2.0
0 stars 0 forks source link

distccmon-text makes some misses #90

Open GoogleCodeExporter opened 9 years ago

GoogleCodeExporter commented 9 years ago 
distcc 3.2rc1 i686-pc-linux-gnu
Linux 3.1.2
gcc (GCC) 4.6.2

I was trying to monitor remote actions of distcc via *distccmon-text*.  I 
launched remote compilation 3-4x in a row:

$ distcc cc -c tg_007.c -o tg_007.o
$ distcc cc -c tg_007.c -o tg_007.o
$ distcc cc -c tg_007.c -o tg_007.o
$ distcc cc -c tg_007.c -o tg_007.o

Unfortunately, *distccmon-text* showed only partial results:

$ distccmon-text 1

  2974  Compile     tg_007.c                             letta[0]

If I set delay to 0.05 (seconds), I get a lot more info:

$ distccmon-text 0.05

  3052  Preprocess                                       localhost[0]
  3052  Preprocess                                       localhost[0]
  3052  Compile     tg_007.c                             letta[0]
  3052  Compile     tg_007.c                             letta[0]

  3055  Preprocess                                       localhost[0]
  3055  Preprocess                                       localhost[0]
  3055  Compile     tg_007.c                             letta[0]
  3055  Compile     tg_007.c                             letta[0]

  3058  Connect     tg_007.c                             letta[0]
  3058  Preprocess                                       localhost[0]
  3058  Preprocess                                       localhost[0]
  3058  Compile     tg_007.c                             letta[0]

  3061  Preprocess                                       localhost[0]
  3061  Preprocess                                       localhost[0]
  3061  Compile     tg_007.c                             letta[0]
  3061  Compile     tg_007.c                             letta[0]

But I guess there is some stuff missing, eg. "Connect" lines.
Then, some lines seems to be duplicated.

The full log of last client run:

$ DISTCC_VERBOSE=1 distcc cc -c tg_007.c -o tg_007.o 
distcc[3061] (dcc_trace_version) distcc 3.2rc1 i686-pc-linux-gnu; built Nov  7 
2011 11:08:50
distcc[3061] (dcc_recursion_safeguard) safeguard level=0
distcc[3061] (main) compiler name is "distcc"
distcc[3061] (dcc_scan_args) scanning arguments: cc -c tg_007.c -o tg_007.o
distcc[3061] (dcc_scan_args) found input file "tg_007.c"
distcc[3061] (dcc_scan_args) found object/output file "tg_007.o"
distcc[3061] compile from tg_007.c to tg_007.o
distcc[3061] (dcc_parse_hosts_file) load hosts from /home/s2/.distcc/hosts
distcc[3061] (dcc_parse_hosts) found tcp token "letta:3632"
distcc[3061] (dcc_lock_host) got cpu lock on letta:3632 slot 0 as fd3
distcc[3061] (dcc_lock_host) got cpu lock on localhost slot 0 as fd4
distcc[3061] (dcc_note_state) note state 3, file "(NULL)", host "localhost"
distcc[3061] (dcc_strip_dasho) result: cc -c tg_007.c
distcc[3061] (dcc_spawn_child) forking to execute: cc -E tg_007.c
distcc[3061] (dcc_spawn_child) child started as pid3062
distcc[3061] (dcc_strip_local_args) result: cc -c tg_007.c -o tg_007.o
distcc[3061] exec on letta:3632: cc -c tg_007.c -o tg_007.o
distcc[3061] (dcc_note_state) note state 2, file "tg_007.c", host "letta"
distcc[3061] (dcc_connect_by_addr) started connecting to 193.219.43.130:3632
distcc[3061] (dcc_select_for_write) select for write on fd5
distcc[3062] (dcc_new_pgrp) entered process group
distcc[3062] (dcc_increment_safeguard) setting safeguard: _DISTCC_SAFEGUARD=1
distcc[3061] (dcc_note_state) note state 4, file "(NULL)", host "(NULL)"
distcc[3061] (dcc_x_token_int) send DIST00000001
distcc[3061] (dcc_x_token_int) send ARGC00000005
distcc[3061] (dcc_x_token_int) send ARGV00000002
distcc[3061] (dcc_x_token_string) send string 'cc'
distcc[3061] (dcc_x_token_int) send ARGV00000002
distcc[3061] (dcc_x_token_string) send string '-c'
distcc[3061] (dcc_x_token_int) send ARGV00000008
distcc[3061] (dcc_x_token_string) send string 'tg_007.c'
distcc[3061] (dcc_x_token_int) send ARGV00000002
distcc[3061] (dcc_x_token_string) send string '-o'
distcc[3061] (dcc_x_token_int) send ARGV00000008
distcc[3061] (dcc_x_token_string) send string 'tg_007.o'
distcc[3061] (dcc_note_state) note state 3, file "(NULL)", host "(NULL)"
distcc[3061] (dcc_collect_child) cpp child 3062 terminated with status 0
distcc[3061] (dcc_collect_child) cpp times: user 0.000000s, system 0.000000s, 0 
minflt, 0 majflt
distcc[3061] cpp tg_007.c on localhost completed ok
distcc[3061] (dcc_unlock) release lock fd4
distcc[3061] (dcc_x_file) send 73344 byte file /tmp/distcc_c67e4436.i with 
token DOTI and compression 69
distcc[3061] (dcc_x_token_int) send DOTI00011e80
distcc[3061] (dcc_pump_sendfile) sendfile: partial transmission of 14362 bytes; 
retrying 58982 @14362
distcc[3061] (dcc_select_for_write) select for write on fd5
distcc[3061] (dcc_pump_sendfile) select() returned, continuing to write
distcc[3061] (dcc_pump_sendfile) sendfile: partial transmission of 33304 bytes; 
retrying 25678 @47666
distcc[3061] (dcc_select_for_write) select for write on fd5
distcc[3061] (dcc_pump_sendfile) select() returned, continuing to write
distcc[3061] (dcc_compile_remote) client finished sending request to server
distcc[3061] (dcc_note_state) note state 5, file "(NULL)", host "letta"
distcc[3061] (dcc_select_for_read) select for read on fd5 for 300s
distcc[3061] (dcc_r_token_int) got DONE00000001
distcc[3061] (dcc_note_state) note state 6, file "(NULL)", host "(NULL)"
distcc[3061] (dcc_r_token_int) got STAT00000000
distcc[3061] (dcc_r_token_int) got SERR00000000
distcc[3061] (dcc_r_file) received 0 bytes to file 
/tmp/distcc_server_stderr_c5764436.txt
distcc[3061] (dcc_r_token_int) got SOUT00000000
distcc[3061] (dcc_r_token_int) got DOTO00001b18
distcc[3061] (dcc_select_for_read) select for read on fd5 for 300s
distcc[3061] (dcc_select_for_read) select for read on fd5 for 300s
distcc[3061] (dcc_r_file) received 6936 bytes to file tg_007.o
distcc[3061] (dcc_r_file_timed) 6936 bytes received in 0.002551s, rate 2655kB/s
distcc[3061] 73344 bytes from tg_007.c compiled on letta in 0.2058s, rate 
348kB/s
distcc[3061] (dcc_unlock) release lock fd3
distcc[3061] compile tg_007.c on letta:3632 completed ok
distcc[3061] elapsed compilation time 0.211053s
distcc[3061] (dcc_exit) exit: code 0; self: 0.000000 user 0.013332 sys; 
children: 0.039997 user 0.016665 sys
distcc[3061] (dcc_cleanup_tempfiles_inner) deleted 2 temporary files

Seems like an unrealiable IPC mechanism for me.

Original issue reported on code.google.com by sauli...@gmail.com on 26 Nov 2011 at 8:09

GoogleCodeExporter commented 9 years ago 
Or is that Issue 24 by a chance?

Original comment by sauli...@gmail.com on 26 Nov 2011 at 8:26