[40.793230] Initializing watchdogs
[40.793438]   /dev/watchdog0
[40.823792] [001/171] (960s left) i915_module_load (load)
[40.977074] Starting subtest: load
[42.469938] Subtest load: SUCCESS (1.489s)
[42.605255] [002/171] (958s left) core_auth (basic-auth)
[42.802779] Starting subtest: basic-auth
[42.823959] Subtest basic-auth: SUCCESS (0.000s)
[42.894703] [003/171] (958s left) debugfs_test (read_all_entries)
[43.070537] Starting subtest: read_all_entries
[43.089153] Subtest read_all_entries: SUCCESS (0.049s)
[43.185913] [004/171] (958s left) debugfs_test (basic-hwmon)
[43.344219] Starting subtest: basic-hwmon
[43.386460] Subtest basic-hwmon: SKIP (0.000s)
[43.463155] [005/171] (958s left) fbdev (eof)
[43.592785] Starting subtest: eof
[43.614760] Subtest eof: SUCCESS (0.000s)
[43.691322] [006/171] (957s left) fbdev (info)
[43.844909] Starting subtest: info
[43.866116] Subtest info: SUCCESS (0.000s)
[43.937782] [007/171] (957s left) fbdev (nullptr)
[44.077255] Starting subtest: nullptr
[44.098355] Subtest nullptr: SUCCESS (0.000s)
[44.168908] [008/171] (957s left) fbdev (read)
[44.297915] Starting subtest: read
[44.421717] Subtest read: SUCCESS (0.130s)
[44.491995] [009/171] (957s left) fbdev (write)
[44.637049] Starting subtest: write
[44.692242] Subtest write: SUCCESS (0.067s)
[44.769763] [010/171] (957s left) gem_basic (bad-close)
[44.931591] Starting subtest: bad-close
[44.976256] Subtest bad-close: SUCCESS (0.000s)
[45.051495] [011/171] (956s left) gem_basic (create-close)
[45.218611] Starting subtest: create-close
[45.258705] Subtest create-close: SUCCESS (0.000s)
[45.328574] [012/171] (956s left) gem_basic (create-fd-close)
[45.491152] Starting subtest: create-fd-close
[45.535263] Subtest create-fd-close: SUCCESS (0.000s)
[45.612810] [013/171] (956s left) gem_busy (busy@all-engines)
[45.770411] Starting subtest: busy
[45.791662] Starting dynamic subtest: all-engines
[45.816389] Dynamic subtest all-engines: SUCCESS (0.024s)
[45.840517] Subtest busy: SUCCESS (0.025s)
[46.121678] [014/171] (956s left) gem_close_race (basic-process)
[46.322947] Starting subtest: basic-process
[46.348663] Subtest basic-process: SUCCESS (0.035s)
[46.530891] [015/171] (955s left) gem_close_race (basic-threads)
[46.715553] Starting subtest: basic-threads
[47.892359] Subtest basic-threads: SUCCESS (1.210s)
[48.082647] [016/171] (954s left) gem_ctx_create (basic)
[48.270725] Starting subtest: basic
[48.294058] Subtest basic: SUCCESS (0.000s)
[48.441437] [017/171] (953s left) gem_ctx_create (basic-files)
[48.616294] Starting subtest: basic-files
[50.618641] Subtest basic-files: SUCCESS (2.012s)
[50.902835] [018/171] (951s left) gem_ctx_exec (basic)
[51.075128] Starting subtest: basic
[51.096916] Subtest basic: SUCCESS (0.002s)
[51.172488] [019/171] (951s left) gem_exec_basic (basic)
[51.344584] Starting subtest: basic
[51.366278] Starting dynamic subtest: rcs0-smem
[51.385370] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[51.408505] Starting dynamic subtest: bcs0-smem
[51.427770] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[51.450972] Starting dynamic subtest: vcs0-smem
[51.472509] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[51.494331] Subtest basic: SUCCESS (0.002s)
[51.568887] [020/171] (950s left) gem_exec_create (basic)
[51.719707] Starting subtest: basic
[51.740067] Starting dynamic subtest: smem
[53.746436] Dynamic subtest smem: SUCCESS (2.042s)
[53.765669] Subtest basic: SUCCESS (2.043s)
[53.928666] [021/171] (948s left) gem_exec_fence (basic-busy)
[54.187914] Starting subtest: basic-busy
[54.207151] Starting dynamic subtest: rcs0
[54.249076] Dynamic subtest rcs0: SUCCESS (0.026s)
[54.277474] Starting dynamic subtest: bcs0
[54.319984] Dynamic subtest bcs0: SUCCESS (0.032s)
[54.343383] Starting dynamic subtest: vcs0
[54.383414] Dynamic subtest vcs0: SUCCESS (0.026s)
[54.402831] Subtest basic-busy: SUCCESS (0.084s)
[54.817467] [022/171] (947s left) gem_exec_fence (basic-wait)
[55.049336] Starting subtest: basic-wait
[55.070749] Starting dynamic subtest: rcs0
[55.090362] Dynamic subtest rcs0: SUCCESS (0.026s)
[55.115659] Starting dynamic subtest: bcs0
[55.135348] Dynamic subtest bcs0: SUCCESS (0.018s)
[55.158896] Starting dynamic subtest: vcs0
[55.181078] Dynamic subtest vcs0: SUCCESS (0.023s)
[55.203552] Subtest basic-wait: SUCCESS (0.067s)
[55.585940] [023/171] (947s left) gem_exec_fence (basic-await)
[55.835362] Starting subtest: basic-await
[55.854656] Starting dynamic subtest: rcs0
[55.900071] Dynamic subtest rcs0: SUCCESS (0.066s)
[55.923252] Starting dynamic subtest: bcs0
[55.969395] Dynamic subtest bcs0: SUCCESS (0.066s)
[56.000029] Starting dynamic subtest: vcs0
[56.039714] Dynamic subtest vcs0: SUCCESS (0.066s)
[56.058473] Subtest basic-await: SUCCESS (0.199s)
[56.482363] [024/171] (946s left) gem_exec_fence (nb-await)
[56.739473] Starting subtest: nb-await
[56.761504] Starting dynamic subtest: rcs0
[56.803588] Dynamic subtest rcs0: SUCCESS (0.054s)
[56.828355] Starting dynamic subtest: bcs0
[56.847530] Dynamic subtest bcs0: SUCCESS (0.052s)
[56.870608] Starting dynamic subtest: vcs0
[56.908093] Dynamic subtest vcs0: SUCCESS (0.052s)
[56.929494] Subtest nb-await: SUCCESS (0.158s)
[57.357855] [025/171] (945s left) gem_exec_gttfill (basic)
[57.529599] Starting subtest: basic
[59.872324] Subtest basic: SUCCESS (2.375s)
[60.067920] [026/171] (942s left) gem_exec_parallel (engines)
[60.328714] Starting subtest: engines
[60.349817] Starting dynamic subtest: basic
[61.733886] Dynamic subtest basic: SUCCESS (1.430s)
[61.757836] Starting dynamic subtest: contexts
[63.314155] Dynamic subtest contexts: SUCCESS (1.579s)
[63.340259] Starting dynamic subtest: fds
[65.097104] Dynamic subtest fds: SUCCESS (1.783s)
[65.123333] Starting dynamic subtest: userptr
[66.562371] Dynamic subtest userptr: SUCCESS (1.459s)
[66.581519] Subtest engines: SUCCESS (6.251s)
[66.754361] [027/171] (936s left) gem_exec_store (basic)
[66.986468] Starting subtest: basic
[67.005566] Subtest basic: SUCCESS (0.028s)
[67.123843] [028/171] (935s left) gem_flink_basic (bad-flink)
[67.284565] Starting subtest: bad-flink
[67.306360] Subtest bad-flink: SUCCESS (0.000s)
[67.382232] [029/171] (935s left) gem_flink_basic (bad-open)
[67.548835] Starting subtest: bad-open
[67.570283] Subtest bad-open: SUCCESS (0.000s)
[67.642638] [030/171] (935s left) gem_flink_basic (basic)
[67.812582] Starting subtest: basic
[67.831592] Subtest basic: SUCCESS (0.000s)
[67.905659] [031/171] (935s left) gem_flink_basic (double-flink)
[68.071418] Starting subtest: double-flink
[68.090418] Subtest double-flink: SUCCESS (0.000s)
[68.169474] [032/171] (935s left) gem_flink_basic (flink-lifetime)
[68.311527] Starting subtest: flink-lifetime
[68.333634] Subtest flink-lifetime: SUCCESS (0.001s)
[68.411457] [033/171] (934s left) gem_huc_copy (huc-copy)
[68.597259] Subtest huc-copy: SKIP (0.000s)
[68.674859] [034/171] (934s left) gem_linear_blits (basic)
[68.875124] Starting subtest: basic
[68.894965] Subtest basic: SUCCESS (0.005s)
[69.016107] [035/171] (934s left) gem_mmap (basic)
[69.290030] Starting subtest: basic
[69.403279] Subtest basic: SUCCESS (0.000s)
[69.510750] [036/171] (934s left) gem_mmap_gtt (basic)
[69.693783] Starting subtest: basic
[69.716829] Subtest basic: SUCCESS (0.000s)
[69.804129] [037/171] (933s left) gem_render_linear_blits (basic)
[69.986979] Starting subtest: basic
[70.099051] Subtest basic: SUCCESS (0.015s)
[70.186904] [038/171] (933s left) gem_render_tiled_blits (basic)
[70.351370] Starting subtest: basic
[70.489982] Subtest basic: SUCCESS (0.029s)
[70.573776] [039/171] (933s left) gem_ringfill (basic-all)
[70.832250] Starting subtest: basic-all
[71.909462] Subtest basic-all: SUCCESS (1.120s)
[72.016849] [040/171] (931s left) gem_softpin (allocator-basic)
[72.211056] Subtest allocator-basic: SKIP (0.000s)
[72.287498] [041/171] (931s left) gem_softpin (allocator-basic-reserve)
[72.470239] Subtest allocator-basic-reserve: SKIP (0.000s)
[72.550205] [042/171] (931s left) gem_softpin (safe-alignment)
[72.738708] Starting subtest: safe-alignment
[72.760284] Subtest safe-alignment: SUCCESS (0.005s)
[72.834300] [043/171] (931s left) gem_sync (basic-all)
[73.045099] Starting subtest: basic-all
[75.101201] Subtest basic-all: SUCCESS (2.098s)
[75.278690] [044/171] (928s left) gem_sync (basic-each)
[75.480879] Starting subtest: basic-each
[77.539786] Subtest basic-each: SUCCESS (2.109s)
[77.732707] [045/171] (926s left) gem_tiled_blits (basic)
[77.947038] Starting subtest: basic
[77.966710] Subtest basic: SUCCESS (0.010s)
[78.094865] [046/171] (926s left) gem_tiled_fence_blits (basic)
[78.403653] Starting subtest: basic
[78.425755] Subtest basic: SUCCESS (0.006s)
[78.547177] [047/171] (925s left) gem_tiled_pread_basic
[78.958445] [048/171] (925s left) gem_wait (busy@all-engines)
[79.132945] Starting subtest: busy
[79.153738] Starting dynamic subtest: all-engines
[79.634565] Dynamic subtest all-engines: SUCCESS (0.517s)
[79.654164] Subtest busy: SUCCESS (0.517s)
[79.854888] [049/171] (924s left) gem_wait (wait@all-engines)
[80.019636] Starting subtest: wait
[80.039830] Starting dynamic subtest: all-engines
[81.017592] Dynamic subtest all-engines: SUCCESS (1.014s)
[81.036872] Subtest wait: SUCCESS (1.014s)
[81.213251] [050/171] (923s left) i915_getparams_basic (basic-eu-total)
[81.378556] Starting subtest: basic-eu-total
[81.421457] Subtest basic-eu-total: SUCCESS (0.000s)
[81.493053] [051/171] (923s left) i915_getparams_basic (basic-subslice-total)
[81.660127] Starting subtest: basic-subslice-total
[81.698263] Subtest basic-subslice-total: SUCCESS (0.000s)
[81.775308] [052/171] (922s left) i915_hangman (error-state-basic)
[81.949410] Starting subtest: error-state-basic
[81.971827] Subtest error-state-basic: SUCCESS (0.004s)
[82.050630] [053/171] (922s left) i915_pciid
[82.312330] [054/171] (922s left) kms_addfb_basic (addfb25-bad-modifier)
[82.489131] Starting subtest: addfb25-bad-modifier
[82.508717] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[82.652632] [055/171] (922s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[82.814093] Starting subtest: addfb25-framebuffer-vs-set-tiling
[82.836183] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[82.914749] [056/171] (922s left) kms_addfb_basic (addfb25-modifier-no-flag)
[83.080379] Starting subtest: addfb25-modifier-no-flag
[83.101729] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[83.174882] [057/171] (921s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[83.343476] Starting subtest: addfb25-x-tiled-legacy
[83.362895] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[83.440105] [058/171] (921s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[83.602703] Starting subtest: addfb25-x-tiled-mismatch-legacy
[83.621707] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[83.702110] [059/171] (921s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[83.863563] Starting subtest: addfb25-yf-tiled-legacy
[83.885212] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[83.964382] [060/171] (921s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[84.129500] Starting subtest: addfb25-y-tiled-legacy
[84.150965] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[84.225400] [061/171] (920s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[84.392527] Starting subtest: addfb25-y-tiled-small-legacy
[84.430926] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[84.511287] [062/171] (920s left) kms_addfb_basic (bad-pitch-0)
[84.672802] Starting subtest: bad-pitch-0
[84.694923] Subtest bad-pitch-0: SUCCESS (0.000s)
[84.774718] [063/171] (920s left) kms_addfb_basic (bad-pitch-1024)
[84.939294] Starting subtest: bad-pitch-1024
[84.960048] Subtest bad-pitch-1024: SUCCESS (0.000s)
[85.042171] [064/171] (920s left) kms_addfb_basic (bad-pitch-128)
[85.209884] Starting subtest: bad-pitch-128
[85.229441] Subtest bad-pitch-128: SUCCESS (0.000s)
[85.303595] [065/171] (920s left) kms_addfb_basic (bad-pitch-256)
[85.468754] Starting subtest: bad-pitch-256
[85.487862] Subtest bad-pitch-256: SUCCESS (0.000s)
[85.566834] [066/171] (919s left) kms_addfb_basic (bad-pitch-32)
[85.726227] Starting subtest: bad-pitch-32
[85.748080] Subtest bad-pitch-32: SUCCESS (0.000s)
[85.830696] [067/171] (919s left) kms_addfb_basic (bad-pitch-63)
[85.996907] Starting subtest: bad-pitch-63
[86.018614] Subtest bad-pitch-63: SUCCESS (0.000s)
[86.093271] [068/171] (919s left) kms_addfb_basic (bad-pitch-65536)
[86.260374] Starting subtest: bad-pitch-65536
[86.279929] Subtest bad-pitch-65536: SUCCESS (0.000s)
[86.354884] [069/171] (919s left) kms_addfb_basic (bad-pitch-999)
[86.518466] Starting subtest: bad-pitch-999
[86.537448] Subtest bad-pitch-999: SUCCESS (0.000s)
[86.616293] [070/171] (919s left) kms_addfb_basic (basic)
[86.774466] Starting subtest: basic
[86.796106] Subtest basic: SUCCESS (0.000s)
[86.875532] [071/171] (919s left) kms_addfb_basic (basic-x-tiled-legacy)
[87.041264] Starting subtest: basic-x-tiled-legacy
[87.062408] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[87.136947] [072/171] (918s left) kms_addfb_basic (basic-y-tiled-legacy)
[87.304158] Starting subtest: basic-y-tiled-legacy
[87.323135] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[87.396689] [073/171] (918s left) kms_addfb_basic (bo-too-small)
[87.563233] Starting subtest: bo-too-small
[87.583290] Subtest bo-too-small: SUCCESS (0.000s)
[87.663511] [074/171] (918s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[87.827022] Starting subtest: bo-too-small-due-to-tiling
[87.848102] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[87.924063] [075/171] (918s left) kms_addfb_basic (clobberred-modifier)
[88.092630] Starting subtest: clobberred-modifier
[88.112562] Subtest clobberred-modifier: SUCCESS (0.000s)
[88.186874] [076/171] (918s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[88.359342] Starting subtest: framebuffer-vs-set-tiling
[88.378061] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[88.456314] [077/171] (917s left) kms_addfb_basic (invalid-get-prop)
[88.616859] Starting subtest: invalid-get-prop
[88.637052] Subtest invalid-get-prop: SUCCESS (0.000s)
[88.717623] [078/171] (917s left) kms_addfb_basic (invalid-get-prop-any)
[88.880621] Starting subtest: invalid-get-prop-any
[88.902169] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[88.979475] [079/171] (917s left) kms_addfb_basic (invalid-set-prop)
[89.138677] Starting subtest: invalid-set-prop
[89.179474] Subtest invalid-set-prop: SUCCESS (0.000s)
[89.266482] [080/171] (917s left) kms_addfb_basic (invalid-set-prop-any)
[89.452258] Starting subtest: invalid-set-prop-any
[89.476555] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[89.578058] [081/171] (916s left) kms_addfb_basic (no-handle)
[89.776991] Starting subtest: no-handle
[89.803184] Subtest no-handle: SUCCESS (0.000s)
[89.894347] [082/171] (916s left) kms_addfb_basic (size-max)
[90.225929] Starting subtest: size-max
[90.250667] Subtest size-max: SUCCESS (0.000s)
[90.344494] [083/171] (916s left) kms_addfb_basic (small-bo)
[90.529496] Starting subtest: small-bo
[90.553086] Subtest small-bo: SUCCESS (0.000s)
[90.651340] [084/171] (916s left) kms_addfb_basic (tile-pitch-mismatch)
[90.845568] Starting subtest: tile-pitch-mismatch
[90.874166] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[90.971535] [085/171] (915s left) kms_addfb_basic (too-high)
[91.160683] Starting subtest: too-high
[91.183529] Subtest too-high: SUCCESS (0.001s)
[91.279060] [086/171] (915s left) kms_addfb_basic (too-wide)
[91.462440] Starting subtest: too-wide
[91.489083] Subtest too-wide: SUCCESS (0.000s)
[91.587360] [087/171] (915s left) kms_addfb_basic (unused-handle)
[91.779098] Starting subtest: unused-handle
[91.811502] Subtest unused-handle: SUCCESS (0.000s)
[91.903847] [088/171] (915s left) kms_addfb_basic (unused-modifier)
[92.091069] Starting subtest: unused-modifier
[92.117044] Subtest unused-modifier: SUCCESS (0.000s)
[92.216105] [089/171] (915s left) kms_addfb_basic (unused-offsets)
[92.414328] Starting subtest: unused-offsets
[92.439454] Subtest unused-offsets: SUCCESS (0.000s)
[92.521549] [090/171] (914s left) kms_addfb_basic (unused-pitches)
[92.681604] Starting subtest: unused-pitches
[92.703166] Subtest unused-pitches: SUCCESS (0.000s)
[92.780712] [091/171] (914s left) kms_busy (basic)
[92.954057] Starting subtest: basic
[92.975894] Starting dynamic subtest: flip
[93.551929] Dynamic subtest flip: SUCCESS (0.612s)
[93.576024] Starting dynamic subtest: modeset
[94.057714] Dynamic subtest modeset: SUCCESS (0.512s)
[94.079676] Subtest basic: SUCCESS (1.125s)
[94.230054] [092/171] (913s left) kms_chamelium_hpd (dp-hpd-fast)
[94.451174] Subtest dp-hpd-fast: SKIP (0.000s)
[94.577138] [093/171] (912s left) kms_chamelium_edid (dp-edid-read)
[94.786952] Subtest dp-edid-read: SKIP (0.000s)
[94.904984] [094/171] (912s left) kms_chamelium_frames (dp-crc-fast)
[95.113041] Subtest dp-crc-fast: SKIP (0.000s)
[95.247832] [095/171] (912s left) kms_chamelium_hpd (hdmi-hpd-fast)
[95.447955] Subtest hdmi-hpd-fast: SKIP (0.000s)
[95.586927] [096/171] (912s left) kms_chamelium_edid (hdmi-edid-read)
[95.810523] Subtest hdmi-edid-read: SKIP (0.000s)
[95.936511] [097/171] (911s left) kms_chamelium_frames (hdmi-crc-fast)
[96.140261] Subtest hdmi-crc-fast: SKIP (0.000s)
[96.259260] [098/171] (911s left) kms_chamelium_hpd (vga-hpd-fast)
[96.483035] Subtest vga-hpd-fast: SKIP (0.000s)
[96.597941] [099/171] (911s left) kms_chamelium_edid (vga-edid-read)
[96.802554] Subtest vga-edid-read: SKIP (0.000s)
[96.943060] [100/171] (911s left) kms_prop_blob (basic)
[97.115418] Starting subtest: basic
[97.137302] Subtest basic: SUCCESS (0.000s)
[97.210937] [101/171] (910s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[97.384568] Starting subtest: basic-busy-flip-before-cursor-atomic
[98.310079] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.941s)
[98.468295] [102/171] (909s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[98.631655] Starting subtest: basic-busy-flip-before-cursor-legacy
[99.575334] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.950s)
[99.738568] [103/171] (908s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[99.899201] Starting subtest: basic-flip-after-cursor-atomic
[100.823794] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.933s)
[100.992590] [104/171] (907s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[101.161128] Starting subtest: basic-flip-after-cursor-legacy
[102.072880] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.927s)
[102.249183] [105/171] (906s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[102.413091] Starting subtest: basic-flip-after-cursor-varying-size
[103.325426] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.934s)
[103.491625] [106/171] (905s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[103.658155] Starting subtest: basic-flip-before-cursor-atomic
[104.574962] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.936s)
[104.738213] [107/171] (903s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[104.901068] Starting subtest: basic-flip-before-cursor-legacy
[105.832045] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.940s)
[105.990251] [108/171] (902s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[106.152241] Starting subtest: basic-flip-before-cursor-varying-size
[107.082787] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.936s)
[107.243934] [109/171] (901s left) kms_flip (basic-flip-vs-dpms)
[107.428830] Starting subtest: basic-flip-vs-dpms
[107.450844] Starting dynamic subtest: A-VGA1
[108.322098] Dynamic subtest A-VGA1: SUCCESS (0.929s)
[108.346387] Starting dynamic subtest: B-VGA1
[109.196945] Dynamic subtest B-VGA1: SUCCESS (0.880s)
[109.224647] Starting dynamic subtest: C-VGA1
[110.092325] Dynamic subtest C-VGA1: SUCCESS (0.878s)
[110.113834] Subtest basic-flip-vs-dpms: SUCCESS (2.690s)
[110.283307] [110/171] (898s left) kms_flip (basic-flip-vs-modeset)
[110.485362] Starting subtest: basic-flip-vs-modeset
[110.507247] Starting dynamic subtest: A-VGA1
[111.284799] Dynamic subtest A-VGA1: SUCCESS (0.842s)
[111.314124] Starting dynamic subtest: B-VGA1
[112.063678] Dynamic subtest B-VGA1: SUCCESS (0.784s)
[112.092734] Starting dynamic subtest: C-VGA1
[112.842358] Dynamic subtest C-VGA1: SUCCESS (0.786s)
[112.860674] Subtest basic-flip-vs-modeset: SUCCESS (2.416s)
[113.016799] [111/171] (895s left) kms_flip (basic-flip-vs-wf_vblank)
[113.209536] Starting subtest: basic-flip-vs-wf_vblank
[113.228190] Starting dynamic subtest: A-VGA1
[114.309602] Dynamic subtest A-VGA1: SUCCESS (1.144s)
[114.336722] Starting dynamic subtest: B-VGA1
[115.435820] Dynamic subtest B-VGA1: SUCCESS (1.123s)
[115.464454] Starting dynamic subtest: C-VGA1
[116.563513] Dynamic subtest C-VGA1: SUCCESS (1.123s)
[116.584367] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.396s)
[116.777251] [112/171] (892s left) kms_flip (basic-plain-flip)
[116.961354] Starting subtest: basic-plain-flip
[116.982617] Starting dynamic subtest: A-VGA1
[117.790963] Dynamic subtest A-VGA1: SUCCESS (0.872s)
[117.817467] Starting dynamic subtest: B-VGA1
[118.636575] Dynamic subtest B-VGA1: SUCCESS (0.845s)
[118.664045] Starting dynamic subtest: C-VGA1
[119.480276] Dynamic subtest C-VGA1: SUCCESS (0.838s)
[119.499820] Subtest basic-plain-flip: SUCCESS (2.561s)
[119.708275] [113/171] (889s left) kms_force_connector_basic (force-connector-state)
[119.883456] Starting subtest: force-connector-state
[120.020992] Subtest force-connector-state: SUCCESS (0.142s)
[120.215602] [114/171] (889s left) kms_force_connector_basic (force-edid)
[120.377122] Starting subtest: force-edid
[120.419021] Subtest force-edid: SUCCESS (0.062s)
[120.554485] [115/171] (888s left) kms_force_connector_basic (force-load-detect)
[120.714800] Starting subtest: force-load-detect
[120.848482] Subtest force-load-detect: SUCCESS (0.139s)
[121.048980] [116/171] (888s left) kms_force_connector_basic (prune-stale-modes)
[121.216880] Starting subtest: prune-stale-modes
[121.236540] Subtest prune-stale-modes: SUCCESS (0.016s)
[121.331438] [117/171] (888s left) kms_frontbuffer_tracking (basic)
[121.561168] Starting subtest: basic
[123.356834] Subtest basic: SUCCESS (1.871s)
[123.489444] [118/171] (886s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[123.659228] Starting subtest: compare-crc-sanitycheck-xr24
[123.680637] Starting dynamic subtest: pipe-A-VGA-1
[123.919657] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.270s)
[123.945753] Starting dynamic subtest: pipe-B-VGA-1
[124.184985] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.265s)
[124.210216] Starting dynamic subtest: pipe-C-VGA-1
[124.455093] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.270s)
[124.473812] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.810s)
[124.622807] [119/171] (885s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[124.784907] Starting subtest: compare-crc-sanitycheck-nv12
[124.806254] Starting dynamic subtest: pipe-A-VGA-1
[124.848187] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s)
[124.875253] Starting dynamic subtest: pipe-B-VGA-1
[124.914079] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s)
[124.939818] Starting dynamic subtest: pipe-C-VGA-1
[124.983317] Dynamic subtest pipe-C-VGA-1: SKIP (0.000s)
[125.025444] Subtest compare-crc-sanitycheck-nv12: SKIP (0.004s)
[125.101382] [120/171] (884s left) kms_pipe_crc_basic (hang-read-crc)
[125.268852] Starting subtest: hang-read-crc
[125.288179] Starting dynamic subtest: pipe-A-VGA-1
[126.016742] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.759s)
[126.042667] Starting dynamic subtest: pipe-B-VGA-1
[126.776368] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.761s)
[126.803490] Starting dynamic subtest: pipe-C-VGA-1
[127.554976] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.773s)
[127.573646] Subtest hang-read-crc: SUCCESS (2.297s)
[127.718266] [121/171] (882s left) kms_pipe_crc_basic (nonblocking-crc)
[127.887606] Starting subtest: nonblocking-crc
[127.908826] Starting dynamic subtest: pipe-A-VGA-1
[128.326409] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.450s)
[128.350810] Starting dynamic subtest: pipe-B-VGA-1
[128.786641] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.457s)
[128.813745] Starting dynamic subtest: pipe-C-VGA-1
[129.238922] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.452s)
[129.272674] Subtest nonblocking-crc: SUCCESS (1.365s)
[129.413838] [122/171] (880s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[129.603405] Starting subtest: nonblocking-crc-frame-sequence
[129.629187] Starting dynamic subtest: pipe-A-VGA-1
[130.031916] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.454s)
[130.063108] Starting dynamic subtest: pipe-B-VGA-1
[130.480497] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.448s)
[130.509033] Starting dynamic subtest: pipe-C-VGA-1
[130.955114] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.452s)
[130.984077] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.359s)
[131.108465] [123/171] (878s left) kms_pipe_crc_basic (read-crc)
[131.304348] Starting subtest: read-crc
[131.328810] Starting dynamic subtest: pipe-A-VGA-1
[131.660271] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.389s)
[131.689044] Starting dynamic subtest: pipe-B-VGA-1
[132.068872] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.381s)
[132.098962] Starting dynamic subtest: pipe-C-VGA-1
[132.447375] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.384s)
[132.467857] Subtest read-crc: SUCCESS (1.160s)
[132.584460] [124/171] (877s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[132.755570] Starting subtest: read-crc-frame-sequence
[132.774821] Starting dynamic subtest: pipe-A-VGA-1
[133.123098] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.378s)
[133.150101] Starting dynamic subtest: pipe-B-VGA-1
[133.509144] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.380s)
[133.533373] Starting dynamic subtest: pipe-C-VGA-1
[133.889611] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.384s)
[133.911042] Subtest read-crc-frame-sequence: SUCCESS (1.147s)
[134.051977] [125/171] (876s left) kms_psr (primary_page_flip)
[134.252227] Subtest primary_page_flip: SKIP (0.000s)
[134.331426] [126/171] (875s left) kms_psr (cursor_plane_move)
[134.515310] Subtest cursor_plane_move: SKIP (0.000s)
[134.596091] [127/171] (875s left) kms_psr (sprite_plane_onoff)
[134.782022] Subtest sprite_plane_onoff: SKIP (0.000s)
[134.858667] [128/171] (875s left) kms_psr (primary_mmap_gtt)
[135.029648] Subtest primary_mmap_gtt: SKIP (0.000s)
[135.103270] [129/171] (875s left) kms_setmode (basic-clone-single-crtc)
[135.278444] Starting subtest: basic-clone-single-crtc
[135.336681] Subtest basic-clone-single-crtc: SKIP (0.000s)
[135.418574] [130/171] (875s left) i915_pm_backlight (basic-brightness)
[135.586963] Subtest basic-brightness: SKIP (0.000s)
[135.668280] [131/171] (874s left) i915_pm_rpm (basic-pci-d3-state)
[147.152810] Subtest basic-pci-d3-state: SKIP (0.000s)
[147.234080] [132/171] (863s left) i915_pm_rpm (basic-rte)
[147.381863] Starting subtest: basic-rte
[158.675429] Subtest basic-rte: SKIP (11.112s)
[158.793756] [133/171] (851s left) i915_pm_rps (basic-api)
[158.962640] Starting subtest: basic-api
[158.984578] Subtest basic-api: SUCCESS (0.002s)
[159.065871] [134/171] (851s left) prime_self_import (basic-llseek-bad)
[159.216447] Starting subtest: basic-llseek-bad
[159.260697] Subtest basic-llseek-bad: SUCCESS (0.001s)
[159.336829] [135/171] (851s left) prime_self_import (basic-llseek-size)
[159.465056] Starting subtest: basic-llseek-size
[159.508290] Subtest basic-llseek-size: SUCCESS (0.003s)
[159.583239] [136/171] (851s left) prime_self_import (basic-with_fd_dup)
[159.734358] Starting subtest: basic-with_fd_dup
[159.773872] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[159.854656] [137/171] (851s left) prime_self_import (basic-with_one_bo)
[159.996131] Starting subtest: basic-with_one_bo
[160.035509] Subtest basic-with_one_bo: SUCCESS (0.002s)
[160.120130] [138/171] (851s left) prime_self_import (basic-with_one_bo_two_files)
[160.249885] Starting subtest: basic-with_one_bo_two_files
[160.294281] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[160.373691] [139/171] (850s left) prime_self_import (basic-with_two_bos)
[160.519630] Starting subtest: basic-with_two_bos
[160.562629] Subtest basic-with_two_bos: SUCCESS (0.002s)
[160.637488] [140/171] (850s left) prime_vgem (basic-fence-flip)
[160.829504] Starting subtest: basic-fence-flip
[161.123658] Subtest basic-fence-flip: SUCCESS (0.330s)
[161.244321] [141/171] (850s left) prime_vgem (basic-fence-mmap)
[161.433122] Starting subtest: basic-fence-mmap
[161.452280] Subtest basic-fence-mmap: SUCCESS (0.030s)
[161.550897] [142/171] (849s left) prime_vgem (basic-fence-read)
[161.732823] Starting subtest: basic-fence-read
[161.754987] Subtest basic-fence-read: SUCCESS (0.042s)
[161.853098] [143/171] (849s left) prime_vgem (basic-gtt)
[162.040889] Starting subtest: basic-gtt
[162.060199] Subtest basic-gtt: SUCCESS (0.011s)
[162.159144] [144/171] (849s left) prime_vgem (basic-read)
[162.364621] Starting subtest: basic-read
[162.385788] Subtest basic-read: SUCCESS (0.017s)
[162.483064] [145/171] (849s left) prime_vgem (basic-write)
[162.673807] Starting subtest: basic-write
[162.693391] Subtest basic-write: SUCCESS (0.019s)
[162.794823] [146/171] (848s left) vgem_basic (setversion)
[162.974408] Starting subtest: setversion
[163.016879] Subtest setversion: SUCCESS (0.000s)
[163.091864] [147/171] (848s left) vgem_basic (create)
[163.259370] Starting subtest: create
[163.278963] Subtest create: SUCCESS (0.000s)
[163.354652] [148/171] (848s left) vgem_basic (debugfs)
[163.519368] Starting subtest: debugfs
[163.538581] Subtest debugfs: SUCCESS (0.000s)
[163.619451] [149/171] (848s left) vgem_basic (dmabuf-export)
[163.780558] Starting subtest: dmabuf-export
[163.824439] Subtest dmabuf-export: SUCCESS (0.002s)
[163.902060] [150/171] (848s left) vgem_basic (dmabuf-fence)
[164.050963] Starting subtest: dmabuf-fence
[164.072129] Subtest dmabuf-fence: SUCCESS (0.001s)
[164.150424] [151/171] (847s left) vgem_basic (dmabuf-fence-before)
[164.316055] Starting subtest: dmabuf-fence-before
[164.335152] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[164.410199] [152/171] (847s left) vgem_basic (dmabuf-mmap)
[164.561530] Starting subtest: dmabuf-mmap
[164.580494] Subtest dmabuf-mmap: SUCCESS (0.015s)
[164.661782] [153/171] (847s left) vgem_basic (mmap)
[164.823769] Starting subtest: mmap
[164.845977] Subtest mmap: SUCCESS (0.010s)
[164.925819] [154/171] (847s left) vgem_basic (second-client)
[165.094229] Starting subtest: second-client
[165.136047] Subtest second-client: SUCCESS (0.033s)
[165.211345] [155/171] (847s left) vgem_basic (sysfs)
[165.379357] Starting subtest: sysfs
[165.398886] Subtest sysfs: SUCCESS (0.001s)
[165.477640] [156/171] (846s left) core_hotunplug (unbind-rebind)
[165.688714] Starting subtest: unbind-rebind
[166.470561] Subtest unbind-rebind: SUCCESS (0.767s)
[166.588155] [157/171] (845s left) vgem_basic (unload)
[166.755722] Starting subtest: unload
[195.866751] Subtest unload: SUCCESS (28.938s)
[195.941905] [158/171] (816s left) i915_module_load (reload)
[196.096183] Starting subtest: reload
[198.179880] Subtest reload: SUCCESS (2.099s)
[198.278635] [159/171] (814s left) gem_lmem_swapping (basic)
[198.460026] Subtest basic: SKIP (0.000s)
[198.536915] [160/171] (814s left) gem_lmem_swapping (parallel-random-engines)
[198.725477] Subtest parallel-random-engines: SKIP (0.000s)
[198.799693] [161/171] (814s left) gem_lmem_swapping (random-engines)
[198.987645] Subtest random-engines: SKIP (0.000s)
[199.065153] [162/171] (813s left) gem_lmem_swapping (verify-random)
[199.249034] Subtest verify-random: SKIP (0.000s)
[199.329260] [163/171] (813s left) i915_pm_rpm (module-reload)
[210.633572] Subtest module-reload: SKIP (0.000s)
[210.711260] [164/171] (802s left) i915_selftest (live)
[211.595325] Starting subtest: live
[211.614357] Starting dynamic subtest: sanitycheck
[212.228294] Dynamic subtest sanitycheck: SUCCESS (0.630s)
[212.255492] Starting dynamic subtest: uncore
[212.834303] Dynamic subtest uncore: SUCCESS (0.607s)
[212.865670] Starting dynamic subtest: workarounds
[213.525194] Dynamic subtest workarounds: SUCCESS (0.689s)
[213.550202] Starting dynamic subtest: gt_engines
[214.130230] Dynamic subtest gt_engines: SUCCESS (0.600s)
[214.157819] Starting dynamic subtest: gt_timelines
[219.379414] Dynamic subtest gt_timelines: SUCCESS (5.250s)
[219.404694] Starting dynamic subtest: gt_contexts
[220.048767] Dynamic subtest gt_contexts: SUCCESS (0.665s)
[220.076252] Starting dynamic subtest: gt_lrc
[220.635417] Dynamic subtest gt_lrc: SUCCESS (0.587s)
[220.660695] Starting dynamic subtest: gt_mocs
[221.247358] Dynamic subtest gt_mocs: SUCCESS (0.608s)
[221.274708] Starting dynamic subtest: gt_pm
[229.827835] Dynamic subtest gt_pm: SUCCESS (8.579s)
[229.856203] Starting dynamic subtest: gt_heartbeat
[230.487480] Dynamic subtest gt_heartbeat: SUCCESS (0.660s)
[230.515382] Starting dynamic subtest: gt_tlb
[231.105395] Dynamic subtest gt_tlb: SUCCESS (0.615s)
[231.130776] Starting dynamic subtest: requests
[236.326581] Dynamic subtest requests: SUCCESS (5.220s)
[236.351961] Starting dynamic subtest: migrate
[236.954081] Dynamic subtest migrate: SUCCESS (0.623s)
[236.981988] Starting dynamic subtest: active
[237.580500] Dynamic subtest active: SUCCESS (0.627s)
[237.605931] Starting dynamic subtest: objects
[238.601660] Dynamic subtest objects: SUCCESS (1.017s)
[238.628653] Starting dynamic subtest: mman
[242.684542] Dynamic subtest mman: SUCCESS (4.083s)
[242.709741] Starting dynamic subtest: dmabuf
[243.368065] Dynamic subtest dmabuf: SUCCESS (0.679s)
[243.394624] Starting dynamic subtest: vma
[244.005203] Dynamic subtest vma: SUCCESS (0.638s)
[244.031777] Starting dynamic subtest: coherency
[245.792264] Dynamic subtest coherency: SUCCESS (1.783s)
[245.819227] Starting dynamic subtest: gtt
[249.661820] Dynamic subtest gtt: SUCCESS (3.870s)
[249.687199] Starting dynamic subtest: gem
[250.321224] Dynamic subtest gem: SUCCESS (0.656s)
[250.349223] Starting dynamic subtest: evict
[250.939191] Dynamic subtest evict: SUCCESS (0.618s)
[250.964450] Starting dynamic subtest: hugepages
[252.648790] Dynamic subtest hugepages: SUCCESS (1.705s)
[252.676433] Starting dynamic subtest: gem_contexts
[256.968730] Dynamic subtest gem_contexts: SUCCESS (4.313s)
[256.998417] Starting dynamic subtest: client
[257.584840] Dynamic subtest client: SUCCESS (0.615s)
[257.613807] Starting dynamic subtest: gem_migrate
[258.154068] Dynamic subtest gem_migrate: SUCCESS (0.570s)
[258.184074] Starting dynamic subtest: reset
[258.766253] Dynamic subtest reset: SUCCESS (0.612s)
[258.798878] Starting dynamic subtest: memory_region
[259.384251] Dynamic subtest memory_region: SUCCESS (0.616s)
[259.417204] Starting dynamic subtest: hangcheck
[272.724465] Dynamic subtest hangcheck: SUCCESS (13.342s)
[272.750224] Starting dynamic subtest: execlists
[273.338245] Dynamic subtest execlists: SUCCESS (0.609s)
[273.364918] Starting dynamic subtest: ring_submission
[273.965250] Dynamic subtest ring_submission: SUCCESS (0.628s)
[273.991957] Starting dynamic subtest: perf
[274.620597] Dynamic subtest perf: SUCCESS (0.652s)
[274.650070] Starting dynamic subtest: slpc
[275.236191] Dynamic subtest slpc: SUCCESS (0.612s)
[275.264119] Starting dynamic subtest: guc
[275.840496] Dynamic subtest guc: SUCCESS (0.606s)
[275.866188] Starting dynamic subtest: guc_multi_lrc
[276.438229] Dynamic subtest guc_multi_lrc: SUCCESS (0.593s)
[276.466286] Starting dynamic subtest: guc_hang
[277.038400] Dynamic subtest guc_hang: SUCCESS (0.601s)
[277.063890] Starting dynamic subtest: late_gt_pm
[277.652857] Dynamic subtest late_gt_pm: SUCCESS (0.610s)
[277.674823] Subtest live: SUCCESS (66.056s)
[277.871468] [165/171] (735s left) dmabuf (all-tests)
[278.029595] Starting subtest: all-tests
[278.048871] Starting dynamic subtest: sanitycheck
[278.118352] Dynamic subtest sanitycheck: SUCCESS (0.090s)
[278.144284] Starting dynamic subtest: dma_fence
[278.294176] Dynamic subtest dma_fence: SUCCESS (0.175s)
[278.317885] Starting dynamic subtest: dma_fence_chain
[290.013947] Dynamic subtest dma_fence_chain: SUCCESS (11.717s)
[290.046495] Starting dynamic subtest: dma_fence_unwrap
[290.101167] Dynamic subtest dma_fence_unwrap: SUCCESS (0.084s)
[290.130354] Starting dynamic subtest: dma_resv
[290.180576] Dynamic subtest dma_resv: SUCCESS (0.079s)
[290.199666] Subtest all-tests: SUCCESS (12.154s)
[290.278736] [166/171] (723s left) i915_suspend (basic-s2idle-without-i915)
[290.427762] Starting subtest: basic-s2idle-without-i915
[307.528851] Subtest basic-s2idle-without-i915: SUCCESS (2.553s)
[310.533985] [167/171] (720s left) i915_suspend (basic-s3-without-i915)
[310.664165] Starting subtest: basic-s3-without-i915
[330.400235] Subtest basic-s3-without-i915: SUCCESS (2.140s)
[334.684167] [168/171] (717s left) gem_exec_suspend (basic-s0)
[334.866735] Starting subtest: basic-S0
[334.887797] Starting dynamic subtest: smem
[352.362137] Dynamic subtest smem: SUCCESS (1.835s)
[352.383167] Subtest basic-S0: SUCCESS (1.836s)
[355.286327] [169/171] (715s left) gem_exec_suspend (basic-s3)
[355.457063] Starting subtest: basic-S3
[355.475637] Starting dynamic subtest: smem
[374.192868] Dynamic subtest smem: SUCCESS (1.699s)
[374.212131] Subtest basic-S3: SUCCESS (1.699s)
[379.579842] [170/171] (713s left) kms_chamelium_hpd (common-hpd-after-suspend)
[379.767410] Subtest common-hpd-after-suspend: SKIP (0.000s)
[379.891240] [171/171] (713s left) kms_pipe_crc_basic (suspend-read-crc)
[380.057030] Starting subtest: suspend-read-crc
[380.076187] Starting dynamic subtest: pipe-A-VGA-1
[399.343793] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.772s)
[399.369534] Starting dynamic subtest: pipe-B-VGA-1
[418.367094] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.804s)
[418.392859] Starting dynamic subtest: pipe-C-VGA-1
[437.361659] Dynamic subtest pipe-C-VGA-1: SUCCESS (1.793s)
[437.382062] Subtest suspend-read-crc: SUCCESS (5.376s)
[440.488650] Closing watchdogs
Done.