[45.433097] Initializing watchdogs
[45.433274]   /dev/watchdog0
[45.443416] [001/162] (960s left) i915_module_load (load)
[45.598134] Starting subtest: load
[48.149219] Subtest load: SUCCESS (2.552s)
[48.183160] [002/162] (957s left) core_auth (basic-auth)
[48.327430] Starting subtest: basic-auth
[48.328568] Subtest basic-auth: SUCCESS (0.001s)
[48.400518] [003/162] (957s left) debugfs_test (read_all_entries)
[48.554521] Starting subtest: read_all_entries
[48.633667] Subtest read_all_entries: SUCCESS (0.079s)
[48.747367] [004/162] (957s left) debugfs_test (basic-hwmon)
[48.893657] Starting subtest: basic-hwmon
[48.897322] Subtest basic-hwmon: SKIP (0.000s)
[49.025528] [005/162] (957s left) fbdev (eof)
[49.250026] Starting subtest: eof
[49.251210] Subtest eof: SUCCESS (0.001s)
[49.312797] [006/162] (956s left) fbdev (info)
[49.454232] Starting subtest: info
[49.455364] Subtest info: SUCCESS (0.000s)
[49.534313] [007/162] (956s left) fbdev (nullptr)
[49.682553] Starting subtest: nullptr
[49.683693] Subtest nullptr: SUCCESS (0.000s)
[49.751299] [008/162] (956s left) fbdev (read)
[49.899686] Starting subtest: read
[57.034457] Subtest read: SUCCESS (7.100s)
[57.085052] [009/162] (949s left) fbdev (write)
[57.250846] Starting subtest: write
[61.031855] Subtest write: SUCCESS (3.746s)
[61.065629] [010/162] (945s left) gem_basic (bad-close)
[61.201831] Starting subtest: bad-close
[61.204118] Subtest bad-close: SUCCESS (0.000s)
[61.281368] [011/162] (944s left) gem_basic (create-close)
[61.419082] Starting subtest: create-close
[61.421242] Subtest create-close: SUCCESS (0.000s)
[61.532155] [012/162] (944s left) gem_basic (create-fd-close)
[61.668416] Starting subtest: create-fd-close
[61.670524] Subtest create-fd-close: SUCCESS (0.000s)
[61.765142] [013/162] (944s left) gem_busy (busy@all-engines)
[61.921877] Starting subtest: busy
[61.923134] Starting dynamic subtest: all-engines
[61.987692] Dynamic subtest all-engines: SUCCESS (0.066s)
[61.988816] Subtest busy: SUCCESS (0.066s)
[62.383484] [014/162] (943s left) gem_close_race (basic-process)
[62.545454] Starting subtest: basic-process
[62.613375] Subtest basic-process: SUCCESS (0.069s)
[62.816581] [015/162] (943s left) gem_close_race (basic-threads)
[62.974933] Starting subtest: basic-threads
[64.131421] Subtest basic-threads: SUCCESS (1.156s)
[64.352222] [016/162] (941s left) gem_ctx_create (basic)
[64.515419] Starting subtest: basic
[64.516644] Subtest basic: SUCCESS (0.000s)
[64.717608] [017/162] (941s left) gem_ctx_create (basic-files)
[64.870544] Starting subtest: basic-files
[66.896704] Subtest basic-files: SUCCESS (2.026s)
[67.118055] [018/162] (939s left) gem_ctx_exec (basic)
[67.279274] Starting subtest: basic
[67.281687] Subtest basic: SUCCESS (0.005s)
[67.399155] [019/162] (939s left) gem_exec_basic (basic)
[67.546456] Starting subtest: basic
[67.547526] Starting dynamic subtest: rcs0-smem
[67.548581] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[67.559864] Starting dynamic subtest: bcs0-smem
[67.561355] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[67.571937] Starting dynamic subtest: vcs0-smem
[67.573339] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[67.583787] Starting dynamic subtest: vecs0-smem
[67.585103] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[67.586386] Subtest basic: SUCCESS (0.005s)
[67.749649] [020/162] (938s left) gem_exec_create (basic)
[67.906065] Starting subtest: basic
[67.907233] Starting dynamic subtest: smem
[69.980076] Dynamic subtest smem: SUCCESS (2.051s)
[69.981573] Subtest basic: SUCCESS (2.051s)
[70.168408] [021/162] (936s left) gem_exec_fence (basic-busy)
[70.490520] Starting subtest: basic-busy
[70.491871] Starting dynamic subtest: rcs0
[70.506449] Dynamic subtest rcs0: SUCCESS (0.025s)
[70.518257] Starting dynamic subtest: bcs0
[70.535067] Dynamic subtest bcs0: SUCCESS (0.028s)
[70.546503] Starting dynamic subtest: vcs0
[70.555280] Dynamic subtest vcs0: SUCCESS (0.020s)
[70.566256] Starting dynamic subtest: vecs0
[70.579390] Dynamic subtest vecs0: SUCCESS (0.024s)
[70.580498] Subtest basic-busy: SUCCESS (0.098s)
[71.184386] [022/162] (935s left) gem_exec_fence (basic-wait)
[71.486231] Starting subtest: basic-wait
[71.487495] Starting dynamic subtest: rcs0
[71.506824] Dynamic subtest rcs0: SUCCESS (0.029s)
[71.518846] Starting dynamic subtest: bcs0
[71.541101] Dynamic subtest bcs0: SUCCESS (0.033s)
[71.555440] Starting dynamic subtest: vcs0
[71.576179] Dynamic subtest vcs0: SUCCESS (0.035s)
[71.588887] Starting dynamic subtest: vecs0
[71.608489] Dynamic subtest vecs0: SUCCESS (0.032s)
[71.610082] Subtest basic-wait: SUCCESS (0.131s)
[72.154544] [023/162] (934s left) gem_exec_fence (basic-await)
[72.454243] Starting subtest: basic-await
[72.455516] Starting dynamic subtest: rcs0
[72.548425] Dynamic subtest rcs0: SUCCESS (0.101s)
[72.576134] Starting dynamic subtest: bcs0
[72.676289] Dynamic subtest bcs0: SUCCESS (0.127s)
[72.703249] Starting dynamic subtest: vcs0
[72.814808] Dynamic subtest vcs0: SUCCESS (0.129s)
[72.841584] Starting dynamic subtest: vecs0
[72.934346] Dynamic subtest vecs0: SUCCESS (0.127s)
[72.936351] Subtest basic-await: SUCCESS (0.488s)
[73.533874] [024/162] (933s left) gem_exec_fence (nb-await)
[73.834970] Starting subtest: nb-await
[73.836180] Starting dynamic subtest: rcs0
[73.893450] Dynamic subtest rcs0: SUCCESS (0.065s)
[73.911684] Starting dynamic subtest: bcs0
[73.962405] Dynamic subtest bcs0: SUCCESS (0.068s)
[73.989990] Starting dynamic subtest: vcs0
[74.038320] Dynamic subtest vcs0: SUCCESS (0.076s)
[74.065789] Starting dynamic subtest: vecs0
[74.113129] Dynamic subtest vecs0: SUCCESS (0.074s)
[74.115252] Subtest nb-await: SUCCESS (0.286s)
[74.683883] [025/162] (931s left) gem_exec_gttfill (basic)
[74.837915] Starting subtest: basic
[81.065425] Subtest basic: SUCCESS (6.219s)
[81.256128] [026/162] (925s left) gem_exec_parallel (engines)
[81.472065] Starting subtest: engines
[81.473269] Starting dynamic subtest: basic
[83.879646] Dynamic subtest basic: SUCCESS (2.382s)
[83.892640] Starting dynamic subtest: contexts
[87.171945] Dynamic subtest contexts: SUCCESS (3.308s)
[87.185558] Starting dynamic subtest: fds
[91.421328] Dynamic subtest fds: SUCCESS (4.234s)
[91.440851] Starting dynamic subtest: userptr
[94.027307] Dynamic subtest userptr: SUCCESS (2.612s)
[94.028852] Subtest engines: SUCCESS (12.538s)
[94.231332] [027/162] (912s left) gem_exec_store (basic)
[94.386954] Starting subtest: basic
[94.437051] Subtest basic: SUCCESS (0.050s)
[94.653598] [028/162] (912s left) gem_flink_basic (bad-flink)
[94.788668] Starting subtest: bad-flink
[94.789890] Subtest bad-flink: SUCCESS (0.000s)
[94.868805] [029/162] (911s left) gem_flink_basic (bad-open)
[95.006715] Starting subtest: bad-open
[95.007960] Subtest bad-open: SUCCESS (0.000s)
[95.085646] [030/162] (911s left) gem_flink_basic (basic)
[95.222272] Starting subtest: basic
[95.223473] Subtest basic: SUCCESS (0.000s)
[95.319060] [031/162] (911s left) gem_flink_basic (double-flink)
[95.456128] Starting subtest: double-flink
[95.457267] Subtest double-flink: SUCCESS (0.000s)
[95.552465] [032/162] (911s left) gem_flink_basic (flink-lifetime)
[95.690654] Starting subtest: flink-lifetime
[95.693373] Subtest flink-lifetime: SUCCESS (0.002s)
[95.802415] [033/162] (910s left) gem_huc_copy (huc-copy)
[95.943924] Starting subtest: huc-copy
[95.946542] Subtest huc-copy: SKIP (0.000s)
[96.052323] [034/162] (910s left) gem_linear_blits (basic)
[96.348033] Starting subtest: basic
[96.360224] Subtest basic: SUCCESS (0.012s)
[96.484927] [035/162] (910s left) gem_mmap (basic)
[96.681845] Starting subtest: basic
[96.687252] Subtest basic: SUCCESS (0.001s)
[96.785421] [036/162] (910s left) gem_mmap_gtt (basic)
[96.923126] Starting subtest: basic
[96.924384] Subtest basic: SUCCESS (0.001s)
[97.001216] [037/162] (909s left) gem_render_linear_blits (basic)
[97.143663] Starting subtest: basic
[97.195420] Subtest basic: SUCCESS (0.050s)
[97.268019] [038/162] (909s left) gem_render_tiled_blits (basic)
[97.413441] Starting subtest: basic
[97.471914] Subtest basic: SUCCESS (0.060s)
[97.534625] [039/162] (909s left) gem_ringfill (basic-all)
[97.813173] Starting subtest: basic-all
[99.024703] Subtest basic-all: SUCCESS (1.202s)
[99.103884] [040/162] (907s left) gem_softpin (allocator-basic)
[99.248444] Starting subtest: allocator-basic
[99.419584] Subtest allocator-basic: SUCCESS (0.162s)
[99.536987] [041/162] (907s left) gem_softpin (allocator-basic-reserve)
[99.696622] Starting subtest: allocator-basic-reserve
[99.867280] Subtest allocator-basic-reserve: SUCCESS (0.162s)
[99.985880] [042/162] (907s left) gem_softpin (safe-alignment)
[100.137607] Starting subtest: safe-alignment
[100.155273] Subtest safe-alignment: SUCCESS (0.018s)
[100.269050] [043/162] (906s left) gem_sync (basic-all)
[100.423759] Starting subtest: basic-all
[102.710888] Subtest basic-all: SUCCESS (2.262s)
[102.886556] [044/162] (904s left) gem_sync (basic-each)
[103.040050] Starting subtest: basic-each
[105.252546] Subtest basic-each: SUCCESS (2.211s)
[105.482190] [045/162] (901s left) gem_tiled_blits (basic)
[105.776748] Starting subtest: basic
[105.805407] Subtest basic: SUCCESS (0.029s)
[105.934935] [046/162] (901s left) gem_tiled_fence_blits (basic)
[106.310940] Starting subtest: basic
[106.338321] Subtest basic: SUCCESS (0.028s)
[106.468972] [047/162] (900s left) gem_tiled_pread_basic
[107.002831] [048/162] (900s left) gem_wait (busy@all-engines)
[107.183234] Starting subtest: busy
[107.184449] Starting dynamic subtest: all-engines
[107.711381] Dynamic subtest all-engines: SUCCESS (0.524s)
[107.712485] Subtest busy: SUCCESS (0.525s)
[107.969700] [049/162] (899s left) gem_wait (wait@all-engines)
[108.131664] Starting subtest: wait
[108.133122] Starting dynamic subtest: all-engines
[109.171146] Dynamic subtest all-engines: SUCCESS (1.037s)
[109.172226] Subtest wait: SUCCESS (1.037s)
[109.402960] [050/162] (897s left) i915_getparams_basic (basic-eu-total)
[109.537513] Starting subtest: basic-eu-total
[109.539750] Subtest basic-eu-total: SUCCESS (0.000s)
[109.619068] [051/162] (897s left) i915_getparams_basic (basic-subslice-total)
[109.761596] Starting subtest: basic-subslice-total
[109.763655] Subtest basic-subslice-total: SUCCESS (0.000s)
[109.835880] [052/162] (897s left) i915_hangman (error-state-basic)
[109.987437] Starting subtest: error-state-basic
[110.000234] Subtest error-state-basic: SUCCESS (0.013s)
[110.086492] [053/162] (897s left) i915_pciid
[110.302699] [054/162] (897s left) kms_addfb_basic (addfb25-bad-modifier)
[110.442115] Starting subtest: addfb25-bad-modifier
[110.443312] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[110.568628] [055/162] (896s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[110.706935] Starting subtest: addfb25-framebuffer-vs-set-tiling
[110.708346] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[110.835572] [056/162] (896s left) kms_addfb_basic (addfb25-modifier-no-flag)
[110.972735] Starting subtest: addfb25-modifier-no-flag
[110.974117] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[111.102674] [057/162] (896s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[111.240430] Starting subtest: addfb25-x-tiled-legacy
[111.241591] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[111.369087] [058/162] (896s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[111.507253] Starting subtest: addfb25-x-tiled-mismatch-legacy
[111.508342] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[111.635845] [059/162] (895s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[111.805451] Starting subtest: addfb25-yf-tiled-legacy
[111.806583] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[111.902610] [060/162] (895s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[112.068745] Starting subtest: addfb25-y-tiled-legacy
[112.069963] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[112.169285] [061/162] (895s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[112.336420] Starting subtest: addfb25-y-tiled-small-legacy
[112.337593] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[112.435456] [062/162] (895s left) kms_addfb_basic (bad-pitch-0)
[112.572873] Starting subtest: bad-pitch-0
[112.574094] Subtest bad-pitch-0: SUCCESS (0.000s)
[112.702420] [063/162] (894s left) kms_addfb_basic (bad-pitch-1024)
[112.840454] Starting subtest: bad-pitch-1024
[112.841527] Subtest bad-pitch-1024: SUCCESS (0.000s)
[112.969185] [064/162] (894s left) kms_addfb_basic (bad-pitch-128)
[113.109282] Starting subtest: bad-pitch-128
[113.110526] Subtest bad-pitch-128: SUCCESS (0.000s)
[113.236045] [065/162] (894s left) kms_addfb_basic (bad-pitch-256)
[113.373596] Starting subtest: bad-pitch-256
[113.374771] Subtest bad-pitch-256: SUCCESS (0.000s)
[113.502297] [066/162] (894s left) kms_addfb_basic (bad-pitch-32)
[113.641085] Starting subtest: bad-pitch-32
[113.642176] Subtest bad-pitch-32: SUCCESS (0.000s)
[113.769381] [067/162] (893s left) kms_addfb_basic (bad-pitch-63)
[113.912049] Starting subtest: bad-pitch-63
[113.913229] Subtest bad-pitch-63: SUCCESS (0.000s)
[114.035928] [068/162] (893s left) kms_addfb_basic (bad-pitch-65536)
[114.175401] Starting subtest: bad-pitch-65536
[114.176477] Subtest bad-pitch-65536: SUCCESS (0.000s)
[114.302308] [069/162] (893s left) kms_addfb_basic (bad-pitch-999)
[114.438604] Starting subtest: bad-pitch-999
[114.439786] Subtest bad-pitch-999: SUCCESS (0.000s)
[114.569561] [070/162] (893s left) kms_addfb_basic (basic)
[114.708459] Starting subtest: basic
[114.709615] Subtest basic: SUCCESS (0.000s)
[114.835820] [071/162] (893s left) kms_addfb_basic (basic-x-tiled-legacy)
[114.974233] Starting subtest: basic-x-tiled-legacy
[114.975327] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[115.102235] [072/162] (892s left) kms_addfb_basic (basic-y-tiled-legacy)
[115.242179] Starting subtest: basic-y-tiled-legacy
[115.243262] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[115.369038] [073/162] (892s left) kms_addfb_basic (bo-too-small)
[115.537365] Starting subtest: bo-too-small
[115.538495] Subtest bo-too-small: SUCCESS (0.000s)
[115.635771] [074/162] (892s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[115.803493] Starting subtest: bo-too-small-due-to-tiling
[115.804654] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[115.901855] [075/162] (892s left) kms_addfb_basic (clobberred-modifier)
[116.039876] Starting subtest: clobberred-modifier
[116.041246] Subtest clobberred-modifier: SUCCESS (0.000s)
[116.186589] [076/162] (891s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[116.319925] Starting subtest: framebuffer-vs-set-tiling
[116.321106] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[116.452596] [077/162] (891s left) kms_addfb_basic (invalid-get-prop)
[116.590678] Starting subtest: invalid-get-prop
[116.591841] Subtest invalid-get-prop: SUCCESS (0.000s)
[116.719310] [078/162] (891s left) kms_addfb_basic (invalid-get-prop-any)
[116.860309] Starting subtest: invalid-get-prop-any
[116.861401] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[116.985399] [079/162] (891s left) kms_addfb_basic (invalid-set-prop)
[117.124933] Starting subtest: invalid-set-prop
[117.126213] Subtest invalid-set-prop: SUCCESS (0.000s)
[117.252357] [080/162] (890s left) kms_addfb_basic (invalid-set-prop-any)
[117.390640] Starting subtest: invalid-set-prop-any
[117.391811] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[117.518997] [081/162] (890s left) kms_addfb_basic (no-handle)
[117.655818] Starting subtest: no-handle
[117.657044] Subtest no-handle: SUCCESS (0.000s)
[117.785776] [082/162] (890s left) kms_addfb_basic (size-max)
[117.953688] Starting subtest: size-max
[117.954836] Subtest size-max: SUCCESS (0.000s)
[118.052056] [083/162] (890s left) kms_addfb_basic (small-bo)
[118.220497] Starting subtest: small-bo
[118.221636] Subtest small-bo: SUCCESS (0.000s)
[118.318806] [084/162] (889s left) kms_addfb_basic (tile-pitch-mismatch)
[118.459141] Starting subtest: tile-pitch-mismatch
[118.460241] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[118.585502] [085/162] (889s left) kms_addfb_basic (too-high)
[118.754760] Starting subtest: too-high
[118.756072] Subtest too-high: SUCCESS (0.001s)
[118.852311] [086/162] (889s left) kms_addfb_basic (too-wide)
[119.021348] Starting subtest: too-wide
[119.022501] Subtest too-wide: SUCCESS (0.000s)
[119.119706] [087/162] (889s left) kms_addfb_basic (unused-handle)
[119.258060] Starting subtest: unused-handle
[119.259307] Subtest unused-handle: SUCCESS (0.000s)
[119.385558] [088/162] (888s left) kms_addfb_basic (unused-modifier)
[119.523568] Starting subtest: unused-modifier
[119.524776] Subtest unused-modifier: SUCCESS (0.000s)
[119.652319] [089/162] (888s left) kms_addfb_basic (unused-offsets)
[119.790787] Starting subtest: unused-offsets
[119.791981] Subtest unused-offsets: SUCCESS (0.000s)
[119.918881] [090/162] (888s left) kms_addfb_basic (unused-pitches)
[120.056489] Starting subtest: unused-pitches
[120.057671] Subtest unused-pitches: SUCCESS (0.000s)
[120.185678] [091/162] (888s left) kms_busy (basic)
[120.359671] Starting subtest: basic
[120.360765] Starting dynamic subtest: flip
[121.353135] Dynamic subtest flip: SUCCESS (0.992s)
[121.370331] Starting dynamic subtest: modeset
[125.175475] Dynamic subtest modeset: SUCCESS (3.821s)
[125.186299] Subtest basic: SUCCESS (4.816s)
[126.141696] [092/162] (882s left) kms_prop_blob (basic)
[126.281320] Starting subtest: basic
[126.282539] Subtest basic: SUCCESS (0.000s)
[126.361104] [093/162] (882s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[126.526361] Starting subtest: basic-busy-flip-before-cursor-atomic
[126.528677] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[126.606917] [094/162] (881s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[126.772794] Starting subtest: basic-busy-flip-before-cursor-legacy
[126.775353] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[126.856594] [095/162] (881s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[127.022546] Starting subtest: basic-flip-after-cursor-atomic
[128.303342] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.277s)
[129.281115] [096/162] (879s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[129.447418] Starting subtest: basic-flip-after-cursor-legacy
[130.708320] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.261s)
[131.642627] [097/162] (876s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[131.808443] Starting subtest: basic-flip-after-cursor-varying-size
[133.083983] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.276s)
[134.011558] [098/162] (874s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[134.180340] Starting subtest: basic-flip-before-cursor-atomic
[135.470482] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.290s)
[136.444160] [099/162] (872s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[136.609896] Starting subtest: basic-flip-before-cursor-legacy
[137.869317] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.259s)
[138.812846] [100/162] (869s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[138.977987] Starting subtest: basic-flip-before-cursor-varying-size
[140.272979] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.295s)
[141.244913] [101/162] (867s left) kms_flip (basic-flip-vs-dpms)
[141.392423] Starting subtest: basic-flip-vs-dpms
[141.395289] Starting dynamic subtest: A-eDP1
[144.273425] Dynamic subtest A-eDP1: SUCCESS (2.870s)
[144.290472] Starting dynamic subtest: B-eDP1
[146.626094] Dynamic subtest B-eDP1: SUCCESS (2.349s)
[146.640868] Starting dynamic subtest: C-eDP1
[149.009910] Dynamic subtest C-eDP1: SUCCESS (2.383s)
[149.011266] Subtest basic-flip-vs-dpms: SUCCESS (7.610s)
[149.908214] [102/162] (858s left) kms_flip (basic-flip-vs-modeset)
[150.053465] Starting subtest: basic-flip-vs-modeset
[150.058293] Starting dynamic subtest: A-eDP1
[152.881685] Dynamic subtest A-eDP1: SUCCESS (2.824s)
[152.898243] Starting dynamic subtest: B-eDP1
[155.253245] Dynamic subtest B-eDP1: SUCCESS (2.368s)
[155.268604] Starting dynamic subtest: C-eDP1
[157.624194] Dynamic subtest C-eDP1: SUCCESS (2.367s)
[157.625306] Subtest basic-flip-vs-modeset: SUCCESS (7.568s)
[158.588564] [103/162] (850s left) kms_flip (basic-flip-vs-wf_vblank)
[158.735730] Starting subtest: basic-flip-vs-wf_vblank
[158.738865] Starting dynamic subtest: A-eDP1
[161.052824] Dynamic subtest A-eDP1: SUCCESS (2.315s)
[161.072145] Starting dynamic subtest: B-eDP1
[163.275487] Dynamic subtest B-eDP1: SUCCESS (2.221s)
[163.294315] Starting dynamic subtest: C-eDP1
[165.519428] Dynamic subtest C-eDP1: SUCCESS (2.243s)
[165.523404] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.788s)
[166.846020] [104/162] (841s left) kms_flip (basic-plain-flip)
[166.995090] Starting subtest: basic-plain-flip
[166.998335] Starting dynamic subtest: A-eDP1
[169.024840] Dynamic subtest A-eDP1: SUCCESS (2.027s)
[169.042994] Starting dynamic subtest: B-eDP1
[170.993502] Dynamic subtest B-eDP1: SUCCESS (1.967s)
[171.012375] Starting dynamic subtest: C-eDP1
[172.976459] Dynamic subtest C-eDP1: SUCCESS (1.982s)
[172.985564] Subtest basic-plain-flip: SUCCESS (5.986s)
[174.280694] [105/162] (834s left) kms_force_connector_basic (force-connector-state)
[174.425703] Starting subtest: force-connector-state
[176.142244] Subtest force-connector-state: SUCCESS (1.716s)
[176.755160] [106/162] (832s left) kms_force_connector_basic (force-edid)
[176.900925] Starting subtest: force-edid
[177.160444] Subtest force-edid: SUCCESS (0.255s)
[177.287650] [107/162] (831s left) kms_force_connector_basic (force-load-detect)
[177.433566] Starting subtest: force-load-detect
[177.435902] Subtest force-load-detect: SKIP (0.000s)
[177.537788] [108/162] (831s left) kms_force_connector_basic (prune-stale-modes)
[177.683721] Starting subtest: prune-stale-modes
[177.993713] Subtest prune-stale-modes: SUCCESS (0.306s)
[178.121239] [109/162] (830s left) kms_frontbuffer_tracking (basic)
[178.309404] Starting subtest: basic
[181.585574] Subtest basic: SUCCESS (3.276s)
[181.706385] [110/162] (827s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[181.877919] Starting subtest: compare-crc-sanitycheck-xr24
[181.879249] Starting dynamic subtest: pipe-A-eDP-1
[182.559503] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.674s)
[182.577184] Starting dynamic subtest: pipe-B-eDP-1
[183.934407] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.365s)
[183.951335] Starting dynamic subtest: pipe-C-eDP-1
[185.509454] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.572s)
[185.510533] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.621s)
[186.424113] [111/162] (822s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[186.593167] Starting subtest: compare-crc-sanitycheck-nv12
[186.594313] Starting dynamic subtest: pipe-A-eDP-1
[187.515644] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.920s)
[187.535129] Starting dynamic subtest: pipe-B-eDP-1
[188.969264] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.451s)
[188.995229] Starting dynamic subtest: pipe-C-eDP-1
[190.758673] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.785s)
[190.759916] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.167s)
[191.673863] [112/162] (817s left) kms_pipe_crc_basic (hang-read-crc)
[191.844924] Starting subtest: hang-read-crc
[191.848194] Starting dynamic subtest: pipe-A-eDP-1
[194.151629] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.305s)
[194.173065] Starting dynamic subtest: pipe-B-eDP-1
[197.125381] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.970s)
[197.145061] Starting dynamic subtest: pipe-C-eDP-1
[200.465472] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.334s)
[200.466628] Subtest hang-read-crc: SUCCESS (8.621s)
[201.401365] [113/162] (807s left) kms_pipe_crc_basic (nonblocking-crc)
[201.572452] Starting subtest: nonblocking-crc
[201.575971] Starting dynamic subtest: pipe-A-eDP-1
[202.424412] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.849s)
[202.443767] Starting dynamic subtest: pipe-B-eDP-1
[203.976667] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.549s)
[203.996579] Starting dynamic subtest: pipe-C-eDP-1
[205.704402] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.723s)
[205.705700] Subtest nonblocking-crc: SUCCESS (4.133s)
[206.647936] [114/162] (802s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[206.817946] Starting subtest: nonblocking-crc-frame-sequence
[206.819355] Starting dynamic subtest: pipe-A-eDP-1
[207.671769] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.853s)
[207.691479] Starting dynamic subtest: pipe-B-eDP-1
[209.226540] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.551s)
[209.246047] Starting dynamic subtest: pipe-C-eDP-1
[210.941978] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.711s)
[210.943340] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.126s)
[211.895942] [115/162] (797s left) kms_pipe_crc_basic (read-crc)
[212.066114] Starting subtest: read-crc
[212.069360] Starting dynamic subtest: pipe-A-eDP-1
[212.853780] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.785s)
[212.873568] Starting dynamic subtest: pipe-B-eDP-1
[214.344341] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.484s)
[214.364306] Starting dynamic subtest: pipe-C-eDP-1
[215.997865] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.650s)
[215.999205] Subtest read-crc: SUCCESS (3.931s)
[216.951667] [116/162] (792s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[217.125405] Starting subtest: read-crc-frame-sequence
[217.126724] Starting dynamic subtest: pipe-A-eDP-1
[217.908356] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.786s)
[217.927519] Starting dynamic subtest: pipe-B-eDP-1
[219.416481] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.504s)
[219.435634] Starting dynamic subtest: pipe-C-eDP-1
[221.068700] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.646s)
[221.069902] Subtest read-crc-frame-sequence: SUCCESS (3.948s)
[222.007896] [117/162] (787s left) kms_psr (primary_page_flip)
[222.181530] Starting subtest: primary_page_flip
[226.368446] Subtest primary_page_flip: SUCCESS (4.188s)
[227.319862] [118/162] (781s left) kms_psr (cursor_plane_move)
[227.489534] Starting subtest: cursor_plane_move
[231.582627] Subtest cursor_plane_move: SUCCESS (4.091s)
[232.503268] [119/162] (776s left) kms_psr (sprite_plane_onoff)
[232.673814] Starting subtest: sprite_plane_onoff
[236.950925] Subtest sprite_plane_onoff: SUCCESS (4.276s)
[237.879842] [120/162] (771s left) kms_psr (primary_mmap_gtt)
[238.051111] Starting subtest: primary_mmap_gtt
[242.239651] Subtest primary_mmap_gtt: SUCCESS (4.187s)
[243.192044] [121/162] (766s left) kms_setmode (basic-clone-single-crtc)
[243.336201] Starting subtest: basic-clone-single-crtc
[243.339548] Subtest basic-clone-single-crtc: SKIP (0.000s)
[243.424960] [122/162] (765s left) i915_pm_backlight (basic-brightness)
[243.595336] Starting subtest: basic-brightness
[243.715232] Starting dynamic subtest: eDP-1
[244.233184] Dynamic subtest eDP-1: SUCCESS (0.526s)
[244.239849] Subtest basic-brightness: SUCCESS (0.639s)
[245.178169] [123/162] (764s left) i915_pm_rpm (basic-pci-d3-state)
[247.076370] Starting subtest: basic-pci-d3-state
[251.474751] Subtest basic-pci-d3-state: SUCCESS (4.408s)
[251.678547] [124/162] (757s left) i915_pm_rpm (basic-rte)
[251.815977] Starting subtest: basic-rte
[257.939868] Subtest basic-rte: SUCCESS (6.121s)
[259.412064] [125/162] (750s left) i915_pm_rps (basic-api)
[259.558778] Starting subtest: basic-api
[259.563204] Subtest basic-api: SUCCESS (0.004s)
[259.677806] [126/162] (749s left) prime_self_import (basic-llseek-bad)
[259.816459] Starting subtest: basic-llseek-bad
[259.818720] Subtest basic-llseek-bad: SUCCESS (0.003s)
[259.910914] [127/162] (749s left) prime_self_import (basic-llseek-size)
[260.046431] Starting subtest: basic-llseek-size
[260.051064] Subtest basic-llseek-size: SUCCESS (0.004s)
[260.144205] [128/162] (749s left) prime_self_import (basic-with_fd_dup)
[260.280661] Starting subtest: basic-with_fd_dup
[260.285598] Subtest basic-with_fd_dup: SUCCESS (0.005s)
[260.377929] [129/162] (749s left) prime_self_import (basic-with_one_bo)
[260.513419] Starting subtest: basic-with_one_bo
[260.518806] Subtest basic-with_one_bo: SUCCESS (0.005s)
[260.608904] [130/162] (748s left) prime_self_import (basic-with_one_bo_two_files)
[260.744376] Starting subtest: basic-with_one_bo_two_files
[260.749377] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s)
[260.844235] [131/162] (748s left) prime_self_import (basic-with_two_bos)
[260.980445] Starting subtest: basic-with_two_bos
[260.985262] Subtest basic-with_two_bos: SUCCESS (0.005s)
[261.077842] [132/162] (748s left) prime_vgem (basic-fence-flip)
[261.231509] Starting subtest: basic-fence-flip
[261.705179] Subtest basic-fence-flip: SUCCESS (0.474s)
[261.828957] [133/162] (747s left) prime_vgem (basic-fence-mmap)
[261.981122] Starting subtest: basic-fence-mmap
[262.028725] Subtest basic-fence-mmap: SUCCESS (0.048s)
[262.128270] [134/162] (747s left) prime_vgem (basic-fence-read)
[262.281498] Starting subtest: basic-fence-read
[262.359781] Subtest basic-fence-read: SUCCESS (0.078s)
[262.445488] [135/162] (747s left) prime_vgem (basic-gtt)
[262.597411] Starting subtest: basic-gtt
[262.620475] Subtest basic-gtt: SUCCESS (0.023s)
[262.727697] [136/162] (747s left) prime_vgem (basic-read)
[262.881282] Starting subtest: basic-read
[262.916492] Subtest basic-read: SUCCESS (0.035s)
[263.027781] [137/162] (746s left) prime_vgem (basic-write)
[263.180597] Starting subtest: basic-write
[263.222476] Subtest basic-write: SUCCESS (0.042s)
[263.311161] [138/162] (746s left) vgem_basic (setversion)
[263.456378] Starting subtest: setversion
[263.458548] Subtest setversion: SUCCESS (0.000s)
[263.527847] [139/162] (746s left) vgem_basic (create)
[263.673332] Starting subtest: create
[263.674603] Subtest create: SUCCESS (0.000s)
[263.744196] [140/162] (746s left) vgem_basic (debugfs)
[263.889975] Starting subtest: debugfs
[263.891486] Subtest debugfs: SUCCESS (0.001s)
[263.966514] [141/162] (745s left) vgem_basic (dmabuf-export)
[264.106983] Starting subtest: dmabuf-export
[264.109688] Subtest dmabuf-export: SUCCESS (0.003s)
[264.221122] [142/162] (745s left) vgem_basic (dmabuf-fence)
[264.356417] Starting subtest: dmabuf-fence
[264.357690] Subtest dmabuf-fence: SUCCESS (0.001s)
[264.431576] [143/162] (745s left) vgem_basic (dmabuf-fence-before)
[264.593178] Starting subtest: dmabuf-fence-before
[264.594458] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[264.661828] [144/162] (745s left) vgem_basic (dmabuf-mmap)
[264.809470] Starting subtest: dmabuf-mmap
[264.833520] Subtest dmabuf-mmap: SUCCESS (0.026s)
[264.911612] [145/162] (745s left) vgem_basic (mmap)
[265.058822] Starting subtest: mmap
[265.074633] Subtest mmap: SUCCESS (0.017s)
[265.144998] [146/162] (744s left) vgem_basic (second-client)
[265.292603] Starting subtest: second-client
[265.325590] Subtest second-client: SUCCESS (0.033s)
[265.396335] [147/162] (744s left) vgem_basic (sysfs)
[265.541325] Starting subtest: sysfs
[265.542510] Subtest sysfs: SUCCESS (0.001s)
[265.611870] [148/162] (744s left) core_hotunplug (unbind-rebind)
[265.791383] Starting subtest: unbind-rebind
[270.193452] Subtest unbind-rebind: SUCCESS (4.403s)
[270.230128] [149/162] (739s left) vgem_basic (unload)
[270.367948] Starting subtest: unload
[299.441629] Subtest unload: SUCCESS (29.038s)
[299.551080] [150/162] (710s left) i915_module_load (reload)
[299.687702] Starting subtest: reload
[303.229780] Subtest reload: SUCCESS (3.541s)
[303.261476] [151/162] (707s left) gem_lmem_swapping (basic)
[303.418403] Subtest basic: SKIP (0.000s)
[303.464137] [152/162] (706s left) gem_lmem_swapping (parallel-random-engines)
[303.610403] Subtest parallel-random-engines: SKIP (0.000s)
[303.664772] [153/162] (706s left) gem_lmem_swapping (random-engines)
[303.810241] Subtest random-engines: SKIP (0.000s)
[303.864260] [154/162] (706s left) gem_lmem_swapping (verify-random)
[304.008639] Subtest verify-random: SKIP (0.000s)
[304.067863] [155/162] (706s left) i915_pm_rpm (module-reload)
[316.566040] Starting subtest: module-reload
[351.500777] Subtest module-reload: SUCCESS (34.928s)
[351.527244] [156/162] (658s left) i915_selftest (live)
[351.671713] Starting subtest: live
[351.673276] Starting dynamic subtest: sanitycheck
[353.565252] Dynamic subtest sanitycheck: SUCCESS (1.884s)
[353.579989] Starting dynamic subtest: uncore
[355.436673] Dynamic subtest uncore: SUCCESS (1.868s)
[355.451027] Starting dynamic subtest: workarounds
[357.573752] Dynamic subtest workarounds: SUCCESS (2.133s)
[357.588024] Starting dynamic subtest: gt_engines
[359.859473] Dynamic subtest gt_engines: SUCCESS (2.282s)
[359.874079] Starting dynamic subtest: gt_timelines
[372.594508] Dynamic subtest gt_timelines: SUCCESS (12.731s)
[372.609227] Starting dynamic subtest: gt_contexts
[374.479508] Dynamic subtest gt_contexts: SUCCESS (1.882s)
[374.494445] Starting dynamic subtest: gt_lrc
[378.909541] Dynamic subtest gt_lrc: SUCCESS (4.427s)
[378.924156] Starting dynamic subtest: gt_mocs
[380.837336] Dynamic subtest gt_mocs: SUCCESS (1.924s)
[380.852320] Starting dynamic subtest: gt_pm
[385.976959] Dynamic subtest gt_pm: SUCCESS (5.136s)
[385.991645] Starting dynamic subtest: gt_heartbeat
[387.941286] Dynamic subtest gt_heartbeat: SUCCESS (1.961s)
[387.956226] Starting dynamic subtest: gt_tlb
[391.028486] Dynamic subtest gt_tlb: SUCCESS (3.085s)
[391.043181] Starting dynamic subtest: requests
[398.647556] Dynamic subtest requests: SUCCESS (7.615s)
[398.662654] Starting dynamic subtest: migrate
[403.264840] Dynamic subtest migrate: SUCCESS (4.614s)
[403.279577] Starting dynamic subtest: active
[405.083443] Dynamic subtest active: SUCCESS (1.815s)
[405.098632] Starting dynamic subtest: objects
[408.462619] Dynamic subtest objects: SUCCESS (3.376s)
[408.477797] Starting dynamic subtest: mman
[415.412697] Dynamic subtest mman: SUCCESS (6.947s)
[415.427495] Starting dynamic subtest: dmabuf
[417.275872] Dynamic subtest dmabuf: SUCCESS (1.859s)
[417.290965] Starting dynamic subtest: vma
[419.107640] Dynamic subtest vma: SUCCESS (1.828s)
[419.122750] Starting dynamic subtest: coherency
[425.507700] Dynamic subtest coherency: SUCCESS (6.397s)
[425.522841] Starting dynamic subtest: gtt
[434.980204] Dynamic subtest gtt: SUCCESS (9.469s)
[434.995481] Starting dynamic subtest: gem
[436.976524] Dynamic subtest gem: SUCCESS (1.994s)
[436.991479] Starting dynamic subtest: evict
[440.875524] Dynamic subtest evict: SUCCESS (3.895s)
[440.890794] Starting dynamic subtest: hugepages
[448.652936] Dynamic subtest hugepages: SUCCESS (7.774s)
[448.668753] Starting dynamic subtest: gem_contexts
[464.016489] Dynamic subtest gem_contexts: SUCCESS (15.360s)
[464.032239] Starting dynamic subtest: client
[465.910630] Dynamic subtest client: SUCCESS (1.891s)
[465.926195] Starting dynamic subtest: gem_migrate
[467.741369] Dynamic subtest gem_migrate: SUCCESS (1.827s)
[467.757035] Starting dynamic subtest: reset
[473.169514] Dynamic subtest reset: SUCCESS (5.425s)
[473.185258] Starting dynamic subtest: memory_region
[475.031520] Dynamic subtest memory_region: SUCCESS (1.859s)
[475.047385] Starting dynamic subtest: hangcheck
[499.440669] Dynamic subtest hangcheck: SUCCESS (24.406s)
[499.456342] Starting dynamic subtest: execlists
[509.653546] Dynamic subtest execlists: SUCCESS (10.210s)
[509.669196] Starting dynamic subtest: ring_submission
[511.536833] Dynamic subtest ring_submission: SUCCESS (1.880s)
[511.552460] Starting dynamic subtest: perf
[513.501594] Dynamic subtest perf: SUCCESS (1.961s)
[513.517554] Starting dynamic subtest: slpc
[515.366050] Dynamic subtest slpc: SUCCESS (1.861s)
[515.381766] Starting dynamic subtest: guc
[517.134183] Dynamic subtest guc: SUCCESS (1.765s)
[517.150104] Starting dynamic subtest: guc_multi_lrc
[518.934529] Dynamic subtest guc_multi_lrc: SUCCESS (1.797s)
[518.950346] Starting dynamic subtest: guc_hang
[520.801900] Dynamic subtest guc_hang: SUCCESS (1.871s)
[520.817179] Starting dynamic subtest: late_gt_pm
[522.730466] Dynamic subtest late_gt_pm: SUCCESS (1.918s)
[522.732168] Subtest live: SUCCESS (171.051s)
[522.933425] [157/162] (487s left) dmabuf (all-tests)
[523.072188] Starting subtest: all-tests
[523.073863] Starting dynamic subtest: sanitycheck
[523.135787] Dynamic subtest sanitycheck: SUCCESS (0.062s)
[523.154189] Starting dynamic subtest: dma_fence
[523.337090] Dynamic subtest dma_fence: SUCCESS (0.197s)
[523.356655] Starting dynamic subtest: dma_fence_chain
[541.452297] Dynamic subtest dma_fence_chain: SUCCESS (18.103s)
[541.465515] Starting dynamic subtest: dma_fence_unwrap
[541.531849] Dynamic subtest dma_fence_unwrap: SUCCESS (0.084s)
[541.551771] Starting dynamic subtest: dma_resv
[541.609903] Dynamic subtest dma_resv: SUCCESS (0.074s)
[541.612202] Subtest all-tests: SUCCESS (18.539s)
[541.644447] [158/162] (468s left) i915_suspend (basic-s2idle-without-i915)
[541.780073] Starting subtest: basic-s2idle-without-i915
[565.765420] Subtest basic-s2idle-without-i915: SUCCESS (8.130s)
[566.122639] [159/162] (460s left) i915_suspend (basic-s3-without-i915)
[566.266506] Starting subtest: basic-s3-without-i915
[589.845331] Subtest basic-s3-without-i915: SUCCESS (6.976s)
[590.188000] [160/162] (452s left) gem_exec_suspend (basic-s0)
[590.344517] Starting subtest: basic-S0
[590.345740] Starting dynamic subtest: smem
[610.056473] Dynamic subtest smem: SUCCESS (3.902s)
[610.057680] Subtest basic-S0: SUCCESS (3.904s)
[610.230256] [161/162] (448s left) gem_exec_suspend (basic-s3)
[610.378695] Starting subtest: basic-S3
[610.379949] Starting dynamic subtest: smem
[628.968737] Dynamic subtest smem: SUCCESS (3.720s)
[628.970018] Subtest basic-S3: SUCCESS (3.722s)
[629.118212] [162/162] (444s left) kms_pipe_crc_basic (suspend-read-crc)
[629.283947] Starting subtest: suspend-read-crc
[629.285196] Starting dynamic subtest: pipe-A-eDP-1
[646.883661] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.421s)
[646.905972] Starting dynamic subtest: pipe-B-eDP-1
[664.860978] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.087s)
[664.884863] Starting dynamic subtest: pipe-C-eDP-1
[683.852584] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.221s)
[683.853705] Subtest suspend-read-crc: SUCCESS (8.741s)
[684.783793] Closing watchdogs
Done.