[17:39:45.217] New invocation is queued and will start shortly
[17:39:46.840] Starting the invocation (attempt 1)
[17:39:46.874] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2a263d9ce496e493c0b3a9c0dbfcd48e23414504"
[17:39:46.874] Popped gitiles commit info from properties and tags
[17:39:46.874] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:39:46.875] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:39:46.875] Buildbucket request:
{
"requestId": "9017197264379655424",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Windows ASan"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2a263d9ce496e493c0b3a9c0dbfcd48e23414504",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9017197264379655424"
},
{
"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"
}
}
[17:39:49.785] Scheduled build:
{
"id": "8851767201885921136",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Windows ASan"
},
"number": 32719,
"createdBy": "project:chromium",
"createTime": "2021-03-25T17:39:46.962644Z",
"updateTime": "2021-03-25T17:39:47.459626Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2a263d9ce496e493c0b3a9c0dbfcd48e23414504",
"ref": "refs/heads/master"
}
}
}
[17:39:49.785] Task URL: https://cr-buildbucket.appspot.com/build/8851767201885921136
[17:39:49.785] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:2:0) after 1m27s
[17:39:51.864] Received PubSub notification, asking Buildbucket for the build status
[17:39:51.909] Build status: STARTED
[17:41:16.866] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:2:0)
[17:41:16.891] Build status: STARTED
[17:41:16.891] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:4:0) after 2m20s
[17:43:36.948] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:4:0)
[17:43:36.973] Build status: STARTED
[17:43:36.973] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:5:0) after 1m36s
[17:45:12.991] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:5:0)
[17:45:13.019] Build status: STARTED
[17:45:13.019] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:6:0) after 3m48s
[17:49:01.038] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:6:0)
[17:49:01.063] Build status: STARTED
[17:49:01.063] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:7:0) after 1m37s
[17:50:38.080] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:7:0)
[17:50:38.109] Build status: STARTED
[17:50:38.109] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:8:0) after 8m5s
[17:58:43.137] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:8:0)
[17:58:43.169] Build status: STARTED
[17:58:43.169] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:9:0) after 9m39s
[18:08:22.320] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:9:0)
[18:08:22.346] Build status: STARTED
[18:08:22.346] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:10:0) after 9m18s
[18:17:40.465] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:10:0)
[18:17:40.801] Build status: STARTED
[18:17:40.801] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:11:0) after 5m5s
[18:22:45.842] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:11:0)
[18:22:45.872] Build status: STARTED
[18:22:45.872] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:12:0) after 2m16s
[18:25:02.105] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:12:0)
[18:25:02.157] Build status: STARTED
[18:25:02.157] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:13:0) after 4m7s
[18:29:09.185] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:13:0)
[18:29:09.217] Build status: STARTED
[18:29:09.217] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:14:0) after 7m13s
[18:36:22.251] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:14:0)
[18:36:22.339] Build status: STARTED
[18:36:22.339] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:15:0) after 5m30s
[18:41:52.383] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:15:0)
[18:41:52.431] Build status: STARTED
[18:41:52.431] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:16:0) after 9m10s
[18:51:02.630] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:16:0)
[18:51:02.688] Build status: STARTED
[18:51:02.688] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:17:0) after 4m11s
[18:55:13.921] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:17:0)
[18:55:13.951] Build status: STARTED
[18:55:13.951] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:18:0) after 8m33s
[19:03:47.194] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:18:0)
[19:03:47.225] Build status: STARTED
[19:03:47.225] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:19:0) after 1m25s
[19:05:12.583] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:19:0)
[19:05:12.619] Build status: STARTED
[19:05:12.619] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:20:0) after 2m50s
[19:08:02.687] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:20:0)
[19:08:02.735] Build status: STARTED
[19:08:02.735] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:21:0) after 1m7s
[19:09:09.772] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:21:0)
[19:09:09.810] Build status: STARTED
[19:09:09.810] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:22:0) after 4m48s
[19:13:58.154] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:22:0)
[19:13:58.187] Build status: STARTED
[19:13:58.187] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:23:0) after 2m39s
[19:16:37.453] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:23:0)
[19:16:37.513] Build status: STARTED
[19:16:37.513] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:24:0) after 5m22s
[19:21:59.534] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:24:0)
[19:21:59.576] Build status: STARTED
[19:21:59.576] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:25:0) after 2m23s
[19:24:22.674] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:25:0)
[19:24:22.704] Build status: STARTED
[19:24:22.704] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:26:0) after 8m30s
[19:32:53.014] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:26:0)
[19:32:53.133] Build status: STARTED
[19:32:53.133] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:27:0) after 1m49s
[19:34:42.169] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:27:0)
[19:34:42.194] Build status: STARTED
[19:34:42.194] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:28:0) after 5m29s
[19:40:11.352] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:28:0)
[19:40:11.432] Build status: STARTED
[19:40:11.432] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:29:0) after 4m50s
[19:45:01.674] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:29:0)
[19:45:02.449] Build status: STARTED
[19:45:02.449] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:30:0) after 7m27s
[19:52:29.625] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:30:0)
[19:52:29.667] Build status: STARTED
[19:52:29.667] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:31:0) after 8m26s
[20:00:55.900] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:31:0)
[20:00:55.927] Build status: STARTED
[20:00:55.927] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:32:0) after 6m11s
[20:07:07.036] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:32:0)
[20:07:07.079] Build status: STARTED
[20:07:07.079] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:33:0) after 4m33s
[20:11:40.290] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:33:0)
[20:11:40.321] Build status: STARTED
[20:11:40.321] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:34:0) after 3m29s
[20:15:09.544] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:34:0)
[20:15:09.576] Build status: STARTED
[20:15:09.576] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:35:0) after 9m19s
[20:24:28.600] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:35:0)
[20:24:28.626] Build status: STARTED
[20:24:28.626] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:36:0) after 1m31s
[20:26:00.477] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:36:0)
[20:26:00.518] Build status: STARTED
[20:26:00.518] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:37:0) after 8m36s
[20:34:36.622] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:37:0)
[20:34:36.652] Build status: STARTED
[20:34:36.652] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:38:0) after 4m10s
[20:38:46.862] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:38:0)
[20:38:46.900] Build status: STARTED
[20:38:46.900] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:39:0) after 9m7s
[20:47:54.215] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:39:0)
[20:47:54.251] Build status: STARTED
[20:47:54.251] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:40:0) after 9m0s
[20:56:54.499] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:40:0)
[20:56:54.533] Build status: STARTED
[20:56:54.533] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:9017197264379655424:41:0) after 5m5s
[20:58:20.503] Received PubSub notification, asking Buildbucket for the build status
[20:58:20.580] Build:
{
"id": "8851767201885921136",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Windows ASan"
},
"number": 32719,
"createdBy": "project:chromium",
"createTime": "2021-03-25T17:39:46.962644Z",
"startTime": "2021-03-25T17:39:50.823538Z",
"endTime": "2021-03-25T20:58:19.606047Z",
"updateTime": "2021-03-25T20:58:20.240199Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2a263d9ce496e493c0b3a9c0dbfcd48e23414504",
"ref": "refs/heads/master"
}
}
}
[20:58:20.580] Invocation finished in 3h18m35.379974356s with status SUCCEEDED