[35.079417] Initializing watchdogs
[35.079538]   /dev/watchdog0
[35.088935] [001/165] (960s left) i915_module_load (load)
[35.195596] Starting subtest: load
[36.719057] Subtest load: SUCCESS (1.524s)
[36.749463] [002/165] (958s left) core_auth (basic-auth)
[36.861785] Starting subtest: basic-auth
[36.862913] Subtest basic-auth: SUCCESS (0.001s)
[36.927381] [003/165] (958s left) debugfs_test (read_all_entries)
[37.054048] Starting subtest: read_all_entries
[37.228037] Subtest read_all_entries: SUCCESS (0.177s)
[37.348651] [004/165] (958s left) debugfs_test (basic-hwmon)
[37.472756] Starting subtest: basic-hwmon
[37.475598] Subtest basic-hwmon: SKIP (0.000s)
[37.580666] [005/165] (958s left) fbdev (eof)
[37.674249] Starting subtest: eof
[37.676234] Subtest eof: SUCCESS (0.002s)
[37.731243] [006/165] (958s left) fbdev (info)
[37.818871] Starting subtest: info
[37.820071] Subtest info: SUCCESS (0.000s)
[37.880871] [007/165] (957s left) fbdev (nullptr)
[37.974223] Starting subtest: nullptr
[37.975749] Subtest nullptr: SUCCESS (0.000s)
[38.035385] [008/165] (957s left) fbdev (read)
[38.123706] Starting subtest: read
[38.366996] Subtest read: SUCCESS (0.243s)
[38.414889] [009/165] (957s left) fbdev (write)
[38.508093] Starting subtest: write
[38.628102] Subtest write: SUCCESS (0.119s)
[38.684545] [010/165] (957s left) gem_basic (bad-close)
[38.774461] Starting subtest: bad-close
[38.776760] Subtest bad-close: SUCCESS (0.000s)
[38.860659] [011/165] (956s left) gem_basic (create-close)
[38.947333] Starting subtest: create-close
[38.949471] Subtest create-close: SUCCESS (0.000s)
[39.019548] [012/165] (956s left) gem_basic (create-fd-close)
[39.105149] Starting subtest: create-fd-close
[39.107821] Subtest create-fd-close: SUCCESS (0.000s)
[39.168587] [013/165] (956s left) gem_busy (busy@all-engines)
[39.271271] Starting subtest: busy
[39.272321] Starting dynamic subtest: all-engines
[39.296510] Dynamic subtest all-engines: SUCCESS (0.026s)
[39.297591] Subtest busy: SUCCESS (0.026s)
[39.619883] [014/165] (956s left) gem_close_race (basic-process)
[39.726150] Starting subtest: basic-process
[39.771490] Subtest basic-process: SUCCESS (0.044s)
[39.955972] [015/165] (955s left) gem_close_race (basic-threads)
[40.057993] Starting subtest: basic-threads
[41.187803] Subtest basic-threads: SUCCESS (1.132s)
[41.375929] [016/165] (954s left) gem_ctx_create (basic)
[41.478045] Subtest basic: SKIP (0.000s)
[41.511944] [017/165] (954s left) gem_ctx_create (basic-files)
[41.603099] Subtest basic-files: SKIP (0.000s)
[41.628377] [018/165] (954s left) gem_ctx_exec (basic)
[41.716411] Subtest basic: SKIP (0.000s)
[41.761538] [019/165] (954s left) gem_exec_basic (basic)
[41.856653] Starting subtest: basic
[41.857770] Starting dynamic subtest: rcs0-smem
[41.858863] Dynamic subtest rcs0-smem: SUCCESS (0.000s)
[41.859974] Subtest basic: SUCCESS (0.001s)
[42.046762] [020/165] (953s left) gem_exec_create (basic)
[42.143736] Starting subtest: basic
[42.145199] Starting dynamic subtest: smem
[44.181432] Dynamic subtest smem: SUCCESS (2.037s)
[44.182544] Subtest basic: SUCCESS (2.038s)
[44.370584] [021/165] (951s left) gem_exec_fence (basic-busy)
[44.597170] Starting subtest: basic-busy
[44.599917] Starting dynamic subtest: rcs0
[44.607222] Dynamic subtest rcs0: SUCCESS (0.013s)
[44.608185] Subtest basic-busy: SUCCESS (0.014s)
[45.088923] [022/165] (950s left) gem_exec_fence (basic-wait)
[45.313373] Starting subtest: basic-wait
[45.314444] Starting dynamic subtest: rcs0
[45.323298] Dynamic subtest rcs0: SUCCESS (0.012s)
[45.324394] Subtest basic-wait: SUCCESS (0.013s)
[45.758267] [023/165] (950s left) gem_exec_fence (basic-await)
[45.983427] Starting subtest: basic-await
[45.984483] Starting dynamic subtest: rcs0
[46.044872] Dynamic subtest rcs0: SUCCESS (0.063s)
[46.045934] Subtest basic-await: SUCCESS (0.063s)
[46.494161] [024/165] (949s left) gem_exec_fence (nb-await)
[46.724893] Starting subtest: nb-await
[46.726549] Starting dynamic subtest: rcs0
[46.777935] Dynamic subtest rcs0: SUCCESS (0.053s)
[46.779130] Subtest nb-await: SUCCESS (0.053s)
[47.214429] [025/165] (948s left) gem_exec_gttfill (basic)
[47.318093] Starting subtest: basic
[50.678157] Subtest basic: SUCCESS (3.361s)
[50.864083] [026/165] (945s left) gem_exec_parallel (engines)
[51.080444] Starting subtest: engines
[51.082419] Starting dynamic subtest: basic
[52.729275] Dynamic subtest basic: SUCCESS (1.646s)
[52.738869] Starting dynamic subtest: contexts
[52.741062] Dynamic subtest contexts: SKIP (0.001s)
[52.750692] Starting dynamic subtest: fds
[52.752790] Dynamic subtest fds: SKIP (0.001s)
[52.760956] Starting dynamic subtest: userptr
[54.431659] Dynamic subtest userptr: SUCCESS (1.702s)
[54.432751] Subtest engines: SUCCESS (3.351s)
[54.609005] [027/165] (941s left) gem_exec_store (basic)
[54.705952] Starting subtest: basic
[54.724066] Subtest basic: SUCCESS (0.018s)
[54.907944] [028/165] (941s left) gem_flink_basic (bad-flink)
[54.993916] Starting subtest: bad-flink
[54.994967] Subtest bad-flink: SUCCESS (0.000s)
[55.058111] [029/165] (941s left) gem_flink_basic (bad-open)
[55.141732] Starting subtest: bad-open
[55.142864] Subtest bad-open: SUCCESS (0.000s)
[55.210280] [030/165] (941s left) gem_flink_basic (basic)
[55.296294] Starting subtest: basic
[55.297563] Subtest basic: SUCCESS (0.000s)
[55.375481] [031/165] (940s left) gem_flink_basic (double-flink)
[55.459988] Starting subtest: double-flink
[55.461413] Subtest double-flink: SUCCESS (0.000s)
[55.526379] [032/165] (940s left) gem_flink_basic (flink-lifetime)
[55.613295] Starting subtest: flink-lifetime
[55.614338] Subtest flink-lifetime: SUCCESS (0.001s)
[55.692112] [033/165] (940s left) gem_huc_copy (huc-copy)
[55.785381] Subtest huc-copy: SKIP (0.000s)
[55.830786] [034/165] (940s left) gem_linear_blits (basic)
[56.155545] Starting subtest: basic
[56.167394] Subtest basic: SUCCESS (0.012s)
[56.279443] [035/165] (940s left) gem_mmap (basic)
[56.493818] Starting subtest: basic
[56.499200] Subtest basic: SUCCESS (0.001s)
[56.562169] [036/165] (939s left) gem_mmap_gtt (basic)
[56.649047] Starting subtest: basic
[56.650083] Subtest basic: SUCCESS (0.001s)
[56.717249] [037/165] (939s left) gem_render_linear_blits (basic)
[56.807190] Starting subtest: basic
[56.857170] Subtest basic: SUCCESS (0.048s)
[56.899415] [038/165] (939s left) gem_render_tiled_blits (basic)
[57.001824] Starting subtest: basic
[57.045666] Subtest basic: SUCCESS (0.044s)
[57.082887] [039/165] (939s left) gem_ringfill (basic-all)
[57.210770] Starting subtest: basic-all
[58.317048] Subtest basic-all: SUCCESS (1.103s)
[58.387337] [040/165] (938s left) gem_softpin (allocator-basic)
[58.478513] Subtest allocator-basic: SKIP (0.000s)
[58.552790] [041/165] (937s left) gem_softpin (allocator-basic-reserve)
[58.640844] Subtest allocator-basic-reserve: SKIP (0.000s)
[58.703316] [042/165] (937s left) gem_softpin (safe-alignment)
[58.794802] Starting subtest: safe-alignment
[58.796203] Subtest safe-alignment: SUCCESS (0.006s)
[58.872222] [043/165] (937s left) gem_sync (basic-all)
[58.971028] Starting subtest: basic-all
[61.069172] Subtest basic-all: SUCCESS (2.099s)
[61.246337] [044/165] (935s left) gem_sync (basic-each)
[61.347251] Starting subtest: basic-each
[63.431921] Subtest basic-each: SUCCESS (2.086s)
[63.624137] [045/165] (932s left) gem_tiled_blits (basic)
[64.008631] Starting subtest: basic
[64.029808] Subtest basic: SUCCESS (0.021s)
[64.138318] [046/165] (932s left) gem_tiled_fence_blits (basic)
[64.690674] Starting subtest: basic
[64.704168] Subtest basic: SUCCESS (0.013s)
[64.807834] [047/165] (931s left) gem_tiled_pread_basic
[65.277395] [048/165] (931s left) gem_wait (busy@all-engines)
[65.388213] Starting subtest: busy
[65.389399] Starting dynamic subtest: all-engines
[65.901152] Dynamic subtest all-engines: SUCCESS (0.514s)
[65.904550] Subtest busy: SUCCESS (0.514s)
[66.113814] [049/165] (930s left) gem_wait (wait@all-engines)
[66.222656] Starting subtest: wait
[66.223818] Starting dynamic subtest: all-engines
[67.234230] Dynamic subtest all-engines: SUCCESS (1.012s)
[67.235230] Subtest wait: SUCCESS (1.013s)
[67.451552] [050/165] (929s left) i915_getparams_basic (basic-eu-total)
[67.537293] Starting subtest: basic-eu-total
[67.540275] Subtest basic-eu-total: SUCCESS (0.000s)
[67.599501] [051/165] (929s left) i915_getparams_basic (basic-subslice-total)
[67.683235] Starting subtest: basic-subslice-total
[67.685399] Subtest basic-subslice-total: SUCCESS (0.000s)
[67.753676] [052/165] (929s left) i915_hangman (error-state-basic)
[67.842756] Starting subtest: error-state-basic
[67.958313] Subtest error-state-basic: SUCCESS (0.113s)
[68.014746] [053/165] (928s left) i915_pciid
[68.162492] [054/165] (928s left) kms_addfb_basic (addfb25-4-tiled)
[68.288480] Starting subtest: addfb25-4-tiled
[68.296029] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[68.363237] [055/165] (928s left) kms_addfb_basic (addfb25-bad-modifier)
[68.449936] Starting subtest: addfb25-bad-modifier
[68.451216] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[68.562045] [056/165] (928s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[68.645906] Starting subtest: addfb25-framebuffer-vs-set-tiling
[68.646959] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[68.765408] [057/165] (928s left) kms_addfb_basic (addfb25-modifier-no-flag)
[68.851476] Starting subtest: addfb25-modifier-no-flag
[68.852801] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[68.964358] [058/165] (927s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[69.051089] Starting subtest: addfb25-x-tiled-legacy
[69.052203] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[69.151340] [059/165] (927s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[69.238062] Starting subtest: addfb25-x-tiled-mismatch-legacy
[69.239148] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[69.348981] [060/165] (927s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[69.474554] Starting subtest: addfb25-yf-tiled-legacy
[69.475750] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[69.551359] [061/165] (927s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[69.676632] Starting subtest: addfb25-y-tiled-legacy
[69.678487] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[69.751082] [062/165] (927s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[69.876708] Starting subtest: addfb25-y-tiled-small-legacy
[69.879538] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[69.951051] [063/165] (927s left) kms_addfb_basic (bad-pitch-0)
[70.039312] Starting subtest: bad-pitch-0
[70.040391] Subtest bad-pitch-0: SUCCESS (0.000s)
[70.154540] [064/165] (926s left) kms_addfb_basic (bad-pitch-1024)
[70.242563] Starting subtest: bad-pitch-1024
[70.244035] Subtest bad-pitch-1024: SUCCESS (0.000s)
[70.353208] [065/165] (926s left) kms_addfb_basic (bad-pitch-128)
[70.442576] Starting subtest: bad-pitch-128
[70.443749] Subtest bad-pitch-128: SUCCESS (0.000s)
[70.556188] [066/165] (926s left) kms_addfb_basic (bad-pitch-256)
[70.647116] Starting subtest: bad-pitch-256
[70.648203] Subtest bad-pitch-256: SUCCESS (0.000s)
[70.760326] [067/165] (926s left) kms_addfb_basic (bad-pitch-32)
[70.845874] Starting subtest: bad-pitch-32
[70.848043] Subtest bad-pitch-32: SUCCESS (0.000s)
[70.953272] [068/165] (926s left) kms_addfb_basic (bad-pitch-63)
[71.039714] Starting subtest: bad-pitch-63
[71.040790] Subtest bad-pitch-63: SUCCESS (0.000s)
[71.144213] [069/165] (925s left) kms_addfb_basic (bad-pitch-65536)
[71.229133] Starting subtest: bad-pitch-65536
[71.230118] Subtest bad-pitch-65536: SUCCESS (0.000s)
[71.340293] [070/165] (925s left) kms_addfb_basic (bad-pitch-999)
[71.427393] Starting subtest: bad-pitch-999
[71.428488] Subtest bad-pitch-999: SUCCESS (0.000s)
[71.538461] [071/165] (925s left) kms_addfb_basic (basic)
[71.628154] Starting subtest: basic
[71.629548] Subtest basic: SUCCESS (0.000s)
[71.725327] [072/165] (925s left) kms_addfb_basic (basic-x-tiled-legacy)
[71.815149] Starting subtest: basic-x-tiled-legacy
[71.816193] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[71.926130] [073/165] (925s left) kms_addfb_basic (basic-y-tiled-legacy)
[72.018308] Starting subtest: basic-y-tiled-legacy
[72.019364] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[72.124368] [074/165] (925s left) kms_addfb_basic (bo-too-small)
[72.230844] Starting subtest: bo-too-small
[72.232057] Subtest bo-too-small: SUCCESS (0.000s)
[72.309969] [075/165] (924s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[72.436625] Starting subtest: bo-too-small-due-to-tiling
[72.437939] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[72.510277] [076/165] (924s left) kms_addfb_basic (clobberred-modifier)
[72.597208] Starting subtest: clobberred-modifier
[72.598252] Subtest clobberred-modifier: SUCCESS (0.000s)
[72.710777] [077/165] (924s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[72.796361] Starting subtest: framebuffer-vs-set-tiling
[72.797410] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[72.895814] [078/165] (924s left) kms_addfb_basic (invalid-get-prop)
[72.984237] Starting subtest: invalid-get-prop
[72.985403] Subtest invalid-get-prop: SUCCESS (0.000s)
[73.096425] [079/165] (924s left) kms_addfb_basic (invalid-get-prop-any)
[73.184557] Starting subtest: invalid-get-prop-any
[73.185742] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[73.296753] [080/165] (924s left) kms_addfb_basic (invalid-set-prop)
[73.385228] Starting subtest: invalid-set-prop
[73.386263] Subtest invalid-set-prop: SUCCESS (0.000s)
[73.496405] [081/165] (923s left) kms_addfb_basic (invalid-set-prop-any)
[73.582184] Starting subtest: invalid-set-prop-any
[73.584725] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[73.699963] [082/165] (923s left) kms_addfb_basic (no-handle)
[73.790127] Starting subtest: no-handle
[73.791225] Subtest no-handle: SUCCESS (0.000s)
[73.899222] [083/165] (923s left) kms_addfb_basic (size-max)
[74.021792] Starting subtest: size-max
[74.023707] Subtest size-max: SUCCESS (0.000s)
[74.103700] [084/165] (923s left) kms_addfb_basic (small-bo)
[74.222453] Starting subtest: small-bo
[74.223624] Subtest small-bo: SUCCESS (0.000s)
[74.299585] [085/165] (923s left) kms_addfb_basic (tile-pitch-mismatch)
[74.385656] Starting subtest: tile-pitch-mismatch
[74.390626] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[74.501333] [086/165] (923s left) kms_addfb_basic (too-high)
[74.623246] Starting subtest: too-high
[74.624954] Subtest too-high: SUCCESS (0.001s)
[74.700754] [087/165] (922s left) kms_addfb_basic (too-wide)
[74.824579] Starting subtest: too-wide
[74.825822] Subtest too-wide: SUCCESS (0.000s)
[74.900370] [088/165] (922s left) kms_addfb_basic (unused-handle)
[74.993553] Starting subtest: unused-handle
[74.994878] Subtest unused-handle: SUCCESS (0.000s)
[75.102263] [089/165] (922s left) kms_addfb_basic (unused-modifier)
[75.186268] Starting subtest: unused-modifier
[75.188753] Subtest unused-modifier: SUCCESS (0.000s)
[75.287315] [090/165] (922s left) kms_addfb_basic (unused-offsets)
[75.373191] Starting subtest: unused-offsets
[75.374254] Subtest unused-offsets: SUCCESS (0.000s)
[75.488087] [091/165] (922s left) kms_addfb_basic (unused-pitches)
[75.575758] Starting subtest: unused-pitches
[75.576814] Subtest unused-pitches: SUCCESS (0.000s)
[75.688391] [092/165] (921s left) kms_busy (basic)
[75.815127] Starting subtest: basic
[75.816364] Starting dynamic subtest: flip
[76.416572] Dynamic subtest flip: SUCCESS (0.604s)
[76.427811] Starting dynamic subtest: modeset
[76.429878] Dynamic subtest modeset: SKIP (0.000s)
[76.430926] Subtest basic: SUCCESS (0.605s)
[76.526933] [093/165] (921s left) kms_prop_blob (basic)
[76.619300] Starting subtest: basic
[76.620346] Subtest basic: SUCCESS (0.000s)
[76.691968] [094/165] (921s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[76.800951] Starting subtest: basic-busy-flip-before-cursor-atomic
[76.806411] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.005s)
[76.875354] [095/165] (920s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[77.005332] Starting subtest: basic-busy-flip-before-cursor-legacy
[78.015543] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.010s)
[78.126252] [096/165] (919s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[78.232304] Starting subtest: basic-flip-after-cursor-atomic
[78.234465] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[78.311051] [097/165] (919s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[78.435615] Starting subtest: basic-flip-after-cursor-legacy
[79.438058] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.001s)
[79.549069] [098/165] (918s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[79.672150] Starting subtest: basic-flip-after-cursor-varying-size
[80.676043] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.003s)
[80.803455] [099/165] (917s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[80.927051] Starting subtest: basic-flip-before-cursor-atomic
[80.930269] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[81.002883] [100/165] (916s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[81.126966] Starting subtest: basic-flip-before-cursor-legacy
[82.128136] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.003s)
[82.251544] [101/165] (915s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[82.372236] Starting subtest: basic-flip-before-cursor-varying-size
[83.376048] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.001s)
[83.498276] [102/165] (914s left) kms_dsc (dsc-basic)
[83.620987] Subtest dsc-basic: SKIP (0.000s)
[83.666158] [103/165] (914s left) kms_flip (basic-flip-vs-dpms)
[83.770712] Starting subtest: basic-flip-vs-dpms
[83.771923] Starting dynamic subtest: A-VGA1
[85.083805] Dynamic subtest A-VGA1: SUCCESS (1.312s)
[85.098077] Starting dynamic subtest: B-VGA1
[86.307602] Dynamic subtest B-VGA1: SUCCESS (1.225s)
[86.308705] Subtest basic-flip-vs-dpms: SUCCESS (2.540s)
[86.442432] [104/165] (911s left) kms_flip (basic-flip-vs-modeset)
[86.563598] Starting subtest: basic-flip-vs-modeset
[86.564822] Starting dynamic subtest: A-VGA1
[87.815825] Dynamic subtest A-VGA1: SUCCESS (1.251s)
[87.831924] Starting dynamic subtest: B-VGA1
[89.033410] Dynamic subtest B-VGA1: SUCCESS (1.218s)
[89.035077] Subtest basic-flip-vs-modeset: SUCCESS (2.470s)
[89.163252] [105/165] (908s left) kms_flip (basic-flip-vs-wf_vblank)
[89.286299] Starting subtest: basic-flip-vs-wf_vblank
[89.287761] Starting dynamic subtest: A-VGA1
[90.828311] Dynamic subtest A-VGA1: SUCCESS (1.539s)
[90.841981] Starting dynamic subtest: B-VGA1
[92.341821] Dynamic subtest B-VGA1: SUCCESS (1.514s)
[92.342949] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.055s)
[92.517110] [106/165] (905s left) kms_flip (basic-plain-flip)
[92.627811] Starting subtest: basic-plain-flip
[92.628926] Starting dynamic subtest: A-VGA1
[93.876289] Dynamic subtest A-VGA1: SUCCESS (1.252s)
[93.885838] Starting dynamic subtest: B-VGA1
[95.099899] Dynamic subtest B-VGA1: SUCCESS (1.223s)
[95.101091] Subtest basic-plain-flip: SUCCESS (2.477s)
[95.271030] [107/165] (902s left) kms_force_connector_basic (force-connector-state)
[95.413410] Starting subtest: force-connector-state
[95.554783] Subtest force-connector-state: SUCCESS (0.145s)
[95.793976] [108/165] (902s left) kms_force_connector_basic (force-edid)
[95.930353] Starting subtest: force-edid
[96.013926] Subtest force-edid: SUCCESS (0.083s)
[96.160751] [109/165] (901s left) kms_force_connector_basic (force-load-detect)
[96.301019] Starting subtest: force-load-detect
[96.473574] Subtest force-load-detect: SUCCESS (0.173s)
[96.689157] [110/165] (901s left) kms_force_connector_basic (prune-stale-modes)
[96.825914] Starting subtest: prune-stale-modes
[96.909590] Subtest prune-stale-modes: SUCCESS (0.083s)
[97.107069] [111/165] (900s left) kms_frontbuffer_tracking (basic)
[97.234625] Subtest basic: SKIP (0.000s)
[97.275552] [112/165] (900s left) kms_hdmi_inject (inject-audio)
[97.365255] Subtest inject-audio: SKIP (0.000s)
[97.392445] [113/165] (900s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[97.498033] Starting subtest: compare-crc-sanitycheck-xr24
[97.499652] Starting dynamic subtest: pipe-A-VGA-1
[97.786865] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.283s)
[97.799763] Starting dynamic subtest: pipe-B-VGA-1
[98.112666] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.328s)
[98.113735] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.616s)
[98.245403] [114/165] (899s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[98.365890] Starting subtest: compare-crc-sanitycheck-nv12
[98.367207] Starting dynamic subtest: pipe-A-VGA-1
[98.371774] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s)
[98.381877] Starting dynamic subtest: pipe-B-VGA-1
[98.384039] Dynamic subtest pipe-B-VGA-1: SKIP (0.001s)
[98.386120] Subtest compare-crc-sanitycheck-nv12: SKIP (0.005s)
[98.439755] [115/165] (899s left) kms_pipe_crc_basic (hang-read-crc)
[98.546606] Starting subtest: hang-read-crc
[98.549055] Starting dynamic subtest: pipe-A-VGA-1
[99.415592] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.870s)
[99.428373] Starting dynamic subtest: pipe-B-VGA-1
[100.273277] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.854s)
[100.277221] Subtest hang-read-crc: SUCCESS (1.728s)
[100.371586] [116/165] (897s left) kms_pipe_crc_basic (nonblocking-crc)
[100.477566] Starting subtest: nonblocking-crc
[100.478711] Starting dynamic subtest: pipe-A-VGA-1
[100.942863] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.463s)
[100.953126] Starting dynamic subtest: pipe-B-VGA-1
[101.415548] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.471s)
[101.417282] Subtest nonblocking-crc: SUCCESS (0.937s)
[101.514249] [117/165] (896s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[101.638637] Starting subtest: nonblocking-crc-frame-sequence
[101.639941] Starting dynamic subtest: pipe-A-VGA-1
[102.088992] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.449s)
[102.108420] Starting dynamic subtest: pipe-B-VGA-1
[102.549779] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.457s)
[102.551461] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.910s)
[102.665942] [118/165] (895s left) kms_pipe_crc_basic (read-crc)
[102.792356] Starting subtest: read-crc
[102.793492] Starting dynamic subtest: pipe-A-VGA-1
[103.205966] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.415s)
[103.218455] Starting dynamic subtest: pipe-B-VGA-1
[103.620522] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.410s)
[103.622201] Subtest read-crc: SUCCESS (0.828s)
[103.718566] [119/165] (894s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[103.854280] Starting subtest: read-crc-frame-sequence
[103.855335] Starting dynamic subtest: pipe-A-VGA-1
[104.228978] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.383s)
[104.246093] Starting dynamic subtest: pipe-B-VGA-1
[104.643149] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.413s)
[104.648022] Subtest read-crc-frame-sequence: SUCCESS (0.799s)
[104.747380] [120/165] (893s left) kms_pm_backlight (basic-brightness)
[104.854574] Subtest basic-brightness: SKIP (0.000s)
[104.885075] [121/165] (893s left) kms_psr (primary_page_flip)
[104.971840] Subtest primary_page_flip: SKIP (0.000s)
[105.019350] [122/165] (893s left) kms_psr (cursor_plane_move)
[105.104687] Subtest cursor_plane_move: SKIP (0.000s)
[105.134236] [123/165] (893s left) kms_psr (sprite_plane_onoff)
[105.223052] Subtest sprite_plane_onoff: SKIP (0.000s)
[105.250563] [124/165] (893s left) kms_psr (primary_mmap_gtt)
[105.339526] Subtest primary_mmap_gtt: SKIP (0.000s)
[105.368833] [125/165] (893s left) kms_setmode (basic-clone-single-crtc)
[105.457355] Starting subtest: basic-clone-single-crtc
[105.460779] Subtest basic-clone-single-crtc: SKIP (0.000s)
[105.534433] [126/165] (892s left) i915_pm_rpm (basic-pci-d3-state)
[116.812682] Subtest basic-pci-d3-state: SKIP (0.000s)
[116.847140] [127/165] (881s left) i915_pm_rpm (basic-rte)
[116.931227] Starting subtest: basic-rte
[128.141231] Subtest basic-rte: SKIP (11.193s)
[128.163568] [128/165] (870s left) i915_pm_rps (basic-api)
[128.255755] Subtest basic-api: SKIP (0.000s)
[128.299045] [129/165] (870s left) prime_self_import (basic-llseek-bad)
[128.385937] Starting subtest: basic-llseek-bad
[128.388272] Subtest basic-llseek-bad: SUCCESS (0.003s)
[128.461849] [130/165] (870s left) prime_self_import (basic-llseek-size)
[128.547037] Starting subtest: basic-llseek-size
[128.549356] Subtest basic-llseek-size: SUCCESS (0.005s)
[128.631196] [131/165] (869s left) prime_self_import (basic-with_fd_dup)
[128.717307] Starting subtest: basic-with_fd_dup
[128.720176] Subtest basic-with_fd_dup: SUCCESS (0.004s)
[128.799491] [132/165] (869s left) prime_self_import (basic-with_one_bo)
[128.885345] Starting subtest: basic-with_one_bo
[128.887983] Subtest basic-with_one_bo: SUCCESS (0.004s)
[128.948764] [133/165] (869s left) prime_self_import (basic-with_one_bo_two_files)
[129.035269] Starting subtest: basic-with_one_bo_two_files
[129.037427] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[129.116392] [134/165] (869s left) prime_self_import (basic-with_two_bos)
[129.198269] Starting subtest: basic-with_two_bos
[129.203221] Subtest basic-with_two_bos: SUCCESS (0.003s)
[129.281384] [135/165] (869s left) prime_vgem (basic-fence-flip)
[129.377584] Starting subtest: basic-fence-flip
[129.762218] Subtest basic-fence-flip: SUCCESS (0.383s)
[129.833109] [136/165] (868s left) prime_vgem (basic-fence-mmap)
[129.931228] Starting subtest: basic-fence-mmap
[129.973773] Subtest basic-fence-mmap: SUCCESS (0.044s)
[130.053076] [137/165] (868s left) prime_vgem (basic-fence-read)
[130.145263] Starting subtest: basic-fence-read
[130.217441] Subtest basic-fence-read: SUCCESS (0.071s)
[130.286363] [138/165] (868s left) prime_vgem (basic-gtt)
[130.381862] Starting subtest: basic-gtt
[130.399762] Subtest basic-gtt: SUCCESS (0.020s)
[130.485524] [139/165] (868s left) prime_vgem (basic-read)
[130.581362] Starting subtest: basic-read
[130.614878] Subtest basic-read: SUCCESS (0.032s)
[130.686206] [140/165] (868s left) prime_vgem (basic-write)
[130.782289] Starting subtest: basic-write
[130.814199] Subtest basic-write: SUCCESS (0.034s)
[130.887536] [141/165] (867s left) vgem_basic (setversion)
[130.979133] Starting subtest: setversion
[130.981359] Subtest setversion: SUCCESS (0.000s)
[131.040189] [142/165] (867s left) vgem_basic (create)
[131.129059] Starting subtest: create
[131.130127] Subtest create: SUCCESS (0.000s)
[131.188789] [143/165] (867s left) vgem_basic (debugfs)
[131.281097] Starting subtest: debugfs
[131.282264] Subtest debugfs: SUCCESS (0.000s)
[131.341863] [144/165] (867s left) vgem_basic (dmabuf-export)
[131.433044] Starting subtest: dmabuf-export
[131.435477] Subtest dmabuf-export: SUCCESS (0.003s)
[131.506566] [145/165] (867s left) vgem_basic (dmabuf-fence)
[131.598761] Starting subtest: dmabuf-fence
[131.599895] Subtest dmabuf-fence: SUCCESS (0.001s)
[131.657246] [146/165] (867s left) vgem_basic (dmabuf-fence-before)
[131.748943] Starting subtest: dmabuf-fence-before
[131.750126] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[131.808300] [147/165] (867s left) vgem_basic (dmabuf-mmap)
[131.909213] Starting subtest: dmabuf-mmap
[131.918923] Subtest dmabuf-mmap: SUCCESS (0.021s)
[131.974846] [148/165] (866s left) vgem_basic (mmap)
[132.066051] Starting subtest: mmap
[132.078890] Subtest mmap: SUCCESS (0.015s)
[132.142101] [149/165] (866s left) vgem_basic (second-client)
[132.232313] Starting subtest: second-client
[132.266928] Subtest second-client: SUCCESS (0.033s)
[132.326406] [150/165] (866s left) vgem_basic (sysfs)
[132.418480] Starting subtest: sysfs
[132.419669] Subtest sysfs: SUCCESS (0.001s)
[132.476478] [151/165] (866s left) core_hotunplug (unbind-rebind)
[132.616462] Starting subtest: unbind-rebind
[135.320544] Subtest unbind-rebind: SUCCESS (2.704s)
[135.346080] [152/165] (863s left) vgem_basic (unload)
[135.434486] Starting subtest: unload
[164.303597] Subtest unload: SUCCESS (28.867s)
[164.414639] [153/165] (834s left) i915_module_load (reload)
[164.500265] Starting subtest: reload
[166.293285] Subtest reload: SUCCESS (1.794s)
[166.338109] [154/165] (832s left) gem_lmem_swapping (basic)
[166.444972] Subtest basic: SKIP (0.000s)
[166.471213] [155/165] (832s left) gem_lmem_swapping (parallel-random-engines)
[166.561241] Subtest parallel-random-engines: SKIP (0.000s)
[166.588971] [156/165] (832s left) gem_lmem_swapping (random-engines)
[166.691954] Subtest random-engines: SKIP (0.000s)
[166.745248] [157/165] (832s left) gem_lmem_swapping (verify-random)
[166.891044] Subtest verify-random: SKIP (0.000s)
[166.924240] [158/165] (832s left) i915_pm_rpm (module-reload)
[178.222715] Subtest module-reload: SKIP (0.000s)
[178.246864] [159/165] (820s left) i915_selftest (live)
[178.830073] Starting subtest: live
[178.831205] Starting dynamic subtest: sanitycheck
[179.496045] Dynamic subtest sanitycheck: SUCCESS (0.666s)
[179.505026] Starting dynamic subtest: uncore
[180.150252] Dynamic subtest uncore: SUCCESS (0.653s)
[180.158168] Starting dynamic subtest: workarounds
[180.779866] Dynamic subtest workarounds: SUCCESS (0.629s)
[180.789099] Starting dynamic subtest: gt_engines
[181.411074] Dynamic subtest gt_engines: SUCCESS (0.630s)
[181.421152] Starting dynamic subtest: gt_timelines
[184.346124] Dynamic subtest gt_timelines: SUCCESS (2.932s)
[184.355327] Starting dynamic subtest: gt_contexts
[184.980936] Dynamic subtest gt_contexts: SUCCESS (0.633s)
[185.008131] Starting dynamic subtest: gt_lrc
[185.613764] Dynamic subtest gt_lrc: SUCCESS (0.634s)
[185.622361] Starting dynamic subtest: gt_mocs
[186.244168] Dynamic subtest gt_mocs: SUCCESS (0.629s)
[186.253396] Starting dynamic subtest: gt_pm
[187.365056] Dynamic subtest gt_pm: SUCCESS (1.120s)
[187.374953] Starting dynamic subtest: gt_heartbeat
[188.020114] Dynamic subtest gt_heartbeat: SUCCESS (0.652s)
[188.038121] Starting dynamic subtest: gt_tlb
[188.632228] Dynamic subtest gt_tlb: SUCCESS (0.611s)
[188.642347] Starting dynamic subtest: requests
[191.810151] Dynamic subtest requests: SUCCESS (3.179s)
[191.819897] Starting dynamic subtest: migrate
[192.471065] Dynamic subtest migrate: SUCCESS (0.660s)
[192.480244] Starting dynamic subtest: active
[193.112995] Dynamic subtest active: SUCCESS (0.641s)
[193.122186] Starting dynamic subtest: objects
[194.062201] Dynamic subtest objects: SUCCESS (0.948s)
[194.071467] Starting dynamic subtest: mman
[198.993127] Dynamic subtest mman: SUCCESS (4.930s)
[199.002678] Starting dynamic subtest: dmabuf
[199.664089] Dynamic subtest dmabuf: SUCCESS (0.670s)
[199.672905] Starting dynamic subtest: vma
[200.308128] Dynamic subtest vma: SUCCESS (0.643s)
[200.316561] Starting dynamic subtest: coherency
[202.079217] Dynamic subtest coherency: SUCCESS (1.770s)
[202.089929] Starting dynamic subtest: gtt
[206.350934] Dynamic subtest gtt: SUCCESS (4.271s)
[206.360361] Starting dynamic subtest: gem
[207.014257] Dynamic subtest gem: SUCCESS (0.662s)
[207.023745] Starting dynamic subtest: evict
[207.646195] Dynamic subtest evict: SUCCESS (0.631s)
[207.655358] Starting dynamic subtest: hugepages
[208.290158] Dynamic subtest hugepages: SUCCESS (0.641s)
[208.307942] Starting dynamic subtest: gem_contexts
[208.934939] Dynamic subtest gem_contexts: SUCCESS (0.645s)
[208.944880] Starting dynamic subtest: client
[209.593169] Dynamic subtest client: SUCCESS (0.657s)
[209.602601] Starting dynamic subtest: gem_migrate
[210.238786] Dynamic subtest gem_migrate: SUCCESS (0.644s)
[210.247325] Starting dynamic subtest: reset
[211.225207] Dynamic subtest reset: SUCCESS (0.985s)
[211.234651] Starting dynamic subtest: memory_region
[211.872092] Dynamic subtest memory_region: SUCCESS (0.646s)
[211.881683] Starting dynamic subtest: hangcheck
[213.554064] Dynamic subtest hangcheck: SUCCESS (1.681s)
[213.563400] Starting dynamic subtest: execlists
[214.198602] Dynamic subtest execlists: SUCCESS (0.645s)
[214.208210] Starting dynamic subtest: ring_submission
[214.838299] Dynamic subtest ring_submission: SUCCESS (0.636s)
[214.847725] Starting dynamic subtest: perf
[215.475122] Dynamic subtest perf: SUCCESS (0.634s)
[215.484225] Starting dynamic subtest: slpc
[216.107378] Dynamic subtest slpc: SUCCESS (0.633s)
[216.116386] Starting dynamic subtest: guc
[216.755869] Dynamic subtest guc: SUCCESS (0.647s)
[216.764630] Starting dynamic subtest: guc_multi_lrc
[217.403816] Dynamic subtest guc_multi_lrc: SUCCESS (0.648s)
[217.413293] Starting dynamic subtest: guc_hang
[218.033191] Dynamic subtest guc_hang: SUCCESS (0.628s)
[218.046844] Starting dynamic subtest: late_gt_pm
[218.649570] Dynamic subtest late_gt_pm: SUCCESS (0.615s)
[218.650663] Subtest live: SUCCESS (39.820s)
[218.672754] [160/165] (780s left) dmabuf (all-tests)
[218.762506] Starting subtest: all-tests
[218.764333] Starting dynamic subtest: sanitycheck
[218.829613] Dynamic subtest sanitycheck: SUCCESS (0.064s)
[218.838437] Starting dynamic subtest: dma_fence
[219.011035] Dynamic subtest dma_fence: SUCCESS (0.180s)
[219.027584] Starting dynamic subtest: dma_fence_chain
[236.829968] Dynamic subtest dma_fence_chain: SUCCESS (17.817s)
[236.842871] Starting dynamic subtest: dma_fence_unwrap
[236.892305] Dynamic subtest dma_fence_unwrap: SUCCESS (0.063s)
[236.906867] Starting dynamic subtest: dma_resv
[236.949272] Dynamic subtest dma_resv: SUCCESS (0.057s)
[236.950479] Subtest all-tests: SUCCESS (18.189s)
[236.972514] [161/165] (762s left) i915_suspend (basic-s2idle-without-i915)
[237.054698] Starting subtest: basic-s2idle-without-i915
[255.236897] Subtest basic-s2idle-without-i915: SUCCESS (18.182s)
[258.313502] [162/165] (743s left) i915_suspend (basic-s3-without-i915)
[258.405182] Starting subtest: basic-s3-without-i915
[274.917265] Subtest basic-s3-without-i915: SUCCESS (1.847s)
[279.999555] [163/165] (741s left) gem_exec_suspend (basic-s0)
[280.107059] Starting subtest: basic-S0
[280.108558] Starting dynamic subtest: smem
[296.855696] Dynamic subtest smem: SUCCESS (16.748s)
[296.856774] Subtest basic-S0: SUCCESS (16.749s)
[301.057938] [164/165] (724s left) gem_exec_suspend (basic-s3)
[301.162689] Starting subtest: basic-S3
[301.166985] Starting dynamic subtest: smem
[318.762972] Dynamic subtest smem: SUCCESS (1.813s)
[318.764109] Subtest basic-S3: SUCCESS (1.815s)
[323.957191] [165/165] (722s left) kms_pipe_crc_basic (suspend-read-crc)
[324.072719] Starting subtest: suspend-read-crc
[324.073810] Starting dynamic subtest: pipe-A-VGA-1
[341.812649] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.631s)
[341.829978] Starting dynamic subtest: pipe-B-VGA-1
[359.775900] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.595s)
[359.777605] Subtest suspend-read-crc: SUCCESS (3.232s)
[364.891142] Closing watchdogs
Done.