[Support] Djoss - CrashPlan PRO (aka CrashPlan for Small Business)


Recommended Posts

9 hours ago, cromwell said:

 

Yes, however yesterday it did something different. It managed to finish the block sync and started backing up files again (yay!). but after maybe 60 minutes it started doing a block sync again and has been doing it since

Try reaching out to CrashPlan customer support. They were able to help me when I had a similar problem.

  • Like 1
Link to comment

My Crashplan has not been backing up for the past 3 days.

It states "Unable to connect to destination for 3.3 days"

ui.log shows...
 

2022-06-01T12:37:23.525Z - info: Retrying communication with service connect ECONNREFUSED 127.0.0.1:4244 attempt 15
2022-06-01T12:37:24.529Z - info: Retrying communication with service connect ECONNREFUSED 127.0.0.1:4244 attempt 16
2022-06-01T12:37:25.533Z - info: Retrying communication with service connect ECONNREFUSED 127.0.0.1:4244 attempt 17
2022-06-01T12:37:26.537Z - info: Retrying communication with service connect ECONNREFUSED 127.0.0.1:4244 attempt 18
2022-06-01T12:37:27.540Z - info: Retrying communication with service connect ECONNREFUSED 127.0.0.1:4244 attempt 19
2022-06-01T12:37:29.370Z - info: Setting locale after receiving loginSetup to AUTOMATIC_LOCALE
2022-06-01T12:37:29.372Z - info: Connected to service, show main window
2022-06-01T12:37:30.371Z - info: Closing splash screen
2022-06-01T12:37:30.338Z - info JS Console: Init browser console logging
2022-06-01T12:37:30.339Z - info main: Starting application initialization
2022-06-01T12:37:30.345Z - info ServiceInterface: init() with https://127.0.0.1:4244
2022-06-01T12:37:30.374Z - info: Showing main window
2022-06-01T12:37:30.342Z - info main: Initialized ipc listeners to main process
2022-06-01T12:37:30.344Z - info main: Initialized push event interface to service
2022-06-01T12:37:30.345Z - info main: Initialized https interface to service
2022-06-01T12:37:30.376Z - info main: Performed localization loading, attempting to connect to the service
2022-06-01T12:37:30.589Z - info main: Connected to the service
2022-06-01T12:37:30.589Z - info main: Attempting to fetch customizations for un-authenticated state
2022-06-01T12:37:30.591Z - info main: System locale en_US did not match the locale returned from the service AUTOMATIC_LOCALE, requesting the correct locale
2022-06-01T12:37:30.629Z - info main: Attempting to auto-login
2022-06-01T12:37:30.630Z - info main: A token is available, test if the token is valid
2022-06-01T12:37:30.639Z - info main: Auto login - token is valid
2022-06-01T12:37:30.639Z - info main: Authenticate with push event interface and set logged in state
2022-06-01T12:37:30.639Z - info main: Requesting initial application data
2022-06-01T12:37:30.639Z - info AppInit: Set application state to be logged in
2022-06-01T12:37:30.645Z - info AppInit: Register authenticated event handlers
2022-06-01T12:37:30.645Z - info AppInit: Requesting all application initialization data
2022-06-01T12:37:30.815Z - info main: Starting main routing
2022-06-01T12:37:30.822Z - warn JS Console: Attempting to access localized key before initialization.
2022-06-01T12:37:30.822Z - warn JS Console: Attempting to access localized key before initialization.
2022-06-01T12:37:30.822Z - warn JS Console: Attempting to access localized key before initialization.
2022-06-01T12:37:31.089Z - info routes.js: onChange: previousPath=/devices/612667590995083266 with params={"deviceId":"612667590995083266"}
2022-06-01T12:37:31.278Z - warn RestAdapter: Error making service request to https://127.0.0.1:4244/v1/CustomDataKey : Bad Request
2022-06-01T12:37:31.089Z - info routes.js: onChange: nextPath=/devices/612667590995083266 with params={"deviceId":"612667590995083266"}



engine.error.log shows this, not sure if it's related...

 

WARNING: Illegal reflective access by com.code42.crypto.jce.ec.EcCurveLookup (file:/usr/local/crashplan/lib/c42-crypto-impl-15.2.4.jar) to method sun.security.util.CurveDB.lookup(java.security.spec.ECParameterSpec)
WARNING: Please consider reporting this to the maintainers of com.code42.crypto.jce.ec.EcCurveLookup
WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations
WARNING: All illegal access operations will be denied in a future release


Any Ideas?

 

Link to comment
On 6/1/2022 at 8:51 AM, NeoDude said:

My Crashplan has not been backing up for the past 3 days.

It states "Unable to connect to destination for 3.3 days"

ui.log shows...
 

