wget: progress doesn't work with BusyBox v1.22.1 on flash memory
Wladislav Wiebe
wladislav.kw at gmail.com
Thu Mar 27 15:35:02 UTC 2014
Hi Denys,
On 27/03/14 14:20, Denys Vlasenko wrote:
> On Thu, Mar 27, 2014 at 12:58 PM, Wladislav Wiebe
> <wladislav.kw at gmail.com> wrote:
>> Hi,
>>
>> I noticed that wget doesn't show progress bar status when downloading
>> something.
>>
>> Basically when download is already finished it's posting at the and:
>> 100% |*************************************************| 22028k 0:00:00 ETA
>>
>> This is really strange - I noticed it's 100% reproduce-able on flash memory
>> chips:
>> e.g. mounting ubifs: ubi0:flash on /some/flashdev type ubifs
>> (rw,sync,relatime)
>>
>> The same is working fine on the same board when using as download-target a
>> ram / mtd device.
>> There is the progress bar really showing the sequence of download status
>> (like: 1%,5%,10% ....)
>
> strace -oLOG -tt -s99 wget ....
>
>
> and then post LOG file.
>
attached.
Thanks!
Wladislav Wiebe
-------------- next part --------------
00:23:38.020114 execve("/usr/bin/wget", ["wget", "http://192.168.2.100:8080/build/lastSuccess"...], [/* 15 vars */]) = 0
00:23:38.029010 brk(0) = 0x10376000
00:23:38.037650 access("/etc/ld.so.preload", R_OK) = -1 ENOENT (No such file or directory)
00:23:38.048878 open("/etc/ld.so.cache", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
00:23:38.062337 open("/lib/tls/ppc8548/libm.so.6", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
00:23:38.078987 stat64("/lib/tls/ppc8548", 0xbfe90428) = -1 ENOENT (No such file or directory)
00:23:38.096144 open("/lib/tls/libm.so.6", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
00:23:38.115802 stat64("/lib/tls", 0xbfe90428) = -1 ENOENT (No such file or directory)
00:23:38.139037 open("/lib/ppc8548/libm.so.6", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
00:23:38.162284 stat64("/lib/ppc8548", 0xbfe90428) = -1 ENOENT (No such file or directory)
00:23:38.189415 open("/lib/libm.so.6", O_RDONLY|O_CLOEXEC) = 3
00:23:38.216412 read(3, "\177ELF\1\2\1\0\0\0\0\0\0\0\0\0\0\3\0\24\0\0\0\1\0\0mD\0\0\0004\0\r\273T\0\0\0\0\0004\0 \0\10\0(\0#\0 \0\0\0\6\0\0\0004\0\0\0004\0\0\0004\0\0\1\0\0\0\1\0\0\0\0\5\0\0\0\4\0\0\0\3\0\r\226\30\0\r\226\30\0\r\226"..., 512) = 512
00:23:38.247800 fstat64(3, {st_mode=S_IFREG|0755, st_size=949134, ...}) = 0
00:23:38.282682 mmap(0xff04000, 965808, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0xff04000
00:23:38.318785 mprotect(0xffdf000, 61440, PROT_NONE) = 0
00:23:38.356752 mmap(0xffee000, 8192, PROT_READ|PROT_WRITE|PROT_EXEC, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0xda000) = 0xffee000
00:23:38.398613 close(3) = 0
00:23:38.441007 open("/lib/libc.so.6", O_RDONLY|O_CLOEXEC) = 3
00:23:38.484360 read(3, "\177ELF\1\2\1\0\0\0\0\0\0\0\0\0\0\3\0\24\0\0\0\1\0\0022\370\0\0\0004\0\23\364\204\0\0\0\0\0004\0 \0\n\0(\0+\0(\0\0\0\6\0\0\0004\0\0\0004\0\0\0004\0\0\1@\0\0\1@\0\0\0\5\0\0\0\4\0\0\0\3\0\22\243\0\0\22\243\0\0\22\243"..., 512) = 512
00:23:38.530541 fstat64(3, {st_mode=S_IFREG|0755, st_size=1523094, ...}) = 0
00:23:38.580393 mmap(0xfda2000, 1383752, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0xfda2000
00:23:38.632432 mprotect(0xfedc000, 65536, PROT_NONE) = 0
00:23:38.686202 mmap(0xfeec000, 24576, PROT_READ|PROT_WRITE|PROT_EXEC, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x13a000) = 0xfeec000
00:23:38.742659 mmap(0xfef2000, 7496, PROT_READ|PROT_WRITE|PROT_EXEC, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0xfef2000
00:23:38.802962 close(3) = 0
00:23:38.863385 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x4801c000
00:23:38.925049 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x4801d000
00:23:38.991467 mprotect(0xfeec000, 8192, PROT_READ) = 0
00:23:39.056780 mprotect(0xffee000, 4096, PROT_READ) = 0
00:23:39.124880 mprotect(0x4802b000, 4096, PROT_READ) = 0
00:23:39.193656 getuid() = 0
00:23:39.263280 brk(0) = 0x10376000
00:23:39.333104 brk(0x10398000) = 0x10398000
00:23:39.404830 rt_sigaction(SIGALRM, {0x10020b98, [ALRM], SA_RESTART}, {SIG_DFL, [], 0}, 8) = 0
00:23:39.479127 socket(PF_LOCAL, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 3
00:23:39.552176 connect(3, {sa_family=AF_LOCAL, sun_path="/var/run/nscd/socket"}, 110) = -1 ENOENT (No such file or directory)
00:23:39.629450 close(3) = 0
00:23:39.710636 socket(PF_LOCAL, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 3
00:23:39.791080 connect(3, {sa_family=AF_LOCAL, sun_path="/var/run/nscd/socket"}, 110) = -1 ENOENT (No such file or directory)
00:23:39.874672 close(3) = 0
00:23:39.959270 open("/etc/nsswitch.conf", O_RDONLY|O_CLOEXEC) = 3
00:23:40.044709 fstat64(3, {st_mode=S_IFREG|0644, st_size=151, ...}) = 0
00:23:40.131924 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x4801e000
00:23:40.220234 read(3, "#\n# /etc/nsswitch.conf\n#\npasswd: files\ngroup: files\nshadow: files\nhosts: files\nne"..., 4096) = 151
00:23:40.310850 read(3, "", 4096) = 0
00:23:40.316571 close(3) = 0
00:23:40.322987 munmap(0x4801e000, 4096) = 0
00:23:40.330757 open("/lib/libnss_files.so.2", O_RDONLY|O_CLOEXEC) = 3
00:23:40.340145 read(3, "\177ELF\1\2\1\0\0\0\0\0\0\0\0\0\0\3\0\24\0\0\0\1\0\0\34\330\0\0\0004\0\0\222\244\0\0\0\0\0004\0 \0\10\0(\0 \0\35\0\0\0\6\0\0\0004\0\0\0004\0\0\0004\0\0\1\0\0\0\1\0\0\0\0\5\0\0\0\4\0\0\0\3\0\0\204\250\0\0\204\250\0\0\204"..., 512) = 512
00:23:40.352350 fstat64(3, {st_mode=S_IFREG|0755, st_size=48223, ...}) = 0
00:23:40.368747 mmap(0xfd78000, 104020, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0xfd78000
00:23:40.386442 mprotect(0xfd81000, 61440, PROT_NONE) = 0
00:23:40.405922 mmap(0xfd90000, 8192, PROT_READ|PROT_WRITE|PROT_EXEC, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x8000) = 0xfd90000
00:23:40.429103 close(3) = 0
00:23:40.451666 mprotect(0xfd90000, 4096, PROT_READ) = 0
00:23:40.477176 open("/etc/services", O_RDONLY|O_CLOEXEC) = 3
00:23:40.502536 fstat64(3, {st_mode=S_IFREG|0644, st_size=58394, ...}) = 0
00:23:40.530107 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x4801e000
00:23:40.559595 read(3, "#\n# Network services, Internet style\n#\n# Removed all the stuff beyond 1024, to save diskspace\n#\n#\n#"..., 4096) = 4096
00:23:40.591083 read(3, "Time Protocol\nxns-time 52/udp \t\t# XNS Time Protocol\ndomain 53/tcp \t\t# Domai"..., 4096) = 4096
00:23:40.626694 close(3) = 0
00:23:40.663531 munmap(0x4801e000, 4096) = 0
00:23:40.700862 write(2, "Connecting to 192.168.2.100:8080 (192.168.2.100:8080)\n", 52) = 52
00:23:40.741070 alarm(900) = 0
00:23:40.781533 socket(PF_INET, SOCK_STREAM, IPPROTO_IP) = 3
00:23:40.823636 connect(3, {sa_family=AF_INET, sin_port=htons(8080), sin_addr=inet_addr("192.168.2.100")}, 16) = 0
00:23:40.868997 fcntl64(3, F_GETFL) = 0x2 (flags O_RDWR)
00:23:40.915404 fstat64(3, {st_mode=S_IFSOCK|0777, st_size=0, ...}) = 0
00:23:40.962610 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x4801e000
00:23:41.013320 _llseek(3, 0, 0xbfe90a98, SEEK_CUR) = -1 ESPIPE (Illegal seek)
00:23:41.065333 write(3, "GET /build/lastSuccessfulBuild/artifact/bl"..., 211) = 211
00:23:41.126193 read(3, "HTTP/1.1 200 OK\r\nServer: Winstone Servlet Engine v0.9.10\r\nLast-Modified: Thu, 20 Mar 2014 15:58:39 "..., 4096) = 4096
00:23:41.189045 open("boundary.tgz", O_WRONLY|O_CREAT|O_EXCL|O_TRUNC|O_LARGEFILE, 0666) = 4
00:23:41.257153 clock_gettime(CLOCK_MONOTONIC, {1424, 874074662}) = 0
00:23:41.323240 clock_gettime(CLOCK_MONOTONIC, {1424, 939066622}) = 0
00:23:41.390179 fcntl64(3, F_GETFL) = 0x2 (flags O_RDWR)
00:23:41.457195 fcntl64(3, F_SETFL, O_RDWR|O_NONBLOCK) = 0
00:23:41.527162 read(3, "\367\277\373\3\215\32\334\1@\203;\320_\203;0\242\33\356\0S\351C\336'>\267\363\323\352\273\373\3430\233<\346<T\254j\17\1\344\274\10\271n\214\351\221\3129\353\256t\307\271\210\351\374&\373A\316\202\203Z?\342\274=B;u}\234[\321=\247\200\260H\235S at X\366\27\274\205\270\17p!T\333~"..., 4096) = 4096
....
(thousan reads .. removed it from the log )
....
00:24:43.503906 write(4, "\351\3725\261\377\304*\215\3177)\230\356\220v\315i\343\31\337K\237\347.,\333\31\327\177F\3\333;gvQ\263\303\345\222\31W'\257J\r\367\177;\360i\17\255\371\n\314\334\267\251\337\234\347:\277\243\237\230B_stf2\232\301\352\363%*)\321e\332\226\323\34397\276\352\275\37xy\265y\332a%"..., 1197) = 1197
00:24:43.563891 fcntl64(3, F_GETFL) = 0x802 (flags O_RDWR|O_NONBLOCK)
00:24:43.606158 fcntl64(3, F_SETFL, O_RDWR) = 0
00:24:43.649511 _llseek(4, 0, [1709229], SEEK_CUR) = 0
00:24:43.693329 ftruncate64(4, 1709229) = 0
00:24:43.739550 clock_gettime(CLOCK_MONOTONIC, {1487, 344985642}) = 0
00:24:43.785636 write(2, "\rboundary.tgz ", 21) = 21
00:24:43.833741 write(2, " 100%", 5) = 5
00:24:43.882449 ioctl(2, TIOCGWINSZ, {ws_row=30, ws_col=208, ws_xpixel=0, ws_ypixel=0}) = 0
00:24:43.932634 write(2, " |*************************************************************************************************"..., 162) = 162
00:24:43.984868 write(2, " 1669k", 7) = 7
00:24:44.038898 write(2, " 0:00:00 ETA", 13) = 13
00:24:44.094147 write(2, "\n", 1) = 1
00:24:44.150752 close(4) = 0
00:24:44.206673 close(3) = 0
00:24:44.263632 munmap(0x4801e000, 4096) = 0
00:24:44.322678 exit_group(0) = ?
00:24:44.351921 +++ exited with 0 +++
More information about the busybox
mailing list