[130.272881] Initializing watchdogs
[130.273859]   /dev/watchdog0
[130.346420] [001/165] (960s left) i915_module_load (load)
[132.854714] Starting subtest: load
[141.703668] Subtest load: SUCCESS (8.691s)
[142.214245] [002/165] (949s left) core_auth (basic-auth)
[143.143541] Starting subtest: basic-auth
[143.153437] Subtest basic-auth: SUCCESS (0.008s)
[143.541739] [003/165] (948s left) debugfs_test (read_all_entries)
[144.262154] Starting subtest: read_all_entries
[144.873977] Subtest read_all_entries: SUCCESS (0.632s)
[145.879634] [004/165] (945s left) debugfs_test (basic-hwmon)
[146.614162] Starting subtest: basic-hwmon
[146.628658] Subtest basic-hwmon: SKIP (0.000s)
[147.573920] [005/165] (944s left) fbdev (eof)
[148.302686] Starting subtest: eof
[148.309961] Subtest eof: SUCCESS (0.007s)
[148.623830] [006/165] (943s left) fbdev (info)
[149.240170] Starting subtest: info
[149.247835] Subtest info: SUCCESS (0.000s)
[149.585142] [007/165] (943s left) fbdev (nullptr)
[150.247197] Starting subtest: nullptr
[150.258601] Subtest nullptr: SUCCESS (0.001s)
[150.597382] [008/165] (942s left) fbdev (read)
[151.297594] Starting subtest: read
[153.805359] Subtest read: SUCCESS (2.429s)
[154.041151] [009/165] (939s left) fbdev (write)
[154.702216] Starting subtest: write
[156.047521] Subtest write: SUCCESS (1.297s)
[156.305140] [010/165] (937s left) gem_basic (bad-close)
[156.958837] Starting subtest: bad-close
[156.973930] Subtest bad-close: SUCCESS (0.000s)
[157.205910] [011/165] (936s left) gem_basic (create-close)
[157.850150] Starting subtest: create-close
[157.865727] Subtest create-close: SUCCESS (0.001s)
[158.143274] [012/165] (935s left) gem_basic (create-fd-close)
[158.783785] Starting subtest: create-fd-close
[158.798895] Subtest create-fd-close: SUCCESS (0.002s)
[159.074739] [013/165] (934s left) gem_busy (busy@all-engines)
[159.916491] Starting subtest: busy
[159.926746] Starting dynamic subtest: all-engines
[160.369492] Dynamic subtest all-engines: SUCCESS (0.458s)
[160.377174] Subtest busy: SUCCESS (0.460s)
[161.077720] [014/165] (932s left) gem_close_race (basic-process)
[161.948704] Starting subtest: basic-process
[162.330438] Subtest basic-process: SUCCESS (0.375s)
[162.766200] [015/165] (931s left) gem_close_race (basic-threads)
[163.652346] Starting subtest: basic-threads
[165.299797] Subtest basic-threads: SUCCESS (1.714s)
[165.785940] [016/165] (928s left) gem_ctx_create (basic)
[166.613866] Starting subtest: basic
[166.621776] Subtest basic: SUCCESS (0.001s)
[167.040319] [017/165] (927s left) gem_ctx_create (basic-files)
[167.880164] Starting subtest: basic-files
[170.061182] Subtest basic-files: SUCCESS (2.173s)
[170.501761] [018/165] (924s left) gem_ctx_exec (basic)
[171.182391] Starting subtest: basic
[171.231691] Subtest basic: SUCCESS (0.039s)
[171.595412] [019/165] (923s left) gem_exec_basic (basic)
[172.347321] Starting subtest: basic
[172.358847] Starting dynamic subtest: rcs0-smem
[172.367674] Dynamic subtest rcs0-smem: SUCCESS (0.015s)
[172.461538] Starting dynamic subtest: bcs0-smem
[172.469751] Dynamic subtest bcs0-smem: SUCCESS (0.009s)
[172.542707] Starting dynamic subtest: vcs0-smem
[172.554302] Dynamic subtest vcs0-smem: SUCCESS (0.005s)
[172.641582] Starting dynamic subtest: vecs0-smem
[172.652232] Dynamic subtest vecs0-smem: SUCCESS (0.006s)
[172.663890] Subtest basic: SUCCESS (0.045s)
[172.885245] [020/165] (922s left) gem_exec_create (basic)
[173.821729] Starting subtest: basic
[173.836341] Starting dynamic subtest: smem
[176.047744] Dynamic subtest smem: SUCCESS (2.296s)
[176.054313] Subtest basic: SUCCESS (2.304s)
[176.603971] [021/165] (919s left) gem_exec_fence (basic-busy)
[177.746111] Starting subtest: basic-busy
[177.759816] Starting dynamic subtest: rcs0
[177.780675] Dynamic subtest rcs0: SUCCESS (0.072s)
[177.928132] Starting dynamic subtest: bcs0
[177.944500] Dynamic subtest bcs0: SUCCESS (0.062s)
[178.050354] Starting dynamic subtest: vcs0
[178.073661] Dynamic subtest vcs0: SUCCESS (0.046s)
[178.176235] Starting dynamic subtest: vecs0
[178.209493] Dynamic subtest vecs0: SUCCESS (0.056s)
[178.219987] Subtest basic-busy: SUCCESS (0.243s)
[180.327304] [022/165] (915s left) gem_exec_fence (basic-wait)
[181.399944] Starting subtest: basic-wait
[181.408929] Starting dynamic subtest: rcs0
[181.416962] Dynamic subtest rcs0: SUCCESS (0.067s)
[181.513895] Starting dynamic subtest: bcs0
[181.526889] Dynamic subtest bcs0: SUCCESS (0.063s)
[181.660444] Starting dynamic subtest: vcs0
[181.671730] Dynamic subtest vcs0: SUCCESS (0.056s)
[181.775972] Starting dynamic subtest: vecs0
[181.785958] Dynamic subtest vecs0: SUCCESS (0.055s)
[181.792807] Subtest basic-wait: SUCCESS (0.249s)
[183.413340] [023/165] (912s left) gem_exec_fence (basic-await)
[184.498292] Starting subtest: basic-await
[184.506818] Starting dynamic subtest: rcs0
[184.970802] Dynamic subtest rcs0: SUCCESS (0.486s)
[185.134122] Starting dynamic subtest: bcs0
[185.420934] Dynamic subtest bcs0: SUCCESS (0.456s)
[185.504148] Starting dynamic subtest: vcs0
[185.897357] Dynamic subtest vcs0: SUCCESS (0.466s)
[185.974216] Starting dynamic subtest: vecs0
[186.357420] Dynamic subtest vecs0: SUCCESS (0.467s)
[186.382177] Subtest basic-await: SUCCESS (1.886s)
[188.138167] [024/165] (908s left) gem_exec_fence (nb-await)
[189.245963] Starting subtest: nb-await
[189.257831] Starting dynamic subtest: rcs0
[189.331845] Dynamic subtest rcs0: SUCCESS (0.157s)
[189.422780] Starting dynamic subtest: bcs0
[189.458715] Dynamic subtest bcs0: SUCCESS (0.127s)
[189.547905] Starting dynamic subtest: vcs0
[189.592737] Dynamic subtest vcs0: SUCCESS (0.131s)
[189.684759] Starting dynamic subtest: vecs0
[189.722656] Dynamic subtest vecs0: SUCCESS (0.127s)
[189.731550] Subtest nb-await: SUCCESS (0.555s)
[191.603909] [025/165] (904s left) gem_exec_gttfill (basic)
[192.450455] Starting subtest: basic
[199.133870] Subtest basic: SKIP (6.606s)
[199.692976] [026/165] (897s left) gem_exec_parallel (engines)
[201.246928] Starting subtest: engines
[201.257422] Starting dynamic subtest: basic
[213.161686] Dynamic subtest basic: SUCCESS (11.931s)
[213.258140] Starting dynamic subtest: contexts
[233.525551] Dynamic subtest contexts: SUCCESS (20.385s)
[233.616276] Starting dynamic subtest: fds
[271.121972] Dynamic subtest fds: SUCCESS (37.616s)
[271.273981] Starting dynamic subtest: userptr
[283.334649] Dynamic subtest userptr: SUCCESS (12.164s)
[283.343682] Subtest engines: SUCCESS (82.106s)
[283.906581] [027/165] (813s left) gem_exec_store (basic)
[284.893357] Starting subtest: basic
[285.001846] Subtest basic: SUCCESS (0.150s)
[285.509370] [028/165] (811s left) gem_flink_basic (bad-flink)
[286.226886] Starting subtest: bad-flink
[286.237834] Subtest bad-flink: SUCCESS (0.000s)
[286.654400] [029/165] (811s left) gem_flink_basic (bad-open)
[287.355638] Starting subtest: bad-open
[287.363914] Subtest bad-open: SUCCESS (0.000s)
[287.694886] [030/165] (810s left) gem_flink_basic (basic)
[288.329592] Starting subtest: basic
[288.335446] Subtest basic: SUCCESS (0.001s)
[288.696280] [031/165] (809s left) gem_flink_basic (double-flink)
[289.370110] Starting subtest: double-flink
[289.376643] Subtest double-flink: SUCCESS (0.001s)
[289.699451] [032/165] (808s left) gem_flink_basic (flink-lifetime)
[290.351449] Starting subtest: flink-lifetime
[290.361218] Subtest flink-lifetime: SUCCESS (0.013s)
[290.685413] [033/165] (807s left) gem_huc_copy (huc-copy)
[291.456689] Starting subtest: huc-copy
[291.472430] Subtest huc-copy: SKIP (0.000s)
[291.783167] [034/165] (807s left) gem_linear_blits (basic)
[293.719623] Subtest basic: SKIP (0.000s)
[293.969187] [035/165] (805s left) gem_mmap (basic)
[295.168998] Starting subtest: basic
[295.203995] Subtest basic: SUCCESS (0.004s)
[295.528415] [036/165] (803s left) gem_mmap_gtt (basic)
[296.360219] Starting subtest: basic
[296.368722] Subtest basic: SUCCESS (0.006s)
[296.714306] [037/165] (802s left) gem_render_linear_blits (basic)
[297.527770] Starting subtest: basic
[297.786187] Subtest basic: SUCCESS (0.256s)
[298.134227] [038/165] (801s left) gem_render_tiled_blits (basic)
[299.009320] Starting subtest: basic
[299.331989] Subtest basic: SUCCESS (0.320s)
[299.685332] [039/165] (800s left) gem_ringfill (basic-all)
[301.580881] Starting subtest: basic-all
[303.293453] Subtest basic-all: SUCCESS (1.645s)
[303.624709] [040/165] (796s left) gem_softpin (allocator-basic)
[304.514683] Starting subtest: allocator-basic
[305.807649] Subtest allocator-basic: SUCCESS (1.193s)
[306.175416] [041/165] (794s left) gem_softpin (allocator-basic-reserve)
[306.888117] Starting subtest: allocator-basic-reserve
[308.090164] Subtest allocator-basic-reserve: SUCCESS (1.115s)
[308.453997] [042/165] (792s left) gem_softpin (safe-alignment)
[309.160325] Starting subtest: safe-alignment
[309.342194] Subtest safe-alignment: SUCCESS (0.129s)
[309.602226] [043/165] (791s left) gem_sync (basic-all)
[310.465896] Starting subtest: basic-all
[314.976817] Subtest basic-all: SUCCESS (4.538s)
[315.489739] [044/165] (785s left) gem_sync (basic-each)
[316.269188] Starting subtest: basic-each
[319.475641] Subtest basic-each: SUCCESS (3.210s)
[320.028932] [045/165] (781s left) gem_tiled_blits (basic)
[321.954202] Subtest basic: SKIP (0.000s)
[322.231544] [046/165] (779s left) gem_tiled_fence_blits (basic)
[324.577463] Starting subtest: basic
[324.601492] Subtest basic: SUCCESS (0.106s)
[325.173715] [047/165] (776s left) gem_tiled_pread_basic
[327.645211] [048/165] (774s left) gem_wait (busy@all-engines)
[328.594503] Starting subtest: busy
[328.602637] Starting dynamic subtest: all-engines
[329.209980] Dynamic subtest all-engines: SUCCESS (0.640s)
[329.216779] Subtest busy: SUCCESS (0.642s)
[329.858906] [049/165] (772s left) gem_wait (wait@all-engines)
[330.705868] Starting subtest: wait
[330.715595] Starting dynamic subtest: all-engines
[331.831482] Dynamic subtest all-engines: SUCCESS (1.117s)
[331.838168] Subtest wait: SUCCESS (1.121s)
[332.454473] [050/165] (770s left) i915_getparams_basic (basic-eu-total)
[333.182313] Starting subtest: basic-eu-total
[333.198691] Subtest basic-eu-total: SUCCESS (0.000s)
[333.553207] [051/165] (769s left) i915_getparams_basic (basic-subslice-total)
[334.175867] Starting subtest: basic-subslice-total
[334.191828] Subtest basic-subslice-total: SUCCESS (0.000s)
[334.465379] [052/165] (768s left) i915_hangman (error-state-basic)
[335.299284] Starting subtest: error-state-basic
[335.352771] Subtest error-state-basic: SUCCESS (0.054s)
[335.718322] [053/165] (767s left) i915_pciid
[336.773667] [054/165] (766s left) kms_addfb_basic (addfb25-4-tiled)
[338.580561] Starting subtest: addfb25-4-tiled
[338.596656] Subtest addfb25-4-tiled: SUCCESS (0.002s)
[338.968738] [055/165] (764s left) kms_addfb_basic (addfb25-bad-modifier)
[339.648556] Starting subtest: addfb25-bad-modifier
[339.654840] Subtest addfb25-bad-modifier: SUCCESS (0.003s)
[340.655213] [056/165] (763s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[341.361145] Starting subtest: addfb25-framebuffer-vs-set-tiling
[341.370417] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.001s)
[342.449134] [057/165] (761s left) kms_addfb_basic (addfb25-modifier-no-flag)
[343.127958] Starting subtest: addfb25-modifier-no-flag
[343.138594] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[344.145826] [058/165] (760s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[344.820281] Starting subtest: addfb25-x-tiled-legacy
[344.827810] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[345.834549] [059/165] (759s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[346.511141] Starting subtest: addfb25-x-tiled-mismatch-legacy
[346.517727] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[347.572912] [060/165] (757s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[348.938745] Starting subtest: addfb25-yf-tiled-legacy
[348.949601] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[349.307993] [061/165] (756s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[350.619700] Starting subtest: addfb25-y-tiled-legacy
[350.632178] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[350.996306] [062/165] (754s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[352.341948] Starting subtest: addfb25-y-tiled-small-legacy
[352.355439] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.002s)
[352.747793] [063/165] (753s left) kms_addfb_basic (bad-pitch-0)
[353.422929] Starting subtest: bad-pitch-0
[353.430607] Subtest bad-pitch-0: SUCCESS (0.000s)
[354.423802] [064/165] (751s left) kms_addfb_basic (bad-pitch-1024)
[355.086926] Starting subtest: bad-pitch-1024
[355.095765] Subtest bad-pitch-1024: SUCCESS (0.000s)
[356.073907] [065/165] (750s left) kms_addfb_basic (bad-pitch-128)
[356.743740] Starting subtest: bad-pitch-128
[356.752860] Subtest bad-pitch-128: SUCCESS (0.000s)
[357.754412] [066/165] (749s left) kms_addfb_basic (bad-pitch-256)
[358.437120] Starting subtest: bad-pitch-256
[358.447409] Subtest bad-pitch-256: SUCCESS (0.000s)
[359.414640] [067/165] (747s left) kms_addfb_basic (bad-pitch-32)
[360.086277] Starting subtest: bad-pitch-32
[360.093900] Subtest bad-pitch-32: SUCCESS (0.000s)
[361.083727] [068/165] (746s left) kms_addfb_basic (bad-pitch-63)
[361.733328] Starting subtest: bad-pitch-63
[361.741534] Subtest bad-pitch-63: SUCCESS (0.000s)
[362.703183] [069/165] (745s left) kms_addfb_basic (bad-pitch-65536)
[363.370232] Starting subtest: bad-pitch-65536
[363.377807] Subtest bad-pitch-65536: SUCCESS (0.002s)
[364.391256] [070/165] (743s left) kms_addfb_basic (bad-pitch-999)
[365.087847] Starting subtest: bad-pitch-999
[365.094501] Subtest bad-pitch-999: SUCCESS (0.000s)
[366.045117] [071/165] (742s left) kms_addfb_basic (basic)
[366.725888] Starting subtest: basic
[366.734813] Subtest basic: SUCCESS (0.000s)
[367.747236] [072/165] (740s left) kms_addfb_basic (basic-x-tiled-legacy)
[368.423752] Starting subtest: basic-x-tiled-legacy
[368.431185] Subtest basic-x-tiled-legacy: SUCCESS (0.001s)
[369.419233] [073/165] (739s left) kms_addfb_basic (basic-y-tiled-legacy)
[370.096885] Starting subtest: basic-y-tiled-legacy
[370.104799] Subtest basic-y-tiled-legacy: SUCCESS (0.003s)
[371.099311] [074/165] (737s left) kms_addfb_basic (bo-too-small)
[372.401257] Starting subtest: bo-too-small
[372.417886] Subtest bo-too-small: SUCCESS (0.003s)
[372.784797] [075/165] (736s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[374.162176] Starting subtest: bo-too-small-due-to-tiling
[374.188410] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[374.538212] [076/165] (735s left) kms_addfb_basic (clobberred-modifier)
[375.203810] Starting subtest: clobberred-modifier
[375.211497] Subtest clobberred-modifier: SUCCESS (0.001s)
[376.286311] [077/165] (733s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[376.981383] Starting subtest: framebuffer-vs-set-tiling
[376.989836] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[377.976115] [078/165] (732s left) kms_addfb_basic (invalid-get-prop)
[378.638607] Starting subtest: invalid-get-prop
[378.645712] Subtest invalid-get-prop: SUCCESS (0.000s)
[379.665419] [079/165] (730s left) kms_addfb_basic (invalid-get-prop-any)
[380.314847] Starting subtest: invalid-get-prop-any
[380.323788] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[381.301896] [080/165] (729s left) kms_addfb_basic (invalid-set-prop)
[381.943637] Starting subtest: invalid-set-prop
[381.951927] Subtest invalid-set-prop: SUCCESS (0.000s)
[382.914617] [081/165] (728s left) kms_addfb_basic (invalid-set-prop-any)
[383.561956] Starting subtest: invalid-set-prop-any
[383.569765] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[384.555447] [082/165] (726s left) kms_addfb_basic (no-handle)
[385.193962] Starting subtest: no-handle
[385.202485] Subtest no-handle: SUCCESS (0.000s)
[386.193476] [083/165] (725s left) kms_addfb_basic (size-max)
[387.477317] Starting subtest: size-max
[387.483967] Subtest size-max: SUCCESS (0.001s)
[387.825267] [084/165] (723s left) kms_addfb_basic (small-bo)
[389.136184] Starting subtest: small-bo
[389.151696] Subtest small-bo: SUCCESS (0.001s)
[389.480861] [085/165] (722s left) kms_addfb_basic (tile-pitch-mismatch)
[390.120582] Starting subtest: tile-pitch-mismatch
[390.128574] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[391.118363] [086/165] (721s left) kms_addfb_basic (too-high)
[392.410510] Starting subtest: too-high
[392.428414] Subtest too-high: SUCCESS (0.008s)
[393.027164] [087/165] (719s left) kms_addfb_basic (too-wide)
[394.677801] Starting subtest: too-wide
[394.692995] Subtest too-wide: SUCCESS (0.001s)
[395.259651] [088/165] (717s left) kms_addfb_basic (unused-handle)
[395.966170] Starting subtest: unused-handle
[395.973870] Subtest unused-handle: SUCCESS (0.000s)
[397.036143] [089/165] (716s left) kms_addfb_basic (unused-modifier)
[397.679392] Starting subtest: unused-modifier
[397.686747] Subtest unused-modifier: SUCCESS (0.000s)
[398.716766] [090/165] (714s left) kms_addfb_basic (unused-offsets)
[399.368448] Starting subtest: unused-offsets
[399.374813] Subtest unused-offsets: SUCCESS (0.001s)
[400.425361] [091/165] (713s left) kms_addfb_basic (unused-pitches)
[401.103412] Starting subtest: unused-pitches
[401.111796] Subtest unused-pitches: SUCCESS (0.001s)
[402.105994] [092/165] (712s left) kms_busy (basic)
[403.495460] Starting subtest: basic
[403.516891] Starting dynamic subtest: flip
[406.623586] Dynamic subtest flip: SUCCESS (3.107s)
[406.767790] Starting dynamic subtest: modeset
[411.529962] Dynamic subtest modeset: SUCCESS (4.879s)
[411.538976] Subtest basic: SUCCESS (8.002s)
[412.696341] [093/165] (701s left) kms_prop_blob (basic)
[413.468855] Starting subtest: basic
[413.477185] Subtest basic: SUCCESS (0.000s)
[413.815282] [094/165] (700s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[415.200438] Starting subtest: basic-busy-flip-before-cursor-atomic
[415.214938] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.001s)
[415.580598] [095/165] (699s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[416.903101] Starting subtest: basic-busy-flip-before-cursor-legacy
[416.919276] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.001s)
[417.241949] [096/165] (697s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[418.529721] Starting subtest: basic-flip-after-cursor-atomic
[420.289482] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.746s)
[421.528237] [097/165] (693s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[422.820541] Starting subtest: basic-flip-after-cursor-legacy
[424.661657] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.831s)
[425.859215] [098/165] (689s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[427.218742] Starting subtest: basic-flip-after-cursor-varying-size
[428.991293] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.772s)
[430.222379] [099/165] (685s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[431.532735] Starting subtest: basic-flip-before-cursor-atomic
[433.277868] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.762s)
[434.473806] [100/165] (681s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[435.758920] Starting subtest: basic-flip-before-cursor-legacy
[437.655937] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.891s)
[438.892439] [101/165] (677s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[440.204994] Starting subtest: basic-flip-before-cursor-varying-size
[441.956825] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.742s)
[443.170627] [102/165] (673s left) kms_dsc (dsc-basic)
[444.563721] Subtest dsc-basic: SKIP (0.000s)
[444.881806] [103/165] (672s left) kms_flip (basic-flip-vs-dpms)
[445.876527] Starting subtest: basic-flip-vs-dpms
[445.912570] Starting dynamic subtest: A-eDP1
[449.558941] Dynamic subtest A-eDP1: SUCCESS (3.640s)
[449.708784] Starting dynamic subtest: B-eDP1
[452.338139] Dynamic subtest B-eDP1: SUCCESS (2.764s)
[452.496940] Starting dynamic subtest: C-eDP1
[455.170754] Dynamic subtest C-eDP1: SUCCESS (2.819s)
[455.207892] Subtest basic-flip-vs-dpms: SUCCESS (9.343s)
[456.378333] [104/165] (661s left) kms_flip (basic-flip-vs-modeset)
[457.369770] Starting subtest: basic-flip-vs-modeset
[457.420385] Starting dynamic subtest: A-eDP1
[461.049419] Dynamic subtest A-eDP1: SUCCESS (3.626s)
[461.230937] Starting dynamic subtest: B-eDP1
[463.691402] Dynamic subtest B-eDP1: SUCCESS (2.639s)
[463.864568] Starting dynamic subtest: C-eDP1
[466.332911] Dynamic subtest C-eDP1: SUCCESS (2.625s)
[466.382856] Subtest basic-flip-vs-modeset: SUCCESS (9.020s)
[467.578861] [105/165] (650s left) kms_flip (basic-flip-vs-wf_vblank)
[468.573651] Starting subtest: basic-flip-vs-wf_vblank
[468.614879] Starting dynamic subtest: A-eDP1
[471.490826] Dynamic subtest A-eDP1: SUCCESS (2.827s)
[471.630452] Starting dynamic subtest: B-eDP1
[474.054607] Dynamic subtest B-eDP1: SUCCESS (2.538s)
[474.170878] Starting dynamic subtest: C-eDP1
[476.628904] Dynamic subtest C-eDP1: SUCCESS (2.564s)
[476.637190] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.065s)
[478.619251] [106/165] (639s left) kms_flip (basic-plain-flip)
[479.552909] Starting subtest: basic-plain-flip
[479.604145] Starting dynamic subtest: A-eDP1
[482.195853] Dynamic subtest A-eDP1: SUCCESS (2.555s)
[482.339088] Starting dynamic subtest: B-eDP1
[484.502474] Dynamic subtest B-eDP1: SUCCESS (2.276s)
[484.623717] Starting dynamic subtest: C-eDP1
[486.792831] Dynamic subtest C-eDP1: SUCCESS (2.276s)
[486.800774] Subtest basic-plain-flip: SUCCESS (7.237s)
[488.781313] [107/165] (629s left) kms_force_connector_basic (force-connector-state)
[490.152830] Starting subtest: force-connector-state
[492.269731] Subtest force-connector-state: SUCCESS (2.096s)
[494.823428] [108/165] (623s left) kms_force_connector_basic (force-edid)
[496.119278] Starting subtest: force-edid
[496.680413] Subtest force-edid: SUCCESS (0.547s)
[498.485946] [109/165] (620s left) kms_force_connector_basic (force-load-detect)
[499.726469] Starting subtest: force-load-detect
[499.741659] Subtest force-load-detect: SKIP (0.000s)
[501.270451] [110/165] (618s left) kms_force_connector_basic (prune-stale-modes)
[502.496939] Starting subtest: prune-stale-modes
[503.073750] Subtest prune-stale-modes: SUCCESS (0.580s)
[504.920102] [111/165] (614s left) kms_frontbuffer_tracking (basic)
[506.362605] Starting subtest: basic
[515.647205] Subtest basic: SUCCESS (9.281s)
[516.091984] [112/165] (603s left) kms_hdmi_inject (inject-audio)
[517.266737] Starting subtest: inject-audio
[518.287697] Subtest inject-audio: SUCCESS (1.009s)
[519.669486] [113/165] (600s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[521.104931] Starting subtest: compare-crc-sanitycheck-xr24
[521.126716] Starting dynamic subtest: pipe-A-eDP-1
[522.285149] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.153s)
[522.434726] Starting dynamic subtest: pipe-B-eDP-1
[524.140545] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.842s)
[524.283844] Starting dynamic subtest: pipe-C-eDP-1
[525.967142] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.792s)
[525.976572] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.867s)
[527.131707] [114/165] (593s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[528.464962] Starting subtest: compare-crc-sanitycheck-nv12
[528.473948] Starting dynamic subtest: pipe-A-eDP-1
[530.327624] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.861s)
[530.482146] Starting dynamic subtest: pipe-B-eDP-1
[532.748389] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.376s)
[532.944941] Starting dynamic subtest: pipe-C-eDP-1
[532.972716] Dynamic subtest pipe-C-eDP-1: SKIP (0.009s)
[532.989162] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.329s)
[534.015871] [115/165] (586s left) kms_pipe_crc_basic (hang-read-crc)
[535.362121] Starting subtest: hang-read-crc
[535.371364] Starting dynamic subtest: pipe-A-eDP-1
[538.676155] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.300s)
[538.870892] Starting dynamic subtest: pipe-B-eDP-1
[542.707582] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.999s)
[542.905258] Starting dynamic subtest: pipe-C-eDP-1
[546.670744] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.932s)
[546.679957] Subtest hang-read-crc: SUCCESS (11.312s)
[547.879688] [116/165] (573s left) kms_pipe_crc_basic (nonblocking-crc)
[549.276800] Starting subtest: nonblocking-crc
[549.285935] Starting dynamic subtest: pipe-A-eDP-1
[550.659898] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.365s)
[550.880859] Starting dynamic subtest: pipe-B-eDP-1
[552.750587] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.061s)
[553.000903] Starting dynamic subtest: pipe-C-eDP-1
[554.783125] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.001s)
[554.792111] Subtest nonblocking-crc: SUCCESS (5.517s)
[555.973867] [117/165] (565s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[557.313892] Starting subtest: nonblocking-crc-frame-sequence
[557.339299] Starting dynamic subtest: pipe-A-eDP-1
[558.696242] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.343s)
[558.892962] Starting dynamic subtest: pipe-B-eDP-1
[560.765313] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.063s)
[560.964508] Starting dynamic subtest: pipe-C-eDP-1
[562.820991] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.030s)
[562.831212] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.515s)
[564.002717] [118/165] (557s left) kms_pipe_crc_basic (read-crc)
[565.330838] Starting subtest: read-crc
[565.340191] Starting dynamic subtest: pipe-A-eDP-1
[566.660124] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.302s)
[566.832934] Starting dynamic subtest: pipe-B-eDP-1
[568.666252] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.973s)
[568.841559] Starting dynamic subtest: pipe-C-eDP-1
[570.630519] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.945s)
[570.640376] Subtest read-crc: SUCCESS (5.302s)
[571.832458] [119/165] (550s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[573.196934] Starting subtest: read-crc-frame-sequence
[573.207358] Starting dynamic subtest: pipe-A-eDP-1
[574.496722] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.277s)
[574.690343] Starting dynamic subtest: pipe-B-eDP-1
[576.537450] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.020s)
[576.755632] Starting dynamic subtest: pipe-C-eDP-1
[578.525548] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.959s)
[578.535317] Subtest read-crc-frame-sequence: SUCCESS (5.344s)
[579.749281] [120/165] (542s left) kms_pm_backlight (basic-brightness)
[581.267356] Starting subtest: basic-brightness
[581.829697] Starting dynamic subtest: eDP-1
[582.458890] Dynamic subtest eDP-1: SUCCESS (0.712s)
[582.466773] Subtest basic-brightness: SUCCESS (1.200s)
[583.699739] [121/165] (538s left) kms_psr (primary_page_flip)
[585.088954] Starting subtest: primary_page_flip
[587.488641] Subtest primary_page_flip: SUCCESS (2.394s)
[588.744506] [122/165] (534s left) kms_psr (cursor_plane_move)
[590.151834] Starting subtest: cursor_plane_move
[592.436522] Subtest cursor_plane_move: SUCCESS (2.288s)
[593.622856] [123/165] (529s left) kms_psr (sprite_plane_onoff)
[594.966914] Starting subtest: sprite_plane_onoff
[597.295912] Subtest sprite_plane_onoff: SUCCESS (2.353s)
[598.465431] [124/165] (524s left) kms_psr (primary_mmap_gtt)
[599.811687] Starting subtest: primary_mmap_gtt
[602.165148] Subtest primary_mmap_gtt: SUCCESS (2.345s)
[603.359672] [125/165] (520s left) kms_setmode (basic-clone-single-crtc)
[604.122286] Starting subtest: basic-clone-single-crtc
[604.144457] Subtest basic-clone-single-crtc: SKIP (0.006s)
[604.516337] [126/165] (519s left) i915_pm_rpm (basic-pci-d3-state)
[608.267732] Starting subtest: basic-pci-d3-state
[612.807586] Subtest basic-pci-d3-state: SUCCESS (4.533s)
[613.509664] [127/165] (510s left) i915_pm_rpm (basic-rte)
[614.192721] Starting subtest: basic-rte
[621.758544] Subtest basic-rte: SUCCESS (7.579s)
[627.924364] [128/165] (496s left) i915_pm_rps (basic-api)
[628.737928] Starting subtest: basic-api
[628.772461] Subtest basic-api: SUCCESS (0.035s)
[629.144754] [129/165] (495s left) prime_self_import (basic-llseek-bad)
[629.865972] Starting subtest: basic-llseek-bad
[629.883706] Subtest basic-llseek-bad: SUCCESS (0.016s)
[630.250172] [130/165] (494s left) prime_self_import (basic-llseek-size)
[630.882835] Starting subtest: basic-llseek-size
[630.912781] Subtest basic-llseek-size: SUCCESS (0.031s)
[631.286156] [131/165] (494s left) prime_self_import (basic-with_fd_dup)
[631.941921] Starting subtest: basic-with_fd_dup
[631.976114] Subtest basic-with_fd_dup: SUCCESS (0.028s)
[632.377243] [132/165] (493s left) prime_self_import (basic-with_one_bo)
[633.058818] Starting subtest: basic-with_one_bo
[633.095125] Subtest basic-with_one_bo: SUCCESS (0.031s)
[633.487685] [133/165] (492s left) prime_self_import (basic-with_one_bo_two_files)
[634.121515] Starting subtest: basic-with_one_bo_two_files
[634.157879] Subtest basic-with_one_bo_two_files: SUCCESS (0.022s)
[634.491102] [134/165] (491s left) prime_self_import (basic-with_two_bos)
[635.165960] Starting subtest: basic-with_two_bos
[635.201958] Subtest basic-with_two_bos: SUCCESS (0.026s)
[635.562596] [135/165] (490s left) prime_vgem (basic-fence-flip)
[636.419451] Starting subtest: basic-fence-flip
[638.226868] Subtest basic-fence-flip: SUCCESS (1.741s)
[638.729839] [136/165] (487s left) prime_vgem (basic-fence-mmap)
[639.465844] Starting subtest: basic-fence-mmap
[639.798282] Subtest basic-fence-mmap: SUCCESS (0.275s)
[640.139661] [137/165] (486s left) prime_vgem (basic-fence-read)
[640.889993] Starting subtest: basic-fence-read
[641.393184] Subtest basic-fence-read: SUCCESS (0.450s)
[641.688108] [138/165] (485s left) prime_vgem (basic-gtt)
[642.425729] Starting subtest: basic-gtt
[642.578925] Subtest basic-gtt: SUCCESS (0.149s)
[642.957142] [139/165] (484s left) prime_vgem (basic-read)
[643.681717] Starting subtest: basic-read
[643.969683] Subtest basic-read: SUCCESS (0.233s)
[644.267463] [140/165] (483s left) prime_vgem (basic-write)
[645.018951] Starting subtest: basic-write
[645.292410] Subtest basic-write: SUCCESS (0.243s)
[645.565954] [141/165] (482s left) vgem_basic (setversion)
[646.377339] Starting subtest: setversion
[646.393420] Subtest setversion: SUCCESS (0.000s)
[646.697185] [142/165] (481s left) vgem_basic (create)
[647.366320] Starting subtest: create
[647.375778] Subtest create: SUCCESS (0.003s)
[647.691342] [143/165] (480s left) vgem_basic (debugfs)
[648.405262] Starting subtest: debugfs
[648.413286] Subtest debugfs: SUCCESS (0.004s)
[648.700534] [144/165] (479s left) vgem_basic (dmabuf-export)
[649.384229] Starting subtest: dmabuf-export
[649.402138] Subtest dmabuf-export: SUCCESS (0.018s)
[649.746667] [145/165] (479s left) vgem_basic (dmabuf-fence)
[650.434460] Starting subtest: dmabuf-fence
[650.442125] Subtest dmabuf-fence: SUCCESS (0.007s)
[650.783651] [146/165] (478s left) vgem_basic (dmabuf-fence-before)
[651.451111] Starting subtest: dmabuf-fence-before
[651.460895] Subtest dmabuf-fence-before: SUCCESS (0.003s)
[651.751822] [147/165] (477s left) vgem_basic (dmabuf-mmap)
[652.409805] Starting subtest: dmabuf-mmap
[652.599798] Subtest dmabuf-mmap: SUCCESS (0.135s)
[652.897724] [148/165] (476s left) vgem_basic (mmap)
[653.583655] Starting subtest: mmap
[653.663534] Subtest mmap: SUCCESS (0.099s)
[653.959385] [149/165] (475s left) vgem_basic (second-client)
[654.625513] Starting subtest: second-client
[654.690475] Subtest second-client: SUCCESS (0.060s)
[654.990906] [150/165] (474s left) vgem_basic (sysfs)
[655.638246] Starting subtest: sysfs
[655.657998] Subtest sysfs: SUCCESS (0.007s)
[655.945145] [151/165] (474s left) core_hotunplug (unbind-rebind)
[657.028189] Starting subtest: unbind-rebind
[665.758816] Subtest unbind-rebind: SUCCESS (8.669s)
[666.129382] [152/165] (464s left) vgem_basic (unload)
[666.851868] Starting subtest: unload
[696.801709] Subtest unload: SUCCESS (29.879s)
[697.285600] [153/165] (433s left) i915_module_load (reload)
[697.971184] Starting subtest: reload
[709.669603] Subtest reload: SUCCESS (11.691s)
[710.371202] [154/165] (420s left) gem_lmem_swapping (basic)
[711.709568] Subtest basic: SKIP (0.000s)
[712.030395] [155/165] (419s left) gem_lmem_swapping (parallel-random-engines)
[712.724384] Subtest parallel-random-engines: SKIP (0.000s)
[713.045469] [156/165] (418s left) gem_lmem_swapping (random-engines)
[713.793776] Subtest random-engines: SKIP (0.000s)
[714.118935] [157/165] (417s left) gem_lmem_swapping (verify-random)
[714.890878] Subtest verify-random: SKIP (0.000s)
[715.192934] [158/165] (417s left) i915_pm_rpm (module-reload)
[719.582836] Starting subtest: module-reload
[750.822734] Subtest module-reload: SUCCESS (31.189s)
[750.933199] [159/165] (381s left) i915_selftest (live)
[751.831138] Starting subtest: live
[751.838794] Starting dynamic subtest: sanitycheck
[757.443859] Dynamic subtest sanitycheck: SUCCESS (5.621s)
[757.502787] Starting dynamic subtest: uncore
[762.787137] Dynamic subtest uncore: SUCCESS (5.337s)
[762.844904] Starting dynamic subtest: workarounds
[769.258933] Dynamic subtest workarounds: SUCCESS (6.438s)
[769.318129] Starting dynamic subtest: gt_engines
[775.078305] Dynamic subtest gt_engines: SUCCESS (5.830s)
[775.133658] Starting dynamic subtest: gt_timelines
[835.098222] Dynamic subtest gt_timelines: SUCCESS (59.998s)
[835.156509] Starting dynamic subtest: gt_contexts
[840.868614] Dynamic subtest gt_contexts: SUCCESS (5.745s)
[840.924708] Starting dynamic subtest: gt_lrc
[851.443621] Dynamic subtest gt_lrc: SUCCESS (10.552s)
[851.505985] Starting dynamic subtest: gt_mocs
[857.318247] Dynamic subtest gt_mocs: SUCCESS (5.869s)
[857.376773] Starting dynamic subtest: gt_pm
[867.581973] Dynamic subtest gt_pm: FAIL (8.659s)
[867.646821] Starting dynamic subtest: gt_heartbeat
[871.897373] Dynamic subtest gt_heartbeat: SUCCESS (5.867s)
[871.990536] Starting dynamic subtest: gt_tlb
[878.827513] Dynamic subtest gt_tlb: SUCCESS (6.917s)
[878.884374] Starting dynamic subtest: requests
[891.121279] Dynamic subtest requests: SUCCESS (12.300s)
[891.181360] Starting dynamic subtest: migrate
[901.969811] Dynamic subtest migrate: SUCCESS (10.833s)
[902.026566] Starting dynamic subtest: active
[907.501610] Dynamic subtest active: SUCCESS (5.520s)
[907.561339] Starting dynamic subtest: objects
[922.297493] Dynamic subtest objects: SUCCESS (14.785s)
[922.355771] Starting dynamic subtest: mman
[944.286430] Dynamic subtest mman: SUCCESS (21.969s)
[944.347326] Starting dynamic subtest: dmabuf
[949.834214] Dynamic subtest dmabuf: SUCCESS (5.535s)
[949.891796] Starting dynamic subtest: vma
[955.286868] Dynamic subtest vma: SUCCESS (5.432s)
[955.345873] Starting dynamic subtest: coherency
[973.779504] Dynamic subtest coherency: SUCCESS (18.477s)
[973.894635] Starting dynamic subtest: gtt
[987.062706] Dynamic subtest gtt: SUCCESS (13.274s)
[987.120781] Starting dynamic subtest: gem
[994.199441] Dynamic subtest gem: SUCCESS (7.107s)
[994.256913] Starting dynamic subtest: evict
[1012.703706] Dynamic subtest evict: SUCCESS (18.511s)
[1012.760741] Starting dynamic subtest: hugepages
[1025.031944] Dynamic subtest hugepages: SUCCESS (12.295s)
[1025.144775] Starting dynamic subtest: gem_contexts
[1090.409193] Dynamic subtest gem_contexts: SUCCESS (65.406s)
[1090.617127] Starting dynamic subtest: client
[1097.205543] Dynamic subtest client: SUCCESS (6.773s)
[1097.347231] Starting dynamic subtest: gem_migrate
[1104.484473] Dynamic subtest gem_migrate: SUCCESS (7.166s)
[1104.662550] Starting dynamic subtest: reset
[1117.049972] Dynamic subtest reset: SUCCESS (12.564s)
[1117.175839] Starting dynamic subtest: memory_region
[1123.725263] Dynamic subtest memory_region: SUCCESS (6.646s)
[1123.886601] Starting dynamic subtest: hangcheck
[1153.740853] Dynamic subtest hangcheck: SUCCESS (30.062s)
[1153.845233] Starting dynamic subtest: execlists
[1162.647855] Abort requested by /sbin/init 3 [1] via Terminated, terminating children
[1162.664734] Abort requested by /sbin/init 3 [1] via Hangup, terminating children
[1162.665572] Exiting gracefully, currently running test will have a 'notrun' result
[1166.320552] Closing watchdogs
Done.