Project

General

Profile

improperly.html

reparsed log summary derived from improperly_escaped... file. - Rob Nahf, 2017-06-07 02:36

Download (176 KB)

 
1
<!DOCTYPE html>
2
<html>
3
<head>
4
<style>
5
    .gap {
6
        align-text: center;
7
        background-color: lightgray;
8
        margin-top:5px;
9
        font-family: courier;
10
      width: 90%;
11
}
12
.gDays {
13
      padding: 200px 0;
14
}
15
.gHours {
16
      padding: 100px 0;
17
}
18
.gMinutes {
19
      padding: 40px 0;
20
}
21
.gSeconds {
22
      padding: 5px 0;
23
}
24

25
.debug {
26
  width: 90%;
27
 padding: 5px 0;
28
 font-family: courier;
29
 font-size: 14px;
30
 background-color: lightblue;
31
 margin-top:5px;
32
}
33

34
.info {
35
 width: 90%;
36
 padding: 5px 0;
37
 font-family: courier;
38
 font-size: 14px;
39
 background-color: lightgreen;
40
 margin-top:5px;
41
}
42

43
.warn {
44
 width: 90%;
45
 padding: 5px 0;
46
 font-family: courier;
47
 font-size: 14px;
48
 background-color: yellow;
49
 margin-top:5px;
50
}
51

52
.error {
53
 width: 90%;
54
 padding: 5px 0;
55
 font-family: courier;
56
 font-size: 14px;
57
 background-color: pink;
58
 margin-top:5px;
59
}
60
</style>
61
</head>
62
<body>
63

    
64
<h3>Log-Level Filters:</h3>
65
<button onclick="toggleDebug()">debug</button><div class="debug">Debug visible</div>
66
<button onclick="toggleInfo()">info</button><div class="info">Info visible</div>
67
<button onclick="toggleWarn()">warn</button><div class="warn">Warn visible</div>
68
<button onclick="toggleError()">error</button><div class="error">Error visible</div>
69
<p/>
70
<hr/>
71
<script>
72
    function toggleDebug() {
73
        var matches = document.getElementsByClassName("debug");
74
        for(var line of matches){
75

76
            if (line.style.display === 'none') {
77
                line.style.display = 'block';
78
            } else {
79
                line.style.display = 'none';
80
            }
81
        }
82
    }
83

84
    function toggleInfo() {
85
        var matches = document.getElementsByClassName("info");
86
        for(var line of matches){
87

88
            if (line.style.display === 'none') {
89
                line.style.display = 'block';
90
            } else {
91
                line.style.display = 'none';
92
            }
93
        }
94
    }
95

96
    function toggleWarn() {
97
        var matches = document.getElementsByClassName("warn");
98
        for(var line of matches){
99

100
            if (line.style.display === 'none') {
101
                line.style.display = 'block';
102
            } else {
103
                line.style.display = 'none';
104
            }
105
        }
106
    }
107

108
    function toggleError() {
109
        var matches = document.getElementsByClassName("error");
110
        for(var line of matches){
111
            
112
            if (line.style.display === 'none') {
113
                line.style.display = 'block';
114
            } else {
115
                line.style.display = 'none';
116
            }
117
        }
118
    }
119
</script>
120

    
121
<div class="error">[METACAT] [ERROR] [2017-06-17 18:37:15] : D1ResourceHandler: Serializing exception with code 404: No system metadata could be found for given PID:
122
  doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 [edu.ucsb.nceas.metacat.restservice.D1ResourceHandler]
123
org.dataone.service.exceptions.NotFound: No system metadata could be found for given PID:
124
  doi:10.6067:XCV8WM1D1X_meta$v=1356819351482
125
at edu.ucsb.nceas.metacat.dataone.D1NodeService.userHasPermission(D1NodeService.java:1214)
126
at edu.ucsb.nceas.metacat.dataone.D1NodeService.isAuthorized(D1NodeService.java:1153)
127
at edu.ucsb.nceas.metacat.dataone.D1NodeService.getSystemMetadata(D1NodeService.java:782)
128
at edu.ucsb.nceas.metacat.restservice.v2.CNResourceHandler.getSystemMetadataObject(CNResourceHandler.java:644)
129
at edu.ucsb.nceas.metacat.restservice.v2.CNResourceHandler.handle(CNResourceHandler.java:188)
130
at edu.ucsb.nceas.metacat.restservice.D1RestServlet.doGet(D1RestServlet.java:76)
131
at javax.servlet.http.HttpServlet.service(HttpServlet.java:620)
132
at javax.servlet.http.HttpServlet.service(HttpServlet.java:727)
133
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:303)
134
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
135
at edu.ucsb.nceas.metacat.restservice.D1URLFilter.doFilter(D1URLFilter.java:48)
136
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241)
137
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
138
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:220)
139
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:122)
140
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:501)
141
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:170)
142
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:98)
143
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:116)
144
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:408)
145
at org.apache.coyote.ajp.AjpProcessor.process(AjpProcessor.java:193)
146
at org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:607)
147
at org.apache.tomcat.util.net.JIoEndpoint$SocketProcessor.run(JIoEndpoint.java:313)
148
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
149
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
150
at java.lang.Thread.run(Thread.java:745)
151

    
152
</div>
153
<div class="warn">[METACAT] [WARN] [2017-06-17 18:37:15] : Could not check docid for revision: doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 [edu.ucsb.nceas.metacat.EventLog]
154
edu.ucsb.nceas.metacat.McdbDocNotFoundException: the requested docid 'doi:10.6067:XCV8WM1D1X_meta$v=1356819351482' does
155
  not exist
156
at edu.ucsb.nceas.metacat.util.DocumentUtil.appendRev(DocumentUtil.java:328)
157
at edu.ucsb.nceas.metacat.EventLog.getReport(EventLog.java:288)
158
at edu.ucsb.nceas.metacat.EventLog.isDeleted(EventLog.java:395)
159
at edu.ucsb.nceas.metacat.dataone.D1NodeService.userHasPermission(D1NodeService.java:1211)
160
at edu.ucsb.nceas.metacat.dataone.D1NodeService.isAuthorized(D1NodeService.java:1153)
161
at edu.ucsb.nceas.metacat.dataone.D1NodeService.getSystemMetadata(D1NodeService.java:782)
162
at edu.ucsb.nceas.metacat.restservice.v2.CNResourceHandler.getSystemMetadataObject(CNResourceHandler.java:644)
163
at edu.ucsb.nceas.metacat.restservice.v2.CNResourceHandler.handle(CNResourceHandler.java:188)
164
at edu.ucsb.nceas.metacat.restservice.D1RestServlet.doGet(D1RestServlet.java:76)
165
at javax.servlet.http.HttpServlet.service(HttpServlet.java:620)
166
at javax.servlet.http.HttpServlet.service(HttpServlet.java:727)
167
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:303)
168
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
169
at edu.ucsb.nceas.metacat.restservice.D1URLFilter.doFilter(D1URLFilter.java:48)
170
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241)
171
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
172
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:220)
173
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:122)
174
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:501)
175
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:170)
176
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:98)
177
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:116)
178
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:408)
179
at org.apache.coyote.ajp.AjpProcessor.process(AjpProcessor.java:193)
180
at org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:607)
181
at org.apache.tomcat.util.net.JIoEndpoint$SocketProcessor.run(JIoEndpoint.java:313)
182
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
183
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
184
at java.lang.Thread.run(Thread.java:745)
185

    
186
</div>
187
<div class="warn">[METACAT] [WARN] [2017-06-17 18:37:15] : Couldn't find the local id for the pid doi:10.6067:XCV8WM1D1X_meta$v=1356819351482
188
  [edu.ucsb.nceas.metacat.dataone.D1NodeService]
189

    
190
</div>
191
<div class="warn">[METACAT] [WARN] [2017-06-17 18:37:15] : could not load system metadata for: doi:10.6067:XCV8WM1D1X_meta$v=1356819351482
192
  [edu.ucsb.nceas.metacat.dataone.hazelcast.SystemMetadataMap]
193
edu.ucsb.nceas.metacat.McdbDocNotFoundException: Could not find doi:10.6067:XCV8WM1D1X_meta$v=1356819351482
194
at edu.ucsb.nceas.metacat.IdentifierManager.getSystemMetadata(IdentifierManager.java:381)
195
at edu.ucsb.nceas.metacat.dataone.hazelcast.SystemMetadataMap.load(SystemMetadataMap.java:77)
196
at edu.ucsb.nceas.metacat.dataone.hazelcast.SystemMetadataMap.load(SystemMetadataMap.java:25)
197
at com.hazelcast.impl.concurrentmap.MapStoreWrapper.load(MapStoreWrapper.java:143)
198
at com.hazelcast.impl.ConcurrentMapManager$GetOperationHandler$GetLoader.doMapStoreOperation(ConcurrentMapManager.java:3
199
  785)
200
at com.hazelcast.impl.ConcurrentMapManager$AbstractMapStoreOperation.run(ConcurrentMapManager.java:3860)
201
at com.hazelcast.impl.executor.ParallelExecutorService$ParallelExecutorImpl$ExecutionSegment.run(ParallelExecutorService
202
  .java:212)
203
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
204
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
205
at java.lang.Thread.run(Thread.java:745)
206
at com.hazelcast.impl.ExecutorThreadFactory$1.run(ExecutorThreadFactory.java:38)
207

    
208
</div>
209
<div class="gap gDays"> TIME GAP = 30.7777430555556 days</div>
210
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 23:57:18] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
211
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
212

    
213
</div>
214
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 23:57:18] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
215
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
216

    
217
</div>
218
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 23:57:18] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
219
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
220

    
221
</div>
222
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 23:57:18] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
223
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
224

    
225
</div>
226
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 23:57:18] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
227
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
228

    
229
</div>
230
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 23:57:18] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
231

    
232
</div>
233
<div class="gap gMinutes"> TIME GAP = 15.95 minutes</div>
234
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 23:41:21] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
235
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
236

    
237
</div>
238
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 23:41:21] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
239
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
240

    
241
</div>
242
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 23:41:21] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
243
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
244

    
245
</div>
246
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 23:41:21] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
247
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
248

    
249
</div>
250
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 23:41:21] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
251
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
252

    
253
</div>
254
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 23:41:21] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
255

    
256
</div>
257
<div class="gap gMinutes"> TIME GAP = 9.2 minutes</div>
258
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 23:32:09] : (ReplicationEventListener:entryUpdated:126) Received entry updated event on the hzSystemMetadata map for pid:
259
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
260

    
261
</div>
262
<div class="gap gMinutes"> TIME GAP = 15.65 minutes</div>
263
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 23:16:30] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
264
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
265

    
266
</div>
267
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 23:16:30] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
268
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
269

    
270
</div>
271
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 23:16:30] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
272
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
273

    
274
</div>
275
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 23:16:30] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
276
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
277

    
278
</div>
279
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 23:16:30] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
280
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
281

    
282
</div>
283
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 23:16:30] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
284

    
285
</div>
286
<div class="gap gMinutes"> TIME GAP = 37.2166666666667 minutes</div>
287
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 22:39:17] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
288
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
289

    
290
</div>
291
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 22:39:17] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
292
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
293

    
294
</div>
295
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 22:39:17] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
296
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
297

    
298
</div>
299
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 22:39:17] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
300
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
301

    
302
</div>
303
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 22:39:17] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
304
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
305

    
306
</div>
307
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 22:39:17] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
308

    
309
</div>
310
<div class="gap gMinutes"> TIME GAP = 4.96666666666667 minutes</div>
311
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 22:34:19] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
312
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
313

    
314
</div>
315
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 22:34:19] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
316
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
317

    
318
</div>
319
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 22:34:19] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
320
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
321

    
322
</div>
323
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 22:34:19] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
324
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
325

    
326
</div>
327
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 22:34:19] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
328
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
329

    
330
</div>
331
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 22:34:19] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
332

    
333
</div>
334
<div class="gap gMinutes"> TIME GAP = 32.0166666666667 minutes</div>
335
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 22:02:18] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
336
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
337

    
338
</div>
339
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 22:02:18] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
340
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
341

    
342
</div>
343
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 22:02:18] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
344
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
345

    
346
</div>
347
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 22:02:18] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
348
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
349

    
350
</div>
351
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 22:02:18] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
352
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
353

    
354
</div>
355
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 22:02:18] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
356

    
357
</div>
358
<div class="gap gMinutes"> TIME GAP = 9.01666666666667 minutes</div>
359
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 21:53:17] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
360
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
361

    
362
</div>
363
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 21:53:17] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
364
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
365

    
366
</div>
367
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 21:53:17] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
368
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
369

    
370
</div>
371
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 21:53:17] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
372
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
373

    
374
</div>
375
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 21:53:17] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
376
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
377

    
378
</div>
379
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 21:53:17] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
380

    
381
</div>
382
<div class="gap gMinutes"> TIME GAP = 41.8166666666667 minutes</div>
383
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 21:11:28] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
384
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
385

    
386
</div>
387
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 21:11:28] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
388
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
389

    
390
</div>
391
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 21:11:28] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
392
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
393

    
394
</div>
395
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 21:11:28] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
396
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
397

    
398
</div>
399
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 21:11:28] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
400
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
401

    
402
</div>
403
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 21:11:28] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
404

    
405
</div>
406
<div class="gap gSeconds"> TIME GAP = 36 seconds</div>
407
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 21:10:52] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
408
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
409

    
410
</div>
411
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 21:10:52] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
412
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
413

    
414
</div>
415
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 21:10:52] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
416
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
417

    
418
</div>
419
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 21:10:52] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
420
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
421

    
422
</div>
423
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 21:10:52] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
424
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
425

    
426
</div>
427
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 21:10:52] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
428

    
429
</div>
430
<div class="gap gMinutes"> TIME GAP = 47.1166666666667 minutes</div>
431
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 20:23:45] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
432
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
433

    
434
</div>
435
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 20:23:45] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
436
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
437

    
438
</div>
439
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 20:23:45] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
440
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
441

    
442
</div>
443
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:23:45] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
444
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
445

    
446
</div>
447
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:23:45] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
448
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
449

    
450
</div>
451
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:23:45] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
452

    
453
</div>
454
<div class="gap gMinutes"> TIME GAP = 23.4833333333333 minutes</div>
455
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:16] : (SyncObjectTask:reapFutures:303) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 Returned from the Future
456
  :(3):
