[104.043743] Initializing watchdogs
[104.044514]   /dev/watchdog0
[104.068737] [001/171] (960s left) i915_module_load (load)
[104.695241] Starting subtest: load
[109.381310] Subtest load: SUCCESS (4.689s)
[109.564621] [002/171] (955s left) core_auth (basic-auth)
[111.201792] Starting subtest: basic-auth
[111.207454] Subtest basic-auth: SUCCESS (0.004s)
[111.336356] [003/171] (953s left) debugfs_test (read_all_entries)
[111.952779] Starting subtest: read_all_entries
[112.139615] Subtest read_all_entries: SUCCESS (0.187s)
[112.328471] [004/171] (952s left) debugfs_test (basic-hwmon)
[112.941231] Starting subtest: basic-hwmon
[112.948370] Subtest basic-hwmon: SKIP (0.000s)
[113.113195] [005/171] (951s left) fbdev (eof)
[113.734558] Starting subtest: eof
[113.738616] Subtest eof: SUCCESS (0.003s)
[113.839945] [006/171] (951s left) fbdev (info)
[114.410805] Starting subtest: info
[114.415384] Subtest info: SUCCESS (0.000s)
[114.544449] [007/171] (950s left) fbdev (nullptr)
[115.183585] Starting subtest: nullptr
[115.188440] Subtest nullptr: SUCCESS (0.000s)
[115.288707] [008/171] (949s left) fbdev (read)
[115.849484] Starting subtest: read
[116.132924] Subtest read: SUCCESS (0.284s)
[116.260770] [009/171] (949s left) fbdev (write)
[116.850541] Starting subtest: write
[117.013745] Subtest write: SUCCESS (0.163s)
[117.125078] [010/171] (948s left) gem_basic (bad-close)
[117.702890] Starting subtest: bad-close
[117.709129] Subtest bad-close: SUCCESS (0.000s)
[117.822934] [011/171] (947s left) gem_basic (create-close)
[118.406365] Starting subtest: create-close
[118.413536] Subtest create-close: SUCCESS (0.001s)
[118.541733] [012/171] (946s left) gem_basic (create-fd-close)
[119.125793] Starting subtest: create-fd-close
[119.132521] Subtest create-fd-close: SUCCESS (0.001s)
[119.261179] [013/171] (946s left) gem_busy (busy@all-engines)
[119.921690] Starting subtest: busy
[119.925580] Starting dynamic subtest: all-engines
[120.040449] Dynamic subtest all-engines: SUCCESS (0.118s)
[120.044227] Subtest busy: SUCCESS (0.121s)
[120.526918] [014/171] (945s left) gem_close_race (basic-process)
[121.166287] Starting subtest: basic-process
[121.340831] Subtest basic-process: SUCCESS (0.175s)
[121.609965] [015/171] (944s left) gem_close_race (basic-threads)
[122.251229] Starting subtest: basic-threads
[123.684744] Subtest basic-threads: SUCCESS (1.435s)
[123.943833] [016/171] (941s left) gem_ctx_create (basic)
[124.546113] Subtest basic: SKIP (0.000s)
[124.647333] [017/171] (941s left) gem_ctx_create (basic-files)
[125.245326] Subtest basic-files: SKIP (0.000s)
[125.331276] [018/171] (940s left) gem_ctx_exec (basic)
[125.931297] Subtest basic: SKIP (0.000s)
[126.063744] [019/171] (939s left) gem_exec_basic (basic)
[126.682215] Starting subtest: basic
[126.686565] Starting dynamic subtest: rcs0-smem
[126.690543] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[126.694293] Subtest basic: SUCCESS (0.009s)
[126.960796] [020/171] (939s left) gem_exec_create (basic)
[127.594917] Starting subtest: basic
[127.599577] Starting dynamic subtest: smem
[129.722649] Dynamic subtest smem: SUCCESS (2.129s)
[129.726435] Subtest basic: SUCCESS (2.130s)
[129.996270] [021/171] (936s left) gem_exec_fence (basic-busy)
[130.813639] Starting subtest: basic-busy
[130.817972] Starting dynamic subtest: rcs0
[130.849340] Dynamic subtest rcs0: SUCCESS (0.030s)
[130.852188] Subtest basic-busy: SUCCESS (0.035s)
[131.713119] [022/171] (934s left) gem_exec_fence (basic-wait)
[132.526090] Starting subtest: basic-wait
[132.531266] Starting dynamic subtest: rcs0
[132.560186] Dynamic subtest rcs0: SUCCESS (0.032s)
[132.563814] Subtest basic-wait: SUCCESS (0.035s)
[133.229529] [023/171] (933s left) gem_exec_fence (basic-await)
[134.046445] Starting subtest: basic-await
[134.050584] Starting dynamic subtest: rcs0
[134.154220] Dynamic subtest rcs0: SUCCESS (0.110s)
[134.157492] Subtest basic-await: SUCCESS (0.112s)
[134.847311] [024/171] (931s left) gem_exec_fence (nb-await)
[135.653490] Starting subtest: nb-await
[135.657868] Starting dynamic subtest: rcs0
[135.718560] Dynamic subtest rcs0: SUCCESS (0.064s)
[135.723104] Subtest nb-await: SUCCESS (0.067s)
[136.399742] [025/171] (930s left) gem_exec_gttfill (basic)
[137.026576] Starting subtest: basic
[152.816249] Subtest basic: SUCCESS (15.796s)
[153.145351] [026/171] (913s left) gem_exec_parallel (engines)
[154.159974] Starting subtest: engines
[154.163628] Starting dynamic subtest: basic
[158.225461] Dynamic subtest basic: SUCCESS (4.068s)
[158.274539] Starting dynamic subtest: contexts
[158.281160] Dynamic subtest contexts: SKIP (0.003s)
[158.316453] Starting dynamic subtest: fds
[158.321628] Dynamic subtest fds: SKIP (0.003s)
[158.355109] Starting dynamic subtest: userptr
[162.468663] Dynamic subtest userptr: SUCCESS (4.237s)
[162.471531] Subtest engines: SUCCESS (8.316s)
[162.745339] [027/171] (903s left) gem_exec_store (basic)
[163.450874] Starting subtest: basic
[163.500642] Subtest basic: SUCCESS (0.052s)
[163.774696] [028/171] (902s left) gem_flink_basic (bad-flink)
[164.362512] Starting subtest: bad-flink
[164.365951] Subtest bad-flink: SUCCESS (0.000s)
[164.487806] [029/171] (902s left) gem_flink_basic (bad-open)
[165.074219] Starting subtest: bad-open
[165.081339] Subtest bad-open: SUCCESS (0.000s)
[165.203114] [030/171] (901s left) gem_flink_basic (basic)
[165.773571] Starting subtest: basic
[165.777475] Subtest basic: SUCCESS (0.001s)
[165.918225] [031/171] (901s left) gem_flink_basic (double-flink)
[166.487589] Starting subtest: double-flink
[166.491776] Subtest double-flink: SUCCESS (0.000s)
[166.619249] [032/171] (900s left) gem_flink_basic (flink-lifetime)
[167.204329] Starting subtest: flink-lifetime
[167.207897] Subtest flink-lifetime: SUCCESS (0.006s)
[167.357275] [033/171] (899s left) gem_huc_copy (huc-copy)
[167.949517] Subtest huc-copy: SKIP (0.000s)
[168.058591] [034/171] (899s left) gem_linear_blits (basic)
[169.097480] Starting subtest: basic
[169.151448] Subtest basic: SUCCESS (0.052s)
[169.394349] [035/171] (897s left) gem_mmap (basic)
[170.650823] Starting subtest: basic
[170.677830] Subtest basic: SUCCESS (0.004s)
[170.853961] [036/171] (896s left) gem_mmap_gtt (basic)
[171.773562] Starting subtest: basic
[171.783256] Subtest basic: SUCCESS (0.014s)
[171.980717] [037/171] (895s left) gem_render_linear_blits (basic)
[172.640468] Starting subtest: basic
[172.794118] Subtest basic: SUCCESS (0.143s)
[172.905845] [038/171] (894s left) gem_render_tiled_blits (basic)
[173.495104] Starting subtest: basic
[173.635290] Subtest basic: SUCCESS (0.137s)
[173.775854] [039/171] (894s left) gem_ringfill (basic-all)
[174.426349] Starting subtest: basic-all
[175.611208] Subtest basic-all: SUCCESS (1.189s)
[175.755758] [040/171] (892s left) gem_softpin (allocator-basic)
[176.337272] Subtest allocator-basic: SKIP (0.000s)
[176.472076] [041/171] (891s left) gem_softpin (allocator-basic-reserve)
[177.097385] Subtest allocator-basic-reserve: SKIP (0.000s)
[177.238571] [042/171] (890s left) gem_softpin (safe-alignment)
[177.843110] Starting subtest: safe-alignment
[177.875411] Subtest safe-alignment: SUCCESS (0.036s)
[178.020903] [043/171] (890s left) gem_sync (basic-all)
[178.663731] Starting subtest: basic-all
[180.978263] Subtest basic-all: SUCCESS (2.315s)
[181.254978] [044/171] (886s left) gem_sync (basic-each)
[181.916604] Starting subtest: basic-each
[184.282525] Subtest basic-each: SUCCESS (2.365s)
[184.557890] [045/171] (883s left) gem_tiled_blits (basic)
[185.426675] Starting subtest: basic
[185.512267] Subtest basic: SUCCESS (0.087s)
[185.731823] [046/171] (882s left) gem_tiled_fence_blits (basic)
[186.909792] Starting subtest: basic
[186.980706] Subtest basic: SUCCESS (0.071s)
[187.201089] [047/171] (881s left) gem_tiled_pread_basic
[189.864343] [048/171] (878s left) gem_wait (busy@all-engines)
[190.517287] Starting subtest: busy
[190.520672] Starting dynamic subtest: all-engines
[191.055338] Dynamic subtest all-engines: SUCCESS (0.537s)
[191.059380] Subtest busy: SUCCESS (0.539s)
[191.457320] [049/171] (877s left) gem_wait (wait@all-engines)
[192.113537] Starting subtest: wait
[192.117476] Starting dynamic subtest: all-engines
[193.153327] Dynamic subtest all-engines: SUCCESS (1.041s)
[193.157712] Subtest wait: SUCCESS (1.044s)
[193.556490] [050/171] (875s left) i915_getparams_basic (basic-eu-total)
[194.131884] Starting subtest: basic-eu-total
[194.138896] Subtest basic-eu-total: SUCCESS (0.000s)
[194.272193] [051/171] (874s left) i915_getparams_basic (basic-subslice-total)
[194.848311] Starting subtest: basic-subslice-total
[194.856124] Subtest basic-subslice-total: SUCCESS (0.000s)
[194.990663] [052/171] (873s left) i915_hangman (error-state-basic)
[195.587323] Starting subtest: error-state-basic
[195.949776] Subtest error-state-basic: SUCCESS (0.358s)
[196.077119] [053/171] (872s left) i915_pciid
[196.804903] [054/171] (872s left) kms_addfb_basic (addfb25-bad-modifier)
[197.410457] Starting subtest: addfb25-bad-modifier
[197.415989] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[197.637278] [055/171] (871s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[198.441618] Starting subtest: addfb25-framebuffer-vs-set-tiling
[198.445576] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.001s)
[198.664325] [056/171] (870s left) kms_addfb_basic (addfb25-modifier-no-flag)
[199.246538] Starting subtest: addfb25-modifier-no-flag
[199.250261] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[199.433286] [057/171] (869s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[200.023124] Starting subtest: addfb25-x-tiled-legacy
[200.027257] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[200.254662] [058/171] (869s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[200.839695] Starting subtest: addfb25-x-tiled-mismatch-legacy
[200.843464] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[201.063625] [059/171] (868s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[201.717659] Starting subtest: addfb25-yf-tiled-legacy
[201.721790] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[201.854542] [060/171] (867s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[202.496926] Starting subtest: addfb25-y-tiled-legacy
[202.501774] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[202.654377] [061/171] (867s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[203.279240] Starting subtest: addfb25-y-tiled-small-legacy
[203.287446] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[203.438501] [062/171] (866s left) kms_addfb_basic (bad-pitch-0)
[204.034737] Starting subtest: bad-pitch-0
[204.038521] Subtest bad-pitch-0: SUCCESS (0.000s)
[204.234900] [063/171] (865s left) kms_addfb_basic (bad-pitch-1024)
[204.816487] Starting subtest: bad-pitch-1024
[204.820855] Subtest bad-pitch-1024: SUCCESS (0.001s)
[205.002825] [064/171] (864s left) kms_addfb_basic (bad-pitch-128)
[205.582845] Starting subtest: bad-pitch-128
[205.586464] Subtest bad-pitch-128: SUCCESS (0.000s)
[205.803846] [065/171] (864s left) kms_addfb_basic (bad-pitch-256)
[206.400567] Starting subtest: bad-pitch-256
[206.403501] Subtest bad-pitch-256: SUCCESS (0.000s)
[206.597293] [066/171] (863s left) kms_addfb_basic (bad-pitch-32)
[207.188511] Starting subtest: bad-pitch-32
[207.193377] Subtest bad-pitch-32: SUCCESS (0.000s)
[207.381545] [067/171] (862s left) kms_addfb_basic (bad-pitch-63)
[207.976352] Starting subtest: bad-pitch-63
[207.979897] Subtest bad-pitch-63: SUCCESS (0.000s)
[208.184316] [068/171] (862s left) kms_addfb_basic (bad-pitch-65536)
[208.765580] Starting subtest: bad-pitch-65536
[208.769610] Subtest bad-pitch-65536: SUCCESS (0.002s)
[208.952889] [069/171] (861s left) kms_addfb_basic (bad-pitch-999)
[209.543818] Starting subtest: bad-pitch-999
[209.547754] Subtest bad-pitch-999: SUCCESS (0.000s)
[209.735246] [070/171] (860s left) kms_addfb_basic (basic)
[210.317248] Starting subtest: basic
[210.321259] Subtest basic: SUCCESS (0.000s)
[210.522575] [071/171] (860s left) kms_addfb_basic (basic-x-tiled-legacy)
[211.116343] Starting subtest: basic-x-tiled-legacy
[211.120400] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[211.321223] [072/171] (859s left) kms_addfb_basic (basic-y-tiled-legacy)
[211.917773] Starting subtest: basic-y-tiled-legacy
[211.924309] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[212.107253] [073/171] (858s left) kms_addfb_basic (bo-too-small)
[212.729184] Starting subtest: bo-too-small
[212.732983] Subtest bo-too-small: SUCCESS (0.002s)
[212.887913] [074/171] (858s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[213.533875] Starting subtest: bo-too-small-due-to-tiling
[213.537898] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[213.686825] [075/171] (857s left) kms_addfb_basic (clobberred-modifier)
[214.273868] Starting subtest: clobberred-modifier
[214.279882] Subtest clobberred-modifier: SUCCESS (0.001s)
[214.470251] [076/171] (856s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[215.054465] Starting subtest: framebuffer-vs-set-tiling
[215.058604] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[215.237595] [077/171] (855s left) kms_addfb_basic (invalid-get-prop)
[215.822367] Starting subtest: invalid-get-prop
[215.826995] Subtest invalid-get-prop: SUCCESS (0.000s)
[216.020350] [078/171] (855s left) kms_addfb_basic (invalid-get-prop-any)
[216.598713] Starting subtest: invalid-get-prop-any
[216.602524] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[216.812180] [079/171] (854s left) kms_addfb_basic (invalid-set-prop)
[217.408779] Starting subtest: invalid-set-prop
[217.412747] Subtest invalid-set-prop: SUCCESS (0.000s)
[217.605436] [080/171] (853s left) kms_addfb_basic (invalid-set-prop-any)
[218.199662] Starting subtest: invalid-set-prop-any
[218.204216] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[218.384429] [081/171] (853s left) kms_addfb_basic (no-handle)
[218.958542] Starting subtest: no-handle
[218.961632] Subtest no-handle: SUCCESS (0.000s)
[219.177276] [082/171] (852s left) kms_addfb_basic (size-max)
[219.809723] Starting subtest: size-max
[219.814544] Subtest size-max: SUCCESS (0.001s)
[219.974362] [083/171] (851s left) kms_addfb_basic (small-bo)
[220.615457] Starting subtest: small-bo
[220.619106] Subtest small-bo: SUCCESS (0.000s)
[220.770421] [084/171] (851s left) kms_addfb_basic (tile-pitch-mismatch)
[221.372921] Starting subtest: tile-pitch-mismatch
[221.377524] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[221.571230] [085/171] (850s left) kms_addfb_basic (too-high)
[222.191285] Starting subtest: too-high
[222.205533] Subtest too-high: SUCCESS (0.005s)
[222.353258] [086/171] (849s left) kms_addfb_basic (too-wide)
[222.999204] Starting subtest: too-wide
[223.002895] Subtest too-wide: SUCCESS (0.000s)
[223.135919] [087/171] (848s left) kms_addfb_basic (unused-handle)
[223.729758] Starting subtest: unused-handle
[223.734868] Subtest unused-handle: SUCCESS (0.000s)
[223.921827] [088/171] (848s left) kms_addfb_basic (unused-modifier)
[224.501757] Starting subtest: unused-modifier
[224.505543] Subtest unused-modifier: SUCCESS (0.000s)
[224.689446] [089/171] (847s left) kms_addfb_basic (unused-offsets)
[225.280456] Starting subtest: unused-offsets
[225.284746] Subtest unused-offsets: SUCCESS (0.000s)
[225.486290] [090/171] (846s left) kms_addfb_basic (unused-pitches)
[226.073769] Starting subtest: unused-pitches
[226.078768] Subtest unused-pitches: SUCCESS (0.000s)
[226.269309] [091/171] (846s left) kms_busy (basic)
[226.899646] Starting subtest: basic
[226.904553] Starting dynamic subtest: flip
[228.445824] Dynamic subtest flip: SUCCESS (1.544s)
[228.493965] Starting dynamic subtest: modeset
[228.500886] Dynamic subtest modeset: SKIP (0.000s)
[228.504519] Subtest basic: SUCCESS (1.551s)
[228.720493] [092/171] (843s left) kms_chamelium_hpd (dp-hpd-fast)
[229.358671] Subtest dp-hpd-fast: SKIP (0.000s)
[229.464981] [093/171] (843s left) kms_chamelium_edid (dp-edid-read)
[230.157653] Subtest dp-edid-read: SKIP (0.000s)
[230.273913] [094/171] (842s left) kms_chamelium_frames (dp-crc-fast)
[230.887738] Subtest dp-crc-fast: SKIP (0.000s)
[230.997927] [095/171] (841s left) kms_chamelium_hpd (hdmi-hpd-fast)
[231.626205] Subtest hdmi-hpd-fast: SKIP (0.000s)
[231.733735] [096/171] (841s left) kms_chamelium_edid (hdmi-edid-read)
[232.357608] Subtest hdmi-edid-read: SKIP (0.000s)
[232.468174] [097/171] (840s left) kms_chamelium_frames (hdmi-crc-fast)
[233.103841] Subtest hdmi-crc-fast: SKIP (0.000s)
[233.218717] [098/171] (839s left) kms_chamelium_hpd (vga-hpd-fast)
[233.861700] Subtest vga-hpd-fast: SKIP (0.000s)
[233.974856] [099/171] (839s left) kms_chamelium_edid (vga-edid-read)
[234.620972] Subtest vga-edid-read: SKIP (0.000s)
[234.731395] [100/171] (838s left) kms_prop_blob (basic)
[235.325184] Starting subtest: basic
[235.328633] Subtest basic: SUCCESS (0.000s)
[235.458271] [101/171] (837s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[236.072609] Starting subtest: basic-busy-flip-before-cursor-atomic
[236.088654] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.012s)
[236.229980] [102/171] (837s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[236.875555] Starting subtest: basic-busy-flip-before-cursor-legacy
[238.161525] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.291s)
[238.443088] [103/171] (835s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[239.078446] Starting subtest: basic-flip-after-cursor-atomic
[239.085114] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[239.226552] [104/171] (834s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[239.866286] Starting subtest: basic-flip-after-cursor-legacy
[241.152481] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.290s)
[241.438210] [105/171] (832s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[242.073437] Starting subtest: basic-flip-after-cursor-varying-size
[243.362452] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.288s)
[243.632193] [106/171] (830s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[244.273368] Starting subtest: basic-flip-before-cursor-atomic
[244.279714] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[244.420349] [107/171] (829s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[245.054115] Starting subtest: basic-flip-before-cursor-legacy
[246.343875] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.290s)
[246.615908] [108/171] (827s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[247.234681] Starting subtest: basic-flip-before-cursor-varying-size
[248.532608] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.294s)
[248.808611] [109/171] (825s left) kms_flip (basic-flip-vs-dpms)
[249.415668] Starting subtest: basic-flip-vs-dpms
[249.419147] Starting dynamic subtest: A-VGA1
[251.035238] Dynamic subtest A-VGA1: SUCCESS (1.615s)
[251.083630] Starting dynamic subtest: B-VGA1
[252.388518] Dynamic subtest B-VGA1: SUCCESS (1.355s)
[252.392374] Subtest basic-flip-vs-dpms: SUCCESS (2.978s)
[252.960627] [110/171] (821s left) kms_flip (basic-flip-vs-modeset)
[253.878516] Starting subtest: basic-flip-vs-modeset
[253.882239] Starting dynamic subtest: A-VGA1
[255.829302] Dynamic subtest A-VGA1: SUCCESS (1.934s)
[255.880792] Starting dynamic subtest: B-VGA1
[257.220533] Dynamic subtest B-VGA1: SUCCESS (1.406s)
[257.228146] Subtest basic-flip-vs-modeset: SUCCESS (3.348s)
[257.572898] [111/171] (816s left) kms_flip (basic-flip-vs-wf_vblank)
[258.179103] Starting subtest: basic-flip-vs-wf_vblank
[258.183397] Starting dynamic subtest: A-VGA1
[260.110402] Dynamic subtest A-VGA1: SUCCESS (1.928s)
[260.154963] Starting dynamic subtest: B-VGA1
[261.804844] Dynamic subtest B-VGA1: SUCCESS (1.694s)
[261.812374] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.630s)
[262.239618] [112/171] (812s left) kms_flip (basic-plain-flip)
[262.846340] Starting subtest: basic-plain-flip
[262.850514] Starting dynamic subtest: A-VGA1
[264.463870] Dynamic subtest A-VGA1: SUCCESS (1.614s)
[264.503878] Starting dynamic subtest: B-VGA1
[265.874497] Dynamic subtest B-VGA1: SUCCESS (1.410s)
[265.877929] Subtest basic-plain-flip: SUCCESS (3.031s)
[266.317108] [113/171] (808s left) kms_force_connector_basic (force-connector-state)
[266.965860] Starting subtest: force-connector-state
[267.252892] Subtest force-connector-state: SUCCESS (0.287s)
[267.691739] [114/171] (806s left) kms_force_connector_basic (force-edid)
[268.320626] Starting subtest: force-edid
[268.415639] Subtest force-edid: SUCCESS (0.099s)
[268.658796] [115/171] (806s left) kms_force_connector_basic (force-load-detect)
[269.283844] Starting subtest: force-load-detect
[269.669808] Subtest force-load-detect: SUCCESS (0.382s)
[270.048221] [116/171] (804s left) kms_force_connector_basic (prune-stale-modes)
[270.723461] Starting subtest: prune-stale-modes
[270.814270] Subtest prune-stale-modes: SUCCESS (0.088s)
[271.046268] [117/171] (803s left) kms_frontbuffer_tracking (basic)
[271.662381] Subtest basic: SKIP (0.000s)
[271.795408] [118/171] (803s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[272.423309] Starting subtest: compare-crc-sanitycheck-xr24
[272.426743] Starting dynamic subtest: pipe-A-VGA-1
[272.779263] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.348s)
[272.829618] Starting dynamic subtest: pipe-B-VGA-1
[273.265550] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.487s)
[273.269230] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.845s)
[273.552512] [119/171] (801s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[274.176606] Starting subtest: compare-crc-sanitycheck-nv12
[274.180294] Starting dynamic subtest: pipe-A-VGA-1
[274.187392] Dynamic subtest pipe-A-VGA-1: SKIP (0.001s)
[274.233804] Starting dynamic subtest: pipe-B-VGA-1
[274.240152] Dynamic subtest pipe-B-VGA-1: SKIP (0.001s)
[274.246731] Subtest compare-crc-sanitycheck-nv12: SKIP (0.011s)
[274.341397] [120/171] (800s left) kms_pipe_crc_basic (hang-read-crc)
[274.966453] Starting subtest: hang-read-crc
[274.970355] Starting dynamic subtest: pipe-A-VGA-1
[276.189500] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.220s)
[276.242133] Starting dynamic subtest: pipe-B-VGA-1
[277.550830] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.357s)
[277.555418] Subtest hang-read-crc: SUCCESS (2.587s)
[277.818553] [121/171] (797s left) kms_pipe_crc_basic (nonblocking-crc)
[278.453841] Starting subtest: nonblocking-crc
[278.457771] Starting dynamic subtest: pipe-A-VGA-1
[279.005340] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.550s)
[279.056118] Starting dynamic subtest: pipe-B-VGA-1
[279.700264] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.693s)
[279.704236] Subtest nonblocking-crc: SUCCESS (1.255s)
[279.993772] [122/171] (795s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[280.643171] Starting subtest: nonblocking-crc-frame-sequence
[280.647456] Starting dynamic subtest: pipe-A-VGA-1
[281.230838] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.584s)
[281.282283] Starting dynamic subtest: pipe-B-VGA-1
[281.908354] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.672s)
[281.912446] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.267s)
[282.164263] [123/171] (793s left) kms_pipe_crc_basic (read-crc)
[282.793213] Starting subtest: read-crc
[282.797454] Starting dynamic subtest: pipe-A-VGA-1
[283.274294] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.480s)
[283.330695] Starting dynamic subtest: pipe-B-VGA-1
[283.882413] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.603s)
[283.887328] Subtest read-crc: SUCCESS (1.095s)
[284.140303] [124/171] (791s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[284.764665] Starting subtest: read-crc-frame-sequence
[284.768943] Starting dynamic subtest: pipe-A-VGA-1
[285.266304] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.500s)
[285.322823] Starting dynamic subtest: pipe-B-VGA-1
[285.883930] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.606s)
[285.888864] Subtest read-crc-frame-sequence: SUCCESS (1.118s)
[286.142323] [125/171] (789s left) kms_psr (primary_page_flip)
[286.732095] Subtest primary_page_flip: SKIP (0.000s)
[286.829932] [126/171] (788s left) kms_psr (cursor_plane_move)
[287.407554] Subtest cursor_plane_move: SKIP (0.000s)
[287.511475] [127/171] (788s left) kms_psr (sprite_plane_onoff)
[288.082438] Subtest sprite_plane_onoff: SKIP (0.000s)
[288.197753] [128/171] (787s left) kms_psr (primary_mmap_gtt)
[288.763770] Subtest primary_mmap_gtt: SKIP (0.000s)
[288.898680] [129/171] (787s left) kms_setmode (basic-clone-single-crtc)
[289.489679] Starting subtest: basic-clone-single-crtc
[289.502452] Subtest basic-clone-single-crtc: SKIP (0.001s)
[289.644330] [130/171] (786s left) i915_pm_backlight (basic-brightness)
[290.287251] Subtest basic-brightness: SKIP (0.000s)
[290.395313] [131/171] (785s left) i915_pm_rpm (basic-pci-d3-state)
[302.518594] Subtest basic-pci-d3-state: SKIP (0.000s)
[302.616192] [132/171] (773s left) i915_pm_rpm (basic-rte)
[303.191902] Starting subtest: basic-rte
[314.717301] Subtest basic-rte: SKIP (11.512s)
[314.832579] [133/171] (761s left) i915_pm_rps (basic-api)
[315.423896] Subtest basic-api: SKIP (0.000s)
[315.534629] [134/171] (760s left) prime_self_import (basic-llseek-bad)
[316.097980] Starting subtest: basic-llseek-bad
[316.106557] Subtest basic-llseek-bad: SUCCESS (0.010s)
[316.268327] [135/171] (760s left) prime_self_import (basic-llseek-size)
[316.875459] Starting subtest: basic-llseek-size
[316.901763] Subtest basic-llseek-size: SUCCESS (0.033s)
[317.073525] [136/171] (759s left) prime_self_import (basic-with_fd_dup)
[317.851685] Starting subtest: basic-with_fd_dup
[317.864911] Subtest basic-with_fd_dup: SUCCESS (0.019s)
[318.045458] [137/171] (758s left) prime_self_import (basic-with_one_bo)
[318.597593] Starting subtest: basic-with_one_bo
[318.613556] Subtest basic-with_one_bo: SUCCESS (0.021s)
[318.757381] [138/171] (758s left) prime_self_import (basic-with_one_bo_two_files)
[319.310576] Starting subtest: basic-with_one_bo_two_files
[319.326644] Subtest basic-with_one_bo_two_files: SUCCESS (0.012s)
[319.480355] [139/171] (757s left) prime_self_import (basic-with_two_bos)
[320.031763] Starting subtest: basic-with_two_bos
[320.051498] Subtest basic-with_two_bos: SUCCESS (0.020s)
[320.194455] [140/171] (756s left) prime_vgem (basic-fence-flip)
[320.770303] Starting subtest: basic-fence-flip
[321.339746] Subtest basic-fence-flip: SUCCESS (0.566s)
[321.511346] [141/171] (755s left) prime_vgem (basic-fence-mmap)
[322.125571] Starting subtest: basic-fence-mmap
[322.279871] Subtest basic-fence-mmap: SUCCESS (0.159s)
[322.430357] [142/171] (754s left) prime_vgem (basic-fence-read)
[323.022265] Starting subtest: basic-fence-read
[323.307716] Subtest basic-fence-read: SUCCESS (0.286s)
[323.474659] [143/171] (753s left) prime_vgem (basic-gtt)
[324.073925] Starting subtest: basic-gtt
[324.175748] Subtest basic-gtt: SUCCESS (0.099s)
[324.326781] [144/171] (753s left) prime_vgem (basic-read)
[324.920565] Starting subtest: basic-read
[325.042405] Subtest basic-read: SUCCESS (0.120s)
[325.247601] [145/171] (752s left) prime_vgem (basic-write)
[325.857849] Starting subtest: basic-write
[325.999397] Subtest basic-write: SUCCESS (0.141s)
[326.143786] [146/171] (751s left) vgem_basic (setversion)
[326.721579] Starting subtest: setversion
[326.728909] Subtest setversion: SUCCESS (0.000s)
[326.846163] [147/171] (750s left) vgem_basic (create)
[327.421793] Starting subtest: create
[327.425754] Subtest create: SUCCESS (0.001s)
[327.552766] [148/171] (750s left) vgem_basic (debugfs)
[328.121744] Starting subtest: debugfs
[328.126395] Subtest debugfs: SUCCESS (0.004s)
[328.258274] [149/171] (749s left) vgem_basic (dmabuf-export)
[328.821296] Starting subtest: dmabuf-export
[328.835196] Subtest dmabuf-export: SUCCESS (0.014s)
[328.979965] [150/171] (749s left) vgem_basic (dmabuf-fence)
[329.572519] Starting subtest: dmabuf-fence
[329.576671] Subtest dmabuf-fence: SUCCESS (0.004s)
[329.710725] [151/171] (748s left) vgem_basic (dmabuf-fence-before)
[330.304288] Starting subtest: dmabuf-fence-before
[330.308239] Subtest dmabuf-fence-before: SUCCESS (0.004s)
[330.442747] [152/171] (747s left) vgem_basic (dmabuf-mmap)
[331.005569] Starting subtest: dmabuf-mmap
[331.088972] Subtest dmabuf-mmap: SUCCESS (0.086s)
[331.226785] [153/171] (747s left) vgem_basic (mmap)
[331.804732] Starting subtest: mmap
[331.861924] Subtest mmap: SUCCESS (0.058s)
[331.996875] [154/171] (746s left) vgem_basic (second-client)
[332.571790] Starting subtest: second-client
[332.604667] Subtest second-client: SUCCESS (0.033s)
[332.728235] [155/171] (745s left) vgem_basic (sysfs)
[333.320818] Starting subtest: sysfs
[333.330740] Subtest sysfs: SUCCESS (0.007s)
[333.460950] [156/171] (745s left) core_hotunplug (unbind-rebind)
[334.170309] Starting subtest: unbind-rebind
[336.974904] Subtest unbind-rebind: SUCCESS (2.804s)
[337.308263] [157/171] (741s left) vgem_basic (unload)
[338.390105] Starting subtest: unload
[367.797536] Subtest unload: SUCCESS (29.413s)
[368.061561] [158/171] (710s left) i915_module_load (reload)
[368.633171] Starting subtest: reload
[373.994139] Subtest reload: SUCCESS (5.361s)
[374.121477] [159/171] (704s left) gem_lmem_swapping (basic)
[375.467918] Subtest basic: SKIP (0.000s)
[375.574463] [160/171] (703s left) gem_lmem_swapping (parallel-random-engines)
[376.169233] Subtest parallel-random-engines: SKIP (0.000s)
[376.272730] [161/171] (702s left) gem_lmem_swapping (random-engines)
[376.858098] Subtest random-engines: SKIP (0.000s)
[376.957501] [162/171] (702s left) gem_lmem_swapping (verify-random)
[377.551510] Subtest verify-random: SKIP (0.000s)
[377.654937] [163/171] (701s left) i915_pm_rpm (module-reload)
[389.824722] Subtest module-reload: SKIP (0.000s)
[389.927147] [164/171] (689s left) i915_selftest (live)
[392.487354] Starting subtest: live
[392.491164] Starting dynamic subtest: sanitycheck
[395.290993] Dynamic subtest sanitycheck: SUCCESS (2.802s)
[395.327704] Starting dynamic subtest: uncore
[397.466119] Dynamic subtest uncore: SUCCESS (2.170s)
[397.509155] Starting dynamic subtest: workarounds
[399.616520] Dynamic subtest workarounds: SUCCESS (2.146s)
[399.654502] Starting dynamic subtest: gt_engines
[401.769562] Dynamic subtest gt_engines: SUCCESS (2.149s)
[401.812129] Starting dynamic subtest: gt_timelines
[412.974459] Dynamic subtest gt_timelines: SUCCESS (11.199s)
[413.010517] Starting dynamic subtest: gt_contexts
[415.179125] Dynamic subtest gt_contexts: SUCCESS (2.202s)
[415.230892] Starting dynamic subtest: gt_lrc
[417.416609] Dynamic subtest gt_lrc: SUCCESS (2.234s)
[417.459447] Starting dynamic subtest: gt_mocs
[419.577646] Dynamic subtest gt_mocs: SUCCESS (2.158s)
[419.619513] Starting dynamic subtest: gt_pm
[422.140526] Dynamic subtest gt_pm: SUCCESS (2.558s)
[422.181949] Starting dynamic subtest: gt_heartbeat
[424.399849] Dynamic subtest gt_heartbeat: SUCCESS (2.255s)
[424.437817] Starting dynamic subtest: gt_tlb
[426.571124] Dynamic subtest gt_tlb: SUCCESS (2.165s)
[426.609732] Starting dynamic subtest: requests
[431.270273] Dynamic subtest requests: SUCCESS (4.696s)
[431.305983] Starting dynamic subtest: migrate
[433.387304] Dynamic subtest migrate: SUCCESS (2.114s)
[433.425961] Starting dynamic subtest: active
[435.561849] Dynamic subtest active: SUCCESS (2.169s)
[435.607191] Starting dynamic subtest: objects
[438.691191] Dynamic subtest objects: SUCCESS (3.126s)
[438.722277] Starting dynamic subtest: mman
[450.398809] Dynamic subtest mman: SUCCESS (11.704s)
[450.435423] Starting dynamic subtest: dmabuf
[452.667358] Dynamic subtest dmabuf: SUCCESS (2.263s)
[452.711816] Starting dynamic subtest: vma
[454.886377] Dynamic subtest vma: SUCCESS (2.213s)
[454.926909] Starting dynamic subtest: coherency
[462.034271] Dynamic subtest coherency: SUCCESS (7.146s)
[462.073322] Starting dynamic subtest: gtt
[467.638659] Dynamic subtest gtt: SUCCESS (5.600s)
[467.673682] Starting dynamic subtest: gem
[469.902258] Dynamic subtest gem: SUCCESS (2.258s)
[469.943836] Starting dynamic subtest: evict
[472.077918] Dynamic subtest evict: SUCCESS (2.172s)
[472.120919] Starting dynamic subtest: hugepages
[474.224482] Dynamic subtest hugepages: SUCCESS (2.144s)
[474.264197] Starting dynamic subtest: gem_contexts
[476.375155] Dynamic subtest gem_contexts: SUCCESS (2.146s)
[476.415359] Starting dynamic subtest: client
[478.633496] Dynamic subtest client: SUCCESS (2.255s)
[478.672472] Starting dynamic subtest: gem_migrate
[480.794503] Dynamic subtest gem_migrate: SUCCESS (2.157s)
[480.856327] Starting dynamic subtest: reset
[483.568756] Dynamic subtest reset: SUCCESS (2.769s)
[483.605378] Starting dynamic subtest: memory_region
[485.745255] Dynamic subtest memory_region: SUCCESS (2.170s)
[485.787300] Starting dynamic subtest: hangcheck
[488.982514] Dynamic subtest hangcheck: SUCCESS (3.234s)
[489.018694] Starting dynamic subtest: execlists
[491.198495] Dynamic subtest execlists: SUCCESS (2.211s)
[491.236413] Starting dynamic subtest: ring_submission
[493.390220] Dynamic subtest ring_submission: SUCCESS (2.187s)
[493.434505] Starting dynamic subtest: perf
[495.552517] Dynamic subtest perf: SUCCESS (2.157s)
[495.588183] Starting dynamic subtest: slpc
[497.700682] Dynamic subtest slpc: SUCCESS (2.141s)
[497.740995] Starting dynamic subtest: guc
[499.876312] Dynamic subtest guc: SUCCESS (2.172s)
[499.928145] Starting dynamic subtest: guc_multi_lrc
[502.049741] Dynamic subtest guc_multi_lrc: SUCCESS (2.167s)
[502.087856] Starting dynamic subtest: guc_hang
[504.160204] Dynamic subtest guc_hang: SUCCESS (2.106s)
[504.203892] Starting dynamic subtest: late_gt_pm
[506.363503] Dynamic subtest late_gt_pm: SUCCESS (2.196s)
[506.367919] Subtest live: SUCCESS (113.877s)
[506.701580] [165/171] (572s left) dmabuf (all-tests)
[507.436854] Starting subtest: all-tests
[507.441594] Starting dynamic subtest: sanitycheck
[507.531453] Dynamic subtest sanitycheck: SUCCESS (0.094s)
[507.573660] Starting dynamic subtest: dma_fence
[507.761253] Dynamic subtest dma_fence: SUCCESS (0.225s)
[507.803224] Starting dynamic subtest: dma_fence_chain
[560.104308] Dynamic subtest dma_fence_chain: SUCCESS (52.338s)
[560.145718] Starting dynamic subtest: dma_fence_unwrap
[560.202540] Dynamic subtest dma_fence_unwrap: SUCCESS (0.095s)
[560.245743] Starting dynamic subtest: dma_resv
[560.318314] Dynamic subtest dma_resv: SUCCESS (0.110s)
[560.322581] Subtest all-tests: SUCCESS (52.886s)
[560.402981] [166/171] (519s left) i915_suspend (basic-s2idle-without-i915)
[560.960507] Starting subtest: basic-s2idle-without-i915
[583.712116] Subtest basic-s2idle-without-i915: SUCCESS (7.549s)
[585.995999] [167/171] (511s left) i915_suspend (basic-s3-without-i915)
[586.771167] Starting subtest: basic-s3-without-i915
[608.062763] Subtest basic-s3-without-i915: SUCCESS (5.122s)
[611.364731] [168/171] (504s left) gem_exec_suspend (basic-s0)
[612.107244] Starting subtest: basic-S0
[612.111494] Starting dynamic subtest: smem
[633.785578] Dynamic subtest smem: SUCCESS (6.271s)
[633.789409] Subtest basic-S0: SUCCESS (6.275s)
[635.715351] [169/171] (497s left) gem_exec_suspend (basic-s3)
[636.406749] Starting subtest: basic-S3
[636.411232] Starting dynamic subtest: smem
[658.904011] Dynamic subtest smem: SUCCESS (6.324s)
[658.907964] Subtest basic-S3: SUCCESS (6.328s)
[663.221142] [170/171] (490s left) kms_chamelium_hpd (common-hpd-after-suspend)
[663.867195] Subtest common-hpd-after-suspend: SKIP (0.000s)
[663.991923] [171/171] (489s left) kms_pipe_crc_basic (suspend-read-crc)
[664.615709] Starting subtest: suspend-read-crc
[664.619262] Starting dynamic subtest: pipe-A-VGA-1
[683.565047] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.476s)
[683.646365] Starting dynamic subtest: pipe-B-VGA-1
[701.646194] Dynamic subtest pipe-B-VGA-1: SUCCESS (2.487s)
[701.649692] Subtest suspend-read-crc: SUCCESS (4.980s)
[705.927970] Closing watchdogs
Done.