2022-06-01T12:37:23.525Z - info: Retrying communication with service connect ECONNREFUSED 127.0.0.1:4244 attempt 15
2022-06-01T12:37:24.529Z - info: Retrying communication with service connect ECONNREFUSED 127.0.0.1:4244 attempt 16
2022-06-01T12:37:25.533Z - info: Retrying communication with service connect ECONNREFUSED 127.0.0.1:4244 attempt 17
2022-06-01T12:37:26.537Z - info: Retrying communication with service connect ECONNREFUSED 127.0.0.1:4244 attempt 18
2022-06-01T12:37:27.540Z - info: Retrying communication with service connect ECONNREFUSED 127.0.0.1:4244 attempt 19
2022-06-01T12:37:29.370Z - info: Setting locale after receiving loginSetup to AUTOMATIC_LOCALE
2022-06-01T12:37:29.372Z - info: Connected to service, show main window
2022-06-01T12:37:30.371Z - info: Closing splash screen
2022-06-01T12:37:30.338Z - info JS Console: Init browser console logging
2022-06-01T12:37:30.339Z - info main: Starting application initialization
2022-06-01T12:37:30.345Z - info ServiceInterface: init() with https://127.0.0.1:4244
2022-06-01T12:37:30.374Z - info: Showing main window
2022-06-01T12:37:30.342Z - info main: Initialized ipc listeners to main process
2022-06-01T12:37:30.344Z - info main: Initialized push event interface to service
2022-06-01T12:37:30.345Z - info main: Initialized https interface to service
2022-06-01T12:37:30.376Z - info main: Performed localization loading, attempting to connect to the service
2022-06-01T12:37:30.589Z - info main: Connected to the service
2022-06-01T12:37:30.589Z - info main: Attempting to fetch customizations for un-authenticated state
2022-06-01T12:37:30.591Z - info main: System locale en_US did not match the locale returned from the service AUTOMATIC_LOCALE, requesting the correct locale
2022-06-01T12:37:30.629Z - info main: Attempting to auto-login
2022-06-01T12:37:30.630Z - info main: A token is available, test if the token is valid
2022-06-01T12:37:30.639Z - info main: Auto login - token is valid
2022-06-01T12:37:30.639Z - info main: Authenticate with push event interface and set logged in state
2022-06-01T12:37:30.639Z - info main: Requesting initial application data
2022-06-01T12:37:30.639Z - info AppInit: Set application state to be logged in
2022-06-01T12:37:30.645Z - info AppInit: Register authenticated event handlers
2022-06-01T12:37:30.645Z - info AppInit: Requesting all application initialization data
2022-06-01T12:37:30.815Z - info main: Starting main routing
2022-06-01T12:37:30.822Z - warn JS Console: Attempting to access localized key before initialization.
2022-06-01T12:37:30.822Z - warn JS Console: Attempting to access localized key before initialization.
2022-06-01T12:37:30.822Z - warn JS Console: Attempting to access localized key before initialization.
2022-06-01T12:37:31.089Z - info routes.js: onChange: previousPath=/devices/612667590995083266 with params={"deviceId":"612667590995083266"}
2022-06-01T12:37:31.278Z - warn RestAdapter: Error making service request to https://127.0.0.1:4244/v1/CustomDataKey : Bad Request
2022-06-01T12:37:31.089Z - info routes.js: onChange: nextPath=/devices/612667590995083266 with params={"deviceId":"612667590995083266"}



engine.error.log shows this, not sure if it's related...

 

WARNING: Illegal reflective access by com.code42.crypto.jce.ec.EcCurveLookup (file:/usr/local/crashplan/lib/c42-crypto-impl-15.2.4.jar) to method sun.security.util.CurveDB.lookup(java.security.spec.ECParameterSpec)
WARNING: Please consider reporting this to the maintainers of com.code42.crypto.jce.ec.EcCurveLookup
WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations
WARNING: All illegal access operations will be denied in a future release


Any Ideas?
 

 

Check in service.log.0 instead.

Link to comment
1 hour ago, Djoss said:

 

Check in service.log.0 instead.


Just this repeating...

 

[06.02.22 18:55:58.587 INFO  re-event-2-1 .handler.ChannelLifecycleHandler] SABRE:: Channel became inactive. closedBy=THIS_SIDE, channel=[id: 0xf4a74296], sessionState=RemotePeer-[guid=4200, state=CONNECTING]; Session-[localID=1062744289189997773, remoteID=0, closed=false, expiration=null, remoteIdentity=ENDPOINT, local=null, remote=null]
[06.02.22 18:55:58.587 INFO  re-event-2-1                      SabreLogger] Channel failed to reach state for app protocol start. reason=javax.net.ssl.SSLHandshakeException: SslHandler removed before handshake completed, channel=[id: 0xf4a74296]
[06.02.22 18:57:06.798 INFO  DefaultGroup .code42.messaging.peer.PeerGroup] PG::DefaultGroup DONE Managing connected remote peers. numConnected=1, numFailedConnectedCheck=0, duration(ms)=0

 

