[42.278323] Initializing watchdogs [42.278556] /dev/watchdog0 [42.315966] [001/171] (960s left) i915_module_load (load) [42.615104] Starting subtest: load [45.149941] Subtest load: SUCCESS (2.529s) [45.287737] [002/171] (957s left) core_auth (basic-auth) [45.624119] Starting subtest: basic-auth [45.645259] Subtest basic-auth: SUCCESS (0.002s) [45.749548] [003/171] (957s left) debugfs_test (read_all_entries) [46.050666] Starting subtest: read_all_entries [46.471315] Subtest read_all_entries: SUCCESS (0.409s) [46.679816] [004/171] (956s left) debugfs_test (basic-hwmon) [46.994464] Starting subtest: basic-hwmon [47.033420] Subtest basic-hwmon: SKIP (0.000s) [47.195444] [005/171] (956s left) fbdev (eof) [47.472161] Starting subtest: eof [47.492067] Subtest eof: SUCCESS (0.002s) [47.621921] [006/171] (955s left) fbdev (info) [47.889175] Starting subtest: info [47.909205] Subtest info: SUCCESS (0.000s) [48.037510] [007/171] (955s left) fbdev (nullptr) [48.307933] Starting subtest: nullptr [48.330159] Subtest nullptr: SUCCESS (0.000s) [48.458043] [008/171] (955s left) fbdev (read) [48.727502] Starting subtest: read [50.215111] Subtest read: SUCCESS (1.485s) [50.323623] [009/171] (953s left) fbdev (write) [50.605159] Starting subtest: write [51.364345] Subtest write: SUCCESS (0.761s) [51.473327] [010/171] (952s left) gem_basic (bad-close) [51.770668] Starting subtest: bad-close [51.816925] Subtest bad-close: SUCCESS (0.000s) [51.905698] [011/171] (951s left) gem_basic (create-close) [52.198655] Starting subtest: create-close [52.241322] Subtest create-close: SUCCESS (0.000s) [52.328241] [012/171] (951s left) gem_basic (create-fd-close) [52.624538] Starting subtest: create-fd-close [52.667924] Subtest create-fd-close: SUCCESS (0.000s) [52.755570] [013/171] (951s left) gem_busy (busy@all-engines) [53.062591] Starting subtest: busy [53.082523] Starting dynamic subtest: all-engines [53.151571] Dynamic subtest all-engines: SUCCESS (0.096s) [53.181068] Subtest busy: SUCCESS (0.096s) [53.576279] [014/171] (950s left) gem_close_race (basic-process) [53.860499] Starting subtest: basic-process [53.965361] Subtest basic-process: SUCCESS (0.107s) [54.191693] [015/171] (949s left) gem_close_race (basic-threads) [54.486167] Starting subtest: basic-threads [55.683416] Subtest basic-threads: SUCCESS (1.190s) [55.898231] [016/171] (948s left) gem_ctx_create (basic) [56.202403] Starting subtest: basic [56.224554] Subtest basic: SUCCESS (0.000s) [56.409842] [017/171] (947s left) gem_ctx_create (basic-files) [56.731623] Starting subtest: basic-files [58.748577] Subtest basic-files: SUCCESS (2.037s) [58.997081] [018/171] (945s left) gem_ctx_exec (basic) [59.300540] Starting subtest: basic [59.322922] Subtest basic: SUCCESS (0.008s) [59.408932] [019/171] (945s left) gem_exec_basic (basic) [59.708050] Starting subtest: basic [59.728253] Starting dynamic subtest: rcs0-smem [59.749607] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [59.784560] Starting dynamic subtest: bcs0-smem [59.805127] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [59.838434] Starting dynamic subtest: vcs0-smem [59.859501] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [59.895676] Starting dynamic subtest: vecs0-smem [59.916892] Dynamic subtest vecs0-smem: SUCCESS (0.002s) [59.937189] Subtest basic: SUCCESS (0.011s) [60.028116] [020/171] (944s left) gem_exec_create (basic) [60.330861] Starting subtest: basic [60.352862] Starting dynamic subtest: smem [62.407801] Dynamic subtest smem: SUCCESS (2.074s) [62.428706] Subtest basic: SUCCESS (2.074s) [62.625797] [021/171] (942s left) gem_exec_fence (basic-busy) [63.057675] Starting subtest: basic-busy [63.079704] Starting dynamic subtest: rcs0 [63.120609] Dynamic subtest rcs0: SUCCESS (0.031s) [63.157129] Starting dynamic subtest: bcs0 [63.201943] Dynamic subtest bcs0: SUCCESS (0.032s) [63.235218] Starting dynamic subtest: vcs0 [63.278660] Dynamic subtest vcs0: SUCCESS (0.026s) [63.311935] Starting dynamic subtest: vecs0 [63.353041] Dynamic subtest vecs0: SUCCESS (0.019s) [63.375695] Subtest basic-busy: SUCCESS (0.108s) [63.968192] [022/171] (940s left) gem_exec_fence (basic-wait) [64.391208] Starting subtest: basic-wait [64.413493] Starting dynamic subtest: rcs0 [64.434920] Dynamic subtest rcs0: SUCCESS (0.029s) [64.469670] Starting dynamic subtest: bcs0 [64.491037] Dynamic subtest bcs0: SUCCESS (0.028s) [64.526848] Starting dynamic subtest: vcs0 [64.548058] Dynamic subtest vcs0: SUCCESS (0.027s) [64.581264] Starting dynamic subtest: vecs0 [64.602480] Dynamic subtest vecs0: SUCCESS (0.030s) [64.625242] Subtest basic-wait: SUCCESS (0.114s) [65.213433] [023/171] (939s left) gem_exec_fence (basic-await) [65.631264] Starting subtest: basic-await [65.651962] Starting dynamic subtest: rcs0 [65.769143] Dynamic subtest rcs0: SUCCESS (0.135s) [65.805673] Starting dynamic subtest: bcs0 [65.903664] Dynamic subtest bcs0: SUCCESS (0.133s) [65.946533] Starting dynamic subtest: vcs0 [66.032496] Dynamic subtest vcs0: SUCCESS (0.129s) [66.074899] Starting dynamic subtest: vecs0 [66.163294] Dynamic subtest vecs0: SUCCESS (0.130s) [66.185339] Subtest basic-await: SUCCESS (0.532s) [66.877205] [024/171] (938s left) gem_exec_fence (nb-await) [67.294624] Starting subtest: nb-await [67.317868] Starting dynamic subtest: rcs0 [67.374984] Dynamic subtest rcs0: SUCCESS (0.081s) [67.412646] Starting dynamic subtest: bcs0 [67.457327] Dynamic subtest bcs0: SUCCESS (0.071s) [67.493138] Starting dynamic subtest: vcs0 [67.538627] Dynamic subtest vcs0: SUCCESS (0.071s) [67.575313] Starting dynamic subtest: vecs0 [67.595200] Dynamic subtest vecs0: SUCCESS (0.070s) [67.616509] Subtest nb-await: SUCCESS (0.296s) [68.275357] [025/171] (936s left) gem_exec_gttfill (basic) [68.588145] Starting subtest: basic [90.493851] Subtest basic: SUCCESS (21.946s) [90.716260] [026/171] (914s left) gem_exec_parallel (engines) [91.166288] Starting subtest: engines [91.185681] Starting dynamic subtest: basic [95.212555] Dynamic subtest basic: SUCCESS (3.877s) [95.248590] Starting dynamic subtest: contexts [99.799126] Dynamic subtest contexts: SUCCESS (4.620s) [99.837949] Starting dynamic subtest: fds [105.045144] Dynamic subtest fds: SUCCESS (5.230s) [105.081887] Starting dynamic subtest: userptr [109.036905] Dynamic subtest userptr: SUCCESS (3.965s) [109.058116] Subtest engines: SUCCESS (17.693s) [109.168407] [027/171] (896s left) gem_exec_store (basic) [109.530390] Starting subtest: basic [109.550230] Subtest basic: SUCCESS (0.065s) [109.752702] [028/171] (895s left) gem_flink_basic (bad-flink) [110.057765] Starting subtest: bad-flink [110.081220] Subtest bad-flink: SUCCESS (0.000s) [110.172204] [029/171] (895s left) gem_flink_basic (bad-open) [110.465224] Starting subtest: bad-open [110.485632] Subtest bad-open: SUCCESS (0.000s) [110.596825] [030/171] (894s left) gem_flink_basic (basic) [110.888808] Starting subtest: basic [110.910927] Subtest basic: SUCCESS (0.000s) [111.002626] [031/171] (894s left) gem_flink_basic (double-flink) [111.289714] Starting subtest: double-flink [111.309865] Subtest double-flink: SUCCESS (0.000s) [111.400859] [032/171] (894s left) gem_flink_basic (flink-lifetime) [111.693903] Starting subtest: flink-lifetime [111.715683] Subtest flink-lifetime: SUCCESS (0.003s) [111.804207] [033/171] (893s left) gem_huc_copy (huc-copy) [112.088748] Starting subtest: huc-copy [112.108740] Subtest huc-copy: SUCCESS (0.005s) [112.228687] [034/171] (893s left) gem_linear_blits (basic) [112.696636] Starting subtest: basic [112.717785] Subtest basic: SUCCESS (0.020s) [112.880566] [035/171] (893s left) gem_mmap (basic) [113.341378] Starting subtest: basic [113.445743] Subtest basic: SUCCESS (0.001s) [113.536393] [036/171] (892s left) gem_mmap_gtt (basic) [113.852820] Starting subtest: basic [113.876294] Subtest basic: SUCCESS (0.002s) [113.966581] [037/171] (892s left) gem_render_linear_blits (basic) [114.259143] Starting subtest: basic [114.362041] Subtest basic: SUCCESS (0.087s) [114.454727] [038/171] (891s left) gem_render_tiled_blits (basic) [114.758085] Starting subtest: basic [114.911537] Subtest basic: SUCCESS (0.118s) [115.028092] [039/171] (891s left) gem_ringfill (basic-all) [115.632290] Starting subtest: basic-all [116.804936] Subtest basic-all: SUCCESS (1.223s) [116.965641] [040/171] (889s left) gem_softpin (allocator-basic) [117.312579] Starting subtest: allocator-basic [117.510744] Subtest allocator-basic: SUCCESS (0.236s) [117.678231] [041/171] (888s left) gem_softpin (allocator-basic-reserve) [117.999559] Starting subtest: allocator-basic-reserve [118.202345] Subtest allocator-basic-reserve: SUCCESS (0.247s) [118.350180] [042/171] (888s left) gem_softpin (safe-alignment) [118.638924] Starting subtest: safe-alignment [118.661603] Subtest safe-alignment: SUCCESS (0.032s) [118.781080] [043/171] (887s left) gem_sync (basic-all) [119.249947] Starting subtest: basic-all [121.152211] Subtest basic-all: SUCCESS (2.066s) [121.360243] [044/171] (885s left) gem_sync (basic-each) [121.831600] Starting subtest: basic-each [124.083348] Subtest basic-each: SUCCESS (2.425s) [124.294969] [045/171] (882s left) gem_tiled_blits (basic) [124.749557] Starting subtest: basic [124.802800] Subtest basic: SUCCESS (0.051s) [124.985594] [046/171] (881s left) gem_tiled_fence_blits (basic) [125.606083] Starting subtest: basic [125.647885] Subtest basic: SUCCESS (0.042s) [125.820354] [047/171] (881s left) gem_tiled_pread_basic [126.629086] [048/171] (880s left) gem_wait (busy@all-engines) [126.948145] Starting subtest: busy [126.969426] Starting dynamic subtest: all-engines [127.477672] Dynamic subtest all-engines: SUCCESS (0.530s) [127.498408] Subtest busy: SUCCESS (0.530s) [127.734606] [049/171] (879s left) gem_wait (wait@all-engines) [128.045469] Starting subtest: wait [128.067616] Starting dynamic subtest: all-engines [129.081173] Dynamic subtest all-engines: SUCCESS (1.047s) [129.103476] Subtest wait: SUCCESS (1.047s) [129.345240] [050/171] (877s left) i915_getparams_basic (basic-eu-total) [129.636207] Starting subtest: basic-eu-total [129.677388] Subtest basic-eu-total: SUCCESS (0.000s) [129.771431] [051/171] (877s left) i915_getparams_basic (basic-subslice-total) [130.062790] Starting subtest: basic-subslice-total [130.105573] Subtest basic-subslice-total: SUCCESS (0.000s) [130.197392] [052/171] (877s left) i915_hangman (error-state-basic) [130.493204] Starting subtest: error-state-basic [130.794955] Subtest error-state-basic: SUCCESS (0.295s) [130.893082] [053/171] (876s left) i915_pciid [131.302666] [054/171] (876s left) kms_addfb_basic (addfb25-bad-modifier) [131.597870] Starting subtest: addfb25-bad-modifier [131.621394] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [131.890257] [055/171] (875s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [132.194094] Starting subtest: addfb25-framebuffer-vs-set-tiling [132.218819] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [132.430132] [056/171] (875s left) kms_addfb_basic (addfb25-modifier-no-flag) [132.734507] Starting subtest: addfb25-modifier-no-flag [132.756133] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [132.960438] [057/171] (874s left) kms_addfb_basic (addfb25-x-tiled-legacy) [133.251035] Starting subtest: addfb25-x-tiled-legacy [133.271602] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [133.465483] [058/171] (874s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [133.755219] Starting subtest: addfb25-x-tiled-mismatch-legacy [133.775411] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [133.966064] [059/171] (874s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [134.340348] Starting subtest: addfb25-yf-tiled-legacy [134.360875] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [134.473353] [060/171] (873s left) kms_addfb_basic (addfb25-y-tiled-legacy) [134.851227] Starting subtest: addfb25-y-tiled-legacy [134.871694] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [134.986436] [061/171] (873s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [135.363069] Starting subtest: addfb25-y-tiled-small-legacy [135.383787] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [135.520134] [062/171] (872s left) kms_addfb_basic (bad-pitch-0) [135.809858] Starting subtest: bad-pitch-0 [135.830478] Subtest bad-pitch-0: SUCCESS (0.000s) [136.033983] [063/171] (872s left) kms_addfb_basic (bad-pitch-1024) [136.321188] Starting subtest: bad-pitch-1024 [136.341932] Subtest bad-pitch-1024: SUCCESS (0.000s) [136.551202] [064/171] (872s left) kms_addfb_basic (bad-pitch-128) [136.840207] Starting subtest: bad-pitch-128 [136.861083] Subtest bad-pitch-128: SUCCESS (0.000s) [137.067303] [065/171] (871s left) kms_addfb_basic (bad-pitch-256) [137.351954] Starting subtest: bad-pitch-256 [137.372728] Subtest bad-pitch-256: SUCCESS (0.000s) [137.569096] [066/171] (871s left) kms_addfb_basic (bad-pitch-32) [137.858464] Starting subtest: bad-pitch-32 [137.877979] Subtest bad-pitch-32: SUCCESS (0.000s) [138.085592] [067/171] (870s left) kms_addfb_basic (bad-pitch-63) [138.375097] Starting subtest: bad-pitch-63 [138.397277] Subtest bad-pitch-63: SUCCESS (0.000s) [138.597340] [068/171] (870s left) kms_addfb_basic (bad-pitch-65536) [138.887501] Starting subtest: bad-pitch-65536 [138.907276] Subtest bad-pitch-65536: SUCCESS (0.001s) [139.119252] [069/171] (870s left) kms_addfb_basic (bad-pitch-999) [139.404578] Starting subtest: bad-pitch-999 [139.427047] Subtest bad-pitch-999: SUCCESS (0.000s) [139.632314] [070/171] (869s left) kms_addfb_basic (basic) [139.925680] Starting subtest: basic [139.945440] Subtest basic: SUCCESS (0.000s) [140.151864] [071/171] (869s left) kms_addfb_basic (basic-x-tiled-legacy) [140.442088] Starting subtest: basic-x-tiled-legacy [140.463880] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [140.646888] [072/171] (868s left) kms_addfb_basic (basic-y-tiled-legacy) [140.937112] Starting subtest: basic-y-tiled-legacy [140.956500] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [141.166448] [073/171] (868s left) kms_addfb_basic (bo-too-small) [141.559328] Starting subtest: bo-too-small [141.583077] Subtest bo-too-small: SUCCESS (0.001s) [141.714441] [074/171] (868s left) kms_addfb_basic (bo-too-small-due-to-tiling) [142.099307] Starting subtest: bo-too-small-due-to-tiling [142.124835] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [142.253952] [075/171] (867s left) kms_addfb_basic (clobberred-modifier) [142.565307] Starting subtest: clobberred-modifier [142.587098] Subtest clobberred-modifier: SUCCESS (0.000s) [142.799920] [076/171] (867s left) kms_addfb_basic (framebuffer-vs-set-tiling) [143.102861] Starting subtest: framebuffer-vs-set-tiling [143.125222] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [143.317889] [077/171] (866s left) kms_addfb_basic (invalid-get-prop) [143.606414] Starting subtest: invalid-get-prop [143.628181] Subtest invalid-get-prop: SUCCESS (0.000s) [143.833974] [078/171] (866s left) kms_addfb_basic (invalid-get-prop-any) [144.121684] Starting subtest: invalid-get-prop-any [144.141105] Subtest invalid-get-prop-any: SUCCESS (0.000s) [144.351082] [079/171] (865s left) kms_addfb_basic (invalid-set-prop) [144.641816] Starting subtest: invalid-set-prop [144.662998] Subtest invalid-set-prop: SUCCESS (0.000s) [144.849603] [080/171] (865s left) kms_addfb_basic (invalid-set-prop-any) [145.136463] Starting subtest: invalid-set-prop-any [145.155887] Subtest invalid-set-prop-any: SUCCESS (0.000s) [145.351865] [081/171] (865s left) kms_addfb_basic (no-handle) [145.642936] Starting subtest: no-handle [145.664294] Subtest no-handle: SUCCESS (0.000s) [145.866358] [082/171] (864s left) kms_addfb_basic (size-max) [146.248525] Starting subtest: size-max [146.267663] Subtest size-max: SUCCESS (0.000s) [146.380409] [083/171] (864s left) kms_addfb_basic (small-bo) [146.753772] Starting subtest: small-bo [146.774142] Subtest small-bo: SUCCESS (0.000s) [146.888956] [084/171] (863s left) kms_addfb_basic (tile-pitch-mismatch) [147.178373] Starting subtest: tile-pitch-mismatch [147.199715] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [147.400540] [085/171] (863s left) kms_addfb_basic (too-high) [147.770548] Starting subtest: too-high [147.789603] Subtest too-high: SUCCESS (0.002s) [147.902432] [086/171] (863s left) kms_addfb_basic (too-wide) [148.275964] Starting subtest: too-wide [148.295039] Subtest too-wide: SUCCESS (0.000s) [148.413273] [087/171] (862s left) kms_addfb_basic (unused-handle) [148.700901] Starting subtest: unused-handle [148.720313] Subtest unused-handle: SUCCESS (0.000s) [148.916182] [088/171] (862s left) kms_addfb_basic (unused-modifier) [149.202266] Starting subtest: unused-modifier [149.224278] Subtest unused-modifier: SUCCESS (0.000s) [149.413373] [089/171] (861s left) kms_addfb_basic (unused-offsets) [149.702400] Starting subtest: unused-offsets [149.721784] Subtest unused-offsets: SUCCESS (0.000s) [149.918647] [090/171] (861s left) kms_addfb_basic (unused-pitches) [150.206912] Starting subtest: unused-pitches [150.228777] Subtest unused-pitches: SUCCESS (0.000s) [150.454535] [091/171] (861s left) kms_busy (basic) [150.842874] Starting subtest: basic [150.862572] Starting dynamic subtest: flip [151.863461] Dynamic subtest flip: SUCCESS (1.024s) [151.903853] Starting dynamic subtest: modeset [153.357420] Dynamic subtest modeset: SUCCESS (1.492s) [153.377249] Subtest basic: SUCCESS (2.520s) [153.790701] [092/171] (857s left) kms_chamelium_hpd (dp-hpd-fast) [154.276110] Subtest dp-hpd-fast: SKIP (0.000s) [154.629523] [093/171] (857s left) kms_chamelium_edid (dp-edid-read) [155.126733] Subtest dp-edid-read: SKIP (0.000s) [155.459397] [094/171] (856s left) kms_chamelium_frames (dp-crc-fast) [155.959857] Subtest dp-crc-fast: SKIP (0.000s) [156.299989] [095/171] (855s left) kms_chamelium_hpd (hdmi-hpd-fast) [156.775723] Subtest hdmi-hpd-fast: SKIP (0.000s) [157.126142] [096/171] (855s left) kms_chamelium_edid (hdmi-edid-read) [157.622694] Subtest hdmi-edid-read: SKIP (0.000s) [157.985764] [097/171] (854s left) kms_chamelium_frames (hdmi-crc-fast) [158.465392] Subtest hdmi-crc-fast: SKIP (0.000s) [158.860937] [098/171] (853s left) kms_chamelium_hpd (vga-hpd-fast) [159.377361] Subtest vga-hpd-fast: SKIP (0.000s) [159.744487] [099/171] (852s left) kms_chamelium_edid (vga-edid-read) [160.214803] Subtest vga-edid-read: SKIP (0.000s) [160.566386] [100/171] (852s left) kms_prop_blob (basic) [160.866992] Starting subtest: basic [160.888069] Subtest basic: SUCCESS (0.000s) [161.003943] [101/171] (851s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [161.388662] Starting subtest: basic-busy-flip-before-cursor-atomic [161.431776] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [161.548912] [102/171] (851s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [161.929142] Starting subtest: basic-busy-flip-before-cursor-legacy [161.971900] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [162.088676] [103/171] (851s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [162.468204] Starting subtest: basic-flip-after-cursor-atomic [163.543822] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.062s) [163.908921] [104/171] (849s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [164.288120] Starting subtest: basic-flip-after-cursor-legacy [165.347075] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.063s) [165.725583] [105/171] (847s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [166.109415] Starting subtest: basic-flip-after-cursor-varying-size [167.187504] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.073s) [167.545925] [106/171] (845s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [167.923586] Starting subtest: basic-flip-before-cursor-atomic [168.994639] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.086s) [169.376963] [107/171] (844s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [169.743396] Starting subtest: basic-flip-before-cursor-legacy [170.828232] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.074s) [171.226838] [108/171] (842s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [171.635374] Starting subtest: basic-flip-before-cursor-varying-size [172.716524] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.074s) [173.069832] [109/171] (840s left) kms_flip (basic-flip-vs-dpms) [173.455788] Starting subtest: basic-flip-vs-dpms [173.477894] Starting dynamic subtest: A-DP1 [174.710329] Dynamic subtest A-DP1: SUCCESS (1.260s) [174.751278] Starting dynamic subtest: B-DP1 [175.865467] Dynamic subtest B-DP1: SUCCESS (1.163s) [175.903884] Starting dynamic subtest: C-DP1 [177.010216] Dynamic subtest C-DP1: SUCCESS (1.149s) [177.029558] Subtest basic-flip-vs-dpms: SUCCESS (3.582s) [177.441476] [110/171] (836s left) kms_flip (basic-flip-vs-modeset) [177.823276] Starting subtest: basic-flip-vs-modeset [177.842717] Starting dynamic subtest: A-DP1 [179.117659] Dynamic subtest A-DP1: SUCCESS (1.300s) [179.162141] Starting dynamic subtest: B-DP1 [180.276329] Dynamic subtest B-DP1: SUCCESS (1.165s) [180.315089] Starting dynamic subtest: C-DP1 [181.421049] Dynamic subtest C-DP1: SUCCESS (1.143s) [181.440956] Subtest basic-flip-vs-modeset: SUCCESS (3.619s) [181.828210] [111/171] (832s left) kms_flip (basic-flip-vs-wf_vblank) [182.212726] Starting subtest: basic-flip-vs-wf_vblank [182.233697] Starting dynamic subtest: A-DP1 [183.673851] Dynamic subtest A-DP1: SUCCESS (1.483s) [183.713330] Starting dynamic subtest: B-DP1 [185.086649] Dynamic subtest B-DP1: SUCCESS (1.411s) [185.126566] Starting dynamic subtest: C-DP1 [186.495426] Dynamic subtest C-DP1: SUCCESS (1.408s) [186.516850] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.314s) [186.973734] [112/171] (827s left) kms_flip (basic-plain-flip) [187.359555] Starting subtest: basic-plain-flip [187.380236] Starting dynamic subtest: A-DP1 [188.526828] Dynamic subtest A-DP1: SUCCESS (1.195s) [188.567500] Starting dynamic subtest: B-DP1 [189.661823] Dynamic subtest B-DP1: SUCCESS (1.120s) [189.707329] Starting dynamic subtest: C-DP1 [190.782296] Dynamic subtest C-DP1: SUCCESS (1.116s) [190.808883] Subtest basic-plain-flip: SUCCESS (3.443s) [191.267811] [113/171] (822s left) kms_force_connector_basic (force-connector-state) [191.596295] Subtest force-connector-state: SKIP (0.000s) [191.709692] [114/171] (822s left) kms_force_connector_basic (force-edid) [192.026094] Subtest force-edid: SKIP (0.000s) [192.141905] [115/171] (822s left) kms_force_connector_basic (force-load-detect) [192.451983] Subtest force-load-detect: SKIP (0.000s) [192.568819] [116/171] (822s left) kms_force_connector_basic (prune-stale-modes) [192.884036] Subtest prune-stale-modes: SKIP (0.000s) [192.998932] [117/171] (821s left) kms_frontbuffer_tracking (basic) [193.459297] Starting subtest: basic [196.410334] Subtest basic: SUCCESS (3.029s) [196.562760] [118/171] (818s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [196.954451] Starting subtest: compare-crc-sanitycheck-xr24 [196.977156] Starting dynamic subtest: pipe-A-DP-1 [197.388024] Dynamic subtest pipe-A-DP-1: SUCCESS (0.433s) [197.428481] Starting dynamic subtest: pipe-B-DP-1 [198.113655] Dynamic subtest pipe-B-DP-1: SUCCESS (0.722s) [198.169678] Starting dynamic subtest: pipe-C-DP-1 [198.972231] Dynamic subtest pipe-C-DP-1: SUCCESS (0.851s) [198.992391] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.020s) [199.358723] [119/171] (815s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [199.741567] Starting subtest: compare-crc-sanitycheck-nv12 [199.761452] Starting dynamic subtest: pipe-A-DP-1 [199.804350] Dynamic subtest pipe-A-DP-1: SKIP (0.001s) [199.843333] Starting dynamic subtest: pipe-B-DP-1 [199.884120] Dynamic subtest pipe-B-DP-1: SKIP (0.001s) [199.925080] Starting dynamic subtest: pipe-C-DP-1 [199.971945] Dynamic subtest pipe-C-DP-1: SKIP (0.001s) [200.016133] Subtest compare-crc-sanitycheck-nv12: SKIP (0.017s) [200.131400] [120/171] (814s left) kms_pipe_crc_basic (hang-read-crc) [200.520212] Starting subtest: hang-read-crc [200.545360] Starting dynamic subtest: pipe-A-DP-1 [202.018972] Dynamic subtest pipe-A-DP-1: SUCCESS (1.503s) [202.067380] Starting dynamic subtest: pipe-B-DP-1 [203.921804] Dynamic subtest pipe-B-DP-1: SUCCESS (1.899s) [203.984459] Starting dynamic subtest: pipe-C-DP-1 [206.073199] Dynamic subtest pipe-C-DP-1: SUCCESS (2.150s) [206.094869] Subtest hang-read-crc: SUCCESS (5.565s) [206.464082] [121/171] (808s left) kms_pipe_crc_basic (nonblocking-crc) [206.877607] Starting subtest: nonblocking-crc [206.898956] Starting dynamic subtest: pipe-A-DP-1 [207.472253] Dynamic subtest pipe-A-DP-1: SUCCESS (0.595s) [207.513764] Starting dynamic subtest: pipe-B-DP-1 [208.339520] Dynamic subtest pipe-B-DP-1: SUCCESS (0.861s) [208.378774] Starting dynamic subtest: pipe-C-DP-1 [209.350507] Dynamic subtest pipe-C-DP-1: SUCCESS (1.001s) [209.378115] Subtest nonblocking-crc: SUCCESS (2.472s) [209.729607] [122/171] (805s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [210.140940] Starting subtest: nonblocking-crc-frame-sequence [210.168618] Starting dynamic subtest: pipe-A-DP-1 [210.715693] Dynamic subtest pipe-A-DP-1: SUCCESS (0.579s) [210.761332] Starting dynamic subtest: pipe-B-DP-1 [211.586807] Dynamic subtest pipe-B-DP-1: SUCCESS (0.849s) [211.629039] Starting dynamic subtest: pipe-C-DP-1 [212.596871] Dynamic subtest pipe-C-DP-1: SUCCESS (1.007s) [212.619511] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.450s) [212.948407] [123/171] (802s left) kms_pipe_crc_basic (read-crc) [213.305949] Starting subtest: read-crc [213.326756] Starting dynamic subtest: pipe-A-DP-1 [213.856954] Dynamic subtest pipe-A-DP-1: SUCCESS (0.525s) [213.895540] Starting dynamic subtest: pipe-B-DP-1 [214.645935] Dynamic subtest pipe-B-DP-1: SUCCESS (0.792s) [214.711869] Starting dynamic subtest: pipe-C-DP-1 [215.591568] Dynamic subtest pipe-C-DP-1: SUCCESS (0.933s) [215.613886] Subtest read-crc: SUCCESS (2.265s) [215.960620] [124/171] (799s left) kms_pipe_crc_basic (read-crc-frame-sequence) [216.345710] Starting subtest: read-crc-frame-sequence [216.367883] Starting dynamic subtest: pipe-A-DP-1 [216.850441] Dynamic subtest pipe-A-DP-1: SUCCESS (0.503s) [216.889082] Starting dynamic subtest: pipe-B-DP-1 [217.625757] Dynamic subtest pipe-B-DP-1: SUCCESS (0.787s) [217.674310] Starting dynamic subtest: pipe-C-DP-1 [218.589442] Dynamic subtest pipe-C-DP-1: SUCCESS (0.934s) [218.614216] Subtest read-crc-frame-sequence: SUCCESS (2.239s) [218.962528] [125/171] (796s left) kms_psr (primary_page_flip) [219.293415] Subtest primary_page_flip: SKIP (0.000s) [219.409592] [126/171] (796s left) kms_psr (cursor_plane_move) [219.722628] Subtest cursor_plane_move: SKIP (0.000s) [219.838714] [127/171] (796s left) kms_psr (sprite_plane_onoff) [220.148229] Subtest sprite_plane_onoff: SKIP (0.000s) [220.262588] [128/171] (795s left) kms_psr (primary_mmap_gtt) [220.570575] Subtest primary_mmap_gtt: SKIP (0.000s) [220.683584] [129/171] (795s left) kms_setmode (basic-clone-single-crtc) [220.983035] Starting subtest: basic-clone-single-crtc [221.045095] Subtest basic-clone-single-crtc: SKIP (0.001s) [221.161079] [130/171] (795s left) i915_pm_backlight (basic-brightness) [221.554979] Subtest basic-brightness: SKIP (0.000s) [221.674365] [131/171] (794s left) i915_pm_rpm (basic-pci-d3-state) [223.638085] Starting subtest: basic-pci-d3-state [224.615233] Subtest basic-pci-d3-state: SUCCESS (0.972s) [224.897995] [132/171] (791s left) i915_pm_rpm (basic-rte) [225.171129] Starting subtest: basic-rte [227.581870] Subtest basic-rte: SUCCESS (2.417s) [228.796985] [133/171] (787s left) i915_pm_rps (basic-api) [229.104846] Starting subtest: basic-api [229.127633] Subtest basic-api: SUCCESS (0.007s) [229.266903] [134/171] (787s left) prime_self_import (basic-llseek-bad) [229.544832] Starting subtest: basic-llseek-bad [229.586609] Subtest basic-llseek-bad: SUCCESS (0.004s) [229.702427] [135/171] (787s left) prime_self_import (basic-llseek-size) [229.972635] Starting subtest: basic-llseek-size [230.012192] Subtest basic-llseek-size: SUCCESS (0.006s) [230.128778] [136/171] (786s left) prime_self_import (basic-with_fd_dup) [230.397404] Starting subtest: basic-with_fd_dup [230.437960] Subtest basic-with_fd_dup: SUCCESS (0.007s) [230.552768] [137/171] (786s left) prime_self_import (basic-with_one_bo) [230.822320] Starting subtest: basic-with_one_bo [230.865975] Subtest basic-with_one_bo: SUCCESS (0.008s) [230.979944] [138/171] (786s left) prime_self_import (basic-with_one_bo_two_files) [231.249866] Starting subtest: basic-with_one_bo_two_files [231.292197] Subtest basic-with_one_bo_two_files: SUCCESS (0.005s) [231.407852] [139/171] (785s left) prime_self_import (basic-with_two_bos) [231.681872] Starting subtest: basic-with_two_bos [231.722277] Subtest basic-with_two_bos: SUCCESS (0.008s) [231.837437] [140/171] (785s left) prime_vgem (basic-fence-flip) [232.178944] Starting subtest: basic-fence-flip [232.722860] Subtest basic-fence-flip: SUCCESS (0.587s) [232.894851] [141/171] (784s left) prime_vgem (basic-fence-mmap) [233.230752] Starting subtest: basic-fence-mmap [233.252222] Subtest basic-fence-mmap: SUCCESS (0.070s) [233.395056] [142/171] (784s left) prime_vgem (basic-fence-read) [233.712726] Starting subtest: basic-fence-read [233.787981] Subtest basic-fence-read: SUCCESS (0.108s) [233.928058] [143/171] (783s left) prime_vgem (basic-gtt) [234.236897] Starting subtest: basic-gtt [234.259560] Subtest basic-gtt: SUCCESS (0.032s) [234.399160] [144/171] (783s left) prime_vgem (basic-read) [234.710884] Starting subtest: basic-read [234.735037] Subtest basic-read: SUCCESS (0.051s) [234.878097] [145/171] (783s left) prime_vgem (basic-write) [235.211651] Starting subtest: basic-write [235.231416] Subtest basic-write: SUCCESS (0.062s) [235.375743] [146/171] (782s left) vgem_basic (setversion) [235.677648] Starting subtest: setversion [235.720343] Subtest setversion: SUCCESS (0.000s) [235.837775] [147/171] (782s left) vgem_basic (create) [236.129521] Starting subtest: create [236.149114] Subtest create: SUCCESS (0.000s) [236.268708] [148/171] (782s left) vgem_basic (debugfs) [236.560503] Starting subtest: debugfs [236.580354] Subtest debugfs: SUCCESS (0.001s) [236.696802] [149/171] (781s left) vgem_basic (dmabuf-export) [237.011295] Starting subtest: dmabuf-export [237.051629] Subtest dmabuf-export: SUCCESS (0.004s) [237.167782] [150/171] (781s left) vgem_basic (dmabuf-fence) [237.467179] Starting subtest: dmabuf-fence [237.488724] Subtest dmabuf-fence: SUCCESS (0.002s) [237.604565] [151/171] (781s left) vgem_basic (dmabuf-fence-before) [237.932328] Starting subtest: dmabuf-fence-before [237.957658] Subtest dmabuf-fence-before: SUCCESS (0.001s) [238.110385] [152/171] (780s left) vgem_basic (dmabuf-mmap) [238.438083] Starting subtest: dmabuf-mmap [238.465914] Subtest dmabuf-mmap: SUCCESS (0.043s) [238.615084] [153/171] (780s left) vgem_basic (mmap) [238.945582] Starting subtest: mmap [238.971455] Subtest mmap: SUCCESS (0.026s) [239.120518] [154/171] (780s left) vgem_basic (second-client) [239.419176] Starting subtest: second-client [239.460669] Subtest second-client: SUCCESS (0.032s) [239.577361] [155/171] (779s left) vgem_basic (sysfs) [239.875163] Starting subtest: sysfs [239.896617] Subtest sysfs: SUCCESS (0.001s) [240.013568] [156/171] (779s left) core_hotunplug (unbind-rebind) [240.354963] Starting subtest: unbind-rebind [242.471211] Subtest unbind-rebind: SUCCESS (2.112s) [242.587157] [157/171] (777s left) vgem_basic (unload) [242.867993] Starting subtest: unload [272.059209] Subtest unload: SUCCESS (29.016s) [272.159588] [158/171] (747s left) i915_module_load (reload) [272.439639] Starting subtest: reload [276.206130] Subtest reload: SUCCESS (3.760s) [276.360499] [159/171] (743s left) gem_lmem_swapping (basic) [276.751771] Subtest basic: SKIP (0.000s) [276.867059] [160/171] (743s left) gem_lmem_swapping (parallel-random-engines) [277.180414] Subtest parallel-random-engines: SKIP (0.000s) [277.294425] [161/171] (742s left) gem_lmem_swapping (random-engines) [277.619404] Subtest random-engines: SKIP (0.000s) [277.758987] [162/171] (742s left) gem_lmem_swapping (verify-random) [278.114876] Subtest verify-random: SKIP (0.000s) [278.260796] [163/171] (742s left) i915_pm_rpm (module-reload) [280.602434] Starting subtest: module-reload [291.983784] Subtest module-reload: SUCCESS (11.386s) [292.117579] [164/171] (728s left) i915_selftest (live) [292.416877] Starting subtest: live [292.445227] Starting dynamic subtest: sanitycheck [293.924597] Dynamic subtest sanitycheck: SUCCESS (1.517s) [293.970410] Starting dynamic subtest: uncore [295.515972] Dynamic subtest uncore: SUCCESS (1.588s) [295.553586] Starting dynamic subtest: workarounds [297.318236] Dynamic subtest workarounds: SUCCESS (1.800s) [297.355424] Starting dynamic subtest: gt_engines [299.342191] Dynamic subtest gt_engines: SUCCESS (2.021s) [299.388949] Starting dynamic subtest: gt_timelines [322.788264] Dynamic subtest gt_timelines: SUCCESS (23.443s) [322.824146] Starting dynamic subtest: gt_contexts [324.462621] Dynamic subtest gt_contexts: SUCCESS (1.670s) [324.499660] Starting dynamic subtest: gt_lrc [328.848538] Dynamic subtest gt_lrc: SUCCESS (4.383s) [328.885724] Starting dynamic subtest: gt_mocs [330.585957] Dynamic subtest gt_mocs: SUCCESS (1.725s) [330.628242] Starting dynamic subtest: gt_pm [339.556359] Dynamic subtest gt_pm: SUCCESS (8.977s) [339.603210] Starting dynamic subtest: gt_heartbeat [341.241061] Dynamic subtest gt_heartbeat: SUCCESS (1.681s) [341.292217] Starting dynamic subtest: gt_tlb [343.622774] Dynamic subtest gt_tlb: SUCCESS (2.378s) [343.658228] Starting dynamic subtest: requests [351.559940] Dynamic subtest requests: SUCCESS (7.933s) [351.596587] Starting dynamic subtest: migrate [356.337730] Dynamic subtest migrate: SUCCESS (4.777s) [356.372619] Starting dynamic subtest: active [357.932510] Dynamic subtest active: SUCCESS (1.589s) [357.968919] Starting dynamic subtest: objects [362.432642] Dynamic subtest objects: SUCCESS (4.499s) [362.485382] Starting dynamic subtest: mman [371.454376] Dynamic subtest mman: SUCCESS (9.017s) [371.488968] Starting dynamic subtest: dmabuf [373.088766] Dynamic subtest dmabuf: SUCCESS (1.626s) [373.123800] Starting dynamic subtest: vma [374.698671] Dynamic subtest vma: SUCCESS (1.615s) [374.743594] Starting dynamic subtest: coherency [378.839906] Dynamic subtest coherency: SUCCESS (4.135s) [378.876531] Starting dynamic subtest: gtt [388.198901] Dynamic subtest gtt: SUCCESS (9.356s) [388.235169] Starting dynamic subtest: gem [391.269377] Dynamic subtest gem: SUCCESS (3.067s) [391.304986] Starting dynamic subtest: evict [397.511605] Dynamic subtest evict: SUCCESS (6.240s) [397.548894] Starting dynamic subtest: hugepages [405.651636] Dynamic subtest hugepages: SUCCESS (8.136s) [405.689365] Starting dynamic subtest: gem_contexts [430.976291] Dynamic subtest gem_contexts: SUCCESS (25.321s) [431.013168] Starting dynamic subtest: client [432.597822] Dynamic subtest client: SUCCESS (1.619s) [432.634964] Starting dynamic subtest: gem_migrate [434.153532] Dynamic subtest gem_migrate: SUCCESS (1.555s) [434.188909] Starting dynamic subtest: reset [447.747660] Dynamic subtest reset: SUCCESS (13.591s) [447.785218] Starting dynamic subtest: memory_region [449.318819] Dynamic subtest memory_region: SUCCESS (1.567s) [449.354580] Starting dynamic subtest: hangcheck [474.100296] Dynamic subtest hangcheck: SUCCESS (24.769s) [474.157297] Starting dynamic subtest: execlists [486.457487] Dynamic subtest execlists: SUCCESS (12.362s) [486.494858] Starting dynamic subtest: ring_submission [487.975128] Dynamic subtest ring_submission: SUCCESS (1.516s) [488.021893] Starting dynamic subtest: perf [489.646686] Dynamic subtest perf: SUCCESS (1.671s) [489.689288] Starting dynamic subtest: slpc [491.249956] Dynamic subtest slpc: SUCCESS (1.601s) [491.287986] Starting dynamic subtest: guc [492.804165] Dynamic subtest guc: SUCCESS (1.548s) [492.852767] Starting dynamic subtest: guc_multi_lrc [494.363265] Dynamic subtest guc_multi_lrc: SUCCESS (1.557s) [494.400329] Starting dynamic subtest: guc_hang [495.936698] Dynamic subtest guc_hang: SUCCESS (1.571s) [495.972096] Starting dynamic subtest: late_gt_pm [497.624898] Dynamic subtest late_gt_pm: SUCCESS (1.679s) [497.658294] Subtest live: SUCCESS (205.212s) [497.915754] [165/171] (522s left) dmabuf (all-tests) [498.217067] Starting subtest: all-tests [498.241927] Starting dynamic subtest: sanitycheck [498.299815] Dynamic subtest sanitycheck: SUCCESS (0.082s) [498.339681] Starting dynamic subtest: dma_fence [498.489284] Dynamic subtest dma_fence: SUCCESS (0.187s) [498.529297] Starting dynamic subtest: dma_fence_chain [521.612578] Dynamic subtest dma_fence_chain: SUCCESS (23.120s) [521.656675] Starting dynamic subtest: dma_fence_unwrap [521.710981] Dynamic subtest dma_fence_unwrap: SUCCESS (0.070s) [521.752895] Starting dynamic subtest: dma_resv [521.776522] Dynamic subtest dma_resv: SUCCESS (0.075s) [521.802480] Subtest all-tests: SUCCESS (23.550s) [521.912721] [166/171] (498s left) i915_suspend (basic-s2idle-without-i915) [522.202678] Starting subtest: basic-s2idle-without-i915 [543.272198] Subtest basic-s2idle-without-i915: SUCCESS (6.069s) [545.902060] [167/171] (492s left) i915_suspend (basic-s3-without-i915) [546.179533] Starting subtest: basic-s3-without-i915 [564.888511] Subtest basic-s3-without-i915: SUCCESS (3.973s) [569.632842] [168/171] (487s left) gem_exec_suspend (basic-s0) [569.976739] Starting subtest: basic-S0 [570.008611] Starting dynamic subtest: smem [591.801465] Dynamic subtest smem: SUCCESS (6.253s) [591.822084] Subtest basic-S0: SUCCESS (6.255s) [594.208796] [169/171] (480s left) gem_exec_suspend (basic-s3) [594.509117] Starting subtest: basic-S3 [594.531314] Starting dynamic subtest: smem [615.649067] Dynamic subtest smem: SUCCESS (6.158s) [615.669824] Subtest basic-S3: SUCCESS (6.161s) [617.204271] [170/171] (474s left) kms_chamelium_hpd (common-hpd-after-suspend) [617.697808] Subtest common-hpd-after-suspend: SKIP (0.000s) [618.053715] [171/171] (473s left) kms_pipe_crc_basic (suspend-read-crc) [618.439872] Starting subtest: suspend-read-crc [618.461894] Starting dynamic subtest: pipe-A-DP-1 [636.613985] Dynamic subtest pipe-A-DP-1: SUCCESS (2.598s) [645.723465] Closing watchdogs Done.