[37.407662] Initializing watchdogs
[37.407810]   /dev/watchdog0
[37.415830] [001/171] (960s left) i915_module_load (load)
[37.556359] Starting subtest: load
[39.238945] Subtest load: SUCCESS (1.684s)
[39.263719] [002/171] (958s left) core_auth (basic-auth)
[39.394246] Starting subtest: basic-auth
[39.396567] Subtest basic-auth: SUCCESS (0.002s)
[39.462845] [003/171] (958s left) debugfs_test (read_all_entries)
[39.607419] Starting subtest: read_all_entries
[39.671993] Subtest read_all_entries: SUCCESS (0.062s)
[39.824916] [004/171] (958s left) debugfs_test (basic-hwmon)
[40.039777] Starting subtest: basic-hwmon
[40.041936] Subtest basic-hwmon: SKIP (0.000s)
[40.150684] [005/171] (957s left) fbdev (eof)
[40.278149] Starting subtest: eof
[40.279206] Subtest eof: SUCCESS (0.001s)
[40.335041] [006/171] (957s left) fbdev (info)
[40.466675] Starting subtest: info
[40.470254] Subtest info: SUCCESS (0.000s)
[40.534637] [007/171] (957s left) fbdev (nullptr)
[40.677811] Starting subtest: nullptr
[40.682640] Subtest nullptr: SUCCESS (0.000s)
[40.736806] [008/171] (957s left) fbdev (read)
[40.862193] Starting subtest: read
[41.094985] Subtest read: SUCCESS (0.231s)
[41.154703] [009/171] (956s left) fbdev (write)
[41.280125] Starting subtest: write
[41.398284] Subtest write: SUCCESS (0.117s)
[41.455735] [010/171] (956s left) gem_basic (bad-close)
[41.593048] Starting subtest: bad-close
[41.596601] Subtest bad-close: SUCCESS (0.000s)
[41.637095] [011/171] (956s left) gem_basic (create-close)
[41.761093] Starting subtest: create-close
[41.764538] Subtest create-close: SUCCESS (0.002s)
[41.839963] [012/171] (956s left) gem_basic (create-fd-close)
[41.966716] Starting subtest: create-fd-close
[41.969487] Subtest create-fd-close: SUCCESS (0.000s)
[42.043120] [013/171] (956s left) gem_busy (busy@all-engines)
[42.206859] Starting subtest: busy
[42.211718] Starting dynamic subtest: all-engines
[42.243565] Dynamic subtest all-engines: SUCCESS (0.030s)
[42.244665] Subtest busy: SUCCESS (0.034s)
[42.559196] [014/171] (955s left) gem_close_race (basic-process)
[42.710858] Starting subtest: basic-process
[42.751366] Subtest basic-process: SUCCESS (0.041s)
[42.928183] [015/171] (955s left) gem_close_race (basic-threads)
[43.066899] Starting subtest: basic-threads
[44.198732] Subtest basic-threads: SUCCESS (1.131s)
[44.386455] [016/171] (953s left) gem_ctx_create (basic)
[44.519057] Subtest basic: SKIP (0.000s)
[44.553142] [017/171] (953s left) gem_ctx_create (basic-files)
[44.681950] Subtest basic-files: SKIP (0.000s)
[44.719931] [018/171] (953s left) gem_ctx_exec (basic)
[44.848312] Subtest basic: SKIP (0.000s)
[44.922482] [019/171] (953s left) gem_exec_basic (basic)
[45.053175] Starting subtest: basic
[45.055238] Starting dynamic subtest: rcs0-smem
[45.056311] Dynamic subtest rcs0-smem: SUCCESS (0.000s)
[45.057440] Subtest basic: SUCCESS (0.001s)
[45.236630] [020/171] (953s left) gem_exec_create (basic)
[45.370119] Starting subtest: basic
[45.371339] Starting dynamic subtest: smem
[47.410748] Dynamic subtest smem: SUCCESS (2.040s)
[47.411913] Subtest basic: SUCCESS (2.041s)
[47.594877] [021/171] (950s left) gem_exec_fence (basic-busy)
[47.853741] Starting subtest: basic-busy
[47.854848] Starting dynamic subtest: rcs0
[47.863173] Dynamic subtest rcs0: SUCCESS (0.011s)
[47.864283] Subtest basic-busy: SUCCESS (0.012s)
[48.347804] [022/171] (950s left) gem_exec_fence (basic-wait)
[48.610098] Starting subtest: basic-wait
[48.611129] Starting dynamic subtest: rcs0
[48.622352] Dynamic subtest rcs0: SUCCESS (0.014s)
[48.623486] Subtest basic-wait: SUCCESS (0.014s)
[49.065861] [023/171] (949s left) gem_exec_fence (basic-await)
[49.327442] Starting subtest: basic-await
[49.328504] Starting dynamic subtest: rcs0
[49.390186] Dynamic subtest rcs0: SUCCESS (0.063s)
[49.391334] Subtest basic-await: SUCCESS (0.064s)
[49.821125] [024/171] (948s left) gem_exec_fence (nb-await)
[50.080040] Starting subtest: nb-await
[50.081104] Starting dynamic subtest: rcs0
[50.132218] Dynamic subtest rcs0: SUCCESS (0.053s)
[50.133377] Subtest nb-await: SUCCESS (0.054s)
[50.572591] [025/171] (947s left) gem_exec_gttfill (basic)
[50.707224] Starting subtest: basic
[53.884251] Subtest basic: SUCCESS (3.176s)
[54.066776] [026/171] (944s left) gem_exec_parallel (engines)
[54.317825] Starting subtest: engines
[54.319114] Starting dynamic subtest: basic
[56.154405] Dynamic subtest basic: SUCCESS (1.837s)
[56.163053] Starting dynamic subtest: contexts
[56.167799] Dynamic subtest contexts: SKIP (0.001s)
[56.177391] Starting dynamic subtest: fds
[56.179447] Dynamic subtest fds: SKIP (0.000s)
[56.187347] Starting dynamic subtest: userptr
[57.983950] Dynamic subtest userptr: SUCCESS (1.825s)
[57.985162] Subtest engines: SUCCESS (3.664s)
[58.167323] [027/171] (940s left) gem_exec_store (basic)
[58.303142] Starting subtest: basic
[58.319247] Subtest basic: SUCCESS (0.017s)
[58.498940] [028/171] (940s left) gem_flink_basic (bad-flink)
[58.624161] Starting subtest: bad-flink
[58.625232] Subtest bad-flink: SUCCESS (0.000s)
[58.701083] [029/171] (939s left) gem_flink_basic (bad-open)
[58.824232] Starting subtest: bad-open
[58.825361] Subtest bad-open: SUCCESS (0.000s)
[58.900504] [030/171] (939s left) gem_flink_basic (basic)
[59.031386] Starting subtest: basic
[59.032462] Subtest basic: SUCCESS (0.000s)
[59.100822] [031/171] (939s left) gem_flink_basic (double-flink)
[59.224153] Starting subtest: double-flink
[59.225187] Subtest double-flink: SUCCESS (0.000s)
[59.301563] [032/171] (939s left) gem_flink_basic (flink-lifetime)
[59.424949] Starting subtest: flink-lifetime
[59.426081] Subtest flink-lifetime: SUCCESS (0.001s)
[59.502399] [033/171] (939s left) gem_huc_copy (huc-copy)
[59.630620] Subtest huc-copy: SKIP (0.000s)
[59.672541] [034/171] (938s left) gem_linear_blits (basic)
[60.103736] Starting subtest: basic
[60.115459] Subtest basic: SUCCESS (0.012s)
[60.222842] [035/171] (938s left) gem_mmap (basic)
[60.461515] Starting subtest: basic
[60.466931] Subtest basic: SUCCESS (0.000s)
[60.539708] [036/171] (938s left) gem_mmap_gtt (basic)
[60.670410] Starting subtest: basic
[60.671476] Subtest basic: SUCCESS (0.001s)
[60.750672] [037/171] (937s left) gem_render_linear_blits (basic)
[60.875134] Starting subtest: basic
[60.927266] Subtest basic: SUCCESS (0.048s)
[60.957564] [038/171] (937s left) gem_render_tiled_blits (basic)
[61.083031] Starting subtest: basic
[61.123728] Subtest basic: SUCCESS (0.042s)
[61.177392] [039/171] (937s left) gem_ringfill (basic-all)
[61.327986] Starting subtest: basic-all
[62.431048] Subtest basic-all: SUCCESS (1.101s)
[62.497156] [040/171] (936s left) gem_softpin (allocator-basic)
[62.625134] Subtest allocator-basic: SKIP (0.000s)
[62.697414] [041/171] (936s left) gem_softpin (allocator-basic-reserve)
[62.821765] Subtest allocator-basic-reserve: SKIP (0.000s)
[62.897177] [042/171] (935s left) gem_softpin (safe-alignment)
[63.026378] Starting subtest: safe-alignment
[63.027452] Subtest safe-alignment: SUCCESS (0.006s)
[63.098813] [043/171] (935s left) gem_sync (basic-all)
[63.236049] Starting subtest: basic-all
[65.336310] Subtest basic-all: SUCCESS (2.102s)
[65.523586] [044/171] (933s left) gem_sync (basic-each)
[65.660072] Starting subtest: basic-each
[67.734188] Subtest basic-each: SUCCESS (2.074s)
[67.915963] [045/171] (930s left) gem_tiled_blits (basic)
[68.277585] Starting subtest: basic
[68.296451] Subtest basic: SUCCESS (0.020s)
[68.402103] [046/171] (930s left) gem_tiled_fence_blits (basic)
[68.938222] Starting subtest: basic
[68.951649] Subtest basic: SUCCESS (0.013s)
[69.068988] [047/171] (929s left) gem_tiled_pread_basic
[69.570976] [048/171] (929s left) gem_wait (busy@all-engines)
[69.718819] Starting subtest: busy
[69.722457] Starting dynamic subtest: all-engines
[70.228156] Dynamic subtest all-engines: SUCCESS (0.511s)
[70.229317] Subtest busy: SUCCESS (0.511s)
[70.440227] [049/171] (928s left) gem_wait (wait@all-engines)
[70.585999] Starting subtest: wait
[70.587802] Starting dynamic subtest: all-engines
[71.598233] Dynamic subtest all-engines: SUCCESS (1.014s)
[71.599390] Subtest wait: SUCCESS (1.015s)
[71.812845] [050/171] (927s left) i915_getparams_basic (basic-eu-total)
[71.937234] Starting subtest: basic-eu-total
[71.939407] Subtest basic-eu-total: SUCCESS (0.000s)
[72.011384] [051/171] (927s left) i915_getparams_basic (basic-subslice-total)
[72.138185] Starting subtest: basic-subslice-total
[72.140330] Subtest basic-subslice-total: SUCCESS (0.000s)
[72.195836] [052/171] (926s left) i915_hangman (error-state-basic)
[72.326290] Starting subtest: error-state-basic
[72.441576] Subtest error-state-basic: SUCCESS (0.118s)
[72.494606] [053/171] (926s left) i915_pciid
[72.692280] [054/171] (926s left) kms_addfb_basic (addfb25-bad-modifier)
[72.819281] Starting subtest: addfb25-bad-modifier
[72.820965] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[72.928516] [055/171] (926s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[73.060194] Starting subtest: addfb25-framebuffer-vs-set-tiling
[73.061291] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[73.164431] [056/171] (925s left) kms_addfb_basic (addfb25-modifier-no-flag)
[73.296892] Starting subtest: addfb25-modifier-no-flag
[73.298042] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[73.396937] [057/171] (925s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[73.526241] Starting subtest: addfb25-x-tiled-legacy
[73.527338] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[73.630570] [058/171] (925s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[73.760857] Starting subtest: addfb25-x-tiled-mismatch-legacy
[73.762150] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[73.867004] [059/171] (925s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[74.021847] Starting subtest: addfb25-yf-tiled-legacy
[74.023279] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[74.097671] [060/171] (925s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[74.254979] Starting subtest: addfb25-y-tiled-legacy
[74.256272] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[74.331586] [061/171] (924s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[74.489220] Starting subtest: addfb25-y-tiled-small-legacy
[74.491832] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[74.566900] [062/171] (924s left) kms_addfb_basic (bad-pitch-0)
[74.697230] Starting subtest: bad-pitch-0
[74.698313] Subtest bad-pitch-0: SUCCESS (0.000s)
[74.801395] [063/171] (924s left) kms_addfb_basic (bad-pitch-1024)
[74.925189] Starting subtest: bad-pitch-1024
[74.926892] Subtest bad-pitch-1024: SUCCESS (0.000s)
[75.037248] [064/171] (924s left) kms_addfb_basic (bad-pitch-128)
[75.166182] Starting subtest: bad-pitch-128
[75.167306] Subtest bad-pitch-128: SUCCESS (0.000s)
[75.267883] [065/171] (924s left) kms_addfb_basic (bad-pitch-256)
[75.398998] Starting subtest: bad-pitch-256
[75.400091] Subtest bad-pitch-256: SUCCESS (0.000s)
[75.505824] [066/171] (923s left) kms_addfb_basic (bad-pitch-32)
[75.635419] Starting subtest: bad-pitch-32
[75.636901] Subtest bad-pitch-32: SUCCESS (0.000s)
[75.737642] [067/171] (923s left) kms_addfb_basic (bad-pitch-63)
[75.864135] Starting subtest: bad-pitch-63
[75.865850] Subtest bad-pitch-63: SUCCESS (0.000s)
[75.971938] [068/171] (923s left) kms_addfb_basic (bad-pitch-65536)
[76.097294] Starting subtest: bad-pitch-65536
[76.098369] Subtest bad-pitch-65536: SUCCESS (0.001s)
[76.207250] [069/171] (923s left) kms_addfb_basic (bad-pitch-999)
[76.342035] Starting subtest: bad-pitch-999
[76.343122] Subtest bad-pitch-999: SUCCESS (0.000s)
[76.440055] [070/171] (923s left) kms_addfb_basic (basic)
[76.568351] Starting subtest: basic
[76.569612] Subtest basic: SUCCESS (0.000s)
[76.674416] [071/171] (922s left) kms_addfb_basic (basic-x-tiled-legacy)
[76.800248] Starting subtest: basic-x-tiled-legacy
[76.801811] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[76.907958] [072/171] (922s left) kms_addfb_basic (basic-y-tiled-legacy)
[77.029241] Starting subtest: basic-y-tiled-legacy
[77.030403] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[77.142499] [073/171] (922s left) kms_addfb_basic (bo-too-small)
[77.299662] Starting subtest: bo-too-small
[77.301052] Subtest bo-too-small: SUCCESS (0.001s)
[77.374699] [074/171] (922s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[77.532649] Starting subtest: bo-too-small-due-to-tiling
[77.534315] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[77.608650] [075/171] (921s left) kms_addfb_basic (clobberred-modifier)
[77.732585] Starting subtest: clobberred-modifier
[77.734903] Subtest clobberred-modifier: SUCCESS (0.000s)
[77.846077] [076/171] (921s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[77.977537] Starting subtest: framebuffer-vs-set-tiling
[77.978642] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[78.079369] [077/171] (921s left) kms_addfb_basic (invalid-get-prop)
[78.207428] Starting subtest: invalid-get-prop
[78.208631] Subtest invalid-get-prop: SUCCESS (0.000s)
[78.313980] [078/171] (921s left) kms_addfb_basic (invalid-get-prop-any)
[78.445998] Starting subtest: invalid-get-prop-any
[78.447131] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[78.547231] [079/171] (921s left) kms_addfb_basic (invalid-set-prop)
[78.680947] Starting subtest: invalid-set-prop
[78.682048] Subtest invalid-set-prop: SUCCESS (0.000s)
[78.781817] [080/171] (920s left) kms_addfb_basic (invalid-set-prop-any)
[78.911288] Starting subtest: invalid-set-prop-any
[78.912453] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[79.016233] [081/171] (920s left) kms_addfb_basic (no-handle)
[79.144243] Starting subtest: no-handle
[79.145373] Subtest no-handle: SUCCESS (0.000s)
[79.251675] [082/171] (920s left) kms_addfb_basic (size-max)
[79.407271] Starting subtest: size-max
[79.408950] Subtest size-max: SUCCESS (0.000s)
[79.482708] [083/171] (920s left) kms_addfb_basic (small-bo)
[79.641169] Starting subtest: small-bo
[79.642302] Subtest small-bo: SUCCESS (0.000s)
[79.718898] [084/171] (920s left) kms_addfb_basic (tile-pitch-mismatch)
[79.847958] Starting subtest: tile-pitch-mismatch
[79.849098] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[79.952106] [085/171] (919s left) kms_addfb_basic (too-high)
[80.113176] Starting subtest: too-high
[80.114423] Subtest too-high: SUCCESS (0.001s)
[80.183981] [086/171] (919s left) kms_addfb_basic (too-wide)
[80.345296] Starting subtest: too-wide
[80.346439] Subtest too-wide: SUCCESS (0.000s)
[80.419647] [087/171] (919s left) kms_addfb_basic (unused-handle)
[80.543269] Starting subtest: unused-handle
[80.544590] Subtest unused-handle: SUCCESS (0.000s)
[80.654536] [088/171] (919s left) kms_addfb_basic (unused-modifier)
[80.779294] Starting subtest: unused-modifier
[80.784722] Subtest unused-modifier: SUCCESS (0.000s)
[80.889804] [089/171] (918s left) kms_addfb_basic (unused-offsets)
[81.018397] Starting subtest: unused-offsets
[81.019502] Subtest unused-offsets: SUCCESS (0.000s)
[81.125555] [090/171] (918s left) kms_addfb_basic (unused-pitches)
[81.254208] Starting subtest: unused-pitches
[81.255280] Subtest unused-pitches: SUCCESS (0.000s)
[81.358151] [091/171] (918s left) kms_busy (basic)
[81.516065] Starting subtest: basic
[81.517199] Starting dynamic subtest: flip
[82.166140] Dynamic subtest flip: SUCCESS (0.639s)
[82.177830] Starting dynamic subtest: modeset
[82.195048] Dynamic subtest modeset: SKIP (0.000s)
[82.196140] Subtest basic: SUCCESS (0.643s)
[82.258586] [092/171] (917s left) kms_chamelium_hpd (dp-hpd-fast)
[82.411920] Subtest dp-hpd-fast: SKIP (0.000s)
[82.457447] [093/171] (917s left) kms_chamelium_edid (dp-edid-read)
[82.612847] Subtest dp-edid-read: SKIP (0.000s)
[82.657444] [094/171] (917s left) kms_chamelium_frames (dp-crc-fast)
[82.813064] Subtest dp-crc-fast: SKIP (0.000s)
[82.857978] [095/171] (917s left) kms_chamelium_hpd (hdmi-hpd-fast)
[83.034134] Subtest hdmi-hpd-fast: SKIP (0.000s)
[83.075601] [096/171] (916s left) kms_chamelium_edid (hdmi-edid-read)
[83.234683] Subtest hdmi-edid-read: SKIP (0.000s)
[83.276064] [097/171] (916s left) kms_chamelium_frames (hdmi-crc-fast)
[83.434167] Subtest hdmi-crc-fast: SKIP (0.000s)
[83.477929] [098/171] (916s left) kms_chamelium_hpd (vga-hpd-fast)
[83.633147] Subtest vga-hpd-fast: SKIP (0.000s)
[83.677577] [099/171] (916s left) kms_chamelium_edid (vga-edid-read)
[83.835391] Subtest vga-edid-read: SKIP (0.000s)
[83.878357] [100/171] (916s left) kms_prop_blob (basic)
[84.003187] Starting subtest: basic
[84.004324] Subtest basic: SUCCESS (0.000s)
[84.081744] [101/171] (916s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[84.236418] Starting subtest: basic-busy-flip-before-cursor-atomic
[84.239365] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.004s)
[84.310833] [102/171] (915s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[84.469222] Starting subtest: basic-busy-flip-before-cursor-legacy
[85.471122] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.003s)
[85.597024] [103/171] (914s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[85.751997] Starting subtest: basic-flip-after-cursor-atomic
[85.754280] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[85.828279] [104/171] (914s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[85.986218] Starting subtest: basic-flip-after-cursor-legacy
[86.987050] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.001s)
[87.100664] [105/171] (913s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[87.257900] Starting subtest: basic-flip-after-cursor-varying-size
[88.275230] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.011s)
[88.392492] [106/171] (911s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[88.549900] Starting subtest: basic-flip-before-cursor-atomic
[88.552244] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[88.625360] [107/171] (911s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[88.785313] Starting subtest: basic-flip-before-cursor-legacy
[89.783153] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.997s)
[89.915498] [108/171] (910s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[90.070898] Starting subtest: basic-flip-before-cursor-varying-size
[91.089366] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.013s)
[91.213254] [109/171] (909s left) kms_flip (basic-flip-vs-dpms)
[91.367213] Starting subtest: basic-flip-vs-dpms
[91.368307] Starting dynamic subtest: A-VGA1
[92.685542] Dynamic subtest A-VGA1: SUCCESS (1.317s)
[92.696906] Starting dynamic subtest: B-VGA1
[93.902899] Dynamic subtest B-VGA1: SUCCESS (1.217s)
[93.903995] Subtest basic-flip-vs-dpms: SUCCESS (2.536s)
[94.041753] [110/171] (906s left) kms_flip (basic-flip-vs-modeset)
[94.200526] Starting subtest: basic-flip-vs-modeset
[94.201711] Starting dynamic subtest: A-VGA1
[95.504366] Dynamic subtest A-VGA1: SUCCESS (1.293s)
[95.519648] Starting dynamic subtest: B-VGA1
[96.751753] Dynamic subtest B-VGA1: SUCCESS (1.248s)
[96.752854] Subtest basic-flip-vs-modeset: SUCCESS (2.552s)
[96.890694] [111/171] (903s left) kms_flip (basic-flip-vs-wf_vblank)
[97.046649] Starting subtest: basic-flip-vs-wf_vblank
[97.047994] Starting dynamic subtest: A-VGA1
[98.606277] Dynamic subtest A-VGA1: SUCCESS (1.559s)
[98.628962] Starting dynamic subtest: B-VGA1
[100.134468] Dynamic subtest B-VGA1: SUCCESS (1.524s)
[100.140060] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.089s)
[100.327074] [112/171] (900s left) kms_flip (basic-plain-flip)
[100.486140] Starting subtest: basic-plain-flip
[100.487306] Starting dynamic subtest: A-VGA1
[101.752990] Dynamic subtest A-VGA1: SUCCESS (1.258s)
[101.774614] Starting dynamic subtest: B-VGA1
[102.992820] Dynamic subtest B-VGA1: SUCCESS (1.216s)
[102.999040] Subtest basic-plain-flip: SUCCESS (2.510s)
[103.155873] [113/171] (897s left) kms_force_connector_basic (force-connector-state)
[103.342412] Starting subtest: force-connector-state
[103.518072] Subtest force-connector-state: SUCCESS (0.173s)
[103.760195] [114/171] (896s left) kms_force_connector_basic (force-edid)
[103.950996] Starting subtest: force-edid
[104.048948] Subtest force-edid: SUCCESS (0.098s)
[104.261605] [115/171] (896s left) kms_force_connector_basic (force-load-detect)
[104.484921] Starting subtest: force-load-detect
[104.660110] Subtest force-load-detect: SUCCESS (0.174s)
[104.862910] [116/171] (895s left) kms_force_connector_basic (prune-stale-modes)
[105.038088] Starting subtest: prune-stale-modes
[105.136533] Subtest prune-stale-modes: SUCCESS (0.100s)
[105.331602] [117/171] (895s left) kms_frontbuffer_tracking (basic)
[105.491404] Subtest basic: SKIP (0.000s)
[105.535315] [118/171] (894s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[105.691092] Starting subtest: compare-crc-sanitycheck-xr24
[105.692269] Starting dynamic subtest: pipe-A-VGA-1
[105.988685] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.298s)
[106.012983] Starting dynamic subtest: pipe-B-VGA-1
[106.333185] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.334s)
[106.335714] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.645s)
[106.465606] [119/171] (894s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[106.624270] Starting subtest: compare-crc-sanitycheck-nv12
[106.625412] Starting dynamic subtest: pipe-A-VGA-1
[106.627993] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s)
[106.636816] Starting dynamic subtest: pipe-B-VGA-1
[106.639777] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s)
[106.641821] Subtest compare-crc-sanitycheck-nv12: SKIP (0.003s)
[106.699867] [120/171] (893s left) kms_pipe_crc_basic (hang-read-crc)
[106.858883] Starting subtest: hang-read-crc
[106.862414] Starting dynamic subtest: pipe-A-VGA-1
[107.744934] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.883s)
[107.760934] Starting dynamic subtest: pipe-B-VGA-1
[108.618375] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.871s)
[108.619831] Subtest hang-read-crc: SUCCESS (1.758s)
[108.723740] [121/171] (891s left) kms_pipe_crc_basic (nonblocking-crc)
[108.882957] Starting subtest: nonblocking-crc
[108.884206] Starting dynamic subtest: pipe-A-VGA-1
[109.378742] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.494s)
[109.389927] Starting dynamic subtest: pipe-B-VGA-1
[109.902171] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.522s)
[109.903349] Subtest nonblocking-crc: SUCCESS (1.020s)
[110.025207] [122/171] (890s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[110.180685] Starting subtest: nonblocking-crc-frame-sequence
[110.183106] Starting dynamic subtest: pipe-A-VGA-1
[110.680148] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.497s)
[110.691940] Starting dynamic subtest: pipe-B-VGA-1
[111.227167] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.545s)
[111.228422] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.046s)
[111.349429] [123/171] (889s left) kms_pipe_crc_basic (read-crc)
[111.507310] Starting subtest: read-crc
[111.509706] Starting dynamic subtest: pipe-A-VGA-1
[111.924994] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.416s)
[111.938959] Starting dynamic subtest: pipe-B-VGA-1
[112.375214] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.447s)
[112.376330] Subtest read-crc: SUCCESS (0.868s)
[112.501657] [124/171] (888s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[112.659061] Starting subtest: read-crc-frame-sequence
[112.661403] Starting dynamic subtest: pipe-A-VGA-1
[113.090798] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.429s)
[113.104966] Starting dynamic subtest: pipe-B-VGA-1
[113.559215] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.466s)
[113.560375] Subtest read-crc-frame-sequence: SUCCESS (0.901s)
[113.692605] [125/171] (886s left) kms_psr (primary_page_flip)
[113.820660] Subtest primary_page_flip: SKIP (0.000s)
[113.860792] [126/171] (886s left) kms_psr (cursor_plane_move)
[113.988744] Subtest cursor_plane_move: SKIP (0.000s)
[114.028620] [127/171] (886s left) kms_psr (sprite_plane_onoff)
[114.157125] Subtest sprite_plane_onoff: SKIP (0.000s)
[114.195499] [128/171] (886s left) kms_psr (primary_mmap_gtt)
[114.321533] Subtest primary_mmap_gtt: SKIP (0.000s)
[114.362768] [129/171] (886s left) kms_setmode (basic-clone-single-crtc)
[114.490141] Starting subtest: basic-clone-single-crtc
[114.493835] Subtest basic-clone-single-crtc: SKIP (0.000s)
[114.560372] [130/171] (886s left) i915_pm_backlight (basic-brightness)
[114.716862] Subtest basic-brightness: SKIP (0.000s)
[114.747437] [131/171] (886s left) i915_pm_rpm (basic-pci-d3-state)
[126.069024] Subtest basic-pci-d3-state: SKIP (0.000s)
[126.104114] [132/171] (874s left) i915_pm_rpm (basic-rte)
[126.223901] Starting subtest: basic-rte
[137.437198] Subtest basic-rte: SKIP (11.197s)
[137.458164] [133/171] (863s left) i915_pm_rps (basic-api)
[137.590083] Subtest basic-api: SKIP (0.000s)
[137.626588] [134/171] (863s left) prime_self_import (basic-llseek-bad)
[137.750646] Starting subtest: basic-llseek-bad
[137.752993] Subtest basic-llseek-bad: SUCCESS (0.003s)
[137.825732] [135/171] (863s left) prime_self_import (basic-llseek-size)
[137.949308] Starting subtest: basic-llseek-size
[137.951781] Subtest basic-llseek-size: SUCCESS (0.004s)
[138.025384] [136/171] (862s left) prime_self_import (basic-with_fd_dup)
[138.149849] Starting subtest: basic-with_fd_dup
[138.152662] Subtest basic-with_fd_dup: SUCCESS (0.004s)
[138.226870] [137/171] (862s left) prime_self_import (basic-with_one_bo)
[138.351996] Starting subtest: basic-with_one_bo
[138.354444] Subtest basic-with_one_bo: SUCCESS (0.004s)
[138.430461] [138/171] (862s left) prime_self_import (basic-with_one_bo_two_files)
[138.553928] Starting subtest: basic-with_one_bo_two_files
[138.556625] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[138.628833] [139/171] (862s left) prime_self_import (basic-with_two_bos)
[138.751607] Starting subtest: basic-with_two_bos
[138.754178] Subtest basic-with_two_bos: SUCCESS (0.004s)
[138.829226] [140/171] (862s left) prime_vgem (basic-fence-flip)
[138.978349] Starting subtest: basic-fence-flip
[139.374784] Subtest basic-fence-flip: SUCCESS (0.398s)
[139.465575] [141/171] (861s left) prime_vgem (basic-fence-mmap)
[139.612992] Starting subtest: basic-fence-mmap
[139.647584] Subtest basic-fence-mmap: SUCCESS (0.039s)
[139.732863] [142/171] (861s left) prime_vgem (basic-fence-read)
[139.880816] Starting subtest: basic-fence-read
[139.942396] Subtest basic-fence-read: SUCCESS (0.064s)
[140.016603] [143/171] (861s left) prime_vgem (basic-gtt)
[140.146974] Starting subtest: basic-gtt
[140.161974] Subtest basic-gtt: SUCCESS (0.018s)
[140.232924] [144/171] (860s left) prime_vgem (basic-read)
[140.363562] Starting subtest: basic-read
[140.389552] Subtest basic-read: SUCCESS (0.028s)
[140.468295] [145/171] (860s left) prime_vgem (basic-write)
[140.615392] Starting subtest: basic-write
[140.643509] Subtest basic-write: SUCCESS (0.031s)
[140.719411] [146/171] (860s left) vgem_basic (setversion)
[140.842919] Starting subtest: setversion
[140.845256] Subtest setversion: SUCCESS (0.000s)
[140.902470] [147/171] (860s left) vgem_basic (create)
[141.027044] Starting subtest: create
[141.028261] Subtest create: SUCCESS (0.000s)
[141.086736] [148/171] (860s left) vgem_basic (debugfs)
[141.228949] Starting subtest: debugfs
[141.230127] Subtest debugfs: SUCCESS (0.001s)
[141.289398] [149/171] (859s left) vgem_basic (dmabuf-export)
[141.432490] Starting subtest: dmabuf-export
[141.436215] Subtest dmabuf-export: SUCCESS (0.003s)
[141.506425] [150/171] (859s left) vgem_basic (dmabuf-fence)
[141.647941] Starting subtest: dmabuf-fence
[141.649162] Subtest dmabuf-fence: SUCCESS (0.001s)
[141.705710] [151/171] (859s left) vgem_basic (dmabuf-fence-before)
[141.830082] Starting subtest: dmabuf-fence-before
[141.831135] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[141.890157] [152/171] (859s left) vgem_basic (dmabuf-mmap)
[142.030760] Starting subtest: dmabuf-mmap
[142.050780] Subtest dmabuf-mmap: SUCCESS (0.022s)
[142.107175] [153/171] (859s left) vgem_basic (mmap)
[142.231418] Starting subtest: mmap
[142.243630] Subtest mmap: SUCCESS (0.013s)
[142.291190] [154/171] (859s left) vgem_basic (second-client)
[142.415037] Starting subtest: second-client
[142.448921] Subtest second-client: SUCCESS (0.034s)
[142.507474] [155/171] (858s left) vgem_basic (sysfs)
[142.634355] Starting subtest: sysfs
[142.635529] Subtest sysfs: SUCCESS (0.001s)
[142.692442] [156/171] (858s left) core_hotunplug (unbind-rebind)
[142.864716] Starting subtest: unbind-rebind
[143.682307] Subtest unbind-rebind: SUCCESS (0.817s)
[143.715257] [157/171] (857s left) vgem_basic (unload)
[143.890626] Starting subtest: unload
[172.845432] Subtest unload: SUCCESS (28.953s)
[172.945315] [158/171] (828s left) i915_module_load (reload)
[173.066348] Starting subtest: reload
[175.055934] Subtest reload: SUCCESS (1.991s)
[175.093653] [159/171] (826s left) gem_lmem_swapping (basic)
[175.264894] Subtest basic: SKIP (0.000s)
[175.302448] [160/171] (826s left) gem_lmem_swapping (parallel-random-engines)
[175.447537] Subtest parallel-random-engines: SKIP (0.000s)
[175.516995] [161/171] (826s left) gem_lmem_swapping (random-engines)
[175.711126] Subtest random-engines: SKIP (0.000s)
[175.754880] [162/171] (825s left) gem_lmem_swapping (verify-random)
[175.884606] Subtest verify-random: SKIP (0.000s)
[175.921859] [163/171] (825s left) i915_pm_rpm (module-reload)
[187.255869] Subtest module-reload: SKIP (0.000s)
[187.276438] [164/171] (814s left) i915_selftest (live)
[188.084779] Starting subtest: live
[188.086021] Starting dynamic subtest: sanitycheck
[188.769881] Dynamic subtest sanitycheck: SUCCESS (0.687s)
[188.780926] Starting dynamic subtest: uncore
[189.429214] Dynamic subtest uncore: SUCCESS (0.658s)
[189.440972] Starting dynamic subtest: workarounds
[190.063450] Dynamic subtest workarounds: SUCCESS (0.634s)
[190.072145] Starting dynamic subtest: gt_engines
[190.737666] Dynamic subtest gt_engines: SUCCESS (0.673s)
[190.748594] Starting dynamic subtest: gt_timelines
[193.653107] Dynamic subtest gt_timelines: SUCCESS (2.914s)
[193.665217] Starting dynamic subtest: gt_contexts
[194.314949] Dynamic subtest gt_contexts: SUCCESS (0.661s)
[194.326246] Starting dynamic subtest: gt_lrc
[194.992974] Dynamic subtest gt_lrc: SUCCESS (0.677s)
[195.003911] Starting dynamic subtest: gt_mocs
[195.671076] Dynamic subtest gt_mocs: SUCCESS (0.677s)
[195.682244] Starting dynamic subtest: gt_pm
[196.824431] Dynamic subtest gt_pm: SUCCESS (1.150s)
[196.833560] Starting dynamic subtest: gt_heartbeat
[197.505861] Dynamic subtest gt_heartbeat: SUCCESS (0.683s)
[197.517420] Starting dynamic subtest: gt_tlb
[198.178903] Dynamic subtest gt_tlb: SUCCESS (0.672s)
[198.187240] Starting dynamic subtest: requests
[201.429164] Dynamic subtest requests: SUCCESS (3.249s)
[201.441330] Starting dynamic subtest: migrate
[202.120047] Dynamic subtest migrate: SUCCESS (0.689s)
[202.130312] Starting dynamic subtest: active
[202.774199] Dynamic subtest active: SUCCESS (0.655s)
[202.783111] Starting dynamic subtest: objects
[203.791407] Dynamic subtest objects: SUCCESS (1.014s)
[203.799813] Starting dynamic subtest: mman
[208.721089] Dynamic subtest mman: SUCCESS (4.929s)
[208.731711] Starting dynamic subtest: dmabuf
[209.506176] Dynamic subtest dmabuf: SUCCESS (0.785s)
[209.517946] Starting dynamic subtest: vma
[210.194030] Dynamic subtest vma: SUCCESS (0.686s)
[210.204407] Starting dynamic subtest: coherency
[212.026977] Dynamic subtest coherency: SUCCESS (1.833s)
[212.038428] Starting dynamic subtest: gtt
[216.158179] Dynamic subtest gtt: SUCCESS (4.130s)
[216.170058] Starting dynamic subtest: gem
[216.861155] Dynamic subtest gem: SUCCESS (0.702s)
[216.872450] Starting dynamic subtest: evict
[217.516981] Dynamic subtest evict: SUCCESS (0.655s)
[217.525513] Starting dynamic subtest: hugepages
[218.161872] Dynamic subtest hugepages: SUCCESS (0.643s)
[218.173211] Starting dynamic subtest: gem_contexts
[218.811698] Dynamic subtest gem_contexts: SUCCESS (0.649s)
[218.820596] Starting dynamic subtest: client
[219.488209] Dynamic subtest client: SUCCESS (0.675s)
[219.500034] Starting dynamic subtest: gem_migrate
[220.155801] Dynamic subtest gem_migrate: SUCCESS (0.667s)
[220.166618] Starting dynamic subtest: reset
[221.186127] Dynamic subtest reset: SUCCESS (1.029s)
[221.197627] Starting dynamic subtest: memory_region
[221.878090] Dynamic subtest memory_region: SUCCESS (0.691s)
[221.888746] Starting dynamic subtest: hangcheck
[223.585156] Dynamic subtest hangcheck: SUCCESS (1.706s)
[223.596396] Starting dynamic subtest: execlists
[224.230825] Dynamic subtest execlists: SUCCESS (0.645s)
[224.244222] Starting dynamic subtest: ring_submission
[224.888159] Dynamic subtest ring_submission: SUCCESS (0.656s)
[224.899068] Starting dynamic subtest: perf
[225.533973] Dynamic subtest perf: SUCCESS (0.645s)
[225.545582] Starting dynamic subtest: slpc
[226.173114] Dynamic subtest slpc: SUCCESS (0.638s)
[226.180343] Starting dynamic subtest: guc
[226.858197] Dynamic subtest guc: SUCCESS (0.683s)
[226.870380] Starting dynamic subtest: guc_multi_lrc
[227.522862] Dynamic subtest guc_multi_lrc: SUCCESS (0.664s)
[227.532798] Starting dynamic subtest: guc_hang
[228.198861] Dynamic subtest guc_hang: SUCCESS (0.672s)
[228.208061] Starting dynamic subtest: late_gt_pm
[228.856901] Dynamic subtest late_gt_pm: SUCCESS (0.660s)
[228.858136] Subtest live: SUCCESS (40.775s)
[228.999936] [165/171] (772s left) dmabuf (all-tests)
[229.128041] Starting subtest: all-tests
[229.133328] Starting dynamic subtest: sanitycheck
[229.192215] Dynamic subtest sanitycheck: SUCCESS (0.062s)
[229.201422] Starting dynamic subtest: dma_fence
[229.361098] Dynamic subtest dma_fence: SUCCESS (0.170s)
[229.379891] Starting dynamic subtest: dma_fence_chain
[246.947942] Dynamic subtest dma_fence_chain: SUCCESS (17.583s)
[246.961908] Starting dynamic subtest: dma_fence_unwrap
[247.006187] Dynamic subtest dma_fence_unwrap: SUCCESS (0.060s)
[247.022976] Starting dynamic subtest: dma_resv
[247.065480] Dynamic subtest dma_resv: SUCCESS (0.059s)
[247.070954] Subtest all-tests: SUCCESS (17.939s)
[247.089742] [166/171] (754s left) i915_suspend (basic-s2idle-without-i915)
[247.208911] Starting subtest: basic-s2idle-without-i915
[265.321270] Subtest basic-s2idle-without-i915: SUCCESS (18.107s)
[268.413780] [167/171] (736s left) i915_suspend (basic-s3-without-i915)
[268.548785] Starting subtest: basic-s3-without-i915
[286.100834] Subtest basic-s3-without-i915: SUCCESS (2.121s)
[288.743706] [168/171] (734s left) gem_exec_suspend (basic-s0)
[288.890722] Starting subtest: basic-S0
[288.892030] Starting dynamic subtest: smem
[306.024102] Dynamic subtest smem: SUCCESS (17.132s)
[306.025350] Subtest basic-S0: SUCCESS (17.135s)
[309.001108] [169/171] (716s left) gem_exec_suspend (basic-s3)
[309.145396] Starting subtest: basic-S3
[309.147146] Starting dynamic subtest: smem
[326.897203] Dynamic subtest smem: SUCCESS (1.887s)
[326.898433] Subtest basic-S3: SUCCESS (1.888s)
[332.092953] [170/171] (714s left) kms_chamelium_hpd (common-hpd-after-suspend)
[332.254415] Subtest common-hpd-after-suspend: SKIP (0.000s)
[332.301531] [171/171] (714s left) kms_pipe_crc_basic (suspend-read-crc)
[332.456393] Starting subtest: suspend-read-crc
[332.457585] Starting dynamic subtest: pipe-A-VGA-1
[349.937094] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.667s)
[349.953725] Starting dynamic subtest: pipe-B-VGA-1
[367.899986] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.639s)
[367.901010] Subtest suspend-read-crc: SUCCESS (3.320s)
[373.042875] Closing watchdogs
Done.