457

    
458
</div>
459
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 20:00:16] : (SyncObjectTask:reapFutures:297) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 SyncObjectState: FAILED
460

    
461
</div>
462
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:16] : (SyncObjectTask:reapFutures:293) trying future Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482
463

    
464
</div>
465
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 20:00:16] : (V2TransferObjectTask:call:294) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 -  exiting with
466
  callState: FAILED
467

    
468
</div>
469
<div class="error">[CN-SYNCHRONIZATION] [ERROR] [2017-05-17 20:00:16] : (SyncFailedTask:submitSynchronizationFailed:139) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 <?xml
470
  version="1.0" encoding="UTF-8"?>
471
<error detailCode="-1" errorCode="500" name="ServiceFailure">
472
<description>415: Unsupported Media Type: parser for deserializing HTML not written yet.  Providing message body:
473
&lt;!DOCTYPE html&gt;&lt;html&gt;&lt;head&gt;&lt;title&gt;Apache Tomcat/8.0.32 (Ubuntu) - Error
474
  report&lt;/title&gt;&lt;style type="text/css"&gt;H1 {font-family:Tahoma,Arial,sans-serif;color:white;background-
475
  color:#525D76;font-size:22px;} H2 {font-family:Tahoma,Arial,sans-serif;color:white;background-color:#525D76;font-
476
  size:16px;} H3 {font-family:Tahoma,Arial,sans-serif;color:white;background-color:#525D76;font-size:14px;} BODY {font-
477
  family:Tahoma,Arial,sans-serif;color:black;background-color:white;} B {font-family:Tahoma,Arial,sans-serif;color:white
478
  ;background-color:#525D76;} P {font-family:Tahoma,Arial,sans-serif;background:white;color:black;font-size:12px;}A
479
  {color : black;}A.name {color : black;}.line {height: 1px; background-color: #525D76; border: none;}&lt;/style&gt;
480
  &lt;/head&gt;&lt;body&gt;&lt;h1&gt;HTTP Status 415 - Unsupported Media Type&lt;/h1&gt;&lt;div
481
  class="line"&gt;&lt;/div&gt;&lt;p&gt;&lt;b&gt;type&lt;/b&gt; Status
482
  report&lt;/p&gt;&lt;p&gt;&lt;b&gt;message&lt;/b&gt; &lt;u&gt;Unsupported Media
483
  Type&lt;/u&gt;&lt;/p&gt;&lt;p&gt;&lt;b&gt;description&lt;/b&gt; &lt;u&gt;The server refused this request because the
484
  request entity is in a format not supported by the requested resource for the requested
485
  method.&lt;/u&gt;&lt;/p&gt;&lt;hr class="line"&gt;&lt;h3&gt;Apache Tomcat/8.0.32
486
  (Ubuntu)&lt;/h3&gt;&lt;/body&gt;&lt;/html&gt;</description>
487
</error>
488

    
489

    
490
</div>
491
<div class="warn">[CN-SYNCHRONIZATION] [WARN] [2017-05-17 20:00:16] : (SyncFailedTask:submitSynchronizationFailed:116) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 -
492
  SynchronizationFailed: detail code: 6001 id:doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 nodeId:urn:node:CNUCSB1
493
  description:Synchronization task of [PID::] doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 [::PID] failed. Cause:
494
  NotFound: Not Found
495

    
496
</div>
497
<div class="error">[CN-SYNCHRONIZATION] [ERROR] [2017-05-17 20:00:16] : (V2TransferObjectTask:call:269) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 - UnrecoverableException:
498
  doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 cn.createObject failed. - NotFound - Not Found
499
org.dataone.cn.batch.exceptions.UnrecoverableException: doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 cn.createObject
500
  failed.
501
at org.dataone.cn.batch.synchronization.tasks.V2TransferObjectTask.createObject(V2TransferObjectTask.java:815)
502
at org.dataone.cn.batch.synchronization.tasks.V2TransferObjectTask.processNewObject(V2TransferObjectTask.java:493)
503
at org.dataone.cn.batch.synchronization.tasks.V2TransferObjectTask.processTask(V2TransferObjectTask.java:426)
504
at org.dataone.cn.batch.synchronization.tasks.V2TransferObjectTask.call(V2TransferObjectTask.java:211)
505
at org.dataone.cn.batch.synchronization.tasks.V2TransferObjectTask.call(V2TransferObjectTask.java:113)
506
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
507
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
508
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
509
at java.lang.Thread.run(Thread.java:745)
510
Caused by: org.dataone.service.exceptions.NotFound: Not Found
511
at org.dataone.service.util.ExceptionHandler.deserializeXml(ExceptionHandler.java:629)
512
at org.dataone.service.util.ExceptionHandler.deserializeXmlAndThrowException(ExceptionHandler.java:517)
513
at org.dataone.service.util.ExceptionHandler.deserializeAndThrowException(ExceptionHandler.java:363)
514
at org.dataone.service.util.ExceptionHandler.deserializeAndThrowException(ExceptionHandler.java:313)
515
at org.dataone.service.util.ExceptionHandler.filterErrors(ExceptionHandler.java:107)
516
at org.dataone.client.rest.HttpMultipartRestClient.doGetRequest(HttpMultipartRestClient.java:343)
517
at org.dataone.client.rest.HttpMultipartRestClient.doGetRequest(HttpMultipartRestClient.java:328)
518
at org.dataone.client.rest.MultipartD1Node.get(MultipartD1Node.java:366)
519
at org.dataone.client.v2.impl.MultipartMNode.get(MultipartMNode.java:279)
520
at org.dataone.cn.batch.synchronization.tasks.V2TransferObjectTask.createObject(V2TransferObjectTask.java:756)
521
... 8 more
522

    
523
</div>
524
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 20:00:16] : (V2TransferObjectTask:call:234) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 -  Unlocked Pid.
525

    
526
</div>
527
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:16] : (V2TransferObjectTask:createObject:753) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 getting
528
  ScienceMetadata
529

    
530
</div>
531
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:16] : (V2TransferObjectTask:validateChecksum:830) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 entering
532
  validateChecksum...
533

    
534
</div>
535
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 20:00:16] : (V2TransferObjectTask:createObject:722) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 - Start
536
  CreateObject
537

    
538
</div>
539
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:16] : (V2TransferObjectTask:populateInitialReplicaList:543) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482
540
  Added CN as replica because formatType METADATA is not DATA
541

    
542
</div>
543
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:16] : (V2TransferObjectTask:populateInitialReplicaList:532) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 Get
544
  Object Format
545

    
546
</div>
547
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:16] : (V2TransferObjectTask:populateInitialReplicaList:528) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482
548
  Included replica for original MN
549

    
550
</div>
551
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:16] : (V2TransferObjectTask:populateInitialReplicaList:513) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482
552
  entering populateInitialReplicaList
553

    
554
</div>
555
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:16] : (V2TransferObjectTask:processNewObject:477) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 Pid is not
556
  reserved by anyone.
557

    
558
</div>
559
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:16] : (V2TransferObjectTask:processNewObject:464) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 entering
560
  processNewObject...
561

    
562
</div>
563
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:16] : (V2TransferObjectTask:resolve:690) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 PID
564
  doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 does not exist on the CN.
565

    
566
</div>
567
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:16] : (SyncObjectTask:reapFutures:303) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 Returned from the Future
568
  :(3):
569

    
570
</div>
571
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 20:00:16] : (SyncObjectTask:reapFutures:297) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 SyncObjectState: FAILED
572

    
573
</div>
574
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:16] : (SyncObjectTask:reapFutures:293) trying future Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482
575

    
576
</div>
577
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 20:00:16] : (V2TransferObjectTask:call:294) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 -  exiting with
578
  callState: FAILED
579

    
580
</div>
581
<div class="error">[D1-PROCESSING-JSVC] [ERROR] [2017-05-17 20:00:16] : (SyncFailedTask:submitSynchronizationFailed:139) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 <?xml
582
  version="1.0" encoding="UTF-8"?>
583
<error detailCode="-1" errorCode="500" name="ServiceFailure">
584
<description>415: Unsupported Media Type: parser for deserializing HTML not written yet.  Providing message body:
585
&lt;!DOCTYPE html&gt;&lt;html&gt;&lt;head&gt;&lt;title&gt;Apache Tomcat/8.0.32 (Ubuntu) - Error
586
  report&lt;/title&gt;&lt;style type="text/css"&gt;H1 {font-family:Tahoma,Arial,sans-serif;color:white;background-
587
  color:#525D76;font-size:22px;} H2 {font-family:Tahoma,Arial,sans-serif;color:white;background-color:#525D76;font-
588
  size:16px;} H3 {font-family:Tahoma,Arial,sans-serif;color:white;background-color:#525D76;font-size:14px;} BODY {font-
589
  family:Tahoma,Arial,sans-serif;color:black;background-color:white;} B {font-family:Tahoma,Arial,sans-serif;color:white
590
  ;background-color:#525D76;} P {font-family:Tahoma,Arial,sans-serif;background:white;color:black;font-size:12px;}A
591
  {color : black;}A.name {color : black;}.line {height: 1px; background-color: #525D76; border: none;}&lt;/style&gt;
592
  &lt;/head&gt;&lt;body&gt;&lt;h1&gt;HTTP Status 415 - Unsupported Media Type&lt;/h1&gt;&lt;div
593
  class="line"&gt;&lt;/div&gt;&lt;p&gt;&lt;b&gt;type&lt;/b&gt; Status
594
  report&lt;/p&gt;&lt;p&gt;&lt;b&gt;message&lt;/b&gt; &lt;u&gt;Unsupported Media
595
  Type&lt;/u&gt;&lt;/p&gt;&lt;p&gt;&lt;b&gt;description&lt;/b&gt; &lt;u&gt;The server refused this request because the
596
  request entity is in a format not supported by the requested resource for the requested
597
  method.&lt;/u&gt;&lt;/p&gt;&lt;hr class="line"&gt;&lt;h3&gt;Apache Tomcat/8.0.32
598
  (Ubuntu)&lt;/h3&gt;&lt;/body&gt;&lt;/html&gt;</description>
599
</error>
600

    
601

    
602
</div>
603
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 20:00:16] : (SyncFailedTask:submitSynchronizationFailed:116) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 -
604
  SynchronizationFailed: detail code: 6001 id:doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 nodeId:urn:node:CNUCSB1
605
  description:Synchronization task of [PID::] doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 [::PID] failed. Cause:
606
  NotFound: Not Found
607

    
608
</div>
609
<div class="error">[D1-PROCESSING-JSVC] [ERROR] [2017-05-17 20:00:16] : (V2TransferObjectTask:call:269) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 - UnrecoverableException:
610
  doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 cn.createObject failed. - NotFound - Not Found
611
org.dataone.cn.batch.exceptions.UnrecoverableException: doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 cn.createObject
612
  failed.
613
at org.dataone.cn.batch.synchronization.tasks.V2TransferObjectTask.createObject(V2TransferObjectTask.java:815)
614
at org.dataone.cn.batch.synchronization.tasks.V2TransferObjectTask.processNewObject(V2TransferObjectTask.java:493)
615
at org.dataone.cn.batch.synchronization.tasks.V2TransferObjectTask.processTask(V2TransferObjectTask.java:426)
616
at org.dataone.cn.batch.synchronization.tasks.V2TransferObjectTask.call(V2TransferObjectTask.java:211)
617
at org.dataone.cn.batch.synchronization.tasks.V2TransferObjectTask.call(V2TransferObjectTask.java:113)
618
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
619
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
620
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
621
at java.lang.Thread.run(Thread.java:745)
622
Caused by: org.dataone.service.exceptions.NotFound: Not Found
623
at org.dataone.service.util.ExceptionHandler.deserializeXml(ExceptionHandler.java:629)
624
at org.dataone.service.util.ExceptionHandler.deserializeXmlAndThrowException(ExceptionHandler.java:517)
625
at org.dataone.service.util.ExceptionHandler.deserializeAndThrowException(ExceptionHandler.java:363)
626
at org.dataone.service.util.ExceptionHandler.deserializeAndThrowException(ExceptionHandler.java:313)
627
at org.dataone.service.util.ExceptionHandler.filterErrors(ExceptionHandler.java:107)
628
at org.dataone.client.rest.HttpMultipartRestClient.doGetRequest(HttpMultipartRestClient.java:343)
629
at org.dataone.client.rest.HttpMultipartRestClient.doGetRequest(HttpMultipartRestClient.java:328)
630
at org.dataone.client.rest.MultipartD1Node.get(MultipartD1Node.java:366)
631
at org.dataone.client.v2.impl.MultipartMNode.get(MultipartMNode.java:279)
632
at org.dataone.cn.batch.synchronization.tasks.V2TransferObjectTask.createObject(V2TransferObjectTask.java:756)
633
... 8 more
634

    
635
</div>
636
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 20:00:16] : (V2TransferObjectTask:call:234) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 -  Unlocked Pid.
637

    
638
</div>
639
<div class="error">[D1-PROCESSING-JSVC] [ERROR] [2017-05-17 20:00:16] : (StdOutErrLog$2:print:51) 440886659 [SynchronizeTask7384] INFO org.dataone.client.rest.RestClient -
640
  RestClient.doRequestNoBody, thread(102757) call Info: GET
