[niceonedave]

Thanks for the response:

The app is compatible with the device as we have succesfully installed it over USB using javaloader.

We have been testing with multiple devices many fresh out of the box, so no previous version of the app has ever been installed on it.

We have also been wiping and reactivating devices a lot and still no luck. Only this model (8900) gives us problems, when we try a different model it works fine.

What sort of things should we be looking out for in the log? I have checked them and I see no obvious errors.

Here is a snippet of the log that should include the time when I tried doing Deploy Applications:

[40000] (08/17 16:15:46.235):{0xD94} {chriso@test.beatsystems.com, PIN=20F27472, UserId=2}RequestHandler::DoWork - Completed Processing NEW_MESSAGE request
[40000] (08/17 16:16:46.220):{0xD7C} [BIPP] Ping 16079 sent
[40000] (08/17 16:16:46.220):{0xD78} [BIPP] PingResponse 16079 received
[40000] (08/17 16:17:46.236):{0xD7C} [BIPP] Ping 16080 sent
[40000] (08/17 16:17:46.236):{0xD78} [BIPP] PingResponse 16080 received
[40000] (08/17 16:18:46.252):{0xD7C} [BIPP] Ping 16081 sent
[40000] (08/17 16:18:46.252):{0xD78} [BIPP] PingResponse 16081 received
[45050] (08/17 16:19:18.752):{0xD9C} DBNS: DbObject=500
[40000] (08/17 16:19:19.752):{0xFDC} {chriso@test.beatsystems.com, PIN=20F27472, UserId=2}SCS::PollDBQueueNewRequests - Queuing POLL_FOR_MISSING_APPS request
[45050] (08/17 16:19:19.846):{0xD9C} DBNS: DbObject=500
[40000] (08/17 16:19:29.643):{0xD88} RequestHandler::PollForMissingApps: Starting Poll For Missing Apps.
[40304] (08/17 16:19:29.643):{0xD84} WorkerThreadPool:: ThreadProc(): Thread released with empty queue
[40000] (08/17 16:19:29.643):{0xD88} SCS::RemoveAppDeliveryRequests - No App Delivery Requests purged for User id 2
[40000] (08/17 16:19:32.174):{0xD88} RequestHandler::PollForMissingApps: Completed Poll For Missing Apps, elapsed time 2.516 seconds.
[45050] (08/17 16:19:32.190):{0xD9C} DBNS: DbObject=500
[40000] (08/17 16:19:46.268):{0xD7C} [BIPP] Ping 16082 sent
[40000] (08/17 16:19:46.268):{0xD78} [BIPP] PingResponse 16082 received
[40000] (08/17 16:20:46.268):{0xD7C} [BIPP] Ping 16083 sent
[40000] (08/17 16:20:46.268):{0xD78} [BIPP] PingResponse 16083 received
[40000] (08/17 16:21:46.269):{0xD7C} [BIPP] Ping 16084 sent
[40000] (08/17 16:21:46.269):{0xD78} [BIPP] PingResponse 16084 received
[45050] (08/17 16:21:53.378):{0xD9C} DBNS: DbObject=800
[40000] (08/17 16:22:35.769):{0xD98} RequestHandler::DoWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (08/17 16:22:35.785):{0xD98} RequestHandler::DoWork - Completed Processing CHECK_FOR_USERCONFIG_CHANGES request
[40304] (08/17 16:22:35.785):{0xD98} WorkerThreadPool:: ThreadProc(): Thread released with empty queue
[40000] (08/17 16:22:46.269):{0xD7C} [BIPP] Ping 16085 sent
[40000] (08/17 16:22:46.269):{0xD78} [BIPP] PingResponse 16085 received
[45050] (08/17 16:22:49.238):{0xD9C} DBNS: DbObject=800
[45050] (08/17 16:23:11.644):{0xD9C} DBNS: DbObject=800
[40000] (08/17 16:23:28.769):{0xD98} RequestHandler::DoWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (08/17 16:23:28.801):{0xD98} {chriso@test.beatsystems.com, PIN=20F27472, UserId=2}SCS::CheckDBforITPolicyChanges - Queuing SET_ITPOLICY_REQUEST request, ITPolicyId 1
[40000] (08/17 16:23:28.832):{0xD98} RequestHandler::DoWork - Completed Processing CHECK_FOR_USERCONFIG_CHANGES request
[40304] (08/17 16:23:28.832):{0xD98} WorkerThreadPool:: ThreadProc(): Thread released with empty queue
[45050] (08/17 16:23:28.910):{0xD9C} DBNS: DbObject=500
[45050] (08/17 16:23:29.910):{0xD9C} DBNS: DbObject=500
[40000] (08/17 16:23:29.926):{0xFDC} {chriso@test.beatsystems.com, PIN=20F27472, UserId=2}SCS::PollDBQueueNewRequests - Queuing SET_ITPOLICY_REQUEST request
[45050] (08/17 16:23:33.660):{0xD9C} DBNS: DbObject=800
[40000] (08/17 16:23:34.660):{0xD8C} {chriso@test.beatsystems.com, PIN=20F27472, UserId=2}RequestHandler::DoWork - Processing SET_ITPOLICY_REQUEST request
[40304] (08/17 16:23:34.660):{0xD90} WorkerThreadPool:: ThreadProc(): Thread released with empty queue
[45050] (08/17 16:23:34.660):{0xD9C} DBNS: DbObject=500
[40000] (08/17 16:23:34.676):{0xD8C} {chriso@test.beatsystems.com, PIN=20F27472, UserId=2}RequestHandler::SendToRelay - SubmitToRelaySendQ, Tag=1452
[40000] (08/17 16:23:34.676):{0xD7C} [BIPP] Send cancel, Tag=1452
[30000] (08/17 16:23:34.691):{0xD8C} {chriso@test.beatsystems.com, PIN=20F27472, UserId=2}RequestHandler::SendQueuedITAdminCommandT oDevice Sending data to device, contentType=ITADMIN, size=788, RefId=0, TransactionId=-897930499, Tag=1453
[40000] (08/17 16:23:34.691):{0xD8C} {chriso@test.beatsystems.com, PIN=20F27472, UserId=2}RequestHandler::SendToRelay - SubmitToRelaySendQ, Tag=1453
[40000] (08/17 16:23:34.691):{0xD7C} [BIPP] Send data, Tag=1453
[40000] (08/17 16:23:34.691):{0xD8C} {chriso@test.beatsystems.com, PIN=20F27472, UserId=2}RequestHandler::DoWork - Completed Processing SET_ITPOLICY_REQUEST request
[45050] (08/17 16:23:34.816):{0xD9C} DBNS: DbObject=500
[40000] (08/17 16:23:36.582):{0xD78} [BIPP] Received status DELIVERED, Tag=1453
[40000] (08/17 16:23:36.582):{0xD94} {chriso@test.beatsystems.com, PIN=20F27472, UserId=2}RequestHandler::DoWork - Processing DEVICE_SEND_STATUS_EVENT request
[30000] (08/17 16:23:36.582):{0xD94} {chriso@test.beatsystems.com, PIN=20F27472, UserId=2}RequestHandler::DoDeviceSentProcessing - Message has been delivered to device, Tag=1453
[40000] (08/17 16:23:36.582):{0xD94} {chriso@test.beatsystems.com, PIN=20F27472, UserId=2}RequestHandler::DoITPolicyDeviceSentProce ssing - ITPolicy GME Receive Ack for the command SET_IT_POLICY_COMMAND - Processing packet, Tag=1453
[45050] (08/17 16:23:36.597):{0xD9C} DBNS: DbObject=500
[40000] (08/17 16:23:36.613):{0xD94} {chriso@test.beatsystems.com, PIN=20F27472, UserId=2}RequestHandler::DoWork - Completed Processing DEVICE_SEND_STATUS_EVENT request
[40000] (08/17 16:23:41.113):{0xD78} [BIPP] Received datagram, Tag=20182703
[40000] (08/17 16:23:41.113):{0xD84} {chriso@test.beatsystems.com, PIN=20F27472, UserId=2}RequestHandler::DoWork - Processing NEW_MESSAGE request
[40000] (08/17 16:23:41.113):{0xD84} {chriso@test.beatsystems.com, PIN=20F27472, UserId=2}RequestHandler::DoGMEReceiveProcessing - Receiving packet from device, size=46, TransactionId=12632148, Tag=20182703, content type=ITADMIN, cmd=0x3
[40000] (08/17 16:23:41.113):{0xD84} {chriso@test.beatsystems.com, PIN=20F27472, UserId=2}RequestHandler::HandleITADMINDataCommand - ITPolicy Success Ack for the command SET_IT_POLICY_COMMAND - Processing packet, Tag=20182703
[40000] (08/17 16:23:41.129):{0xD84} {chriso@test.beatsystems.com, PIN=20F27472, UserId=2}RequestHandler::SendToRelay - SubmitToRelaySendQ, Tag=20182703
[40000] (08/17 16:23:41.129):{0xD7C} [BIPP] Send status DATA_ACCEPTED, Tag=20182703
[40000] (08/17 16:23:41.129):{0xD84} {chriso@test.beatsystems.com, PIN=20F27472, UserId=2}RequestHandler::DoWork - Completed Processing NEW_MESSAGE request
[45050] (08/17 16:23:41.176):{0xD9C} DBNS: DbObject=500
[40000] (08/17 16:23:44.285):{0xD78} [BIPP] Received datagram, Tag=20182704
[40000] (08/17 16:23:44.285):{0xD88} {chriso@test.beatsystems.com, PIN=20F27472, UserId=2}RequestHandler::DoWork - Processing NEW_MESSAGE request
[40000] (08/17 16:23:44.285):{0xD88} {chriso@test.beatsystems.com, PIN=20F27472, UserId=2}RequestHandler::DoGMEReceiveProcessing - Receiving packet from device, size=388, TransactionId=12632150, Tag=20182704, content type=OTASL, cmd=0x3
[40000] (08/17 16:23:44.301):{0xD88} {chriso@test.beatsystems.com, PIN=20F27472, UserId=2}RequestHandler::SendToRelay - SubmitToRelaySendQ, Tag=20182704
[40000] (08/17 16:23:44.301):{0xD7C} [BIPP] Send status DATA_ACCEPTED, Tag=20182704
[40000] (08/17 16:23:44.301):{0xD88} {chriso@test.beatsystems.com, PIN=20F27472, UserId=2}RequestHandler::DoWork - Completed Processing NEW_MESSAGE request
[40000] (08/17 16:24:21.770):{0xD98} RequestHandler::DoWork - Processing CHECK_FOR_USERCONFIG_CHANGES request
[40000] (08/17 16:24:21.801):{0xD98} RequestHandler::DoWork - Completed Processing CHECK_FOR_USERCONFIG_CHANGES request
[40304] (08/17 16:24:21.801):{0xD98} WorkerThreadPool:: ThreadProc(): Thread released with empty queue
[45051] (08/17 16:24:34.098):{0xD9C} DBNS: renewed subscription, heartbeat 45957
[30181] (08/17 16:24:38.192):{0xD80} Performing system health check (BlackBerry Enterprise Server [BlackBerryPolicyServer Version 4.1.5.29] - BES [POLC] - Exchange)
[40000] (08/17 16:24:44.301):{0xD7C} [BIPP] Ping 16086 sent
[40000] (08/17 16:24:44.301):{0xD78} [BIPP] PingResponse 16086 received
[40000] (08/17 16:24:44.520):{0xD84} RequestHandler::DoWork - Processing CHECK_FLOW_CONTROL_QUEUE request
[40304] (08/17 16:24:44.520):{0xD88} WorkerThreadPool:: ThreadProc(): Thread released with empty queue
[40000] (08/17 16:25:44.317):{0xD7C} [BIPP] Ping 16087 sent