Okay, I've searched through ALL the posts, FAW, etc. and have yet to resolve my situatuion. Here I am resorting to posting a new thread.

Prior to version 1.03, I used the ehternet conenction via my office network to transfer my mp3's to my Empeg with ease. It's been several months and a new version of the firmware later, and now I can't seem to get it working again. :/

All of our office workstations connect to the network via DHCP, and are on the same subnet. When watching the bootstrap via Hyperterminal I get :

3b5714f9 DHCP Our mac is 00:02:d7:10:01:79
3b5714f9 DHCP Our address is 255.255.255.255
3b5714f9 DHCP Broadcast address is 255.255.255.255
3b5714f9 DHCP Current IP address is 255.255.255.255
3b5714f9 DHCP Sending DHCP discover
3b5714fa DHCP Sending DHCP discover
3b5714fc DHCP Sending DHCP discover
3b571500 DHCP Sending DHCP discover
3b571507 DHCP Sending DHCP discover
3b571516 DHCP Sending DHCP discover
3b571534 DHCP Sending DHCP discover
3b571570 DHCP Sending DHCP discover
3b5715e8 DHCP Sending DHCP discover
3b571660 DHCP Sending DHCP discover

...basically searching for the DHCP connection forever, and Emplode is obviously unable to find the Empeg on the network... Since our entire network is run via DHCP, using a static IP for the Empeg is a bit out of the question. I've never had to alter any of the network config files within linux before to get it to work, and am at a complete loss as to what I need to do now.

...Eagerly awaiting any help. :)


-chris
icq 7634211

Assuming that:

a) It worked before,
b) All you changed is the software version installed on the empeg
c) You correctly installed Car2 software instead of accidentally installing Car1 software...

Then the problem is most likely a hardware one, or an external-to-the-empeg configuration issue.

One other user had a faulty ethernet adapter in his empeg, and it showed in the boot log. Can you give us a boot log?

Also, make sure you're plugging into a 10mbps hub instead of 100. The empeg doesn't do 100.

___________
Tony Fabris

Thats it. Damn your smart, Tony. :)

We changed our whole network to 100mbps.

Now lets see if I have an autoswitching hub around.... Hmmmm

Heh. Not smart, just experienced. I went through something similar myself.

___________
Tony Fabris

Why do so many companies go to 100mbps only switches, while almost all home hubs and switches are 10/100? I always come across some device somewhere that won't do 100, like older JetDirect devices and such.

Got it, and it werks.. Thanks guys. :)

Bring on the Empeg with 100mbps ports :)

Edited by chris_vd on 02/08/01 12:43 AM.

Hold your horses :/

After switching my port from 100 to 10 mbps full duplex, I know can see the Empeg on the network, but cannot connect to it. Emplode fails at :downloading from unit. I rebuilt the drive with the builder and reinstalled the consumer 1.03. Now when I connect and it synchronizes, it hangs in the middle of transferring the first song onto a completely empty drive. Note that I have to use the task manager to end the Emplode process, or it will just sit there forever trying to copy a single file.

Here's a log at the point of the hang:

Wed 01 Aug 2001 23:49:37.272 Logfile opened
23:49:38.538 protocolclient.cpp(873) : I [041c] ProtocolClient::IsUnitConnected()
23:49:38.538 packets.cpp(49) : I [041c] NEW request
23:49:38.538 packets.cpp(140) : I [041c] Request::Ping
23:49:38.538 packets.cpp(1061) : I [041c] FLUSH

23:49:38.538 packets.cpp(99) : I [041c] Sending response.
23:49:38.538 packets.cpp(106) : I [041c] Sending packet with id=77
23:49:38.538 packets.cpp(688) : I [041c] Request::WaitForReply(header_return=0012F51C, packet_id=77)

23:49:38.538 packets.cpp(699) : I [041c] WaitForReply loop

23:49:38.538 packets.cpp(701) : I [041c] Waiting for reply with id 77 and timeout 2

23:49:38.538 packets.cpp(827) : I [041c] Request::Receive(h = 0012F360, timeout=2)
23:49:38.538 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:38.538 packets.cpp(851) : I [041c] Got 95 bytes from connection->Receive
23:49:38.538 packets.cpp(954) : I [041c] Got a PSOH
23:49:38.538 packets.cpp(998) : I [041c] Got packet length: 84 bytes.

23:49:38.538 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:38.538 packets.cpp(1041) : I [041c] CRC is good.

23:49:38.538 packets.cpp(911) : I [041c] We got a valid packet!
23:49:38.538 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:38.538 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:38.538 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:38.538 packets.cpp(704) : I [041c] Receive result was 0

23:49:38.538 packets.cpp(784) : I [041c] Got a response to packet 77
23:49:38.538 packets.cpp(790) : I [041c] We have a progress reply.
23:49:38.538 packets.cpp(796) : I [041c] Progress reply, new timeout is 15
23:49:38.538 packets.cpp(699) : I [041c] WaitForReply loop

23:49:38.538 packets.cpp(701) : I [041c] Waiting for reply with id 77 and timeout 15

23:49:38.538 packets.cpp(827) : I [041c] Request::Receive(h = 0012F360, timeout=15)
23:49:38.538 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:38.538 packets.cpp(851) : I [041c] Got 95 bytes from connection->Receive
23:49:38.538 packets.cpp(954) : I [041c] Got a PSOH
23:49:38.538 packets.cpp(998) : I [041c] Got packet length: 84 bytes.

23:49:38.538 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:38.538 packets.cpp(1041) : I [041c] CRC is good.

23:49:38.538 packets.cpp(911) : I [041c] We got a valid packet!
23:49:38.538 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:38.538 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:38.538 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:38.538 packets.cpp(704) : I [041c] Receive result was 0

23:49:38.538 packets.cpp(784) : I [041c] Got a response to packet 77
23:49:38.538 packets.cpp(790) : I [041c] We have a progress reply.
23:49:38.538 packets.cpp(796) : I [041c] Progress reply, new timeout is 15
23:49:38.538 packets.cpp(699) : I [041c] WaitForReply loop

23:49:38.538 packets.cpp(701) : I [041c] Waiting for reply with id 77 and timeout 15

23:49:38.538 packets.cpp(827) : I [041c] Request::Receive(h = 0012F360, timeout=15)
23:49:38.538 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:38.538 packets.cpp(851) : I [041c] Got 15 bytes from connection->Receive
23:49:38.538 packets.cpp(954) : I [041c] Got a PSOH
23:49:38.538 packets.cpp(998) : I [041c] Got packet length: 4 bytes.

23:49:38.538 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:38.538 packets.cpp(1041) : I [041c] CRC is good.

23:49:38.538 packets.cpp(911) : I [041c] We got a valid packet!
23:49:38.538 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:38.538 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:38.538 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:38.538 packets.cpp(704) : I [041c] Receive result was 0

23:49:38.538 packets.cpp(784) : I [041c] Got a response to packet 77
23:49:38.538 packets.cpp(810) : I [041c] Got a real reply.

23:49:38.538 packets.cpp(814) : I [041c] Packet::WaitForReply(G) = 0x6
23:49:38.538 packets.cpp(217) : I [041c] Request::Ping(D) = 0x0
23:49:38.538 protocolclient.cpp(876) : I [041c] ProtocolClient::IsUnitConnected()=1
23:49:38.538 DatabaseSync.cpp(245) : I [041c] Disabling power management
23:49:38.538 DatabaseUpload.cpp(84) : I [041c] Verify Player Identity...
23:49:38.538 protocolclient.cpp(211) : I [041c] ProtocolClient::ReadFidToMemory(1, 0012F4E0, 0012F4E4)
23:49:38.538 packets.cpp(49) : I [041c] NEW request
23:49:38.538 DatabaseSyncProtocolObserver.cpp(74) : I [041c] ProgressProtocolObserver::ReportProgress(client=00C5AAD0, activity=3, current=0, maximum=1)
23:49:38.538 DatabaseSyncProtocolObserver.cpp(80) : I [041c] Progress of activity 3 set to 0/1 in CProgressProtocolObserver::ReportProgress.
23:49:38.538 DatabaseSyncProtocolObserver.cpp(86) : I [041c] ProgressProtocolObserver::ReportProgress()
23:49:38.538 packets.cpp(99) : I [041c] Sending response.
23:49:38.538 packets.cpp(106) : I [041c] Sending packet with id=78
23:49:38.538 packets.cpp(688) : I [041c] Request::WaitForReply(header_return=0012F454, packet_id=78)

23:49:38.538 packets.cpp(699) : I [041c] WaitForReply loop

23:49:38.538 packets.cpp(701) : I [041c] Waiting for reply with id 78 and timeout 2