Link to comment
On 6/2/2022 at 2:03 PM, NeoDude said:


Just this repeating...

 

[06.02.22 18:55:58.587 INFO  re-event-2-1 .handler.ChannelLifecycleHandler] SABRE:: Channel became inactive. closedBy=THIS_SIDE, channel=[id: 0xf4a74296], sessionState=RemotePeer-[guid=4200, state=CONNECTING]; Session-[localID=1062744289189997773, remoteID=0, closed=false, expiration=null, remoteIdentity=ENDPOINT, local=null, remote=null]
[06.02.22 18:55:58.587 INFO  re-event-2-1                      SabreLogger] Channel failed to reach state for app protocol start. reason=javax.net.ssl.SSLHandshakeException: SslHandler removed before handshake completed, channel=[id: 0xf4a74296]
[06.02.22 18:57:06.798 INFO  DefaultGroup .code42.messaging.peer.PeerGroup] PG::DefaultGroup DONE Managing connected remote peers. numConnected=1, numFailedConnectedCheck=0, duration(ms)=0

 

 

I assume the container image is up-to-date ?

 

You can also try to re-login: double click on the Code42 logo and enter the "deauthorize" command.

Link to comment
On 6/6/2022 at 10:12 PM, Djoss said:

 

I assume the container image is up-to-date ?

 

You can also try to re-login: double click on the Code42 logo and enter the "deauthorize" command.

You assume correctly :)

I'm now logged out and it won't let me log back in. "Unable to sign in. Can't connect to server"

😕

Link to comment
On 6/8/2022 at 5:10 AM, NeoDude said:

You assume correctly :)

I'm now logged out and it won't let me log back in. "Unable to sign in. Can't connect to server"

😕

What are the errors now in service.log.0 ?

Link to comment
On 6/10/2022 at 5:44 PM, Djoss said:

What are the errors now in service.log.0 ?


 

[06.13.22 07:34:10.870 INFO  er1WeDftWkr0 ging.direct.DirectNetworkChannel] Channel became inactive. closedBy=THIS_SIDE, reason='Session close', channel=DIRECT
[06.13.22 07:34:12.869 INFO  re-event-2-1 abre.SabrePendingChannelListener] SABRE::Channel connect failed for guid 4200, cause=java.net.UnknownHostException: central.crashplanpro.com
[06.13.22 07:34:12.869 INFO  re-event-2-1 .handler.ChannelLifecycleHandler] SABRE:: Channel became inactive. closedBy=THIS_SIDE, channel=[id: 0xcc3fd3a9], sessionState=RemotePeer-[guid=4200, state=CONNECTING]; Session-[localID=1064270167411230650, remoteID=0, closed=false, expiration=null, remoteIdentity=ENDPOINT, local=null, remote=null]
[06.13.22 07:34:12.870 INFO  re-event-2-1                      SabreLogger] Channel failed to reach state for app protocol start. reason=javax.net.ssl.SSLHandshakeException: SslHandler removed before handshake completed, channel=[id: 0xcc3fd3a9]
[06.13.22 07:34:31.891 INFO  re-event-2-2 abre.SabrePendingChannelListener] SABRE::Channel connect failed for guid 4200, cause=java.net.UnknownHostException: central.crashplanpro.com
[06.13.22 07:34:31.891 INFO  re-event-2-2 .handler.ChannelLifecycleHandler] SABRE:: Channel became inactive. closedBy=THIS_SIDE, channel=[id: 0x6153b7cb], sessionState=RemotePeer-[guid=4200, state=CONNECTING]; Session-[localID=1064270199321495482, remoteID=0, closed=false, expiration=null, remoteIdentity=ENDPOINT, local=null, remote=null]
[06.13.22 07:34:31.891 INFO  re-event-2-2                      SabreLogger] Channel failed to reach state for app protocol start. reason=javax.net.ssl.SSLHandshakeException: SslHandler removed before handshake completed, channel=[id: 0x6153b7cb]
[06.13.22 07:34:33.893 INFO  re-event-2-3 abre.SabrePendingChannelListener] SABRE::Channel connect failed for guid 4200, cause=java.net.UnknownHostException: central.crashplanpro.com
[06.13.22 07:34:33.893 INFO  re-event-2-3 .handler.ChannelLifecycleHandler] SABRE:: Channel became inactive. closedBy=THIS_SIDE, channel=[id: 0x9697aaa7], sessionState=RemotePeer-[guid=4200, state=CONNECTING]; Session-[localID=1064270202676938682, remoteID=0, closed=false, expiration=null, remoteIdentity=ENDPOINT, local=null, remote=null]
[06.13.22 07:34:33.893 INFO  re-event-2-3                      SabreLogger] Channel failed to reach state for app protocol start. reason=javax.net.ssl.SSLHandshakeException: SslHandler removed before handshake completed, channel=[id: 0x9697aaa7]

 