641
  https://dataone.tdar.org/dataone/v2/object/doi:10.6067:XCV8WM1D1X_meta$v=1356819351482
642

    
643

    
644
</div>
645
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:16] : (V2TransferObjectTask:createObject:753) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 getting
646
  ScienceMetadata
647

    
648
</div>
649
<div class="error">[D1-PROCESSING-JSVC] [ERROR] [2017-05-17 20:00:16] : (StdOutErrLog$2:print:51) 440886258 [SynchronizeTask7384] INFO org.dataone.client.rest.RestClient -
650
  RestClient.doRequestNoBody, thread(102757) call Info: GET
651
  https://dataone.tdar.org/dataone/v2/checksum/doi:10.6067:XCV8WM1D1X_meta$v=1356819351482?checksumAlgorithm=MD5
652

    
653

    
654
</div>
655
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:16] : (V2TransferObjectTask:validateChecksum:830) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 entering
656
  validateChecksum...
657

    
658
</div>
659
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 20:00:16] : (V2TransferObjectTask:createObject:722) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 - Start
660
  CreateObject
661

    
662
</div>
663
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:16] : (V2TransferObjectTask:populateInitialReplicaList:543) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482
664
  Added CN as replica because formatType METADATA is not DATA
665

    
666
</div>
667
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:16] : (V2TransferObjectTask:populateInitialReplicaList:532) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 Get
668
  Object Format
669

    
670
</div>
671
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:16] : (V2TransferObjectTask:populateInitialReplicaList:528) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482
672
  Included replica for original MN
673

    
674
</div>
675
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:16] : (V2TransferObjectTask:populateInitialReplicaList:513) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482
676
  entering populateInitialReplicaList
677

    
678
</div>
679
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:16] : (V2TransferObjectTask:processNewObject:477) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 Pid is not
680
  reserved by anyone.
681

    
682
</div>
683
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:16] : (V2TransferObjectTask:processNewObject:464) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 entering
684
  processNewObject...
685

    
686
</div>
687
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:16] : (V2TransferObjectTask:resolve:690) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 PID
688
  doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 does not exist on the CN.
689

    
690
</div>
691
<div class="error">[D1-PROCESSING-JSVC] [ERROR] [2017-05-17 20:00:16] : (StdOutErrLog$2:print:51) 440886054 [SynchronizeTask7384] INFO org.dataone.client.rest.RestClient -
692
  RestClient.doRequestNoBody, thread(102757) call Info: GET https://cn-
693
  ucsb-1.dataone.org/cn/v2/resolve/doi:10.6067:XCV8WM1D1X_meta$v=1356819351482
694

    
695

    
696
</div>
697
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:15] : (SyncObjectTask:reapFutures:334) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 Waiting for the future
698
  :(3): since 2017-05-01T20:00:13.509+00:00
699

    
700
</div>
701
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:15] : (SyncObjectTask:reapFutures:293) trying future Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482
702

    
703
</div>
704
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:15] : (V2TransferObjectTask:resolve:682) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 entering resolve...
705

    
706
</div>
707
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:15] : (V2TransferObjectTask:validateSeriesId:638) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 OK. SeriesId
708
  is not reserved.
709

    
710
</div>
711
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:15] : (V2TransferObjectTask:validateSeriesId:624) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 SeriesId
712
  (377505_meta) doesn't exist for any object on the CN, checking reservation service...
713

    
714
</div>
715
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:15] : (V2TransferObjectTask:resolve:690) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 SID
716
  doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 does not exist on the CN.
717

    
718
</div>
719
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:15] : (SyncObjectTask:reapFutures:303) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 Returned from the Future
720
  :(5):
721

    
722
</div>
723
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 20:00:15] : (SyncObjectTask:reapFutures:297) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 SyncObjectState: SUCCESS
724

    
725
</div>
726
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:15] : (SyncObjectTask:reapFutures:293) trying future Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
727

    
728
</div>
729
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:15] : (SyncObjectTask:reapFutures:334) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 Waiting for the future
730
  :(3): since 2017-05-01T20:00:13.509+00:00
731

    
732
</div>
733
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:15] : (SyncObjectTask:reapFutures:293) trying future Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482
734

    
735
</div>
736
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:15] : (V2TransferObjectTask:resolve:682) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 entering resolve...
737

    
738
</div>
739
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:15] : (V2TransferObjectTask:validateSeriesId:638) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 OK. SeriesId
740
  is not reserved.
741

    
742
</div>
743
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:15] : (V2TransferObjectTask:validateSeriesId:624) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 SeriesId
744
  (377505_meta) doesn't exist for any object on the CN, checking reservation service...
745

    
746
</div>
747
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:15] : (V2TransferObjectTask:resolve:690) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 SID
748
  doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 does not exist on the CN.
749

    
750
</div>
751
<div class="error">[D1-PROCESSING-JSVC] [ERROR] [2017-05-17 20:00:15] : (StdOutErrLog$2:print:51) 440885429 [SynchronizeTask7384] INFO org.dataone.client.rest.RestClient -
752
  RestClient.doRequestNoBody, thread(102757) call Info: GET https://cn-
753
  ucsb-1.dataone.org/cn/v2/resolve/doi:10.6067:XCV8WM1D1X_meta$v=1356819351482
754

    
755

    
756
</div>
757
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:15] : (SyncObjectTask:reapFutures:303) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 Returned from the Future
758
  :(5):
759

    
760
</div>
761
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 20:00:15] : (SyncObjectTask:reapFutures:297) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 SyncObjectState: SUCCESS
762

    
763
</div>
764
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:15] : (SyncObjectTask:reapFutures:293) trying future Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
765

    
766
</div>
767
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 20:00:14] : (V2TransferObjectTask:call:294) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 -  exiting with
768
  callState: SUCCESS
769

    
770
</div>
771
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 20:00:14] : (V2TransferObjectTask:call:234) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 -  Unlocked Pid.
772

    
773
</div>
774
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:14] : (V2TransferObjectTask:resolve:682) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 entering resolve...
775

    
776
</div>
777
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:14] : (V2TransferObjectTask:validateSeriesId:580) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 entering
778
  validateSeriesId...
779

    
780
</div>
781
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:14] : (V2TransferObjectTask:processTask:412) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 entering
782
  processTask...
783

    
784
</div>
785
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:14] : (V2TransferObjectTask:call:209) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 MN system metadata
786
  retrieved...
787

    
788
</div>
789
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 20:00:14] : (V2TransferObjectTask:retrieveMNSystemMetadata:317) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 -
790
  Retrieved SystemMetadata Identifier:doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 from node urn:node:TDAR for ObjectInfo
791
  Identifier doi:10.6067:XCV8WM1D1X_meta$v=1356819351482
792

    
793
</div>
794
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 20:00:14] : (V2TransferObjectTask:createObject:805) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 - Completed
795
  CreateObject
796

    
797
</div>
798
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:14] : (V2TransferObjectTask:createObject:794) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 ... CNCreate
799
  finished
800

    
801
</div>
802
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:14] : (SyncObjectTask:reapFutures:334) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 Waiting for the future
803
  :(3): since 2017-05-01T20:00:13.509+00:00
804

    
805
</div>
806
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:14] : (SyncObjectTask:reapFutures:293) trying future Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482
807

    
808
</div>
809
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:14] : (SyncObjectTask:reapFutures:334) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 Waiting for the future
810
  :(5): since 2017-05-01T20:00:04.027+00:00
811

    
812
</div>
813
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:14] : (SyncObjectTask:reapFutures:293) trying future Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
814

    
815
</div>
816
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 20:00:14] : (V2TransferObjectTask:call:294) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 -  exiting with
817
  callState: SUCCESS
818

    
819
</div>
820
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 20:00:14] : (V2TransferObjectTask:call:234) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 -  Unlocked Pid.
821

    
822
</div>
823
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:14] : (V2TransferObjectTask:resolve:682) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 entering resolve...
824

    
825
</div>
826
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:14] : (V2TransferObjectTask:validateSeriesId:580) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 entering
827
  validateSeriesId...
828

    
829
</div>
830
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:14] : (V2TransferObjectTask:processTask:412) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 entering
831
  processTask...
832

    
833
</div>
834
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:14] : (V2TransferObjectTask:call:209) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 MN system metadata
835
  retrieved...
836

    
837
</div>
838
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 20:00:14] : (V2TransferObjectTask:retrieveMNSystemMetadata:317) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 -
839
  Retrieved SystemMetadata Identifier:doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 from node urn:node:TDAR for ObjectInfo
840
  Identifier doi:10.6067:XCV8WM1D1X_meta$v=1356819351482
841

    
842
</div>
843
<div class="error">[D1-PROCESSING-JSVC] [ERROR] [2017-05-17 20:00:14] : (StdOutErrLog$2:print:51) 440884772 [SynchronizeTask7384] INFO org.dataone.client.rest.RestClient -
844
  RestClient.doRequestNoBody, thread(102757) call Info: GET
845
  https://dataone.tdar.org/dataone/v2/meta/doi:10.6067:XCV8WM1D1X_meta$v=1356819351482
846

    
847

    
848
</div>
849
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 20:00:14] : (V2TransferObjectTask:createObject:805) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 - Completed
850
  CreateObject
851

    
852
</div>
853
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:14] : (V2TransferObjectTask:createObject:794) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 ... CNCreate
854
  finished
855

    
856
</div>
857
<div class="error">[D1-PROCESSING-JSVC] [ERROR] [2017-05-17 20:00:14] : (StdOutErrLog$2:print:51) 440884758 [SynchronizeTask7381] INFO org.dataone.client.rest.RestClient -
858
  RestClient.doRequestMMPBody, thread(102738) call Info: POST https://cn-ucsb-1.dataone.org/cn/v2/object; MMP message
859
  has: ParamPart:pid = doi:10.6067:XCV8WM1D1X_meta$v=1493667645608; FilePart:object =
860
  /tmp/mmp.output.6511241267508104030.tmp (2485 bytes); FilePart:sysmeta = /tmp/mmp.output.458160030191918558.tmp (1604
861
  bytes);
862

    
863

    
864
</div>
865
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:14] : (SyncObjectTask:reapFutures:334) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 Waiting for the future
866
  :(3): since 2017-05-01T20:00:13.509+00:00
867

    
868
</div>
869
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:14] : (SyncObjectTask:reapFutures:293) trying future Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482
870

    
871
</div>
872
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:14] : (SyncObjectTask:reapFutures:334) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 Waiting for the future
873
  :(5): since 2017-05-01T20:00:04.027+00:00
874

    
875
</div>
876
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:14] : (SyncObjectTask:reapFutures:293) trying future Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
877

    
878
</div>
879
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 20:00:13] : (V2TransferObjectTask:call:207) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 -  Processing SyncObject
880

    
881
</div>
882
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 20:00:13] : (V2TransferObjectTask:call:202) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 -  Locking task, attempt
883
  1
884

    
885
</div>
886
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 20:00:13] : (SyncObjectTask:executeTransferObjectTask:236) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 submitted
887
  for execution
888

    
889
</div>
890
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 20:00:13] : (SyncObjectTask:executeTransferObjectTask:219) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 received
891

    
892
</div>
893
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:13] : (SyncObjectTask:reapFutures:334) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 Waiting for the future
894
  :(5): since 2017-05-01T20:00:04.027+00:00
895

    
896
</div>
897
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:13] : (SyncObjectTask:reapFutures:293) trying future Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
898

    
899
</div>
900
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 20:00:13] : (ReplicationEventListener:entryAdded:104) Received entry added event on the hzSystemMetadata map for pid:
901
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
902

    
903
</div>
904
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 20:00:13] : (V2TransferObjectTask:call:207) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 -  Processing SyncObject
905

    
906
</div>
907
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 20:00:13] : (V2TransferObjectTask:call:202) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 -  Locking task, attempt
908
  1
909

    
910
</div>
911
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 20:00:13] : (SyncObjectTask:executeTransferObjectTask:236) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 submitted
912
  for execution
913

    
914
</div>
915
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 20:00:13] : (SyncObjectTask:executeTransferObjectTask:219) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 received
916

    
917
</div>
918
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:13] : (SyncObjectTask:reapFutures:334) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 Waiting for the future
919
  :(5): since 2017-05-01T20:00:04.027+00:00