23:49:38.538 packets.cpp(827) : I [041c] Request::Receive(h = 0012F29C, timeout=2)
23:49:38.538 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:38.538 packets.cpp(851) : I [041c] Got 19 bytes from connection->Receive
23:49:38.538 packets.cpp(954) : I [041c] Got a PSOH
23:49:38.538 packets.cpp(998) : I [041c] Got packet length: 8 bytes.

23:49:38.538 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:38.538 packets.cpp(1041) : I [041c] CRC is good.

23:49:38.538 packets.cpp(911) : I [041c] We got a valid packet!
23:49:38.538 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:38.538 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:38.538 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:38.538 packets.cpp(704) : I [041c] Receive result was 0

23:49:38.538 packets.cpp(784) : I [041c] Got a response to packet 78
23:49:38.538 packets.cpp(810) : I [041c] Got a real reply.

23:49:38.538 packets.cpp(814) : I [041c] Packet::WaitForReply(G) = 0x6
23:49:38.538 packets.cpp(49) : I [041c] NEW request
23:49:38.538 DatabaseSyncProtocolObserver.cpp(74) : I [041c] ProgressProtocolObserver::ReportProgress(client=00C5AAD0, activity=3, current=1, maximum=1)
23:49:38.538 DatabaseSyncProtocolObserver.cpp(80) : I [041c] Progress of activity 3 set to 1/1 in CProgressProtocolObserver::ReportProgress.
23:49:38.538 DatabaseSyncProtocolObserver.cpp(86) : I [041c] ProgressProtocolObserver::ReportProgress()
23:49:38.538 DatabaseSyncProtocolObserver.cpp(74) : I [041c] ProgressProtocolObserver::ReportProgress(client=00C5AAD0, activity=1, current=0, maximum=145)
23:49:38.538 DatabaseSyncProtocolObserver.cpp(80) : I [041c] Progress of activity 1 set to 0/145 in CProgressProtocolObserver::ReportProgress.
23:49:38.538 DatabaseSyncProtocolObserver.cpp(86) : I [041c] ProgressProtocolObserver::ReportProgress()
23:49:38.538 packets.cpp(99) : I [041c] Sending response.
23:49:38.538 packets.cpp(106) : I [041c] Sending packet with id=79
23:49:38.538 packets.cpp(688) : I [041c] Request::WaitForReply(header_return=0012F448, packet_id=79)

23:49:38.538 packets.cpp(699) : I [041c] WaitForReply loop

23:49:38.538 packets.cpp(701) : I [041c] Waiting for reply with id 79 and timeout 2

23:49:38.538 packets.cpp(827) : I [041c] Request::Receive(h = 0012F284, timeout=2)
23:49:38.538 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:38.538 packets.cpp(851) : I [041c] Got 95 bytes from connection->Receive
23:49:38.538 packets.cpp(954) : I [041c] Got a PSOH
23:49:38.538 packets.cpp(998) : I [041c] Got packet length: 84 bytes.

23:49:38.553 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:38.553 packets.cpp(1041) : I [041c] CRC is good.

23:49:38.553 packets.cpp(911) : I [041c] We got a valid packet!
23:49:38.553 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:38.553 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:38.553 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:38.553 packets.cpp(704) : I [041c] Receive result was 0

23:49:38.553 packets.cpp(784) : I [041c] Got a response to packet 79
23:49:38.553 packets.cpp(790) : I [041c] We have a progress reply.
23:49:38.553 packets.cpp(796) : I [041c] Progress reply, new timeout is 20
23:49:38.553 packets.cpp(699) : I [041c] WaitForReply loop

23:49:38.553 packets.cpp(701) : I [041c] Waiting for reply with id 79 and timeout 20

23:49:38.553 packets.cpp(827) : I [041c] Request::Receive(h = 0012F284, timeout=20)
23:49:38.553 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:38.553 packets.cpp(851) : I [041c] Got 168 bytes from connection->Receive
23:49:38.553 packets.cpp(954) : I [041c] Got a PSOH
23:49:38.553 packets.cpp(998) : I [041c] Got packet length: 157 bytes.

23:49:38.553 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:38.553 packets.cpp(1041) : I [041c] CRC is good.

23:49:38.553 packets.cpp(911) : I [041c] We got a valid packet!
23:49:38.553 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:38.553 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:38.553 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:38.553 packets.cpp(704) : I [041c] Receive result was 0

23:49:38.553 packets.cpp(784) : I [041c] Got a response to packet 79
23:49:38.553 packets.cpp(810) : I [041c] Got a real reply.

23:49:38.553 packets.cpp(814) : I [041c] Packet::WaitForReply(G) = 0x6
23:49:38.553 packets.cpp(49) : I [041c] NEW request
23:49:38.553 DatabaseSyncProtocolObserver.cpp(74) : I [041c] ProgressProtocolObserver::ReportProgress(client=00C5AAD0, activity=1, current=145, maximum=145)
23:49:38.553 DatabaseSyncProtocolObserver.cpp(80) : I [041c] Progress of activity 1 set to 145/145 in CProgressProtocolObserver::ReportProgress.
23:49:38.553 DatabaseSyncProtocolObserver.cpp(86) : I [041c] ProgressProtocolObserver::ReportProgress()
23:49:38.553 DatabaseSyncProtocolObserver.cpp(74) : I [041c] ProgressProtocolObserver::ReportProgress(client=00C5AAD0, activity=1, current=145, maximum=145)
23:49:38.553 DatabaseSyncProtocolObserver.cpp(80) : I [041c] Progress of activity 1 set to 145/145 in CProgressProtocolObserver::ReportProgress.
23:49:38.553 DatabaseSyncProtocolObserver.cpp(86) : I [041c] ProgressProtocolObserver::ReportProgress()
23:49:38.553 protocolclient.cpp(295) : I [041c] ProtocolClient::ReadFidToMemory() = 0
23:49:38.553 protocolclient.cpp(648) : I [041c] ProtocolClient::FreeFidMemory(ppdest=0012F4E0)
23:49:38.553 protocolclient.cpp(649) : I [041c] *ppdest=00C59428
23:49:38.553 protocolclient.cpp(653) : I [041c] ProtocolClient::FreeFidMemory()
23:49:38.553 DatabaseUpload.cpp(96) : I [041c] Player serial = 80000377, expecting 80000377
23:49:38.553 protocolclient.cpp(1316) : I [041c] ProtocolClient::GetPlayerConfiguration(s=0012F530)
23:49:38.553 protocolclient.cpp(211) : I [041c] ProtocolClient::ReadFidToMemory(6, 0012F4B4, 0012F4B8)
23:49:38.553 packets.cpp(49) : I [041c] NEW request
23:49:38.553 DatabaseSyncProtocolObserver.cpp(74) : I [041c] ProgressProtocolObserver::ReportProgress(client=00C5AAD0, activity=3, current=0, maximum=1)
23:49:38.553 DatabaseSyncProtocolObserver.cpp(80) : I [041c] Progress of activity 3 set to 0/1 in CProgressProtocolObserver::ReportProgress.
23:49:38.553 DatabaseSyncProtocolObserver.cpp(86) : I [041c] ProgressProtocolObserver::ReportProgress()
23:49:38.553 packets.cpp(99) : I [041c] Sending response.
23:49:38.553 packets.cpp(106) : I [041c] Sending packet with id=81
23:49:38.553 packets.cpp(688) : I [041c] Request::WaitForReply(header_return=0012F420, packet_id=81)

23:49:38.553 packets.cpp(699) : I [041c] WaitForReply loop

23:49:38.553 packets.cpp(701) : I [041c] Waiting for reply with id 81 and timeout 2

23:49:38.553 packets.cpp(827) : I [041c] Request::Receive(h = 0012F268, timeout=2)
23:49:38.553 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:38.553 packets.cpp(851) : I [041c] Got 19 bytes from connection->Receive
23:49:38.553 packets.cpp(954) : I [041c] Got a PSOH
23:49:38.553 packets.cpp(998) : I [041c] Got packet length: 8 bytes.

23:49:38.553 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:38.553 packets.cpp(1041) : I [041c] CRC is good.

23:49:38.553 packets.cpp(911) : I [041c] We got a valid packet!
23:49:38.553 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:38.553 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:38.553 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:38.553 packets.cpp(704) : I [041c] Receive result was 0

23:49:38.553 packets.cpp(784) : I [041c] Got a response to packet 81
23:49:38.553 packets.cpp(810) : I [041c] Got a real reply.

