[40.281589] Initializing watchdogs [40.281779] /dev/watchdog0 [40.292900] [001/171] (960s left) i915_module_load (load) [40.433180] Starting subtest: load [42.163032] Subtest load: SUCCESS (1.730s) [42.189894] [002/171] (958s left) core_auth (basic-auth) [42.468907] Starting subtest: basic-auth [42.470108] Subtest basic-auth: SUCCESS (0.001s) [42.554435] [003/171] (958s left) debugfs_test (read_all_entries) [42.778904] Starting subtest: read_all_entries [42.916695] Subtest read_all_entries: SUCCESS (0.138s) [43.054233] [004/171] (957s left) debugfs_test (basic-hwmon) [43.189887] Starting subtest: basic-hwmon [43.193805] Subtest basic-hwmon: SKIP (0.001s) [43.337418] [005/171] (957s left) fbdev (eof) [43.480310] Starting subtest: eof [43.481447] Subtest eof: SUCCESS (0.000s) [43.537194] [006/171] (957s left) fbdev (info) [43.661538] Starting subtest: info [43.662714] Subtest info: SUCCESS (0.000s) [43.736953] [007/171] (957s left) fbdev (nullptr) [43.880199] Starting subtest: nullptr [43.881317] Subtest nullptr: SUCCESS (0.000s) [43.937127] [008/171] (957s left) fbdev (read) [44.080143] Starting subtest: read [45.609923] Subtest read: SUCCESS (1.527s) [45.671825] [009/171] (955s left) fbdev (write) [45.816892] Starting subtest: write [46.615533] Subtest write: SUCCESS (0.800s) [46.674124] [010/171] (954s left) gem_basic (bad-close) [46.804648] Starting subtest: bad-close [46.807035] Subtest bad-close: SUCCESS (0.000s) [46.873093] [011/171] (954s left) gem_basic (create-close) [47.001602] Starting subtest: create-close [47.003801] Subtest create-close: SUCCESS (0.000s) [47.089156] [012/171] (953s left) gem_basic (create-fd-close) [47.218122] Starting subtest: create-fd-close [47.220334] Subtest create-fd-close: SUCCESS (0.001s) [47.290110] [013/171] (953s left) gem_busy (busy@all-engines) [47.442190] Starting subtest: busy [47.443909] Starting dynamic subtest: all-engines [47.503457] Dynamic subtest all-engines: SUCCESS (0.061s) [47.505095] Subtest busy: SUCCESS (0.062s) [47.824170] [014/171] (953s left) gem_close_race (basic-process) [47.976867] Starting subtest: basic-process [48.046044] Subtest basic-process: SUCCESS (0.069s) [48.222200] [015/171] (952s left) gem_close_race (basic-threads) [48.373048] Starting subtest: basic-threads [49.511183] Subtest basic-threads: SUCCESS (1.138s) [49.689814] [016/171] (951s left) gem_ctx_create (basic) [49.838270] Starting subtest: basic [49.839509] Subtest basic: SUCCESS (0.000s) [50.023761] [017/171] (951s left) gem_ctx_create (basic-files) [50.175835] Starting subtest: basic-files [52.205205] Subtest basic-files: SUCCESS (2.035s) [52.418124] [018/171] (948s left) gem_ctx_exec (basic) [52.644092] Starting subtest: basic [52.653595] Subtest basic: SUCCESS (0.010s) [52.733379] [019/171] (948s left) gem_exec_basic (basic) [52.900545] Starting subtest: basic [52.902249] Starting dynamic subtest: rcs0-smem [52.905580] Dynamic subtest rcs0-smem: SUCCESS (0.004s) [52.922157] Starting dynamic subtest: bcs0-smem [52.924665] Dynamic subtest bcs0-smem: SUCCESS (0.010s) [52.934231] Starting dynamic subtest: vcs0-smem [52.935306] Dynamic subtest vcs0-smem: SUCCESS (0.003s) [52.944577] Starting dynamic subtest: vecs0-smem [52.945659] Dynamic subtest vecs0-smem: SUCCESS (0.003s) [52.946819] Subtest basic: SUCCESS (0.026s) [53.124498] [020/171] (948s left) gem_exec_create (basic) [53.266601] Starting subtest: basic [53.267771] Starting dynamic subtest: smem [55.312764] Dynamic subtest smem: SUCCESS (2.046s) [55.314228] Subtest basic: SUCCESS (2.046s) [55.491282] [021/171] (945s left) gem_exec_fence (basic-busy) [55.759575] Starting subtest: basic-busy [55.761210] Starting dynamic subtest: rcs0 [55.776733] Dynamic subtest rcs0: SUCCESS (0.018s) [55.788834] Starting dynamic subtest: bcs0 [55.794474] Dynamic subtest bcs0: SUCCESS (0.020s) [55.806211] Starting dynamic subtest: vcs0 [55.809772] Dynamic subtest vcs0: SUCCESS (0.015s) [55.822024] Starting dynamic subtest: vecs0 [55.824414] Dynamic subtest vecs0: SUCCESS (0.013s) [55.825539] Subtest basic-busy: SUCCESS (0.067s) [56.457536] [022/171] (944s left) gem_exec_fence (basic-wait) [56.727330] Starting subtest: basic-wait [56.729134] Starting dynamic subtest: rcs0 [56.741239] Dynamic subtest rcs0: SUCCESS (0.016s) [56.753405] Starting dynamic subtest: bcs0 [56.764939] Dynamic subtest bcs0: SUCCESS (0.021s) [56.775260] Starting dynamic subtest: vcs0 [56.777675] Dynamic subtest vcs0: SUCCESS (0.014s) [56.788193] Starting dynamic subtest: vecs0 [56.790585] Dynamic subtest vecs0: SUCCESS (0.013s) [56.791742] Subtest basic-wait: SUCCESS (0.066s) [57.356742] [023/171] (943s left) gem_exec_fence (basic-await) [57.621886] Starting subtest: basic-await [57.623194] Starting dynamic subtest: rcs0 [57.716567] Dynamic subtest rcs0: SUCCESS (0.093s) [57.726744] Starting dynamic subtest: bcs0 [57.813148] Dynamic subtest bcs0: SUCCESS (0.095s) [57.823181] Starting dynamic subtest: vcs0 [57.904917] Dynamic subtest vcs0: SUCCESS (0.093s) [57.915206] Starting dynamic subtest: vecs0 [58.000863] Dynamic subtest vecs0: SUCCESS (0.094s) [58.002249] Subtest basic-await: SUCCESS (0.380s) [58.575606] [024/171] (942s left) gem_exec_fence (nb-await) [58.843275] Starting subtest: nb-await [58.844443] Starting dynamic subtest: rcs0 [58.912145] Dynamic subtest rcs0: SUCCESS (0.070s) [58.925033] Starting dynamic subtest: bcs0 [58.974055] Dynamic subtest bcs0: SUCCESS (0.063s) [58.983979] Starting dynamic subtest: vcs0 [59.042954] Dynamic subtest vcs0: SUCCESS (0.067s) [59.052985] Starting dynamic subtest: vecs0 [59.109125] Dynamic subtest vecs0: SUCCESS (0.067s) [59.110804] Subtest nb-await: SUCCESS (0.268s) [59.691185] [025/171] (941s left) gem_exec_gttfill (basic) [59.836969] Starting subtest: basic [71.921163] Subtest basic: SUCCESS (12.083s) [72.112743] [026/171] (929s left) gem_exec_parallel (engines) [72.370666] Starting subtest: engines [72.372845] Starting dynamic subtest: basic [75.241212] Dynamic subtest basic: SUCCESS (2.869s) [75.254691] Starting dynamic subtest: contexts [78.715333] Dynamic subtest contexts: SUCCESS (3.473s) [78.726829] Starting dynamic subtest: fds [82.725588] Dynamic subtest fds: SUCCESS (4.010s) [82.748935] Starting dynamic subtest: userptr [85.892905] Dynamic subtest userptr: SUCCESS (3.166s) [85.893999] Subtest engines: SUCCESS (13.520s) [86.075391] [027/171] (915s left) gem_exec_store (basic) [86.231435] Starting subtest: basic [86.276693] Subtest basic: SUCCESS (0.044s) [86.459501] [028/171] (914s left) gem_flink_basic (bad-flink) [86.588354] Starting subtest: bad-flink [86.589525] Subtest bad-flink: SUCCESS (0.000s) [86.657596] [029/171] (914s left) gem_flink_basic (bad-open) [86.786417] Starting subtest: bad-open [86.787550] Subtest bad-open: SUCCESS (0.000s) [86.858660] [030/171] (914s left) gem_flink_basic (basic) [86.982547] Starting subtest: basic [86.983791] Subtest basic: SUCCESS (0.000s) [87.057559] [031/171] (914s left) gem_flink_basic (double-flink) [87.180056] Starting subtest: double-flink [87.181254] Subtest double-flink: SUCCESS (0.000s) [87.257905] [032/171] (914s left) gem_flink_basic (flink-lifetime) [87.381236] Starting subtest: flink-lifetime [87.383126] Subtest flink-lifetime: SUCCESS (0.002s) [87.459091] [033/171] (914s left) gem_huc_copy (huc-copy) [87.592348] Starting subtest: huc-copy [87.595457] Subtest huc-copy: SKIP (0.000s) [87.675333] [034/171] (913s left) gem_linear_blits (basic) [87.951410] Starting subtest: basic [87.967213] Subtest basic: SUCCESS (0.014s) [88.102906] [035/171] (913s left) gem_mmap (basic) [88.330539] Starting subtest: basic [88.336925] Subtest basic: SUCCESS (0.001s) [88.408748] [036/171] (913s left) gem_mmap_gtt (basic) [88.538182] Starting subtest: basic [88.539388] Subtest basic: SUCCESS (0.001s) [88.594936] [037/171] (913s left) gem_render_linear_blits (basic) [88.724187] Starting subtest: basic [88.786338] Subtest basic: SUCCESS (0.058s) [88.829772] [038/171] (912s left) gem_render_tiled_blits (basic) [88.958044] Starting subtest: basic [89.048741] Subtest basic: SUCCESS (0.089s) [89.098583] [039/171] (912s left) gem_ringfill (basic-all) [89.424825] Starting subtest: basic-all [90.611500] Subtest basic-all: SUCCESS (1.184s) [90.710742] [040/171] (911s left) gem_softpin (allocator-basic) [90.846805] Starting subtest: allocator-basic [91.016898] Subtest allocator-basic: SUCCESS (0.167s) [91.108461] [041/171] (910s left) gem_softpin (allocator-basic-reserve) [91.240964] Starting subtest: allocator-basic-reserve [91.413653] Subtest allocator-basic-reserve: SUCCESS (0.170s) [91.509094] [042/171] (910s left) gem_softpin (safe-alignment) [91.643698] Starting subtest: safe-alignment [91.663940] Subtest safe-alignment: SUCCESS (0.019s) [91.758427] [043/171] (910s left) gem_sync (basic-all) [91.904968] Starting subtest: basic-all [94.454490] Subtest basic-all: SUCCESS (2.551s) [94.642306] [044/171] (907s left) gem_sync (basic-each) [94.789083] Starting subtest: basic-each [97.040932] Subtest basic-each: SUCCESS (2.251s) [97.225305] [045/171] (904s left) gem_tiled_blits (basic) [97.492020] Starting subtest: basic [97.527398] Subtest basic: SUCCESS (0.035s) [97.651600] [046/171] (904s left) gem_tiled_fence_blits (basic) [98.042189] Starting subtest: basic [98.070993] Subtest basic: SUCCESS (0.029s) [98.206574] [047/171] (903s left) gem_tiled_pread_basic [98.724553] [048/171] (903s left) gem_wait (busy@all-engines) [98.873886] Starting subtest: busy [98.874989] Starting dynamic subtest: all-engines [99.394716] Dynamic subtest all-engines: SUCCESS (0.521s) [99.395829] Subtest busy: SUCCESS (0.522s) [99.607595] [049/171] (902s left) gem_wait (wait@all-engines) [99.755685] Starting subtest: wait [99.757170] Starting dynamic subtest: all-engines [100.789246] Dynamic subtest all-engines: SUCCESS (1.032s) [100.790529] Subtest wait: SUCCESS (1.032s) [100.992522] [050/171] (900s left) i915_getparams_basic (basic-eu-total) [101.116263] Starting subtest: basic-eu-total [101.118459] Subtest basic-eu-total: SUCCESS (0.000s) [101.191583] [051/171] (900s left) i915_getparams_basic (basic-subslice-total) [101.319073] Starting subtest: basic-subslice-total [101.321252] Subtest basic-subslice-total: SUCCESS (0.000s) [101.397471] [052/171] (900s left) i915_hangman (error-state-basic) [101.541358] Starting subtest: error-state-basic [101.558489] Subtest error-state-basic: SUCCESS (0.012s) [101.626523] [053/171] (900s left) i915_pciid [101.825533] [054/171] (900s left) kms_addfb_basic (addfb25-bad-modifier) [102.026915] Starting subtest: addfb25-bad-modifier [102.028094] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [102.206923] [055/171] (899s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [102.387458] Starting subtest: addfb25-framebuffer-vs-set-tiling [102.389170] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [102.573797] [056/171] (899s left) kms_addfb_basic (addfb25-modifier-no-flag) [102.761584] Starting subtest: addfb25-modifier-no-flag [102.762719] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [102.939841] [057/171] (899s left) kms_addfb_basic (addfb25-x-tiled-legacy) [103.130334] Starting subtest: addfb25-x-tiled-legacy [103.131544] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [103.340539] [058/171] (898s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [103.534265] Starting subtest: addfb25-x-tiled-mismatch-legacy [103.535447] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [103.740535] [059/171] (898s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [103.994721] Starting subtest: addfb25-yf-tiled-legacy [103.996054] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [104.140625] [060/171] (898s left) kms_addfb_basic (addfb25-y-tiled-legacy) [104.401161] Starting subtest: addfb25-y-tiled-legacy [104.402329] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [104.557117] [061/171] (897s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [104.801823] Starting subtest: addfb25-y-tiled-small-legacy [104.803087] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [104.940563] [062/171] (897s left) kms_addfb_basic (bad-pitch-0) [105.069902] Starting subtest: bad-pitch-0 [105.071082] Subtest bad-pitch-0: SUCCESS (0.000s) [105.340331] [063/171] (896s left) kms_addfb_basic (bad-pitch-1024) [105.467094] Starting subtest: bad-pitch-1024 [105.468222] Subtest bad-pitch-1024: SUCCESS (0.000s) [105.740782] [064/171] (896s left) kms_addfb_basic (bad-pitch-128) [105.867112] Starting subtest: bad-pitch-128 [105.868176] Subtest bad-pitch-128: SUCCESS (0.000s) [106.107668] [065/171] (896s left) kms_addfb_basic (bad-pitch-256) [106.236470] Starting subtest: bad-pitch-256 [106.237609] Subtest bad-pitch-256: SUCCESS (0.000s) [106.508114] [066/171] (895s left) kms_addfb_basic (bad-pitch-32) [106.636764] Starting subtest: bad-pitch-32 [106.637881] Subtest bad-pitch-32: SUCCESS (0.000s) [106.891263] [067/171] (895s left) kms_addfb_basic (bad-pitch-63) [107.018725] Starting subtest: bad-pitch-63 [107.019835] Subtest bad-pitch-63: SUCCESS (0.000s) [107.273992] [068/171] (895s left) kms_addfb_basic (bad-pitch-65536) [107.400434] Starting subtest: bad-pitch-65536 [107.401553] Subtest bad-pitch-65536: SUCCESS (0.000s) [107.657216] [069/171] (894s left) kms_addfb_basic (bad-pitch-999) [107.786876] Starting subtest: bad-pitch-999 [107.788128] Subtest bad-pitch-999: SUCCESS (0.000s) [108.040643] [070/171] (894s left) kms_addfb_basic (basic) [108.165066] Starting subtest: basic [108.166145] Subtest basic: SUCCESS (0.000s) [108.407256] [071/171] (894s left) kms_addfb_basic (basic-x-tiled-legacy) [108.720343] Starting subtest: basic-x-tiled-legacy [108.721443] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [108.807382] [072/171] (893s left) kms_addfb_basic (basic-y-tiled-legacy) [109.127264] Starting subtest: basic-y-tiled-legacy [109.128396] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [109.208073] [073/171] (893s left) kms_addfb_basic (bo-too-small) [109.399368] Starting subtest: bo-too-small [109.400447] Subtest bo-too-small: SUCCESS (0.001s) [109.607201] [074/171] (892s left) kms_addfb_basic (bo-too-small-due-to-tiling) [109.799762] Starting subtest: bo-too-small-due-to-tiling [109.800901] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [110.007338] [075/171] (892s left) kms_addfb_basic (clobberred-modifier) [110.133254] Starting subtest: clobberred-modifier [110.134348] Subtest clobberred-modifier: SUCCESS (0.000s) [110.407318] [076/171] (892s left) kms_addfb_basic (framebuffer-vs-set-tiling) [110.727243] Starting subtest: framebuffer-vs-set-tiling [110.728427] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [110.807442] [077/171] (891s left) kms_addfb_basic (invalid-get-prop) [111.130437] Starting subtest: invalid-get-prop [111.131749] Subtest invalid-get-prop: SUCCESS (0.000s) [111.207318] [078/171] (891s left) kms_addfb_basic (invalid-get-prop-any) [111.528371] Starting subtest: invalid-get-prop-any [111.529587] Subtest invalid-get-prop-any: SUCCESS (0.000s) [111.607420] [079/171] (891s left) kms_addfb_basic (invalid-set-prop) [111.924283] Starting subtest: invalid-set-prop [111.925417] Subtest invalid-set-prop: SUCCESS (0.000s) [112.007303] [080/171] (890s left) kms_addfb_basic (invalid-set-prop-any) [112.316726] Starting subtest: invalid-set-prop-any [112.317976] Subtest invalid-set-prop-any: SUCCESS (0.000s) [112.390483] [081/171] (890s left) kms_addfb_basic (no-handle) [112.515327] Starting subtest: no-handle [112.516511] Subtest no-handle: SUCCESS (0.000s) [112.790719] [082/171] (889s left) kms_addfb_basic (size-max) [112.984415] Starting subtest: size-max [112.985529] Subtest size-max: SUCCESS (0.000s) [113.190762] [083/171] (889s left) kms_addfb_basic (small-bo) [113.386960] Starting subtest: small-bo [113.388207] Subtest small-bo: SUCCESS (0.001s) [113.607980] [084/171] (889s left) kms_addfb_basic (tile-pitch-mismatch) [113.937324] Starting subtest: tile-pitch-mismatch [113.939807] Subtest tile-pitch-mismatch: SUCCESS (0.002s) [114.023970] [085/171] (888s left) kms_addfb_basic (too-high) [114.223439] Starting subtest: too-high [114.228743] Subtest too-high: SUCCESS (0.004s) [114.440640] [086/171] (888s left) kms_addfb_basic (too-wide) [114.650153] Starting subtest: too-wide [114.651240] Subtest too-wide: SUCCESS (0.000s) [114.857373] [087/171] (888s left) kms_addfb_basic (unused-handle) [114.983605] Starting subtest: unused-handle [114.984803] Subtest unused-handle: SUCCESS (0.000s) [115.274291] [088/171] (887s left) kms_addfb_basic (unused-modifier) [115.405420] Starting subtest: unused-modifier [115.406578] Subtest unused-modifier: SUCCESS (0.000s) [115.691625] [089/171] (887s left) kms_addfb_basic (unused-offsets) [115.818434] Starting subtest: unused-offsets [115.819595] Subtest unused-offsets: SUCCESS (0.000s) [116.074111] [090/171] (886s left) kms_addfb_basic (unused-pitches) [116.205173] Starting subtest: unused-pitches [116.206297] Subtest unused-pitches: SUCCESS (0.000s) [116.458079] [091/171] (886s left) kms_busy (basic) [116.675289] Starting subtest: basic [116.679765] Starting dynamic subtest: flip [117.561356] Dynamic subtest flip: SUCCESS (0.881s) [117.583091] Starting dynamic subtest: modeset [119.018609] Dynamic subtest modeset: SUCCESS (1.457s) [119.023239] Subtest basic: SUCCESS (2.343s) [119.218614] [092/171] (883s left) kms_chamelium_hpd (dp-hpd-fast) [119.643960] Subtest dp-hpd-fast: SKIP (0.000s) [119.792639] [093/171] (883s left) kms_chamelium_edid (dp-edid-read) [120.230918] Subtest dp-edid-read: SKIP (0.000s) [120.398186] [094/171] (882s left) kms_chamelium_frames (dp-crc-fast) [120.837642] Subtest dp-crc-fast: SKIP (0.000s) [121.002486] [095/171] (882s left) kms_chamelium_hpd (hdmi-hpd-fast) [121.445917] Subtest hdmi-hpd-fast: SKIP (0.000s) [121.612138] [096/171] (881s left) kms_chamelium_edid (hdmi-edid-read) [122.051224] Subtest hdmi-edid-read: SKIP (0.000s) [122.218937] [097/171] (880s left) kms_chamelium_frames (hdmi-crc-fast) [122.659182] Subtest hdmi-crc-fast: SKIP (0.000s) [122.829692] [098/171] (880s left) kms_chamelium_hpd (vga-hpd-fast) [123.270271] Subtest vga-hpd-fast: SKIP (0.000s) [123.437971] [099/171] (879s left) kms_chamelium_edid (vga-edid-read) [123.878756] Subtest vga-edid-read: SKIP (0.000s) [124.047594] [100/171] (879s left) kms_prop_blob (basic) [124.175169] Starting subtest: basic [124.176269] Subtest basic: SUCCESS (0.000s) [124.254723] [101/171] (878s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [124.457998] Starting subtest: basic-busy-flip-before-cursor-atomic [124.460505] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [124.538546] [102/171] (878s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [124.738042] Starting subtest: basic-busy-flip-before-cursor-legacy [124.740551] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [124.821572] [103/171] (878s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [125.021748] Starting subtest: basic-flip-after-cursor-atomic [126.257290] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.235s) [126.474567] [104/171] (876s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [126.679013] Starting subtest: basic-flip-after-cursor-legacy [127.901904] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.221s) [128.106374] [105/171] (875s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [128.309943] Starting subtest: basic-flip-after-cursor-varying-size [129.482787] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.173s) [129.678901] [106/171] (873s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [129.878885] Starting subtest: basic-flip-before-cursor-atomic [131.076661] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.198s) [131.283843] [107/171] (872s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [131.484983] Starting subtest: basic-flip-before-cursor-legacy [132.709690] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.221s) [132.914815] [108/171] (870s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [133.122666] Starting subtest: basic-flip-before-cursor-varying-size [134.341754] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.220s) [134.539807] [109/171] (868s left) kms_flip (basic-flip-vs-dpms) [134.723796] Starting subtest: basic-flip-vs-dpms [134.728952] Starting dynamic subtest: A-HDMI-A2 [136.095754] Dynamic subtest A-HDMI-A2: SUCCESS (1.357s) [136.119863] Starting dynamic subtest: B-HDMI-A2 [137.200301] Dynamic subtest B-HDMI-A2: SUCCESS (1.110s) [137.223834] Starting dynamic subtest: C-HDMI-A2 [138.281361] Dynamic subtest C-HDMI-A2: SUCCESS (1.082s) [138.282498] Subtest basic-flip-vs-dpms: SUCCESS (3.558s) [138.523815] [110/171] (864s left) kms_flip (basic-flip-vs-modeset) [138.702287] Starting subtest: basic-flip-vs-modeset [138.708844] Starting dynamic subtest: A-HDMI-A2 [140.141403] Dynamic subtest A-HDMI-A2: SUCCESS (1.424s) [140.166894] Starting dynamic subtest: B-HDMI-A2 [141.286856] Dynamic subtest B-HDMI-A2: SUCCESS (1.140s) [141.310908] Starting dynamic subtest: C-HDMI-A2 [142.444733] Dynamic subtest C-HDMI-A2: SUCCESS (1.141s) [142.445935] Subtest basic-flip-vs-modeset: SUCCESS (3.743s) [142.636918] [111/171] (860s left) kms_flip (basic-flip-vs-wf_vblank) [142.820520] Starting subtest: basic-flip-vs-wf_vblank [142.828173] Starting dynamic subtest: A-HDMI-A2 [144.342995] Dynamic subtest A-HDMI-A2: SUCCESS (1.506s) [144.366909] Starting dynamic subtest: B-HDMI-A2 [145.770359] Dynamic subtest B-HDMI-A2: SUCCESS (1.425s) [145.795917] Starting dynamic subtest: C-HDMI-A2 [147.192655] Dynamic subtest C-HDMI-A2: SUCCESS (1.418s) [147.193784] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.367s) [147.596100] [112/171] (855s left) kms_flip (basic-plain-flip) [147.779399] Starting subtest: basic-plain-flip [147.787195] Starting dynamic subtest: A-HDMI-A2 [149.017429] Dynamic subtest A-HDMI-A2: SUCCESS (1.230s) [149.042906] Starting dynamic subtest: B-HDMI-A2 [150.152377] Dynamic subtest B-HDMI-A2: SUCCESS (1.119s) [150.173894] Starting dynamic subtest: C-HDMI-A2 [151.293598] Dynamic subtest C-HDMI-A2: SUCCESS (1.125s) [151.294637] Subtest basic-plain-flip: SUCCESS (3.514s) [151.701559] [113/171] (851s left) kms_force_connector_basic (force-connector-state) [151.950753] Starting subtest: force-connector-state [152.391186] Subtest force-connector-state: SUCCESS (0.439s) [152.961177] [114/171] (850s left) kms_force_connector_basic (force-edid) [153.202083] Starting subtest: force-edid [153.250096] Subtest force-edid: SUCCESS (0.047s) [153.527194] [115/171] (850s left) kms_force_connector_basic (force-load-detect) [153.779980] Starting subtest: force-load-detect [153.784138] Subtest force-load-detect: SKIP (0.000s) [154.060681] [116/171] (849s left) kms_force_connector_basic (prune-stale-modes) [154.321947] Starting subtest: prune-stale-modes [154.390911] Subtest prune-stale-modes: SUCCESS (0.071s) [154.644077] [117/171] (849s left) kms_frontbuffer_tracking (basic) [154.871330] Starting subtest: basic [157.676555] Subtest basic: SUCCESS (2.795s) [157.778335] [118/171] (845s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [157.989233] Starting subtest: compare-crc-sanitycheck [157.993857] Starting dynamic subtest: pipe-A-HDMI-A-2 [158.578628] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.579s) [158.602908] Starting dynamic subtest: pipe-B-HDMI-A-2 [159.172767] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.582s) [159.196937] Starting dynamic subtest: pipe-C-HDMI-A-2 [159.774236] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.591s) [159.775354] Subtest compare-crc-sanitycheck: SUCCESS (1.786s) [159.981915] [119/171] (843s left) kms_pipe_crc_basic (hang-read-crc) [160.194956] Starting subtest: hang-read-crc [160.200011] Starting dynamic subtest: pipe-A-HDMI-A-2 [161.707715] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.507s) [161.730928] Starting dynamic subtest: pipe-B-HDMI-A-2 [163.232997] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.514s) [163.257944] Starting dynamic subtest: pipe-C-HDMI-A-2 [164.756234] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.509s) [164.757417] Subtest hang-read-crc: SUCCESS (4.559s) [165.023269] [120/171] (838s left) kms_pipe_crc_basic (nonblocking-crc) [165.243840] Starting subtest: nonblocking-crc [165.249025] Starting dynamic subtest: pipe-A-HDMI-A-2 [166.018316] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.771s) [166.041949] Starting dynamic subtest: pipe-B-HDMI-A-2 [166.790752] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.755s) [166.811871] Starting dynamic subtest: pipe-C-HDMI-A-2 [167.519822] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.730s) [167.521202] Subtest nonblocking-crc: SUCCESS (2.277s) [167.705838] [121/171] (836s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [167.915441] Starting subtest: nonblocking-crc-frame-sequence [167.920560] Starting dynamic subtest: pipe-A-HDMI-A-2 [168.680787] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.760s) [168.705940] Starting dynamic subtest: pipe-B-HDMI-A-2 [169.440511] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.749s) [169.466869] Starting dynamic subtest: pipe-C-HDMI-A-2 [170.233792] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.778s) [170.235158] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.317s) [170.463689] [122/171] (833s left) kms_pipe_crc_basic (read-crc) [170.670808] Starting subtest: read-crc [170.676055] Starting dynamic subtest: pipe-A-HDMI-A-2 [171.351951] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.677s) [171.373925] Starting dynamic subtest: pipe-B-HDMI-A-2 [172.073837] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.711s) [172.101887] Starting dynamic subtest: pipe-C-HDMI-A-2 [172.846071] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.761s) [172.847183] Subtest read-crc: SUCCESS (2.175s) [173.051107] [123/171] (830s left) kms_pipe_crc_basic (read-crc-frame-sequence) [173.259213] Starting subtest: read-crc-frame-sequence [173.263470] Starting dynamic subtest: pipe-A-HDMI-A-2 [173.961613] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.697s) [173.984917] Starting dynamic subtest: pipe-B-HDMI-A-2 [174.722816] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.750s) [174.747883] Starting dynamic subtest: pipe-C-HDMI-A-2 [175.426300] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.693s) [175.427430] Subtest read-crc-frame-sequence: SUCCESS (2.168s) [175.610245] [124/171] (828s left) kms_psr (primary_page_flip) [175.738977] Subtest primary_page_flip: SKIP (0.000s) [175.781697] [125/171] (828s left) kms_psr (cursor_plane_move) [175.909645] Subtest cursor_plane_move: SKIP (0.000s) [175.949064] [126/171] (827s left) kms_psr (sprite_plane_onoff) [176.078117] Subtest sprite_plane_onoff: SKIP (0.000s) [176.131617] [127/171] (827s left) kms_psr (primary_mmap_gtt) [176.259314] Subtest primary_mmap_gtt: SKIP (0.000s) [176.314890] [128/171] (827s left) kms_setmode (basic-clone-single-crtc) [176.443759] Starting subtest: basic-clone-single-crtc [176.447115] Subtest basic-clone-single-crtc: SKIP (0.000s) [176.526328] [129/171] (827s left) i915_pm_backlight (basic-brightness) [176.736897] Subtest basic-brightness: SKIP (0.000s) [176.781572] [130/171] (827s left) i915_pm_rpm (basic-pci-d3-state) [178.670812] Starting subtest: basic-pci-d3-state [179.286343] Subtest basic-pci-d3-state: SUCCESS (0.617s) [179.520606] [131/171] (824s left) i915_pm_rpm (basic-rte) [179.645725] Starting subtest: basic-rte [181.975702] Subtest basic-rte: SUCCESS (2.324s) [182.785477] [132/171] (821s left) i915_pm_rps (basic-api) [182.929827] Starting subtest: basic-api [182.941548] Subtest basic-api: SUCCESS (0.012s) [183.017368] [133/171] (821s left) prime_self_import (basic-llseek-bad) [183.144258] Starting subtest: basic-llseek-bad [183.152188] Subtest basic-llseek-bad: SUCCESS (0.008s) [183.233757] [134/171] (820s left) prime_self_import (basic-llseek-size) [183.357615] Starting subtest: basic-llseek-size [183.366204] Subtest basic-llseek-size: SUCCESS (0.008s) [183.450387] [135/171] (820s left) prime_self_import (basic-with_fd_dup) [183.574264] Starting subtest: basic-with_fd_dup [183.582752] Subtest basic-with_fd_dup: SUCCESS (0.008s) [183.666828] [136/171] (820s left) prime_self_import (basic-with_one_bo) [183.792236] Starting subtest: basic-with_one_bo [183.801348] Subtest basic-with_one_bo: SUCCESS (0.009s) [183.872600] [137/171] (820s left) prime_self_import (basic-with_one_bo_two_files) [183.993825] Starting subtest: basic-with_one_bo_two_files [184.003205] Subtest basic-with_one_bo_two_files: SUCCESS (0.009s) [184.083619] [138/171] (820s left) prime_self_import (basic-with_two_bos) [184.207652] Starting subtest: basic-with_two_bos [184.218187] Subtest basic-with_two_bos: SUCCESS (0.010s) [184.301732] [139/171] (819s left) prime_vgem (basic-fence-flip) [184.454435] Starting subtest: basic-fence-flip [184.964844] Subtest basic-fence-flip: SUCCESS (0.510s) [185.051542] [140/171] (819s left) prime_vgem (basic-fence-mmap) [185.204948] Starting subtest: basic-fence-mmap [185.259930] Subtest basic-fence-mmap: SUCCESS (0.051s) [185.351628] [141/171] (818s left) prime_vgem (basic-fence-read) [185.505452] Starting subtest: basic-fence-read [185.591175] Subtest basic-fence-read: SUCCESS (0.083s) [185.669253] [142/171] (818s left) prime_vgem (basic-gtt) [185.821426] Starting subtest: basic-gtt [185.846585] Subtest basic-gtt: SUCCESS (0.025s) [185.933863] [143/171] (818s left) prime_vgem (basic-read) [186.085754] Starting subtest: basic-read [186.134842] Subtest basic-read: SUCCESS (0.049s) [186.217390] [144/171] (818s left) prime_vgem (basic-write) [186.368584] Starting subtest: basic-write [186.420434] Subtest basic-write: SUCCESS (0.052s) [186.501583] [145/171] (817s left) prime_vgem (basic-userptr) [186.655629] Starting subtest: basic-userptr [186.674226] Subtest basic-userptr: SKIP (0.018s) [186.772596] [146/171] (817s left) vgem_basic (setversion) [186.905438] Starting subtest: setversion [186.907693] Subtest setversion: SUCCESS (0.001s) [186.967238] [147/171] (817s left) vgem_basic (create) [187.107640] Starting subtest: create [187.108770] Subtest create: SUCCESS (0.001s) [187.167141] [148/171] (817s left) vgem_basic (debugfs) [187.305287] Starting subtest: debugfs [187.308381] Subtest debugfs: SUCCESS (0.003s) [187.367230] [149/171] (817s left) vgem_basic (dmabuf-export) [187.507572] Starting subtest: dmabuf-export [187.513096] Subtest dmabuf-export: SUCCESS (0.007s) [187.600627] [150/171] (816s left) vgem_basic (dmabuf-fence) [187.738571] Starting subtest: dmabuf-fence [187.741754] Subtest dmabuf-fence: SUCCESS (0.003s) [187.800561] [151/171] (816s left) vgem_basic (dmabuf-fence-before) [187.939013] Starting subtest: dmabuf-fence-before [187.940111] Subtest dmabuf-fence-before: SUCCESS (0.001s) [188.000607] [152/171] (816s left) vgem_basic (dmabuf-mmap) [188.139593] Starting subtest: dmabuf-mmap [188.171166] Subtest dmabuf-mmap: SUCCESS (0.032s) [188.234189] [153/171] (816s left) vgem_basic (mmap) [188.371870] Starting subtest: mmap [188.392446] Subtest mmap: SUCCESS (0.020s) [188.450590] [154/171] (816s left) vgem_basic (second-client) [188.589060] Starting subtest: second-client [188.637584] Subtest second-client: SUCCESS (0.049s) [188.701797] [155/171] (815s left) vgem_basic (sysfs) [188.838499] Starting subtest: sysfs [188.841719] Subtest sysfs: SUCCESS (0.003s) [188.901630] [156/171] (815s left) core_hotunplug (unbind-rebind) [189.055296] Starting subtest: unbind-rebind [190.612367] Subtest unbind-rebind: SUCCESS (1.550s) [190.671503] [157/171] (814s left) vgem_basic (unload) [190.962711] Starting subtest: unload [219.834648] Subtest unload: SUCCESS (28.869s) [219.955205] [158/171] (784s left) i915_module_load (reload) [220.083945] Starting subtest: reload [222.715740] Subtest reload: SUCCESS (2.629s) [222.782076] [159/171] (782s left) gem_lmem_swapping (basic) [223.034229] Subtest basic: SKIP (0.000s) [223.098972] [160/171] (781s left) gem_lmem_swapping (parallel-random-engines) [223.313515] Subtest parallel-random-engines: SKIP (0.000s) [223.356847] [161/171] (781s left) gem_lmem_swapping (random-engines) [223.498200] Subtest random-engines: SKIP (0.000s) [223.539919] [162/171] (781s left) gem_lmem_swapping (verify-random) [223.677184] Subtest verify-random: SKIP (0.000s) [223.728440] [163/171] (781s left) i915_pm_rpm (module-reload) [225.812285] Starting subtest: module-reload [234.607333] Subtest module-reload: SUCCESS (8.795s) [234.635710] [164/171] (770s left) i915_selftest (live) [234.789562] Starting subtest: live [234.792757] Starting dynamic subtest: sanitycheck [235.635148] Dynamic subtest sanitycheck: SUCCESS (0.841s) [235.648856] Starting dynamic subtest: uncore [236.491111] Dynamic subtest uncore: SUCCESS (0.855s) [236.505076] Starting dynamic subtest: workarounds [237.488294] Dynamic subtest workarounds: SUCCESS (0.996s) [237.501882] Starting dynamic subtest: gt_engines [238.774987] Dynamic subtest gt_engines: SUCCESS (1.286s) [238.788997] Starting dynamic subtest: gt_timelines [251.360925] Dynamic subtest gt_timelines: SUCCESS (12.584s) [251.371636] Starting dynamic subtest: gt_contexts [252.253520] Dynamic subtest gt_contexts: SUCCESS (0.892s) [252.268904] Starting dynamic subtest: gt_lrc [255.689798] Dynamic subtest gt_lrc: SUCCESS (3.433s) [255.700616] Starting dynamic subtest: gt_mocs [256.480161] Dynamic subtest gt_mocs: SUCCESS (0.791s) [256.495038] Starting dynamic subtest: gt_pm [263.587679] Dynamic subtest gt_pm: SUCCESS (7.105s) [263.598196] Starting dynamic subtest: gt_heartbeat [264.503801] Dynamic subtest gt_heartbeat: SUCCESS (0.916s) [264.520290] Starting dynamic subtest: requests [271.896092] Dynamic subtest requests: SUCCESS (7.391s) [271.907145] Starting dynamic subtest: migrate [275.861043] Dynamic subtest migrate: SUCCESS (3.964s) [275.872401] Starting dynamic subtest: active [276.701351] Dynamic subtest active: SUCCESS (0.840s) [276.715933] Starting dynamic subtest: objects [279.732993] Dynamic subtest objects: SUCCESS (3.029s) [279.744282] Starting dynamic subtest: mman [286.804846] Dynamic subtest mman: SUCCESS (7.072s) [286.816847] Starting dynamic subtest: dmabuf [287.659134] Dynamic subtest dmabuf: SUCCESS (0.853s) [287.676092] Starting dynamic subtest: vma [288.464176] Dynamic subtest vma: SUCCESS (0.804s) [288.478191] Starting dynamic subtest: coherency [291.525994] Dynamic subtest coherency: SUCCESS (3.060s) [291.537035] Starting dynamic subtest: gtt [301.812575] Dynamic subtest gtt: SUCCESS (10.285s) [301.823347] Starting dynamic subtest: gem [302.713323] Dynamic subtest gem: SUCCESS (0.901s) [302.729044] Starting dynamic subtest: evict [305.798911] Dynamic subtest evict: SUCCESS (3.084s) [305.810089] Starting dynamic subtest: hugepages [312.236954] Dynamic subtest hugepages: SUCCESS (6.437s) [312.248448] Starting dynamic subtest: gem_contexts [328.623202] Dynamic subtest gem_contexts: SUCCESS (16.386s) [328.635674] Starting dynamic subtest: client [329.432179] Dynamic subtest client: SUCCESS (0.808s) [329.447125] Starting dynamic subtest: gem_migrate [330.141034] Dynamic subtest gem_migrate: SUCCESS (0.708s) [330.157929] Starting dynamic subtest: reset [335.308943] Dynamic subtest reset: SUCCESS (5.166s) [335.320416] Starting dynamic subtest: memory_region [336.146916] Dynamic subtest memory_region: SUCCESS (0.838s) [336.164104] Starting dynamic subtest: hangcheck [360.169017] Dynamic subtest hangcheck: SUCCESS (24.020s) [360.180089] Starting dynamic subtest: execlists [370.015901] Dynamic subtest execlists: SUCCESS (9.846s) [370.027393] Starting dynamic subtest: ring_submission [370.894219] Dynamic subtest ring_submission: SUCCESS (0.878s) [370.911291] Starting dynamic subtest: perf [371.923685] Dynamic subtest perf: SUCCESS (1.028s) [371.934629] Starting dynamic subtest: slpc [372.766018] Dynamic subtest slpc: SUCCESS (0.841s) [372.785063] Starting dynamic subtest: guc [373.580132] Dynamic subtest guc: SUCCESS (0.813s) [373.600036] Starting dynamic subtest: guc_multi_lrc [374.373145] Dynamic subtest guc_multi_lrc: SUCCESS (0.792s) [374.387889] Starting dynamic subtest: guc_hang [375.245343] Dynamic subtest guc_hang: SUCCESS (0.871s) [375.264048] Starting dynamic subtest: late_gt_pm [376.165103] Dynamic subtest late_gt_pm: SUCCESS (0.919s) [376.166175] Subtest live: SUCCESS (141.374s) [376.241518] [165/171] (628s left) dmabuf (all-tests) [376.375915] Starting subtest: all-tests [376.379901] Starting dynamic subtest: sanitycheck [376.393984] Dynamic subtest sanitycheck: SUCCESS (0.019s) [376.405239] Starting dynamic subtest: dma_fence [376.543769] Dynamic subtest dma_fence: SUCCESS (0.148s) [376.565895] Starting dynamic subtest: dma_fence_chain [394.288606] Dynamic subtest dma_fence_chain: SUCCESS (17.742s) [394.303352] Starting dynamic subtest: dma_fence_unwrap [394.319958] Dynamic subtest dma_fence_unwrap: SUCCESS (0.030s) [394.342404] Starting dynamic subtest: dma_resv [394.355850] Dynamic subtest dma_resv: SUCCESS (0.026s) [394.356970] Subtest all-tests: SUCCESS (17.974s) [394.374697] [166/171] (610s left) i915_suspend (basic-s2idle-without-i915) [394.502332] Starting subtest: basic-s2idle-without-i915 [413.470644] Subtest basic-s2idle-without-i915: SUCCESS (3.989s) [419.727179] [167/171] (606s left) i915_suspend (basic-s3-without-i915) [419.854662] Starting subtest: basic-s3-without-i915 [439.944241] Subtest basic-s3-without-i915: SUCCESS (4.104s) [444.195786] [168/171] (601s left) gem_exec_suspend (basic-s0) [444.361561] Starting subtest: basic-S0 [444.364302] Starting dynamic subtest: smem [464.385863] Dynamic subtest smem: SUCCESS (4.853s) [464.387065] Subtest basic-S0: SUCCESS (4.854s) [470.555868] [169/171] (596s left) gem_exec_suspend (basic-s3) [470.705262] Starting subtest: basic-S3 [470.707629] Starting dynamic subtest: smem [492.418262] Dynamic subtest smem: SUCCESS (5.766s) [492.419380] Subtest basic-S3: SUCCESS (5.768s) [497.596437] [170/171] (590s left) kms_chamelium_hpd (common-hpd-after-suspend) [498.028392] Subtest common-hpd-after-suspend: SKIP (0.000s) [498.214894] [171/171] (590s left) kms_pipe_crc_basic (suspend-read-crc) [498.426203] Starting subtest: suspend-read-crc [498.430557] Starting dynamic subtest: pipe-A-HDMI-A-2 [519.244989] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (4.246s) [519.271885] Starting dynamic subtest: pipe-B-HDMI-A-2 [540.016003] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (3.905s) [540.040265] Starting dynamic subtest: pipe-C-HDMI-A-2 [560.402729] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (4.327s) [560.403904] Subtest suspend-read-crc: SUCCESS (12.501s) [566.590257] Closing watchdogs Done.