[29.564374] Initializing watchdogs
[29.564531]   /dev/watchdog0
[29.575749] [001/170] (960s left) i915_module_load (load)
[29.719992] Starting subtest: load
[31.301912] Subtest load: SUCCESS (1.584s)
[31.325075] [002/170] (958s left) core_auth (basic-auth)
[31.455738] Starting subtest: basic-auth
[31.458184] Subtest basic-auth: SUCCESS (0.002s)
[31.525828] [003/170] (958s left) debugfs_test (read_all_entries)
[31.673732] Starting subtest: read_all_entries
[31.732286] Subtest read_all_entries: SUCCESS (0.050s)
[31.840474] [004/170] (958s left) debugfs_test (basic-hwmon)
[32.092324] Starting subtest: basic-hwmon
[32.094435] Subtest basic-hwmon: SKIP (0.000s)
[32.195901] [005/170] (957s left) fbdev (eof)
[32.323433] Starting subtest: eof
[32.324510] Subtest eof: SUCCESS (0.000s)
[32.378797] [006/170] (957s left) fbdev (info)
[32.498406] Starting subtest: info
[32.499644] Subtest info: SUCCESS (0.000s)
[32.565246] [007/170] (957s left) fbdev (nullptr)
[32.691572] Starting subtest: nullptr
[32.692717] Subtest nullptr: SUCCESS (0.000s)
[32.749207] [008/170] (957s left) fbdev (read)
[32.875253] Starting subtest: read
[33.114565] Subtest read: SUCCESS (0.239s)
[33.167285] [009/170] (957s left) fbdev (write)
[33.293482] Starting subtest: write
[33.441331] Subtest write: SUCCESS (0.147s)
[33.500454] [010/170] (956s left) gem_basic (bad-close)
[33.639553] Starting subtest: bad-close
[33.641851] Subtest bad-close: SUCCESS (0.000s)
[33.717413] [011/170] (956s left) gem_basic (create-close)
[33.860449] Starting subtest: create-close
[33.863745] Subtest create-close: SUCCESS (0.003s)
[33.939170] [012/170] (956s left) gem_basic (create-fd-close)
[34.077890] Starting subtest: create-fd-close
[34.082258] Subtest create-fd-close: SUCCESS (0.004s)
[34.152577] [013/170] (956s left) gem_busy (busy@all-engines)
[34.309774] Starting subtest: busy
[34.315161] Starting dynamic subtest: all-engines
[34.343581] Dynamic subtest all-engines: SUCCESS (0.029s)
[34.344676] Subtest busy: SUCCESS (0.033s)
[34.655840] [014/170] (955s left) gem_close_race (basic-process)
[34.800968] Starting subtest: basic-process
[34.844333] Subtest basic-process: SUCCESS (0.043s)
[35.024741] [015/170] (955s left) gem_close_race (basic-threads)
[35.161913] Starting subtest: basic-threads
[36.293563] Subtest basic-threads: SUCCESS (1.132s)
[36.481250] [016/170] (953s left) gem_ctx_create (basic)
[36.612038] Subtest basic: SKIP (0.000s)
[36.629565] [017/170] (953s left) gem_ctx_create (basic-files)
[36.755858] Subtest basic-files: SKIP (0.000s)
[36.780840] [018/170] (953s left) gem_ctx_exec (basic)
[36.909252] Subtest basic: SKIP (0.000s)
[36.988191] [019/170] (953s left) gem_exec_basic (basic)
[37.119730] Starting subtest: basic
[37.120835] Starting dynamic subtest: rcs0-smem
[37.121919] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[37.123127] Subtest basic: SUCCESS (0.002s)
[37.300990] [020/170] (953s left) gem_exec_create (basic)
[37.432232] Starting subtest: basic
[37.433344] Starting dynamic subtest: smem
[39.472411] Dynamic subtest smem: SUCCESS (2.040s)
[39.473562] Subtest basic: SUCCESS (2.040s)
[39.656329] [021/170] (950s left) gem_exec_fence (basic-busy)
[39.913386] Starting subtest: basic-busy
[39.914413] Starting dynamic subtest: rcs0
[39.925174] Dynamic subtest rcs0: SUCCESS (0.014s)
[39.926336] Subtest basic-busy: SUCCESS (0.014s)
[40.410200] [022/170] (950s left) gem_exec_fence (basic-wait)
[40.661690] Starting subtest: basic-wait
[40.662900] Starting dynamic subtest: rcs0
[40.674143] Dynamic subtest rcs0: SUCCESS (0.013s)
[40.675285] Subtest basic-wait: SUCCESS (0.014s)
[41.113301] [023/170] (949s left) gem_exec_fence (basic-await)
[41.369356] Starting subtest: basic-await
[41.370423] Starting dynamic subtest: rcs0
[41.429595] Dynamic subtest rcs0: SUCCESS (0.061s)
[41.430900] Subtest basic-await: SUCCESS (0.062s)
[41.866168] [024/170] (948s left) gem_exec_fence (nb-await)
[42.123930] Starting subtest: nb-await
[42.125073] Starting dynamic subtest: rcs0
[42.174773] Dynamic subtest rcs0: SUCCESS (0.053s)
[42.175892] Subtest nb-await: SUCCESS (0.054s)
[42.617545] [025/170] (947s left) gem_exec_gttfill (basic)
[42.750303] Starting subtest: basic
[45.978788] Subtest basic: SUCCESS (3.229s)
[46.167901] [026/170] (944s left) gem_exec_parallel (engines)
[46.425168] Starting subtest: engines
[46.426313] Starting dynamic subtest: basic
[48.302473] Dynamic subtest basic: SUCCESS (1.877s)
[48.311353] Starting dynamic subtest: contexts
[48.313522] Dynamic subtest contexts: SKIP (0.001s)
[48.320835] Starting dynamic subtest: fds
[48.322905] Dynamic subtest fds: SKIP (0.000s)
[48.330096] Starting dynamic subtest: userptr
[50.112439] Dynamic subtest userptr: SUCCESS (1.807s)
[50.113667] Subtest engines: SUCCESS (3.686s)
[50.295007] [027/170] (940s left) gem_exec_store (basic)
[50.431071] Starting subtest: basic
[50.453389] Subtest basic: SUCCESS (0.023s)
[50.628513] [028/170] (940s left) gem_flink_basic (bad-flink)
[50.749264] Starting subtest: bad-flink
[50.750409] Subtest bad-flink: SUCCESS (0.000s)
[50.810976] [029/170] (939s left) gem_flink_basic (bad-open)
[50.931708] Starting subtest: bad-open
[50.932762] Subtest bad-open: SUCCESS (0.000s)
[50.995114] [030/170] (939s left) gem_flink_basic (basic)
[51.116206] Starting subtest: basic
[51.117269] Subtest basic: SUCCESS (0.000s)
[51.196859] [031/170] (939s left) gem_flink_basic (double-flink)
[51.317251] Starting subtest: double-flink
[51.318433] Subtest double-flink: SUCCESS (0.000s)
[51.397461] [032/170] (939s left) gem_flink_basic (flink-lifetime)
[51.519498] Starting subtest: flink-lifetime
[51.520662] Subtest flink-lifetime: SUCCESS (0.001s)
[51.598684] [033/170] (939s left) gem_huc_copy (huc-copy)
[51.725116] Subtest huc-copy: SKIP (0.000s)
[51.749646] [034/170] (939s left) gem_linear_blits (basic)
[52.150696] Starting subtest: basic
[52.164528] Subtest basic: SUCCESS (0.013s)
[52.284033] [035/170] (938s left) gem_mmap (basic)
[52.521953] Starting subtest: basic
[52.527460] Subtest basic: SUCCESS (0.000s)
[52.601232] [036/170] (938s left) gem_mmap_gtt (basic)
[52.727787] Starting subtest: basic
[52.728935] Subtest basic: SUCCESS (0.001s)
[52.805420] [037/170] (938s left) gem_render_linear_blits (basic)
[52.929797] Starting subtest: basic
[52.975578] Subtest basic: SUCCESS (0.047s)
[53.022690] [038/170] (937s left) gem_render_tiled_blits (basic)
[53.148248] Starting subtest: basic
[53.189611] Subtest basic: SUCCESS (0.042s)
[53.221066] [039/170] (937s left) gem_ringfill (basic-all)
[53.365530] Starting subtest: basic-all
[54.470495] Subtest basic-all: SUCCESS (1.105s)
[54.543134] [040/170] (936s left) gem_softpin (allocator-basic)
[54.666861] Subtest allocator-basic: SKIP (0.000s)
[54.742912] [041/170] (936s left) gem_softpin (allocator-basic-reserve)
[54.868030] Subtest allocator-basic-reserve: SKIP (0.000s)
[54.926863] [042/170] (936s left) gem_softpin (safe-alignment)
[55.049724] Starting subtest: safe-alignment
[55.056271] Subtest safe-alignment: SUCCESS (0.008s)
[55.126365] [043/170] (935s left) gem_sync (basic-all)
[55.258786] Starting subtest: basic-all
[57.294347] Subtest basic-all: SUCCESS (2.035s)
[57.469717] [044/170] (933s left) gem_sync (basic-each)
[57.603798] Starting subtest: basic-each
[59.697036] Subtest basic-each: SUCCESS (2.092s)
[59.877708] [045/170] (931s left) gem_tiled_blits (basic)
[60.316975] Starting subtest: basic
[60.336361] Subtest basic: SUCCESS (0.021s)
[60.443728] [046/170] (930s left) gem_tiled_fence_blits (basic)
[60.980608] Starting subtest: basic
[60.991949] Subtest basic: SUCCESS (0.013s)
[61.100342] [047/170] (929s left) gem_tiled_pread_basic
[61.600221] [048/170] (929s left) gem_wait (busy@all-engines)
[61.743373] Starting subtest: busy
[61.744431] Starting dynamic subtest: all-engines
[62.251278] Dynamic subtest all-engines: SUCCESS (0.511s)
[62.252335] Subtest busy: SUCCESS (0.511s)
[62.453914] [049/170] (928s left) gem_wait (wait@all-engines)
[62.593401] Starting subtest: wait
[62.594493] Starting dynamic subtest: all-engines
[63.610054] Dynamic subtest all-engines: SUCCESS (1.019s)
[63.611109] Subtest wait: SUCCESS (1.019s)
[63.823964] [050/170] (927s left) i915_getparams_basic (basic-eu-total)
[63.943086] Starting subtest: basic-eu-total
[63.945275] Subtest basic-eu-total: SUCCESS (0.000s)
[64.008178] [051/170] (927s left) i915_getparams_basic (basic-subslice-total)
[64.129185] Starting subtest: basic-subslice-total
[64.134072] Subtest basic-subslice-total: SUCCESS (0.000s)
[64.192838] [052/170] (926s left) i915_hangman (error-state-basic)
[64.316186] Starting subtest: error-state-basic
[64.424590] Subtest error-state-basic: SUCCESS (0.109s)
[64.481551] [053/170] (926s left) i915_pciid
[64.679561] [054/170] (926s left) kms_addfb_basic (addfb25-bad-modifier)
[64.803427] Starting subtest: addfb25-bad-modifier
[64.805731] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[64.915528] [055/170] (926s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[65.040793] Starting subtest: addfb25-framebuffer-vs-set-tiling
[65.041964] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[65.133842] [056/170] (926s left) kms_addfb_basic (addfb25-modifier-no-flag)
[65.260620] Starting subtest: addfb25-modifier-no-flag
[65.261741] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[65.366312] [057/170] (925s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[65.493330] Starting subtest: addfb25-x-tiled-legacy
[65.494415] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[65.602505] [058/170] (925s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[65.723367] Starting subtest: addfb25-x-tiled-mismatch-legacy
[65.724447] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[65.834966] [059/170] (925s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[65.993923] Starting subtest: addfb25-yf-tiled-legacy
[65.996701] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[66.067783] [060/170] (925s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[66.211996] Starting subtest: addfb25-y-tiled-legacy
[66.213112] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[66.285369] [061/170] (925s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[66.429586] Starting subtest: addfb25-y-tiled-small-legacy
[66.432327] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[66.503215] [062/170] (924s left) kms_addfb_basic (bad-pitch-0)
[66.628631] Starting subtest: bad-pitch-0
[66.629874] Subtest bad-pitch-0: SUCCESS (0.000s)
[66.722162] [063/170] (924s left) kms_addfb_basic (bad-pitch-1024)
[66.842821] Starting subtest: bad-pitch-1024
[66.843915] Subtest bad-pitch-1024: SUCCESS (0.000s)
[66.954873] [064/170] (924s left) kms_addfb_basic (bad-pitch-128)
[67.080783] Starting subtest: bad-pitch-128
[67.081900] Subtest bad-pitch-128: SUCCESS (0.000s)
[67.188867] [065/170] (924s left) kms_addfb_basic (bad-pitch-256)
[67.311710] Starting subtest: bad-pitch-256
[67.312834] Subtest bad-pitch-256: SUCCESS (0.000s)
[67.408056] [066/170] (924s left) kms_addfb_basic (bad-pitch-32)
[67.533056] Starting subtest: bad-pitch-32
[67.534437] Subtest bad-pitch-32: SUCCESS (0.000s)
[67.640645] [067/170] (923s left) kms_addfb_basic (bad-pitch-63)
[67.767125] Starting subtest: bad-pitch-63
[67.768228] Subtest bad-pitch-63: SUCCESS (0.000s)
[67.859630] [068/170] (923s left) kms_addfb_basic (bad-pitch-65536)
[67.984157] Starting subtest: bad-pitch-65536
[67.985250] Subtest bad-pitch-65536: SUCCESS (0.001s)
[68.091982] [069/170] (923s left) kms_addfb_basic (bad-pitch-999)
[68.218238] Starting subtest: bad-pitch-999
[68.219291] Subtest bad-pitch-999: SUCCESS (0.000s)
[68.312837] [070/170] (923s left) kms_addfb_basic (basic)
[68.434204] Starting subtest: basic
[68.435247] Subtest basic: SUCCESS (0.000s)
[68.543839] [071/170] (923s left) kms_addfb_basic (basic-x-tiled-legacy)
[68.666990] Starting subtest: basic-x-tiled-legacy
[68.668117] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[68.777688] [072/170] (922s left) kms_addfb_basic (basic-y-tiled-legacy)
[68.903774] Starting subtest: basic-y-tiled-legacy
[68.904917] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[68.994958] [073/170] (922s left) kms_addfb_basic (bo-too-small)
[69.136325] Starting subtest: bo-too-small
[69.137433] Subtest bo-too-small: SUCCESS (0.000s)
[69.211851] [074/170] (922s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[69.354975] Starting subtest: bo-too-small-due-to-tiling
[69.356281] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[69.430707] [075/170] (922s left) kms_addfb_basic (clobberred-modifier)
[69.561110] Starting subtest: clobberred-modifier
[69.562197] Subtest clobberred-modifier: SUCCESS (0.000s)
[69.664961] [076/170] (921s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[69.788445] Starting subtest: framebuffer-vs-set-tiling
[69.789588] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[69.881308] [077/170] (921s left) kms_addfb_basic (invalid-get-prop)
[70.006302] Starting subtest: invalid-get-prop
[70.007384] Subtest invalid-get-prop: SUCCESS (0.000s)
[70.099189] [078/170] (921s left) kms_addfb_basic (invalid-get-prop-any)
[70.223971] Starting subtest: invalid-get-prop-any
[70.225265] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[70.317208] [079/170] (921s left) kms_addfb_basic (invalid-set-prop)
[70.443255] Starting subtest: invalid-set-prop
[70.444965] Subtest invalid-set-prop: SUCCESS (0.000s)
[70.550635] [080/170] (921s left) kms_addfb_basic (invalid-set-prop-any)
[70.671733] Starting subtest: invalid-set-prop-any
[70.672987] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[70.783623] [081/170] (920s left) kms_addfb_basic (no-handle)
[70.909233] Starting subtest: no-handle
[70.910292] Subtest no-handle: SUCCESS (0.000s)
[71.003293] [082/170] (920s left) kms_addfb_basic (size-max)
[71.162333] Starting subtest: size-max
[71.163430] Subtest size-max: SUCCESS (0.000s)
[71.235811] [083/170] (920s left) kms_addfb_basic (small-bo)
[71.377340] Starting subtest: small-bo
[71.378839] Subtest small-bo: SUCCESS (0.000s)
[71.452746] [084/170] (920s left) kms_addfb_basic (tile-pitch-mismatch)
[71.578969] Starting subtest: tile-pitch-mismatch
[71.580199] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[71.672306] [085/170] (920s left) kms_addfb_basic (too-high)
[71.812253] Starting subtest: too-high
[71.813454] Subtest too-high: SUCCESS (0.001s)
[71.887134] [086/170] (919s left) kms_addfb_basic (too-wide)
[72.031364] Starting subtest: too-wide
[72.032379] Subtest too-wide: SUCCESS (0.000s)
[72.104822] [087/170] (919s left) kms_addfb_basic (unused-handle)
[72.230285] Starting subtest: unused-handle
[72.231632] Subtest unused-handle: SUCCESS (0.000s)
[72.324135] [088/170] (919s left) kms_addfb_basic (unused-modifier)
[72.449317] Starting subtest: unused-modifier
[72.450453] Subtest unused-modifier: SUCCESS (0.000s)
[72.558281] [089/170] (919s left) kms_addfb_basic (unused-offsets)
[72.683971] Starting subtest: unused-offsets
[72.686051] Subtest unused-offsets: SUCCESS (0.000s)
[72.792550] [090/170] (919s left) kms_addfb_basic (unused-pitches)
[72.918480] Starting subtest: unused-pitches
[72.919562] Subtest unused-pitches: SUCCESS (0.000s)
[73.009285] [091/170] (918s left) kms_busy (basic)
[73.167577] Starting subtest: basic
[73.170112] Starting dynamic subtest: flip
[73.775156] Dynamic subtest flip: SUCCESS (0.605s)
[73.788832] Starting dynamic subtest: modeset
[73.794096] Dynamic subtest modeset: SKIP (0.000s)
[73.804040] Subtest basic: SUCCESS (0.608s)
[73.892213] [092/170] (918s left) kms_chamelium_hpd (dp-hpd-fast)
[74.049923] Subtest dp-hpd-fast: SKIP (0.000s)
[74.090899] [093/170] (917s left) kms_chamelium_edid (dp-edid-read)
[74.250080] Subtest dp-edid-read: SKIP (0.000s)
[74.291523] [094/170] (917s left) kms_chamelium_frames (dp-crc-fast)
[74.449361] Subtest dp-crc-fast: SKIP (0.000s)
[74.492300] [095/170] (917s left) kms_chamelium_hpd (hdmi-hpd-fast)
[74.631617] Subtest hdmi-hpd-fast: SKIP (0.000s)
[74.676438] [096/170] (917s left) kms_chamelium_edid (hdmi-edid-read)
[74.835910] Subtest hdmi-edid-read: SKIP (0.000s)
[74.876927] [097/170] (917s left) kms_chamelium_frames (hdmi-crc-fast)
[75.018863] Subtest hdmi-crc-fast: SKIP (0.000s)
[75.044382] [098/170] (917s left) kms_chamelium_hpd (vga-hpd-fast)
[75.201289] Subtest vga-hpd-fast: SKIP (0.000s)
[75.244994] [099/170] (916s left) kms_chamelium_edid (vga-edid-read)
[75.384020] Subtest vga-edid-read: SKIP (0.000s)
[75.411635] [100/170] (916s left) kms_prop_blob (basic)
[75.533809] Starting subtest: basic
[75.534960] Subtest basic: SUCCESS (0.000s)
[75.611576] [101/170] (916s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[75.753152] Starting subtest: basic-busy-flip-before-cursor-atomic
[75.757810] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.004s)
[75.828688] [102/170] (916s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[75.970984] Starting subtest: basic-busy-flip-before-cursor-legacy
[76.973741] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.000s)
[77.089387] [103/170] (915s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[77.286687] Starting subtest: basic-flip-after-cursor-atomic
[77.288812] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[77.391467] [104/170] (914s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[77.538168] Starting subtest: basic-flip-after-cursor-legacy
[78.538602] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.001s)
[78.646949] [105/170] (913s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[78.805961] Starting subtest: basic-flip-after-cursor-varying-size
[79.813355] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.008s)
[79.934686] [106/170] (912s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[80.093695] Starting subtest: basic-flip-before-cursor-atomic
[80.095835] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[80.167428] [107/170] (912s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[80.328521] Starting subtest: basic-flip-before-cursor-legacy
[81.335943] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.003s)
[81.445454] [108/170] (910s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[81.602721] Starting subtest: basic-flip-before-cursor-varying-size
[82.611459] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.009s)
[82.736574] [109/170] (909s left) kms_flip (basic-flip-vs-dpms)
[82.877964] Starting subtest: basic-flip-vs-dpms
[82.879201] Starting dynamic subtest: A-VGA1
[84.190731] Dynamic subtest A-VGA1: SUCCESS (1.302s)
[84.209911] Starting dynamic subtest: B-VGA1
[85.429884] Dynamic subtest B-VGA1: SUCCESS (1.232s)
[85.430945] Subtest basic-flip-vs-dpms: SUCCESS (2.553s)
[85.584141] [110/170] (906s left) kms_flip (basic-flip-vs-modeset)
[85.741134] Starting subtest: basic-flip-vs-modeset
[85.742252] Starting dynamic subtest: A-VGA1
[87.032276] Dynamic subtest A-VGA1: SUCCESS (1.278s)
[87.052855] Starting dynamic subtest: B-VGA1
[88.204040] Dynamic subtest B-VGA1: SUCCESS (1.171s)
[88.204995] Subtest basic-flip-vs-modeset: SUCCESS (2.450s)
[88.326658] [111/170] (904s left) kms_flip (basic-flip-vs-wf_vblank)
[88.486210] Starting subtest: basic-flip-vs-wf_vblank
[88.487216] Starting dynamic subtest: A-VGA1
[90.044996] Dynamic subtest A-VGA1: SUCCESS (1.549s)
[90.062848] Starting dynamic subtest: B-VGA1
[91.564145] Dynamic subtest B-VGA1: SUCCESS (1.510s)
[91.565091] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.079s)
[91.761092] [112/170] (900s left) kms_flip (basic-plain-flip)
[91.902957] Starting subtest: basic-plain-flip
[91.904174] Starting dynamic subtest: A-VGA1
[93.169765] Dynamic subtest A-VGA1: SUCCESS (1.265s)
[93.186881] Starting dynamic subtest: B-VGA1
[94.404853] Dynamic subtest B-VGA1: SUCCESS (1.228s)
[94.406883] Subtest basic-plain-flip: SUCCESS (2.503s)
[94.570294] [113/170] (897s left) kms_force_connector_basic (force-connector-state)
[94.797136] Starting subtest: force-connector-state
[94.986241] Subtest force-connector-state: SUCCESS (0.189s)
[95.259627] [114/170] (897s left) kms_force_connector_basic (force-edid)
[95.465906] Starting subtest: force-edid
[95.570363] Subtest force-edid: SUCCESS (0.102s)
[95.761329] [115/170] (896s left) kms_force_connector_basic (force-load-detect)
[95.954814] Starting subtest: force-load-detect
[96.170208] Subtest force-load-detect: SUCCESS (0.214s)
[96.387225] [116/170] (896s left) kms_force_connector_basic (prune-stale-modes)
[96.563302] Starting subtest: prune-stale-modes
[96.646414] Subtest prune-stale-modes: SUCCESS (0.083s)
[96.822140] [117/170] (895s left) kms_frontbuffer_tracking (basic)
[96.982789] Subtest basic: SKIP (0.000s)
[97.025511] [118/170] (895s left) kms_pipe_crc_basic (compare-crc-sanitycheck)
[97.182792] Starting subtest: compare-crc-sanitycheck
[97.185085] Starting dynamic subtest: pipe-A-VGA-1
[97.496039] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.310s)
[97.513091] Starting dynamic subtest: pipe-B-VGA-1
[97.825366] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.311s)
[97.826420] Subtest compare-crc-sanitycheck: SUCCESS (0.638s)
[97.953194] [119/170] (894s left) kms_pipe_crc_basic (hang-read-crc)
[98.113996] Starting subtest: hang-read-crc
[98.116226] Starting dynamic subtest: pipe-A-VGA-1
[99.010366] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.894s)
[99.019979] Starting dynamic subtest: pipe-B-VGA-1
[99.909412] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.898s)
[99.910553] Subtest hang-read-crc: SUCCESS (1.796s)
[100.025565] [120/170] (892s left) kms_pipe_crc_basic (nonblocking-crc)
[100.186986] Starting subtest: nonblocking-crc
[100.188152] Starting dynamic subtest: pipe-A-VGA-1
[100.687916] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.498s)
[100.700923] Starting dynamic subtest: pipe-B-VGA-1
[101.224412] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.535s)
[101.225546] Subtest nonblocking-crc: SUCCESS (1.038s)
[101.345501] [121/170] (891s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[101.504879] Starting subtest: nonblocking-crc-frame-sequence
[101.507198] Starting dynamic subtest: pipe-A-VGA-1
[102.003883] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.497s)
[102.020842] Starting dynamic subtest: pipe-B-VGA-1
[102.522427] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.517s)
[102.523580] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.018s)
[102.627598] [122/170] (890s left) kms_pipe_crc_basic (read-crc)
[102.785364] Starting subtest: read-crc
[102.788169] Starting dynamic subtest: pipe-A-VGA-1
[103.183799] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.396s)
[103.196157] Starting dynamic subtest: pipe-B-VGA-1
[103.619418] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.434s)
[103.620643] Subtest read-crc: SUCCESS (0.833s)
[103.737347] [123/170] (888s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[103.897216] Starting subtest: read-crc-frame-sequence
[103.898383] Starting dynamic subtest: pipe-A-VGA-1
[104.310879] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.410s)
[104.328031] Starting dynamic subtest: pipe-B-VGA-1
[104.726209] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.415s)
[104.727867] Subtest read-crc-frame-sequence: SUCCESS (0.828s)
[104.842700] [124/170] (887s left) kms_psr (primary_page_flip)
[104.964284] Subtest primary_page_flip: SKIP (0.000s)
[104.995989] [125/170] (887s left) kms_psr (cursor_plane_move)
[105.120801] Subtest cursor_plane_move: SKIP (0.000s)
[105.163125] [126/170] (887s left) kms_psr (sprite_plane_onoff)
[105.287428] Subtest sprite_plane_onoff: SKIP (0.000s)
[105.330296] [127/170] (887s left) kms_psr (primary_mmap_gtt)
[105.451841] Subtest primary_mmap_gtt: SKIP (0.000s)
[105.480959] [128/170] (887s left) kms_setmode (basic-clone-single-crtc)
[105.604157] Starting subtest: basic-clone-single-crtc
[105.607663] Subtest basic-clone-single-crtc: SKIP (0.000s)
[105.678491] [129/170] (887s left) i915_pm_backlight (basic-brightness)
[105.838070] Subtest basic-brightness: SKIP (0.000s)
[105.883052] [130/170] (886s left) i915_pm_rpm (basic-pci-d3-state)
[117.189964] Subtest basic-pci-d3-state: SKIP (0.000s)
[117.222260] [131/170] (875s left) i915_pm_rpm (basic-rte)
[117.342436] Starting subtest: basic-rte
[128.537345] Subtest basic-rte: SKIP (11.181s)
[128.561698] [132/170] (864s left) i915_pm_rps (basic-api)
[128.688832] Subtest basic-api: SKIP (0.000s)
[128.710528] [133/170] (864s left) prime_self_import (basic-llseek-bad)
[128.832220] Starting subtest: basic-llseek-bad
[128.834412] Subtest basic-llseek-bad: SUCCESS (0.002s)
[128.910729] [134/170] (863s left) prime_self_import (basic-llseek-size)
[129.029176] Starting subtest: basic-llseek-size
[129.032366] Subtest basic-llseek-size: SUCCESS (0.004s)
[129.110538] [135/170] (863s left) prime_self_import (basic-with_fd_dup)
[129.228345] Starting subtest: basic-with_fd_dup
[129.232371] Subtest basic-with_fd_dup: SUCCESS (0.004s)
[129.311975] [136/170] (863s left) prime_self_import (basic-with_one_bo)
[129.432137] Starting subtest: basic-with_one_bo
[129.435538] Subtest basic-with_one_bo: SUCCESS (0.004s)
[129.479952] [137/170] (863s left) prime_self_import (basic-with_one_bo_two_files)
[129.598942] Starting subtest: basic-with_one_bo_two_files
[129.601357] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[129.680925] [138/170] (863s left) prime_self_import (basic-with_two_bos)
[129.802402] Starting subtest: basic-with_two_bos
[129.804689] Subtest basic-with_two_bos: SUCCESS (0.003s)
[129.881562] [139/170] (863s left) prime_vgem (basic-fence-flip)
[130.012110] Starting subtest: basic-fence-flip
[130.410888] Subtest basic-fence-flip: SUCCESS (0.398s)
[130.498872] [140/170] (862s left) prime_vgem (basic-fence-mmap)
[130.631101] Starting subtest: basic-fence-mmap
[130.667157] Subtest basic-fence-mmap: SUCCESS (0.040s)
[130.751441] [141/170] (862s left) prime_vgem (basic-fence-read)
[130.880782] Starting subtest: basic-fence-read
[130.946316] Subtest basic-fence-read: SUCCESS (0.066s)
[131.018673] [142/170] (862s left) prime_vgem (basic-gtt)
[131.149624] Starting subtest: basic-gtt
[131.162157] Subtest basic-gtt: SUCCESS (0.017s)
[131.236047] [143/170] (861s left) prime_vgem (basic-read)
[131.366767] Starting subtest: basic-read
[131.391081] Subtest basic-read: SUCCESS (0.028s)
[131.469087] [144/170] (861s left) prime_vgem (basic-write)
[131.601027] Starting subtest: basic-write
[131.628133] Subtest basic-write: SUCCESS (0.031s)
[131.704125] [145/170] (861s left) vgem_basic (setversion)
[131.827870] Starting subtest: setversion
[131.830105] Subtest setversion: SUCCESS (0.000s)
[131.888594] [146/170] (861s left) vgem_basic (create)
[132.012756] Starting subtest: create
[132.013949] Subtest create: SUCCESS (0.000s)
[132.072353] [147/170] (861s left) vgem_basic (debugfs)
[132.196820] Starting subtest: debugfs
[132.197989] Subtest debugfs: SUCCESS (0.001s)
[132.255945] [148/170] (860s left) vgem_basic (dmabuf-export)
[132.381498] Starting subtest: dmabuf-export
[132.383807] Subtest dmabuf-export: SUCCESS (0.002s)
[132.457071] [149/170] (860s left) vgem_basic (dmabuf-fence)
[132.582334] Starting subtest: dmabuf-fence
[132.583450] Subtest dmabuf-fence: SUCCESS (0.001s)
[132.640789] [150/170] (860s left) vgem_basic (dmabuf-fence-before)
[132.765313] Starting subtest: dmabuf-fence-before
[132.766486] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[132.826344] [151/170] (860s left) vgem_basic (dmabuf-mmap)
[132.948120] Starting subtest: dmabuf-mmap
[132.968988] Subtest dmabuf-mmap: SUCCESS (0.022s)
[133.025357] [152/170] (860s left) vgem_basic (mmap)
[133.150046] Starting subtest: mmap
[133.162869] Subtest mmap: SUCCESS (0.015s)
[133.226189] [153/170] (860s left) vgem_basic (second-client)
[133.350137] Starting subtest: second-client
[133.398751] Subtest second-client: SUCCESS (0.050s)
[133.459359] [154/170] (859s left) vgem_basic (sysfs)
[133.583892] Starting subtest: sysfs
[133.585883] Subtest sysfs: SUCCESS (0.002s)
[133.644410] [155/170] (859s left) core_hotunplug (unbind-rebind)
[133.817215] Starting subtest: unbind-rebind
[134.618364] Subtest unbind-rebind: SUCCESS (0.801s)
[134.666454] [156/170] (858s left) vgem_basic (unload)
[134.840845] Starting subtest: unload
[163.803200] Subtest unload: SUCCESS (28.961s)
[163.914419] [157/170] (829s left) i915_module_load (reload)
[164.035280] Starting subtest: reload
[166.002866] Subtest reload: SUCCESS (1.961s)
[166.027469] [158/170] (827s left) gem_lmem_swapping (basic)
[166.197391] Subtest basic: SKIP (0.000s)
[166.239462] [159/170] (827s left) gem_lmem_swapping (parallel-random-engines)
[166.410197] Subtest parallel-random-engines: SKIP (0.000s)
[166.459812] [160/170] (827s left) gem_lmem_swapping (random-engines)
[166.628524] Subtest random-engines: SKIP (0.000s)
[166.658738] [161/170] (826s left) gem_lmem_swapping (verify-random)
[166.784895] Subtest verify-random: SKIP (0.000s)
[166.808463] [162/170] (826s left) i915_pm_rpm (module-reload)
[178.127758] Subtest module-reload: SKIP (0.000s)
[178.151491] [163/170] (815s left) i915_selftest (live)
[178.896096] Starting subtest: live
[178.897866] Starting dynamic subtest: sanitycheck
[179.614550] Dynamic subtest sanitycheck: SUCCESS (0.718s)
[179.623793] Starting dynamic subtest: uncore
[180.238951] Dynamic subtest uncore: SUCCESS (0.624s)
[180.248999] Starting dynamic subtest: workarounds
[180.907204] Dynamic subtest workarounds: SUCCESS (0.667s)
[180.929042] Starting dynamic subtest: gt_engines
[181.541486] Dynamic subtest gt_engines: SUCCESS (0.634s)
[181.550359] Starting dynamic subtest: gt_timelines
[184.432877] Dynamic subtest gt_timelines: SUCCESS (2.889s)
[184.441607] Starting dynamic subtest: gt_contexts
[185.087847] Dynamic subtest gt_contexts: SUCCESS (0.655s)
[185.097119] Starting dynamic subtest: gt_lrc
[185.726657] Dynamic subtest gt_lrc: SUCCESS (0.638s)
[185.735169] Starting dynamic subtest: gt_mocs
[186.356479] Dynamic subtest gt_mocs: SUCCESS (0.629s)
[186.366409] Starting dynamic subtest: gt_pm
[187.476081] Dynamic subtest gt_pm: SUCCESS (1.118s)
[187.485036] Starting dynamic subtest: gt_heartbeat
[188.183804] Dynamic subtest gt_heartbeat: SUCCESS (0.707s)
[188.192568] Starting dynamic subtest: gt_tlb
[188.810485] Dynamic subtest gt_tlb: SUCCESS (0.627s)
[188.820786] Starting dynamic subtest: requests
[192.024800] Dynamic subtest requests: SUCCESS (3.214s)
[192.032815] Starting dynamic subtest: migrate
[192.669681] Dynamic subtest migrate: SUCCESS (0.644s)
[192.678868] Starting dynamic subtest: active
[193.361039] Dynamic subtest active: SUCCESS (0.690s)
[193.368221] Starting dynamic subtest: objects
[194.372953] Dynamic subtest objects: SUCCESS (1.011s)
[194.382122] Starting dynamic subtest: mman
[199.267034] Dynamic subtest mman: SUCCESS (4.893s)
[199.276150] Starting dynamic subtest: dmabuf
[199.957933] Dynamic subtest dmabuf: SUCCESS (0.690s)
[199.966823] Starting dynamic subtest: vma
[200.634898] Dynamic subtest vma: SUCCESS (0.677s)
[200.644282] Starting dynamic subtest: coherency
[202.387927] Dynamic subtest coherency: SUCCESS (1.751s)
[202.397184] Starting dynamic subtest: gtt
[206.706535] Dynamic subtest gtt: SUCCESS (4.318s)
[206.715205] Starting dynamic subtest: gem
[207.389594] Dynamic subtest gem: SUCCESS (0.683s)
[207.399334] Starting dynamic subtest: evict
[208.038882] Dynamic subtest evict: SUCCESS (0.648s)
[208.048832] Starting dynamic subtest: hugepages
[208.719617] Dynamic subtest hugepages: SUCCESS (0.680s)
[208.728600] Starting dynamic subtest: gem_contexts
[209.353915] Dynamic subtest gem_contexts: SUCCESS (0.633s)
[209.363327] Starting dynamic subtest: client
[210.009691] Dynamic subtest client: SUCCESS (0.655s)
[210.019402] Starting dynamic subtest: gem_migrate
[210.688700] Dynamic subtest gem_migrate: SUCCESS (0.677s)
[210.697296] Starting dynamic subtest: reset
[211.660224] Dynamic subtest reset: SUCCESS (0.970s)
[211.668795] Starting dynamic subtest: memory_region
[212.321783] Dynamic subtest memory_region: SUCCESS (0.662s)
[212.330956] Starting dynamic subtest: hangcheck
[213.969789] Dynamic subtest hangcheck: SUCCESS (1.646s)
[213.978426] Starting dynamic subtest: execlists
[214.637705] Dynamic subtest execlists: SUCCESS (0.668s)
[214.647482] Starting dynamic subtest: ring_submission
[215.296506] Dynamic subtest ring_submission: SUCCESS (0.658s)
[215.307262] Starting dynamic subtest: perf
[215.988831] Dynamic subtest perf: SUCCESS (0.691s)
[215.997786] Starting dynamic subtest: slpc
[216.630632] Dynamic subtest slpc: SUCCESS (0.641s)
[216.639834] Starting dynamic subtest: guc
[217.281953] Dynamic subtest guc: SUCCESS (0.650s)
[217.290866] Starting dynamic subtest: guc_multi_lrc
[217.928671] Dynamic subtest guc_multi_lrc: SUCCESS (0.646s)
[217.938165] Starting dynamic subtest: guc_hang
[218.629158] Dynamic subtest guc_hang: SUCCESS (0.698s)
[218.638298] Starting dynamic subtest: late_gt_pm
[219.306812] Dynamic subtest late_gt_pm: SUCCESS (0.678s)
[219.308173] Subtest live: SUCCESS (40.411s)
[219.449186] [164/170] (774s left) dmabuf (all-tests)
[219.575051] Starting subtest: all-tests
[219.579813] Starting dynamic subtest: sanitycheck
[219.633969] Dynamic subtest sanitycheck: SUCCESS (0.059s)
[219.647057] Starting dynamic subtest: dma_fence
[219.803438] Dynamic subtest dma_fence: SUCCESS (0.170s)
[219.813397] Starting dynamic subtest: dma_fence_chain
[237.003978] Dynamic subtest dma_fence_chain: SUCCESS (17.198s)
[237.016959] Starting dynamic subtest: dma_fence_unwrap
[237.060762] Dynamic subtest dma_fence_unwrap: SUCCESS (0.056s)
[237.073056] Starting dynamic subtest: dma_resv
[237.113416] Dynamic subtest dma_resv: SUCCESS (0.053s)
[237.114872] Subtest all-tests: SUCCESS (17.540s)
[237.133370] [165/170] (756s left) i915_suspend (basic-s2idle-without-i915)
[237.249885] Starting subtest: basic-s2idle-without-i915
[255.478290] Subtest basic-s2idle-without-i915: SUCCESS (18.227s)
[260.050320] [166/170] (738s left) i915_suspend (basic-s3-without-i915)
[260.176467] Starting subtest: basic-s3-without-i915
[277.144698] Subtest basic-s3-without-i915: SUCCESS (2.150s)
[279.830970] [167/170] (735s left) gem_exec_suspend (basic-s0)
[279.972097] Starting subtest: basic-S0
[279.974033] Starting dynamic subtest: smem
[297.043115] Dynamic subtest smem: SUCCESS (17.072s)
[297.044211] Subtest basic-S0: SUCCESS (17.072s)
[302.804261] [168/170] (718s left) gem_exec_suspend (basic-s3)
[302.942204] Starting subtest: basic-S3
[302.944180] Starting dynamic subtest: smem
[320.899057] Dynamic subtest smem: SUCCESS (1.873s)
[320.900177] Subtest basic-S3: SUCCESS (1.874s)
[326.083614] [169/170] (716s left) kms_chamelium_hpd (common-hpd-after-suspend)
[326.234484] Subtest common-hpd-after-suspend: SKIP (0.000s)
[326.280080] [170/170] (716s left) kms_pipe_crc_basic (suspend-read-crc)
[326.436260] Starting subtest: suspend-read-crc
[326.437414] Starting dynamic subtest: pipe-A-VGA-1
[343.994229] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.738s)
[344.010037] Starting dynamic subtest: pipe-B-VGA-1
[362.013425] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.824s)
[362.015108] Subtest suspend-read-crc: SUCCESS (3.575s)
[365.122032] Closing watchdogs
Done.