23:49:38.553 packets.cpp(814) : I [041c] Packet::WaitForReply(G) = 0x6
23:49:38.553 packets.cpp(49) : I [041c] NEW request
23:49:38.553 DatabaseSyncProtocolObserver.cpp(74) : I [041c] ProgressProtocolObserver::ReportProgress(client=00C5AAD0, activity=3, current=1, maximum=1)
23:49:38.553 DatabaseSyncProtocolObserver.cpp(80) : I [041c] Progress of activity 3 set to 1/1 in CProgressProtocolObserver::ReportProgress.
23:49:38.553 DatabaseSyncProtocolObserver.cpp(86) : I [041c] ProgressProtocolObserver::ReportProgress()
23:49:38.553 DatabaseSyncProtocolObserver.cpp(74) : I [041c] ProgressProtocolObserver::ReportProgress(client=00C5AAD0, activity=1, current=0, maximum=334)
23:49:38.553 DatabaseSyncProtocolObserver.cpp(80) : I [041c] Progress of activity 1 set to 0/334 in CProgressProtocolObserver::ReportProgress.
23:49:38.553 DatabaseSyncProtocolObserver.cpp(86) : I [041c] ProgressProtocolObserver::ReportProgress()
23:49:38.553 packets.cpp(99) : I [041c] Sending response.
23:49:38.553 packets.cpp(106) : I [041c] Sending packet with id=82
23:49:38.553 packets.cpp(688) : I [041c] Request::WaitForReply(header_return=0012F414, packet_id=82)

23:49:38.553 packets.cpp(699) : I [041c] WaitForReply loop

23:49:38.553 packets.cpp(701) : I [041c] Waiting for reply with id 82 and timeout 2

23:49:38.553 packets.cpp(827) : I [041c] Request::Receive(h = 0012F250, timeout=2)
23:49:38.553 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:38.553 packets.cpp(851) : I [041c] Got 95 bytes from connection->Receive
23:49:38.553 packets.cpp(954) : I [041c] Got a PSOH
23:49:38.553 packets.cpp(998) : I [041c] Got packet length: 84 bytes.

23:49:38.553 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:38.553 packets.cpp(1041) : I [041c] CRC is good.

23:49:38.553 packets.cpp(911) : I [041c] We got a valid packet!
23:49:38.553 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:38.553 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:38.553 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:38.553 packets.cpp(704) : I [041c] Receive result was 0

23:49:38.553 packets.cpp(784) : I [041c] Got a response to packet 82
23:49:38.553 packets.cpp(790) : I [041c] We have a progress reply.
23:49:38.553 packets.cpp(796) : I [041c] Progress reply, new timeout is 20
23:49:38.553 packets.cpp(699) : I [041c] WaitForReply loop

23:49:38.553 packets.cpp(701) : I [041c] Waiting for reply with id 82 and timeout 20

23:49:38.553 packets.cpp(827) : I [041c] Request::Receive(h = 0012F250, timeout=20)
23:49:38.553 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:38.553 packets.cpp(851) : I [041c] Got 357 bytes from connection->Receive
23:49:38.553 packets.cpp(954) : I [041c] Got a PSOH
23:49:38.553 packets.cpp(998) : I [041c] Got packet length: 346 bytes.

23:49:38.553 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:38.553 packets.cpp(1041) : I [041c] CRC is good.

23:49:38.553 packets.cpp(911) : I [041c] We got a valid packet!
23:49:38.553 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:38.553 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:38.553 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:38.553 packets.cpp(704) : I [041c] Receive result was 0

23:49:38.553 packets.cpp(784) : I [041c] Got a response to packet 82
23:49:38.553 packets.cpp(810) : I [041c] Got a real reply.

