gistfile1.txt

[2017-05-30T22:34:05.878Z]  INFO: jobsupervisor/30395 on b9548126-d8d3-43f9-895d-4106f855b15d: attempting to take new job "31850527-85cd-4be1-928c-098a68a2b397"
[2017-05-30T22:34:05.921Z]  INFO: jobsupervisor/30395 on b9548126-d8d3-43f9-895d-4106f855b15d: successfully assigned job (job=31850527-85cd-4be1-928c-098a68a2b397)
[2017-05-30T22:34:05.921Z]  INFO: jobsupervisor/30395 on b9548126-d8d3-43f9-895d-4106f855b15d: transitioning states from unassigned to initializing (job=31850527-85cd-4be1-928c-098a68a2b397)
[2017-05-30T22:34:05.921Z]  INFO: jobsupervisor/30395 on b9548126-d8d3-43f9-895d-4106f855b15d: abandoning stale tasks on all agents (job=31850527-85cd-4be1-928c-098a68a2b397)
[2017-05-30T22:34:05.921Z]  INFO: jobsupervisor/30395 on b9548126-d8d3-43f9-895d-4106f855b15d: agent "1.cn.coalregion.joyent.us": abandoning stale tasks (job=31850527-85cd-4be1-928c-098a68a2b397)
[2017-05-30T22:34:05.921Z]  INFO: jobsupervisor/30395 on b9548126-d8d3-43f9-895d-4106f855b15d: agent "1.cn.coalregion.joyent.us": job "31850527-85cd-4be1-928c-098a68a2b397": abandoning tasks (!(agentGeneration=2017-05-30T21:09:54.291Z))
[2017-05-30T22:34:05.988Z]  INFO: jobsupervisor/30395 on b9548126-d8d3-43f9-895d-4106f855b15d: agent "1.cn.coalregion.joyent.us": job "31850527-85cd-4be1-928c-098a68a2b397": abandoned 0 tasks (!(agentGeneration=2017-05-30T21:09:54.291Z))
[2017-05-30T22:34:06.044Z]  INFO: jobsupervisor/30395 on b9548126-d8d3-43f9-895d-4106f855b15d: tasks needing outputs 0 (job=31850527-85cd-4be1-928c-098a68a2b397)
[2017-05-30T22:34:06.044Z]  INFO: jobsupervisor/30395 on b9548126-d8d3-43f9-895d-4106f855b15d: tasks needing inputs removed 0 (job=31850527-85cd-4be1-928c-098a68a2b397)
[2017-05-30T22:34:06.044Z]  INFO: jobsupervisor/30395 on b9548126-d8d3-43f9-895d-4106f855b15d: taskinputs needing retry 0 (job=31850527-85cd-4be1-928c-098a68a2b397)
[2017-05-30T22:34:06.044Z]  INFO: jobsupervisor/30395 on b9548126-d8d3-43f9-895d-4106f855b15d: tasks needing retry 0 (job=31850527-85cd-4be1-928c-098a68a2b397)
[2017-05-30T22:34:06.044Z]  INFO: jobsupervisor/30395 on b9548126-d8d3-43f9-895d-4106f855b15d: tasks needing inputs retried 0 (job=31850527-85cd-4be1-928c-098a68a2b397)
[2017-05-30T22:34:06.103Z]  INFO: jobsupervisor/30395 on b9548126-d8d3-43f9-895d-4106f855b15d: transitioning states from initializing to running (job=31850527-85cd-4be1-928c-098a68a2b397)
[2017-05-30T22:34:06.103Z]  INFO: jobsupervisor/30395 on b9548126-d8d3-43f9-895d-4106f855b15d: marking inputs (job=31850527-85cd-4be1-928c-098a68a2b397)
[2017-05-30T22:34:06.164Z]  INFO: jobsupervisor/30395 on b9548126-d8d3-43f9-895d-4106f855b15d: marked inputs (job=31850527-85cd-4be1-928c-098a68a2b397, err=null, count=1)
[2017-05-30T22:34:11.177Z]  INFO: jobsupervisor/30395 on b9548126-d8d3-43f9-895d-4106f855b15d: marking inputs (job=31850527-85cd-4be1-928c-098a68a2b397)
[2017-05-30T22:34:11.304Z]  INFO: jobsupervisor/30395 on b9548126-d8d3-43f9-895d-4106f855b15d: marked inputs (job=31850527-85cd-4be1-928c-098a68a2b397, err=null, count=0)
[2017-05-30T22:34:16.033Z]  INFO: jobsupervisor/30395 on b9548126-d8d3-43f9-895d-4106f855b15d: job input completed (job=31850527-85cd-4be1-928c-098a68a2b397)
[2017-05-30T22:34:16.033Z]  INFO: jobsupervisor/30395 on b9548126-d8d3-43f9-895d-4106f855b15d: marking inputs (job=31850527-85cd-4be1-928c-098a68a2b397)
[2017-05-30T22:34:16.082Z]  INFO: jobsupervisor/30395 on b9548126-d8d3-43f9-895d-4106f855b15d: marked inputs (job=31850527-85cd-4be1-928c-098a68a2b397, err=null, count=0)
[2017-05-30T22:34:16.265Z]  INFO: jobsupervisor/30395 on b9548126-d8d3-43f9-895d-4106f855b15d: finished reading job inputs (job=31850527-85cd-4be1-928c-098a68a2b397)
[2017-05-30T22:34:16.472Z]  WARN: jobsupervisor/30395 on b9548126-d8d3-43f9-895d-4106f855b15d: (job=31850527-85cd-4be1-928c-098a68a2b397)
    onRecord: found record with up-to-date etag { bucket: 'marlin_jobs_v2',
      key: '31850527-85cd-4be1-928c-098a68a2b397',
      value: 
       { jobId: '31850527-85cd-4be1-928c-098a68a2b397',
         name: 'muskie_test_word_count',
         auth: 
          { principal: [Object],
            conditions: [Object],
            login: 'devuser',
            groups: [],
            uuid: '52da14b8-4244-11e7-ab5a-33639d42e354',
            token: 'krozbN6mjhD0/qhjxu14fWxjhO+JBC68ZLUytDUDWs0AJ8rmC1zA/o04PnhtJSyXR9VWplPy1/3CtMtbDvE1m0uDtHfsi0kzY3rLtsGKTl+hAtgPNWvIo3L89J9q1bnWKUvgb/s6KMq/ATHNM5cPNbGuPdKrcIoJBNBSWRp3i9Hro2LSlGV7lrxlodklkBwcjeo7EbZsiPZWbh8Li8WQjUWakNmuRoh8FZItp5NCUVSqfu0Mo4xmnUSbFMlVHD4HwxAjhjT3puajGgSIEHKhY45whQXQxrJxm28ELDu4g+m/hwKStdDdDAb8WT5EgPsveMmj3sEce0WbH9HNcM5rMeomwyC679Czh1kYv3V2VMSM3JLJGqdUGa8AgMgyRG9j8tQidflOD4z/+pOUz3WHv4x1uYRnSlIImE/P+GlYM+i19NKHwV4YG5X1uuUcEWS/bSbhnr05MJiVUHFqr+hJgjEFTLFiZANs/9x/XhM06h3ci07yPvzsrF5xX0I1q/RIIF9eY0w0jOZoIlDyKQN9g20Jtd2+YzzLUiOf3+ScJh1McswyTMn/XU0m07pyn1Aqc8r3NKU3vnPTsIcLP5fzkevGasfoj7Kd3/cKir8DDdWDNevYLO0dbs/EvDZC+1M7z2HB21RzJ7k6vkrgWFIJyP9TBZqWweq0AK2cga/oPktmp7gSrgdC0Wct9Sa2vBXnbqFxF4niqS2PAZXgnb7M49a4U2rdM6GKk6rvbZlsVPjvndNcty1cQrJLShK4TC/eV6A5Z95Y0pDDhbkGmkKWFzuFe8eDofOFpSZt1sXaxEUPSU+VYjEghBTaj95uNHWwuiKUhG17e2/8puHG2SXTv3DJ62H9mFyKU35HpSxSEjCt8vAdS7G8m5a4WJJOmBAw1wCEkUdNlwfwxNNcFs7CcQ/Z55fTvSO8J3Jy5xtZH2rDvvGIIB9yUqSBgVDfZsioHPydsYbYwYUiT3E6wmtRL7pp0vKCDFGHqsN7/W/LYNSyEoGvxGGs5RBiQkT20/k8cAySbqGsb/Upk9pXyQeYuMNfyMu+dt3jduskbVyJ9rlj6nGHc3aj8gsZq0+5ETA7FINWxPfW6g7gyU0qXq1lLb1gDZ2eKL+Hq4hCtcr/wmbtK23s9EGZYqCsEmfwsGfyu3jwtyPYY2TIYSVJTSJT4w==' },
         authToken: 'krozbN6mjhD0/qhjxu14fWxjhO+JBC68ZLUytDUDWs0AJ8rmC1zA/o04PnhtJSyXR9VWplPy1/3CtMtbDvE1m0uDtHfsi0kzY3rLtsGKTl+hAtgPNWvIo3L89J9q1bnWKUvgb/s6KMq/ATHNM5cPNbGuPdKrcIoJBNBSWRp3i9Hro2LSlGV7lrxlodklkBwcjeo7EbZsiPZWbh8Li8WQjUWakNmuRoh8FZItp5NCUVSqfu0Mo4xmnUSbFMlVHD4HwxAjhjT3puajGgSIEHKhY45whQXQxrJxm28ELDu4g+m/hwKStdDdDAb8WT5EgPsveMmj3sEce0WbH9HNcM5rMeomwyC679Czh1kYv3V2VMSM3JLJGqdUGa8AgMgyRG9j8tQidflOD4z/+pOUz3WHv4x1uYRnSlIImE/P+GlYM+i19NKHwV4YG5X1uuUcEWS/bSbhnr05MJiVUHFqr+hJgjEFTLFiZANs/9x/XhM06h3ci07yPvzsrF5xX0I1q/RIIF9eY0w0jOZoIlDyKQN9g20Jtd2+YzzLUiOf3+ScJh1McswyTMn/XU0m07pyn1Aqc8r3NKU3vnPTsIcLP5fzkevGasfoj7Kd3/cKir8DDdWDNevYLO0dbs/EvDZC+1M7z2HB21RzJ7k6vkrgWFIJyP9TBZqWweq0AK2cga/oPktmp7gSrgdC0Wct9Sa2vBXnbqFxF4niqS2PAZXgnb7M49a4U2rdM6GKk6rvbZlsVPjvndNcty1cQrJLShK4TC/eV6A5Z95Y0pDDhbkGmkKWFzuFe8eDofOFpSZt1sXaxEUPSU+VYjEghBTaj95uNHWwuiKUhG17e2/8puHG2SXTv3DJ62H9mFyKU35HpSxSEjCt8vAdS7G8m5a4WJJOmBAw1wCEkUdNlwfwxNNcFs7CcQ/Z55fTvSO8J3Jy5xtZH2rDvvGIIB9yUqSBgVDfZsioHPydsYbYwYUiT3E6wmtRL7pp0vKCDFGHqsN7/W/LYNSyEoGvxGGs5RBiQkT20/k8cAySbqGsb/Upk9pXyQeYuMNfyMu+dt3jduskbVyJ9rlj6nGHc3aj8gsZq0+5ETA7FINWxPfW6g7gyU0qXq1lLb1gDZ2eKL+Hq4hCtcr/wmbtK23s9EGZYqCsEmfwsGfyu3jwtyPYY2TIYSVJTSJT4w==',
         owner: '52da14b8-4244-11e7-ab5a-33639d42e354',
         phases: [ [Object] ],
         state: 'running',
         timeCreated: '2017-05-30T22:34:05.550Z',
         transient: false,
         options: {},
         timeAssigned: '2017-05-30T22:34:05.878Z',
         worker: 'b9548126-d8d3-43f9-895d-4106f855b15d',
         stats: 
          { nAssigns: 1,
            nErrors: 0,
            nRetries: 0,
            nInputsRead: 1,
            nJobOutputs: 0,
            nTasksDispatched: 1,
            nTasksCommittedOk: 0,
            nTasksCommittedFail: 0 },
         timeInputDone: '2017-05-30T22:34:15.975Z' },
      _id: 247,
      _etag: '9272F7E0',
      _mtime: 1496183656316,
      _txn_snap: null,
      _count: 1 }
[2017-05-30T22:34:16.472Z]  INFO: jobsupervisor/30395 on b9548126-d8d3-43f9-895d-4106f855b15d: job input completed (job=31850527-85cd-4be1-928c-098a68a2b397)
[2017-05-30T22:34:16.472Z]  INFO: jobsupervisor/30395 on b9548126-d8d3-43f9-895d-4106f855b15d: marking inputs (job=31850527-85cd-4be1-928c-098a68a2b397)
[2017-05-30T22:34:16.501Z]  INFO: jobsupervisor/30395 on b9548126-d8d3-43f9-895d-4106f855b15d: marked inputs (job=31850527-85cd-4be1-928c-098a68a2b397, err=null, count=0)
[2017-05-30T22:34:16.749Z]  INFO: jobsupervisor/30395 on b9548126-d8d3-43f9-895d-4106f855b15d: finished reading job inputs (job=31850527-85cd-4be1-928c-098a68a2b397)