[06:55:16.637] New invocation is queued and will start shortly
[06:55:17.904] Starting the invocation (attempt 1)
[06:55:17.945] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3019e8b61afee13c8a85410a39b88e4445fa1d19"
[06:55:17.945] Popped gitiles commit info from properties and tags
[06:55:17.945] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:55:17.945] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:55:17.945] Buildbucket request:
{
"requestId": "8972754700819013712",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Linux TSan Builder"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "3019e8b61afee13c8a85410a39b88e4445fa1d19",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8972754700819013712"
},
{
"key": "scheduler_job_id",
"value": "chromium/Linux TSan Builder"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[06:55:18.598] Scheduled build:
{
"id": "8807324638715544753",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Linux TSan Builder"
},
"number": 85670,
"createdBy": "project:chromium",
"createTime": "2022-07-29T06:55:18.013444019Z",
"updateTime": "2022-07-29T06:55:18.013444019Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "3019e8b61afee13c8a85410a39b88e4445fa1d19",
"ref": "refs/heads/main"
}
}
}
[06:55:18.598] Task URL: https://cr-buildbucket.appspot.com/build/8807324638715544753
[06:55:18.598] Scheduling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:2:0) after 4m33s
[06:59:51.636] Handling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:2:0)
[06:59:51.666] Build status: SCHEDULED
[06:59:51.666] Scheduling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:3:0) after 1m58s
[07:00:08.493] Received PubSub notification, asking Buildbucket for the build status
[07:00:08.511] Build status: STARTED
[07:01:49.685] Handling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:3:0)
[07:01:49.704] Build status: STARTED
[07:01:49.704] Scheduling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:5:0) after 2m51s
[07:04:40.789] Handling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:5:0)
[07:04:40.819] Build status: STARTED
[07:04:40.819] Scheduling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:6:0) after 7m14s
[07:11:54.949] Handling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:6:0)
[07:11:54.972] Build status: STARTED
[07:11:54.972] Scheduling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:7:0) after 9m26s
[07:21:21.217] Handling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:7:0)
[07:21:21.241] Build status: STARTED
[07:21:21.241] Scheduling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:8:0) after 3m6s
[07:24:27.266] Handling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:8:0)
[07:24:27.287] Build status: STARTED
[07:24:27.287] Scheduling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:9:0) after 1m11s
[07:25:38.686] Handling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:9:0)
[07:25:38.717] Build status: STARTED
[07:25:38.717] Scheduling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:10:0) after 8m13s
[07:33:52.032] Handling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:10:0)
[07:33:52.051] Build status: STARTED
[07:33:52.051] Scheduling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:11:0) after 1m20s
[07:35:12.241] Handling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:11:0)
[07:35:12.261] Build status: STARTED
[07:35:12.261] Scheduling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:12:0) after 4m26s
[07:39:38.283] Handling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:12:0)
[07:39:38.303] Build status: STARTED
[07:39:38.303] Scheduling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:13:0) after 2m4s
[07:41:42.623] Handling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:13:0)
[07:41:42.645] Build status: STARTED
[07:41:42.645] Scheduling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:14:0) after 6m1s
[07:47:43.666] Handling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:14:0)
[07:47:43.696] Build status: STARTED
[07:47:43.696] Scheduling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:15:0) after 5m23s
[07:53:06.687] Handling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:15:0)
[07:53:06.711] Build status: STARTED
[07:53:06.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:16:0) after 4m48s
[07:57:55.014] Handling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:16:0)
[07:57:55.035] Build status: STARTED
[07:57:55.035] Scheduling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:17:0) after 1m1s
[07:58:56.054] Handling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:17:0)
[07:58:56.085] Build status: STARTED
[07:58:56.085] Scheduling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:18:0) after 4m42s
[08:03:38.104] Handling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:18:0)
[08:03:38.132] Build status: STARTED
[08:03:38.132] Scheduling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:19:0) after 7m55s
[08:11:33.382] Handling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:19:0)
[08:11:33.404] Build status: STARTED
[08:11:33.404] Scheduling timer "check-buildbucket-build-status" (chromium/Linux TSan Builder:8972754700819013712:20:0) after 9m1s
[08:14:21.165] Received PubSub notification, asking Buildbucket for the build status
[08:14:21.184] Build:
{
"id": "8807324638715544753",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Linux TSan Builder"
},
"number": 85670,
"createdBy": "project:chromium",
"createTime": "2022-07-29T06:55:18.013444019Z",
"startTime": "2022-07-29T07:00:07.346199Z",
"endTime": "2022-07-29T08:14:20.779266764Z",
"updateTime": "2022-07-29T08:14:20.779266764Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "3019e8b61afee13c8a85410a39b88e4445fa1d19",
"ref": "refs/heads/main"
}
}
}
[08:14:21.184] Invocation finished in 1h19m4.561641578s with status SUCCEEDED