[38.794375] Initializing watchdogs
[38.794494]   /dev/watchdog0
[38.801463] [001/165] (960s left) i915_module_load (load)
[38.889928] Starting subtest: load
[40.380920] Subtest load: SUCCESS (1.490s)
[40.398643] [002/165] (958s left) core_auth (basic-auth)
[40.489685] Starting subtest: basic-auth
[40.490790] Subtest basic-auth: SUCCESS (0.001s)
[40.555892] [003/165] (958s left) debugfs_test (read_all_entries)
[40.646037] Starting subtest: read_all_entries
[40.699931] Subtest read_all_entries: SUCCESS (0.054s)
[40.830635] [004/165] (958s left) debugfs_test (basic-hwmon)
[40.973380] Starting subtest: basic-hwmon
[40.977992] Subtest basic-hwmon: SKIP (0.000s)
[41.091339] [005/165] (958s left) fbdev (eof)
[41.184325] Starting subtest: eof
[41.185436] Subtest eof: SUCCESS (0.001s)
[41.240269] [006/165] (958s left) fbdev (info)
[41.321157] Starting subtest: info
[41.322337] Subtest info: SUCCESS (0.000s)
[41.390484] [007/165] (958s left) fbdev (nullptr)
[41.487587] Starting subtest: nullptr
[41.488876] Subtest nullptr: SUCCESS (0.000s)
[41.542706] [008/165] (957s left) fbdev (read)
[41.634661] Starting subtest: read
[41.869202] Subtest read: SUCCESS (0.234s)
[41.925542] [009/165] (957s left) fbdev (write)
[42.019335] Starting subtest: write
[42.138513] Subtest write: SUCCESS (0.117s)
[42.194311] [010/165] (957s left) gem_basic (bad-close)
[42.280151] Starting subtest: bad-close
[42.282323] Subtest bad-close: SUCCESS (0.000s)
[42.344588] [011/165] (957s left) gem_basic (create-close)
[42.428718] Starting subtest: create-close
[42.431195] Subtest create-close: SUCCESS (0.000s)
[42.494345] [012/165] (957s left) gem_basic (create-fd-close)
[42.579142] Starting subtest: create-fd-close
[42.581979] Subtest create-fd-close: SUCCESS (0.000s)
[42.645662] [013/165] (956s left) gem_busy (busy@all-engines)
[42.747600] Starting subtest: busy
[42.748667] Starting dynamic subtest: all-engines
[42.770223] Dynamic subtest all-engines: SUCCESS (0.025s)
[42.772186] Subtest busy: SUCCESS (0.026s)
[43.081644] [014/165] (956s left) gem_close_race (basic-process)
[43.186220] Starting subtest: basic-process
[43.226560] Subtest basic-process: SUCCESS (0.043s)
[43.415793] [015/165] (956s left) gem_close_race (basic-threads)
[43.520099] Starting subtest: basic-threads
[44.641850] Subtest basic-threads: SUCCESS (1.125s)
[44.821253] [016/165] (954s left) gem_ctx_create (basic)
[44.911382] Subtest basic: SKIP (0.000s)
[44.938449] [017/165] (954s left) gem_ctx_create (basic-files)
[45.029821] Subtest basic-files: SKIP (0.000s)
[45.073292] [018/165] (954s left) gem_ctx_exec (basic)
[45.164163] Subtest basic: SKIP (0.000s)
[45.222363] [019/165] (954s left) gem_exec_basic (basic)
[45.315577] Starting subtest: basic
[45.316842] Starting dynamic subtest: rcs0-smem
[45.317932] Dynamic subtest rcs0-smem: SUCCESS (0.000s)
[45.319116] Subtest basic: SUCCESS (0.001s)
[45.505350] [020/165] (954s left) gem_exec_create (basic)
[45.603219] Starting subtest: basic
[45.604359] Starting dynamic subtest: smem
[47.647166] Dynamic subtest smem: SUCCESS (2.044s)
[47.648316] Subtest basic: SUCCESS (2.044s)
[47.831415] [021/165] (951s left) gem_exec_fence (basic-busy)
[48.054189] Starting subtest: basic-busy
[48.055470] Starting dynamic subtest: rcs0
[48.063459] Dynamic subtest rcs0: SUCCESS (0.012s)
[48.064585] Subtest basic-busy: SUCCESS (0.013s)
[48.549327] [022/165] (951s left) gem_exec_fence (basic-wait)
[48.785308] Starting subtest: basic-wait
[48.789100] Starting dynamic subtest: rcs0
[48.797551] Dynamic subtest rcs0: SUCCESS (0.013s)
[48.798657] Subtest basic-wait: SUCCESS (0.014s)
[49.234695] [023/165] (950s left) gem_exec_fence (basic-await)
[49.464846] Starting subtest: basic-await
[49.465838] Starting dynamic subtest: rcs0
[49.528212] Dynamic subtest rcs0: SUCCESS (0.063s)
[49.529328] Subtest basic-await: SUCCESS (0.063s)
[49.971843] [024/165] (949s left) gem_exec_fence (nb-await)
[50.195623] Starting subtest: nb-await
[50.196752] Starting dynamic subtest: rcs0
[50.246426] Dynamic subtest rcs0: SUCCESS (0.053s)
[50.247655] Subtest nb-await: SUCCESS (0.053s)
[50.691945] [025/165] (949s left) gem_exec_gttfill (basic)
[50.795113] Starting subtest: basic
[54.087199] Subtest basic: SUCCESS (3.295s)
[54.276303] [026/165] (945s left) gem_exec_parallel (engines)
[54.491408] Starting subtest: engines
[54.493659] Starting dynamic subtest: basic
[56.118583] Dynamic subtest basic: SUCCESS (1.624s)
[56.129943] Starting dynamic subtest: contexts
[56.132145] Dynamic subtest contexts: SKIP (0.000s)
[56.140233] Starting dynamic subtest: fds
[56.142458] Dynamic subtest fds: SKIP (0.000s)
[56.150990] Starting dynamic subtest: userptr
[57.753106] Dynamic subtest userptr: SUCCESS (1.634s)
[57.754302] Subtest engines: SUCCESS (3.260s)
[57.934035] [027/165] (941s left) gem_exec_store (basic)
[58.031967] Starting subtest: basic
[58.048564] Subtest basic: SUCCESS (0.017s)
[58.234895] [028/165] (941s left) gem_flink_basic (bad-flink)
[58.319081] Starting subtest: bad-flink
[58.320142] Subtest bad-flink: SUCCESS (0.000s)
[58.386399] [029/165] (941s left) gem_flink_basic (bad-open)
[58.475430] Starting subtest: bad-open
[58.476601] Subtest bad-open: SUCCESS (0.000s)
[58.535974] [030/165] (941s left) gem_flink_basic (basic)
[58.620375] Starting subtest: basic
[58.621517] Subtest basic: SUCCESS (0.000s)
[58.687678] [031/165] (941s left) gem_flink_basic (double-flink)
[58.771192] Starting subtest: double-flink
[58.772559] Subtest double-flink: SUCCESS (0.000s)
[58.836549] [032/165] (941s left) gem_flink_basic (flink-lifetime)
[58.922514] Starting subtest: flink-lifetime
[58.923679] Subtest flink-lifetime: SUCCESS (0.001s)
[59.003254] [033/165] (940s left) gem_huc_copy (huc-copy)
[59.092542] Subtest huc-copy: SKIP (0.000s)
[59.121848] [034/165] (940s left) gem_linear_blits (basic)
[59.485743] Starting subtest: basic
[59.497883] Subtest basic: SUCCESS (0.012s)
[59.605861] [035/165] (940s left) gem_mmap (basic)
[59.810163] Starting subtest: basic
[59.816422] Subtest basic: SUCCESS (0.000s)
[59.890456] [036/165] (940s left) gem_mmap_gtt (basic)
[59.980118] Starting subtest: basic
[59.981335] Subtest basic: SUCCESS (0.001s)
[60.025332] [037/165] (940s left) gem_render_linear_blits (basic)
[60.113291] Starting subtest: basic
[60.168625] Subtest basic: SUCCESS (0.051s)
[60.209611] [038/165] (939s left) gem_render_tiled_blits (basic)
[60.299837] Starting subtest: basic
[60.344644] Subtest basic: SUCCESS (0.043s)
[60.395172] [039/165] (939s left) gem_ringfill (basic-all)
[60.503968] Starting subtest: basic-all
[61.608556] Subtest basic-all: SUCCESS (1.101s)
[61.677779] [040/165] (938s left) gem_softpin (allocator-basic)
[61.764916] Subtest allocator-basic: SKIP (0.000s)
[61.829045] [041/165] (938s left) gem_softpin (allocator-basic-reserve)
[61.915576] Subtest allocator-basic-reserve: SKIP (0.000s)
[61.980021] [042/165] (938s left) gem_softpin (safe-alignment)
[62.068050] Starting subtest: safe-alignment
[62.071593] Subtest safe-alignment: SUCCESS (0.006s)
[62.148142] [043/165] (938s left) gem_sync (basic-all)
[62.247606] Starting subtest: basic-all
[64.343454] Subtest basic-all: SUCCESS (2.097s)
[64.523369] [044/165] (935s left) gem_sync (basic-each)
[64.619023] Starting subtest: basic-each
[66.690072] Subtest basic-each: SUCCESS (2.073s)
[66.881438] [045/165] (933s left) gem_tiled_blits (basic)
[67.266186] Starting subtest: basic
[67.287856] Subtest basic: SUCCESS (0.021s)
[67.399304] [046/165] (932s left) gem_tiled_fence_blits (basic)
[67.859868] Starting subtest: basic
[67.873756] Subtest basic: SUCCESS (0.013s)
[67.986572] [047/165] (932s left) gem_tiled_pread_basic
[68.453641] [048/165] (931s left) gem_wait (busy@all-engines)
[68.559509] Starting subtest: busy
[68.561042] Starting dynamic subtest: all-engines
[69.073198] Dynamic subtest all-engines: SUCCESS (0.513s)
[69.076599] Subtest busy: SUCCESS (0.514s)
[69.289955] [049/165] (931s left) gem_wait (wait@all-engines)
[69.392871] Starting subtest: wait
[69.394033] Starting dynamic subtest: all-engines
[70.408673] Dynamic subtest all-engines: SUCCESS (1.013s)
[70.409737] Subtest wait: SUCCESS (1.014s)
[70.611157] [050/165] (929s left) i915_getparams_basic (basic-eu-total)
[70.697935] Starting subtest: basic-eu-total
[70.701695] Subtest basic-eu-total: SUCCESS (0.000s)
[70.760920] [051/165] (929s left) i915_getparams_basic (basic-subslice-total)
[70.846842] Starting subtest: basic-subslice-total
[70.850156] Subtest basic-subslice-total: SUCCESS (0.000s)
[70.909342] [052/165] (929s left) i915_hangman (error-state-basic)
[71.002083] Starting subtest: error-state-basic
[71.121826] Subtest error-state-basic: SUCCESS (0.119s)
[71.174853] [053/165] (929s left) i915_pciid
[71.321576] [054/165] (929s left) kms_addfb_basic (addfb25-4-tiled)
[71.446255] Starting subtest: addfb25-4-tiled
[71.447367] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[71.521628] [055/165] (928s left) kms_addfb_basic (addfb25-bad-modifier)
[71.607302] Starting subtest: addfb25-bad-modifier
[71.608386] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[71.708399] [056/165] (928s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[71.794235] Starting subtest: addfb25-framebuffer-vs-set-tiling
[71.795304] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[71.908450] [057/165] (928s left) kms_addfb_basic (addfb25-modifier-no-flag)
[71.995246] Starting subtest: addfb25-modifier-no-flag
[71.996236] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[72.109117] [058/165] (928s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[72.199197] Starting subtest: addfb25-x-tiled-legacy
[72.200332] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[72.309820] [059/165] (928s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[72.396087] Starting subtest: addfb25-x-tiled-mismatch-legacy
[72.397137] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[72.508281] [060/165] (928s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[72.635720] Starting subtest: addfb25-yf-tiled-legacy
[72.636908] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[72.708227] [061/165] (927s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[72.819237] Starting subtest: addfb25-y-tiled-legacy
[72.820597] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[72.894940] [062/165] (927s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[73.001601] Starting subtest: addfb25-y-tiled-small-legacy
[73.003825] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[73.078799] [063/165] (927s left) kms_addfb_basic (bad-pitch-0)
[73.164843] Starting subtest: bad-pitch-0
[73.165952] Subtest bad-pitch-0: SUCCESS (0.000s)
[73.281437] [064/165] (927s left) kms_addfb_basic (bad-pitch-1024)
[73.367956] Starting subtest: bad-pitch-1024
[73.369081] Subtest bad-pitch-1024: SUCCESS (0.000s)
[73.480349] [065/165] (927s left) kms_addfb_basic (bad-pitch-128)
[73.565987] Starting subtest: bad-pitch-128
[73.567240] Subtest bad-pitch-128: SUCCESS (0.000s)
[73.661365] [066/165] (927s left) kms_addfb_basic (bad-pitch-256)
[73.748681] Starting subtest: bad-pitch-256
[73.750225] Subtest bad-pitch-256: SUCCESS (0.000s)
[73.847346] [067/165] (926s left) kms_addfb_basic (bad-pitch-32)
[73.931244] Starting subtest: bad-pitch-32
[73.932301] Subtest bad-pitch-32: SUCCESS (0.000s)
[74.033808] [068/165] (926s left) kms_addfb_basic (bad-pitch-63)
[74.120884] Starting subtest: bad-pitch-63
[74.122068] Subtest bad-pitch-63: SUCCESS (0.000s)
[74.233324] [069/165] (926s left) kms_addfb_basic (bad-pitch-65536)
[74.319580] Starting subtest: bad-pitch-65536
[74.320678] Subtest bad-pitch-65536: SUCCESS (0.000s)
[74.433868] [070/165] (926s left) kms_addfb_basic (bad-pitch-999)
[74.518314] Starting subtest: bad-pitch-999
[74.519363] Subtest bad-pitch-999: SUCCESS (0.000s)
[74.633233] [071/165] (926s left) kms_addfb_basic (basic)
[74.719052] Starting subtest: basic
[74.720127] Subtest basic: SUCCESS (0.000s)
[74.816980] [072/165] (926s left) kms_addfb_basic (basic-x-tiled-legacy)
[74.903236] Starting subtest: basic-x-tiled-legacy
[74.904731] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[75.001430] [073/165] (925s left) kms_addfb_basic (basic-y-tiled-legacy)
[75.087819] Starting subtest: basic-y-tiled-legacy
[75.088932] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[75.186150] [074/165] (925s left) kms_addfb_basic (bo-too-small)
[75.310332] Starting subtest: bo-too-small
[75.311599] Subtest bo-too-small: SUCCESS (0.000s)
[75.386907] [075/165] (925s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[75.492360] Starting subtest: bo-too-small-due-to-tiling
[75.493517] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[75.570307] [076/165] (925s left) kms_addfb_basic (clobberred-modifier)
[75.654574] Starting subtest: clobberred-modifier
[75.656151] Subtest clobberred-modifier: SUCCESS (0.000s)
[75.754635] [077/165] (925s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[75.837393] Starting subtest: framebuffer-vs-set-tiling
[75.838844] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[75.938755] [078/165] (925s left) kms_addfb_basic (invalid-get-prop)
[76.025302] Starting subtest: invalid-get-prop
[76.026405] Subtest invalid-get-prop: SUCCESS (0.000s)
[76.139342] [079/165] (924s left) kms_addfb_basic (invalid-get-prop-any)
[76.223348] Starting subtest: invalid-get-prop-any
[76.224406] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[76.340121] [080/165] (924s left) kms_addfb_basic (invalid-set-prop)
[76.425871] Starting subtest: invalid-set-prop
[76.428088] Subtest invalid-set-prop: SUCCESS (0.000s)
[76.523386] [081/165] (924s left) kms_addfb_basic (invalid-set-prop-any)
[76.609716] Starting subtest: invalid-set-prop-any
[76.611773] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[76.706273] [082/165] (924s left) kms_addfb_basic (no-handle)
[76.792278] Starting subtest: no-handle
[76.793440] Subtest no-handle: SUCCESS (0.000s)
[76.890764] [083/165] (924s left) kms_addfb_basic (size-max)
[76.999383] Starting subtest: size-max
[77.000500] Subtest size-max: SUCCESS (0.000s)
[77.077720] [084/165] (924s left) kms_addfb_basic (small-bo)
[77.198382] Starting subtest: small-bo
[77.199494] Subtest small-bo: SUCCESS (0.000s)
[77.277673] [085/165] (923s left) kms_addfb_basic (tile-pitch-mismatch)
[77.362828] Starting subtest: tile-pitch-mismatch
[77.363884] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[77.478641] [086/165] (923s left) kms_addfb_basic (too-high)
[77.603851] Starting subtest: too-high
[77.604990] Subtest too-high: SUCCESS (0.002s)
[77.676793] [087/165] (923s left) kms_addfb_basic (too-wide)
[77.801175] Starting subtest: too-wide
[77.802381] Subtest too-wide: SUCCESS (0.000s)
[77.878525] [088/165] (923s left) kms_addfb_basic (unused-handle)
[77.969285] Starting subtest: unused-handle
[77.970392] Subtest unused-handle: SUCCESS (0.000s)
[78.081082] [089/165] (923s left) kms_addfb_basic (unused-modifier)
[78.167378] Starting subtest: unused-modifier
[78.168577] Subtest unused-modifier: SUCCESS (0.000s)
[78.279853] [090/165] (922s left) kms_addfb_basic (unused-offsets)
[78.365138] Starting subtest: unused-offsets
[78.366216] Subtest unused-offsets: SUCCESS (0.000s)
[78.464174] [091/165] (922s left) kms_addfb_basic (unused-pitches)
[78.551574] Starting subtest: unused-pitches
[78.552666] Subtest unused-pitches: SUCCESS (0.000s)
[78.664675] [092/165] (922s left) kms_busy (basic)
[78.786625] Starting subtest: basic
[78.787893] Starting dynamic subtest: flip
[79.376041] Dynamic subtest flip: SUCCESS (0.586s)
[79.389127] Starting dynamic subtest: modeset
[79.391731] Dynamic subtest modeset: SKIP (0.000s)
[79.394716] Subtest basic: SUCCESS (0.590s)
[79.473476] [093/165] (921s left) kms_prop_blob (basic)
[79.559277] Starting subtest: basic
[79.560316] Subtest basic: SUCCESS (0.000s)
[79.639419] [094/165] (921s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[79.745986] Starting subtest: basic-busy-flip-before-cursor-atomic
[79.749218] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.004s)
[79.822549] [095/165] (921s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[79.930024] Starting subtest: basic-busy-flip-before-cursor-legacy
[80.932452] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.001s)
[81.048088] [096/165] (920s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[81.156635] Starting subtest: basic-flip-after-cursor-atomic
[81.158941] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[81.233802] [097/165] (920s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[81.355752] Starting subtest: basic-flip-after-cursor-legacy
[82.355256] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.999s)
[82.469105] [098/165] (918s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[82.576620] Starting subtest: basic-flip-after-cursor-varying-size
[83.576057] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.000s)
[83.688400] [099/165] (917s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[83.810937] Starting subtest: basic-flip-before-cursor-atomic
[83.813306] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[83.888169] [100/165] (917s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[83.993607] Starting subtest: basic-flip-before-cursor-legacy
[84.985639] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.991s)
[85.100704] [101/165] (916s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[85.210149] Starting subtest: basic-flip-before-cursor-varying-size
[86.210921] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.001s)
[86.329420] [102/165] (915s left) kms_dsc (dsc-basic)
[86.437876] Subtest dsc-basic: SKIP (0.000s)
[86.484198] [103/165] (915s left) kms_flip (basic-flip-vs-dpms)
[86.589049] Starting subtest: basic-flip-vs-dpms
[86.590140] Starting dynamic subtest: A-VGA1
[87.879120] Dynamic subtest A-VGA1: SUCCESS (1.291s)
[87.894866] Starting dynamic subtest: B-VGA1
[89.096084] Dynamic subtest B-VGA1: SUCCESS (1.216s)
[89.097115] Subtest basic-flip-vs-dpms: SUCCESS (2.508s)
[89.227220] [104/165] (912s left) kms_flip (basic-flip-vs-modeset)
[89.337308] Starting subtest: basic-flip-vs-modeset
[89.338455] Starting dynamic subtest: A-VGA1
[90.598018] Dynamic subtest A-VGA1: SUCCESS (1.263s)
[90.615206] Starting dynamic subtest: B-VGA1
[91.800180] Dynamic subtest B-VGA1: SUCCESS (1.202s)
[91.801763] Subtest basic-flip-vs-modeset: SUCCESS (2.468s)
[91.936449] [105/165] (909s left) kms_flip (basic-flip-vs-wf_vblank)
[92.058893] Starting subtest: basic-flip-vs-wf_vblank
[92.060868] Starting dynamic subtest: A-VGA1
[93.590151] Dynamic subtest A-VGA1: SUCCESS (1.532s)
[93.599163] Starting dynamic subtest: B-VGA1
[95.091223] Dynamic subtest B-VGA1: SUCCESS (1.499s)
[95.092325] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.032s)
[95.261598] [106/165] (906s left) kms_flip (basic-plain-flip)
[95.369431] Starting subtest: basic-plain-flip
[95.370582] Starting dynamic subtest: A-VGA1
[96.615874] Dynamic subtest A-VGA1: SUCCESS (1.246s)
[96.625224] Starting dynamic subtest: B-VGA1
[97.832862] Dynamic subtest B-VGA1: SUCCESS (1.217s)
[97.834025] Subtest basic-plain-flip: SUCCESS (2.464s)
[97.986590] [107/165] (903s left) kms_force_connector_basic (force-connector-state)
[98.126628] Starting subtest: force-connector-state
[98.307349] Subtest force-connector-state: SUCCESS (0.182s)
[98.565353] [108/165] (903s left) kms_force_connector_basic (force-edid)
[98.704202] Starting subtest: force-edid
[98.785985] Subtest force-edid: SUCCESS (0.082s)
[98.947632] [109/165] (902s left) kms_force_connector_basic (force-load-detect)
[99.126430] Starting subtest: force-load-detect
[99.292400] Subtest force-load-detect: SUCCESS (0.169s)
[99.493723] [110/165] (902s left) kms_force_connector_basic (prune-stale-modes)
[99.634534] Starting subtest: prune-stale-modes
[99.717798] Subtest prune-stale-modes: SUCCESS (0.083s)
[99.863480] [111/165] (901s left) kms_frontbuffer_tracking (basic)
[99.990251] Subtest basic: SKIP (0.000s)
[100.030765] [112/165] (901s left) kms_hdmi_inject (inject-audio)
[100.117056] Subtest inject-audio: SKIP (0.000s)
[100.149446] [113/165] (901s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[100.270636] Starting subtest: compare-crc-sanitycheck-xr24
[100.271953] Starting dynamic subtest: pipe-A-VGA-1
[100.554764] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.283s)
[100.573701] Starting dynamic subtest: pipe-B-VGA-1
[100.867495] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.307s)
[100.870539] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.593s)
[100.985553] [114/165] (900s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[101.093673] Starting subtest: compare-crc-sanitycheck-nv12
[101.094864] Starting dynamic subtest: pipe-A-VGA-1
[101.097706] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s)
[101.108043] Starting dynamic subtest: pipe-B-VGA-1
[101.110177] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s)
[101.112312] Subtest compare-crc-sanitycheck-nv12: SKIP (0.003s)
[101.172070] [115/165] (900s left) kms_pipe_crc_basic (hang-read-crc)
[101.292634] Starting subtest: hang-read-crc
[101.293860] Starting dynamic subtest: pipe-A-VGA-1
[102.121320] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.829s)
[102.139504] Starting dynamic subtest: pipe-B-VGA-1
[102.963338] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.838s)
[102.965285] Subtest hang-read-crc: SUCCESS (1.671s)
[103.076328] [116/165] (898s left) kms_pipe_crc_basic (nonblocking-crc)
[103.203155] Starting subtest: nonblocking-crc
[103.204287] Starting dynamic subtest: pipe-A-VGA-1
[103.649225] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.451s)
[103.668503] Starting dynamic subtest: pipe-B-VGA-1
[104.132143] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.480s)
[104.133428] Subtest nonblocking-crc: SUCCESS (0.935s)
[104.248409] [117/165] (897s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[104.370893] Starting subtest: nonblocking-crc-frame-sequence
[104.372073] Starting dynamic subtest: pipe-A-VGA-1
[104.835129] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.464s)
[104.845045] Starting dynamic subtest: pipe-B-VGA-1
[105.309762] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.472s)
[105.312405] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.939s)
[105.425319] [118/165] (896s left) kms_pipe_crc_basic (read-crc)
[105.532851] Starting subtest: read-crc
[105.533938] Starting dynamic subtest: pipe-A-VGA-1
[105.914494] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.384s)
[105.934776] Starting dynamic subtest: pipe-B-VGA-1
[106.331302] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.414s)
[106.333191] Subtest read-crc: SUCCESS (0.802s)
[106.442078] [119/165] (895s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[106.566658] Starting subtest: read-crc-frame-sequence
[106.567940] Starting dynamic subtest: pipe-A-VGA-1
[106.962060] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.393s)
[106.974295] Starting dynamic subtest: pipe-B-VGA-1
[107.392152] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.430s)
[107.393315] Subtest read-crc-frame-sequence: SUCCESS (0.827s)
[107.493262] [120/165] (894s left) kms_pm_backlight (basic-brightness)
[107.620268] Subtest basic-brightness: SKIP (0.000s)
[107.661173] [121/165] (894s left) kms_pm_rpm (basic-pci-d3-state)
[118.920720] Subtest basic-pci-d3-state: SKIP (0.000s)
[118.953594] [122/165] (883s left) kms_pm_rpm (basic-rte)
[119.036996] Starting subtest: basic-rte
[130.226334] Subtest basic-rte: SKIP (11.175s)
[130.262569] [123/165] (871s left) kms_psr (psr_primary_page_flip)
[130.383046] Subtest psr_primary_page_flip: SKIP (0.000s)
[130.424151] [124/165] (871s left) kms_psr (psr_cursor_plane_move)
[130.547970] Subtest psr_cursor_plane_move: SKIP (0.000s)
[130.592705] [125/165] (871s left) kms_psr (psr_sprite_plane_onoff)
[130.716357] Subtest psr_sprite_plane_onoff: SKIP (0.000s)
[130.758070] [126/165] (871s left) kms_psr (psr_primary_mmap_gtt)
[130.884603] Subtest psr_primary_mmap_gtt: SKIP (0.000s)
[130.925263] [127/165] (871s left) kms_setmode (basic-clone-single-crtc)
[131.010426] Starting subtest: basic-clone-single-crtc
[131.014781] Subtest basic-clone-single-crtc: SKIP (0.000s)
[131.075030] [128/165] (871s left) i915_pm_rps (basic-api)
[131.161959] Subtest basic-api: SKIP (0.000s)
[131.195563] [129/165] (870s left) prime_self_import (basic-llseek-bad)
[131.280022] Starting subtest: basic-llseek-bad
[131.282506] Subtest basic-llseek-bad: SUCCESS (0.002s)
[131.359378] [130/165] (870s left) prime_self_import (basic-llseek-size)
[131.441640] Starting subtest: basic-llseek-size
[131.443981] Subtest basic-llseek-size: SUCCESS (0.004s)
[131.508774] [131/165] (870s left) prime_self_import (basic-with_fd_dup)
[131.593367] Starting subtest: basic-with_fd_dup
[131.595602] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[131.677383] [132/165] (870s left) prime_self_import (basic-with_one_bo)
[131.761593] Starting subtest: basic-with_one_bo
[131.765156] Subtest basic-with_one_bo: SUCCESS (0.003s)
[131.811525] [133/165] (870s left) prime_self_import (basic-with_one_bo_two_files)
[131.896030] Starting subtest: basic-with_one_bo_two_files
[131.898194] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[131.978405] [134/165] (870s left) prime_self_import (basic-with_two_bos)
[132.062100] Starting subtest: basic-with_two_bos
[132.064359] Subtest basic-with_two_bos: SUCCESS (0.003s)
[132.143751] [135/165] (870s left) prime_vgem (basic-fence-flip)
[132.240356] Starting subtest: basic-fence-flip
[132.639343] Subtest basic-fence-flip: SUCCESS (0.400s)
[132.730179] [136/165] (869s left) prime_vgem (basic-fence-mmap)
[132.825293] Starting subtest: basic-fence-mmap
[132.865939] Subtest basic-fence-mmap: SUCCESS (0.042s)
[132.948191] [137/165] (869s left) prime_vgem (basic-fence-read)
[133.042158] Starting subtest: basic-fence-read
[133.111467] Subtest basic-fence-read: SUCCESS (0.068s)
[133.183395] [138/165] (869s left) prime_vgem (basic-gtt)
[133.277303] Starting subtest: basic-gtt
[133.294771] Subtest basic-gtt: SUCCESS (0.019s)
[133.365068] [139/165] (868s left) prime_vgem (basic-read)
[133.459806] Starting subtest: basic-read
[133.490025] Subtest basic-read: SUCCESS (0.030s)
[133.565674] [140/165] (868s left) prime_vgem (basic-write)
[133.660422] Starting subtest: basic-write
[133.693263] Subtest basic-write: SUCCESS (0.033s)
[133.767108] [141/165] (868s left) vgem_basic (setversion)
[133.859206] Starting subtest: setversion
[133.861570] Subtest setversion: SUCCESS (0.000s)
[133.918509] [142/165] (868s left) vgem_basic (create)
[134.009409] Starting subtest: create
[134.010724] Subtest create: SUCCESS (0.000s)
[134.067184] [143/165] (868s left) vgem_basic (debugfs)
[134.160231] Starting subtest: debugfs
[134.161383] Subtest debugfs: SUCCESS (0.001s)
[134.218257] [144/165] (868s left) vgem_basic (dmabuf-export)
[134.310994] Starting subtest: dmabuf-export
[134.314069] Subtest dmabuf-export: SUCCESS (0.002s)
[134.384790] [145/165] (868s left) vgem_basic (dmabuf-fence)
[134.478162] Starting subtest: dmabuf-fence
[134.479201] Subtest dmabuf-fence: SUCCESS (0.001s)
[134.536858] [146/165] (867s left) vgem_basic (dmabuf-fence-before)
[134.628219] Starting subtest: dmabuf-fence-before
[134.629290] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[134.687739] [147/165] (867s left) vgem_basic (dmabuf-mmap)
[134.778457] Starting subtest: dmabuf-mmap
[134.797932] Subtest dmabuf-mmap: SUCCESS (0.020s)
[134.854998] [148/165] (867s left) vgem_basic (mmap)
[134.945391] Starting subtest: mmap
[134.957864] Subtest mmap: SUCCESS (0.014s)
[135.021459] [149/165] (867s left) vgem_basic (second-client)
[135.113118] Starting subtest: second-client
[135.147187] Subtest second-client: SUCCESS (0.033s)
[135.205883] [150/165] (867s left) vgem_basic (sysfs)
[135.297168] Starting subtest: sysfs
[135.298315] Subtest sysfs: SUCCESS (0.001s)
[135.356086] [151/165] (867s left) core_hotunplug (unbind-rebind)
[135.480258] Starting subtest: unbind-rebind
[138.225870] Subtest unbind-rebind: SUCCESS (2.747s)
[138.253379] [152/165] (864s left) vgem_basic (unload)
[138.338684] Starting subtest: unload
[167.221193] Subtest unload: SUCCESS (28.880s)
[167.321481] [153/165] (835s left) i915_module_load (reload)
[167.406418] Starting subtest: reload
[169.158807] Subtest reload: SUCCESS (1.754s)
[169.183447] [154/165] (833s left) gem_lmem_swapping (basic)
[169.278590] Subtest basic: SKIP (0.000s)
[169.304478] [155/165] (833s left) gem_lmem_swapping (parallel-random-engines)
[169.394175] Subtest parallel-random-engines: SKIP (0.000s)
[169.420801] [156/165] (833s left) gem_lmem_swapping (random-engines)
[169.510127] Subtest random-engines: SKIP (0.000s)
[169.561222] [157/165] (833s left) gem_lmem_swapping (verify-random)
[169.676317] Subtest verify-random: SKIP (0.000s)
[169.723610] [158/165] (833s left) i915_pm_rpm (module-reload)
[180.998302] Subtest module-reload: SKIP (0.000s)
[181.027485] [159/165] (821s left) i915_selftest (live)
[181.588320] Starting subtest: live
[181.589601] Starting dynamic subtest: sanitycheck
[182.252111] Dynamic subtest sanitycheck: SUCCESS (0.663s)
[182.261357] Starting dynamic subtest: uncore
[182.885028] Dynamic subtest uncore: SUCCESS (0.632s)
[182.894569] Starting dynamic subtest: workarounds
[183.508120] Dynamic subtest workarounds: SUCCESS (0.622s)
[183.517948] Starting dynamic subtest: gt_engines
[184.140092] Dynamic subtest gt_engines: SUCCESS (0.631s)
[184.149336] Starting dynamic subtest: gt_timelines
[187.031198] Dynamic subtest gt_timelines: SUCCESS (2.888s)
[187.040630] Starting dynamic subtest: gt_contexts
[187.653344] Dynamic subtest gt_contexts: SUCCESS (0.623s)
[187.662961] Starting dynamic subtest: gt_lrc
[188.272033] Dynamic subtest gt_lrc: SUCCESS (0.618s)
[188.280970] Starting dynamic subtest: gt_mocs
[188.894141] Dynamic subtest gt_mocs: SUCCESS (0.619s)
[188.903425] Starting dynamic subtest: gt_pm
[189.992161] Dynamic subtest gt_pm: SUCCESS (1.099s)
[190.000356] Starting dynamic subtest: gt_heartbeat
[190.654153] Dynamic subtest gt_heartbeat: SUCCESS (0.660s)
[190.663479] Starting dynamic subtest: gt_tlb
[191.259277] Dynamic subtest gt_tlb: SUCCESS (0.606s)
[191.268949] Starting dynamic subtest: requests
[194.439626] Dynamic subtest requests: SUCCESS (3.179s)
[194.449154] Starting dynamic subtest: migrate
[195.067220] Dynamic subtest migrate: SUCCESS (0.627s)
[195.077087] Starting dynamic subtest: active
[195.702222] Dynamic subtest active: SUCCESS (0.634s)
[195.711714] Starting dynamic subtest: objects
[196.659228] Dynamic subtest objects: SUCCESS (0.954s)
[196.668823] Starting dynamic subtest: mman
[201.518773] Dynamic subtest mman: SUCCESS (4.861s)
[201.528131] Starting dynamic subtest: dmabuf
[202.172736] Dynamic subtest dmabuf: SUCCESS (0.652s)
[202.182068] Starting dynamic subtest: vma
[202.809180] Dynamic subtest vma: SUCCESS (0.636s)
[202.818695] Starting dynamic subtest: coherency
[204.536163] Dynamic subtest coherency: SUCCESS (1.724s)
[204.545430] Starting dynamic subtest: gtt
[208.778074] Dynamic subtest gtt: SUCCESS (4.243s)
[208.787442] Starting dynamic subtest: gem
[209.448455] Dynamic subtest gem: SUCCESS (0.669s)
[209.457736] Starting dynamic subtest: evict
[210.067291] Dynamic subtest evict: SUCCESS (0.618s)
[210.076279] Starting dynamic subtest: hugepages
[210.697291] Dynamic subtest hugepages: SUCCESS (0.629s)
[210.706794] Starting dynamic subtest: gem_contexts
[211.314083] Dynamic subtest gem_contexts: SUCCESS (0.616s)
[211.323048] Starting dynamic subtest: client
[211.964239] Dynamic subtest client: SUCCESS (0.647s)
[211.973873] Starting dynamic subtest: gem_migrate
[212.572054] Dynamic subtest gem_migrate: SUCCESS (0.609s)
[212.581322] Starting dynamic subtest: reset
[213.524093] Dynamic subtest reset: SUCCESS (0.951s)
[213.533286] Starting dynamic subtest: memory_region
[214.140984] Dynamic subtest memory_region: SUCCESS (0.615s)
[214.150648] Starting dynamic subtest: hangcheck
[215.834135] Dynamic subtest hangcheck: SUCCESS (1.691s)
[215.842853] Starting dynamic subtest: execlists
[216.446471] Dynamic subtest execlists: SUCCESS (0.613s)
[216.455442] Starting dynamic subtest: ring_submission
[217.067372] Dynamic subtest ring_submission: SUCCESS (0.620s)
[217.076561] Starting dynamic subtest: perf
[217.677156] Dynamic subtest perf: SUCCESS (0.609s)
[217.687403] Starting dynamic subtest: slpc
[218.287379] Dynamic subtest slpc: SUCCESS (0.609s)
[218.296957] Starting dynamic subtest: guc
[218.941350] Dynamic subtest guc: SUCCESS (0.653s)
[218.950602] Starting dynamic subtest: guc_multi_lrc
[219.573128] Dynamic subtest guc_multi_lrc: SUCCESS (0.628s)
[219.581979] Starting dynamic subtest: guc_hang
[220.196125] Dynamic subtest guc_hang: SUCCESS (0.622s)
[220.205216] Starting dynamic subtest: late_gt_pm
[220.807156] Dynamic subtest late_gt_pm: SUCCESS (0.611s)
[220.808191] Subtest live: SUCCESS (39.219s)
[220.828581] [160/165] (782s left) dmabuf (all-tests)
[220.923035] Starting subtest: all-tests
[220.924195] Starting dynamic subtest: sanitycheck
[220.981025] Dynamic subtest sanitycheck: SUCCESS (0.062s)
[220.991207] Starting dynamic subtest: dma_fence
[221.157628] Dynamic subtest dma_fence: SUCCESS (0.176s)
[221.166771] Starting dynamic subtest: dma_fence_chain
[238.847367] Dynamic subtest dma_fence_chain: SUCCESS (17.689s)
[238.857374] Starting dynamic subtest: dma_fence_unwrap
[238.908296] Dynamic subtest dma_fence_unwrap: SUCCESS (0.061s)
[238.921022] Starting dynamic subtest: dma_resv
[238.970637] Dynamic subtest dma_resv: SUCCESS (0.062s)
[238.972231] Subtest all-tests: SUCCESS (18.055s)
[238.994599] [161/165] (763s left) i915_suspend (basic-s2idle-without-i915)
[239.078657] Starting subtest: basic-s2idle-without-i915
[257.182084] Subtest basic-s2idle-without-i915: SUCCESS (18.099s)
[260.255706] [162/165] (745s left) i915_suspend (basic-s3-without-i915)
[260.345709] Starting subtest: basic-s3-without-i915
[276.956579] Subtest basic-s3-without-i915: SUCCESS (1.830s)
[282.033928] [163/165] (743s left) gem_exec_suspend (basic-s0)
[282.139110] Starting subtest: basic-S0
[282.141782] Starting dynamic subtest: smem
[298.917067] Dynamic subtest smem: SUCCESS (16.779s)
[298.918266] Subtest basic-S0: SUCCESS (16.780s)
[303.104672] [164/165] (726s left) gem_exec_suspend (basic-s3)
[303.209816] Starting subtest: basic-S3
[303.210928] Starting dynamic subtest: smem
[320.789625] Dynamic subtest smem: SUCCESS (1.770s)
[320.790881] Subtest basic-S3: SUCCESS (1.771s)
[326.989111] [165/165] (724s left) kms_pipe_crc_basic (suspend-read-crc)
[327.107828] Starting subtest: suspend-read-crc
[327.109025] Starting dynamic subtest: pipe-A-VGA-1
[344.849668] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.615s)
[344.861009] Starting dynamic subtest: pipe-B-VGA-1
[362.798563] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.589s)
[362.800135] Subtest suspend-read-crc: SUCCESS (3.207s)
[367.918487] Closing watchdogs
Done.