[08:26:53.090] New invocation is queued and will start shortly
[08:26:54.397] Starting the invocation (attempt 1)
[08:26:54.434] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d4f39ffd8b31423e45849e409addcfa015f745de"
[08:26:54.434] Popped gitiles commit info from properties and tags
[08:26:54.434] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:26:54.434] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:26:54.435] Buildbucket request:
{
"requestId": "8972748937371626208",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Windows ASan"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d4f39ffd8b31423e45849e409addcfa015f745de",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8972748937371626208"
},
{
"key": "scheduler_job_id",
"value": "chromium/Libfuzzer Upload Windows ASan"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[08:26:54.922] Scheduled build:
{
"id": "8807318875244628097",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Windows ASan"
},
"number": 43387,
"createdBy": "project:chromium",
"createTime": "2022-07-29T08:26:54.487174191Z",
"updateTime": "2022-07-29T08:26:54.487174191Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d4f39ffd8b31423e45849e409addcfa015f745de",
"ref": "refs/heads/main"
}
}
}
[08:26:54.922] Task URL: https://cr-buildbucket.appspot.com/build/8807318875244628097
[08:26:54.922] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:2:0) after 2m35s
[08:29:29.938] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:2:0)
[08:29:29.960] Build status: SCHEDULED
[08:29:29.960] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:3:0) after 7m43s
[08:33:19.581] Received PubSub notification, asking Buildbucket for the build status
[08:33:19.601] Build status: STARTED
[08:37:13.026] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:3:0)
[08:37:13.048] Build status: STARTED
[08:37:13.048] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:5:0) after 9m33s
[08:46:46.257] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:5:0)
[08:46:46.330] Build status: STARTED
[08:46:46.330] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:6:0) after 2m7s
[08:48:53.346] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:6:0)
[08:48:53.381] Build status: STARTED
[08:48:53.381] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:7:0) after 4m55s
[08:53:48.466] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:7:0)
[08:53:48.488] Build status: STARTED
[08:53:48.488] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:8:0) after 2m55s
[08:56:43.625] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:8:0)
[08:56:43.651] Build status: STARTED
[08:56:43.651] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:9:0) after 1m1s
[08:57:44.767] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:9:0)
[08:57:44.787] Build status: STARTED
[08:57:44.787] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:10:0) after 1m32s
[08:59:16.806] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:10:0)
[08:59:16.824] Build status: STARTED
[08:59:16.824] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:11:0) after 9m8s
[09:08:24.850] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:11:0)
[09:08:24.887] Build status: STARTED
[09:08:24.887] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:12:0) after 3m17s
[09:11:42.146] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:12:0)
[09:11:42.229] Build status: STARTED
[09:11:42.229] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:13:0) after 3m21s
[09:15:03.246] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:13:0)
[09:15:03.416] Build status: STARTED
[09:15:03.416] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:14:0) after 8m46s
[09:23:49.546] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:14:0)
[09:23:49.590] Build status: STARTED
[09:23:49.590] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:15:0) after 4m5s
[09:27:54.706] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:15:0)
[09:27:54.727] Build status: STARTED
[09:27:54.727] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:16:0) after 9m50s
[09:37:44.961] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:16:0)
[09:37:44.993] Build status: STARTED
[09:37:44.993] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:17:0) after 3m29s
[09:41:14.112] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:17:0)
[09:41:14.138] Build status: STARTED
[09:41:14.138] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:18:0) after 2m5s
[09:43:19.243] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:18:0)
[09:43:19.276] Build status: STARTED
[09:43:19.277] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:19:0) after 4m57s
[09:48:16.354] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:19:0)
[09:48:16.376] Build status: STARTED
[09:48:16.376] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:20:0) after 2m58s
[09:51:14.394] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:20:0)
[09:51:14.427] Build status: STARTED
[09:51:14.427] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:21:0) after 4m12s
[09:55:26.444] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:21:0)
[09:55:26.469] Build status: STARTED
[09:55:26.469] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:22:0) after 4m48s
[10:00:14.500] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:22:0)
[10:00:14.569] Build status: STARTED
[10:00:14.569] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:23:0) after 2m54s
[10:03:08.587] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:23:0)
[10:03:08.622] Build status: STARTED
[10:03:08.622] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:24:0) after 5m44s
[10:08:52.820] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:24:0)
[10:08:52.856] Build status: STARTED
[10:08:52.856] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:25:0) after 8m41s
[10:17:33.854] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:25:0)
[10:17:33.886] Build status: STARTED
[10:17:33.886] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:26:0) after 9m20s
[10:26:53.902] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:26:0)
[10:26:53.937] Build status: STARTED
[10:26:53.937] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:27:0) after 9m48s
[10:36:41.973] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:27:0)
[10:36:41.991] Build status: STARTED
[10:36:41.991] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:28:0) after 9m49s
[10:46:31.187] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:28:0)
[10:46:31.227] Build status: STARTED
[10:46:31.227] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:29:0) after 1m14s
[10:47:45.244] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:29:0)
[10:47:45.265] Build status: STARTED
[10:47:45.265] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:30:0) after 3m29s
[10:51:14.282] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:30:0)
[10:51:14.317] Build status: STARTED
[10:51:14.317] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:31:0) after 4m41s
[10:55:55.487] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:31:0)
[10:55:55.544] Build status: STARTED
[10:55:55.544] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:32:0) after 7m6s
[11:03:01.565] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:32:0)
[11:03:01.595] Build status: STARTED
[11:03:01.595] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:33:0) after 4m11s
[11:07:12.635] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:33:0)
[11:07:12.661] Build status: STARTED
[11:07:12.661] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:34:0) after 5m28s
[11:12:40.684] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:34:0)
[11:12:40.716] Build status: STARTED
[11:12:40.716] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:35:0) after 5m30s
[11:18:10.862] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:35:0)
[11:18:10.893] Build status: STARTED
[11:18:10.893] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:36:0) after 1m59s
[11:20:09.914] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:36:0)
[11:20:09.952] Build status: STARTED
[11:20:09.952] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:37:0) after 8m47s
[11:28:57.083] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:37:0)
[11:28:57.106] Build status: STARTED
[11:28:57.106] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:38:0) after 7m30s
[11:36:27.277] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:38:0)
[11:36:27.342] Build status: STARTED
[11:36:27.342] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:39:0) after 4m12s
[11:40:39.442] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:39:0)
[11:40:39.467] Build status: STARTED
[11:40:39.467] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:40:0) after 2m40s
[11:43:19.513] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:40:0)
[11:43:19.540] Build status: STARTED
[11:43:19.540] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:41:0) after 5m50s
[11:49:09.654] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:41:0)
[11:49:09.757] Build status: STARTED
[11:49:09.757] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:42:0) after 8m15s
[11:57:24.739] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:42:0)
[11:57:24.764] Build status: STARTED
[11:57:24.765] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:43:0) after 9m55s
[12:07:19.790] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:43:0)
[12:07:19.823] Build status: STARTED
[12:07:19.823] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:44:0) after 9m16s
[12:16:35.971] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:44:0)
[12:16:36.000] Build status: STARTED
[12:16:36.000] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:45:0) after 7m32s
[12:24:08.025] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:45:0)
[12:24:08.134] Build status: STARTED
[12:24:08.134] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:46:0) after 9m20s
[12:33:28.247] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:46:0)
[12:33:28.283] Build status: STARTED
[12:33:28.283] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8972748937371626208:47:0) after 5m56s
[12:34:00.598] Received PubSub notification, asking Buildbucket for the build status
[12:34:00.619] Build:
{
"id": "8807318875244628097",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Windows ASan"
},
"number": 43387,
"createdBy": "project:chromium",
"createTime": "2022-07-29T08:26:54.487174191Z",
"startTime": "2022-07-29T08:33:18.764043Z",
"endTime": "2022-07-29T12:34:00.194331040Z",
"updateTime": "2022-07-29T12:34:00.194331040Z",
"status": "CANCELED",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d4f39ffd8b31423e45849e409addcfa015f745de",
"ref": "refs/heads/main"
}
}
}
[12:34:00.619] Invocation finished in 4h7m7.543426591s with status ABORTED