- This topic has 21 replies, 8 voices, and was last updated 17 years ago by
.
-
Posts
-
hi
just to say, after install I experienced this. The service had been shut down and started a few times and I then left the server running and tested it from a few different clients.
I think the problem could have been caused due to the loss of network connection that the server experienced while it was serving. It automatically recovered when the network came back but then seemed to exhibit this effect. After a service restart some hours later, it initially peaked at 100% again but went down to a normal level.
This may be of no help… but if you want any more info let me know.
Btw, this was my first install of the software ever so there was no upgrade issues here.
arkid
@arkid77 wrote:
hi
just to say, after install I experienced this. The service had been shut down and started a few times and I then left the server running and tested it from a few different clients.
I think the problem could have been caused due to the loss of network connection that the server experienced while it was serving. It automatically recovered when the network came back but then seemed to exhibit this effect. After a service restart some hours later, it initially peaked at 100% again but went down to a normal level.
This may be of no help… but if you want any more info let me know.
Btw, this was my first install of the software ever so there was no upgrade issues here.
arkid
The initial file scan is pretty cpu intensive, so that’s probably what that was.
As far as it going to 100% when the network connection dies, that’s interesting… I might not be detecting a closed connection well, and might be trying to continue to push data through the closed socket. I’ll see if I can replicate this by unplugging a nic while streaming.
— Ron
@rpedde wrote:
The initial file scan is pretty cpu intensive, so that’s probably what that was.
As far as it going to 100% when the network connection dies, that’s interesting… I might not be detecting a closed connection well, and might be trying to continue to push data through the closed socket. I’ll see if I can replicate this by unplugging a nic while streaming.
— Ron
Hi
Thanks, that would be great to test. This activity was definitely not desirable and I encountered 3/4 hours after the server had first been installed. The service was problably on its 3rd or 4th session of having ever run.
The 100% activity was constant. I realised something was wrong as my laptop was huffing and puffing so loud and normally I hardly ever hear its fan due to its low heat mobile cpu.
A
Yup same problem here, It will run for a while just fine, then my server will just ramp up to 100% and eventually die.
I just want to confirm that I have this same 100% CPU issue. I can’t really pinpoint when it happens; obviously I get high CPU usage when other people connect and it starts transcoding FLAC stuff, but even when no one is connected and listening to music, it still bumps up to max CPU usage (on both cores). Since it’s hard to pinpoint when it happens, and I’m not always paying attention to my server, I’ll often come back hours later and it will be at 100% and I won’t be sure why.
I haven’t noticed this yet, and I’m on svn-1696 as well. My processor load runs at 16% right now steadily, and only that because I’ve got Oddcast streaming Pandora 😀 I’ll keep an eye out for things, though.
Thanks,
Zachary
@redbeard wrote:
I just want to confirm that I have this same 100% CPU issue. I can’t really pinpoint when it happens; obviously I get high CPU usage when other people connect and it starts transcoding FLAC stuff, but even when no one is connected and listening to music, it still bumps up to max CPU usage (on both cores). Since it’s hard to pinpoint when it happens, and I’m not always paying attention to my server, I’ll often come back hours later and it will be at 100% and I won’t be sure why.
Might be the same thing — a client disconnecting in the middle of a song, and it keeps trying to pump data at it.
At least, that’s what seems likely now. I just re-installed my laptop with Leopard (from scratch), so don’t have a windows dev vm up yet, hope to tonight or tomorrow, and then I’ll be able to take a closer look at this.
— Ron
I left it running all night and all today. When I woke up it was fine, but when I got home from class it was doing it again. I had the logs running on verbosity level 8, and using a rough estimate from the amount of CPU time firefly.exe has used, I think the time frame below is roughly about when it started. I cut out all of the “unknown meta code” stuff that happens all the time, and there’s a lot more of similar logs after this as the day progressed. I’m also on a college network, and I’m starting to have a weird suspicion that this is happening perhaps as a result of people using mytunes or ourtunes or something similar to attempt to download the music off me.
2007-11-05 14:15:27 (b49e01c5): Request: GET daap://146.244.184.248:9999/databases/1/items/1036.wav HTTP/1.1
2007-11-05 14:15:27 (b49e01c5): Session 0: Streaming file '1_1.4_14. Harder, Better, Faster, Stronger.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:17:53 (b49e01c5): Error writing to client socket: An existing connection was forcibly closed by the remote host.
2007-11-05 14:17:53 (def9d5db): Request: GET daap://146.244.184.248:9999/databases/1/items/1034.wav HTTP/1.1
2007-11-05 14:17:53 (def9d5db): Session 0: Streaming file '1_1.2_14. Aerodynamic.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:17:53 (def9d5db): Error writing to client socket: An existing connection was forcibly closed by the remote host.
2007-11-05 14:17:53 (b49e8e26): Request: GET daap://146.244.184.248:9999/databases/1/items/1034.wav HTTP/1.1
2007-11-05 14:17:53 (b49e8e26): Session 0: Streaming file '1_1.2_14. Aerodynamic.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:19:21 (b49e8e26): Error writing to client socket: An existing connection was forcibly closed by the remote host.
2007-11-05 14:19:21 (defa623c): Request: GET daap://146.244.184.248:9999/databases/1/items/1061.wav HTTP/1.1
2007-11-05 14:19:21 (defa623c): Session 0: Streaming file '1_1.5_10. Make Love.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:19:22 (defa623c): Error writing to client socket: An existing connection was forcibly closed by the remote host.
2007-11-05 14:19:22 (b49f1a87): Request: GET daap://146.244.184.248:9999/databases/1/items/1061.wav HTTP/1.1
2007-11-05 14:19:22 (b49f1a87): Session 0: Streaming file '1_1.5_10. Make Love.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:24:19 (defaee9d): Request: GET daap://146.244.184.248:9999/databases/1/items/1062.wav HTTP/1.1
2007-11-05 14:24:19 (defaee9d): Session 0: Streaming file '1_1.6_10. The Brainwasher.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:24:50 (b0ae96e3): Rescanning database
2007-11-05 14:24:56 (b0ae96e3): Starting playlist scan
2007-11-05 14:24:56 (b0ae96e3): Updating playlists
2007-11-05 14:24:56 (b0ae96e3): Scanned 4249 songs (was 4249) in 6 seconds
2007-11-05 14:25:29 (defaee9d): Error writing to client socket: An existing connection was forcibly closed by the remote host.
2007-11-05 14:25:29 (b49fa6e8): Request: GET daap://146.244.184.248:9999/databases/1/items/1059.wav HTTP/1.1
2007-11-05 14:25:29 (b49fa6e8): Session 0: Streaming file '1_1.3_10. Robot Rock.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:25:30 (b49fa6e8): Error writing to client socket: An established connection was aborted by the software in your host machine.
2007-11-05 14:25:30 (defb7afe): Request: GET daap://146.244.184.248:9999/databases/1/items/1059.wav HTTP/1.1
2007-11-05 14:25:30 (defb7afe): Session 0: Streaming file '1_1.3_10. Robot Rock.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:30:15 (defc075f): Request: GET daap://146.244.184.248:9999/databases/1/items/1060.wav HTTP/1.1
2007-11-05 14:30:15 (defc075f): Session 0: Streaming file '1_1.4_10. Steam Machine.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:35:35 (defc93c0): Request: GET daap://146.244.184.248:9999/databases/1/items/1061.wav HTTP/1.1
2007-11-05 14:35:35 (defc93c0): Session 0: Streaming file '1_1.5_10. Make Love.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:38:59 (defc93c0): Error writing to client socket: An existing connection was forcibly closed by the remote host.
2007-11-05 14:38:59 (defd2021): Request: GET daap://146.244.184.248:9999/databases/1/items/1033.wav HTTP/1.1
2007-11-05 14:38:59 (defd2021): Session 0: Streaming file '1_1.1_14. One More Time.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:38:59 (defd2021): Error writing to client socket: An existing connection was forcibly closed by the remote host.
2007-11-05 14:38:59 (defdac82): Request: GET daap://146.244.184.248:9999/databases/1/items/1033.wav HTTP/1.1
2007-11-05 14:38:59 (defdac82): Session 0: Streaming file '1_1.1_14. One More Time.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:44:18 (defe38e3): Request: GET daap://146.244.184.248:9999/databases/1/items/1034.wav HTTP/1.1
2007-11-05 14:44:18 (defe38e3): Session 0: Streaming file '1_1.2_14. Aerodynamic.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:47:47 (defec544): Request: GET daap://146.244.184.248:9999/databases/1/items/1035.wav HTTP/1.1
2007-11-05 14:47:47 (defec544): Session 0: Streaming file '1_1.3_14. Digital Love.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:52:44 (deff51a5): Request: GET daap://146.244.184.248:9999/databases/1/items/1036.wav HTTP/1.1
2007-11-05 14:52:44 (deff51a5): Session 0: Streaming file '1_1.4_14. Harder, Better, Faster, Stronger.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:53:40 (deff51a5): Error writing to client socket: An existing connection was forcibly closed by the remote host.
2007-11-05 14:53:40 (e942016d): Thread 176: could not read: unknown internal error
2007-11-05 15:24:58 (b0ae96e3): Rescanning database
2007-11-05 15:25:04 (b0ae96e3): Starting playlist scan
2007-11-05 15:25:04 (b0ae96e3): Updating playlists
2007-11-05 15:25:04 (b0ae96e3): Scanned 4249 songs (was 4249) in 6 seconds
2007-11-05 16:16:14 (e9428dce): Request: GET daap://146.244.184.248:9999/databases/1/items/443.wav HTTP/1.1
2007-11-05 16:16:14 (e9428dce): Session 0: Streaming file '1_1.5_12. Drown Me Slowly.flac' to 146.244.184.26 (offset 0)
2007-11-05 16:17:20 (e9428dce): Error writing to client socket: An established connection was aborted by the software in your host machine.
2007-11-05 16:17:28 (deffde06): Thread 193: could not read: Unknown error
2007-11-05 16:18:16 (b4a03349): Thread 185: could not read: unknown internal error
@redbeard wrote:
I left it running all night and all today. When I woke up it was fine, but when I got home from class it was doing it again. I had the logs running on verbosity level 8, and using a rough estimate from the amount of CPU time firefly.exe has used, I think the time frame below is roughly about when it started. I cut out all of the “unknown meta code” stuff that happens all the time, and there’s a lot more of similar logs after this as the day progressed. I’m also on a college network, and I’m starting to have a weird suspicion that this is happening perhaps as a result of people using mytunes or ourtunes or something similar to attempt to download the music off me.
2007-11-05 14:15:27 (b49e01c5): Request: GET daap://146.244.184.248:9999/databases/1/items/1036.wav HTTP/1.1
2007-11-05 14:15:27 (b49e01c5): Session 0: Streaming file '1_1.4_14. Harder, Better, Faster, Stronger.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:17:53 (b49e01c5): Error writing to client socket: An existing connection was forcibly closed by the remote host.
2007-11-05 14:17:53 (def9d5db): Request: GET daap://146.244.184.248:9999/databases/1/items/1034.wav HTTP/1.1
2007-11-05 14:17:53 (def9d5db): Session 0: Streaming file '1_1.2_14. Aerodynamic.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:17:53 (def9d5db): Error writing to client socket: An existing connection was forcibly closed by the remote host.
2007-11-05 14:17:53 (b49e8e26): Request: GET daap://146.244.184.248:9999/databases/1/items/1034.wav HTTP/1.1
2007-11-05 14:17:53 (b49e8e26): Session 0: Streaming file '1_1.2_14. Aerodynamic.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:19:21 (b49e8e26): Error writing to client socket: An existing connection was forcibly closed by the remote host.
2007-11-05 14:19:21 (defa623c): Request: GET daap://146.244.184.248:9999/databases/1/items/1061.wav HTTP/1.1
2007-11-05 14:19:21 (defa623c): Session 0: Streaming file '1_1.5_10. Make Love.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:19:22 (defa623c): Error writing to client socket: An existing connection was forcibly closed by the remote host.
2007-11-05 14:19:22 (b49f1a87): Request: GET daap://146.244.184.248:9999/databases/1/items/1061.wav HTTP/1.1
2007-11-05 14:19:22 (b49f1a87): Session 0: Streaming file '1_1.5_10. Make Love.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:24:19 (defaee9d): Request: GET daap://146.244.184.248:9999/databases/1/items/1062.wav HTTP/1.1
2007-11-05 14:24:19 (defaee9d): Session 0: Streaming file '1_1.6_10. The Brainwasher.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:24:50 (b0ae96e3): Rescanning database
2007-11-05 14:24:56 (b0ae96e3): Starting playlist scan
2007-11-05 14:24:56 (b0ae96e3): Updating playlists
2007-11-05 14:24:56 (b0ae96e3): Scanned 4249 songs (was 4249) in 6 seconds
2007-11-05 14:25:29 (defaee9d): Error writing to client socket: An existing connection was forcibly closed by the remote host.
2007-11-05 14:25:29 (b49fa6e8): Request: GET daap://146.244.184.248:9999/databases/1/items/1059.wav HTTP/1.1
2007-11-05 14:25:29 (b49fa6e8): Session 0: Streaming file '1_1.3_10. Robot Rock.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:25:30 (b49fa6e8): Error writing to client socket: An established connection was aborted by the software in your host machine.
2007-11-05 14:25:30 (defb7afe): Request: GET daap://146.244.184.248:9999/databases/1/items/1059.wav HTTP/1.1
2007-11-05 14:25:30 (defb7afe): Session 0: Streaming file '1_1.3_10. Robot Rock.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:30:15 (defc075f): Request: GET daap://146.244.184.248:9999/databases/1/items/1060.wav HTTP/1.1
2007-11-05 14:30:15 (defc075f): Session 0: Streaming file '1_1.4_10. Steam Machine.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:35:35 (defc93c0): Request: GET daap://146.244.184.248:9999/databases/1/items/1061.wav HTTP/1.1
2007-11-05 14:35:35 (defc93c0): Session 0: Streaming file '1_1.5_10. Make Love.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:38:59 (defc93c0): Error writing to client socket: An existing connection was forcibly closed by the remote host.
2007-11-05 14:38:59 (defd2021): Request: GET daap://146.244.184.248:9999/databases/1/items/1033.wav HTTP/1.1
2007-11-05 14:38:59 (defd2021): Session 0: Streaming file '1_1.1_14. One More Time.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:38:59 (defd2021): Error writing to client socket: An existing connection was forcibly closed by the remote host.
2007-11-05 14:38:59 (defdac82): Request: GET daap://146.244.184.248:9999/databases/1/items/1033.wav HTTP/1.1
2007-11-05 14:38:59 (defdac82): Session 0: Streaming file '1_1.1_14. One More Time.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:44:18 (defe38e3): Request: GET daap://146.244.184.248:9999/databases/1/items/1034.wav HTTP/1.1
2007-11-05 14:44:18 (defe38e3): Session 0: Streaming file '1_1.2_14. Aerodynamic.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:47:47 (defec544): Request: GET daap://146.244.184.248:9999/databases/1/items/1035.wav HTTP/1.1
2007-11-05 14:47:47 (defec544): Session 0: Streaming file '1_1.3_14. Digital Love.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:52:44 (deff51a5): Request: GET daap://146.244.184.248:9999/databases/1/items/1036.wav HTTP/1.1
2007-11-05 14:52:44 (deff51a5): Session 0: Streaming file '1_1.4_14. Harder, Better, Faster, Stronger.flac' to 146.244.184.19 (offset 0)
2007-11-05 14:53:40 (deff51a5): Error writing to client socket: An existing connection was forcibly closed by the remote host.
2007-11-05 14:53:40 (e942016d): Thread 176: could not read: unknown internal error
2007-11-05 15:24:58 (b0ae96e3): Rescanning database
2007-11-05 15:25:04 (b0ae96e3): Starting playlist scan
2007-11-05 15:25:04 (b0ae96e3): Updating playlists
2007-11-05 15:25:04 (b0ae96e3): Scanned 4249 songs (was 4249) in 6 seconds
2007-11-05 16:16:14 (e9428dce): Request: GET daap://146.244.184.248:9999/databases/1/items/443.wav HTTP/1.1
2007-11-05 16:16:14 (e9428dce): Session 0: Streaming file '1_1.5_12. Drown Me Slowly.flac' to 146.244.184.26 (offset 0)
2007-11-05 16:17:20 (e9428dce): Error writing to client socket: An established connection was aborted by the software in your host machine.
2007-11-05 16:17:28 (deffde06): Thread 193: could not read: Unknown error
2007-11-05 16:18:16 (b4a03349): Thread 185: could not read: unknown internal error
A file leecher like mytunes pulling down flacs as fast as possible will definitely peg your cpu.
That’s likely your culprit.
— Ron
@rpedde wrote:
A file leecher like mytunes pulling down flacs as fast as possible will definitely peg your cpu.
That’s likely your culprit.
— Ron
The thing is, it stays at 100% long after anyone has finished whatever they were doing. Like right now- firefly.exe is running at 100% CPU, but the last person to try and listen to a song was three hours ago.
I wish it were possible to block mytunes and what not on here, but unfortunately due to network constraints that just isn’t possible 🙁
- The forum ‘Nightlies Feedback’ is closed to new topics and replies.