[42.660175] Initializing watchdogs [42.660374] /dev/watchdog0 [42.670344] [001/171] (960s left) i915_module_load (load) [42.978165] Starting subtest: load [45.568246] Subtest load: SUCCESS (2.588s) [45.593587] [002/171] (957s left) core_auth (basic-auth) [45.742370] Starting subtest: basic-auth [45.743831] Subtest basic-auth: SUCCESS (0.002s) [45.813321] [003/171] (957s left) debugfs_test (read_all_entries) [45.965708] Starting subtest: read_all_entries [46.051221] Subtest read_all_entries: SUCCESS (0.085s) [46.164052] [004/171] (957s left) debugfs_test (basic-hwmon) [46.312428] Starting subtest: basic-hwmon [46.314788] Subtest basic-hwmon: SKIP (0.000s) [46.432539] [005/171] (956s left) fbdev (eof) [46.617325] Starting subtest: eof [46.618648] Subtest eof: SUCCESS (0.000s) [46.678409] [006/171] (956s left) fbdev (info) [46.819848] Starting subtest: info [46.821321] Subtest info: SUCCESS (0.000s) [46.899204] [007/171] (956s left) fbdev (nullptr) [47.049580] Starting subtest: nullptr [47.050836] Subtest nullptr: SUCCESS (0.000s) [47.114164] [008/171] (956s left) fbdev (read) [47.265994] Starting subtest: read [54.396910] Subtest read: SUCCESS (7.096s) [54.431356] [009/171] (948s left) fbdev (write) [54.582837] Starting subtest: write [58.375068] Subtest write: SUCCESS (3.757s) [58.414178] [010/171] (944s left) gem_basic (bad-close) [58.568459] Starting subtest: bad-close [58.570973] Subtest bad-close: SUCCESS (0.000s) [58.653408] [011/171] (944s left) gem_basic (create-close) [58.798063] Starting subtest: create-close [58.800236] Subtest create-close: SUCCESS (0.000s) [58.899810] [012/171] (944s left) gem_basic (create-fd-close) [59.044268] Starting subtest: create-fd-close [59.046369] Subtest create-fd-close: SUCCESS (0.000s) [59.134908] [013/171] (944s left) gem_busy (busy@all-engines) [59.297170] Starting subtest: busy [59.298451] Starting dynamic subtest: all-engines [59.349134] Dynamic subtest all-engines: SUCCESS (0.052s) [59.350631] Subtest busy: SUCCESS (0.052s) [59.741028] [014/171] (943s left) gem_close_race (basic-process) [59.904395] Starting subtest: basic-process [59.988065] Subtest basic-process: SUCCESS (0.083s) [60.186703] [015/171] (943s left) gem_close_race (basic-threads) [60.352469] Starting subtest: basic-threads [61.503367] Subtest basic-threads: SUCCESS (1.151s) [61.736539] [016/171] (941s left) gem_ctx_create (basic) [61.898541] Starting subtest: basic [61.899742] Subtest basic: SUCCESS (0.001s) [62.104310] [017/171] (941s left) gem_ctx_create (basic-files) [62.254407] Starting subtest: basic-files [64.276558] Subtest basic-files: SUCCESS (2.022s) [64.505847] [018/171] (939s left) gem_ctx_exec (basic) [64.646423] Starting subtest: basic [64.651494] Subtest basic: SUCCESS (0.005s) [64.764519] [019/171] (938s left) gem_exec_basic (basic) [64.913434] Starting subtest: basic [64.914670] Starting dynamic subtest: rcs0-smem [64.915830] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [64.928023] Starting dynamic subtest: bcs0-smem [64.929405] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [64.939488] Starting dynamic subtest: vcs0-smem [64.940780] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [64.950991] Starting dynamic subtest: vecs0-smem [64.952424] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [64.953750] Subtest basic: SUCCESS (0.006s) [65.127593] [020/171] (938s left) gem_exec_create (basic) [65.286294] Starting subtest: basic [65.287534] Starting dynamic subtest: smem [67.350403] Dynamic subtest smem: SUCCESS (2.041s) [67.351849] Subtest basic: SUCCESS (2.041s) [67.552204] [021/171] (936s left) gem_exec_fence (basic-busy) [67.851060] Starting subtest: basic-busy [67.852458] Starting dynamic subtest: rcs0 [67.868757] Dynamic subtest rcs0: SUCCESS (0.026s) [67.880177] Starting dynamic subtest: bcs0 [67.900691] Dynamic subtest bcs0: SUCCESS (0.032s) [67.911961] Starting dynamic subtest: vcs0 [67.929428] Dynamic subtest vcs0: SUCCESS (0.028s) [67.940751] Starting dynamic subtest: vecs0 [67.959637] Dynamic subtest vecs0: SUCCESS (0.030s) [67.960922] Subtest basic-busy: SUCCESS (0.117s) [68.572438] [022/171] (935s left) gem_exec_fence (basic-wait) [68.880622] Starting subtest: basic-wait [68.882111] Starting dynamic subtest: rcs0 [68.893516] Dynamic subtest rcs0: SUCCESS (0.021s) [68.905647] Starting dynamic subtest: bcs0 [68.914814] Dynamic subtest bcs0: SUCCESS (0.021s) [68.926274] Starting dynamic subtest: vcs0 [68.940442] Dynamic subtest vcs0: SUCCESS (0.026s) [68.951627] Starting dynamic subtest: vecs0 [68.981529] Dynamic subtest vecs0: SUCCESS (0.040s) [68.983181] Subtest basic-wait: SUCCESS (0.109s) [69.536450] [023/171] (934s left) gem_exec_fence (basic-await) [69.844165] Starting subtest: basic-await [69.845385] Starting dynamic subtest: rcs0 [69.931748] Dynamic subtest rcs0: SUCCESS (0.094s) [69.958155] Starting dynamic subtest: bcs0 [70.055230] Dynamic subtest bcs0: SUCCESS (0.124s) [70.082562] Starting dynamic subtest: vcs0 [70.179435] Dynamic subtest vcs0: SUCCESS (0.122s) [70.200521] Starting dynamic subtest: vecs0 [70.281376] Dynamic subtest vecs0: SUCCESS (0.103s) [70.283665] Subtest basic-await: SUCCESS (0.445s) [70.888286] [024/171] (932s left) gem_exec_fence (nb-await) [71.195937] Starting subtest: nb-await [71.197311] Starting dynamic subtest: rcs0 [71.252598] Dynamic subtest rcs0: SUCCESS (0.064s) [71.269555] Starting dynamic subtest: bcs0 [71.322533] Dynamic subtest bcs0: SUCCESS (0.069s) [71.343882] Starting dynamic subtest: vcs0 [71.396217] Dynamic subtest vcs0: SUCCESS (0.073s) [71.422328] Starting dynamic subtest: vecs0 [71.472594] Dynamic subtest vecs0: SUCCESS (0.075s) [71.474947] Subtest nb-await: SUCCESS (0.285s) [72.032936] [025/171] (931s left) gem_exec_gttfill (basic) [72.194887] Starting subtest: basic [80.959086] Subtest basic: SUCCESS (8.756s) [81.134784] [026/171] (922s left) gem_exec_parallel (engines) [81.361806] Starting subtest: engines [81.363222] Starting dynamic subtest: basic [84.208590] Dynamic subtest basic: SUCCESS (2.823s) [84.221437] Starting dynamic subtest: contexts [87.979084] Dynamic subtest contexts: SUCCESS (3.785s) [87.991906] Starting dynamic subtest: fds [92.972055] Dynamic subtest fds: SUCCESS (4.987s) [92.984880] Starting dynamic subtest: userptr [95.684679] Dynamic subtest userptr: SUCCESS (2.699s) [95.687107] Subtest engines: SUCCESS (14.294s) [95.889632] [027/171] (907s left) gem_exec_store (basic) [96.051298] Starting subtest: basic [96.114654] Subtest basic: SUCCESS (0.064s) [96.331816] [028/171] (907s left) gem_flink_basic (bad-flink) [96.474305] Starting subtest: bad-flink [96.475529] Subtest bad-flink: SUCCESS (0.000s) [96.555234] [029/171] (907s left) gem_flink_basic (bad-open) [96.699375] Starting subtest: bad-open [96.700545] Subtest bad-open: SUCCESS (0.000s) [96.788804] [030/171] (907s left) gem_flink_basic (basic) [96.927512] Starting subtest: basic [96.928669] Subtest basic: SUCCESS (0.000s) [97.038554] [031/171] (906s left) gem_flink_basic (double-flink) [97.183353] Starting subtest: double-flink [97.184601] Subtest double-flink: SUCCESS (0.000s) [97.288383] [032/171] (906s left) gem_flink_basic (flink-lifetime) [97.433453] Starting subtest: flink-lifetime [97.434689] Subtest flink-lifetime: SUCCESS (0.002s) [97.554926] [033/171] (906s left) gem_huc_copy (huc-copy) [97.704691] Starting subtest: huc-copy [97.707283] Subtest huc-copy: SKIP (0.000s) [97.821351] [034/171] (906s left) gem_linear_blits (basic) [98.133105] Starting subtest: basic [98.146997] Subtest basic: SUCCESS (0.014s) [98.276112] [035/171] (905s left) gem_mmap (basic) [98.483153] Starting subtest: basic [98.488567] Subtest basic: SUCCESS (0.001s) [98.588304] [036/171] (905s left) gem_mmap_gtt (basic) [98.733386] Starting subtest: basic [98.734733] Subtest basic: SUCCESS (0.001s) [98.816324] [037/171] (905s left) gem_render_linear_blits (basic) [98.963339] Starting subtest: basic [99.020062] Subtest basic: SUCCESS (0.057s) [99.087708] [038/171] (905s left) gem_render_tiled_blits (basic) [99.238297] Starting subtest: basic [99.304478] Subtest basic: SUCCESS (0.065s) [99.365932] [039/171] (904s left) gem_ringfill (basic-all) [99.655458] Starting subtest: basic-all [100.890279] Subtest basic-all: SUCCESS (1.225s) [100.979495] [040/171] (903s left) gem_softpin (allocator-basic) [101.131845] Starting subtest: allocator-basic [101.320476] Subtest allocator-basic: SUCCESS (0.181s) [101.449785] [041/171] (902s left) gem_softpin (allocator-basic-reserve) [101.617075] Starting subtest: allocator-basic-reserve [101.817079] Subtest allocator-basic-reserve: SUCCESS (0.191s) [101.935816] [042/171] (902s left) gem_softpin (safe-alignment) [102.105141] Starting subtest: safe-alignment [102.127635] Subtest safe-alignment: SUCCESS (0.022s) [102.236539] [043/171] (902s left) gem_sync (basic-all) [102.407362] Starting subtest: basic-all [105.083310] Subtest basic-all: SUCCESS (2.651s) [105.251260] [044/171] (899s left) gem_sync (basic-each) [105.412152] Starting subtest: basic-each [107.665399] Subtest basic-each: SUCCESS (2.253s) [107.869786] [045/171] (896s left) gem_tiled_blits (basic) [108.185559] Starting subtest: basic [108.223439] Subtest basic: SUCCESS (0.038s) [108.355967] [046/171] (895s left) gem_tiled_fence_blits (basic) [108.735058] Starting subtest: basic [108.764662] Subtest basic: SUCCESS (0.030s) [108.909953] [047/171] (895s left) gem_tiled_pread_basic [109.480500] [048/171] (894s left) gem_wait (busy@all-engines) [109.649386] Starting subtest: busy [109.650737] Starting dynamic subtest: all-engines [110.173429] Dynamic subtest all-engines: SUCCESS (0.524s) [110.174616] Subtest busy: SUCCESS (0.524s) [110.422876] [049/171] (893s left) gem_wait (wait@all-engines) [110.589730] Starting subtest: wait [110.591103] Starting dynamic subtest: all-engines [111.635381] Dynamic subtest all-engines: SUCCESS (1.043s) [111.636682] Subtest wait: SUCCESS (1.043s) [111.874610] [050/171] (892s left) i915_getparams_basic (basic-eu-total) [112.009825] Starting subtest: basic-eu-total [112.012176] Subtest basic-eu-total: SUCCESS (0.000s) [112.089394] [051/171] (892s left) i915_getparams_basic (basic-subslice-total) [112.224811] Starting subtest: basic-subslice-total [112.227330] Subtest basic-subslice-total: SUCCESS (0.000s) [112.306518] [052/171] (892s left) i915_hangman (error-state-basic) [112.467015] Starting subtest: error-state-basic [112.480265] Subtest error-state-basic: SUCCESS (0.013s) [112.568839] [053/171] (891s left) i915_pciid [112.791217] [054/171] (891s left) kms_addfb_basic (addfb25-bad-modifier) [112.969741] Starting subtest: addfb25-bad-modifier [112.970946] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [113.135466] [055/171] (891s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [113.317630] Starting subtest: addfb25-framebuffer-vs-set-tiling [113.318781] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [113.468477] [056/171] (891s left) kms_addfb_basic (addfb25-modifier-no-flag) [113.646889] Starting subtest: addfb25-modifier-no-flag [113.648218] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [113.802289] [057/171] (890s left) kms_addfb_basic (addfb25-x-tiled-legacy) [113.981744] Starting subtest: addfb25-x-tiled-legacy [113.982922] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [114.135429] [058/171] (890s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [114.315845] Starting subtest: addfb25-x-tiled-mismatch-legacy [114.317014] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [114.468692] [059/171] (890s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [114.669995] Starting subtest: addfb25-yf-tiled-legacy [114.671417] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [114.801940] [060/171] (889s left) kms_addfb_basic (addfb25-y-tiled-legacy) [115.009905] Starting subtest: addfb25-y-tiled-legacy [115.011196] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [115.135286] [061/171] (889s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [115.337070] Starting subtest: addfb25-y-tiled-small-legacy [115.338206] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [115.452020] [062/171] (889s left) kms_addfb_basic (bad-pitch-0) [115.590487] Starting subtest: bad-pitch-0 [115.591793] Subtest bad-pitch-0: SUCCESS (0.000s) [115.785517] [063/171] (888s left) kms_addfb_basic (bad-pitch-1024) [115.932390] Starting subtest: bad-pitch-1024 [115.933637] Subtest bad-pitch-1024: SUCCESS (0.000s) [116.135182] [064/171] (888s left) kms_addfb_basic (bad-pitch-128) [116.282817] Starting subtest: bad-pitch-128 [116.284060] Subtest bad-pitch-128: SUCCESS (0.000s) [116.468801] [065/171] (888s left) kms_addfb_basic (bad-pitch-256) [116.615212] Starting subtest: bad-pitch-256 [116.616382] Subtest bad-pitch-256: SUCCESS (0.000s) [116.802176] [066/171] (888s left) kms_addfb_basic (bad-pitch-32) [116.948834] Starting subtest: bad-pitch-32 [116.950111] Subtest bad-pitch-32: SUCCESS (0.000s) [117.151803] [067/171] (887s left) kms_addfb_basic (bad-pitch-63) [117.300480] Starting subtest: bad-pitch-63 [117.301670] Subtest bad-pitch-63: SUCCESS (0.000s) [117.502260] [068/171] (887s left) kms_addfb_basic (bad-pitch-65536) [117.647484] Starting subtest: bad-pitch-65536 [117.648818] Subtest bad-pitch-65536: SUCCESS (0.000s) [117.835244] [069/171] (887s left) kms_addfb_basic (bad-pitch-999) [117.980317] Starting subtest: bad-pitch-999 [117.981751] Subtest bad-pitch-999: SUCCESS (0.000s) [118.168948] [070/171] (886s left) kms_addfb_basic (basic) [118.304979] Starting subtest: basic [118.306410] Subtest basic: SUCCESS (0.000s) [118.501955] [071/171] (886s left) kms_addfb_basic (basic-x-tiled-legacy) [118.740727] Starting subtest: basic-x-tiled-legacy [118.742033] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [118.852077] [072/171] (886s left) kms_addfb_basic (basic-y-tiled-legacy) [119.083450] Starting subtest: basic-y-tiled-legacy [119.084723] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [119.201761] [073/171] (885s left) kms_addfb_basic (bo-too-small) [119.378869] Starting subtest: bo-too-small [119.380152] Subtest bo-too-small: SUCCESS (0.000s) [119.552063] [074/171] (885s left) kms_addfb_basic (bo-too-small-due-to-tiling) [119.729715] Starting subtest: bo-too-small-due-to-tiling [119.730931] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [119.901901] [075/171] (885s left) kms_addfb_basic (clobberred-modifier) [120.049590] Starting subtest: clobberred-modifier [120.050801] Subtest clobberred-modifier: SUCCESS (0.000s) [120.235301] [076/171] (884s left) kms_addfb_basic (framebuffer-vs-set-tiling) [120.472260] Starting subtest: framebuffer-vs-set-tiling [120.473526] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [120.590967] [077/171] (884s left) kms_addfb_basic (invalid-get-prop) [120.830263] Starting subtest: invalid-get-prop [120.831513] Subtest invalid-get-prop: SUCCESS (0.000s) [120.935418] [078/171] (884s left) kms_addfb_basic (invalid-get-prop-any) [121.174773] Starting subtest: invalid-get-prop-any [121.176134] Subtest invalid-get-prop-any: SUCCESS (0.000s) [121.268563] [079/171] (883s left) kms_addfb_basic (invalid-set-prop) [121.506563] Starting subtest: invalid-set-prop [121.507837] Subtest invalid-set-prop: SUCCESS (0.000s) [121.603635] [080/171] (883s left) kms_addfb_basic (invalid-set-prop-any) [121.846664] Starting subtest: invalid-set-prop-any [121.848017] Subtest invalid-set-prop-any: SUCCESS (0.000s) [121.951550] [081/171] (883s left) kms_addfb_basic (no-handle) [122.095286] Starting subtest: no-handle [122.096497] Subtest no-handle: SUCCESS (0.000s) [122.285766] [082/171] (883s left) kms_addfb_basic (size-max) [122.455102] Starting subtest: size-max [122.456271] Subtest size-max: SUCCESS (0.000s) [122.601849] [083/171] (882s left) kms_addfb_basic (small-bo) [122.775125] Starting subtest: small-bo [122.776421] Subtest small-bo: SUCCESS (0.000s) [122.935270] [084/171] (882s left) kms_addfb_basic (tile-pitch-mismatch) [123.164246] Starting subtest: tile-pitch-mismatch [123.165544] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [123.251808] [085/171] (882s left) kms_addfb_basic (too-high) [123.437634] Starting subtest: too-high [123.438807] Subtest too-high: SUCCESS (0.001s) [123.601707] [086/171] (881s left) kms_addfb_basic (too-wide) [123.785681] Starting subtest: too-wide [123.786864] Subtest too-wide: SUCCESS (0.000s) [123.951989] [087/171] (881s left) kms_addfb_basic (unused-handle) [124.101340] Starting subtest: unused-handle [124.102505] Subtest unused-handle: SUCCESS (0.000s) [124.285934] [088/171] (881s left) kms_addfb_basic (unused-modifier) [124.434251] Starting subtest: unused-modifier [124.435454] Subtest unused-modifier: SUCCESS (0.000s) [124.635566] [089/171] (880s left) kms_addfb_basic (unused-offsets) [124.785152] Starting subtest: unused-offsets [124.786437] Subtest unused-offsets: SUCCESS (0.000s) [124.984965] [090/171] (880s left) kms_addfb_basic (unused-pitches) [125.134184] Starting subtest: unused-pitches [125.135357] Subtest unused-pitches: SUCCESS (0.000s) [125.335337] [091/171] (880s left) kms_busy (basic) [125.543217] Starting subtest: basic [125.544653] Starting dynamic subtest: flip [126.634111] Dynamic subtest flip: SUCCESS (1.090s) [126.650176] Starting dynamic subtest: modeset [130.448257] Dynamic subtest modeset: SUCCESS (3.814s) [130.449667] Subtest basic: SUCCESS (4.905s) [131.429679] [092/171] (874s left) kms_chamelium_hpd (dp-hpd-fast) [131.916660] Subtest dp-hpd-fast: SKIP (0.000s) [132.785620] [093/171] (872s left) kms_chamelium_edid (dp-edid-read) [133.281660] Subtest dp-edid-read: SKIP (0.000s) [134.195455] [094/171] (871s left) kms_chamelium_frames (dp-crc-fast) [134.688239] Subtest dp-crc-fast: SKIP (0.000s) [135.604450] [095/171] (870s left) kms_chamelium_hpd (hdmi-hpd-fast) [136.098673] Subtest hdmi-hpd-fast: SKIP (0.000s) [137.008503] [096/171] (868s left) kms_chamelium_edid (hdmi-edid-read) [137.502465] Subtest hdmi-edid-read: SKIP (0.000s) [138.416120] [097/171] (867s left) kms_chamelium_frames (hdmi-crc-fast) [138.894636] Subtest hdmi-crc-fast: SKIP (0.000s) [139.758893] [098/171] (865s left) kms_chamelium_hpd (vga-hpd-fast) [140.255349] Subtest vga-hpd-fast: SKIP (0.000s) [141.169118] [099/171] (864s left) kms_chamelium_edid (vga-edid-read) [141.664529] Subtest vga-edid-read: SKIP (0.000s) [142.577421] [100/171] (863s left) kms_prop_blob (basic) [142.723378] Starting subtest: basic [142.724677] Subtest basic: SUCCESS (0.000s) [142.814210] [101/171] (862s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [142.993131] Starting subtest: basic-busy-flip-before-cursor-atomic [142.995523] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [143.077315] [102/171] (862s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [143.256106] Starting subtest: basic-busy-flip-before-cursor-legacy [143.258902] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [143.341644] [103/171] (862s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [143.521417] Starting subtest: basic-flip-after-cursor-atomic [144.837318] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.317s) [145.764508] [104/171] (860s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [145.942958] Starting subtest: basic-flip-after-cursor-legacy [147.228917] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.286s) [148.194054] [105/171] (857s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [148.373572] Starting subtest: basic-flip-after-cursor-varying-size [149.656749] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.284s) [150.627041] [106/171] (855s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [150.807215] Starting subtest: basic-flip-before-cursor-atomic [152.104186] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.297s) [153.059988] [107/171] (852s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [153.239706] Starting subtest: basic-flip-before-cursor-legacy [154.534559] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.295s) [155.490206] [108/171] (850s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [155.666485] Starting subtest: basic-flip-before-cursor-varying-size [156.990531] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.316s) [157.922974] [109/171] (848s left) kms_flip (basic-flip-vs-dpms) [158.077403] Starting subtest: basic-flip-vs-dpms [158.082831] Starting dynamic subtest: A-eDP1 [160.993562] Dynamic subtest A-eDP1: SUCCESS (2.903s) [161.008025] Starting dynamic subtest: B-eDP1 [163.352716] Dynamic subtest B-eDP1: SUCCESS (2.367s) [163.382253] Starting dynamic subtest: C-eDP1 [165.719120] Dynamic subtest C-eDP1: SUCCESS (2.366s) [165.735748] Subtest basic-flip-vs-dpms: SUCCESS (7.660s) [166.635271] [110/171] (839s left) kms_flip (basic-flip-vs-modeset) [166.790231] Starting subtest: basic-flip-vs-modeset [166.793503] Starting dynamic subtest: A-eDP1 [169.699296] Dynamic subtest A-eDP1: SUCCESS (2.889s) [169.713102] Starting dynamic subtest: B-eDP1 [172.036828] Dynamic subtest B-eDP1: SUCCESS (2.353s) [172.065507] Starting dynamic subtest: C-eDP1 [174.406268] Dynamic subtest C-eDP1: SUCCESS (2.368s) [174.408262] Subtest basic-flip-vs-modeset: SUCCESS (7.620s) [175.332182] [111/171] (830s left) kms_flip (basic-flip-vs-wf_vblank) [175.485790] Starting subtest: basic-flip-vs-wf_vblank [175.490852] Starting dynamic subtest: A-eDP1 [177.858653] Dynamic subtest A-eDP1: SUCCESS (2.368s) [177.874840] Starting dynamic subtest: B-eDP1 [180.147313] Dynamic subtest B-eDP1: SUCCESS (2.288s) [180.163259] Starting dynamic subtest: C-eDP1 [182.447375] Dynamic subtest C-eDP1: SUCCESS (2.299s) [182.450647] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.965s) [183.783925] [112/171] (822s left) kms_flip (basic-plain-flip) [183.939186] Starting subtest: basic-plain-flip [183.942569] Starting dynamic subtest: A-eDP1 [186.023039] Dynamic subtest A-eDP1: SUCCESS (2.080s) [186.039019] Starting dynamic subtest: B-eDP1 [187.991757] Dynamic subtest B-eDP1: SUCCESS (1.968s) [188.008104] Starting dynamic subtest: C-eDP1 [189.975972] Dynamic subtest C-eDP1: SUCCESS (1.983s) [189.979282] Subtest basic-plain-flip: SUCCESS (6.042s) [191.267263] [113/171] (814s left) kms_force_connector_basic (force-connector-state) [191.419073] Starting subtest: force-connector-state [192.173876] Subtest force-connector-state: SUCCESS (0.754s) [193.055725] [114/171] (813s left) kms_force_connector_basic (force-edid) [193.196494] Starting subtest: force-edid [193.447873] Subtest force-edid: SUCCESS (0.249s) [193.555943] [115/171] (812s left) kms_force_connector_basic (force-load-detect) [193.704880] Starting subtest: force-load-detect [193.707558] Subtest force-load-detect: SKIP (0.000s) [193.822538] [116/171] (812s left) kms_force_connector_basic (prune-stale-modes) [193.962493] Starting subtest: prune-stale-modes [194.269506] Subtest prune-stale-modes: SUCCESS (0.306s) [194.388722] [117/171] (811s left) kms_frontbuffer_tracking (basic) [194.574205] Starting subtest: basic [197.968154] Subtest basic: SUCCESS (3.395s) [198.089883] [118/171] (808s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [198.272920] Starting subtest: compare-crc-sanitycheck [198.274493] Starting dynamic subtest: pipe-A-eDP-1 [198.953735] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.680s) [198.971046] Starting dynamic subtest: pipe-B-eDP-1 [200.355088] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.401s) [200.371144] Starting dynamic subtest: pipe-C-eDP-1 [201.738657] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.382s) [201.744277] Subtest compare-crc-sanitycheck: SUCCESS (3.466s) [202.675512] [119/171] (803s left) kms_pipe_crc_basic (hang-read-crc) [202.856265] Starting subtest: hang-read-crc [202.857681] Starting dynamic subtest: pipe-A-eDP-1 [205.250721] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.394s) [205.266434] Starting dynamic subtest: pipe-B-eDP-1 [208.287995] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.037s) [208.303773] Starting dynamic subtest: pipe-C-eDP-1 [211.294682] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.007s) [211.295923] Subtest hang-read-crc: SUCCESS (8.440s) [212.259911] [120/171] (794s left) kms_pipe_crc_basic (nonblocking-crc) [212.440985] Starting subtest: nonblocking-crc [212.442415] Starting dynamic subtest: pipe-A-eDP-1 [213.322758] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.881s) [213.338767] Starting dynamic subtest: pipe-B-eDP-1 [214.884647] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.562s) [214.900370] Starting dynamic subtest: pipe-C-eDP-1 [216.469954] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.583s) [216.471195] Subtest nonblocking-crc: SUCCESS (4.029s) [217.441752] [121/171] (788s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [217.623178] Starting subtest: nonblocking-crc-frame-sequence [217.624523] Starting dynamic subtest: pipe-A-eDP-1 [218.504064] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.881s) [218.520022] Starting dynamic subtest: pipe-B-eDP-1 [220.088544] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.584s) [220.104505] Starting dynamic subtest: pipe-C-eDP-1 [221.652895] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.564s) [221.654168] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.031s) [222.628732] [122/171] (783s left) kms_pipe_crc_basic (read-crc) [222.810967] Starting subtest: read-crc [222.812291] Starting dynamic subtest: pipe-A-eDP-1 [223.622904] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.812s) [223.638869] Starting dynamic subtest: pipe-B-eDP-1 [225.122929] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.499s) [225.139029] Starting dynamic subtest: pipe-C-eDP-1 [226.613394] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.489s) [226.614665] Subtest read-crc: SUCCESS (3.803s) [227.555614] [123/171] (778s left) kms_pipe_crc_basic (read-crc-frame-sequence) [227.728566] Starting subtest: read-crc-frame-sequence [227.730034] Starting dynamic subtest: pipe-A-eDP-1 [228.564667] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.837s) [228.580765] Starting dynamic subtest: pipe-B-eDP-1 [230.138276] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.571s) [230.154235] Starting dynamic subtest: pipe-C-eDP-1 [231.625382] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.487s) [231.626773] Subtest read-crc-frame-sequence: SUCCESS (3.898s) [232.547456] [124/171] (773s left) kms_psr (primary_page_flip) [232.728441] Starting subtest: primary_page_flip [234.981718] Subtest primary_page_flip: FAIL (1.933s) [235.008734] [125/171] (771s left) kms_psr (cursor_plane_move) [235.187559] Starting subtest: cursor_plane_move [237.381289] Subtest cursor_plane_move: FAIL (1.886s) [237.408138] [126/171] (769s left) kms_psr (sprite_plane_onoff) [237.591791] Starting subtest: sprite_plane_onoff [239.823800] Subtest sprite_plane_onoff: FAIL (1.921s) [239.850418] [127/171] (766s left) kms_psr (primary_mmap_gtt) [240.033690] Starting subtest: primary_mmap_gtt [242.251392] Subtest primary_mmap_gtt: FAIL (1.913s) [242.278709] [128/171] (764s left) kms_setmode (basic-clone-single-crtc) [242.427314] Starting subtest: basic-clone-single-crtc [242.431030] Subtest basic-clone-single-crtc: SKIP (0.000s) [242.513253] [129/171] (764s left) i915_pm_backlight (basic-brightness) [242.695145] Starting subtest: basic-brightness [242.808379] Starting dynamic subtest: eDP-1 [243.376696] Dynamic subtest eDP-1: SUCCESS (0.563s) [243.378128] Subtest basic-brightness: SUCCESS (0.677s) [244.323820] [130/171] (762s left) i915_pm_rpm (basic-pci-d3-state) [246.257443] Starting subtest: basic-pci-d3-state [250.689218] Subtest basic-pci-d3-state: SUCCESS (4.432s) [250.889674] [131/171] (755s left) i915_pm_rpm (basic-rte) [251.033131] Starting subtest: basic-rte [257.216975] Subtest basic-rte: SUCCESS (6.181s) [262.588284] [132/171] (744s left) i915_pm_rps (basic-api) [262.743363] Starting subtest: basic-api [262.748764] Subtest basic-api: SUCCESS (0.005s) [262.858043] [133/171] (743s left) prime_self_import (basic-llseek-bad) [263.001136] Starting subtest: basic-llseek-bad [263.004879] Subtest basic-llseek-bad: SUCCESS (0.003s) [263.108074] [134/171] (743s left) prime_self_import (basic-llseek-size) [263.249416] Starting subtest: basic-llseek-size [263.253418] Subtest basic-llseek-size: SUCCESS (0.004s) [263.358164] [135/171] (743s left) prime_self_import (basic-with_fd_dup) [263.501171] Starting subtest: basic-with_fd_dup [263.507471] Subtest basic-with_fd_dup: SUCCESS (0.005s) [263.626222] [136/171] (743s left) prime_self_import (basic-with_one_bo) [263.769056] Starting subtest: basic-with_one_bo [263.775266] Subtest basic-with_one_bo: SUCCESS (0.006s) [263.851753] [137/171] (742s left) prime_self_import (basic-with_one_bo_two_files) [263.993196] Starting subtest: basic-with_one_bo_two_files [263.997197] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s) [264.108114] [138/171] (742s left) prime_self_import (basic-with_two_bos) [264.251413] Starting subtest: basic-with_two_bos [264.257539] Subtest basic-with_two_bos: SUCCESS (0.005s) [264.360929] [139/171] (742s left) prime_vgem (basic-fence-flip) [264.531214] Starting subtest: basic-fence-flip [265.081927] Subtest basic-fence-flip: SUCCESS (0.551s) [265.204829] [140/171] (741s left) prime_vgem (basic-fence-mmap) [265.378686] Starting subtest: basic-fence-mmap [265.427493] Subtest basic-fence-mmap: SUCCESS (0.049s) [265.544615] [141/171] (741s left) prime_vgem (basic-fence-read) [265.711469] Starting subtest: basic-fence-read [265.790696] Subtest basic-fence-read: SUCCESS (0.079s) [265.876533] [142/171] (741s left) prime_vgem (basic-gtt) [266.025471] Starting subtest: basic-gtt [266.050791] Subtest basic-gtt: SUCCESS (0.025s) [266.158691] [143/171] (740s left) prime_vgem (basic-read) [266.325736] Starting subtest: basic-read [266.366179] Subtest basic-read: SUCCESS (0.040s) [266.475658] [144/171] (740s left) prime_vgem (basic-write) [266.649878] Starting subtest: basic-write [266.697839] Subtest basic-write: SUCCESS (0.048s) [266.792796] [145/171] (740s left) prime_vgem (basic-userptr) [266.969576] Starting subtest: basic-userptr [266.986069] Subtest basic-userptr: SKIP (0.015s) [267.100493] [146/171] (740s left) vgem_basic (setversion) [267.249851] Starting subtest: setversion [267.252914] Subtest setversion: SUCCESS (0.000s) [267.323682] [147/171] (739s left) vgem_basic (create) [267.483666] Starting subtest: create [267.484972] Subtest create: SUCCESS (0.000s) [267.557684] [148/171] (739s left) vgem_basic (debugfs) [267.716867] Starting subtest: debugfs [267.718545] Subtest debugfs: SUCCESS (0.001s) [267.788695] [149/171] (739s left) vgem_basic (dmabuf-export) [267.950778] Starting subtest: dmabuf-export [267.962546] Subtest dmabuf-export: SUCCESS (0.010s) [268.058292] [150/171] (739s left) vgem_basic (dmabuf-fence) [268.216782] Starting subtest: dmabuf-fence [268.218338] Subtest dmabuf-fence: SUCCESS (0.001s) [268.295428] [151/171] (738s left) vgem_basic (dmabuf-fence-before) [268.450095] Starting subtest: dmabuf-fence-before [268.451486] Subtest dmabuf-fence-before: SUCCESS (0.001s) [268.524601] [152/171] (738s left) vgem_basic (dmabuf-mmap) [268.666762] Starting subtest: dmabuf-mmap [268.697167] Subtest dmabuf-mmap: SUCCESS (0.030s) [268.773404] [153/171] (738s left) vgem_basic (mmap) [268.933515] Starting subtest: mmap [268.953409] Subtest mmap: SUCCESS (0.020s) [269.022126] [154/171] (738s left) vgem_basic (second-client) [269.186089] Starting subtest: second-client [269.234501] Subtest second-client: SUCCESS (0.050s) [269.307458] [155/171] (738s left) vgem_basic (sysfs) [269.468289] Starting subtest: sysfs [269.470405] Subtest sysfs: SUCCESS (0.002s) [269.543705] [156/171] (737s left) core_hotunplug (unbind-rebind) [269.701740] Starting subtest: unbind-rebind [272.146959] Subtest unbind-rebind: SUCCESS (2.446s) [272.181881] [157/171] (735s left) vgem_basic (unload) [272.324100] Starting subtest: unload [301.193321] Subtest unload: SUCCESS (28.834s) [301.307193] [158/171] (706s left) i915_module_load (reload) [301.446299] Starting subtest: reload [304.800060] Subtest reload: SUCCESS (3.352s) [304.829348] [159/171] (702s left) gem_lmem_swapping (basic) [304.993409] Subtest basic: SKIP (0.000s) [305.049806] [160/171] (702s left) gem_lmem_swapping (parallel-random-engines) [305.201409] Subtest parallel-random-engines: SKIP (0.000s) [305.249583] [161/171] (702s left) gem_lmem_swapping (random-engines) [305.403798] Subtest random-engines: SKIP (0.000s) [305.449483] [162/171] (702s left) gem_lmem_swapping (verify-random) [305.599837] Subtest verify-random: SKIP (0.000s) [305.649275] [163/171] (701s left) i915_pm_rpm (module-reload) [318.178781] Starting subtest: module-reload [352.833959] Subtest module-reload: SUCCESS (34.648s) [352.855366] [164/171] (654s left) i915_selftest (live) [353.003925] Starting subtest: live [353.005425] Starting dynamic subtest: sanitycheck [354.921709] Dynamic subtest sanitycheck: SUCCESS (1.908s) [354.936597] Starting dynamic subtest: uncore [356.855669] Dynamic subtest uncore: SUCCESS (1.933s) [356.870645] Starting dynamic subtest: workarounds [359.023786] Dynamic subtest workarounds: SUCCESS (2.167s) [359.038533] Starting dynamic subtest: gt_engines [361.404491] Dynamic subtest gt_engines: SUCCESS (2.380s) [361.419268] Starting dynamic subtest: gt_timelines [375.082783] Dynamic subtest gt_timelines: SUCCESS (13.677s) [375.097718] Starting dynamic subtest: gt_contexts [377.066579] Dynamic subtest gt_contexts: SUCCESS (1.983s) [377.081421] Starting dynamic subtest: gt_lrc [381.494812] Dynamic subtest gt_lrc: SUCCESS (4.427s) [381.509697] Starting dynamic subtest: gt_mocs [383.474525] Dynamic subtest gt_mocs: SUCCESS (1.979s) [383.489275] Starting dynamic subtest: gt_pm [388.605776] Dynamic subtest gt_pm: SUCCESS (5.130s) [388.620753] Starting dynamic subtest: gt_heartbeat [390.555691] Dynamic subtest gt_heartbeat: SUCCESS (1.949s) [390.570758] Starting dynamic subtest: requests [398.243043] Dynamic subtest requests: SUCCESS (7.686s) [398.257998] Starting dynamic subtest: migrate [402.888522] Dynamic subtest migrate: SUCCESS (4.645s) [402.903461] Starting dynamic subtest: active [404.791934] Dynamic subtest active: SUCCESS (1.902s) [404.806951] Starting dynamic subtest: objects [408.628596] Dynamic subtest objects: SUCCESS (3.836s) [408.643546] Starting dynamic subtest: mman [416.145792] Dynamic subtest mman: SUCCESS (7.516s) [416.161024] Starting dynamic subtest: dmabuf [418.102894] Dynamic subtest dmabuf: SUCCESS (1.956s) [418.118153] Starting dynamic subtest: vma [420.004818] Dynamic subtest vma: SUCCESS (1.901s) [420.020126] Starting dynamic subtest: coherency [424.632641] Dynamic subtest coherency: SUCCESS (4.627s) [424.647876] Starting dynamic subtest: gtt [436.033780] Dynamic subtest gtt: SUCCESS (11.400s) [436.049083] Starting dynamic subtest: gem [438.011984] Dynamic subtest gem: SUCCESS (1.977s) [438.027428] Starting dynamic subtest: evict [442.099574] Dynamic subtest evict: SUCCESS (4.087s) [442.114742] Starting dynamic subtest: hugepages [449.048889] Dynamic subtest hugepages: SUCCESS (6.948s) [449.064471] Starting dynamic subtest: gem_contexts [465.078974] Dynamic subtest gem_contexts: SUCCESS (16.003s) [465.094581] Starting dynamic subtest: client [466.996579] Dynamic subtest client: SUCCESS (1.943s) [467.012130] Starting dynamic subtest: gem_migrate [468.835540] Dynamic subtest gem_migrate: SUCCESS (1.838s) [468.851200] Starting dynamic subtest: reset [474.324918] Dynamic subtest reset: SUCCESS (5.488s) [474.340568] Starting dynamic subtest: memory_region [476.200566] Dynamic subtest memory_region: SUCCESS (1.883s) [476.213498] Starting dynamic subtest: hangcheck [500.711733] Dynamic subtest hangcheck: SUCCESS (24.502s) [500.727488] Starting dynamic subtest: execlists [511.210690] Dynamic subtest execlists: SUCCESS (10.498s) [511.226264] Starting dynamic subtest: ring_submission [513.069964] Dynamic subtest ring_submission: SUCCESS (1.858s) [513.085729] Starting dynamic subtest: perf [515.049621] Dynamic subtest perf: SUCCESS (1.979s) [515.065453] Starting dynamic subtest: slpc [516.923778] Dynamic subtest slpc: SUCCESS (1.873s) [516.939467] Starting dynamic subtest: guc [518.820690] Dynamic subtest guc: SUCCESS (1.896s) [518.836497] Starting dynamic subtest: guc_multi_lrc [520.764720] Dynamic subtest guc_multi_lrc: SUCCESS (1.943s) [520.780458] Starting dynamic subtest: guc_hang [522.602819] Dynamic subtest guc_hang: SUCCESS (1.837s) [522.618750] Starting dynamic subtest: late_gt_pm [524.527666] Dynamic subtest late_gt_pm: SUCCESS (1.924s) [524.529188] Subtest live: SUCCESS (171.515s) [524.613814] [165/171] (483s left) dmabuf (all-tests) [524.758263] Starting subtest: all-tests [524.760494] Starting dynamic subtest: sanitycheck [524.780959] Dynamic subtest sanitycheck: SUCCESS (0.022s) [524.793838] Starting dynamic subtest: dma_fence [524.926465] Dynamic subtest dma_fence: SUCCESS (0.144s) [524.947837] Starting dynamic subtest: dma_fence_chain [546.469565] Dynamic subtest dma_fence_chain: SUCCESS (21.534s) [546.483432] Starting dynamic subtest: dma_fence_unwrap [546.487972] Dynamic subtest dma_fence_unwrap: SUCCESS (0.024s) [546.500539] Starting dynamic subtest: dma_resv [546.516057] Dynamic subtest dma_resv: SUCCESS (0.029s) [546.517518] Subtest all-tests: SUCCESS (21.758s) [546.543197] [166/171] (461s left) i915_suspend (basic-s2idle-without-i915) [546.686931] Starting subtest: basic-s2idle-without-i915 [570.095265] Subtest basic-s2idle-without-i915: SUCCESS (8.341s) [570.382281] [167/171] (452s left) i915_suspend (basic-s3-without-i915) [570.539249] Starting subtest: basic-s3-without-i915 [594.342789] Subtest basic-s3-without-i915: SUCCESS (7.195s) [594.599478] [168/171] (444s left) gem_exec_suspend (basic-s0) [594.760958] Starting subtest: basic-S0 [594.762295] Starting dynamic subtest: smem [614.257134] Dynamic subtest smem: SUCCESS (4.199s) [614.258343] Subtest basic-S0: SUCCESS (4.200s) [614.406997] [169/171] (440s left) gem_exec_suspend (basic-s3) [614.558583] Starting subtest: basic-S3 [614.560383] Starting dynamic subtest: smem [633.208612] Dynamic subtest smem: SUCCESS (4.018s) [633.209797] Subtest basic-S3: SUCCESS (4.019s) [633.365344] [170/171] (436s left) kms_chamelium_hpd (common-hpd-after-suspend) [633.849873] Subtest common-hpd-after-suspend: SKIP (0.000s) [634.776033] [171/171] (434s left) kms_pipe_crc_basic (suspend-read-crc) [634.944668] Starting subtest: suspend-read-crc [634.945883] Starting dynamic subtest: pipe-A-eDP-1 [653.111832] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.528s) [653.131050] Starting dynamic subtest: pipe-B-eDP-1 [672.150488] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.229s) [672.169637] Starting dynamic subtest: pipe-C-eDP-1 [691.077568] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.185s) [691.078955] Subtest suspend-read-crc: SUCCESS (8.946s) [692.009731] Closing watchdogs Done.