23:49:38.553 packets.cpp(814) : I [041c] Packet::WaitForReply(G) = 0x6
23:49:38.553 packets.cpp(49) : I [041c] NEW request
23:49:38.553 DatabaseSyncProtocolObserver.cpp(74) : I [041c] ProgressProtocolObserver::ReportProgress(client=00C5AAD0, activity=1, current=334, maximum=334)
23:49:38.569 DatabaseSyncProtocolObserver.cpp(80) : I [041c] Progress of activity 1 set to 334/334 in CProgressProtocolObserver::ReportProgress.
23:49:38.569 DatabaseSyncProtocolObserver.cpp(86) : I [041c] ProgressProtocolObserver::ReportProgress()
23:49:38.569 DatabaseSyncProtocolObserver.cpp(74) : I [041c] ProgressProtocolObserver::ReportProgress(client=00C5AAD0, activity=1, current=334, maximum=334)
23:49:38.569 DatabaseSyncProtocolObserver.cpp(80) : I [041c] Progress of activity 1 set to 334/334 in CProgressProtocolObserver::ReportProgress.
23:49:38.569 DatabaseSyncProtocolObserver.cpp(86) : I [041c] ProgressProtocolObserver::ReportProgress()
23:49:38.569 protocolclient.cpp(295) : I [041c] ProtocolClient::ReadFidToMemory() = 0
23:49:38.569 protocolclient.cpp(648) : I [041c] ProtocolClient::FreeFidMemory(ppdest=0012F4B4)
23:49:38.569 protocolclient.cpp(649) : I [041c] *ppdest=00C59040
23:49:38.569 protocolclient.cpp(653) : I [041c] ProtocolClient::FreeFidMemory()
23:49:38.569 protocolclient.cpp(1334) : I [041c] ProtocolClient::GetPlayerConfiguration() = 0
23:49:38.569 DatabaseUpload.cpp(110) : I [041c] Database seq number = 12, expecting 12
23:49:38.569 DatabaseUpload.cpp(138) : I [041c] Entering stage 1.
23:49:38.569 protocolclient.cpp(1202) : I [041c] ProtocolClient::LockUI(1)
23:49:38.569 protocolclient.cpp(1143) : I [041c] ProtocolClient::SendCommand(command=1, p0=1, p1=0, p2=00000000
23:49:38.569 packets.cpp(49) : I [041c] NEW request
23:49:38.569 packets.cpp(1061) : I [041c] FLUSH

23:49:38.569 packets.cpp(99) : I [041c] Sending response.
23:49:38.569 packets.cpp(106) : I [041c] Sending packet with id=84
23:49:38.569 packets.cpp(688) : I [041c] Request::WaitForReply(header_return=0012F394, packet_id=84)

23:49:38.569 packets.cpp(699) : I [041c] WaitForReply loop

23:49:38.569 packets.cpp(701) : I [041c] Waiting for reply with id 84 and timeout 2

23:49:38.569 packets.cpp(827) : I [041c] Request::Receive(h = 0012F1E8, timeout=2)
23:49:38.569 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:38.819 packets.cpp(851) : I [041c] Got -110 bytes from connection->Receive
23:49:38.819 packets.cpp(886) : I [041c] It timed out - trying again
23:49:38.819 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:38.913 packets.cpp(851) : I [041c] Got 15 bytes from connection->Receive
23:49:38.913 packets.cpp(954) : I [041c] Got a PSOH
23:49:38.913 packets.cpp(998) : I [041c] Got packet length: 4 bytes.

23:49:38.913 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:38.913 packets.cpp(1041) : I [041c] CRC is good.

23:49:38.913 packets.cpp(911) : I [041c] We got a valid packet!
23:49:38.913 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:38.913 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:38.913 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:38.913 packets.cpp(704) : I [041c] Receive result was 0

23:49:38.913 packets.cpp(784) : I [041c] Got a response to packet 84
23:49:38.913 packets.cpp(810) : I [041c] Got a real reply.

23:49:38.913 packets.cpp(814) : I [041c] Packet::WaitForReply(G) = 0x6
23:49:38.913 protocolclient.cpp(1157) : I [041c] ProtocolClient::SendCommand()=0
23:49:38.913 protocolclient.cpp(1204) : I [041c] ProtocolClient::LockUI()=0
23:49:38.913 DatabaseUpload.cpp(144) : I [041c] Entering stage 2.
23:49:38.913 protocolclient.cpp(1121) : I [041c] ProtocolClient::CheckMedia()
23:49:38.913 protocolclient.cpp(1052) : I [041c] ProtocolClient::Fsck(drive='/dev/hda4')
23:49:38.913 packets.cpp(49) : I [041c] NEW request
23:49:38.913 packets.cpp(1061) : I [041c] FLUSH

23:49:38.913 packets.cpp(99) : I [041c] Sending response.
23:49:38.913 packets.cpp(106) : I [041c] Sending packet with id=85
23:49:38.913 packets.cpp(688) : I [041c] Request::WaitForReply(header_return=0012F4B0, packet_id=85)

23:49:38.913 packets.cpp(699) : I [041c] WaitForReply loop

23:49:38.913 packets.cpp(701) : I [041c] Waiting for reply with id 85 and timeout 2

23:49:38.913 packets.cpp(827) : I [041c] Request::Receive(h = 0012F2E4, timeout=2)
23:49:38.913 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:38.913 packets.cpp(851) : I [041c] Got 95 bytes from connection->Receive
23:49:38.913 packets.cpp(954) : I [041c] Got a PSOH
23:49:38.913 packets.cpp(998) : I [041c] Got packet length: 84 bytes.

23:49:38.913 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:38.913 packets.cpp(1041) : I [041c] CRC is good.

23:49:38.913 packets.cpp(911) : I [041c] We got a valid packet!
23:49:38.913 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:38.913 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:38.913 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:38.913 packets.cpp(704) : I [041c] Receive result was 0

23:49:38.913 packets.cpp(784) : I [041c] Got a response to packet 85
23:49:38.913 packets.cpp(790) : I [041c] We have a progress reply.
23:49:38.913 packets.cpp(796) : I [041c] Progress reply, new timeout is 25
23:49:38.913 DatabaseSyncProtocolObserver.cpp(74) : I [041c] ProgressProtocolObserver::ReportProgress(client=00C5AAD0, activity=7, current=-5, maximum=0)
23:49:38.913 DatabaseSyncProtocolObserver.cpp(80) : I [041c] Progress of activity 7 set to -5/0 in CProgressProtocolObserver::ReportProgress.
23:49:38.913 DatabaseSyncProtocolObserver.cpp(86) : I [041c] ProgressProtocolObserver::ReportProgress()
23:49:38.913 packets.cpp(699) : I [041c] WaitForReply loop

23:49:38.913 packets.cpp(701) : I [041c] Waiting for reply with id 85 and timeout 25

23:49:38.913 packets.cpp(827) : I [041c] Request::Receive(h = 0012F2E4, timeout=25)
23:49:38.913 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:38.944 packets.cpp(851) : I [041c] Got 15 bytes from connection->Receive
23:49:38.944 packets.cpp(954) : I [041c] Got a PSOH
23:49:38.944 packets.cpp(998) : I [041c] Got packet length: 4 bytes.

23:49:38.944 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:38.944 packets.cpp(1041) : I [041c] CRC is good.

23:49:38.944 packets.cpp(911) : I [041c] We got a valid packet!
23:49:38.944 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:38.944 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:38.944 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:38.944 packets.cpp(704) : I [041c] Receive result was 0

23:49:38.944 packets.cpp(784) : I [041c] Got a response to packet 85
23:49:38.944 packets.cpp(810) : I [041c] Got a real reply.

23:49:38.944 packets.cpp(814) : I [041c] Packet::WaitForReply(G) = 0x6
23:49:38.944 protocolclient.cpp(1077) : I [041c] FSCK result: 0
23:49:38.944 protocolclient.cpp(1115) : I [041c] ProtocolClient::Fsck()=0
23:49:38.944 protocolclient.cpp(1052) : I [041c] ProtocolClient::Fsck(drive='/dev/hdc4')
23:49:38.944 packets.cpp(49) : I [041c] NEW request
23:49:38.944 packets.cpp(1061) : I [041c] FLUSH

23:49:38.944 packets.cpp(99) : I [041c] Sending response.
23:49:38.944 packets.cpp(106) : I [041c] Sending packet with id=86
23:49:38.944 packets.cpp(688) : I [041c] Request::WaitForReply(header_return=0012F4B0, packet_id=86)

23:49:38.944 packets.cpp(699) : I [041c] WaitForReply loop

23:49:38.944 packets.cpp(701) : I [041c] Waiting for reply with id 86 and timeout 2

23:49:38.944 packets.cpp(827) : I [041c] Request::Receive(h = 0012F2E4, timeout=2)
23:49:38.944 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:38.944 packets.cpp(851) : I [041c] Got 95 bytes from connection->Receive
23:49:38.944 packets.cpp(954) : I [041c] Got a PSOH
23:49:38.944 packets.cpp(998) : I [041c] Got packet length: 84 bytes.

23:49:38.944 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:38.944 packets.cpp(1041) : I [041c] CRC is good.

23:49:38.944 packets.cpp(911) : I [041c] We got a valid packet!
23:49:38.944 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:38.944 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:38.944 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:38.944 packets.cpp(704) : I [041c] Receive result was 0

23:49:38.944 packets.cpp(784) : I [041c] Got a response to packet 86
23:49:38.944 packets.cpp(790) : I [041c] We have a progress reply.
23:49:38.944 packets.cpp(796) : I [041c] Progress reply, new timeout is 25
23:49:38.944 DatabaseSyncProtocolObserver.cpp(74) : I [041c] ProgressProtocolObserver::ReportProgress(client=00C5AAD0, activity=7, current=-5, maximum=0)
23:49:38.944 DatabaseSyncProtocolObserver.cpp(80) : I [041c] Progress of activity 7 set to -5/0 in CProgressProtocolObserver::ReportProgress.
23:49:38.944 DatabaseSyncProtocolObserver.cpp(86) : I [041c] ProgressProtocolObserver::ReportProgress()
23:49:38.944 packets.cpp(699) : I [041c] WaitForReply loop

23:49:38.944 packets.cpp(701) : I [041c] Waiting for reply with id 86 and timeout 25

23:49:38.944 packets.cpp(827) : I [041c] Request::Receive(h = 0012F2E4, timeout=25)
23:49:38.944 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:38.944 packets.cpp(851) : I [041c] Got 15 bytes from connection->Receive
23:49:38.944 packets.cpp(954) : I [041c] Got a PSOH
23:49:38.944 packets.cpp(998) : I [041c] Got packet length: 4 bytes.

23:49:38.944 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:38.944 packets.cpp(1041) : I [041c] CRC is good.

23:49:38.960 packets.cpp(911) : I [041c] We got a valid packet!
23:49:38.960 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:38.960 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:38.960 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:38.960 packets.cpp(704) : I [041c] Receive result was 0

23:49:38.960 packets.cpp(784) : I [041c] Got a response to packet 86
23:49:38.960 packets.cpp(810) : I [041c] Got a real reply.

23:49:38.960 packets.cpp(814) : I [041c] Packet::WaitForReply(G) = 0x6
23:49:38.960 protocolclient.cpp(1077) : I [041c] FSCK result: 512
23:49:38.960 protocolclient.cpp(1109) : I [041c] FSCK reported disk is not present on drive /dev/hdc4
23:49:38.960 protocolclient.cpp(1115) : I [041c] ProtocolClient::Fsck()=512
23:49:38.960 protocolclient.cpp(1136) : I [041c] ProtocolClient::CheckMedia()=512
23:49:38.960 DatabaseUpload.cpp(156) : I [041c] Entering stage 3.
23:49:38.960 protocolclient.cpp(936) : I [041c] ProtocolClient::EnableWrite(b=1)
23:49:38.960 packets.cpp(49) : I [041c] NEW request
23:49:38.960 DatabaseSyncProtocolObserver.cpp(74) : I [041c] ProgressProtocolObserver::ReportProgress(client=00C5AAD0, activity=8, current=0, maximum=1)
23:49:38.960 DatabaseSyncProtocolObserver.cpp(80) : I [041c] Progress of activity 8 set to 0/1 in CProgressProtocolObserver::ReportProgress.
23:49:38.960 DatabaseSyncProtocolObserver.cpp(86) : I [041c] ProgressProtocolObserver::ReportProgress()
23:49:38.960 packets.cpp(1061) : I [041c] FLUSH

23:49:38.960 packets.cpp(99) : I [041c] Sending response.
23:49:38.960 packets.cpp(106) : I [041c] Sending packet with id=87
23:49:38.960 packets.cpp(688) : I [041c] Request::WaitForReply(header_return=0012F50C, packet_id=87)

23:49:38.960 packets.cpp(699) : I [041c] WaitForReply loop

23:49:38.960 packets.cpp(701) : I [041c] Waiting for reply with id 87 and timeout 2

23:49:38.960 packets.cpp(827) : I [041c] Request::Receive(h = 0012F350, timeout=2)
23:49:38.960 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:38.960 packets.cpp(851) : I [041c] Got 95 bytes from connection->Receive
23:49:38.960 packets.cpp(954) : I [041c] Got a PSOH
23:49:38.960 packets.cpp(998) : I [041c] Got packet length: 84 bytes.

23:49:38.960 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:38.960 packets.cpp(1041) : I [041c] CRC is good.

23:49:38.960 packets.cpp(911) : I [041c] We got a valid packet!
23:49:38.960 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:38.960 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:38.960 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:38.960 packets.cpp(704) : I [041c] Receive result was 0

23:49:38.960 packets.cpp(784) : I [041c] Got a response to packet 87
23:49:38.960 packets.cpp(790) : I [041c] We have a progress reply.
23:49:38.960 packets.cpp(796) : I [041c] Progress reply, new timeout is 60
23:49:38.960 packets.cpp(699) : I [041c] WaitForReply loop

23:49:38.960 packets.cpp(701) : I [041c] Waiting for reply with id 87 and timeout 60

23:49:38.960 packets.cpp(827) : I [041c] Request::Receive(h = 0012F350, timeout=60)
23:49:38.960 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:38.960 packets.cpp(851) : I [041c] Got 15 bytes from connection->Receive
23:49:38.960 packets.cpp(954) : I [041c] Got a PSOH
23:49:38.960 packets.cpp(998) : I [041c] Got packet length: 4 bytes.

23:49:38.960 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:38.960 packets.cpp(1041) : I [041c] CRC is good.

23:49:38.960 packets.cpp(911) : I [041c] We got a valid packet!
23:49:38.960 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:38.960 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:38.960 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:38.960 packets.cpp(704) : I [041c] Receive result was 0

23:49:38.960 packets.cpp(784) : I [041c] Got a response to packet 87
23:49:38.960 packets.cpp(810) : I [041c] Got a real reply.

23:49:38.960 packets.cpp(814) : I [041c] Packet::WaitForReply(G) = 0x6
23:49:38.960 DatabaseSyncProtocolObserver.cpp(74) : I [041c] ProgressProtocolObserver::ReportProgress(client=00C5AAD0, activity=8, current=1, maximum=1)
23:49:38.960 DatabaseSyncProtocolObserver.cpp(80) : I [041c] Progress of activity 8 set to 1/1 in CProgressProtocolObserver::ReportProgress.
23:49:38.960 DatabaseSyncProtocolObserver.cpp(86) : I [041c] ProgressProtocolObserver::ReportProgress()
23:49:38.960 protocolclient.cpp(952) : I [041c] ProtocolClient::EnableWrite()=0
23:49:38.960 DatabaseUpload.cpp(222) : I [041c] Stage 4: Delete player databases
23:49:38.960 protocolclient.cpp(775) : I [041c] ProtocolClient::DeleteDatabases()
23:49:38.960 protocolclient.cpp(985) : I [041c] ProtocolClient::DeleteFid(fid=3, mask=0xffff)
23:49:38.960 packets.cpp(49) : I [041c] NEW request
23:49:38.960 DatabaseSyncProtocolObserver.cpp(74) : I [041c] ProgressProtocolObserver::ReportProgress(client=00C5AAD0, activity=6, current=0, maximum=1)
23:49:38.960 DatabaseSyncProtocolObserver.cpp(80) : I [041c] Progress of activity 6 set to 0/1 in CProgressProtocolObserver::ReportProgress.
23:49:38.960 DatabaseSyncProtocolObserver.cpp(86) : I [041c] ProgressProtocolObserver::ReportProgress()
23:49:38.960 packets.cpp(99) : I [041c] Sending response.
23:49:38.960 packets.cpp(106) : I [041c] Sending packet with id=88
23:49:38.960 packets.cpp(688) : I [041c] Request::WaitForReply(header_return=0012F480, packet_id=88)

23:49:38.960 packets.cpp(699) : I [041c] WaitForReply loop

23:49:38.960 packets.cpp(701) : I [041c] Waiting for reply with id 88 and timeout 2

23:49:38.960 packets.cpp(827) : I [041c] Request::Receive(h = 0012F2C4, timeout=2)
23:49:38.960 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:38.960 packets.cpp(851) : I [041c] Got 95 bytes from connection->Receive
23:49:38.960 packets.cpp(954) : I [041c] Got a PSOH
23:49:38.960 packets.cpp(998) : I [041c] Got packet length: 84 bytes.

23:49:38.960 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:38.960 packets.cpp(1041) : I [041c] CRC is good.

23:49:38.960 packets.cpp(911) : I [041c] We got a valid packet!
23:49:38.960 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:38.960 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:38.960 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:38.960 packets.cpp(704) : I [041c] Receive result was 0

23:49:38.960 packets.cpp(784) : I [041c] Got a response to packet 88
23:49:38.960 packets.cpp(790) : I [041c] We have a progress reply.
23:49:38.960 packets.cpp(796) : I [041c] Progress reply, new timeout is 2
23:49:38.960 packets.cpp(699) : I [041c] WaitForReply loop

23:49:38.960 packets.cpp(701) : I [041c] Waiting for reply with id 88 and timeout 2

23:49:38.960 packets.cpp(827) : I [041c] Request::Receive(h = 0012F2C4, timeout=2)
23:49:38.960 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:38.960 packets.cpp(851) : I [041c] Got 15 bytes from connection->Receive
23:49:38.960 packets.cpp(954) : I [041c] Got a PSOH
23:49:38.960 packets.cpp(998) : I [041c] Got packet length: 4 bytes.

23:49:38.960 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:38.975 packets.cpp(1041) : I [041c] CRC is good.

23:49:38.975 packets.cpp(911) : I [041c] We got a valid packet!
23:49:38.975 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:38.975 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:38.975 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:38.975 packets.cpp(704) : I [041c] Receive result was 0

23:49:38.975 packets.cpp(784) : I [041c] Got a response to packet 88
23:49:38.975 packets.cpp(810) : I [041c] Got a real reply.

23:49:38.975 packets.cpp(814) : I [041c] Packet::WaitForReply(G) = 0x6
23:49:38.975 DatabaseSyncProtocolObserver.cpp(74) : I [041c] ProgressProtocolObserver::ReportProgress(client=00C5AAD0, activity=6, current=1, maximum=1)
23:49:38.975 DatabaseSyncProtocolObserver.cpp(80) : I [041c] Progress of activity 6 set to 1/1 in CProgressProtocolObserver::ReportProgress.
23:49:38.975 DatabaseSyncProtocolObserver.cpp(86) : I [041c] ProgressProtocolObserver::ReportProgress()
23:49:38.975 protocolclient.cpp(1002) : I [041c] ProtocolClient::DeleteFid()=0
23:49:38.975 protocolclient.cpp(985) : I [041c] ProtocolClient::DeleteFid(fid=2, mask=0xffff)
23:49:38.975 packets.cpp(49) : I [041c] NEW request
23:49:38.975 DatabaseSyncProtocolObserver.cpp(74) : I [041c] ProgressProtocolObserver::ReportProgress(client=00C5AAD0, activity=6, current=0, maximum=1)
23:49:38.975 DatabaseSyncProtocolObserver.cpp(80) : I [041c] Progress of activity 6 set to 0/1 in CProgressProtocolObserver::ReportProgress.
23:49:38.975 DatabaseSyncProtocolObserver.cpp(86) : I [041c] ProgressProtocolObserver::ReportProgress()
23:49:38.975 packets.cpp(99) : I [041c] Sending response.
23:49:38.975 packets.cpp(106) : I [041c] Sending packet with id=89
23:49:38.975 packets.cpp(688) : I [041c] Request::WaitForReply(header_return=0012F480, packet_id=89)

23:49:38.975 packets.cpp(699) : I [041c] WaitForReply loop

23:49:38.975 packets.cpp(701) : I [041c] Waiting for reply with id 89 and timeout 2

23:49:38.975 packets.cpp(827) : I [041c] Request::Receive(h = 0012F2C4, timeout=2)
23:49:38.975 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:38.975 packets.cpp(851) : I [041c] Got 95 bytes from connection->Receive
23:49:38.975 packets.cpp(954) : I [041c] Got a PSOH
23:49:38.975 packets.cpp(998) : I [041c] Got packet length: 84 bytes.

23:49:38.975 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:38.975 packets.cpp(1041) : I [041c] CRC is good.

23:49:38.975 packets.cpp(911) : I [041c] We got a valid packet!
23:49:38.975 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:38.975 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:38.975 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:38.975 packets.cpp(704) : I [041c] Receive result was 0

23:49:38.975 packets.cpp(784) : I [041c] Got a response to packet 89
23:49:38.975 packets.cpp(790) : I [041c] We have a progress reply.
23:49:38.975 packets.cpp(796) : I [041c] Progress reply, new timeout is 2
23:49:38.975 packets.cpp(699) : I [041c] WaitForReply loop

23:49:38.975 packets.cpp(701) : I [041c] Waiting for reply with id 89 and timeout 2

23:49:38.975 packets.cpp(827) : I [041c] Request::Receive(h = 0012F2C4, timeout=2)
23:49:38.975 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:38.975 packets.cpp(851) : I [041c] Got 15 bytes from connection->Receive
23:49:38.975 packets.cpp(954) : I [041c] Got a PSOH
23:49:38.975 packets.cpp(998) : I [041c] Got packet length: 4 bytes.

23:49:38.975 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:38.975 packets.cpp(1041) : I [041c] CRC is good.

23:49:38.975 packets.cpp(911) : I [041c] We got a valid packet!
23:49:38.975 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:38.975 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:38.975 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:38.975 packets.cpp(704) : I [041c] Receive result was 0

23:49:38.975 packets.cpp(784) : I [041c] Got a response to packet 89
23:49:38.975 packets.cpp(810) : I [041c] Got a real reply.

23:49:38.975 packets.cpp(814) : I [041c] Packet::WaitForReply(G) = 0x6
23:49:38.975 DatabaseSyncProtocolObserver.cpp(74) : I [041c] ProgressProtocolObserver::ReportProgress(client=00C5AAD0, activity=6, current=1, maximum=1)
23:49:38.975 DatabaseSyncProtocolObserver.cpp(80) : I [041c] Progress of activity 6 set to 1/1 in CProgressProtocolObserver::ReportProgress.
23:49:38.975 DatabaseSyncProtocolObserver.cpp(86) : I [041c] ProgressProtocolObserver::ReportProgress()
23:49:38.975 protocolclient.cpp(1002) : I [041c] ProtocolClient::DeleteFid()=0
23:49:38.975 protocolclient.cpp(985) : I [041c] ProtocolClient::DeleteFid(fid=5, mask=0xffff)
23:49:38.975 packets.cpp(49) : I [041c] NEW request
23:49:38.975 DatabaseSyncProtocolObserver.cpp(74) : I [041c] ProgressProtocolObserver::ReportProgress(client=00C5AAD0, activity=6, current=0, maximum=1)
23:49:38.975 DatabaseSyncProtocolObserver.cpp(80) : I [041c] Progress of activity 6 set to 0/1 in CProgressProtocolObserver::ReportProgress.
23:49:38.975 DatabaseSyncProtocolObserver.cpp(86) : I [041c] ProgressProtocolObserver::ReportProgress()
23:49:38.975 packets.cpp(99) : I [041c] Sending response.
23:49:38.975 packets.cpp(106) : I [041c] Sending packet with id=90
23:49:38.975 packets.cpp(688) : I [041c] Request::WaitForReply(header_return=0012F480, packet_id=90)

23:49:38.975 packets.cpp(699) : I [041c] WaitForReply loop

23:49:38.975 packets.cpp(701) : I [041c] Waiting for reply with id 90 and timeout 2

23:49:38.975 packets.cpp(827) : I [041c] Request::Receive(h = 0012F2C4, timeout=2)
23:49:38.991 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:38.991 packets.cpp(851) : I [041c] Got 95 bytes from connection->Receive
23:49:38.991 packets.cpp(954) : I [041c] Got a PSOH
23:49:38.991 packets.cpp(998) : I [041c] Got packet length: 84 bytes.

23:49:38.991 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:38.991 packets.cpp(1041) : I [041c] CRC is good.

23:49:38.991 packets.cpp(911) : I [041c] We got a valid packet!
23:49:38.991 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:38.991 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:38.991 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:38.991 packets.cpp(704) : I [041c] Receive result was 0

23:49:38.991 packets.cpp(784) : I [041c] Got a response to packet 90
23:49:38.991 packets.cpp(790) : I [041c] We have a progress reply.
23:49:38.991 packets.cpp(796) : I [041c] Progress reply, new timeout is 2
23:49:38.991 packets.cpp(699) : I [041c] WaitForReply loop

23:49:38.991 packets.cpp(701) : I [041c] Waiting for reply with id 90 and timeout 2

23:49:38.991 packets.cpp(827) : I [041c] Request::Receive(h = 0012F2C4, timeout=2)
23:49:38.991 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:38.991 packets.cpp(851) : I [041c] Got 15 bytes from connection->Receive
23:49:38.991 packets.cpp(954) : I [041c] Got a PSOH
23:49:38.991 packets.cpp(998) : I [041c] Got packet length: 4 bytes.

23:49:38.991 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:38.991 packets.cpp(1041) : I [041c] CRC is good.

23:49:38.991 packets.cpp(911) : I [041c] We got a valid packet!
23:49:38.991 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:38.991 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:38.991 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:38.991 packets.cpp(704) : I [041c] Receive result was 0

23:49:38.991 packets.cpp(784) : I [041c] Got a response to packet 90
23:49:38.991 packets.cpp(810) : I [041c] Got a real reply.

23:49:38.991 packets.cpp(814) : I [041c] Packet::WaitForReply(G) = 0x6
23:49:38.991 DatabaseSyncProtocolObserver.cpp(74) : I [041c] ProgressProtocolObserver::ReportProgress(client=00C5AAD0, activity=6, current=1, maximum=1)
23:49:38.991 DatabaseSyncProtocolObserver.cpp(80) : I [041c] Progress of activity 6 set to 1/1 in CProgressProtocolObserver::ReportProgress.
23:49:38.991 DatabaseSyncProtocolObserver.cpp(86) : I [041c] ProgressProtocolObserver::ReportProgress()
23:49:38.991 protocolclient.cpp(1002) : I [041c] ProtocolClient::DeleteFid()=0
23:49:38.991 protocolclient.cpp(787) : I [041c] ProtocolClient::DeleteDatabases() = 0
23:49:38.991 DatabaseUpload.cpp(228) : I [041c] Stage 5: Synchronise Modified Fids
23:49:38.991 DatabaseUpload.cpp(294) : I [041c] CSyncDialog::SynchroniseModifiedFids(client = 00C5AAD0)
23:49:38.991 DatabaseUpload.cpp(380) : I [041c] Synchronise is required for FID 120
23:49:38.991 Items.cpp(240) : I [041c] CCompoundItem::Synchronise(fid=120, client=00C5AAD0)
23:49:38.991 protocolclient.cpp(326) : I [041c] ProtocolClient::WriteFidFromMemory(fid=288, psource=00C5AC28, size=4)
23:49:38.991 packets.cpp(49) : I [041c] NEW request
23:49:38.991 DatabaseSyncProtocolObserver.cpp(92) : I [041c] PlaylistProtocolObserver::ReportProgress(client=00C5AAD0, activity=4, current=0, maximum=5)
23:49:38.991 DatabaseSyncProtocolObserver.cpp(100) : I [041c] Progress of activity 4 set to 0/2000 in CPlaylistProtocolObserver::ReportProgress.
23:49:38.991 DatabaseSyncProtocolObserver.cpp(102) : I [041c] Based on values: current_playlist=0, maximum_playlist=2, current=0, maximum=5.
23:49:38.991 DatabaseSyncProtocolObserver.cpp(108) : I [041c] PlaylistProtocolObserver::ReportProgress()
23:49:38.991 packets.cpp(99) : I [041c] Sending response.
23:49:38.991 packets.cpp(106) : I [041c] Sending packet with id=91
23:49:38.991 packets.cpp(688) : I [041c] Request::WaitForReply(header_return=0012F33C, packet_id=91)

23:49:38.991 packets.cpp(699) : I [041c] WaitForReply loop

23:49:38.991 packets.cpp(701) : I [041c] Waiting for reply with id 91 and timeout 2

23:49:38.991 packets.cpp(827) : I [041c] Request::Receive(h = 0012F17C, timeout=2)
23:49:38.991 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:38.991 packets.cpp(851) : I [041c] Got 95 bytes from connection->Receive
23:49:38.991 packets.cpp(954) : I [041c] Got a PSOH
23:49:38.991 packets.cpp(998) : I [041c] Got packet length: 84 bytes.

23:49:38.991 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:38.991 packets.cpp(1041) : I [041c] CRC is good.

23:49:38.991 packets.cpp(911) : I [041c] We got a valid packet!
23:49:38.991 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:38.991 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:38.991 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:38.991 packets.cpp(704) : I [041c] Receive result was 0

23:49:38.991 packets.cpp(784) : I [041c] Got a response to packet 91
23:49:38.991 packets.cpp(790) : I [041c] We have a progress reply.
23:49:38.991 packets.cpp(796) : I [041c] Progress reply, new timeout is 2
23:49:38.991 packets.cpp(699) : I [041c] WaitForReply loop

23:49:38.991 packets.cpp(701) : I [041c] Waiting for reply with id 91 and timeout 2

23:49:38.991 packets.cpp(827) : I [041c] Request::Receive(h = 0012F17C, timeout=2)
23:49:38.991 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:39.006 packets.cpp(851) : I [041c] Got 23 bytes from connection->Receive
23:49:39.006 packets.cpp(954) : I [041c] Got a PSOH
23:49:39.006 packets.cpp(998) : I [041c] Got packet length: 12 bytes.

23:49:39.006 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:39.006 packets.cpp(1041) : I [041c] CRC is good.

23:49:39.006 packets.cpp(911) : I [041c] We got a valid packet!
23:49:39.006 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:39.006 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:39.006 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:39.006 packets.cpp(704) : I [041c] Receive result was 0

23:49:39.006 packets.cpp(784) : I [041c] Got a response to packet 91
23:49:39.006 packets.cpp(810) : I [041c] Got a real reply.

23:49:39.006 packets.cpp(814) : I [041c] Packet::WaitForReply(G) = 0x6
23:49:39.006 DatabaseSyncProtocolObserver.cpp(92) : I [041c] PlaylistProtocolObserver::ReportProgress(client=00C5AAD0, activity=4, current=1, maximum=5)
23:49:39.006 DatabaseSyncProtocolObserver.cpp(100) : I [041c] Progress of activity 4 set to 200/2000 in CPlaylistProtocolObserver::ReportProgress.
23:49:39.006 DatabaseSyncProtocolObserver.cpp(102) : I [041c] Based on values: current_playlist=0, maximum_playlist=2, current=1, maximum=5.
23:49:39.006 DatabaseSyncProtocolObserver.cpp(108) : I [041c] PlaylistProtocolObserver::ReportProgress()
23:49:39.006 packets.cpp(49) : I [041c] NEW request
23:49:39.006 packets.cpp(318) : I [041c] Request::WriteFid(fid=0x120, offset=0x0, size=0x4, buffer=00C5AC28)
23:49:39.006 packets.cpp(341) : I [041c] Request::GenericWrite(h=0012B224)
23:49:39.006 packets.cpp(99) : I [041c] Sending response.
23:49:39.006 packets.cpp(106) : I [041c] Sending packet with id=92
23:49:39.006 packets.cpp(688) : I [041c] Request::WaitForReply(header_return=0012B1BC, packet_id=92)

23:49:39.022 packets.cpp(699) : I [041c] WaitForReply loop

23:49:39.022 packets.cpp(701) : I [041c] Waiting for reply with id 92 and timeout 2

23:49:39.022 packets.cpp(827) : I [041c] Request::Receive(h = 0012B008, timeout=2)
23:49:39.022 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:39.022 packets.cpp(851) : I [041c] Got 23 bytes from connection->Receive
23:49:39.022 packets.cpp(954) : I [041c] Got a PSOH
23:49:39.022 packets.cpp(998) : I [041c] Got packet length: 12 bytes.

23:49:39.022 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:39.022 packets.cpp(1041) : I [041c] CRC is good.

23:49:39.022 packets.cpp(911) : I [041c] We got a valid packet!
23:49:39.022 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:39.022 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:39.022 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:39.022 packets.cpp(704) : I [041c] Receive result was 0

23:49:39.022 packets.cpp(784) : I [041c] Got a response to packet 92
23:49:39.022 packets.cpp(810) : I [041c] Got a real reply.

23:49:39.022 packets.cpp(814) : I [041c] Packet::WaitForReply(G) = 0x6
23:49:39.022 packets.cpp(382) : I [041c] Request::GenericWrite(C) = 4 (0x4)
23:49:39.022 packets.cpp(335) : I [041c] Request::WriteFid() = 4 (0x4)
23:49:39.022 packets.cpp(49) : I [041c] NEW request
23:49:39.022 DatabaseSyncProtocolObserver.cpp(92) : I [041c] PlaylistProtocolObserver::ReportProgress(client=00C5AAD0, activity=2, current=5, maximum=5)
23:49:39.022 DatabaseSyncProtocolObserver.cpp(100) : I [041c] Progress of activity 2 set to 1000/2000 in CPlaylistProtocolObserver::ReportProgress.
23:49:39.022 DatabaseSyncProtocolObserver.cpp(102) : I [041c] Based on values: current_playlist=0, maximum_playlist=2, current=5, maximum=5.
23:49:39.022 DatabaseSyncProtocolObserver.cpp(108) : I [041c] PlaylistProtocolObserver::ReportProgress()
23:49:39.022 DatabaseSyncProtocolObserver.cpp(92) : I [041c] PlaylistProtocolObserver::ReportProgress(client=00C5AAD0, activity=2, current=5, maximum=5)
23:49:39.022 DatabaseSyncProtocolObserver.cpp(100) : I [041c] Progress of activity 2 set to 1000/2000 in CPlaylistProtocolObserver::ReportProgress.
23:49:39.022 DatabaseSyncProtocolObserver.cpp(102) : I [041c] Based on values: current_playlist=0, maximum_playlist=2, current=5, maximum=5.
23:49:39.022 DatabaseSyncProtocolObserver.cpp(108) : I [041c] PlaylistProtocolObserver::ReportProgress()
23:49:39.022 protocolclient.cpp(398) : I [041c] ProtocolClient::WriteFidFromMemory() = 0
23:49:39.022 Items.cpp(28) : I [041c] CPlayableItem::Synchronise(fid=120, client=00C5AAD0)
23:49:39.022 protocolclient.cpp(326) : I [041c] ProtocolClient::WriteFidFromMemory(fid=289, psource=00C59CC9, size=34)
23:49:39.022 packets.cpp(49) : I [041c] NEW request
23:49:39.022 DatabaseSyncProtocolObserver.cpp(92) : I [041c] PlaylistProtocolObserver::ReportProgress(client=00C5AAD0, activity=4, current=0, maximum=42)
23:49:39.022 DatabaseSyncProtocolObserver.cpp(100) : I [041c] Progress of activity 4 set to 0/2000 in CPlaylistProtocolObserver::ReportProgress.
23:49:39.022 DatabaseSyncProtocolObserver.cpp(102) : I [041c] Based on values: current_playlist=0, maximum_playlist=2, current=0, maximum=42.
23:49:39.022 DatabaseSyncProtocolObserver.cpp(108) : I [041c] PlaylistProtocolObserver::ReportProgress()
23:49:39.022 packets.cpp(99) : I [041c] Sending response.
23:49:39.022 packets.cpp(106) : I [041c] Sending packet with id=94
23:49:39.022 packets.cpp(688) : I [041c] Request::WaitForReply(header_return=0012F2F4, packet_id=94)

23:49:39.022 packets.cpp(699) : I [041c] WaitForReply loop

23:49:39.022 packets.cpp(701) : I [041c] Waiting for reply with id 94 and timeout 2

23:49:39.022 packets.cpp(827) : I [041c] Request::Receive(h = 0012F134, timeout=2)
23:49:39.022 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:39.022 packets.cpp(851) : I [041c] Got 95 bytes from connection->Receive
23:49:39.022 packets.cpp(954) : I [041c] Got a PSOH
23:49:39.022 packets.cpp(998) : I [041c] Got packet length: 84 bytes.

23:49:39.022 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:39.022 packets.cpp(1041) : I [041c] CRC is good.

23:49:39.022 packets.cpp(911) : I [041c] We got a valid packet!
23:49:39.022 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:39.022 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:39.022 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:39.022 packets.cpp(704) : I [041c] Receive result was 0

23:49:39.022 packets.cpp(784) : I [041c] Got a response to packet 94
23:49:39.022 packets.cpp(790) : I [041c] We have a progress reply.
23:49:39.022 packets.cpp(796) : I [041c] Progress reply, new timeout is 2
23:49:39.022 packets.cpp(699) : I [041c] WaitForReply loop

23:49:39.022 packets.cpp(701) : I [041c] Waiting for reply with id 94 and timeout 2

23:49:39.022 packets.cpp(827) : I [041c] Request::Receive(h = 0012F134, timeout=2)
23:49:39.022 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:39.038 packets.cpp(851) : I [041c] Got 23 bytes from connection->Receive
23:49:39.038 packets.cpp(954) : I [041c] Got a PSOH
23:49:39.038 packets.cpp(998) : I [041c] Got packet length: 12 bytes.

23:49:39.038 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:39.038 packets.cpp(1041) : I [041c] CRC is good.

23:49:39.038 packets.cpp(911) : I [041c] We got a valid packet!
23:49:39.038 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:39.038 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:39.038 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:39.038 packets.cpp(704) : I [041c] Receive result was 0

23:49:39.038 packets.cpp(784) : I [041c] Got a response to packet 94
23:49:39.038 packets.cpp(810) : I [041c] Got a real reply.

23:49:39.038 packets.cpp(814) : I [041c] Packet::WaitForReply(G) = 0x6
23:49:39.038 DatabaseSyncProtocolObserver.cpp(92) : I [041c] PlaylistProtocolObserver::ReportProgress(client=00C5AAD0, activity=4, current=8, maximum=42)
23:49:39.038 DatabaseSyncProtocolObserver.cpp(100) : I [041c] Progress of activity 4 set to 190/2000 in CPlaylistProtocolObserver::ReportProgress.
23:49:39.038 DatabaseSyncProtocolObserver.cpp(102) : I [041c] Based on values: current_playlist=0, maximum_playlist=2, current=8, maximum=42.
23:49:39.038 DatabaseSyncProtocolObserver.cpp(108) : I [041c] PlaylistProtocolObserver::ReportProgress()
23:49:39.038 packets.cpp(49) : I [041c] NEW request
23:49:39.038 packets.cpp(318) : I [041c] Request::WriteFid(fid=0x121, offset=0x0, size=0x22, buffer=00C59CC9)
23:49:39.038 packets.cpp(341) : I [041c] Request::GenericWrite(h=0012B1DC)
23:49:39.038 packets.cpp(99) : I [041c] Sending response.
23:49:39.038 packets.cpp(106) : I [041c] Sending packet with id=95
23:49:39.038 packets.cpp(688) : I [041c] Request::WaitForReply(header_return=0012B174, packet_id=95)

23:49:39.038 packets.cpp(699) : I [041c] WaitForReply loop

23:49:39.038 packets.cpp(701) : I [041c] Waiting for reply with id 95 and timeout 2

23:49:39.038 packets.cpp(827) : I [041c] Request::Receive(h = 0012AFC0, timeout=2)
23:49:39.038 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:39.038 packets.cpp(851) : I [041c] Got 23 bytes from connection->Receive
23:49:39.038 packets.cpp(954) : I [041c] Got a PSOH
23:49:39.038 packets.cpp(998) : I [041c] Got packet length: 12 bytes.

23:49:39.038 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:39.038 packets.cpp(1041) : I [041c] CRC is good.

23:49:39.038 packets.cpp(911) : I [041c] We got a valid packet!
23:49:39.038 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:39.038 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:39.038 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:39.038 packets.cpp(704) : I [041c] Receive result was 0

23:49:39.038 packets.cpp(784) : I [041c] Got a response to packet 95
23:49:39.038 packets.cpp(810) : I [041c] Got a real reply.

23:49:39.038 packets.cpp(814) : I [041c] Packet::WaitForReply(G) = 0x6
23:49:39.038 packets.cpp(382) : I [041c] Request::GenericWrite(C) = 34 (0x22)
23:49:39.038 packets.cpp(335) : I [041c] Request::WriteFid() = 34 (0x22)
23:49:39.038 packets.cpp(49) : I [041c] NEW request
23:49:39.038 DatabaseSyncProtocolObserver.cpp(92) : I [041c] PlaylistProtocolObserver::ReportProgress(client=00C5AAD0, activity=2, current=42, maximum=42)
23:49:39.053 DatabaseSyncProtocolObserver.cpp(100) : I [041c] Progress of activity 2 set to 1000/2000 in CPlaylistProtocolObserver::ReportProgress.
23:49:39.053 DatabaseSyncProtocolObserver.cpp(102) : I [041c] Based on values: current_playlist=0, maximum_playlist=2, current=42, maximum=42.
23:49:39.053 DatabaseSyncProtocolObserver.cpp(108) : I [041c] PlaylistProtocolObserver::ReportProgress()
23:49:39.053 DatabaseSyncProtocolObserver.cpp(92) : I [041c] PlaylistProtocolObserver::ReportProgress(client=00C5AAD0, activity=2, current=42, maximum=42)
23:49:39.053 DatabaseSyncProtocolObserver.cpp(100) : I [041c] Progress of activity 2 set to 1000/2000 in CPlaylistProtocolObserver::ReportProgress.
23:49:39.053 DatabaseSyncProtocolObserver.cpp(102) : I [041c] Based on values: current_playlist=0, maximum_playlist=2, current=42, maximum=42.
23:49:39.053 DatabaseSyncProtocolObserver.cpp(108) : I [041c] PlaylistProtocolObserver::ReportProgress()
23:49:39.053 protocolclient.cpp(398) : I [041c] ProtocolClient::WriteFidFromMemory() = 0
23:49:39.053 Items.cpp(44) : I [041c] CPlayableItem::Synchronise() = 0
23:49:39.053 Items.cpp(268) : I [041c] CCompoundItem::Synchronise() = 0
23:49:39.053 DatabaseUpload.cpp(380) : I [041c] Synchronise is required for FID 130
23:49:39.053 protocolclient.cpp(415) : I [041c] ProtocolClient::WriteFidFromFile(fid=304, filename=J:\mp3\Less Than Jake\(Less Than Jake) - Dopeman(Beastie Boys Remix).mp3)
23:49:39.053 DatabaseSyncProtocolObserver.cpp(92) : I [041c] PlaylistProtocolObserver::ReportProgress(client=00C5AAD0, activity=4, current=1, maximum=4)
23:49:39.053 DatabaseSyncProtocolObserver.cpp(100) : I [041c] Progress of activity 4 set to 1250/2000 in CPlaylistProtocolObserver::ReportProgress.
23:49:39.053 DatabaseSyncProtocolObserver.cpp(102) : I [041c] Based on values: current_playlist=1, maximum_playlist=2, current=1, maximum=4.
23:49:39.053 DatabaseSyncProtocolObserver.cpp(108) : I [041c] PlaylistProtocolObserver::ReportProgress()
23:49:39.053 DatabaseSyncProtocolObserver.cpp(92) : I [041c] PlaylistProtocolObserver::ReportProgress(client=00C5AAD0, activity=4, current=0, maximum=3041280)
23:49:39.053 DatabaseSyncProtocolObserver.cpp(100) : I [041c] Progress of activity 4 set to 1000/2000 in CPlaylistProtocolObserver::ReportProgress.
23:49:39.053 DatabaseSyncProtocolObserver.cpp(102) : I [041c] Based on values: current_playlist=1, maximum_playlist=2, current=0, maximum=3041280.
23:49:39.053 DatabaseSyncProtocolObserver.cpp(108) : I [041c] PlaylistProtocolObserver::ReportProgress()
23:49:39.053 packets.cpp(49) : I [041c] NEW request
23:49:39.053 packets.cpp(99) : I [041c] Sending response.
23:49:39.053 packets.cpp(106) : I [041c] Sending packet with id=97
23:49:39.053 packets.cpp(688) : I [041c] Request::WaitForReply(header_return=0012F3CC, packet_id=97)

23:49:39.053 packets.cpp(699) : I [041c] WaitForReply loop

23:49:39.053 packets.cpp(701) : I [041c] Waiting for reply with id 97 and timeout 2

23:49:39.053 packets.cpp(827) : I [041c] Request::Receive(h = 0012F20C, timeout=2)
23:49:39.053 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:39.053 packets.cpp(851) : I [041c] Got 95 bytes from connection->Receive
23:49:39.053 packets.cpp(954) : I [041c] Got a PSOH
23:49:39.053 packets.cpp(998) : I [041c] Got packet length: 84 bytes.

23:49:39.053 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:39.053 packets.cpp(1041) : I [041c] CRC is good.

23:49:39.053 packets.cpp(911) : I [041c] We got a valid packet!
23:49:39.053 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:39.053 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:39.053 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:39.053 packets.cpp(704) : I [041c] Receive result was 0

23:49:39.053 packets.cpp(784) : I [041c] Got a response to packet 97
23:49:39.053 packets.cpp(790) : I [041c] We have a progress reply.
23:49:39.053 packets.cpp(796) : I [041c] Progress reply, new timeout is 2
23:49:39.053 packets.cpp(699) : I [041c] WaitForReply loop

23:49:39.053 packets.cpp(701) : I [041c] Waiting for reply with id 97 and timeout 2

23:49:39.053 packets.cpp(827) : I [041c] Request::Receive(h = 0012F20C, timeout=2)
23:49:39.053 packets.cpp(840) : I [041c] Trying to receive bytes.

23:49:39.069 packets.cpp(851) : I [041c] Got 23 bytes from connection->Receive
23:49:39.069 packets.cpp(954) : I [041c] Got a PSOH
23:49:39.069 packets.cpp(998) : I [041c] Got packet length: 12 bytes.

23:49:39.069 packets.cpp(1018) : I [041c] We've read all the data we were expecting, reading CRC.

23:49:39.069 packets.cpp(1041) : I [041c] CRC is good.

23:49:39.069 packets.cpp(911) : I [041c] We got a valid packet!
23:49:39.069 packets.cpp(916) : I [041c] End of packet, pushing back 0 bytes
23:49:39.069 packets.cpp(928) : I [041c] Processing complete: result is 0
23:49:39.069 packets.cpp(929) : I [041c] Request::Receive(D) = 0x0
23:49:39.069 packets.cpp(704) : I [041c] Receive result was 0

23:49:39.069 packets.cpp(784) : I [041c] Got a response to packet 97
23:49:39.069 packets.cpp(810) : I [041c] Got a real reply.

23:49:39.069 packets.cpp(814) : I [041c] Packet::WaitForReply(G) = 0x6
23:49:39.069 DatabaseSyncProtocolObserver.cpp(92) : I [041c] PlaylistProtocolObserver::ReportProgress(client=00C5AAD0,

After switching my port from 100 to 10 mbps full duplex

I believe it also need to be set to half-duplex. This would probably explain why you can see it (the simple ping manages to work it's way back and forth), but the second you start trying to get a decent amount of data, the empeg runs into a problem with full-duplex.