920

    
921
</div>
922
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:13] : (SyncObjectTask:reapFutures:293) trying future Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
923

    
924
</div>
925
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:11] : (SyncObjectTask:reapFutures:334) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 Waiting for the future
926
  :(5): since 2017-05-01T20:00:04.027+00:00
927

    
928
</div>
929
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:11] : (V2TransferObjectTask:createObject:790) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 Calling
930
  CNCreate...
931

    
932
</div>
933
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:11] : (SyncObjectTask:reapFutures:293) trying future Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
934

    
935
</div>
936
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:11] : (SyncObjectTask:reapFutures:334) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 Waiting for the future
937
  :(5): since 2017-05-01T20:00:04.027+00:00
938

    
939
</div>
940
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:11] : (V2TransferObjectTask:createObject:790) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 Calling
941
  CNCreate...
942

    
943
</div>
944
<div class="error">[D1-PROCESSING-JSVC] [ERROR] [2017-05-17 20:00:11] : (StdOutErrLog$2:print:51) 440881830 [SynchronizeTask7381] INFO org.dataone.client.rest.RestClient -
945
  RestClient.doRequestNoBody, thread(102738) call Info: GET
946
  https://dataone.tdar.org/dataone/v2/object/doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
947

    
948

    
949
</div>
950
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:11] : (SyncObjectTask:reapFutures:293) trying future Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
951

    
952
</div>
953
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:10] : (V2TransferObjectTask:createObject:753) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 getting
954
  ScienceMetadata
955

    
956
</div>
957
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:10] : (V2TransferObjectTask:validateChecksum:830) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 entering
958
  validateChecksum...
959

    
960
</div>
961
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 20:00:10] : (V2TransferObjectTask:createObject:722) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 - Start
962
  CreateObject
963

    
964
</div>
965
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:10] : (V2TransferObjectTask:populateInitialReplicaList:543) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
966
  Added CN as replica because formatType METADATA is not DATA
967

    
968
</div>
969
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:10] : (V2TransferObjectTask:populateInitialReplicaList:532) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 Get
970
  Object Format
971

    
972
</div>
973
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:10] : (V2TransferObjectTask:populateInitialReplicaList:528) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
974
  Included replica for original MN
975

    
976
</div>
977
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:10] : (V2TransferObjectTask:populateInitialReplicaList:513) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
978
  entering populateInitialReplicaList
979

    
980
</div>
981
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:10] : (V2TransferObjectTask:processNewObject:477) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 Pid is not
982
  reserved by anyone.
983

    
984
</div>
985
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:10] : (V2TransferObjectTask:processNewObject:464) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 entering
986
  processNewObject...
987

    
988
</div>
989
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:10] : (V2TransferObjectTask:resolve:690) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 PID
990
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 does not exist on the CN.
991

    
992
</div>
993
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:10] : (SyncObjectTask:reapFutures:334) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 Waiting for the future
994
  :(5): since 2017-05-01T20:00:04.027+00:00
995

    
996
</div>
997
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:10] : (SyncObjectTask:reapFutures:293) trying future Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
998

    
999
</div>
1000
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:10] : (V2TransferObjectTask:createObject:753) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 getting
1001
  ScienceMetadata
1002

    
1003
</div>
1004
<div class="error">[D1-PROCESSING-JSVC] [ERROR] [2017-05-17 20:00:10] : (StdOutErrLog$2:print:51) 440880808 [SynchronizeTask7381] INFO org.dataone.client.rest.RestClient -
1005
  RestClient.doRequestNoBody, thread(102738) call Info: GET
1006
  https://dataone.tdar.org/dataone/v2/checksum/doi:10.6067:XCV8WM1D1X_meta$v=1493667645608?checksumAlgorithm=MD5
1007

    
1008

    
1009
</div>
1010
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:10] : (V2TransferObjectTask:validateChecksum:830) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 entering
1011
  validateChecksum...
1012

    
1013
</div>
1014
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 20:00:10] : (V2TransferObjectTask:createObject:722) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 - Start
1015
  CreateObject
1016

    
1017
</div>
1018
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:10] : (V2TransferObjectTask:populateInitialReplicaList:543) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1019
  Added CN as replica because formatType METADATA is not DATA
1020

    
1021
</div>
1022
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:10] : (V2TransferObjectTask:populateInitialReplicaList:532) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 Get
1023
  Object Format
1024

    
1025
</div>
1026
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:10] : (V2TransferObjectTask:populateInitialReplicaList:528) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1027
  Included replica for original MN
1028

    
1029
</div>
1030
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:10] : (V2TransferObjectTask:populateInitialReplicaList:513) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1031
  entering populateInitialReplicaList
1032

    
1033
</div>
1034
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:10] : (V2TransferObjectTask:processNewObject:477) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 Pid is not
1035
  reserved by anyone.
1036

    
1037
</div>
1038
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:10] : (V2TransferObjectTask:processNewObject:464) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 entering
1039
  processNewObject...
1040

    
1041
</div>
1042
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:10] : (V2TransferObjectTask:resolve:690) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 PID
1043
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 does not exist on the CN.
1044

    
1045
</div>
1046
<div class="error">[D1-PROCESSING-JSVC] [ERROR] [2017-05-17 20:00:10] : (StdOutErrLog$2:print:51) 440880628 [SynchronizeTask7381] INFO org.dataone.client.rest.RestClient -
1047
  RestClient.doRequestNoBody, thread(102738) call Info: GET https://cn-
1048
  ucsb-1.dataone.org/cn/v2/resolve/doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1049

    
1050

    
1051
</div>
1052
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:10] : (SyncObjectTask:reapFutures:334) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 Waiting for the future
1053
  :(5): since 2017-05-01T20:00:04.027+00:00
1054

    
1055
</div>
1056
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:10] : (SyncObjectTask:reapFutures:293) trying future Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1057

    
1058
</div>
1059
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:09] : (V2TransferObjectTask:resolve:682) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 entering resolve...
1060

    
1061
</div>
1062
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:09] : (V2TransferObjectTask:validateSeriesId:638) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 OK. SeriesId
1063
  is not reserved.
1064

    
1065
</div>
1066
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:09] : (V2TransferObjectTask:validateSeriesId:624) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 SeriesId
1067
  (377505_meta) doesn't exist for any object on the CN, checking reservation service...
1068

    
1069
</div>
1070
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:09] : (V2TransferObjectTask:resolve:690) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 SID
1071
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 does not exist on the CN.
1072

    
1073
</div>
1074
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 20:00:09] : (SyncObjectTask:call:154) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 - requeueing task.
1075

    
1076
</div>
1077
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 20:00:09] : (SyncObjectTask:executeTransferObjectTask:219) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 received
1078

    
1079
</div>
1080
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:09] : (SyncObjectTask:reapFutures:334) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 Waiting for the future
1081
  :(5): since 2017-05-01T20:00:04.027+00:00
1082

    
1083
</div>
1084
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:09] : (V2TransferObjectTask:resolve:682) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 entering resolve...
1085

    
1086
</div>
1087
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:09] : (V2TransferObjectTask:validateSeriesId:580) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 entering
1088
  validateSeriesId...
1089

    
1090
</div>
1091
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:09] : (V2TransferObjectTask:processTask:412) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 entering
1092
  processTask...
1093

    
1094
</div>
1095
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:09] : (V2TransferObjectTask:call:209) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 MN system metadata
1096
  retrieved...
1097

    
1098
</div>
1099
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 20:00:09] : (V2TransferObjectTask:retrieveMNSystemMetadata:317) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 -
1100
  Retrieved SystemMetadata Identifier:doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 from node urn:node:TDAR for ObjectInfo
1101
  Identifier doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1102

    
1103
</div>
1104
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:09] : (SyncObjectTask:reapFutures:293) trying future Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1105

    
1106
</div>
1107
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:09] : (V2TransferObjectTask:resolve:682) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 entering resolve...
1108

    
1109
</div>
1110
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:09] : (V2TransferObjectTask:validateSeriesId:638) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 OK. SeriesId
1111
  is not reserved.
1112

    
1113
</div>
1114
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:09] : (V2TransferObjectTask:validateSeriesId:624) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 SeriesId
1115
  (377505_meta) doesn't exist for any object on the CN, checking reservation service...
1116

    
1117
</div>
1118
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:09] : (V2TransferObjectTask:resolve:690) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 SID
1119
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 does not exist on the CN.
1120

    
1121
</div>
1122
<div class="error">[D1-PROCESSING-JSVC] [ERROR] [2017-05-17 20:00:09] : (StdOutErrLog$2:print:51) 440879848 [SynchronizeTask7381] INFO org.dataone.client.rest.RestClient -
1123
  RestClient.doRequestNoBody, thread(102738) call Info: GET https://cn-
1124
  ucsb-1.dataone.org/cn/v2/resolve/doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1125

    
1126

    
1127
</div>
1128
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 20:00:09] : (SyncObjectTask:call:154) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 - requeueing task.
1129

    
1130
</div>
1131
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 20:00:09] : (SyncObjectTask:executeTransferObjectTask:219) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 received
1132

    
1133
</div>
1134
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:09] : (SyncObjectTask:reapFutures:334) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 Waiting for the future
1135
  :(5): since 2017-05-01T20:00:04.027+00:00
1136

    
1137
</div>
1138
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:09] : (V2TransferObjectTask:resolve:682) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 entering resolve...
1139

    
1140
</div>
1141
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:09] : (V2TransferObjectTask:validateSeriesId:580) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 entering
1142
  validateSeriesId...
1143

    
1144
</div>
1145
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:09] : (V2TransferObjectTask:processTask:412) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 entering
1146
  processTask...
1147

    
1148
</div>
1149
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:09] : (V2TransferObjectTask:call:209) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 MN system metadata
1150
  retrieved...
1151

    
1152
</div>
1153
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 20:00:09] : (V2TransferObjectTask:retrieveMNSystemMetadata:317) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 -
1154
  Retrieved SystemMetadata Identifier:doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 from node urn:node:TDAR for ObjectInfo
1155
  Identifier doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1156

    
1157
</div>
1158
<div class="error">[D1-PROCESSING-JSVC] [ERROR] [2017-05-17 20:00:09] : (StdOutErrLog$2:print:51) 440879096 [SynchronizeTask7381] INFO org.dataone.client.rest.RestClient -
1159
  RestClient.doRequestNoBody, thread(102738) call Info: GET
1160
  https://dataone.tdar.org/dataone/v2/meta/doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1161

    
1162

    
1163
</div>
1164
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:09] : (SyncObjectTask:reapFutures:293) trying future Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1165

    
1166
</div>
1167
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:07] : (SyncObjectTask:reapFutures:334) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 Waiting for the future
1168
  :(5): since 2017-05-01T20:00:04.027+00:00
1169

    
1170
</div>
1171
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:07] : (SyncObjectTask:reapFutures:293) trying future Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1172

    
1173
</div>
1174
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:07] : (SyncObjectTask:reapFutures:334) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 Waiting for the future
1175
  :(5): since 2017-05-01T20:00:04.027+00:00
1176

    
1177
</div>
1178
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:07] : (SyncObjectTask:reapFutures:293) trying future Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1179

    
1180
</div>
1181
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:06] : (SyncObjectTask:reapFutures:334) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 Waiting for the future
1182
  :(5): since 2017-05-01T20:00:04.027+00:00
1183

    
1184
</div>
1185
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:06] : (SyncObjectTask:reapFutures:293) trying future Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1186

    
1187
</div>
1188
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:06] : (SyncObjectTask:reapFutures:334) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 Waiting for the future
1189
  :(5): since 2017-05-01T20:00:04.027+00:00
1190

    
1191
</div>
1192
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:06] : (SyncObjectTask:reapFutures:293) trying future Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1193

    
1194
</div>
1195
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 20:00:05] : (SyncObjectTask:call:154) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 - requeueing task.
1196

    
1197
</div>
1198
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 20:00:05] : (SyncObjectTask:executeTransferObjectTask:219) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 received
1199

    
1200
</div>
1201
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 20:00:05] : (SyncObjectTask:call:154) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 - requeueing task.
1202

    
1203
</div>
1204
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 20:00:05] : (SyncObjectTask:executeTransferObjectTask:219) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 received
1205

    
1206
</div>
1207
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:04] : (SyncObjectTask:reapFutures:334) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 Waiting for the future
1208
  :(5): since 2017-05-01T20:00:04.027+00:00
1209

    
1210
</div>
1211
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:04] : (SyncObjectTask:reapFutures:293) trying future Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1212

    
1213
</div>
1214
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 20:00:04] : (V2TransferObjectTask:call:207) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 -  Processing SyncObject
1215

    
1216
</div>
1217
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 20:00:04] : (V2TransferObjectTask:call:202) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 -  Locking task, attempt
1218
  1
1219

    
1220
</div>
1221
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 20:00:04] : (SyncObjectTask:executeTransferObjectTask:236) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 submitted
1222
  for execution
1223

    
1224
</div>
1225
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 20:00:04] : (SyncObjectTask:executeTransferObjectTask:219) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 received
1226

    
1227
</div>
1228
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:04] : (SyncObjectTask:reapFutures:334) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 Waiting for the future
1229
  :(5): since 2017-05-01T20:00:04.027+00:00
