[69.751524] Initializing watchdogs
[69.751665]   /dev/watchdog0
[69.761315] [001/160] (960s left) i915_module_load (load)
[69.858565] Starting subtest: load
[74.065306] Subtest load: SUCCESS (4.207s)
[74.089219] [002/160] (956s left) core_auth (basic-auth)
[74.194480] Starting subtest: basic-auth
[74.196889] Subtest basic-auth: SUCCESS (0.002s)
[74.300294] [003/160] (956s left) debugfs_test (read_all_entries)
[74.410539] Starting subtest: read_all_entries
[74.503613] Subtest read_all_entries: SUCCESS (0.092s)
[74.618648] [004/160] (955s left) debugfs_test (basic-hwmon)
[74.726684] Starting subtest: basic-hwmon
[74.728882] Subtest basic-hwmon: SKIP (0.000s)
[74.832312] [005/160] (955s left) fbdev (eof)
[74.952397] Starting subtest: eof
[74.953872] Subtest eof: SUCCESS (0.001s)
[75.022975] [006/160] (955s left) fbdev (info)
[75.124258] Starting subtest: info
[75.125622] Subtest info: SUCCESS (0.000s)
[75.203552] [007/160] (955s left) fbdev (nullptr)
[75.316917] Starting subtest: nullptr
[75.318502] Subtest nullptr: SUCCESS (0.000s)
[75.385810] [008/160] (955s left) fbdev (read)
[75.484323] Starting subtest: read
[82.592319] Subtest read: SUCCESS (7.073s)
[82.622869] [009/160] (947s left) fbdev (write)
[82.724647] Starting subtest: write
[86.505625] Subtest write: SUCCESS (3.746s)
[86.546737] [010/160] (943s left) gem_basic (bad-close)
[86.649612] Starting subtest: bad-close
[86.652735] Subtest bad-close: SUCCESS (0.000s)
[86.727589] [011/160] (943s left) gem_basic (create-close)
[86.827992] Starting subtest: create-close
[86.830317] Subtest create-close: SUCCESS (0.000s)
[86.928578] [012/160] (943s left) gem_basic (create-fd-close)
[87.030652] Starting subtest: create-fd-close
[87.033276] Subtest create-fd-close: SUCCESS (0.000s)
[87.129906] [013/160] (943s left) gem_busy (busy@all-engines)
[87.250851] Starting subtest: busy
[87.252080] Starting dynamic subtest: all-engines
[87.318232] Dynamic subtest all-engines: SUCCESS (0.067s)
[87.319388] Subtest busy: SUCCESS (0.068s)
[87.701499] [014/160] (942s left) gem_close_race (basic-process)
[87.824655] Starting subtest: basic-process
[87.885143] Subtest basic-process: SUCCESS (0.060s)
[88.086158] [015/160] (942s left) gem_close_race (basic-threads)
[88.216413] Starting subtest: basic-threads
[89.432803] Subtest basic-threads: SUCCESS (1.218s)
[89.653427] [016/160] (940s left) gem_ctx_create (basic)
[89.771378] Starting subtest: basic
[89.772515] Subtest basic: SUCCESS (0.000s)
[89.971700] [017/160] (940s left) gem_ctx_create (basic-files)
[90.083075] Starting subtest: basic-files
[92.108911] Subtest basic-files: SUCCESS (2.026s)
[92.349102] [018/160] (938s left) gem_ctx_exec (basic)
[92.461332] Starting subtest: basic
[92.467576] Subtest basic: SUCCESS (0.006s)
[92.589290] [019/160] (938s left) gem_exec_basic (basic)
[92.699497] Starting subtest: basic
[92.700827] Starting dynamic subtest: rcs0-smem
[92.702024] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[92.714193] Starting dynamic subtest: bcs0-smem
[92.715484] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[92.725959] Starting dynamic subtest: vcs0-smem
[92.727357] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[92.737937] Starting dynamic subtest: vecs0-smem
[92.739376] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[92.740568] Subtest basic: SUCCESS (0.007s)
[92.906793] [020/160] (937s left) gem_exec_create (basic)
[93.029205] Starting subtest: basic
[93.030365] Starting dynamic subtest: smem
[95.091918] Dynamic subtest smem: SUCCESS (2.040s)
[95.093713] Subtest basic: SUCCESS (2.040s)
[95.306916] [021/160] (935s left) gem_exec_fence (basic-busy)
[95.560859] Starting subtest: basic-busy
[95.562165] Starting dynamic subtest: rcs0
[95.576842] Dynamic subtest rcs0: SUCCESS (0.024s)
[95.588219] Starting dynamic subtest: bcs0
[95.604103] Dynamic subtest bcs0: SUCCESS (0.027s)
[95.615562] Starting dynamic subtest: vcs0
[95.630686] Dynamic subtest vcs0: SUCCESS (0.026s)
[95.642799] Starting dynamic subtest: vecs0
[95.654034] Dynamic subtest vecs0: SUCCESS (0.023s)
[95.655307] Subtest basic-busy: SUCCESS (0.101s)
[96.263142] [022/160] (934s left) gem_exec_fence (basic-wait)
[96.526095] Starting subtest: basic-wait
[96.527395] Starting dynamic subtest: rcs0
[96.548327] Dynamic subtest rcs0: SUCCESS (0.030s)
[96.561496] Starting dynamic subtest: bcs0
[96.577121] Dynamic subtest bcs0: SUCCESS (0.028s)
[96.591916] Starting dynamic subtest: vcs0
[96.610399] Dynamic subtest vcs0: SUCCESS (0.033s)
[96.625189] Starting dynamic subtest: vecs0
[96.649488] Dynamic subtest vecs0: SUCCESS (0.036s)
[96.651502] Subtest basic-wait: SUCCESS (0.130s)
[97.199643] [023/160] (933s left) gem_exec_fence (basic-await)
[97.461180] Starting subtest: basic-await
[97.462381] Starting dynamic subtest: rcs0
[97.552186] Dynamic subtest rcs0: SUCCESS (0.098s)
[97.573220] Starting dynamic subtest: bcs0
[97.658171] Dynamic subtest bcs0: SUCCESS (0.105s)
[97.684991] Starting dynamic subtest: vcs0
[97.794525] Dynamic subtest vcs0: SUCCESS (0.127s)
[97.821331] Starting dynamic subtest: vecs0
[97.914927] Dynamic subtest vecs0: SUCCESS (0.128s)
[97.917204] Subtest basic-await: SUCCESS (0.462s)
[98.498508] [024/160] (932s left) gem_exec_fence (nb-await)
[98.755471] Starting subtest: nb-await
[98.756600] Starting dynamic subtest: rcs0
[98.815680] Dynamic subtest rcs0: SUCCESS (0.066s)
[98.833689] Starting dynamic subtest: bcs0
[98.884944] Dynamic subtest bcs0: SUCCESS (0.069s)
[98.908695] Starting dynamic subtest: vcs0
[98.962300] Dynamic subtest vcs0: SUCCESS (0.076s)
[98.990232] Starting dynamic subtest: vecs0
[99.037930] Dynamic subtest vecs0: SUCCESS (0.076s)
[99.040083] Subtest nb-await: SUCCESS (0.291s)
[99.616674] [025/160] (931s left) gem_exec_gttfill (basic)
[99.728953] Starting subtest: basic
[105.785384] Subtest basic: SUCCESS (6.048s)
[105.972060] [026/160] (924s left) gem_exec_parallel (engines)
[106.205592] Starting subtest: engines
[106.206872] Starting dynamic subtest: basic
[108.720160] Dynamic subtest basic: SUCCESS (2.495s)
[108.733444] Starting dynamic subtest: contexts
[116.092485] Dynamic subtest contexts: SUCCESS (7.385s)
[116.105823] Starting dynamic subtest: fds
[129.917214] Dynamic subtest fds: SUCCESS (13.832s)
[129.938743] Starting dynamic subtest: userptr
[132.525689] Dynamic subtest userptr: SUCCESS (2.583s)
[132.527686] Subtest engines: SUCCESS (26.296s)
[132.733335] [027/160] (898s left) gem_exec_store (basic)
[132.852861] Starting subtest: basic
[132.932983] Subtest basic: SUCCESS (0.080s)
[133.135745] [028/160] (897s left) gem_flink_basic (bad-flink)
[133.236634] Starting subtest: bad-flink
[133.237799] Subtest bad-flink: SUCCESS (0.000s)
[133.334660] [029/160] (897s left) gem_flink_basic (bad-open)
[133.431548] Starting subtest: bad-open
[133.432700] Subtest bad-open: SUCCESS (0.000s)
[133.517918] [030/160] (897s left) gem_flink_basic (basic)
[133.617527] Starting subtest: basic
[133.618725] Subtest basic: SUCCESS (0.000s)
[133.718142] [031/160] (897s left) gem_flink_basic (double-flink)
[133.813467] Starting subtest: double-flink
[133.814869] Subtest double-flink: SUCCESS (0.000s)
[133.917323] [032/160] (897s left) gem_flink_basic (flink-lifetime)
[134.014975] Starting subtest: flink-lifetime
[134.017510] Subtest flink-lifetime: SUCCESS (0.003s)
[134.114151] [033/160] (897s left) gem_huc_copy (huc-copy)
[134.219274] Starting subtest: huc-copy
[134.221722] Subtest huc-copy: SKIP (0.000s)
[134.318899] [034/160] (896s left) gem_linear_blits (basic)
[134.570422] Starting subtest: basic
[134.587281] Subtest basic: SUCCESS (0.017s)
[134.721706] [035/160] (896s left) gem_mmap (basic)
[134.885826] Starting subtest: basic
[134.891120] Subtest basic: SUCCESS (0.001s)
[134.986305] [036/160] (896s left) gem_mmap_gtt (basic)
[135.090533] Starting subtest: basic
[135.093017] Subtest basic: SUCCESS (0.002s)
[135.197058] [037/160] (896s left) gem_render_linear_blits (basic)
[135.303284] Starting subtest: basic
[135.355851] Subtest basic: SUCCESS (0.053s)
[135.411941] [038/160] (895s left) gem_render_tiled_blits (basic)
[135.517925] Starting subtest: basic
[135.580036] Subtest basic: SUCCESS (0.061s)
[135.645461] [039/160] (895s left) gem_ringfill (basic-all)
[135.906260] Starting subtest: basic-all
[137.167564] Subtest basic-all: SUCCESS (1.251s)
[137.257834] [040/160] (894s left) gem_softpin (allocator-basic)
[137.365363] Starting subtest: allocator-basic
[137.537594] Subtest allocator-basic: SUCCESS (0.164s)
[137.657899] [041/160] (893s left) gem_softpin (allocator-basic-reserve)
[137.763240] Starting subtest: allocator-basic-reserve
[137.934770] Subtest allocator-basic-reserve: SUCCESS (0.163s)
[138.057536] [042/160] (893s left) gem_softpin (safe-alignment)
[138.171159] Starting subtest: safe-alignment
[138.190472] Subtest safe-alignment: SUCCESS (0.019s)
[138.326027] [043/160] (893s left) gem_sync (basic-all)
[138.440555] Starting subtest: basic-all
[141.082435] Subtest basic-all: SUCCESS (2.617s)
[141.273526] [044/160] (890s left) gem_sync (basic-each)
[141.390639] Starting subtest: basic-each
[143.632213] Subtest basic-each: SUCCESS (2.241s)
[143.859133] [045/160] (887s left) gem_tiled_blits (basic)
[144.080553] Starting subtest: basic
[144.110807] Subtest basic: SUCCESS (0.031s)
[144.248413] [046/160] (887s left) gem_tiled_fence_blits (basic)
[144.553394] Starting subtest: basic
[144.582543] Subtest basic: SUCCESS (0.029s)
[144.712022] [047/160] (886s left) gem_tiled_pread_basic
[145.247384] [048/160] (886s left) gem_wait (busy@all-engines)
[145.374659] Starting subtest: busy
[145.375922] Starting dynamic subtest: all-engines
[145.904054] Dynamic subtest all-engines: SUCCESS (0.530s)
[145.905214] Subtest busy: SUCCESS (0.531s)
[146.150051] [049/160] (885s left) gem_wait (wait@all-engines)
[146.275799] Starting subtest: wait
[146.277093] Starting dynamic subtest: all-engines
[147.309021] Dynamic subtest all-engines: SUCCESS (1.032s)
[147.310141] Subtest wait: SUCCESS (1.032s)
[147.551334] [050/160] (884s left) i915_getparams_basic (basic-eu-total)
[147.647382] Starting subtest: basic-eu-total
[147.649477] Subtest basic-eu-total: SUCCESS (0.000s)
[147.750349] [051/160] (883s left) i915_getparams_basic (basic-subslice-total)
[147.851806] Starting subtest: basic-subslice-total
[147.853972] Subtest basic-subslice-total: SUCCESS (0.000s)
[147.949111] [052/160] (883s left) i915_hangman (error-state-basic)
[148.060522] Starting subtest: error-state-basic
[148.073955] Subtest error-state-basic: SUCCESS (0.013s)
[148.166481] [053/160] (883s left) i915_pciid
[148.349759] [054/160] (883s left) kms_addfb_basic (addfb25-4-tiled)
[148.487530] Starting subtest: addfb25-4-tiled
[148.488690] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[148.583566] [055/160] (883s left) kms_addfb_basic (addfb25-bad-modifier)
[148.698471] Starting subtest: addfb25-bad-modifier
[148.699998] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[148.836310] [056/160] (882s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[148.938819] Starting subtest: addfb25-framebuffer-vs-set-tiling
[148.939909] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[149.069162] [057/160] (882s left) kms_addfb_basic (addfb25-modifier-no-flag)
[149.168913] Starting subtest: addfb25-modifier-no-flag
[149.170024] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[149.303602] [058/160] (882s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[149.404074] Starting subtest: addfb25-x-tiled-legacy
[149.405275] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[149.534267] [059/160] (882s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[149.638904] Starting subtest: addfb25-x-tiled-mismatch-legacy
[149.639966] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[149.770284] [060/160] (882s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[149.911544] Starting subtest: addfb25-yf-tiled-legacy
[149.912732] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[150.016156] [061/160] (881s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[150.143547] Starting subtest: addfb25-y-tiled-legacy
[150.144685] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[150.255991] [062/160] (881s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[150.387844] Starting subtest: addfb25-y-tiled-small-legacy
[150.388925] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[150.501663] [063/160] (881s left) kms_addfb_basic (bad-pitch-0)
[150.601809] Starting subtest: bad-pitch-0
[150.602895] Subtest bad-pitch-0: SUCCESS (0.000s)
[150.738561] [064/160] (881s left) kms_addfb_basic (bad-pitch-1024)
[150.838117] Starting subtest: bad-pitch-1024
[150.839258] Subtest bad-pitch-1024: SUCCESS (0.000s)
[150.965722] [065/160] (881s left) kms_addfb_basic (bad-pitch-128)
[151.063766] Starting subtest: bad-pitch-128
[151.064900] Subtest bad-pitch-128: SUCCESS (0.000s)
[151.181466] [066/160] (880s left) kms_addfb_basic (bad-pitch-256)
[151.280534] Starting subtest: bad-pitch-256
[151.281635] Subtest bad-pitch-256: SUCCESS (0.000s)
[151.402235] [067/160] (880s left) kms_addfb_basic (bad-pitch-32)
[151.499797] Starting subtest: bad-pitch-32
[151.501656] Subtest bad-pitch-32: SUCCESS (0.000s)
[151.638593] [068/160] (880s left) kms_addfb_basic (bad-pitch-63)
[151.740766] Starting subtest: bad-pitch-63
[151.741978] Subtest bad-pitch-63: SUCCESS (0.000s)
[151.872371] [069/160] (880s left) kms_addfb_basic (bad-pitch-65536)
[151.973838] Starting subtest: bad-pitch-65536
[151.975077] Subtest bad-pitch-65536: SUCCESS (0.000s)
[152.105758] [070/160] (880s left) kms_addfb_basic (bad-pitch-999)
[152.200502] Starting subtest: bad-pitch-999
[152.201610] Subtest bad-pitch-999: SUCCESS (0.000s)
[152.315115] [071/160] (879s left) kms_addfb_basic (basic)
[152.414146] Starting subtest: basic
[152.415174] Subtest basic: SUCCESS (0.000s)
[152.555844] [072/160] (879s left) kms_addfb_basic (basic-x-tiled-legacy)
[152.650600] Starting subtest: basic-x-tiled-legacy
[152.651792] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[152.772324] [073/160] (879s left) kms_addfb_basic (basic-y-tiled-legacy)
[152.874845] Starting subtest: basic-y-tiled-legacy
[152.876053] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[153.006334] [074/160] (879s left) kms_addfb_basic (bo-too-small)
[153.135568] Starting subtest: bo-too-small
[153.136758] Subtest bo-too-small: SUCCESS (0.000s)
[153.222037] [075/160] (879s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[153.344151] Starting subtest: bo-too-small-due-to-tiling
[153.345387] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[153.432883] [076/160] (878s left) kms_addfb_basic (clobberred-modifier)
[153.530595] Starting subtest: clobberred-modifier
[153.531698] Subtest clobberred-modifier: SUCCESS (0.000s)
[153.675414] [077/160] (878s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[153.778088] Starting subtest: framebuffer-vs-set-tiling
[153.779204] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[153.906866] [078/160] (878s left) kms_addfb_basic (invalid-get-prop)
[154.002631] Starting subtest: invalid-get-prop
[154.003687] Subtest invalid-get-prop: SUCCESS (0.000s)
[154.123154] [079/160] (878s left) kms_addfb_basic (invalid-get-prop-any)
[154.223702] Starting subtest: invalid-get-prop-any
[154.224777] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[154.360609] [080/160] (878s left) kms_addfb_basic (invalid-set-prop)
[154.464746] Starting subtest: invalid-set-prop
[154.465866] Subtest invalid-set-prop: SUCCESS (0.000s)
[154.590115] [081/160] (877s left) kms_addfb_basic (invalid-set-prop-any)
[154.686787] Starting subtest: invalid-set-prop-any
[154.688045] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[154.824583] [082/160] (877s left) kms_addfb_basic (no-handle)
[154.925545] Starting subtest: no-handle
[154.926640] Subtest no-handle: SUCCESS (0.000s)
[155.058475] [083/160] (877s left) kms_addfb_basic (size-max)
[155.188817] Starting subtest: size-max
[155.189994] Subtest size-max: SUCCESS (0.000s)
[155.291988] [084/160] (877s left) kms_addfb_basic (small-bo)
[155.423485] Starting subtest: small-bo
[155.424701] Subtest small-bo: SUCCESS (0.000s)
[155.527768] [085/160] (877s left) kms_addfb_basic (tile-pitch-mismatch)
[155.630190] Starting subtest: tile-pitch-mismatch
[155.631387] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[155.757243] [086/160] (876s left) kms_addfb_basic (too-high)
[155.883545] Starting subtest: too-high
[155.884809] Subtest too-high: SUCCESS (0.001s)
[155.990866] [087/160] (876s left) kms_addfb_basic (too-wide)
[156.125490] Starting subtest: too-wide
[156.126724] Subtest too-wide: SUCCESS (0.000s)
[156.225767] [088/160] (876s left) kms_addfb_basic (unused-handle)
[156.325612] Starting subtest: unused-handle
[156.326757] Subtest unused-handle: SUCCESS (0.000s)
[156.459895] [089/160] (876s left) kms_addfb_basic (unused-modifier)
[156.556449] Starting subtest: unused-modifier
[156.557575] Subtest unused-modifier: SUCCESS (0.000s)
[156.688796] [090/160] (876s left) kms_addfb_basic (unused-offsets)
[156.790630] Starting subtest: unused-offsets
[156.792164] Subtest unused-offsets: SUCCESS (0.000s)
[156.925494] [091/160] (875s left) kms_addfb_basic (unused-pitches)
[157.022447] Starting subtest: unused-pitches
[157.023539] Subtest unused-pitches: SUCCESS (0.000s)
[157.139640] [092/160] (875s left) kms_busy (basic)
[157.280780] Starting subtest: basic
[157.282039] Starting dynamic subtest: flip
[158.274353] Dynamic subtest flip: SUCCESS (0.992s)
[158.290753] Starting dynamic subtest: modeset
[162.146935] Dynamic subtest modeset: SUCCESS (3.870s)
[162.148373] Subtest basic: SUCCESS (4.865s)
[163.120277] [093/160] (869s left) kms_prop_blob (basic)
[163.219158] Starting subtest: basic
[163.220303] Subtest basic: SUCCESS (0.000s)
[163.323682] [094/160] (869s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[163.459123] Starting subtest: basic-busy-flip-before-cursor-atomic
[163.461471] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[163.553896] [095/160] (869s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[163.683386] Starting subtest: basic-busy-flip-before-cursor-legacy
[163.685892] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[163.770342] [096/160] (869s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[163.893224] Starting subtest: basic-flip-after-cursor-atomic
[165.199485] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.306s)
[166.125272] [097/160] (866s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[166.249836] Starting subtest: basic-flip-after-cursor-legacy
[167.555561] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.305s)
[168.493501] [098/160] (864s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[168.621630] Starting subtest: basic-flip-after-cursor-varying-size
[169.888288] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.266s)
[170.860196] [099/160] (862s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[170.996023] Starting subtest: basic-flip-before-cursor-atomic
[172.307035] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.311s)
[173.227456] [100/160] (859s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[173.352339] Starting subtest: basic-flip-before-cursor-legacy
[174.656807] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.306s)
[175.588839] [101/160] (857s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[175.722843] Starting subtest: basic-flip-before-cursor-varying-size
[177.039341] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.316s)
[177.969998] [102/160] (855s left) kms_dsc (dsc-basic)
[178.094907] Starting subtest: dsc-basic
[178.097320] Subtest dsc-basic: SKIP (0.001s)
[178.179328] [103/160] (854s left) kms_flip (basic-flip-vs-dpms)
[178.314347] Starting subtest: basic-flip-vs-dpms
[178.317691] Starting dynamic subtest: A-eDP1
[181.171275] Dynamic subtest A-eDP1: SUCCESS (2.853s)
[181.188492] Starting dynamic subtest: B-eDP1
[183.605286] Dynamic subtest B-eDP1: SUCCESS (2.433s)
[183.622913] Starting dynamic subtest: C-eDP1
[186.035482] Dynamic subtest C-eDP1: SUCCESS (2.430s)
[186.039334] Subtest basic-flip-vs-dpms: SUCCESS (7.725s)
[186.955432] [104/160] (846s left) kms_flip (basic-flip-vs-modeset)
[187.088946] Starting subtest: basic-flip-vs-modeset
[187.092123] Starting dynamic subtest: A-eDP1
[189.999724] Dynamic subtest A-eDP1: SUCCESS (2.907s)
[190.017030] Starting dynamic subtest: B-eDP1
[192.419185] Dynamic subtest B-eDP1: SUCCESS (2.417s)
[192.435172] Starting dynamic subtest: C-eDP1
[194.785530] Dynamic subtest C-eDP1: SUCCESS (2.367s)
[194.788148] Subtest basic-flip-vs-modeset: SUCCESS (7.700s)
[195.758358] [105/160] (837s left) kms_flip (basic-flip-vs-wf_vblank)
[195.883323] Starting subtest: basic-flip-vs-wf_vblank
[195.886299] Starting dynamic subtest: A-eDP1
[198.219608] Dynamic subtest A-eDP1: SUCCESS (2.332s)
[198.237892] Starting dynamic subtest: B-eDP1
[200.504328] Dynamic subtest B-eDP1: SUCCESS (2.283s)
[200.522834] Starting dynamic subtest: C-eDP1
[202.750294] Dynamic subtest C-eDP1: SUCCESS (2.243s)
[202.754628] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.872s)
[204.078738] [106/160] (829s left) kms_flip (basic-plain-flip)
[204.207334] Starting subtest: basic-plain-flip
[204.210647] Starting dynamic subtest: A-eDP1
[206.255857] Dynamic subtest A-eDP1: SUCCESS (2.044s)
[206.275407] Starting dynamic subtest: B-eDP1
[208.224649] Dynamic subtest B-eDP1: SUCCESS (1.964s)
[208.241428] Starting dynamic subtest: C-eDP1
[210.206340] Dynamic subtest C-eDP1: SUCCESS (1.981s)
[210.212763] Subtest basic-plain-flip: SUCCESS (6.006s)
[211.566167] [107/160] (821s left) kms_force_connector_basic (force-connector-state)
[211.666855] Starting subtest: force-connector-state
[212.256479] Subtest force-connector-state: SUCCESS (0.590s)
[213.344192] [108/160] (819s left) kms_force_connector_basic (force-edid)
[213.448522] Starting subtest: force-edid
[213.709844] Subtest force-edid: SUCCESS (0.261s)
[213.839267] [109/160] (819s left) kms_force_connector_basic (force-load-detect)
[213.942783] Starting subtest: force-load-detect
[213.945130] Subtest force-load-detect: SKIP (0.000s)
[214.077878] [110/160] (819s left) kms_force_connector_basic (prune-stale-modes)
[214.182645] Starting subtest: prune-stale-modes
[214.501625] Subtest prune-stale-modes: SUCCESS (0.319s)
[214.644603] [111/160] (818s left) kms_frontbuffer_tracking (basic)
[214.784530] Starting subtest: basic
[218.507919] Subtest basic: SUCCESS (3.722s)
[218.650187] [112/160] (814s left) kms_hdmi_inject (inject-audio)
[219.064424] Starting subtest: inject-audio
[219.314988] Subtest inject-audio: SUCCESS (0.247s)
[220.346991] [113/160] (813s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[220.481513] Starting subtest: compare-crc-sanitycheck-xr24
[220.484489] Starting dynamic subtest: pipe-A-eDP-1
[221.195811] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[221.213832] Starting dynamic subtest: pipe-B-eDP-1
[222.584993] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.389s)
[222.606249] Starting dynamic subtest: pipe-C-eDP-1
[223.970437] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.379s)
[223.971622] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.488s)
[224.940243] [114/160] (808s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[225.074552] Starting subtest: compare-crc-sanitycheck-nv12
[225.077398] Starting dynamic subtest: pipe-A-eDP-1
[226.018021] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.941s)
[226.039121] Starting dynamic subtest: pipe-B-eDP-1
[227.421270] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.400s)
[227.440422] Starting dynamic subtest: pipe-C-eDP-1
[228.821533] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.397s)
[228.822741] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.748s)
[229.743317] [115/160] (803s left) kms_pipe_crc_basic (hang-read-crc)
[229.873273] Starting subtest: hang-read-crc
[229.874539] Starting dynamic subtest: pipe-A-eDP-1
[232.306307] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.431s)
[232.324605] Starting dynamic subtest: pipe-B-eDP-1
[235.373126] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.064s)
[235.391604] Starting dynamic subtest: pipe-C-eDP-1
[238.367351] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.991s)
[238.368641] Subtest hang-read-crc: SUCCESS (8.496s)
[239.340597] [116/160] (794s left) kms_pipe_crc_basic (nonblocking-crc)
[239.474516] Starting subtest: nonblocking-crc
[239.475842] Starting dynamic subtest: pipe-A-eDP-1
[240.369193] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.892s)
[240.387409] Starting dynamic subtest: pipe-B-eDP-1
[241.968541] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.596s)
[241.986831] Starting dynamic subtest: pipe-C-eDP-1
[243.511962] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.541s)
[243.513181] Subtest nonblocking-crc: SUCCESS (4.039s)
[244.467335] [117/160] (789s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[244.599476] Starting subtest: nonblocking-crc-frame-sequence
[244.600630] Starting dynamic subtest: pipe-A-eDP-1
[245.489687] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.888s)
[245.508082] Starting dynamic subtest: pipe-B-eDP-1
[247.089290] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.597s)
[247.107840] Starting dynamic subtest: pipe-C-eDP-1
[248.640392] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.546s)
[248.641469] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.041s)
[249.578776] [118/160] (783s left) kms_pipe_crc_basic (read-crc)
[249.714673] Starting subtest: read-crc
[249.717945] Starting dynamic subtest: pipe-A-eDP-1
[250.542352] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.825s)
[250.561464] Starting dynamic subtest: pipe-B-eDP-1
[252.095710] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.549s)
[252.114370] Starting dynamic subtest: pipe-C-eDP-1
[253.617674] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.517s)
[253.619027] Subtest read-crc: SUCCESS (3.902s)
[254.574895] [119/160] (778s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[254.700885] Starting subtest: read-crc-frame-sequence
[254.703894] Starting dynamic subtest: pipe-A-eDP-1
[255.536737] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.833s)
[255.555627] Starting dynamic subtest: pipe-B-eDP-1
[257.087748] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.546s)
[257.108187] Starting dynamic subtest: pipe-C-eDP-1
[258.584724] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.492s)
[258.585960] Subtest read-crc-frame-sequence: SUCCESS (3.883s)
[259.505674] [120/160] (774s left) kms_pm_backlight (basic-brightness)
[259.634465] Starting subtest: basic-brightness
[259.733468] Starting dynamic subtest: eDP-1
[260.319818] Dynamic subtest eDP-1: SUCCESS (0.586s)
[260.321074] Subtest basic-brightness: SUCCESS (0.685s)
[261.296240] [121/160] (772s left) kms_pm_rpm (basic-pci-d3-state)
[263.129154] Starting subtest: basic-pci-d3-state
[267.524422] Subtest basic-pci-d3-state: SUCCESS (4.396s)
[267.732357] [122/160] (765s left) kms_pm_rpm (basic-rte)
[267.820185] Starting subtest: basic-rte
[273.994137] Subtest basic-rte: SUCCESS (6.172s)
[275.519151] [123/160] (758s left) kms_psr (psr-primary-page-flip)
[275.654344] Starting subtest: psr-primary-page-flip
[275.655622] Starting dynamic subtest: eDP-1
[279.504924] Dynamic subtest eDP-1: SUCCESS (3.849s)
[279.506236] Subtest psr-primary-page-flip: SUCCESS (3.852s)
[280.430667] [124/160] (753s left) kms_psr (psr-cursor-plane-move)
[280.558587] Starting subtest: psr-cursor-plane-move
[280.559777] Starting dynamic subtest: eDP-1
[284.344329] Dynamic subtest eDP-1: SUCCESS (3.783s)
[284.345438] Subtest psr-cursor-plane-move: SUCCESS (3.786s)
[285.295209] [125/160] (748s left) kms_psr (psr-sprite-plane-onoff)
[285.432394] Starting subtest: psr-sprite-plane-onoff
[285.433769] Starting dynamic subtest: eDP-1
[289.298076] Dynamic subtest eDP-1: SUCCESS (3.862s)
[289.299339] Subtest psr-sprite-plane-onoff: SUCCESS (3.865s)
[290.223877] [126/160] (743s left) kms_psr (psr-primary-mmap-gtt)
[290.355405] Starting subtest: psr-primary-mmap-gtt
[290.356591] Starting dynamic subtest: eDP-1
[294.198463] Dynamic subtest eDP-1: SUCCESS (3.843s)
[294.199609] Subtest psr-primary-mmap-gtt: SUCCESS (3.845s)
[295.150660] [127/160] (738s left) kms_setmode (basic-clone-single-crtc)
[295.249209] Starting subtest: basic-clone-single-crtc
[295.252681] Subtest basic-clone-single-crtc: SKIP (0.000s)
[295.350607] [128/160] (738s left) i915_pm_rps (basic-api)
[295.464860] Starting subtest: basic-api
[295.469882] Subtest basic-api: SUCCESS (0.005s)
[295.568990] [129/160] (738s left) prime_self_import (basic-llseek-bad)
[295.656021] Starting subtest: basic-llseek-bad
[295.669518] Subtest basic-llseek-bad: SUCCESS (0.013s)
[295.769643] [130/160] (738s left) prime_self_import (basic-llseek-size)
[295.855954] Starting subtest: basic-llseek-size
[295.865445] Subtest basic-llseek-size: SUCCESS (0.010s)
[295.969201] [131/160] (737s left) prime_self_import (basic-with_fd_dup)
[296.054895] Starting subtest: basic-with_fd_dup
[296.072373] Subtest basic-with_fd_dup: SUCCESS (0.017s)
[296.189074] [132/160] (737s left) prime_self_import (basic-with_one_bo)
[296.276469] Starting subtest: basic-with_one_bo
[296.295503] Subtest basic-with_one_bo: SUCCESS (0.021s)
[296.396715] [133/160] (737s left) prime_self_import (basic-with_one_bo_two_files)
[296.481436] Starting subtest: basic-with_one_bo_two_files
[296.491477] Subtest basic-with_one_bo_two_files: SUCCESS (0.009s)
[296.584911] [134/160] (737s left) prime_self_import (basic-with_two_bos)
[296.671939] Starting subtest: basic-with_two_bos
[296.693359] Subtest basic-with_two_bos: SUCCESS (0.023s)
[296.805547] [135/160] (737s left) prime_vgem (basic-fence-flip)
[296.935491] Starting subtest: basic-fence-flip
[297.459660] Subtest basic-fence-flip: SUCCESS (0.524s)
[297.590548] [136/160] (736s left) prime_vgem (basic-fence-mmap)
[297.710218] Starting subtest: basic-fence-mmap
[297.759369] Subtest basic-fence-mmap: SUCCESS (0.049s)
[297.853203] [137/160] (736s left) prime_vgem (basic-fence-read)
[297.976173] Starting subtest: basic-fence-read
[298.075430] Subtest basic-fence-read: SUCCESS (0.098s)
[298.172906] [138/160] (735s left) prime_vgem (basic-gtt)
[298.300787] Starting subtest: basic-gtt
[298.325629] Subtest basic-gtt: SUCCESS (0.025s)
[298.420965] [139/160] (735s left) prime_vgem (basic-read)
[298.527802] Starting subtest: basic-read
[298.576385] Subtest basic-read: SUCCESS (0.048s)
[298.688713] [140/160] (735s left) prime_vgem (basic-write)
[298.793789] Starting subtest: basic-write
[298.858995] Subtest basic-write: SUCCESS (0.065s)
[298.955418] [141/160] (735s left) vgem_basic (setversion)
[299.062578] Starting subtest: setversion
[299.064978] Subtest setversion: SUCCESS (0.000s)
[299.138672] [142/160] (735s left) vgem_basic (create)
[299.229736] Starting subtest: create
[299.230938] Subtest create: SUCCESS (0.000s)
[299.305263] [143/160] (734s left) vgem_basic (debugfs)
[299.413452] Starting subtest: debugfs
[299.414667] Subtest debugfs: SUCCESS (0.001s)
[299.489809] [144/160] (734s left) vgem_basic (dmabuf-export)
[299.578955] Starting subtest: dmabuf-export
[299.595508] Subtest dmabuf-export: SUCCESS (0.015s)
[299.691501] [145/160] (734s left) vgem_basic (dmabuf-fence)
[299.804157] Starting subtest: dmabuf-fence
[299.805757] Subtest dmabuf-fence: SUCCESS (0.002s)
[299.873713] [146/160] (734s left) vgem_basic (dmabuf-fence-before)
[299.980040] Starting subtest: dmabuf-fence-before
[299.981326] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[300.055849] [147/160] (734s left) vgem_basic (dmabuf-mmap)
[300.164035] Starting subtest: dmabuf-mmap
[300.188959] Subtest dmabuf-mmap: SUCCESS (0.025s)
[300.252821] [148/160] (734s left) vgem_basic (mmap)
[300.346950] Starting subtest: mmap
[300.364140] Subtest mmap: SUCCESS (0.017s)
[300.438260] [149/160] (734s left) vgem_basic (second-client)
[300.530638] Starting subtest: second-client
[300.569169] Subtest second-client: SUCCESS (0.034s)
[300.638590] [150/160] (733s left) vgem_basic (sysfs)
[300.731941] Starting subtest: sysfs
[300.733168] Subtest sysfs: SUCCESS (0.001s)
[300.808129] [151/160] (733s left) core_hotunplug (unbind-rebind)
[300.964185] Starting subtest: unbind-rebind
[307.067506] Subtest unbind-rebind: SUCCESS (6.103s)
[307.102734] [152/160] (727s left) vgem_basic (unload)
[307.197092] Starting subtest: unload
[336.258402] Subtest unload: SUCCESS (29.027s)
[336.376922] [153/160] (698s left) i915_module_load (reload)
[336.468922] Starting subtest: reload
[341.442370] Subtest reload: SUCCESS (4.973s)
[341.472469] [154/160] (693s left) gem_lmem_swapping (basic)
[341.581862] Subtest basic: SKIP (0.000s)
[341.626791] [155/160] (693s left) gem_lmem_swapping (parallel-random-engines)
[341.723095] Subtest parallel-random-engines: SKIP (0.000s)
[341.778681] [156/160] (692s left) gem_lmem_swapping (random-engines)
[341.878736] Subtest random-engines: SKIP (0.000s)
[341.928173] [157/160] (692s left) gem_lmem_swapping (verify-random)
[342.029389] Subtest verify-random: SKIP (0.000s)
[342.077867] [158/160] (692s left) i915_pm_rpm (module-reload)
[354.547063] Starting subtest: module-reload
[387.038307] Subtest module-reload: SUCCESS (32.483s)
[387.062272] [159/160] (647s left) i915_selftest (live)
[387.160839] Starting subtest: live
[387.162134] Starting dynamic subtest: sanitycheck
[390.611432] Dynamic subtest sanitycheck: SUCCESS (3.441s)
[390.622154] Starting dynamic subtest: uncore
[394.053238] Dynamic subtest uncore: SUCCESS (3.438s)
[394.063865] Starting dynamic subtest: workarounds
[397.758283] Dynamic subtest workarounds: SUCCESS (3.702s)
[397.769017] Starting dynamic subtest: gt_engines
[401.656752] Dynamic subtest gt_engines: SUCCESS (3.895s)
[401.667374] Starting dynamic subtest: gt_timelines
[417.116579] Dynamic subtest gt_timelines: SUCCESS (15.456s)
[417.127415] Starting dynamic subtest: gt_contexts
[420.664320] Dynamic subtest gt_contexts: SUCCESS (3.544s)
[420.674975] Starting dynamic subtest: gt_lrc
[426.019563] Dynamic subtest gt_lrc: SUCCESS (5.352s)
[426.030285] Starting dynamic subtest: gt_mocs
[429.571392] Dynamic subtest gt_mocs: SUCCESS (3.548s)
[429.582137] Starting dynamic subtest: gt_pm
[436.246486] Dynamic subtest gt_pm: SUCCESS (6.672s)
[436.257191] Starting dynamic subtest: gt_heartbeat
[439.810483] Dynamic subtest gt_heartbeat: SUCCESS (3.562s)
[439.821409] Starting dynamic subtest: gt_tlb
[444.400751] Dynamic subtest gt_tlb: SUCCESS (4.585s)
[444.411617] Starting dynamic subtest: requests
[453.690772] Dynamic subtest requests: SUCCESS (9.294s)
[453.706039] Starting dynamic subtest: migrate
[459.627584] Dynamic subtest migrate: SUCCESS (5.925s)
[459.638215] Starting dynamic subtest: active
[463.069453] Dynamic subtest active: SUCCESS (3.439s)
[463.080116] Starting dynamic subtest: objects
[467.763945] Dynamic subtest objects: SUCCESS (4.691s)
[467.775407] Starting dynamic subtest: mman
[476.278583] Dynamic subtest mman: SUCCESS (8.511s)
[476.289367] Starting dynamic subtest: dmabuf
[479.790203] Dynamic subtest dmabuf: SUCCESS (3.507s)
[479.801040] Starting dynamic subtest: vma
[483.219509] Dynamic subtest vma: SUCCESS (3.426s)
[483.230368] Starting dynamic subtest: coherency
[489.561260] Dynamic subtest coherency: SUCCESS (6.346s)
[489.574317] Starting dynamic subtest: gtt
[500.315884] Dynamic subtest gtt: SUCCESS (10.744s)
[500.326962] Starting dynamic subtest: gem
[503.894735] Dynamic subtest gem: SUCCESS (3.575s)
[503.905825] Starting dynamic subtest: evict
[508.970520] Dynamic subtest evict: SUCCESS (5.072s)
[508.981278] Starting dynamic subtest: hugepages
[518.348682] Dynamic subtest hugepages: SUCCESS (9.375s)
[518.359699] Starting dynamic subtest: gem_contexts
[536.626137] Dynamic subtest gem_contexts: SUCCESS (18.273s)
[536.637995] Starting dynamic subtest: client
[540.093634] Dynamic subtest client: SUCCESS (3.465s)
[540.104773] Starting dynamic subtest: gem_migrate
[543.561275] Dynamic subtest gem_migrate: SUCCESS (3.464s)
[543.572549] Starting dynamic subtest: reset
[550.533494] Dynamic subtest reset: SUCCESS (6.969s)
[550.544752] Starting dynamic subtest: memory_region
[553.983584] Dynamic subtest memory_region: SUCCESS (3.447s)
[553.994847] Starting dynamic subtest: hangcheck
[579.985822] Dynamic subtest hangcheck: SUCCESS (25.999s)
[579.997084] Starting dynamic subtest: execlists
[592.053625] Dynamic subtest execlists: SUCCESS (12.064s)
[592.064888] Starting dynamic subtest: ring_submission
[595.478765] Dynamic subtest ring_submission: SUCCESS (3.421s)
[595.490023] Starting dynamic subtest: perf
[598.995538] Dynamic subtest perf: SUCCESS (3.513s)
[599.006943] Starting dynamic subtest: slpc
[602.437354] Dynamic subtest slpc: SUCCESS (3.437s)
[602.449108] Starting dynamic subtest: guc
[605.903468] Dynamic subtest guc: SUCCESS (3.464s)
[605.914661] Starting dynamic subtest: guc_multi_lrc
[609.359560] Dynamic subtest guc_multi_lrc: SUCCESS (3.453s)
[609.370872] Starting dynamic subtest: guc_hang
[612.804641] Dynamic subtest guc_hang: SUCCESS (3.442s)
[612.815889] Starting dynamic subtest: late_gt_pm
[616.259728] Dynamic subtest late_gt_pm: SUCCESS (3.452s)
[616.261031] Subtest live: SUCCESS (229.092s)
[616.284349] [160/160] (418s left) dmabuf (all-tests)
[616.376717] Starting subtest: all-tests
[616.378327] Starting dynamic subtest: sanitycheck
[616.443988] Dynamic subtest sanitycheck: SUCCESS (0.065s)
[616.462229] Starting dynamic subtest: dma_fence
[616.632936] Dynamic subtest dma_fence: SUCCESS (0.185s)
[616.650838] Starting dynamic subtest: dma_fence_chain
[634.815217] Dynamic subtest dma_fence_chain: SUCCESS (18.170s)
[634.827917] Starting dynamic subtest: dma_fence_unwrap
[634.893865] Dynamic subtest dma_fence_unwrap: SUCCESS (0.083s)
[634.913721] Starting dynamic subtest: dma_resv
[634.967812] Dynamic subtest dma_resv: SUCCESS (0.070s)
[634.970066] Subtest all-tests: SUCCESS (18.592s)
[634.998656] Closing watchdogs
Done.