[31.679961] Initializing watchdogs
[31.680132]   /dev/watchdog0
[31.689185] [001/160] (960s left) i915_module_load (load)
[31.785307] Starting subtest: load
[33.379641] Subtest load: SUCCESS (1.594s)
[33.401960] [002/160] (958s left) core_auth (basic-auth)
[33.500137] Starting subtest: basic-auth
[33.501167] Subtest basic-auth: SUCCESS (0.001s)
[33.572560] [003/160] (958s left) debugfs_test (read_all_entries)
[33.664979] Starting subtest: read_all_entries
[33.717519] Subtest read_all_entries: SUCCESS (0.052s)
[33.844533] [004/160] (958s left) debugfs_test (basic-hwmon)
[34.011156] Starting subtest: basic-hwmon
[34.014053] Subtest basic-hwmon: SKIP (0.000s)
[34.125646] [005/160] (958s left) fbdev (eof)
[34.218512] Starting subtest: eof
[34.219664] Subtest eof: SUCCESS (0.001s)
[34.275439] [006/160] (958s left) fbdev (info)
[34.363561] Starting subtest: info
[34.367133] Subtest info: SUCCESS (0.000s)
[34.426063] [007/160] (957s left) fbdev (nullptr)
[34.519035] Starting subtest: nullptr
[34.520225] Subtest nullptr: SUCCESS (0.000s)
[34.577372] [008/160] (957s left) fbdev (read)
[34.668706] Starting subtest: read
[34.901250] Subtest read: SUCCESS (0.231s)
[34.960289] [009/160] (957s left) fbdev (write)
[35.052818] Starting subtest: write
[35.171670] Subtest write: SUCCESS (0.118s)
[35.233197] [010/160] (957s left) gem_basic (bad-close)
[35.334211] Starting subtest: bad-close
[35.338639] Subtest bad-close: SUCCESS (0.000s)
[35.410876] [011/160] (956s left) gem_basic (create-close)
[35.509228] Starting subtest: create-close
[35.511523] Subtest create-close: SUCCESS (0.000s)
[35.577937] [012/160] (956s left) gem_basic (create-fd-close)
[35.680388] Starting subtest: create-fd-close
[35.682836] Subtest create-fd-close: SUCCESS (0.000s)
[35.745591] [013/160] (956s left) gem_busy (busy@all-engines)
[35.865675] Starting subtest: busy
[35.869966] Starting dynamic subtest: all-engines
[35.901253] Dynamic subtest all-engines: SUCCESS (0.034s)
[35.906119] Subtest busy: SUCCESS (0.039s)
[36.216326] [014/160] (956s left) gem_close_race (basic-process)
[36.324930] Starting subtest: basic-process
[36.371319] Subtest basic-process: SUCCESS (0.049s)
[36.552413] [015/160] (955s left) gem_close_race (basic-threads)
[36.655092] Starting subtest: basic-threads
[37.847252] Subtest basic-threads: SUCCESS (1.191s)
[38.022548] [016/160] (954s left) gem_ctx_create (basic)
[38.134644] Subtest basic: SKIP (0.000s)
[38.175635] [017/160] (954s left) gem_ctx_create (basic-files)
[38.268102] Subtest basic-files: SKIP (0.000s)
[38.308794] [018/160] (954s left) gem_ctx_exec (basic)
[38.401900] Subtest basic: SKIP (0.000s)
[38.476250] [019/160] (954s left) gem_exec_basic (basic)
[38.573532] Starting subtest: basic
[38.576108] Starting dynamic subtest: rcs0-smem
[38.577088] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[38.578158] Subtest basic: SUCCESS (0.002s)
[38.771880] [020/160] (953s left) gem_exec_create (basic)
[38.909163] Starting subtest: basic
[38.910366] Starting dynamic subtest: smem
[40.945394] Dynamic subtest smem: SUCCESS (2.038s)
[40.946571] Subtest basic: SUCCESS (2.038s)
[41.133469] [021/160] (951s left) gem_exec_fence (basic-busy)
[41.366113] Starting subtest: basic-busy
[41.367253] Starting dynamic subtest: rcs0
[41.377080] Dynamic subtest rcs0: SUCCESS (0.012s)
[41.378194] Subtest basic-busy: SUCCESS (0.013s)
[41.869959] [022/160] (950s left) gem_exec_fence (basic-wait)
[42.096081] Starting subtest: basic-wait
[42.097164] Starting dynamic subtest: rcs0
[42.106388] Dynamic subtest rcs0: SUCCESS (0.011s)
[42.107547] Subtest basic-wait: SUCCESS (0.012s)
[42.554400] [023/160] (950s left) gem_exec_fence (basic-await)
[42.780588] Starting subtest: basic-await
[42.781772] Starting dynamic subtest: rcs0
[42.845172] Dynamic subtest rcs0: SUCCESS (0.063s)
[42.846315] Subtest basic-await: SUCCESS (0.064s)
[43.290917] [024/160] (949s left) gem_exec_fence (nb-await)
[43.520830] Starting subtest: nb-await
[43.522000] Starting dynamic subtest: rcs0
[43.571647] Dynamic subtest rcs0: SUCCESS (0.053s)
[43.572806] Subtest nb-await: SUCCESS (0.054s)
[44.026769] [025/160] (948s left) gem_exec_gttfill (basic)
[44.129488] Starting subtest: basic
[47.521957] Subtest basic: SUCCESS (3.392s)
[47.711945] [026/160] (945s left) gem_exec_parallel (engines)
[47.935159] Starting subtest: engines
[47.936285] Starting dynamic subtest: basic
[50.284486] Dynamic subtest basic: SUCCESS (2.348s)
[50.316251] Starting dynamic subtest: contexts
[50.319123] Dynamic subtest contexts: SKIP (0.002s)
[50.340128] Starting dynamic subtest: fds
[50.342295] Dynamic subtest fds: SKIP (0.001s)
[50.364170] Starting dynamic subtest: userptr
[52.858872] Dynamic subtest userptr: SUCCESS (2.567s)
[52.859991] Subtest engines: SUCCESS (4.922s)
[53.084056] [027/160] (939s left) gem_exec_store (basic)
[53.222149] Starting subtest: basic
[53.236521] Subtest basic: SUCCESS (0.015s)
[53.428524] [028/160] (939s left) gem_flink_basic (bad-flink)
[53.519208] Starting subtest: bad-flink
[53.520407] Subtest bad-flink: SUCCESS (0.000s)
[53.595283] [029/160] (939s left) gem_flink_basic (bad-open)
[53.683110] Starting subtest: bad-open
[53.684179] Subtest bad-open: SUCCESS (0.000s)
[53.762998] [030/160] (939s left) gem_flink_basic (basic)
[53.853421] Starting subtest: basic
[53.854539] Subtest basic: SUCCESS (0.000s)
[53.930961] [031/160] (938s left) gem_flink_basic (double-flink)
[54.019354] Starting subtest: double-flink
[54.020489] Subtest double-flink: SUCCESS (0.000s)
[54.096125] [032/160] (938s left) gem_flink_basic (flink-lifetime)
[54.186927] Starting subtest: flink-lifetime
[54.188405] Subtest flink-lifetime: SUCCESS (0.001s)
[54.265042] [033/160] (938s left) gem_huc_copy (huc-copy)
[54.358645] Subtest huc-copy: SKIP (0.000s)
[54.400380] [034/160] (938s left) gem_linear_blits (basic)
[54.702343] Starting subtest: basic
[54.718483] Subtest basic: SUCCESS (0.014s)
[54.834750] [035/160] (938s left) gem_mmap (basic)
[55.050379] Starting subtest: basic
[55.056722] Subtest basic: SUCCESS (0.000s)
[55.117250] [036/160] (937s left) gem_mmap_gtt (basic)
[55.211058] Starting subtest: basic
[55.214149] Subtest basic: SUCCESS (0.001s)
[55.287275] [037/160] (937s left) gem_render_linear_blits (basic)
[55.377251] Starting subtest: basic
[55.429765] Subtest basic: SUCCESS (0.051s)
[55.470807] [038/160] (937s left) gem_render_tiled_blits (basic)
[55.562243] Starting subtest: basic
[55.608152] Subtest basic: SUCCESS (0.043s)
[55.653652] [039/160] (937s left) gem_ringfill (basic-all)
[55.770689] Starting subtest: basic-all
[56.876185] Subtest basic-all: SUCCESS (1.103s)
[56.957623] [040/160] (936s left) gem_softpin (allocator-basic)
[57.060208] Subtest allocator-basic: SKIP (0.000s)
[57.124161] [041/160] (936s left) gem_softpin (allocator-basic-reserve)
[57.215924] Subtest allocator-basic-reserve: SKIP (0.000s)
[57.291330] [042/160] (935s left) gem_softpin (safe-alignment)
[57.384745] Starting subtest: safe-alignment
[57.388919] Subtest safe-alignment: SUCCESS (0.009s)
[57.476071] [043/160] (935s left) gem_sync (basic-all)
[57.583241] Starting subtest: basic-all
[59.707433] Subtest basic-all: SUCCESS (2.127s)
[59.901623] [044/160] (933s left) gem_sync (basic-each)
[60.005092] Starting subtest: basic-each
[62.105826] Subtest basic-each: SUCCESS (2.099s)
[62.292954] [045/160] (930s left) gem_tiled_blits (basic)
[62.547394] Starting subtest: basic
[62.569965] Subtest basic: SUCCESS (0.021s)
[62.678468] [046/160] (930s left) gem_tiled_fence_blits (basic)
[63.064587] Starting subtest: basic
[63.078789] Subtest basic: SUCCESS (0.013s)
[63.197618] [047/160] (930s left) gem_tiled_pread_basic
[63.680310] [048/160] (929s left) gem_wait (busy@all-engines)
[63.793952] Starting subtest: busy
[63.795143] Starting dynamic subtest: all-engines
[64.314689] Dynamic subtest all-engines: SUCCESS (0.516s)
[64.316205] Subtest busy: SUCCESS (0.517s)
[64.534095] [049/160] (928s left) gem_wait (wait@all-engines)
[64.642857] Starting subtest: wait
[64.643968] Starting dynamic subtest: all-engines
[65.661942] Dynamic subtest all-engines: SUCCESS (1.016s)
[65.663091] Subtest wait: SUCCESS (1.017s)
[65.872290] [050/160] (927s left) i915_getparams_basic (basic-eu-total)
[65.966208] Starting subtest: basic-eu-total
[65.968413] Subtest basic-eu-total: SUCCESS (0.000s)
[66.038220] [051/160] (927s left) i915_getparams_basic (basic-subslice-total)
[66.131273] Starting subtest: basic-subslice-total
[66.133451] Subtest basic-subslice-total: SUCCESS (0.000s)
[66.205423] [052/160] (927s left) i915_hangman (error-state-basic)
[66.298848] Starting subtest: error-state-basic
[66.389905] Subtest error-state-basic: SUCCESS (0.091s)
[66.448994] [053/160] (926s left) i915_pciid
[66.616867] [054/160] (926s left) kms_addfb_basic (addfb25-4-tiled)
[66.737387] Starting subtest: addfb25-4-tiled
[66.738625] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[66.816192] [055/160] (926s left) kms_addfb_basic (addfb25-bad-modifier)
[66.906468] Starting subtest: addfb25-bad-modifier
[66.907610] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[67.016750] [056/160] (926s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[67.108058] Starting subtest: addfb25-framebuffer-vs-set-tiling
[67.111545] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[67.219337] [057/160] (926s left) kms_addfb_basic (addfb25-modifier-no-flag)
[67.312754] Starting subtest: addfb25-modifier-no-flag
[67.313829] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[67.419971] [058/160] (926s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[67.510605] Starting subtest: addfb25-x-tiled-legacy
[67.512843] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[67.619836] [059/160] (925s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[67.713875] Starting subtest: addfb25-x-tiled-mismatch-legacy
[67.714936] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[67.821460] [060/160] (925s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[67.939199] Starting subtest: addfb25-yf-tiled-legacy
[67.940460] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[68.019505] [061/160] (925s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[68.144279] Starting subtest: addfb25-y-tiled-legacy
[68.145585] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[68.222164] [062/160] (925s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[68.347362] Starting subtest: addfb25-y-tiled-small-legacy
[68.349553] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[68.423375] [063/160] (925s left) kms_addfb_basic (bad-pitch-0)
[68.516956] Starting subtest: bad-pitch-0
[68.518110] Subtest bad-pitch-0: SUCCESS (0.000s)
[68.624042] [064/160] (925s left) kms_addfb_basic (bad-pitch-1024)
[68.714210] Starting subtest: bad-pitch-1024
[68.715238] Subtest bad-pitch-1024: SUCCESS (0.000s)
[68.825114] [065/160] (924s left) kms_addfb_basic (bad-pitch-128)
[68.914960] Starting subtest: bad-pitch-128
[68.917992] Subtest bad-pitch-128: SUCCESS (0.000s)
[69.024273] [066/160] (924s left) kms_addfb_basic (bad-pitch-256)
[69.115313] Starting subtest: bad-pitch-256
[69.116442] Subtest bad-pitch-256: SUCCESS (0.000s)
[69.224864] [067/160] (924s left) kms_addfb_basic (bad-pitch-32)
[69.315930] Starting subtest: bad-pitch-32
[69.317067] Subtest bad-pitch-32: SUCCESS (0.000s)
[69.425974] [068/160] (924s left) kms_addfb_basic (bad-pitch-63)
[69.517838] Starting subtest: bad-pitch-63
[69.518930] Subtest bad-pitch-63: SUCCESS (0.000s)
[69.625576] [069/160] (924s left) kms_addfb_basic (bad-pitch-65536)
[69.715299] Starting subtest: bad-pitch-65536
[69.718037] Subtest bad-pitch-65536: SUCCESS (0.000s)
[69.830647] [070/160] (924s left) kms_addfb_basic (bad-pitch-999)
[69.925125] Starting subtest: bad-pitch-999
[69.926186] Subtest bad-pitch-999: SUCCESS (0.000s)
[70.028308] [071/160] (923s left) kms_addfb_basic (basic)
[70.118668] Starting subtest: basic
[70.121113] Subtest basic: SUCCESS (0.000s)
[70.229187] [072/160] (923s left) kms_addfb_basic (basic-x-tiled-legacy)
[70.323140] Starting subtest: basic-x-tiled-legacy
[70.324244] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[70.430482] [073/160] (923s left) kms_addfb_basic (basic-y-tiled-legacy)
[70.523044] Starting subtest: basic-y-tiled-legacy
[70.524210] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[70.630087] [074/160] (923s left) kms_addfb_basic (bo-too-small)
[70.751387] Starting subtest: bo-too-small
[70.752576] Subtest bo-too-small: SUCCESS (0.000s)
[70.833713] [075/160] (923s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[70.949237] Starting subtest: bo-too-small-due-to-tiling
[70.950404] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[71.030616] [076/160] (922s left) kms_addfb_basic (clobberred-modifier)
[71.121817] Starting subtest: clobberred-modifier
[71.124942] Subtest clobberred-modifier: SUCCESS (0.000s)
[71.233028] [077/160] (922s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[71.323892] Starting subtest: framebuffer-vs-set-tiling
[71.326852] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[71.434060] [078/160] (922s left) kms_addfb_basic (invalid-get-prop)
[71.524434] Starting subtest: invalid-get-prop
[71.525700] Subtest invalid-get-prop: SUCCESS (0.000s)
[71.633815] [079/160] (922s left) kms_addfb_basic (invalid-get-prop-any)
[71.726075] Starting subtest: invalid-get-prop-any
[71.728144] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[71.834954] [080/160] (922s left) kms_addfb_basic (invalid-set-prop)
[71.923488] Starting subtest: invalid-set-prop
[71.924755] Subtest invalid-set-prop: SUCCESS (0.000s)
[72.034779] [081/160] (922s left) kms_addfb_basic (invalid-set-prop-any)
[72.126309] Starting subtest: invalid-set-prop-any
[72.127463] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[72.235771] [082/160] (921s left) kms_addfb_basic (no-handle)
[72.325460] Starting subtest: no-handle
[72.330221] Subtest no-handle: SUCCESS (0.000s)
[72.435860] [083/160] (921s left) kms_addfb_basic (size-max)
[72.556920] Starting subtest: size-max
[72.558221] Subtest size-max: SUCCESS (0.000s)
[72.637216] [084/160] (921s left) kms_addfb_basic (small-bo)
[72.756696] Starting subtest: small-bo
[72.757827] Subtest small-bo: SUCCESS (0.000s)
[72.838898] [085/160] (921s left) kms_addfb_basic (tile-pitch-mismatch)
[72.928371] Starting subtest: tile-pitch-mismatch
[72.929457] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[73.036329] [086/160] (921s left) kms_addfb_basic (too-high)
[73.157783] Starting subtest: too-high
[73.159170] Subtest too-high: SUCCESS (0.002s)
[73.238928] [087/160] (921s left) kms_addfb_basic (too-wide)
[73.358278] Starting subtest: too-wide
[73.360172] Subtest too-wide: SUCCESS (0.000s)
[73.439644] [088/160] (920s left) kms_addfb_basic (unused-handle)
[73.531901] Starting subtest: unused-handle
[73.532995] Subtest unused-handle: SUCCESS (0.000s)
[73.641307] [089/160] (920s left) kms_addfb_basic (unused-modifier)
[73.728563] Starting subtest: unused-modifier
[73.729654] Subtest unused-modifier: SUCCESS (0.000s)
[73.841089] [090/160] (920s left) kms_addfb_basic (unused-offsets)
[73.932503] Starting subtest: unused-offsets
[73.933688] Subtest unused-offsets: SUCCESS (0.000s)
[74.042878] [091/160] (920s left) kms_addfb_basic (unused-pitches)
[74.131995] Starting subtest: unused-pitches
[74.133168] Subtest unused-pitches: SUCCESS (0.000s)
[74.241864] [092/160] (920s left) kms_busy (basic)
[74.363167] Starting subtest: basic
[74.365974] Starting dynamic subtest: flip
[74.937136] Dynamic subtest flip: SUCCESS (0.572s)
[74.947948] Starting dynamic subtest: modeset
[74.951720] Dynamic subtest modeset: SKIP (0.000s)
[74.952825] Subtest basic: SUCCESS (0.573s)
[75.034735] [093/160] (919s left) kms_prop_blob (basic)
[75.126292] Starting subtest: basic
[75.127369] Subtest basic: SUCCESS (0.000s)
[75.201899] [094/160] (919s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[75.324199] Starting subtest: basic-busy-flip-before-cursor-atomic
[75.326631] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.004s)
[75.401468] [095/160] (919s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[75.521810] Starting subtest: basic-busy-flip-before-cursor-legacy
[76.528109] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.005s)
[76.643663] [096/160] (917s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[76.763750] Starting subtest: basic-flip-after-cursor-atomic
[76.766860] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[76.844475] [097/160] (917s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[76.964106] Starting subtest: basic-flip-after-cursor-legacy
[77.971631] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.006s)
[78.084907] [098/160] (916s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[78.203635] Starting subtest: basic-flip-after-cursor-varying-size
[79.209046] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.003s)
[79.331379] [099/160] (915s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[79.454828] Starting subtest: basic-flip-before-cursor-atomic
[79.456989] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[79.532236] [100/160] (915s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[79.653111] Starting subtest: basic-flip-before-cursor-legacy
[80.653191] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.002s)
[80.770766] [101/160] (913s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[80.892659] Starting subtest: basic-flip-before-cursor-varying-size
[81.887744] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.997s)
[82.011159] [102/160] (912s left) kms_dsc (dsc-basic)
[82.132795] Subtest dsc-basic: SKIP (0.000s)
[82.178429] [103/160] (912s left) kms_flip (basic-flip-vs-dpms)
[82.298127] Starting subtest: basic-flip-vs-dpms
[82.299172] Starting dynamic subtest: A-VGA1
[83.584808] Dynamic subtest A-VGA1: SUCCESS (1.286s)
[83.600950] Starting dynamic subtest: B-VGA1
[84.820243] Dynamic subtest B-VGA1: SUCCESS (1.236s)
[84.825033] Subtest basic-flip-vs-dpms: SUCCESS (2.523s)
[84.970846] [104/160] (909s left) kms_flip (basic-flip-vs-modeset)
[85.094971] Starting subtest: basic-flip-vs-modeset
[85.096135] Starting dynamic subtest: A-VGA1
[86.358699] Dynamic subtest A-VGA1: SUCCESS (1.248s)
[86.377696] Starting dynamic subtest: B-VGA1
[87.596398] Dynamic subtest B-VGA1: SUCCESS (1.251s)
[87.598770] Subtest basic-flip-vs-modeset: SUCCESS (2.503s)
[87.723248] [105/160] (907s left) kms_flip (basic-flip-vs-wf_vblank)
[87.846081] Starting subtest: basic-flip-vs-wf_vblank
[87.847228] Starting dynamic subtest: A-VGA1
[89.380156] Dynamic subtest A-VGA1: SUCCESS (1.534s)
[89.391399] Starting dynamic subtest: B-VGA1
[90.880112] Dynamic subtest B-VGA1: SUCCESS (1.499s)
[90.881582] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.035s)
[91.038633] [106/160] (903s left) kms_flip (basic-plain-flip)
[91.162400] Starting subtest: basic-plain-flip
[91.163561] Starting dynamic subtest: A-VGA1
[92.415368] Dynamic subtest A-VGA1: SUCCESS (1.247s)
[92.445610] Starting dynamic subtest: B-VGA1
[93.611205] Dynamic subtest B-VGA1: SUCCESS (1.199s)
[93.612315] Subtest basic-plain-flip: SUCCESS (2.449s)
[93.784042] [107/160] (900s left) kms_force_connector_basic (force-connector-state)
[93.935586] Starting subtest: force-connector-state
[94.118634] Subtest force-connector-state: SUCCESS (0.184s)
[94.357510] [108/160] (900s left) kms_force_connector_basic (force-edid)
[94.523118] Starting subtest: force-edid
[94.625090] Subtest force-edid: SUCCESS (0.100s)
[94.772166] [109/160] (900s left) kms_force_connector_basic (force-load-detect)
[94.942255] Starting subtest: force-load-detect
[95.126326] Subtest force-load-detect: SUCCESS (0.183s)
[95.337370] [110/160] (899s left) kms_force_connector_basic (prune-stale-modes)
[95.489171] Starting subtest: prune-stale-modes
[95.573244] Subtest prune-stale-modes: SUCCESS (0.083s)
[95.724510] [111/160] (899s left) kms_frontbuffer_tracking (basic)
[95.844795] Subtest basic: SKIP (0.000s)
[95.890483] [112/160] (899s left) kms_hdmi_inject (inject-audio)
[95.982658] Subtest inject-audio: SKIP (0.000s)
[96.024473] [113/160] (898s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[96.144837] Starting subtest: compare-crc-sanitycheck-xr24
[96.146139] Starting dynamic subtest: pipe-A-VGA-1
[96.440799] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.294s)
[96.463217] Starting dynamic subtest: pipe-B-VGA-1
[96.755802] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.314s)
[96.757746] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.612s)
[96.875087] [114/160] (898s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[96.994751] Starting subtest: compare-crc-sanitycheck-nv12
[96.996027] Starting dynamic subtest: pipe-A-VGA-1
[96.999174] Dynamic subtest pipe-A-VGA-1: SKIP (0.001s)
[97.015068] Starting dynamic subtest: pipe-B-VGA-1
[97.017094] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s)
[97.019288] Subtest compare-crc-sanitycheck-nv12: SKIP (0.007s)
[97.075357] [115/160] (897s left) kms_pipe_crc_basic (hang-read-crc)
[97.200094] Starting subtest: hang-read-crc
[97.201139] Starting dynamic subtest: pipe-A-VGA-1
[98.051722] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.853s)
[98.071493] Starting dynamic subtest: pipe-B-VGA-1
[98.912926] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.862s)
[98.914949] Subtest hang-read-crc: SUCCESS (1.717s)
[99.033739] [116/160] (895s left) kms_pipe_crc_basic (nonblocking-crc)
[99.154702] Starting subtest: nonblocking-crc
[99.155932] Starting dynamic subtest: pipe-A-VGA-1
[99.614810] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.460s)
[99.627341] Starting dynamic subtest: pipe-B-VGA-1
[100.090638] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.476s)
[100.092432] Subtest nonblocking-crc: SUCCESS (0.938s)
[100.208659] [117/160] (894s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[100.330098] Starting subtest: nonblocking-crc-frame-sequence
[100.331254] Starting dynamic subtest: pipe-A-VGA-1
[100.793883] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.465s)
[100.809880] Starting dynamic subtest: pipe-B-VGA-1
[101.270363] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.475s)
[101.272121] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.943s)
[101.389418] [118/160] (893s left) kms_pipe_crc_basic (read-crc)
[101.509649] Starting subtest: read-crc
[101.511320] Starting dynamic subtest: pipe-A-VGA-1
[101.892639] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.383s)
[101.912123] Starting dynamic subtest: pipe-B-VGA-1
[102.305756] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.409s)
[102.308307] Subtest read-crc: SUCCESS (0.796s)
[102.420391] [119/160] (892s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[102.541198] Starting subtest: read-crc-frame-sequence
[102.542387] Starting dynamic subtest: pipe-A-VGA-1
[102.957877] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.415s)
[102.974162] Starting dynamic subtest: pipe-B-VGA-1
[103.368245] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.408s)
[103.369938] Subtest read-crc-frame-sequence: SUCCESS (0.826s)
[103.479800] [120/160] (891s left) kms_pm_backlight (basic-brightness)
[103.603087] Subtest basic-brightness: SKIP (0.000s)
[103.649115] [121/160] (891s left) kms_pm_rpm (basic-pci-d3-state)
[114.935142] Subtest basic-pci-d3-state: SKIP (0.000s)
[114.975305] [122/160] (880s left) kms_pm_rpm (basic-rte)
[115.061905] Starting subtest: basic-rte
[126.236891] Subtest basic-rte: SKIP (11.170s)
[126.276814] [123/160] (868s left) kms_psr (psr-primary-page-flip)
[126.397367] Subtest psr-primary-page-flip: SKIP (0.000s)
[126.441524] [124/160] (868s left) kms_psr (psr-cursor-plane-move)
[126.563087] Subtest psr-cursor-plane-move: SKIP (0.000s)
[126.611584] [125/160] (868s left) kms_psr (psr-sprite-plane-onoff)
[126.730645] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[126.777150] [126/160] (868s left) kms_psr (psr-primary-mmap-gtt)
[126.899881] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[126.943916] [127/160] (868s left) kms_setmode (basic-clone-single-crtc)
[127.037281] Starting subtest: basic-clone-single-crtc
[127.040693] Subtest basic-clone-single-crtc: SKIP (0.000s)
[127.112158] [128/160] (868s left) i915_pm_rps (basic-api)
[127.208577] Subtest basic-api: SKIP (0.000s)
[127.247586] [129/160] (868s left) prime_self_import (basic-llseek-bad)
[127.339054] Starting subtest: basic-llseek-bad
[127.341456] Subtest basic-llseek-bad: SUCCESS (0.002s)
[127.412775] [130/160] (867s left) prime_self_import (basic-llseek-size)
[127.501052] Starting subtest: basic-llseek-size
[127.503272] Subtest basic-llseek-size: SUCCESS (0.005s)
[127.579432] [131/160] (867s left) prime_self_import (basic-with_fd_dup)
[127.669928] Starting subtest: basic-with_fd_dup
[127.672244] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[127.747569] [132/160] (867s left) prime_self_import (basic-with_one_bo)
[127.835740] Starting subtest: basic-with_one_bo
[127.838227] Subtest basic-with_one_bo: SUCCESS (0.004s)
[127.916574] [133/160] (867s left) prime_self_import (basic-with_one_bo_two_files)
[128.008617] Starting subtest: basic-with_one_bo_two_files
[128.010958] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[128.081962] [134/160] (867s left) prime_self_import (basic-with_two_bos)
[128.167918] Starting subtest: basic-with_two_bos
[128.173266] Subtest basic-with_two_bos: SUCCESS (0.006s)
[128.247500] [135/160] (867s left) prime_vgem (basic-fence-flip)
[128.341564] Starting subtest: basic-fence-flip
[128.723592] Subtest basic-fence-flip: SUCCESS (0.384s)
[128.818239] [136/160] (866s left) prime_vgem (basic-fence-mmap)
[128.925670] Starting subtest: basic-fence-mmap
[128.968810] Subtest basic-fence-mmap: SUCCESS (0.044s)
[129.051205] [137/160] (866s left) prime_vgem (basic-fence-read)
[129.161912] Starting subtest: basic-fence-read
[129.222247] Subtest basic-fence-read: SUCCESS (0.061s)
[129.303058] [138/160] (866s left) prime_vgem (basic-gtt)
[129.412856] Starting subtest: basic-gtt
[129.430638] Subtest basic-gtt: SUCCESS (0.020s)
[129.519635] [139/160] (866s left) prime_vgem (basic-read)
[129.628414] Starting subtest: basic-read
[129.656702] Subtest basic-read: SUCCESS (0.028s)
[129.737296] [140/160] (865s left) prime_vgem (basic-write)
[129.847385] Starting subtest: basic-write
[129.874838] Subtest basic-write: SUCCESS (0.030s)
[129.955353] [141/160] (865s left) vgem_basic (setversion)
[130.062370] Starting subtest: setversion
[130.064777] Subtest setversion: SUCCESS (0.000s)
[130.119663] [142/160] (865s left) vgem_basic (create)
[130.228163] Starting subtest: create
[130.229286] Subtest create: SUCCESS (0.000s)
[130.289825] [143/160] (865s left) vgem_basic (debugfs)
[130.394938] Starting subtest: debugfs
[130.396166] Subtest debugfs: SUCCESS (0.001s)
[130.455364] [144/160] (865s left) vgem_basic (dmabuf-export)
[130.561455] Starting subtest: dmabuf-export
[130.564932] Subtest dmabuf-export: SUCCESS (0.002s)
[130.642782] [145/160] (865s left) vgem_basic (dmabuf-fence)
[130.745743] Starting subtest: dmabuf-fence
[130.747463] Subtest dmabuf-fence: SUCCESS (0.001s)
[130.808510] [146/160] (864s left) vgem_basic (dmabuf-fence-before)
[130.912990] Starting subtest: dmabuf-fence-before
[130.914246] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[130.974180] [147/160] (864s left) vgem_basic (dmabuf-mmap)
[131.079662] Starting subtest: dmabuf-mmap
[131.101825] Subtest dmabuf-mmap: SUCCESS (0.023s)
[131.159168] [148/160] (864s left) vgem_basic (mmap)
[131.263464] Starting subtest: mmap
[131.276989] Subtest mmap: SUCCESS (0.016s)
[131.344427] [149/160] (864s left) vgem_basic (second-client)
[131.447185] Starting subtest: second-client
[131.480924] Subtest second-client: SUCCESS (0.033s)
[131.542616] [150/160] (864s left) vgem_basic (sysfs)
[131.648145] Starting subtest: sysfs
[131.649252] Subtest sysfs: SUCCESS (0.001s)
[131.709499] [151/160] (864s left) core_hotunplug (unbind-rebind)
[131.846610] Starting subtest: unbind-rebind
[134.623730] Subtest unbind-rebind: SUCCESS (2.777s)
[134.653555] [152/160] (861s left) vgem_basic (unload)
[134.747228] Starting subtest: unload
[163.632976] Subtest unload: SUCCESS (28.884s)
[163.738322] [153/160] (832s left) i915_module_load (reload)
[163.825736] Starting subtest: reload
[165.631249] Subtest reload: SUCCESS (1.807s)
[165.660215] [154/160] (830s left) gem_lmem_swapping (basic)
[165.763904] Subtest basic: SKIP (0.000s)
[165.795904] [155/160] (830s left) gem_lmem_swapping (parallel-random-engines)
[165.890243] Subtest parallel-random-engines: SKIP (0.000s)
[165.931254] [156/160] (830s left) gem_lmem_swapping (random-engines)
[166.072674] Subtest random-engines: SKIP (0.000s)
[166.122610] [157/160] (829s left) gem_lmem_swapping (verify-random)
[166.260841] Subtest verify-random: SKIP (0.000s)
[166.298571] [158/160] (829s left) i915_pm_rpm (module-reload)
[177.582248] Subtest module-reload: SKIP (0.000s)
[177.619285] [159/160] (818s left) i915_selftest (live)
[178.223380] Starting subtest: live
[178.224525] Starting dynamic subtest: sanitycheck
[178.920306] Dynamic subtest sanitycheck: SUCCESS (0.696s)
[178.931189] Starting dynamic subtest: uncore
[179.562182] Dynamic subtest uncore: SUCCESS (0.641s)
[179.572423] Starting dynamic subtest: workarounds
[180.233108] Dynamic subtest workarounds: SUCCESS (0.670s)
[180.243121] Starting dynamic subtest: gt_engines
[180.898127] Dynamic subtest gt_engines: SUCCESS (0.664s)
[180.908278] Starting dynamic subtest: gt_timelines
[183.736231] Dynamic subtest gt_timelines: SUCCESS (2.837s)
[183.746797] Starting dynamic subtest: gt_contexts
[184.383067] Dynamic subtest gt_contexts: SUCCESS (0.647s)
[184.394216] Starting dynamic subtest: gt_lrc
[185.043079] Dynamic subtest gt_lrc: SUCCESS (0.658s)
[185.053362] Starting dynamic subtest: gt_mocs
[185.685077] Dynamic subtest gt_mocs: SUCCESS (0.641s)
[185.696097] Starting dynamic subtest: gt_pm
[186.820349] Dynamic subtest gt_pm: SUCCESS (1.134s)
[186.830951] Starting dynamic subtest: gt_heartbeat
[187.493185] Dynamic subtest gt_heartbeat: SUCCESS (0.672s)
[187.503788] Starting dynamic subtest: gt_tlb
[188.144153] Dynamic subtest gt_tlb: SUCCESS (0.650s)
[188.154374] Starting dynamic subtest: requests
[191.371123] Dynamic subtest requests: SUCCESS (3.226s)
[191.381441] Starting dynamic subtest: migrate
[192.024220] Dynamic subtest migrate: SUCCESS (0.652s)
[192.035126] Starting dynamic subtest: active
[192.679313] Dynamic subtest active: SUCCESS (0.654s)
[192.689548] Starting dynamic subtest: objects
[193.661051] Dynamic subtest objects: SUCCESS (0.981s)
[193.672023] Starting dynamic subtest: mman
[198.618117] Dynamic subtest mman: SUCCESS (4.953s)
[198.627853] Starting dynamic subtest: dmabuf
[199.328182] Dynamic subtest dmabuf: SUCCESS (0.712s)
[199.339466] Starting dynamic subtest: vma
[200.001189] Dynamic subtest vma: SUCCESS (0.671s)
[200.011311] Starting dynamic subtest: coherency
[202.202308] Dynamic subtest coherency: SUCCESS (2.200s)
[202.213063] Starting dynamic subtest: gtt
[205.776248] Dynamic subtest gtt: SUCCESS (3.571s)
[205.786407] Starting dynamic subtest: gem
[206.468165] Dynamic subtest gem: SUCCESS (0.693s)
[206.478331] Starting dynamic subtest: evict
[207.107109] Dynamic subtest evict: SUCCESS (0.638s)
[207.116110] Starting dynamic subtest: hugepages
[207.768100] Dynamic subtest hugepages: SUCCESS (0.660s)
[207.778550] Starting dynamic subtest: gem_contexts
[208.424217] Dynamic subtest gem_contexts: SUCCESS (0.655s)
[208.434292] Starting dynamic subtest: client
[209.071373] Dynamic subtest client: SUCCESS (0.646s)
[209.081670] Starting dynamic subtest: gem_migrate
[209.701909] Dynamic subtest gem_migrate: SUCCESS (0.630s)
[209.712381] Starting dynamic subtest: reset
[210.672183] Dynamic subtest reset: SUCCESS (0.969s)
[210.683063] Starting dynamic subtest: memory_region
[211.315071] Dynamic subtest memory_region: SUCCESS (0.642s)
[211.325495] Starting dynamic subtest: hangcheck
[213.016212] Dynamic subtest hangcheck: SUCCESS (1.698s)
[213.026310] Starting dynamic subtest: execlists
[213.652091] Dynamic subtest execlists: SUCCESS (0.637s)
[213.663140] Starting dynamic subtest: ring_submission
[214.296963] Dynamic subtest ring_submission: SUCCESS (0.644s)
[214.308227] Starting dynamic subtest: perf
[214.951453] Dynamic subtest perf: SUCCESS (0.653s)
[214.961896] Starting dynamic subtest: slpc
[215.607190] Dynamic subtest slpc: SUCCESS (0.652s)
[215.617427] Starting dynamic subtest: guc
[216.250199] Dynamic subtest guc: SUCCESS (0.644s)
[216.261073] Starting dynamic subtest: guc_multi_lrc
[216.898947] Dynamic subtest guc_multi_lrc: SUCCESS (0.648s)
[216.910043] Starting dynamic subtest: guc_hang
[217.548459] Dynamic subtest guc_hang: SUCCESS (0.648s)
[217.559157] Starting dynamic subtest: late_gt_pm
[218.203454] Dynamic subtest late_gt_pm: SUCCESS (0.654s)
[218.204634] Subtest live: SUCCESS (39.980s)
[218.230890] [160/160] (777s left) dmabuf (all-tests)
[218.330409] Starting subtest: all-tests
[218.331581] Starting dynamic subtest: sanitycheck
[218.382234] Dynamic subtest sanitycheck: SUCCESS (0.057s)
[218.393699] Starting dynamic subtest: dma_fence
[218.553203] Dynamic subtest dma_fence: SUCCESS (0.170s)
[218.566162] Starting dynamic subtest: dma_fence_chain
[236.113120] Dynamic subtest dma_fence_chain: SUCCESS (17.557s)
[236.125401] Starting dynamic subtest: dma_fence_unwrap
[236.170166] Dynamic subtest dma_fence_unwrap: SUCCESS (0.056s)
[236.183816] Starting dynamic subtest: dma_resv
[236.231679] Dynamic subtest dma_resv: SUCCESS (0.063s)
[236.233380] Subtest all-tests: SUCCESS (17.908s)
[236.255520] Closing watchdogs
Done.