1230

    
1231
</div>
1232
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:04] : (SyncObjectTask:reapFutures:293) trying future Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1233

    
1234
</div>
1235
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 20:00:04] : (V2TransferObjectTask:call:207) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 -  Processing SyncObject
1236

    
1237
</div>
1238
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 20:00:04] : (V2TransferObjectTask:call:202) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 -  Locking task, attempt
1239
  1
1240

    
1241
</div>
1242
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 20:00:04] : (SyncObjectTask:executeTransferObjectTask:236) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 submitted
1243
  for execution
1244

    
1245
</div>
1246
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 20:00:04] : (SyncObjectTask:executeTransferObjectTask:219) Task-urn:node:TDAR-doi:10.6067:XCV8WM1D1X_meta$v=1493667645608 received
1247

    
1248
</div>
1249
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:01] : (ObjectListHarvestTask:call:221) placed on hzSyncObjectQueue- Task-urn:node:TDAR-
1250
  doi:10.6067:XCV8WM1D1X_meta$v=1356819351482
1251

    
1252
</div>
1253
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 20:00:01] : (ObjectListHarvestTask:call:221) placed on hzSyncObjectQueue- Task-urn:node:TDAR-
1254
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1255

    
1256
</div>
1257
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:01] : (ObjectListHarvestTask:call:221) placed on hzSyncObjectQueue- Task-urn:node:TDAR-
1258
  doi:10.6067:XCV8WM1D1X_meta$v=1356819351482
1259

    
1260
</div>
1261
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 20:00:01] : (ObjectListHarvestTask:call:221) placed on hzSyncObjectQueue- Task-urn:node:TDAR-
1262
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1263

    
1264
</div>
1265
<div class="gap gMinutes"> TIME GAP = 11.3333333333333 minutes</div>
1266
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 19:48:41] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
1267
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1268

    
1269
</div>
1270
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 19:48:41] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
1271
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1272

    
1273
</div>
1274
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 19:48:41] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
1275
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1276

    
1277
</div>
1278
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 19:48:41] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
1279
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1280

    
1281
</div>
1282
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 19:48:41] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
1283
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1284

    
1285
</div>
1286
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 19:48:41] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1287

    
1288
</div>
1289
<div class="gap gMinutes"> TIME GAP = 4.88333333333333 minutes</div>
1290
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 19:43:48] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
1291
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1292

    
1293
</div>
1294
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 19:43:48] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
1295
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1296

    
1297
</div>
1298
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 19:43:48] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
1299
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1300

    
1301
</div>
1302
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 19:43:48] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
1303
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1304

    
1305
</div>
1306
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 19:43:48] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
1307
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1308

    
1309
</div>
1310
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 19:43:48] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1311

    
1312
</div>
1313
<div class="gap gMinutes"> TIME GAP = 42 minutes</div>
1314
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 19:01:48] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
1315
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1316

    
1317
</div>
1318
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 19:01:48] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
1319
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1320

    
1321
</div>
1322
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 19:01:48] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
1323
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1324

    
1325
</div>
1326
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 19:01:48] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
1327
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1328

    
1329
</div>
1330
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 19:01:48] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
1331
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1332

    
1333
</div>
1334
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 19:01:48] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1335

    
1336
</div>
1337
<div class="gap gMinutes"> TIME GAP = 15.9 minutes</div>
1338
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 18:45:54] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
1339
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1340

    
1341
</div>
1342
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 18:45:54] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
1343
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1344

    
1345
</div>
1346
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 18:45:54] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
1347
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1348

    
1349
</div>
1350
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 18:45:54] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
1351
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1352

    
1353
</div>
1354
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 18:45:54] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
1355
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1356

    
1357
</div>
1358
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 18:45:54] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1359

    
1360
</div>
1361
<div class="gap gSeconds"> TIME GAP = 23 seconds</div>
1362
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 18:45:31] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
1363
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1364

    
1365
</div>
1366
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 18:45:31] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
1367
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1368

    
1369
</div>
1370
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 18:45:31] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
1371
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1372

    
1373
</div>
1374
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 18:45:31] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
1375
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1376

    
1377
</div>
1378
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 18:45:31] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
1379
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1380

    
1381
</div>
1382
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 18:45:31] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1383

    
1384
</div>
1385
<div class="gap gMinutes"> TIME GAP = 1.71666666666667 minutes</div>
1386
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 18:43:48] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
1387
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1388

    
1389
</div>
1390
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 18:43:48] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
1391
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1392

    
1393
</div>
1394
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 18:43:48] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
1395
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1396

    
1397
</div>
1398
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 18:43:48] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
1399
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1400

    
1401
</div>
1402
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 18:43:48] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
1403
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1404

    
1405
</div>
1406
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 18:43:48] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1407

    
1408
</div>
1409
<div class="gap gMinutes"> TIME GAP = 15.35 minutes</div>
1410
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 18:28:27] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
1411
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1412

    
1413
</div>
1414
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 18:28:27] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
1415
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1416

    
1417
</div>
1418
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 18:28:27] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
1419
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1420

    
1421
</div>
1422
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 18:28:27] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
1423
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1424

    
1425
</div>
1426
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 18:28:27] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
1427
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1428

    
1429
</div>
1430
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 18:28:27] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1431

    
1432
</div>
1433
<div class="gap gMinutes"> TIME GAP = 11.0333333333333 minutes</div>
1434
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 18:17:25] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
1435
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1436

    
1437
</div>
1438
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 18:17:25] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
1439
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1440

    
1441
</div>
1442
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 18:17:25] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
1443
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1444

    
1445
</div>
1446
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 18:17:25] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
1447
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1448

    
1449
</div>
1450
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 18:17:25] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
1451
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1452

    
1453
</div>
1454
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 18:17:25] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1455

    
1456
</div>
1457
<div class="gap gMinutes"> TIME GAP = 57.2 minutes</div>
1458
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 17:20:13] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
1459
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1460

    
1461
</div>
1462
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 17:20:13] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
1463
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1464

    
1465
</div>
1466
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 17:20:13] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
1467
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1468

    
1469
</div>
1470
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 17:20:13] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
1471
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1472

    
1473
</div>
1474
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 17:20:13] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
1475
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1476

    
1477
</div>
1478
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 17:20:13] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1479

    
1480
</div>
1481
<div class="gap gMinutes"> TIME GAP = 10.8333333333333 minutes</div>
1482
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 17:09:23] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
1483
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1484

    
1485
</div>
1486
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 17:09:23] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
1487
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1488

    
1489
</div>
1490
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 17:09:23] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
1491
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1492

    
1493
</div>
1494
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 17:09:23] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
1495
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1496

    
1497
</div>
1498
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 17:09:23] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
1499
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1500

    
1501
</div>
1502
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 17:09:23] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1503

    
1504
</div>
1505
<div class="gap gSeconds"> TIME GAP = 40 seconds</div>
1506
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 17:08:43] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
1507
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1508

    
1509
</div>
1510
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 17:08:43] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
1511
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1512

    
1513
</div>
1514
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 17:08:43] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
1515
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1516

    
1517
</div>
1518
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 17:08:43] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
1519
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1520

    
1521
</div>
1522
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 17:08:43] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
1523
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1524

    
1525
</div>
1526
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 17:08:43] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1527

    
1528
</div>
1529
<div class="gap gSeconds"> TIME GAP = 19 seconds</div>
1530
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 17:08:24] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
1531
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1532

    
1533
</div>
1534
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 17:08:24] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
1535
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1536

    
1537
</div>
1538
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 17:08:24] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
1539
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1540

    
1541
</div>
1542
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 17:08:24] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
1543
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1544

    
1545
</div>
1546
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 17:08:24] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
1547
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1548

    
1549
</div>
1550
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 17:08:24] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1551

    
1552
</div>
1553
<div class="gap gMinutes"> TIME GAP = 17.15 minutes</div>
1554
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 16:51:15] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
1555
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1556

    
1557
</div>
1558
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 16:51:15] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
1559
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1560

    
1561
</div>
1562
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 16:51:15] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
1563
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1564

    
1565
</div>
1566
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 16:51:15] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
1567
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1568

    
1569
</div>
1570
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 16:51:15] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
1571
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1572

    
1573
</div>
1574
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 16:51:15] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1575

    
1576
</div>
1577
<div class="gap gMinutes"> TIME GAP = 40.05 minutes</div>
1578
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 16:11:12] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
1579
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1580

    
1581
</div>
1582
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 16:11:12] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
1583
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1584

    
1585
</div>
1586
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 16:11:11] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
1587
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1588

    
1589
</div>
1590
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 16:11:11] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
1591
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1592

    
1593
</div>
1594
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 16:11:11] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
1595
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1596

    
1597
</div>
1598
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 16:11:11] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1599

    
1600
</div>
1601
<div class="gap gMinutes"> TIME GAP = 20.3166666666667 minutes</div>
1602
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 15:50:52] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
1603
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1604

    
1605
</div>
1606
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 15:50:52] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
1607
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1608

    
1609
</div>
1610
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 15:50:52] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
1611
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1612

    
1613
</div>
1614
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 15:50:52] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
1615
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1616

    
1617
</div>
1618
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 15:50:52] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
1619
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1620

    
1621
</div>
1622
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 15:50:52] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1623

    
1624
</div>
1625
<div class="gap gMinutes"> TIME GAP = 18.9166666666667 minutes</div>
1626
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 15:31:57] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
1627
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1628

    
1629
</div>
1630
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 15:31:57] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
1631
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1632

    
1633
</div>
1634
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 15:31:57] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
1635
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1636

    
1637
</div>
1638
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 15:31:57] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
1639
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1640

    
1641
</div>
1642
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 15:31:57] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
1643
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1644

    
1645
</div>
1646
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 15:31:57] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1647

    
1648
</div>
1649
<div class="gap gMinutes"> TIME GAP = 6.6 minutes</div>
1650
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 15:25:21] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
1651
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1652

    
1653
</div>
1654
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 15:25:21] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
1655
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1656

    
1657
</div>
1658
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 15:25:21] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
1659
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1660

    
1661
</div>
1662
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 15:25:21] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
1663
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1664

    
1665
</div>
1666
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 15:25:21] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
1667
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1668

    
1669
</div>
1670
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 15:25:21] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1671

    
1672
</div>
1673
<div class="gap gMinutes"> TIME GAP = 20.9833333333333 minutes</div>
1674
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 15:04:22] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
1675
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1676

    
1677
</div>
1678
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 15:04:22] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
1679
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1680

    
1681
</div>
1682
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 15:04:22] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
1683
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1684

    
1685
</div>
1686
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 15:04:22] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
1687
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1688

    
1689
</div>
1690
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 15:04:22] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
1691
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1692

    
1693
</div>
1694
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 15:04:22] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1695

    
1696
</div>
1697
<div class="gap gMinutes"> TIME GAP = 18.2666666666667 minutes</div>
1698
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 14:46:06] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
1699
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1700

    
1701
</div>
1702
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 14:46:06] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
1703
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1704

    
1705
</div>
1706
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 14:46:06] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
1707
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1708

    
1709
</div>
1710
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 14:46:06] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
1711
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1712

    
1713
</div>
1714
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 14:46:06] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
1715
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1716

    
1717
</div>
1718
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 14:46:06] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1719

    
1720
</div>
1721
<div class="gap gMinutes"> TIME GAP = 6 minutes</div>
1722
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 14:40:06] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
1723
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1724

    
1725
</div>
1726
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 14:40:06] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
1727
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1728

    
1729
</div>
1730
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 14:40:06] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
1731
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1732

    
1733
</div>
1734
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 14:40:06] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
1735
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1736

    
1737
</div>
1738
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 14:40:06] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
1739
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1740

    
1741
</div>
1742
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 14:40:06] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1743

    
1744
</div>
1745
<div class="gap gMinutes"> TIME GAP = 5.51666666666667 minutes</div>
1746
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 14:34:35] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
1747
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1748

    
1749
</div>
1750
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 14:34:35] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
1751
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1752

    
1753
</div>
1754
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 14:34:35] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
1755
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1756

    
1757
</div>
1758
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 14:34:35] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
1759
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1760

    
1761
</div>
1762
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 14:34:35] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
1763
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1764

    
1765
</div>
1766
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 14:34:35] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1767

    
1768
</div>
1769
<div class="gap gMinutes"> TIME GAP = 34.9666666666667 minutes</div>
1770
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 13:59:37] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
1771
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1772

    
1773
</div>
1774
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 13:59:37] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
1775
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1776

    
1777
</div>
1778
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 13:59:37] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
1779
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1780

    
1781
</div>
1782
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 13:59:37] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
1783
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1784

    
1785
</div>
1786
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 13:59:37] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
1787
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1788

    
1789
</div>
1790
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 13:59:37] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1791

    
1792
</div>
1793
<div class="gap gMinutes"> TIME GAP = 4.05 minutes</div>
1794
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 13:55:34] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
1795
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1796

    
1797
</div>
1798
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 13:55:34] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
1799
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1800

    
1801
</div>
1802
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 13:55:34] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
1803
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1804

    
1805
</div>
1806
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 13:55:34] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
1807
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1808

    
1809
</div>
1810
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 13:55:34] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
1811
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1812

    
1813
</div>
1814
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 13:55:34] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1815

    
1816
</div>
1817
<div class="gap gMinutes"> TIME GAP = 32.3833333333333 minutes</div>
1818
<div class="debug">[HAZELCAST-STORAGE] [DEBUG] [2017-05-17 13:23:11] : (FactoryImpl$4:process:421) [128.111.54.80]:5701 [DataONE] Instance created ProxyKey {name='lock',
1819
  key=doi:10.6067:XCV8WM1D1X_meta$v=1493667645608}
