[45.346577] Initializing watchdogs [45.346751] /dev/watchdog0 [45.357501] [001/171] (960s left) i915_module_load (load) [45.499269] Starting subtest: load [48.035404] Subtest load: SUCCESS (2.536s) [48.071774] [002/171] (957s left) core_auth (basic-auth) [48.216623] Starting subtest: basic-auth [48.219172] Subtest basic-auth: SUCCESS (0.002s) [48.303800] [003/171] (957s left) debugfs_test (read_all_entries) [48.454621] Starting subtest: read_all_entries [48.534512] Subtest read_all_entries: SUCCESS (0.079s) [48.648241] [004/171] (957s left) debugfs_test (basic-hwmon) [48.792528] Starting subtest: basic-hwmon [48.794598] Subtest basic-hwmon: SKIP (0.000s) [48.912315] [005/171] (957s left) fbdev (eof) [49.101530] Starting subtest: eof [49.102655] Subtest eof: SUCCESS (0.001s) [49.164676] [006/171] (956s left) fbdev (info) [49.321664] Starting subtest: info [49.323082] Subtest info: SUCCESS (0.000s) [49.401096] [007/171] (956s left) fbdev (nullptr) [49.550382] Starting subtest: nullptr [49.551578] Subtest nullptr: SUCCESS (0.000s) [49.616515] [008/171] (956s left) fbdev (read) [49.767101] Starting subtest: read [56.859547] Subtest read: SUCCESS (7.058s) [56.899407] [009/171] (949s left) fbdev (write) [57.051611] Starting subtest: write [60.834057] Subtest write: SUCCESS (3.748s) [60.882312] [010/171] (945s left) gem_basic (bad-close) [61.019812] Starting subtest: bad-close [61.022197] Subtest bad-close: SUCCESS (0.000s) [61.098591] [011/171] (945s left) gem_basic (create-close) [61.237407] Starting subtest: create-close [61.239516] Subtest create-close: SUCCESS (0.000s) [61.332042] [012/171] (944s left) gem_basic (create-fd-close) [61.469208] Starting subtest: create-fd-close [61.471301] Subtest create-fd-close: SUCCESS (0.000s) [61.566907] [013/171] (944s left) gem_busy (busy@all-engines) [61.724332] Starting subtest: busy [61.725505] Starting dynamic subtest: all-engines [61.786957] Dynamic subtest all-engines: SUCCESS (0.062s) [61.788124] Subtest busy: SUCCESS (0.063s) [62.183622] [014/171] (944s left) gem_close_race (basic-process) [62.344640] Starting subtest: basic-process [62.416899] Subtest basic-process: SUCCESS (0.072s) [62.616518] [015/171] (943s left) gem_close_race (basic-threads) [62.774875] Starting subtest: basic-threads [63.954976] Subtest basic-threads: SUCCESS (1.180s) [64.180420] [016/171] (942s left) gem_ctx_create (basic) [64.340595] Starting subtest: basic [64.341810] Subtest basic: SUCCESS (0.000s) [64.552089] [017/171] (941s left) gem_ctx_create (basic-files) [64.706356] Starting subtest: basic-files [66.733879] Subtest basic-files: SUCCESS (2.028s) [66.963219] [018/171] (939s left) gem_ctx_exec (basic) [67.111355] Starting subtest: basic [67.116798] Subtest basic: SUCCESS (0.005s) [67.232642] [019/171] (939s left) gem_exec_basic (basic) [67.374350] Starting subtest: basic [67.375565] Starting dynamic subtest: rcs0-smem [67.376650] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [67.388220] Starting dynamic subtest: bcs0-smem [67.389448] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [67.400092] Starting dynamic subtest: vcs0-smem [67.401335] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [67.411834] Starting dynamic subtest: vecs0-smem [67.413092] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [67.414383] Subtest basic: SUCCESS (0.005s) [67.583620] [020/171] (938s left) gem_exec_create (basic) [67.741049] Starting subtest: basic [67.742197] Starting dynamic subtest: smem [69.792946] Dynamic subtest smem: SUCCESS (2.053s) [69.794178] Subtest basic: SUCCESS (2.053s) [70.005760] [021/171] (936s left) gem_exec_fence (basic-busy) [70.304191] Starting subtest: basic-busy [70.305478] Starting dynamic subtest: rcs0 [70.326588] Dynamic subtest rcs0: SUCCESS (0.031s) [70.338396] Starting dynamic subtest: bcs0 [70.353343] Dynamic subtest bcs0: SUCCESS (0.027s) [70.364448] Starting dynamic subtest: vcs0 [70.384815] Dynamic subtest vcs0: SUCCESS (0.031s) [70.400334] Starting dynamic subtest: vecs0 [70.405314] Dynamic subtest vecs0: SUCCESS (0.021s) [70.406502] Subtest basic-busy: SUCCESS (0.110s) [71.002806] [022/171] (935s left) gem_exec_fence (basic-wait) [71.307594] Starting subtest: basic-wait [71.308825] Starting dynamic subtest: rcs0 [71.328579] Dynamic subtest rcs0: SUCCESS (0.030s) [71.341134] Starting dynamic subtest: bcs0 [71.368645] Dynamic subtest bcs0: SUCCESS (0.039s) [71.383452] Starting dynamic subtest: vcs0 [71.390364] Dynamic subtest vcs0: SUCCESS (0.022s) [71.402170] Starting dynamic subtest: vecs0 [71.420471] Dynamic subtest vecs0: SUCCESS (0.029s) [71.422223] Subtest basic-wait: SUCCESS (0.121s) [71.969623] [023/171] (934s left) gem_exec_fence (basic-await) [72.256017] Starting subtest: basic-await [72.257128] Starting dynamic subtest: rcs0 [72.348328] Dynamic subtest rcs0: SUCCESS (0.100s) [72.376097] Starting dynamic subtest: bcs0 [72.474056] Dynamic subtest bcs0: SUCCESS (0.124s) [72.502990] Starting dynamic subtest: vcs0 [72.607590] Dynamic subtest vcs0: SUCCESS (0.132s) [72.635367] Starting dynamic subtest: vecs0 [72.741564] Dynamic subtest vecs0: SUCCESS (0.132s) [72.743668] Subtest basic-await: SUCCESS (0.492s) [73.303170] [024/171] (933s left) gem_exec_fence (nb-await) [73.610030] Starting subtest: nb-await [73.611144] Starting dynamic subtest: rcs0 [73.669297] Dynamic subtest rcs0: SUCCESS (0.067s) [73.687294] Starting dynamic subtest: bcs0 [73.739168] Dynamic subtest bcs0: SUCCESS (0.069s) [73.766532] Starting dynamic subtest: vcs0 [73.813865] Dynamic subtest vcs0: SUCCESS (0.074s) [73.841213] Starting dynamic subtest: vecs0 [73.889271] Dynamic subtest vecs0: SUCCESS (0.075s) [73.891165] Subtest nb-await: SUCCESS (0.287s) [74.484610] [025/171] (931s left) gem_exec_gttfill (basic) [74.631628] Starting subtest: basic [80.891984] Subtest basic: SUCCESS (6.260s) [81.086424] [026/171] (925s left) gem_exec_parallel (engines) [81.310715] Starting subtest: engines [81.312295] Starting dynamic subtest: basic [83.852496] Dynamic subtest basic: SUCCESS (2.520s) [83.868216] Starting dynamic subtest: contexts [87.320490] Dynamic subtest contexts: SUCCESS (3.480s) [87.335400] Starting dynamic subtest: fds [91.640158] Dynamic subtest fds: SUCCESS (4.327s) [91.673394] Starting dynamic subtest: userptr [94.257894] Dynamic subtest userptr: SUCCESS (2.593s) [94.259899] Subtest engines: SUCCESS (12.922s) [94.501906] [027/171] (912s left) gem_exec_store (basic) [94.668456] Starting subtest: basic [94.732033] Subtest basic: SUCCESS (0.063s) [94.922553] [028/171] (911s left) gem_flink_basic (bad-flink) [95.070250] Starting subtest: bad-flink [95.071590] Subtest bad-flink: SUCCESS (0.000s) [95.156446] [029/171] (911s left) gem_flink_basic (bad-open) [95.313711] Starting subtest: bad-open [95.315305] Subtest bad-open: SUCCESS (0.000s) [95.388755] [030/171] (911s left) gem_flink_basic (basic) [95.531683] Starting subtest: basic [95.532839] Subtest basic: SUCCESS (0.000s) [95.636817] [031/171] (911s left) gem_flink_basic (double-flink) [95.774311] Starting subtest: double-flink [95.775465] Subtest double-flink: SUCCESS (0.000s) [95.869477] [032/171] (910s left) gem_flink_basic (flink-lifetime) [96.006870] Starting subtest: flink-lifetime [96.009553] Subtest flink-lifetime: SUCCESS (0.002s) [96.103305] [033/171] (910s left) gem_huc_copy (huc-copy) [96.246784] Starting subtest: huc-copy [96.249321] Subtest huc-copy: SKIP (0.000s) [96.369739] [034/171] (910s left) gem_linear_blits (basic) [96.645037] Starting subtest: basic [96.658509] Subtest basic: SUCCESS (0.013s) [96.788257] [035/171] (909s left) gem_mmap (basic) [96.988779] Starting subtest: basic [96.993842] Subtest basic: SUCCESS (0.001s) [97.086073] [036/171] (909s left) gem_mmap_gtt (basic) [97.220323] Starting subtest: basic [97.221506] Subtest basic: SUCCESS (0.001s) [97.301086] [037/171] (909s left) gem_render_linear_blits (basic) [97.442271] Starting subtest: basic [97.491805] Subtest basic: SUCCESS (0.050s) [97.552123] [038/171] (909s left) gem_render_tiled_blits (basic) [97.687623] Starting subtest: basic [97.746576] Subtest basic: SUCCESS (0.058s) [97.818714] [039/171] (909s left) gem_ringfill (basic-all) [98.099632] Starting subtest: basic-all [99.354086] Subtest basic-all: SUCCESS (1.245s) [99.436615] [040/171] (907s left) gem_softpin (allocator-basic) [99.584560] Starting subtest: allocator-basic [99.757565] Subtest allocator-basic: SUCCESS (0.164s) [99.874332] [041/171] (907s left) gem_softpin (allocator-basic-reserve) [100.030674] Starting subtest: allocator-basic-reserve [100.204119] Subtest allocator-basic-reserve: SUCCESS (0.165s) [100.303449] [042/171] (906s left) gem_softpin (safe-alignment) [100.465839] Starting subtest: safe-alignment [100.484418] Subtest safe-alignment: SUCCESS (0.018s) [100.602586] [043/171] (906s left) gem_sync (basic-all) [100.750368] Starting subtest: basic-all [103.049812] Subtest basic-all: SUCCESS (2.275s) [103.237104] [044/171] (903s left) gem_sync (basic-each) [103.392987] Starting subtest: basic-each [105.592704] Subtest basic-each: SUCCESS (2.199s) [105.789214] [045/171] (901s left) gem_tiled_blits (basic) [106.073766] Starting subtest: basic [106.103568] Subtest basic: SUCCESS (0.030s) [106.223719] [046/171] (900s left) gem_tiled_fence_blits (basic) [106.574521] Starting subtest: basic [106.601917] Subtest basic: SUCCESS (0.028s) [106.736292] [047/171] (900s left) gem_tiled_pread_basic [107.287148] [048/171] (899s left) gem_wait (busy@all-engines) [107.444554] Starting subtest: busy [107.445766] Starting dynamic subtest: all-engines [107.987029] Dynamic subtest all-engines: SUCCESS (0.542s) [107.988342] Subtest busy: SUCCESS (0.543s) [108.237433] [049/171] (898s left) gem_wait (wait@all-engines) [108.401241] Starting subtest: wait [108.402392] Starting dynamic subtest: all-engines [109.441554] Dynamic subtest all-engines: SUCCESS (1.038s) [109.442678] Subtest wait: SUCCESS (1.039s) [109.670638] [050/171] (897s left) i915_getparams_basic (basic-eu-total) [109.807561] Starting subtest: basic-eu-total [109.809910] Subtest basic-eu-total: SUCCESS (0.000s) [109.886410] [051/171] (897s left) i915_getparams_basic (basic-subslice-total) [110.024535] Starting subtest: basic-subslice-total [110.026874] Subtest basic-subslice-total: SUCCESS (0.000s) [110.103038] [052/171] (897s left) i915_hangman (error-state-basic) [110.248893] Starting subtest: error-state-basic [110.259644] Subtest error-state-basic: SUCCESS (0.011s) [110.353576] [053/171] (896s left) i915_pciid [110.569820] [054/171] (896s left) kms_addfb_basic (addfb25-bad-modifier) [110.706404] Starting subtest: addfb25-bad-modifier [110.707500] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [110.836067] [055/171] (896s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [110.975147] Starting subtest: addfb25-framebuffer-vs-set-tiling [110.976320] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [111.102837] [056/171] (896s left) kms_addfb_basic (addfb25-modifier-no-flag) [111.241970] Starting subtest: addfb25-modifier-no-flag [111.243145] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [111.369249] [057/171] (896s left) kms_addfb_basic (addfb25-x-tiled-legacy) [111.516373] Starting subtest: addfb25-x-tiled-legacy [111.517663] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [111.636742] [058/171] (895s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [111.776189] Starting subtest: addfb25-x-tiled-mismatch-legacy [111.777302] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [111.903020] [059/171] (895s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [112.071507] Starting subtest: addfb25-yf-tiled-legacy [112.072695] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [112.169364] [060/171] (895s left) kms_addfb_basic (addfb25-y-tiled-legacy) [112.338439] Starting subtest: addfb25-y-tiled-legacy [112.339615] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [112.454583] [061/171] (895s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [112.622669] Starting subtest: addfb25-y-tiled-small-legacy [112.623883] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [112.736312] [062/171] (894s left) kms_addfb_basic (bad-pitch-0) [112.874971] Starting subtest: bad-pitch-0 [112.876172] Subtest bad-pitch-0: SUCCESS (0.000s) [113.003291] [063/171] (894s left) kms_addfb_basic (bad-pitch-1024) [113.143275] Starting subtest: bad-pitch-1024 [113.144525] Subtest bad-pitch-1024: SUCCESS (0.000s) [113.269289] [064/171] (894s left) kms_addfb_basic (bad-pitch-128) [113.408096] Starting subtest: bad-pitch-128 [113.409172] Subtest bad-pitch-128: SUCCESS (0.000s) [113.535700] [065/171] (894s left) kms_addfb_basic (bad-pitch-256) [113.675831] Starting subtest: bad-pitch-256 [113.676933] Subtest bad-pitch-256: SUCCESS (0.000s) [113.802784] [066/171] (893s left) kms_addfb_basic (bad-pitch-32) [113.942570] Starting subtest: bad-pitch-32 [113.943953] Subtest bad-pitch-32: SUCCESS (0.000s) [114.069057] [067/171] (893s left) kms_addfb_basic (bad-pitch-63) [114.210047] Starting subtest: bad-pitch-63 [114.211120] Subtest bad-pitch-63: SUCCESS (0.000s) [114.336418] [068/171] (893s left) kms_addfb_basic (bad-pitch-65536) [114.476156] Starting subtest: bad-pitch-65536 [114.477269] Subtest bad-pitch-65536: SUCCESS (0.000s) [114.602798] [069/171] (893s left) kms_addfb_basic (bad-pitch-999) [114.742626] Starting subtest: bad-pitch-999 [114.743799] Subtest bad-pitch-999: SUCCESS (0.000s) [114.869315] [070/171] (892s left) kms_addfb_basic (basic) [115.009638] Starting subtest: basic [115.010881] Subtest basic: SUCCESS (0.000s) [115.135981] [071/171] (892s left) kms_addfb_basic (basic-x-tiled-legacy) [115.276216] Starting subtest: basic-x-tiled-legacy [115.277376] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [115.402736] [072/171] (892s left) kms_addfb_basic (basic-y-tiled-legacy) [115.545781] Starting subtest: basic-y-tiled-legacy [115.546951] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [115.669366] [073/171] (892s left) kms_addfb_basic (bo-too-small) [115.839808] Starting subtest: bo-too-small [115.841214] Subtest bo-too-small: SUCCESS (0.000s) [115.936162] [074/171] (891s left) kms_addfb_basic (bo-too-small-due-to-tiling) [116.105634] Starting subtest: bo-too-small-due-to-tiling [116.106823] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [116.202283] [075/171] (891s left) kms_addfb_basic (clobberred-modifier) [116.342517] Starting subtest: clobberred-modifier [116.343698] Subtest clobberred-modifier: SUCCESS (0.000s) [116.469894] [076/171] (891s left) kms_addfb_basic (framebuffer-vs-set-tiling) [116.610877] Starting subtest: framebuffer-vs-set-tiling [116.612158] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [116.735810] [077/171] (891s left) kms_addfb_basic (invalid-get-prop) [116.874898] Starting subtest: invalid-get-prop [116.876255] Subtest invalid-get-prop: SUCCESS (0.000s) [117.002566] [078/171] (890s left) kms_addfb_basic (invalid-get-prop-any) [117.143684] Starting subtest: invalid-get-prop-any [117.144843] Subtest invalid-get-prop-any: SUCCESS (0.000s) [117.269286] [079/171] (890s left) kms_addfb_basic (invalid-set-prop) [117.409551] Starting subtest: invalid-set-prop [117.410742] Subtest invalid-set-prop: SUCCESS (0.000s) [117.556549] [080/171] (890s left) kms_addfb_basic (invalid-set-prop-any) [117.696697] Starting subtest: invalid-set-prop-any [117.697878] Subtest invalid-set-prop-any: SUCCESS (0.000s) [117.819329] [081/171] (890s left) kms_addfb_basic (no-handle) [117.958524] Starting subtest: no-handle [117.959632] Subtest no-handle: SUCCESS (0.000s) [118.086367] [082/171] (890s left) kms_addfb_basic (size-max) [118.254483] Starting subtest: size-max [118.255637] Subtest size-max: SUCCESS (0.000s) [118.352417] [083/171] (889s left) kms_addfb_basic (small-bo) [118.519477] Starting subtest: small-bo [118.520697] Subtest small-bo: SUCCESS (0.000s) [118.619273] [084/171] (889s left) kms_addfb_basic (tile-pitch-mismatch) [118.759787] Starting subtest: tile-pitch-mismatch [118.760907] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [118.868954] [085/171] (889s left) kms_addfb_basic (too-high) [119.035501] Starting subtest: too-high [119.036627] Subtest too-high: SUCCESS (0.001s) [119.135758] [086/171] (889s left) kms_addfb_basic (too-wide) [119.303584] Starting subtest: too-wide [119.304716] Subtest too-wide: SUCCESS (0.000s) [119.402883] [087/171] (888s left) kms_addfb_basic (unused-handle) [119.539571] Starting subtest: unused-handle [119.540831] Subtest unused-handle: SUCCESS (0.000s) [119.670576] [088/171] (888s left) kms_addfb_basic (unused-modifier) [119.809604] Starting subtest: unused-modifier [119.810774] Subtest unused-modifier: SUCCESS (0.000s) [119.936225] [089/171] (888s left) kms_addfb_basic (unused-offsets) [120.073561] Starting subtest: unused-offsets [120.074794] Subtest unused-offsets: SUCCESS (0.000s) [120.203036] [090/171] (888s left) kms_addfb_basic (unused-pitches) [120.341783] Starting subtest: unused-pitches [120.342954] Subtest unused-pitches: SUCCESS (0.000s) [120.469824] [091/171] (887s left) kms_busy (basic) [120.637075] Starting subtest: basic [120.638462] Starting dynamic subtest: flip [121.721794] Dynamic subtest flip: SUCCESS (1.081s) [121.739327] Starting dynamic subtest: modeset [125.608877] Dynamic subtest modeset: SUCCESS (3.890s) [125.610069] Subtest basic: SUCCESS (4.974s) [126.584210] [092/171] (881s left) kms_chamelium_hpd (dp-hpd-fast) [127.066134] Subtest dp-hpd-fast: SKIP (0.000s) [127.940246] [093/171] (880s left) kms_chamelium_edid (dp-edid-read) [128.422441] Subtest dp-edid-read: SKIP (0.000s) [129.284078] [094/171] (879s left) kms_chamelium_frames (dp-crc-fast) [129.766596] Subtest dp-crc-fast: SKIP (0.000s) [130.640156] [095/171] (877s left) kms_chamelium_hpd (hdmi-hpd-fast) [131.120437] Subtest hdmi-hpd-fast: SKIP (0.000s) [132.039175] [096/171] (876s left) kms_chamelium_edid (hdmi-edid-read) [132.521638] Subtest hdmi-edid-read: SKIP (0.000s) [133.383233] [097/171] (875s left) kms_chamelium_frames (hdmi-crc-fast) [133.868179] Subtest hdmi-crc-fast: SKIP (0.000s) [134.786271] [098/171] (873s left) kms_chamelium_hpd (vga-hpd-fast) [135.267695] Subtest vga-hpd-fast: SKIP (0.000s) [136.133572] [099/171] (872s left) kms_chamelium_edid (vga-edid-read) [136.614319] Subtest vga-edid-read: SKIP (0.000s) [137.476343] [100/171] (871s left) kms_prop_blob (basic) [137.607658] Starting subtest: basic [137.608843] Subtest basic: SUCCESS (0.000s) [137.697404] [101/171] (870s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [137.857836] Starting subtest: basic-busy-flip-before-cursor-atomic [137.860249] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [137.941241] [102/171] (870s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [138.107824] Starting subtest: basic-busy-flip-before-cursor-legacy [138.110116] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [138.191493] [103/171] (870s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [138.359388] Starting subtest: basic-flip-after-cursor-atomic [139.619081] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.260s) [140.534874] [104/171] (868s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [140.702975] Starting subtest: basic-flip-after-cursor-legacy [141.993467] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.290s) [142.964329] [105/171] (865s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [143.130878] Starting subtest: basic-flip-after-cursor-varying-size [144.422660] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.292s) [145.399426] [106/171] (863s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [145.568176] Starting subtest: basic-flip-before-cursor-atomic [146.864505] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.291s) [147.830574] [107/171] (860s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [147.999782] Starting subtest: basic-flip-before-cursor-legacy [149.290749] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.292s) [150.262826] [108/171] (858s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [150.430386] Starting subtest: basic-flip-before-cursor-varying-size [151.707346] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.276s) [152.631668] [109/171] (856s left) kms_flip (basic-flip-vs-dpms) [152.776551] Starting subtest: basic-flip-vs-dpms [152.781806] Starting dynamic subtest: A-eDP1 [155.660440] Dynamic subtest A-eDP1: SUCCESS (2.871s) [155.685670] Starting dynamic subtest: B-eDP1 [157.986990] Dynamic subtest B-eDP1: SUCCESS (2.334s) [158.004752] Starting dynamic subtest: C-eDP1 [160.356174] Dynamic subtest C-eDP1: SUCCESS (2.367s) [160.358872] Subtest basic-flip-vs-dpms: SUCCESS (7.582s) [161.264360] [110/171] (847s left) kms_flip (basic-flip-vs-modeset) [161.412419] Starting subtest: basic-flip-vs-modeset [161.415662] Starting dynamic subtest: A-eDP1 [164.268341] Dynamic subtest A-eDP1: SUCCESS (2.852s) [164.289674] Starting dynamic subtest: B-eDP1 [166.639956] Dynamic subtest B-eDP1: SUCCESS (2.371s) [166.662522] Starting dynamic subtest: C-eDP1 [168.993356] Dynamic subtest C-eDP1: SUCCESS (2.349s) [168.994432] Subtest basic-flip-vs-modeset: SUCCESS (7.581s) [169.909708] [111/171] (839s left) kms_flip (basic-flip-vs-wf_vblank) [170.057079] Starting subtest: basic-flip-vs-wf_vblank [170.060560] Starting dynamic subtest: A-eDP1 [172.377132] Dynamic subtest A-eDP1: SUCCESS (2.316s) [172.395300] Starting dynamic subtest: B-eDP1 [174.660544] Dynamic subtest B-eDP1: SUCCESS (2.282s) [174.678455] Starting dynamic subtest: C-eDP1 [176.902442] Dynamic subtest C-eDP1: SUCCESS (2.241s) [176.907534] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.849s) [178.233423] [112/171] (830s left) kms_flip (basic-plain-flip) [178.382590] Starting subtest: basic-plain-flip [178.385771] Starting dynamic subtest: A-eDP1 [180.410543] Dynamic subtest A-eDP1: SUCCESS (2.025s) [180.428127] Starting dynamic subtest: B-eDP1 [182.379347] Dynamic subtest B-eDP1: SUCCESS (1.968s) [182.397772] Starting dynamic subtest: C-eDP1 [184.361063] Dynamic subtest C-eDP1: SUCCESS (1.980s) [184.364189] Subtest basic-plain-flip: SUCCESS (5.983s) [185.662669] [113/171] (823s left) kms_force_connector_basic (force-connector-state) [185.801857] Starting subtest: force-connector-state [187.522508] Subtest force-connector-state: SUCCESS (1.721s) [188.140527] [114/171] (820s left) kms_force_connector_basic (force-edid) [188.293785] Starting subtest: force-edid [188.551106] Subtest force-edid: SUCCESS (0.251s) [188.673529] [115/171] (820s left) kms_force_connector_basic (force-load-detect) [188.825026] Starting subtest: force-load-detect [188.827481] Subtest force-load-detect: SKIP (0.000s) [188.940030] [116/171] (820s left) kms_force_connector_basic (prune-stale-modes) [189.091703] Starting subtest: prune-stale-modes [189.404594] Subtest prune-stale-modes: SUCCESS (0.310s) [189.523302] [117/171] (819s left) kms_frontbuffer_tracking (basic) [189.707605] Starting subtest: basic [192.988166] Subtest basic: SUCCESS (3.281s) [193.124854] [118/171] (816s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [193.299594] Starting subtest: compare-crc-sanitycheck-xr24 [193.300780] Starting dynamic subtest: pipe-A-eDP-1 [193.968527] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.667s) [193.991492] Starting dynamic subtest: pipe-B-eDP-1 [195.338298] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.367s) [195.369451] Starting dynamic subtest: pipe-C-eDP-1 [196.899791] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.549s) [196.901128] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.594s) [197.818701] [119/171] (811s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [197.989172] Starting subtest: compare-crc-sanitycheck-nv12 [197.990258] Starting dynamic subtest: pipe-A-eDP-1 [198.911463] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.921s) [198.936884] Starting dynamic subtest: pipe-B-eDP-1 [200.379137] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.463s) [200.399370] Starting dynamic subtest: pipe-C-eDP-1 [202.182490] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.793s) [202.183533] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.187s) [203.123551] [120/171] (806s left) kms_pipe_crc_basic (hang-read-crc) [203.291733] Starting subtest: hang-read-crc [203.295176] Starting dynamic subtest: pipe-A-eDP-1 [205.601709] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.306s) [205.621461] Starting dynamic subtest: pipe-B-eDP-1 [208.600326] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.994s) [208.619366] Starting dynamic subtest: pipe-C-eDP-1 [211.957656] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.354s) [211.958915] Subtest hang-read-crc: SUCCESS (8.666s) [212.913887] [121/171] (796s left) kms_pipe_crc_basic (nonblocking-crc) [213.086219] Starting subtest: nonblocking-crc [213.087394] Starting dynamic subtest: pipe-A-eDP-1 [213.939474] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.851s) [213.958564] Starting dynamic subtest: pipe-B-eDP-1 [215.502990] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.560s) [215.522440] Starting dynamic subtest: pipe-C-eDP-1 [217.220432] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.713s) [217.221649] Subtest nonblocking-crc: SUCCESS (4.137s) [218.162127] [122/171] (791s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [218.334133] Starting subtest: nonblocking-crc-frame-sequence [218.337369] Starting dynamic subtest: pipe-A-eDP-1 [219.186760] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.849s) [219.206237] Starting dynamic subtest: pipe-B-eDP-1 [220.763352] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.573s) [220.782752] Starting dynamic subtest: pipe-C-eDP-1 [222.486796] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.718s) [222.488059] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.151s) [223.410070] [123/171] (785s left) kms_pipe_crc_basic (read-crc) [223.593942] Starting subtest: read-crc [223.597122] Starting dynamic subtest: pipe-A-eDP-1 [224.385389] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.788s) [224.404713] Starting dynamic subtest: pipe-B-eDP-1 [225.872301] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.483s) [225.891623] Starting dynamic subtest: pipe-C-eDP-1 [227.524270] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.648s) [227.525406] Subtest read-crc: SUCCESS (3.931s) [228.465731] [124/171] (780s left) kms_pipe_crc_basic (read-crc-frame-sequence) [228.639461] Starting subtest: read-crc-frame-sequence [228.640556] Starting dynamic subtest: pipe-A-eDP-1 [229.423914] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.781s) [229.443652] Starting dynamic subtest: pipe-B-eDP-1 [230.910796] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.485s) [230.930841] Starting dynamic subtest: pipe-C-eDP-1 [232.564802] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.648s) [232.566139] Subtest read-crc-frame-sequence: SUCCESS (3.926s) [233.520951] [125/171] (775s left) kms_psr (primary_page_flip) [233.695659] Starting subtest: primary_page_flip [237.966776] Subtest primary_page_flip: SUCCESS (4.249s) [238.896964] [126/171] (770s left) kms_psr (cursor_plane_move) [239.068288] Starting subtest: cursor_plane_move [243.265732] Subtest cursor_plane_move: SUCCESS (4.192s) [244.210672] [127/171] (765s left) kms_psr (sprite_plane_onoff) [244.382512] Starting subtest: sprite_plane_onoff [248.679092] Subtest sprite_plane_onoff: SUCCESS (4.297s) [249.586294] [128/171] (759s left) kms_psr (primary_mmap_gtt) [249.760604] Starting subtest: primary_mmap_gtt [254.052371] Subtest primary_mmap_gtt: SUCCESS (4.291s) [254.962042] [129/171] (754s left) kms_setmode (basic-clone-single-crtc) [255.104788] Starting subtest: basic-clone-single-crtc [255.108426] Subtest basic-clone-single-crtc: SKIP (0.000s) [255.195272] [130/171] (754s left) i915_pm_backlight (basic-brightness) [255.357847] Starting subtest: basic-brightness [255.460084] Starting dynamic subtest: eDP-1 [256.027720] Dynamic subtest eDP-1: SUCCESS (0.560s) [256.029075] Subtest basic-brightness: SUCCESS (0.665s) [256.947472] [131/171] (752s left) i915_pm_rpm (basic-pci-d3-state) [258.836228] Starting subtest: basic-pci-d3-state [263.244806] Subtest basic-pci-d3-state: SUCCESS (4.408s) [263.449065] [132/171] (746s left) i915_pm_rpm (basic-rte) [263.587462] Starting subtest: basic-rte [269.709350] Subtest basic-rte: SUCCESS (6.119s) [271.190618] [133/171] (738s left) i915_pm_rps (basic-api) [271.330070] Starting subtest: basic-api [271.334611] Subtest basic-api: SUCCESS (0.004s) [271.439334] [134/171] (738s left) prime_self_import (basic-llseek-bad) [271.578018] Starting subtest: basic-llseek-bad [271.582653] Subtest basic-llseek-bad: SUCCESS (0.003s) [271.672517] [135/171] (737s left) prime_self_import (basic-llseek-size) [271.809966] Starting subtest: basic-llseek-size [271.814813] Subtest basic-llseek-size: SUCCESS (0.004s) [271.922410] [136/171] (737s left) prime_self_import (basic-with_fd_dup) [272.060693] Starting subtest: basic-with_fd_dup [272.065506] Subtest basic-with_fd_dup: SUCCESS (0.005s) [272.172182] [137/171] (737s left) prime_self_import (basic-with_one_bo) [272.310971] Starting subtest: basic-with_one_bo [272.316190] Subtest basic-with_one_bo: SUCCESS (0.005s) [272.403846] [138/171] (737s left) prime_self_import (basic-with_one_bo_two_files) [272.541669] Starting subtest: basic-with_one_bo_two_files [272.546607] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s) [272.639411] [139/171] (737s left) prime_self_import (basic-with_two_bos) [272.776732] Starting subtest: basic-with_two_bos [272.781441] Subtest basic-with_two_bos: SUCCESS (0.005s) [272.889223] [140/171] (736s left) prime_vgem (basic-fence-flip) [273.057855] Starting subtest: basic-fence-flip [273.533268] Subtest basic-fence-flip: SUCCESS (0.475s) [273.657765] [141/171] (736s left) prime_vgem (basic-fence-mmap) [273.816795] Starting subtest: basic-fence-mmap [273.864843] Subtest basic-fence-mmap: SUCCESS (0.048s) [273.973178] [142/171] (735s left) prime_vgem (basic-fence-read) [274.133235] Starting subtest: basic-fence-read [274.207040] Subtest basic-fence-read: SUCCESS (0.074s) [274.289889] [143/171] (735s left) prime_vgem (basic-gtt) [274.441933] Starting subtest: basic-gtt [274.465256] Subtest basic-gtt: SUCCESS (0.023s) [274.572421] [144/171] (735s left) prime_vgem (basic-read) [274.725371] Starting subtest: basic-read [274.761254] Subtest basic-read: SUCCESS (0.036s) [274.872546] [145/171] (735s left) prime_vgem (basic-write) [275.025374] Starting subtest: basic-write [275.067227] Subtest basic-write: SUCCESS (0.042s) [275.156140] [146/171] (734s left) vgem_basic (setversion) [275.300966] Starting subtest: setversion [275.303366] Subtest setversion: SUCCESS (0.000s) [275.372516] [147/171] (734s left) vgem_basic (create) [275.517820] Starting subtest: create [275.519335] Subtest create: SUCCESS (0.000s) [275.589313] [148/171] (734s left) vgem_basic (debugfs) [275.734457] Starting subtest: debugfs [275.735627] Subtest debugfs: SUCCESS (0.001s) [275.805925] [149/171] (734s left) vgem_basic (dmabuf-export) [275.951258] Starting subtest: dmabuf-export [275.972695] Subtest dmabuf-export: SUCCESS (0.020s) [276.089299] [150/171] (734s left) vgem_basic (dmabuf-fence) [276.234764] Starting subtest: dmabuf-fence [276.236195] Subtest dmabuf-fence: SUCCESS (0.001s) [276.308724] [151/171] (733s left) vgem_basic (dmabuf-fence-before) [276.454330] Starting subtest: dmabuf-fence-before [276.455540] Subtest dmabuf-fence-before: SUCCESS (0.001s) [276.523228] [152/171] (733s left) vgem_basic (dmabuf-mmap) [276.687245] Starting subtest: dmabuf-mmap [276.711779] Subtest dmabuf-mmap: SUCCESS (0.026s) [276.790170] [153/171] (733s left) vgem_basic (mmap) [276.954061] Starting subtest: mmap [276.969281] Subtest mmap: SUCCESS (0.017s) [277.040210] [154/171] (733s left) vgem_basic (second-client) [277.203934] Starting subtest: second-client [277.237129] Subtest second-client: SUCCESS (0.033s) [277.306483] [155/171] (732s left) vgem_basic (sysfs) [277.453151] Starting subtest: sysfs [277.454370] Subtest sysfs: SUCCESS (0.001s) [277.523303] [156/171] (732s left) core_hotunplug (unbind-rebind) [277.702550] Starting subtest: unbind-rebind [280.176998] Subtest unbind-rebind: SUCCESS (2.473s) [280.215130] [157/171] (730s left) vgem_basic (unload) [280.356538] Starting subtest: unload [309.416195] Subtest unload: SUCCESS (29.025s) [309.533080] [158/171] (700s left) i915_module_load (reload) [309.672922] Starting subtest: reload [313.230479] Subtest reload: SUCCESS (3.554s) [313.258834] [159/171] (697s left) gem_lmem_swapping (basic) [313.416175] Subtest basic: SKIP (0.000s) [313.461526] [160/171] (696s left) gem_lmem_swapping (parallel-random-engines) [313.608359] Subtest parallel-random-engines: SKIP (0.000s) [313.661389] [161/171] (696s left) gem_lmem_swapping (random-engines) [313.806792] Subtest random-engines: SKIP (0.000s) [313.861475] [162/171] (696s left) gem_lmem_swapping (verify-random) [314.006945] Subtest verify-random: SKIP (0.000s) [314.060953] [163/171] (696s left) i915_pm_rpm (module-reload) [326.564748] Starting subtest: module-reload [361.493591] Subtest module-reload: SUCCESS (34.919s) [361.519310] [164/171] (649s left) i915_selftest (live) [361.662390] Starting subtest: live [361.663892] Starting dynamic subtest: sanitycheck [363.549796] Dynamic subtest sanitycheck: SUCCESS (1.878s) [363.564373] Starting dynamic subtest: uncore [365.416518] Dynamic subtest uncore: SUCCESS (1.863s) [365.431285] Starting dynamic subtest: workarounds [367.540439] Dynamic subtest workarounds: SUCCESS (2.121s) [367.555214] Starting dynamic subtest: gt_engines [369.889587] Dynamic subtest gt_engines: SUCCESS (2.346s) [369.904404] Starting dynamic subtest: gt_timelines [382.753715] Dynamic subtest gt_timelines: SUCCESS (12.861s) [382.768175] Starting dynamic subtest: gt_contexts [384.679481] Dynamic subtest gt_contexts: SUCCESS (1.922s) [384.694070] Starting dynamic subtest: gt_lrc [389.049069] Dynamic subtest gt_lrc: SUCCESS (4.365s) [389.063575] Starting dynamic subtest: gt_mocs [391.001071] Dynamic subtest gt_mocs: SUCCESS (1.949s) [391.015907] Starting dynamic subtest: gt_pm [396.128084] Dynamic subtest gt_pm: SUCCESS (5.124s) [396.142755] Starting dynamic subtest: gt_heartbeat [398.065673] Dynamic subtest gt_heartbeat: SUCCESS (1.934s) [398.080510] Starting dynamic subtest: gt_tlb [401.210878] Dynamic subtest gt_tlb: SUCCESS (3.141s) [401.225079] Starting dynamic subtest: requests [408.865528] Dynamic subtest requests: SUCCESS (7.651s) [408.880122] Starting dynamic subtest: migrate [413.464651] Dynamic subtest migrate: SUCCESS (4.595s) [413.479293] Starting dynamic subtest: active [415.331528] Dynamic subtest active: SUCCESS (1.863s) [415.346215] Starting dynamic subtest: objects [418.726474] Dynamic subtest objects: SUCCESS (3.391s) [418.741325] Starting dynamic subtest: mman [425.676062] Dynamic subtest mman: SUCCESS (6.946s) [425.690910] Starting dynamic subtest: dmabuf [427.559809] Dynamic subtest dmabuf: SUCCESS (1.880s) [427.574179] Starting dynamic subtest: vma [429.414874] Dynamic subtest vma: SUCCESS (1.851s) [429.429937] Starting dynamic subtest: coherency [433.962418] Dynamic subtest coherency: SUCCESS (4.545s) [433.977679] Starting dynamic subtest: gtt [443.503669] Dynamic subtest gtt: SUCCESS (9.538s) [443.518684] Starting dynamic subtest: gem [445.480646] Dynamic subtest gem: SUCCESS (1.974s) [445.495522] Starting dynamic subtest: evict [449.327113] Dynamic subtest evict: SUCCESS (3.843s) [449.342282] Starting dynamic subtest: hugepages [457.107758] Dynamic subtest hugepages: SUCCESS (7.778s) [457.123231] Starting dynamic subtest: gem_contexts [472.601156] Dynamic subtest gem_contexts: SUCCESS (15.490s) [472.616837] Starting dynamic subtest: client [474.472851] Dynamic subtest client: SUCCESS (1.869s) [474.488282] Starting dynamic subtest: gem_migrate [476.316494] Dynamic subtest gem_migrate: SUCCESS (1.840s) [476.331917] Starting dynamic subtest: reset [481.761438] Dynamic subtest reset: SUCCESS (5.442s) [481.776776] Starting dynamic subtest: memory_region [483.613879] Dynamic subtest memory_region: SUCCESS (1.849s) [483.629258] Starting dynamic subtest: hangcheck [508.035544] Dynamic subtest hangcheck: SUCCESS (24.418s) [508.051274] Starting dynamic subtest: execlists [518.261092] Dynamic subtest execlists: SUCCESS (10.222s) [518.276523] Starting dynamic subtest: ring_submission [520.163387] Dynamic subtest ring_submission: SUCCESS (1.899s) [520.179069] Starting dynamic subtest: perf [522.096838] Dynamic subtest perf: SUCCESS (1.930s) [522.112411] Starting dynamic subtest: slpc [523.917490] Dynamic subtest slpc: SUCCESS (1.817s) [523.933130] Starting dynamic subtest: guc [525.783287] Dynamic subtest guc: SUCCESS (1.863s) [525.798932] Starting dynamic subtest: guc_multi_lrc [527.637489] Dynamic subtest guc_multi_lrc: SUCCESS (1.851s) [527.653145] Starting dynamic subtest: guc_hang [529.507519] Dynamic subtest guc_hang: SUCCESS (1.867s) [529.523226] Starting dynamic subtest: late_gt_pm [531.372368] Dynamic subtest late_gt_pm: SUCCESS (1.862s) [531.373624] Subtest live: SUCCESS (169.703s) [531.571838] [165/171] (479s left) dmabuf (all-tests) [531.713051] Starting subtest: all-tests [531.714572] Starting dynamic subtest: sanitycheck [531.779924] Dynamic subtest sanitycheck: SUCCESS (0.065s) [531.799260] Starting dynamic subtest: dma_fence [531.969078] Dynamic subtest dma_fence: SUCCESS (0.185s) [531.988972] Starting dynamic subtest: dma_fence_chain [549.559195] Dynamic subtest dma_fence_chain: SUCCESS (17.578s) [549.573982] Starting dynamic subtest: dma_fence_unwrap [549.620752] Dynamic subtest dma_fence_unwrap: SUCCESS (0.066s) [549.639859] Starting dynamic subtest: dma_resv [549.698845] Dynamic subtest dma_resv: SUCCESS (0.074s) [549.701367] Subtest all-tests: SUCCESS (17.987s) [549.732651] [166/171] (460s left) i915_suspend (basic-s2idle-without-i915) [549.860815] Starting subtest: basic-s2idle-without-i915 [572.968570] Subtest basic-s2idle-without-i915: SUCCESS (8.415s) [573.270599] [167/171] (452s left) i915_suspend (basic-s3-without-i915) [573.411507] Starting subtest: basic-s3-without-i915 [597.010803] Subtest basic-s3-without-i915: SUCCESS (7.109s) [597.347909] [168/171] (444s left) gem_exec_suspend (basic-s0) [597.506532] Starting subtest: basic-S0 [597.507769] Starting dynamic subtest: smem [617.100832] Dynamic subtest smem: SUCCESS (3.813s) [617.102165] Subtest basic-S0: SUCCESS (3.815s) [617.259004] [169/171] (440s left) gem_exec_suspend (basic-s3) [617.408860] Starting subtest: basic-S3 [617.409998] Starting dynamic subtest: smem [636.219257] Dynamic subtest smem: SUCCESS (3.802s) [636.220420] Subtest basic-S3: SUCCESS (3.804s) [636.378967] [170/171] (436s left) kms_chamelium_hpd (common-hpd-after-suspend) [636.873461] Subtest common-hpd-after-suspend: SKIP (0.000s) [637.789540] [171/171] (434s left) kms_pipe_crc_basic (suspend-read-crc) [637.951374] Starting subtest: suspend-read-crc [637.954825] Starting dynamic subtest: pipe-A-eDP-1 [656.024176] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.416s) [656.046555] Starting dynamic subtest: pipe-B-eDP-1 [673.980815] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.062s) [674.003892] Starting dynamic subtest: pipe-C-eDP-1 [692.990635] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.241s) [692.991847] Subtest suspend-read-crc: SUCCESS (8.731s) [693.888584] Closing watchdogs Done.