Link to comment
5 hours ago, NeoDude said:


 

[06.13.22 07:34:10.870 INFO  er1WeDftWkr0 ging.direct.DirectNetworkChannel] Channel became inactive. closedBy=THIS_SIDE, reason='Session close', channel=DIRECT
[06.13.22 07:34:12.869 INFO  re-event-2-1 abre.SabrePendingChannelListener] SABRE::Channel connect failed for guid 4200, cause=java.net.UnknownHostException: central.crashplanpro.com
[06.13.22 07:34:12.869 INFO  re-event-2-1 .handler.ChannelLifecycleHandler] SABRE:: Channel became inactive. closedBy=THIS_SIDE, channel=[id: 0xcc3fd3a9], sessionState=RemotePeer-[guid=4200, state=CONNECTING]; Session-[localID=1064270167411230650, remoteID=0, closed=false, expiration=null, remoteIdentity=ENDPOINT, local=null, remote=null]
[06.13.22 07:34:12.870 INFO  re-event-2-1                      SabreLogger] Channel failed to reach state for app protocol start. reason=javax.net.ssl.SSLHandshakeException: SslHandler removed before handshake completed, channel=[id: 0xcc3fd3a9]
[06.13.22 07:34:31.891 INFO  re-event-2-2 abre.SabrePendingChannelListener] SABRE::Channel connect failed for guid 4200, cause=java.net.UnknownHostException: central.crashplanpro.com
[06.13.22 07:34:31.891 INFO  re-event-2-2 .handler.ChannelLifecycleHandler] SABRE:: Channel became inactive. closedBy=THIS_SIDE, channel=[id: 0x6153b7cb], sessionState=RemotePeer-[guid=4200, state=CONNECTING]; Session-[localID=1064270199321495482, remoteID=0, closed=false, expiration=null, remoteIdentity=ENDPOINT, local=null, remote=null]
[06.13.22 07:34:31.891 INFO  re-event-2-2                      SabreLogger] Channel failed to reach state for app protocol start. reason=javax.net.ssl.SSLHandshakeException: SslHandler removed before handshake completed, channel=[id: 0x6153b7cb]
[06.13.22 07:34:33.893 INFO  re-event-2-3 abre.SabrePendingChannelListener] SABRE::Channel connect failed for guid 4200, cause=java.net.UnknownHostException: central.crashplanpro.com
[06.13.22 07:34:33.893 INFO  re-event-2-3 .handler.ChannelLifecycleHandler] SABRE:: Channel became inactive. closedBy=THIS_SIDE, channel=[id: 0x9697aaa7], sessionState=RemotePeer-[guid=4200, state=CONNECTING]; Session-[localID=1064270202676938682, remoteID=0, closed=false, expiration=null, remoteIdentity=ENDPOINT, local=null, remote=null]
[06.13.22 07:34:33.893 INFO  re-event-2-3                      SabreLogger] Channel failed to reach state for app protocol start. reason=javax.net.ssl.SSLHandshakeException: SslHandler removed before handshake completed, channel=[id: 0x9697aaa7]

 

 

Looks like a network issue.  Can you run the following command to see if the DNS resolution works from the container:

 

docker exec CrashPlanPRO nslookup central.crashplanpro.com

 

Link to comment
27 minutes ago, Djoss said:

 

Looks like a network issue.  Can you run the following command to see if the DNS resolution works from the container:

 

docker exec CrashPlanPRO nslookup central.crashplanpro.com

 


Nope. Says no servers can be found. But the same lookup done directly from UnRaid or my PfSense box works fine.

 

Edited by NeoDude
Link to comment
2 minutes ago, NeoDude said:


Nope. Says no servers can be found. But the same lookup done directly from UnRaid or my PfSense box works fine.

 

How did you configure the container ?  Are you using the default Bridge network mode ?

Link to comment

Ok, I fixed it. The issue was due to the fact I had a Static IP mapping entry for the Container in PfSense. The MAC address must've changed (possibly when I changed from MACVLAN to IPVLAN?). Deleted it and all is good with the world.

Thanks for steering me in the right direction :)

Link to comment
  • 1 month later...

Join the conversation

You can post now and register later. If you have an account, sign in now to post with your account.
Note: Your post will require moderator approval before it will be visible.

Guest
Reply to this topic...

×   Pasted as rich text.   Restore formatting

  Only 75 emoji are allowed.

×   Your link has been automatically embedded.   Display as a link instead

×   Your previous content has been restored.   Clear editor

×   You cannot paste images directly. Upload or insert images from URL.