1820

    
1821
</div>
1822
<div class="gap gMinutes"> TIME GAP = 4.7 minutes</div>
1823
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 13:18:29] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
1824
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1825

    
1826
</div>
1827
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 13:18:29] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
1828
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1829

    
1830
</div>
1831
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 13:18:29] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
1832
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1833

    
1834
</div>
1835
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 13:18:29] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
1836
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1837

    
1838
</div>
1839
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 13:18:29] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
1840
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1841

    
1842
</div>
1843
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 13:18:29] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
1844

    
1845
</div>
1846
<div class="gap gMinutes"> TIME GAP = 12.8 minutes</div>
1847
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 13:05:41] : (SyncObjectTask:reapFutures:303) Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 Returned from the
1848
  Future :(1):
1849

    
1850
</div>
1851
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 13:05:41] : (SyncObjectTask:reapFutures:297) Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 SyncObjectState: FAILED
1852

    
1853
</div>
1854
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 13:05:41] : (SyncObjectTask:reapFutures:293) trying future Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482
1855

    
1856
</div>
1857
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 13:05:41] : (SyncObjectTask:reapFutures:303) Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 Returned from the
1858
  Future :(1):
1859

    
1860
</div>
1861
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 13:05:41] : (SyncObjectTask:reapFutures:297) Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 SyncObjectState: FAILED
1862

    
1863
</div>
1864
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 13:05:41] : (SyncObjectTask:reapFutures:293) trying future Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482
1865

    
1866
</div>
1867
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 13:05:40] : (V2TransferObjectTask:call:294) Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 -  exiting with
1868
  callState: FAILED
1869

    
1870
</div>
1871
<div class="error">[CN-SYNCHRONIZATION] [ERROR] [2017-05-17 13:05:40] : (SyncFailedTask:submitSynchronizationFailed:139) Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 <?xml
1872
  version="1.0" encoding="UTF-8"?>
1873
<error detailCode="-1" errorCode="500" name="ServiceFailure">
1874
<description>415: Unsupported Media Type: parser for deserializing HTML not written yet.  Providing message body:
1875
&lt;!DOCTYPE html&gt;&lt;html&gt;&lt;head&gt;&lt;title&gt;Apache Tomcat/8.0.32 (Ubuntu) - Error
1876
  report&lt;/title&gt;&lt;style type="text/css"&gt;H1 {font-family:Tahoma,Arial,sans-serif;color:white;background-
1877
  color:#525D76;font-size:22px;} H2 {font-family:Tahoma,Arial,sans-serif;color:white;background-color:#525D76;font-
1878
  size:16px;} H3 {font-family:Tahoma,Arial,sans-serif;color:white;background-color:#525D76;font-size:14px;} BODY {font-
1879
  family:Tahoma,Arial,sans-serif;color:black;background-color:white;} B {font-family:Tahoma,Arial,sans-serif;color:white
1880
  ;background-color:#525D76;} P {font-family:Tahoma,Arial,sans-serif;background:white;color:black;font-size:12px;}A
1881
  {color : black;}A.name {color : black;}.line {height: 1px; background-color: #525D76; border: none;}&lt;/style&gt;
1882
  &lt;/head&gt;&lt;body&gt;&lt;h1&gt;HTTP Status 415 - Unsupported Media Type&lt;/h1&gt;&lt;div
1883
  class="line"&gt;&lt;/div&gt;&lt;p&gt;&lt;b&gt;type&lt;/b&gt; Status
1884
  report&lt;/p&gt;&lt;p&gt;&lt;b&gt;message&lt;/b&gt; &lt;u&gt;Unsupported Media
1885
  Type&lt;/u&gt;&lt;/p&gt;&lt;p&gt;&lt;b&gt;description&lt;/b&gt; &lt;u&gt;The server refused this request because the
1886
  request entity is in a format not supported by the requested resource for the requested
1887
  method.&lt;/u&gt;&lt;/p&gt;&lt;hr class="line"&gt;&lt;h3&gt;Apache Tomcat/8.0.32
1888
  (Ubuntu)&lt;/h3&gt;&lt;/body&gt;&lt;/html&gt;</description>
1889
</error>
1890

    
1891

    
1892
</div>
1893
<div class="warn">[CN-SYNCHRONIZATION] [WARN] [2017-05-17 13:05:40] : (SyncFailedTask:submitSynchronizationFailed:116) Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 -
1894
  SynchronizationFailed: detail code: 6001 id:+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 nodeId:urn:node:CNUCSB1
1895
  description:Synchronization task of [PID::] +doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 [::PID] failed. Cause:
1896
  NotFound: Not Found
1897

    
1898
</div>
1899
<div class="error">[CN-SYNCHRONIZATION] [ERROR] [2017-05-17 13:05:40] : (V2TransferObjectTask:call:259) Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 - SynchronizationFailed:
1900
  Synchronization task of [PID::] +doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 [::PID] failed. Cause: NotFound: Not
1901
  Found
1902
org.dataone.service.exceptions.SynchronizationFailed: Synchronization task of [PID::]
1903
  +doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 [::PID] failed. Cause: NotFound: Not Found
1904
at org.dataone.cn.batch.synchronization.tasks.SyncFailedTask.createSynchronizationFailed(SyncFailedTask.java:97)
1905
at
1906
  org.dataone.cn.batch.synchronization.tasks.V2TransferObjectTask.retrieveMNSystemMetadata(V2TransferObjectTask.java:334
1907
  )
1908
at org.dataone.cn.batch.synchronization.tasks.V2TransferObjectTask.call(V2TransferObjectTask.java:208)
1909
at org.dataone.cn.batch.synchronization.tasks.V2TransferObjectTask.call(V2TransferObjectTask.java:113)
1910
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
1911
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
1912
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
1913
at java.lang.Thread.run(Thread.java:745)
1914

    
1915
</div>
1916
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 13:05:40] : (V2TransferObjectTask:call:234) Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 -  Unlocked Pid.
1917

    
1918
</div>
1919
<div class="error">[CN-SYNCHRONIZATION] [ERROR] [2017-05-17 13:05:40] : (V2TransferObjectTask:retrieveMNSystemMetadata:333) Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 -
1920
  Not Found - NotFound - Not Found
1921
org.dataone.service.exceptions.NotFound: Not Found
1922
at org.dataone.service.util.ExceptionHandler.deserializeXml(ExceptionHandler.java:629)
1923
at org.dataone.service.util.ExceptionHandler.deserializeXmlAndThrowException(ExceptionHandler.java:517)
1924
at org.dataone.service.util.ExceptionHandler.deserializeAndThrowException(ExceptionHandler.java:363)
1925
at org.dataone.service.util.ExceptionHandler.deserializeAndThrowException(ExceptionHandler.java:313)
1926
at org.dataone.service.util.ExceptionHandler.filterErrors(ExceptionHandler.java:107)
1927
at org.dataone.client.rest.HttpMultipartRestClient.doGetRequest(HttpMultipartRestClient.java:343)
1928
at org.dataone.client.rest.HttpMultipartRestClient.doGetRequest(HttpMultipartRestClient.java:328)
1929
at org.dataone.client.v2.impl.MultipartD1Node.getSystemMetadata(MultipartD1Node.java:94)
1930
at org.dataone.client.v2.impl.MultipartMNode.getSystemMetadata(MultipartMNode.java:337)
1931
at org.dataone.cn.batch.synchronization.tasks.V2TransferObjectTask.getSystemMetadataHandleRetry(V2TransferObjectTask.jav
1932
  a:365)
1933
at
1934
  org.dataone.cn.batch.synchronization.tasks.V2TransferObjectTask.retrieveMNSystemMetadata(V2TransferObjectTask.java:316
1935
  )
1936
at org.dataone.cn.batch.synchronization.tasks.V2TransferObjectTask.call(V2TransferObjectTask.java:208)
1937
at org.dataone.cn.batch.synchronization.tasks.V2TransferObjectTask.call(V2TransferObjectTask.java:113)
1938
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
1939
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
1940
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
1941
at java.lang.Thread.run(Thread.java:745)
1942

    
1943
</div>
1944
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 13:05:40] : (SyncObjectTask:reapFutures:334) Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 Waiting for the future
1945
  :(1): since 2017-05-12T13:05:39.474+00:00
1946

    
1947
</div>
1948
<div class="debug">[CN-SYNCHRONIZATION] [DEBUG] [2017-05-17 13:05:40] : (SyncObjectTask:reapFutures:293) trying future Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482
1949

    
1950
</div>
1951
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 13:05:40] : (V2TransferObjectTask:call:294) Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 -  exiting with
1952
  callState: FAILED
1953

    
1954
</div>
1955
<div class="error">[D1-PROCESSING-JSVC] [ERROR] [2017-05-17 13:05:40] : (SyncFailedTask:submitSynchronizationFailed:139) Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 <?xml
1956
  version="1.0" encoding="UTF-8"?>
1957
<error detailCode="-1" errorCode="500" name="ServiceFailure">
1958
<description>415: Unsupported Media Type: parser for deserializing HTML not written yet.  Providing message body:
1959
&lt;!DOCTYPE html&gt;&lt;html&gt;&lt;head&gt;&lt;title&gt;Apache Tomcat/8.0.32 (Ubuntu) - Error
1960
  report&lt;/title&gt;&lt;style type="text/css"&gt;H1 {font-family:Tahoma,Arial,sans-serif;color:white;background-
1961
  color:#525D76;font-size:22px;} H2 {font-family:Tahoma,Arial,sans-serif;color:white;background-color:#525D76;font-
1962
  size:16px;} H3 {font-family:Tahoma,Arial,sans-serif;color:white;background-color:#525D76;font-size:14px;} BODY {font-
1963
  family:Tahoma,Arial,sans-serif;color:black;background-color:white;} B {font-family:Tahoma,Arial,sans-serif;color:white
1964
  ;background-color:#525D76;} P {font-family:Tahoma,Arial,sans-serif;background:white;color:black;font-size:12px;}A
1965
  {color : black;}A.name {color : black;}.line {height: 1px; background-color: #525D76; border: none;}&lt;/style&gt;
1966
  &lt;/head&gt;&lt;body&gt;&lt;h1&gt;HTTP Status 415 - Unsupported Media Type&lt;/h1&gt;&lt;div
1967
  class="line"&gt;&lt;/div&gt;&lt;p&gt;&lt;b&gt;type&lt;/b&gt; Status
1968
  report&lt;/p&gt;&lt;p&gt;&lt;b&gt;message&lt;/b&gt; &lt;u&gt;Unsupported Media
1969
  Type&lt;/u&gt;&lt;/p&gt;&lt;p&gt;&lt;b&gt;description&lt;/b&gt; &lt;u&gt;The server refused this request because the
1970
  request entity is in a format not supported by the requested resource for the requested
1971
  method.&lt;/u&gt;&lt;/p&gt;&lt;hr class="line"&gt;&lt;h3&gt;Apache Tomcat/8.0.32
1972
  (Ubuntu)&lt;/h3&gt;&lt;/body&gt;&lt;/html&gt;</description>
1973
</error>
1974

    
1975

    
1976
</div>
1977
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 13:05:40] : (SyncFailedTask:submitSynchronizationFailed:116) Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 -
1978
  SynchronizationFailed: detail code: 6001 id:+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 nodeId:urn:node:CNUCSB1
1979
  description:Synchronization task of [PID::] +doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 [::PID] failed. Cause:
1980
  NotFound: Not Found
1981

    
1982
</div>
1983
<div class="error">[D1-PROCESSING-JSVC] [ERROR] [2017-05-17 13:05:40] : (V2TransferObjectTask:call:259) Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 - SynchronizationFailed:
1984
  Synchronization task of [PID::] +doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 [::PID] failed. Cause: NotFound: Not
1985
  Found
1986
org.dataone.service.exceptions.SynchronizationFailed: Synchronization task of [PID::]
1987
  +doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 [::PID] failed. Cause: NotFound: Not Found
1988
at org.dataone.cn.batch.synchronization.tasks.SyncFailedTask.createSynchronizationFailed(SyncFailedTask.java:97)
1989
at
1990
  org.dataone.cn.batch.synchronization.tasks.V2TransferObjectTask.retrieveMNSystemMetadata(V2TransferObjectTask.java:334
1991
  )
1992
at org.dataone.cn.batch.synchronization.tasks.V2TransferObjectTask.call(V2TransferObjectTask.java:208)
1993
at org.dataone.cn.batch.synchronization.tasks.V2TransferObjectTask.call(V2TransferObjectTask.java:113)
1994
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
1995
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
1996
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
1997
at java.lang.Thread.run(Thread.java:745)
1998

    
1999
</div>
2000
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 13:05:40] : (V2TransferObjectTask:call:234) Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 -  Unlocked Pid.
2001

    
2002
</div>
2003
<div class="error">[D1-PROCESSING-JSVC] [ERROR] [2017-05-17 13:05:40] : (V2TransferObjectTask:retrieveMNSystemMetadata:333) Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 -
2004
  Not Found - NotFound - Not Found
