[12:32:13.020] New invocation is queued and will start shortly
[12:32:16.355] Starting the invocation (attempt 1)
[12:32:16.398] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e33bf598e0ca2e3c72fff8d1b35f633d61f9e498"
[12:32:16.398] Popped gitiles commit info from properties and tags
[12:32:16.398] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:32:16.398] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:32:16.398] Buildbucket request:
{
"requestId": "8938759640005166000",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Linux32 ASan"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e33bf598e0ca2e3c72fff8d1b35f633d61f9e498",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8938759640005166000"
},
{
"key": "scheduler_job_id",
"value": "chromium/Libfuzzer Upload Linux32 ASan"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[12:32:16.980] Scheduled build:
{
"id": "8773329575735679233",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Linux32 ASan"
},
"number": 104709,
"createdBy": "project:chromium",
"createTime": "2023-08-08T12:32:16.461123005Z",
"updateTime": "2023-08-08T12:32:16.461123005Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e33bf598e0ca2e3c72fff8d1b35f633d61f9e498",
"ref": "refs/heads/main"
}
}
}
[12:32:16.980] Task URL: https://cr-buildbucket.appspot.com/build/8773329575735679233
[12:32:16.980] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:2:0) after 4m21s
[12:32:17.711] Received PubSub notification, asking Buildbucket for the build status
[12:32:17.747] Build status: SCHEDULED
[12:34:16.601] Received PubSub notification, asking Buildbucket for the build status
[12:34:16.626] Build status: STARTED
[12:36:38.004] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:2:0)
[12:36:38.032] Build status: STARTED
[12:36:38.032] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:5:0) after 5m56s
[12:42:34.151] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:5:0)
[12:42:34.207] Build status: STARTED
[12:42:34.207] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:6:0) after 5m44s
[12:48:18.427] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:6:0)
[12:48:18.464] Build status: STARTED
[12:48:18.464] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:7:0) after 1m6s
[12:49:24.621] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:7:0)
[12:49:24.646] Build status: STARTED
[12:49:24.646] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:8:0) after 5m19s
[12:54:43.662] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:8:0)
[12:54:43.691] Build status: STARTED
[12:54:43.691] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:9:0) after 6m1s
[13:00:44.721] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:9:0)
[13:00:44.765] Build status: STARTED
[13:00:44.765] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:10:0) after 1m57s
[13:02:41.949] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:10:0)
[13:02:41.967] Build status: STARTED
[13:02:41.967] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:11:0) after 5m33s
[13:08:14.985] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:11:0)
[13:08:15.057] Build status: STARTED
[13:08:15.057] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:12:0) after 8m32s
[13:16:47.054] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:12:0)
[13:16:47.141] Build status: STARTED
[13:16:47.141] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:13:0) after 7m50s
[13:24:37.215] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:13:0)
[13:24:37.235] Build status: STARTED
[13:24:37.235] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:14:0) after 3m29s
[13:28:06.687] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:14:0)
[13:28:06.705] Build status: STARTED
[13:28:06.705] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:15:0) after 6m29s
[13:34:35.843] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:15:0)
[13:34:35.878] Build status: STARTED
[13:34:35.878] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:16:0) after 3m18s
[13:37:53.994] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:16:0)
[13:37:54.012] Build status: STARTED
[13:37:54.012] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:17:0) after 4m1s
[13:41:55.083] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:17:0)
[13:41:55.105] Build status: STARTED
[13:41:55.105] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:18:0) after 8m5s
[13:50:00.127] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:18:0)
[13:50:00.151] Build status: STARTED
[13:50:00.151] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:19:0) after 5m15s
[13:55:15.171] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:19:0)
[13:55:15.202] Build status: STARTED
[13:55:15.202] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:20:0) after 3m57s
[13:59:12.345] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:20:0)
[13:59:12.369] Build status: STARTED
[13:59:12.369] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:21:0) after 3m15s
[14:02:27.587] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:21:0)
[14:02:27.618] Build status: STARTED
[14:02:27.618] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:22:0) after 5m38s
[14:08:05.716] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:22:0)
[14:08:05.907] Build status: STARTED
[14:08:05.907] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:23:0) after 5m32s
[14:13:37.959] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:23:0)
[14:13:37.978] Build status: STARTED
[14:13:37.978] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:24:0) after 1m35s
[14:15:13.103] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:24:0)
[14:15:13.131] Build status: STARTED
[14:15:13.131] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:25:0) after 3m12s
[14:18:25.369] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:25:0)
[14:18:25.399] Build status: STARTED
[14:18:25.399] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux32 ASan:8938759640005166000:26:0) after 4m25s
[14:19:23.183] Received PubSub notification, asking Buildbucket for the build status
[14:19:23.214] Build:
{
"id": "8773329575735679233",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Linux32 ASan"
},
"number": 104709,
"createdBy": "project:chromium",
"createTime": "2023-08-08T12:32:16.461123005Z",
"startTime": "2023-08-08T12:34:15.553004Z",
"endTime": "2023-08-08T14:19:22.915226523Z",
"updateTime": "2023-08-08T14:19:22.915226523Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e33bf598e0ca2e3c72fff8d1b35f633d61f9e498",
"ref": "refs/heads/main"
}
}
}
[14:19:23.214] Invocation finished in 1h47m10.207668116s with status SUCCEEDED