[131.212272] Initializing watchdogs
[131.213193]   /dev/watchdog0
[131.301384] [001/171] (960s left) i915_module_load (load)
[132.486946] Starting subtest: load
[141.539313] Subtest load: SUCCESS (8.942s)
[141.885120] [002/171] (950s left) core_auth (basic-auth)
[143.681591] Starting subtest: basic-auth
[143.694126] Subtest basic-auth: SUCCESS (0.008s)
[144.116765] [003/171] (948s left) debugfs_test (read_all_entries)
[145.314793] Starting subtest: read_all_entries
[145.900843] Subtest read_all_entries: SUCCESS (0.612s)
[146.913129] [004/171] (945s left) debugfs_test (basic-hwmon)
[148.004918] Starting subtest: basic-hwmon
[148.019952] Subtest basic-hwmon: SKIP (0.000s)
[149.004410] [005/171] (944s left) fbdev (eof)
[150.409549] Starting subtest: eof
[150.418681] Subtest eof: SUCCESS (0.006s)
[150.848289] [006/171] (942s left) fbdev (info)
[152.098184] Starting subtest: info
[152.107082] Subtest info: SUCCESS (0.000s)
[152.522487] [007/171] (941s left) fbdev (nullptr)
[153.691890] Starting subtest: nullptr
[153.702469] Subtest nullptr: SUCCESS (0.000s)
[154.170694] [008/171] (939s left) fbdev (read)
[155.615861] Starting subtest: read
[158.301767] Subtest read: SUCCESS (2.630s)
[158.625666] [009/171] (935s left) fbdev (write)
[159.638367] Starting subtest: write
[160.959127] Subtest write: SUCCESS (1.251s)
[161.288435] [010/171] (933s left) gem_basic (bad-close)
[162.334899] Starting subtest: bad-close
[162.352198] Subtest bad-close: SUCCESS (0.000s)
[162.737692] [011/171] (932s left) gem_basic (create-close)
[163.662924] Starting subtest: create-close
[163.678377] Subtest create-close: SUCCESS (0.001s)
[164.104925] [012/171] (930s left) gem_basic (create-fd-close)
[165.077818] Starting subtest: create-fd-close
[165.091922] Subtest create-fd-close: SUCCESS (0.002s)
[165.500457] [013/171] (929s left) gem_busy (busy@all-engines)
[166.769648] Starting subtest: busy
[166.785790] Starting dynamic subtest: all-engines
[167.200159] Dynamic subtest all-engines: SUCCESS (0.454s)
[167.208997] Subtest busy: SUCCESS (0.457s)
[167.924221] [014/171] (927s left) gem_close_race (basic-process)
[169.294196] Starting subtest: basic-process
[169.681848] Subtest basic-process: SUCCESS (0.423s)
[170.244272] [015/171] (925s left) gem_close_race (basic-threads)
[171.489570] Starting subtest: basic-threads
[173.217740] Subtest basic-threads: SUCCESS (1.777s)
[173.830884] [016/171] (922s left) gem_ctx_create (basic)
[175.043850] Starting subtest: basic
[175.060543] Subtest basic: SUCCESS (0.002s)
[175.529447] [017/171] (920s left) gem_ctx_create (basic-files)
[176.651944] Starting subtest: basic-files
[178.819164] Subtest basic-files: SUCCESS (2.183s)
[179.334549] [018/171] (917s left) gem_ctx_exec (basic)
[180.414590] Starting subtest: basic
[180.440606] Subtest basic: SUCCESS (0.038s)
[180.858205] [019/171] (915s left) gem_exec_basic (basic)
[181.958256] Starting subtest: basic
[181.969980] Starting dynamic subtest: rcs0-smem
[181.979410] Dynamic subtest rcs0-smem: SUCCESS (0.015s)
[182.049782] Starting dynamic subtest: bcs0-smem
[182.060792] Dynamic subtest bcs0-smem: SUCCESS (0.010s)
[182.138888] Starting dynamic subtest: vcs0-smem
[182.160594] Dynamic subtest vcs0-smem: SUCCESS (0.008s)
[182.243210] Starting dynamic subtest: vecs0-smem
[182.250979] Dynamic subtest vecs0-smem: SUCCESS (0.007s)
[182.259374] Subtest basic: SUCCESS (0.050s)
[182.490772] [020/171] (914s left) gem_exec_create (basic)
[183.748571] Starting subtest: basic
[183.759899] Starting dynamic subtest: smem
[185.915762] Dynamic subtest smem: SUCCESS (2.239s)
[185.923607] Subtest basic: SUCCESS (2.244s)
[186.512315] [021/171] (910s left) gem_exec_fence (basic-busy)
[188.008618] Starting subtest: basic-busy
[188.016719] Starting dynamic subtest: rcs0
[188.031402] Dynamic subtest rcs0: SUCCESS (0.064s)
[188.106103] Starting dynamic subtest: bcs0
[188.122490] Dynamic subtest bcs0: SUCCESS (0.071s)
[188.267173] Starting dynamic subtest: vcs0
[188.285306] Dynamic subtest vcs0: SUCCESS (0.058s)
[188.363429] Starting dynamic subtest: vecs0
[188.381302] Dynamic subtest vecs0: SUCCESS (0.044s)
[188.387763] Subtest basic-busy: SUCCESS (0.245s)
[190.499117] [022/171] (907s left) gem_exec_fence (basic-wait)
[191.865784] Starting subtest: basic-wait
[191.873801] Starting dynamic subtest: rcs0
[191.881993] Dynamic subtest rcs0: SUCCESS (0.070s)
[191.984997] Starting dynamic subtest: bcs0
[191.995696] Dynamic subtest bcs0: SUCCESS (0.059s)
[192.092633] Starting dynamic subtest: vcs0
[192.099882] Dynamic subtest vcs0: SUCCESS (0.049s)
[192.190561] Starting dynamic subtest: vecs0
[192.197686] Dynamic subtest vecs0: SUCCESS (0.050s)
[192.204571] Subtest basic-wait: SUCCESS (0.236s)
[194.016355] [023/171] (903s left) gem_exec_fence (basic-await)
[195.385719] Starting subtest: basic-await
[195.395547] Starting dynamic subtest: rcs0
[195.865634] Dynamic subtest rcs0: SUCCESS (0.476s)
[196.019753] Starting dynamic subtest: bcs0
[196.321633] Dynamic subtest bcs0: SUCCESS (0.461s)
[196.450576] Starting dynamic subtest: vcs0
[196.798219] Dynamic subtest vcs0: SUCCESS (0.477s)
[196.886501] Starting dynamic subtest: vecs0
[197.279495] Dynamic subtest vecs0: SUCCESS (0.457s)
[197.293443] Subtest basic-await: SUCCESS (1.885s)
[199.135841] [024/171] (898s left) gem_exec_fence (nb-await)
[200.548855] Starting subtest: nb-await
[200.558768] Starting dynamic subtest: rcs0
[200.662794] Dynamic subtest rcs0: SUCCESS (0.175s)
[200.801232] Starting dynamic subtest: bcs0
[200.816965] Dynamic subtest bcs0: SUCCESS (0.133s)
[200.958432] Starting dynamic subtest: vcs0
[200.970146] Dynamic subtest vcs0: SUCCESS (0.129s)
[201.051925] Starting dynamic subtest: vecs0
[201.063164] Dynamic subtest vecs0: SUCCESS (0.126s)
[201.072844] Subtest nb-await: SUCCESS (0.571s)
[203.007162] [025/171] (895s left) gem_exec_gttfill (basic)
[204.296745] Starting subtest: basic
[209.650158] Subtest basic: SKIP (5.279s)
[210.220927] [026/171] (888s left) gem_exec_parallel (engines)
[211.971918] Starting subtest: engines
[211.980271] Starting dynamic subtest: basic
[225.077958] Dynamic subtest basic: SUCCESS (13.154s)
[225.208931] Starting dynamic subtest: contexts
[242.009135] Dynamic subtest contexts: SUCCESS (16.906s)
[242.142696] Starting dynamic subtest: fds
[260.770899] Dynamic subtest fds: SUCCESS (18.753s)
[260.949431] Starting dynamic subtest: userptr
[274.655140] Dynamic subtest userptr: SUCCESS (13.923s)
[274.662798] Subtest engines: SUCCESS (62.743s)
[275.289846] [027/171] (823s left) gem_exec_store (basic)
[276.493495] Starting subtest: basic
[276.639720] Subtest basic: SUCCESS (0.153s)
[277.148370] [028/171] (822s left) gem_flink_basic (bad-flink)
[278.100903] Starting subtest: bad-flink
[278.108992] Subtest bad-flink: SUCCESS (0.000s)
[278.493278] [029/171] (820s left) gem_flink_basic (bad-open)
[279.381750] Starting subtest: bad-open
[279.389954] Subtest bad-open: SUCCESS (0.000s)
[279.806163] [030/171] (819s left) gem_flink_basic (basic)
[280.715939] Starting subtest: basic
[280.723625] Subtest basic: SUCCESS (0.001s)
[281.115287] [031/171] (818s left) gem_flink_basic (double-flink)
[282.046724] Starting subtest: double-flink
[282.053930] Subtest double-flink: SUCCESS (0.001s)
[282.460624] [032/171] (817s left) gem_flink_basic (flink-lifetime)
[283.380722] Starting subtest: flink-lifetime
[283.390273] Subtest flink-lifetime: SUCCESS (0.012s)
[283.817392] [033/171] (816s left) gem_huc_copy (huc-copy)
[284.898801] Starting subtest: huc-copy
[284.925458] Subtest huc-copy: SKIP (0.000s)
[285.263382] [034/171] (815s left) gem_linear_blits (basic)
[287.390924] Subtest basic: SKIP (0.000s)
[287.799337] [035/171] (813s left) gem_mmap (basic)
[289.428725] Starting subtest: basic
[289.469758] Subtest basic: SUCCESS (0.004s)
[289.880432] [036/171] (811s left) gem_mmap_gtt (basic)
[290.935669] Starting subtest: basic
[290.944589] Subtest basic: SUCCESS (0.007s)
[291.383736] [037/171] (810s left) gem_render_linear_blits (basic)
[292.429137] Starting subtest: basic
[292.688620] Subtest basic: SUCCESS (0.255s)
[293.031211] [038/171] (808s left) gem_render_tiled_blits (basic)
[294.137642] Starting subtest: basic
[294.482512] Subtest basic: SUCCESS (0.340s)
[294.804120] [039/171] (807s left) gem_ringfill (basic-all)
[296.865172] Starting subtest: basic-all
[298.567697] Subtest basic-all: SUCCESS (1.655s)
[298.956259] [040/171] (803s left) gem_softpin (allocator-basic)
[300.027656] Starting subtest: allocator-basic
[301.267786] Subtest allocator-basic: SUCCESS (1.164s)
[301.781394] [041/171] (800s left) gem_softpin (allocator-basic-reserve)
[302.774889] Starting subtest: allocator-basic-reserve
[304.012562] Subtest allocator-basic-reserve: SUCCESS (1.171s)
[304.533885] [042/171] (798s left) gem_softpin (safe-alignment)
[305.510678] Starting subtest: safe-alignment
[305.729783] Subtest safe-alignment: SUCCESS (0.138s)
[306.035709] [043/171] (797s left) gem_sync (basic-all)
[307.284162] Starting subtest: basic-all
[312.284680] Subtest basic-all: SUCCESS (4.998s)
[312.848253] [044/171] (790s left) gem_sync (basic-each)
[313.868245] Starting subtest: basic-each
[317.133852] Subtest basic-each: SUCCESS (3.263s)
[317.731245] [045/171] (785s left) gem_tiled_blits (basic)
[319.972346] Subtest basic: SKIP (0.000s)
[320.308365] [046/171] (783s left) gem_tiled_fence_blits (basic)
[323.103644] Starting subtest: basic
[323.158551] Subtest basic: SUCCESS (0.115s)
[323.686757] [047/171] (780s left) gem_tiled_pread_basic
[326.489327] [048/171] (777s left) gem_wait (busy@all-engines)
[327.666140] Starting subtest: busy
[327.675434] Starting dynamic subtest: all-engines
[328.299864] Dynamic subtest all-engines: SUCCESS (0.595s)
[328.308388] Subtest busy: SUCCESS (0.599s)
[328.988738] [049/171] (775s left) gem_wait (wait@all-engines)
[330.185689] Starting subtest: wait
[330.209731] Starting dynamic subtest: all-engines
[331.352807] Dynamic subtest all-engines: SUCCESS (1.125s)
[331.365366] Subtest wait: SUCCESS (1.129s)
[332.111251] [050/171] (772s left) i915_getparams_basic (basic-eu-total)
[333.163179] Starting subtest: basic-eu-total
[333.179747] Subtest basic-eu-total: SUCCESS (0.000s)
[333.576466] [051/171] (771s left) i915_getparams_basic (basic-subslice-total)
[334.546818] Starting subtest: basic-subslice-total
[334.563837] Subtest basic-subslice-total: SUCCESS (0.000s)
[334.996287] [052/171] (770s left) i915_hangman (error-state-basic)
[336.079981] Starting subtest: error-state-basic
[336.150569] Subtest error-state-basic: SUCCESS (0.057s)
[336.501987] [053/171] (769s left) i915_pciid
[337.882663] [054/171] (768s left) kms_addfb_basic (addfb25-bad-modifier)
[338.998746] Starting subtest: addfb25-bad-modifier
[339.007623] Subtest addfb25-bad-modifier: SUCCESS (0.003s)
[340.439706] [055/171] (765s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[341.405175] Starting subtest: addfb25-framebuffer-vs-set-tiling
[341.413994] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.001s)
[342.440980] [056/171] (764s left) kms_addfb_basic (addfb25-modifier-no-flag)
[343.400776] Starting subtest: addfb25-modifier-no-flag
[343.408344] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[344.390265] [057/171] (762s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[345.350977] Starting subtest: addfb25-x-tiled-legacy
[345.357903] Subtest addfb25-x-tiled-legacy: SUCCESS (0.001s)
[346.429984] [058/171] (760s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[347.390559] Starting subtest: addfb25-x-tiled-mismatch-legacy
[347.400605] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[348.390865] [059/171] (758s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[350.105897] Starting subtest: addfb25-yf-tiled-legacy
[350.113784] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[350.605781] [060/171] (757s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[352.498773] Starting subtest: addfb25-y-tiled-legacy
[352.507692] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[352.928476] [061/171] (755s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[354.549200] Starting subtest: addfb25-y-tiled-small-legacy
[354.557422] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.003s)
[354.968551] [062/171] (753s left) kms_addfb_basic (bad-pitch-0)
[355.966696] Starting subtest: bad-pitch-0
[355.974480] Subtest bad-pitch-0: SUCCESS (0.000s)
[357.020816] [063/171] (751s left) kms_addfb_basic (bad-pitch-1024)
[357.992483] Starting subtest: bad-pitch-1024
[358.002387] Subtest bad-pitch-1024: SUCCESS (0.000s)
[359.032906] [064/171] (749s left) kms_addfb_basic (bad-pitch-128)
[360.014752] Starting subtest: bad-pitch-128
[360.022894] Subtest bad-pitch-128: SUCCESS (0.000s)
[361.033696] [065/171] (748s left) kms_addfb_basic (bad-pitch-256)
[362.011526] Starting subtest: bad-pitch-256
[362.019960] Subtest bad-pitch-256: SUCCESS (0.000s)
[363.047437] [066/171] (746s left) kms_addfb_basic (bad-pitch-32)
[363.979285] Starting subtest: bad-pitch-32
[363.985919] Subtest bad-pitch-32: SUCCESS (0.000s)
[365.039081] [067/171] (744s left) kms_addfb_basic (bad-pitch-63)
[365.979865] Starting subtest: bad-pitch-63
[365.989847] Subtest bad-pitch-63: SUCCESS (0.000s)
[367.050188] [068/171] (742s left) kms_addfb_basic (bad-pitch-65536)
[368.003775] Starting subtest: bad-pitch-65536
[368.014551] Subtest bad-pitch-65536: SUCCESS (0.003s)
[369.033268] [069/171] (741s left) kms_addfb_basic (bad-pitch-999)
[369.987838] Starting subtest: bad-pitch-999
[369.995726] Subtest bad-pitch-999: SUCCESS (0.000s)
[371.112489] [070/171] (739s left) kms_addfb_basic (basic)
[372.090085] Starting subtest: basic
[372.098277] Subtest basic: SUCCESS (0.000s)
[373.113779] [071/171] (737s left) kms_addfb_basic (basic-x-tiled-legacy)
[374.075976] Starting subtest: basic-x-tiled-legacy
[374.084283] Subtest basic-x-tiled-legacy: SUCCESS (0.001s)
[375.141886] [072/171] (736s left) kms_addfb_basic (basic-y-tiled-legacy)
[376.090730] Starting subtest: basic-y-tiled-legacy
[376.098938] Subtest basic-y-tiled-legacy: SUCCESS (0.003s)
[377.104494] [073/171] (734s left) kms_addfb_basic (bo-too-small)
[378.751945] Starting subtest: bo-too-small
[378.760156] Subtest bo-too-small: SUCCESS (0.002s)
[379.101764] [074/171] (732s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[380.717639] Starting subtest: bo-too-small-due-to-tiling
[380.725390] Subtest bo-too-small-due-to-tiling: SUCCESS (0.003s)
[381.181918] [075/171] (730s left) kms_addfb_basic (clobberred-modifier)
[382.167435] Starting subtest: clobberred-modifier
[382.175995] Subtest clobberred-modifier: SUCCESS (0.001s)
[383.242204] [076/171] (729s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[384.222413] Starting subtest: framebuffer-vs-set-tiling
[384.230315] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[385.219545] [077/171] (727s left) kms_addfb_basic (invalid-get-prop)
[386.179794] Starting subtest: invalid-get-prop
[386.188167] Subtest invalid-get-prop: SUCCESS (0.001s)
[387.199118] [078/171] (725s left) kms_addfb_basic (invalid-get-prop-any)
[388.166801] Starting subtest: invalid-get-prop-any
[388.175702] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[389.169491] [079/171] (724s left) kms_addfb_basic (invalid-set-prop)
[390.086838] Starting subtest: invalid-set-prop
[390.094699] Subtest invalid-set-prop: SUCCESS (0.000s)
[391.209362] [080/171] (722s left) kms_addfb_basic (invalid-set-prop-any)
[392.129537] Starting subtest: invalid-set-prop-any
[392.138420] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[393.161943] [081/171] (720s left) kms_addfb_basic (no-handle)
[394.089994] Starting subtest: no-handle
[394.098669] Subtest no-handle: SUCCESS (0.000s)
[395.137994] [082/171] (718s left) kms_addfb_basic (size-max)
[396.745782] Starting subtest: size-max
[396.766138] Subtest size-max: SUCCESS (0.001s)
[397.155413] [083/171] (717s left) kms_addfb_basic (small-bo)
[398.791767] Starting subtest: small-bo
[398.800877] Subtest small-bo: SUCCESS (0.000s)
[399.175890] [084/171] (715s left) kms_addfb_basic (tile-pitch-mismatch)
[400.122814] Starting subtest: tile-pitch-mismatch
[400.130792] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[401.149386] [085/171] (713s left) kms_addfb_basic (too-high)
[402.755550] Starting subtest: too-high
[402.763624] Subtest too-high: SUCCESS (0.007s)
[403.117179] [086/171] (712s left) kms_addfb_basic (too-wide)
[404.696461] Starting subtest: too-wide
[404.704923] Subtest too-wide: SUCCESS (0.000s)
[405.049734] [087/171] (710s left) kms_addfb_basic (unused-handle)
[405.974789] Starting subtest: unused-handle
[405.985174] Subtest unused-handle: SUCCESS (0.000s)
[406.973747] [088/171] (708s left) kms_addfb_basic (unused-modifier)
[407.900255] Starting subtest: unused-modifier
[407.908905] Subtest unused-modifier: SUCCESS (0.001s)
[408.914192] [089/171] (707s left) kms_addfb_basic (unused-offsets)
[409.860772] Starting subtest: unused-offsets
[409.869273] Subtest unused-offsets: SUCCESS (0.000s)
[410.896345] [090/171] (705s left) kms_addfb_basic (unused-pitches)
[411.843605] Starting subtest: unused-pitches
[411.850344] Subtest unused-pitches: SUCCESS (0.000s)
[412.902101] [091/171] (703s left) kms_busy (basic)
[414.611896] Starting subtest: basic
[414.638349] Starting dynamic subtest: flip
[417.990897] Dynamic subtest flip: SUCCESS (3.350s)
[418.148944] Starting dynamic subtest: modeset
[422.924317] Dynamic subtest modeset: SUCCESS (4.933s)
[422.932918] Subtest basic: SUCCESS (8.298s)
[424.159233] [092/171] (692s left) kms_chamelium_hpd (dp-hpd-fast)
[426.321920] Subtest dp-hpd-fast: SKIP (0.000s)
[427.343092] [093/171] (689s left) kms_chamelium_edid (dp-edid-read)
[429.563303] Subtest dp-edid-read: SKIP (0.000s)
[430.603503] [094/171] (686s left) kms_chamelium_frames (dp-crc-fast)
[432.826599] Subtest dp-crc-fast: SKIP (0.000s)
[433.852317] [095/171] (683s left) kms_chamelium_hpd (hdmi-hpd-fast)
[435.923927] Subtest hdmi-hpd-fast: SKIP (0.000s)
[436.933257] [096/171] (680s left) kms_chamelium_edid (hdmi-edid-read)
[439.002957] Subtest hdmi-edid-read: SKIP (0.000s)
[440.038651] [097/171] (678s left) kms_chamelium_frames (hdmi-crc-fast)
[442.159791] Subtest hdmi-crc-fast: SKIP (0.000s)
[443.196637] [098/171] (675s left) kms_chamelium_hpd (vga-hpd-fast)
[445.286622] Subtest vga-hpd-fast: SKIP (0.000s)
[446.317955] [099/171] (672s left) kms_chamelium_edid (vga-edid-read)
[448.363910] Subtest vga-edid-read: SKIP (0.000s)
[449.396625] [100/171] (669s left) kms_prop_blob (basic)
[450.446974] Starting subtest: basic
[450.455377] Subtest basic: SUCCESS (0.000s)
[450.830980] [101/171] (668s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[452.527644] Starting subtest: basic-busy-flip-before-cursor-atomic
[452.551861] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.001s)
[452.902842] [102/171] (666s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[454.493974] Starting subtest: basic-busy-flip-before-cursor-legacy
[454.507724] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[454.854427] [103/171] (664s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[456.453766] Starting subtest: basic-flip-after-cursor-atomic
[458.359183] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.904s)
[459.596920] [104/171] (660s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[461.247644] Starting subtest: basic-flip-after-cursor-legacy
[463.042826] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.812s)
[464.294352] [105/171] (656s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[465.967929] Starting subtest: basic-flip-after-cursor-varying-size
[467.787880] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.818s)
[469.033293] [106/171] (651s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[470.663115] Starting subtest: basic-flip-before-cursor-atomic
[472.536400] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.876s)
[473.744952] [107/171] (647s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[475.367981] Starting subtest: basic-flip-before-cursor-legacy
[477.185707] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.815s)
[478.375577] [108/171] (642s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[480.012627] Starting subtest: basic-flip-before-cursor-varying-size
[481.949500] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.943s)
[483.117186] [109/171] (638s left) kms_flip (basic-flip-vs-dpms)
[484.415914] Starting subtest: basic-flip-vs-dpms
[484.455761] Starting dynamic subtest: A-eDP1
[488.225776] Dynamic subtest A-eDP1: SUCCESS (3.769s)
[488.406750] Starting dynamic subtest: B-eDP1
[491.119940] Dynamic subtest B-eDP1: SUCCESS (2.880s)
[491.282917] Starting dynamic subtest: C-eDP1
[494.027820] Dynamic subtest C-eDP1: SUCCESS (2.896s)
[494.092955] Subtest basic-flip-vs-dpms: SUCCESS (9.685s)
[495.207975] [110/171] (626s left) kms_flip (basic-flip-vs-modeset)
[496.468993] Starting subtest: basic-flip-vs-modeset
[496.521834] Starting dynamic subtest: A-eDP1
[500.172361] Dynamic subtest A-eDP1: SUCCESS (3.651s)
[500.378539] Starting dynamic subtest: B-eDP1
[502.860359] Dynamic subtest B-eDP1: SUCCESS (2.644s)
[503.011729] Starting dynamic subtest: C-eDP1
[505.541356] Dynamic subtest C-eDP1: SUCCESS (2.698s)
[505.598871] Subtest basic-flip-vs-modeset: SUCCESS (9.131s)
[506.748871] [111/171] (615s left) kms_flip (basic-flip-vs-wf_vblank)
[507.958924] Starting subtest: basic-flip-vs-wf_vblank
[508.005711] Starting dynamic subtest: A-eDP1
[510.917787] Dynamic subtest A-eDP1: SUCCESS (2.873s)
[511.066717] Starting dynamic subtest: B-eDP1
[513.534941] Dynamic subtest B-eDP1: SUCCESS (2.593s)
[513.683505] Starting dynamic subtest: C-eDP1
[516.111414] Dynamic subtest C-eDP1: SUCCESS (2.556s)
[516.129714] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.166s)
[518.147901] [112/171] (604s left) kms_flip (basic-plain-flip)
[519.397116] Starting subtest: basic-plain-flip
[519.437744] Starting dynamic subtest: A-eDP1
[522.108534] Dynamic subtest A-eDP1: SUCCESS (2.631s)
[522.242825] Starting dynamic subtest: B-eDP1
[524.508851] Dynamic subtest B-eDP1: SUCCESS (2.336s)
[524.681625] Starting dynamic subtest: C-eDP1
[526.842609] Dynamic subtest C-eDP1: SUCCESS (2.331s)
[526.862244] Subtest basic-plain-flip: SUCCESS (7.449s)
[528.796191] [113/171] (593s left) kms_force_connector_basic (force-connector-state)
[530.421746] Starting subtest: force-connector-state
[533.484481] Subtest force-connector-state: SUCCESS (3.031s)
[536.074125] [114/171] (586s left) kms_force_connector_basic (force-edid)
[537.631296] Starting subtest: force-edid
[538.182473] Subtest force-edid: SUCCESS (0.573s)
[540.036401] [115/171] (583s left) kms_force_connector_basic (force-load-detect)
[541.585737] Starting subtest: force-load-detect
[541.604295] Subtest force-load-detect: SKIP (0.000s)
[543.135687] [116/171] (580s left) kms_force_connector_basic (prune-stale-modes)
[544.681779] Starting subtest: prune-stale-modes
[545.269827] Subtest prune-stale-modes: SUCCESS (0.585s)
[547.096375] [117/171] (576s left) kms_frontbuffer_tracking (basic)
[548.873879] Starting subtest: basic
[557.891926] Subtest basic: SUCCESS (9.016s)
[558.359690] [118/171] (565s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[560.142990] Starting subtest: compare-crc-sanitycheck-xr24
[560.158516] Starting dynamic subtest: pipe-A-eDP-1
[561.310795] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.157s)
[561.496177] Starting dynamic subtest: pipe-B-eDP-1
[563.252389] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.915s)
[563.434573] Starting dynamic subtest: pipe-C-eDP-1
[565.388338] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.110s)
[565.396100] Subtest compare-crc-sanitycheck-xr24: SUCCESS (5.271s)
[566.616513] [119/171] (557s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[568.289704] Starting subtest: compare-crc-sanitycheck-nv12
[568.298599] Starting dynamic subtest: pipe-A-eDP-1
[570.175270] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.870s)
[570.366711] Starting dynamic subtest: pipe-B-eDP-1
[572.814784] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.607s)
[572.990991] Starting dynamic subtest: pipe-C-eDP-1
[573.017262] Dynamic subtest pipe-C-eDP-1: SKIP (0.007s)
[573.025863] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.573s)
[574.012818] [120/171] (550s left) kms_pipe_crc_basic (hang-read-crc)
[575.627913] Starting subtest: hang-read-crc
[575.664712] Starting dynamic subtest: pipe-A-eDP-1
[578.979991] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.327s)
[579.161281] Starting dynamic subtest: pipe-B-eDP-1
[583.035411] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.026s)
[583.208921] Starting dynamic subtest: pipe-C-eDP-1
[587.568645] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.522s)
[587.576819] Subtest hang-read-crc: SUCCESS (11.954s)
[588.773169] [121/171] (536s left) kms_pipe_crc_basic (nonblocking-crc)
[590.395663] Starting subtest: nonblocking-crc
[590.405889] Starting dynamic subtest: pipe-A-eDP-1
[591.746243] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.338s)
[591.894151] Starting dynamic subtest: pipe-B-eDP-1
[593.910771] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.121s)
[594.067979] Starting dynamic subtest: pipe-C-eDP-1
[596.191608] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.269s)
[596.199923] Subtest nonblocking-crc: SUCCESS (5.812s)
[597.384615] [122/171] (527s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[599.006379] Starting subtest: nonblocking-crc-frame-sequence
[599.033616] Starting dynamic subtest: pipe-A-eDP-1
[600.413628] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.373s)
[600.572973] Starting dynamic subtest: pipe-B-eDP-1
[602.508808] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.072s)
[602.686918] Starting dynamic subtest: pipe-C-eDP-1
[604.917243] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.345s)
[604.930234] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.882s)
[606.089353] [123/171] (519s left) kms_pipe_crc_basic (read-crc)
[607.686465] Starting subtest: read-crc
[607.713850] Starting dynamic subtest: pipe-A-eDP-1
[609.046916] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.329s)
[609.221742] Starting dynamic subtest: pipe-B-eDP-1
[611.070294] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.001s)
[611.247959] Starting dynamic subtest: pipe-C-eDP-1
[613.369081] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.262s)
[613.375905] Subtest read-crc: SUCCESS (5.682s)
[614.631550] [124/171] (511s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[616.283911] Starting subtest: read-crc-frame-sequence
[616.291193] Starting dynamic subtest: pipe-A-eDP-1
[617.671899] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.364s)
[617.852686] Starting dynamic subtest: pipe-B-eDP-1
[619.716558] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.021s)
[619.903176] Starting dynamic subtest: pipe-C-eDP-1
[622.023784] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.271s)
[622.030859] Subtest read-crc-frame-sequence: SUCCESS (5.745s)
[623.197954] [125/171] (503s left) kms_psr (primary_page_flip)
[624.823743] Starting subtest: primary_page_flip
[627.672107] Subtest primary_page_flip: SUCCESS (2.853s)
[628.907426] [126/171] (497s left) kms_psr (cursor_plane_move)
[630.581835] Starting subtest: cursor_plane_move
[633.414665] Subtest cursor_plane_move: SUCCESS (2.818s)
[634.612545] [127/171] (492s left) kms_psr (sprite_plane_onoff)
[636.237120] Starting subtest: sprite_plane_onoff
[639.260241] Subtest sprite_plane_onoff: SUCCESS (3.035s)
[640.554603] [128/171] (486s left) kms_psr (primary_mmap_gtt)
[642.147812] Starting subtest: primary_mmap_gtt
[645.015442] Subtest primary_mmap_gtt: SUCCESS (2.853s)
[646.195905] [129/171] (481s left) kms_setmode (basic-clone-single-crtc)
[647.239477] Starting subtest: basic-clone-single-crtc
[647.259865] Subtest basic-clone-single-crtc: SKIP (0.008s)
[647.632089] [130/171] (480s left) i915_pm_backlight (basic-brightness)
[649.363491] Starting subtest: basic-brightness
[649.964594] Starting dynamic subtest: eDP-1
[650.635344] Dynamic subtest eDP-1: SUCCESS (0.728s)
[650.646881] Subtest basic-brightness: SUCCESS (1.269s)
[651.841389] [131/171] (476s left) i915_pm_rpm (basic-pci-d3-state)
[655.785260] Starting subtest: basic-pci-d3-state
[660.686838] Subtest basic-pci-d3-state: SUCCESS (4.884s)
[661.428377] [132/171] (467s left) i915_pm_rpm (basic-rte)
[662.400725] Starting subtest: basic-rte
[670.204359] Subtest basic-rte: SUCCESS (7.797s)
[676.747977] [133/171] (451s left) i915_pm_rps (basic-api)
[677.781672] Starting subtest: basic-api
[677.826747] Subtest basic-api: SUCCESS (0.047s)
[678.250365] [134/171] (450s left) prime_self_import (basic-llseek-bad)
[679.304354] Starting subtest: basic-llseek-bad
[679.317836] Subtest basic-llseek-bad: SUCCESS (0.018s)
[679.791526] [135/171] (449s left) prime_self_import (basic-llseek-size)
[680.725933] Starting subtest: basic-llseek-size
[680.760381] Subtest basic-llseek-size: SUCCESS (0.030s)
[681.185775] [136/171] (448s left) prime_self_import (basic-with_fd_dup)
[682.096427] Starting subtest: basic-with_fd_dup
[682.135341] Subtest basic-with_fd_dup: SUCCESS (0.039s)
[682.592497] [137/171] (447s left) prime_self_import (basic-with_one_bo)
[683.512902] Starting subtest: basic-with_one_bo
[683.546707] Subtest basic-with_one_bo: SUCCESS (0.035s)
[683.981499] [138/171] (446s left) prime_self_import (basic-with_one_bo_two_files)
[684.892774] Starting subtest: basic-with_one_bo_two_files
[684.927125] Subtest basic-with_one_bo_two_files: SUCCESS (0.021s)
[685.373295] [139/171] (445s left) prime_self_import (basic-with_two_bos)
[686.331743] Starting subtest: basic-with_two_bos
[686.370936] Subtest basic-with_two_bos: SUCCESS (0.028s)
[686.857977] [140/171] (443s left) prime_vgem (basic-fence-flip)
[687.993324] Starting subtest: basic-fence-flip
[689.725711] Subtest basic-fence-flip: SUCCESS (1.664s)
[690.275779] [141/171] (440s left) prime_vgem (basic-fence-mmap)
[691.331365] Starting subtest: basic-fence-mmap
[691.661741] Subtest basic-fence-mmap: SUCCESS (0.271s)
[692.049706] [142/171] (439s left) prime_vgem (basic-fence-read)
[693.124662] Starting subtest: basic-fence-read
[693.640317] Subtest basic-fence-read: SUCCESS (0.454s)
[694.028792] [143/171] (437s left) prime_vgem (basic-gtt)
[695.097528] Starting subtest: basic-gtt
[695.274752] Subtest basic-gtt: SUCCESS (0.124s)
[695.690360] [144/171] (436s left) prime_vgem (basic-read)
[696.732824] Starting subtest: basic-read
[696.950875] Subtest basic-read: SUCCESS (0.216s)
[697.435133] [145/171] (434s left) prime_vgem (basic-write)
[698.482645] Starting subtest: basic-write
[698.702126] Subtest basic-write: SUCCESS (0.226s)
[699.146330] [146/171] (433s left) vgem_basic (setversion)
[700.223171] Starting subtest: setversion
[700.238184] Subtest setversion: SUCCESS (0.000s)
[700.624220] [147/171] (432s left) vgem_basic (create)
[701.627178] Starting subtest: create
[701.635662] Subtest create: SUCCESS (0.002s)
[702.054955] [148/171] (431s left) vgem_basic (debugfs)
[703.054461] Starting subtest: debugfs
[703.061909] Subtest debugfs: SUCCESS (0.005s)
[703.489457] [149/171] (430s left) vgem_basic (dmabuf-export)
[704.499174] Starting subtest: dmabuf-export
[704.517330] Subtest dmabuf-export: SUCCESS (0.024s)
[704.951223] [150/171] (428s left) vgem_basic (dmabuf-fence)
[705.942537] Starting subtest: dmabuf-fence
[705.951467] Subtest dmabuf-fence: SUCCESS (0.006s)
[706.319882] [151/171] (427s left) vgem_basic (dmabuf-fence-before)
[707.291665] Starting subtest: dmabuf-fence-before
[707.299884] Subtest dmabuf-fence-before: SUCCESS (0.004s)
[707.663294] [152/171] (426s left) vgem_basic (dmabuf-mmap)
[708.685969] Starting subtest: dmabuf-mmap
[708.903352] Subtest dmabuf-mmap: SUCCESS (0.148s)
[709.274597] [153/171] (425s left) vgem_basic (mmap)
[710.316827] Starting subtest: mmap
[710.489863] Subtest mmap: SUCCESS (0.116s)
[710.834301] [154/171] (424s left) vgem_basic (second-client)
[711.842292] Starting subtest: second-client
[711.926152] Subtest second-client: SUCCESS (0.076s)
[712.387373] [155/171] (423s left) vgem_basic (sysfs)
[713.387430] Starting subtest: sysfs
[713.396776] Subtest sysfs: SUCCESS (0.007s)
[713.817597] [156/171] (421s left) core_hotunplug (unbind-rebind)
[715.273336] Starting subtest: unbind-rebind
[722.869654] Subtest unbind-rebind: SUCCESS (7.570s)
[723.239299] [157/171] (412s left) vgem_basic (unload)
[724.498627] Starting subtest: unload
[754.581131] Subtest unload: SUCCESS (30.035s)
[755.216514] [158/171] (381s left) i915_module_load (reload)
[756.189779] Starting subtest: reload
[768.613589] Subtest reload: SUCCESS (12.423s)
[769.046866] [159/171] (367s left) gem_lmem_swapping (basic)
[770.833798] Subtest basic: SKIP (0.000s)
[771.087303] [160/171] (366s left) gem_lmem_swapping (parallel-random-engines)
[772.101214] Subtest parallel-random-engines: SKIP (0.000s)
[772.431208] [161/171] (365s left) gem_lmem_swapping (random-engines)
[773.435971] Subtest random-engines: SKIP (0.000s)
[773.929197] [162/171] (363s left) gem_lmem_swapping (verify-random)
[774.920764] Subtest verify-random: SKIP (0.000s)
[775.303236] [163/171] (362s left) i915_pm_rpm (module-reload)
[780.060297] Starting subtest: module-reload
[813.617780] Subtest module-reload: SUCCESS (33.489s)
[813.757987] [164/171] (324s left) i915_selftest (live)
[814.862296] Starting subtest: live
[814.869616] Starting dynamic subtest: sanitycheck
[820.750548] Dynamic subtest sanitycheck: SUCCESS (5.864s)
[820.912557] Starting dynamic subtest: uncore
[826.646984] Dynamic subtest uncore: SUCCESS (5.904s)
[826.703344] Starting dynamic subtest: workarounds
[833.613467] Dynamic subtest workarounds: SUCCESS (6.919s)
[833.749682] Starting dynamic subtest: gt_engines
[839.830158] Dynamic subtest gt_engines: SUCCESS (6.211s)
[839.957395] Starting dynamic subtest: gt_timelines
[910.268863] Dynamic subtest gt_timelines: SUCCESS (70.432s)
[910.326812] Starting dynamic subtest: gt_contexts
[916.351515] Dynamic subtest gt_contexts: SUCCESS (6.048s)
[916.484151] Starting dynamic subtest: gt_lrc
[927.622515] Dynamic subtest gt_lrc: SUCCESS (11.214s)
[927.756136] Starting dynamic subtest: gt_mocs
[933.814934] Dynamic subtest gt_mocs: SUCCESS (6.212s)
[933.949336] Starting dynamic subtest: gt_pm
[944.989967] Dynamic subtest gt_pm: FAIL (9.353s)
[945.056736] Starting dynamic subtest: gt_heartbeat
[949.314219] Dynamic subtest gt_heartbeat: SUCCESS (6.107s)
[949.476182] Starting dynamic subtest: gt_tlb
[956.625998] Dynamic subtest gt_tlb: SUCCESS (7.302s)
[956.759757] Starting dynamic subtest: requests
[969.705920] Dynamic subtest requests: SUCCESS (13.072s)
[969.838917] Starting dynamic subtest: migrate
[981.126383] Dynamic subtest migrate: SUCCESS (11.421s)
[981.183552] Starting dynamic subtest: active
[987.066692] Dynamic subtest active: SUCCESS (5.882s)
[987.203818] Starting dynamic subtest: objects
[1002.845285] Dynamic subtest objects: SUCCESS (15.789s)
[1002.975990] Starting dynamic subtest: mman
[1025.471952] Dynamic subtest mman: SUCCESS (22.627s)
[1025.528447] Starting dynamic subtest: dmabuf
[1031.393952] Dynamic subtest dmabuf: SUCCESS (5.892s)
[1031.531722] Starting dynamic subtest: vma
[1037.202925] Dynamic subtest vma: SUCCESS (5.806s)
[1037.264145] Starting dynamic subtest: coherency
[1052.467147] Dynamic subtest coherency: SUCCESS (15.238s)
[1052.524452] Starting dynamic subtest: gtt
[1066.279274] Dynamic subtest gtt: SUCCESS (13.833s)
[1066.340319] Starting dynamic subtest: gem
[1073.631710] Dynamic subtest gem: SUCCESS (7.306s)
[1073.689485] Starting dynamic subtest: evict
[1092.488440] Dynamic subtest evict: SUCCESS (18.832s)
[1092.544383] Starting dynamic subtest: hugepages
[1105.248275] Dynamic subtest hugepages: SUCCESS (12.753s)
[1105.381213] Starting dynamic subtest: gem_contexts
[1157.816243] Dynamic subtest gem_contexts: SUCCESS (52.544s)
[1157.874394] Starting dynamic subtest: client
[1164.091613] Dynamic subtest client: SUCCESS (6.233s)
[1164.232373] Starting dynamic subtest: gem_migrate
[1169.752539] Dynamic subtest gem_migrate: SUCCESS (5.717s)
[1169.931321] Starting dynamic subtest: reset
[1180.580932] Dynamic subtest reset: SUCCESS (10.751s)
[1180.642125] Starting dynamic subtest: memory_region
[1186.292347] Dynamic subtest memory_region: SUCCESS (5.693s)
[1186.425309] Starting dynamic subtest: hangcheck
[1215.596588] Dynamic subtest hangcheck: SUCCESS (29.300s)
[1215.655822] Starting dynamic subtest: execlists
[1237.581478] Dynamic subtest execlists: SUCCESS (21.962s)
[1237.640164] Starting dynamic subtest: ring_submission
[1243.395269] Dynamic subtest ring_submission: SUCCESS (5.780s)
[1243.538102] Starting dynamic subtest: perf
[1249.483416] Dynamic subtest perf: SUCCESS (6.089s)
[1249.622436] Starting dynamic subtest: slpc
[1255.179866] Dynamic subtest slpc: SUCCESS (5.684s)
[1255.310721] Starting dynamic subtest: guc
[1260.844938] Dynamic subtest guc: SUCCESS (5.646s)
[1260.977168] Starting dynamic subtest: guc_multi_lrc
[1266.561742] Dynamic subtest guc_multi_lrc: SUCCESS (5.702s)
[1266.702647] Starting dynamic subtest: guc_hang
[1272.290469] Dynamic subtest guc_hang: SUCCESS (5.748s)
[1272.423114] Starting dynamic subtest: late_gt_pm
[1278.209656] Dynamic subtest late_gt_pm: SUCCESS (5.864s)
[1278.220930] Subtest live: FAIL (463.351s)
[1278.575540] Overall timeout time exceeded, stopping.
[1278.577758] Closing watchdogs
Done.