2005
org.dataone.service.exceptions.NotFound: Not Found
2006
at org.dataone.service.util.ExceptionHandler.deserializeXml(ExceptionHandler.java:629)
2007
at org.dataone.service.util.ExceptionHandler.deserializeXmlAndThrowException(ExceptionHandler.java:517)
2008
at org.dataone.service.util.ExceptionHandler.deserializeAndThrowException(ExceptionHandler.java:363)
2009
at org.dataone.service.util.ExceptionHandler.deserializeAndThrowException(ExceptionHandler.java:313)
2010
at org.dataone.service.util.ExceptionHandler.filterErrors(ExceptionHandler.java:107)
2011
at org.dataone.client.rest.HttpMultipartRestClient.doGetRequest(HttpMultipartRestClient.java:343)
2012
at org.dataone.client.rest.HttpMultipartRestClient.doGetRequest(HttpMultipartRestClient.java:328)
2013
at org.dataone.client.v2.impl.MultipartD1Node.getSystemMetadata(MultipartD1Node.java:94)
2014
at org.dataone.client.v2.impl.MultipartMNode.getSystemMetadata(MultipartMNode.java:337)
2015
at org.dataone.cn.batch.synchronization.tasks.V2TransferObjectTask.getSystemMetadataHandleRetry(V2TransferObjectTask.jav
2016
  a:365)
2017
at
2018
  org.dataone.cn.batch.synchronization.tasks.V2TransferObjectTask.retrieveMNSystemMetadata(V2TransferObjectTask.java:316
2019
  )
2020
at org.dataone.cn.batch.synchronization.tasks.V2TransferObjectTask.call(V2TransferObjectTask.java:208)
2021
at org.dataone.cn.batch.synchronization.tasks.V2TransferObjectTask.call(V2TransferObjectTask.java:113)
2022
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
2023
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
2024
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
2025
at java.lang.Thread.run(Thread.java:745)
2026

    
2027
</div>
2028
<div class="error">[D1-PROCESSING-JSVC] [ERROR] [2017-05-17 13:05:40] : (StdOutErrLog$2:print:51) 152067061 [SynchronizeTask2885] INFO org.dataone.client.rest.RestClient -
2029
  RestClient.doRequestNoBody, thread(31890) call Info: GET
2030
  https://dataone.tdar.org/dataone/v2/meta/%2Bdoi:10.6067:XCV8WM1D1X_meta$v=1356819351482
2031

    
2032

    
2033
</div>
2034
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 13:05:40] : (SyncObjectTask:reapFutures:334) Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 Waiting for the future
2035
  :(1): since 2017-05-12T13:05:39.474+00:00
2036

    
2037
</div>
2038
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 13:05:40] : (SyncObjectTask:reapFutures:293) trying future Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482
2039

    
2040
</div>
2041
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 13:05:39] : (V2TransferObjectTask:call:207) Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 -  Processing SyncObject
2042

    
2043
</div>
2044
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 13:05:39] : (V2TransferObjectTask:call:202) Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 -  Locking task, attempt
2045
  1
2046

    
2047
</div>
2048
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 13:05:39] : (SyncObjectTask:executeTransferObjectTask:236) Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 submitted
2049
  for execution
2050

    
2051
</div>
2052
<div class="info">[CN-SYNCHRONIZATION] [INFO] [2017-05-17 13:05:39] : (SyncObjectTask:executeTransferObjectTask:219) Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 received
2053

    
2054
</div>
2055
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 13:05:39] : (V2TransferObjectTask:call:207) Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 -  Processing SyncObject
2056

    
2057
</div>
2058
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 13:05:39] : (V2TransferObjectTask:call:202) Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 -  Locking task, attempt
2059
  1
2060

    
2061
</div>
2062
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 13:05:39] : (SyncObjectTask:executeTransferObjectTask:236) Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 submitted
2063
  for execution
