gistfile1.txt

2009-11-12 08:37:46,802 [main] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Waiting for queue workers DbManager to finish....
2009-11-12 08:37:46,803 [main] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Work queue DbManager: 0 added, 0 executed.
2009-11-12 08:37:48,282 [main] INFO  com.acnlabs.CloudMapReduce.MapReduceApp - Total input file size: 10539778. Each split size: 10539779
2009-11-12 08:37:48,284 [main] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Waiting for queue workers general to finish....
2009-11-12 08:37:51,284 [main] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - general: 100% complete
2009-11-12 08:37:51,284 [main] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Work queue general: 1 added, 1 executed.
2009-11-12 08:37:51,439 [main] INFO  com.acnlabs.CloudMapReduce.MapReduce - start setup phase
2009-11-12 08:37:51,878 [main] INFO  com.acnlabs.CloudMapReduce.MapReduce - Creating reduce queues: 
2009-11-12 08:37:51,879 [main] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Waiting for queue workers queueWorkers to finish....
2009-11-12 08:37:51,880 [queueWorkers_thread19] DEBUG com.acnlabs.CloudMapReduce.MapReduce - 0.
2009-11-12 08:37:54,880 [main] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - queueWorkers: 100% complete
2009-11-12 08:37:54,880 [main] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Work queue queueWorkers: 2 added, 2 executed.
2009-11-12 08:37:55,138 [main] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Waiting for queue workers queueWorkers to finish....
2009-11-12 08:37:55,138 [main] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Work queue queueWorkers: 2 added, 2 executed.
2009-11-12 08:37:55,138 [main] DEBUG com.acnlabs.CloudMapReduce.DbManager - wait for setup phase to complete
2009-11-12 08:37:55,437 [main] DEBUG com.acnlabs.CloudMapReduce.DbManager - Checking setup phase: 1 registered 0 running.
2009-11-12 08:37:55,437 [main] INFO  com.acnlabs.CloudMapReduce.MapReduce - start map phase
2009-11-12 08:37:55,957 [main] DEBUG com.acnlabs.CloudMapReduce.MapReduce - 0.
2009-11-12 08:37:55,967 [mapWorkers_thread1] INFO  com.acnlabs.CloudMapReduce.application.WordCount - WordCount: download /kplummer/word_10MB.txt start: 0 len: 10539778
2009-11-12 08:37:56,227 [main] DEBUG com.acnlabs.CloudMapReduce.MapReduce - 0.
2009-11-12 08:37:56,232 [mapWorkers_thread0] INFO  com.acnlabs.CloudMapReduce.application.WordCount - WordCount: download /kplummer/word_10MB.txt start: 0 len: 10539778
2009-11-12 08:44:22,840 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Waiting for queue workers map0 to finish....
2009-11-12 08:44:27,148 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Waiting for queue workers map0 to finish....
2009-11-12 08:44:54,037 [map0_thread18] ERROR com.acnlabs.CloudMapReduce.QueueManager - Fail to push message (size=7175) to queue CloudMapReduce_reduceQueue_0: Request must contain AWSAccessKeyId or X.509 certificate.
2009-11-12 08:44:56,524 [map0_thread11] ERROR com.acnlabs.CloudMapReduce.QueueManager - Fail to push message (size=7175) to queue CloudMapReduce_reduceQueue_0: The request must contain the parameter MessageBody.
2009-11-12 08:45:11,987 [map0_thread5] ERROR com.acnlabs.CloudMapReduce.QueueManager - Fail to push message (size=7178) to queue CloudMapReduce_reduceQueue_0: Internal Error
2009-11-12 08:45:13,138 [map0_thread12] ERROR com.acnlabs.CloudMapReduce.QueueManager - Fail to push message (size=7180) to queue CloudMapReduce_reduceQueue_0: Request must contain AWSAccessKeyId or X.509 certificate.
2009-11-12 08:45:13,842 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 1% complete
2009-11-12 08:45:15,368 [map0_thread18] ERROR com.acnlabs.CloudMapReduce.QueueManager - Fail to push message (size=7179) to queue CloudMapReduce_reduceQueue_0: Internal Error
2009-11-12 08:45:48,153 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 1% complete
2009-11-12 08:45:52,825 [map0_thread17] ERROR com.acnlabs.CloudMapReduce.QueueManager - Fail to push message (size=7177) to queue CloudMapReduce_reduceQueue_0: Request must contain AWSAccessKeyId or X.509 certificate.
2009-11-12 08:46:10,005 [map0_thread6] ERROR com.acnlabs.CloudMapReduce.QueueManager - Fail to push message (size=7172) to queue CloudMapReduce_reduceQueue_0: Request must contain AWSAccessKeyId or X.509 certificate.
2009-11-12 08:46:25,846 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 2% complete
2009-11-12 08:46:26,147 [map0_thread11] ERROR com.acnlabs.CloudMapReduce.QueueManager - Fail to push message (size=7182) to queue CloudMapReduce_reduceQueue_0: The request must contain the parameter MessageBody.
2009-11-12 08:46:55,847 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 3% complete
2009-11-12 08:46:56,038 [map0_thread1] ERROR com.acnlabs.CloudMapReduce.QueueManager - Fail to push message (size=7182) to queue CloudMapReduce_reduceQueue_0: Internal Error
2009-11-12 08:47:06,157 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 2% complete
2009-11-12 08:47:24,165 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 3% complete
2009-11-12 08:47:25,849 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 4% complete
2009-11-12 08:47:27,165 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 4% complete
2009-11-12 08:47:31,850 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 5% complete
2009-11-12 08:47:33,166 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 5% complete
2009-11-12 08:47:49,853 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 6% complete
2009-11-12 08:47:51,167 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 6% complete
2009-11-12 08:48:01,854 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 7% complete
2009-11-12 08:48:03,168 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 7% complete
2009-11-12 08:48:04,855 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 8% complete
2009-11-12 08:48:06,169 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 8% complete
2009-11-12 08:48:07,858 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 9% complete
2009-11-12 08:48:09,169 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 9% complete
2009-11-12 08:48:10,860 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 10% complete
2009-11-12 08:48:15,170 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 10% complete
2009-11-12 08:48:16,861 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 11% complete
2009-11-12 08:48:18,171 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 11% complete
2009-11-12 08:48:19,861 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 12% complete
2009-11-12 08:48:24,180 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 12% complete
2009-11-12 08:48:25,862 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 13% complete
2009-11-12 08:48:28,862 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 14% complete
2009-11-12 08:48:30,187 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 13% complete
2009-11-12 08:48:33,188 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 14% complete
2009-11-12 08:48:37,909 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 15% complete
2009-11-12 08:48:39,190 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 15% complete
2009-11-12 08:48:43,911 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 16% complete
2009-11-12 08:48:48,190 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 16% complete
2009-11-12 08:48:49,912 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 17% complete
2009-11-12 08:48:51,190 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 17% complete
2009-11-12 08:48:52,913 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 18% complete
2009-11-12 08:48:54,191 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 18% complete
2009-11-12 08:48:55,914 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 19% complete
2009-11-12 08:48:57,192 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 19% complete
2009-11-12 08:49:00,192 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 20% complete
2009-11-12 08:49:01,914 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 20% complete
2009-11-12 08:49:03,193 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 21% complete
2009-11-12 08:49:04,915 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 21% complete
2009-11-12 08:49:06,194 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 22% complete
2009-11-12 08:49:07,915 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 22% complete
2009-11-12 08:49:09,195 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 23% complete
2009-11-12 08:49:10,916 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 23% complete
2009-11-12 08:49:15,195 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 24% complete
2009-11-12 08:49:16,918 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 24% complete
2009-11-12 08:49:31,931 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 25% complete
2009-11-12 08:49:33,204 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 25% complete
2009-11-12 08:49:34,932 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 26% complete
2009-11-12 08:49:36,205 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 26% complete
2009-11-12 08:49:37,932 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 27% complete
2009-11-12 08:49:42,206 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 27% complete
2009-11-12 08:49:43,934 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 28% complete
2009-11-12 08:49:45,206 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 28% complete
2009-11-12 08:49:46,935 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 29% complete
2009-11-12 08:49:48,212 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 29% complete
2009-11-12 08:49:52,936 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 30% complete
2009-11-12 08:49:54,213 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 30% complete
2009-11-12 08:49:55,937 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 31% complete
2009-11-12 08:49:57,213 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 31% complete
2009-11-12 08:49:58,938 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 32% complete
2009-11-12 08:50:00,214 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 32% complete
2009-11-12 08:50:01,939 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 33% complete
2009-11-12 08:50:03,215 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 33% complete
2009-11-12 08:50:04,939 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 34% complete
2009-11-12 08:50:06,215 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 34% complete
2009-11-12 08:50:07,939 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 35% complete
2009-11-12 08:50:10,940 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 36% complete
2009-11-12 08:50:12,218 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 35% complete
2009-11-12 08:50:15,218 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 36% complete
2009-11-12 08:50:16,941 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 37% complete
2009-11-12 08:50:18,225 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 37% complete
2009-11-12 08:50:19,943 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 38% complete
2009-11-12 08:50:24,226 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 38% complete
2009-11-12 08:50:25,944 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 39% complete
2009-11-12 08:50:27,226 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 39% complete
2009-11-12 08:50:28,944 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 40% complete
2009-11-12 08:50:30,233 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 40% complete
2009-11-12 08:50:31,945 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 41% complete
2009-11-12 08:50:33,234 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 41% complete
2009-11-12 08:50:34,946 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 42% complete
2009-11-12 08:50:39,234 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 42% complete
2009-11-12 08:50:40,947 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 43% complete
2009-11-12 08:50:42,238 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 43% complete
2009-11-12 08:50:43,947 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 44% complete
2009-11-12 08:50:45,239 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 44% complete
2009-11-12 08:50:46,948 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 45% complete
2009-11-12 08:50:48,239 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 45% complete
2009-11-12 08:50:49,948 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 46% complete
2009-11-12 08:50:51,240 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 46% complete
2009-11-12 08:50:52,949 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 47% complete
2009-11-12 08:50:54,241 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 47% complete
2009-11-12 08:50:55,949 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 48% complete
2009-11-12 08:50:57,241 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 48% complete
2009-11-12 08:50:58,954 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 49% complete
2009-11-12 08:51:00,243 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 49% complete
2009-11-12 08:51:01,955 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 50% complete
2009-11-12 08:51:03,243 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 50% complete
2009-11-12 08:51:04,956 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 51% complete
2009-11-12 08:51:06,243 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 51% complete
2009-11-12 08:51:07,956 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 52% complete
2009-11-12 08:51:09,244 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 52% complete
2009-11-12 08:51:10,960 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 53% complete
2009-11-12 08:51:12,244 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 53% complete
2009-11-12 08:51:15,245 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 54% complete
2009-11-12 08:51:16,963 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 54% complete
2009-11-12 08:51:19,964 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 55% complete
2009-11-12 08:51:21,248 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 55% complete
2009-11-12 08:51:22,965 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 56% complete
2009-11-12 08:51:24,248 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 56% complete
2009-11-12 08:51:27,252 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 57% complete
2009-11-12 08:51:28,965 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 57% complete
2009-11-12 08:51:33,253 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 58% complete
2009-11-12 08:51:34,966 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 58% complete
2009-11-12 08:51:36,253 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 59% complete
2009-11-12 08:51:37,966 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 59% complete
2009-11-12 08:51:42,253 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 60% complete
2009-11-12 08:51:43,966 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 60% complete
2009-11-12 08:51:46,967 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 61% complete
2009-11-12 08:51:48,254 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 61% complete
2009-11-12 08:51:49,967 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 62% complete
2009-11-12 08:51:54,254 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 62% complete
2009-11-12 08:51:55,968 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 63% complete
2009-11-12 08:51:57,255 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 63% complete
2009-11-12 08:52:01,968 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 64% complete
2009-11-12 08:52:03,255 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 64% complete
2009-11-12 08:52:06,255 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 65% complete
2009-11-12 08:52:07,973 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 65% complete
2009-11-12 08:52:09,256 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 66% complete
2009-11-12 08:52:13,973 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 66% complete
2009-11-12 08:52:15,256 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 67% complete
2009-11-12 08:52:16,974 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 67% complete
2009-11-12 08:52:18,256 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 68% complete
2009-11-12 08:52:22,974 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 68% complete
2009-11-12 08:52:27,257 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 69% complete
2009-11-12 08:52:37,975 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 69% complete
2009-11-12 08:52:39,259 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 70% complete
2009-11-12 08:52:43,976 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 70% complete
2009-11-12 08:52:45,259 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 71% complete
2009-11-12 08:52:49,976 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 71% complete
2009-11-12 08:52:54,260 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 72% complete
2009-11-12 08:53:16,978 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 72% complete
2009-11-12 08:53:48,427 [map0_thread3] ERROR com.acnlabs.CloudMapReduce.QueueManager - Fail to push message (size=7184) to queue CloudMapReduce_reduceQueue_0: The request must contain the parameter MessageBody.
2009-11-12 08:53:53,054 [map0_thread6] ERROR com.acnlabs.CloudMapReduce.QueueManager - Fail to push message (size=7183) to queue CloudMapReduce_reduceQueue_0: The request must contain the parameter MessageBody.
2009-11-12 08:53:53,982 [map0_thread7] ERROR com.acnlabs.CloudMapReduce.QueueManager - Fail to push message (size=7181) to queue CloudMapReduce_reduceQueue_0: The request must contain the parameter MessageBody.
2009-11-12 08:53:54,730 [map0_thread17] ERROR com.acnlabs.CloudMapReduce.QueueManager - Fail to push message (size=7177) to queue CloudMapReduce_reduceQueue_0: Internal Error
2009-11-12 08:53:55,713 [map0_thread15] ERROR com.acnlabs.CloudMapReduce.QueueManager - Fail to push message (size=7184) to queue CloudMapReduce_reduceQueue_0: The request must contain the parameter MessageBody.
2009-11-12 08:54:01,269 [map0_thread4] ERROR com.acnlabs.CloudMapReduce.QueueManager - Fail to push message (size=7170) to queue CloudMapReduce_reduceQueue_0: The request must contain the parameter MessageBody.
2009-11-12 08:54:28,824 [map0_thread11] ERROR com.acnlabs.CloudMapReduce.QueueManager - Fail to push message (size=7129) to queue CloudMapReduce_reduceQueue_0: The request must contain the parameter MessageBody.
2009-11-12 08:54:39,191 [map0_thread14] ERROR com.acnlabs.CloudMapReduce.QueueManager - Fail to push message (size=7176) to queue CloudMapReduce_reduceQueue_0: The request must contain the parameter MessageBody.
2009-11-12 08:54:42,281 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 73% complete
2009-11-12 08:54:43,209 [map0_thread1] ERROR com.acnlabs.CloudMapReduce.QueueManager - Fail to push message (size=7171) to queue CloudMapReduce_reduceQueue_0: Internal Error
2009-11-12 08:54:44,705 [map0_thread17] ERROR com.acnlabs.CloudMapReduce.QueueManager - Fail to push message (size=7175) to queue CloudMapReduce_reduceQueue_0: The request must contain the parameter MessageBody.
2009-11-12 08:54:45,047 [map0_thread0] ERROR com.acnlabs.CloudMapReduce.QueueManager - Fail to push message (size=7175) to queue CloudMapReduce_reduceQueue_0: Internal Error
2009-11-12 08:54:51,281 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 74% complete
2009-11-12 08:54:51,842 [map0_thread9] ERROR com.acnlabs.CloudMapReduce.QueueManager - Fail to push message (size=7174) to queue CloudMapReduce_reduceQueue_0: Internal Error
2009-11-12 08:54:52,983 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 73% complete
2009-11-12 08:54:58,984 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 74% complete
2009-11-12 08:55:03,282 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 75% complete
2009-11-12 08:55:35,150 [map0_thread17] ERROR com.acnlabs.CloudMapReduce.QueueManager - Fail to push message (size=7178) to queue CloudMapReduce_reduceQueue_0: Request must contain AWSAccessKeyId or X.509 certificate.
2009-11-12 08:55:43,004 [map0_thread1] ERROR com.acnlabs.CloudMapReduce.QueueManager - Fail to push message (size=7172) to queue CloudMapReduce_reduceQueue_0: Request must contain AWSAccessKeyId or X.509 certificate.
2009-11-12 08:55:43,580 [map0_thread12] ERROR com.acnlabs.CloudMapReduce.QueueManager - Fail to push message (size=7157) to queue CloudMapReduce_reduceQueue_0: The request must contain the parameter MessageBody.
2009-11-12 08:55:44,850 [map0_thread11] ERROR com.acnlabs.CloudMapReduce.QueueManager - Fail to push message (size=7176) to queue CloudMapReduce_reduceQueue_0: Request must contain AWSAccessKeyId or X.509 certificate.
2009-11-12 08:55:46,986 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 75% complete
2009-11-12 08:55:48,294 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 76% complete
2009-11-12 08:55:55,987 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 76% complete
2009-11-12 08:55:57,295 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 77% complete
2009-11-12 08:56:01,988 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 77% complete
2009-11-12 08:56:03,295 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 78% complete
2009-11-12 08:56:04,988 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 78% complete
2009-11-12 08:56:06,295 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 79% complete
2009-11-12 08:56:09,296 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 80% complete
2009-11-12 08:56:13,989 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 79% complete
2009-11-12 08:56:15,296 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 81% complete
2009-11-12 08:56:16,989 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 80% complete
2009-11-12 08:56:18,297 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 82% complete
2009-11-12 08:56:19,989 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 81% complete
2009-11-12 08:56:21,297 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 83% complete
2009-11-12 08:56:22,989 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 82% complete
2009-11-12 08:56:27,297 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 84% complete
2009-11-12 08:56:31,990 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 83% complete
2009-11-12 08:56:33,298 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 86% complete
2009-11-12 08:56:34,990 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 85% complete
2009-11-12 08:56:39,298 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 87% complete
2009-11-12 08:56:40,991 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 86% complete
2009-11-12 08:56:46,991 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 87% complete
2009-11-12 08:56:48,299 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 88% complete
2009-11-12 08:56:55,992 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 88% complete
2009-11-12 08:57:03,300 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 89% complete
2009-11-12 08:57:07,993 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 89% complete
2009-11-12 08:57:16,993 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 90% complete
2009-11-12 08:57:18,301 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 90% complete
2009-11-12 08:57:22,994 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 91% complete
2009-11-12 08:57:24,301 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 91% complete
2009-11-12 08:57:27,301 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 92% complete
2009-11-12 08:57:28,994 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 92% complete
2009-11-12 08:57:33,302 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 93% complete
2009-11-12 08:57:34,995 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 93% complete
2009-11-12 08:57:48,303 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 94% complete
2009-11-12 08:57:49,995 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 94% complete
2009-11-12 08:57:51,303 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 95% complete
2009-11-12 08:57:54,303 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 96% complete
2009-11-12 08:57:55,996 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 95% complete
2009-11-12 08:58:06,304 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 97% complete
2009-11-12 08:58:07,997 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 97% complete
2009-11-12 08:58:09,304 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 98% complete
2009-11-12 08:58:10,997 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 98% complete
2009-11-12 08:58:12,305 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 100% complete
2009-11-12 08:58:12,305 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Work queue map0: 2779 added, 2779 executed.
2009-11-12 08:58:12,788 [main] DEBUG com.acnlabs.CloudMapReduce.MapReduce - 0.
2009-11-12 08:58:12,792 [mapWorkers_thread0] INFO  com.acnlabs.CloudMapReduce.application.WordCount - WordCount: download /kplummer/word_10MB.txt start: 0 len: 10539778
2009-11-12 08:58:13,997 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 99% complete
2009-11-12 08:58:16,998 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 100% complete
2009-11-12 08:58:16,998 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Work queue map0: 2779 added, 2779 executed.
2009-11-12 08:58:17,143 [main] DEBUG com.acnlabs.CloudMapReduce.MapReduce - 0.
2009-11-12 08:58:17,152 [mapWorkers_thread1] INFO  com.acnlabs.CloudMapReduce.application.WordCount - WordCount: download /kplummer/word_50MB.txt start: 0 len: 52472758
2009-11-12 08:58:19,187 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Waiting for queue workers map0 to finish....
2009-11-12 08:58:19,187 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Work queue map0: 0 added, 0 executed.
2009-11-12 08:58:19,529 [main] DEBUG com.acnlabs.CloudMapReduce.MapReduce - 0.
2009-11-12 08:58:19,551 [mapWorkers_thread1] INFO  com.acnlabs.CloudMapReduce.application.WordCount - WordCount: download /kplummer/word_10MB.txt start: 0 len: 10539778
2009-11-12 08:59:53,272 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Waiting for queue workers map0 to finish....
2009-11-12 08:59:56,100 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Waiting for queue workers map0 to finish....
2009-11-12 08:59:56,276 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 1% complete
2009-11-12 08:59:59,100 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 1% complete
2009-11-12 08:59:59,279 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 2% complete
2009-11-12 09:00:02,100 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 2% complete
2009-11-12 09:00:02,279 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 3% complete
2009-11-12 09:00:05,101 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 3% complete
2009-11-12 09:00:05,280 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 5% complete
2009-11-12 09:00:08,101 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 4% complete
2009-11-12 09:00:08,280 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 6% complete
2009-11-12 09:00:11,102 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 6% complete
2009-11-12 09:00:11,280 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 7% complete
2009-11-12 09:00:14,102 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 7% complete
2009-11-12 09:00:14,282 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 9% complete
2009-11-12 09:00:17,102 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 9% complete
2009-11-12 09:00:17,284 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 11% complete
2009-11-12 09:00:20,103 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 11% complete
2009-11-12 09:00:20,284 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 12% complete
2009-11-12 09:00:23,103 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 12% complete
2009-11-12 09:00:23,285 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 13% complete
2009-11-12 09:00:26,287 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 14% complete
2009-11-12 09:00:29,103 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 13% complete
2009-11-12 09:00:29,287 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 15% complete
2009-11-12 09:00:35,104 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 14% complete
2009-11-12 09:00:35,287 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 16% complete
2009-11-12 09:00:41,104 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 15% complete
2009-11-12 09:00:41,288 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 17% complete
2009-11-12 09:00:56,105 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 16% complete
2009-11-12 09:00:56,289 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 18% complete
2009-11-12 09:01:08,290 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 19% complete
2009-11-12 09:01:11,106 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 17% complete
2009-11-12 09:01:20,290 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 20% complete
2009-11-12 09:01:23,107 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 18% complete
2009-11-12 09:01:32,291 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 21% complete
2009-11-12 09:01:35,107 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 19% complete
2009-11-12 09:01:38,292 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 22% complete
2009-11-12 09:01:47,108 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 20% complete
2009-11-12 09:01:50,293 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 23% complete
2009-11-12 09:01:59,109 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 21% complete
2009-11-12 09:01:59,293 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 24% complete
2009-11-12 09:02:05,294 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 25% complete
2009-11-12 09:02:08,110 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 22% complete
2009-11-12 09:02:11,294 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 26% complete
2009-11-12 09:02:17,110 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 23% complete
2009-11-12 09:02:20,295 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 27% complete
2009-11-12 09:02:23,111 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 24% complete
2009-11-12 09:02:26,295 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 28% complete
2009-11-12 09:02:32,111 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 25% complete
2009-11-12 09:02:32,296 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 29% complete
2009-11-12 09:02:38,112 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 26% complete
2009-11-12 09:02:38,296 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 30% complete
2009-11-12 09:02:41,112 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 27% complete
2009-11-12 09:02:41,297 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 31% complete
2009-11-12 09:02:47,113 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 28% complete
2009-11-12 09:02:47,297 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 32% complete
2009-11-12 09:02:50,113 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 29% complete
2009-11-12 09:02:50,298 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 34% complete
2009-11-12 09:02:53,298 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 35% complete
2009-11-12 09:02:59,114 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 30% complete
2009-11-12 09:02:59,299 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 36% complete
2009-11-12 09:03:05,114 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 32% complete
2009-11-12 09:03:05,299 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 37% complete
2009-11-12 09:03:08,114 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 33% complete
2009-11-12 09:03:08,299 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 38% complete
2009-11-12 09:03:11,115 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 34% complete
2009-11-12 09:03:11,300 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 39% complete
2009-11-12 09:03:14,115 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 35% complete
2009-11-12 09:03:14,300 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 40% complete
2009-11-12 09:03:17,115 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 36% complete
2009-11-12 09:03:17,300 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 41% complete
2009-11-12 09:03:35,116 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 37% complete
2009-11-12 09:03:38,117 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 38% complete
2009-11-12 09:03:41,302 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 42% complete
2009-11-12 09:03:44,117 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 39% complete
2009-11-12 09:03:47,118 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 40% complete
2009-11-12 09:03:47,302 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 43% complete
2009-11-12 09:03:50,302 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 44% complete
2009-11-12 09:03:53,118 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 41% complete
2009-11-12 09:03:53,303 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 45% complete
2009-11-12 09:03:56,303 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 46% complete
2009-11-12 09:03:59,119 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 42% complete
2009-11-12 09:03:59,303 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 47% complete
2009-11-12 09:04:05,119 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 43% complete
2009-11-12 09:04:05,304 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 48% complete
2009-11-12 09:04:08,120 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 44% complete
2009-11-12 09:04:11,305 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 49% complete
2009-11-12 09:04:17,121 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 45% complete
2009-11-12 09:04:17,306 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 50% complete
2009-11-12 09:04:32,122 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 46% complete
2009-11-12 09:04:44,307 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 51% complete
2009-11-12 09:04:50,123 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 47% complete
2009-11-12 09:04:50,307 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 52% complete
2009-11-12 09:04:53,124 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 48% complete
2009-11-12 09:04:53,308 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 53% complete
2009-11-12 09:04:56,127 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 49% complete
2009-11-12 09:04:56,308 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 54% complete
2009-11-12 09:04:59,127 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 50% complete
2009-11-12 09:04:59,308 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 55% complete
2009-11-12 09:05:02,309 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 56% complete
2009-11-12 09:05:05,128 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 51% complete
2009-11-12 09:05:05,309 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 57% complete
2009-11-12 09:05:08,128 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 53% complete
2009-11-12 09:05:08,310 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 58% complete
2009-11-12 09:05:11,129 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 54% complete
2009-11-12 09:05:11,310 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 59% complete
2009-11-12 09:05:14,310 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 60% complete
2009-11-12 09:05:17,129 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 55% complete
2009-11-12 09:05:17,311 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 61% complete
2009-11-12 09:05:20,129 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 56% complete
2009-11-12 09:05:20,311 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 62% complete
2009-11-12 09:05:23,130 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 57% complete
2009-11-12 09:05:23,311 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 63% complete
2009-11-12 09:05:26,130 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 58% complete
2009-11-12 09:05:26,312 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 65% complete
2009-11-12 09:05:29,131 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 59% complete
2009-11-12 09:05:29,312 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 66% complete
2009-11-12 09:05:41,132 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 60% complete
2009-11-12 09:05:59,314 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 67% complete
2009-11-12 09:05:59,984 [map0_thread8] ERROR com.acnlabs.CloudMapReduce.QueueManager - Fail to push message (size=7181) to queue CloudMapReduce_reduceQueue_0: Request must contain AWSAccessKeyId or X.509 certificate.
2009-11-12 09:06:02,133 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 61% complete
2009-11-12 09:06:03,895 [map0_thread12] ERROR com.acnlabs.CloudMapReduce.QueueManager - Fail to push message (size=7178) to queue CloudMapReduce_reduceQueue_0: Request must contain AWSAccessKeyId or X.509 certificate.
2009-11-12 09:06:17,134 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 62% complete
2009-11-12 09:06:20,315 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 68% complete
2009-11-12 09:06:23,134 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 63% complete
2009-11-12 09:06:26,315 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 69% complete
2009-11-12 09:06:35,135 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 64% complete
2009-11-12 09:06:35,316 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 70% complete
2009-11-12 09:06:44,136 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 65% complete
2009-11-12 09:06:44,316 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 71% complete
2009-11-12 09:06:53,136 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 66% complete
2009-11-12 09:06:56,317 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 72% complete
2009-11-12 09:07:02,137 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 67% complete
2009-11-12 09:07:05,318 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 73% complete
2009-11-12 09:07:11,137 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 68% complete
2009-11-12 09:07:14,318 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 74% complete
2009-11-12 09:07:17,138 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 69% complete
2009-11-12 09:07:20,319 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 75% complete
2009-11-12 09:07:23,138 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 70% complete
2009-11-12 09:07:26,319 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 76% complete
2009-11-12 09:07:29,139 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 71% complete
2009-11-12 09:07:32,320 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 77% complete
2009-11-12 09:07:41,140 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 72% complete
2009-11-12 09:07:47,321 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 78% complete
2009-11-12 09:07:53,140 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 73% complete
2009-11-12 09:08:02,141 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 74% complete
2009-11-12 09:08:02,322 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 79% complete
2009-11-12 09:08:05,141 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 75% complete
2009-11-12 09:08:05,322 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 80% complete
2009-11-12 09:08:08,142 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 77% complete
2009-11-12 09:08:08,322 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 82% complete
2009-11-12 09:08:11,142 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 78% complete
2009-11-12 09:08:11,323 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 83% complete
2009-11-12 09:08:14,142 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 79% complete
2009-11-12 09:08:14,323 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 84% complete
2009-11-12 09:08:17,143 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 80% complete
2009-11-12 09:08:17,323 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 85% complete
2009-11-12 09:08:20,143 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 82% complete
2009-11-12 09:08:20,323 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 86% complete
2009-11-12 09:08:23,144 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 83% complete
2009-11-12 09:08:23,324 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 88% complete
2009-11-12 09:08:26,144 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 85% complete
2009-11-12 09:08:26,324 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 89% complete
2009-11-12 09:08:29,144 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 86% complete
2009-11-12 09:08:29,324 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 91% complete
2009-11-12 09:08:32,145 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 87% complete
2009-11-12 09:08:32,325 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 92% complete
2009-11-12 09:08:35,145 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 89% complete
2009-11-12 09:08:35,325 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 93% complete
2009-11-12 09:08:38,326 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 94% complete
2009-11-12 09:08:41,145 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 90% complete
2009-11-12 09:08:41,326 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 95% complete
2009-11-12 09:08:44,146 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 91% complete
2009-11-12 09:08:47,327 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 96% complete
2009-11-12 09:08:50,146 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 92% complete
2009-11-12 09:08:53,327 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 97% complete
2009-11-12 09:08:59,147 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 93% complete
2009-11-12 09:09:08,148 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 94% complete
2009-11-12 09:09:08,328 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 99% complete
2009-11-12 09:09:11,148 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 95% complete
2009-11-12 09:09:14,148 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 97% complete
2009-11-12 09:09:14,328 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 100% complete
2009-11-12 09:09:14,329 [mapWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Work queue map0: 2779 added, 2779 executed.
2009-11-12 09:09:15,068 [main] DEBUG com.acnlabs.CloudMapReduce.MapReduce - 0.
2009-11-12 09:09:15,082 [mapWorkers_thread0] INFO  com.acnlabs.CloudMapReduce.application.WordCount - WordCount: download /kplummer/word_10MB.txt start: 0 len: 10539778
2009-11-12 09:09:17,149 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 98% complete
2009-11-12 09:09:20,149 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 99% complete
2009-11-12 09:09:23,150 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - map0: 100% complete
2009-11-12 09:09:23,150 [mapWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Work queue map0: 2779 added, 2779 executed.
2009-11-12 09:09:24,198 [main] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Waiting for queue workers DbManager to finish....
2009-11-12 09:09:27,198 [main] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - DbManager: 100% complete
2009-11-12 09:09:27,198 [main] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Work queue DbManager: 1 added, 1 executed.
2009-11-12 09:09:27,199 [main] DEBUG com.acnlabs.CloudMapReduce.DbManager - Done 1 maps, waiting for 1
2009-11-12 09:09:27,199 [main] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Waiting for queue workers DbManager to finish....
2009-11-12 09:09:30,199 [main] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - DbManager: 100% complete
2009-11-12 09:09:30,199 [main] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Work queue DbManager: 2 added, 2 executed.
2009-11-12 09:09:30,199 [main] INFO  com.acnlabs.CloudMapReduce.MapReduce - start reduce phase
2009-11-12 09:09:31,229 [reduceWorkers_thread3] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Waiting for queue workers DbManager to finish....
2009-11-12 09:09:34,229 [reduceWorkers_thread3] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - DbManager: 100% complete
2009-11-12 09:09:34,229 [reduceWorkers_thread3] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Work queue DbManager: 3 added, 3 executed.
2009-11-12 09:09:34,235 [reduceWorkers_thread2] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Waiting for queue workers DbManager to finish....
2009-11-12 09:09:37,235 [reduceWorkers_thread2] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - DbManager: 100% complete
2009-11-12 09:09:37,235 [reduceWorkers_thread2] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Work queue DbManager: 4 added, 4 executed.
2009-11-12 09:09:37,236 [reduceWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Waiting for queue workers DbManager to finish....
2009-11-12 09:09:37,265 [reduceWorkers_thread3] WARN  com.acnlabs.CloudMapReduce.MapReduce - ReduceRunnable Exception: String index out of range: -1
2009-11-12 09:09:37,952 [reduce0_thread12] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_71 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:09:37,952 [reduce0_thread12] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_101 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:09:38,564 [reduce0_thread15] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_112 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:09:38,564 [reduce0_thread15] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_168 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:09:39,062 [reduce0_thread8] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_94 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:09:39,062 [reduce0_thread8] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_110 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:09:39,062 [reduce0_thread8] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_134 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:09:39,062 [reduce0_thread8] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_162 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:09:40,042 [reduce0_thread16] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_67 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:09:40,043 [reduce0_thread16] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_106 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:09:40,238 [reduceWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - DbManager: 100% complete
2009-11-12 09:09:40,238 [reduceWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Work queue DbManager: 5 added, 5 executed.
2009-11-12 09:09:40,238 [reduceWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Waiting for queue workers DbManager to finish....
2009-11-12 09:09:40,972 [reduce0_thread14] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_26 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:09:40,972 [reduce0_thread14] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_51 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:09:40,972 [reduce0_thread14] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_53 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:09:40,972 [reduce0_thread14] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_61 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:09:43,238 [reduceWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - DbManager: 100% complete
2009-11-12 09:09:43,238 [reduceWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Work queue DbManager: 6 added, 6 executed.
2009-11-12 09:09:43,239 [reduceWorkers_thread3] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Waiting for queue workers DbManager to finish....
2009-11-12 09:09:43,347 [reduceWorkers_thread2] INFO  com.acnlabs.CloudMapReduce.MapReduce - start conflict resolution
2009-11-12 09:09:46,244 [reduceWorkers_thread0] INFO  com.acnlabs.CloudMapReduce.MapReduce - start conflict resolution
2009-11-12 09:09:49,239 [reduceWorkers_thread3] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - DbManager: 100% complete
2009-11-12 09:09:49,239 [reduceWorkers_thread3] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Work queue DbManager: 7 added, 7 executed.
2009-11-12 09:09:49,252 [reduceWorkers_thread1] INFO  com.acnlabs.CloudMapReduce.MapReduce - start conflict resolution
2009-11-12 09:09:54,102 [reduceWorkers_thread0] INFO  com.acnlabs.CloudMapReduce.MapReduce - resolution winner is task0_+eXJYhj5rDrfRoyBvTFx/r7WTBqmmAOf2RujXcLMFLF0DJ3gVOmjI2Gh/oFnb0IeJqy5Zc8kH4LX5fdVFQUb8jaAPSeOkXQZNVCeKIYQb27lgLFFITfzza4WVLpMJHQAW1p0MfPYTvOnWFPIR74+6A/vMi2zGXZietJiawiNPVc=
2009-11-12 09:09:55,245 [reduceWorkers_thread3] INFO  com.acnlabs.CloudMapReduce.MapReduce - start conflict resolution
2009-11-12 09:09:57,425 [reduceWorkers_thread3] INFO  com.acnlabs.CloudMapReduce.MapReduce - resolution winner is task0_+eXJYhj5rDpqyTcjPVFjHhw0djRTStHl8Wkdosw1855xwaxJnzHTltgjYiJCA/h8Jqy5Zc8kH4LDAA1Ww6R4FDaAPSeOkXQZEaEA/7g0SSe60F4g6clnFLXcRYoxtP2FHuvjRwxvB+xlCcb3zgGW712/3erde7HW/4vNy8OeEQI=
2009-11-12 09:09:59,062 [reduce0_thread4] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_140 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:09:59,062 [reduce0_thread4] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_4 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:09:59,067 [reduce0_thread19] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_12 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:09:59,067 [reduce0_thread19] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_15 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:09:59,269 [reduceWorkers_thread2] INFO  com.acnlabs.CloudMapReduce.MapReduce - resolution winner is task0_+eXJYhj5rDqV0QFALKFb6u3v7jacVt4chsHGgv1nW050DJ3gVOmjI2Gh/oFnb0IeJqy5Zc8kH4LX5fdVFQUb8jaAPSeOkXQZC5QgoJkM6Jsxw5ZShQ8CQF/BACyHATqQDvA882K3iuYFxtNVsJ7W6dh0El70qrOgV6nlP+VwRAs=
2009-11-12 09:09:59,270 [reduceWorkers_thread2] WARN  com.acnlabs.CloudMapReduce.MapReduce - ReduceRunnable Exception: String index out of range: -1
2009-11-12 09:09:59,475 [reduce0_thread7] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_21 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:09:59,475 [reduce0_thread7] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_32 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:09:59,475 [reduce0_thread7] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_33 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:09:59,527 [reduceWorkers_thread2] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Waiting for queue workers DbManager to finish....
2009-11-12 09:09:59,947 [reduce0_thread16] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_7 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:09:59,947 [reduce0_thread16] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_24 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:09:59,947 [reduce0_thread16] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_48 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:00,102 [reduceWorkers_thread0] INFO  com.acnlabs.CloudMapReduce.MapReduce - start conflict resolution
2009-11-12 09:10:00,426 [reduceWorkers_thread3] WARN  com.acnlabs.CloudMapReduce.MapReduce - ReduceRunnable Exception: String index out of range: -1
2009-11-12 09:10:00,528 [reduce0_thread0] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_19 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:00,528 [reduce0_thread0] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_30 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:00,528 [reduce0_thread0] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_1 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:00,529 [reduce0_thread0] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_2 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:00,829 [reduceWorkers_thread0] INFO  com.acnlabs.CloudMapReduce.MapReduce - resolution winner is task0_+eXJYhj5rDrfRoyBvTFx/r7WTBqmmAOf2RujXcLMFLF0DJ3gVOmjI2Gh/oFnb0IeJqy5Zc8kH4LX5fdVFQUb8jaAPSeOkXQZNVCeKIYQb27lgLFFITfzza4WVLpMJHQAW1p0MfPYTvOnWFPIR74+6A/vMi2zGXZietJiawiNPVc=
2009-11-12 09:10:00,832 [reduce0_thread5] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_62 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:02,527 [reduceWorkers_thread2] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - DbManager: 100% complete
2009-11-12 09:10:02,527 [reduceWorkers_thread2] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Work queue DbManager: 8 added, 8 executed.
2009-11-12 09:10:02,528 [reduceWorkers_thread3] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Waiting for queue workers DbManager to finish....
2009-11-12 09:10:05,300 [reduce0_thread1] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_113 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:05,830 [reduceWorkers_thread0] WARN  com.acnlabs.CloudMapReduce.MapReduce - ReduceRunnable Exception: String index out of range: -1
2009-11-12 09:10:08,528 [reduceWorkers_thread3] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - DbManager: 100% complete
2009-11-12 09:10:08,528 [reduceWorkers_thread3] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Work queue DbManager: 9 added, 9 executed.
2009-11-12 09:10:08,544 [reduceWorkers_thread2] INFO  com.acnlabs.CloudMapReduce.MapReduce - start conflict resolution
2009-11-12 09:10:14,559 [reduceWorkers_thread3] INFO  com.acnlabs.CloudMapReduce.MapReduce - start conflict resolution
2009-11-12 09:10:16,506 [reduceWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Waiting for queue workers DbManager to finish....
2009-11-12 09:10:18,516 [reduceWorkers_thread1] INFO  com.acnlabs.CloudMapReduce.MapReduce - resolution winner is task0_+eXJYhj5rDrfRoyBvTFx/r7WTBqmmAOf2RujXcLMFLF0DJ3gVOmjI2Gh/oFnb0IeJqy5Zc8kH4LX5fdVFQUb8jaAPSeOkXQZNVCeKIYQb27lgLFFITfzza4WVLpMJHQAW1p0MfPYTvOnWFPIR74+6A/vMi2zGXZietJiawiNPVc=
2009-11-12 09:10:18,592 [reduce0_thread6] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_46 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:18,592 [reduce0_thread6] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_54 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:18,592 [reduce0_thread6] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_72 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:18,679 [reduceWorkers_thread1] WARN  com.acnlabs.CloudMapReduce.MapReduce - ReduceRunnable Exception: String index out of range: -1
2009-11-12 09:10:20,685 [reduceWorkers_thread2] INFO  com.acnlabs.CloudMapReduce.MapReduce - resolution winner is task0_+eXJYhj5rDqH0HLPoWnMkHMtMlFQnCGPEZzcTvF36yFxwaxJnzHTltgjYiJCA/h8Jqy5Zc8kH4LDAA1Ww6R4FDaAPSeOkXQZ7yuaiVeXN+/k+q4NmrPWceklJptyGtpuqPokVdjtk/l6ExmEQrVBEkKVD2SZH+JCpTJH8i+AtmU=
2009-11-12 09:10:22,507 [reduceWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - DbManager: 100% complete
2009-11-12 09:10:22,508 [reduceWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Work queue DbManager: 10 added, 10 executed.
2009-11-12 09:10:26,687 [reduceWorkers_thread2] INFO  com.acnlabs.CloudMapReduce.MapReduce - start conflict resolution
2009-11-12 09:10:27,738 [reduceWorkers_thread3] INFO  com.acnlabs.CloudMapReduce.MapReduce - resolution winner is task0_+eXJYhj5rDoAKBHr1ThZM+N0Un5edVaWYGewNR8WFNl0DJ3gVOmjI2Gh/oFnb0IeJqy5Zc8kH4LX5fdVFQUb8jaAPSeOkXQZpvxLIY0Nk9SpxcsQtJC+Bf75c27HRoK4VeZzyrGsuCXUou2Fhzj8gfxpUYMku6QhAWYeAzosW7g=
2009-11-12 09:10:28,516 [reduceWorkers_thread0] INFO  com.acnlabs.CloudMapReduce.MapReduce - start conflict resolution
2009-11-12 09:10:30,026 [reduce0_thread12] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_36 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:30,026 [reduce0_thread12] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_7 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:30,027 [reduce0_thread12] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_16 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:31,146 [reduceWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Waiting for queue workers DbManager to finish....
2009-11-12 09:10:32,458 [reduce0_thread3] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_21 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:32,458 [reduce0_thread3] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_31 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:32,458 [reduce0_thread3] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_18 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:32,692 [reduce0_thread2] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_185 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:32,692 [reduce0_thread2] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_18 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:33,738 [reduceWorkers_thread3] INFO  com.acnlabs.CloudMapReduce.MapReduce - start conflict resolution
2009-11-12 09:10:34,146 [reduceWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - DbManager: 100% complete
2009-11-12 09:10:34,146 [reduceWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Work queue DbManager: 11 added, 11 executed.
2009-11-12 09:10:40,151 [reduceWorkers_thread1] INFO  com.acnlabs.CloudMapReduce.MapReduce - start conflict resolution
2009-11-12 09:10:42,962 [reduceWorkers_thread1] INFO  com.acnlabs.CloudMapReduce.MapReduce - resolution winner is task0_+eXJYhj5rDqH0HLPoWnMkMfR88amixL5cHvvBG4oGHhBIyeuQznGDtQ+RmA+dbqzJqy5Zc8kH4Lyj/jXR/Yr9jaAPSeOkXQZWhgXU6kjdgdkPfFE1n34+OCoaTnmUYKu2/Jl1FknQL5CglNnDNpNmR6xzeBp/4IK/mLjSzHD51A=
2009-11-12 09:10:43,380 [reduce0_thread12] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_18 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:43,380 [reduce0_thread12] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_23 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:43,932 [reduce0_thread0] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_49 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:43,932 [reduce0_thread0] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_26 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:43,932 [reduce0_thread0] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_59 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:43,932 [reduce0_thread0] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_84 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:43,932 [reduce0_thread0] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_69 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:43,932 [reduce0_thread0] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_20 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:44,648 [reduceWorkers_thread0] INFO  com.acnlabs.CloudMapReduce.MapReduce - resolution winner is task0_+eXJYhj5rDqH0HLPoWnMkMfR88amixL5cHvvBG4oGHhBIyeuQznGDtQ+RmA+dbqzJqy5Zc8kH4Lyj/jXR/Yr9jaAPSeOkXQZWhgXU6kjdgdkPfFE1n34+OCoaTnmUYKu2/Jl1FknQL5CglNnDNpNmR6xzeBp/4IK/mLjSzHD51A=
2009-11-12 09:10:45,042 [reduce0_thread17] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_149 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:45,245 [reduce0_thread19] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_79 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:45,247 [reduce0_thread11] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_89 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:45,247 [reduce0_thread11] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_16 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:45,247 [reduce0_thread11] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_20 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:45,671 [reduceWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.MapReduce - 0: Processed 5393 out of total 1471075
2009-11-12 09:10:45,979 [reduceWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.MapReduce - 0: Processed 5504 out of total 1471075
2009-11-12 09:10:47,547 [reduce0_thread19] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_303 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:47,547 [reduce0_thread19] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_320 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:47,691 [reduceWorkers_thread0] DEBUG com.acnlabs.CloudMapReduce.MapReduce - 0: Processed 10857 out of total 1471075
2009-11-12 09:10:48,002 [reduceWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.MapReduce - 0: Processed 9780 out of total 1471075
2009-11-12 09:10:50,012 [reduceWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.MapReduce - 0: Processed 15675 out of total 1471075
2009-11-12 09:10:54,024 [reduceWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.MapReduce - 0: Processed 21246 out of total 1471075
2009-11-12 09:10:54,692 [reduceWorkers_thread0] INFO  com.acnlabs.CloudMapReduce.MapReduce - start conflict resolution
2009-11-12 09:10:54,749 [reduce0_thread6] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_8 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:54,749 [reduce0_thread6] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_15 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:54,749 [reduce0_thread6] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_42 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:54,749 [reduce0_thread6] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_48 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:54,749 [reduce0_thread6] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_74 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:55,277 [reduce0_thread1] WARN  com.acnlabs.CloudMapReduce.QueueManager - Fail to pop from queue CloudMapReduce_reduceQueue_0. Caller will retry. XML: null. Caused by: java.net.SocketTimeoutException: Read timed out
2009-11-12 09:10:55,279 [reduceWorkers_thread2] INFO  com.acnlabs.CloudMapReduce.MapReduce - resolution winner is task0_+eXJYhj5rDqH0HLPoWnMkMfR88amixL5cHvvBG4oGHhBIyeuQznGDtQ+RmA+dbqzJqy5Zc8kH4Lyj/jXR/Yr9jaAPSeOkXQZWhgXU6kjdgdkPfFE1n34+OCoaTnmUYKu2/Jl1FknQL5CglNnDNpNmR6xzeBp/4IK/mLjSzHD51A=
2009-11-12 09:10:55,330 [reduceWorkers_thread2] DEBUG com.acnlabs.CloudMapReduce.MapReduce - 0: Processed 11494 out of total 1471075
2009-11-12 09:10:55,612 [reduceWorkers_thread3] INFO  com.acnlabs.CloudMapReduce.MapReduce - resolution winner is task0_+eXJYhj5rDoAKBHr1ThZM+N0Un5edVaWYGewNR8WFNl0DJ3gVOmjI2Gh/oFnb0IeJqy5Zc8kH4LX5fdVFQUb8jaAPSeOkXQZpvxLIY0Nk9SpxcsQtJC+Bf75c27HRoK4VeZzyrGsuCXUou2Fhzj8gfxpUYMku6QhAWYeAzosW7g=
2009-11-12 09:10:55,617 [reduce0_thread19] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_56 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:10:55,635 [reduceWorkers_thread3] DEBUG com.acnlabs.CloudMapReduce.MapReduce - 0: Processed 10904 out of total 1471075
2009-11-12 09:10:58,039 [reduceWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.MapReduce - 0: Processed 26788 out of total 1471075
2009-11-12 09:10:58,348 [reduceWorkers_thread0] INFO  com.acnlabs.CloudMapReduce.MapReduce - resolution winner is task0_+eXJYhj5rDpqyTcjPVFjHhCn4Aw/GJ+BdOVvH1jHF2RBIyeuQznGDtQ+RmA+dbqzJqy5Zc8kH4Lyj/jXR/Yr9jaAPSeOkXQZikj5TPoLRuA1b1QyzrlQ+Pa1Pj9PtZ6ZpVP2ABWx/pJ1rS0gTP2hqZgWDoTSeA5GS1Y34td/zC8=
2009-11-12 09:11:02,332 [reduceWorkers_thread2] INFO  com.acnlabs.CloudMapReduce.MapReduce - start conflict resolution
2009-11-12 09:11:02,402 [reduce0_thread18] WARN  com.acnlabs.CloudMapReduce.QueueManager - Fail to pop from queue CloudMapReduce_reduceQueue_0. Caller will retry. XML: null. Caused by: java.net.SocketException: Connection reset
2009-11-12 09:11:02,636 [reduceWorkers_thread3] INFO  com.acnlabs.CloudMapReduce.MapReduce - start conflict resolution
2009-11-12 09:11:04,349 [reduceWorkers_thread0] INFO  com.acnlabs.CloudMapReduce.MapReduce - start conflict resolution
2009-11-12 09:11:05,040 [reduceWorkers_thread1] INFO  com.acnlabs.CloudMapReduce.MapReduce - start conflict resolution
2009-11-12 09:11:05,345 [reduceWorkers_thread2] INFO  com.acnlabs.CloudMapReduce.MapReduce - resolution winner is task0_+eXJYhj5rDoAKBHr1ThZM+N0Un5edVaWYGewNR8WFNl0DJ3gVOmjI2Gh/oFnb0IeJqy5Zc8kH4LX5fdVFQUb8jaAPSeOkXQZpvxLIY0Nk9SpxcsQtJC+Bf75c27HRoK4VeZzyrGsuCXUou2Fhzj8gfxpUYMku6QhAWYeAzosW7g=
2009-11-12 09:11:06,182 [reduceWorkers_thread3] INFO  com.acnlabs.CloudMapReduce.MapReduce - resolution winner is task0_+eXJYhj5rDoAKBHr1ThZM+N0Un5edVaWYGewNR8WFNl0DJ3gVOmjI2Gh/oFnb0IeJqy5Zc8kH4LX5fdVFQUb8jaAPSeOkXQZpvxLIY0Nk9SpxcsQtJC+Bf75c27HRoK4VeZzyrGsuCXUou2Fhzj8gfxpUYMku6QhAWYeAzosW7g=
2009-11-12 09:11:08,969 [reduceWorkers_thread1] INFO  com.acnlabs.CloudMapReduce.MapReduce - resolution winner is task0_+eXJYhj5rDqH0HLPoWnMkMfR88amixL5cHvvBG4oGHhBIyeuQznGDtQ+RmA+dbqzJqy5Zc8kH4Lyj/jXR/Yr9jaAPSeOkXQZWhgXU6kjdgdkPfFE1n34+OCoaTnmUYKu2/Jl1FknQL5CglNnDNpNmR6xzeBp/4IK/mLjSzHD51A=
2009-11-12 09:11:09,420 [reduce0_thread3] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_275 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:11:11,346 [reduceWorkers_thread2] INFO  com.acnlabs.CloudMapReduce.MapReduce - start conflict resolution
2009-11-12 09:11:12,193 [reduceWorkers_thread3] INFO  com.acnlabs.CloudMapReduce.MapReduce - start conflict resolution
2009-11-12 09:11:12,836 [reduce0_thread10] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_11 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:11:14,782 [reduce0_thread18] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_10 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:11:14,782 [reduce0_thread18] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_14 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:11:14,970 [reduceWorkers_thread1] INFO  com.acnlabs.CloudMapReduce.MapReduce - start conflict resolution
2009-11-12 09:11:17,001 [reduceWorkers_thread3] INFO  com.acnlabs.CloudMapReduce.MapReduce - resolution winner is task0_+eXJYhj5rDoAKBHr1ThZM+N0Un5edVaWYGewNR8WFNl0DJ3gVOmjI2Gh/oFnb0IeJqy5Zc8kH4LX5fdVFQUb8jaAPSeOkXQZpvxLIY0Nk9SpxcsQtJC+Bf75c27HRoK4VeZzyrGsuCXUou2Fhzj8gfxpUYMku6QhAWYeAzosW7g=
2009-11-12 09:11:18,209 [reduce0_thread15] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_193 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:11:19,279 [reduceWorkers_thread1] INFO  com.acnlabs.CloudMapReduce.MapReduce - resolution winner is task0_+eXJYhj5rDqH0HLPoWnMkMfR88amixL5cHvvBG4oGHhBIyeuQznGDtQ+RmA+dbqzJqy5Zc8kH4Lyj/jXR/Yr9jaAPSeOkXQZWhgXU6kjdgdkPfFE1n34+OCoaTnmUYKu2/Jl1FknQL5CglNnDNpNmR6xzeBp/4IK/mLjSzHD51A=
2009-11-12 09:11:19,279 [reduceWorkers_thread2] INFO  com.acnlabs.CloudMapReduce.MapReduce - resolution winner is task0_+eXJYhj5rDqH0HLPoWnMkMfR88amixL5cHvvBG4oGHhBIyeuQznGDtQ+RmA+dbqzJqy5Zc8kH4Lyj/jXR/Yr9jaAPSeOkXQZWhgXU6kjdgdkPfFE1n34+OCoaTnmUYKu2/Jl1FknQL5CglNnDNpNmR6xzeBp/4IK/mLjSzHD51A=
2009-11-12 09:11:19,281 [reduceWorkers_thread2] WARN  com.acnlabs.CloudMapReduce.MapReduce - ReduceRunnable Exception: String index out of range: -1
2009-11-12 09:11:20,289 [reduceWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.MapReduce - 0: Processed 32282 out of total 1471075
2009-11-12 09:11:21,334 [reduceWorkers_thread2] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Waiting for queue workers DbManager to finish....
2009-11-12 09:11:23,002 [reduceWorkers_thread3] INFO  com.acnlabs.CloudMapReduce.MapReduce - start conflict resolution
2009-11-12 09:11:27,290 [reduceWorkers_thread1] INFO  com.acnlabs.CloudMapReduce.MapReduce - start conflict resolution
2009-11-12 09:11:27,335 [reduceWorkers_thread2] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - DbManager: 100% complete
2009-11-12 09:11:27,335 [reduceWorkers_thread2] DEBUG com.acnlabs.CloudMapReduce.WorkerThreadQueue - Work queue DbManager: 12 added, 12 executed.
2009-11-12 09:11:29,345 [reduce0_thread5] WARN  com.acnlabs.CloudMapReduce.QueueManager - Fail to pop from queue CloudMapReduce_reduceQueue_0. Caller will retry. XML: null. Caused by: java.net.SocketTimeoutException: Read timed out
2009-11-12 09:11:31,042 [reduce0_thread9] WARN  com.acnlabs.CloudMapReduce.QueueManager - Fail to pop from queue CloudMapReduce_reduceQueue_0. Caller will retry. XML: null. Caused by: java.net.SocketTimeoutException: Read timed out
2009-11-12 09:11:33,350 [reduceWorkers_thread2] INFO  com.acnlabs.CloudMapReduce.MapReduce - start conflict resolution
2009-11-12 09:11:34,314 [reduceWorkers_thread3] INFO  com.acnlabs.CloudMapReduce.MapReduce - resolution winner is task0_+eXJYhj5rDoAKBHr1ThZM+N0Un5edVaWYGewNR8WFNl0DJ3gVOmjI2Gh/oFnb0IeJqy5Zc8kH4LX5fdVFQUb8jaAPSeOkXQZpvxLIY0Nk9SpxcsQtJC+Bf75c27HRoK4VeZzyrGsuCXUou2Fhzj8gfxpUYMku6QhAWYeAzosW7g=
2009-11-12 09:11:34,940 [reduce0_thread4] WARN  com.acnlabs.CloudMapReduce.QueueManager - Fail to pop from queue CloudMapReduce_reduceQueue_0. Caller will retry. XML: null. Caused by: java.net.SocketTimeoutException: Read timed out
2009-11-12 09:11:34,965 [reduce0_thread17] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_19 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:11:34,965 [reduce0_thread17] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_66 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:11:34,965 [reduce0_thread17] INFO  com.acnlabs.CloudMapReduce.QueueManager - Found duplicate message task0_map0_98 in reduce queue CloudMapReduce_reduceQueue_0
2009-11-12 09:11:37,563 [reduce0_thread19] WARN  com.acnlabs.CloudMapReduce.QueueManager - Fail to pop from queue CloudMapReduce_reduceQueue_0. Caller will retry. XML: null. Caused by: java.net.SocketTimeoutException: Read timed out
2009-11-12 09:11:39,241 [reduceWorkers_thread1] INFO  com.acnlabs.CloudMapReduce.MapReduce - resolution winner is task0_+eXJYhj5rDpChIhVYBGS3ObEIbdsObDZeJhQ2ZPxjbl0DJ3gVOmjI2Gh/oFnb0IeJqy5Zc8kH4LX5fdVFQUb8jaAPSeOkXQZe9h9tEql5+xXGoJD42ZWFR//BxvLOymOBTWf/bYIqSB502e80/uTmor3cmrOLN0ZTNSXPJj9iCc=
2009-11-12 09:11:39,258 [reduceWorkers_thread1] DEBUG com.acnlabs.CloudMapReduce.MapReduce - 0: Processed 38126 out of total 1471075
2009-11-12 09:11:40,315 [reduceWorkers_thread3] INFO  com.acnlabs.CloudMapReduce.MapReduce - start conflict resolution
^Cblitz:cloudmapreduce kplummer$