[22:01:36.561] New invocation is queued and will start shortly
[22:01:37.858] Starting the invocation (attempt 1)
[22:01:37.901] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/36b963c7bdeda1974e0e0f2eb7e5bb6c9e232422"
[22:01:37.901] Popped gitiles commit info from properties and tags
[22:01:37.901] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:01:37.901] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:01:37.901] Buildbucket request:
{
"requestId": "8974600215632284288",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Windows ASan"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "36b963c7bdeda1974e0e0f2eb7e5bb6c9e232422",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8974600215632284288"
},
{
"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"
}
}
[22:01:38.428] Scheduled build:
{
"id": "8809170153481003729",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Windows ASan"
},
"number": 43037,
"createdBy": "project:chromium",
"createTime": "2022-07-08T22:01:37.980265284Z",
"updateTime": "2022-07-08T22:01:37.980265284Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "36b963c7bdeda1974e0e0f2eb7e5bb6c9e232422",
"ref": "refs/heads/main"
}
}
}
[22:01:38.428] Task URL: https://cr-buildbucket.appspot.com/build/8809170153481003729
[22:01:38.428] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:2:0) after 3m58s
[22:05:36.543] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:2:0)
[22:05:36.563] Build status: SCHEDULED
[22:05:36.563] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:3:0) after 3m29s
[22:09:05.881] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:3:0)
[22:09:05.913] Build status: SCHEDULED
[22:09:05.913] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:4:0) after 4m17s
[22:09:15.800] Received PubSub notification, asking Buildbucket for the build status
[22:09:15.821] Build status: STARTED
[22:13:22.936] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:4:0)
[22:13:22.968] Build status: STARTED
[22:13:22.968] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:6:0) after 8m28s
[22:21:50.990] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:6:0)
[22:21:51.041] Build status: STARTED
[22:21:51.041] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:7:0) after 8m24s
[22:30:15.061] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:7:0)
[22:30:15.129] Build status: STARTED
[22:30:15.129] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:8:0) after 9m51s
[22:40:06.252] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:8:0)
[22:40:06.272] Build status: STARTED
[22:40:06.272] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:9:0) after 4m28s
[22:44:34.422] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:9:0)
[22:44:34.463] Build status: STARTED
[22:44:34.463] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:10:0) after 9m43s
[22:54:17.583] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:10:0)
[22:54:17.664] Build status: STARTED
[22:54:17.664] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:11:0) after 8m35s
[23:02:52.690] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:11:0)
[23:02:52.711] Build status: STARTED
[23:02:52.711] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:12:0) after 6m1s
[23:08:53.786] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:12:0)
[23:08:53.815] Build status: STARTED
[23:08:53.815] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:13:0) after 2m7s
[23:11:01.147] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:13:0)
[23:11:01.169] Build status: STARTED
[23:11:01.169] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:14:0) after 5m54s
[23:16:55.302] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:14:0)
[23:16:55.373] Build status: STARTED
[23:16:55.373] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:15:0) after 3m56s
[23:20:51.407] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:15:0)
[23:20:51.438] Build status: STARTED
[23:20:51.438] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:16:0) after 7m12s
[23:28:03.462] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:16:0)
[23:28:03.484] Build status: STARTED
[23:28:03.484] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:17:0) after 4m6s
[23:32:09.505] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:17:0)
[23:32:09.522] Build status: STARTED
[23:32:09.522] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:18:0) after 7m16s
[23:39:25.555] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:18:0)
[23:39:25.578] Build status: STARTED
[23:39:25.578] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:19:0) after 2m2s
[23:41:27.801] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:19:0)
[23:41:27.822] Build status: STARTED
[23:41:27.822] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:20:0) after 2m17s
[23:43:44.979] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:20:0)
[23:43:45.008] Build status: STARTED
[23:43:45.008] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:21:0) after 8m34s
[23:52:19.030] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:21:0)
[23:52:19.055] Build status: STARTED
[23:52:19.055] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:22:0) after 3m38s
[23:55:57.203] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:22:0)
[23:55:57.238] Build status: STARTED
[23:55:57.238] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:23:0) after 1m13s
[23:57:10.307] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:23:0)
[23:57:10.343] Build status: STARTED
[23:57:10.343] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:24:0) after 4m29s
[00:01:39.466] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:24:0)
[00:01:39.506] Build status: STARTED
[00:01:39.506] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:25:0) after 2m38s
[00:04:17.641] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:25:0)
[00:04:17.822] Build status: STARTED
[00:04:17.822] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:26:0) after 5m41s
[00:09:58.845] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:26:0)
[00:09:58.906] Build status: STARTED
[00:09:58.906] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:27:0) after 3m45s
[00:13:44.006] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:27:0)
[00:13:44.044] Build status: STARTED
[00:13:44.044] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:28:0) after 6m55s
[00:20:39.349] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:28:0)
[00:20:39.386] Build status: STARTED
[00:20:39.386] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:29:0) after 7m15s
[00:27:54.407] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:29:0)
[00:27:54.436] Build status: STARTED
[00:27:54.437] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:30:0) after 9m2s
[00:36:56.456] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:30:0)
[00:36:56.504] Build status: STARTED
[00:36:56.504] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:31:0) after 1m56s
[00:38:52.682] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:31:0)
[00:38:52.744] Build status: STARTED
[00:38:52.744] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:32:0) after 2m41s
[00:41:33.774] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:32:0)
[00:41:33.795] Build status: STARTED
[00:41:33.795] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:33:0) after 6m35s
[00:48:09.140] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:33:0)
[00:48:09.159] Build status: STARTED
[00:48:09.159] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:34:0) after 6m14s
[00:54:23.332] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:34:0)
[00:54:23.358] Build status: STARTED
[00:54:23.358] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:35:0) after 1m36s
[00:55:59.380] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:35:0)
[00:55:59.419] Build status: STARTED
[00:55:59.419] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:36:0) after 7m14s
[01:03:13.443] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:36:0)
[01:03:13.478] Build status: STARTED
[01:03:13.478] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:37:0) after 7m19s
[01:10:32.479] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:37:0)
[01:10:32.517] Build status: STARTED
[01:10:32.517] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:38:0) after 7m52s
[01:18:24.696] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:38:0)
[01:18:24.716] Build status: STARTED
[01:18:24.716] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:39:0) after 2m41s
[01:21:05.835] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:39:0)
[01:21:05.870] Build status: STARTED
[01:21:05.870] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:40:0) after 4m33s
[01:25:38.994] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:40:0)
[01:25:39.032] Build status: STARTED
[01:25:39.032] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:41:0) after 1m22s
[01:27:01.118] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:41:0)
[01:27:01.146] Build status: STARTED
[01:27:01.146] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:42:0) after 9m34s
[01:36:35.527] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:42:0)
[01:36:35.554] Build status: STARTED
[01:36:35.554] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:43:0) after 6m5s
[01:42:40.672] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:43:0)
[01:42:40.698] Build status: STARTED
[01:42:40.698] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:44:0) after 7m3s
[01:49:43.719] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:44:0)
[01:49:43.753] Build status: STARTED
[01:49:43.753] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8974600215632284288:45:0) after 8m8s
[01:54:24.756] Received PubSub notification, asking Buildbucket for the build status
[01:54:24.777] Build:
{
"id": "8809170153481003729",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Windows ASan"
},
"number": 43037,
"createdBy": "project:chromium",
"createTime": "2022-07-08T22:01:37.980265284Z",
"startTime": "2022-07-08T22:09:15.163251Z",
"endTime": "2022-07-09T01:54:24.453666837Z",
"updateTime": "2022-07-09T01:54:24.453666837Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "36b963c7bdeda1974e0e0f2eb7e5bb6c9e232422",
"ref": "refs/heads/main"
}
}
}
[01:54:24.777] Invocation finished in 3h52m48.231591829s with status SUCCEEDED