2064

    
2065
</div>
2066
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 13:05:39] : (SyncObjectTask:executeTransferObjectTask:219) Task-urn:node:TDAR-+doi:10.6067:XCV8WM1D1X_meta$v=1356819351482 received
2067

    
2068
</div>
2069
<div class="gap gMinutes"> TIME GAP = 17.95 minutes</div>
2070
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 12:47:42] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2071
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2072

    
2073
</div>
2074
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 12:47:42] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2075
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2076

    
2077
</div>
2078
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 12:47:42] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2079
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2080

    
2081
</div>
2082
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 12:47:42] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2083
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2084

    
2085
</div>
2086
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 12:47:42] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2087
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2088

    
2089
</div>
2090
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 12:47:42] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2091

    
2092
</div>
2093
<div class="gap gMinutes"> TIME GAP = 13.7833333333333 minutes</div>
2094
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 12:33:55] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2095
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2096

    
2097
</div>
2098
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 12:33:55] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2099
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2100

    
2101
</div>
2102
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 12:33:55] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2103
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2104

    
2105
</div>
2106
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 12:33:55] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2107
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2108

    
2109
</div>
2110
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 12:33:55] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2111
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2112

    
2113
</div>
2114
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 12:33:55] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2115

    
2116
</div>
2117
<div class="gap gMinutes"> TIME GAP = 14.2166666666667 minutes</div>
2118
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 12:19:42] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2119
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2120

    
2121
</div>
2122
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 12:19:42] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2123
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2124

    
2125
</div>
2126
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 12:19:42] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2127
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2128

    
2129
</div>
2130
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 12:19:42] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2131
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2132

    
2133
</div>
2134
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 12:19:42] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2135
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2136

    
2137
</div>
2138
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 12:19:42] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2139

    
2140
</div>
2141
<div class="gap gMinutes"> TIME GAP = 17.1333333333333 minutes</div>
2142
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 12:02:34] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2143
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2144

    
2145
</div>
2146
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 12:02:34] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2147
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2148

    
2149
</div>
2150
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 12:02:34] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2151
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2152

    
2153
</div>
2154
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 12:02:34] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2155
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2156

    
2157
</div>
2158
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 12:02:34] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2159
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2160

    
2161
</div>
2162
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 12:02:34] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2163

    
2164
</div>
2165
<div class="gap gMinutes"> TIME GAP = 16.45 minutes</div>
2166
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 11:46:07] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2167
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2168

    
2169
</div>
2170
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 11:46:07] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2171
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2172

    
2173
</div>
2174
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 11:46:07] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2175
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2176

    
2177
</div>
2178
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 11:46:07] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2179
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2180

    
2181
</div>
2182
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 11:46:07] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2183
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2184

    
2185
</div>
2186
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 11:46:07] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2187

    
2188
</div>
2189
<div class="gap gMinutes"> TIME GAP = 34.95 minutes</div>
2190
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 11:11:10] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2191
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2192

    
2193
</div>
2194
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 11:11:10] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2195
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2196

    
2197
</div>
2198
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 11:11:10] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2199
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2200

    
2201
</div>
2202
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 11:11:10] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2203
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2204

    
2205
</div>
2206
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 11:11:10] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2207
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2208

    
2209
</div>
2210
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 11:11:10] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2211

    
2212
</div>
2213
<div class="gap gMinutes"> TIME GAP = 10.6166666666667 minutes</div>
2214
<div class="warn">[CN-PROCESS-DAEMON] [WARN] [2017-05-17 11:00:33] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2215
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2216

    
2217
</div>
2218
<div class="info">[CN-PROCESS-DAEMON] [INFO] [2017-05-17 11:00:33] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2219
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2220

    
2221
</div>
2222
<div class="info">[CN-PROCESS-DAEMON] [INFO] [2017-05-17 11:00:33] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2223
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2224

    
2225
</div>
2226
<div class="debug">[CN-PROCESS-DAEMON] [DEBUG] [2017-05-17 11:00:33] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2227
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2228

    
2229
</div>
2230
<div class="debug">[CN-PROCESS-DAEMON] [DEBUG] [2017-05-17 11:00:33] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2231
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2232

    
2233
</div>
2234
<div class="debug">[CN-PROCESS-DAEMON] [DEBUG] [2017-05-17 11:00:33] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2235

    
2236
</div>
2237
<div class="warn">[CN-REPLICATION] [WARN] [2017-05-17 11:00:33] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2238
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2239

    
2240
</div>
2241
<div class="info">[CN-REPLICATION] [INFO] [2017-05-17 11:00:33] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2242
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2243

    
2244
</div>
2245
<div class="info">[CN-REPLICATION] [INFO] [2017-05-17 11:00:33] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2246
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2247

    
2248
</div>
2249
<div class="debug">[CN-REPLICATION] [DEBUG] [2017-05-17 11:00:33] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2250
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2251

    
2252
</div>
2253
<div class="debug">[CN-REPLICATION] [DEBUG] [2017-05-17 11:00:33] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2254
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2255

    
2256
</div>
2257
<div class="debug">[CN-REPLICATION] [DEBUG] [2017-05-17 11:00:33] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2258

    
2259
</div>
2260
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 11:00:33] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2261
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2262

    
2263
</div>
2264
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 11:00:33] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2265
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2266

    
2267
</div>
2268
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 11:00:33] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2269
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2270

    
2271
</div>
2272
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 11:00:33] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2273
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2274

    
2275
</div>
2276
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 11:00:33] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2277
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2278

    
2279
</div>
2280
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 11:00:33] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2281

    
2282
</div>
2283
<div class="gap gMinutes"> TIME GAP = 12.9666666666667 minutes</div>
2284
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 10:47:35] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2285
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2286

    
2287
</div>
2288
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 10:47:35] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2289
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2290

    
2291
</div>
2292
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 10:47:35] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2293
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2294

    
2295
</div>
2296
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 10:47:35] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2297
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2298

    
2299
</div>
2300
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 10:47:35] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2301
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2302

    
2303
</div>
2304
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 10:47:35] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2305

    
2306
</div>
2307
<div class="gap gSeconds"> TIME GAP = 49 seconds</div>
2308
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 10:46:46] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2309
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2310

    
2311
</div>
2312
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 10:46:46] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2313
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2314

    
2315
</div>
2316
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 10:46:46] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2317
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2318

    
2319
</div>
2320
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 10:46:46] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2321
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2322

    
2323
</div>
2324
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 10:46:46] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2325
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2326

    
2327
</div>
2328
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 10:46:46] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2329

    
2330
</div>
2331
<div class="gap gMinutes"> TIME GAP = 1.43333333333333 minutes</div>
2332
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 10:45:20] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2333
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2334

    
2335
</div>
2336
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 10:45:20] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2337
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2338

    
2339
</div>
2340
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 10:45:20] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2341
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2342

    
2343
</div>
2344
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 10:45:20] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2345
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2346

    
2347
</div>
2348
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 10:45:20] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2349
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2350

    
2351
</div>
2352
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 10:45:20] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2353

    
2354
</div>
2355
<div class="gap gMinutes"> TIME GAP = 57.5166666666667 minutes</div>
2356
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 09:47:49] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2357
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2358

    
2359
</div>
2360
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 09:47:49] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2361
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2362

    
2363
</div>
2364
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 09:47:49] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2365
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2366

    
2367
</div>
2368
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 09:47:49] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2369
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2370

    
2371
</div>
2372
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 09:47:49] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2373
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2374

    
2375
</div>
2376
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 09:47:49] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2377

    
2378
</div>
2379
<div class="gap gMinutes"> TIME GAP = 7.38333333333333 minutes</div>
2380
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 09:40:26] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2381
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2382

    
2383
</div>
2384
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 09:40:26] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2385
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2386

    
2387
</div>
2388
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 09:40:26] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2389
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2390

    
2391
</div>
2392
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 09:40:26] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2393
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2394

    
2395
</div>
2396
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 09:40:26] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2397
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2398

    
2399
</div>
2400
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 09:40:26] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2401

    
2402
</div>
2403
<div class="gap gMinutes"> TIME GAP = 9.5 minutes</div>
2404
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 09:30:56] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2405
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2406

    
2407
</div>
2408
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 09:30:56] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2409
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2410

    
2411
</div>
2412
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 09:30:56] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2413
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2414

    
2415
</div>
2416
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 09:30:56] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2417
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2418

    
2419
</div>
2420
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 09:30:56] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2421
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2422

    
2423
</div>
2424
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 09:30:56] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2425

    
2426
</div>
2427
<div class="gap gMinutes"> TIME GAP = 16.9666666666667 minutes</div>
2428
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 09:13:58] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2429
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2430

    
2431
</div>
2432
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 09:13:58] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2433
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2434

    
2435
</div>
2436
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 09:13:58] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2437
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2438

    
2439
</div>
2440
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 09:13:58] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2441
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2442

    
2443
</div>
2444
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 09:13:58] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2445
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2446

    
2447
</div>
2448
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 09:13:58] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2449

    
2450
</div>
2451
<div class="gap gMinutes"> TIME GAP = 4.11666666666667 minutes</div>
2452
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 09:09:51] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2453
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2454

    
2455
</div>
2456
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 09:09:51] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2457
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2458

    
2459
</div>
2460
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 09:09:51] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2461
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2462

    
2463
</div>
2464
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 09:09:51] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2465
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2466

    
2467
</div>
2468
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 09:09:51] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2469
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2470

    
2471
</div>
2472
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 09:09:51] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2473

    
2474
</div>
2475
<div class="gap gMinutes"> TIME GAP = 19.95 minutes</div>
2476
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 08:49:54] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2477
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2478

    
2479
</div>
2480
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 08:49:54] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2481
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2482

    
2483
</div>
2484
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 08:49:54] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2485
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2486

    
2487
</div>
2488
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 08:49:54] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2489
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2490

    
2491
</div>
2492
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 08:49:54] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2493
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2494

    
2495
</div>
2496
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 08:49:54] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2497

    
2498
</div>
2499
<div class="gap gMinutes"> TIME GAP = 33.2833333333333 minutes</div>
2500
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 08:16:37] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2501
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2502

    
2503
</div>
2504
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 08:16:37] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2505
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2506

    
2507
</div>
2508
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 08:16:37] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2509
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2510

    
2511
</div>
2512
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 08:16:37] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2513
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2514

    
2515
</div>
2516
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 08:16:37] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2517
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2518

    
2519
</div>
2520
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 08:16:37] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2521

    
2522
</div>
2523
<div class="gap gSeconds"> TIME GAP = 10 seconds</div>
2524
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 08:16:27] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2525
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2526

    
2527
</div>
2528
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 08:16:27] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2529
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2530

    
2531
</div>
2532
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 08:16:27] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2533
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2534

    
2535
</div>
2536
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 08:16:27] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2537
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2538

    
2539
</div>
2540
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 08:16:27] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2541
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2542

    
2543
</div>
2544
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 08:16:27] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2545

    
2546
</div>
2547
<div class="gap gMinutes"> TIME GAP = 40.8 minutes</div>
2548
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 07:35:39] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2549
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2550

    
2551
</div>
2552
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 07:35:39] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2553
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2554

    
2555
</div>
2556
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 07:35:39] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2557
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2558

    
2559
</div>
2560
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 07:35:39] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2561
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2562

    
2563
</div>
2564
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 07:35:39] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2565
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2566

    
2567
</div>
2568
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 07:35:39] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2569

    
2570
</div>
2571
<div class="gap gMinutes"> TIME GAP = 23.25 minutes</div>
2572
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 07:12:24] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2573
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2574

    
2575
</div>
2576
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 07:12:24] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2577
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2578

    
2579
</div>
2580
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 07:12:24] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2581
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2582

    
2583
</div>
2584
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 07:12:24] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2585
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2586

    
2587
</div>
2588
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 07:12:24] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2589
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2590

    
2591
</div>
2592
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 07:12:24] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2593

    
2594
</div>
2595
<div class="gap gMinutes"> TIME GAP = 6.21666666666667 minutes</div>
2596
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 07:06:11] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2597
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2598

    
2599
</div>
2600
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 07:06:11] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2601
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2602

    
2603
</div>
2604
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 07:06:11] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2605
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2606

    
2607
</div>
2608
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 07:06:11] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2609
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2610

    
2611
</div>
2612
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 07:06:11] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2613
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2614

    
2615
</div>
2616
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 07:06:11] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2617

    
2618
</div>
2619
<div class="gap gMinutes"> TIME GAP = 5.38333333333333 minutes</div>
2620
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 07:00:48] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2621
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2622

    
2623
</div>
2624
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 07:00:48] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2625
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2626

    
2627
</div>
2628
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 07:00:48] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2629
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2630

    
2631
</div>
2632
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 07:00:48] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2633
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2634

    
2635
</div>
2636
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 07:00:48] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2637
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2638

    
2639
</div>
2640
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 07:00:48] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2641

    
2642
</div>
2643
<div class="gap gMinutes"> TIME GAP = 1.03333333333333 minutes</div>
2644
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 06:59:46] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2645
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2646

    
2647
</div>
2648
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 06:59:46] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2649
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2650

    
2651
</div>
2652
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 06:59:46] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2653
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2654

    
2655
</div>
2656
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 06:59:46] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2657
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2658

    
2659
</div>
2660
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 06:59:46] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2661
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2662

    
2663
</div>
2664
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 06:59:46] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2665

    
2666
</div>
2667
<div class="gap gMinutes"> TIME GAP = 6.81666666666667 minutes</div>
2668
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 06:52:57] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2669
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2670

    
2671
</div>
2672
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 06:52:57] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2673
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2674

    
2675
</div>
2676
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 06:52:57] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2677
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2678

    
2679
</div>
2680
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 06:52:57] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2681
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2682

    
2683
</div>
2684
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 06:52:57] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2685
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2686

    
2687
</div>
2688
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 06:52:57] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2689

    
2690
</div>
2691
<div class="gap gMinutes"> TIME GAP = 51.4 minutes</div>
2692
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 06:01:33] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2693
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2694

    
2695
</div>
2696
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 06:01:33] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2697
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2698

    
2699
</div>
2700
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 06:01:33] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2701
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2702

    
2703
</div>
2704
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 06:01:33] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2705

    
2706
</div>
2707
<div class="gap gMinutes"> TIME GAP = 17.9333333333333 minutes</div>
2708
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 05:43:37] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2709
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2710

    
2711
</div>
2712
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 05:43:37] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2713
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2714

    
2715
</div>
2716
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 05:43:37] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2717
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2718

    
2719
</div>
2720
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 05:43:37] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2721
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2722

    
2723
</div>
2724
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 05:43:37] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2725
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2726

    
2727
</div>
2728
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 05:43:37] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2729

    
2730
</div>
2731
<div class="gap gHours"> TIME GAP = 1.19555555555556 hours</div>
2732
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 04:31:53] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2733
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2734

    
2735
</div>
2736
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 04:31:53] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2737
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2738

    
2739
</div>
2740
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 04:31:52] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2741
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2742

    
2743
</div>
2744
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 04:31:52] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2745
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2746

    
2747
</div>
2748
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 04:31:52] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2749
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2750

    
2751
</div>
2752
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 04:31:52] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2753

    
2754
</div>
2755
<div class="gap gMinutes"> TIME GAP = 25.3 minutes</div>
2756
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 04:06:34] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2757
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2758

    
2759
</div>
2760
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 04:06:34] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2761
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2762

    
2763
</div>
2764
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 04:06:34] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2765
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2766

    
2767
</div>
2768
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 04:06:34] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2769

    
2770
</div>
2771
<div class="gap gMinutes"> TIME GAP = 6.3 minutes</div>
2772
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 04:00:16] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2773
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2774

    
2775
</div>
2776
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 04:00:16] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2777
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2778

    
2779
</div>
2780
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 04:00:16] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2781
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2782

    
2783
</div>
2784
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 04:00:16] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2785
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2786

    
2787
</div>
2788
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 04:00:16] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2789
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2790

    
2791
</div>
2792
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 04:00:16] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2793

    
2794
</div>
2795
<div class="gap gMinutes"> TIME GAP = 12.8166666666667 minutes</div>
2796
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 03:47:27] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2797
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2798

    
2799
</div>
2800
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 03:47:27] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2801
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2802

    
2803
</div>
2804
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 03:47:27] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2805
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2806

    
2807
</div>
2808
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 03:47:27] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2809
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2810

    
2811
</div>
2812
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 03:47:27] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2813
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2814

    
2815
</div>
2816
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 03:47:27] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2817

    
2818
</div>
2819
<div class="gap gMinutes"> TIME GAP = 43.8333333333333 minutes</div>
2820
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 03:03:37] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2821
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2822

    
2823
</div>
2824
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 03:03:37] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2825
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2826

    
2827
</div>
2828
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 03:03:37] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2829
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2830

    
2831
</div>
2832
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 03:03:37] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2833
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2834

    
2835
</div>
2836
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 03:03:37] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2837
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2838

    
2839
</div>
2840
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 03:03:37] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2841

    
2842
</div>
2843
<div class="gap gMinutes"> TIME GAP = 4.05 minutes</div>
2844
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 02:59:34] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2845
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2846

    
2847
</div>
2848
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 02:59:34] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2849
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2850

    
2851
</div>
2852
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 02:59:34] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2853
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2854

    
2855
</div>
2856
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 02:59:34] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2857
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2858

    
2859
</div>
2860
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 02:59:34] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2861
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2862

    
2863
</div>
2864
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 02:59:34] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2865

    
2866
</div>
2867
<div class="gap gMinutes"> TIME GAP = 16.6166666666667 minutes</div>
2868
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 02:42:57] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2869
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2870

    
2871
</div>
2872
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 02:42:57] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2873
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2874

    
2875
</div>
2876
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 02:42:57] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2877
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2878

    
2879
</div>
2880
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 02:42:57] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2881
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2882

    
2883
</div>
2884
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 02:42:57] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2885
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2886

    
2887
</div>
2888
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 02:42:57] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2889

    
2890
</div>
2891
<div class="gap gMinutes"> TIME GAP = 58.5833333333333 minutes</div>
2892
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 01:44:22] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2893
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2894

    
2895
</div>
2896
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 01:44:22] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2897
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2898

    
2899
</div>
2900
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 01:44:21] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2901
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2902

    
2903
</div>
2904
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 01:44:21] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2905
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2906

    
2907
</div>
2908
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 01:44:21] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2909
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2910

    
2911
</div>
2912
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 01:44:21] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2913

    
2914
</div>
2915
<div class="gap gMinutes"> TIME GAP = 8.91666666666667 minutes</div>
2916
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 01:35:26] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2917
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2918

    
2919
</div>
2920
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 01:35:26] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2921
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2922

    
2923
</div>
2924
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 01:35:26] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2925
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2926

    
2927
</div>
2928
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 01:35:26] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2929
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2930

    
2931
</div>
2932
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 01:35:26] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2933
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2934

    
2935
</div>
2936
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 01:35:26] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2937

    
2938
</div>
2939
<div class="gap gMinutes"> TIME GAP = 14.6333333333333 minutes</div>
2940
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 01:20:48] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2941
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2942

    
2943
</div>
2944
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 01:20:48] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2945
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2946

    
2947
</div>
2948
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 01:20:48] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2949
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2950

    
2951
</div>
2952
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 01:20:48] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2953
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2954

    
2955
</div>
2956
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 01:20:48] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2957
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2958

    
2959
</div>
2960
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 01:20:48] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2961

    
2962
</div>
2963
<div class="gap gMinutes"> TIME GAP = 1.03333333333333 minutes</div>
2964
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 01:19:46] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2965
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2966

    
2967
</div>
2968
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 01:19:46] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2969
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2970

    
2971
</div>
2972
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 01:19:46] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2973
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2974

    
2975
</div>
2976
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 01:19:46] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
2977
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2978

    
2979
</div>
2980
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 01:19:46] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
2981
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2982

    
2983
</div>
2984
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 01:19:46] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2985

    
2986
</div>
2987
<div class="gap gMinutes"> TIME GAP = 5.71666666666667 minutes</div>
2988
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 01:14:03] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
2989
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2990

    
2991
</div>
2992
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 01:14:03] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
2993
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2994

    
2995
</div>
2996
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 01:14:03] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
2997
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
2998

    
2999
</div>
3000
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 01:14:03] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
3001
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
3002

    
3003
</div>
3004
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 01:14:03] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
3005
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
3006

    
3007
</div>
3008
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 01:14:03] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
3009

    
3010
</div>
3011
<div class="gap gMinutes"> TIME GAP = 17.8666666666667 minutes</div>
3012
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 00:56:11] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
3013
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
3014

    
3015
</div>
3016
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 00:56:11] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
3017
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
3018

    
3019
</div>
3020
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 00:56:11] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
3021
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
3022

    
3023
</div>
3024
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 00:56:11] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
3025
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
3026

    
3027
</div>
3028
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 00:56:11] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
3029
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
3030

    
3031
</div>
3032
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 00:56:11] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
3033

    
3034
</div>
3035
<div class="gap gMinutes"> TIME GAP = 48.9 minutes</div>
3036
<div class="warn">[D1-PROCESSING-JSVC] [WARN] [2017-05-17 00:07:17] : (ReplicationManager:requeueReplicationTask:787) In Replication Manager, task that should exist 'in process' does not
3037
  exist.  Creating new task for pid: doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
3038

    
3039
</div>
3040
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 00:07:17] : (ReplicationManager:createAndQueueTasks:390) Added 0 MNReplicationTasks to the queue for
3041
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
3042

    
3043
</div>
3044
<div class="info">[D1-PROCESSING-JSVC] [INFO] [2017-05-17 00:07:17] : (ReplicationManager:removeReplicationTasksForPid:772) removing replication tasks for pid:
3045
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
3046

    
3047
</div>
3048
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 00:07:17] : (ReplicationManager:processPid:413) Replication is not allowed for the object identified by
3049
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
3050

    
3051
</div>
3052
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 00:07:17] : (ReplicationManager:isAllowed:824) ReplicationManager.isAllowed() = false for
3053
  doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
3054

    
3055
</div>
3056
<div class="debug">[D1-PROCESSING-JSVC] [DEBUG] [2017-05-17 00:07:17] : (ReplicationManager:isAllowed:807) ReplicationManager.isAllowed() called for doi:10.6067:XCV8WM1D1X_meta$v=1493667645608
3057

    
3058
</div>
3059

    
3060
</body>
3061
</html>
Add picture from clipboard (Maximum size: 14.8 MB)